You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2016/07/03 23:48:24 UTC

[JENKINS] Lucene-Solr-Tests-6.x - Build # 311 - Still Failing

Build: https://builds.apache.org/job/Lucene-Solr-Tests-6.x/311/

4 tests failed.
FAILED:  org.apache.solr.cloud.overseer.ZkStateReaderTest.testExternalCollectionWatchedNotWatched

Error Message:


Stack Trace:
java.lang.NullPointerException
	at __randomizedtesting.SeedInfo.seed([CCA512216E94B775:C71EE30D3FCD41DC]:0)
	at org.apache.solr.cloud.overseer.ZkStateReaderTest.testExternalCollectionWatchedNotWatched(ZkStateReaderTest.java:167)
	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)


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

Error Message:
Could not find collection : c1

Stack Trace:
org.apache.solr.common.SolrException: Could not find collection : c1
	at __randomizedtesting.SeedInfo.seed([CCA512216E94B775:D31F63D6BEF471B0]:0)
	at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:192)
	at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:129)
	at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:43)
	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)


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([CCA512216E94B775:A7EAB25C179B6A4F]:0)
	at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:192)
	at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:129)
	at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy(ZkStateReaderTest.java:48)
	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)


FAILED:  org.apache.solr.cloud.overseer.ZkStateWriterTest.testExternalModificationToStateFormat2

Error Message:


Stack Trace:
java.lang.AssertionError
	at __randomizedtesting.SeedInfo.seed([CCA512216E94B775:BD7806F50F3F4BF5]:0)
	at org.junit.Assert.fail(Assert.java:92)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.junit.Assert.assertTrue(Assert.java:54)
	at org.apache.solr.cloud.overseer.ZkStateWriterTest.testExternalModificationToStateFormat2(ZkStateWriterTest.java:322)
	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 11179 lines...]
   [junit4] Suite: org.apache.solr.cloud.overseer.ZkStateWriterTest
   [junit4]   2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.overseer.ZkStateWriterTest_CCA512216E94B775-001/init-core-data-001
   [junit4]   2> 572355 INFO  (SUITE-ZkStateWriterTest-seed#[CCA512216E94B775]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 572358 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testSingleExternalCollection
   [junit4]   2> 572358 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 572358 INFO  (Thread-2226) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 572358 INFO  (Thread-2226) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 572458 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer start zk server on port:45547
   [junit4]   2> 572458 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 572459 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 572461 INFO  (zkCallback-715-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@60e9113a name:ZooKeeperConnection Watcher:127.0.0.1:45547 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 572461 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 572462 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 572462 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 572463 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 572464 INFO  (zkCallback-716-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@d2eac0b name:ZooKeeperConnection Watcher:127.0.0.1:45547 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 572464 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 572464 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 572464 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 572468 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 572469 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 572469 INFO  (zkCallback-717-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@fcfd2e8 name:ZooKeeperConnection Watcher:127.0.0.1:45547/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 572470 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 572470 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 572470 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 572471 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 572472 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 572473 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 572473 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 572474 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 572475 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 572475 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 572476 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 572476 INFO  (zkCallback-717-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 572477 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 572479 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45547 45547
   [junit4]   2> 572605 INFO  (Thread-2226) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45547 45547
   [junit4]   2> 572606 INFO  (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testSingleExternalCollection
   [junit4]   2> 572608 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testExternalModificationToSharedClusterState
   [junit4]   2> 572608 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 572608 INFO  (Thread-2227) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 572608 INFO  (Thread-2227) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 572708 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer start zk server on port:44330
   [junit4]   2> 572708 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 572709 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 572712 INFO  (zkCallback-719-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@32ca0f3a name:ZooKeeperConnection Watcher:127.0.0.1:44330 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 572712 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 572712 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 572713 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 572714 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 572714 INFO  (zkCallback-720-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5fa91c68 name:ZooKeeperConnection Watcher:127.0.0.1:44330 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 572715 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 572715 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 572715 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 572717 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 572717 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 572718 INFO  (zkCallback-721-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6d95a8f3 name:ZooKeeperConnection Watcher:127.0.0.1:44330/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 572718 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 572719 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 572719 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 572720 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 572720 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 572721 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 572722 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 572722 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 572723 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 572723 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 572724 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 572724 INFO  (zkCallback-721-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 572725 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c2
   [junit4]   2> 572725 INFO  (zkCallback-721-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 572726 INFO  (zkCallback-721-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> 572728 INFO  (zkCallback-721-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> 572729 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44330 44330
   [junit4]   2> 573246 INFO  (Thread-2227) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44330 44330
   [junit4]   2> 573246 INFO  (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testExternalModificationToSharedClusterState
   [junit4]   2> 573248 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testSingleLegacyCollection
   [junit4]   2> 573249 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 573249 INFO  (Thread-2228) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 573249 INFO  (Thread-2228) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 573349 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer start zk server on port:39049
   [junit4]   2> 573349 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 573360 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 573366 INFO  (zkCallback-723-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@626dcdd4 name:ZooKeeperConnection Watcher:127.0.0.1:39049 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 573366 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 573366 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 573367 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 573368 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 573368 INFO  (zkCallback-724-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@77223124 name:ZooKeeperConnection Watcher:127.0.0.1:39049 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 573368 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 573368 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 573368 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 573375 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 573376 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 573376 INFO  (zkCallback-725-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@45d945f9 name:ZooKeeperConnection Watcher:127.0.0.1:39049/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 573376 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 573376 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 573376 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 573377 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 573377 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 573378 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 573378 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 573378 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 573378 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 573379 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 573379 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 573380 INFO  (zkCallback-725-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 573381 INFO  (zkCallback-725-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> 573381 WARN  (zkCallback-725-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> 573386 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39049 39049
   [junit4]   2> 573485 INFO  (Thread-2228) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39049 39049
   [junit4]   2> 573485 INFO  (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testSingleLegacyCollection
   [junit4]   2> 573487 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testExternalModificationToStateFormat2
   [junit4]   2> 573487 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 573487 INFO  (Thread-2229) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 573487 INFO  (Thread-2229) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 573588 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer start zk server on port:53264
   [junit4]   2> 573588 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 573588 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 573592 INFO  (zkCallback-727-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2d7c0317 name:ZooKeeperConnection Watcher:127.0.0.1:53264 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 573592 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 573593 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 573594 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 573594 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 573595 INFO  (zkCallback-728-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@10d34f6 name:ZooKeeperConnection Watcher:127.0.0.1:53264 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 573595 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 573595 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 573595 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 573597 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 573597 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 573598 INFO  (zkCallback-729-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@552543e6 name:ZooKeeperConnection Watcher:127.0.0.1:53264/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 573598 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 573598 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 573599 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 573599 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 573600 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 573600 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 573601 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 573601 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 573601 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 573601 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 573602 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 573602 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c2
   [junit4]   2> 573603 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c2/state.json
   [junit4]   2> 573604 ERROR (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]-EventThread) [    ] o.a.z.ClientCnxn Error while calling watcher 
   [junit4]   2> java.util.concurrent.RejectedExecutionException: Task org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$8/1149293457@768385f3 rejected from org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@72bc1ffb[Shutting down, pool size = 1, active threads = 0, queued tasks = 0, completed tasks = 1]
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2047)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:823)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1369)
   [junit4]   2> 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.execute(ExecutorUtil.java:214)
   [junit4]   2> 	at java.util.concurrent.AbstractExecutorService.submit(AbstractExecutorService.java:112)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient$3.process(SolrZkClient.java:267)
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522)
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498)
   [junit4]   2> 573609 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:53264 53264
   [junit4]   2> 573716 INFO  (Thread-2229) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:53264 53264
   [junit4]   2> 573716 INFO  (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testExternalModificationToStateFormat2
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=ZkStateWriterTest -Dtests.method=testExternalModificationToStateFormat2 -Dtests.seed=CCA512216E94B775 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=sr-Latn -Dtests.timezone=Europe/London -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] FAILURE 0.23s J1 | ZkStateWriterTest.testExternalModificationToStateFormat2 <<<
   [junit4]    > Throwable #1: java.lang.AssertionError
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([CCA512216E94B775:BD7806F50F3F4BF5]:0)
   [junit4]    > 	at org.apache.solr.cloud.overseer.ZkStateWriterTest.testExternalModificationToStateFormat2(ZkStateWriterTest.java:322)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 573721 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testZkStateWriterBatching
   [junit4]   2> 573721 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 573721 INFO  (Thread-2230) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 573721 INFO  (Thread-2230) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 573821 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer start zk server on port:44163
   [junit4]   2> 573821 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 573832 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 573839 INFO  (zkCallback-731-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@ba1f150 name:ZooKeeperConnection Watcher:127.0.0.1:44163 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 573839 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 573839 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 573840 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 573844 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 573844 INFO  (zkCallback-732-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@472b7b71 name:ZooKeeperConnection Watcher:127.0.0.1:44163 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 573844 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 573845 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 573845 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 573846 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 573847 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 573854 INFO  (zkCallback-733-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6f8ab739 name:ZooKeeperConnection Watcher:127.0.0.1:44163/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 573854 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 573854 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 573854 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 573855 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 573855 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 573856 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 573866 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 573867 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 573867 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 573867 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 573868 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 573868 INFO  (zkCallback-733-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 573868 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c2
   [junit4]   2> 573869 INFO  (zkCallback-733-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 573869 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 573871 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44163 44163
   [junit4]   2> 573989 INFO  (Thread-2230) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44163 44163
   [junit4]   2> 573990 INFO  (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testZkStateWriterBatching
   [junit4]   2> 573990 INFO  (SUITE-ZkStateWriterTest-seed#[CCA512216E94B775]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.overseer.ZkStateWriterTest_CCA512216E94B775-001
   [junit4]   2> Jul 03, 2016 11:14:10 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 3 leaked thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene62): {}, docValues:{}, maxPointsInLeafNode=1276, maxMBSortInHeap=5.515003184709201, sim=RandomSimilarity(queryNorm=true,coord=crazy): {}, locale=sr-Latn, timezone=Europe/London
   [junit4]   2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 1.8.0_74 (64-bit)/cpus=4,threads=1,free=315493480,total=522715136
   [junit4]   2> NOTE: All tests run in this JVM: [TestWordDelimiterFilterFactory, TestHashQParserPlugin, TestManagedStopFilterFactory, AliasIntegrationTest, TestSortByMinMaxFunction, ZkControllerTest, WordBreakSolrSpellCheckerTest, TermVectorComponentTest, CoreAdminCreateDiscoverTest, InfoHandlerTest, TestCloudInspectUtil, SpellingQueryConverterTest, StressHdfsTest, BlockJoinFacetRandomTest, TestConfigOverlay, TestStressCloudBlindAtomicUpdates, CachingDirectoryFactoryTest, CdcrReplicationHandlerTest, TestRequestForwarding, TestSolrCoreProperties, ZkSolrClientTest, UpdateRequestProcessorFactoryTest, MoreLikeThisHandlerTest, JavabinLoaderTest, TestReRankQParserPlugin, TestStressUserVersions, DistributedSuggestComponentTest, BasicFunctionalityTest, OverseerModifyCollectionTest, TestLRUStatsCache, TestQuerySenderNoQuery, TestConfigSetsAPI, TestDistributedGrouping, RulesTest, SimplePostToolTest, ChaosMonkeySafeLeaderTest, UniqFieldsUpdateProcessorFactoryTest, TimeZoneUtilsTest, TestFieldSortValues, SoftAutoCommitTest, TestHashPartitioner, TestMacros, BitVectorTest, TestLegacyFieldCache, MultiTermTest, HdfsLockFactoryTest, TestQuerySenderListener, TestUninvertingReader, TestSurroundQueryParser, AddSchemaFieldsUpdateProcessorFactoryTest, SortByFunctionTest, DistanceFunctionTest, SuggesterFSTTest, TestDistribIDF, ZkStateWriterTest]
   [junit4] Completed [187/619 (1!)] on J1 in 1.90s, 5 tests, 1 failure <<< FAILURES!

[...truncated 351 lines...]
   [junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
   [junit4]   2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_CCA512216E94B775-001/init-core-data-001
   [junit4]   2> 900058 INFO  (SUITE-ZkStateReaderTest-seed#[CCA512216E94B775]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 900064 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
   [junit4]   2> 900064 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 900073 INFO  (Thread-2321) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 900073 INFO  (Thread-2321) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 900173 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer start zk server on port:38770
   [junit4]   2> 900173 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 900197 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 900210 INFO  (zkCallback-1060-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4cb86bb3 name:ZooKeeperConnection Watcher:127.0.0.1:38770 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 900210 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 900210 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 900218 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 900257 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 900275 INFO  (zkCallback-1061-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@57d70bde name:ZooKeeperConnection Watcher:127.0.0.1:38770 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 900432 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 900433 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 900433 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 900486 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 900488 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 900490 INFO  (zkCallback-1062-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@c425099 name:ZooKeeperConnection Watcher:127.0.0.1:38770/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 900490 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 900490 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 900491 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 900491 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 900492 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 900492 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 900493 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 900493 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 900493 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 900493 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 900494 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 900495 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 900496 INFO  (zkCallback-1062-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 900496 WARN  (zkCallback-1062-thread-1) [    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /collections]
   [junit4]   2> 900497 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38770 38770
   [junit4]   2> 900601 INFO  (Thread-2321) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38770 38770
   [junit4]   2> 900601 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=ZkStateReaderTest -Dtests.method=testExternalCollectionWatchedNotWatched -Dtests.seed=CCA512216E94B775 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=en-CA -Dtests.timezone=Asia/Ashkhabad -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.54s J0 | ZkStateReaderTest.testExternalCollectionWatchedNotWatched <<<
   [junit4]    > Throwable #1: java.lang.NullPointerException
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([CCA512216E94B775:C71EE30D3FCD41DC]:0)
   [junit4]    > 	at org.apache.solr.cloud.overseer.ZkStateReaderTest.testExternalCollectionWatchedNotWatched(ZkStateReaderTest.java:167)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 900604 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 900605 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 900605 INFO  (Thread-2322) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 900605 INFO  (Thread-2322) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 900705 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer start zk server on port:52875
   [junit4]   2> 900705 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 900729 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 900749 INFO  (zkCallback-1064-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@15c88250 name:ZooKeeperConnection Watcher:127.0.0.1:52875 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 900749 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 900749 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 900757 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 900791 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 900798 INFO  (zkCallback-1065-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3b513d48 name:ZooKeeperConnection Watcher:127.0.0.1:52875 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 900798 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 900798 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 900798 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 900806 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 900806 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 900818 INFO  (zkCallback-1066-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@44740dff name:ZooKeeperConnection Watcher:127.0.0.1:52875/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 900818 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 900818 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 900824 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 900825 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 900825 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 900826 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 900826 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 900826 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 900827 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 900827 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 900827 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 900828 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 900828 INFO  (zkCallback-1066-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 900832 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 900833 INFO  (zkCallback-1066-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> 900835 INFO  (zkCallback-1066-thread-3) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for collection [c1] has occurred - updating... (live nodes size: [0])
   [junit4]   2> 900836 WARN  (zkCallback-1066-thread-3) [    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /collections/c1/state.json]
   [junit4]   2> 900836 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:52875 52875
   [junit4]   2> 901087 INFO  (Thread-2322) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:52875 52875
   [junit4]   2> 901088 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithExplicitRefresh -Dtests.seed=CCA512216E94B775 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=en-CA -Dtests.timezone=Asia/Ashkhabad -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.49s J0 | ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh <<<
   [junit4]    > Throwable #1: org.apache.solr.common.SolrException: Could not find collection : c1
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([CCA512216E94B775:D31F63D6BEF471B0]:0)
   [junit4]    > 	at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:192)
   [junit4]    > 	at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:129)
   [junit4]    > 	at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:43)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 901090 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
   [junit4]   2> 901090 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 901093 INFO  (Thread-2323) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 901093 INFO  (Thread-2323) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 901269 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer start zk server on port:38961
   [junit4]   2> 901269 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 901285 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 901290 INFO  (zkCallback-1068-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@38c11643 name:ZooKeeperConnection Watcher:127.0.0.1:38961 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 901290 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 901290 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 901297 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 901297 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 901304 INFO  (zkCallback-1069-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@714f015e name:ZooKeeperConnection Watcher:127.0.0.1:38961 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 901304 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 901304 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 901304 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 901323 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 901324 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 901324 INFO  (zkCallback-1070-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1c1d93e3 name:ZooKeeperConnection Watcher:127.0.0.1:38961/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 901324 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 901324 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 901325 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 901325 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 901325 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 901326 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 901326 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 901327 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 901327 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 901327 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 901328 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 901328 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 901329 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 901329 INFO  (zkCallback-1070-thread-2) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for collection [c1] has occurred - updating... (live nodes size: [0])
   [junit4]   2> 901332 INFO  (zkCallback-1070-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 901336 INFO  (zkCallback-1070-thread-2) [    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 901349 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38961 38961
   [junit4]   2> 901451 INFO  (Thread-2323) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38961 38961
   [junit4]   2> 901452 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
   [junit4]   2> 901455 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 901456 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 901456 INFO  (Thread-2324) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 901456 INFO  (Thread-2324) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 901556 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer start zk server on port:52478
   [junit4]   2> 901556 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 901557 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 901560 INFO  (zkCallback-1072-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@35b3a3ee name:ZooKeeperConnection Watcher:127.0.0.1:52478 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 901561 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 901561 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 901562 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 901563 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 901563 INFO  (zkCallback-1073-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@17663c52 name:ZooKeeperConnection Watcher:127.0.0.1:52478 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 901563 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 901564 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 901564 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 901566 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 901569 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 901569 INFO  (zkCallback-1074-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6bc830b0 name:ZooKeeperConnection Watcher:127.0.0.1:52478/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 901569 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 901569 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 901569 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 901570 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 901571 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 901571 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 901577 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 901577 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 901577 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 901578 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 901578 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 901580 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 901585 INFO  (zkCallback-1074-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 901592 INFO  (zkCallback-1074-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> 901593 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 901593 INFO  (zkCallback-1074-thread-2) [    ] o.a.s.c.c.ZkStateReader Uninteresting collection c1
   [junit4]   2> 901593 INFO  (zkCallback-1074-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> 901596 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 901597 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:52478 52478
   [junit4]   2> 901772 INFO  (Thread-2324) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:52478 52478
   [junit4]   2> 901773 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 901777 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> 901778 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 901778 INFO  (Thread-2325) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 901778 INFO  (Thread-2325) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 901878 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer start zk server on port:43551
   [junit4]   2> 901878 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 901885 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 901889 INFO  (zkCallback-1076-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@73f13be7 name:ZooKeeperConnection Watcher:127.0.0.1:43551 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 901889 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 901889 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 901889 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 901893 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 901921 INFO  (zkCallback-1077-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6902483 name:ZooKeeperConnection Watcher:127.0.0.1:43551 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 901921 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 901921 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 901921 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 901929 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 901929 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 901930 INFO  (zkCallback-1078-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@eeaef name:ZooKeeperConnection Watcher:127.0.0.1:43551/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 901930 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 901930 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 901930 INFO  (TEST-ZkStateReaderTest.testStateForma

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

Waiting for client to connect to ZooKeeper
   [junit4]   2> 902233 INFO  (zkCallback-1081-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@496fd353 name:ZooKeeperConnection Watcher:127.0.0.1:57371 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 902233 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 902233 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 902233 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 902234 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 902234 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 902235 INFO  (zkCallback-1082-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@cb13959 name:ZooKeeperConnection Watcher:127.0.0.1:57371/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 902235 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 902235 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 902236 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 902236 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 902237 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 902237 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 902238 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 902238 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 902238 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 902239 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 902239 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 902239 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 902240 INFO  (zkCallback-1082-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 902240 INFO  (zkCallback-1082-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> 902241 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 902241 INFO  (zkCallback-1082-thread-1) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for collection [c1] has occurred - updating... (live nodes size: [0])
   [junit4]   2> 902241 INFO  (zkCallback-1082-thread-1) [    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 902242 INFO  (zkCallback-1082-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> 902244 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57371 57371
   [junit4]   2> 902501 INFO  (Thread-2326) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57371 57371
   [junit4]   2> 902502 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
   [junit4]   2> 902502 INFO  (SUITE-ZkStateReaderTest-seed#[CCA512216E94B775]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_CCA512216E94B775-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene62): {}, docValues:{}, maxPointsInLeafNode=1134, maxMBSortInHeap=5.327257604830283, sim=RandomSimilarity(queryNorm=true,coord=no): {}, locale=en-CA, timezone=Asia/Ashkhabad
   [junit4]   2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 1.8.0_74 (64-bit)/cpus=4,threads=1,free=338148088,total=505937920
   [junit4]   2> NOTE: All tests run in this JVM: [TestCrossCoreJoin, HdfsRecoveryZkTest, TestSmileRequest, TestRangeQuery, OverseerStatusTest, TestDynamicFieldResource, TestDefaultStatsCache, TestHighlightDedupGrouping, DistribJoinFromCollectionTest, TestCollectionAPI, TestRTGBase, TestOrdValues, TestSolr4Spatial, TestStressLucene, TestIBSimilarityFactory, TestUniqueKeyFieldResource, DistributedFacetPivotLargeTest, TestChildDocTransformer, RuleEngineTest, JSONWriterTest, TestNRTOpen, TestDistributedSearch, TestSolrCloudWithKerberosAlt, IgnoreCommitOptimizeUpdateProcessorFactoryTest, ExitableDirectoryReaderTest, TestMergePolicyConfig, TestFieldCacheSort, SpatialRPTFieldTypeTest, UUIDFieldTest, TestPseudoReturnFields, TestConfigSetsAPIZkFailure, TestMaxScoreQueryParser, DistributedSpellCheckComponentTest, DefaultValueUpdateProcessorTest, PeerSyncTest, QueryElevationComponentTest, TestConfigSetProperties, SyncSliceTest, LeaderElectionIntegrationTest, TestFileDictionaryLookup, TestSolrCLIRunExample, CopyFieldTest, TestRestoreCore, TriLevelCompositeIdRoutingTest, TestFieldTypeCollectionResource, SignatureUpdateProcessorFactoryTest, TestBackupRepositoryFactory, DateFieldTest, DistributedQueryElevationComponentTest, TestFastOutputStream, TestCSVLoader, TestAtomicUpdateErrorCases, CreateCollectionCleanupTest, DeleteLastCustomShardedReplicaTest, DisMaxRequestHandlerTest, TestReplicaProperties, TestRuleBasedAuthorizationPlugin, BigEndianAscendingWordSerializerTest, IndexSchemaTest, StandardRequestHandlerTest, TestManagedSchema, TestRemoteStreaming, HdfsCollectionsAPIDistributedZkTest, TestCopyFieldCollectionResource, TestDocBasedVersionConstraints, CoreMergeIndexesAdminHandlerTest, ShardSplitTest, TestFunctionQuery, XsltUpdateRequestHandlerTest, TestGraphTermsQParserPlugin, CdcrReplicationDistributedZkTest, FullHLLTest, TestXmlQParser, TestSlowCompositeReaderWrapper, ResponseLogComponentTest, TestLeaderInitiatedRecoveryThread, TestValueSourceCache, TestClassicSimilarityFactory, ActionThrottleTest, CursorPagingTest, TestSolrConfigHandler, TestOnReconnectListenerSupport, HdfsWriteToMultipleCollectionsTest, TestSSLRandomization, TestNumericTerms64, ClassificationUpdateProcessorFactoryTest, SimpleCollectionCreateDeleteTest, DistanceUnitsTest, BadCopyFieldTest, HdfsDirectoryTest, TestRawTransformer, TestCloudDeleteByQuery, TestStandardQParsers, AnalysisAfterCoreReloadTest, URLClassifyProcessorTest, TestOverriddenPrefixQueryForCustomFieldType, TestDownShardTolerantSearch, ConjunctionSolrSpellCheckerTest, TestFaceting, ZkStateReaderTest]
   [junit4] Completed [292/619 (2!)] on J0 in 2.52s, 6 tests, 3 errors <<< FAILURES!

[...truncated 1068 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:740: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:684: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:59: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build.xml:233: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/common-build.xml:530: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/lucene/common-build.xml:1427: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/lucene/common-build.xml:984: There were test failures: 619 suites (10 ignored), 2597 tests, 3 errors, 1 failure, 87 ignored (72 assumptions) [seed: CCA512216E94B775]

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