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

1 tests failed.
FAILED:  org.apache.solr.cloud.CustomCollectionTest.testCustomCollectionsAPI

Error Message:
Could not find collection : implicitcoll

Stack Trace:
org.apache.solr.common.SolrException: Could not find collection : implicitcoll
        at 
__randomizedtesting.SeedInfo.seed([6ABDE45BA9D1ED3:6C4A502E8707A8AB]:0)
        at 
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:194)
        at 
org.apache.solr.cloud.SolrCloudTestCase.getCollectionState(SolrCloudTestCase.java:245)
        at 
org.apache.solr.cloud.CustomCollectionTest.testCustomCollectionsAPI(CustomCollectionTest.java:68)
        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:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        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:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        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:745)




Build Log:
[...truncated 12222 lines...]
   [junit4] Suite: org.apache.solr.cloud.CustomCollectionTest
   [junit4]   2> Creating dataDir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/init-core-data-001
   [junit4]   2> 2620559 INFO  
(SUITE-CustomCollectionTest-seed#[6ABDE45BA9D1ED3]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields
   [junit4]   2> 2620564 INFO  
(SUITE-CustomCollectionTest-seed#[6ABDE45BA9D1ED3]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) 
w/ MAC_OS_X supressed clientAuth
   [junit4]   2> 2620566 INFO  
(SUITE-CustomCollectionTest-seed#[6ABDE45BA9D1ED3]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001
   [junit4]   2> 2620566 INFO  
(SUITE-CustomCollectionTest-seed#[6ABDE45BA9D1ED3]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2620567 INFO  (Thread-3538) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2620567 INFO  (Thread-3538) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 2620672 INFO  
(SUITE-CustomCollectionTest-seed#[6ABDE45BA9D1ED3]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:53159
   [junit4]   2> 2620711 INFO  (jetty-launcher-2652-thread-3) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 2620712 INFO  (jetty-launcher-2652-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 2620712 INFO  (jetty-launcher-2652-thread-4) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 2620711 INFO  (jetty-launcher-2652-thread-2) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 2620715 INFO  (jetty-launcher-2652-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@4c270f47{/solr,null,AVAILABLE}
   [junit4]   2> 2620718 INFO  (jetty-launcher-2652-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@12d15706{/solr,null,AVAILABLE}
   [junit4]   2> 2620718 INFO  (jetty-launcher-2652-thread-2) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@4591217c{SSL,[ssl, 
http/1.1]}{127.0.0.1:53162}
   [junit4]   2> 2620718 INFO  (jetty-launcher-2652-thread-2) [    ] 
o.e.j.s.Server Started @2626577ms
   [junit4]   2> 2620718 INFO  (jetty-launcher-2652-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=53162}
   [junit4]   2> 2620718 ERROR (jetty-launcher-2652-thread-2) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2620720 INFO  (jetty-launcher-2652-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 2620720 INFO  (jetty-launcher-2652-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2620720 INFO  (jetty-launcher-2652-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2620720 INFO  (jetty-launcher-2652-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-03-26T21:56:00.210Z
   [junit4]   2> 2620722 INFO  (jetty-launcher-2652-thread-4) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@7c6dcb8c{/solr,null,AVAILABLE}
   [junit4]   2> 2620723 INFO  (jetty-launcher-2652-thread-4) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@51979c3a{SSL,[ssl, 
http/1.1]}{127.0.0.1:53163}
   [junit4]   2> 2620723 INFO  (jetty-launcher-2652-thread-4) [    ] 
o.e.j.s.Server Started @2626582ms
   [junit4]   2> 2620723 INFO  (jetty-launcher-2652-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=53163}
   [junit4]   2> 2620723 ERROR (jetty-launcher-2652-thread-4) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2620724 INFO  (jetty-launcher-2652-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 2620724 INFO  (jetty-launcher-2652-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2620724 INFO  (jetty-launcher-2652-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2620724 INFO  (jetty-launcher-2652-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-03-26T21:56:00.214Z
   [junit4]   2> 2620726 INFO  (jetty-launcher-2652-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2aae118b{/solr,null,AVAILABLE}
   [junit4]   2> 2620729 INFO  (jetty-launcher-2652-thread-3) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@4ebfb43{SSL,[ssl, 
http/1.1]}{127.0.0.1:53161}
   [junit4]   2> 2620729 INFO  (jetty-launcher-2652-thread-3) [    ] 
o.e.j.s.Server Started @2626587ms
   [junit4]   2> 2620729 INFO  (jetty-launcher-2652-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=53161}
   [junit4]   2> 2620729 ERROR (jetty-launcher-2652-thread-3) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2620729 INFO  (jetty-launcher-2652-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@2763d566{SSL,[ssl, 
http/1.1]}{127.0.0.1:53164}
   [junit4]   2> 2620729 INFO  (jetty-launcher-2652-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 2620729 INFO  (jetty-launcher-2652-thread-1) [    ] 
o.e.j.s.Server Started @2626588ms
   [junit4]   2> 2620729 INFO  (jetty-launcher-2652-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2620730 INFO  (jetty-launcher-2652-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=53164}
   [junit4]   2> 2620730 INFO  (jetty-launcher-2652-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2620730 INFO  (jetty-launcher-2652-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-03-26T21:56:00.220Z
   [junit4]   2> 2620730 ERROR (jetty-launcher-2652-thread-1) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2620730 INFO  (jetty-launcher-2652-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 2620730 INFO  (jetty-launcher-2652-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2620730 INFO  (jetty-launcher-2652-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2620730 INFO  (jetty-launcher-2652-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-03-26T21:56:00.220Z
   [junit4]   2> 2620732 INFO  (jetty-launcher-2652-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2620743 INFO  (jetty-launcher-2652-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2620743 INFO  (jetty-launcher-2652-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2620743 INFO  (jetty-launcher-2652-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2620750 INFO  (jetty-launcher-2652-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:53159/solr
   [junit4]   2> 2620755 INFO  (jetty-launcher-2652-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:53159/solr
   [junit4]   2> 2620756 INFO  (jetty-launcher-2652-thread-3) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:53159/solr
   [junit4]   2> 2620760 INFO  (jetty-launcher-2652-thread-4) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:53159/solr
   [junit4]   2> 2620819 INFO  (jetty-launcher-2652-thread-1) 
[n:127.0.0.1:53164_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2620819 INFO  (jetty-launcher-2652-thread-3) 
[n:127.0.0.1:53161_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2620819 INFO  (jetty-launcher-2652-thread-4) 
[n:127.0.0.1:53163_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2620820 INFO  (jetty-launcher-2652-thread-1) 
[n:127.0.0.1:53164_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:53164_solr
   [junit4]   2> 2620821 INFO  (jetty-launcher-2652-thread-2) 
[n:127.0.0.1:53162_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2620823 INFO  (jetty-launcher-2652-thread-1) 
[n:127.0.0.1:53164_solr    ] o.a.s.c.Overseer Overseer 
(id=97685691436957706-127.0.0.1:53164_solr-n_0000000000) starting
   [junit4]   2> 2620823 INFO  (jetty-launcher-2652-thread-4) 
[n:127.0.0.1:53163_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:53163_solr
   [junit4]   2> 2620824 INFO  (jetty-launcher-2652-thread-3) 
[n:127.0.0.1:53161_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:53161_solr
   [junit4]   2> 2620824 INFO  (jetty-launcher-2652-thread-2) 
[n:127.0.0.1:53162_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:53162_solr
   [junit4]   2> 2620844 INFO  
(zkCallback-2672-thread-1-processing-n:127.0.0.1:53164_solr) 
[n:127.0.0.1:53164_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2620845 INFO  
(zkCallback-2673-thread-1-processing-n:127.0.0.1:53161_solr) 
[n:127.0.0.1:53161_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2620846 INFO  
(zkCallback-2674-thread-1-processing-n:127.0.0.1:53163_solr) 
[n:127.0.0.1:53163_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2620847 INFO  
(zkCallback-2671-thread-1-processing-n:127.0.0.1:53162_solr) 
[n:127.0.0.1:53162_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2620848 INFO  
(zkCallback-2672-thread-1-processing-n:127.0.0.1:53164_solr) 
[n:127.0.0.1:53164_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (3)
   [junit4]   2> 2620849 INFO  
(zkCallback-2671-thread-1-processing-n:127.0.0.1:53162_solr) 
[n:127.0.0.1:53162_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (3)
   [junit4]   2> 2620849 INFO  
(zkCallback-2673-thread-1-processing-n:127.0.0.1:53161_solr) 
[n:127.0.0.1:53161_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (3)
   [junit4]   2> 2620849 INFO  
(zkCallback-2674-thread-1-processing-n:127.0.0.1:53163_solr) 
[n:127.0.0.1:53163_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (3)
   [junit4]   2> 2620883 INFO  (jetty-launcher-2652-thread-1) 
[n:127.0.0.1:53164_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:53164_solr
   [junit4]   2> 2620886 INFO  
(zkCallback-2672-thread-1-processing-n:127.0.0.1:53164_solr) 
[n:127.0.0.1:53164_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2620887 INFO  
(zkCallback-2671-thread-1-processing-n:127.0.0.1:53162_solr) 
[n:127.0.0.1:53162_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2620887 INFO  
(zkCallback-2673-thread-1-processing-n:127.0.0.1:53161_solr) 
[n:127.0.0.1:53161_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2620888 INFO  
(zkCallback-2674-thread-1-processing-n:127.0.0.1:53163_solr) 
[n:127.0.0.1:53163_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2620968 INFO  (jetty-launcher-2652-thread-1) 
[n:127.0.0.1:53164_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node1/.
   [junit4]   2> 2620971 INFO  (jetty-launcher-2652-thread-4) 
[n:127.0.0.1:53163_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node4/.
   [junit4]   2> 2621061 INFO  (jetty-launcher-2652-thread-3) 
[n:127.0.0.1:53161_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node3/.
   [junit4]   2> 2621065 INFO  (jetty-launcher-2652-thread-2) 
[n:127.0.0.1:53162_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node2/.
   [junit4]   2> 2623297 INFO  
(SUITE-CustomCollectionTest-seed#[6ABDE45BA9D1ED3]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 2623299 INFO  
(SUITE-CustomCollectionTest-seed#[6ABDE45BA9D1ED3]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:53159/solr ready
   [junit4]   2> 2623349 INFO  
(TEST-CustomCollectionTest.testCreateShardRepFactor-seed#[6ABDE45BA9D1ED3]) [   
 ] o.a.s.SolrTestCaseJ4 ###Starting testCreateShardRepFactor
   [junit4]   2> 2623352 INFO  
(TEST-CustomCollectionTest.testCreateShardRepFactor-seed#[6ABDE45BA9D1ED3]) [   
 ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 2623373 INFO  (qtp1524859334-16274) [n:127.0.0.1:53163_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
shards=a,b&replicationFactor=1&collection.configName=conf&name=testCreateShardRepFactor&router.name=implicit&action=CREATE&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2623377 INFO  
(OverseerThreadFactory-8583-thread-1-processing-n:127.0.0.1:53164_solr) 
[n:127.0.0.1:53164_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
testCreateShardRepFactor
   [junit4]   2> 2623497 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&name=testCreateShardRepFactor_b_replica1&action=CREATE&numShards=2&collection=testCreateShardRepFactor&shard=b&wt=javabin&version=2
   [junit4]   2> 2623511 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&name=testCreateShardRepFactor_a_replica1&action=CREATE&numShards=2&collection=testCreateShardRepFactor&shard=a&wt=javabin&version=2
   [junit4]   2> 2623619 INFO  
(zkCallback-2673-thread-1-processing-n:127.0.0.1:53161_solr) 
[n:127.0.0.1:53161_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testCreateShardRepFactor/state.json] for collection 
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2623619 INFO  
(zkCallback-2674-thread-1-processing-n:127.0.0.1:53163_solr) 
[n:127.0.0.1:53163_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testCreateShardRepFactor/state.json] for collection 
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2624515 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2624522 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.s.IndexSchema [testCreateShardRepFactor_b_replica1] Schema 
name=cloud-dynamic
   [junit4]   2> 2624523 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2624531 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.s.IndexSchema [testCreateShardRepFactor_a_replica1] Schema 
name=cloud-dynamic
   [junit4]   2> 2624555 WARN  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.s.IndexSchema [testCreateShardRepFactor_b_replica1] default search field 
in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2624556 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2624558 WARN  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.s.IndexSchema [testCreateShardRepFactor_a_replica1] default search field 
in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2624558 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.c.CoreContainer Creating SolrCore 'testCreateShardRepFactor_b_replica1' 
using configuration from collection testCreateShardRepFactor
   [junit4]   2> 2624559 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2624559 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2624559 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.c.SolrCore [[testCreateShardRepFactor_b_replica1] ] Opening new SolrCore 
at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node4/testCreateShardRepFactor_b_replica1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node4/./testCreateShardRepFactor_b_replica1/data/]
   [junit4]   2> 2624560 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.c.CoreContainer Creating SolrCore 'testCreateShardRepFactor_a_replica1' 
using configuration from collection testCreateShardRepFactor
   [junit4]   2> 2624560 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2624560 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.c.SolrCore [[testCreateShardRepFactor_a_replica1] ] Opening new SolrCore 
at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node3/testCreateShardRepFactor_a_replica1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node3/./testCreateShardRepFactor_a_replica1/data/]
   [junit4]   2> 2624641 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2624641 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2624641 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2624641 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2624644 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2624644 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2624645 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@10925571[testCreateShardRepFactor_a_replica1] main]
   [junit4]   2> 2624645 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2624645 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2624646 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@9647cda[testCreateShardRepFactor_b_replica1] main]
   [junit4]   2> 2624647 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2624648 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2624648 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2624648 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2624648 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1562971067266367488
   [junit4]   2> 2624648 INFO  
(searcherExecutor-8593-thread-1-processing-n:127.0.0.1:53161_solr 
x:testCreateShardRepFactor_a_replica1 s:a c:testCreateShardRepFactor) 
[n:127.0.0.1:53161_solr c:testCreateShardRepFactor s:a  
x:testCreateShardRepFactor_a_replica1] o.a.s.c.SolrCore 
[testCreateShardRepFactor_a_replica1] Registered new searcher 
Searcher@10925571[testCreateShardRepFactor_a_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2624648 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2624648 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2624649 INFO  
(searcherExecutor-8592-thread-1-processing-n:127.0.0.1:53163_solr 
x:testCreateShardRepFactor_b_replica1 s:b c:testCreateShardRepFactor) 
[n:127.0.0.1:53163_solr c:testCreateShardRepFactor s:b  
x:testCreateShardRepFactor_b_replica1] o.a.s.c.SolrCore 
[testCreateShardRepFactor_b_replica1] Registered new searcher 
Searcher@9647cda[testCreateShardRepFactor_b_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2624649 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1562971067267416064
   [junit4]   2> 2624659 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2624660 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 2624660 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.c.SyncStrategy Sync replicas to 
https://127.0.0.1:53161/solr/testCreateShardRepFactor_a_replica1/
   [junit4]   2> 2624659 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2624660 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 2624660 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.c.SyncStrategy 
https://127.0.0.1:53161/solr/testCreateShardRepFactor_a_replica1/ has no 
replicas
   [junit4]   2> 2624660 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 2624660 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 2624660 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.c.SyncStrategy Sync replicas to 
https://127.0.0.1:53163/solr/testCreateShardRepFactor_b_replica1/
   [junit4]   2> 2624660 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 2624660 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.c.SyncStrategy 
https://127.0.0.1:53163/solr/testCreateShardRepFactor_b_replica1/ has no 
replicas
   [junit4]   2> 2624660 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 2624669 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:53161/solr/testCreateShardRepFactor_a_replica1/ a
   [junit4]   2> 2624669 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:53163/solr/testCreateShardRepFactor_b_replica1/ b
   [junit4]   2> 2624783 INFO  
(zkCallback-2673-thread-1-processing-n:127.0.0.1:53161_solr) 
[n:127.0.0.1:53161_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testCreateShardRepFactor/state.json] for collection 
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2624783 INFO  
(zkCallback-2674-thread-1-processing-n:127.0.0.1:53163_solr) 
[n:127.0.0.1:53163_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testCreateShardRepFactor/state.json] for collection 
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2624822 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 2624825 INFO  (qtp1140603163-16256) [n:127.0.0.1:53161_solr 
c:testCreateShardRepFactor s:a  x:testCreateShardRepFactor_a_replica1] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=testCreateShardRepFactor_a_replica1&action=CREATE&numShards=2&collection=testCreateShardRepFactor&shard=a&wt=javabin&version=2}
 status=0 QTime=1313
   [junit4]   2> 2624829 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 2624832 INFO  (qtp1524859334-16277) [n:127.0.0.1:53163_solr 
c:testCreateShardRepFactor s:b  x:testCreateShardRepFactor_b_replica1] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=testCreateShardRepFactor_b_replica1&action=CREATE&numShards=2&collection=testCreateShardRepFactor&shard=b&wt=javabin&version=2}
 status=0 QTime=1335
   [junit4]   2> 2624836 INFO  (qtp1524859334-16274) [n:127.0.0.1:53163_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> 2624941 INFO  
(zkCallback-2674-thread-1-processing-n:127.0.0.1:53163_solr) 
[n:127.0.0.1:53163_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testCreateShardRepFactor/state.json] for collection 
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2624941 INFO  
(zkCallback-2673-thread-1-processing-n:127.0.0.1:53161_solr) 
[n:127.0.0.1:53161_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testCreateShardRepFactor/state.json] for collection 
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2625381 INFO  
(OverseerCollectionConfigSetProcessor-97685691436957706-127.0.0.1:53164_solr-n_0000000000)
 [n:127.0.0.1:53164_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> 2625837 INFO  (qtp1524859334-16274) [n:127.0.0.1:53163_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={shards=a,b&replicationFactor=1&collection.configName=conf&name=testCreateShardRepFactor&router.name=implicit&action=CREATE&wt=javabin&version=2}
 status=0 QTime=2464
   [junit4]   2> 2625839 INFO  (qtp1524859334-16270) [n:127.0.0.1:53163_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :createshard with 
params 
action=CREATESHARD&collection=testCreateShardRepFactor&shard=x&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2625843 INFO  
(OverseerThreadFactory-8583-thread-2-processing-n:127.0.0.1:53164_solr) 
[n:127.0.0.1:53164_solr    ] o.a.s.c.CreateShardCmd Create shard invoked: {
   [junit4]   2>   "collection":"testCreateShardRepFactor",
   [junit4]   2>   "shard":"x",
   [junit4]   2>   "operation":"createshard"}
   [junit4]   2> 2625952 INFO  
(zkCallback-2673-thread-1-processing-n:127.0.0.1:53161_solr) 
[n:127.0.0.1:53161_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testCreateShardRepFactor/state.json] for collection 
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2625952 INFO  
(zkCallback-2674-thread-1-processing-n:127.0.0.1:53163_solr) 
[n:127.0.0.1:53163_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testCreateShardRepFactor/state.json] for collection 
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2626051 INFO  
(OverseerThreadFactory-8583-thread-2-processing-n:127.0.0.1:53164_solr) 
[n:127.0.0.1:53164_solr    ] o.a.s.c.CreateShardCmd Creating shard 
testCreateShardRepFactor_x_replica1 as part of slice x of collection 
testCreateShardRepFactor on 127.0.0.1:53162_solr
   [junit4]   2> 2626074 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&name=testCreateShardRepFactor_x_replica1&action=CREATE&numShards=1&collection=testCreateShardRepFactor&shard=x&wt=javabin&version=2
   [junit4]   2> 2626182 INFO  
(zkCallback-2673-thread-1-processing-n:127.0.0.1:53161_solr) 
[n:127.0.0.1:53161_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testCreateShardRepFactor/state.json] for collection 
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2626182 INFO  
(zkCallback-2674-thread-1-processing-n:127.0.0.1:53163_solr) 
[n:127.0.0.1:53163_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testCreateShardRepFactor/state.json] for collection 
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2626182 INFO  
(zkCallback-2671-thread-1-processing-n:127.0.0.1:53162_solr) 
[n:127.0.0.1:53162_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testCreateShardRepFactor/state.json] for collection 
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2627092 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2627100 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.s.IndexSchema [testCreateShardRepFactor_x_replica1] Schema 
name=cloud-dynamic
   [junit4]   2> 2627130 WARN  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.s.IndexSchema [testCreateShardRepFactor_x_replica1] default search field 
in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2627131 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2627134 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.c.CoreContainer Creating SolrCore 'testCreateShardRepFactor_x_replica1' 
using configuration from collection testCreateShardRepFactor
   [junit4]   2> 2627134 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2627134 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.c.SolrCore [[testCreateShardRepFactor_x_replica1] ] Opening new SolrCore 
at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node2/testCreateShardRepFactor_x_replica1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node2/./testCreateShardRepFactor_x_replica1/data/]
   [junit4]   2> 2627218 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2627218 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2627220 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2627220 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2627221 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@1703ab41[testCreateShardRepFactor_x_replica1] main]
   [junit4]   2> 2627223 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2627224 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2627224 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2627224 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1562971069967499264
   [junit4]   2> 2627224 INFO  
(searcherExecutor-8602-thread-1-processing-n:127.0.0.1:53162_solr 
x:testCreateShardRepFactor_x_replica1 s:x c:testCreateShardRepFactor) 
[n:127.0.0.1:53162_solr c:testCreateShardRepFactor s:x  
x:testCreateShardRepFactor_x_replica1] o.a.s.c.SolrCore 
[testCreateShardRepFactor_x_replica1] Registered new searcher 
Searcher@1703ab41[testCreateShardRepFactor_x_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2627234 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2627234 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 2627234 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.c.SyncStrategy Sync replicas to 
https://127.0.0.1:53162/solr/testCreateShardRepFactor_x_replica1/
   [junit4]   2> 2627234 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 2627234 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.c.SyncStrategy 
https://127.0.0.1:53162/solr/testCreateShardRepFactor_x_replica1/ has no 
replicas
   [junit4]   2> 2627234 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 2627241 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:53162/solr/testCreateShardRepFactor_x_replica1/ x
   [junit4]   2> 2627352 INFO  
(zkCallback-2671-thread-1-processing-n:127.0.0.1:53162_solr) 
[n:127.0.0.1:53162_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testCreateShardRepFactor/state.json] for collection 
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2627352 INFO  
(zkCallback-2674-thread-1-processing-n:127.0.0.1:53163_solr) 
[n:127.0.0.1:53163_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testCreateShardRepFactor/state.json] for collection 
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2627352 INFO  
(zkCallback-2673-thread-1-processing-n:127.0.0.1:53161_solr) 
[n:127.0.0.1:53161_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testCreateShardRepFactor/state.json] for collection 
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2627353 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 2627357 INFO  (qtp957983695-16265) [n:127.0.0.1:53162_solr 
c:testCreateShardRepFactor s:x  x:testCreateShardRepFactor_x_replica1] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&name=testCreateShardRepFactor_x_replica1&action=CREATE&numShards=1&collection=testCreateShardRepFactor&shard=x&wt=javabin&version=2}
 status=0 QTime=1283
   [junit4]   2> 2627359 INFO  
(OverseerThreadFactory-8583-thread-2-processing-n:127.0.0.1:53164_solr) 
[n:127.0.0.1:53164_solr    ] o.a.s.c.CreateShardCmd Finished create command on 
all shards for collection: testCreateShardRepFactor
   [junit4]   2> 2627362 INFO  (qtp1524859334-16270) [n:127.0.0.1:53163_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=CREATESHARD&collection=testCreateShardRepFactor&shard=x&wt=javabin&version=2}
 status=0 QTime=1522
   [junit4]   2> 2627364 INFO  
(TEST-CustomCollectionTest.testCreateShardRepFactor-seed#[6ABDE45BA9D1ED3]) [   
 ] o.a.s.SolrTestCaseJ4 ###Ending testCreateShardRepFactor
   [junit4]   2> 2627402 INFO  
(TEST-CustomCollectionTest.testRouteFieldForHashRouter-seed#[6ABDE45BA9D1ED3]) 
[    ] o.a.s.SolrTestCaseJ4 ###Starting testRouteFieldForHashRouter
   [junit4]   2> 2627404 INFO  
(TEST-CustomCollectionTest.testRouteFieldForHashRouter-seed#[6ABDE45BA9D1ED3]) 
[    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 2627407 INFO  (qtp1524859334-16272) [n:127.0.0.1:53163_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params 
name=testCreateShardRepFactor&action=DELETE&wt=javabin&version=2 and 
sendToOCPQueue=true
   [junit4]   2> 2627411 INFO  
(OverseerCollectionConfigSetProcessor-97685691436957706-127.0.0.1:53164_solr-n_0000000000)
 [n:127.0.0.1:53164_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> 2627411 INFO  
(OverseerThreadFactory-8583-thread-3-processing-n:127.0.0.1:53164_solr) 
[n:127.0.0.1:53164_solr    ] o.a.s.c.OverseerCollectionMessageHandler Executing 
Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true
   [junit4]   2> 2627414 INFO  (qtp1524859334-16273) [n:127.0.0.1:53163_solr    
] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.testCreateShardRepFactor.b.replica1, tag=null
   [junit4]   2> 2627414 INFO  (qtp1524859334-16273) [n:127.0.0.1:53163_solr    
] o.a.s.c.SolrCore [testCreateShardRepFactor_b_replica1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@9293bbb
   [junit4]   2> 2627417 INFO  (qtp1140603163-16257) [n:127.0.0.1:53161_solr    
] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.testCreateShardRepFactor.a.replica1, tag=null
   [junit4]   2> 2627418 INFO  (qtp1140603163-16257) [n:127.0.0.1:53161_solr    
] o.a.s.c.SolrCore [testCreateShardRepFactor_a_replica1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@5cb0f857
   [junit4]   2> 2627418 INFO  (qtp1524859334-16273) [n:127.0.0.1:53163_solr    
] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.testCreateShardRepFactor.b.replica1, tag=153697211
   [junit4]   2> 2627420 INFO  (qtp957983695-16266) [n:127.0.0.1:53162_solr    
] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.testCreateShardRepFactor.x.replica1, tag=null
   [junit4]   2> 2627420 INFO  (qtp1140603163-16257) [n:127.0.0.1:53161_solr    
] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.testCreateShardRepFactor.a.replica1, tag=1555101783
   [junit4]   2> 2627420 INFO  (qtp957983695-16266) [n:127.0.0.1:53162_solr    
] o.a.s.c.SolrCore [testCreateShardRepFactor_x_replica1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@26f9da3d
   [junit4]   2> 2627424 INFO  (qtp957983695-16266) [n:127.0.0.1:53162_solr    
] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.testCreateShardRepFactor.x.replica1, tag=653908541
   [junit4]   2> 2627425 INFO  (qtp1524859334-16273) [n:127.0.0.1:53163_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={deleteInstanceDir=true&core=testCreateShardRepFactor_b_replica1&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
 status=0 QTime=10
   [junit4]   2> 2627426 INFO  (qtp1140603163-16257) [n:127.0.0.1:53161_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={deleteInstanceDir=true&core=testCreateShardRepFactor_a_replica1&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
 status=0 QTime=8
   [junit4]   2> 2627429 INFO  (qtp957983695-16266) [n:127.0.0.1:53162_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={deleteInstanceDir=true&core=testCreateShardRepFactor_x_replica1&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
 status=0 QTime=9
   [junit4]   2> 2628152 INFO  (qtp1524859334-16272) [n:127.0.0.1:53163_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={name=testCreateShardRepFactor&action=DELETE&wt=javabin&version=2} 
status=0 QTime=745
   [junit4]   2> 2628153 INFO  (qtp1524859334-16275) [n:127.0.0.1:53163_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=2&collection.configName=conf&maxShardsPerNode=3&router.field=shard_s&name=routeFieldColl&action=CREATE&numShards=4&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2628157 INFO  
(OverseerThreadFactory-8583-thread-4-processing-n:127.0.0.1:53164_solr) 
[n:127.0.0.1:53164_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
routeFieldColl
   [junit4]   2> 2628157 INFO  
(OverseerCollectionConfigSetProcessor-97685691436957706-127.0.0.1:53164_solr-n_0000000000)
 [n:127.0.0.1:53164_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> 2628370 INFO  (qtp1524859334-16276) [n:127.0.0.1:53163_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard3_replica2&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard3&wt=javabin&version=2
   [junit4]   2> 2628371 INFO  (qtp1140603163-16258) [n:127.0.0.1:53161_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard3_replica1&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard3&wt=javabin&version=2
   [junit4]   2> 2628379 INFO  (qtp1140603163-16252) [n:127.0.0.1:53161_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard1_replica1&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard1&wt=javabin&version=2
   [junit4]   2> 2628380 INFO  (qtp1524859334-16274) [n:127.0.0.1:53163_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard1_replica2&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard1&wt=javabin&version=2
   [junit4]   2> 2628383 INFO  (qtp957983695-16267) [n:127.0.0.1:53162_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard4_replica1&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard4&wt=javabin&version=2
   [junit4]   2> 2628390 INFO  (qtp957983695-16261) [n:127.0.0.1:53162_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard2_replica1&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard2&wt=javabin&version=2
   [junit4]   2> 2628416 INFO  (qtp881600723-16286) [n:127.0.0.1:53164_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard2_replica2&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard2&wt=javabin&version=2
   [junit4]   2> 2628421 INFO  (qtp881600723-16282) [n:127.0.0.1:53164_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard4_replica2&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard4&wt=javabin&version=2
   [junit4]   2> 2628563 INFO  
(zkCallback-2671-thread-1-processing-n:127.0.0.1:53162_solr) 
[n:127.0.0.1:53162_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2628563 INFO  
(zkCallback-2673-thread-1-processing-n:127.0.0.1:53161_solr) 
[n:127.0.0.1:53161_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2628563 INFO  
(zkCallback-2672-thread-3-processing-n:127.0.0.1:53164_solr) 
[n:127.0.0.1:53164_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2628563 INFO  
(zkCallback-2674-thread-1-processing-n:127.0.0.1:53163_solr) 
[n:127.0.0.1:53163_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2629426 INFO  (qtp1524859334-16276) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica2] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2629435 INFO  (qtp1524859334-16274) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica2] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2629453 INFO  (qtp1524859334-16276) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica2] 
o.a.s.s.IndexSchema [routeFieldColl_shard3_replica2] Schema name=cloud-dynamic
   [junit4]   2> 2629455 INFO  (qtp1140603163-16258) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica1] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2629457 INFO  (qtp1140603163-16252) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica1] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2629464 INFO  (qtp957983695-16267) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica1] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2629465 INFO  (qtp957983695-16261) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica1] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2629487 INFO  (qtp1140603163-16258) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica1] 
o.a.s.s.IndexSchema [routeFieldColl_shard3_replica1] Schema name=cloud-dynamic
   [junit4]   2> 2629488 INFO  (qtp1140603163-16252) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica1] 
o.a.s.s.IndexSchema [routeFieldColl_shard1_replica1] Schema name=cloud-dynamic
   [junit4]   2> 2629489 WARN  (qtp1524859334-16276) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica2] 
o.a.s.s.IndexSchema [routeFieldColl_shard3_replica2] default search field in 
schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2629490 INFO  (qtp1524859334-16276) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica2] 
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2629497 INFO  (qtp881600723-16282) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica2] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2629497 INFO  (qtp881600723-16286) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica2] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2629514 INFO  (qtp881600723-16282) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica2] 
o.a.s.s.IndexSchema [routeFieldColl_shard4_replica2] Schema name=cloud-dynamic
   [junit4]   2> 2629514 INFO  (qtp881600723-16286) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica2] 
o.a.s.s.IndexSchema [routeFieldColl_shard2_replica2] Schema name=cloud-dynamic
   [junit4]   2> 2629515 WARN  (qtp1140603163-16252) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica1] 
o.a.s.s.IndexSchema [routeFieldColl_shard1_replica1] default search field in 
schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2629516 INFO  (qtp1140603163-16252) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica1] 
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2629519 INFO  (qtp1524859334-16274) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica2] 
o.a.s.s.IndexSchema [routeFieldColl_shard1_replica2] Schema name=cloud-dynamic
   [junit4]   2> 2629519 INFO  (qtp1140603163-16252) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica1] 
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard1_replica1' using 
configuration from collection routeFieldColl
   [junit4]   2> 2629520 INFO  (qtp1140603163-16252) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 2629520 INFO  (qtp1140603163-16252) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica1] o.a.s.c.SolrCore 
[[routeFieldColl_shard1_replica1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node3/routeFieldColl_shard1_replica1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node3/./routeFieldColl_shard1_replica1/data/]
   [junit4]   2> 2629541 INFO  (qtp1524859334-16276) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica2] 
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard3_replica2' using 
configuration from collection routeFieldColl
   [junit4]   2> 2629541 INFO  (qtp1524859334-16276) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica2] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 2629541 INFO  (qtp1524859334-16276) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica2] o.a.s.c.SolrCore 
[[routeFieldColl_shard3_replica2] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node4/routeFieldColl_shard3_replica2],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node4/./routeFieldColl_shard3_replica2/data/]
   [junit4]   2> 2629544 INFO  (qtp957983695-16261) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica1] 
o.a.s.s.IndexSchema [routeFieldColl_shard2_replica1] Schema name=cloud-dynamic
   [junit4]   2> 2629545 INFO  (qtp957983695-16267) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica1] 
o.a.s.s.IndexSchema [routeFieldColl_shard4_replica1] Schema name=cloud-dynamic
   [junit4]   2> 2629565 WARN  (qtp1140603163-16258) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica1] 
o.a.s.s.IndexSchema [routeFieldColl_shard3_replica1] default search field in 
schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2629567 INFO  (qtp1140603163-16258) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica1] 
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2629570 WARN  (qtp881600723-16282) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica2] 
o.a.s.s.IndexSchema [routeFieldColl_shard4_replica2] default search field in 
schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2629571 WARN  (qtp957983695-16267) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica1] 
o.a.s.s.IndexSchema [routeFieldColl_shard4_replica1] default search field in 
schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2629571 INFO  (qtp881600723-16282) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica2] 
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2629571 INFO  (qtp957983695-16267) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica1] 
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2629572 INFO  (qtp881600723-16282) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica2] 
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard4_replica2' using 
configuration from collection routeFieldColl
   [junit4]   2> 2629572 INFO  (qtp881600723-16282) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica2] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 2629572 INFO  (qtp957983695-16267) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica1] 
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard4_replica1' using 
configuration from collection routeFieldColl
   [junit4]   2> 2629572 INFO  (qtp881600723-16282) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica2] o.a.s.c.SolrCore 
[[routeFieldColl_shard4_replica2] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node1/routeFieldColl_shard4_replica2],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node1/./routeFieldColl_shard4_replica2/data/]
   [junit4]   2> 2629573 INFO  (qtp957983695-16267) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 2629573 INFO  (qtp957983695-16267) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica1] o.a.s.c.SolrCore 
[[routeFieldColl_shard4_replica1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node2/routeFieldColl_shard4_replica1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node2/./routeFieldColl_shard4_replica1/data/]
   [junit4]   2> 2629575 INFO  (qtp1140603163-16258) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica1] 
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard3_replica1' using 
configuration from collection routeFieldColl
   [junit4]   2> 2629575 INFO  (qtp1140603163-16258) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 2629575 INFO  (qtp1140603163-16258) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica1] o.a.s.c.SolrCore 
[[routeFieldColl_shard3_replica1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node3/routeFieldColl_shard3_replica1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node3/./routeFieldColl_shard3_replica1/data/]
   [junit4]   2> 2629576 WARN  (qtp957983695-16261) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica1] 
o.a.s.s.IndexSchema [routeFieldColl_shard2_replica1] default search field in 
schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2629577 INFO  (qtp957983695-16261) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica1] 
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2629578 INFO  (qtp957983695-16261) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica1] 
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard2_replica1' using 
configuration from collection routeFieldColl
   [junit4]   2> 2629579 INFO  (qtp957983695-16261) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 2629579 INFO  (qtp957983695-16261) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica1] o.a.s.c.SolrCore 
[[routeFieldColl_shard2_replica1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node2/routeFieldColl_shard2_replica1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node2/./routeFieldColl_shard2_replica1/data/]
   [junit4]   2> 2629579 WARN  (qtp1524859334-16274) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica2] 
o.a.s.s.IndexSchema [routeFieldColl_shard1_replica2] default search field in 
schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2629580 INFO  (qtp1524859334-16274) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica2] 
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2629580 INFO  (qtp1524859334-16274) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica2] 
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard1_replica2' using 
configuration from collection routeFieldColl
   [junit4]   2> 2629580 WARN  (qtp881600723-16286) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica2] 
o.a.s.s.IndexSchema [routeFieldColl_shard2_replica2] default search field in 
schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2629581 INFO  (qtp1524859334-16274) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica2] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 2629581 INFO  (qtp1524859334-16274) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica2] o.a.s.c.SolrCore 
[[routeFieldColl_shard1_replica2] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node4/routeFieldColl_shard1_replica2],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node4/./routeFieldColl_shard1_replica2/data/]
   [junit4]   2> 2629581 INFO  (qtp881600723-16286) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica2] 
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2629583 INFO  (qtp881600723-16286) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica2] 
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard2_replica2' using 
configuration from collection routeFieldColl
   [junit4]   2> 2629583 INFO  (qtp881600723-16286) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica2] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 2629583 INFO  (qtp881600723-16286) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica2] o.a.s.c.SolrCore 
[[routeFieldColl_shard2_replica2] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node1/routeFieldColl_shard2_replica2],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001/tempDir-001/node1/./routeFieldColl_shard2_replica2/data/]
   [junit4]   2> 2629713 INFO  (qtp1140603163-16252) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2629713 INFO  (qtp1140603163-16252) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2629715 INFO  (qtp1140603163-16252) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2629715 INFO  (qtp1140603163-16252) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2629727 INFO  (qtp1140603163-16252) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@2a51a876[routeFieldColl_shard1_replica1] main]
   [junit4]   2> 2629731 INFO  (qtp1140603163-16252) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2629732 INFO  (qtp1140603163-16252) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2629732 INFO  (qtp1140603163-16252) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2629732 INFO  
(searcherExecutor-8607-thread-1-processing-n:127.0.0.1:53161_solr 
x:routeFieldColl_shard1_replica1 s:shard1 c:routeFieldColl) 
[n:127.0.0.1:53161_solr c:routeFieldColl s:shard1  
x:routeFieldColl_shard1_replica1] o.a.s.c.SolrCore 
[routeFieldColl_shard1_replica1] Registered new searcher 
Searcher@2a51a876[routeFieldColl_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2629732 INFO  (qtp1140603163-16252) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica1] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1562971072597327872
   [junit4]   2> 2629736 INFO  (qtp881600723-16286) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica2] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2629736 INFO  (qtp881600723-16286) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica2] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2629743 INFO  (qtp881600723-16286) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica2] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2629743 INFO  (qtp881600723-16286) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica2] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2629749 INFO  (qtp881600723-16282) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica2] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2629749 INFO  (qtp881600723-16282) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica2] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2629750 INFO  (qtp1524859334-16274) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica2] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2629750 INFO  (qtp1524859334-16274) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica2] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2629751 INFO  (qtp881600723-16282) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica2] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2629751 INFO  (qtp881600723-16282) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica2] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2629751 INFO  (qtp1524859334-16274) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica2] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2629751 INFO  (qtp1524859334-16274) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica2] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2629752 INFO  (qtp957983695-16261) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2629752 INFO  (qtp957983695-16261) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2629753 INFO  (qtp1140603163-16258) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2629753 INFO  (qtp1140603163-16258) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2629754 INFO  (qtp957983695-16261) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2629754 INFO  (qtp957983695-16261) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2629755 INFO  (qtp1524859334-16276) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica2] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2629755 INFO  (qtp1524859334-16276) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica2] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2629755 INFO  (qtp1140603163-16258) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2629755 INFO  (qtp1140603163-16258) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2629756 INFO  (qtp881600723-16286) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica2] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@ba94749[routeFieldColl_shard2_replica2] main]
   [junit4]   2> 2629757 INFO  (qtp1524859334-16276) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica2] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2629757 INFO  (qtp1524859334-16276) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica2] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2629758 INFO  (qtp957983695-16267) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2629758 INFO  (qtp881600723-16286) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica2] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2629758 INFO  (qtp957983695-16267) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2629759 INFO  (qtp881600723-16286) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica2] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2629759 INFO  (qtp881600723-16286) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica2] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2629759 INFO  
(searcherExecutor-8614-thread-1-processing-n:127.0.0.1:53164_solr 
x:routeFieldColl_shard2_replica2 s:shard2 c:routeFieldColl) 
[n:127.0.0.1:53164_solr c:routeFieldColl s:shard2  
x:routeFieldColl_shard2_replica2] o.a.s.c.SolrCore 
[routeFieldColl_shard2_replica2] Registered new searcher 
Searcher@ba94749[routeFieldColl_shard2_replica2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2629759 INFO  (qtp881600723-16286) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica2] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1562971072625639424
   [junit4]   2> 2629760 INFO  (qtp881600723-16282) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica2] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@9fc5de9[routeFieldColl_shard4_replica2] main]
   [junit4]   2> 2629761 INFO  (qtp957983695-16267) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2629761 INFO  (qtp957983695-16267) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2629762 INFO  (qtp881600723-16282) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica2] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2629762 INFO  (qtp1524859334-16274) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica2] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@135175da[routeFieldColl_shard1_replica2] main]
   [junit4]   2> 2629762 INFO  (qtp957983695-16261) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@6cdff434[routeFieldColl_shard2_replica1] main]
   [junit4]   2> 2629763 INFO  (qtp881600723-16282) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica2] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2629763 INFO  (qtp881600723-16282) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica2] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2629763 INFO  
(searcherExecutor-8609-thread-1-processing-n:127.0.0.1:53164_solr 
x:routeFieldColl_shard4_replica2 s:shard4 c:routeFieldColl) 
[n:127.0.0.1:53164_solr c:routeFieldColl s:shard4  
x:routeFieldColl_shard4_replica2] o.a.s.c.SolrCore 
[routeFieldColl_shard4_replica2] Registered new searcher 
Searcher@9fc5de9[routeFieldColl_shard4_replica2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2629763 INFO  (qtp881600723-16282) [n:127.0.0.1:53164_solr 
c:routeFieldColl s:shard4  x:routeFieldColl_shard4_replica2] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1562971072629833728
   [junit4]   2> 2629766 INFO  (qtp957983695-16261) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2629766 INFO  (qtp1140603163-16258) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@26d15b4[routeFieldColl_shard3_replica1] main]
   [junit4]   2> 2629766 INFO  (qtp957983695-16261) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2629766 INFO  (qtp957983695-16261) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2629767 INFO  
(searcherExecutor-8612-thread-1-processing-n:127.0.0.1:53162_solr 
x:routeFieldColl_shard2_replica1 s:shard2 c:routeFieldColl) 
[n:127.0.0.1:53162_solr c:routeFieldColl s:shard2  
x:routeFieldColl_shard2_replica1] o.a.s.c.SolrCore 
[routeFieldColl_shard2_replica1] Registered new searcher 
Searcher@6cdff434[routeFieldColl_shard2_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2629767 INFO  (qtp957983695-16261) [n:127.0.0.1:53162_solr 
c:routeFieldColl s:shard2  x:routeFieldColl_shard2_replica1] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1562971072634028032
   [junit4]   2> 2629766 INFO  (qtp1524859334-16274) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica2] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2629768 INFO  (qtp1524859334-16276) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica2] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@72c3b612[routeFieldColl_shard3_replica2] main]
   [junit4]   2> 2629770 INFO  (qtp1524859334-16274) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica2] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2629770 INFO  (qtp1524859334-16274) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica2] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2629770 INFO  
(searcherExecutor-8613-thread-1-processing-n:127.0.0.1:53163_solr 
x:routeFieldColl_shard1_replica2 s:shard1 c:routeFieldColl) 
[n:127.0.0.1:53163_solr c:routeFieldColl s:shard1  
x:routeFieldColl_shard1_replica2] o.a.s.c.SolrCore 
[routeFieldColl_shard1_replica2] Registered new searcher 
Searcher@135175da[routeFieldColl_shard1_replica2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2629770 INFO  (qtp1524859334-16274) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard1  x:routeFieldColl_shard1_replica2] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1562971072637173760
   [junit4]   2> 2629771 INFO  (qtp1140603163-16258) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2629772 INFO  (qtp1140603163-16258) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2629772 INFO  (qtp1140603163-16258) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2629773 INFO  
(searcherExecutor-8611-thread-1-processing-n:127.0.0.1:53161_solr 
x:routeFieldColl_shard3_replica1 s:shard3 c:routeFieldColl) 
[n:127.0.0.1:53161_solr c:routeFieldColl s:shard3  
x:routeFieldColl_shard3_replica1] o.a.s.c.SolrCore 
[routeFieldColl_shard3_replica1] Registered new searcher 
Searcher@26d15b4[routeFieldColl_shard3_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2629773 INFO  (qtp1140603163-16258) [n:127.0.0.1:53161_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica1] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1562971072640319488
   [junit4]   2> 2629774 INFO  (qtp1524859334-16276) [n:127.0.0.1:53163_solr 
c:routeFieldColl s:shard3  x:routeFieldColl_shard3_replica2] 
o.a.s.r.ManagedResourceStorage Configured Z

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

FO  (SUITE-CustomCollectionTest-seed#[6ABDE45BA9D1ED3]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:53159 53159
   [junit4]   2> 2672932 INFO  (Thread-3538) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:53159 53159
   [junit4]   2> 2678866 WARN  (Thread-3538) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        14      /solr/configs/conf
   [junit4]   2>        9       /solr/aliases.json
   [junit4]   2>        4       /solr/security.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        9       /solr/clusterprops.json
   [junit4]   2>        9       /solr/clusterstate.json
   [junit4]   2>        4       
/solr/collections/testCreateShardRepFactor/state.json
   [junit4]   2>        4       /solr/collections/routeFieldColl/state.json
   [junit4]   2>        4       /solr/collections/implicitcoll/state.json
   [junit4]   2>        4       /solr/collections/withShardField/state.json
   [junit4]   2>        2       
/solr/collections/withShardField/leader_elect/b/election/97685691436957708-core_node5-n_0000000000
   [junit4]   2>        2       
/solr/overseer_elect/election/97685691436957708-127.0.0.1:53163_solr-n_0000000001
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        59      /solr/overseer/queue
   [junit4]   2>        37      /solr/overseer/collection-queue-work
   [junit4]   2>        27      /solr/collections
   [junit4]   2>        9       /solr/live_nodes
   [junit4]   2>        7       /solr/overseer/queue-work
   [junit4]   2> 
   [junit4]   2> 2678867 INFO  
(SUITE-CustomCollectionTest-seed#[6ABDE45BA9D1ED3]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_6ABDE45BA9D1ED3-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{shard_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
_version_=PostingsFormat(name=LuceneVarGapFixedInterval), 
id=Lucene50(blocksize=128)}, docValues:{}, maxPointsInLeafNode=106, 
maxMBSortInHeap=7.6383418106987815, sim=RandomSimilarity(queryNorm=false): {}, 
locale=sk-SK, timezone=America/Argentina/Tucuman
   [junit4]   2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 1.8.0_121 
(64-bit)/cpus=3,threads=1,free=171583360,total=492503040
   [junit4]   2> NOTE: All tests run in this JVM: 
[TestReversedWildcardFilterFactory, PreAnalyzedFieldManagedSchemaCloudTest, 
BJQParserTest, TestSolrCloudSnapshots, BufferStoreTest, 
TestSolrQueryParserDefaultOperatorResource, TestImpersonationWithHadoopAuth, 
TestRestManager, TestTrie, LeaderInitiatedRecoveryOnShardRestartTest, 
TestClassNameShortening, TestCrossCoreJoin, SegmentsInfoRequestHandlerTest, 
BooleanFieldTest, DistributedFacetExistsSmallTest, SolrInfoMBeanTest, 
TestSchemaResource, TestBlendedInfixSuggestions, SolrMetricsIntegrationTest, 
OpenCloseCoreStressTest, QueryParsingTest, HdfsNNFailoverTest, TestDistribIDF, 
BlobRepositoryCloudTest, TestAuthenticationFramework, TestFastWriter, 
TestDynamicFieldResource, TestLegacyNumericRangeQueryBuilder, TestPushWriter, 
ClassificationUpdateProcessorIntegrationTest, TestDeleteCollectionOnDownNodes, 
BasicFunctionalityTest, TestGraphMLResponseWriter, ExternalFileFieldSortTest, 
ShowFileRequestHandlerTest, LeaderElectionContextKeyTest, TestQueryUtils, 
SuggesterTSTTest, TestQuerySenderListener, TestFreeTextSuggestions, 
RegexBoostProcessorTest, CurrencyFieldOpenExchangeTest, 
TestClusterStateMutator, LeaderElectionIntegrationTest, SuggesterTest, 
TestRecoveryHdfs, CloudMLTQParserTest, TestRequestForwarding, 
HLLSerializationTest, TestUseDocValuesAsStored2, UtilsToolTest, GraphQueryTest, 
InfixSuggestersTest, TestFoldingMultitermQuery, EnumFieldTest, 
TestCollationFieldDocValues, TestXmlQParserPlugin, ScriptEngineTest, 
TestMissingGroups, RequestLoggingTest, TestDocSet, TestTrieFacet, 
ExitableDirectoryReaderTest, TestLegacyFieldCache, CleanupOldIndexTest, 
DirectUpdateHandlerOptimizeTest, VMParamsZkACLAndCredentialsProvidersTest, 
RemoteQueryErrorTest, SolrCmdDistributorTest, TemplateUpdateProcessorTest, 
HighlighterConfigTest, TestCorePropertiesReload, TestComponentsName, 
TestSolrIndexConfig, SparseHLLTest, TestConfigSetProperties, 
TestRandomFlRTGCloud, TestQueryWrapperFilter, BadIndexSchemaTest, 
ZkSolrClientTest, ShardRoutingCustomTest, TestClassicSimilarityFactory, 
TestLMJelinekMercerSimilarityFactory, TestPointFields, CacheHeaderTest, 
TestApiFramework, TestSchemalessBufferedUpdates, ReplicationFactorTest, 
SolrSlf4jReporterTest, TestAnalyzedSuggestions, TestInfoStreamLogging, 
TestUniqueKeyFieldResource, BlockJoinFacetRandomTest, 
TestShortCircuitedRequests, SuggestComponentContextFilterQueryTest, 
TestCloudPseudoReturnFields, UpdateRequestProcessorFactoryTest, 
TestCoreDiscovery, RuleEngineTest, CollectionTooManyReplicasTest, 
UpdateParamsTest, EchoParamsTest, TestPivotHelperCode, TestSearchPerf, 
TestScoreJoinQPScore, SaslZkACLProviderTest, CachingDirectoryFactoryTest, 
TestFilteredDocIdSet, TestStressRecovery, TestReload, 
IgnoreCommitOptimizeUpdateProcessorFactoryTest, AnalyticsQueryTest, 
BasicAuthIntegrationTest, SolrMetricManagerTest, SolrGraphiteReporterTest, 
TestMacroExpander, CollectionsAPISolrJTest, 
OverriddenZkACLAndCredentialsProvidersTest, TestSuggestSpellingConverter, 
MissingSegmentRecoveryTest, TestSolrCloudWithSecureImpersonation, 
CoreAdminRequestStatusTest, DeleteInactiveReplicaTest, CollectionReloadTest, 
JavabinLoaderTest, TestHdfsUpdateLog, OverseerModifyCollectionTest, 
HdfsLockFactoryTest, TestExactStatsCache, TestSystemIdResolver, TestConfig, 
SolrShardReporterTest, TestJoin, CheckHdfsIndexTest, AutoCommitTest, 
TestStressInPlaceUpdates, DistributedSuggestComponentTest, 
TestDistributedStatsComponentCardinality, TestManagedResource, 
DistributedIntervalFacetingTest, TestStandardQParsers, TestShardHandlerFactory, 
TestMiniSolrCloudClusterSSL, SimpleCollectionCreateDeleteTest, 
TestFuzzyAnalyzedSuggestions, ClusterStateTest, 
CloneFieldUpdateProcessorFactoryTest, SortByFunctionTest, 
TestObjectReleaseTracker, TestFieldResource, TestLuceneMatchVersion, 
BlockCacheTest, RequestHandlersTest, TestCustomSort, SuggesterWFSTTest, 
ZkStateWriterTest, AtomicUpdatesTest, CdcrVersionReplicationTest, 
TestBinaryResponseWriter, TestSolrCoreProperties, ConnectionReuseTest, 
DistributedDebugComponentTest, TestRawTransformer, TestSolrCLIRunExample, 
TestSolrCoreParser, UninvertDocValuesMergePolicyTest, TestConfigsApi, 
CdcrBootstrapTest, CSVRequestHandlerTest, IndexSchemaTest, 
ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, 
CollectionsAPIDistributedZkTest, SyncSliceTest, BasicZkTest, 
FullSolrCloudDistribCmdsTest, ClusterStateUpdateTest, TestRandomFaceting, 
LeaderElectionTest, TestZkChroot, TestRandomDVFaceting, TestDistributedSearch, 
TestDistributedGrouping, TestFaceting, TestRecovery, TestHashPartitioner, 
DistributedSpellCheckComponentTest, TermVectorComponentDistributedTest, 
TestRealTimeGet, TestStressVersions, HardAutoCommitTest, 
DistributedTermsComponentTest, TestRangeQuery, TestCoreContainer, 
SimpleFacetsTest, TestSolr4Spatial, StatsComponentTest, 
SpellCheckComponentTest, TestGroupingSearch, ConvertedLegacyTest, 
TestFiltering, TestLazyCores, TestBadConfig, TestIndexSearcher, 
HighlighterTest, SolrIndexSplitterTest, SimplePostToolTest, 
AnalysisAfterCoreReloadTest, SignatureUpdateProcessorFactoryTest, 
SpellCheckCollatorTest, SuggesterFSTTest, CoreAdminHandlerTest, DocValuesTest, 
PolyFieldTest, NoCacheHeaderTest, WordBreakSolrSpellCheckerTest, 
SchemaVersionSpecificBehaviorTest, SolrCoreCheckLockOnStartupTest, 
TestPseudoReturnFields, TestUpdate, FieldMutatingUpdateProcessorTest, 
TestAtomicUpdateErrorCases, TestWordDelimiterFilterFactory, 
DefaultValueUpdateProcessorTest, StatelessScriptUpdateProcessorFactoryTest, 
DocValuesMultiTest, DistanceFunctionTest, TestSolrDeletionPolicy1, 
DebugComponentTest, IndexBasedSpellCheckerTest, LukeRequestHandlerTest, 
StandardRequestHandlerTest, TestWriterPerf, DirectSolrSpellCheckerTest, 
DocumentAnalysisRequestHandlerTest, TestQueryTypes, PrimitiveFieldTypeTest, 
TestOmitPositions, FileBasedSpellCheckerTest, XmlUpdateRequestHandlerTest, 
DocumentBuilderTest, TestValueSourceCache, PathHierarchyTokenizerFactoryTest, 
TermVectorComponentTest, TestIndexingPerformance, MoreLikeThisHandlerTest, 
FieldAnalysisRequestHandlerTest, TestSolrQueryParser, 
FastVectorHighlighterTest, IndexSchemaRuntimeFieldTest, LoggingHandlerTest, 
SolrPluginUtilsTest, TestJmxIntegration, ReturnFieldsTest, 
TestCSVResponseWriter, MBeansHandlerTest, JsonLoaderTest, 
TestPHPSerializedResponseWriter, SearchHandlerTest, AlternateDirectoryTest, 
CopyFieldTest, ResponseLogComponentTest, SolrIndexConfigTest, BadComponentTest, 
TestSolrDeletionPolicy2, MultiTermTest, TestBinaryField, MinimalSchemaTest, 
OutputWriterTest, DirectSolrConnectionTest, NotRequiredUniqueKeyTest, 
SpellPossibilityIteratorTest, TestCodecSupport, SynonymTokenizerTest, 
TestDFRSimilarityFactory, TestLMDirichletSimilarityFactory, 
TestBM25SimilarityFactory, TestJmxMonitoredMap, ResourceLoaderTest, 
OpenExchangeRatesOrgProviderTest, URLClassifyProcessorTest, PluginInfoTest, 
DateMathParserTest, ChaosMonkeyNothingIsSafeTest, PreAnalyzedFieldTest, 
PrimUtilsTest, SpellingQueryConverterTest, RAMDirectoryFactoryTest, 
TestLRUCache, TestUtils, ZkNodePropsTest, SliceStateTest, 
SystemInfoHandlerTest, UUIDFieldTest, CircularListTest, 
DistributedMLTComponentTest, CursorPagingTest, SolrTestCaseJ4Test, 
TestDistributedMissingSort, TestSimpleTrackingShardHandler, TestPathTrie, 
TestEmbeddedSolrServerSchemaAPI, AliasIntegrationTest, 
AsyncCallRequestStatusResponseTest, BaseCdcrDistributedZkTest, 
CdcrReplicationHandlerTest, CollectionStateFormat2Test, 
CollectionsAPIAsyncDistributedZkTest, ConcurrentDeleteAndCreateCollectionTest, 
ConfigSetsAPITest, CreateCollectionCleanupTest, CustomCollectionTest]
   [junit4] Completed [456/701 (1!)] on J1 in 58.32s, 4 tests, 1 error <<< 
FAILURES!

[...truncated 44107 lines...]

---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to