Build: http://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Linux/595/
Java: 64bit/jdk-9-ea+116 -XX:+UseCompressedOops -XX:+UseParallelGC

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([21CCCF4E16072A08:5E5278CB7F650782]: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:52)
        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native 
Method)
        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
        at 
jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:531)
        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(java.base@9-ea/Thread.java:804)




Build Log:
[...truncated 10920 lines...]
   [junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.overseer.ZkStateReaderTest_21CCCF4E16072A08-001/init-core-data-001
   [junit4]   2> 310554 INFO  
(SUITE-ZkStateReaderTest-seed#[21CCCF4E16072A08]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 310555 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
   [junit4]   2> 310556 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 310556 INFO  (Thread-868) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 310556 INFO  (Thread-868) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 310658 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.ZkTestServer start zk server on port:43985
   [junit4]   2> 310658 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 310658 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 310662 INFO  (zkCallback-378-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@2f967aca 
name:ZooKeeperConnection Watcher:127.0.0.1:43985 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 310662 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 310662 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 310663 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 310664 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 310668 INFO  (zkCallback-379-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@243fcd43 
name:ZooKeeperConnection Watcher:127.0.0.1:43985 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 310668 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 310668 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 310668 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 310672 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 310672 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 310685 INFO  (zkCallback-380-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@54444caa 
name:ZooKeeperConnection Watcher:127.0.0.1:43985/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 310685 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 310685 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 310691 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 310695 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 310696 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 310698 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 310699 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 310700 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 310700 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 310701 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 310701 INFO  (zkCallback-380-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 310702 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 310703 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 310703 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 310703 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ZkStateReader Removing watch for uninteresting collection [c1]
   [junit4]   2> 310704 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:43985 43985
   [junit4]   2> 310726 INFO  (Thread-868) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:43985 43985
   [junit4]   2> 310727 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21CCCF4E16072A08])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
   [junit4]   2> 310730 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
   [junit4]   2> 310730 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 310738 INFO  (Thread-869) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 310738 INFO  (Thread-869) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 310830 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.ZkTestServer start zk server on port:37998
   [junit4]   2> 310830 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 310831 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 310833 INFO  (zkCallback-381-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7c507bd2 
name:ZooKeeperConnection Watcher:127.0.0.1:37998 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 310833 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 310833 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 310834 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 310834 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 310836 INFO  (zkCallback-382-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@a94a6d name:ZooKeeperConnection 
Watcher:127.0.0.1:37998 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 310836 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 310836 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 310836 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 310838 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 310838 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 310840 INFO  (zkCallback-383-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@3d4c6bd1 
name:ZooKeeperConnection Watcher:127.0.0.1:37998/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 310840 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 310840 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 310840 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 310841 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 310841 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 310842 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 310842 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 310843 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 310844 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 310844 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 310844 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 310844 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 310845 INFO  (zkCallback-383-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 310846 INFO  (zkCallback-383-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> 310896 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 310897 INFO  (zkCallback-383-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> 310897 INFO  (zkCallback-383-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> 310898 INFO  (zkCallback-383-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 310898 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37998 37998
   [junit4]   2> 311021 INFO  (Thread-869) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:37998 37998
   [junit4]   2> 311023 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21CCCF4E16072A08])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=ZkStateReaderTest 
-Dtests.method=testStateFormatUpdateWithTimeDelay -Dtests.seed=21CCCF4E16072A08 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=de-AT 
-Dtests.timezone=America/Swift_Current -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.30s J2 | 
ZkStateReaderTest.testStateFormatUpdateWithTimeDelay <<<
   [junit4]    > Throwable #1: org.apache.solr.common.SolrException: Could not 
find collection : c1
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([21CCCF4E16072A08:5E5278CB7F650782]: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:52)
   [junit4]    >        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native 
Method)
   [junit4]    >        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
   [junit4]    >        at 
jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
   [junit4]    >        at java.lang.Thread.run(java.base@9-ea/Thread.java:804)
   [junit4]   2> 311027 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 311027 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 311027 INFO  (Thread-870) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 311027 INFO  (Thread-870) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 311127 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.ZkTestServer start zk server on port:45357
   [junit4]   2> 311127 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 311128 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 311131 INFO  (zkCallback-384-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@67616eb5 
name:ZooKeeperConnection Watcher:127.0.0.1:45357 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 311131 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 311131 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 311132 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 311133 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 311133 INFO  (zkCallback-385-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@428b5622 
name:ZooKeeperConnection Watcher:127.0.0.1:45357 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 311133 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 311134 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 311134 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 311137 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 311137 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 311138 INFO  (zkCallback-386-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@365fd027 
name:ZooKeeperConnection Watcher:127.0.0.1:45357/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 311138 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 311138 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 311138 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 311140 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 311140 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 311141 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 311141 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 311142 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 311144 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 311144 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 311144 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 311144 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 311145 INFO  (zkCallback-386-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 311146 INFO  (zkCallback-386-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> 311146 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 311146 INFO  (zkCallback-386-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> 311147 INFO  (zkCallback-386-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 311147 INFO  (zkCallback-386-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> 311148 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45357 45357
   [junit4]   2> 311253 INFO  (Thread-870) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:45357 45357
   [junit4]   2> 311255 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21CCCF4E16072A08])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 311257 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 311258 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 311258 INFO  (Thread-871) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 311258 INFO  (Thread-871) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 311358 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.ZkTestServer start zk server on port:39838
   [junit4]   2> 311358 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 311358 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 311360 INFO  (zkCallback-387-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@4202932d 
name:ZooKeeperConnection Watcher:127.0.0.1:39838 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 311360 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 311361 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 311361 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 311362 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 311362 INFO  (zkCallback-388-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@37860fd1 
name:ZooKeeperConnection Watcher:127.0.0.1:39838 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 311362 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 311362 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 311363 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 311364 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 311364 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 311365 INFO  (zkCallback-389-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@15f00c62 
name:ZooKeeperConnection Watcher:127.0.0.1:39838/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 311365 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 311365 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 311365 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 311366 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 311366 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 311367 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 311367 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 311368 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 311369 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 311369 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 311370 INFO  (zkCallback-389-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 311370 INFO  (zkCallback-389-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> 311421 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 311421 INFO  (zkCallback-389-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> 311423 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39838 39838
   [junit4]   2> 311453 INFO  (Thread-871) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:39838 39838
   [junit4]   2> 311454 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 311457 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
   [junit4]   2> 311457 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 311457 INFO  (Thread-872) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 311457 INFO  (Thread-872) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 311557 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.ZkTestServer start zk server on port:34638
   [junit4]   2> 311557 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 311558 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 311560 INFO  (zkCallback-390-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@42f97043 
name:ZooKeeperConnection Watcher:127.0.0.1:34638 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 311560 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 311560 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 311561 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 311561 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 311562 INFO  (zkCallback-391-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@35cc920a 
name:ZooKeeperConnection Watcher:127.0.0.1:34638 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 311562 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 311562 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 311562 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 311563 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 311564 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 311572 INFO  (zkCallback-392-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@44f23692 
name:ZooKeeperConnection Watcher:127.0.0.1:34638/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 311572 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 311572 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 311572 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 311573 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 311573 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 311574 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 311575 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 311575 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 311576 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 311576 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 311576 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 311576 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 311578 INFO  (zkCallback-392-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 311578 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 311579 INFO  (zkCallback-392-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> 311579 INFO  (zkCallback-392-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 311631 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34638 34638
   [junit4]   2> 311659 INFO  (Thread-872) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:34638 34638
   [junit4]   2> 311661 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21CCCF4E16072A08]) 
[    ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
   [junit4]   2> 311663 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> 311663 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 311663 INFO  (Thread-873) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 311663 INFO  (Thread-873) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 311764 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.ZkTestServer start zk server on port:35098
   [junit4]   2> 311764 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 311764 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 311768 INFO  (zkCallback-393-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@3e92272e 
name:ZooKeeperConnection Watcher:127.0.0.1:35098 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 311768 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 311768 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 311768 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 311769 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 311769 INFO  (zkCallback-394-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@26102824 
name:ZooKeeperConnection Watcher:127.0.0.1:35098 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 311769 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 311770 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 311770 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 311771 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 311771 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 311772 INFO  (zkCallback-395-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@79e2cc7a 
name:ZooKeeperConnection Watcher:127.0.0.1:35098/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 311772 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 311772 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 311772 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 311773 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 311773 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 311774 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 311774 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 311774 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 311775 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 311776 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 311776 INFO  (zkCallback-395-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 311776 INFO  (zkCallback-395-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> 311778 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 311778 INFO  (zkCallback-395-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> 311780 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35098 35098
   [junit4]   2> 311836 INFO  (Thread-873) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:35098 35098
   [junit4]   2> 311838 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21CCCF4E16072A08])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending 
testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> 311839 INFO  
(SUITE-ZkStateReaderTest-seed#[21CCCF4E16072A08]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.overseer.ZkStateReaderTest_21CCCF4E16072A08-001
   [junit4]   2> May 08, 2016 4:03:02 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 6 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene60): {}, 
docValues:{}, maxPointsInLeafNode=113, maxMBSortInHeap=6.1574670954562, 
sim=ClassicSimilarity, locale=de-AT, timezone=America/Swift_Current
   [junit4]   2> NOTE: Linux 4.4.0-21-generic amd64/Oracle Corporation 9-ea 
(64-bit)/cpus=12,threads=1,free=160136816,total=525860864
   [junit4]   2> NOTE: All tests run in this JVM: 
[SolrCoreCheckLockOnStartupTest, EnumFieldTest, TestElisionMultitermQuery, 
TestHdfsUpdateLog, RegexBoostProcessorTest, RuleEngineTest, 
TestIndexingPerformance, TestFilteredDocIdSet, TestCloudManagedSchema, 
TestConfigOverlay, TestSolrQueryParserDefaultOperatorResource, 
OverseerStatusTest, FullSolrCloudDistribCmdsTest, TestTrieFacet, 
CurrencyFieldXmlFileTest, NoCacheHeaderTest, TestRequestStatusCollectionAPI, 
HdfsRecoveryZkTest, TestFieldTypeResource, TestSizeLimitedDistributedMap, 
SliceStateTest, TestXIncludeConfig, CollectionStateFormat2Test, 
AnalyticsMergeStrategyTest, UpdateParamsTest, SearchHandlerTest, 
TriLevelCompositeIdRoutingTest, TestPKIAuthenticationPlugin, 
TestSolrDeletionPolicy1, UnloadDistributedZkTest, CoreAdminRequestStatusTest, 
HdfsWriteToMultipleCollectionsTest, OverriddenZkACLAndCredentialsProvidersTest, 
TestMinMaxOnMultiValuedField, ZkStateReaderTest]
   [junit4] Completed [120/595 (1!)] on J2 in 2.05s, 6 tests, 1 error <<< 
FAILURES!

[...truncated 1547 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/build.xml:740: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/build.xml:684: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/build.xml:59: The following error 
occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build.xml:233: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/common-build.xml:529: The 
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/lucene/common-build.xml:1457: The 
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/lucene/common-build.xml:1014: 
There were test failures: 595 suites (10 ignored), 2404 tests, 1 error, 117 
ignored (71 assumptions) [seed: 21CCCF4E16072A08]

Total time: 56 minutes 48 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