You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2016/04/09 14:59:18 UTC
[JENKINS] Lucene-Solr-6.x-Linux (32bit/jdk1.8.0_72) - Build # 379 -
Still Failing!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Linux/379/
Java: 32bit/jdk1.8.0_72 -client -XX:+UseConcMarkSweepGC
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([7764B608C8DF48EB:1C2B1675B1D095D1]:0)
at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:135)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy(ZkStateReaderTest.java:46)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 10637 lines...]
[junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_7764B608C8DF48EB-001/init-core-data-001
[junit4] 2> 6732 INFO (SUITE-ZkStateReaderTest-seed#[7764B608C8DF48EB]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 6734 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 6749 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 6751 INFO (Thread-20) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 6751 INFO (Thread-20) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 6850 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.ZkTestServer start zk server on port:44812
[junit4] 2> 6865 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 6914 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 6956 INFO (zkCallback-11-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@13ee4c5 name:ZooKeeperConnection Watcher:127.0.0.1:44812 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 6956 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 6956 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 6973 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 6973 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 6979 INFO (zkCallback-12-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1027f19 name:ZooKeeperConnection Watcher:127.0.0.1:44812 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 6979 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 6980 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 6981 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 7002 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 7003 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7005 INFO (zkCallback-13-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@190ff72 name:ZooKeeperConnection Watcher:127.0.0.1:44812/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 7005 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7005 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 7039 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 7042 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 7045 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 7047 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 7050 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 7070 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 7086 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 7094 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 7097 INFO (zkCallback-13-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 7114 INFO (zkCallback-13-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> 7123 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 7125 INFO (zkCallback-13-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> 7130 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44812 44812
[junit4] 2> 7146 INFO (Thread-20) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44812 44812
[junit4] 2> 7175 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 7179 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
[junit4] 2> 7180 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 7180 INFO (Thread-21) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 7180 INFO (Thread-21) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 7281 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.ZkTestServer start zk server on port:35584
[junit4] 2> 7281 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 7282 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7286 INFO (zkCallback-14-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@e21371 name:ZooKeeperConnection Watcher:127.0.0.1:35584 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 7286 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7287 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 7294 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 7302 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7309 INFO (zkCallback-15-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1bad830 name:ZooKeeperConnection Watcher:127.0.0.1:35584 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 7309 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7309 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 7309 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 7314 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 7315 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7316 INFO (zkCallback-16-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@831ea8 name:ZooKeeperConnection Watcher:127.0.0.1:35584/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 7316 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7317 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 7318 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 7320 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 7322 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 7325 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 7326 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 7328 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 7332 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 7335 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 7337 INFO (zkCallback-16-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 7340 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 7345 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
[junit4] 2> 7347 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 7348 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ZkStateReader Removing watch for uninteresting collection [c1]
[junit4] 2> 7349 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35584 35584
[junit4] 2> 7356 INFO (Thread-21) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35584 35584
[junit4] 2> 7357 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7764B608C8DF48EB]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
[junit4] 2> 7360 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
[junit4] 2> 7360 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 7360 INFO (Thread-22) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 7360 INFO (Thread-22) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 7460 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.ZkTestServer start zk server on port:34809
[junit4] 2> 7461 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 7464 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7484 INFO (zkCallback-17-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@106f988 name:ZooKeeperConnection Watcher:127.0.0.1:34809 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 7484 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7484 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 7496 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 7502 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7508 INFO (zkCallback-18-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@366718 name:ZooKeeperConnection Watcher:127.0.0.1:34809 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 7508 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7508 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 7509 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 7512 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 7513 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7532 INFO (zkCallback-19-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@12e39b5 name:ZooKeeperConnection Watcher:127.0.0.1:34809/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 7532 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7533 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 7536 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 7539 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 7542 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 7546 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 7552 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 7553 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 7555 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 7557 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
[junit4] 2> 7558 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 7559 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 7559 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 7563 INFO (zkCallback-19-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 7564 INFO (zkCallback-19-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> 7565 INFO (zkCallback-19-thread-1) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 7617 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 7636 INFO (zkCallback-19-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> 7638 INFO (zkCallback-19-thread-2) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 7701 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34809 34809
[junit4] 2> 7719 INFO (Thread-22) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34809 34809
[junit4] 2> 7719 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7764B608C8DF48EB]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
[junit4] 2> 7722 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 7722 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 7722 INFO (Thread-23) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 7722 INFO (Thread-23) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 7825 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.ZkTestServer start zk server on port:36322
[junit4] 2> 7825 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 7828 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7842 INFO (zkCallback-20-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1223a95 name:ZooKeeperConnection Watcher:127.0.0.1:36322 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 7843 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7844 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 7845 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 7845 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7849 INFO (zkCallback-21-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1e1c6c0 name:ZooKeeperConnection Watcher:127.0.0.1:36322 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 7849 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7849 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 7849 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 7866 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 7866 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 7868 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x153faf9c0440001, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 7892 INFO (zkCallback-22-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@408ce2 name:ZooKeeperConnection Watcher:127.0.0.1:36322/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 7892 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 7893 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 7894 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 7897 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 7899 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 7903 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 7905 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 7906 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 7908 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 7909 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 7917 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 7927 INFO (zkCallback-22-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> 7928 INFO (zkCallback-22-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 7929 WARN (zkCallback-22-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> 7931 WARN (zkCallback-22-thread-1) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /collections]
[junit4] 2> 7935 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36322 36322
[junit4] 2> 7989 INFO (Thread-23) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36322 36322
[junit4] 2> 7990 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7764B608C8DF48EB]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithExplicitRefreshLazy -Dtests.seed=7764B608C8DF48EB -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=es-VE -Dtests.timezone=Asia/Jakarta -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.28s J0 | ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy <<<
[junit4] > Throwable #1: org.apache.solr.common.SolrException: Could not find collection : c1
[junit4] > at __randomizedtesting.SeedInfo.seed([7764B608C8DF48EB:1C2B1675B1D095D1]: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> 8006 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 8008 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 8008 INFO (Thread-24) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 8008 INFO (Thread-24) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 8108 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.ZkTestServer start zk server on port:40897
[junit4] 2> 8108 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 8109 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 8111 INFO (zkCallback-23-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1a974d7 name:ZooKeeperConnection Watcher:127.0.0.1:40897 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 8112 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 8112 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 8115 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 8115 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 8125 INFO (zkCallback-24-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@11d40e6 name:ZooKeeperConnection Watcher:127.0.0.1:40897 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 8126 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 8126 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 8126 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 8134 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 8134 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 8146 INFO (zkCallback-25-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1d1f05a name:ZooKeeperConnection Watcher:127.0.0.1:40897/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 8146 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 8146 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 8151 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 8154 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 8158 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 8164 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 8166 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 8169 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 8172 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 8173 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
[junit4] 2> 8174 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 8176 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 8176 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 8180 INFO (zkCallback-25-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 8180 INFO (zkCallback-25-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> 8184 INFO (zkCallback-25-thread-1) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 8186 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 8192 INFO (zkCallback-25-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> 8194 INFO (zkCallback-25-thread-2) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 8196 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:40897 40897
[junit4] 2> 8217 INFO (Thread-24) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:40897 40897
[junit4] 2> 8218 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7764B608C8DF48EB]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 8221 INFO (SUITE-ZkStateReaderTest-seed#[7764B608C8DF48EB]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_7764B608C8DF48EB-001
[junit4] 2> Apr 09, 2016 12:23:05 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 5 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene60): {}, docValues:{}, maxPointsInLeafNode=1228, maxMBSortInHeap=4.61602744264616, sim=RandomSimilarity(queryNorm=true,coord=crazy): {}, locale=es-VE, timezone=Asia/Jakarta
[junit4] 2> NOTE: Linux 4.2.0-34-generic i386/Oracle Corporation 1.8.0_72 (32-bit)/cpus=12,threads=1,free=12756504,total=31592448
[junit4] 2> NOTE: All tests run in this JVM: [TestNRTOpen, EnumFieldTest, TestRTGBase, SystemInfoHandlerTest, ChangedSchemaMergeTest, TestCustomSort, ZkStateReaderTest]
[junit4] Completed [12/585 (1!)] on J0 in 2.04s, 5 tests, 1 error <<< FAILURES!
[...truncated 1865 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/build.xml:740: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/build.xml:684: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/build.xml:59: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build.xml:233: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/common-build.xml:529: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/lucene/common-build.xml:1457: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/lucene/common-build.xml:1014: There were test failures: 585 suites (10 ignored), 2363 tests, 1 error, 114 ignored (70 assumptions) [seed: 7764B608C8DF48EB]
Total time: 71 minutes 0 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any