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

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

Error Message:
Could not find collection : implicitcoll

Stack Trace:
org.apache.solr.common.SolrException: Could not find collection : implicitcoll
        at 
__randomizedtesting.SeedInfo.seed([A7C67F31EFD2B706:CD27F15AD248017E]:0)
        at 
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:194)
        at 
org.apache.solr.cloud.SolrCloudTestCase.getCollectionState(SolrCloudTestCase.java:245)
        at 
org.apache.solr.cloud.CustomCollectionTest.testCustomCollectionsAPI(CustomCollectionTest.java:68)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:745)


FAILED:  org.apache.solr.handler.TestSQLHandler.doTest

Error Message:
--> http://127.0.0.1:56917/_/f/collection1:Failed to execute sqlQuery 'select 
str_s, count(*), sum(field_i), min(field_i), max(field_i), cast(avg(1.0 * 
field_i) as float) from collection1 where text='XXXX' group by str_s order by 
sum(field_i) asc limit 2' against JDBC connection 'jdbc:calcitesolr:'. Error 
while executing SQL "select str_s, count(*), sum(field_i), min(field_i), 
max(field_i), cast(avg(1.0 * field_i) as float) from collection1 where 
text='XXXX' group by str_s order by sum(field_i) asc limit 2": From line 1, 
column 39 to line 1, column 50: No match found for function signature 
min(<NUMERIC>)

Stack Trace:
java.io.IOException: --> http://127.0.0.1:56917/_/f/collection1:Failed to 
execute sqlQuery 'select str_s, count(*), sum(field_i), min(field_i), 
max(field_i), cast(avg(1.0 * field_i) as float) from collection1 where 
text='XXXX' group by str_s order by sum(field_i) asc limit 2' against JDBC 
connection 'jdbc:calcitesolr:'.
Error while executing SQL "select str_s, count(*), sum(field_i), min(field_i), 
max(field_i), cast(avg(1.0 * field_i) as float) from collection1 where 
text='XXXX' group by str_s order by sum(field_i) asc limit 2": From line 1, 
column 39 to line 1, column 50: No match found for function signature 
min(<NUMERIC>)
        at 
__randomizedtesting.SeedInfo.seed([A7C67F31EFD2B706:82C7958269A4BF]:0)
        at 
org.apache.solr.client.solrj.io.stream.SolrStream.read(SolrStream.java:235)
        at 
org.apache.solr.handler.TestSQLHandler.getTuples(TestSQLHandler.java:2333)
        at 
org.apache.solr.handler.TestSQLHandler.testBasicGrouping(TestSQLHandler.java:659)
        at org.apache.solr.handler.TestSQLHandler.doTest(TestSQLHandler.java:77)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:745)


FAILED:  junit.framework.TestSuite.org.apache.solr.handler.TestSQLHandler

Error Message:
1 thread leaked from SUITE scope at org.apache.solr.handler.TestSQLHandler:     
1) Thread[id=22905, name=Connection evictor, state=TIMED_WAITING, 
group=TGRP-TestSQLHandler]         at java.lang.Thread.sleep(Native Method)     
    at 
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
         at java.lang.Thread.run(Thread.java:745)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE 
scope at org.apache.solr.handler.TestSQLHandler: 
   1) Thread[id=22905, name=Connection evictor, state=TIMED_WAITING, 
group=TGRP-TestSQLHandler]
        at java.lang.Thread.sleep(Native Method)
        at 
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
        at java.lang.Thread.run(Thread.java:745)
        at __randomizedtesting.SeedInfo.seed([A7C67F31EFD2B706]:0)




Build Log:
[...truncated 12409 lines...]
   [junit4] Suite: org.apache.solr.cloud.CustomCollectionTest
   [junit4]   2> Creating dataDir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_A7C67F31EFD2B706-001/init-core-data-001
   [junit4]   2> 2052656 INFO  
(SUITE-CustomCollectionTest-seed#[A7C67F31EFD2B706]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields
   [junit4]   2> 2052660 INFO  
(SUITE-CustomCollectionTest-seed#[A7C67F31EFD2B706]-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> 2052661 INFO  
(SUITE-CustomCollectionTest-seed#[A7C67F31EFD2B706]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_A7C67F31EFD2B706-001/tempDir-001
   [junit4]   2> 2052661 INFO  
(SUITE-CustomCollectionTest-seed#[A7C67F31EFD2B706]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2052662 INFO  (Thread-2741) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2052662 INFO  (Thread-2741) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 2052769 INFO  
(SUITE-CustomCollectionTest-seed#[A7C67F31EFD2B706]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:54330
   [junit4]   2> 2052793 INFO  (jetty-launcher-3055-thread-2) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 2052793 INFO  (jetty-launcher-3055-thread-3) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 2052793 INFO  (jetty-launcher-3055-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 2052794 INFO  (jetty-launcher-3055-thread-4) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 2052797 INFO  (jetty-launcher-3055-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2338f519{/solr,null,AVAILABLE}
   [junit4]   2> 2052797 INFO  (jetty-launcher-3055-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@7b84c21e{/solr,null,AVAILABLE}
   [junit4]   2> 2052799 INFO  (jetty-launcher-3055-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1c07067{/solr,null,AVAILABLE}
   [junit4]   2> 2052799 INFO  (jetty-launcher-3055-thread-2) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@4e89fd2e{HTTP/1.1,[http/1.1]}{127.0.0.1:54333}
   [junit4]   2> 2052799 INFO  (jetty-launcher-3055-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@5d231798{HTTP/1.1,[http/1.1]}{127.0.0.1:54332}
   [junit4]   2> 2052799 INFO  (jetty-launcher-3055-thread-2) [    ] 
o.e.j.s.Server Started @2059301ms
   [junit4]   2> 2052800 INFO  (jetty-launcher-3055-thread-1) [    ] 
o.e.j.s.Server Started @2059301ms
   [junit4]   2> 2052800 INFO  (jetty-launcher-3055-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=54333}
   [junit4]   2> 2052800 INFO  (jetty-launcher-3055-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=54332}
   [junit4]   2> 2052800 ERROR (jetty-launcher-3055-thread-1) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2052800 ERROR (jetty-launcher-3055-thread-2) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2052800 INFO  (jetty-launcher-3055-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 2052800 INFO  (jetty-launcher-3055-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 2052800 INFO  (jetty-launcher-3055-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2052801 INFO  (jetty-launcher-3055-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2052801 INFO  (jetty-launcher-3055-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2052802 INFO  (jetty-launcher-3055-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-03-05T21:43:32.559Z
   [junit4]   2> 2052802 INFO  (jetty-launcher-3055-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2052802 INFO  (jetty-launcher-3055-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-03-05T21:43:32.559Z
   [junit4]   2> 2052801 INFO  (jetty-launcher-3055-thread-4) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1f7c05fc{/solr,null,AVAILABLE}
   [junit4]   2> 2052802 INFO  (jetty-launcher-3055-thread-4) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@200d1d58{HTTP/1.1,[http/1.1]}{127.0.0.1:54335}
   [junit4]   2> 2052802 INFO  (jetty-launcher-3055-thread-4) [    ] 
o.e.j.s.Server Started @2059303ms
   [junit4]   2> 2052802 INFO  (jetty-launcher-3055-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=54335}
   [junit4]   2> 2052801 INFO  (jetty-launcher-3055-thread-3) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@6f192006{HTTP/1.1,[http/1.1]}{127.0.0.1:54334}
   [junit4]   2> 2052802 INFO  (jetty-launcher-3055-thread-3) [    ] 
o.e.j.s.Server Started @2059303ms
   [junit4]   2> 2052802 ERROR (jetty-launcher-3055-thread-4) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2052802 INFO  (jetty-launcher-3055-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=54334}
   [junit4]   2> 2052803 INFO  (jetty-launcher-3055-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 2052803 ERROR (jetty-launcher-3055-thread-3) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2052803 INFO  (jetty-launcher-3055-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2052803 INFO  (jetty-launcher-3055-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2052803 INFO  (jetty-launcher-3055-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-03-05T21:43:32.560Z
   [junit4]   2> 2052803 INFO  (jetty-launcher-3055-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 2052803 INFO  (jetty-launcher-3055-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2052803 INFO  (jetty-launcher-3055-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2052803 INFO  (jetty-launcher-3055-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-03-05T21:43:32.560Z
   [junit4]   2> 2052813 INFO  (jetty-launcher-3055-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2052815 INFO  (jetty-launcher-3055-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2052815 INFO  (jetty-launcher-3055-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2052815 INFO  (jetty-launcher-3055-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2052825 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x15aa06d75450001, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2052830 INFO  (jetty-launcher-3055-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54330/solr
   [junit4]   2> 2052830 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x15aa06d75450002, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2052832 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x15aa06d75450003, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2052834 INFO  (jetty-launcher-3055-thread-4) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54330/solr
   [junit4]   2> 2052835 INFO  (jetty-launcher-3055-thread-3) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54330/solr
   [junit4]   2> 2052838 INFO  (jetty-launcher-3055-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54330/solr
   [junit4]   2> 2052843 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x15aa06d75450005, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2052845 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x15aa06d75450006, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2052847 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x15aa06d75450007, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2052848 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x15aa06d75450008, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2052901 INFO  (jetty-launcher-3055-thread-1) 
[n:127.0.0.1:54332_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2052901 INFO  (jetty-launcher-3055-thread-4) 
[n:127.0.0.1:54335_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2052901 INFO  (jetty-launcher-3055-thread-3) 
[n:127.0.0.1:54334_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2052901 INFO  (jetty-launcher-3055-thread-2) 
[n:127.0.0.1:54333_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2052902 INFO  (jetty-launcher-3055-thread-1) 
[n:127.0.0.1:54332_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:54332_solr
   [junit4]   2> 2052904 INFO  (jetty-launcher-3055-thread-4) 
[n:127.0.0.1:54335_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:54335_solr
   [junit4]   2> 2052904 INFO  (jetty-launcher-3055-thread-3) 
[n:127.0.0.1:54334_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:54334_solr
   [junit4]   2> 2052904 INFO  (jetty-launcher-3055-thread-2) 
[n:127.0.0.1:54333_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:54333_solr
   [junit4]   2> 2052906 INFO  (jetty-launcher-3055-thread-1) 
[n:127.0.0.1:54332_solr    ] o.a.s.c.Overseer Overseer 
(id=97566733921222665-127.0.0.1:54332_solr-n_0000000000) starting
   [junit4]   2> 2052909 INFO  
(zkCallback-3074-thread-1-processing-n:127.0.0.1:54332_solr) 
[n:127.0.0.1:54332_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 2052909 INFO  
(zkCallback-3076-thread-1-processing-n:127.0.0.1:54334_solr) 
[n:127.0.0.1:54334_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 2052909 INFO  
(zkCallback-3075-thread-1-processing-n:127.0.0.1:54335_solr) 
[n:127.0.0.1:54335_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 2052910 INFO  
(zkCallback-3077-thread-1-processing-n:127.0.0.1:54333_solr) 
[n:127.0.0.1:54333_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 2053002 INFO  (jetty-launcher-3055-thread-4) 
[n:127.0.0.1:54335_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_A7C67F31EFD2B706-001/tempDir-001/node4/.
   [junit4]   2> 2053040 INFO  (jetty-launcher-3055-thread-3) 
[n:127.0.0.1:54334_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_A7C67F31EFD2B706-001/tempDir-001/node3/.
   [junit4]   2> 2053050 INFO  (jetty-launcher-3055-thread-1) 
[n:127.0.0.1:54332_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:54332_solr
   [junit4]   2> 2053051 INFO  (jetty-launcher-3055-thread-2) 
[n:127.0.0.1:54333_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_A7C67F31EFD2B706-001/tempDir-001/node2/.
   [junit4]   2> 2053054 INFO  
(zkCallback-3077-thread-1-processing-n:127.0.0.1:54333_solr) 
[n:127.0.0.1:54333_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2053054 INFO  
(zkCallback-3075-thread-1-processing-n:127.0.0.1:54335_solr) 
[n:127.0.0.1:54335_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2053054 INFO  
(zkCallback-3076-thread-1-processing-n:127.0.0.1:54334_solr) 
[n:127.0.0.1:54334_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2053054 INFO  
(zkCallback-3074-thread-1-processing-n:127.0.0.1:54332_solr) 
[n:127.0.0.1:54332_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2053157 INFO  (jetty-launcher-3055-thread-1) 
[n:127.0.0.1:54332_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_A7C67F31EFD2B706-001/tempDir-001/node1/.
   [junit4]   2> 2055537 INFO  
(SUITE-CustomCollectionTest-seed#[A7C67F31EFD2B706]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 2055539 INFO  
(SUITE-CustomCollectionTest-seed#[A7C67F31EFD2B706]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:54330/solr ready
   [junit4]   2> 2055584 INFO  
(TEST-CustomCollectionTest.testRouteFieldForImplicitRouter-seed#[A7C67F31EFD2B706])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testRouteFieldForImplicitRouter
   [junit4]   2> 2055587 INFO  
(TEST-CustomCollectionTest.testRouteFieldForImplicitRouter-seed#[A7C67F31EFD2B706])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 2055593 INFO  (qtp136685573-16146) [n:127.0.0.1:54334_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
shards=a,b,c,d&replicationFactor=2&collection.configName=conf&maxShardsPerNode=3&router.field=shard_s&name=withShardField&router.name=implicit&action=CREATE&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2055597 INFO  
(OverseerThreadFactory-6772-thread-1-processing-n:127.0.0.1:54332_solr) 
[n:127.0.0.1:54332_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
withShardField
   [junit4]   2> 2055725 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&name=withShardField_c_replica2&action=CREATE&numShards=4&collection=withShardField&shard=c&wt=javabin&version=2
   [junit4]   2> 2055725 INFO  (qtp136685573-16149) [n:127.0.0.1:54334_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&name=withShardField_a_replica2&action=CREATE&numShards=4&collection=withShardField&shard=a&wt=javabin&version=2
   [junit4]   2> 2055727 INFO  (qtp1852616071-16151) [n:127.0.0.1:54335_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&name=withShardField_b_replica1&action=CREATE&numShards=4&collection=withShardField&shard=b&wt=javabin&version=2
   [junit4]   2> 2055727 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&name=withShardField_d_replica1&action=CREATE&numShards=4&collection=withShardField&shard=d&wt=javabin&version=2
   [junit4]   2> 2055729 INFO  (qtp1592706413-16137) [n:127.0.0.1:54332_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&name=withShardField_d_replica2&action=CREATE&numShards=4&collection=withShardField&shard=d&wt=javabin&version=2
   [junit4]   2> 2055729 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&name=withShardField_a_replica1&action=CREATE&numShards=4&collection=withShardField&shard=a&wt=javabin&version=2
   [junit4]   2> 2055729 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&name=withShardField_b_replica2&action=CREATE&numShards=4&collection=withShardField&shard=b&wt=javabin&version=2
   [junit4]   2> 2055732 INFO  (qtp1956011886-16131) [n:127.0.0.1:54333_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&name=withShardField_c_replica1&action=CREATE&numShards=4&collection=withShardField&shard=c&wt=javabin&version=2
   [junit4]   2> 2055873 INFO  
(zkCallback-3075-thread-1-processing-n:127.0.0.1:54335_solr) 
[n:127.0.0.1:54335_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2055873 INFO  
(zkCallback-3076-thread-1-processing-n:127.0.0.1:54334_solr) 
[n:127.0.0.1:54334_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2055873 INFO  
(zkCallback-3074-thread-1-processing-n:127.0.0.1:54332_solr) 
[n:127.0.0.1:54332_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2055873 INFO  
(zkCallback-3077-thread-1-processing-n:127.0.0.1:54333_solr) 
[n:127.0.0.1:54333_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2056769 INFO  (qtp1956011886-16131) [n:127.0.0.1:54333_solr 
c:withShardField s:c  x:withShardField_c_replica1] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 7.0.0
   [junit4]   2> 2056796 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 7.0.0
   [junit4]   2> 2056802 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 7.0.0
   [junit4]   2> 2056802 INFO  (qtp1592706413-16137) [n:127.0.0.1:54332_solr 
c:withShardField s:d  x:withShardField_d_replica2] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 7.0.0
   [junit4]   2> 2056807 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 7.0.0
   [junit4]   2> 2056832 INFO  (qtp136685573-16149) [n:127.0.0.1:54334_solr 
c:withShardField s:a  x:withShardField_a_replica2] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 7.0.0
   [junit4]   2> 2056834 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 7.0.0
   [junit4]   2> 2056832 INFO  (qtp1852616071-16151) [n:127.0.0.1:54335_solr 
c:withShardField s:b  x:withShardField_b_replica1] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 7.0.0
   [junit4]   2> 2056844 INFO  (qtp1956011886-16131) [n:127.0.0.1:54333_solr 
c:withShardField s:c  x:withShardField_c_replica1] o.a.s.s.IndexSchema 
[withShardField_c_replica1] Schema name=cloud-dynamic
   [junit4]   2> 2056844 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] o.a.s.s.IndexSchema 
[withShardField_a_replica1] Schema name=cloud-dynamic
   [junit4]   2> 2056846 INFO  (qtp1592706413-16137) [n:127.0.0.1:54332_solr 
c:withShardField s:d  x:withShardField_d_replica2] o.a.s.s.IndexSchema 
[withShardField_d_replica2] Schema name=cloud-dynamic
   [junit4]   2> 2056848 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] o.a.s.s.IndexSchema 
[withShardField_b_replica2] Schema name=cloud-dynamic
   [junit4]   2> 2056866 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] o.a.s.s.IndexSchema 
[withShardField_c_replica2] Schema name=cloud-dynamic
   [junit4]   2> 2056867 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] o.a.s.s.IndexSchema 
[withShardField_d_replica1] Schema name=cloud-dynamic
   [junit4]   2> 2056868 INFO  (qtp1852616071-16151) [n:127.0.0.1:54335_solr 
c:withShardField s:b  x:withShardField_b_replica1] o.a.s.s.IndexSchema 
[withShardField_b_replica1] Schema name=cloud-dynamic
   [junit4]   2> 2056866 INFO  (qtp136685573-16149) [n:127.0.0.1:54334_solr 
c:withShardField s:a  x:withShardField_a_replica2] o.a.s.s.IndexSchema 
[withShardField_a_replica2] Schema name=cloud-dynamic
   [junit4]   2> 2056965 WARN  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] o.a.s.s.IndexSchema 
[withShardField_d_replica1] default search field in schema is text. WARNING: 
Deprecated, please use 'df' on request instead.
   [junit4]   2> 2056966 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] o.a.s.s.IndexSchema Loaded 
schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2056967 WARN  (qtp136685573-16149) [n:127.0.0.1:54334_solr 
c:withShardField s:a  x:withShardField_a_replica2] o.a.s.s.IndexSchema 
[withShardField_a_replica2] default search field in schema is text. WARNING: 
Deprecated, please use 'df' on request instead.
   [junit4]   2> 2056968 WARN  (qtp1592706413-16137) [n:127.0.0.1:54332_solr 
c:withShardField s:d  x:withShardField_d_replica2] o.a.s.s.IndexSchema 
[withShardField_d_replica2] default search field in schema is text. WARNING: 
Deprecated, please use 'df' on request instead.
   [junit4]   2> 2056968 WARN  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] o.a.s.s.IndexSchema 
[withShardField_b_replica2] default search field in schema is text. WARNING: 
Deprecated, please use 'df' on request instead.
   [junit4]   2> 2056969 INFO  (qtp1592706413-16137) [n:127.0.0.1:54332_solr 
c:withShardField s:d  x:withShardField_d_replica2] o.a.s.s.IndexSchema Loaded 
schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2056969 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] o.a.s.s.IndexSchema Loaded 
schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2056971 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] o.a.s.c.CoreContainer 
Creating SolrCore 'withShardField_b_replica2' using configuration from 
collection withShardField
   [junit4]   2> 2056971 WARN  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] o.a.s.s.IndexSchema 
[withShardField_c_replica2] default search field in schema is text. WARNING: 
Deprecated, please use 'df' on request instead.
   [junit4]   2> 2056972 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] o.a.s.c.SolrCore 
[[withShardField_b_replica2] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_A7C67F31EFD2B706-001/tempDir-001/node1/withShardField_b_replica2],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_A7C67F31EFD2B706-001/tempDir-001/node1/./withShardField_b_replica2/data/]
   [junit4]   2> 2056972 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] o.a.s.s.IndexSchema Loaded 
schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2056973 INFO  (qtp1592706413-16137) [n:127.0.0.1:54332_solr 
c:withShardField s:d  x:withShardField_d_replica2] o.a.s.c.CoreContainer 
Creating SolrCore 'withShardField_d_replica2' using configuration from 
collection withShardField
   [junit4]   2> 2056973 INFO  (qtp1592706413-16137) [n:127.0.0.1:54332_solr 
c:withShardField s:d  x:withShardField_d_replica2] o.a.s.c.SolrCore 
[[withShardField_d_replica2] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_A7C67F31EFD2B706-001/tempDir-001/node1/withShardField_d_replica2],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_A7C67F31EFD2B706-001/tempDir-001/node1/./withShardField_d_replica2/data/]
   [junit4]   2> 2056973 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] o.a.s.c.CoreContainer 
Creating SolrCore 'withShardField_c_replica2' using configuration from 
collection withShardField
   [junit4]   2> 2056973 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] o.a.s.c.SolrCore 
[[withShardField_c_replica2] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_A7C67F31EFD2B706-001/tempDir-001/node3/withShardField_c_replica2],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_A7C67F31EFD2B706-001/tempDir-001/node3/./withShardField_c_replica2/data/]
   [junit4]   2> 2056975 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] o.a.s.c.CoreContainer 
Creating SolrCore 'withShardField_d_replica1' using configuration from 
collection withShardField
   [junit4]   2> 2056975 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] o.a.s.c.SolrCore 
[[withShardField_d_replica1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_A7C67F31EFD2B706-001/tempDir-001/node4/withShardField_d_replica1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_A7C67F31EFD2B706-001/tempDir-001/node4/./withShardField_d_replica1/data/]
   [junit4]   2> 2056976 INFO  (qtp136685573-16149) [n:127.0.0.1:54334_solr 
c:withShardField s:a  x:withShardField_a_replica2] o.a.s.s.IndexSchema Loaded 
schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2056976 WARN  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] o.a.s.s.IndexSchema 
[withShardField_a_replica1] default search field in schema is text. WARNING: 
Deprecated, please use 'df' on request instead.
   [junit4]   2> 2056977 WARN  (qtp1852616071-16151) [n:127.0.0.1:54335_solr 
c:withShardField s:b  x:withShardField_b_replica1] o.a.s.s.IndexSchema 
[withShardField_b_replica1] default search field in schema is text. WARNING: 
Deprecated, please use 'df' on request instead.
   [junit4]   2> 2056977 INFO  (qtp136685573-16149) [n:127.0.0.1:54334_solr 
c:withShardField s:a  x:withShardField_a_replica2] o.a.s.c.CoreContainer 
Creating SolrCore 'withShardField_a_replica2' using configuration from 
collection withShardField
   [junit4]   2> 2056977 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] o.a.s.s.IndexSchema Loaded 
schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2056977 INFO  (qtp136685573-16149) [n:127.0.0.1:54334_solr 
c:withShardField s:a  x:withShardField_a_replica2] o.a.s.c.SolrCore 
[[withShardField_a_replica2] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_A7C67F31EFD2B706-001/tempDir-001/node3/withShardField_a_replica2],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_A7C67F31EFD2B706-001/tempDir-001/node3/./withShardField_a_replica2/data/]
   [junit4]   2> 2056977 INFO  (qtp1852616071-16151) [n:127.0.0.1:54335_solr 
c:withShardField s:b  x:withShardField_b_replica1] o.a.s.s.IndexSchema Loaded 
schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2056978 INFO  (qtp1852616071-16151) [n:127.0.0.1:54335_solr 
c:withShardField s:b  x:withShardField_b_replica1] o.a.s.c.CoreContainer 
Creating SolrCore 'withShardField_b_replica1' using configuration from 
collection withShardField
   [junit4]   2> 2056978 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] o.a.s.c.CoreContainer 
Creating SolrCore 'withShardField_a_replica1' using configuration from 
collection withShardField
   [junit4]   2> 2056979 INFO  (qtp1852616071-16151) [n:127.0.0.1:54335_solr 
c:withShardField s:b  x:withShardField_b_replica1] o.a.s.c.SolrCore 
[[withShardField_b_replica1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_A7C67F31EFD2B706-001/tempDir-001/node4/withShardField_b_replica1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_A7C67F31EFD2B706-001/tempDir-001/node4/./withShardField_b_replica1/data/]
   [junit4]   2> 2056980 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] o.a.s.c.SolrCore 
[[withShardField_a_replica1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_A7C67F31EFD2B706-001/tempDir-001/node2/withShardField_a_replica1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_A7C67F31EFD2B706-001/tempDir-001/node2/./withShardField_a_replica1/data/]
   [junit4]   2> 2056980 WARN  (qtp1956011886-16131) [n:127.0.0.1:54333_solr 
c:withShardField s:c  x:withShardField_c_replica1] o.a.s.s.IndexSchema 
[withShardField_c_replica1] default search field in schema is text. WARNING: 
Deprecated, please use 'df' on request instead.
   [junit4]   2> 2056981 INFO  (qtp1956011886-16131) [n:127.0.0.1:54333_solr 
c:withShardField s:c  x:withShardField_c_replica1] o.a.s.s.IndexSchema Loaded 
schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2056982 INFO  (qtp1956011886-16131) [n:127.0.0.1:54333_solr 
c:withShardField s:c  x:withShardField_c_replica1] o.a.s.c.CoreContainer 
Creating SolrCore 'withShardField_c_replica1' using configuration from 
collection withShardField
   [junit4]   2> 2056982 INFO  (qtp1956011886-16131) [n:127.0.0.1:54333_solr 
c:withShardField s:c  x:withShardField_c_replica1] o.a.s.c.SolrCore 
[[withShardField_c_replica1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_A7C67F31EFD2B706-001/tempDir-001/node2/withShardField_c_replica1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CustomCollectionTest_A7C67F31EFD2B706-001/tempDir-001/node2/./withShardField_c_replica1/data/]
   [junit4]   2> 2057143 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2057143 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2057145 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 2057145 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 2057157 INFO  (qtp1592706413-16137) [n:127.0.0.1:54332_solr 
c:withShardField s:d  x:withShardField_d_replica2] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2057157 INFO  (qtp1592706413-16137) [n:127.0.0.1:54332_solr 
c:withShardField s:d  x:withShardField_d_replica2] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2057160 INFO  (qtp1592706413-16137) [n:127.0.0.1:54332_solr 
c:withShardField s:d  x:withShardField_d_replica2] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 2057160 INFO  (qtp1592706413-16137) [n:127.0.0.1:54332_solr 
c:withShardField s:d  x:withShardField_d_replica2] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 2057161 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2057161 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2057165 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 2057165 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 2057174 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@6e5aad04[withShardField_d_replica1] main]
   [junit4]   2> 2057183 INFO  (qtp1592706413-16137) [n:127.0.0.1:54332_solr 
c:withShardField s:d  x:withShardField_d_replica2] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@2a3a6d43[withShardField_d_replica2] main]
   [junit4]   2> 2057184 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@304246d5[withShardField_c_replica2] main]
   [junit4]   2> 2057190 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2057197 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2057197 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2057200 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 2057200 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 2057203 INFO  (qtp1956011886-16131) [n:127.0.0.1:54333_solr 
c:withShardField s:c  x:withShardField_c_replica1] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2057203 INFO  (qtp1956011886-16131) [n:127.0.0.1:54333_solr 
c:withShardField s:c  x:withShardField_c_replica1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2057206 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2057206 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2057207 INFO  (qtp1956011886-16131) [n:127.0.0.1:54333_solr 
c:withShardField s:c  x:withShardField_c_replica1] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 2057207 INFO  (qtp1956011886-16131) [n:127.0.0.1:54333_solr 
c:withShardField s:c  x:withShardField_c_replica1] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 2057209 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2057209 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 2057210 INFO  
(searcherExecutor-6779-thread-1-processing-n:127.0.0.1:54335_solr 
x:withShardField_d_replica1 s:d c:withShardField) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] o.a.s.c.SolrCore 
[withShardField_d_replica1] Registered new searcher 
Searcher@6e5aad04[withShardField_d_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2057210 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1561067747506388992
   [junit4]   2> 2057212 INFO  (qtp136685573-16149) [n:127.0.0.1:54334_solr 
c:withShardField s:a  x:withShardField_a_replica2] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2057212 INFO  (qtp136685573-16149) [n:127.0.0.1:54334_solr 
c:withShardField s:a  x:withShardField_a_replica2] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2057212 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 2057213 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 2057214 INFO  (qtp136685573-16149) [n:127.0.0.1:54334_solr 
c:withShardField s:a  x:withShardField_a_replica2] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 2057214 INFO  (qtp136685573-16149) [n:127.0.0.1:54334_solr 
c:withShardField s:a  x:withShardField_a_replica2] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 2057216 INFO  (qtp1852616071-16151) [n:127.0.0.1:54335_solr 
c:withShardField s:b  x:withShardField_b_replica1] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2057216 INFO  (qtp1852616071-16151) [n:127.0.0.1:54335_solr 
c:withShardField s:b  x:withShardField_b_replica1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2057216 INFO  (qtp1592706413-16137) [n:127.0.0.1:54332_solr 
c:withShardField s:d  x:withShardField_d_replica2] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2057218 INFO  (qtp1592706413-16137) [n:127.0.0.1:54332_solr 
c:withShardField s:d  x:withShardField_d_replica2] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2057218 INFO  (qtp1592706413-16137) [n:127.0.0.1:54332_solr 
c:withShardField s:d  x:withShardField_d_replica2] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 2057218 INFO  
(searcherExecutor-6777-thread-1-processing-n:127.0.0.1:54332_solr 
x:withShardField_d_replica2 s:d c:withShardField) [n:127.0.0.1:54332_solr 
c:withShardField s:d  x:withShardField_d_replica2] o.a.s.c.SolrCore 
[withShardField_d_replica2] Registered new searcher 
Searcher@2a3a6d43[withShardField_d_replica2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2057219 INFO  (qtp1592706413-16137) [n:127.0.0.1:54332_solr 
c:withShardField s:d  x:withShardField_d_replica2] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1561067747515826176
   [junit4]   2> 2057219 INFO  (qtp1852616071-16151) [n:127.0.0.1:54335_solr 
c:withShardField s:b  x:withShardField_b_replica1] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 2057219 INFO  (qtp1852616071-16151) [n:127.0.0.1:54335_solr 
c:withShardField s:b  x:withShardField_b_replica1] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 2057221 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2057225 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard d: total=2 found=1 timeoutin=9998ms
   [junit4]   2> 2057226 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2057226 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 2057227 INFO  
(searcherExecutor-6778-thread-1-processing-n:127.0.0.1:54334_solr 
x:withShardField_c_replica2 s:c c:withShardField) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] o.a.s.c.SolrCore 
[withShardField_c_replica2] Registered new searcher 
Searcher@304246d5[withShardField_c_replica2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2057227 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1561067747524214784
   [junit4]   2> 2057230 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@2c4c8973[withShardField_b_replica2] main]
   [junit4]   2> 2057232 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2057233 INFO  (qtp1956011886-16131) [n:127.0.0.1:54333_solr 
c:withShardField s:c  x:withShardField_c_replica1] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@6cc93128[withShardField_c_replica1] main]
   [junit4]   2> 2057233 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2057233 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 2057233 INFO  
(searcherExecutor-6776-thread-1-processing-n:127.0.0.1:54332_solr 
x:withShardField_b_replica2 s:b c:withShardField) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] o.a.s.c.SolrCore 
[withShardField_b_replica2] Registered new searcher 
Searcher@2c4c8973[withShardField_b_replica2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2057233 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1561067747530506240
   [junit4]   2> 2057235 INFO  (qtp1956011886-16131) [n:127.0.0.1:54333_solr 
c:withShardField s:c  x:withShardField_c_replica1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2057235 INFO  (qtp1956011886-16131) [n:127.0.0.1:54333_solr 
c:withShardField s:c  x:withShardField_c_replica1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2057236 INFO  (qtp1956011886-16131) [n:127.0.0.1:54333_solr 
c:withShardField s:c  x:withShardField_c_replica1] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 2057236 INFO  
(searcherExecutor-6783-thread-1-processing-n:127.0.0.1:54333_solr 
x:withShardField_c_replica1 s:c c:withShardField) [n:127.0.0.1:54333_solr 
c:withShardField s:c  x:withShardField_c_replica1] o.a.s.c.SolrCore 
[withShardField_c_replica1] Registered new searcher 
Searcher@6cc93128[withShardField_c_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2057236 INFO  (qtp1956011886-16131) [n:127.0.0.1:54333_solr 
c:withShardField s:c  x:withShardField_c_replica1] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1561067747533651968
   [junit4]   2> 2057241 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@3e78c10b[withShardField_a_replica1] main]
   [junit4]   2> 2057245 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2057246 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2057246 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 2057247 INFO  
(searcherExecutor-6782-thread-1-processing-n:127.0.0.1:54333_solr 
x:withShardField_a_replica1 s:a c:withShardField) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] o.a.s.c.SolrCore 
[withShardField_a_replica1] Registered new searcher 
Searcher@3e78c10b[withShardField_a_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2057247 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1561067747545186304
   [junit4]   2> 2057249 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard b: total=2 found=1 timeoutin=9997ms
   [junit4]   2> 2057250 INFO  (qtp1852616071-16151) [n:127.0.0.1:54335_solr 
c:withShardField s:b  x:withShardField_b_replica1] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@376d1eff[withShardField_b_replica1] main]
   [junit4]   2> 2057252 INFO  (qtp1852616071-16151) [n:127.0.0.1:54335_solr 
c:withShardField s:b  x:withShardField_b_replica1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2057252 INFO  (qtp1852616071-16151) [n:127.0.0.1:54335_solr 
c:withShardField s:b  x:withShardField_b_replica1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2057253 INFO  (qtp1852616071-16151) [n:127.0.0.1:54335_solr 
c:withShardField s:b  x:withShardField_b_replica1] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 2057253 INFO  
(searcherExecutor-6781-thread-1-processing-n:127.0.0.1:54335_solr 
x:withShardField_b_replica1 s:b c:withShardField) [n:127.0.0.1:54335_solr 
c:withShardField s:b  x:withShardField_b_replica1] o.a.s.c.SolrCore 
[withShardField_b_replica1] Registered new searcher 
Searcher@376d1eff[withShardField_b_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2057253 INFO  (qtp1852616071-16151) [n:127.0.0.1:54335_solr 
c:withShardField s:b  x:withShardField_b_replica1] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1561067747551477760
   [junit4]   2> 2057258 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2057258 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 2057258 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] o.a.s.c.SyncStrategy Sync 
replicas to http://127.0.0.1:54334/solr/withShardField_c_replica2/
   [junit4]   2> 2057259 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] o.a.s.u.PeerSync PeerSync: 
core=withShardField_c_replica2 url=http://127.0.0.1:54334/solr START 
replicas=[http://127.0.0.1:54333/solr/withShardField_c_replica1/] nUpdates=100
   [junit4]   2> 2057259 INFO  (qtp136685573-16149) [n:127.0.0.1:54334_solr 
c:withShardField s:a  x:withShardField_a_replica2] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@404e9563[withShardField_a_replica2] main]
   [junit4]   2> 2057262 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard a: total=2 found=1 timeoutin=9999ms
   [junit4]   2> 2057259 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] o.a.s.u.PeerSync PeerSync: 
core=withShardField_c_replica2 url=http://127.0.0.1:54334/solr DONE.  We have 
no versions.  sync failed.
   [junit4]   2> 2057261 INFO  (qtp1956011886-16134) [n:127.0.0.1:54333_solr 
c:withShardField s:c r:core_node8 x:withShardField_c_replica1] 
o.a.s.c.S.Request [withShardField_c_replica1]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2057263 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] o.a.s.c.SyncStrategy 
Leader's attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 2057263 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] 
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> 2057263 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 2057265 INFO  (qtp136685573-16149) [n:127.0.0.1:54334_solr 
c:withShardField s:a  x:withShardField_a_replica2] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2057265 INFO  (qtp136685573-16149) [n:127.0.0.1:54334_solr 
c:withShardField s:a  x:withShardField_a_replica2] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2057265 INFO  (qtp136685573-16149) [n:127.0.0.1:54334_solr 
c:withShardField s:a  x:withShardField_a_replica2] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 2057266 INFO  
(searcherExecutor-6780-thread-1-processing-n:127.0.0.1:54334_solr 
x:withShardField_a_replica2 s:a c:withShardField) [n:127.0.0.1:54334_solr 
c:withShardField s:a  x:withShardField_a_replica2] o.a.s.c.SolrCore 
[withShardField_a_replica2] Registered new searcher 
Searcher@404e9563[withShardField_a_replica2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2057266 INFO  (qtp136685573-16149) [n:127.0.0.1:54334_solr 
c:withShardField s:a  x:withShardField_a_replica2] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1561067747565109248
   [junit4]   2> 2057271 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:54334/solr/withShardField_c_replica2/ c
   [junit4]   2> 2057386 INFO  
(zkCallback-3075-thread-1-processing-n:127.0.0.1:54335_solr) 
[n:127.0.0.1:54335_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2057386 INFO  
(zkCallback-3074-thread-3-processing-n:127.0.0.1:54332_solr) 
[n:127.0.0.1:54332_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2057386 INFO  
(zkCallback-3076-thread-1-processing-n:127.0.0.1:54334_solr) 
[n:127.0.0.1:54334_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2057386 INFO  
(zkCallback-3077-thread-1-processing-n:127.0.0.1:54333_solr) 
[n:127.0.0.1:54333_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2057437 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] o.a.s.c.ZkController I am 
the leader, no recovery necessary
   [junit4]   2> 2057442 INFO  (qtp136685573-16147) [n:127.0.0.1:54334_solr 
c:withShardField s:c  x:withShardField_c_replica2] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=withShardField_c_replica2&action=CREATE&numShards=4&collection=withShardField&shard=c&wt=javabin&version=2}
 status=0 QTime=1717
   [junit4]   2> 2057595 INFO  
(zkCallback-3075-thread-1-processing-n:127.0.0.1:54335_solr) 
[n:127.0.0.1:54335_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2057595 INFO  
(zkCallback-3074-thread-2-processing-n:127.0.0.1:54332_solr) 
[n:127.0.0.1:54332_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2057595 INFO  
(zkCallback-3076-thread-1-processing-n:127.0.0.1:54334_solr) 
[n:127.0.0.1:54334_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2057595 INFO  
(zkCallback-3077-thread-1-processing-n:127.0.0.1:54333_solr) 
[n:127.0.0.1:54333_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2057728 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2057728 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 2057728 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] o.a.s.c.SyncStrategy Sync 
replicas to http://127.0.0.1:54335/solr/withShardField_d_replica1/
   [junit4]   2> 2057728 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] o.a.s.u.PeerSync PeerSync: 
core=withShardField_d_replica1 url=http://127.0.0.1:54335/solr START 
replicas=[http://127.0.0.1:54332/solr/withShardField_d_replica2/] nUpdates=100
   [junit4]   2> 2057729 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] o.a.s.u.PeerSync PeerSync: 
core=withShardField_d_replica1 url=http://127.0.0.1:54335/solr DONE.  We have 
no versions.  sync failed.
   [junit4]   2> 2057730 INFO  (qtp1592706413-16142) [n:127.0.0.1:54332_solr 
c:withShardField s:d r:core_node5 x:withShardField_d_replica2] 
o.a.s.c.S.Request [withShardField_d_replica2]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2057731 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] o.a.s.c.SyncStrategy 
Leader's attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 2057731 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] 
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> 2057731 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 2057740 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:54335/solr/withShardField_d_replica1/ d
   [junit4]   2> 2057761 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2057761 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 2057761 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] o.a.s.c.SyncStrategy Sync 
replicas to http://127.0.0.1:54332/solr/withShardField_b_replica2/
   [junit4]   2> 2057761 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] o.a.s.u.PeerSync PeerSync: 
core=withShardField_b_replica2 url=http://127.0.0.1:54332/solr START 
replicas=[http://127.0.0.1:54335/solr/withShardField_b_replica1/] nUpdates=100
   [junit4]   2> 2057761 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] o.a.s.u.PeerSync PeerSync: 
core=withShardField_b_replica2 url=http://127.0.0.1:54332/solr DONE.  We have 
no versions.  sync failed.
   [junit4]   2> 2057763 INFO  (qtp1852616071-16158) [n:127.0.0.1:54335_solr 
c:withShardField s:b r:core_node3 x:withShardField_b_replica1] 
o.a.s.c.S.Request [withShardField_b_replica1]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2057763 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2057763 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 2057763 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] o.a.s.c.SyncStrategy Sync 
replicas to http://127.0.0.1:54333/solr/withShardField_a_replica1/
   [junit4]   2> 2057763 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] o.a.s.c.SyncStrategy 
Leader's attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 2057763 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] o.a.s.u.PeerSync PeerSync: 
core=withShardField_a_replica1 url=http://127.0.0.1:54333/solr START 
replicas=[http://127.0.0.1:54334/solr/withShardField_a_replica2/] nUpdates=100
   [junit4]   2> 2057763 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] 
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> 2057763 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 2057764 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] o.a.s.u.PeerSync PeerSync: 
core=withShardField_a_replica1 url=http://127.0.0.1:54333/solr DONE.  We have 
no versions.  sync failed.
   [junit4]   2> 2057765 INFO  (qtp136685573-16152) [n:127.0.0.1:54334_solr 
c:withShardField s:a r:core_node2 x:withShardField_a_replica2] 
o.a.s.c.S.Request [withShardField_a_replica2]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2057765 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] o.a.s.c.SyncStrategy 
Leader's attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 2057765 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] 
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> 2057765 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 2057769 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:54332/solr/withShardField_b_replica2/ b
   [junit4]   2> 2057771 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:54333/solr/withShardField_a_replica1/ a
   [junit4]   2> 2057890 INFO  
(zkCallback-3076-thread-1-processing-n:127.0.0.1:54334_solr) 
[n:127.0.0.1:54334_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2057890 INFO  
(zkCallback-3075-thread-1-processing-n:127.0.0.1:54335_solr) 
[n:127.0.0.1:54335_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2057890 INFO  
(zkCallback-3077-thread-1-processing-n:127.0.0.1:54333_solr) 
[n:127.0.0.1:54333_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2057890 INFO  
(zkCallback-3074-thread-1-processing-n:127.0.0.1:54332_solr) 
[n:127.0.0.1:54332_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2057909 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] o.a.s.c.ZkController I am 
the leader, no recovery necessary
   [junit4]   2> 2057912 INFO  (qtp1852616071-16156) [n:127.0.0.1:54335_solr 
c:withShardField s:d  x:withShardField_d_replica1] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=withShardField_d_replica1&action=CREATE&numShards=4&collection=withShardField&shard=d&wt=javabin&version=2}
 status=0 QTime=2184
   [junit4]   2> 2057940 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] o.a.s.c.ZkController I am 
the leader, no recovery necessary
   [junit4]   2> 2057940 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] o.a.s.c.ZkController I am 
the leader, no recovery necessary
   [junit4]   2> 2057943 INFO  (qtp1956011886-16128) [n:127.0.0.1:54333_solr 
c:withShardField s:a  x:withShardField_a_replica1] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=withShardField_a_replica1&action=CREATE&numShards=4&collection=withShardField&shard=a&wt=javabin&version=2}
 status=0 QTime=2213
   [junit4]   2> 2057943 INFO  (qtp1592706413-16140) [n:127.0.0.1:54332_solr 
c:withShardField s:b  x:withShardField_b_replica2] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=withShardField_b_replica2&action=CREATE&numShards=4&collection=withShardField&shard=b&wt=javabin&version=2}
 status=0 QTime=2213
   [junit4]   2> 2058060 INFO  
(zkCallback-3075-thread-1-processing-n:127.0.0.1:54335_solr) 
[n:127.0.0.1:54335_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2058060 INFO  
(zkCallback-3076-thread-1-processing-n:127.0.0.1:54334_solr) 
[n:127.0.0.1:54334_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2058061 INFO  
(zkCallback-3077-thread-1-processing-n:127.0.0.1:54333_solr) 
[n:127.0.0.1:54333_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2058061 INFO  
(zkCallback-3074-thread-2-processing-n:127.0.0.1:54332_solr) 
[n:127.0.0.1:54332_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2058239 INFO  (qtp1592706413-16137) [n:127.0.0.1:54332_solr 
c:withShardField s:d  x:withShardField_d_replica2] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=withShardField_d_replica2&action=CREATE&numShards=4&collection=withShardField&shard=d&wt=javabin&version=2}
 status=0 QTime=2510
   [junit4]   2> 2058255 INFO  (qtp1956011886-16131) [n:127.0.0.1:54333_solr 
c:withShardField s:c  x:withShardField_c_replica1] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=withShardField_c_replica1&action=CREATE&numShards=4&collection=withShardField&shard=c&wt=javabin&version=2}
 status=0 QTime=2523
   [junit4]   2> 2058269 INFO  (qtp1852616071-16151) [n:127.0.0.1:54335_solr 
c:withShardField s:b  x:withShardField_b_replica1] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=withShardField_b_replica1&action=CREATE&numShards=4&collection=withShardField&shard=b&wt=javabin&version=2}
 status=0 QTime=2542
   [junit4]   2> 2058282 INFO  (qtp136685573-16149) [n:127.0.0.1:54334_solr 
c:withShardField s:a  x:withShardField_a_replica2] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=withShardField_a_replica2&action=CREATE&numShards=4&collection=withShardField&shard=a&wt=javabin&version=2}
 status=0 QTime=2557
   [junit4]   2> 2058286 INFO  (qtp136685573-16146) [n:127.0.0.1:54334_solr    
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 2058388 INFO  
(zkCallback-3075-thread-1-processing-n:127.0.0.1:54335_solr) 
[n:127.0.0.1:54335_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2058388 INFO  
(zkCallback-3077-thread-1-processing-n:127.0.0.1:54333_solr) 
[n:127.0.0.1:54333_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2058388 INFO  
(zkCallback-3074-thread-3-processing-n:127.0.0.1:54332_solr) 
[n:127.0.0.1:54332_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2058388 INFO  
(zkCallback-3076-thread-1-processing-n:127.0.0.1:54334_solr) 
[n:127.0.0.1:54334_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/withShardField/state.json] for collection [withShardField] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2059295 INFO  (qtp136685573-16146) [n:127.0.0.1:54334_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={shards=a,b,c,d&replicationFactor=2&collection.configName=conf&maxShardsPerNode=3&router.field=shard_s&name=withShardField&router.name=implicit&action=CREATE&wt=javabin&version=2}
 status=0 QTime=3702
   [junit4]   2> 2059304 INFO  (qtp1852616071-16159) [n:127.0.0.1:54335_solr 
c:withShardField s:b r:core_node3 x:withShardField_b_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [withShardField_b_replica1]  webapp=/solr 
path=/update 
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:54332/solr/withShardField_b_replica2/&wt=javabin&version=2}{add=[8
 (1561067749700009984)]} 0 0
   [junit4]   2> 2059305 INFO  (qtp1592706413-16127) [n:127.0.0.1:54332_solr 
c:withShardField s:b r:core_node7 x:withShardField_b_replica2] 
o.a.s.u.p.LogUpdateProcessorFactory [withShardField_b_replica2]  webapp=/solr 
path=/update 
params={update.distrib=TOLEADER&distrib.from=http://127.0.0.1:54333/solr/withShardField_a_replica1/&wt=javabin&version=2}{add=[8
 (1561067749700009984)]} 0 3
   [junit4]   2> 2059306 INFO  (qtp136685573-16153) [n:127.0.0.1:54334_solr 
c:withShardField s:a r:core_node2 x:withShardField_a_replica2] 
o.a.s.u.p.LogUpdateProcessorFactory [withShardField_a_replica2]  webapp=/solr 
path=/update 
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:54333/solr/withShardField_a_replica1/&wt=javabin&version=2}{add=[6
 (1561067749695815680), 7 (1561067749697912832)]} 0 0
   [junit4]   2> 2059308 INFO  (qtp136685573-16130) [n:127.0.0.1:54334_solr 
c:withShardField s:a r:core_node2 x:withShardField_a_replica2] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2059308 INFO  (qtp136685573-16130) [n:127.0.0.1:54334_solr 
c:withShardField s:a r:core_node2 x:withShardField_a_replica2] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@42d8f011
   [junit4]   2> 2059309 INFO  (qtp1956011886-16125) [n:127.0.0.1:54333_solr 
c:withShardField s:a r:core_node6 x:withShardField_a_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2059309 INFO  (qtp1956011886-16125) [n:127.0.0.1:54333_solr 
c:withShardField s:a r:core_node6 x:withShardField_a_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@155e043d
   [junit4]   2> 2059310 INFO  (qtp1852616071-16132) [n:127.0.0.1:54335_solr 
c:withShardField s:b r:core_node3 x:withShardField_b_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2059310 INFO  (qtp1852616071-16132) [n:127.0.0.1:54335_solr 
c:withShardField s:b r:core_node3 x:withShardField_b_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@2b4d2ca0
   [junit4]   2> 2059310 INFO  (qtp1592706413-16138) [n:127.0.0.1:54332_solr 
c:withShardField s:b r:core_node7 x:withShardField_b_replica2] 
o.a.s.u.DirectUpdateHandler2 start commit{,optimize

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

0.1:56917/_/f/collection1:Failed to execute sqlQuery 'select str_s, count(*), 
sum(field_i), min(field_i), max(field_i), cast(avg(1.0 * field_i) as float) 
from collection1 where text='XXXX' group by str_s order by sum(field_i) asc 
limit 2' against JDBC connection 'jdbc:calcitesolr:'.
   [junit4]    > Error while executing SQL "select str_s, count(*), 
sum(field_i), min(field_i), max(field_i), cast(avg(1.0 * field_i) as float) 
from collection1 where text='XXXX' group by str_s order by sum(field_i) asc 
limit 2": From line 1, column 39 to line 1, column 50: No match found for 
function signature min(<NUMERIC>)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([A7C67F31EFD2B706:82C7958269A4BF]:0)
   [junit4]    >        at 
org.apache.solr.client.solrj.io.stream.SolrStream.read(SolrStream.java:235)
   [junit4]    >        at 
org.apache.solr.handler.TestSQLHandler.getTuples(TestSQLHandler.java:2333)
   [junit4]    >        at 
org.apache.solr.handler.TestSQLHandler.testBasicGrouping(TestSQLHandler.java:659)
   [junit4]    >        at 
org.apache.solr.handler.TestSQLHandler.doTest(TestSQLHandler.java:77)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2980781 INFO  
(SUITE-TestSQLHandler-seed#[A7C67F31EFD2B706]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_A7C67F31EFD2B706-001
   [junit4]   2> Mar 05, 2017 9:59:00 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> Mar 05, 2017 9:59:20 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> SEVERE: 1 thread leaked from SUITE scope at 
org.apache.solr.handler.TestSQLHandler: 
   [junit4]   2>    1) Thread[id=22905, name=Connection evictor, 
state=TIMED_WAITING, group=TGRP-TestSQLHandler]
   [junit4]   2>         at java.lang.Thread.sleep(Native Method)
   [junit4]   2>         at 
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
   [junit4]   2>         at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> Mar 05, 2017 9:59:20 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
   [junit4]   2> INFO: Starting to interrupt leaked threads:
   [junit4]   2>    1) Thread[id=22905, name=Connection evictor, 
state=TIMED_WAITING, group=TGRP-TestSQLHandler]
   [junit4]   2> Mar 05, 2017 9:59:20 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
   [junit4]   2> INFO: All leaked threads terminated.
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70), 
sim=RandomSimilarity(queryNorm=false): {}, locale=tr-TR, timezone=Africa/Abidjan
   [junit4]   2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 1.8.0_121 
(64-bit)/cpus=3,threads=1,free=133589704,total=518979584
   [junit4]   2> NOTE: All tests run in this JVM: [RestartWhileUpdatingTest, 
TestSmileRequest, DistributedExpandComponentTest, TestFieldCacheSort, 
EnumFieldTest, SpellPossibilityIteratorTest, DeleteNodeTest, 
TestDefaultSearchFieldResource, PKIAuthenticationIntegrationTest, 
ConfigSetsAPITest, BasicAuthIntegrationTest, TestMaxScoreQueryParser, 
JvmMetricsTest, TestLockTree, TestOnReconnectListenerSupport, 
QueryResultKeyTest, TestCodecSupport, UtilsToolTest, 
LeaderElectionContextKeyTest, TestManagedSchemaAPI, 
TestInPlaceUpdatesStandalone, TestRealTimeGet, TestRandomFaceting, 
CoreAdminRequestStatusTest, TestTrackingShardHandlerFactory, 
HttpSolrCallGetCoreTest, TestSizeLimitedDistributedMap, DebugComponentTest, 
TestTrieFacet, HighlighterConfigTest, TestSimpleTrackingShardHandler, 
CdcrReplicationHandlerTest, TestSolr4Spatial, TestDFRSimilarityFactory, 
TestHdfsUpdateLog, ExternalFileFieldSortTest, 
AsyncCallRequestStatusResponseTest, SolrMetricManagerTest, ReplaceNodeTest, 
CacheHeaderTest, CheckHdfsIndexTest, TestJsonFacets, TestJoin, 
TestSolrQueryParser, TestStressLiveNodes, SolrCLIZkUtilsTest, 
DirectUpdateHandlerOptimizeTest, TestUtils, MissingSegmentRecoveryTest, 
CurrencyFieldOpenExchangeTest, RequestLoggingTest, TestFieldTypeResource, 
TestSuggestSpellingConverter, TestSolrDeletionPolicy2, TestSolrCloudSnapshots, 
DistributedFacetPivotLargeTest, TestCollectionAPI, StressHdfsTest, 
TestSearchPerf, TestManagedSynonymFilterFactory, TestFreeTextSuggestions, 
DistanceUnitsTest, BufferStoreTest, ShardRoutingCustomTest, TestFieldResource, 
HdfsCollectionsAPIDistributedZkTest, ZkSolrClientTest, ScriptEngineTest, 
TestComplexPhraseQParserPlugin, TriLevelCompositeIdRoutingTest, 
TestNumericTerms64, AddBlockUpdateTest, BadIndexSchemaTest, 
TestFieldCacheVsDocValues, CdcrUpdateLogTest, SliceStateTest, TestInitQParser, 
SuggestComponentTest, TermVectorComponentDistributedTest, HdfsThreadLeakTest, 
CdcrVersionReplicationTest, TermVectorComponentTest, 
ConjunctionSolrSpellCheckerTest, TestOrdValues, TestQueryWrapperFilter, 
SecurityConfHandlerTest, CSVRequestHandlerTest, HighlighterMaxOffsetTest, 
DeleteShardTest, TestSolrCLIRunExample, TestCollectionAPIs, AutoCommitTest, 
BlockCacheTest, CleanupOldIndexTest, TestGraphTermsQParserPlugin, 
TestGraphMLResponseWriter, SolrIndexSplitterTest, TestSystemIdResolver, 
IndexSchemaTest, TestRecoveryHdfs, DistribCursorPagingTest, ExplicitHLLTest, 
TestPathTrie, HLLSerializationTest, ResourceLoaderTest, 
SolrMetricsIntegrationTest, EchoParamsTest, TestRequestStatusCollectionAPI, 
TestIndexingPerformance, TestCoreDiscovery, TestRestoreCore, 
TestPHPSerializedResponseWriter, SortSpecParsingTest, 
TestSha256AuthenticationProvider, DistributedFacetPivotWhiteBoxTest, 
TestJmxMonitoredMap, InfoHandlerTest, CollectionsAPIDistributedZkTest, 
SolrCoreCheckLockOnStartupTest, SortByFunctionTest, NotRequiredUniqueKeyTest, 
SuggesterTest, SpellingQueryConverterTest, TestLegacyFieldCache, 
DefaultValueUpdateProcessorTest, DistributedFacetPivotSmallAdvancedTest, 
CoreAdminHandlerTest, TestScoreJoinQPScore, SolrInfoMBeanTest, 
V2ApiIntegrationTest, TestFastWriter, RulesTest, 
LeaderInitiatedRecoveryOnShardRestartTest, TestPKIAuthenticationPlugin, 
SignatureUpdateProcessorFactoryTest, CloudMLTQParserTest, 
DistributedTermsComponentTest, BJQParserTest, SuggesterWFSTTest, 
RAMDirectoryFactoryTest, TestRecovery, TestSearcherReuse, TestManagedResource, 
TestTolerantUpdateProcessorRandomCloud, TestPointFields, 
SolrCmdDistributorTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, 
TestSolrDynamicMBean, TestReplicationHandlerBackup, 
TestSolrCloudWithKerberosAlt, TestComponentsName, BasicZkTest, 
TestCloudPivotFacet, TestCrossCoreJoin, TestNRTOpen, TestShardHandlerFactory, 
RegexBoostProcessorTest, AtomicUpdatesTest, ReplicaListTransformerTest, 
TestCollapseQParserPlugin, TestFuzzyAnalyzedSuggestions, TestSolrIndexConfig, 
ExitableDirectoryReaderTest, CollectionReloadTest, TestCoreAdminApis, 
SpellCheckCollatorTest, AnalyticsQueryTest, TestIndexSearcher, 
ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, UnloadDistributedZkTest, 
OpenCloseCoreStressTest, OverseerTest, LeaderElectionIntegrationTest, 
FullSolrCloudDistribCmdsTest, LeaderElectionTest, TestRandomDVFaceting, 
TestFaceting, TestHashPartitioner, TestReload, TestStressVersions, 
SimpleFacetsTest, SpellCheckComponentTest, TestGroupingSearch, 
QueryElevationComponentTest, ConvertedLegacyTest, TestFunctionQuery, 
TestLazyCores, SoftAutoCommitTest, TermsComponentTest, RequestHandlersTest, 
FieldAnalysisRequestHandlerTest, LoggingHandlerTest, 
UpdateRequestProcessorFactoryTest, QueryParsingTest, JsonLoaderTest, 
BinaryUpdateRequestHandlerTest, TestQuerySenderListener, UpdateParamsTest, 
TestQuerySenderNoQuery, CopyFieldTest, ResponseLogComponentTest, 
BadComponentTest, TestStressRecovery, PreAnalyzedFieldTest, DateFieldTest, 
DOMUtilTest, ClusterStateTest, ZkNodePropsTest, CircularListTest, TestRTGBase, 
DistributedIntervalFacetingTest, TestHighlightDedupGrouping, 
TestTolerantSearch, ConnectionReuseTest, CdcrBootstrapTest, 
CollectionsAPISolrJTest, CustomCollectionTest, DistribJoinFromCollectionTest, 
DistributedVersionInfoTest, HttpPartitionTest, 
LeaderFailureAfterFreshStartTest, OutOfBoxZkACLAndCredentialsProvidersTest, 
OverriddenZkACLAndCredentialsProvidersTest, OverseerStatusTest, 
RecoveryAfterSoftCommitTest, SSLMigrationTest, SaslZkACLProviderTest, 
ShardSplitTest, TestHdfsCloudBackupRestore, TestLeaderElectionWithEmptyReplica, 
TestLocalFSCloudBackupRestore, TestRandomFlRTGCloud, 
TestRandomRequestDistribution, TestReplicaProperties, TestSSLRandomization, 
TestStressCloudBlindAtomicUpdates, TestTolerantUpdateProcessorCloud, 
TestConfigSetImmutable, TestDynamicLoading, TestConfigReload, TestReqParamsAPI, 
TestSQLHandler]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestSQLHandler 
-Dtests.seed=A7C67F31EFD2B706 -Dtests.slow=true -Dtests.locale=tr-TR 
-Dtests.timezone=Africa/Abidjan -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J1 | TestSQLHandler (suite) <<<
   [junit4]    > Throwable #1: 
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE 
scope at org.apache.solr.handler.TestSQLHandler: 
   [junit4]    >    1) Thread[id=22905, name=Connection evictor, 
state=TIMED_WAITING, group=TGRP-TestSQLHandler]
   [junit4]    >         at java.lang.Thread.sleep(Native Method)
   [junit4]    >         at 
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
   [junit4]    >         at java.lang.Thread.run(Thread.java:745)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([A7C67F31EFD2B706]:0)
   [junit4] Completed [572/693 (2!)] on J1 in 66.02s, 1 test, 2 errors <<< 
FAILURES!

[...truncated 62988 lines...]

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

Reply via email to