Build: http://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Linux/1036/
Java: 32bit/jdk-9-ea+124 -server -XX:+UseSerialGC
1 tests failed.
FAILED:
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy
Error Message:
expected:<2> but was:<1>
Stack Trace:
java.lang.AssertionError: expected:<2> but was:<1>
at
__randomizedtesting.SeedInfo.seed([36C8FBFAF4C32D7B:9933D5DB50E89447]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:130)
at
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy(ZkStateReaderTest.java:58)
at
jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native
Method)
at
jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
at
jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:533)
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(java.base@9-ea/Thread.java:843)
Build Log:
[...truncated 10792 lines...]
[junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_36C8FBFAF4C32D7B-001/init-core-data-001
[junit4] 2> 119913 INFO
(SUITE-ZkStateReaderTest-seed#[36C8FBFAF4C32D7B]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 119914 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
[junit4] 2> 119920 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 119922 INFO (Thread-218) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 119922 INFO (Thread-218) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 120021 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.ZkTestServer start zk server on port:42713
[junit4] 2> 120035 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 120082 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 120128 INFO (zkCallback-52-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@e8896a name:ZooKeeperConnection
Watcher:127.0.0.1:42713 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 120128 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 120128 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 120145 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 120145 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 0x155aec341e40000, 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(java.base@9-ea/Thread.java:843)
[junit4] 2> 120148 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 120151 INFO (zkCallback-53-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@6e078d name:ZooKeeperConnection
Watcher:127.0.0.1:42713 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 120151 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 120151 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 120152 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 120165 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 0x155aec341e40001, 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(java.base@9-ea/Thread.java:843)
[junit4] 2> 120165 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 120166 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 120167 INFO (zkCallback-54-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@6f75a2 name:ZooKeeperConnection
Watcher:127.0.0.1:42713/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 120167 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 120167 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 120179 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 120183 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 120188 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 120191 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 120193 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 120200 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 120204 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 120207 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 120215 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 120218 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 120222 INFO (zkCallback-54-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 120229 INFO (zkCallback-54-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> 120234 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 120235 INFO (zkCallback-54-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> 120236 INFO (zkCallback-54-thread-1) [ ]
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 120236 INFO (zkCallback-54-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> 120239 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42713 42713
[junit4] 2> 120294 INFO (Thread-218) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:42713 42713
[junit4] 2> 120310 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
[junit4] 2> 120312 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.SolrTestCaseJ4 ###Starting
testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 120312 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 120312 INFO (Thread-219) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 120312 INFO (Thread-219) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 120412 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.ZkTestServer start zk server on port:45183
[junit4] 2> 120412 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 120414 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 120416 INFO (zkCallback-56-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@660d1e name:ZooKeeperConnection
Watcher:127.0.0.1:45183 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 120416 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 120416 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 120418 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 120418 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 120419 INFO (zkCallback-57-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@3280c0 name:ZooKeeperConnection
Watcher:127.0.0.1:45183 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 120420 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 120420 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 120420 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 120422 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 120422 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 120424 INFO (zkCallback-58-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1940c7c name:ZooKeeperConnection
Watcher:127.0.0.1:45183/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 120424 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 120426 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 120426 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 120430 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 120431 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 120432 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 120433 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 120434 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 120434 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 120435 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 120436 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 120438 INFO (zkCallback-58-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 120439 INFO (zkCallback-58-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> 120441 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 120443 INFO (zkCallback-58-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> 120445 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45183 45183
[junit4] 2> 120465 INFO (Thread-219) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:45183 45183
[junit4] 2> 120466 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.SolrTestCaseJ4 ###Ending
testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 120468 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 120469 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 120469 INFO (Thread-220) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 120469 INFO (Thread-220) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 120569 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.ZkTestServer start zk server on port:41372
[junit4] 2> 120570 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 120570 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 120572 INFO (zkCallback-60-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@a4762f name:ZooKeeperConnection
Watcher:127.0.0.1:41372 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 120572 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 120572 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 120574 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 120574 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 120577 INFO (zkCallback-61-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@8766f2 name:ZooKeeperConnection
Watcher:127.0.0.1:41372 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 120577 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 120578 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 120578 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 120580 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 120582 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 120583 INFO (zkCallback-62-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1bf0c88 name:ZooKeeperConnection
Watcher:127.0.0.1:41372/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 120584 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 120584 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 120584 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 120586 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 120587 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 120588 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 120589 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 120590 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 120590 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 120591 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 120592 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 120594 INFO (zkCallback-62-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 120595 INFO (zkCallback-62-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> 120598 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 120598 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 120599 INFO (zkCallback-62-thread-1) [ ]
o.a.s.c.c.ZkStateReader Uninteresting collection c1
[junit4] 2> 120600 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 120607 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:41372 41372
[junit4] 2> 120609 ERROR
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B]-EventThread)
[ ] o.a.z.ClientCnxn Error while calling watcher
[junit4] 2> java.util.concurrent.RejectedExecutionException: Task
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$131/33465583@1316c3b
rejected from
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@33ebf9[Terminated,
pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 4]
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(java.base@9-ea/ThreadPoolExecutor.java:2073)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.reject(java.base@9-ea/ThreadPoolExecutor.java:839)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.execute(java.base@9-ea/ThreadPoolExecutor.java:1385)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.execute(ExecutorUtil.java:214)
[junit4] 2> at
java.util.concurrent.AbstractExecutorService.submit(java.base@9-ea/AbstractExecutorService.java:118)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$3.process(SolrZkClient.java:267)
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522)
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498)
[junit4] 2> 120626 INFO (Thread-220) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:41372 41372
[junit4] 2> 120627 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest
-Dtests.method=testStateFormatUpdateWithTimeDelayLazy
-Dtests.seed=36C8FBFAF4C32D7B -Dtests.multiplier=3 -Dtests.slow=true
-Dtests.locale=sq-XK -Dtests.timezone=Pacific/Auckland -Dtests.asserts=true
-Dtests.file.encoding=ISO-8859-1
[junit4] FAILURE 0.16s J0 |
ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<2> but
was:<1>
[junit4] > at
__randomizedtesting.SeedInfo.seed([36C8FBFAF4C32D7B:9933D5DB50E89447]:0)
[junit4] > at
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:130)
[junit4] > at
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy(ZkStateReaderTest.java:58)
[junit4] > at
jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native
Method)
[junit4] > at
jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
[junit4] > at
jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
[junit4] > at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
[junit4] 2> 120632 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.SolrTestCaseJ4 ###Starting
testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 120632 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 120632 INFO (Thread-221) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 120632 INFO (Thread-221) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 120732 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.ZkTestServer start zk server on port:36245
[junit4] 2> 120732 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 120733 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 120735 INFO (zkCallback-64-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@108f07a name:ZooKeeperConnection
Watcher:127.0.0.1:36245 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 120735 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 120735 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 120740 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 120740 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 120754 INFO (zkCallback-65-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1ebb0f name:ZooKeeperConnection
Watcher:127.0.0.1:36245 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 120754 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 120754 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 120754 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 120757 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 120757 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 120758 INFO (zkCallback-66-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@17997df name:ZooKeeperConnection
Watcher:127.0.0.1:36245/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 120759 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 120759 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 120760 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 120760 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 120763 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 120764 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 120765 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 120765 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 120766 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 120766 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 120767 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 120768 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 120769 INFO (zkCallback-66-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 120770 INFO (zkCallback-66-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> 120771 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 120771 INFO (zkCallback-66-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> 120772 INFO (zkCallback-66-thread-1) [ ]
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 120772 INFO (zkCallback-66-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> 120775 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36245 36245
[junit4] 2> 120871 INFO (Thread-221) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:36245 36245
[junit4] 2> 120872 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 120874 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
[junit4] 2> 120874 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 120875 INFO (Thread-222) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 120875 INFO (Thread-222) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 120975 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.ZkTestServer start zk server on port:33582
[junit4] 2> 120975 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 120975 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 120978 INFO (zkCallback-68-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@89e7d4 name:ZooKeeperConnection
Watcher:127.0.0.1:33582 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 120978 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 120978 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 120979 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 120980 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 120983 INFO (zkCallback-69-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@13ce6c1 name:ZooKeeperConnection
Watcher:127.0.0.1:33582 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 120983 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 120984 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 120984 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 120987 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 120987 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 120988 INFO (zkCallback-70-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@135df79 name:ZooKeeperConnection
Watcher:127.0.0.1:33582/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 120988 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 120988 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 120990 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 120991 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 120993 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 120994 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 120995 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 120995 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 120996 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 120996 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 120997 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 120999 INFO (zkCallback-70-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 120999 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 121000 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 121003 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:33582 33582
[junit4] 2> 121220 INFO (Thread-222) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:33582 33582
[junit4] 2> 121221 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
[junit4] 2> 121224 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
[junit4] 2> 121224 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 121224 INFO (Thread-223) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 121224 INFO (Thread-223) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 121324 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.ZkTestServer start zk server on port:33721
[junit4] 2> 121324 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 121326 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 121328 INFO (zkCallback-72-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1c4ddb2 name:ZooKeeperConnection
Watcher:127.0.0.1:33721 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 121328 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 121329 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 121338 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 121339 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 121340 INFO (zkCallback-73-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@41e79b name:ZooKeeperConnection
Watcher:127.0.0.1:33721 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 121340 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 121340 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 121340 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 121342 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 121342 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 121345 INFO (zkCallback-74-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@388592 name:ZooKeeperConnection
Watcher:127.0.0.1:33721/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 121345 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 121346 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 121346 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 121347 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 121348 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 121350 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 121350 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 121351 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 121351 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 121352 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 121353 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 121353 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 121354 INFO (zkCallback-74-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 121355 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 121356 INFO (zkCallback-74-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> 121357 INFO (zkCallback-74-thread-1) [ ]
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 121358 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:33721 33721
[junit4] 2> 121475 INFO (Thread-223) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:33721 33721
[junit4] 2> 121476 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[36C8FBFAF4C32D7B])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
[junit4] 2> 121477 INFO
(SUITE-ZkStateReaderTest-seed#[36C8FBFAF4C32D7B]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_36C8FBFAF4C32D7B-001
[junit4] 2> Jul 03, 2016 3:18:01 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {},
docValues:{}, maxPointsInLeafNode=1112, maxMBSortInHeap=6.788780931340961,
sim=RandomSimilarity(queryNorm=true,coord=yes): {}, locale=sq-XK,
timezone=Pacific/Auckland
[junit4] 2> NOTE: Linux 4.4.0-24-generic i386/Oracle Corporation 9-ea
(32-bit)/cpus=12,threads=1,free=51217304,total=122458112
[junit4] 2> NOTE: All tests run in this JVM:
[CdcrReplicationDistributedZkTest, TestNumericTerms64,
TestFoldingMultitermQuery, TestHdfsBackupRestoreCore, TestSchemaResource,
TestSlowCompositeReaderWrapper, TestCrossCoreJoin,
SegmentsInfoRequestHandlerTest, TestDistributedSearch, ReturnFieldsTest,
TestFieldCache, IndexSchemaTest, DistributedQueryElevationComponentTest,
TestRuleBasedAuthorizationPlugin, RankQueryTest, ZkStateReaderTest]
[junit4] Completed [55/619 (1!)] on J0 in 2.35s, 6 tests, 1 failure <<<
FAILURES!
[...truncated 1808 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/build.xml:740: The following
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/build.xml:684: The following
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/build.xml:59: The following error
occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build.xml:233: The following
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/common-build.xml:530: The
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/lucene/common-build.xml:1427: The
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/lucene/common-build.xml:984:
There were test failures: 619 suites (10 ignored), 2597 tests, 1 failure, 119
ignored (72 assumptions) [seed: 36C8FBFAF4C32D7B]
Total time: 56 minutes 44 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]
