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/03/17 02:59:54 UTC
[JENKINS] Lucene-Solr-Tests-master - Build # 1005 - Still Failing
Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/1005/
1 tests failed.
FAILED: org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy
Error Message:
Could not find collection : c1
Stack Trace:
org.apache.solr.common.SolrException: Could not find collection : c1
at __randomizedtesting.SeedInfo.seed([8393AB73E30BACCC:E8DC0B0E9A0471F6]:0)
at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:135)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy(ZkStateReaderTest.java:46)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
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 10666 lines...]
[junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
[junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.overseer.ZkStateReaderTest_8393AB73E30BACCC-001/init-core-data-001
[junit4] 2> 140906 INFO (SUITE-ZkStateReaderTest-seed#[8393AB73E30BACCC]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 140913 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
[junit4] 2> 140913 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 140914 INFO (Thread-247) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 140914 INFO (Thread-247) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 141048 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.ZkTestServer start zk server on port:41831
[junit4] 2> 141049 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 141075 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 141095 INFO (zkCallback-78-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5758d0e name:ZooKeeperConnection Watcher:127.0.0.1:41831 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 141095 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 141096 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 141111 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 141127 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 141149 INFO (zkCallback-79-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4f2348bd name:ZooKeeperConnection Watcher:127.0.0.1:41831 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 141149 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 141149 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 141149 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 141168 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 141183 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 141203 INFO (zkCallback-80-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@9734de5 name:ZooKeeperConnection Watcher:127.0.0.1:41831/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 141203 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 141204 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 141204 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 141205 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 141206 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 141207 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 141208 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 141209 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 141210 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 141210 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
[junit4] 2> 141211 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 141211 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 141211 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 141216 INFO (zkCallback-80-thread-2) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 141234 INFO (zkCallback-80-thread-3) [ ] 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> 141239 INFO (zkCallback-80-thread-2) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 141264 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 141265 INFO (zkCallback-80-thread-3) [ ] 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> 141266 INFO (zkCallback-80-thread-3) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 141268 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:41831 41831
[junit4] 2> 141374 INFO (Thread-247) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:41831 41831
[junit4] 2> 141375 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[8393AB73E30BACCC]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
[junit4] 2> 141378 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 141378 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 141399 INFO (Thread-248) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 141399 INFO (Thread-248) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 141499 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.ZkTestServer start zk server on port:47128
[junit4] 2> 141499 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 141635 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 141673 INFO (zkCallback-81-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5e5b4154 name:ZooKeeperConnection Watcher:127.0.0.1:47128 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 141673 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 141674 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 141676 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 141696 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 141719 INFO (zkCallback-82-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@b5cf6b name:ZooKeeperConnection Watcher:127.0.0.1:47128 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 141719 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 141719 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 141719 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 141732 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 141755 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 141774 INFO (zkCallback-83-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7a419626 name:ZooKeeperConnection Watcher:127.0.0.1:47128/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 141774 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 141774 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 141775 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 141776 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 141777 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 141778 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 141779 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 141779 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 141780 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 141781 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
[junit4] 2> 141781 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 141781 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 141781 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 141782 INFO (zkCallback-83-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 141783 INFO (zkCallback-83-thread-1) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 141784 INFO (zkCallback-83-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> 141785 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 141786 INFO (zkCallback-83-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> 141786 INFO (zkCallback-83-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 141790 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:47128 47128
[junit4] 2> 141961 INFO (Thread-248) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:47128 47128
[junit4] 2> 141963 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[8393AB73E30BACCC]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 141965 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 141966 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 141971 INFO (Thread-249) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 141971 INFO (Thread-249) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 142071 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.ZkTestServer start zk server on port:35833
[junit4] 2> 142071 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 142091 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 142110 INFO (zkCallback-84-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5ac1f847 name:ZooKeeperConnection Watcher:127.0.0.1:35833 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 142110 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 142110 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 142112 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 142123 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 142147 INFO (zkCallback-85-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4dfe5709 name:ZooKeeperConnection Watcher:127.0.0.1:35833 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 142147 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 142147 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 142147 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 142150 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 142162 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 142188 INFO (zkCallback-86-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@59bd2fe3 name:ZooKeeperConnection Watcher:127.0.0.1:35833/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 142188 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 142188 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 142190 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 142191 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 142192 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 142193 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 142194 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 142196 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 142197 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 142197 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 142198 INFO (zkCallback-86-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 142199 INFO (zkCallback-86-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> 142200 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 142201 INFO (zkCallback-86-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> 142206 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35833 35833
[junit4] 2> 142326 INFO (Thread-249) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35833 35833
[junit4] 2> 142332 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 142336 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 142337 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 142337 INFO (Thread-250) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 142337 INFO (Thread-250) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 142437 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.ZkTestServer start zk server on port:42755
[junit4] 2> 142437 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 142459 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 142475 INFO (zkCallback-87-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7012ca9f name:ZooKeeperConnection Watcher:127.0.0.1:42755 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 142475 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 142476 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 142478 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 142495 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 142647 INFO (zkCallback-88-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@280d87fe name:ZooKeeperConnection Watcher:127.0.0.1:42755 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 142647 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 142648 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 142648 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 142650 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 142659 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 142683 INFO (zkCallback-89-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@52f90235 name:ZooKeeperConnection Watcher:127.0.0.1:42755/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 142683 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 142684 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 142684 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 142685 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 142686 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 142687 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 142688 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 142689 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 142690 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 142690 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 142693 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 142695 INFO (zkCallback-89-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 142695 WARN (zkCallback-89-thread-1) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /collections]
[junit4] 2> 142707 INFO (zkCallback-89-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> 142707 WARN (zkCallback-89-thread-2) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /clusterstate.json]
[junit4] 2> 142720 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42755 42755
[junit4] 2> 142893 INFO (Thread-250) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42755 42755
[junit4] 2> 142894 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[8393AB73E30BACCC]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithExplicitRefreshLazy -Dtests.seed=8393AB73E30BACCC -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=tr-TR -Dtests.timezone=Africa/Monrovia -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.57s J1 | ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy <<<
[junit4] > Throwable #1: org.apache.solr.common.SolrException: Could not find collection : c1
[junit4] > at __randomizedtesting.SeedInfo.seed([8393AB73E30BACCC:E8DC0B0E9A0471F6]:0)
[junit4] > at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
[junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:135)
[junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy(ZkStateReaderTest.java:46)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 142900 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
[junit4] 2> 142901 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 142911 INFO (Thread-251) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 142911 INFO (Thread-251) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 143088 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.ZkTestServer start zk server on port:34786
[junit4] 2> 143088 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 143151 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 143155 INFO (zkCallback-90-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@43418cdf name:ZooKeeperConnection Watcher:127.0.0.1:34786 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 143155 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 143156 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 143158 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 143167 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 143189 INFO (zkCallback-91-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5085aaa6 name:ZooKeeperConnection Watcher:127.0.0.1:34786 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 143189 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 143189 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 143189 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 143192 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 143207 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 143235 INFO (zkCallback-92-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3e285007 name:ZooKeeperConnection Watcher:127.0.0.1:34786/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 143235 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 143236 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 143236 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 143237 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 143238 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 143239 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 143240 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 143241 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 143242 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 143243 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 143243 INFO (zkCallback-92-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 143244 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 143245 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
[junit4] 2> 143245 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 143245 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.c.ZkStateReader Removing watch for uninteresting collection [c1]
[junit4] 2> 143253 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34786 34786
[junit4] 2> 143377 INFO (Thread-251) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34786 34786
[junit4] 2> 143387 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[8393AB73E30BACCC]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
[junit4] 2> 143388 INFO (SUITE-ZkStateReaderTest-seed#[8393AB73E30BACCC]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.overseer.ZkStateReaderTest_8393AB73E30BACCC-001
[junit4] 2> Mar 17, 2016 1:25:20 AM 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=1079, maxMBSortInHeap=5.315658611212838, sim=RandomSimilarity(queryNorm=false,coord=yes): {}, locale=tr-TR, timezone=Africa/Monrovia
[junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_66 (64-bit)/cpus=4,threads=1,free=64533128,total=301465600
[junit4] 2> NOTE: All tests run in this JVM: [TestFiltering, SimpleCollectionCreateDeleteTest, AsyncMigrateRouteKeyTest, DistributedIntervalFacetingTest, ZkStateReaderTest]
[junit4] Completed [32/580 (1!)] on J1 in 3.09s, 5 tests, 1 error <<< FAILURES!
[...truncated 1775 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:740: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:684: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:59: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build.xml:233: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/common-build.xml:526: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:1457: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:1014: There were test failures: 580 suites (10 ignored), 2318 tests, 1 error, 86 ignored (70 assumptions) [seed: 8393AB73E30BACCC]
Total time: 58 minutes 18 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