Build: http://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/17185/ Java: 32bit/jdk-9-ea+125 -server -XX:+UseConcMarkSweepGC
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([6F0B43B6F6D42519:70B1324126B4E3DC]: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.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:43) at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method) at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62) at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:533) 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(java.base@9-ea/Thread.java:843) Build Log: [...truncated 10855 lines...] [junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.overseer.ZkStateReaderTest_6F0B43B6F6D42519-001/init-core-data-001 [junit4] 2> 269101 INFO (SUITE-ZkStateReaderTest-seed#[6F0B43B6F6D42519]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN) [junit4] 2> 269103 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay [junit4] 2> 269103 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 269103 INFO (Thread-709) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 269103 INFO (Thread-709) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 269203 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.ZkTestServer start zk server on port:37431 [junit4] 2> 269204 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 269204 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 269205 INFO (zkCallback-320-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1aede1 name:ZooKeeperConnection Watcher:127.0.0.1:37431 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 269205 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 269206 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 269206 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 269207 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 269207 INFO (zkCallback-321-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1f92a16 name:ZooKeeperConnection Watcher:127.0.0.1:37431 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 269207 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 269208 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 269208 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 269209 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 269210 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 269210 INFO (zkCallback-322-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1f99269 name:ZooKeeperConnection Watcher:127.0.0.1:37431/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 269210 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 269210 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 269211 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 269211 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 269211 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 269212 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 269212 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 269213 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 269213 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 269213 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 269214 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1] [junit4] 2> 269214 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 269214 INFO (zkCallback-322-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 269215 INFO (zkCallback-322-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> 269218 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 269218 INFO (zkCallback-322-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> 269218 INFO (zkCallback-322-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 269219 INFO (zkCallback-322-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> 269220 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37431 37431 [junit4] 2> 269239 INFO (Thread-709) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37431 37431 [junit4] 2> 269239 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[6F0B43B6F6D42519]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay [junit4] 2> 269241 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh [junit4] 2> 269241 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 269241 INFO (Thread-710) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 269241 INFO (Thread-710) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 269342 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.ZkTestServer start zk server on port:43967 [junit4] 2> 269342 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 269343 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 269344 INFO (zkCallback-324-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1e40eb2 name:ZooKeeperConnection Watcher:127.0.0.1:43967 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 269344 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 269344 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 269345 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 269345 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 269346 INFO (zkCallback-325-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1c2aa7a name:ZooKeeperConnection Watcher:127.0.0.1:43967 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 269346 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 269346 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 269346 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 269351 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 269352 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 269354 INFO (zkCallback-326-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1732954 name:ZooKeeperConnection Watcher:127.0.0.1:43967/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 269354 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 269354 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 269354 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 269355 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 269356 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 269356 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 269357 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 269357 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 269358 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 269358 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 269359 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1] [junit4] 2> 269359 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 269360 INFO (zkCallback-326-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 269360 INFO (zkCallback-326-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> 269361 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Checking legacy cluster state for collection c1 [junit4] 2> 269361 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 269362 INFO (zkCallback-326-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> 269362 INFO (zkCallback-326-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> 269362 INFO (zkCallback-326-thread-2) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 269363 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Checking legacy cluster state for collection c1 [junit4] 2> 269367 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:43967 43967 [junit4] 2> 269391 INFO (Thread-710) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:43967 43967 [junit4] 2> 269392 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[6F0B43B6F6D42519]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithExplicitRefresh -Dtests.seed=6F0B43B6F6D42519 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=haw -Dtests.timezone=Europe/Vienna -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 0.16s J2 | ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh <<< [junit4] > Throwable #1: org.apache.solr.common.SolrException: Could not find collection : c1 [junit4] > at __randomizedtesting.SeedInfo.seed([6F0B43B6F6D42519:70B1324126B4E3DC]: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.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:43) [junit4] > at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method) [junit4] > at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62) [junit4] > at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43) [junit4] > at java.lang.Thread.run(java.base@9-ea/Thread.java:843) [junit4] 2> 269399 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy [junit4] 2> 269400 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 269400 INFO (Thread-711) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 269400 INFO (Thread-711) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 269500 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.ZkTestServer start zk server on port:37428 [junit4] 2> 269500 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 269501 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 269502 INFO (zkCallback-328-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@aa46b6 name:ZooKeeperConnection Watcher:127.0.0.1:37428 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 269502 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 269503 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 269504 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 269505 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 269505 INFO (zkCallback-329-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@11ee68f name:ZooKeeperConnection Watcher:127.0.0.1:37428 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 269505 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 269506 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 269506 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 269508 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 269508 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 269509 INFO (zkCallback-330-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@573980 name:ZooKeeperConnection Watcher:127.0.0.1:37428/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 269509 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 269509 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 269509 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 269510 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 269511 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 269511 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 269512 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 269513 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 269513 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 269513 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 269514 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 269515 INFO (zkCallback-330-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 269531 INFO (zkCallback-330-thread-1) [ ] o.a.s.c.c.ZkStateReader Adding lazy collectionRef for collection c1 [junit4] 2> 269531 INFO (zkCallback-330-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> 269532 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1] [junit4] 2> 269532 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 269533 INFO (zkCallback-330-thread-1) [ ] o.a.s.c.c.ZkStateReader Uninteresting collection c1 [junit4] 2> 269533 INFO (zkCallback-330-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> 269534 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 269535 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37428 37428 [junit4] 2> 269683 INFO (Thread-711) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37428 37428 [junit4] 2> 269683 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy [junit4] 2> 269686 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy [junit4] 2> 269686 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 269697 INFO (Thread-712) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 269697 INFO (Thread-712) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 269797 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.ZkTestServer start zk server on port:42220 [junit4] 2> 269797 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 269798 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 269799 INFO (zkCallback-332-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@19f63b4 name:ZooKeeperConnection Watcher:127.0.0.1:42220 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 269799 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 269800 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 269800 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 269801 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 269802 INFO (zkCallback-333-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@34602d name:ZooKeeperConnection Watcher:127.0.0.1:42220 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 269802 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 269802 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 269802 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 269803 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 269804 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 269837 INFO (zkCallback-334-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@9203bb name:ZooKeeperConnection Watcher:127.0.0.1:42220/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 269837 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 269837 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 269837 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 269838 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 269839 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 269840 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 269841 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 269841 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 269841 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 269842 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 269843 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 269844 INFO (zkCallback-334-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 269844 INFO (zkCallback-334-thread-1) [ ] o.a.s.c.c.ZkStateReader Adding lazy collectionRef for collection c1 [junit4] 2> 269867 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Refreshing lazily-loaded state for collection c1 [junit4] 2> 269868 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 269869 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Checking legacy cluster state for collection c1 [junit4] 2> 269878 INFO (zkCallback-334-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> 269880 WARN (zkCallback-334-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> 269881 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42220 42220 [junit4] 2> 270030 INFO (Thread-712) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42220 42220 [junit4] 2> 270033 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[6F0B43B6F6D42519]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy [junit4] 2> 270034 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation [junit4] 2> 270035 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 270035 INFO (Thread-713) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 270035 INFO (Thread-713) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 270135 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.ZkTestServer start zk server on port:39265 [junit4] 2> 270135 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 270136 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 270146 INFO (zkCallback-336-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@787474 name:ZooKeeperConnection Watcher:127.0.0.1:39265 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 270146 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 270147 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 270148 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 270149 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 270149 INFO (zkCallback-337-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@159ad52 name:ZooKeeperConnection Watcher:127.0.0.1:39265 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 270149 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 270149 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 270149 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 270150 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 270151 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 270151 INFO (zkCallback-338-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1770572 name:ZooKeeperConnection Watcher:127.0.0.1:39265/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 270151 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 270152 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 270152 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 270153 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 270153 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 270154 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 270155 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 270156 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 270156 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 270156 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 270158 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1] [junit4] 2> 270158 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 270158 INFO (zkCallback-338-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 270159 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Checking legacy cluster state for collection c1 [junit4] 2> 270159 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 270160 INFO (zkCallback-338-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> 270160 INFO (zkCallback-338-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 270163 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39265 39265 [junit4] 2> 270384 INFO (Thread-713) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39265 39265 [junit4] 2> 270384 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[6F0B43B6F6D42519]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation [junit4] 2> 270390 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched [junit4] 2> 270390 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 270390 INFO (Thread-714) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 270390 INFO (Thread-714) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 270491 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.ZkTestServer start zk server on port:46748 [junit4] 2> 270491 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 270492 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 270493 INFO (zkCallback-340-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@152f686 name:ZooKeeperConnection Watcher:127.0.0.1:46748 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 270493 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 270494 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 270494 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 270496 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 270496 INFO (zkCallback-341-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@17f742b name:ZooKeeperConnection Watcher:127.0.0.1:46748 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 270496 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 270496 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 270496 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 270497 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 270498 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 270499 INFO (zkCallback-342-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@b617d4 name:ZooKeeperConnection Watcher:127.0.0.1:46748/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 270499 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 270499 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 270499 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 270500 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 270500 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 270501 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 270501 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 270502 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 270502 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 270502 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 270504 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 270504 INFO (zkCallback-342-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 270504 INFO (zkCallback-342-thread-1) [ ] o.a.s.c.c.ZkStateReader Adding lazy collectionRef for collection c1 [junit4] 2> 270505 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 270505 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Refreshing lazily-loaded state for collection c1 [junit4] 2> 270505 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 270506 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:46748 46748 [junit4] 2> 270621 INFO (Thread-714) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:46748 46748 [junit4] 2> 270622 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[6F0B43B6F6D42519]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched [junit4] 2> 270623 INFO (SUITE-ZkStateReaderTest-seed#[6F0B43B6F6D42519]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.overseer.ZkStateReaderTest_6F0B43B6F6D42519-001 [junit4] 2> Jul 08, 2016 8:12:05 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 2 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {}, docValues:{}, maxPointsInLeafNode=658, maxMBSortInHeap=7.017015207732694, sim=ClassicSimilarity, locale=haw, timezone=Europe/Vienna [junit4] 2> NOTE: Linux 4.4.0-28-generic i386/Oracle Corporation 9-ea (32-bit)/cpus=12,threads=1,free=56423408,total=223023104 [junit4] 2> NOTE: All tests run in this JVM: [BaseCdcrDistributedZkTest, SpatialRPTFieldTypeTest, TestFieldTypeCollectionResource, TestSolrJ, SampleTest, TestIndexSearcher, TestReloadDeadlock, DistributedFacetPivotSmallTest, HdfsLockFactoryTest, DistributedFacetPivotLargeTest, DirectUpdateHandlerTest, SliceStateTest, TestFastWriter, TestOrdValues, TestPerFieldSimilarityWithDefaultOverride, TestSweetSpotSimilarityFactory, TestOnReconnectListenerSupport, UpdateParamsTest, DateMathParserTest, TestMaxScoreQueryParser, TestHdfsCloudBackupRestore, TolerantUpdateProcessorTest, TestChildDocTransformer, TestExtendedDismaxParser, TestZkChroot, CollectionsAPISolrJTest, TestElisionMultitermQuery, TestCharFilters, FullSolrCloudDistribCmdsTest, MigrateRouteKeyTest, ZkStateReaderTest] [junit4] Completed [103/620 (1!)] on J2 in 2.04s, 6 tests, 1 error <<< FAILURES! [...truncated 1724 lines...] BUILD FAILED /home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:740: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:684: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:59: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build.xml:233: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/common-build.xml:530: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1443: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:984: There were test failures: 620 suites (10 ignored), 2635 tests, 1 error, 136 ignored (88 assumptions) [seed: 6F0B43B6F6D42519] Total time: 63 minutes 39 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts [WARNINGS] Skipping publisher since build result is FAILURE Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org