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-6.x - Build # 243 - Failure
Date Wed, 01 Jun 2016 22:32:56 GMT
Build: https://builds.apache.org/job/Lucene-Solr-Tests-6.x/243/

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([9D9AACC87084909C:E2041B4D19E6BD16]:0)
	at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:192)
	at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:130)
	at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay(ZkStateReaderTest.java:52)
	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 12128 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/J0/temp/solr.cloud.overseer.ZkStateReaderTest_9D9AACC87084909C-001/init-core-data-001
   [junit4]   2> 2006589 INFO  (SUITE-ZkStateReaderTest-seed#[9D9AACC87084909C]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true)
   [junit4]   2> 2006594 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 2006594 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2006594 INFO  (Thread-6790) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2006594 INFO  (Thread-6790) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 2006694 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.ZkTestServer start zk server on port:56053
   [junit4]   2> 2006694 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2006695 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2006698 INFO  (zkCallback-2754-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2384752e name:ZooKeeperConnection Watcher:127.0.0.1:56053 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2006698 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2006698 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2006699 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2006700 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2006701 INFO  (zkCallback-2755-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1563b447 name:ZooKeeperConnection Watcher:127.0.0.1:56053 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2006701 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2006701 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2006701 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 2006707 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2006708 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2006708 INFO  (zkCallback-2756-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@157d2381 name:ZooKeeperConnection Watcher:127.0.0.1:56053/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2006708 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2006709 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2006709 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 2006710 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 2006710 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 2006711 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 2006712 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 2006712 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 2006712 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 2006713 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 2006713 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 2006714 INFO  (zkCallback-2756-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 2006715 INFO  (zkCallback-2756-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> 2006716 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 2006716 INFO  (zkCallback-2756-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> 2006718 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:56053 56053
   [junit4]   2> 2007035 INFO  (Thread-6790) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:56053 56053
   [junit4]   2> 2007036 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 2007040 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> 2007041 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2007041 INFO  (Thread-6791) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2007041 INFO  (Thread-6791) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 2007141 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.ZkTestServer start zk server on port:51812
   [junit4]   2> 2007141 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2007142 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2007144 INFO  (zkCallback-2758-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3ccdefe7 name:ZooKeeperConnection Watcher:127.0.0.1:51812 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2007145 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2007145 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2007146 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2007146 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2007147 INFO  (zkCallback-2759-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@30821d7d name:ZooKeeperConnection Watcher:127.0.0.1:51812 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2007147 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2007147 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2007147 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 2007150 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2007151 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2007151 INFO  (zkCallback-2760-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@fea6e4f name:ZooKeeperConnection Watcher:127.0.0.1:51812/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2007151 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2007152 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2007152 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 2007153 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 2007154 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 2007154 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 2007155 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 2007156 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 2007156 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 2007156 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 2007157 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 2007158 INFO  (zkCallback-2760-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 2007159 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 2007160 INFO  (zkCallback-2760-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> 2007162 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:51812 51812
   [junit4]   2> 2008373 INFO  (Thread-6791) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:51812 51812
   [junit4]   2> 2008374 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9D9AACC87084909C]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> 2008376 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 2008377 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2008377 INFO  (Thread-6792) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2008377 INFO  (Thread-6792) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 2008477 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.ZkTestServer start zk server on port:46143
   [junit4]   2> 2008477 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2008478 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2008479 INFO  (zkCallback-2762-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7eac2235 name:ZooKeeperConnection Watcher:127.0.0.1:46143 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2008479 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2008480 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2008480 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2008480 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2008481 INFO  (zkCallback-2763-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@9a5736 name:ZooKeeperConnection Watcher:127.0.0.1:46143 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2008481 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2008481 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2008481 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 2008483 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2008483 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2008484 INFO  (zkCallback-2764-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@8fdd651 name:ZooKeeperConnection Watcher:127.0.0.1:46143/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2008484 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2008484 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2008484 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 2008485 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 2008485 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 2008486 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 2008486 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 2008487 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 2008487 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 2008488 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 2008488 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 2008489 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 2008489 INFO  (zkCallback-2764-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 2008490 INFO  (zkCallback-2764-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> 2008490 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 2008491 INFO  (zkCallback-2764-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> 2008491 INFO  (zkCallback-2764-thread-1) [    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 2008491 INFO  (zkCallback-2764-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> 2008492 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:46143 46143
   [junit4]   2> 2008762 INFO  (Thread-6792) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:46143 46143
   [junit4]   2> 2008763 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9D9AACC87084909C]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 2008765 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
   [junit4]   2> 2008766 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2008766 INFO  (Thread-6793) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2008766 INFO  (Thread-6793) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 2008866 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.ZkTestServer start zk server on port:57240
   [junit4]   2> 2008866 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2008866 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2008868 INFO  (zkCallback-2766-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3a33d838 name:ZooKeeperConnection Watcher:127.0.0.1:57240 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2008868 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2008868 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2008868 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2008869 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2008869 INFO  (zkCallback-2767-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@17c40c18 name:ZooKeeperConnection Watcher:127.0.0.1:57240 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2008869 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2008869 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2008869 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 2008871 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2008871 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2008872 INFO  (zkCallback-2768-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@64ce1e92 name:ZooKeeperConnection Watcher:127.0.0.1:57240/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2008872 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2008872 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2008872 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 2008873 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 2008879 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 2008880 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 2008880 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 2008880 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 2008881 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 2008881 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 2008882 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 2008885 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 2008886 INFO  (zkCallback-2768-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 2008887 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 2008887 INFO  (zkCallback-2768-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> 2008887 INFO  (zkCallback-2768-thread-1) [    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 2008938 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57240 57240
   [junit4]   2> 2009144 INFO  (Thread-6793) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57240 57240
   [junit4]   2> 2009146 INFO  (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9D9AACC87084909C]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
   [junit4]   2> 2009149 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
   [junit4]   2> 2009149 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2009150 INFO  (Thread-6794) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2009150 INFO  (Thread-6794) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 2009250 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.ZkTestServer start zk server on port:48623
   [junit4]   2> 2009250 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2009250 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2009252 INFO  (zkCallback-2770-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@775dd280 name:ZooKeeperConnection Watcher:127.0.0.1:48623 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2009252 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2009252 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2009253 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2009253 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2009253 INFO  (zkCallback-2771-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@27a3bc27 name:ZooKeeperConnection Watcher:127.0.0.1:48623 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2009254 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2009254 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2009254 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 2009255 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2009256 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2009256 INFO  (zkCallback-2772-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1242269a name:ZooKeeperConnection Watcher:127.0.0.1:48623/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2009256 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2009269 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2009270 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 2009270 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 2009271 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 2009271 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 2009272 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 2009273 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 2009273 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 2009273 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 2009274 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 2009274 INFO  (zkCallback-2772-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 2009275 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 2009276 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 2009277 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:48623 48623
   [junit4]   2> 2009471 INFO  (Thread-6794) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:48623 48623
   [junit4]   2> 2009472 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9D9AACC87084909C]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
   [junit4]   2> 2009475 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
   [junit4]   2> 2009475 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2009475 INFO  (Thread-6795) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2009475 INFO  (Thread-6795) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 2009575 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.ZkTestServer start zk server on port:35251
   [junit4]   2> 2009575 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2009576 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2009577 INFO  (zkCallback-2774-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@24a1c53b name:ZooKeeperConnection Watcher:127.0.0.1:35251 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2009577 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2009578 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2009578 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2009578 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2009579 INFO  (zkCallback-2775-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@65f49fa2 name:ZooKeeperConnection Watcher:127.0.0.1:35251 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2009579 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2009579 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2009579 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 2009581 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2009581 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2009582 INFO  (zkCallback-2776-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@50294e97 name:ZooKeeperConnection Watcher:127.0.0.1:35251/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2009582 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2009582 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2009582 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 2009583 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 2009583 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 2009584 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 2009585 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 2009585 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 2009585 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 2009586 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 2009587 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 2009589 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 2009592 INFO  (zkCallback-2776-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 2009593 INFO  (zkCallback-2776-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> 2009643 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 2009644 INFO  (zkCallback-2776-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> 2009644 INFO  (zkCallback-2776-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> 2009644 INFO  (zkCallback-2776-thread-2) [    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 2009645 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35251 35251
   [junit4]   2> 2009840 INFO  (Thread-6795) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35251 35251
   [junit4]   2> 2009841 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9D9AACC87084909C]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithTimeDelay -Dtests.seed=9D9AACC87084909C -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=sr-RS -Dtests.timezone=Europe/Jersey -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.37s J0 | ZkStateReaderTest.testStateFormatUpdateWithTimeDelay <<<
   [junit4]    > Throwable #1: org.apache.solr.common.SolrException: Could not find collection : c1
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([9D9AACC87084909C:E2041B4D19E6BD16]:0)
   [junit4]    > 	at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:192)
   [junit4]    > 	at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:130)
   [junit4]    > 	at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay(ZkStateReaderTest.java:52)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2009845 INFO  (SUITE-ZkStateReaderTest-seed#[9D9AACC87084909C]-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/J0/temp/solr.cloud.overseer.ZkStateReaderTest_9D9AACC87084909C-001
   [junit4]   2> Jun 01, 2016 10:19:01 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=Asserting(Lucene60): {}, docValues:{}, maxPointsInLeafNode=1286, maxMBSortInHeap=5.061370634273344, sim=RandomSimilarity(queryNorm=true,coord=yes): {}, locale=sr-RS, timezone=Europe/Jersey
   [junit4]   2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 1.8.0_74 (64-bit)/cpus=4,threads=1,free=220262968,total=519569408
   [junit4]   2> NOTE: All tests run in this JVM: [FileBasedSpellCheckerTest, SystemInfoHandlerTest, ConnectionReuseTest, TestArbitraryIndexDir, SignatureUpdateProcessorFactoryTest, TestUniqueKeyFieldResource, TestManagedSchemaAPI, FacetPivotSmallTest, TestInfoStreamLogging, TestFastOutputStream, OverseerTaskQueueTest, PingRequestHandlerTest, DistributedFacetPivotSmallAdvancedTest, BitVectorTest, PolyFieldTest, TestRangeQuery, StandardRequestHandlerTest, BadCopyFieldTest, TestPhraseSuggestions, TestConfigSets, CheckHdfsIndexTest, LeaderElectionIntegrationTest, TestRemoteStreaming, TriLevelCompositeIdRoutingTest, HdfsLockFactoryTest, DocValuesMissingTest, ForceLeaderTest, DistributedQueryComponentCustomSortTest, IndexSchemaRuntimeFieldTest, TestLRUCache, BasicZkTest, URLClassifyProcessorTest, DefaultValueUpdateProcessorTest, SSLMigrationTest, TestChildDocTransformer, TestLuceneMatchVersion, TestRealTimeGet, TestSerializedLuceneMatchVersion, TestBinaryField, TestFoldingMultitermQuery, TestStressUserVersions, TestSolr4Spatial, TestReplicationHandler, TestCSVLoader, TestHighlightDedupGrouping, TestReRankQParserPlugin, TestLRUStatsCache, TestLegacyFieldCache, TestCollapseQParserPlugin, TestUninvertingReader, SuggestComponentTest, MultiThreadedOCPTest, TestStressLucene, TestTolerantUpdateProcessorCloud, RequiredFieldsTest, TestPseudoReturnFields, XsltUpdateRequestHandlerTest, DocumentAnalysisRequestHandlerTest, CdcrVersionReplicationTest, TestRandomFaceting, CursorPagingTest, TestRTGBase, CacheHeaderTest, TestSolr4Spatial2, SolrRequestParserTest, TestBadConfig, TestConfigSetsAPIExclusivity, TestUseDocValuesAsStored2, DistributedQueryElevationComponentTest, TestCloudBackupRestore, HdfsRecoveryZkTest, TestRandomDVFaceting, ResponseLogComponentTest, TestSubQueryTransformerDistrib, AnalysisAfterCoreReloadTest, TestRawTransformer, TestFieldSortValues, JsonLoaderTest, SolrCoreTest, DisMaxRequestHandlerTest, DeleteLastCustomShardedReplicaTest, DistributedExpandComponentTest, BlockJoinFacetRandomTest, DistributedSpellCheckComponentTest, TestComponentsName, SyncSliceTest, SecurityConfHandlerTest, CollectionTooManyReplicasTest, TolerantUpdateProcessorTest, CreateCollectionCleanupTest, CloudMLTQParserTest, TestBlobHandler, TestOnReconnectListenerSupport, SOLR749Test, RAMDirectoryFactoryTest, TestCrossCoreJoin, TestPerFieldSimilarityWithDefaultOverride, TestCloudSchemaless, ParsingFieldUpdateProcessorsTest, TestDynamicFieldResource, TestSolrConfigHandlerCloud, BasicDistributedZkTest, ShardRoutingTest, TestZkChroot, ShardRoutingCustomTest, TestDistributedSearch, ReturnFieldsTest, MBeansHandlerTest, BinaryUpdateRequestHandlerTest, TestLFUCache, AssignTest, AsyncCallRequestStatusResponseTest, CdcrReplicationDistributedZkTest, CdcrReplicationHandlerTest, CdcrRequestHandlerTest, CloudExitableDirectoryReaderTest, CollectionStateFormat2Test, ConcurrentDeleteAndCreateCollectionTest, ConnectionManagerTest, DeleteShardTest, DeleteStatusTest, DistributedVersionInfoTest, LeaderInitiatedRecoveryOnShardRestartTest, OverriddenZkACLAndCredentialsProvidersTest, OverseerStatusTest, RemoteQueryErrorTest, SharedFSAutoReplicaFailoverTest, SolrCloudExampleTest, TestConfigSetsAPI, TestConfigSetsAPIZkFailure, TestDistribDocBasedVersion, TestMiniSolrCloudCluster, TestReplicaProperties, TestSSLRandomization, TestSolrCloudWithKerberosAlt, HdfsChaosMonkeyNothingIsSafeTest, HdfsNNFailoverTest, HdfsTlogReplayBufferedWhileIndexingTest, HdfsUnloadDistributedZkTest, ZkStateReaderTest]
   [junit4] Completed [495/612 (1!)] on J0 in 4.03s, 6 tests, 1 error <<< FAILURES!

[...truncated 402 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:531: 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: 612 suites (10 ignored), 2564 tests, 1 error, 87 ignored (72 assumptions) [seed: 9D9AACC87084909C]

Total time: 72 minutes 28 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