Build: https://builds.apache.org/job/Lucene-Solr-Tests-5.5-Java8/41/
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([13372E0D4F154FDF:C8D5FFA9F75891A]:0) at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170) at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:136) at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:42) 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 11286 lines...] [junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J2/temp/solr.cloud.overseer.ZkStateReaderTest_13372E0D4F154FDF-001/init-core-data-001 [junit4] 2> 832711 INFO (SUITE-ZkStateReaderTest-seed#[13372E0D4F154FDF]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) [junit4] 2> 832712 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched [junit4] 2> 832712 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 832718 INFO (Thread-2098) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 832718 INFO (Thread-2098) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 832818 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.ZkTestServer start zk server on port:59437 [junit4] 2> 832818 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 832822 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 832824 INFO (zkCallback-693-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@69c18f10 name:ZooKeeperConnection Watcher:127.0.0.1:59437 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 832824 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 832824 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 832825 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 832825 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 832826 INFO (zkCallback-694-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@18164705 name:ZooKeeperConnection Watcher:127.0.0.1:59437 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 832826 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 832826 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 832826 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 832833 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 832838 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 832841 INFO (zkCallback-695-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@65dc882c name:ZooKeeperConnection Watcher:127.0.0.1:59437/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 832841 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 832842 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 832842 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 832843 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 832843 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 832844 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 832844 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 832845 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 832846 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 832847 INFO (zkCallback-695-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 832847 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 832851 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1] [junit4] 2> 832852 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 832852 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ZkStateReader Removing watch for uninteresting collection [c1] [junit4] 2> 832853 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:59437 59437 [junit4] 2> 832974 INFO (Thread-2098) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:59437 59437 [junit4] 2> 832978 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[13372E0D4F154FDF]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched [junit4] 2> 832980 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy [junit4] 2> 832981 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 832986 INFO (Thread-2099) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 832986 INFO (Thread-2099) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 833086 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.ZkTestServer start zk server on port:51049 [junit4] 2> 833086 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 833087 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 833089 INFO (zkCallback-696-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@20e00b43 name:ZooKeeperConnection Watcher:127.0.0.1:51049 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 833089 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 833090 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 833091 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 833091 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 833093 INFO (zkCallback-697-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@74f5fe2a name:ZooKeeperConnection Watcher:127.0.0.1:51049 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 833093 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 833093 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 833093 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 833095 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 833095 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 833098 INFO (zkCallback-698-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2d91a411 name:ZooKeeperConnection Watcher:127.0.0.1:51049/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 833098 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 833098 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 833099 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 833099 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 833100 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 833100 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 833101 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 833104 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 833105 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 833106 INFO (zkCallback-698-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 833106 INFO (zkCallback-698-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> 833107 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 833111 INFO (zkCallback-698-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> 833113 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:51049 51049 [junit4] 2> 833277 INFO (Thread-2099) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:51049 51049 [junit4] 2> 833278 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy [junit4] 2> 833280 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay [junit4] 2> 833280 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 833280 INFO (Thread-2100) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 833280 INFO (Thread-2100) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 833380 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.ZkTestServer start zk server on port:51492 [junit4] 2> 833380 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 833381 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 833384 INFO (zkCallback-699-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@13a2fb4c name:ZooKeeperConnection Watcher:127.0.0.1:51492 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 833384 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 833384 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 833385 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 833386 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 833387 INFO (zkCallback-700-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@18f07394 name:ZooKeeperConnection Watcher:127.0.0.1:51492 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 833387 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 833387 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 833388 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 833390 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 833390 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 833399 INFO (zkCallback-701-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@ca533d name:ZooKeeperConnection Watcher:127.0.0.1:51492/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 833399 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 833400 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 833400 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 833401 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 833402 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 833402 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 833403 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 833403 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 833404 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1] [junit4] 2> 833405 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1] [junit4] 2> 833405 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 833406 INFO (zkCallback-701-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 833410 INFO (zkCallback-701-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> 833460 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 833461 INFO (zkCallback-701-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for collection [c1] has occurred - updating... (live nodes size: [0]) [junit4] 2> 833461 INFO (zkCallback-701-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> 833461 INFO (zkCallback-701-thread-2) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 833463 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:51492 51492 [junit4] 2> 833604 INFO (Thread-2100) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:51492 51492 [junit4] 2> 833607 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[13372E0D4F154FDF]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay [junit4] 2> 833614 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh [junit4] 2> 833614 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 833616 INFO (Thread-2101) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 833616 INFO (Thread-2101) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 833716 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.ZkTestServer start zk server on port:55228 [junit4] 2> 833716 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 833717 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 833723 INFO (zkCallback-702-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@72da1b89 name:ZooKeeperConnection Watcher:127.0.0.1:55228 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 833723 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 833723 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 833725 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 833729 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 833729 INFO (zkCallback-703-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@50e75482 name:ZooKeeperConnection Watcher:127.0.0.1:55228 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 833729 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 833729 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 833729 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 833733 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 833737 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 833737 INFO (zkCallback-704-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5466246 name:ZooKeeperConnection Watcher:127.0.0.1:55228/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 833737 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 833737 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 833737 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 833738 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 833738 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 833739 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 833739 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 833740 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 833740 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1] [junit4] 2> 833741 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1] [junit4] 2> 833741 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 833747 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 833748 ERROR (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]-EventThread) [ ] o.a.z.ClientCnxn Error while calling watcher [junit4] 2> java.util.concurrent.RejectedExecutionException: Task org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1@7da54c2e rejected from org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@32c4337a[Shutting down, pool size = 3, active threads = 3, queued tasks = 0, completed tasks = 0] [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2047) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:823) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1369) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.execute(ExecutorUtil.java:214) [junit4] 2> at java.util.concurrent.AbstractExecutorService.submit(AbstractExecutorService.java:112) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$3.process(SolrZkClient.java:261) [junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522) [junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498) [junit4] 2> 833748 INFO (zkCallback-704-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> 833749 WARN (zkCallback-704-thread-3) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /clusterstate.json] [junit4] 2> 833749 INFO (zkCallback-704-thread-2) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 833749 WARN (zkCallback-704-thread-2) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /collections] [junit4] 2> 833758 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:55228 55228 [junit4] 2> 834211 INFO (Thread-2101) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:55228 55228 [junit4] 2> 834213 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[13372E0D4F154FDF]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithExplicitRefresh -Dtests.seed=13372E0D4F154FDF -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=ar-SD -Dtests.timezone=Africa/Timbuktu -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1 [junit4] ERROR 0.61s J2 | ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh <<< [junit4] > Throwable #1: org.apache.solr.common.SolrException: Could not find collection : c1 [junit4] > at __randomizedtesting.SeedInfo.seed([13372E0D4F154FDF:C8D5FFA9F75891A]:0) [junit4] > at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170) [junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:136) [junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:42) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] 2> 834219 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy [junit4] 2> 834219 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 834219 INFO (Thread-2102) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 834219 INFO (Thread-2102) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 834319 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.ZkTestServer start zk server on port:39435 [junit4] 2> 834320 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 834321 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 834322 INFO (zkCallback-705-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@bdc921f name:ZooKeeperConnection Watcher:127.0.0.1:39435 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 834322 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 834322 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 834327 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 834329 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 834330 INFO (zkCallback-706-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@db48b5a name:ZooKeeperConnection Watcher:127.0.0.1:39435 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 834330 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 834330 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 834330 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 834332 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 834334 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 834334 INFO (zkCallback-707-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@218b2e69 name:ZooKeeperConnection Watcher:127.0.0.1:39435/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 834334 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 834335 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 834335 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 834336 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 834336 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 834337 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 834337 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 834337 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 834338 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 834338 INFO (zkCallback-707-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 834339 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 834346 INFO (zkCallback-707-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> 834347 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39435 39435 [junit4] 2> 834514 INFO (Thread-2102) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39435 39435 [junit4] 2> 834515 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[13372E0D4F154FDF]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy [junit4] 2> 834517 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation [junit4] 2> 834517 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 834517 INFO (Thread-2103) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 834517 INFO (Thread-2103) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 834617 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.ZkTestServer start zk server on port:37163 [junit4] 2> 834617 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 834618 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 834619 INFO (zkCallback-708-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7f1d3d40 name:ZooKeeperConnection Watcher:127.0.0.1:37163 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 834620 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 834620 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 834622 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 834622 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 834626 INFO (zkCallback-709-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@a82156 name:ZooKeeperConnection Watcher:127.0.0.1:37163 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 834626 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 834626 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 834626 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 834634 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 834634 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 834635 INFO (zkCallback-710-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@73af976a name:ZooKeeperConnection Watcher:127.0.0.1:37163/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 834635 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 834635 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 834635 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 834636 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 834636 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 834637 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 834637 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 834638 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 834639 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1] [junit4] 2> 834639 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1] [junit4] 2> 834639 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 834640 INFO (zkCallback-710-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 834642 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 834643 INFO (zkCallback-710-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> 834643 INFO (zkCallback-710-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 834694 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37163 37163 [junit4] 2> 834866 INFO (Thread-2103) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37163 37163 [junit4] 2> 834866 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[13372E0D4F154FDF]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation [junit4] 2> 834867 INFO (SUITE-ZkStateReaderTest-seed#[13372E0D4F154FDF]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J2/temp/solr.cloud.overseer.ZkStateReaderTest_13372E0D4F154FDF-001 [junit4] 2> Jun 24, 2016 10:19:45 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(Lucene54): {}, docValues:{}, sim=RandomSimilarity(queryNorm=false,coord=yes): {}, locale=ar-SD, timezone=Africa/Timbuktu [junit4] 2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 1.8.0_74 (64-bit)/cpus=4,threads=1,free=163568000,total=534773760 [junit4] 2> NOTE: All tests run in this JVM: [RulesTest, TestMiniSolrCloudClusterSSL, TestExceedMaxTermLength, RecoveryAfterSoftCommitTest, BlockCacheTest, TestRestManager, TestSolrCLIRunExample, BigEndianAscendingWordSerializerTest, WrapperMergePolicyFactoryTest, TestFastWriter, TestScoreJoinQPScore, TestJsonFacets, TestBlobHandler, RecoveryZkTest, HdfsRecoverLeaseTest, BadComponentTest, TestIndexSearcher, SparseHLLTest, BadIndexSchemaTest, DistributedQueueTest, TestCoreDiscovery, TestConfigOverlay, TestUtils, DeleteReplicaTest, TestSolrDynamicMBean, TestReversedWildcardFilterFactory, TestSortByMinMaxFunction, HdfsSyncSliceTest, DirectUpdateHandlerOptimizeTest, HardAutoCommitTest, DebugComponentTest, SimpleFacetsTest, HdfsDirectoryTest, TestJettySolrRunner, TestUseDocValuesAsStored, TestSearchPerf, TestRecovery, AnalysisErrorHandlingTest, PreAnalyzedUpdateProcessorTest, SliceStateTest, DirectUpdateHandlerTest, NoCacheHeaderTest, TestSolrQueryParserResource, SpatialRPTFieldTypeTest, TestCollationField, CurrencyFieldXmlFileTest, TestJmxMonitoredMap, TestSortingResponseWriter, TestDefaultStatsCache, LeaderInitiatedRecoveryOnShardRestartTest, OverseerRolesTest, TestExclusionRuleCollectionAccess, FieldAnalysisRequestHandlerTest, TestExtendedDismaxParser, RegexBoostProcessorTest, ShowFileRequestHandlerTest, ConfigSetsAPITest, DistanceUnitsTest, TestManagedSynonymFilterFactory, TestCustomSort, TestReloadDeadlock, TestCSVResponseWriter, SolrTestCaseJ4Test, TestReload, FullSolrCloudDistribCmdsTest, SimpleMLTQParserTest, FullHLLTest, TestDistributedStatsComponentCardinality, HighlighterConfigTest, ZkStateReaderTest] [junit4] Completed [209/573 (1!)] on J2 in 2.95s, 6 tests, 1 error <<< FAILURES! [...truncated 1153 lines...] BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/build.xml:750: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/build.xml:694: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/build.xml:59: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build.xml:233: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/common-build.xml:534: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/lucene/common-build.xml:1477: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/lucene/common-build.xml:1033: There were test failures: 573 suites (7 ignored), 2319 tests, 1 error, 55 ignored (39 assumptions) [seed: 13372E0D4F154FDF] Total time: 65 minutes 11 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
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org