Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.0/20/

4 tests failed.
FAILED:  org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test

Error Message:
Captured an uncaught exception in thread: Thread[id=116272, name=collection0, 
state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=116272, name=collection0, state=RUNNABLE, 
group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:46875: collection already exists: 
awholynewstresscollection_collection0_3
        at __randomizedtesting.SeedInfo.seed([33FD9B2EC1BC674F]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:577)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1100)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806)
        at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1595)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1616)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:990)


FAILED:  org.apache.solr.core.TestDynamicLoading.testDynamicLoading

Error Message:
Could not find collection:.system

Stack Trace:
java.lang.AssertionError: Could not find collection:.system
        at 
__randomizedtesting.SeedInfo.seed([33FD9B2EC1BC674F:EBB0B6793661C2EF]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNotNull(Assert.java:526)
        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:151)
        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:135)
        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:130)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:852)
        at 
org.apache.solr.core.TestDynamicLoading.testDynamicLoading(TestDynamicLoading.java:116)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
        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:  
junit.framework.TestSuite.org.apache.solr.handler.TestReplicationHandler

Error Message:
ObjectTracker found 4 object(s) that were not released!!! [NRTCachingDirectory, 
NRTCachingDirectory, NRTCachingDirectory, NRTCachingDirectory]

Stack Trace:
java.lang.AssertionError: ObjectTracker found 4 object(s) that were not 
released!!! [NRTCachingDirectory, NRTCachingDirectory, NRTCachingDirectory, 
NRTCachingDirectory]
        at __randomizedtesting.SeedInfo.seed([33FD9B2EC1BC674F]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNull(Assert.java:551)
        at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:248)
        at sun.reflect.GeneratedMethodAccessor21.invoke(Unknown Source)
        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$7.evaluate(RandomizedRunner.java:834)
        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.testStateFormatUpdateWithTimeDelay

Error Message:
Could not find collection : c1

Stack Trace:
org.apache.solr.common.SolrException: Could not find collection : c1
        at 
__randomizedtesting.SeedInfo.seed([33FD9B2EC1BC674F:4C632CABA8DE4AC5]:0)
        at 
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:129)
        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay(ZkStateReaderTest.java:52)
        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 11359 lines...]
   [junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J2/temp/solr.cloud.overseer.ZkStateReaderTest_33FD9B2EC1BC674F-001/init-core-data-001
   [junit4]   2> 1213177 INFO  
(SUITE-ZkStateReaderTest-seed#[33FD9B2EC1BC674F]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true)
   [junit4]   2> 1213180 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> 1213180 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1213180 INFO  (Thread-3370) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1213180 INFO  (Thread-3370) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1213280 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.ZkTestServer start zk server on port:51583
   [junit4]   2> 1213280 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1213281 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1213282 INFO  (zkCallback-763-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@5b5f5d1a 
name:ZooKeeperConnection Watcher:127.0.0.1:51583 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1213282 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1213282 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1213283 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1213283 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1213284 INFO  (zkCallback-764-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@64b5e1b3 
name:ZooKeeperConnection Watcher:127.0.0.1:51583 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1213284 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1213284 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1213284 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1213287 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1213287 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1213287 INFO  (zkCallback-765-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@70d39551 
name:ZooKeeperConnection Watcher:127.0.0.1:51583/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1213287 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1213287 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1213288 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1213288 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 1213289 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1213289 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1213290 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1213290 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1213291 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1213291 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 1213292 INFO  (zkCallback-765-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 1213292 INFO  (zkCallback-765-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> 1213293 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1213293 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 1213294 INFO  (zkCallback-765-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> 1213294 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1213295 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:51583 51583
   [junit4]   2> 1213407 INFO  (Thread-3370) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:51583 51583
   [junit4]   2> 1213407 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending 
testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> 1213410 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 1213410 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1213410 INFO  (Thread-3371) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1213410 INFO  (Thread-3371) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1213510 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.ZkTestServer start zk server on port:49915
   [junit4]   2> 1213510 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1213511 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1213512 INFO  (zkCallback-766-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@4ed106da 
name:ZooKeeperConnection Watcher:127.0.0.1:49915 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1213512 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1213512 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1213513 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1213513 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x154ee8f90920000, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 1213513 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1213519 INFO  (zkCallback-767-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@262d597c 
name:ZooKeeperConnection Watcher:127.0.0.1:49915 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1213519 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1213519 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1213519 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1213521 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1213521 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x154ee8f90920001, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 1213521 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1213521 INFO  (zkCallback-768-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@2a8ce667 
name:ZooKeeperConnection Watcher:127.0.0.1:49915/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1213522 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1213522 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1213522 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1213523 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 1213523 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1213524 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1213524 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1213525 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1213525 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1213526 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 1213526 INFO  (zkCallback-768-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 1213527 INFO  (zkCallback-768-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> 1213578 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 1213578 INFO  (zkCallback-768-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> 1213630 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:49915 49915
   [junit4]   2> 1213781 INFO  (Thread-3371) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:49915 49915
   [junit4]   2> 1213781 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 1213783 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
   [junit4]   2> 1213784 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1213784 INFO  (Thread-3372) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1213784 INFO  (Thread-3372) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1213884 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.ZkTestServer start zk server on port:40397
   [junit4]   2> 1213884 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1213884 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1213885 INFO  (zkCallback-769-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@499f038f 
name:ZooKeeperConnection Watcher:127.0.0.1:40397 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1213885 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1213885 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1213886 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1213886 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1213887 INFO  (zkCallback-770-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@e683026 name:ZooKeeperConnection 
Watcher:127.0.0.1:40397 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 1213887 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1213887 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1213887 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1213888 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1213889 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1213889 INFO  (zkCallback-771-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@f7c69d3 name:ZooKeeperConnection 
Watcher:127.0.0.1:40397/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 1213889 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1213889 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1213889 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1213890 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 1213891 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1213891 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1213892 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1213892 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1213893 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1213893 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 1213894 INFO  (zkCallback-771-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 1213894 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 1213895 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1213895 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 1213895 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 1213895 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ZkStateReader Removing watch for uninteresting collection [c1]
   [junit4]   2> 1213896 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:40397 40397
   [junit4]   2> 1214033 INFO  (Thread-3372) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:40397 40397
   [junit4]   2> 1214033 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
   [junit4]   2> 1214036 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 1214036 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1214036 INFO  (Thread-3373) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1214036 INFO  (Thread-3373) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1214136 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.ZkTestServer start zk server on port:49702
   [junit4]   2> 1214136 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1214136 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1214138 INFO  (zkCallback-772-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@20920d46 
name:ZooKeeperConnection Watcher:127.0.0.1:49702 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1214138 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1214138 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1214138 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1214139 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1214142 INFO  (zkCallback-773-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7e9282ac 
name:ZooKeeperConnection Watcher:127.0.0.1:49702 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1214142 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1214142 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1214142 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1214143 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1214144 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1214144 INFO  (zkCallback-774-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@193881c0 
name:ZooKeeperConnection Watcher:127.0.0.1:49702/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1214144 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1214144 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1214145 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1214145 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 1214146 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1214146 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1214147 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1214147 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1214148 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1214148 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 1214148 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 1214148 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 1214149 INFO  (zkCallback-774-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 1214150 INFO  (zkCallback-774-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> 1214150 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1214151 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 1214151 INFO  (zkCallback-774-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> 1214151 INFO  (zkCallback-774-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> 1214151 INFO  (zkCallback-774-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 1214152 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1214153 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:49702 49702
   [junit4]   2> 1214278 INFO  (Thread-3373) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:49702 49702
   [junit4]   2> 1214279 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 1214281 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
   [junit4]   2> 1214281 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1214282 INFO  (Thread-3374) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1214282 INFO  (Thread-3374) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1214382 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.ZkTestServer start zk server on port:36729
   [junit4]   2> 1214382 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1214382 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1214383 INFO  (zkCallback-775-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@49f8a68e 
name:ZooKeeperConnection Watcher:127.0.0.1:36729 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1214383 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1214383 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1214384 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1214384 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1214388 INFO  (zkCallback-776-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@39a2f0f9 
name:ZooKeeperConnection Watcher:127.0.0.1:36729 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1214388 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1214388 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1214389 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1214390 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1214392 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1214392 INFO  (zkCallback-777-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@192eec41 
name:ZooKeeperConnection Watcher:127.0.0.1:36729/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1214392 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1214393 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1214393 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1214393 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 1214394 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1214395 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1214395 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1214395 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1214396 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1214396 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 1214397 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 1214397 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 1214397 INFO  (zkCallback-777-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 1214404 INFO  (zkCallback-777-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> 1214455 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 1214455 INFO  (zkCallback-777-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> 1214455 INFO  (zkCallback-777-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> 1214455 INFO  (zkCallback-777-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 1214456 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36729 36729
   [junit4]   2> 1214615 INFO  (Thread-3374) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:36729 36729
   [junit4]   2> 1214618 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[33FD9B2EC1BC674F])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
   [junit4]   2> NOTE: download the large Jenkins line-docs file by running 
'ant get-jenkins-line-docs' in the lucene directory.
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=ZkStateReaderTest 
-Dtests.method=testStateFormatUpdateWithTimeDelay -Dtests.seed=33FD9B2EC1BC674F 
-Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true 
-Dtests.linedocsfile=/x1/jenkins/lucene-data/enwiki.random.lines.txt 
-Dtests.locale=de-GR -Dtests.timezone=America/Coral_Harbour 
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.35s J2 | 
ZkStateReaderTest.testStateFormatUpdateWithTimeDelay <<<
   [junit4]    > Throwable #1: org.apache.solr.common.SolrException: Could not 
find collection : c1
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([33FD9B2EC1BC674F:4C632CABA8DE4AC5]:0)
   [junit4]    >        at 
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
   [junit4]    >        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:129)
   [junit4]    >        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay(ZkStateReaderTest.java:52)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 1214632 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
   [junit4]   2> 1214633 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1214633 INFO  (Thread-3375) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1214633 INFO  (Thread-3375) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1214733 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.ZkTestServer start zk server on port:39324
   [junit4]   2> 1214733 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1214733 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1214735 INFO  (zkCallback-778-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@18b83e6 name:ZooKeeperConnection 
Watcher:127.0.0.1:39324 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 1214735 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1214735 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1214744 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1214744 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1214746 INFO  (zkCallback-779-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@3d37f753 
name:ZooKeeperConnection Watcher:127.0.0.1:39324 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1214746 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1214746 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1214746 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1214753 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1214756 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1214768 INFO  (zkCallback-780-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@71d057cf 
name:ZooKeeperConnection Watcher:127.0.0.1:39324/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1214768 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1214769 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1214769 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1214769 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 1214769 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1214770 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1214770 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1214770 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1214771 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1214771 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 1214771 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 1214771 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 1214772 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1214772 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 1214772 INFO  (zkCallback-780-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> 1214776 INFO  (zkCallback-780-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 1214777 INFO  (zkCallback-780-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 1214828 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39324 39324
   [junit4]   2> 1214952 INFO  (Thread-3375) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:39324 39324
   [junit4]   2> 1214953 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[33FD9B2EC1BC674F]) 
[    ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
   [junit4]   2> 1214954 INFO  
(SUITE-ZkStateReaderTest-seed#[33FD9B2EC1BC674F]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J2/temp/solr.cloud.overseer.ZkStateReaderTest_33FD9B2EC1BC674F-001
   [junit4]   2> May 26, 2016 7:34:28 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene60): {}, 
docValues:{}, maxPointsInLeafNode=1888, maxMBSortInHeap=6.746620272315982, 
sim=RandomSimilarity(queryNorm=true,coord=crazy): {}, locale=de-GR, 
timezone=America/Coral_Harbour
   [junit4]   2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 
1.8.0_74 (64-bit)/cpus=4,threads=1,free=136861040,total=524812288
   [junit4]   2> NOTE: All tests run in this JVM: [ShardSplitTest, 
HighlighterConfigTest, UpdateParamsTest, SimpleMLTQParserTest, 
FieldAnalysisRequestHandlerTest, BinaryUpdateRequestHandlerTest, 
TestPerFieldSimilarity, NoCacheHeaderTest, TestWriterPerf, DeleteShardTest, 
TestGroupingSearch, TestAuthenticationFramework, ConnectionManagerTest, 
TestSolrQueryParserResource, TestReplicationHandlerBackup, JavabinLoaderTest, 
DirectSolrConnectionTest, BasicDistributedZk2Test, TestZkChroot, 
LeaderFailoverAfterPartitionTest, TestSchemaNameResource, 
DistributedDebugComponentTest, DistribDocExpirationUpdateProcessorTest, 
TestPKIAuthenticationPlugin, FieldMutatingUpdateProcessorTest, 
TestExactSharedStatsCache, SearchHandlerTest, TestExpandComponent, 
TestNonDefinedSimilarityFactory, CheckHdfsIndexTest, TestHashQParserPlugin, 
TestSweetSpotSimilarityFactory, HdfsThreadLeakTest, TestSchemaVersionResource, 
PluginInfoTest, TestSolrQueryParser, ZkStateReaderTest]
   [junit4] Completed [128/584 (1!)] on J2 in 2.55s, 6 tests, 1 error <<< 
FAILURES!

[...truncated 491 lines...]
   [junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_33FD9B2EC1BC674F-001/init-core-data-001
   [junit4]   2> 1841127 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[33FD9B2EC1BC674F]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 1841128 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[33FD9B2EC1BC674F]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 1841130 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1841130 INFO  (Thread-7166) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1841130 INFO  (Thread-7166) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1841230 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:38204
   [junit4]   2> 1841231 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1841231 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1841233 INFO  (zkCallback-29514-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@537be770 
name:ZooKeeperConnection Watcher:127.0.0.1:38204 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1841233 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1841233 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1841234 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1841235 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1841236 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1841237 INFO  (zkCallback-29515-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@2c6a026a 
name:ZooKeeperConnection Watcher:127.0.0.1:38204/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1841237 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1841238 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1841238 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
   [junit4]   2> 1841239 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
   [junit4]   2> 1841240 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
   [junit4]   2> 1841240 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
   [junit4]   2> 1841241 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 1841242 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 1841245 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 1841246 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
   [junit4]   2> 1841247 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1841247 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1841250 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 1841251 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
   [junit4]   2> 1841252 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 1841252 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
   [junit4]   2> 1841253 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 1841253 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
   [junit4]   2> 1841255 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 1841255 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
   [junit4]   2> 1841256 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 1841257 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
   [junit4]   2> 1841258 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1841259 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1841260 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 1841260 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
   [junit4]   2> 1841269 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 1841270 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
   [junit4]   2> 1841381 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_33FD9B2EC1BC674F-001/control-001/cores/collection1
   [junit4]   2> 1841382 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 1841389 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@30055396{/,null,AVAILABLE}
   [junit4]   2> 1841390 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@21d92afd{HTTP/1.1,[http/1.1]}{127.0.0.1:54049}
   [junit4]   2> 1841390 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.e.j.s.Server Started @1844217ms
   [junit4]   2> 1841390 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_33FD9B2EC1BC674F-001/tempDir-001/control/data,
 hostContext=/, hostPort=54049, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_33FD9B2EC1BC674F-001/control-001/cores}
   [junit4]   2> 1841390 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@73d16e93
   [junit4]   2> 1841390 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_33FD9B2EC1BC674F-001/control-001'
   [junit4]   2> 1841390 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1841390 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 1841398 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1841403 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1841411 INFO  (zkCallback-29516-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1b7356d6 
name:ZooKeeperConnection Watcher:127.0.0.1:38204/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1841411 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1841411 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1841412 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1841412 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_33FD9B2EC1BC674F-001/control-001/solr.xml
   [junit4]   2> 1841415 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_33FD9B2EC1BC674F-001/control-001/cores
   [junit4]   2> 1841415 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 611413564
   [junit4]   2> 1841415 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_33FD9B2EC1BC674F-001/control-001]
   [junit4]   2> 1841415 WARN  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_33FD9B2EC1BC674F-001/control-001/lib
 to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_33FD9B2EC1BC674F-001/control-001/lib
   [junit4]   2> 1841415 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme 
: ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 
10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 
5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 1841416 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1841416 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1841417 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1841417 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:38204/solr
   [junit4]   2> 1841417 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 1841417 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1841428 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1841430 INFO  (zkCallback-29519-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@299bc25d 
name:ZooKeeperConnection Watcher:127.0.0.1:38204 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1841430 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1841430 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1841431 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.ZkController Added new OnReconnect listener 
org.apache.solr.cloud.ZkController$$Lambda$46/1348614197@43878201
   [junit4]   2> 1841431 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 1841432 INFO  
(zkCallback-29520-thread-1-processing-n:127.0.0.1:54049_) [n:127.0.0.1:54049_   
 ] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@26b10ea0 
name:ZooKeeperConnection Watcher:127.0.0.1:38204/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1841432 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.c.ConnectionManager Client is connected to 
ZooKeeper
   [junit4]   2> 1841432 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 1841433 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-queue-work
   [junit4]   2> 1841434 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-running
   [junit4]   2> 1841435 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-completed
   [junit4]   2> 1841444 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-failure
   [junit4]   2> 1841446 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1841447 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1841447 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1841448 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1841448 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.c.ZkStateReader Updating cluster state from 
ZooKeeper... 
   [junit4]   2> 1841449 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (0)
   [junit4]   2> 1841449 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 1841450 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer_elect/election
   [junit4]   2> 1841451 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1841451 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.LeaderElector Joined leadership election with 
path: /overseer_elect/election/95963833530515460-127.0.0.1:54049_-n_0000000000
   [junit4]   2> 1841451 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.OverseerElectionContext I am going to be the 
leader 127.0.0.1:54049_
   [junit4]   2> 1841451 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 1841451 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.Overseer Overseer 
(id=95963833530515460-127.0.0.1:54049_-n_0000000000) starting
   [junit4]   2> 1841452 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 1841455 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=10000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 1841455 INFO  
(OverseerStateUpdate-95963833530515460-127.0.0.1:54049_-n_0000000000) 
[n:127.0.0.1:54049_    ] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 1841461 INFO  
(OverseerCollectionConfigSetProcessor-95963833530515460-127.0.0.1:54049_-n_0000000000)
 [n:127.0.0.1:54049_    ] o.a.s.c.OverseerTaskProcessor Process current queue 
of overseer operations
   [junit4]   2> 1841472 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:54049_
   [junit4]   2> 1841472 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.c.SolrZkClient makePath: 
/live_nodes/127.0.0.1:54049_
   [junit4]   2> 1841473 INFO  
(OverseerStateUpdate-95963833530515460-127.0.0.1:54049_-n_0000000000) 
[n:127.0.0.1:54049_    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (0)
   [junit4]   2> 1841480 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.CoreContainer Security conf doesn't exist. 
Skipping setup for authorization module.
   [junit4]   2> 1841480 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 1841481 INFO  
(zkCallback-29520-thread-1-processing-n:127.0.0.1:54049_) [n:127.0.0.1:54049_   
 ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent 
state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - 
updating... (live nodes size: [0])
   [junit4]   2> 1841481 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.CorePropertiesLocator Looking for core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_33FD9B2EC1BC674F-001/control-001/cores
   [junit4]   2> 1841482 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: 
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, 
loadOnStartup=true, configSetProperties=configsetprops.json, 
collection=control_collection, coreNodeName=, dataDir=data/, shard=}
   [junit4]   2> 1841482 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.CorePropertiesLocator Found core collection1 
in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_33FD9B2EC1BC674F-001/control-001/cores/collection1
   [junit4]   2> 1841482 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 1841482 INFO  
(zkCallback-29520-thread-1-processing-n:127.0.0.1:54049_) [n:127.0.0.1:54049_   
 ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1841483 INFO  
(coreLoadExecutor-9006-thread-1-processing-n:127.0.0.1:54049_) 
[n:127.0.0.1:54049_ c:control_collection   x:collection1] o.a.s.c.ZkController 
publishing state=down
   [junit4]   2> 1841483 INFO  
(coreLoadExecutor-9006-thread-1-processing-n:127.0.0.1:54049_) 
[n:127.0.0.1:54049_ c:control_collection   x:collection1] o.a.s.c.ZkController 
numShards not found on descriptor - reading it from system property
   [junit4]   2> 1841483 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.s.SolrDispatchFilter 
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J0
   [junit4]   2> 1841483 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[33FD9B2EC1BC674F]) 
[n:127.0.0.1:54049_    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() 
done
   [junit4]   2> 1841486 INFO  
(coreLoadExecutor-9006-thread-1-processing-n:127.0.0.1:54049_) 
[n:127.0.0.1:54049_ c:control_collection   x:collection1] o.a.s.c.ZkController 
Collection control_collection not visible yet, but flagging it so a watch is 
registered when it becomes visible
   [junit4]   2> 1841486 INFO  
(coreLoadExecutor-9006-thread-1-processing-n:127.0.0.1:54049_) 
[n:127.0.0.1:54049_ c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader addZkWatch [control_collection]
   [junit4]   2> 1841486 INFO  
(OverseerStateUpdate-95963833530515460-127.0.0.1:54049_-n_0000000000) 
[n:127.0.0.1:54049_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:54049";,
   [junit4]   2>   "node_name":"127.0.0.1:54049_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4] 

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

a watches above limit:
   [junit4]   2> 
   [junit4]   2>        6       /solr/clusterstate.json
   [junit4]   2>        2       /solr/collections/.system/state.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        6       /solr/live_nodes
   [junit4]   2>        6       /solr/collections
   [junit4]   2>        3       /solr/overseer/queue
   [junit4]   2>        2       /solr/overseer/collection-queue-work
   [junit4]   2> 
   [junit4]   2> NOTE: download the large Jenkins line-docs file by running 
'ant get-jenkins-line-docs' in the lucene directory.
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestDynamicLoading 
-Dtests.method=testDynamicLoading -Dtests.seed=33FD9B2EC1BC674F 
-Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true 
-Dtests.linedocsfile=/x1/jenkins/lucene-data/enwiki.random.lines.txt 
-Dtests.locale=mk-MK -Dtests.timezone=Pacific/Pohnpei -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] FAILURE 48.6s J1 | TestDynamicLoading.testDynamicLoading <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: Could not find 
collection:.system
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([33FD9B2EC1BC674F:EBB0B6793661C2EF]:0)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:151)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:135)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:130)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:852)
   [junit4]    >        at 
org.apache.solr.core.TestDynamicLoading.testDynamicLoading(TestDynamicLoading.java:116)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 4404930 INFO  
(SUITE-TestDynamicLoading-seed#[33FD9B2EC1BC674F]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.core.TestDynamicLoading_33FD9B2EC1BC674F-001
   [junit4]   2> May 26, 2016 8:27:37 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene60), 
sim=ClassicSimilarity, locale=mk-MK, timezone=Pacific/Pohnpei
   [junit4]   2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 
1.8.0_74 (64-bit)/cpus=4,threads=1,free=172793320,total=532152320
   [junit4]   2> NOTE: All tests run in this JVM: [TestMaxScoreQueryParser, 
OpenCloseCoreStressTest, AddSchemaFieldsUpdateProcessorFactoryTest, 
SolrIndexSplitterTest, TestCloudManagedSchema, ConvertedLegacyTest, 
TestManagedStopFilterFactory, TestDistributedStatsComponentCardinality, 
HdfsChaosMonkeySafeLeaderTest, BasicFunctionalityTest, TestManagedResource, 
TestBM25SimilarityFactory, HdfsLockFactoryTest, 
TestExclusionRuleCollectionAccess, SolrCmdDistributorTest, 
DistributedQueueTest, ConfigSetsAPITest, SpellingQueryConverterTest, 
OverseerRolesTest, TestPerFieldSimilarityWithDefaultOverride, 
DistributedIntervalFacetingTest, DocExpirationUpdateProcessorFactoryTest, 
TestSha256AuthenticationProvider, TestUpdate, DeleteReplicaTest, 
AsyncMigrateRouteKeyTest, TestSmileRequest, ShardRoutingTest, 
CachingDirectoryFactoryTest, SpellPossibilityIteratorTest, 
TestCollationFieldDocValues, NotRequiredUniqueKeyTest, TestSolrXml, 
SharedFSAutoReplicaFailoverUtilsTest, SoftAutoCommitTest, 
DirectSolrSpellCheckerTest, HdfsDirectoryFactoryTest, TestBulkSchemaAPI, 
TestDistribIDF, SchemaVersionSpecificBehaviorTest, ZkCLITest, 
TestExceedMaxTermLength, RestartWhileUpdatingTest, AliasIntegrationTest, 
TermsComponentTest, MBeansHandlerTest, SolrXmlInZkTest, SolrInfoMBeanTest, 
SolrIndexConfigTest, ChaosMonkeyNothingIsSafeTest, ChangedSchemaMergeTest, 
TestReloadDeadlock, TestRestoreCore, TestFreeTextSuggestions, 
TermVectorComponentTest, TestChildDocTransformer, 
TestSolrConfigHandlerConcurrent, CdcrReplicationHandlerTest, TestQueryUtils, 
TestSolrQueryParserDefaultOperatorResource, HdfsSyncSliceTest, 
TestConfigSetsAPI, SuggesterFSTTest, DocumentBuilderTest, 
TestSolrCoreProperties, DistributedFacetPivotLargeTest, TestJsonFacets, 
TestDFISimilarityFactory, CustomCollectionTest, TimeZoneUtilsTest, 
TestInitParams, TestPartialUpdateDeduplication, EnumFieldTest, 
DistanceFunctionTest, TestRebalanceLeaders, PreAnalyzedUpdateProcessorTest, 
ZkControllerTest, SolrPluginUtilsTest, TestShardHandlerFactory, 
TestCoreContainer, BlockDirectoryTest, DistanceUnitsTest, 
CSVRequestHandlerTest, TestWordDelimiterFilterFactory, 
BlockJoinFacetRandomTest, TestCloudInspectUtil, TestRequestStatusCollectionAPI, 
TestMiniSolrCloudCluster, TestOverriddenPrefixQueryForCustomFieldType, 
TestFiltering, CdcrUpdateLogTest, AnalyticsMergeStrategyTest, 
TestRandomFaceting, ShardRoutingCustomTest, AutoCommitTest, 
TestDistributedGrouping, TestFaceting, TestRecovery, TestHashPartitioner, 
TestRealTimeGet, TestJoin, TestReload, TestStressVersions, 
DistributedTermsComponentTest, SimpleFacetsTest, SpellCheckComponentTest, 
QueryElevationComponentTest, BadIndexSchemaTest, TestFunctionQuery, 
TestLazyCores, DirectUpdateHandlerTest, TestBadConfig, TestIndexSearcher, 
HighlighterTest, ShowFileRequestHandlerTest, CurrencyFieldXmlFileTest, 
SimplePostToolTest, TestCoreDiscovery, SignatureUpdateProcessorFactoryTest, 
TestExtendedDismaxParser, SpellCheckCollatorTest, CoreAdminHandlerTest, 
TestFoldingMultitermQuery, DocValuesTest, SuggesterTSTTest, TestStressLucene, 
TestTrie, SpatialFilterTest, TestCSVLoader, WordBreakSolrSpellCheckerTest, 
TestPseudoReturnFields, DirectUpdateHandlerOptimizeTest, 
DefaultValueUpdateProcessorTest, SortByFunctionTest, TestRemoteStreaming, 
DocValuesMultiTest, DebugComponentTest, IndexBasedSpellCheckerTest, 
TestSurroundQueryParser, TestReversedWildcardFilterFactory, TestQueryTypes, 
TestOmitPositions, RequestHandlersTest, TestIndexingPerformance, 
MoreLikeThisHandlerTest, RequiredFieldsTest, TestArbitraryIndexDir, 
FastVectorHighlighterTest, IndexSchemaRuntimeFieldTest, LoggingHandlerTest, 
TestCollationField, UpdateRequestProcessorFactoryTest, TestCSVResponseWriter, 
UniqFieldsUpdateProcessorFactoryTest, JsonLoaderTest, PingRequestHandlerTest, 
TestBinaryResponseWriter, TestLFUCache, TestQuerySenderListener, 
AlternateDirectoryTest, TestSolrIndexConfig, TestQuerySenderNoQuery, 
CopyFieldTest, ResponseLogComponentTest, BadComponentTest, 
TestSolrDeletionPolicy2, MultiTermTest, TestBinaryField, TestSearchPerf, 
NumericFieldsTest, MinimalSchemaTest, TestElisionMultitermQuery, 
ExternalFileFieldSortTest, TestPostingsSolrHighlighter, TestLuceneMatchVersion, 
TestCharFilters, TestCodecSupport, EchoParamsTest, TestDFRSimilarityFactory, 
TestLMJelinekMercerSimilarityFactory, TestFastOutputStream, 
OpenExchangeRatesOrgProviderTest, URLClassifyProcessorTest, TestFastLRUCache, 
DateMathParserTest, TestSystemIdResolver, PrimUtilsTest, DateFieldTest, 
DOMUtilTest, ClusterStateTest, TestSolrJ, TestLRUCache, TestDocumentBuilder, 
ZkNodePropsTest, SliceStateTest, SystemInfoHandlerTest, FileUtilsTest, 
CircularListTest, DistributedMLTComponentTest, TestRTGBase, SolrTestCaseJ4Test, 
TestCrossCoreJoin, TestCursorMarkWithoutUniqueKey, TestDistributedMissingSort, 
TestHighlightDedupGrouping, TestSimpleTrackingShardHandler, 
TestJettySolrRunner, BaseCdcrDistributedZkTest, CdcrVersionReplicationTest, 
CleanupOldIndexTest, CloudExitableDirectoryReaderTest, CollectionReloadTest, 
CollectionsAPIAsyncDistributedZkTest, CollectionsAPISolrJTest, 
DistribCursorPagingTest, HttpPartitionTest, MigrateRouteKeyTest, 
OutOfBoxZkACLAndCredentialsProvidersTest, 
OverriddenZkACLAndCredentialsProvidersTest, OverseerStatusTest, 
OverseerTaskQueueTest, RecoveryAfterSoftCommitTest, RollingRestartTest, 
TestClusterStateMutator, ZkStateWriterTest, RuleEngineTest, 
DirectoryFactoryTest, ExitableDirectoryReaderTest, QueryResultKeyTest, 
TestConfigOverlay, TestConfigSetImmutable, TestConfigSetProperties, 
TestDynamicLoading]
   [junit4] Completed [488/584 (4!)] on J1 in 49.66s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 308 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/build.xml:747: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/build.xml:684: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/build.xml:59: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build.xml:233:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/common-build.xml:527:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/lucene/common-build.xml:1457:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/lucene/common-build.xml:1014:
 There were test failures: 584 suites (10 ignored), 2340 tests, 1 suite-level 
error, 2 errors, 1 failure, 31 ignored (16 assumptions) [seed: 33FD9B2EC1BC674F]

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



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

Reply via email to