You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2016/03/29 05:58:22 UTC
[JENKINS-EA] Lucene-Solr-6.x-Linux (64bit/jdk-9-ea+111-patched) -
Build # 284 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Linux/284/
Java: 64bit/jdk-9-ea+111-patched -XX:+UseCompressedOops -XX:+UseG1GC -XX:-CompactStrings
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([1C5BCDF1E7293F6E:77146D8C9E26E254]:0)
at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:135)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy(ZkStateReaderTest.java:46)
at sun.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:531)
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:804)
Build Log:
[...truncated 12065 lines...]
[junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.overseer.ZkStateReaderTest_1C5BCDF1E7293F6E-001/init-core-data-001
[junit4] 2> 1737063 INFO (SUITE-ZkStateReaderTest-seed#[1C5BCDF1E7293F6E]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 1737065 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 1737065 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1737065 INFO (Thread-4168) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1737065 INFO (Thread-4168) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1737165 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.ZkTestServer start zk server on port:38184
[junit4] 2> 1737165 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1737166 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1737168 INFO (zkCallback-1854-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1272b61a name:ZooKeeperConnection Watcher:127.0.0.1:38184 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1737168 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1737168 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1737169 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1737169 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1737169 INFO (zkCallback-1855-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5cb9cd92 name:ZooKeeperConnection Watcher:127.0.0.1:38184 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1737169 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1737170 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1737170 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1737172 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1737172 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1737173 INFO (zkCallback-1856-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@32065045 name:ZooKeeperConnection Watcher:127.0.0.1:38184/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1737173 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1737173 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1737173 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1737173 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1737174 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1737174 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1737175 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1737176 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1737176 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1737176 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
[junit4] 2> 1737176 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 1737177 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 1737177 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1737177 INFO (zkCallback-1856-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1737177 INFO (zkCallback-1856-thread-1) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 1737177 INFO (zkCallback-1856-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> 1737178 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 1737178 INFO (zkCallback-1856-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> 1737179 INFO (zkCallback-1856-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 1737180 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38184 38184
[junit4] 2> 1737186 INFO (Thread-4168) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38184 38184
[junit4] 2> 1737187 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 1737190 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
[junit4] 2> 1737191 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1737191 INFO (Thread-4169) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1737191 INFO (Thread-4169) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1737291 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.ZkTestServer start zk server on port:39854
[junit4] 2> 1737291 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1737291 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1737293 INFO (zkCallback-1857-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6149e91a name:ZooKeeperConnection Watcher:127.0.0.1:39854 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1737293 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1737294 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1737294 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1737294 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1737295 INFO (zkCallback-1858-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@39757448 name:ZooKeeperConnection Watcher:127.0.0.1:39854 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1737295 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1737295 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1737295 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1737297 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1737298 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1737298 INFO (zkCallback-1859-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@155d6480 name:ZooKeeperConnection Watcher:127.0.0.1:39854/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1737298 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1737299 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1737299 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1737300 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1737300 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1737301 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1737301 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1737301 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1737302 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1737302 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
[junit4] 2> 1737302 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 1737302 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 1737302 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1737303 INFO (zkCallback-1859-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1737303 INFO (zkCallback-1859-thread-1) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 1737303 INFO (zkCallback-1859-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> 1737354 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 1737354 INFO (zkCallback-1859-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> 1737355 INFO (zkCallback-1859-thread-2) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 1737406 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39854 39854
[junit4] 2> 1737500 INFO (Thread-4169) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39854 39854
[junit4] 2> 1737501 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
[junit4] 2> 1737505 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 1737505 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1737506 INFO (Thread-4170) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1737506 INFO (Thread-4170) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1737606 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.ZkTestServer start zk server on port:37219
[junit4] 2> 1737606 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1737606 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1737608 INFO (zkCallback-1860-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7117ec1d name:ZooKeeperConnection Watcher:127.0.0.1:37219 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1737608 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1737609 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1737609 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1737609 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1737610 INFO (zkCallback-1861-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@531fcc10 name:ZooKeeperConnection Watcher:127.0.0.1:37219 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1737610 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1737610 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1737610 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1737613 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1737613 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1737614 INFO (zkCallback-1862-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7535dfe3 name:ZooKeeperConnection Watcher:127.0.0.1:37219/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1737614 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1737614 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1737614 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1737615 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1737616 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1737616 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1737616 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1737617 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1737617 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1737617 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1737618 INFO (zkCallback-1862-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1737618 INFO (zkCallback-1862-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> 1737618 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 1737618 INFO (zkCallback-1862-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> 1737620 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37219 37219
[junit4] 2> 1737674 INFO (Thread-4170) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37219 37219
[junit4] 2> 1737675 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 1737679 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
[junit4] 2> 1737679 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1737680 INFO (Thread-4171) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1737680 INFO (Thread-4171) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1737780 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.ZkTestServer start zk server on port:34535
[junit4] 2> 1737780 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1737780 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1737782 INFO (zkCallback-1863-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@638a36ac name:ZooKeeperConnection Watcher:127.0.0.1:34535 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1737783 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1737783 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1737784 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1737784 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1737785 INFO (zkCallback-1864-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@66e3ad02 name:ZooKeeperConnection Watcher:127.0.0.1:34535 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1737785 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1737785 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1737785 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1737787 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1737787 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1737788 INFO (zkCallback-1865-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@33162ce6 name:ZooKeeperConnection Watcher:127.0.0.1:34535/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1737788 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1737788 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1737788 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1737789 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1737790 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1737790 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1737790 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1737791 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1737792 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1737792 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1737793 INFO (zkCallback-1865-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1737793 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 1737793 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
[junit4] 2> 1737793 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 1737793 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ZkStateReader Removing watch for uninteresting collection [c1]
[junit4] 2> 1737795 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34535 34535
[junit4] 2> 1737898 INFO (Thread-4171) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34535 34535
[junit4] 2> 1737902 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
[junit4] 2> 1737907 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 1737907 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1737908 INFO (Thread-4172) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1737908 INFO (Thread-4172) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1738008 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.ZkTestServer start zk server on port:45012
[junit4] 2> 1738008 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1738011 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1738016 INFO (zkCallback-1866-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@55843e62 name:ZooKeeperConnection Watcher:127.0.0.1:45012 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1738016 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1738016 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1738017 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1738017 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1738017 INFO (zkCallback-1867-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6b9c2db6 name:ZooKeeperConnection Watcher:127.0.0.1:45012 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1738018 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1738018 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1738018 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1738033 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1738033 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1738033 INFO (zkCallback-1868-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6655c6f7 name:ZooKeeperConnection Watcher:127.0.0.1:45012/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1738034 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1738034 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1738035 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1738041 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1738042 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1738042 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1738046 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1738046 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1738047 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1738047 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1738049 INFO (zkCallback-1868-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> 1738050 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 1738050 INFO (zkCallback-1868-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> 1738056 INFO (zkCallback-1868-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1738057 WARN (zkCallback-1868-thread-1) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /collections]
[junit4] 2> 1738058 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45012 45012
[junit4] 2> 1738090 INFO (Thread-4172) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45012 45012
[junit4] 2> 1738093 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1C5BCDF1E7293F6E]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithExplicitRefreshLazy -Dtests.seed=1C5BCDF1E7293F6E -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=so-SO -Dtests.timezone=Etc/GMT-3 -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.19s J2 | ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy <<<
[junit4] > Throwable #1: org.apache.solr.common.SolrException: Could not find collection : c1
[junit4] > at __randomizedtesting.SeedInfo.seed([1C5BCDF1E7293F6E:77146D8C9E26E254]:0)
[junit4] > at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
[junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:135)
[junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy(ZkStateReaderTest.java:46)
[junit4] > at java.lang.Thread.run(java.base@9-ea/Thread.java:804)
[junit4] 2> 1738095 INFO (SUITE-ZkStateReaderTest-seed#[1C5BCDF1E7293F6E]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.overseer.ZkStateReaderTest_1C5BCDF1E7293F6E-001
[junit4] 2> Mar 29, 2016 3:53:57 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 7 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=FastCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST, chunkSize=18652, maxDocsPerChunk=937, blockSize=84), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST, chunkSize=18652, blockSize=84)), sim=RandomSimilarity(queryNorm=true,coord=no): {}, locale=so-SO, timezone=Etc/GMT-3
[junit4] 2> NOTE: Linux 4.2.0-34-generic amd64/Oracle Corporation 9-ea (64-bit)/cpus=12,threads=1,free=260322672,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [DirectUpdateHandlerOptimizeTest, RequestHandlersTest, HdfsSyncSliceTest, TestCSVResponseWriter, TestCollectionAPI, TestFuzzyAnalyzedSuggestions, DocValuesMissingTest, TestSolrCLIRunExample, BlockJoinFacetDistribTest, TestSchemaResource, LukeRequestHandlerTest, TestCollationField, QueryParsingTest, TestDynamicLoading, TestSolrJ, TestTolerantSearch, TestRequestStatusCollectionAPI, SuggesterTSTTest, TestClassicSimilarityFactory, PrimitiveFieldTypeTest, TestFieldTypeCollectionResource, ClassificationUpdateProcessorFactoryTest, SSLMigrationTest, ScriptEngineTest, TestXmlQParser, SmileWriterTest, TestJettySolrRunner, UnloadDistributedZkTest, SegmentsInfoRequestHandlerTest, SolrCoreCheckLockOnStartupTest, SpatialHeatmapFacetsTest, TestExtendedDismaxParser, BlockCacheTest, BadComponentTest, UpdateParamsTest, TestSearchPerf, TestExactStatsCache, AnalysisErrorHandlingTest, TestPerFieldSimilarityClassic, TestWriterPerf, TestDistributedMissingSort, OverseerCollectionConfigSetProcessorTest, TestRuleBasedAuthorizationPlugin, PKIAuthenticationIntegrationTest, StatsComponentTest, OverseerTest, DistribJoinFromCollectionTest, TestPostingsSolrHighlighter, TestCoreDiscovery, CachingDirectoryFactoryTest, CoreMergeIndexesAdminHandlerTest, SampleTest, TestTrackingShardHandlerFactory, TestDefaultStatsCache, CurrencyFieldXmlFileTest, TlogReplayBufferedWhileIndexingTest, CleanupOldIndexTest, WrapperMergePolicyFactoryTest, FieldAnalysisRequestHandlerTest, TestJmxMonitoredMap, TestGroupingSearch, ConjunctionSolrSpellCheckerTest, HdfsBasicDistributedZk2Test, TestConfigSetsAPIZkFailure, DistanceUnitsTest, NoCacheHeaderTest, ConnectionManagerTest, TestSerializedLuceneMatchVersion, TestSolrCloudWithKerberosAlt, AssignTest, TestFilteredDocIdSet, MergeStrategyTest, LeaderInitiatedRecoveryOnCommitTest, SharedFSAutoReplicaFailoverTest, DateMathParserTest, CoreAdminHandlerTest, DistributedFacetPivotLargeTest, TestZkChroot, HdfsRecoverLeaseTest, TestRecovery, TestReloadDeadlock, SolrCloudExampleTest, TestSuggestSpellingConverter, TestStressReorder, TestElisionMultitermQuery, TestIndexSearcher, ReplicationFactorTest, TestUtils, SimpleFacetsTest, TestSweetSpotSimilarityFactory, TestSmileRequest, HdfsChaosMonkeySafeLeaderTest, TestJsonRequest, HdfsUnloadDistributedZkTest, BinaryUpdateRequestHandlerTest, ClusterStateTest, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, CollectionsAPIDistributedZkTest, SyncSliceTest, OpenCloseCoreStressTest, LeaderElectionIntegrationTest, BasicZkTest, RecoveryZkTest, FullSolrCloudDistribCmdsTest, TestRandomFaceting, LeaderElectionTest, ZkSolrClientTest, ShardRoutingCustomTest, TestDistributedSearch, HighlighterConfigTest, SOLR749Test, TestQuerySenderListener, TestSolrIndexConfig, TestQuerySenderNoQuery, CopyFieldTest, SolrIndexConfigTest, TestStressRecovery, DirectSolrConnectionTest, TestCharFilters, TestCodecSupport, TestPerFieldSimilarity, TestFastWriter, PreAnalyzedFieldTest, TestLRUCache, SystemInfoHandlerTest, FileUtilsTest, CursorPagingTest, AsyncCallRequestStatusResponseTest, BaseCdcrDistributedZkTest, CdcrReplicationDistributedZkTest, CdcrReplicationHandlerTest, CdcrRequestHandlerTest, CollectionReloadTest, CollectionsAPIAsyncDistributedZkTest, ConcurrentDeleteAndCreateCollectionTest, DeleteInactiveReplicaTest, DeleteStatusTest, DistributedQueueTest, ForceLeaderTest, TestCloudDeleteByQuery, TestDownShardTolerantSearch, TestLeaderInitiatedRecoveryThread, HdfsNNFailoverTest, HdfsRecoveryZkTest, HdfsRestartWhileUpdatingTest, HdfsThreadLeakTest, TestClusterStateMutator, ZkStateReaderTest]
[junit4] Completed [464/585 (1!)] on J2 in 1.55s, 5 tests, 1 error <<< FAILURES!
[...truncated 413 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/build.xml:740: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/build.xml:684: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/build.xml:59: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build.xml:233: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/common-build.xml:529: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/lucene/common-build.xml:1457: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/lucene/common-build.xml:1014: There were test failures: 585 suites (10 ignored), 2364 tests, 1 error, 117 ignored (70 assumptions) [seed: 1C5BCDF1E7293F6E]
Total time: 57 minutes 52 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