You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2015/07/30 21:27:10 UTC

[JENKINS-EA] Lucene-Solr-5.x-Linux (32bit/jdk1.9.0-ea-b60) - Build # 13485 - Still Failing!

Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Linux/13485/
Java: 32bit/jdk1.9.0-ea-b60 -client -XX:+UseConcMarkSweepGC -Djava.locale.providers=JRE,SPI

2 tests failed.
FAILED:  org.apache.solr.client.solrj.impl.TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp

Error Message:
java.lang.NullPointerException

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: java.lang.NullPointerException
	at __randomizedtesting.SeedInfo.seed([7D4C1691741CE71D:66A095312600C2D8]:0)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:414)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:328)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1086)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:856)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:799)
	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
	at org.apache.solr.client.solrj.impl.TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp(TestCloudSolrClientConnections.java:57)
	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:502)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
	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:46)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	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:54)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
	at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.NullPointerException
	at org.apache.solr.client.solrj.impl.BasicHttpSolrClientTest$2.process(BasicHttpSolrClientTest.java:672)
	at org.apache.http.protocol.ImmutableHttpProcessor.process(ImmutableHttpProcessor.java:132)
	at org.apache.http.protocol.HttpRequestExecutor.preProcess(HttpRequestExecutor.java:166)
	at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:485)
	at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882)
	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
	at org.apache.solr.util.SolrHttpClient$SolrSystemDefaultHttpClient.execute(SolrHttpClient.java:54)
	at org.apache.solr.util.SolrHttpClient$SolrSystemDefaultHttpClient.execute(SolrHttpClient.java:45)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:465)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:376)
	... 45 more


FAILED:  org.apache.solr.client.solrj.io.stream.StreamExpressionTest.testAll

Error Message:
There are still nodes recoverying - waited for 30 seconds

Stack Trace:
java.lang.AssertionError: There are still nodes recoverying - waited for 30 seconds
	at __randomizedtesting.SeedInfo.seed([7D4C1691741CE71D:311238E80F8CB8D8]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:172)
	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:834)
	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForThingsToLevelOut(AbstractFullDistribZkTestBase.java:1391)
	at org.apache.solr.client.solrj.io.stream.StreamExpressionTest.testAll(StreamExpressionTest.java:110)
	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:502)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:966)
	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:941)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
	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:46)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	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:54)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
	at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 11889 lines...]
   [junit4] Suite: org.apache.solr.client.solrj.impl.TestCloudSolrClientConnections
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.impl.TestCloudSolrClientConnections_7D4C1691741CE71D-001/init-core-data-001
   [junit4]   2> 12354 INFO  (SUITE-TestCloudSolrClientConnections-seed#[7D4C1691741CE71D]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 12356 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testCloudClientCanConnectAfterClusterComesUp
   [junit4]   2> 12364 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 12366 INFO  (Thread-38) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 12366 INFO  (Thread-38) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 12466 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.ZkTestServer start zk server on port:58720
   [junit4]   2> 12475 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 12505 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 12527 INFO  (zkCallback-9-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@19d43d2 name:ZooKeeperConnection Watcher:127.0.0.1:58720 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 12528 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 12529 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 12530 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr/solr.xml
   [junit4]   2> 12548 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 12549 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 12552 INFO  (zkCallback-10-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@638ce7 name:ZooKeeperConnection Watcher:127.0.0.1:58720 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 12553 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 12553 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 13560 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 13561 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 13562 INFO  (zkCallback-12-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@16bdcc0 name:ZooKeeperConnection Watcher:127.0.0.1:58720/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 13562 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 13563 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 13565 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 13569 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.e.j.s.Server jetty-9.2.11.v20150529
   [junit4]   2> 13570 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1c838f1{/solr,null,AVAILABLE}
   [junit4]   2> 13572 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.e.j.s.ServerConnector Started ServerConnector@134592c{HTTP/1.1}{127.0.0.1:42464}
   [junit4]   2> 13573 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.e.j.s.Server Started @15279ms
   [junit4]   2> 13573 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=42464}
   [junit4]   2> 13574 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@1764bce
   [junit4]   2> 13574 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.impl.TestCloudSolrClientConnections_7D4C1691741CE71D-001/tempDir-001/'
   [junit4]   2> 13594 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.s.SolrDispatchFilter Trying to read solr.xml from 127.0.0.1:58720/solr
   [junit4]   2> 13594 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 13595 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 13597 INFO  (zkCallback-13-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7939ad name:ZooKeeperConnection Watcher:127.0.0.1:58720/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 13597 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 13598 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 13616 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.CoresLocator Config-defined core root directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.impl.TestCloudSolrClientConnections_7D4C1691741CE71D-001/tempDir-001/.
   [junit4]   2> 13617 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.CoreContainer New CoreContainer 7998911
   [junit4]   2> 13617 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.impl.TestCloudSolrClientConnections_7D4C1691741CE71D-001/tempDir-001/]
   [junit4]   2> 13617 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.CoreContainer loading shared library: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.impl.TestCloudSolrClientConnections_7D4C1691741CE71D-001/tempDir-001/lib
   [junit4]   2> 13618 WARN  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.impl.TestCloudSolrClientConnections_7D4C1691741CE71D-001/tempDir-001/lib).
   [junit4]   2> 13626 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 13628 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 13629 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 13629 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 13629 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58720/solr
   [junit4]   2> 13639 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 13639 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 13640 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 13641 INFO  (zkCallback-15-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1997f0e name:ZooKeeperConnection Watcher:127.0.0.1:58720 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 13642 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 13642 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 13647 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 13656 INFO  (zkCallback-16-thread-1-processing-n:127.0.0.1:42464_solr) [n:127.0.0.1:42464_solr    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@218d4 name:ZooKeeperConnection Watcher:127.0.0.1:58720/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 13657 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 13664 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 13671 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
   [junit4]   2> 13674 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
   [junit4]   2> 13678 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
   [junit4]   2> 13692 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
   [junit4]   2> 13696 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 13698 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 13700 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 13701 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 13703 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:42464_solr
   [junit4]   2> 13705 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:42464_solr
   [junit4]   2> 13710 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 13720 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
   [junit4]   2> 13722 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 13723 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94259398129876997-127.0.0.1:42464_solr-n_0000000000
   [junit4]   2> 13727 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:42464_solr
   [junit4]   2> 13729 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 13730 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.Overseer Overseer (id=94259398129876997-127.0.0.1:42464_solr-n_0000000000) starting
   [junit4]   2> 13736 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 13755 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 13758 INFO  (OverseerCollectionProcessor-94259398129876997-127.0.0.1:42464_solr-n_0000000000) [n:127.0.0.1:42464_solr    ] o.a.s.c.OverseerCollectionProcessor Process current queue of collection creations
   [junit4]   2> 13758 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 13760 INFO  (OverseerStateUpdate-94259398129876997-127.0.0.1:42464_solr-n_0000000000) [n:127.0.0.1:42464_solr    ] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 13766 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 13767 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 13768 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.CoresLocator Looking for core definitions underneath /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.impl.TestCloudSolrClientConnections_7D4C1691741CE71D-001/tempDir-001/.
   [junit4]   2> 13769 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.c.CoresLocator Found 0 core definitions
   [junit4]   2> 13770 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.s.SolrDispatchFilter user.dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1
   [junit4]   2> 13771 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [n:127.0.0.1:42464_solr    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 13771 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.s.i.CloudSolrClient Waiting for 20 SECONDS for cluster at 127.0.0.1:58720/solr to be ready
   [junit4]   2> 13771 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 13773 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 13781 INFO  (zkCallback-17-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1444863 name:ZooKeeperConnection Watcher:127.0.0.1:58720/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 13782 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 13782 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 13783 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 13785 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.s.i.CloudSolrClient Cluster at 127.0.0.1:58720/solr ready
   [junit4]   2> 13789 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.s.i.BasicHttpSolrClientTest Intercepted params: [local: [SolrHttpContext contains: null]defaults: {http.cookie-store=[], http.cookiespec-registry=org.apache.http.cookie.CookieSpecRegistry@fd68, http.scheme-registry=org.apache.http.conn.scheme.SchemeRegistry@8d77f3, http.auth.credentials-provider={}, http.authscheme-registry=org.apache.http.auth.AuthSchemeRegistry@f3730c}]
   [junit4]   2> 13793 INFO  (jetty-launcher-8-thread-1) [    ] o.e.j.s.ServerConnector Stopped ServerConnector@134592c{HTTP/1.1}{127.0.0.1:0}
   [junit4]   2> 13793 INFO  (jetty-launcher-8-thread-1) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=7998911
   [junit4]   2> 13795 INFO  (jetty-launcher-8-thread-1) [    ] o.a.s.c.Overseer Overseer (id=94259398129876997-127.0.0.1:42464_solr-n_0000000000) closing
   [junit4]   2> 13796 INFO  (OverseerStateUpdate-94259398129876997-127.0.0.1:42464_solr-n_0000000000) [n:127.0.0.1:42464_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:42464_solr
   [junit4]   2> 13799 WARN  (zkCallback-16-thread-1-processing-n:127.0.0.1:42464_solr) [n:127.0.0.1:42464_solr    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK
   [junit4]   2> 13801 INFO  (jetty-launcher-8-thread-1) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1c838f1{/solr,null,UNAVAILABLE}
   [junit4]   2> 13803 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:58720 58720
   [junit4]   2> 13847 INFO  (Thread-38) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:58720 58720
   [junit4]   2> 13860 WARN  (Thread-38) [    ] o.a.s.c.ZkTestServer Watch limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2> 	3	/solr/clusterstate.json
   [junit4]   2> 	2	/solr/aliases.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2> 	2	/solr/live_nodes
   [junit4]   2> 
   [junit4]   2> 13860 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp-seed#[7D4C1691741CE71D]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testCloudClientCanConnectAfterClusterComesUp
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestCloudSolrClientConnections -Dtests.method=testCloudClientCanConnectAfterClusterComesUp -Dtests.seed=7D4C1691741CE71D -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ar_SY -Dtests.timezone=CST6CDT -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   1.54s J1 | TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp <<<
   [junit4]    > Throwable #1: org.apache.solr.client.solrj.SolrServerException: java.lang.NullPointerException
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([7D4C1691741CE71D:66A095312600C2D8]:0)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:414)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:328)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1086)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:856)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:799)
   [junit4]    > 	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.TestCloudSolrClientConnections.testCloudClientCanConnectAfterClusterComesUp(TestCloudSolrClientConnections.java:57)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]    > Caused by: java.lang.NullPointerException
   [junit4]    > 	at org.apache.solr.client.solrj.impl.BasicHttpSolrClientTest$2.process(BasicHttpSolrClientTest.java:672)
   [junit4]    > 	at org.apache.http.protocol.ImmutableHttpProcessor.process(ImmutableHttpProcessor.java:132)
   [junit4]    > 	at org.apache.http.protocol.HttpRequestExecutor.preProcess(HttpRequestExecutor.java:166)
   [junit4]    > 	at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:485)
   [junit4]    > 	at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882)
   [junit4]    > 	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
   [junit4]    > 	at org.apache.solr.util.SolrHttpClient$SolrSystemDefaultHttpClient.execute(SolrHttpClient.java:54)
   [junit4]    > 	at org.apache.solr.util.SolrHttpClient$SolrSystemDefaultHttpClient.execute(SolrHttpClient.java:45)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:465)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:376)
   [junit4]    > 	... 45 more
   [junit4]   2> 13894 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testCloudClientUploads
   [junit4]   2> 13895 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 13895 INFO  (Thread-51) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 13895 INFO  (Thread-51) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 13995 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.ZkTestServer start zk server on port:36826
   [junit4]   2> 13996 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 13996 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 13998 INFO  (zkCallback-19-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1f13b88 name:ZooKeeperConnection Watcher:127.0.0.1:36826 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 13998 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 13999 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 13999 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr/solr.xml
   [junit4]   2> 14002 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 14002 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 14004 INFO  (zkCallback-20-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@171d59a name:ZooKeeperConnection Watcher:127.0.0.1:36826 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 14004 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 14004 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 15006 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 15006 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 15008 INFO  (zkCallback-22-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@dfb02f name:ZooKeeperConnection Watcher:127.0.0.1:36826/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 15008 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 15008 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 15009 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 15011 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.e.j.s.Server jetty-9.2.11.v20150529
   [junit4]   2> 15013 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@e1ddab{/solr,null,AVAILABLE}
   [junit4]   2> 15014 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.e.j.s.ServerConnector Started ServerConnector@cb454f{HTTP/1.1}{127.0.0.1:58709}
   [junit4]   2> 15014 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.e.j.s.Server Started @16720ms
   [junit4]   2> 15014 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=58709}
   [junit4]   2> 15015 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@1764bce
   [junit4]   2> 15015 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.impl.TestCloudSolrClientConnections_7D4C1691741CE71D-001/tempDir-002/'
   [junit4]   2> 15041 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.s.SolrDispatchFilter Trying to read solr.xml from 127.0.0.1:36826/solr
   [junit4]   2> 15043 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 15044 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 15045 INFO  (zkCallback-23-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@e8331 name:ZooKeeperConnection Watcher:127.0.0.1:36826/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 15046 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 15046 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 15059 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.CoresLocator Config-defined core root directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.impl.TestCloudSolrClientConnections_7D4C1691741CE71D-001/tempDir-002/.
   [junit4]   2> 15059 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.CoreContainer New CoreContainer 28334708
   [junit4]   2> 15060 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.impl.TestCloudSolrClientConnections_7D4C1691741CE71D-001/tempDir-002/]
   [junit4]   2> 15060 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.CoreContainer loading shared library: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.impl.TestCloudSolrClientConnections_7D4C1691741CE71D-001/tempDir-002/lib
   [junit4]   2> 15060 WARN  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.impl.TestCloudSolrClientConnections_7D4C1691741CE71D-001/tempDir-002/lib).
   [junit4]   2> 15068 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 15070 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 15071 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 15071 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 15071 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36826/solr
   [junit4]   2> 15071 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 15071 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 15072 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 15073 INFO  (zkCallback-25-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@104f4cc name:ZooKeeperConnection Watcher:127.0.0.1:36826 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 15074 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 15074 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 15076 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 15077 INFO  (zkCallback-26-thread-1-processing-n:127.0.0.1:58709_solr) [n:127.0.0.1:58709_solr    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@19b01e2 name:ZooKeeperConnection Watcher:127.0.0.1:36826/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 15077 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 15079 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 15083 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
   [junit4]   2> 15086 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
   [junit4]   2> 15088 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
   [junit4]   2> 15089 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
   [junit4]   2> 15092 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 15093 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 15095 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 15097 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 15098 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:58709_solr
   [junit4]   2> 15099 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:58709_solr
   [junit4]   2> 15101 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 15102 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
   [junit4]   2> 15104 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 15105 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94259398227394565-127.0.0.1:58709_solr-n_0000000000
   [junit4]   2> 15106 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:58709_solr
   [junit4]   2> 15106 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 15107 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.Overseer Overseer (id=94259398227394565-127.0.0.1:58709_solr-n_0000000000) starting
   [junit4]   2> 15110 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 15125 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 15125 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 15125 INFO  (OverseerCollectionProcessor-94259398227394565-127.0.0.1:58709_solr-n_0000000000) [n:127.0.0.1:58709_solr    ] o.a.s.c.OverseerCollectionProcessor Process current queue of collection creations
   [junit4]   2> 15126 INFO  (OverseerStateUpdate-94259398227394565-127.0.0.1:58709_solr-n_0000000000) [n:127.0.0.1:58709_solr    ] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 15129 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 15129 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 15130 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.CoresLocator Looking for core definitions underneath /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.impl.TestCloudSolrClientConnections_7D4C1691741CE71D-001/tempDir-002/.
   [junit4]   2> 15131 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.c.CoresLocator Found 0 core definitions
   [junit4]   2> 15131 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.s.SolrDispatchFilter user.dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1
   [junit4]   2> 15131 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [n:127.0.0.1:58709_solr    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 15132 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.s.i.CloudSolrClient Waiting for 20 SECONDS for cluster at 127.0.0.1:36826/solr to be ready
   [junit4]   2> 15132 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 15132 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 15134 INFO  (zkCallback-27-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1719e04 name:ZooKeeperConnection Watcher:127.0.0.1:36826/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 15134 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 15135 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 15135 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 15137 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.s.i.CloudSolrClient Cluster at 127.0.0.1:36826/solr ready
   [junit4]   2> 15139 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/testconfig/solrconfig.xml
   [junit4]   2> 15142 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/testconfig/schema.xml
   [junit4]   2> 15154 INFO  (jetty-launcher-18-thread-1) [    ] o.e.j.s.ServerConnector Stopped ServerConnector@cb454f{HTTP/1.1}{127.0.0.1:0}
   [junit4]   2> 15154 INFO  (jetty-launcher-18-thread-1) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=28334708
   [junit4]   2> 15155 INFO  (jetty-launcher-18-thread-1) [    ] o.a.s.c.Overseer Overseer (id=94259398227394565-127.0.0.1:58709_solr-n_0000000000) closing
   [junit4]   2> 15155 INFO  (OverseerStateUpdate-94259398227394565-127.0.0.1:58709_solr-n_0000000000) [n:127.0.0.1:58709_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:58709_solr
   [junit4]   2> 15167 WARN  (zkCallback-26-thread-1-processing-n:127.0.0.1:58709_solr) [n:127.0.0.1:58709_solr    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK
   [junit4]   2> 15168 INFO  (jetty-launcher-18-thread-1) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@e1ddab{/solr,null,UNAVAILABLE}
   [junit4]   2> 15169 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36826 36826
   [junit4]   2> 15264 INFO  (Thread-51) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36826 36826
   [junit4]   2> 15264 WARN  (Thread-51) [    ] o.a.s.c.ZkTestServer Watch limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2> 	3	/solr/clusterstate.json
   [junit4]   2> 	2	/solr/aliases.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2> 	2	/solr/live_nodes
   [junit4]   2> 
   [junit4]   2> 15264 INFO  (TEST-TestCloudSolrClientConnections.testCloudClientUploads-seed#[7D4C1691741CE71D]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testCloudClientUploads
   [junit4]   2> 15266 INFO  (SUITE-TestCloudSolrClientConnections-seed#[7D4C1691741CE71D]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.impl.TestCloudSolrClientConnections_7D4C1691741CE71D-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene53): {}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=ar_SY, timezone=CST6CDT
   [junit4]   2> NOTE: Linux 3.16.0-44-generic i386/Oracle Corporation 1.9.0-ea (32-bit)/cpus=12,threads=1,free=9672168,total=36810752
   [junit4]   2> NOTE: All tests run in this JVM: [CollectionAdminRequestRequiredParamsTest, DocumentAnalysisResponseTest, SolrQueryTest, MergeIndexesEmbeddedTest, BasicHttpSolrClientTest, QueryResponseTest, CloudSolrClientMultiConstructorTest, FieldAnalysisResponseTest, TestSolrProperties, TestCloudSolrClientConnections]
   [junit4] Completed [25/65] on J1 in 2.94s, 2 tests, 1 error <<< FAILURES!

[...truncated 103 lines...]
   [junit4] Suite: org.apache.solr.client.solrj.io.stream.StreamExpressionTest
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_7D4C1691741CE71D-001/init-core-data-001
   [junit4]   2> 53755 INFO  (SUITE-StreamExpressionTest-seed#[7D4C1691741CE71D]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 53755 INFO  (SUITE-StreamExpressionTest-seed#[7D4C1691741CE71D]-worker) [    ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 53757 WARN  (SUITE-StreamExpressionTest-seed#[7D4C1691741CE71D]-worker) [    ] o.a.s.c.AbstractZkTestCase TEST_HOME() does not exist - solrj test?
   [junit4]   2> 53760 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 53760 INFO  (Thread-125) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 53760 INFO  (Thread-125) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 53860 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.ZkTestServer start zk server on port:39915
   [junit4]   2> 53860 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 53861 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 53863 INFO  (zkCallback-37-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@96f292 name:ZooKeeperConnection Watcher:127.0.0.1:39915 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 53863 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 53863 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 53864 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 53866 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 53867 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 53868 INFO  (zkCallback-38-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1721867 name:ZooKeeperConnection Watcher:127.0.0.1:39915/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 53868 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 53868 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 53868 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1
   [junit4]   2> 53870 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
   [junit4]   2> 53872 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
   [junit4]   2> 53873 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
   [junit4]   2> 53875 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/solrconfig-streaming.xml to /configs/conf1/solrconfig.xml
   [junit4]   2> 53875 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 53879 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/schema-streaming.xml to /configs/conf1/schema.xml
   [junit4]   2> 53879 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
   [junit4]   2> 53882 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.AbstractZkTestCase skipping /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml because it doesn't exist
   [junit4]   2> 53882 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.AbstractZkTestCase skipping /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/stopwords.txt because it doesn't exist
   [junit4]   2> 53883 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.AbstractZkTestCase skipping /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/protwords.txt because it doesn't exist
   [junit4]   2> 53883 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.AbstractZkTestCase skipping /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/currency.xml because it doesn't exist
   [junit4]   2> 53883 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.AbstractZkTestCase skipping /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/enumsConfig.xml because it doesn't exist
   [junit4]   2> 53883 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.AbstractZkTestCase skipping /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/open-exchange-rates.json because it doesn't exist
   [junit4]   2> 53883 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.AbstractZkTestCase skipping /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/mapping-ISOLatin1Accent.txt because it doesn't exist
   [junit4]   2> 53883 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.AbstractZkTestCase skipping /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/old_synonyms.txt because it doesn't exist
   [junit4]   2> 53883 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.AbstractZkTestCase skipping /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/synonyms.txt because it doesn't exist
   [junit4]   2> 53894 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_7D4C1691741CE71D-001/control-001/cores/collection1
   [junit4]   2> 53896 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.e.j.s.Server jetty-9.2.11.v20150529
   [junit4]   2> 53897 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5277c3{/,null,AVAILABLE}
   [junit4]   2> 53898 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.e.j.s.ServerConnector Started ServerConnector@12e0fcd{HTTP/1.1}{127.0.0.1:37572}
   [junit4]   2> 53898 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.e.j.s.Server Started @55604ms
   [junit4]   2> 53898 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_7D4C1691741CE71D-001/tempDir-001/control/data, hostContext=/, hostPort=37572, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_7D4C1691741CE71D-001/control-001/cores}
   [junit4]   2> 53899 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@1764bce
   [junit4]   2> 53899 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_7D4C1691741CE71D-001/control-001/'
   [junit4]   2> 53914 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_7D4C1691741CE71D-001/control-001/solr.xml
   [junit4]   2> 53919 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.CoresLocator Config-defined core root directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_7D4C1691741CE71D-001/control-001/cores
   [junit4]   2> 53919 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.CoreContainer New CoreContainer 3333423
   [junit4]   2> 53920 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_7D4C1691741CE71D-001/control-001/]
   [junit4]   2> 53920 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.CoreContainer loading shared library: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_7D4C1691741CE71D-001/control-001/lib
   [junit4]   2> 53920 WARN  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_7D4C1691741CE71D-001/control-001/lib).
   [junit4]   2> 53926 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 53927 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 53927 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 53927 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 53927 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39915/solr
   [junit4]   2> 53927 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 53928 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 53928 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 53930 INFO  (zkCallback-40-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@11a259a name:ZooKeeperConnection Watcher:127.0.0.1:39915 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 53930 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 53930 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 53932 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 53933 INFO  (zkCallback-41-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1ed0670 name:ZooKeeperConnection Watcher:127.0.0.1:39915/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 53933 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 53934 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 53936 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
   [junit4]   2> 53938 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
   [junit4]   2> 53940 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
   [junit4]   2> 53942 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
   [junit4]   2> 53944 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 53945 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 53946 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 53947 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:37572_
   [junit4]   2> 53948 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:37572_
   [junit4]   2> 53949 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 53950 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
   [junit4]   2> 53952 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 53952 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94259400840052739-127.0.0.1:37572_-n_0000000000
   [junit4]   2> 53953 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:37572_
   [junit4]   2> 53953 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 53954 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.Overseer Overseer (id=94259400840052739-127.0.0.1:37572_-n_0000000000) starting
   [junit4]   2> 53956 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 53960 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 53961 INFO  (OverseerCollectionProcessor-94259400840052739-127.0.0.1:37572_-n_0000000000) [n:127.0.0.1:37572_    ] o.a.s.c.OverseerCollectionProcessor Process current queue of collection creations
   [junit4]   2> 53961 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 53961 INFO  (OverseerStateUpdate-94259400840052739-127.0.0.1:37572_-n_0000000000) [n:127.0.0.1:37572_    ] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 53963 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 53964 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 53964 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.CoresLocator Looking for core definitions underneath /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_7D4C1691741CE71D-001/control-001/cores
   [junit4]   2> 53967 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_7D4C1691741CE71D-001/control-001/cores/collection1, collection=control_collection, absoluteInstDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_7D4C1691741CE71D-001/control-001/cores/collection1/, coreNodeName=, dataDir=data/, shard=}
   [junit4]   2> 53968 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.CoresLocator Found core collection1 in /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_7D4C1691741CE71D-001/control-001/cores/collection1/
   [junit4]   2> 53969 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.c.CoresLocator Found 1 core definitions
   [junit4]   2> 53970 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.s.SolrDispatchFilter user.dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1
   [junit4]   2> 53970 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:37572_    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 53970 INFO  (coreLoadExecutor-192-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_ c:control_collection   x:collection1] o.a.s.c.ZkController publishing state=down
   [junit4]   2> 53970 INFO  (coreLoadExecutor-192-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_ c:control_collection   x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property
   [junit4]   2> 53972 INFO  (zkCallback-41-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_    ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 53972 INFO  (coreLoadExecutor-192-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_ c:control_collection   x:collection1] o.a.s.c.ZkController look for our core node name
   [junit4]   2> 53974 INFO  (OverseerStateUpdate-94259400840052739-127.0.0.1:37572_-n_0000000000) [n:127.0.0.1:37572_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:37572",
   [junit4]   2>   "node_name":"127.0.0.1:37572_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 53979 INFO  (OverseerStateUpdate-94259400840052739-127.0.0.1:37572_-n_0000000000) [n:127.0.0.1:37572_    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:37572",
   [junit4]   2>   "node_name":"127.0.0.1:37572_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 53980 INFO  (OverseerStateUpdate-94259400840052739-127.0.0.1:37572_-n_0000000000) [n:127.0.0.1:37572_    ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection
   [junit4]   2> 53986 INFO  (OverseerStateUpdate-94259400840052739-127.0.0.1:37572_-n_0000000000) [n:127.0.0.1:37572_    ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
   [junit4]   2> 53990 INFO  (zkCallback-41-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_    ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 53992 INFO  (zkCallback-41-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_    ] o.a.s.c.c.ZkStateReader Updated cluster state version to 1
   [junit4]   2> 54972 INFO  (coreLoadExecutor-192-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_ c:control_collection   x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1
   [junit4]   2> 54973 INFO  (coreLoadExecutor-192-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_ c:control_collection   x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection
   [junit4]   2> 54973 INFO  (coreLoadExecutor-192-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_ c:control_collection   x:collection1] o.a.s.c.ZkController Collection zkNode exists
   [junit4]   2> 54973 INFO  (coreLoadExecutor-192-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_ c:control_collection   x:collection1] o.a.s.c.c.ZkStateReader Load collection config from:/collections/control_collection
   [junit4]   2> 54974 INFO  (coreLoadExecutor-192-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_ c:control_collection   x:collection1] o.a.s.c.c.ZkStateReader path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 54975 INFO  (coreLoadExecutor-192-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_ c:control_collection   x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_7D4C1691741CE71D-001/control-001/cores/collection1/'
   [junit4]   2> 54999 INFO  (coreLoadExecutor-192-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_ c:control_collection   x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 
   [junit4]   2> 55005 INFO  (coreLoadExecutor-192-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_ c:control_collection   x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 55011 INFO  (coreLoadExecutor-192-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_ c:control_collection   x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.0
   [junit4]   2> 55023 INFO  (coreLoadExecutor-192-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_ c:control_collection   x:collection1] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 55025 INFO  (coreLoadExecutor-192-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_ c:control_collection   x:collection1] o.a.s.s.IndexSchema Reading Solr Schema from /configs/conf1/schema.xml
   [junit4]   2> 55031 INFO  (coreLoadExecutor-192-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_ c:control_collection   x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 55186 INFO  (coreLoadExecutor-192-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_ c:control_collection   x:collection1] o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 55189 INFO  (coreLoadExecutor-192-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_ c:control_collection   x:collection1] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 55189 WARN  (coreLoadExecutor-192-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_ c:control_collection   x:collection1] o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for multiple copyFields (2)
   [junit4]   2> 55190 WARN  (coreLoadExecutor-192-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_ c:control_collection   x:collection1] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (3)
   [junit4]   2> 55194 INFO  (coreLoadExecutor-192-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_ c:control_collection   x:collection1] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/configs/conf1', cwd=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1
   [junit4]   2> 55194 INFO  (coreLoadExecutor-192-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_ c:control_collection   x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection
   [junit4]   2> 55194 INFO  (coreLoadExecutor-192-thread-1-processing-n:127.0.0.1:37572_) [n:127.0.0.1:37572_ c:

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

esByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
   [junit4]   2> 104406 INFO  (OverseerStateUpdate-94259400840052748-127.0.0.1:40488_-n_0000000004) [n:127.0.0.1:40488_    ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "core_node_name":"core_node4",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:40488",
   [junit4]   2>   "node_name":"127.0.0.1:40488_",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 104406 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:40488_ c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
   [junit4]   2> 104406 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:40488_ c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 104406 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:40488_ c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
   [junit4]   2> 104407 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:40488_ c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 104408 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:40488_ c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 104408 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:40488_ c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_7D4C1691741CE71D-001/shard-4-001/cores/collection1/data/index [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_7D4C1691741CE71D-001/shard-4-001/cores/collection1/data/index;done=false>>]
   [junit4]   2> 104408 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:40488_ c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_7D4C1691741CE71D-001/shard-4-001/cores/collection1/data/index
   [junit4]   2> 104408 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:40488_ c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_7D4C1691741CE71D-001/shard-4-001/cores/collection1/data [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_7D4C1691741CE71D-001/shard-4-001/cores/collection1/data;done=false>>]
   [junit4]   2> 104408 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:40488_ c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_7D4C1691741CE71D-001/shard-4-001/cores/collection1/data
   [junit4]   2> 104409 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:40488_ c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.c.Overseer Overseer (id=94259400840052748-127.0.0.1:40488_-n_0000000004) closing
   [junit4]   2> 104409 INFO  (OverseerStateUpdate-94259400840052748-127.0.0.1:40488_-n_0000000004) [n:127.0.0.1:40488_    ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:40488_
   [junit4]   2> 104411 WARN  (zkCallback-56-thread-2-processing-n:127.0.0.1:40488_) [n:127.0.0.1:40488_    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK
   [junit4]   2> 104412 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.e.j.s.ServerConnector Stopped ServerConnector@6983de{HTTP/1.1}{127.0.0.1:0}
   [junit4]   2> 104412 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@f768d7{/,null,UNAVAILABLE}
   [junit4]   2> 104413 INFO  (TEST-StreamExpressionTest.testAll-seed#[7D4C1691741CE71D]) [n:127.0.0.1:40488_ c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39915 39915
   [junit4]   2> 104446 INFO  (Thread-125) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39915 39915
   [junit4]   2> 104446 WARN  (Thread-125) [    ] o.a.s.c.ZkTestServer Watch limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2> 	6	/solr/aliases.json
   [junit4]   2> 	6	/solr/clusterstate.json
   [junit4]   2> 	5	/solr/configs/conf1
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2> 	6	/solr/live_nodes
   [junit4]   2> 	5	/solr/overseer/collection-queue-work
   [junit4]   2> 	4	/solr/overseer/queue
   [junit4]   2> 
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=StreamExpressionTest -Dtests.method=testAll -Dtests.seed=7D4C1691741CE71D -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=tr -Dtests.timezone=America/Argentina/San_Luis -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] FAILURE 50.7s J1 | StreamExpressionTest.testAll <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: There are still nodes recoverying - waited for 30 seconds
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([7D4C1691741CE71D:311238E80F8CB8D8]:0)
   [junit4]    > 	at org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:172)
   [junit4]    > 	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:834)
   [junit4]    > 	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForThingsToLevelOut(AbstractFullDistribZkTestBase.java:1391)
   [junit4]    > 	at org.apache.solr.client.solrj.io.stream.StreamExpressionTest.testAll(StreamExpressionTest.java:110)
   [junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:966)
   [junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:941)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 104459 INFO  (SUITE-StreamExpressionTest-seed#[7D4C1691741CE71D]-worker) [n:127.0.0.1:40488_ c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_7D4C1691741CE71D-001
   [junit4]   2> Jul 30, 2015 7:26:05 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 2 leaked thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene53): {}, docValues:{}, sim=DefaultSimilarity, locale=tr, timezone=America/Argentina/San_Luis
   [junit4]   2> NOTE: Linux 3.16.0-44-generic i386/Oracle Corporation 1.9.0-ea (32-bit)/cpus=12,threads=1,free=16469008,total=47558656
   [junit4]   2> NOTE: All tests run in this JVM: [CollectionAdminRequestRequiredParamsTest, DocumentAnalysisResponseTest, SolrQueryTest, MergeIndexesEmbeddedTest, BasicHttpSolrClientTest, QueryResponseTest, CloudSolrClientMultiConstructorTest, FieldAnalysisResponseTest, TestSolrProperties, TestCloudSolrClientConnections, SolrExampleStreamingBinaryTest, SolrExampleXMLTest, SolrExampleEmbeddedTest, TestSpellCheckResponse, TestEmbeddedSolrServer, TestNamedListCodec, ContentStreamTest, TestXMLEscaping, SolrExceptionTest, FacetFieldTest, StreamExpressionTest]
   [junit4] Completed [60/65] on J1 in 51.50s, 1 test, 1 failure <<< FAILURES!

[...truncated 27 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:727: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:671: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:59: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build.xml:243: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/common-build.xml:517: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:1447: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:1002: There were test failures: 65 suites, 455 tests, 1 error, 1 failure

Total time: 58 minutes 28 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any