Build: http://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/16557/ Java: 32bit/jdk1.8.0_72 -server -XX:+UseParallelGC
1 tests failed. FAILED: org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh Error Message: Could not find collection : c1 Stack Trace: org.apache.solr.common.SolrException: Could not find collection : c1 at __randomizedtesting.SeedInfo.seed([171A934ECAAA636D:8A0E2B91ACAA5A8]: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.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:41) 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 10685 lines...] [junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_171A934ECAAA636D-001/init-core-data-001 [junit4] 2> 173367 INFO (SUITE-ZkStateReaderTest-seed#[171A934ECAAA636D]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) [junit4] 2> 173368 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy [junit4] 2> 173369 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 173369 INFO (Thread-408) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 173369 INFO (Thread-408) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 173469 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.ZkTestServer start zk server on port:39598 [junit4] 2> 173469 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 173469 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 173472 INFO (zkCallback-193-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@135300f name:ZooKeeperConnection Watcher:127.0.0.1:39598 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 173472 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 173473 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 173474 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 173474 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 173475 INFO (zkCallback-194-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1494986 name:ZooKeeperConnection Watcher:127.0.0.1:39598 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 173475 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 173475 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 173475 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 173477 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 173478 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 173478 INFO (zkCallback-195-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1165610 name:ZooKeeperConnection Watcher:127.0.0.1:39598/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 173478 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 173479 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 173479 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 173480 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 173480 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 173481 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 173481 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 173481 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 173482 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 173482 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 173483 INFO (zkCallback-195-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 173483 INFO (zkCallback-195-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> 173484 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 173484 INFO (zkCallback-195-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> 173485 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39598 39598 [junit4] 2> 173622 INFO (Thread-408) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39598 39598 [junit4] 2> 173622 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy [junit4] 2> 173624 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay [junit4] 2> 173625 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 173625 INFO (Thread-409) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 173625 INFO (Thread-409) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 173725 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.ZkTestServer start zk server on port:38181 [junit4] 2> 173725 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 173725 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 173728 INFO (zkCallback-196-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4abb72 name:ZooKeeperConnection Watcher:127.0.0.1:38181 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 173728 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 173728 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 173729 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 173729 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 173731 INFO (zkCallback-197-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@e79604 name:ZooKeeperConnection Watcher:127.0.0.1:38181 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 173732 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 173732 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 173732 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 173733 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 173733 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 173734 INFO (zkCallback-198-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@f2d35e name:ZooKeeperConnection Watcher:127.0.0.1:38181/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 173734 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 173734 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 173735 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 173735 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 173736 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 173736 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 173737 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 173737 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 173737 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 173738 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1] [junit4] 2> 173738 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1] [junit4] 2> 173738 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 173738 INFO (zkCallback-198-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 173739 INFO (zkCallback-198-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> 173739 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 173739 INFO (zkCallback-198-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> 173740 INFO (zkCallback-198-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 173740 INFO (zkCallback-198-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> 173791 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38181 38181 [junit4] 2> 173921 INFO (Thread-409) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38181 38181 [junit4] 2> 173921 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[171A934ECAAA636D]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay [junit4] 2> 173923 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation [junit4] 2> 173923 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 173923 INFO (Thread-410) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 173923 INFO (Thread-410) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 174023 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.ZkTestServer start zk server on port:44685 [junit4] 2> 174023 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 174024 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 174034 INFO (zkCallback-199-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1e00342 name:ZooKeeperConnection Watcher:127.0.0.1:44685 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 174036 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 174037 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 174046 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 174046 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 174047 INFO (zkCallback-200-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1cad743 name:ZooKeeperConnection Watcher:127.0.0.1:44685 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 174047 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 174048 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 174048 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 174051 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 174052 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 174055 INFO (zkCallback-201-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@b4efce name:ZooKeeperConnection Watcher:127.0.0.1:44685/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 174056 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 174056 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 174056 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 174057 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 174058 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 174058 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 174059 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 174060 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 174061 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 174067 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1] [junit4] 2> 174067 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1] [junit4] 2> 174067 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 174068 INFO (zkCallback-201-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 174069 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 174069 INFO (zkCallback-201-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> 174070 INFO (zkCallback-201-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 174121 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44685 44685 [junit4] 2> 174127 INFO (Thread-410) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44685 44685 [junit4] 2> 174128 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[171A934ECAAA636D]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation [junit4] 2> 174130 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh [junit4] 2> 174130 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 174130 INFO (Thread-411) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 174130 INFO (Thread-411) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 174231 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.ZkTestServer start zk server on port:38197 [junit4] 2> 174231 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 174231 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 174233 INFO (zkCallback-202-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@12f9fc5 name:ZooKeeperConnection Watcher:127.0.0.1:38197 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 174233 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 174233 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 174233 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 174234 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 174234 INFO (zkCallback-203-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@645144 name:ZooKeeperConnection Watcher:127.0.0.1:38197 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 174234 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 174235 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 174235 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 174236 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 174236 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 174237 INFO (zkCallback-204-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@14a4c69 name:ZooKeeperConnection Watcher:127.0.0.1:38197/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 174237 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 174237 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 174237 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 174238 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 174238 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 174239 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 174239 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 174240 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 174240 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 174240 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1] [junit4] 2> 174241 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1] [junit4] 2> 174241 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 174241 INFO (zkCallback-204-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 174242 INFO (zkCallback-204-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> 174242 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 174243 INFO (zkCallback-204-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> 174243 INFO (zkCallback-204-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> 175743 WARN (zkCallback-204-thread-1) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /collections/c1/state.json] [junit4] 2> 175748 WARN (zkCallback-204-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> 175748 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38197 38197 [junit4] 2> 175770 INFO (Thread-411) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38197 38197 [junit4] 2> 175771 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[171A934ECAAA636D]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithExplicitRefresh -Dtests.seed=171A934ECAAA636D -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ms -Dtests.timezone=Africa/Gaborone -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [junit4] ERROR 1.65s J0 | ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh <<< [junit4] > Throwable #1: org.apache.solr.common.SolrException: Could not find collection : c1 [junit4] > at __randomizedtesting.SeedInfo.seed([171A934ECAAA636D:8A0E2B91ACAA5A8]: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.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:41) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] 2> 175775 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy [junit4] 2> 175776 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 175777 INFO (Thread-412) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 175777 INFO (Thread-412) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 175877 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.ZkTestServer start zk server on port:35502 [junit4] 2> 175878 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 175878 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 175880 INFO (zkCallback-205-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@190c2bb name:ZooKeeperConnection Watcher:127.0.0.1:35502 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 175881 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 175881 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 175881 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 175882 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 175883 INFO (zkCallback-206-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@179bb54 name:ZooKeeperConnection Watcher:127.0.0.1:35502 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 175883 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 175883 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 175883 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 175884 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 175885 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 175892 INFO (zkCallback-207-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@16dfd39 name:ZooKeeperConnection Watcher:127.0.0.1:35502/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 175892 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 175892 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 175892 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 175893 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 175893 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 175894 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 175894 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 175894 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 175895 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 175895 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 175896 INFO (zkCallback-207-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 175896 INFO (zkCallback-207-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> 175897 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 175897 INFO (zkCallback-207-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> 175898 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35502 35502 [junit4] 2> 175918 INFO (Thread-412) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35502 35502 [junit4] 2> 175919 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[171A934ECAAA636D]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy [junit4] 2> 175923 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched [junit4] 2> 175923 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 175923 INFO (Thread-413) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 175923 INFO (Thread-413) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 176023 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.ZkTestServer start zk server on port:41395 [junit4] 2> 176024 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 176024 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 176027 INFO (zkCallback-208-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@15c3afd name:ZooKeeperConnection Watcher:127.0.0.1:41395 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 176027 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 176027 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 176029 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 176029 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 176030 INFO (zkCallback-209-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@74b5d3 name:ZooKeeperConnection Watcher:127.0.0.1:41395 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 176030 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 176030 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 176031 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 176032 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 176032 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 176033 INFO (zkCallback-210-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@e35f12 name:ZooKeeperConnection Watcher:127.0.0.1:41395/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 176034 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 176034 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 176034 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 176036 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 176037 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 176037 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 176038 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 176038 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 176038 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 176039 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 176039 INFO (zkCallback-210-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 176040 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 176040 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1] [junit4] 2> 176041 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 176041 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.c.ZkStateReader Removing watch for uninteresting collection [c1] [junit4] 2> 176042 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:41395 41395 [junit4] 2> 176107 INFO (Thread-413) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:41395 41395 [junit4] 2> 176107 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[171A934ECAAA636D]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched [junit4] 2> 176108 INFO (SUITE-ZkStateReaderTest-seed#[171A934ECAAA636D]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_171A934ECAAA636D-001 [junit4] 2> Apr 21, 2016 10:17:53 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 6 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene60): {}, docValues:{}, maxPointsInLeafNode=1631, maxMBSortInHeap=4.456141026004228, sim=ClassicSimilarity, locale=ms, timezone=Africa/Gaborone [junit4] 2> NOTE: Linux 4.2.0-35-generic i386/Oracle Corporation 1.8.0_72 (32-bit)/cpus=12,threads=1,free=169931520,total=259522560 [junit4] 2> NOTE: All tests run in this JVM: [TestHighFrequencyDictionaryFactory, DistributedSpellCheckComponentTest, PathHierarchyTokenizerFactoryTest, DeleteLastCustomShardedReplicaTest, LeaderElectionIntegrationTest, TestLMDirichletSimilarityFactory, HdfsThreadLeakTest, TestHashQParserPlugin, FileBasedSpellCheckerTest, SolrCoreTest, SyncSliceTest, TestDFISimilarityFactory, TestPseudoReturnFields, TestSchemaNameResource, RankQueryTest, TestPhraseSuggestions, SuggestComponentTest, TestHighlightDedupGrouping, TestOmitPositions, SystemInfoHandlerTest, TestPivotHelperCode, ZkStateReaderTest] [junit4] Completed [54/590 (1!)] on J0 in 3.51s, 6 tests, 1 error <<< FAILURES! [...truncated 1737 lines...] BUILD FAILED /home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:740: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:684: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:59: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build.xml:233: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/common-build.xml:529: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1457: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1014: There were test failures: 590 suites (10 ignored), 2382 tests, 1 error, 114 ignored (70 assumptions) [seed: 171A934ECAAA636D] Total time: 58 minutes 46 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
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org