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

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

Error Message:
Collection not found: withShardField

Stack Trace:
org.apache.solr.common.SolrException: Collection not found: withShardField
        at 
__randomizedtesting.SeedInfo.seed([7132144B0BEC835E:2462FCD9A7154CAE]:0)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:842)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:808)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:183)
        at 
org.apache.solr.client.solrj.request.UpdateRequest.commit(UpdateRequest.java:233)
        at 
org.apache.solr.cloud.CustomCollectionTest.testRouteFieldForImplicitRouter(CustomCollectionTest.java:141)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 13206 lines...]
   [junit4] Suite: org.apache.solr.cloud.CustomCollectionTest
   [junit4]   2> 2134533 INFO  
(SUITE-CustomCollectionTest-seed#[7132144B0BEC835E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001/init-core-data-001
   [junit4]   2> 2134534 WARN  
(SUITE-CustomCollectionTest-seed#[7132144B0BEC835E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=4 numCloses=4
   [junit4]   2> 2134534 INFO  
(SUITE-CustomCollectionTest-seed#[7132144B0BEC835E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 2134537 INFO  
(SUITE-CustomCollectionTest-seed#[7132144B0BEC835E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) 
w/ MAC_OS_X supressed clientAuth
   [junit4]   2> 2134538 INFO  
(SUITE-CustomCollectionTest-seed#[7132144B0BEC835E]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in 
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001/tempDir-001
   [junit4]   2> 2134538 INFO  
(SUITE-CustomCollectionTest-seed#[7132144B0BEC835E]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2134538 INFO  (Thread-3509) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2134539 INFO  (Thread-3509) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 2134546 ERROR (Thread-3509) [    ] o.a.z.s.ZooKeeperServer 
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action 
on ERROR or SHUTDOWN server state changes
   [junit4]   2> 2134641 INFO  
(SUITE-CustomCollectionTest-seed#[7132144B0BEC835E]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:63073
   [junit4]   2> 2134663 INFO  (jetty-launcher-2988-thread-2) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 2134663 INFO  (jetty-launcher-2988-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 2134663 INFO  (jetty-launcher-2988-thread-3) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 2134664 INFO  (jetty-launcher-2988-thread-4) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 2134665 INFO  (jetty-launcher-2988-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@70d91933{/solr,null,AVAILABLE}
   [junit4]   2> 2134666 INFO  (jetty-launcher-2988-thread-2) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@4accb50a{HTTP/1.1,[http/1.1]}{127.0.0.1:63075}
   [junit4]   2> 2134666 INFO  (jetty-launcher-2988-thread-2) [    ] 
o.e.j.s.Server Started @2139791ms
   [junit4]   2> 2134666 INFO  (jetty-launcher-2988-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=63075}
   [junit4]   2> 2134666 ERROR (jetty-launcher-2988-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2134666 INFO  (jetty-launcher-2988-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.2.0
   [junit4]   2> 2134666 INFO  (jetty-launcher-2988-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2134666 INFO  (jetty-launcher-2988-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@7996eab6{/solr,null,AVAILABLE}
   [junit4]   2> 2134666 INFO  (jetty-launcher-2988-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2134666 INFO  (jetty-launcher-2988-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-06T08:08:46.500Z
   [junit4]   2> 2134667 INFO  (jetty-launcher-2988-thread-3) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@166e13bf{HTTP/1.1,[http/1.1]}{127.0.0.1:63076}
   [junit4]   2> 2134667 INFO  (jetty-launcher-2988-thread-3) [    ] 
o.e.j.s.Server Started @2139792ms
   [junit4]   2> 2134667 INFO  (jetty-launcher-2988-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=63076}
   [junit4]   2> 2134667 ERROR (jetty-launcher-2988-thread-3) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2134667 INFO  (jetty-launcher-2988-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.2.0
   [junit4]   2> 2134667 INFO  (jetty-launcher-2988-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2134667 INFO  (jetty-launcher-2988-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2134667 INFO  (jetty-launcher-2988-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-06T08:08:46.501Z
   [junit4]   2> 2134669 INFO  (jetty-launcher-2988-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@20ac1e6b{/solr,null,AVAILABLE}
   [junit4]   2> 2134669 INFO  (jetty-launcher-2988-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@169f210c{HTTP/1.1,[http/1.1]}{127.0.0.1:63078}
   [junit4]   2> 2134669 INFO  (jetty-launcher-2988-thread-1) [    ] 
o.e.j.s.Server Started @2139795ms
   [junit4]   2> 2134669 INFO  (jetty-launcher-2988-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=63078}
   [junit4]   2> 2134670 ERROR (jetty-launcher-2988-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2134670 INFO  (jetty-launcher-2988-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.2.0
   [junit4]   2> 2134670 INFO  (jetty-launcher-2988-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2134670 INFO  (jetty-launcher-2988-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2134670 INFO  (jetty-launcher-2988-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-06T08:08:46.504Z
   [junit4]   2> 2134670 INFO  (jetty-launcher-2988-thread-4) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@4d8e2abd{/solr,null,AVAILABLE}
   [junit4]   2> 2134670 INFO  (jetty-launcher-2988-thread-4) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@74341eed{HTTP/1.1,[http/1.1]}{127.0.0.1:63079}
   [junit4]   2> 2134670 INFO  (jetty-launcher-2988-thread-4) [    ] 
o.e.j.s.Server Started @2139796ms
   [junit4]   2> 2134670 INFO  (jetty-launcher-2988-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=63079}
   [junit4]   2> 2134671 ERROR (jetty-launcher-2988-thread-4) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2134671 INFO  (jetty-launcher-2988-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.2.0
   [junit4]   2> 2134671 INFO  (jetty-launcher-2988-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2134671 INFO  (jetty-launcher-2988-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2134671 INFO  (jetty-launcher-2988-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-06T08:08:46.505Z
   [junit4]   2> 2134674 INFO  (jetty-launcher-2988-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2134675 INFO  (jetty-launcher-2988-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2134675 INFO  (jetty-launcher-2988-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2134675 INFO  (jetty-launcher-2988-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2134687 INFO  (jetty-launcher-2988-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:63073/solr
   [junit4]   2> 2134688 INFO  (jetty-launcher-2988-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:63073/solr
   [junit4]   2> 2134689 INFO  (jetty-launcher-2988-thread-3) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:63073/solr
   [junit4]   2> 2134690 INFO  (jetty-launcher-2988-thread-4) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:63073/solr
   [junit4]   2> 2134858 INFO  (jetty-launcher-2988-thread-4) 
[n:127.0.0.1:63079_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2134858 INFO  (jetty-launcher-2988-thread-1) 
[n:127.0.0.1:63078_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2134858 INFO  (jetty-launcher-2988-thread-4) 
[n:127.0.0.1:63079_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:63079_solr
   [junit4]   2> 2134863 INFO  (jetty-launcher-2988-thread-1) 
[n:127.0.0.1:63078_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:63078_solr
   [junit4]   2> 2134864 INFO  (jetty-launcher-2988-thread-4) 
[n:127.0.0.1:63079_solr    ] o.a.s.c.Overseer Overseer 
(id=98956458483843084-127.0.0.1:63079_solr-n_0000000000) starting
   [junit4]   2> 2134867 INFO  
(zkCallback-3008-thread-1-processing-n:127.0.0.1:63078_solr) 
[n:127.0.0.1:63078_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2134869 INFO  
(zkCallback-3010-thread-1-processing-n:127.0.0.1:63079_solr) 
[n:127.0.0.1:63079_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2134887 INFO  (jetty-launcher-2988-thread-4) 
[n:127.0.0.1:63079_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:63079_solr
   [junit4]   2> 2134901 INFO  
(zkCallback-3008-thread-1-processing-n:127.0.0.1:63078_solr) 
[n:127.0.0.1:63078_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 2134901 INFO  
(zkCallback-3010-thread-1-processing-n:127.0.0.1:63079_solr) 
[n:127.0.0.1:63079_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 2134920 INFO  (jetty-launcher-2988-thread-3) 
[n:127.0.0.1:63076_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 2134924 INFO  (jetty-launcher-2988-thread-3) 
[n:127.0.0.1:63076_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2134935 INFO  (jetty-launcher-2988-thread-3) 
[n:127.0.0.1:63076_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:63076_solr
   [junit4]   2> 2134949 INFO  
(zkCallback-3009-thread-1-processing-n:127.0.0.1:63076_solr) 
[n:127.0.0.1:63076_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 2134956 INFO  
(zkCallback-3008-thread-1-processing-n:127.0.0.1:63078_solr) 
[n:127.0.0.1:63078_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 2134956 INFO  
(zkCallback-3010-thread-1-processing-n:127.0.0.1:63079_solr) 
[n:127.0.0.1:63079_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 2134996 INFO  (jetty-launcher-2988-thread-1) 
[n:127.0.0.1:63078_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63078.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@74ac9908
   [junit4]   2> 2135006 INFO  (jetty-launcher-2988-thread-2) 
[n:127.0.0.1:63075_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 2135008 INFO  (jetty-launcher-2988-thread-2) 
[n:127.0.0.1:63075_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2135011 INFO  (jetty-launcher-2988-thread-2) 
[n:127.0.0.1:63075_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:63075_solr
   [junit4]   2> 2135012 INFO  
(zkCallback-3008-thread-1-processing-n:127.0.0.1:63078_solr) 
[n:127.0.0.1:63078_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2135012 INFO  
(zkCallback-3009-thread-1-processing-n:127.0.0.1:63076_solr) 
[n:127.0.0.1:63076_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2135015 INFO  
(zkCallback-3007-thread-1-processing-n:127.0.0.1:63075_solr) 
[n:127.0.0.1:63075_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2135015 INFO  (jetty-launcher-2988-thread-1) 
[n:127.0.0.1:63078_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63078.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@74ac9908
   [junit4]   2> 2135016 INFO  (jetty-launcher-2988-thread-1) 
[n:127.0.0.1:63078_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63078.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@74ac9908
   [junit4]   2> 2135016 INFO  (jetty-launcher-2988-thread-1) 
[n:127.0.0.1:63078_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001/tempDir-001/node1/.
   [junit4]   2> 2135038 INFO  
(zkCallback-3010-thread-1-processing-n:127.0.0.1:63079_solr) 
[n:127.0.0.1:63079_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2135049 INFO  (jetty-launcher-2988-thread-3) 
[n:127.0.0.1:63076_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63076.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@74ac9908
   [junit4]   2> 2135058 INFO  (jetty-launcher-2988-thread-4) 
[n:127.0.0.1:63079_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63079.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@74ac9908
   [junit4]   2> 2135067 WARN  (jetty-launcher-2988-thread-3) 
[n:127.0.0.1:63076_solr    ] o.a.s.m.r.j.JmxMetricsReporter Unable to register 
gauge
   [junit4]   2> javax.management.InstanceNotFoundException: 
solr_63076:dom1=solr,dom2=jvm,name0=os,name=freePhysicalMemorySize
   [junit4]   2>        at 
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1095)
   [junit4]   2>        at 
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:427)
   [junit4]   2>        at 
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:415)
   [junit4]   2>        at 
com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:546)
   [junit4]   2>        at 
org.apache.solr.metrics.reporters.jmx.JmxMetricsReporter$JmxListener.registerMBean(JmxMetricsReporter.java:530)
   [junit4]   2>        at 
org.apache.solr.metrics.reporters.jmx.JmxMetricsReporter$JmxListener.onGaugeAdded(JmxMetricsReporter.java:565)
   [junit4]   2>        at 
org.apache.solr.metrics.reporters.jmx.JmxMetricsReporter.lambda$start$0(JmxMetricsReporter.java:738)
   [junit4]   2>        at java.util.HashMap.forEach(HashMap.java:1288)
   [junit4]   2>        at 
org.apache.solr.metrics.reporters.jmx.JmxMetricsReporter.start(JmxMetricsReporter.java:728)
   [junit4]   2>        at 
org.apache.solr.metrics.reporters.SolrJmxReporter.doInit(SolrJmxReporter.java:109)
   [junit4]   2>        at 
org.apache.solr.metrics.SolrMetricReporter.init(SolrMetricReporter.java:70)
   [junit4]   2>        at 
org.apache.solr.metrics.SolrMetricManager.loadReporter(SolrMetricManager.java:883)
   [junit4]   2>        at 
org.apache.solr.metrics.SolrMetricManager.loadReporters(SolrMetricManager.java:819)
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.load(CoreContainer.java:549)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.createCoreContainer(SolrDispatchFilter.java:263)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.init(SolrDispatchFilter.java:183)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.FilterHolder.initialize(FilterHolder.java:139)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.initialize(ServletHandler.java:873)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.updateMappings(ServletHandler.java:1596)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.setFilterMappings(ServletHandler.java:1659)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.addFilterMapping(ServletHandler.java:1316)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.addFilterWithMapping(ServletHandler.java:1145)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletContextHandler.addFilter(ServletContextHandler.java:448)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$1.lifeCycleStarted(JettySolrRunner.java:306)
   [junit4]   2>        at 
org.eclipse.jetty.util.component.AbstractLifeCycle.setStarted(AbstractLifeCycle.java:179)
   [junit4]   2>        at 
org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:69)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:394)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:367)
   [junit4]   2>        at 
org.apache.solr.cloud.MiniSolrCloudCluster.startJettySolrRunner(MiniSolrCloudCluster.java:384)
   [junit4]   2>        at 
org.apache.solr.cloud.MiniSolrCloudCluster.lambda$new$0(MiniSolrCloudCluster.java:247)
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 2135086 INFO  (jetty-launcher-2988-thread-4) 
[n:127.0.0.1:63079_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63079.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@74ac9908
   [junit4]   2> 2135086 INFO  (jetty-launcher-2988-thread-4) 
[n:127.0.0.1:63079_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63079.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@74ac9908
   [junit4]   2> 2135093 INFO  (jetty-launcher-2988-thread-4) 
[n:127.0.0.1:63079_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001/tempDir-001/node4/.
   [junit4]   2> 2135094 INFO  (jetty-launcher-2988-thread-3) 
[n:127.0.0.1:63076_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63076.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@74ac9908
   [junit4]   2> 2135094 INFO  (jetty-launcher-2988-thread-3) 
[n:127.0.0.1:63076_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63076.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@74ac9908
   [junit4]   2> 2135097 INFO  (jetty-launcher-2988-thread-3) 
[n:127.0.0.1:63076_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001/tempDir-001/node3/.
   [junit4]   2> 2135101 INFO  (jetty-launcher-2988-thread-2) 
[n:127.0.0.1:63075_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63075.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@74ac9908
   [junit4]   2> 2135108 INFO  (jetty-launcher-2988-thread-2) 
[n:127.0.0.1:63075_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63075.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@74ac9908
   [junit4]   2> 2135108 INFO  (jetty-launcher-2988-thread-2) 
[n:127.0.0.1:63075_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63075.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@74ac9908
   [junit4]   2> 2135109 INFO  (jetty-launcher-2988-thread-2) 
[n:127.0.0.1:63075_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001/tempDir-001/node2/.
   [junit4]   2> 2135195 INFO  
(SUITE-CustomCollectionTest-seed#[7132144B0BEC835E]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 2135196 INFO  
(SUITE-CustomCollectionTest-seed#[7132144B0BEC835E]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:63073/solr ready
   [junit4]   2> 2135395 INFO  
(TEST-CustomCollectionTest.testRouteFieldForHashRouter-seed#[7132144B0BEC835E]) 
[    ] o.a.s.SolrTestCaseJ4 ###Starting testRouteFieldForHashRouter
   [junit4]   2> 2135397 INFO  
(TEST-CustomCollectionTest.testRouteFieldForHashRouter-seed#[7132144B0BEC835E]) 
[    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 2135412 INFO  (qtp946284992-18399) [n:127.0.0.1:63076_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&nrtReplicas=2&action=CREATE&numShards=4&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2135417 INFO  
(OverseerThreadFactory-9079-thread-1-processing-n:127.0.0.1:63079_solr) 
[n:127.0.0.1:63079_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
routeFieldColl
   [junit4]   2> 2135535 INFO  
(OverseerStateUpdate-98956458483843084-127.0.0.1:63079_solr-n_0000000000) 
[n:127.0.0.1:63079_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"routeFieldColl",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"routeFieldColl_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:63078/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2135539 INFO  
(OverseerStateUpdate-98956458483843084-127.0.0.1:63079_solr-n_0000000000) 
[n:127.0.0.1:63079_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"routeFieldColl",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"routeFieldColl_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:63079/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2135542 INFO  
(OverseerStateUpdate-98956458483843084-127.0.0.1:63079_solr-n_0000000000) 
[n:127.0.0.1:63079_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"routeFieldColl",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"routeFieldColl_shard2_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:63076/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2135545 INFO  
(OverseerStateUpdate-98956458483843084-127.0.0.1:63079_solr-n_0000000000) 
[n:127.0.0.1:63079_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"routeFieldColl",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"routeFieldColl_shard2_replica_n6",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:63075/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2135548 INFO  
(OverseerStateUpdate-98956458483843084-127.0.0.1:63079_solr-n_0000000000) 
[n:127.0.0.1:63079_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"routeFieldColl",
   [junit4]   2>   "shard":"shard3",
   [junit4]   2>   "core":"routeFieldColl_shard3_replica_n8",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:63078/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2135552 INFO  
(OverseerStateUpdate-98956458483843084-127.0.0.1:63079_solr-n_0000000000) 
[n:127.0.0.1:63079_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"routeFieldColl",
   [junit4]   2>   "shard":"shard3",
   [junit4]   2>   "core":"routeFieldColl_shard3_replica_n10",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:63079/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2135555 INFO  
(OverseerStateUpdate-98956458483843084-127.0.0.1:63079_solr-n_0000000000) 
[n:127.0.0.1:63079_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"routeFieldColl",
   [junit4]   2>   "shard":"shard4",
   [junit4]   2>   "core":"routeFieldColl_shard4_replica_n12",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:63076/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2135559 INFO  
(OverseerStateUpdate-98956458483843084-127.0.0.1:63079_solr-n_0000000000) 
[n:127.0.0.1:63079_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"routeFieldColl",
   [junit4]   2>   "shard":"shard4",
   [junit4]   2>   "core":"routeFieldColl_shard4_replica_n14",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:63075/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2135783 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node15&collection.configName=conf&newCollection=true&name=routeFieldColl_shard4_replica_n12&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard4&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2135783 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=routeFieldColl_shard2_replica_n4&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2135784 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node11&collection.configName=conf&newCollection=true&name=routeFieldColl_shard3_replica_n8&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard3&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2135784 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 2135783 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=routeFieldColl_shard1_replica_n1&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2135784 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 2135789 INFO  (qtp887761522-18384) [n:127.0.0.1:63075_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node9&collection.configName=conf&newCollection=true&name=routeFieldColl_shard2_replica_n6&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2135789 INFO  (qtp887761522-18385) [n:127.0.0.1:63075_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node16&collection.configName=conf&newCollection=true&name=routeFieldColl_shard4_replica_n14&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard4&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2135789 INFO  (qtp1229893218-18394) [n:127.0.0.1:63079_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=routeFieldColl_shard1_replica_n2&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2135790 INFO  (qtp887761522-18384) [n:127.0.0.1:63075_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 2135790 INFO  (qtp1229893218-18394) [n:127.0.0.1:63079_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 2135790 INFO  (qtp1229893218-18396) [n:127.0.0.1:63079_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node13&collection.configName=conf&newCollection=true&name=routeFieldColl_shard3_replica_n10&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard3&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2135913 INFO  
(zkCallback-3008-thread-1-processing-n:127.0.0.1:63078_solr) 
[n:127.0.0.1:63078_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> 2135913 INFO  
(zkCallback-3007-thread-1-processing-n:127.0.0.1:63075_solr) 
[n:127.0.0.1:63075_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> 2135913 INFO  
(zkCallback-3009-thread-1-processing-n:127.0.0.1:63076_solr) 
[n:127.0.0.1:63076_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> 2135914 INFO  
(zkCallback-3008-thread-2-processing-n:127.0.0.1:63078_solr) 
[n:127.0.0.1:63078_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> 2135914 INFO  
(zkCallback-3007-thread-2-processing-n:127.0.0.1:63075_solr) 
[n:127.0.0.1:63075_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> 2135914 INFO  
(zkCallback-3009-thread-2-processing-n:127.0.0.1:63076_solr) 
[n:127.0.0.1:63076_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> 2135915 INFO  
(zkCallback-3010-thread-1-processing-n:127.0.0.1:63079_solr) 
[n:127.0.0.1:63079_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> 2135915 INFO  
(zkCallback-3010-thread-2-processing-n:127.0.0.1:63079_solr) 
[n:127.0.0.1:63079_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> 2136828 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 2136829 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 2136831 INFO  (qtp887761522-18385) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard4 r:core_node16 x:routeFieldColl_shard4_replica_n14] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 2136833 INFO  (qtp887761522-18384) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard2 r:core_node9 x:routeFieldColl_shard2_replica_n6] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 2136848 INFO  (qtp1229893218-18394) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard1 r:core_node5 x:routeFieldColl_shard1_replica_n2] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 2136851 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 2136852 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 2136855 INFO  (qtp1229893218-18396) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard3 r:core_node13 x:routeFieldColl_shard3_replica_n10] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 2136860 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.s.IndexSchema [routeFieldColl_shard4_replica_n12] Schema 
name=cloud-dynamic
   [junit4]   2> 2136860 INFO  (qtp887761522-18384) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard2 r:core_node9 x:routeFieldColl_shard2_replica_n6] 
o.a.s.s.IndexSchema [routeFieldColl_shard2_replica_n6] Schema name=cloud-dynamic
   [junit4]   2> 2136861 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.s.IndexSchema [routeFieldColl_shard1_replica_n1] Schema name=cloud-dynamic
   [junit4]   2> 2136870 INFO  (qtp1229893218-18394) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard1 r:core_node5 x:routeFieldColl_shard1_replica_n2] 
o.a.s.s.IndexSchema [routeFieldColl_shard1_replica_n2] Schema name=cloud-dynamic
   [junit4]   2> 2136876 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.s.IndexSchema [routeFieldColl_shard3_replica_n8] Schema name=cloud-dynamic
   [junit4]   2> 2136877 INFO  (qtp887761522-18384) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard2 r:core_node9 x:routeFieldColl_shard2_replica_n6] 
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2136877 INFO  (qtp887761522-18384) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard2 r:core_node9 x:routeFieldColl_shard2_replica_n6] 
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard2_replica_n6' 
using configuration from collection routeFieldColl, trusted=true
   [junit4]   2> 2136877 INFO  (qtp887761522-18384) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard2 r:core_node9 x:routeFieldColl_shard2_replica_n6] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63075.solr.core.routeFieldColl.shard2.replica_n6' (registry 
'solr.core.routeFieldColl.shard2.replica_n6') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@74ac9908
   [junit4]   2> 2136878 INFO  (qtp887761522-18384) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard2 r:core_node9 x:routeFieldColl_shard2_replica_n6] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2136878 INFO  (qtp887761522-18384) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard2 r:core_node9 x:routeFieldColl_shard2_replica_n6] 
o.a.s.c.SolrCore [[routeFieldColl_shard2_replica_n6] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001/tempDir-001/node2/routeFieldColl_shard2_replica_n6],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001/tempDir-001/node2/./routeFieldColl_shard2_replica_n6/data/]
   [junit4]   2> 2136882 INFO  (qtp1229893218-18396) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard3 r:core_node13 x:routeFieldColl_shard3_replica_n10] 
o.a.s.s.IndexSchema [routeFieldColl_shard3_replica_n10] Schema 
name=cloud-dynamic
   [junit4]   2> 2136907 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2136907 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard4_replica_n12' 
using configuration from collection routeFieldColl, trusted=true
   [junit4]   2> 2136907 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63076.solr.core.routeFieldColl.shard4.replica_n12' (registry 
'solr.core.routeFieldColl.shard4.replica_n12') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@74ac9908
   [junit4]   2> 2136907 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2136907 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2136907 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.c.SolrCore [[routeFieldColl_shard4_replica_n12] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001/tempDir-001/node3/routeFieldColl_shard4_replica_n12],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001/tempDir-001/node3/./routeFieldColl_shard4_replica_n12/data/]
   [junit4]   2> 2136908 INFO  (qtp887761522-18385) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard4 r:core_node16 x:routeFieldColl_shard4_replica_n14] 
o.a.s.s.IndexSchema [routeFieldColl_shard4_replica_n14] Schema 
name=cloud-dynamic
   [junit4]   2> 2136907 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard3_replica_n8' 
using configuration from collection routeFieldColl, trusted=true
   [junit4]   2> 2136909 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63078.solr.core.routeFieldColl.shard3.replica_n8' (registry 
'solr.core.routeFieldColl.shard3.replica_n8') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@74ac9908
   [junit4]   2> 2136909 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2136909 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.c.SolrCore [[routeFieldColl_shard3_replica_n8] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001/tempDir-001/node1/routeFieldColl_shard3_replica_n8],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001/tempDir-001/node1/./routeFieldColl_shard3_replica_n8/data/]
   [junit4]   2> 2136914 INFO  (qtp1229893218-18394) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard1 r:core_node5 x:routeFieldColl_shard1_replica_n2] 
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2136914 INFO  (qtp1229893218-18394) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard1 r:core_node5 x:routeFieldColl_shard1_replica_n2] 
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard1_replica_n2' 
using configuration from collection routeFieldColl, trusted=true
   [junit4]   2> 2136914 INFO  (qtp1229893218-18394) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard1 r:core_node5 x:routeFieldColl_shard1_replica_n2] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63079.solr.core.routeFieldColl.shard1.replica_n2' (registry 
'solr.core.routeFieldColl.shard1.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@74ac9908
   [junit4]   2> 2136915 INFO  (qtp1229893218-18394) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard1 r:core_node5 x:routeFieldColl_shard1_replica_n2] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2136915 INFO  (qtp1229893218-18394) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard1 r:core_node5 x:routeFieldColl_shard1_replica_n2] 
o.a.s.c.SolrCore [[routeFieldColl_shard1_replica_n2] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001/tempDir-001/node4/routeFieldColl_shard1_replica_n2],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001/tempDir-001/node4/./routeFieldColl_shard1_replica_n2/data/]
   [junit4]   2> 2136917 INFO  (qtp1229893218-18396) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard3 r:core_node13 x:routeFieldColl_shard3_replica_n10] 
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2136917 INFO  (qtp1229893218-18396) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard3 r:core_node13 x:routeFieldColl_shard3_replica_n10] 
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard3_replica_n10' 
using configuration from collection routeFieldColl, trusted=true
   [junit4]   2> 2136918 INFO  (qtp1229893218-18396) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard3 r:core_node13 x:routeFieldColl_shard3_replica_n10] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63079.solr.core.routeFieldColl.shard3.replica_n10' (registry 
'solr.core.routeFieldColl.shard3.replica_n10') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@74ac9908
   [junit4]   2> 2136918 INFO  (qtp1229893218-18396) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard3 r:core_node13 x:routeFieldColl_shard3_replica_n10] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2136918 INFO  (qtp1229893218-18396) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard3 r:core_node13 x:routeFieldColl_shard3_replica_n10] 
o.a.s.c.SolrCore [[routeFieldColl_shard3_replica_n10] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001/tempDir-001/node4/routeFieldColl_shard3_replica_n10],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001/tempDir-001/node4/./routeFieldColl_shard3_replica_n10/data/]
   [junit4]   2> 2136926 INFO  (qtp887761522-18385) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard4 r:core_node16 x:routeFieldColl_shard4_replica_n14] 
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2136926 INFO  (qtp887761522-18385) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard4 r:core_node16 x:routeFieldColl_shard4_replica_n14] 
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard4_replica_n14' 
using configuration from collection routeFieldColl, trusted=true
   [junit4]   2> 2136927 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2136927 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard1_replica_n1' 
using configuration from collection routeFieldColl, trusted=true
   [junit4]   2> 2136927 INFO  (qtp887761522-18385) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard4 r:core_node16 x:routeFieldColl_shard4_replica_n14] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63075.solr.core.routeFieldColl.shard4.replica_n14' (registry 
'solr.core.routeFieldColl.shard4.replica_n14') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@74ac9908
   [junit4]   2> 2136927 INFO  (qtp887761522-18385) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard4 r:core_node16 x:routeFieldColl_shard4_replica_n14] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2136927 INFO  (qtp887761522-18385) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard4 r:core_node16 x:routeFieldColl_shard4_replica_n14] 
o.a.s.c.SolrCore [[routeFieldColl_shard4_replica_n14] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001/tempDir-001/node2/routeFieldColl_shard4_replica_n14],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001/tempDir-001/node2/./routeFieldColl_shard4_replica_n14/data/]
   [junit4]   2> 2136927 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63078.solr.core.routeFieldColl.shard1.replica_n1' (registry 
'solr.core.routeFieldColl.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@74ac9908
   [junit4]   2> 2136927 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2136927 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.c.SolrCore [[routeFieldColl_shard1_replica_n1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001/tempDir-001/node1/routeFieldColl_shard1_replica_n1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001/tempDir-001/node1/./routeFieldColl_shard1_replica_n1/data/]
   [junit4]   2> 2136928 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.s.IndexSchema [routeFieldColl_shard2_replica_n4] Schema name=cloud-dynamic
   [junit4]   2> 2136941 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2136942 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard2_replica_n4' 
using configuration from collection routeFieldColl, trusted=true
   [junit4]   2> 2136942 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63076.solr.core.routeFieldColl.shard2.replica_n4' (registry 
'solr.core.routeFieldColl.shard2.replica_n4') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@74ac9908
   [junit4]   2> 2136942 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2136942 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.c.SolrCore [[routeFieldColl_shard2_replica_n4] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001/tempDir-001/node3/routeFieldColl_shard2_replica_n4],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001/tempDir-001/node3/./routeFieldColl_shard2_replica_n4/data/]
   [junit4]   2> 2137057 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2137057 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2137059 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2137059 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2137061 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@44274a8a[routeFieldColl_shard3_replica_n8] main]
   [junit4]   2> 2137069 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2137069 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2137069 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2137070 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2137071 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2137071 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2137071 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2137072 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2137073 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2137073 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2137073 INFO  (qtp1229893218-18394) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard1 r:core_node5 x:routeFieldColl_shard1_replica_n2] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2137074 INFO  (qtp1229893218-18394) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard1 r:core_node5 x:routeFieldColl_shard1_replica_n2] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2137074 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2137074 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2137074 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2137075 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2137076 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@e43e795[routeFieldColl_shard4_replica_n12] main]
   [junit4]   2> 2137076 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@50109536[routeFieldColl_shard1_replica_n1] main]
   [junit4]   2> 2137076 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2137077 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2137077 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2137078 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2137078 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2137078 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@2e519490[routeFieldColl_shard2_replica_n4] main]
   [junit4]   2> 2137078 INFO  (qtp1229893218-18394) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard1 r:core_node5 x:routeFieldColl_shard1_replica_n2] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2137078 INFO  (qtp1229893218-18394) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard1 r:core_node5 x:routeFieldColl_shard1_replica_n2] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2137079 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2137079 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1583303338400677888
   [junit4]   2> 2137080 INFO  
(searcherExecutor-9094-thread-1-processing-n:127.0.0.1:63078_solr 
x:routeFieldColl_shard1_replica_n1 s:shard1 c:routeFieldColl r:core_node3) 
[n:127.0.0.1:63078_solr c:routeFieldColl s:shard1 r:core_node3 
x:routeFieldColl_shard1_replica_n1] o.a.s.c.SolrCore 
[routeFieldColl_shard1_replica_n1] Registered new searcher 
Searcher@50109536[routeFieldColl_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2137080 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2137080 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1583303338401726464
   [junit4]   2> 2137080 INFO  
(searcherExecutor-9089-thread-1-processing-n:127.0.0.1:63076_solr 
x:routeFieldColl_shard4_replica_n12 s:shard4 c:routeFieldColl r:core_node15) 
[n:127.0.0.1:63076_solr c:routeFieldColl s:shard4 r:core_node15 
x:routeFieldColl_shard4_replica_n12] o.a.s.c.SolrCore 
[routeFieldColl_shard4_replica_n12] Registered new searcher 
Searcher@e43e795[routeFieldColl_shard4_replica_n12] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2137081 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2137081 INFO  
(searcherExecutor-9090-thread-1-processing-n:127.0.0.1:63078_solr 
x:routeFieldColl_shard3_replica_n8 s:shard3 c:routeFieldColl r:core_node11) 
[n:127.0.0.1:63078_solr c:routeFieldColl s:shard3 r:core_node11 
x:routeFieldColl_shard3_replica_n8] o.a.s.c.SolrCore 
[routeFieldColl_shard3_replica_n8] Registered new searcher 
Searcher@44274a8a[routeFieldColl_shard3_replica_n8] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2137081 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2137082 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2137082 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1583303338403823616
   [junit4]   2> 2137082 INFO  
(searcherExecutor-9095-thread-1-processing-n:127.0.0.1:63076_solr 
x:routeFieldColl_shard2_replica_n4 s:shard2 c:routeFieldColl r:core_node7) 
[n:127.0.0.1:63076_solr c:routeFieldColl s:shard2 r:core_node7 
x:routeFieldColl_shard2_replica_n4] o.a.s.c.SolrCore 
[routeFieldColl_shard2_replica_n4] Registered new searcher 
Searcher@2e519490[routeFieldColl_shard2_replica_n4] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2137086 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard1: total=2 found=1 timeoutin=9999ms
   [junit4]   2> 2137086 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1583303338408017920
   [junit4]   2> 2137089 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard2: total=2 found=1 timeoutin=9999ms
   [junit4]   2> 2137090 INFO  (qtp887761522-18384) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard2 r:core_node9 x:routeFieldColl_shard2_replica_n6] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2137090 INFO  (qtp887761522-18384) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard2 r:core_node9 x:routeFieldColl_shard2_replica_n6] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2137091 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard4: total=2 found=1 timeoutin=9999ms
   [junit4]   2> 2137092 INFO  (qtp887761522-18384) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard2 r:core_node9 x:routeFieldColl_shard2_replica_n6] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2137092 INFO  (qtp887761522-18384) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard2 r:core_node9 x:routeFieldColl_shard2_replica_n6] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2137095 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard3: total=2 found=1 timeoutin=9999ms
   [junit4]   2> 2137100 INFO  (qtp887761522-18384) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard2 r:core_node9 x:routeFieldColl_shard2_replica_n6] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@1e46d7f8[routeFieldColl_shard2_replica_n6] main]
   [junit4]   2> 2137101 INFO  (qtp887761522-18385) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard4 r:core_node16 x:routeFieldColl_shard4_replica_n14] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2137101 INFO  (qtp887761522-18385) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard4 r:core_node16 x:routeFieldColl_shard4_replica_n14] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2137101 INFO  (qtp1229893218-18394) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard1 r:core_node5 x:routeFieldColl_shard1_replica_n2] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@10097b9c[routeFieldColl_shard1_replica_n2] main]
   [junit4]   2> 2137103 INFO  (qtp887761522-18385) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard4 r:core_node16 x:routeFieldColl_shard4_replica_n14] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2137103 INFO  (qtp887761522-18385) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard4 r:core_node16 x:routeFieldColl_shard4_replica_n14] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2137103 INFO  (qtp887761522-18384) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard2 r:core_node9 x:routeFieldColl_shard2_replica_n6] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2137104 INFO  (qtp887761522-18384) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard2 r:core_node9 x:routeFieldColl_shard2_replica_n6] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2137104 INFO  (qtp887761522-18384) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard2 r:core_node9 x:routeFieldColl_shard2_replica_n6] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2137104 INFO  (qtp1229893218-18394) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard1 r:core_node5 x:routeFieldColl_shard1_replica_n2] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2137104 INFO  (qtp887761522-18384) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard2 r:core_node9 x:routeFieldColl_shard2_replica_n6] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1583303338426892288
   [junit4]   2> 2137105 INFO  
(searcherExecutor-9088-thread-1-processing-n:127.0.0.1:63075_solr 
x:routeFieldColl_shard2_replica_n6 s:shard2 c:routeFieldColl r:core_node9) 
[n:127.0.0.1:63075_solr c:routeFieldColl s:shard2 r:core_node9 
x:routeFieldColl_shard2_replica_n6] o.a.s.c.SolrCore 
[routeFieldColl_shard2_replica_n6] Registered new searcher 
Searcher@1e46d7f8[routeFieldColl_shard2_replica_n6] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2137105 INFO  (qtp1229893218-18394) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard1 r:core_node5 x:routeFieldColl_shard1_replica_n2] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2137106 INFO  (qtp1229893218-18394) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard1 r:core_node5 x:routeFieldColl_shard1_replica_n2] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2137106 INFO  (qtp1229893218-18394) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard1 r:core_node5 x:routeFieldColl_shard1_replica_n2] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1583303338428989440
   [junit4]   2> 2137106 INFO  
(searcherExecutor-9091-thread-1-processing-n:127.0.0.1:63079_solr 
x:routeFieldColl_shard1_replica_n2 s:shard1 c:routeFieldColl r:core_node5) 
[n:127.0.0.1:63079_solr c:routeFieldColl s:shard1 r:core_node5 
x:routeFieldColl_shard1_replica_n2] o.a.s.c.SolrCore 
[routeFieldColl_shard1_replica_n2] Registered new searcher 
Searcher@10097b9c[routeFieldColl_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2137107 INFO  (qtp1229893218-18396) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard3 r:core_node13 x:routeFieldColl_shard3_replica_n10] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2137107 INFO  (qtp1229893218-18396) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard3 r:core_node13 x:routeFieldColl_shard3_replica_n10] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2137109 INFO  (qtp1229893218-18396) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard3 r:core_node13 x:routeFieldColl_shard3_replica_n10] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2137109 INFO  (qtp1229893218-18396) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard3 r:core_node13 x:routeFieldColl_shard3_replica_n10] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2137110 INFO  (qtp887761522-18385) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard4 r:core_node16 x:routeFieldColl_shard4_replica_n14] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@2a5a8cbe[routeFieldColl_shard4_replica_n14] main]
   [junit4]   2> 2137111 INFO  (qtp1229893218-18396) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard3 r:core_node13 x:routeFieldColl_shard3_replica_n10] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@4e4f5bf6[routeFieldColl_shard3_replica_n10] main]
   [junit4]   2> 2137111 INFO  (qtp887761522-18385) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard4 r:core_node16 x:routeFieldColl_shard4_replica_n14] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2137112 INFO  (qtp1229893218-18396) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard3 r:core_node13 x:routeFieldColl_shard3_replica_n10] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2137112 INFO  (qtp887761522-18385) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard4 r:core_node16 x:routeFieldColl_shard4_replica_n14] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2137112 INFO  (qtp1229893218-18396) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard3 r:core_node13 x:routeFieldColl_shard3_replica_n10] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2137113 INFO  (qtp887761522-18385) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard4 r:core_node16 x:routeFieldColl_shard4_replica_n14] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2137113 INFO  (qtp1229893218-18396) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard3 r:core_node13 x:routeFieldColl_shard3_replica_n10] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2137113 INFO  
(searcherExecutor-9093-thread-1-processing-n:127.0.0.1:63075_solr 
x:routeFieldColl_shard4_replica_n14 s:shard4 c:routeFieldColl r:core_node16) 
[n:127.0.0.1:63075_solr c:routeFieldColl s:shard4 r:core_node16 
x:routeFieldColl_shard4_replica_n14] o.a.s.c.SolrCore 
[routeFieldColl_shard4_replica_n14] Registered new searcher 
Searcher@2a5a8cbe[routeFieldColl_shard4_replica_n14] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2137113 INFO  
(searcherExecutor-9092-thread-1-processing-n:127.0.0.1:63079_solr 
x:routeFieldColl_shard3_replica_n10 s:shard3 c:routeFieldColl r:core_node13) 
[n:127.0.0.1:63079_solr c:routeFieldColl s:shard3 r:core_node13 
x:routeFieldColl_shard3_replica_n10] o.a.s.c.SolrCore 
[routeFieldColl_shard3_replica_n10] Registered new searcher 
Searcher@4e4f5bf6[routeFieldColl_shard3_replica_n10] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2137113 INFO  (qtp887761522-18385) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard4 r:core_node16 x:routeFieldColl_shard4_replica_n14] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1583303338436329472
   [junit4]   2> 2137113 INFO  (qtp1229893218-18396) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard3 r:core_node13 x:routeFieldColl_shard3_replica_n10] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1583303338436329472
   [junit4]   2> 2137199 INFO  
(zkCallback-3009-thread-2-processing-n:127.0.0.1:63076_solr) 
[n:127.0.0.1:63076_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> 2137199 INFO  
(zkCallback-3007-thread-2-processing-n:127.0.0.1:63075_solr) 
[n:127.0.0.1:63075_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> 2137199 INFO  
(zkCallback-3008-thread-1-processing-n:127.0.0.1:63078_solr) 
[n:127.0.0.1:63078_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> 2137200 INFO  
(zkCallback-3010-thread-1-processing-n:127.0.0.1:63079_solr) 
[n:127.0.0.1:63079_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> 2137200 INFO  
(zkCallback-3010-thread-2-processing-n:127.0.0.1:63079_solr) 
[n:127.0.0.1:63079_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> 2137199 INFO  
(zkCallback-3007-thread-1-processing-n:127.0.0.1:63075_solr) 
[n:127.0.0.1:63075_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> 2137199 INFO  
(zkCallback-3008-thread-2-processing-n:127.0.0.1:63078_solr) 
[n:127.0.0.1:63078_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> 2137199 INFO  
(zkCallback-3009-thread-1-processing-n:127.0.0.1:63076_solr) 
[n:127.0.0.1:63076_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> 2137594 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2137594 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 2137594 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2137594 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:63078/solr/routeFieldColl_shard1_replica_n1/
   [junit4]   2> 2137594 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 2137594 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:63076/solr/routeFieldColl_shard2_replica_n4/
   [junit4]   2> 2137594 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.u.PeerSync PeerSync: core=routeFieldColl_shard2_replica_n4 
url=http://127.0.0.1:63076/solr START 
replicas=[http://127.0.0.1:63075/solr/routeFieldColl_shard2_replica_n6/] 
nUpdates=100
   [junit4]   2> 2137596 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.u.PeerSync PeerSync: core=routeFieldColl_shard1_replica_n1 
url=http://127.0.0.1:63078/solr START 
replicas=[http://127.0.0.1:63079/solr/routeFieldColl_shard1_replica_n2/] 
nUpdates=100
   [junit4]   2> 2137596 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2137596 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 2137596 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:63076/solr/routeFieldColl_shard4_replica_n12/
   [junit4]   2> 2137600 INFO  (qtp887761522-18387) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard2 r:core_node9 x:routeFieldColl_shard2_replica_n6] 
o.a.s.c.S.Request [routeFieldColl_shard2_replica_n6]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=2
   [junit4]   2> 2137600 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.u.PeerSync PeerSync: core=routeFieldColl_shard4_replica_n12 
url=http://127.0.0.1:63076/solr START 
replicas=[http://127.0.0.1:63075/solr/routeFieldColl_shard4_replica_n14/] 
nUpdates=100
   [junit4]   2> 2137604 INFO  (qtp887761522-18388) [n:127.0.0.1:63075_solr 
c:routeFieldColl s:shard4 r:core_node16 x:routeFieldColl_shard4_replica_n14] 
o.a.s.c.S.Request [routeFieldColl_shard4_replica_n14]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=2
   [junit4]   2> 2137606 INFO  (qtp1229893218-18397) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard1 r:core_node5 x:routeFieldColl_shard1_replica_n2] 
o.a.s.c.S.Request [routeFieldColl_shard1_replica_n2]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=5
   [junit4]   2> 2137607 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2137607 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 2137607 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:63078/solr/routeFieldColl_shard3_replica_n8/
   [junit4]   2> 2137608 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.u.PeerSync PeerSync: core=routeFieldColl_shard3_replica_n8 
url=http://127.0.0.1:63078/solr START 
replicas=[http://127.0.0.1:63079/solr/routeFieldColl_shard3_replica_n10/] 
nUpdates=100
   [junit4]   2> 2137610 INFO  (qtp1229893218-18417) [n:127.0.0.1:63079_solr 
c:routeFieldColl s:shard3 r:core_node13 x:routeFieldColl_shard3_replica_n10] 
o.a.s.c.S.Request [routeFieldColl_shard3_replica_n10]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=2
   [junit4]   2> 2137902 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.u.PeerSync PeerSync: core=routeFieldColl_shard2_replica_n4 
url=http://127.0.0.1:63076/solr DONE.  We have no versions.  sync failed.
   [junit4]   2> 2137902 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.u.PeerSync PeerSync: core=routeFieldColl_shard1_replica_n1 
url=http://127.0.0.1:63078/solr DONE.  We have no versions.  sync failed.
   [junit4]   2> 2137902 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the 
next candidate
   [junit4]   2> 2137902 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the 
next candidate
   [junit4]   2> 2137902 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we 
can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 2137902 INFO  (qtp946284992-18403) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard2 r:core_node7 x:routeFieldColl_shard2_replica_n4] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 2137902 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we 
can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 2137906 INFO  (qtp878245061-18410) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard1 r:core_node3 x:routeFieldColl_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 2137902 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.u.PeerSync PeerSync: core=routeFieldColl_shard4_replica_n12 
url=http://127.0.0.1:63076/solr DONE.  We have no versions.  sync failed.
   [junit4]   2> 2137906 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the 
next candidate
   [junit4]   2> 2137906 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we 
can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 2137906 INFO  (qtp946284992-18401) [n:127.0.0.1:63076_solr 
c:routeFieldColl s:shard4 r:core_node15 x:routeFieldColl_shard4_replica_n12] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 2137908 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.u.PeerSync PeerSync: core=routeFieldColl_shard3_replica_n8 
url=http://127.0.0.1:63078/solr DONE.  We have no versions.  sync failed.
   [junit4]   2> 2137908 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the 
next candidate
   [junit4]   2> 2137908 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we 
can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 2137908 INFO  (qtp878245061-18412) [n:127.0.0.1:63078_solr 
c:routeFieldColl s:shard3 r:core_node11 x:routeFieldColl_shard3_replica_n8] 
o.a.s.c.ShardLeaderElectionContext Found all replicas part

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

.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.testCreateShardRepFactor.b.leader, tag=891821009
   [junit4]   2> 2201849 INFO  
(zkCallback-3009-thread-2-processing-n:127.0.0.1:63076_solr) 
[n:127.0.0.1:63076_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:63076_solr
   [junit4]   2> 2201850 INFO  (jetty-closer-2989-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@4d8e2abd{/solr,null,UNAVAILABLE}
   [junit4]   2> 2201855 INFO  (jetty-closer-2989-thread-4) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@7996eab6{/solr,null,UNAVAILABLE}
   [junit4]   2> 2201857 ERROR 
(SUITE-CustomCollectionTest-seed#[7132144B0BEC835E]-worker) [    ] 
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper 
server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 2201857 INFO  
(SUITE-CustomCollectionTest-seed#[7132144B0BEC835E]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:63073 63073
   [junit4]   2> 2201873 INFO  (Thread-3509) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:63073 63073
   [junit4]   2> 2202070 WARN  (Thread-3509) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        15      /solr/configs/conf
   [junit4]   2>        9       /solr/clusterprops.json
   [junit4]   2>        9       /solr/aliases.json
   [junit4]   2>        4       /solr/security.json
   [junit4]   2>        2       /solr/collections/withShardField/state.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        119     /solr/collections/implicitcoll/state.json
   [junit4]   2>        56      /solr/collections/withShardField/state.json
   [junit4]   2>        26      
/solr/collections/testCreateShardRepFactor/state.json
   [junit4]   2>        24      /solr/collections/routeFieldColl/state.json
   [junit4]   2>        9       /solr/clusterstate.json
   [junit4]   2>        3       
/solr/collections/implicitcoll/leader_elect/c/election/98956458483843083-core_node24-n_0000000000
   [junit4]   2>        3       
/solr/collections/withShardField/leader_elect/d/election/98956458483843083-core_node37-n_0000000000
   [junit4]   2>        2       
/solr/collections/withShardField/leader_elect/d/election/98956458483843084-core_node33-n_0000000001
   [junit4]   2>        2       
/solr/collections/implicitcoll/leader_elect/x/election/98956458483843084-core_node28-n_0000000001
   [junit4]   2>        2       
/solr/overseer_elect/election/98956458483843084-127.0.0.1:63079_solr-n_0000000000
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        27      /solr/collections
   [junit4]   2>        9       /solr/live_nodes
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_7132144B0BEC835E-001
   [junit4]   2> Nov 06, 2017 8:09:53 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{shard_s=PostingsFormat(name=LuceneFixedGap), 
id=PostingsFormat(name=LuceneVarGapFixedInterval), 
_route_=PostingsFormat(name=MockRandom)}, docValues:{}, 
maxPointsInLeafNode=1619, maxMBSortInHeap=6.713227382877657, 
sim=RandomSimilarity(queryNorm=false): {}, locale=ja-JP, 
timezone=America/Montevideo
   [junit4]   2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 1.8.0_144 
(64-bit)/cpus=3,threads=1,free=100394240,total=477102080
   [junit4]   2> NOTE: All tests run in this JVM: [ReplicationFactorTest, 
RulesTest, TestGraphTermsQParserPlugin, TestSimpleTextCodec, 
TestUseDocValuesAsStored, TestCoreDiscovery, TestEmbeddedSolrServerSchemaAPI, 
TestLocalFSCloudBackupRestore, QueryParsingTest, TestApiFramework, 
UnloadDistributedZkTest, StressHdfsTest, TestExceedMaxTermLength, 
TemplateUpdateProcessorTest, ZkFailoverTest, CursorMarkTest, TestJoin, 
SegmentsInfoRequestHandlerTest, BadIndexSchemaTest, 
CreateCollectionCleanupTest, TestTolerantUpdateProcessorRandomCloud, 
ReturnFieldsTest, TestTolerantSearch, TestCustomDocTransformer, 
TestSolrFieldCacheBean, TestCollapseQParserPlugin, TestAuthorizationFramework, 
DistributedVersionInfoTest, DistribJoinFromCollectionTest, PrimUtilsTest, 
TestRestManager, TestRealTimeGet, NumericFieldsTest, TestChildDocTransformer, 
PreAnalyzedUpdateProcessorTest, CollectionReloadTest, 
OverriddenZkACLAndCredentialsProvidersTest, ConjunctionSolrSpellCheckerTest, 
TestPolicyCloud, TestRangeQuery, AnalysisErrorHandlingTest, TestStressRecovery, 
TestCodecSupport, TestXmlQParser, TestIBSimilarityFactory, 
FastVectorHighlighterTest, ConfigSetsAPITest, 
DistributedQueryElevationComponentTest, TestRecovery, 
TestGeoJSONResponseWriter, TestMacros, IndexBasedSpellCheckerTest, 
TestAnalyzeInfixSuggestions, TestComplexPhraseQParserPlugin, 
SolrRequestParserTest, TestSolr4Spatial2, 
IgnoreCommitOptimizeUpdateProcessorFactoryTest, V2ApiIntegrationTest, 
SignatureUpdateProcessorFactoryTest, DeleteShardTest, 
TestDeleteCollectionOnDownNodes, TestConfigSetsAPI, TestStressUserVersions, 
TestRawResponseWriter, HttpSolrCallGetCoreTest, ZkCLITest, TestXIncludeConfig, 
TestDistributedSearch, TestInitParams, TestPayloadScoreQParserPlugin, 
TestJmxIntegration, AddReplicaTest, TestCloudSearcherWarming, 
TestMultiValuedNumericRangeQuery, TestConfigSetImmutable, 
TestMaxTokenLenTokenizer, TestSurroundQueryParser, MergeStrategyTest, 
TestCloudPseudoReturnFields, TestReloadDeadlock, HighlighterMaxOffsetTest, 
ChangedSchemaMergeTest, DistributedFacetPivotLongTailTest, TestFieldSortValues, 
ExplicitHLLTest, MoveReplicaTest, ShufflingReplicaListTransformerTest, 
CollectionTooManyReplicasTest, CdcrReplicationHandlerTest, TestLazyCores, 
SortSpecParsingTest, TestUninvertingReader, TestFieldTypeResource, 
DistributedFacetPivotSmallTest, TimeZoneUtilsTest, TestInPlaceUpdatesDistrib, 
TestRequestStatusCollectionAPI, LeaderInitiatedRecoveryOnShardRestartTest, 
BasicDistributedZkTest, RegexBoostProcessorTest, 
TriLevelCompositeIdRoutingTest, SolrInfoBeanTest, 
TestRandomCollapseQParserPlugin, SpellCheckCollatorTest, TestSegmentSorting, 
DistributedDebugComponentTest, TestSolrDeletionPolicy2, 
PreAnalyzedFieldManagedSchemaCloudTest, TestManagedSchema, 
TestQuerySenderNoQuery, RequestHandlersTest, PeerSyncReplicationTest, 
TestBinaryField, ConnectionReuseTest, TestStressInPlaceUpdates, 
TestCursorMarkWithoutUniqueKey, TestReRankQParserPlugin, TestMultiWordSynonyms, 
HdfsDirectoryFactoryTest, TestUtils, DeleteNodeTest, TestSchemaResource, 
PathHierarchyTokenizerFactoryTest, TestSizeLimitedDistributedMap, 
TestSolrCloudWithSecureImpersonation, AtomicUpdatesTest, 
DirectUpdateHandlerTest, SolrIndexMetricsTest, XsltUpdateRequestHandlerTest, 
HighlighterTest, AutoscalingHistoryHandlerTest, 
TestSolrCloudWithDelegationTokens, DateMathParserTest, 
ConfigureRecoveryStrategyTest, RollingRestartTest, 
TestManagedSynonymFilterFactory, TestHighlightDedupGrouping, 
DeleteInactiveReplicaTest, BasicAuthStandaloneTest, TestSchemaVersionResource, 
TestFieldCacheSortRandom, SparseHLLTest, RequiredFieldsTest, 
AssignBackwardCompatibilityTest, XmlUpdateRequestHandlerTest, 
DistributedQueryComponentCustomSortTest, TestUniqueKeyFieldResource, 
CdcrVersionReplicationTest, TestCloudDeleteByQuery, MigrateRouteKeyTest, 
TestSubQueryTransformerCrossCore, TestConfigReload, DistribCursorPagingTest, 
ForceLeaderTest, StatsComponentTest, InfixSuggestersTest, 
SolrMetricsIntegrationTest, DistanceUnitsTest, ZkControllerTest, 
DataDrivenBlockJoinTest, HdfsBasicDistributedZk2Test, TestCSVResponseWriter, 
CircularListTest, SolrCLIZkUtilsTest, TestCloudNestedDocsSort, 
HdfsCollectionsAPIDistributedZkTest, DirectSolrConnectionTest, 
TestNumericRangeQuery64, CollectionsAPISolrJTest, UUIDFieldTest, 
ShowFileRequestHandlerTest, MoveReplicaHDFSFailoverTest, NodeMutatorTest, 
TestReplicationHandler, TestReloadAndDeleteDocs, 
AsyncCallRequestStatusResponseTest, ConvertedLegacyTest, TestUpdate, 
BigEndianAscendingWordSerializerTest, BadCopyFieldTest, 
WordBreakSolrSpellCheckerTest, TestFieldCacheReopen, 
DistributedFacetExistsSmallTest, HdfsDirectoryTest, SearchRateTriggerTest, 
SolrIndexSplitterTest, SimplePostToolTest, SuggesterFSTTest, 
CoreAdminHandlerTest, TestFoldingMultitermQuery, SuggesterTSTTest, 
SuggesterTest, SpatialFilterTest, SuggesterWFSTTest, PolyFieldTest, 
NoCacheHeaderTest, SolrCoreCheckLockOnStartupTest, TestPseudoReturnFields, 
FieldMutatingUpdateProcessorTest, TestAtomicUpdateErrorCases, 
QueryEqualityTest, DirectUpdateHandlerOptimizeTest, 
DefaultValueUpdateProcessorTest, SortByFunctionTest, TestRemoteStreaming, 
DistanceFunctionTest, TestSolrDeletionPolicy1, DebugComponentTest, 
LukeRequestHandlerTest, DisMaxRequestHandlerTest, TestQueryUtils, 
TestWriterPerf, TestReversedWildcardFilterFactory, PrimitiveFieldTypeTest, 
TestOmitPositions, FileBasedSpellCheckerTest, TermsComponentTest, 
TermVectorComponentTest, TestIndexingPerformance, MoreLikeThisHandlerTest, 
FieldAnalysisRequestHandlerTest, TestSolrQueryParser, 
IndexSchemaRuntimeFieldTest, LoggingHandlerTest, IndexSchemaTest, 
TestCollationField, UpdateRequestProcessorFactoryTest, MBeansHandlerTest, 
HighlighterConfigTest, SOLR749Test, TestQuerySenderListener, UpdateParamsTest, 
AlternateDirectoryTest, CopyFieldTest, ResponseLogComponentTest, 
BadComponentTest, TestMergePolicyConfig, MultiTermTest, TestSearchPerf, 
MinimalSchemaTest, TestElisionMultitermQuery, TestFuzzyAnalyzedSuggestions, 
TestSolrCoreProperties, TestLuceneMatchVersion, TestCharFilters, 
TestSweetSpotSimilarityFactory, TestPerFieldSimilarity, 
TestLMJelinekMercerSimilarityFactory, ResourceLoaderTest, 
OpenExchangeRatesOrgProviderTest, PluginInfoTest, TestFastLRUCache, 
ChaosMonkeyNothingIsSafeTest, AssignTest, CleanupOldIndexTest, 
CustomCollectionTest]
   [junit4] Completed [528/747 (1!)] on J0 in 67.82s, 4 tests, 1 error <<< 
FAILURES!

[...truncated 48055 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to