lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Jenkins Server <jenk...@builds.apache.org>
Subject [JENKINS] Lucene-Solr-Tests-master - Build # 1030 - Failure
Date Mon, 21 Mar 2016 18:11:43 GMT
Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/1030/

1 tests failed.
FAILED:  org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy

Error Message:
Could not find collection : c1

Stack Trace:
org.apache.solr.common.SolrException: Could not find collection : c1
	at __randomizedtesting.SeedInfo.seed([F34DB2ED4A0C2019:980212903303FD23]:0)
	at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
	at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:135)
	at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy(ZkStateReaderTest.java:46)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 12081 lines...]
   [junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
   [junit4]   2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_F34DB2ED4A0C2019-001/init-core-data-001
   [junit4]   2> 1873504 INFO  (SUITE-ZkStateReaderTest-seed#[F34DB2ED4A0C2019]-worker)
[    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true)
   [junit4]   2> 1873507 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> 1873507 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1873507 INFO  (Thread-6803) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1873507 INFO  (Thread-6803) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 1873607 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.ZkTestServer start zk server on port:52677
   [junit4]   2> 1873608 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1873610 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1873612 INFO  (zkCallback-2259-thread-1) [    ] o.a.s.c.c.ConnectionManager
Watcher org.apache.solr.common.cloud.ConnectionManager@483904fa name:ZooKeeperConnection Watcher:127.0.0.1:52677
got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1873613 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1873613 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1873614 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1873615 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1873616 INFO  (zkCallback-2260-thread-1) [    ] o.a.s.c.c.ConnectionManager
Watcher org.apache.solr.common.cloud.ConnectionManager@7f8bc72b name:ZooKeeperConnection Watcher:127.0.0.1:52677
got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1873616 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1873616 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1873616 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1873621 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1873623 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1873624 INFO  (zkCallback-2261-thread-1) [    ] o.a.s.c.c.ConnectionManager
Watcher org.apache.solr.common.cloud.ConnectionManager@43d98241 name:ZooKeeperConnection Watcher:127.0.0.1:52677/solr
got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1873624 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1873624 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1873625 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1873626 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 1873627 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1873628 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1873630 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1873632 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1873633 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1873633 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 1873637 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 1873641 INFO  (zkCallback-2261-thread-1) [    ] o.a.s.c.c.ZkStateReader
A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections],
has occurred - updating...
   [junit4]   2> 1873647 INFO  (zkCallback-2261-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> 1873647 WARN  (zkCallback-2261-thread-2) [    ] o.a.s.c.c.ZkStateReader
ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired
for /clusterstate.json]
   [junit4]   2> 1875141 WARN  (zkCallback-2261-thread-1) [    ] o.a.s.c.c.ZkStateReader
ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired
for /collections]
   [junit4]   2> 1875143 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:52677 52677
   [junit4]   2> 1875322 INFO  (Thread-6803) [    ] o.a.s.c.ZkTestServer connecting to
127.0.0.1:52677 52677
   [junit4]   2> 1875324 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithExplicitRefreshLazy
-Dtests.seed=F34DB2ED4A0C2019 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=es-EC
-Dtests.timezone=Australia/Canberra -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   1.82s J0 | ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy
<<<
   [junit4]    > Throwable #1: org.apache.solr.common.SolrException: Could not find collection
: c1
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([F34DB2ED4A0C2019:980212903303FD23]:0)
   [junit4]    > 	at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
   [junit4]    > 	at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:135)
   [junit4]    > 	at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy(ZkStateReaderTest.java:46)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 1875330 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
   [junit4]   2> 1875330 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1875331 INFO  (Thread-6804) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1875331 INFO  (Thread-6804) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 1875431 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.ZkTestServer start zk server on port:60896
   [junit4]   2> 1875432 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1875433 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1875436 INFO  (zkCallback-2262-thread-1) [    ] o.a.s.c.c.ConnectionManager
Watcher org.apache.solr.common.cloud.ConnectionManager@6a1a574e name:ZooKeeperConnection Watcher:127.0.0.1:60896
got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1875437 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1875437 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1875439 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1875440 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1875441 INFO  (zkCallback-2263-thread-1) [    ] o.a.s.c.c.ConnectionManager
Watcher org.apache.solr.common.cloud.ConnectionManager@ba39255 name:ZooKeeperConnection Watcher:127.0.0.1:60896
got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1875443 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1875443 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1875443 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1875447 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1875447 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1875449 INFO  (zkCallback-2264-thread-1) [    ] o.a.s.c.c.ConnectionManager
Watcher org.apache.solr.common.cloud.ConnectionManager@6ef4b5e9 name:ZooKeeperConnection Watcher:127.0.0.1:60896/solr
got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1875449 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1875449 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1875450 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1875452 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 1875454 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1875455 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1875456 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1875457 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1875458 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1875459 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 1875460 INFO  (zkCallback-2264-thread-1) [    ] o.a.s.c.c.ZkStateReader
A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections],
has occurred - updating...
   [junit4]   2> 1875464 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 1875465 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 1875465 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 1875466 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ZkStateReader Removing watch for uninteresting collection [c1]
   [junit4]   2> 1875467 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:60896 60896
   [junit4]   2> 1875643 INFO  (Thread-6804) [    ] o.a.s.c.ZkTestServer connecting to
127.0.0.1:60896 60896
   [junit4]   2> 1875644 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
   [junit4]   2> 1875648 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 1875649 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1875649 INFO  (Thread-6805) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1875649 INFO  (Thread-6805) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 1875749 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.ZkTestServer start zk server on port:37644
   [junit4]   2> 1875750 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1875750 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1875753 INFO  (zkCallback-2265-thread-1) [    ] o.a.s.c.c.ConnectionManager
Watcher org.apache.solr.common.cloud.ConnectionManager@7abd56d7 name:ZooKeeperConnection Watcher:127.0.0.1:37644
got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1875753 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1875753 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1875754 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1875755 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1875756 INFO  (zkCallback-2266-thread-1) [    ] o.a.s.c.c.ConnectionManager
Watcher org.apache.solr.common.cloud.ConnectionManager@29412971 name:ZooKeeperConnection Watcher:127.0.0.1:37644
got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1875756 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1875756 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1875756 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1875758 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1875759 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1875759 INFO  (zkCallback-2267-thread-1) [    ] o.a.s.c.c.ConnectionManager
Watcher org.apache.solr.common.cloud.ConnectionManager@335b2da8 name:ZooKeeperConnection Watcher:127.0.0.1:37644/solr
got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1875759 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1875760 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1875760 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1875761 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 1875762 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1875763 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1875764 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1875766 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1875767 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1875768 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 1875769 INFO  (zkCallback-2267-thread-1) [    ] o.a.s.c.c.ZkStateReader
A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections],
has occurred - updating...
   [junit4]   2> 1875770 INFO  (zkCallback-2267-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> 1875771 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 1875771 INFO  (zkCallback-2267-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> 1875774 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37644 37644
   [junit4]   2> 1876012 INFO  (Thread-6805) [    ] o.a.s.c.ZkTestServer connecting to
127.0.0.1:37644 37644
   [junit4]   2> 1876016 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 1876020 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
   [junit4]   2> 1876021 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1876022 INFO  (Thread-6806) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1876022 INFO  (Thread-6806) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 1876122 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.ZkTestServer start zk server on port:43783
   [junit4]   2> 1876122 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1876122 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1876126 INFO  (zkCallback-2268-thread-1) [    ] o.a.s.c.c.ConnectionManager
Watcher org.apache.solr.common.cloud.ConnectionManager@4552faac name:ZooKeeperConnection Watcher:127.0.0.1:43783
got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1876126 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1876126 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1876128 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1876128 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1876130 INFO  (zkCallback-2269-thread-1) [    ] o.a.s.c.c.ConnectionManager
Watcher org.apache.solr.common.cloud.ConnectionManager@1e11f43e name:ZooKeeperConnection Watcher:127.0.0.1:43783
got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1876130 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1876130 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1876130 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1876133 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1876134 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1876135 INFO  (zkCallback-2270-thread-1) [    ] o.a.s.c.c.ConnectionManager
Watcher org.apache.solr.common.cloud.ConnectionManager@6ce39a1e name:ZooKeeperConnection Watcher:127.0.0.1:43783/solr
got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1876135 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1876135 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1876135 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1876137 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 1876138 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1876139 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1876140 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1876141 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1876142 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1876143 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 1876143 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 1876144 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 1876144 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 1876145 INFO  (zkCallback-2270-thread-1) [    ] o.a.s.c.c.ZkStateReader
A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections],
has occurred - updating...
   [junit4]   2> 1876146 INFO  (zkCallback-2270-thread-1) [    ] o.a.s.c.c.ZkStateReader
Deleting data for [c1]
   [junit4]   2> 1876146 INFO  (zkCallback-2270-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> 1876197 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 1876198 INFO  (zkCallback-2270-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> 1876199 INFO  (zkCallback-2270-thread-2) [    ] o.a.s.c.c.ZkStateReader
Add data for [c1] ver [0]
   [junit4]   2> 1876250 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:43783 43783
   [junit4]   2> 1876407 INFO  (Thread-6806) [    ] o.a.s.c.ZkTestServer connecting to
127.0.0.1:43783 43783
   [junit4]   2> 1876409 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
   [junit4]   2> 1876412 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 1876413 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1876413 INFO  (Thread-6807) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1876413 INFO  (Thread-6807) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 1876513 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.ZkTestServer start zk server on port:58982
   [junit4]   2> 1876514 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1876515 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1876518 INFO  (zkCallback-2271-thread-1) [    ] o.a.s.c.c.ConnectionManager
Watcher org.apache.solr.common.cloud.ConnectionManager@24864859 name:ZooKeeperConnection Watcher:127.0.0.1:58982
got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1876518 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1876518 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1876519 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1876520 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1876521 INFO  (zkCallback-2272-thread-1) [    ] o.a.s.c.c.ConnectionManager
Watcher org.apache.solr.common.cloud.ConnectionManager@52aa207e name:ZooKeeperConnection Watcher:127.0.0.1:58982
got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1876521 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1876521 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1876521 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1876524 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1876524 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1876525 INFO  (zkCallback-2273-thread-1) [    ] o.a.s.c.c.ConnectionManager
Watcher org.apache.solr.common.cloud.ConnectionManager@126b2717 name:ZooKeeperConnection Watcher:127.0.0.1:58982/solr
got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1876525 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1876525 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1876526 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1876527 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 1876528 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1876529 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1876530 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1876531 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1876533 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 1876533 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 1876533 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 1876534 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 1876534 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 1876535 INFO  (zkCallback-2273-thread-1) [    ] o.a.s.c.c.ZkStateReader
A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections],
has occurred - updating...
   [junit4]   2> 1876537 INFO  (zkCallback-2273-thread-1) [    ] o.a.s.c.c.ZkStateReader
Deleting data for [c1]
   [junit4]   2> 1876537 INFO  (zkCallback-2273-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> 1876538 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 1876539 INFO  (zkCallback-2273-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> 1876540 INFO  (zkCallback-2273-thread-2) [    ] o.a.s.c.c.ZkStateReader
Add data for [c1] ver [0]
   [junit4]   2> 1876541 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:58982 58982
   [junit4]   2> 1876706 INFO  (Thread-6807) [    ] o.a.s.c.ZkTestServer connecting to
127.0.0.1:58982 58982
   [junit4]   2> 1876708 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F34DB2ED4A0C2019])
[    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 1876708 INFO  (SUITE-ZkStateReaderTest-seed#[F34DB2ED4A0C2019]-worker)
[    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_F34DB2ED4A0C2019-001
   [junit4]   2> Mar 21, 2016 6:04:07 PM com.carrotsearch.randomizedtesting.ThreadLeakControl
checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
   [junit4]   2> NOTE: test params are: codec=FastCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST,
chunkSize=627, maxDocsPerChunk=4, blockSize=6), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST,
chunkSize=627, blockSize=6)), sim=ClassicSimilarity, locale=es-EC, timezone=Australia/Canberra
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_74 (64-bit)/cpus=4,threads=1,free=168331376,total=501219328
   [junit4]   2> NOTE: All tests run in this JVM: [TestPseudoReturnFields, TestDocSet,
DocExpirationUpdateProcessorFactoryTest, TestBinaryField, SparseHLLTest, DistributedSpellCheckComponentTest,
CachingDirectoryFactoryTest, DefaultValueUpdateProcessorTest, PreAnalyzedUpdateProcessorTest,
TestSolrCLIRunExample, TestIBSimilarityFactory, TestHdfsUpdateLog, URLClassifyProcessorTest,
TestSchemaResource, FileBasedSpellCheckerTest, ConcurrentDeleteAndCreateCollectionTest, TestExactSharedStatsCache,
ExternalFileFieldSortTest, TestConfigReload, TestLMDirichletSimilarityFactory, TestFoldingMultitermQuery,
TestValueSourceCache, PathHierarchyTokenizerFactoryTest, TestJsonFacets, CloudExitableDirectoryReaderTest,
HdfsDirectoryFactoryTest, TestArbitraryIndexDir, TestClusterStateMutator, TestCryptoKeys,
TestMiniSolrCloudCluster, BlockJoinFacetRandomTest, RAMDirectoryFactoryTest, TestComplexPhraseQParserPlugin,
TestDistributedStatsComponentCardinality, CopyFieldTest, DistanceUnitsTest, TestRandomFaceting,
TestReplicaProperties, TestChildDocTransformer, TestSortByMinMaxFunction, RestartWhileUpdatingTest,
WrapperMergePolicyFactoryTest, SmileWriterTest, TestCSVLoader, TestDistributedSearch, CoreMergeIndexesAdminHandlerTest,
PrimUtilsTest, TestMiniSolrCloudClusterSSL, DistributedQueryElevationComponentTest, TestSolrXml,
TestRealTimeGet, DeleteReplicaTest, BadCopyFieldTest, TestMaxScoreQueryParser, TestSchemaManager,
DocumentAnalysisRequestHandlerTest, DocValuesMissingTest, TestMergePolicyConfig, SolrRequestParserTest,
TestLuceneMatchVersion, TestConfig, TestCopyFieldCollectionResource, SpatialHeatmapFacetsTest,
CustomCollectionTest, PolyFieldTest, AnalyticsMergeStrategyTest, PingRequestHandlerTest, JsonLoaderTest,
TestHighlightDedupGrouping, TestOverriddenPrefixQueryForCustomFieldType, SharedFSAutoReplicaFailoverUtilsTest,
OutputWriterTest, TestShortCircuitedRequests, ConnectionReuseTest, MergeStrategyTest, CurrencyFieldOpenExchangeTest,
SynonymTokenizerTest, DisMaxRequestHandlerTest, OverseerRolesTest, TestSerializedLuceneMatchVersion,
AsyncCallRequestStatusResponseTest, TestAtomicUpdateErrorCases, DataDrivenBlockJoinTest, AnalysisAfterCoreReloadTest,
DistributedFacetPivotLargeTest, TestJoin, CdcrReplicationDistributedZkTest, TestCloudSchemaless,
TestShardHandlerFactory, OutOfBoxZkACLAndCredentialsProvidersTest, TestReplicationHandler,
TestFaceting, TestScoreJoinQPNoScore, TestRTGBase, BasicDistributedZkTest, SyncSliceTest,
BasicZkTest, FullSolrCloudDistribCmdsTest, ShardRoutingCustomTest, TestHashPartitioner, TestStressVersions,
TestRangeQuery, TestSolr4Spatial, TestGroupingSearch, QueryElevationComponentTest, PeerSyncTest,
TestSort, HighlighterTest, SoftAutoCommitTest, SpatialFilterTest, TestWordDelimiterFilterFactory,
DirectUpdateHandlerOptimizeTest, TestRemoteStreaming, DistanceFunctionTest, DebugComponentTest,
CacheHeaderTest, StandardRequestHandlerTest, TestReversedWildcardFilterFactory, PrimitiveFieldTypeTest,
XmlUpdateRequestHandlerTest, DocumentBuilderTest, RequiredFieldsTest, TestSolrQueryParser,
IndexSchemaRuntimeFieldTest, RegexBoostProcessorTest, TestJmxIntegration, JSONWriterTest,
BinaryUpdateRequestHandlerTest, SOLR749Test, AlternateDirectoryTest, ResponseLogComponentTest,
TestSolrDeletionPolicy2, NumericFieldsTest, MinimalSchemaTest, TestElisionMultitermQuery,
NotRequiredUniqueKeyTest, TestCharFilters, TestCodecSupport, TestDFRSimilarityFactory, TestFastWriter,
ResourceLoaderTest, ScriptEngineTest, TestSuggestSpellingConverter, DateFieldTest, TestUtils,
CursorPagingTest, TestEmbeddedSolrServerConstructors, ActionThrottleTest, CdcrRequestHandlerTest,
CdcrVersionReplicationTest, ConfigSetsAPITest, DeleteShardTest, LeaderInitiatedRecoveryOnCommitTest,
OverriddenZkACLAndCredentialsProvidersTest, OverseerCollectionConfigSetProcessorTest, RecoveryAfterSoftCommitTest,
SolrXmlInZkTest, TestCloudDeleteByQuery, TestCloudInspectUtil, TestCollectionAPI, TestConfigSetsAPI,
TestConfigSetsAPIExclusivity, TestConfigSetsAPIZkFailure, TestDistribDocBasedVersion, TestLeaderElectionZkExpiry,
TestRandomRequestDistribution, TestRequestStatusCollectionAPI, HdfsRestartWhileUpdatingTest,
HdfsSyncSliceTest, HdfsThreadLeakTest, ZkStateReaderTest]
   [junit4] Completed [473/580 (1!)] on J0 in 4.23s, 5 tests, 1 error <<< FAILURES!

[...truncated 373 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:740: The following
error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:684: The following
error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:59: The following error
occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build.xml:233: The following
error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/common-build.xml:529: The
following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:1457:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:1014:
There were test failures: 580 suites (10 ignored), 2323 tests, 1 error, 86 ignored (70 assumptions)
[seed: F34DB2ED4A0C2019]

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



Mime
View raw message