Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/25/

4 tests failed.
FAILED:  
org.apache.solr.cloud.CdcrReplicationDistributedZkTest.testBufferOnNonLeader

Error Message:
Captured an uncaught exception in thread: Thread[id=102044, 
name=cdcr-replicator-5816-thread-1, state=RUNNABLE, 
group=TGRP-CdcrReplicationDistributedZkTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=102044, name=cdcr-replicator-5816-thread-1, 
state=RUNNABLE, group=TGRP-CdcrReplicationDistributedZkTest]
        at 
__randomizedtesting.SeedInfo.seed([2EDAC8600D29B3B2:2E90C7575B19CB38]:0)
Caused by: java.lang.AssertionError
        at __randomizedtesting.SeedInfo.seed([2EDAC8600D29B3B2]:0)
        at 
org.apache.solr.update.CdcrUpdateLog$CdcrLogReader.forwardSeek(CdcrUpdateLog.java:609)
        at org.apache.solr.handler.CdcrReplicator.run(CdcrReplicator.java:120)
        at 
org.apache.solr.handler.CdcrReplicatorScheduler$1.run(CdcrReplicatorScheduler.java:83)
        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:745)


FAILED:  org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test

Error Message:
Timeout occured while waiting response from server at: 
http://127.0.0.1:59046/neg

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting 
response from server at: http://127.0.0.1:59046/neg
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:588)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
        at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.makeRequest(CollectionsAPIDistributedZkTest.java:381)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testErrorHandling(CollectionsAPIDistributedZkTest.java:497)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test(CollectionsAPIDistributedZkTest.java:169)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:996)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:971)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)
Caused by: java.net.SocketTimeoutException: Read timed out
        at java.net.SocketInputStream.socketRead0(Native Method)
        at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
        at java.net.SocketInputStream.read(SocketInputStream.java:170)
        at java.net.SocketInputStream.read(SocketInputStream.java:141)
        at 
org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
        at 
org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
        at 
org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
        at 
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
        at 
org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
        at 
org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
        at 
org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
        at 
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
        at 
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
        at 
org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685)
        at 
org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487)
        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.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:482)
        ... 47 more


FAILED:  org.apache.solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest.test

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

Stack Trace:
java.lang.AssertionError: There are still nodes recoverying - waited for 440 
seconds
        at 
__randomizedtesting.SeedInfo.seed([2EDAC8600D29B3B2:A68EF7BAA3D5DE4A]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:173)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:856)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForThingsToLevelOut(AbstractFullDistribZkTestBase.java:1412)
        at 
org.apache.solr.cloud.TlogReplayBufferedWhileIndexingTest.test(TlogReplayBufferedWhileIndexingTest.java:99)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:996)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:971)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)


FAILED:  
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy

Error Message:
Could not find collection : c1

Stack Trace:
org.apache.solr.common.SolrException: Could not find collection : c1
        at 
__randomizedtesting.SeedInfo.seed([2EDAC8600D29B3B2:4595681D74266E88]:0)
        at 
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:135)
        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy(ZkStateReaderTest.java:46)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 11344 lines...]
   [junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_2EDAC8600D29B3B2-001/init-core-data-001
   [junit4]   2> 908529 INFO  
(SUITE-ZkStateReaderTest-seed#[2EDAC8600D29B3B2]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 908534 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
   [junit4]   2> 908534 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 908542 INFO  (Thread-1384) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 908542 INFO  (Thread-1384) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 908642 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.ZkTestServer start zk server on port:49563
   [junit4]   2> 908642 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 908642 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 908650 INFO  (zkCallback-431-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@4e6709ec 
name:ZooKeeperConnection Watcher:127.0.0.1:49563 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 908650 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 908650 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 908651 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 908652 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 908659 INFO  (zkCallback-432-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@246779c2 
name:ZooKeeperConnection Watcher:127.0.0.1:49563 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 908659 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 908659 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 908659 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 908662 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 908662 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 908669 INFO  (zkCallback-433-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7fc36e3f 
name:ZooKeeperConnection Watcher:127.0.0.1:49563/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 908669 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 908669 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 908669 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 908670 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 908670 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 908671 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 908671 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 908672 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 908672 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 908673 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 908673 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 908674 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 908674 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 908674 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ZkStateReader Removing watch for uninteresting collection [c1]
   [junit4]   2> 908681 INFO  (zkCallback-433-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 908681 WARN  (zkCallback-433-thread-2) [    ] 
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: 
[KeeperErrorCode = Session expired for /collections]
   [junit4]   2> 908682 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:49563 49563
   [junit4]   2> 908918 INFO  (Thread-1384) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:49563 49563
   [junit4]   2> 908934 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
   [junit4]   2> 908935 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 908935 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 908942 INFO  (Thread-1385) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 908942 INFO  (Thread-1385) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 909046 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.ZkTestServer start zk server on port:44251
   [junit4]   2> 909046 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 909046 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 909063 INFO  (zkCallback-434-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@35b16c86 
name:ZooKeeperConnection Watcher:127.0.0.1:44251 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 909063 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 909063 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 909066 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 909066 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 909067 INFO  (zkCallback-435-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@6c4544d2 
name:ZooKeeperConnection Watcher:127.0.0.1:44251 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 909067 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 909067 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 909067 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 909069 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 909069 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 909072 INFO  (zkCallback-436-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@454f37f4 
name:ZooKeeperConnection Watcher:127.0.0.1:44251/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 909072 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 909072 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 909073 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 909073 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 909074 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 909075 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 909075 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 909076 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 909076 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 909077 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 909077 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 909077 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 909077 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 909078 INFO  (zkCallback-436-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 909079 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 909080 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 909082 INFO  (zkCallback-436-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred 
- updating... (live nodes size: [0])
   [junit4]   2> 909082 WARN  (zkCallback-436-thread-2) [    ] 
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: 
[KeeperErrorCode = Session expired for /clusterstate.json]
   [junit4]   2> 909083 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44251 44251
   [junit4]   2> 909315 INFO  (Thread-1385) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:44251 44251
   [junit4]   2> 909315 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 909321 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> 909321 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 909324 INFO  (Thread-1386) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 909324 INFO  (Thread-1386) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 909451 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.ZkTestServer start zk server on port:60572
   [junit4]   2> 909451 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 909466 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 909468 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Exception causing close of session 0x0 due to 
java.io.IOException: ZooKeeperServer not running
   [junit4]   2> 910970 INFO  (zkCallback-437-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@107a1b31 
name:ZooKeeperConnection Watcher:127.0.0.1:60572 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 910970 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 910970 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 910978 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 910979 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 910989 INFO  (zkCallback-438-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@32ed6041 
name:ZooKeeperConnection Watcher:127.0.0.1:60572 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 910989 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 910990 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 910990 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 910995 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 911002 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 911003 INFO  (zkCallback-439-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1383a59a 
name:ZooKeeperConnection Watcher:127.0.0.1:60572/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 911003 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 911003 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 911004 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 911004 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 911005 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 911005 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 911006 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 911007 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 911007 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 911007 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 911009 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 911010 INFO  (zkCallback-439-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 911010 INFO  (zkCallback-439-thread-3) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred 
- updating... (live nodes size: [0])
   [junit4]   2> 912510 WARN  (zkCallback-439-thread-2) [    ] 
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: 
[KeeperErrorCode = Session expired for /collections]
   [junit4]   2> 912510 WARN  (zkCallback-439-thread-3) [    ] 
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: 
[KeeperErrorCode = Session expired for /clusterstate.json]
   [junit4]   2> 912511 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:60572 60572
   [junit4]   2> 912634 INFO  (Thread-1386) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:60572 60572
   [junit4]   2> 912635 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending 
testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> NOTE: download the large Jenkins line-docs file by running 
'ant get-jenkins-line-docs' in the lucene directory.
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=ZkStateReaderTest 
-Dtests.method=testStateFormatUpdateWithExplicitRefreshLazy 
-Dtests.seed=2EDAC8600D29B3B2 -Dtests.multiplier=2 -Dtests.nightly=true 
-Dtests.slow=true 
-Dtests.linedocsfile=/x1/jenkins/lucene-data/enwiki.random.lines.txt 
-Dtests.locale=es-US -Dtests.timezone=Australia/West -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   3.32s J0 | 
ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy <<<
   [junit4]    > Throwable #1: org.apache.solr.common.SolrException: Could not 
find collection : c1
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([2EDAC8600D29B3B2:4595681D74266E88]:0)
   [junit4]    >        at 
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
   [junit4]    >        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:135)
   [junit4]    >        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy(ZkStateReaderTest.java:46)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 912637 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
   [junit4]   2> 912638 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 912638 INFO  (Thread-1387) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 912638 INFO  (Thread-1387) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 912742 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.ZkTestServer start zk server on port:57204
   [junit4]   2> 912742 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 912747 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 912782 INFO  (zkCallback-440-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@61b2a7c9 
name:ZooKeeperConnection Watcher:127.0.0.1:57204 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 912782 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 912782 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 912798 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 912813 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 912834 INFO  (zkCallback-441-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@2da8b0b9 
name:ZooKeeperConnection Watcher:127.0.0.1:57204 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 912834 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 912834 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 912834 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 912953 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 912953 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 912994 INFO  (zkCallback-442-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@458a1ede 
name:ZooKeeperConnection Watcher:127.0.0.1:57204/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 912994 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 912994 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 912994 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 912995 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 912995 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 912996 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 912996 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 912997 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 912997 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 912997 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 912998 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 912998 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 912998 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 913023 INFO  (zkCallback-442-thread-3) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred 
- updating... (live nodes size: [0])
   [junit4]   2> 913026 INFO  (zkCallback-442-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 913050 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 913057 INFO  (zkCallback-442-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred 
- updating... (live nodes size: [0])
   [junit4]   2> 913074 INFO  (zkCallback-442-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 913110 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57204 57204
   [junit4]   2> 913282 INFO  (Thread-1387) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:57204 57204
   [junit4]   2> 913283 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
   [junit4]   2> 913286 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 913294 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 913294 INFO  (Thread-1388) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 913294 INFO  (Thread-1388) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 913401 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.ZkTestServer start zk server on port:53023
   [junit4]   2> 913401 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 913410 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 913495 INFO  (zkCallback-443-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@48ef0850 
name:ZooKeeperConnection Watcher:127.0.0.1:53023 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 913495 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 913495 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 913496 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 913496 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x153c53883ce0000, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 913496 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 913497 INFO  (zkCallback-444-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@80c0fc0 name:ZooKeeperConnection 
Watcher:127.0.0.1:53023 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 913497 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 913497 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 913497 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 913499 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 913499 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 913505 INFO  (zkCallback-445-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7c1b54c4 
name:ZooKeeperConnection Watcher:127.0.0.1:53023/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 913505 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 913505 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 913505 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 913506 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 913507 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 913507 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 913508 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 913509 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 913509 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 913510 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 913526 INFO  (zkCallback-445-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 913531 INFO  (zkCallback-445-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred 
- updating... (live nodes size: [0])
   [junit4]   2> 913582 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 913582 INFO  (zkCallback-445-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred 
- updating... (live nodes size: [0])
   [junit4]   2> 913586 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:53023 53023
   [junit4]   2> 913749 INFO  (Thread-1388) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:53023 53023
   [junit4]   2> 913762 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2EDAC8600D29B3B2])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 913762 INFO  
(SUITE-ZkStateReaderTest-seed#[2EDAC8600D29B3B2]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_2EDAC8600D29B3B2-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene60): {}, 
docValues:{}, maxPointsInLeafNode=1273, maxMBSortInHeap=4.129988558298747, 
sim=ClassicSimilarity, locale=es-US, timezone=Australia/West
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 
1.8.0_74 (64-bit)/cpus=4,threads=1,free=200152960,total=443023360
   [junit4]   2> NOTE: All tests run in this JVM: [TolerantUpdateProcessorTest, 
SignatureUpdateProcessorFactoryTest, OutputWriterTest, TestHashQParserPlugin, 
TestExpandComponent, TestAnalyzeInfixSuggestions, BasicDistributedZkTest, 
TestAtomicUpdateErrorCases, CloudExitableDirectoryReaderTest, 
DeleteReplicaTest, PolyFieldTest, TestFunctionQuery, AnalyticsQueryTest, 
TestImplicitCoreProperties, EchoParamsTest, SystemInfoHandlerTest, 
SolrCoreTest, InfoHandlerTest, QueryElevationComponentTest, 
DistributedSuggestComponentTest, DistributedFacetPivotWhiteBoxTest, 
DistributedSpellCheckComponentTest, RestartWhileUpdatingTest, 
HLLSerializationTest, TestLazyCores, CdcrUpdateLogTest, 
DistributedQueryElevationComponentTest, LeaderElectionIntegrationTest, 
RuleEngineTest, TestJsonFacets, ZkStateReaderTest]
   [junit4] Completed [75/585 (1!)] on J0 in 5.26s, 5 tests, 1 error <<< 
FAILURES!

[...truncated 583 lines...]
   [junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_2EDAC8600D29B3B2-001/init-core-data-001
   [junit4]   2> 2961309 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[2EDAC8600D29B3B2]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 2961309 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[2EDAC8600D29B3B2]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /neg/
   [junit4]   2> 2961311 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2961311 INFO  (Thread-11634) [    ] o.a.s.c.ZkTestServer 
client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2961311 INFO  (Thread-11634) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 2961414 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:55524
   [junit4]   2> 2961414 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2961422 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2961435 INFO  (zkCallback-1696-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@3d4d0202 
name:ZooKeeperConnection Watcher:127.0.0.1:55524 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2961436 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2961436 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2961436 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 2961439 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2961450 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2961474 INFO  (zkCallback-1697-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@55122850 
name:ZooKeeperConnection Watcher:127.0.0.1:55524/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2961474 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2961474 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2961474 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
   [junit4]   2> 2961475 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
   [junit4]   2> 2961475 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
   [junit4]   2> 2961476 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
   [junit4]   2> 2961476 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 2961476 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 2961477 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 2961477 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
   [junit4]   2> 2961478 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 2961478 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 2961479 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 2961479 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
   [junit4]   2> 2961480 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 2961480 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
   [junit4]   2> 2961480 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 2961481 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
   [junit4]   2> 2961481 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 2961481 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
   [junit4]   2> 2961482 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 2961482 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
   [junit4]   2> 2961482 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 2961483 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 2961483 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 2961483 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
   [junit4]   2> 2961484 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 2961484 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
   [junit4]   2> 2961485 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2961498 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2961515 INFO  (zkCallback-1698-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7e93e41d 
name:ZooKeeperConnection Watcher:127.0.0.1:55524 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2961515 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2961515 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2961516 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 2961518 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2961645 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2961658 INFO  (zkCallback-1699-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@292ba34f 
name:ZooKeeperConnection Watcher:127.0.0.1:55524/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2961658 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2961658 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2961658 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf2/solrconfig.xml
   [junit4]   2> 2961659 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.xml
   [junit4]   2> 2961659 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf2/schema.xml
   [junit4]   2> 2961660 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/schema.xml
   [junit4]   2> 2961660 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf2/enumsConfig.xml
   [junit4]   2> 2961660 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/enumsConfig.xml
   [junit4]   2> 2961661 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf2/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 2961661 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/configs/conf2/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 2961662 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf2/stopwords.txt
   [junit4]   2> 2961662 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/stopwords.txt
   [junit4]   2> 2961662 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf2/protwords.txt
   [junit4]   2> 2961663 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/protwords.txt
   [junit4]   2> 2961663 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf2/currency.xml
   [junit4]   2> 2961663 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/currency.xml
   [junit4]   2> 2961664 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf2/open-exchange-rates.json
   [junit4]   2> 2961664 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/open-exchange-rates.json
   [junit4]   2> 2961665 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf2/mapping-ISOLatin1Accent.txt
   [junit4]   2> 2961665 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/mapping-ISOLatin1Accent.txt
   [junit4]   2> 2961665 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf2/old_synonyms.txt
   [junit4]   2> 2961665 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/old_synonyms.txt
   [junit4]   2> 2961666 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf2/synonyms.txt
   [junit4]   2> 2961666 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/synonyms.txt
   [junit4]   2> 2961667 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/elevate.xml
 to /configs/conf2/elevate.xml
   [junit4]   2> 2961667 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/elevate.xml
   [junit4]   2> 2961778 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_2EDAC8600D29B3B2-001/control-001/cores/collection1
   [junit4]   2> 2961780 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 2961846 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2df1212c{/neg,null,AVAILABLE}
   [junit4]   2> 2961847 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@4f2a2602{HTTP/1.1,[http/1.1]}{127.0.0.1:35114}
   [junit4]   2> 2961847 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.e.j.s.Server Started @2968333ms
   [junit4]   2> 2961847 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_2EDAC8600D29B3B2-001/tempDir-001/control/data,
 hostContext=/neg, hostPort=35114, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_2EDAC8600D29B3B2-001/control-001/cores}
   [junit4]   2> 2961847 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@73d16e93
   [junit4]   2> 2961847 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_2EDAC8600D29B3B2-001/control-001'
   [junit4]   2> 2961848 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 2961848 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 2961858 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2961872 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2961874 INFO  (zkCallback-1700-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@66794faa 
name:ZooKeeperConnection Watcher:127.0.0.1:55524/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2961874 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2961874 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2961875 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 2961875 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_2EDAC8600D29B3B2-001/control-001/solr.xml
   [junit4]   2> 2961878 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_2EDAC8600D29B3B2-001/control-001/cores
   [junit4]   2> 2961878 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 1020900989
   [junit4]   2> 2961878 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_2EDAC8600D29B3B2-001/control-001]
   [junit4]   2> 2961878 WARN  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_2EDAC8600D29B3B2-001/control-001/lib
 to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_2EDAC8600D29B3B2-001/control-001/lib
   [junit4]   2> 2961879 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
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> 2961879 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 2961880 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 2961880 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 2961880 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:55524/solr
   [junit4]   2> 2961880 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 2961880 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2961886 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2961922 INFO  (zkCallback-1703-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@5da17273 
name:ZooKeeperConnection Watcher:127.0.0.1:55524 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2961922 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2961923 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2961934 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 2961941 INFO  
(zkCallback-1704-thread-1-processing-n:127.0.0.1:35114_neg) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@2fc8d453 
name:ZooKeeperConnection Watcher:127.0.0.1:55524/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2961941 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.c.ConnectionManager Client is connected to 
ZooKeeper
   [junit4]   2> 2961941 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 2961942 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-queue-work
   [junit4]   2> 2961943 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-running
   [junit4]   2> 2961944 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-completed
   [junit4]   2> 2961945 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-failure
   [junit4]   2> 2961946 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 2961947 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 2961947 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 2961948 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 2961948 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.c.ZkStateReader Updating cluster state from 
ZooKeeper... 
   [junit4]   2> 2961949 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (0)
   [junit4]   2> 2961950 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 2961950 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer_elect/election
   [junit4]   2> 2961951 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2961951 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.LeaderElector Joined leadership election 
with path: 
/overseer_elect/election/95636997904203782-127.0.0.1:35114_neg-n_0000000000
   [junit4]   2> 2961951 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:35114_neg
   [junit4]   2> 2961951 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer_elect/leader
   [junit4]   2> 2961952 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.Overseer Overseer 
(id=95636997904203782-127.0.0.1:35114_neg-n_0000000000) starting
   [junit4]   2> 2961956 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/queue-work
   [junit4]   2> 2961959 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=10000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 2961970 INFO  
(OverseerStateUpdate-95636997904203782-127.0.0.1:35114_neg-n_0000000000) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 2961972 INFO  
(OverseerStateUpdate-95636997904203782-127.0.0.1:35114_neg-n_0000000000) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (0)
   [junit4]   2> 2961982 INFO  
(OverseerCollectionConfigSetProcessor-95636997904203782-127.0.0.1:35114_neg-n_0000000000)
 [n:127.0.0.1:35114_neg    ] o.a.s.c.OverseerTaskProcessor Process current 
queue of overseer operations
   [junit4]   2> 2961987 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:35114_neg
   [junit4]   2> 2961988 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.c.SolrZkClient makePath: 
/live_nodes/127.0.0.1:35114_neg
   [junit4]   2> 2961988 INFO  
(zkCallback-1704-thread-1-processing-n:127.0.0.1:35114_neg) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.c.ZkStateReader A live node change: 
[WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], 
has occurred - updating... (live nodes size: [0])
   [junit4]   2> 2961989 INFO  
(zkCallback-1704-thread-1-processing-n:127.0.0.1:35114_neg) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2962019 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.CoreContainer Security conf doesn't exist. 
Skipping setup for authorization module.
   [junit4]   2> 2962019 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 2962019 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.CorePropertiesLocator Looking for core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_2EDAC8600D29B3B2-001/control-001/cores
   [junit4]   2> 2962020 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[2EDAC8600D29B3B2]) 
[n:127.0.0.1:35114_neg    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: 
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, 
loadOnStartup=true, configSetProperties=configsetprops.json, 
collection=control_collection, coreNodeName=, dataDir=data/, shard=}
   [junit4]   2> 2962020 INFO  (TEST-CollectionsAPIDistribute

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

[junit4]   2>   at 
org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1720)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1699)
   [junit4]   2>        at 
org.apache.solr.cloud.hdfs.HdfsTestUtil.teardownClass(HdfsTestUtil.java:198)
   [junit4]   2>        at 
org.apache.solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest.teardownClass(HdfsTlogReplayBufferedWhileIndexingTest.java:52)
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method)
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:834)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> Caused by: java.lang.NullPointerException
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.blockmanagement.BlocksMap.size(BlocksMap.java:198)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.blockmanagement.BlockManager.getTotalBlocks(BlockManager.java:3291)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.namenode.FSNamesystem.getBlocksTotal(FSNamesystem.java:6223)
   [junit4]   2>        ... 54 more
   [junit4]   2> 6178293 INFO  
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[2EDAC8600D29B3B2]-worker) 
[    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_2EDAC8600D29B3B2-001
   [junit4]   2> Mar 30, 2016 3:19:54 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 2 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: 
codec=FastCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST,
 chunkSize=527, maxDocsPerChunk=651, blockSize=4), 
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST, 
chunkSize=527, blockSize=4)), sim=ClassicSimilarity, locale=it-CH, 
timezone=Etc/GMT+9
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 
1.8.0_74 (64-bit)/cpus=4,threads=2,free=234760504,total=481296384
   [junit4]   2> NOTE: All tests run in this JVM: [DateMathParserTest, 
CircularListTest, TestTolerantSearch, TestSolrJ, 
DirectUpdateHandlerOptimizeTest, ConnectionManagerTest, 
FieldMutatingUpdateProcessorTest, ForceLeaderTest, MultiThreadedOCPTest, 
TestCollationField, TestExactStatsCache, TestIndexSearcher, TestSolrXml, 
TestGroupingSearch, DistributedQueryComponentOptimizationTest, 
TestJmxIntegration, DistributedFacetPivotSmallTest, HighlighterConfigTest, 
TestTrackingShardHandlerFactory, StatsComponentTest, 
TestDistributedStatsComponentCardinality, SolrCloudExampleTest, SparseHLLTest, 
TestXIncludeConfig, VersionInfoTest, TermVectorComponentDistributedTest, 
RecoveryZkTest, PluginInfoTest, TestDefaultStatsCache, 
HdfsDirectoryFactoryTest, TestDynamicFieldResource, 
TestSerializedLuceneMatchVersion, BlockCacheTest, TestConfigSetImmutable, 
TestReversedWildcardFilterFactory, BadCopyFieldTest, SmileWriterTest, 
OverseerTest, TestUniqueKeyFieldResource, SegmentsInfoRequestHandlerTest, 
LukeRequestHandlerTest, TestSolrCloudWithKerberosAlt, DebugComponentTest, 
TestCoreDiscovery, CleanupOldIndexTest, SharedFSAutoReplicaFailoverTest, 
TestSolrConfigHandlerConcurrent, SSLMigrationTest, TestElisionMultitermQuery, 
TestLeaderInitiatedRecoveryThread, TestXmlQParser, 
DistributedFacetPivotLargeTest, FullSolrCloudDistribCmdsTest, 
TestReloadDeadlock, TestSort, SearchHandlerTest, 
TlogReplayBufferedWhileIndexingTest, DocValuesMultiTest, TestRecovery, 
TestSolrIndexConfig, CoreAdminHandlerTest, TestSolrCLIRunExample, 
SimpleFacetsTest, QueryParsingTest, HdfsSyncSliceTest, TestChildDocTransformer, 
DistribJoinFromCollectionTest, TestDownShardTolerantSearch, 
BaseCdcrDistributedZkTest, OverseerCollectionConfigSetProcessorTest, 
TestFileDictionaryLookup, TestDynamicLoading, TestUtils, TestStandardQParsers, 
TestMaxScoreQueryParser, TestOverriddenPrefixQueryForCustomFieldType, 
DeleteLastCustomShardedReplicaTest, CachingDirectoryFactoryTest, 
BinaryUpdateRequestHandlerTest, TestRebalanceLeaders, 
XmlUpdateRequestHandlerTest, DirectSolrConnectionTest, DeleteStatusTest, 
SuggesterTSTTest, TestSchemaManager, TestCSVResponseWriter, 
TestPHPSerializedResponseWriter, BasicDistributedZk2Test, 
TestPerFieldSimilarity, TestZkChroot, TestJmxMonitoredMap, 
HdfsBasicDistributedZk2Test, ShowFileRequestHandlerTest, 
LeaderInitiatedRecoveryOnCommitTest, ConjunctionSolrSpellCheckerTest, 
UnloadDistributedZkTest, CollectionsAPIDistributedZkTest, 
OpenCloseCoreStressTest, TestFiltering, TestFoldingMultitermQuery, 
SuggesterTest, SpatialFilterTest, SuggesterWFSTTest, NoCacheHeaderTest, 
WordBreakSolrSpellCheckerTest, SchemaVersionSpecificBehaviorTest, 
SolrCoreCheckLockOnStartupTest, TestUpdate, TestWordDelimiterFilterFactory, 
DefaultValueUpdateProcessorTest, StatelessScriptUpdateProcessorFactoryTest, 
DistanceFunctionTest, TestSolrDeletionPolicy1, CacheHeaderTest, 
IndexBasedSpellCheckerTest, DisMaxRequestHandlerTest, TestWriterPerf, 
PrimitiveFieldTypeTest, RequestHandlersTest, TestValueSourceCache, 
TestIndexingPerformance, FieldAnalysisRequestHandlerTest, 
FastVectorHighlighterTest, SolrPluginUtilsTest, IndexSchemaTest, 
JSONWriterTest, UniqFieldsUpdateProcessorFactoryTest, CSVRequestHandlerTest, 
UpdateParamsTest, AlternateDirectoryTest, ResponseLogComponentTest, 
BadComponentTest, TestStressRecovery, SolrTestCaseJ4Test, TestCrossCoreJoin, 
TestCursorMarkWithoutUniqueKey, TestDistributedMissingSort, 
TestHighlightDedupGrouping, TestSimpleTrackingShardHandler, 
ConnectionReuseTest, TestJettySolrRunner, ActionThrottleTest, 
AliasIntegrationTest, AssignTest, AsyncCallRequestStatusResponseTest, 
AsyncMigrateRouteKeyTest, CdcrRequestHandlerTest, CollectionStateFormat2Test, 
ConcurrentDeleteAndCreateCollectionTest, DistributedQueueTest, 
LeaderInitiatedRecoveryOnShardRestartTest, OverseerTaskQueueTest, 
RecoveryAfterSoftCommitTest, ReplicationFactorTest, SaslZkACLProviderTest, 
ShardSplitTest, HdfsChaosMonkeySafeLeaderTest, HdfsRecoverLeaseTest, 
HdfsRecoveryZkTest, HdfsThreadLeakTest, HdfsTlogReplayBufferedWhileIndexingTest]
   [junit4] Completed [462/585 (4!)] on J2 in 533.02s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 395 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:747: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:684: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:59: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build.xml:233:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/common-build.xml:529:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1457:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1014:
 There were test failures: 585 suites (10 ignored), 2364 tests, 3 errors, 1 
failure, 32 ignored (16 assumptions) [seed: 2EDAC8600D29B3B2]

Total time: 286 minutes 35 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
No prior successful build to compare, so performing full copy of artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any



---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to