You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2016/07/04 05:52:52 UTC
[JENKINS] Lucene-Solr-6.x-Linux (32bit/jdk1.8.0_92) - Build # 1047
- Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Linux/1047/
Java: 32bit/jdk1.8.0_92 -server -XX:+UseConcMarkSweepGC
1 tests failed.
FAILED: org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh
Error Message:
Could not find collection : c1
Stack Trace:
org.apache.solr.common.SolrException: Could not find collection : c1
at __randomizedtesting.SeedInfo.seed([D57D68A4F863A8F5:CAC7195328036E30]:0)
at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:192)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:129)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:43)
at 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 10725 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/J0/temp/solr.cloud.overseer.ZkStateReaderTest_D57D68A4F863A8F5-001/init-core-data-001
[junit4] 2> 104423 INFO (SUITE-ZkStateReaderTest-seed#[D57D68A4F863A8F5]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 104424 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 104424 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 104424 INFO (Thread-760) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 104424 INFO (Thread-760) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 104524 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.ZkTestServer start zk server on port:39106
[junit4] 2> 104525 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 104525 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 104528 INFO (zkCallback-149-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1c79339 name:ZooKeeperConnection Watcher:127.0.0.1:39106 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 104528 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 104529 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 104530 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 104531 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 104532 INFO (zkCallback-150-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6ca06e name:ZooKeeperConnection Watcher:127.0.0.1:39106 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 104532 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 104532 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 104532 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 104537 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 104538 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 104539 INFO (zkCallback-151-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@b8c055 name:ZooKeeperConnection Watcher:127.0.0.1:39106/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 104539 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 104539 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 104540 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 104544 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 104545 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 104546 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 104547 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 104548 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 104548 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 104549 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 104550 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 104550 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 104552 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 104555 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39106 39106
[junit4] 2> 104556 ERROR (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]-EventThread) [ ] o.a.z.ClientCnxn Error while calling watcher
[junit4] 2> java.util.concurrent.RejectedExecutionException: Task org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$8/29011579@644f8c rejected from org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@5bcad8[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:267)
[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> 104556 ERROR (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]-EventThread) [ ] o.a.z.ClientCnxn Error while calling watcher
[junit4] 2> java.util.concurrent.RejectedExecutionException: Task org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$8/29011579@680355 rejected from org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@5bcad8[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:267)
[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> 104557 ERROR (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]-EventThread) [ ] o.a.z.ClientCnxn Error while calling watcher
[junit4] 2> java.util.concurrent.RejectedExecutionException: Task org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$8/29011579@8536e2 rejected from org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@5bcad8[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:267)
[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> 104751 INFO (Thread-760) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39106 39106
[junit4] 2> 104752 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D57D68A4F863A8F5]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithExplicitRefresh -Dtests.seed=D57D68A4F863A8F5 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=es-NI -Dtests.timezone=Asia/Dubai -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.33s J0 | ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh <<<
[junit4] > Throwable #1: org.apache.solr.common.SolrException: Could not find collection : c1
[junit4] > at __randomizedtesting.SeedInfo.seed([D57D68A4F863A8F5:CAC7195328036E30]:0)
[junit4] > at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:192)
[junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:129)
[junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:43)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 104755 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 104755 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 104755 INFO (Thread-761) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 104755 INFO (Thread-761) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 104855 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.ZkTestServer start zk server on port:35454
[junit4] 2> 104855 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 104856 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 104868 INFO (zkCallback-153-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@a43d7e name:ZooKeeperConnection Watcher:127.0.0.1:35454 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 104868 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 104868 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 104869 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 104869 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 104871 INFO (zkCallback-154-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@16ad9e4 name:ZooKeeperConnection Watcher:127.0.0.1:35454 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 104871 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 104872 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 104872 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 104873 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 104883 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 104884 INFO (zkCallback-155-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@115d74a name:ZooKeeperConnection Watcher:127.0.0.1:35454/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 104884 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 104884 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 104885 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 104885 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 104888 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 104888 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 104889 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 104889 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 104890 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 104890 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 104891 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 104892 INFO (zkCallback-155-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 104892 INFO (zkCallback-155-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> 104893 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 104897 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35454 35454
[junit4] 2> 104900 ERROR (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]-EventThread) [ ] o.a.z.ClientCnxn Error while calling watcher
[junit4] 2> java.util.concurrent.RejectedExecutionException: Task org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$8/29011579@3f50a5 rejected from org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@d5ba[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 3]
[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:267)
[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> 110005 INFO (Thread-761) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35454 35454
[junit4] 2> 110006 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 110008 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
[junit4] 2> 110008 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 110008 INFO (Thread-762) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 110008 INFO (Thread-762) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 110108 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.ZkTestServer start zk server on port:35145
[junit4] 2> 110108 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 110109 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 110110 INFO (zkCallback-157-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1995065 name:ZooKeeperConnection Watcher:127.0.0.1:35145 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 110110 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 110111 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 110111 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 110111 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 110112 INFO (zkCallback-158-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@16247bf name:ZooKeeperConnection Watcher:127.0.0.1:35145 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 110112 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 110112 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 110112 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 110114 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 110115 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 110117 INFO (zkCallback-159-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@109f2a3 name:ZooKeeperConnection Watcher:127.0.0.1:35145/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 110117 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 110117 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 110118 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 110118 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 110119 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 110119 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 110120 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 110120 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 110120 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 110121 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 110121 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 110121 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 110122 INFO (zkCallback-159-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 110122 INFO (zkCallback-159-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> 110126 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 110127 INFO (zkCallback-159-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> 110127 INFO (zkCallback-159-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for collection [c1] has occurred - updating... (live nodes size: [0])
[junit4] 2> 110128 INFO (zkCallback-159-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 110129 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35145 35145
[junit4] 2> 110250 INFO (Thread-762) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35145 35145
[junit4] 2> 110251 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D57D68A4F863A8F5]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
[junit4] 2> 110252 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
[junit4] 2> 110252 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 110253 INFO (Thread-763) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 110253 INFO (Thread-763) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 110353 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.ZkTestServer start zk server on port:35418
[junit4] 2> 110353 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 110353 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 110355 INFO (zkCallback-161-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3ee22b name:ZooKeeperConnection Watcher:127.0.0.1:35418 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 110355 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 110355 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 110356 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 110356 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 110358 INFO (zkCallback-162-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@8335ea name:ZooKeeperConnection Watcher:127.0.0.1:35418 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 110358 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 110358 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 110358 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 110360 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 110360 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 110361 INFO (zkCallback-163-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@12073 name:ZooKeeperConnection Watcher:127.0.0.1:35418/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 110361 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 110361 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 110361 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 110362 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 110362 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 110363 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 110363 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 110364 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 110364 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 110364 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 110365 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 110365 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 110365 INFO (zkCallback-163-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 110367 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 110368 INFO (zkCallback-163-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for collection [c1] has occurred - updating... (live nodes size: [0])
[junit4] 2> 110368 INFO (zkCallback-163-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 110369 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35418 35418
[junit4] 2> 110397 INFO (Thread-763) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35418 35418
[junit4] 2> 110398 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D57D68A4F863A8F5]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
[junit4] 2> 110400 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
[junit4] 2> 110400 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 110400 INFO (Thread-764) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 110400 INFO (Thread-764) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 110500 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.ZkTestServer start zk server on port:43660
[junit4] 2> 110500 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 110501 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 110502 INFO (zkCallback-165-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@681e2f name:ZooKeeperConnection Watcher:127.0.0.1:43660 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 110502 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 110503 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 110503 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 110504 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 110504 INFO (zkCallback-166-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1202361 name:ZooKeeperConnection Watcher:127.0.0.1:43660 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 110504 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 110505 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 110505 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 110506 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 110506 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 110507 INFO (zkCallback-167-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3ab775 name:ZooKeeperConnection Watcher:127.0.0.1:43660/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 110507 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 110507 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 110507 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 110508 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 110508 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 110508 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 110509 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 110509 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 110509 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 110511 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 110511 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 110524 INFO (zkCallback-167-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 110524 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 110525 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 110527 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:43660 43660
[junit4] 2> 120544 INFO (Thread-764) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:43660 43660
[junit4] 2> 120545 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D57D68A4F863A8F5]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
[junit4] 2> 120547 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 120547 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 120547 INFO (Thread-765) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 120547 INFO (Thread-765) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 120647 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.ZkTestServer start zk server on port:40200
[junit4] 2> 120647 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 120648 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 120649 INFO (zkCallback-169-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@a0f199 name:ZooKeeperConnection Watcher:127.0.0.1:40200 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 120649 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 120649 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 120650 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 120651 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 120652 INFO (zkCallback-170-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@11653f4 name:ZooKeeperConnection Watcher:127.0.0.1:40200 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 120652 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 120652 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 120652 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 120653 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 120654 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 120655 INFO (zkCallback-171-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@12a7950 name:ZooKeeperConnection Watcher:127.0.0.1:40200/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 120655 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 120655 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 120655 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 120656 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 120656 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 120657 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 120657 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 120658 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 120658 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 120659 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 120659 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 120660 INFO (zkCallback-171-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 120660 INFO (zkCallback-171-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> 120661 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 120661 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 120661 INFO (zkCallback-171-thread-1) [ ] o.a.s.c.c.ZkStateReader Uninteresting collection c1
[junit4] 2> 120661 INFO (zkCallback-171-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> 120663 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 120664 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:40200 40200
[junit4] 2> 120679 INFO (Thread-765) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:40200 40200
[junit4] 2> 120679 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D57D68A4F863A8F5]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 120680 INFO (SUITE-ZkStateReaderTest-seed#[D57D68A4F863A8F5]-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/J0/temp/solr.cloud.overseer.ZkStateReaderTest_D57D68A4F863A8F5-001
[junit4] 2> Jul 04, 2016 5:21:01 AM 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(Lucene62): {}, docValues:{}, maxPointsInLeafNode=808, maxMBSortInHeap=5.458880935274054, sim=RandomSimilarity(queryNorm=true,coord=crazy): {}, locale=es-NI, timezone=Asia/Dubai
[junit4] 2> NOTE: Linux 4.4.0-24-generic i386/Oracle Corporation 1.8.0_92 (32-bit)/cpus=12,threads=1,free=90846864,total=154210304
[junit4] 2> NOTE: All tests run in this JVM: [TestRandomDVFaceting, TestSolrConfigHandlerConcurrent, TestUniqueKeyFieldResource, PrimUtilsTest, TestFieldTypeCollectionResource, SolrCoreTest, TestConfigSetProperties, DistributedFacetPivotSmallTest, RequiredFieldsTest, AnalyticsQueryTest, TestIBSimilarityFactory, AlternateDirectoryTest, BlockCacheTest, PreAnalyzedFieldTest, TestDefaultStatsCache, TestFieldCacheWithThreads, TestReloadDeadlock, HdfsDirectoryTest, TestSolr4Spatial, CursorPagingTest, TestOverriddenPrefixQueryForCustomFieldType, ZkStateReaderTest]
[junit4] Completed [41/619 (1!)] on J0 in 17.29s, 6 tests, 1 error <<< FAILURES!
[...truncated 1873 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:530: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/lucene/common-build.xml:1427: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/lucene/common-build.xml:984: There were test failures: 619 suites (10 ignored), 2597 tests, 1 error, 116 ignored (71 assumptions) [seed: D57D68A4F863A8F5]
Total time: 58 minutes 6 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