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 2017/10/23 09:07:38 UTC
[JENKINS] Lucene-Solr-5.5-Linux (64bit/jdk1.8.0_144) - Build # 498
- Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-5.5-Linux/498/
Java: 64bit/jdk1.8.0_144 -XX:+UseCompressedOops -XX:+UseG1GC
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([D1D4A64438CE641B:CE6ED7B3E8AEA2DE]:0)
at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:136)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:42)
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:748)
Build Log:
[...truncated 10950 lines...]
[junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-5.5-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_D1D4A64438CE641B-001/init-core-data-001
[junit4] 2> 319393 INFO (SUITE-ZkStateReaderTest-seed#[D1D4A64438CE641B]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 319394 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
[junit4] 2> 319394 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 319394 INFO (Thread-1322) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 319394 INFO (Thread-1322) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 319494 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.ZkTestServer start zk server on port:45601
[junit4] 2> 319494 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 319494 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 319496 INFO (zkCallback-433-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@34e27240 name:ZooKeeperConnection Watcher:127.0.0.1:45601 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 319496 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 319496 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 319496 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 319497 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 319498 INFO (zkCallback-434-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@51c9481 name:ZooKeeperConnection Watcher:127.0.0.1:45601 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 319498 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 319498 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 319498 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 319500 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 319500 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 319500 INFO (zkCallback-435-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@32733140 name:ZooKeeperConnection Watcher:127.0.0.1:45601/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 319500 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 319500 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 319501 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 319501 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 319501 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 319501 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 319502 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 319502 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 319502 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 319503 INFO (zkCallback-435-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 319503 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 319503 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
[junit4] 2> 319503 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 319503 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ZkStateReader Removing watch for uninteresting collection [c1]
[junit4] 2> 319504 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45601 45601
[junit4] 2> 324544 INFO (Thread-1322) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45601 45601
[junit4] 2> 324544 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[D1D4A64438CE641B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
[junit4] 2> 324545 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 324545 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 324546 INFO (Thread-1323) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 324546 INFO (Thread-1323) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 324646 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.ZkTestServer start zk server on port:42317
[junit4] 2> 324646 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 324646 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 324647 INFO (zkCallback-436-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4d19ad0c name:ZooKeeperConnection Watcher:127.0.0.1:42317 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 324647 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 324647 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 324648 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 324648 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 324649 INFO (zkCallback-437-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7c90d719 name:ZooKeeperConnection Watcher:127.0.0.1:42317 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 324649 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 324649 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 324649 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 324649 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 324650 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 324650 INFO (zkCallback-438-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@204155b6 name:ZooKeeperConnection Watcher:127.0.0.1:42317/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 324650 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 324650 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 324650 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 324651 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 324652 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 324652 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 324652 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 324652 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 324652 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 324653 INFO (zkCallback-438-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 324653 INFO (zkCallback-438-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> 324653 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 324653 INFO (zkCallback-438-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> 324654 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42317 42317
[junit4] 2> 324690 INFO (Thread-1323) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42317 42317
[junit4] 2> 324690 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 324692 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
[junit4] 2> 324692 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 324692 INFO (Thread-1324) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 324692 INFO (Thread-1324) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 324792 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.ZkTestServer start zk server on port:45395
[junit4] 2> 324792 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 324793 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 324795 INFO (zkCallback-439-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1bf9f57a name:ZooKeeperConnection Watcher:127.0.0.1:45395 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 324795 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 324795 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 324796 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 324796 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 324797 INFO (zkCallback-440-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@73a5ffb8 name:ZooKeeperConnection Watcher:127.0.0.1:45395 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 324797 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 324798 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 324798 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 324799 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 324800 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 324801 INFO (zkCallback-441-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6b23fb05 name:ZooKeeperConnection Watcher:127.0.0.1:45395/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 324801 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 324801 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 324802 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 324803 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 324804 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 324804 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 324805 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 324805 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 324806 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
[junit4] 2> 324806 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 324806 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 324807 INFO (zkCallback-441-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 324807 INFO (zkCallback-441-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> 324808 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 324808 INFO (zkCallback-441-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> 324809 INFO (zkCallback-441-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 324809 INFO (zkCallback-441-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> 324860 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45395 45395
[junit4] 2> 329609 INFO (Thread-1324) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45395 45395
[junit4] 2> 329610 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[D1D4A64438CE641B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
[junit4] 2> 329612 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 329612 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 329612 INFO (Thread-1325) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 329612 INFO (Thread-1325) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 329712 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.ZkTestServer start zk server on port:42031
[junit4] 2> 329712 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 329713 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 329715 INFO (zkCallback-442-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@53b56dcc name:ZooKeeperConnection Watcher:127.0.0.1:42031 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 329715 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 329715 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 329716 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 329718 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 329719 INFO (zkCallback-443-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7def8be3 name:ZooKeeperConnection Watcher:127.0.0.1:42031 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 329719 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 329720 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 329720 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 329721 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 329724 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 329725 INFO (zkCallback-444-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@30c37b6e name:ZooKeeperConnection Watcher:127.0.0.1:42031/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 329725 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 329725 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 329726 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 329726 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 329727 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 329728 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 329728 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 329729 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 329730 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 329730 INFO (zkCallback-444-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 329731 INFO (zkCallback-444-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> 329732 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 329732 INFO (zkCallback-444-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> 329734 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42031 42031
[junit4] 2> 334891 INFO (Thread-1325) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42031 42031
[junit4] 2> 334891 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[D1D4A64438CE641B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 334892 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 334892 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 334892 INFO (Thread-1326) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 334892 INFO (Thread-1326) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 334992 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.ZkTestServer start zk server on port:46087
[junit4] 2> 334993 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 334993 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 334994 INFO (zkCallback-445-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@11afb5e1 name:ZooKeeperConnection Watcher:127.0.0.1:46087 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 334994 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 334994 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 334995 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 334995 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 334995 INFO (zkCallback-446-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7a454c41 name:ZooKeeperConnection Watcher:127.0.0.1:46087 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 334996 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 334996 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 334996 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 334997 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 334997 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 334998 INFO (zkCallback-447-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@177a5c0 name:ZooKeeperConnection Watcher:127.0.0.1:46087/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 334998 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 334998 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 334998 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 334999 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 334999 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 335000 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 335000 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 335000 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 335000 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
[junit4] 2> 335001 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 335001 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 335002 INFO (zkCallback-447-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 335003 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 335005 INFO (zkCallback-447-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> 335005 ERROR (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]-EventThread) [ ] o.a.z.ClientCnxn Error while calling watcher
[junit4] 2> java.util.concurrent.RejectedExecutionException: Task org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1@739bf771 rejected from org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@36997766[Shutting down, pool size = 2, active threads = 2, queued tasks = 0, completed tasks = 1]
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2063)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:830)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1379)
[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:261)
[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> 335005 WARN (zkCallback-447-thread-2) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /clusterstate.json]
[junit4] 2> 335006 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:46087 46087
[junit4] 2> 340071 INFO (Thread-1326) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:46087 46087
[junit4] 2> 340072 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[D1D4A64438CE641B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithExplicitRefresh -Dtests.seed=D1D4A64438CE641B -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sr-RS -Dtests.timezone=America/Antigua -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 5.18s J0 | ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh <<<
[junit4] > Throwable #1: org.apache.solr.common.SolrException: Could not find collection : c1
[junit4] > at __randomizedtesting.SeedInfo.seed([D1D4A64438CE641B:CE6ED7B3E8AEA2DE]:0)
[junit4] > at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
[junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:136)
[junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:42)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 340075 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
[junit4] 2> 340075 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 340076 INFO (Thread-1327) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 340076 INFO (Thread-1327) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 340176 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.ZkTestServer start zk server on port:35329
[junit4] 2> 340176 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 340176 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 340178 INFO (zkCallback-448-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@23e215d name:ZooKeeperConnection Watcher:127.0.0.1:35329 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 340178 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 340178 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 340179 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 340180 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 340181 INFO (zkCallback-449-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@632bf6a2 name:ZooKeeperConnection Watcher:127.0.0.1:35329 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 340181 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 340181 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 340181 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 340184 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 340185 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 340185 INFO (zkCallback-450-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6a3931cb name:ZooKeeperConnection Watcher:127.0.0.1:35329/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 340186 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 340186 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 340186 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 340187 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 340188 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 340189 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 340190 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 340190 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 340191 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
[junit4] 2> 340191 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 340191 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 340192 INFO (zkCallback-450-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 340193 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 340193 INFO (zkCallback-450-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> 340193 INFO (zkCallback-450-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 340244 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35329 35329
[junit4] 2> 341173 INFO (Thread-1327) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35329 35329
[junit4] 2> 341173 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D1D4A64438CE641B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
[junit4] 2> 341174 INFO (SUITE-ZkStateReaderTest-seed#[D1D4A64438CE641B]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-5.5-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_D1D4A64438CE641B-001
[junit4] 2> NOTE: test params are: codec=CheapBastard, sim=DefaultSimilarity, locale=sr-RS, timezone=America/Antigua
[junit4] 2> NOTE: Linux 4.10.0-33-generic amd64/Oracle Corporation 1.8.0_144 (64-bit)/cpus=8,threads=1,free=157614496,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [TestSolrQueryParserDefaultOperatorResource, SecurityConfHandlerTest, BlockJoinFacetDistribTest, ResponseLogComponentTest, TestRangeQuery, TestSchemaManager, AnalyticsMergeStrategyTest, TestDocBasedVersionConstraints, DeleteInactiveReplicaTest, SignatureUpdateProcessorFactoryTest, TestBlendedInfixSuggestions, TestMergePolicyConfig, PrimUtilsTest, QueryResultKeyTest, HdfsRecoverLeaseTest, EchoParamsTest, MigrateRouteKeyTest, IndexSchemaRuntimeFieldTest, TestPivotHelperCode, TestManagedResourceStorage, BufferStoreTest, TestMiniSolrCloudCluster, EnumFieldTest, RAMDirectoryFactoryTest, TestManagedSchemaDynamicFieldResource, CleanupOldIndexTest, URLClassifyProcessorTest, PingRequestHandlerTest, TestComplexPhraseQParserPlugin, XsltUpdateRequestHandlerTest, TestSolrConfigHandler, TestBadConfig, TestSimpleQParserPlugin, ZkStateReaderTest]
[junit4] Completed [109/575 (1!)] on J0 in 21.79s, 6 tests, 1 error <<< FAILURES!
[...truncated 58142 lines...]