Build: http://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Linux/824/
Java: 32bit/jdk1.8.0_92 -client -XX:+UseParallelGC
1 tests failed.
FAILED:
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay
Error Message:
Stack Trace:
java.util.concurrent.TimeoutException
at
__randomizedtesting.SeedInfo.seed([DC25DA3E1E422345:A3BB6DBB77200ECF]:0)
at
org.apache.solr.common.cloud.ZkStateReader.waitForState(ZkStateReader.java:1200)
at
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:126)
at
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay(ZkStateReaderTest.java:54)
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 12184 lines...]
[junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.overseer.ZkStateReaderTest_DC25DA3E1E422345-001/init-core-data-001
[junit4] 2> 1507178 INFO
(SUITE-ZkStateReaderTest-seed#[DC25DA3E1E422345]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 1507180 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
[junit4] 2> 1507181 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1507181 INFO (Thread-4188) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1507181 INFO (Thread-4188) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1507281 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.ZkTestServer start zk server on port:36578
[junit4] 2> 1507281 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1507281 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1507284 INFO (zkCallback-1942-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@cf1fce name:ZooKeeperConnection
Watcher:127.0.0.1:36578 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1507284 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1507284 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1507285 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1507285 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1507286 INFO (zkCallback-1943-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@434b41 name:ZooKeeperConnection
Watcher:127.0.0.1:36578 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1507286 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1507287 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1507287 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1507289 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1507290 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1507290 INFO (zkCallback-1944-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@43ed19 name:ZooKeeperConnection
Watcher:127.0.0.1:36578/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 1507290 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1507290 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1507291 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1507292 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1507293 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1507294 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1507295 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1507296 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1507296 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 1507297 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1507297 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1507298 INFO (zkCallback-1944-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1507299 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 1507300 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 1507301 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36578 36578
[junit4] 2> 1507436 INFO (Thread-4188) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:36578 36578
[junit4] 2> 1507438 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DC25DA3E1E422345])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
[junit4] 2> 1507440 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 1507441 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1507441 INFO (Thread-4189) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1507441 INFO (Thread-4189) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1507541 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.ZkTestServer start zk server on port:45289
[junit4] 2> 1507541 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1507542 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1507544 INFO (zkCallback-1946-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1a870b5 name:ZooKeeperConnection
Watcher:127.0.0.1:45289 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1507544 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1507545 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1507545 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1507546 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1507547 INFO (zkCallback-1947-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@6ad017 name:ZooKeeperConnection
Watcher:127.0.0.1:45289 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1507548 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1507549 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1507549 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1507550 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1507551 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1507552 INFO (zkCallback-1948-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@13f609f name:ZooKeeperConnection
Watcher:127.0.0.1:45289/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 1507552 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1507552 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1507552 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1507553 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1507553 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1507554 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1507555 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1507556 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1507557 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 1507557 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1507558 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1507558 INFO (zkCallback-1948-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1507559 INFO (zkCallback-1948-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> 1507561 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 1507562 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 1507562 INFO (zkCallback-1948-thread-1) [ ]
o.a.s.c.c.ZkStateReader Uninteresting collection c1
[junit4] 2> 1507562 INFO (zkCallback-1948-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> 1507563 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 1507564 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45289 45289
[junit4] 2> 1507578 INFO (Thread-4189) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:45289 45289
[junit4] 2> 1507580 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 1507583 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.SolrTestCaseJ4 ###Starting
testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 1507584 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1507584 INFO (Thread-4190) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1507584 INFO (Thread-4190) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1507684 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.ZkTestServer start zk server on port:38433
[junit4] 2> 1507684 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1507685 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1507687 INFO (zkCallback-1950-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@b81e84 name:ZooKeeperConnection
Watcher:127.0.0.1:38433 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1507687 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1507689 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1507690 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1507690 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1507691 INFO (zkCallback-1951-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@75a684 name:ZooKeeperConnection
Watcher:127.0.0.1:38433 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1507691 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1507691 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1507691 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1507693 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1507693 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1507694 INFO (zkCallback-1952-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@14607b2 name:ZooKeeperConnection
Watcher:127.0.0.1:38433/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 1507694 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1507695 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1507695 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1507695 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1507696 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1507697 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1507697 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1507698 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1507698 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 1507698 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1507701 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1507701 INFO (zkCallback-1952-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1507702 INFO (zkCallback-1952-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> 1507703 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 1507704 INFO (zkCallback-1952-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> 1507705 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38433 38433
[junit4] 2> 1507804 INFO (Thread-4190) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:38433 38433
[junit4] 2> 1507805 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[DC25DA3E1E422345])
[ ] o.a.s.SolrTestCaseJ4 ###Ending
testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 1507809 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
[junit4] 2> 1507809 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1507809 INFO (Thread-4191) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1507809 INFO (Thread-4191) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1507909 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.ZkTestServer start zk server on port:38020
[junit4] 2> 1507909 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1507910 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1507912 INFO (zkCallback-1954-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@b54fbe name:ZooKeeperConnection
Watcher:127.0.0.1:38020 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1507912 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1507912 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1507913 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1507913 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1507914 INFO (zkCallback-1955-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1151e0b name:ZooKeeperConnection
Watcher:127.0.0.1:38020 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1507914 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1507915 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1507915 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1507917 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1507917 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1507918 INFO (zkCallback-1956-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1a348d0 name:ZooKeeperConnection
Watcher:127.0.0.1:38020/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 1507919 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1507919 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1507920 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1507921 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1507922 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1507922 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1507923 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1507924 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1507924 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 1507925 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1507926 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 1507926 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1507927 INFO (zkCallback-1956-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1507929 INFO (zkCallback-1956-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> 1507929 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 1507930 INFO (zkCallback-1956-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> 1507930 INFO (zkCallback-1956-thread-1) [ ]
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 1507931 INFO (zkCallback-1956-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> 1537932 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38020 38020
[junit4] 2> 1537950 INFO (Thread-4191) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:38020 38020
[junit4] 2> 1537952 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[DC25DA3E1E422345])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest
-Dtests.method=testStateFormatUpdateWithTimeDelay -Dtests.seed=DC25DA3E1E422345
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=vi -Dtests.timezone=IET
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 30.1s J2 |
ZkStateReaderTest.testStateFormatUpdateWithTimeDelay <<<
[junit4] > Throwable #1: java.util.concurrent.TimeoutException
[junit4] > at
__randomizedtesting.SeedInfo.seed([DC25DA3E1E422345:A3BB6DBB77200ECF]:0)
[junit4] > at
org.apache.solr.common.cloud.ZkStateReader.waitForState(ZkStateReader.java:1200)
[junit4] > at
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:126)
[junit4] > at
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay(ZkStateReaderTest.java:54)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 1537956 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
[junit4] 2> 1537956 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1537956 INFO (Thread-4192) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1537956 INFO (Thread-4192) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1538056 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.ZkTestServer start zk server on port:35713
[junit4] 2> 1538056 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1538057 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1538058 INFO (zkCallback-1958-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@50934a name:ZooKeeperConnection
Watcher:127.0.0.1:35713 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1538058 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1538059 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1538060 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1538060 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1538061 INFO (zkCallback-1959-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1fb9652 name:ZooKeeperConnection
Watcher:127.0.0.1:35713 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1538061 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1538061 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1538061 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1538063 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1538065 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1538066 INFO (zkCallback-1960-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@f66feb name:ZooKeeperConnection
Watcher:127.0.0.1:35713/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 1538066 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1538066 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1538067 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1538067 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1538068 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1538069 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1538069 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1538070 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1538070 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 1538070 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1538071 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 1538072 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1538072 INFO (zkCallback-1960-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1538073 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 1538073 INFO (zkCallback-1960-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> 1538074 INFO (zkCallback-1960-thread-1) [ ]
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 1538075 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35713 35713
[junit4] 2> 1538296 INFO (Thread-4192) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:35713 35713
[junit4] 2> 1538297 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[DC25DA3E1E422345])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
[junit4] 2> 1538299 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.SolrTestCaseJ4 ###Starting
testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 1538300 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1538300 INFO (Thread-4193) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1538300 INFO (Thread-4193) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1538400 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.ZkTestServer start zk server on port:44993
[junit4] 2> 1538400 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1538401 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1538402 INFO (zkCallback-1962-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1853688 name:ZooKeeperConnection
Watcher:127.0.0.1:44993 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1538402 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1538403 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1538404 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1538404 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1538405 INFO (zkCallback-1963-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@e68354 name:ZooKeeperConnection
Watcher:127.0.0.1:44993 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1538405 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1538405 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1538405 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1538406 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1538407 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1538408 INFO (zkCallback-1964-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@60f66 name:ZooKeeperConnection
Watcher:127.0.0.1:44993/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 1538408 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1538408 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1538408 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1538409 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1538410 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1538410 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1538411 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1538411 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1538411 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 1538412 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1538412 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 1538413 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1538413 INFO (zkCallback-1964-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1538413 INFO (zkCallback-1964-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> 1538414 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 1538414 INFO (zkCallback-1964-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> 1538414 INFO (zkCallback-1964-thread-1) [ ]
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 1538415 INFO (zkCallback-1964-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> 1538415 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44993 44993
[junit4] 2> 1538431 INFO (Thread-4193) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:44993 44993
[junit4] 2> 1538432 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[DC25DA3E1E422345])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 1538433 INFO
(SUITE-ZkStateReaderTest-seed#[DC25DA3E1E422345]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.overseer.ZkStateReaderTest_DC25DA3E1E422345-001
[junit4] 2> Jun 04, 2016 12:23:39 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 6 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene60): {},
docValues:{}, maxPointsInLeafNode=844, maxMBSortInHeap=6.3386821505413735,
sim=ClassicSimilarity, locale=vi, timezone=IET
[junit4] 2> NOTE: Linux 4.4.0-21-generic i386/Oracle Corporation 1.8.0_92
(32-bit)/cpus=12,threads=1,free=84126016,total=379322368
[junit4] 2> NOTE: All tests run in this JVM: [TestLockTree,
StressHdfsTest, TestJettySolrRunner, FieldAnalysisRequestHandlerTest,
MergeStrategyTest, PrimitiveFieldTypeTest,
DocExpirationUpdateProcessorFactoryTest, EnumFieldTest,
XmlUpdateRequestHandlerTest, BlockJoinFacetSimpleTest, TestCharFilters,
RegexBoostProcessorTest, TestMacros, TestMinMaxOnMultiValuedField, TestReload,
TestConfigSetsAPI, TestNonDefinedSimilarityFactory, TestRestoreCore,
TestRequestForwarding, TestStressCloudBlindAtomicUpdates, SimpleMLTQParserTest,
TestExactSharedStatsCache, DistributedQueryComponentOptimizationTest,
TestTolerantSearch, TestGroupingSearch, TestManagedStopFilterFactory,
SpatialHeatmapFacetsTest, TestUtils, AssignTest, CleanupOldIndexTest,
AddBlockUpdateTest, TestExtendedDismaxParser, TestJmxMonitoredMap,
ExplicitHLLTest, TermVectorComponentDistributedTest, TestTrieFacet,
TestSolrIndexConfig, ZkStateWriterTest, TestFastWriter,
BasicDistributedZk2Test, ResponseHeaderTest, DirectUpdateHandlerTest,
CollectionStateFormat2Test, TestRecovery, TestRecoveryHdfs,
TestScoreJoinQPScore, BinaryUpdateRequestHandlerTest, HLLUtilTest,
RecoveryZkTest, TestIndexSearcher, PluginInfoTest,
TestRandomCollapseQParserPlugin, TestSolrDeletionPolicy1, ClusterStateTest,
TestShortCircuitedRequests, ChangedSchemaMergeTest, TestRTimerTree,
PreAnalyzedUpdateProcessorTest, SimpleFacetsTest, AutoCommitTest,
BJQParserTest, DistributedVersionInfoTest, TestAuthenticationFramework,
TestFuzzyAnalyzedSuggestions, UUIDUpdateProcessorFallbackTest,
TestJmxIntegration, TestSolrQueryResponse, TestHdfsUpdateLog,
TestSubQueryTransformer, TestPHPSerializedResponseWriter, SolrTestCaseJ4Test,
DistribDocExpirationUpdateProcessorTest, TestSchemaManager, OverseerStatusTest,
TestCSVResponseWriter, SuggesterWFSTTest, CircularListTest,
CollectionsAPISolrJTest, DebugComponentTest, TestDefaultSearchFieldResource,
LeaderElectionTest, HighlighterConfigTest, TestXIncludeConfig,
BasicAuthIntegrationTest, DataDrivenBlockJoinTest,
HdfsRestartWhileUpdatingTest, TestSort, SliceStateTest,
TestShardHandlerFactory, TestSchemaSimilarityResource, StatsComponentTest,
TestSlowCompositeReaderWrapper, TestManagedResource,
AnalyticsMergeStrategyTest, NoCacheHeaderTest, BaseCdcrDistributedZkTest,
StatelessScriptUpdateProcessorFactoryTest, UnloadDistributedZkTest,
LeaderElectionIntegrationTest, BasicZkTest, FullSolrCloudDistribCmdsTest,
TestRealTimeGet, TestStressReorder, TestJoin, TestRangeQuery,
SolrCmdDistributorTest, BadIndexSchemaTest, TestFiltering, TestLFUCache,
TestCrossCoreJoin, TestDistributedMissingSort, ActionThrottleTest,
CollectionTooManyReplicasTest, DeleteLastCustomShardedReplicaTest,
DeleteReplicaTest, ForceLeaderTest, ShardSplitTest,
VMParamsZkACLAndCredentialsProvidersTest, HdfsBasicDistributedZkTest,
HdfsChaosMonkeyNothingIsSafeTest, HdfsCollectionsAPIDistributedZkTest,
HdfsNNFailoverTest, HdfsRecoveryZkTest, HdfsSyncSliceTest,
HdfsTlogReplayBufferedWhileIndexingTest, HdfsWriteToMultipleCollectionsTest,
ZkStateReaderTest]
[junit4] Completed [498/613 (1!)] on J2 in 31.78s, 6 tests, 1 error <<<
FAILURES!
[...truncated 356 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/build.xml:740: The following
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/build.xml:684: The following
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/build.xml:59: The following error
occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build.xml:233: The following
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/common-build.xml:531: The
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/lucene/common-build.xml:1427: The
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/lucene/common-build.xml:984:
There were test failures: 613 suites (10 ignored), 2567 tests, 1 error, 116
ignored (72 assumptions) [seed: DC25DA3E1E422345]
Total time: 61 minutes 40 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]
