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

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([4DE70A0D02536C9B:3279BD886B314111]:0)
        at 
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:192)
        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:130)
        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 11476 lines...]
   [junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.overseer.ZkStateReaderTest_4DE70A0D02536C9B-001/init-core-data-001
   [junit4]   2> 1185354 INFO  
(SUITE-ZkStateReaderTest-seed#[4DE70A0D02536C9B]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 1185356 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> 1185357 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1185357 INFO  (Thread-2903) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1185357 INFO  (Thread-2903) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1185457 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.ZkTestServer start zk server on port:51341
   [junit4]   2> 1185457 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1185457 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1185459 INFO  (zkCallback-1290-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1d1ec159 
name:ZooKeeperConnection Watcher:127.0.0.1:51341 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1185459 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1185459 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1185460 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1185464 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1185464 INFO  (zkCallback-1291-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7ac76f56 
name:ZooKeeperConnection Watcher:127.0.0.1:51341 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1185464 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1185465 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1185465 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1185468 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1185472 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1185476 INFO  (zkCallback-1292-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@4c0c7f01 
name:ZooKeeperConnection Watcher:127.0.0.1:51341/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1185476 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1185477 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1185477 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1185478 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 1185478 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1185479 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1185479 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1185480 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1185480 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 1185480 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1185481 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 1185481 INFO  (zkCallback-1292-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 1185482 INFO  (zkCallback-1292-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> 1185483 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 1185483 INFO  (zkCallback-1292-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> 1185485 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:51341 51341
   [junit4]   2> 1185597 INFO  (Thread-2903) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:51341 51341
   [junit4]   2> 1185598 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending 
testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> 1185600 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
   [junit4]   2> 1185600 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1185600 INFO  (Thread-2904) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1185600 INFO  (Thread-2904) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1185700 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.ZkTestServer start zk server on port:34985
   [junit4]   2> 1185700 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1185701 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1185702 INFO  (zkCallback-1294-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1d2993fd 
name:ZooKeeperConnection Watcher:127.0.0.1:34985 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1185702 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1185702 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1185703 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1185703 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1185704 INFO  (zkCallback-1295-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@68620b26 
name:ZooKeeperConnection Watcher:127.0.0.1:34985 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1185704 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1185704 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1185704 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1185705 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1185706 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1185706 INFO  (zkCallback-1296-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@3feece97 
name:ZooKeeperConnection Watcher:127.0.0.1:34985/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1185706 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1185706 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1185707 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1185707 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 1185708 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1185708 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1185709 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1185712 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1185713 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 1185713 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1185714 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 1185714 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 1185715 INFO  (zkCallback-1296-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 1185715 INFO  (zkCallback-1296-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> 1185766 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 1185767 INFO  (zkCallback-1296-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> 1185767 INFO  (zkCallback-1296-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> 1185767 INFO  (zkCallback-1296-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 1185768 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34985 34985
   [junit4]   2> 1186028 INFO  (Thread-2904) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:34985 34985
   [junit4]   2> 1186029 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=ZkStateReaderTest 
-Dtests.method=testStateFormatUpdateWithTimeDelay -Dtests.seed=4DE70A0D02536C9B 
-Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=de 
-Dtests.timezone=America/Metlakatla -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.43s J1 | 
ZkStateReaderTest.testStateFormatUpdateWithTimeDelay <<<
   [junit4]    > Throwable #1: org.apache.solr.common.SolrException: Could not 
find collection : c1
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([4DE70A0D02536C9B:3279BD886B314111]:0)
   [junit4]    >        at 
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:192)
   [junit4]    >        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:130)
   [junit4]    >        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay(ZkStateReaderTest.java:52)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 1186032 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 1186032 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1186032 INFO  (Thread-2905) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1186032 INFO  (Thread-2905) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1186132 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.ZkTestServer start zk server on port:43415
   [junit4]   2> 1186132 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1186133 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1186134 INFO  (zkCallback-1298-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@769d7285 
name:ZooKeeperConnection Watcher:127.0.0.1:43415 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1186134 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1186134 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1186135 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1186135 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1186136 INFO  (zkCallback-1299-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@464877cd 
name:ZooKeeperConnection Watcher:127.0.0.1:43415 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1186136 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1186136 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1186136 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1186138 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1186138 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1186139 INFO  (zkCallback-1300-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@57bffd59 
name:ZooKeeperConnection Watcher:127.0.0.1:43415/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1186139 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1186139 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1186139 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1186140 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 1186141 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1186141 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1186142 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1186142 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1186143 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 1186143 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1186144 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 1186144 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 1186145 INFO  (zkCallback-1300-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 1186145 INFO  (zkCallback-1300-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> 1186146 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 1186146 INFO  (zkCallback-1300-thread-3) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for 
collection [c1] has occurred - updating... (live nodes size: [0])
   [junit4]   2> 1186146 INFO  (zkCallback-1300-thread-3) [    ] 
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 1186147 INFO  (zkCallback-1300-thread-4) [    ] 
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> 1186151 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:43415 43415
   [junit4]   2> 1186474 INFO  (Thread-2905) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:43415 43415
   [junit4]   2> 1186475 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 1186477 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 1186477 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1186477 INFO  (Thread-2906) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1186477 INFO  (Thread-2906) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1186577 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.ZkTestServer start zk server on port:56254
   [junit4]   2> 1186577 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1186578 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1186580 INFO  (zkCallback-1302-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@793c76cf 
name:ZooKeeperConnection Watcher:127.0.0.1:56254 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1186580 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1186580 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1186581 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1186581 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1186582 INFO  (zkCallback-1303-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@2e1f4e57 
name:ZooKeeperConnection Watcher:127.0.0.1:56254 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1186582 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1186582 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1186582 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1186584 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1186584 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1186585 INFO  (zkCallback-1304-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7a6eca98 
name:ZooKeeperConnection Watcher:127.0.0.1:56254/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1186585 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1186585 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1186588 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1186589 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 1186589 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1186590 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1186591 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1186591 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1186591 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 1186591 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1186592 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 1186592 INFO  (zkCallback-1304-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 1186603 INFO  (zkCallback-1304-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> 1186643 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 1186644 INFO  (zkCallback-1304-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> 1186645 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:56254 56254
   [junit4]   2> 1186997 INFO  (Thread-2906) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:56254 56254
   [junit4]   2> 1186998 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 1187000 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
   [junit4]   2> 1187001 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1187001 INFO  (Thread-2907) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1187001 INFO  (Thread-2907) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1187101 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.ZkTestServer start zk server on port:45451
   [junit4]   2> 1187101 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1187105 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1187106 INFO  (zkCallback-1306-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7102afd0 
name:ZooKeeperConnection Watcher:127.0.0.1:45451 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1187106 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1187106 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1187107 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1187107 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1187108 INFO  (zkCallback-1307-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@304be51 name:ZooKeeperConnection 
Watcher:127.0.0.1:45451 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 1187108 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1187108 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1187108 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1187109 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1187113 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1187113 INFO  (zkCallback-1308-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@3668f575 
name:ZooKeeperConnection Watcher:127.0.0.1:45451/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1187113 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1187114 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1187114 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1187115 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 1187115 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1187116 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1187117 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1187117 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1187118 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 1187118 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1187119 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 1187119 INFO  (zkCallback-1308-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 1187124 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 1187124 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 1187125 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45451 45451
   [junit4]   2> 1187347 INFO  (Thread-2907) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:45451 45451
   [junit4]   2> 1187348 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4DE70A0D02536C9B])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
   [junit4]   2> 1187351 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
   [junit4]   2> 1187351 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1187351 INFO  (Thread-2908) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1187351 INFO  (Thread-2908) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1187452 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.ZkTestServer start zk server on port:45593
   [junit4]   2> 1187452 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1187452 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1187457 INFO  (zkCallback-1310-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@47ae1e05 
name:ZooKeeperConnection Watcher:127.0.0.1:45593 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1187457 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1187457 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1187461 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1187461 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1187462 INFO  (zkCallback-1311-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@3c743483 
name:ZooKeeperConnection Watcher:127.0.0.1:45593 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1187462 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1187462 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1187462 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1187464 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1187464 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1187465 INFO  (zkCallback-1312-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@4a924d56 
name:ZooKeeperConnection Watcher:127.0.0.1:45593/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1187465 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1187465 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1187465 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1187466 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 1187467 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1187468 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1187468 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1187469 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1187469 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 1187470 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1187471 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 1187471 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 1187471 INFO  (zkCallback-1312-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 1187476 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 1187476 INFO  (zkCallback-1312-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> 1187476 INFO  (zkCallback-1312-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 1187528 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45593 45593
   [junit4]   2> 1187975 INFO  (Thread-2908) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:45593 45593
   [junit4]   2> 1187977 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4DE70A0D02536C9B]) 
[    ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
   [junit4]   2> 1187977 INFO  
(SUITE-ZkStateReaderTest-seed#[4DE70A0D02536C9B]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.overseer.ZkStateReaderTest_4DE70A0D02536C9B-001
   [junit4]   2> NOTE: test params are: codec=CheapBastard, 
sim=RandomSimilarity(queryNorm=false,coord=no): {}, locale=de, 
timezone=America/Metlakatla
   [junit4]   2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 
1.8.0_74 (64-bit)/cpus=4,threads=1,free=272677800,total=530579456
   [junit4]   2> NOTE: All tests run in this JVM: [TestCollapseQParserPlugin, 
HdfsRecoveryZkTest, TestSystemIdResolver, CollectionsAPIDistributedZkTest, 
TestTrie, BlockDirectoryTest, TestSha256AuthenticationProvider, 
BlockJoinFacetRandomTest, TestDistribIDF, HdfsCollectionsAPIDistributedZkTest, 
DistributedQueueTest, TestAnalyzeInfixSuggestions, 
DistributedIntervalFacetingTest, TestFastLRUCache, TestSearcherReuse, 
ZkSolrClientTest, TestLRUStatsCache, OpenExchangeRatesOrgProviderTest, 
FacetPivotSmallTest, DistributedMLTComponentTest, DirectSolrSpellCheckerTest, 
TestJsonFacets, TestFreeTextSuggestions, TestQueryTypes, TestConfigSets, 
OpenCloseCoreStressTest, TermVectorComponentTest, 
DistributedQueryComponentCustomSortTest, TestSerializedLuceneMatchVersion, 
TestSortByMinMaxFunction, TestSimpleTrackingShardHandler, 
TestQuerySenderListener, TestReRankQParserPlugin, SpellingQueryConverterTest, 
SaslZkACLProviderTest, CloneFieldUpdateProcessorFactoryTest, 
HighlighterMaxOffsetTest, SolrCmdDistributorTest, TestIntervalFaceting, 
TestTestInjection, DocValuesMissingTest, FastVectorHighlighterTest, 
TestMiniSolrCloudClusterBase, TestDocumentBuilder, MultiTermTest, 
CdcrReplicationHandlerTest, TestConfigOverlay, 
LeaderInitiatedRecoveryOnShardRestartTest, TestInfoStreamLogging, 
TestDistributedGrouping, TestBlobHandler, TestRestManager, 
CoreAdminRequestStatusTest, TestBinaryResponseWriter, DOMUtilTest, 
TestLegacyFieldCache, TestDFISimilarityFactory, TestFieldCacheReopen, 
TermsComponentTest, CSVRequestHandlerTest, TestCopyFieldCollectionResource, 
TestSSLRandomization, DeleteReplicaTest, CustomCollectionTest, 
SortSpecParsingTest, SecurityConfHandlerTest, HdfsLockFactoryTest, 
ClusterStateUpdateTest, FileUtilsTest, RuleEngineTest, HttpPartitionTest, 
TolerantUpdateProcessorTest, TestUseDocValuesAsStored2, TestSolrDynamicMBean, 
TestCollectionAPI, OverseerRolesTest, TestGeoJSONResponseWriter, 
TestCloudSchemaless, SpatialFilterTest, TestTolerantUpdateProcessorCloud, 
TestAuthorizationFramework, TestSchemaResource, 
SharedFSAutoReplicaFailoverUtilsTest, ShardRoutingTest, TestQuerySenderNoQuery, 
DistributedTermsComponentTest, DistribCursorPagingTest, TestLFUCache, 
SpellPossibilityIteratorTest, SolrIndexConfigTest, SolrXmlInZkTest, 
TestCursorMarkWithoutUniqueKey, DistributedFacetPivotSmallAdvancedTest, 
HdfsBasicDistributedZkTest, ZkStateReaderTest]
   [junit4] Completed [294/613 (1!)] on J1 in 2.63s, 6 tests, 1 error <<< 
FAILURES!

[...truncated 1048 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:740: The 
following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:684: The 
following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:59: The 
following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build.xml:233: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/common-build.xml:531:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/lucene/common-build.xml:1427:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/lucene/common-build.xml:984:
 There were test failures: 613 suites (10 ignored), 2565 tests, 1 error, 87 
ignored (72 assumptions) [seed: 4DE70A0D02536C9B]

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



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

Reply via email to