Build: http://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/17003/
Java: 64bit/jdk-9-ea+122 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC

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([30DC225BAFA028D3:4F4295DEC6C20559]:0)
        at 
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:192)
        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:129)
        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay(ZkStateReaderTest.java:51)
        at 
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:843)




Build Log:
[...truncated 11134 lines...]
   [junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.overseer.ZkStateReaderTest_30DC225BAFA028D3-001/init-core-data-001
   [junit4]   2> 511684 INFO  
(SUITE-ZkStateReaderTest-seed#[30DC225BAFA028D3]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 511686 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
   [junit4]   2> 511686 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 511686 INFO  (Thread-1009) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 511686 INFO  (Thread-1009) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 511786 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.ZkTestServer start zk server on port:34901
   [junit4]   2> 511786 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 511787 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 511789 INFO  (zkCallback-513-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@38b57510 
name:ZooKeeperConnection Watcher:127.0.0.1:34901 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 511789 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 511791 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 511792 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 511792 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 511793 INFO  (zkCallback-514-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@2f67faa8 
name:ZooKeeperConnection Watcher:127.0.0.1:34901 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 511793 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 511793 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 511793 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 511798 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 511798 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 511799 INFO  (zkCallback-515-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@290edb77 
name:ZooKeeperConnection Watcher:127.0.0.1:34901/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 511799 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 511799 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 511800 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 511800 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 511801 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 511801 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 511803 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 511804 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 511804 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 511804 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 511805 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 511805 INFO  (zkCallback-515-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 511806 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 511807 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 511808 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34901 34901
   [junit4]   2> 521871 INFO  (Thread-1009) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:34901 34901
   [junit4]   2> 521872 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[30DC225BAFA028D3])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
   [junit4]   2> 521873 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 521873 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 521873 INFO  (Thread-1010) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 521873 INFO  (Thread-1010) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 521973 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.ZkTestServer start zk server on port:36350
   [junit4]   2> 521973 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 521974 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 521975 INFO  (zkCallback-517-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1146ae58 
name:ZooKeeperConnection Watcher:127.0.0.1:36350 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 521975 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 521976 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 521976 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 521976 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 521977 INFO  (zkCallback-518-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@5ad5f928 
name:ZooKeeperConnection Watcher:127.0.0.1:36350 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 521977 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 521977 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 521977 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 521979 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 521980 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 521981 INFO  (zkCallback-519-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@6abe7fb0 
name:ZooKeeperConnection Watcher:127.0.0.1:36350/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 521981 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 521981 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 521981 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 521982 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 521983 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 521983 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 521984 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 521984 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 521984 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 521985 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 521985 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 521986 INFO  (zkCallback-519-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 521986 INFO  (zkCallback-519-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> 521987 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 521987 INFO  (zkCallback-519-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> 521988 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36350 36350
   [junit4]   2> 522020 INFO  (Thread-1010) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:36350 36350
   [junit4]   2> 522021 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 522023 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 522024 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 522024 INFO  (Thread-1011) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 522024 INFO  (Thread-1011) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 522124 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.ZkTestServer start zk server on port:33505
   [junit4]   2> 522124 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 522124 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 522126 INFO  (zkCallback-521-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@28b1545b 
name:ZooKeeperConnection Watcher:127.0.0.1:33505 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 522126 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 522126 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 522126 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 522127 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 522127 INFO  (zkCallback-522-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@443a83c3 
name:ZooKeeperConnection Watcher:127.0.0.1:33505 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 522127 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 522128 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 522128 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 522129 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 522129 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 522130 INFO  (zkCallback-523-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@51a0a400 
name:ZooKeeperConnection Watcher:127.0.0.1:33505/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 522130 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 522130 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 522130 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 522131 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 522131 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 522132 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 522132 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 522133 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 522133 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 522133 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 522135 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 522135 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 522136 INFO  (zkCallback-523-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 522136 INFO  (zkCallback-523-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> 522137 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 522137 INFO  (zkCallback-523-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> 522137 INFO  (zkCallback-523-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 522137 INFO  (zkCallback-523-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> 522138 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:33505 33505
   [junit4]   2> 532156 INFO  (Thread-1011) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:33505 33505
   [junit4]   2> 532157 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[30DC225BAFA028D3])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 532158 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
   [junit4]   2> 532159 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 532160 INFO  (Thread-1012) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 532160 INFO  (Thread-1012) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 532260 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.ZkTestServer start zk server on port:35215
   [junit4]   2> 532260 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 532260 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 532264 INFO  (zkCallback-525-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@e60a7f7 name:ZooKeeperConnection 
Watcher:127.0.0.1:35215 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 532264 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 532264 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 532265 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 532265 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 532279 INFO  (zkCallback-526-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@604c85c5 
name:ZooKeeperConnection Watcher:127.0.0.1:35215 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 532279 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 532280 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 532280 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 532281 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 532281 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 532296 INFO  (zkCallback-527-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@24473a81 
name:ZooKeeperConnection Watcher:127.0.0.1:35215/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 532296 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 532297 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 532297 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 532299 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 532299 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 532300 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 532301 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 532301 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 532302 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 532302 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 532303 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 532303 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 532303 INFO  (zkCallback-527-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 532304 INFO  (zkCallback-527-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> 532305 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 532305 INFO  (zkCallback-527-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> 532305 INFO  (zkCallback-527-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> 532306 INFO  (zkCallback-527-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 532307 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35215 35215
   [junit4]   2> 547390 INFO  (Thread-1012) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:35215 35215
   [junit4]   2> 547391 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[30DC225BAFA028D3])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=ZkStateReaderTest 
-Dtests.method=testStateFormatUpdateWithTimeDelay -Dtests.seed=30DC225BAFA028D3 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sr-Latn-ME 
-Dtests.timezone=America/Monterrey -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   15.2s J1 | 
ZkStateReaderTest.testStateFormatUpdateWithTimeDelay <<<
   [junit4]    > Throwable #1: org.apache.solr.common.SolrException: Could not 
find collection : c1
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([30DC225BAFA028D3:4F4295DEC6C20559]:0)
   [junit4]    >        at 
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:192)
   [junit4]    >        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:129)
   [junit4]    >        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay(ZkStateReaderTest.java:51)
   [junit4]    >        at 
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:843)
   [junit4]   2> 547396 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> 547396 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 547396 INFO  (Thread-1013) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 547396 INFO  (Thread-1013) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 547496 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.ZkTestServer start zk server on port:39777
   [junit4]   2> 547496 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 547497 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 547498 INFO  (zkCallback-529-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@388e654e 
name:ZooKeeperConnection Watcher:127.0.0.1:39777 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 547498 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 547498 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 547499 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 547499 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 547500 INFO  (zkCallback-530-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@6fca9b7d 
name:ZooKeeperConnection Watcher:127.0.0.1:39777 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 547500 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 547500 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 547500 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 547501 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 547501 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 547503 INFO  (zkCallback-531-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@6bf437ee 
name:ZooKeeperConnection Watcher:127.0.0.1:39777/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 547503 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 547503 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 547503 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 547504 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 547504 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 547504 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 547505 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 547505 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 547505 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 547505 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 547506 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 547506 INFO  (zkCallback-531-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 547507 INFO  (zkCallback-531-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> 547507 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 547507 INFO  (zkCallback-531-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> 547509 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39777 39777
   [junit4]   2> 552567 INFO  (Thread-1013) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:39777 39777
   [junit4]   2> 552568 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[30DC225BAFA028D3])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending 
testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> 552569 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
   [junit4]   2> 552569 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 552569 INFO  (Thread-1014) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 552569 INFO  (Thread-1014) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 552669 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.ZkTestServer start zk server on port:34387
   [junit4]   2> 552670 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 552670 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 552671 INFO  (zkCallback-533-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@54589ab9 
name:ZooKeeperConnection Watcher:127.0.0.1:34387 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 552671 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 552671 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 552672 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 552672 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 552673 INFO  (zkCallback-534-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@28994c73 
name:ZooKeeperConnection Watcher:127.0.0.1:34387 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 552673 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 552673 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 552673 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 552675 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 552676 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 552676 INFO  (zkCallback-535-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@bf01707 name:ZooKeeperConnection 
Watcher:127.0.0.1:34387/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 552676 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 552676 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 552676 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 552677 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 552677 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 552678 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 552678 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 552679 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 552679 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 552679 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 552680 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 552680 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 552680 INFO  (zkCallback-535-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 552681 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 552681 INFO  (zkCallback-535-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> 552681 INFO  (zkCallback-535-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 552732 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34387 34387
   [junit4]   2> 552735 INFO  (Thread-1014) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:34387 34387
   [junit4]   2> 552736 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[30DC225BAFA028D3]) 
[    ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
   [junit4]   2> 552736 INFO  
(SUITE-ZkStateReaderTest-seed#[30DC225BAFA028D3]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.overseer.ZkStateReaderTest_30DC225BAFA028D3-001
   [junit4]   2> Jun 17, 2016 3:01:04 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 4 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene62), 
sim=ClassicSimilarity, locale=sr-Latn-ME, timezone=America/Monterrey
   [junit4]   2> NOTE: Linux 4.4.0-24-generic amd64/Oracle Corporation 9-ea 
(64-bit)/cpus=12,threads=1,free=245279904,total=515899392
   [junit4]   2> NOTE: All tests run in this JVM: [HdfsBasicDistributedZkTest, 
ChangedSchemaMergeTest, TestPartialUpdateDeduplication, NumericFieldsTest, 
TestConfigOverlay, TestLeaderInitiatedRecoveryThread, 
CollectionsAPIDistributedZkTest, ChaosMonkeyNothingIsSafeTest, 
TestScoreJoinQPScore, TestSolrCLIRunExample, EnumFieldTest, MergeStrategyTest, 
TermsComponentTest, DocValuesTest, TestNonDefinedSimilarityFactory, 
DistributedQueryComponentCustomSortTest, HdfsDirectoryTest, SolrXmlInZkTest, 
MinimalSchemaTest, BlockJoinFacetSimpleTest, TestReloadAndDeleteDocs, 
UpdateRequestProcessorFactoryTest, SpellPossibilityIteratorTest, 
TestSimpleQParserPlugin, TestCollectionAPI, ShardRoutingCustomTest, 
TestManagedResourceStorage, TestMinMaxOnMultiValuedField, 
UniqFieldsUpdateProcessorFactoryTest, HdfsWriteToMultipleCollectionsTest, 
CheckHdfsIndexTest, DOMUtilTest, TestNumericTerms64, 
TestConfigSetsAPIZkFailure, FacetPivotSmallTest, 
TestSimpleTrackingShardHandler, TestManagedSynonymFilterFactory, 
TestSolrFieldCacheMBean, TestInitQParser, TestFieldCacheWithThreads, 
NotRequiredUniqueKeyTest, TriLevelCompositeIdRoutingTest, TestStressVersions, 
DistributedExpandComponentTest, AnalysisErrorHandlingTest, SoftAutoCommitTest, 
BasicFunctionalityTest, TestSchemaNameResource, TestPivotHelperCode, 
DistanceUnitsTest, ZkStateReaderTest]
   [junit4] Completed [192/614 (1!)] on J1 in 41.57s, 6 tests, 1 error <<< 
FAILURES!

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

Total time: 57 minutes 15 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