lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@thetaphi.de>
Subject [JENKINS-EA] Lucene-Solr-6.x-Linux (64bit/jdk-9-ea+111-patched) - Build # 284 - Failure!
Date Tue, 29 Mar 2016 03:58:22 GMT
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



Mime
View raw message