You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2016/06/30 01:49:46 UTC
[JENKINS] Lucene-Solr-Tests-6.x - Build # 299 - Still Failing
Build: https://builds.apache.org/job/Lucene-Solr-Tests-6.x/299/
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([F6DEF604DC6FDB52:89404181B50DF6D8]: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 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 11155 lines...]
[junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
[junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.overseer.ZkStateReaderTest_F6DEF604DC6FDB52-001/init-core-data-001
[junit4] 2> 705889 INFO (SUITE-ZkStateReaderTest-seed#[F6DEF604DC6FDB52]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 705897 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
[junit4] 2> 705897 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 705911 INFO (Thread-1741) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 705911 INFO (Thread-1741) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 706009 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.ZkTestServer start zk server on port:35627
[junit4] 2> 706009 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 706018 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 706021 INFO (zkCallback-616-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@ea33bbb name:ZooKeeperConnection Watcher:127.0.0.1:35627 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 706021 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 706022 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 706022 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 706023 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 706023 INFO (zkCallback-617-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3ca387f3 name:ZooKeeperConnection Watcher:127.0.0.1:35627 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 706023 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 706024 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 706024 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 706026 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 706027 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 706028 INFO (zkCallback-618-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@24f517be name:ZooKeeperConnection Watcher:127.0.0.1:35627/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 706028 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 706028 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 706028 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 706029 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 706029 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 706030 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 706030 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 706030 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 706031 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 706031 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 706032 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 706032 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 706033 INFO (zkCallback-618-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 706040 INFO (zkCallback-618-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> 706084 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 706084 INFO (zkCallback-618-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> 706086 INFO (zkCallback-618-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for collection [c1] has occurred - updating... (live nodes size: [0])
[junit4] 2> 706086 WARN (zkCallback-618-thread-2) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /collections/c1/state.json]
[junit4] 2> 706086 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35627 35627
[junit4] 2> 706271 INFO (Thread-1741) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35627 35627
[junit4] 2> 706271 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithTimeDelay -Dtests.seed=F6DEF604DC6FDB52 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=es-VE -Dtests.timezone=America/Nome -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.39s J1 | ZkStateReaderTest.testStateFormatUpdateWithTimeDelay <<<
[junit4] > Throwable #1: org.apache.solr.common.SolrException: Could not find collection : c1
[junit4] > at __randomizedtesting.SeedInfo.seed([F6DEF604DC6FDB52:89404181B50DF6D8]: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 java.lang.Thread.run(Thread.java:745)
[junit4] 2> 706276 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 706276 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 706276 INFO (Thread-1742) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 706276 INFO (Thread-1742) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 706376 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.ZkTestServer start zk server on port:46647
[junit4] 2> 706377 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 706377 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 706381 INFO (zkCallback-620-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@58596b0 name:ZooKeeperConnection Watcher:127.0.0.1:46647 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 706381 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 706382 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 706386 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 706391 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 706392 INFO (zkCallback-621-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@154f170 name:ZooKeeperConnection Watcher:127.0.0.1:46647 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 706392 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 706392 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 706392 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 706393 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 706399 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 706399 INFO (zkCallback-622-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@407a2af7 name:ZooKeeperConnection Watcher:127.0.0.1:46647/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 706399 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 706399 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 706399 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 706400 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 706400 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 706401 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 706401 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 706401 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 706402 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 706402 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 706402 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 706403 INFO (zkCallback-622-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 706404 INFO (zkCallback-622-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> 706455 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 706456 INFO (zkCallback-622-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> 706508 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:46647 46647
[junit4] 2> 706627 INFO (Thread-1742) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:46647 46647
[junit4] 2> 706629 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 706632 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
[junit4] 2> 706632 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 706632 INFO (Thread-1743) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 706632 INFO (Thread-1743) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 706732 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.ZkTestServer start zk server on port:46653
[junit4] 2> 706733 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 706733 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 706734 INFO (zkCallback-624-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6b0f46aa name:ZooKeeperConnection Watcher:127.0.0.1:46653 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 706734 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 706735 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 706735 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 706736 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 706736 INFO (zkCallback-625-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@54dd776a name:ZooKeeperConnection Watcher:127.0.0.1:46653 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 706736 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 706737 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 706737 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 706742 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 706742 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 706743 INFO (zkCallback-626-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7deaafdb name:ZooKeeperConnection Watcher:127.0.0.1:46653/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 706743 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 706743 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 706743 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 706744 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 706745 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 706745 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 706746 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 706746 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 706747 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 706747 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 706748 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 706748 INFO (zkCallback-626-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 706749 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 706750 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 706751 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:46653 46653
[junit4] 2> 706872 INFO (Thread-1743) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:46653 46653
[junit4] 2> 706873 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
[junit4] 2> 706876 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
[junit4] 2> 706876 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 706877 INFO (Thread-1744) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 706877 INFO (Thread-1744) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 706977 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.ZkTestServer start zk server on port:56304
[junit4] 2> 706977 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 706977 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 706982 INFO (zkCallback-628-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2a75665c name:ZooKeeperConnection Watcher:127.0.0.1:56304 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 706982 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 706982 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 706983 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 706983 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 706986 INFO (zkCallback-629-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4282acdb name:ZooKeeperConnection Watcher:127.0.0.1:56304 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 706987 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 706987 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 706987 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 706988 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 706988 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 706989 INFO (zkCallback-630-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@554c2964 name:ZooKeeperConnection Watcher:127.0.0.1:56304/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 706989 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 706989 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 706989 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 706990 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 706991 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 706991 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 706992 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 706992 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 706993 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 706993 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 706994 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 706994 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 706995 INFO (zkCallback-630-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 706996 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 706996 INFO (zkCallback-630-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> 706996 INFO (zkCallback-630-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 707048 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:56304 56304
[junit4] 2> 707169 INFO (Thread-1744) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:56304 56304
[junit4] 2> 707170 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
[junit4] 2> 707173 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 707174 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 707174 INFO (Thread-1745) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 707174 INFO (Thread-1745) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 707274 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.ZkTestServer start zk server on port:42205
[junit4] 2> 707274 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 707275 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 707278 INFO (zkCallback-632-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@166e1f43 name:ZooKeeperConnection Watcher:127.0.0.1:42205 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 707278 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 707278 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 707279 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 707279 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 707280 INFO (zkCallback-633-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7c4a4a5b name:ZooKeeperConnection Watcher:127.0.0.1:42205 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 707280 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 707281 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 707281 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 707288 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 707289 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 707289 INFO (zkCallback-634-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@42b4f841 name:ZooKeeperConnection Watcher:127.0.0.1:42205/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 707289 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 707289 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 707290 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 707290 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 707291 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 707292 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 707292 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 707293 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 707293 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 707293 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 707294 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 707295 INFO (zkCallback-634-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 707298 INFO (zkCallback-634-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> 707299 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 707299 INFO (zkCallback-634-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> 707301 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42205 42205
[junit4] 2> 707401 INFO (Thread-1745) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42205 42205
[junit4] 2> 707401 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 707405 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 707405 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 707406 INFO (Thread-1746) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 707406 INFO (Thread-1746) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 707506 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.ZkTestServer start zk server on port:39740
[junit4] 2> 707506 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 707506 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 707510 INFO (zkCallback-636-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7edc6a21 name:ZooKeeperConnection Watcher:127.0.0.1:39740 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 707510 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 707510 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 707511 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 707512 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 707513 INFO (zkCallback-637-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@713adab2 name:ZooKeeperConnection Watcher:127.0.0.1:39740 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 707513 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 707513 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 707513 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 707519 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 707521 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 707522 INFO (zkCallback-638-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1b56d75a name:ZooKeeperConnection Watcher:127.0.0.1:39740/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 707522 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 707523 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 707523 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 707524 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 707525 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 707526 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 707526 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 707527 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 707527 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 707528 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 707529 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 707529 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 707530 INFO (zkCallback-638-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 707531 INFO (zkCallback-638-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> 707532 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 707532 INFO (zkCallback-638-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> 707533 INFO (zkCallback-638-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 707533 INFO (zkCallback-638-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> 707538 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39740 39740
[junit4] 2> 707659 INFO (Thread-1746) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39740 39740
[junit4] 2> 707662 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[F6DEF604DC6FDB52]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 707663 INFO (SUITE-ZkStateReaderTest-seed#[F6DEF604DC6FDB52]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.overseer.ZkStateReaderTest_F6DEF604DC6FDB52-001
[junit4] 2> Jun 30, 2016 1:20:02 AM 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): {}, docValues:{}, maxPointsInLeafNode=1650, maxMBSortInHeap=6.027517893458983, sim=RandomSimilarity(queryNorm=true,coord=yes): {}, locale=es-VE, timezone=America/Nome
[junit4] 2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 1.8.0_74 (64-bit)/cpus=4,threads=1,free=283883584,total=529006592
[junit4] 2> NOTE: All tests run in this JVM: [TestIntervalFaceting, TestDynamicFieldResource, PKIAuthenticationIntegrationTest, TestGraphTermsQParserPlugin, TestFastLRUCache, TestFieldCacheWithThreads, RestartWhileUpdatingTest, DistanceUnitsTest, TestWordDelimiterFilterFactory, TestDownShardTolerantSearch, ClassificationUpdateProcessorFactoryTest, ZkSolrClientTest, TestSolrCoreProperties, TestQueryTypes, BigEndianAscendingWordSerializerTest, TestEmbeddedSolrServerConstructors, TestRawTransformer, NumericFieldsTest, CoreMergeIndexesAdminHandlerTest, TestMiniSolrCloudClusterBase, SpellPossibilityIteratorTest, TestBackupRepositoryFactory, DistributedFacetPivotSmallTest, TestImplicitCoreProperties, TestUseDocValuesAsStored, DistributedTermsComponentTest, LoggingHandlerTest, RankQueryTest, TermsComponentTest, TestUniqueKeyFieldResource, SoftAutoCommitTest, TestDocumentBuilder, SolrCmdDistributorTest, TestLeaderInitiatedRecoveryThread, OpenCloseCoreStressTest, SchemaVersionSpecificBehaviorTest, TestQueryUtils, TestOnReconnectListenerSupport, TestConfigSetProperties, TestLMJelinekMercerSimilarityFactory, TestSSLRandomization, TestDistributedGrouping, HdfsThreadLeakTest, BasicFunctionalityTest, TestClassicSimilarityFactory, TestOverriddenPrefixQueryForCustomFieldType, TestCursorMarkWithoutUniqueKey, SolrPluginUtilsTest, ConvertedLegacyTest, TestCustomSort, HttpPartitionTest, CdcrReplicationHandlerTest, UniqFieldsUpdateProcessorFactoryTest, TestDistributedStatsComponentCardinality, TestNRTOpen, TestBM25SimilarityFactory, ClusterStateUpdateTest, TestSolrConfigHandler, TestStressVersions, OverseerRolesTest, LeaderInitiatedRecoveryOnShardRestartTest, TestSurroundQueryParser, DistributedFacetPivotLargeTest, OpenExchangeRatesOrgProviderTest, TestSystemIdResolver, UpdateRequestProcessorFactoryTest, TestSchemaResource, NotRequiredUniqueKeyTest, MBeansHandlerTest, HdfsDirectoryTest, TestSolrConfigHandlerConcurrent, IndexBasedSpellCheckerTest, TestSolrDeletionPolicy2, SpellCheckCollatorTest, TestCodecSupport, ZkStateReaderTest]
[junit4] Completed [162/617 (1!)] on J1 in 2.04s, 6 tests, 1 error <<< FAILURES!
[...truncated 1442 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:740: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:684: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:59: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build.xml:233: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/common-build.xml:530: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/lucene/common-build.xml:1427: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/lucene/common-build.xml:984: There were test failures: 617 suites (10 ignored), 2597 tests, 1 error, 87 ignored (72 assumptions) [seed: F6DEF604DC6FDB52]
Total time: 67 minutes 38 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