Build: https://builds.apache.org/job/Lucene-Solr-Tests-6.x/306/
1 tests failed. FAILED: org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy Error Message: Could not find collection : c1 Stack Trace: org.apache.solr.common.SolrException: Could not find collection : c1 at __randomizedtesting.SeedInfo.seed([21DF598BF56F242D:4A90F9F68C60F917]:0) at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:192) at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:129) at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy(ZkStateReaderTest.java:48) 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 12193 lines...] [junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.overseer.ZkStateReaderTest_21DF598BF56F242D-001/init-core-data-001 [junit4] 2> 1719089 INFO (SUITE-ZkStateReaderTest-seed#[21DF598BF56F242D]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN) [junit4] 2> 1719096 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched [junit4] 2> 1719096 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 1719097 INFO (Thread-4627) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 1719097 INFO (Thread-4627) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 1719197 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.ZkTestServer start zk server on port:49451 [junit4] 2> 1719197 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1719197 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1719198 INFO (zkCallback-2336-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6a4ce71b name:ZooKeeperConnection Watcher:127.0.0.1:49451 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1719198 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1719199 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1719199 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1719199 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1719200 INFO (zkCallback-2337-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@76521527 name:ZooKeeperConnection Watcher:127.0.0.1:49451 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1719200 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1719200 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1719200 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 1719202 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1719202 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1719202 INFO (zkCallback-2338-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3f50f166 name:ZooKeeperConnection Watcher:127.0.0.1:49451/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1719202 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1719203 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1719203 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 1719203 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 1719204 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 1719205 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 1719205 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 1719206 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 1719206 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 1719206 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 1719207 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 1719208 INFO (zkCallback-2338-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 1719208 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 1719209 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 1719210 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:49451 49451 [junit4] 2> 1719310 INFO (Thread-4627) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:49451 49451 [junit4] 2> 1719310 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[21DF598BF56F242D]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched [junit4] 2> 1719312 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay [junit4] 2> 1719312 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 1719312 INFO (Thread-4628) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 1719312 INFO (Thread-4628) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 1719412 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.ZkTestServer start zk server on port:41148 [junit4] 2> 1719412 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1719413 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1719414 INFO (zkCallback-2340-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@592cf80f name:ZooKeeperConnection Watcher:127.0.0.1:41148 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1719414 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1719414 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1719418 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1719418 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1719418 INFO (zkCallback-2341-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2da1569 name:ZooKeeperConnection Watcher:127.0.0.1:41148 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1719419 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1719419 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1719419 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 1719420 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1719422 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1719422 INFO (zkCallback-2342-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@12056bb9 name:ZooKeeperConnection Watcher:127.0.0.1:41148/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1719422 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1719422 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1719422 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 1719423 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 1719424 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 1719424 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 1719425 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 1719425 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 1719426 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 1719426 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 1719427 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1] [junit4] 2> 1719427 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 1719427 INFO (zkCallback-2342-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 1719428 INFO (zkCallback-2342-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> 1719429 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 1719429 INFO (zkCallback-2342-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> 1719430 INFO (zkCallback-2342-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> 1719430 INFO (zkCallback-2342-thread-2) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 1719431 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:41148 41148 [junit4] 2> 1719626 INFO (Thread-4628) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:41148 41148 [junit4] 2> 1719630 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[21DF598BF56F242D]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay [junit4] 2> 1719631 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh [junit4] 2> 1719632 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 1719632 INFO (Thread-4629) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 1719632 INFO (Thread-4629) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 1719732 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.ZkTestServer start zk server on port:56056 [junit4] 2> 1719732 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1719733 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1719738 INFO (zkCallback-2344-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4071ff9c name:ZooKeeperConnection Watcher:127.0.0.1:56056 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1719738 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1719738 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1719738 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1719739 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1719739 INFO (zkCallback-2345-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6440675b name:ZooKeeperConnection Watcher:127.0.0.1:56056 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1719739 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1719739 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1719739 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 1719741 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1719742 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1719746 INFO (zkCallback-2346-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@273198b8 name:ZooKeeperConnection Watcher:127.0.0.1:56056/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1719746 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1719746 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1719746 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 1719747 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 1719747 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 1719748 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 1719748 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 1719749 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 1719749 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 1719749 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 1719750 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1] [junit4] 2> 1719754 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 1719754 INFO (zkCallback-2346-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 1719758 INFO (zkCallback-2346-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> 1719758 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 1719758 INFO (zkCallback-2346-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> 1719758 INFO (zkCallback-2346-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> 1719759 INFO (zkCallback-2346-thread-2) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 1719760 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:56056 56056 [junit4] 2> 1719926 INFO (Thread-4629) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:56056 56056 [junit4] 2> 1719927 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[21DF598BF56F242D]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh [junit4] 2> 1719928 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy [junit4] 2> 1719929 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 1719929 INFO (Thread-4630) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 1719929 INFO (Thread-4630) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 1720029 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.ZkTestServer start zk server on port:42132 [junit4] 2> 1720029 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1720030 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1720031 INFO (zkCallback-2348-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@453138dd name:ZooKeeperConnection Watcher:127.0.0.1:42132 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1720032 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1720032 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1720033 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1720034 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1720034 INFO (zkCallback-2349-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4e3bf9e8 name:ZooKeeperConnection Watcher:127.0.0.1:42132 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1720034 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1720035 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1720035 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 1720036 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1720037 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1720038 INFO (zkCallback-2350-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@f6b20ed name:ZooKeeperConnection Watcher:127.0.0.1:42132/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1720038 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1720038 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1720038 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 1720040 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 1720041 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 1720042 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 1720042 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 1720043 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 1720043 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 1720043 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 1720044 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 1720045 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 1720046 INFO (zkCallback-2350-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 1720046 WARN (zkCallback-2350-thread-1) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /collections] [junit4] 2> 1720047 INFO (zkCallback-2350-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> 1720047 WARN (zkCallback-2350-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> 1720047 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42132 42132 [junit4] 2> 1720225 INFO (Thread-4630) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42132 42132 [junit4] 2> 1720226 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithExplicitRefreshLazy -Dtests.seed=21DF598BF56F242D -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=sr-ME -Dtests.timezone=America/El_Salvador -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [junit4] ERROR 0.30s J2 | ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy <<< [junit4] > Throwable #1: org.apache.solr.common.SolrException: Could not find collection : c1 [junit4] > at __randomizedtesting.SeedInfo.seed([21DF598BF56F242D:4A90F9F68C60F917]:0) [junit4] > at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:192) [junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:129) [junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy(ZkStateReaderTest.java:48) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] 2> 1720229 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy [junit4] 2> 1720229 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 1720229 INFO (Thread-4631) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 1720229 INFO (Thread-4631) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 1720329 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.ZkTestServer start zk server on port:38805 [junit4] 2> 1720329 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1720330 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1720332 INFO (zkCallback-2352-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@45722a0d name:ZooKeeperConnection Watcher:127.0.0.1:38805 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1720332 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1720332 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1720333 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1720333 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1720334 INFO (zkCallback-2353-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@204c4a0f name:ZooKeeperConnection Watcher:127.0.0.1:38805 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1720334 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1720334 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1720334 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 1720336 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1720336 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1720337 INFO (zkCallback-2354-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@679412ef name:ZooKeeperConnection Watcher:127.0.0.1:38805/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1720337 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1720337 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1720337 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 1720338 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 1720339 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 1720339 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 1720340 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 1720340 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 1720341 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 1720341 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 1720342 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 1720342 INFO (zkCallback-2354-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 1720343 INFO (zkCallback-2354-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> 1720343 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1] [junit4] 2> 1720344 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 1720344 INFO (zkCallback-2354-thread-1) [ ] o.a.s.c.c.ZkStateReader Uninteresting collection c1 [junit4] 2> 1720344 INFO (zkCallback-2354-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> 1720344 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 1720347 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38805 38805 [junit4] 2> 1720530 INFO (Thread-4631) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38805 38805 [junit4] 2> 1720542 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[21DF598BF56F242D]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy [junit4] 2> 1720566 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation [junit4] 2> 1720566 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 1720578 INFO (Thread-4632) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 1720578 INFO (Thread-4632) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 1720678 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.ZkTestServer start zk server on port:42542 [junit4] 2> 1720678 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1720686 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1720700 INFO (zkCallback-2356-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4c90aa33 name:ZooKeeperConnection Watcher:127.0.0.1:42542 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1720700 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1720701 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1720702 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1720702 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1720703 INFO (zkCallback-2357-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7aed7bf4 name:ZooKeeperConnection Watcher:127.0.0.1:42542 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1720703 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1720703 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1720703 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 1720704 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1720705 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1720705 INFO (zkCallback-2358-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@43f4d77b name:ZooKeeperConnection Watcher:127.0.0.1:42542/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1720705 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1720705 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1720706 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 1720707 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 1720707 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 1720708 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 1720708 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 1720709 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 1720709 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 1720709 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 1720710 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1] [junit4] 2> 1720710 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 1720711 INFO (zkCallback-2358-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 1720711 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 1720712 INFO (zkCallback-2358-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> 1720712 INFO (zkCallback-2358-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 1720713 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42542 42542 [junit4] 2> 1720876 INFO (Thread-4632) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42542 42542 [junit4] 2> 1720878 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[21DF598BF56F242D]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation [junit4] 2> 1720882 INFO (SUITE-ZkStateReaderTest-seed#[21DF598BF56F242D]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.overseer.ZkStateReaderTest_21DF598BF56F242D-001 [junit4] 2> NOTE: test params are: codec=DummyCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=DUMMY, chunkSize=1, maxDocsPerChunk=10, blockSize=2), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=DUMMY, chunkSize=1, blockSize=2)), sim=ClassicSimilarity, locale=sr-ME, timezone=America/El_Salvador [junit4] 2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 1.8.0_74 (64-bit)/cpus=4,threads=1,free=227876472,total=529530880 [junit4] 2> NOTE: All tests run in this JVM: [TestSearchPerf, UpdateParamsTest, OverseerTest, TestTrackingShardHandlerFactory, TestNumericTerms64, TestCloudDeleteByQuery, TestConfigSetProperties, DistribDocExpirationUpdateProcessorTest, DirectUpdateHandlerTest, SuggesterWFSTTest, UnloadDistributedZkTest, CircularListTest, BigEndianAscendingWordSerializerTest, TestSlowCompositeReaderWrapper, DistributedVersionInfoTest, CollectionsAPISolrJTest, TestManagedSchema, SpatialHeatmapFacetsTest, TestDefaultStatsCache, PrimitiveFieldTypeTest, TestConfigSetsAPIZkFailure, TestPostingsSolrHighlighter, TestFastWriter, TestRestManager, TestHdfsBackupRestoreCore, TestDistributedStatsComponentCardinality, TestSubQueryTransformerDistrib, TestNRTOpen, StatsComponentTest, TestTolerantSearch, TestElisionMultitermQuery, TestJmxIntegration, TestSort, TestRawTransformer, AnalyticsQueryTest, TestSolrDeletionPolicy1, CleanupOldIndexTest, TestSolrConfigHandlerConcurrent, TestMaxScoreQueryParser, ClassificationUpdateProcessorFactoryTest, DebugComponentTest, SpatialRPTFieldTypeTest, TestCSVResponseWriter, StatelessScriptUpdateProcessorFactoryTest, TestUniqueKeyFieldResource, XmlUpdateRequestHandlerTest, TestXmlQParser, HdfsThreadLeakTest, RuleEngineTest, FullSolrCloudDistribCmdsTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestWriterPerf, HighlighterConfigTest, TestClassicSimilarityFactory, SolrTestCaseJ4Test, LukeRequestHandlerTest, CoreMergeIndexesAdminHandlerTest, CurrencyFieldXmlFileTest, TestGraphTermsQParserPlugin, LeaderElectionTest, OverseerRolesTest, TestRecovery, CollectionStateFormat2Test, TestCharFilters, TestIntervalFaceting, DistributedFacetPivotSmallTest, HardAutoCommitTest, TestFileDictionaryLookup, TestTolerantUpdateProcessorCloud, TestZkChroot, NoCacheHeaderTest, TestFieldCache, HdfsCollectionsAPIDistributedZkTest, VersionInfoTest, HdfsDirectoryTest, BlockJoinFacetDistribTest, SliceStateTest, TestDocBasedVersionConstraints, ScriptEngineTest, FieldAnalysisRequestHandlerTest, ConjunctionSolrSpellCheckerTest, TestJettySolrRunner, SuggesterTSTTest, RestartWhileUpdatingTest, TestIndexingPerformance, SolrCoreCheckLockOnStartupTest, RequestLoggingTest, AutoCommitTest, TestSolrIndexConfig, ExitableDirectoryReaderTest, TestSolrCloudWithKerberosAlt, TestReversedWildcardFilterFactory, SolrXmlInZkTest, TestReload, TestGroupingSearch, TestStressReorder, RecoveryZkTest, SearchHandlerTest, FullHLLTest, TestSolrQueryParser, TestSmileRequest, TestDistributedMissingSort, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, ShardRoutingTest, TestRandomFaceting, ZkSolrClientTest, TestHashPartitioner, ZkControllerTest, TestJoin, TestSolr4Spatial, TestIndexSearcher, ShowFileRequestHandlerTest, SimplePostToolTest, TestCoreDiscovery, AnalysisAfterCoreReloadTest, TestExtendedDismaxParser, DocValuesTest, BadComponentTest, MultiTermTest, TestDocSet, TestConfig, TestSolrCoreProperties, DirectSolrConnectionTest, TestCodecSupport, TestPerFieldSimilarity, TestIBSimilarityFactory, TestJmxMonitoredMap, TestFastOutputStream, PluginInfoTest, ChaosMonkeyNothingIsSafeTest, DeleteLastCustomShardedReplicaTest, DeleteReplicaTest, HttpPartitionTest, TestCloudBackupRestore, TestConfigSetsAPI, TestConfigSetsAPIExclusivity, TestCryptoKeys, TestExclusionRuleCollectionAccess, TestOnReconnectListenerSupport, TestSSLRandomization, TestShortCircuitedRequests, TlogReplayBufferedWhileIndexingTest, TriLevelCompositeIdRoutingTest, ZkStateReaderTest] [junit4] Completed [489/618 (1!)] on J2 in 1.81s, 6 tests, 1 error <<< FAILURES! [...truncated 406 lines...] BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:740: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:684: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:59: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build.xml:233: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/common-build.xml:530: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/lucene/common-build.xml:1427: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/lucene/common-build.xml:984: There were test failures: 618 suites (10 ignored), 2591 tests, 1 error, 87 ignored (72 assumptions) [seed: 21DF598BF56F242D] Total time: 63 minutes 28 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org