Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.5-Linux/262/
Java: 32bit/jdk1.8.0_92 -server -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([9785C6EF51156FA0:883FB7188175A965]: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:745)
Build Log:
[...truncated 11173 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/J2/temp/solr.cloud.overseer.ZkStateReaderTest_9785C6EF51156FA0-001/init-core-data-001
[junit4] 2> 651683 INFO
(SUITE-ZkStateReaderTest-seed#[9785C6EF51156FA0]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 651684 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 651684 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 651684 INFO (Thread-1321) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 651685 INFO (Thread-1321) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 651785 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.ZkTestServer start zk server on port:37497
[junit4] 2> 651785 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 651785 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 651787 INFO (zkCallback-21586-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@5f1ac2 name:ZooKeeperConnection
Watcher:127.0.0.1:37497 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 651787 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 651787 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 651788 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 651788 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 651788 INFO (zkCallback-21587-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1d535f6 name:ZooKeeperConnection
Watcher:127.0.0.1:37497 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 651788 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 651789 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 651789 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 651796 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 651796 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 651797 INFO (zkCallback-21588-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1fc2956 name:ZooKeeperConnection
Watcher:127.0.0.1:37497/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 651797 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 651797 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 651797 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 651798 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 651798 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 651799 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 651799 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 651800 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 651800 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 651801 INFO (zkCallback-21588-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 651801 INFO (zkCallback-21588-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> 651802 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 651802 INFO (zkCallback-21588-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> 651803 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37497 37497
[junit4] 2> 651818 INFO (Thread-1321) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:37497 37497
[junit4] 2> 651819 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 651822 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
[junit4] 2> 651822 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 651822 INFO (Thread-1322) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 651822 INFO (Thread-1322) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 651922 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.ZkTestServer start zk server on port:36373
[junit4] 2> 651922 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 651923 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 651924 INFO (zkCallback-21589-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@15223e5 name:ZooKeeperConnection
Watcher:127.0.0.1:36373 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 651924 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 651925 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 651925 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 651926 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 651926 INFO (zkCallback-21590-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1388173 name:ZooKeeperConnection
Watcher:127.0.0.1:36373 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 651926 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 651927 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 651927 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 651928 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 651928 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 651929 INFO (zkCallback-21591-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1fa29fd name:ZooKeeperConnection
Watcher:127.0.0.1:36373/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 651929 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 651929 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 651929 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 651930 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 651930 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 651931 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 651931 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 651932 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 651932 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 651933 INFO (zkCallback-21591-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 651933 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 651934 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
[junit4] 2> 651934 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 651934 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ZkStateReader Removing watch for uninteresting collection [c1]
[junit4] 2> 651945 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36373 36373
[junit4] 2> 651964 INFO (Thread-1322) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:36373 36373
[junit4] 2> 651965 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[9785C6EF51156FA0])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
[junit4] 2> 651969 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
[junit4] 2> 651969 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 651969 INFO (Thread-1323) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 651969 INFO (Thread-1323) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 652069 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.ZkTestServer start zk server on port:43271
[junit4] 2> 652069 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 652070 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 652074 INFO (zkCallback-21592-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@2e848 name:ZooKeeperConnection
Watcher:127.0.0.1:43271 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 652074 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 652075 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 652075 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 652075 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 652076 INFO (zkCallback-21593-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@af0847 name:ZooKeeperConnection
Watcher:127.0.0.1:43271 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 652076 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 652076 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 652076 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 652078 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 652078 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 652079 INFO (zkCallback-21594-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@a93f1b name:ZooKeeperConnection
Watcher:127.0.0.1:43271/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 652079 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 652079 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 652079 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 652080 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 652080 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 652081 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 652081 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 652082 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 652082 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
[junit4] 2> 652083 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 652083 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 652083 INFO (zkCallback-21594-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 652084 INFO (zkCallback-21594-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> 652086 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 652087 INFO (zkCallback-21594-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> 652087 INFO (zkCallback-21594-thread-1) [ ]
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 652088 INFO (zkCallback-21594-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> 652140 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:43271 43271
[junit4] 2> 652168 INFO (Thread-1323) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:43271 43271
[junit4] 2> 652168 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[9785C6EF51156FA0])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
[junit4] 2> 652171 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
[junit4] 2> 652171 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 652171 INFO (Thread-1324) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 652171 INFO (Thread-1324) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 652271 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.ZkTestServer start zk server on port:43046
[junit4] 2> 652271 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 652272 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 652273 INFO (zkCallback-21595-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@ce3ee4 name:ZooKeeperConnection
Watcher:127.0.0.1:43046 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 652273 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 652273 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 652274 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 652274 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 652275 INFO (zkCallback-21596-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@114f190 name:ZooKeeperConnection
Watcher:127.0.0.1:43046 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 652275 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 652275 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 652275 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 652276 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 652278 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 652279 INFO (zkCallback-21597-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1fbf1ab name:ZooKeeperConnection
Watcher:127.0.0.1:43046/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 652279 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 652279 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 652279 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 652280 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 652280 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 652280 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 652281 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 652281 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 652282 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
[junit4] 2> 652282 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 652282 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 652282 INFO (zkCallback-21597-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 652284 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 652284 INFO (zkCallback-21597-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> 652284 INFO (zkCallback-21597-thread-1) [ ]
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 652335 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:43046 43046
[junit4] 2> 652350 INFO (Thread-1324) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:43046 43046
[junit4] 2> 652350 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[9785C6EF51156FA0])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
[junit4] 2> 652353 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.SolrTestCaseJ4 ###Starting
testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 652353 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 652353 INFO (Thread-1325) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 652353 INFO (Thread-1325) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 652453 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.ZkTestServer start zk server on port:35853
[junit4] 2> 652454 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 652454 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 652455 INFO (zkCallback-21598-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1e5ac31 name:ZooKeeperConnection
Watcher:127.0.0.1:35853 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 652455 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 652456 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 652456 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 652456 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 652457 INFO (zkCallback-21599-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@b41de name:ZooKeeperConnection
Watcher:127.0.0.1:35853 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 652457 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 652457 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 652457 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 652466 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 652466 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 652467 INFO (zkCallback-21600-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@359927 name:ZooKeeperConnection
Watcher:127.0.0.1:35853/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 652467 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 652468 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 652468 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 652468 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 652469 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 652470 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 652471 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 652471 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 652471 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
[junit4] 2> 652472 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 652472 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 652473 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 652476 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x1547db2e9470002, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 652476 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35853 35853
[junit4] 2> 652477 ERROR
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0]-EventThread)
[ ] o.a.z.ClientCnxn Error while calling watcher
[junit4] 2> java.util.concurrent.RejectedExecutionException: Task
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1@32fce9
rejected from
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@d73f7[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: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> 652477 ERROR
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0]-EventThread)
[ ] o.a.z.ClientCnxn Error while calling watcher
[junit4] 2> java.util.concurrent.RejectedExecutionException: Task
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1@146e494
rejected from
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@d73f7[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: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> 652477 ERROR
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0]-EventThread)
[ ] o.a.z.ClientCnxn Error while calling watcher
[junit4] 2> java.util.concurrent.RejectedExecutionException: Task
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1@1f9c5d6
rejected from
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@d73f7[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: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> 652567 INFO (Thread-1325) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:35853 35853
[junit4] 2> 652568 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[9785C6EF51156FA0])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest
-Dtests.method=testStateFormatUpdateWithExplicitRefresh
-Dtests.seed=9785C6EF51156FA0 -Dtests.multiplier=3 -Dtests.slow=true
-Dtests.locale=vi-VN -Dtests.timezone=Africa/Douala -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] ERROR 0.22s J2 |
ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh <<<
[junit4] > Throwable #1: org.apache.solr.common.SolrException: Could not
find collection : c1
[junit4] > at
__randomizedtesting.SeedInfo.seed([9785C6EF51156FA0:883FB7188175A965]: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:745)
[junit4] 2> 652573 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.SolrTestCaseJ4 ###Starting
testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 652574 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 652574 INFO (Thread-1326) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 652574 INFO (Thread-1326) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 652674 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.ZkTestServer start zk server on port:34716
[junit4] 2> 652674 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 652674 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 652676 INFO (zkCallback-21601-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1dcd6e6 name:ZooKeeperConnection
Watcher:127.0.0.1:34716 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 652676 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 652676 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 652677 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 652677 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 652677 INFO (zkCallback-21602-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@11b980a name:ZooKeeperConnection
Watcher:127.0.0.1:34716 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 652678 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 652678 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 652678 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 652679 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 652679 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 652680 INFO (zkCallback-21603-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1040231 name:ZooKeeperConnection
Watcher:127.0.0.1:34716/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 652680 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 652680 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 652680 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 652681 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 652681 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 652681 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 652682 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 652682 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 652683 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 652683 INFO (zkCallback-21603-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 652684 INFO (zkCallback-21603-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> 652684 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 652685 INFO (zkCallback-21603-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> 652686 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34716 34716
[junit4] 2> 652748 INFO (Thread-1326) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:34716 34716
[junit4] 2> 652748 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[9785C6EF51156FA0])
[ ] o.a.s.SolrTestCaseJ4 ###Ending
testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 652749 INFO
(SUITE-ZkStateReaderTest-seed#[9785C6EF51156FA0]-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/J2/temp/solr.cloud.overseer.ZkStateReaderTest_9785C6EF51156FA0-001
[junit4] 2> May 04, 2016 9:35:58 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 4 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene54): {},
docValues:{}, sim=RandomSimilarity(queryNorm=false,coord=no): {}, locale=vi-VN,
timezone=Africa/Douala
[junit4] 2> NOTE: Linux 4.2.0-35-generic i386/Oracle Corporation 1.8.0_92
(32-bit)/cpus=12,threads=1,free=235380424,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [SolrTestCaseJ4Test,
SuggesterTest, TestStressLiveNodes, TestConfigOverlay, SuggesterWFSTTest,
TestSolrJ, TestManagedSchemaFieldTypeResource,
TestPerFieldSimilarityWithDefaultOverride, RegexBoostProcessorTest,
TestTrackingShardHandlerFactory, TestRequestStatusCollectionAPI,
TestSearcherReuse, HardAutoCommitTest, TestSerializedLuceneMatchVersion,
TestSolrQueryParser, FullSolrCloudDistribCmdsTest,
CoreMergeIndexesAdminHandlerTest, TestCollationField, TestObjectReleaseTracker,
DeleteReplicaTest, DistributedFacetPivotLargeTest, DebugComponentTest,
ShowFileRequestHandlerTest, TestTrieFacet, TestHdfsUpdateLog,
SolrCoreCheckLockOnStartupTest, TestPostingsSolrHighlighter,
TestJmxMonitoredMap, TestRawTransformer, TestFieldTypeResource,
ClusterStateTest, SearchHandlerTest, AssignTest, RestartWhileUpdatingTest,
TestJmxIntegration, TestFuzzyAnalyzedSuggestions, BitVectorTest,
TestIndexingPerformance, TestExtendedDismaxParser, RulesTest,
TestDistributedStatsComponentCardinality, TestInfoStreamLogging,
BinaryUpdateRequestHandlerTest, LukeRequestHandlerTest,
TestSuggestSpellingConverter, TestCollapseQParserPlugin, AtomicUpdatesTest,
TestNamedUpdateProcessors, HttpPartitionTest, TestCoreDiscovery,
TestJsonRequest, TestCloudInspectUtil, HdfsBasicDistributedZk2Test,
ZkStateReaderTest]
[junit4] Completed [180/572 (1!)] on J2 in 2.08s, 6 tests, 1 error <<<
FAILURES!
[...truncated 1244 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-5.5-Linux/build.xml:750: The following
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.5-Linux/build.xml:694: The following
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.5-Linux/build.xml:59: The following error
occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.5-Linux/solr/build.xml:233: The following
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.5-Linux/solr/common-build.xml:534: The
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.5-Linux/lucene/common-build.xml:1477: The
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.5-Linux/lucene/common-build.xml:1033:
There were test failures: 572 suites (7 ignored), 2293 tests, 1 error, 84
ignored (39 assumptions) [seed: 9785C6EF51156FA0]
Total time: 59 minutes 31 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
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]