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] Lucene-Solr-master-Solaris (64bit/jdk1.8.0) - Build # 468 - Failure!
Date Mon, 21 Mar 2016 19:50:50 GMT
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-master-Solaris/468/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseParallelGC

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([608CC9E0648E1198:BC3699D1D81CCA2]: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(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 12096 lines...]
   [junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
   [junit4]   2> Creating dataDir: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.overseer.ZkStateReaderTest_608CC9E0648E1198-001/init-core-data-001
   [junit4]   2> 2689866 INFO  (SUITE-ZkStateReaderTest-seed#[608CC9E0648E1198]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 2689871 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> 2689871 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2689871 INFO  (Thread-8069) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2689872 INFO  (Thread-8069) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 2689972 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.ZkTestServer start zk server on port:52735
   [junit4]   2> 2689972 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2689973 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2689975 INFO  (zkCallback-3101-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2792c97a name:ZooKeeperConnection Watcher:127.0.0.1:52735 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2689975 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2689976 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2689979 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2689979 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2689982 INFO  (zkCallback-3102-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4924fd4e name:ZooKeeperConnection Watcher:127.0.0.1:52735 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2689982 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2689982 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2689982 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 2689992 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2689993 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2689994 INFO  (zkCallback-3103-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1831471e name:ZooKeeperConnection Watcher:127.0.0.1:52735/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2689995 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2689995 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2689995 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 2689998 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 2690000 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 2690003 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 2690006 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 2690008 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 2690010 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 2690010 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 2690014 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 2690019 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:52735 52735
   [junit4]   2> 2690020 ERROR (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]-EventThread) [    ] o.a.z.ClientCnxn Error while calling watcher 
   [junit4]   2> java.util.concurrent.RejectedExecutionException: Task org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$7/349860621@681cbcd0 rejected from org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@6c23350b[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 1]
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2047)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:823)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1369)
   [junit4]   2> 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.execute(ExecutorUtil.java:214)
   [junit4]   2> 	at java.util.concurrent.AbstractExecutorService.submit(AbstractExecutorService.java:112)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient$3.process(SolrZkClient.java:266)
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522)
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498)
   [junit4]   2> 2690020 ERROR (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]-EventThread) [    ] o.a.z.ClientCnxn Error while calling watcher 
   [junit4]   2> java.util.concurrent.RejectedExecutionException: Task org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$7/349860621@15351d32 rejected from org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@6c23350b[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 1]
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2047)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:823)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1369)
   [junit4]   2> 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.execute(ExecutorUtil.java:214)
   [junit4]   2> 	at java.util.concurrent.AbstractExecutorService.submit(AbstractExecutorService.java:112)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient$3.process(SolrZkClient.java:266)
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522)
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498)
   [junit4]   2> 2690046 INFO  (Thread-8069) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:52735 52735
   [junit4]   2> 2690048 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithExplicitRefreshLazy -Dtests.seed=608CC9E0648E1198 -Dtests.slow=true -Dtests.locale=en-CA -Dtests.timezone=Chile/EasterIsland -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.19s J1 | ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy <<<
   [junit4]    > Throwable #1: org.apache.solr.common.SolrException: Could not find collection : c1
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([608CC9E0648E1198:BC3699D1D81CCA2]: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(Thread.java:745)
   [junit4]   2> 2690059 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
   [junit4]   2> 2690059 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2690060 INFO  (Thread-8070) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2690060 INFO  (Thread-8070) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 2690164 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.ZkTestServer start zk server on port:49360
   [junit4]   2> 2690165 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2690165 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2690168 INFO  (zkCallback-3104-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@56e40d46 name:ZooKeeperConnection Watcher:127.0.0.1:49360 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2690168 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2690169 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2690171 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2690171 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2690172 INFO  (zkCallback-3105-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@465fccce name:ZooKeeperConnection Watcher:127.0.0.1:49360 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2690173 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2690173 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2690173 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 2690178 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2690178 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2690179 INFO  (zkCallback-3106-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6663a6d5 name:ZooKeeperConnection Watcher:127.0.0.1:49360/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2690179 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2690180 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2690180 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 2690182 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 2690184 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 2690187 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 2690188 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 2690190 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 2690192 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 2690193 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 2690193 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 2690194 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 2690194 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 2690196 INFO  (zkCallback-3106-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 2690203 INFO  (zkCallback-3106-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> 2690203 INFO  (zkCallback-3106-thread-1) [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 2690254 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 2690256 INFO  (zkCallback-3106-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> 2690257 INFO  (zkCallback-3106-thread-2) [    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 2690314 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:49360 49360
   [junit4]   2> 2690455 INFO  (Thread-8070) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:49360 49360
   [junit4]   2> 2690457 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[608CC9E0648E1198]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
   [junit4]   2> 2690461 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 2690461 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2690462 INFO  (Thread-8071) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2690462 INFO  (Thread-8071) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 2690564 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.ZkTestServer start zk server on port:62279
   [junit4]   2> 2690565 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2690565 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2690568 INFO  (zkCallback-3107-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4d403c63 name:ZooKeeperConnection Watcher:127.0.0.1:62279 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2690568 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2690568 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2690570 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2690570 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2690572 INFO  (zkCallback-3108-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@25643c75 name:ZooKeeperConnection Watcher:127.0.0.1:62279 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2690572 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2690572 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2690572 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 2690576 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2690576 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2690578 INFO  (zkCallback-3109-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@520f2693 name:ZooKeeperConnection Watcher:127.0.0.1:62279/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2690578 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2690578 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2690579 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 2690581 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 2690583 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 2690585 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 2690588 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 2690589 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 2690591 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 2690592 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 2690594 INFO  (zkCallback-3109-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 2690596 INFO  (zkCallback-3109-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> 2690598 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 2690599 INFO  (zkCallback-3109-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> 2690603 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:62279 62279
   [junit4]   2> 2690629 INFO  (Thread-8071) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:62279 62279
   [junit4]   2> 2690630 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[608CC9E0648E1198]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 2690636 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
   [junit4]   2> 2690636 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2690637 INFO  (Thread-8072) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2690637 INFO  (Thread-8072) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 2690744 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.ZkTestServer start zk server on port:55176
   [junit4]   2> 2690745 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2690745 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2690748 INFO  (zkCallback-3110-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@39b92a92 name:ZooKeeperConnection Watcher:127.0.0.1:55176 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2690748 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2690748 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2690750 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2690751 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2690752 INFO  (zkCallback-3111-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@63de8152 name:ZooKeeperConnection Watcher:127.0.0.1:55176 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2690752 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2690752 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2690752 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 2690757 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2690757 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2690758 INFO  (zkCallback-3112-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5985fdc9 name:ZooKeeperConnection Watcher:127.0.0.1:55176/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2690759 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2690759 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2690760 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 2690762 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 2690764 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 2690766 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 2690768 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 2690770 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 2690772 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 2690773 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 2690775 INFO  (zkCallback-3112-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 2690777 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 2690778 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 2690779 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 2690779 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ZkStateReader Removing watch for uninteresting collection [c1]
   [junit4]   2> 2690781 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:55176 55176
   [junit4]   2> 2690883 INFO  (Thread-8072) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:55176 55176
   [junit4]   2> 2690884 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[608CC9E0648E1198]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
   [junit4]   2> 2690890 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 2690890 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2690890 INFO  (Thread-8073) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2690890 INFO  (Thread-8073) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 2690990 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.ZkTestServer start zk server on port:52147
   [junit4]   2> 2690991 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2690991 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2690994 INFO  (zkCallback-3113-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3bd33e82 name:ZooKeeperConnection Watcher:127.0.0.1:52147 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2690994 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2690994 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2690996 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2690996 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2690997 INFO  (zkCallback-3114-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6475b072 name:ZooKeeperConnection Watcher:127.0.0.1:52147 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2690998 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2690998 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2690998 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 2691002 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2691003 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2691004 INFO  (zkCallback-3115-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@eb2e355 name:ZooKeeperConnection Watcher:127.0.0.1:52147/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2691004 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2691004 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2691005 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 2691008 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 2691016 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 2691019 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 2691021 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 2691023 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 2691026 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 2691027 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 2691027 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 2691030 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 2691030 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 2691034 INFO  (zkCallback-3115-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 2691036 INFO  (zkCallback-3115-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> 2691036 INFO  (zkCallback-3115-thread-1) [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 2691039 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 2691040 INFO  (zkCallback-3115-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> 2691041 INFO  (zkCallback-3115-thread-2) [    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 2691044 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:52147 52147
   [junit4]   2> 2691080 INFO  (Thread-8073) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:52147 52147
   [junit4]   2> 2691083 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[608CC9E0648E1198]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 2691083 INFO  (SUITE-ZkStateReaderTest-seed#[608CC9E0648E1198]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.overseer.ZkStateReaderTest_608CC9E0648E1198-001
   [junit4]   2> Mar 21, 2016 7:42:20 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 4 leaked thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene60): {}, docValues:{}, maxPointsInLeafNode=1112, maxMBSortInHeap=6.742357989146651, sim=RandomSimilarity(queryNorm=true,coord=no): {}, locale=en-CA, timezone=Chile/EasterIsland
   [junit4]   2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_72 (64-bit)/cpus=3,threads=1,free=158865944,total=488636416
   [junit4]   2> NOTE: All tests run in this JVM: [CdcrUpdateLogTest, DistributedVersionInfoTest, TriLevelCompositeIdRoutingTest, WordBreakSolrSpellCheckerTest, TestFilteredDocIdSet, TestDistribIDF, SpatialHeatmapFacetsTest, ResponseHeaderTest, TestSolrJ, TestFuzzyAnalyzedSuggestions, TestRandomFaceting, DefaultValueUpdateProcessorTest, TestMissingGroups, ReplicationFactorTest, TestRawResponseWriter, TestReversedWildcardFilterFactory, CopyFieldTest, HLLSerializationTest, CustomCollectionTest, TestSolrCoreProperties, TestDynamicLoading, TestQuerySenderListener, CoreAdminRequestStatusTest, DistanceUnitsTest, TestCloudPivotFacet, CollectionsAPISolrJTest, TestJsonFacets, ShowFileRequestHandlerTest, LukeRequestHandlerTest, TestMiniSolrCloudClusterBase, TestBinaryResponseWriter, HdfsChaosMonkeyNothingIsSafeTest, TestShardHandlerFactory, MinimalSchemaTest, DebugComponentTest, TestCollationField, TestSuggestSpellingConverter, TestZkChroot, TestHdfsUpdateLog, TestConfigSetProperties, TestSolrIndexConfig, TestNRTOpen, TestCustomDocTransformer, TestFiltering, TestBM25SimilarityFactory, OutputWriterTest, TestNamedUpdateProcessors, DeleteShardTest, SimpleCollectionCreateDeleteTest, SolrInfoMBeanTest, TestRTGBase, DateMathParserTest, SignatureUpdateProcessorFactoryTest, CdcrVersionReplicationTest, TestCSVResponseWriter, TestCoreDiscovery, TestRebalanceLeaders, TestReload, FieldAnalysisRequestHandlerTest, TestSolrQueryResponse, TestHighFrequencyDictionaryFactory, ClassificationUpdateProcessorFactoryTest, UpdateRequestProcessorFactoryTest, TestInfoStreamLogging, AsyncCallRequestStatusResponseTest, SolrPluginUtilsTest, DirectoryFactoryTest, TestClassicSimilarityFactory, TestRuleBasedAuthorizationPlugin, TestSolrQueryParserDefaultOperatorResource, TestConfigSetsAPIZkFailure, ZkNodePropsTest, ResourceLoaderTest, FileUtilsTest, TestReqParamsAPI, TestRecovery, DateFieldTest, RecoveryAfterSoftCommitTest, TestSQLHandler, TestManagedSchema, TestCharFilters, TestManagedResource, HdfsRestartWhileUpdatingTest, NumericFieldsTest, TestAtomicUpdateErrorCases, TestTrackingShardHandlerFactory, IndexSchemaRuntimeFieldTest, AliasIntegrationTest, TestQueryTypes, SharedFSAutoReplicaFailoverTest, TestDistributedMissingSort, TestUtils, TestOrdValues, TestSchemaVersionResource, SolrCoreCheckLockOnStartupTest, OutOfBoxZkACLAndCredentialsProvidersTest, SynonymTokenizerTest, BasicDistributedZk2Test, BigEndianAscendingWordSerializerTest, ParsingFieldUpdateProcessorsTest, TestFieldTypeResource, TestSolr4Spatial, TestSolrQueryParser, DistributedTermsComponentTest, HdfsBasicDistributedZk2Test, BasicZkTest, PluginInfoTest, TestSimpleQParserPlugin, LoggingHandlerTest, TestDistribDocBasedVersion, TestScoreJoinQPScore, ConfigSetsAPITest, LeaderInitiatedRecoveryOnCommitTest, TestConfigSetsAPI, HdfsDirectoryFactoryTest, OverseerStatusTest, TestStandardQParsers, TestTrie, RequestLoggingTest, TestSolrDynamicMBean, TestFieldResource, TestShortCircuitedRequests, TestRestManager, SolrXmlInZkTest, TestFoldingMultitermQuery, SolrIndexSplitterTest, TestRealTimeGet, SuggesterWFSTTest, TestValueSourceCache, RollingRestartTest, BlockJoinFacetRandomTest, TestExclusionRuleCollectionAccess, UniqFieldsUpdateProcessorFactoryTest, TermVectorComponentTest, TestMacros, TestRTimerTree, MultiTermTest, AddSchemaFieldsUpdateProcessorFactoryTest, OverseerCollectionConfigSetProcessorTest, TestDocBasedVersionConstraints, DistributedFacetPivotSmallTest, BasicDistributedZkTest, ChaosMonkeySafeLeaderTest, CollectionsAPIDistributedZkTest, ClusterStateUpdateTest, LeaderElectionTest, ZkSolrClientTest, TestRandomDVFaceting, ShardRoutingCustomTest, AutoCommitTest, TestDistributedGrouping, DistributedSpellCheckComponentTest, TermVectorComponentDistributedTest, ZkControllerTest, TestStressReorder, TestJoin, HardAutoCommitTest, TestRangeQuery, SolrCoreTest, StatsComponentTest, SpellCheckComponentTest, SolrCmdDistributorTest, QueryElevationComponentTest, PeerSyncTest, BadIndexSchemaTest, ConvertedLegacyTest, TestSort, TestFunctionQuery, BasicFunctionalityTest, DirectUpdateHandlerTest, TestBadConfig, TestIndexSearcher, CurrencyFieldOpenExchangeTest, DistributedQueryElevationComponentTest, SimplePostToolTest, SpellCheckCollatorTest, CoreAdminHandlerTest, SuggesterTSTTest, SuggesterTest, TestStressLucene, SpatialFilterTest, TestCSVLoader, NoCacheHeaderTest, SchemaVersionSpecificBehaviorTest, FieldMutatingUpdateProcessorTest, DirectUpdateHandlerOptimizeTest, SortByFunctionTest, DistanceFunctionTest, XsltUpdateRequestHandlerTest, CacheHeaderTest, TestSurroundQueryParser, DisMaxRequestHandlerTest, TestQueryUtils, TestWriterPerf, FileBasedSpellCheckerTest, PathHierarchyTokenizerFactoryTest, MoreLikeThisHandlerTest, RequiredFieldsTest, RegexBoostProcessorTest, IndexSchemaTest, JSONWriterTest, QueryParsingTest, JsonLoaderTest, BinaryUpdateRequestHandlerTest, PingRequestHandlerTest, TestLFUCache, ScriptEngineTest, PreAnalyzedFieldTest, PrimUtilsTest, SpellingQueryConverterTest, RAMDirectoryFactoryTest, CursorPagingTest, TestCrossCoreJoin, TestSimpleTrackingShardHandler, TestTolerantSearch, ConnectionReuseTest, BaseCdcrDistributedZkTest, CdcrReplicationHandlerTest, CdcrRequestHandlerTest, CleanupOldIndexTest, CloudExitableDirectoryReaderTest, CollectionStateFormat2Test, CollectionTooManyReplicasTest, DistribCursorPagingTest, DistribJoinFromCollectionTest, LeaderInitiatedRecoveryOnShardRestartTest, MigrateRouteKeyTest, MultiThreadedOCPTest, OverriddenZkACLAndCredentialsProvidersTest, OverseerRolesTest, OverseerTaskQueueTest, SSLMigrationTest, SaslZkACLProviderTest, ShardSplitTest, TestMiniSolrCloudCluster, HdfsRecoverLeaseTest, ZkStateReaderTest]
   [junit4] Completed [481/581 (1!)] on J1 in 2.27s, 5 tests, 1 error <<< FAILURES!

[...truncated 312 lines...]
BUILD FAILED
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/build.xml:740: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/build.xml:684: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/build.xml:59: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build.xml:233: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/common-build.xml:529: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/common-build.xml:1457: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/lucene/common-build.xml:1014: There were test failures: 581 suites (10 ignored), 2324 tests, 1 error, 86 ignored (70 assumptions) [seed: 608CC9E0648E1198]

Total time: 71 minutes 47 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