Build: http://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/16956/
Java: 32bit/jdk1.8.0_92 -server -XX:+UseG1GC

1 tests failed.
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([20A07D4792A44933:5F3ECAC2FBC664B9]:0)
        at 
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:192)
        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:129)
        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay(ZkStateReaderTest.java:51)
        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 10540 lines...]
   [junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.overseer.ZkStateReaderTest_20A07D4792A44933-001/init-core-data-001
   [junit4]   2> 0    INFO  
(SUITE-ZkStateReaderTest-seed#[20A07D4792A44933]-worker) [    ] o.e.j.u.log 
Logging initialized @1967ms
   [junit4]   2> 15   INFO  
(SUITE-ZkStateReaderTest-seed#[20A07D4792A44933]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 49   INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
   [junit4]   2> 60   INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 63   INFO  (Thread-1) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 63   INFO  (Thread-1) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 162  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.ZkTestServer start zk server on port:42008
   [junit4]   2> 190  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 252  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 314  INFO  (zkCallback-1-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@c08bd1 name:ZooKeeperConnection 
Watcher:127.0.0.1:42008 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 314  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 318  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 367  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 369  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 372  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 0x1553660df670000, 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> 380  INFO  (zkCallback-2-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1e51506 name:ZooKeeperConnection 
Watcher:127.0.0.1:42008 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 380  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 381  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 382  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 395  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 396  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 398  INFO  (zkCallback-3-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@11ed0fd name:ZooKeeperConnection 
Watcher:127.0.0.1:42008/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 398  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 399  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 433  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 438  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 441  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 445  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 451  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 463  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 470  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 475  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 499  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 501  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 506  INFO  (zkCallback-3-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 543  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 545  INFO  (zkCallback-3-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for 
collection [c1] has occurred - updating... (live nodes size: [0])
   [junit4]   2> 547  INFO  (zkCallback-3-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 604  INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42008 42008
   [junit4]   2> 5628 INFO  (Thread-1) [    ] o.a.s.c.ZkTestServer connecting 
to 127.0.0.1:42008 42008
   [junit4]   2> 5639 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[20A07D4792A44933]) 
[    ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
   [junit4]   2> 5681 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
   [junit4]   2> 5682 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 5682 INFO  (Thread-2) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 5682 INFO  (Thread-2) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 5782 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.ZkTestServer start zk server on port:41566
   [junit4]   2> 5782 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 5783 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 5795 INFO  (zkCallback-5-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@18836ed name:ZooKeeperConnection 
Watcher:127.0.0.1:41566 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 5795 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 5795 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 5799 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 5799 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 5803 INFO  (zkCallback-6-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@b2b6e4 name:ZooKeeperConnection 
Watcher:127.0.0.1:41566 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 5803 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 5804 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 5804 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 5808 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 5810 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 5812 INFO  (zkCallback-7-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1106920 name:ZooKeeperConnection 
Watcher:127.0.0.1:41566/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 5813 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 5813 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 5817 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 5819 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 5821 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 5823 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 5825 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 5827 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 5828 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 5829 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 5833 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 5836 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 5837 INFO  (zkCallback-7-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 5839 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 5857 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:41566 41566
   [junit4]   2> 10889 INFO  (Thread-2) [    ] o.a.s.c.ZkTestServer connecting 
to 127.0.0.1:41566 41566
   [junit4]   2> 10890 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[20A07D4792A44933])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
   [junit4]   2> 10892 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 10893 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 10893 INFO  (Thread-3) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 10893 INFO  (Thread-3) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 10993 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.ZkTestServer start zk server on port:36411
   [junit4]   2> 10993 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 10994 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 10998 INFO  (zkCallback-9-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@b57355 name:ZooKeeperConnection 
Watcher:127.0.0.1:36411 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 10998 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 10999 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 11005 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 11007 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 11009 INFO  (zkCallback-10-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@14ef02d name:ZooKeeperConnection 
Watcher:127.0.0.1:36411 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 11009 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 11010 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 11010 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 11013 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 11014 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 11017 INFO  (zkCallback-11-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@18a0b16 name:ZooKeeperConnection 
Watcher:127.0.0.1:36411/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 11018 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 11018 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 11019 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 11021 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 11022 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 11023 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 11025 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 11026 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 11027 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 11028 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 11031 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 11031 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 11038 INFO  (zkCallback-11-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 11048 INFO  (zkCallback-11-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> 11050 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 11051 INFO  (zkCallback-11-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for 
collection [c1] has occurred - updating... (live nodes size: [0])
   [junit4]   2> 11052 INFO  (zkCallback-11-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> 11052 INFO  (zkCallback-11-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 11056 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36411 36411
   [junit4]   2> 21093 INFO  (Thread-3) [    ] o.a.s.c.ZkTestServer connecting 
to 127.0.0.1:36411 36411
   [junit4]   2> 21098 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[20A07D4792A44933])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 21103 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 21104 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 21104 INFO  (Thread-4) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 21104 INFO  (Thread-4) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 21204 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.ZkTestServer start zk server on port:34421
   [junit4]   2> 21205 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 21206 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 21213 INFO  (zkCallback-13-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@f0772 name:ZooKeeperConnection 
Watcher:127.0.0.1:34421 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 21213 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 21214 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 21223 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 21223 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 21226 INFO  (zkCallback-14-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@740acc name:ZooKeeperConnection 
Watcher:127.0.0.1:34421 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 21226 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 21227 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 21227 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 21232 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 21232 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 21239 INFO  (zkCallback-15-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@91eefc name:ZooKeeperConnection 
Watcher:127.0.0.1:34421/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 21239 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 21240 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 21242 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 21244 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 21246 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 21248 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 21250 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 21251 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 21252 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 21254 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 21258 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 21261 INFO  (zkCallback-15-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> 21262 INFO  (zkCallback-15-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 21263 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 21269 INFO  (zkCallback-15-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> 21271 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34421 34421
   [junit4]   2> 21294 INFO  (Thread-4) [    ] o.a.s.c.ZkTestServer connecting 
to 127.0.0.1:34421 34421
   [junit4]   2> 21295 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 21298 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
   [junit4]   2> 21299 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 21301 INFO  (Thread-5) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 21301 INFO  (Thread-5) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 21401 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.ZkTestServer start zk server on port:41358
   [junit4]   2> 21401 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 21401 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 21407 INFO  (zkCallback-17-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@de3d99 name:ZooKeeperConnection 
Watcher:127.0.0.1:41358 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 21407 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 21408 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 21411 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 21412 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 21413 INFO  (zkCallback-18-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@14c6704 name:ZooKeeperConnection 
Watcher:127.0.0.1:41358 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 21413 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 21417 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 21417 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 21420 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 21429 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 21433 INFO  (zkCallback-19-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1474a10 name:ZooKeeperConnection 
Watcher:127.0.0.1:41358/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 21433 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 21435 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 21438 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 21440 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 21442 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 21443 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 21446 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 21447 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 21448 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 21449 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 21451 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 21451 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 21453 INFO  (zkCallback-19-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 21455 INFO  (zkCallback-19-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> 21459 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 21461 INFO  (zkCallback-19-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> 21463 INFO  (zkCallback-19-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for 
collection [c1] has occurred - updating... (live nodes size: [0])
   [junit4]   2> 21464 INFO  (zkCallback-19-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 21465 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:41358 41358
   [junit4]   2> 21522 INFO  (Thread-5) [    ] o.a.s.c.ZkTestServer connecting 
to 127.0.0.1:41358 41358
   [junit4]   2> 21523 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[20A07D4792A44933])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=ZkStateReaderTest 
-Dtests.method=testStateFormatUpdateWithTimeDelay -Dtests.seed=20A07D4792A44933 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=lv 
-Dtests.timezone=Asia/Jakarta -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.23s J1 | 
ZkStateReaderTest.testStateFormatUpdateWithTimeDelay <<<
   [junit4]    > Throwable #1: org.apache.solr.common.SolrException: Could not 
find collection : c1
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([20A07D4792A44933:5F3ECAC2FBC664B9]:0)
   [junit4]    >        at 
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:192)
   [junit4]    >        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:129)
   [junit4]    >        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay(ZkStateReaderTest.java:51)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 21530 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> 21530 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 21531 INFO  (Thread-6) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 21531 INFO  (Thread-6) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 21631 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.ZkTestServer start zk server on port:46529
   [junit4]   2> 21631 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 21632 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 21638 INFO  (zkCallback-21-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@2f11c1 name:ZooKeeperConnection 
Watcher:127.0.0.1:46529 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 21638 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 21638 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 21640 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 21641 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 21645 INFO  (zkCallback-22-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1fe471f name:ZooKeeperConnection 
Watcher:127.0.0.1:46529 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 21646 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 21646 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 21646 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 21649 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 21649 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 21651 INFO  (zkCallback-23-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@96b9ee name:ZooKeeperConnection 
Watcher:127.0.0.1:46529/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 21651 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 21651 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 21652 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 21654 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 21656 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 21658 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 21659 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 21677 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 21679 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 21680 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 21681 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 21696 INFO  (zkCallback-23-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 21698 INFO  (zkCallback-23-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> 21699 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 21700 INFO  (zkCallback-23-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> 21702 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 0x155366132f20002, 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> 21703 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:46529 46529
   [junit4]   2> 21794 INFO  (Thread-6) [    ] o.a.s.c.ZkTestServer connecting 
to 127.0.0.1:46529 46529
   [junit4]   2> 21795 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[20A07D4792A44933])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending 
testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> 21801 INFO  
(SUITE-ZkStateReaderTest-seed#[20A07D4792A44933]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.overseer.ZkStateReaderTest_20A07D4792A44933-001
   [junit4]   2> Jun 09, 2016 6:16:27 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 3 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene62): {}, 
docValues:{}, maxPointsInLeafNode=1270, maxMBSortInHeap=6.077699634503058, 
sim=ClassicSimilarity, locale=lv, timezone=Asia/Jakarta
   [junit4]   2> NOTE: Linux 4.4.0-21-generic i386/Oracle Corporation 1.8.0_92 
(32-bit)/cpus=12,threads=1,free=29208184,total=67108864
   [junit4]   2> NOTE: All tests run in this JVM: [ZkStateReaderTest]
   [junit4] Completed [12/612 (1!)] on J1 in 23.39s, 6 tests, 1 error <<< 
FAILURES!

[...truncated 1943 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:740: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:684: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:59: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build.xml:233: The 
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/common-build.xml:531: The 
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1427: 
The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:984: 
There were test failures: 612 suites (10 ignored), 2562 tests, 1 error, 116 
ignored (72 assumptions) [seed: 20A07D4792A44933]

Total time: 64 minutes 34 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any


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

Reply via email to