lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@thetaphi.de>
Subject [JENKINS-EA] Lucene-Solr-master-Linux (64bit/jdk-9-ea+122) - Build # 17003 - Failure!
Date Fri, 17 Jun 2016 15:28:27 GMT
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



Mime
View raw message