Build: https://builds.apache.org/job/Lucene-Solr-Tests-trunk-Java8/583/
1 tests failed.
FAILED: org.apache.solr.cloud.OverseerTest.testOverseerStatsReset
Error Message:
expected:<1> but was:<2>
Stack Trace:
java.lang.AssertionError: expected:<1> but was:<2>
at
__randomizedtesting.SeedInfo.seed([51AAE98999A64DCF:FAFE0EB50C7CEEC1]: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.OverseerTest.testOverseerStatsReset(OverseerTest.java:722)
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:497)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1660)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:866)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:902)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:916)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
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:875)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:777)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:811)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:822)
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:46)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
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:54)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
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 10162 lines...]
[junit4] Suite: org.apache.solr.cloud.OverseerTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J2/temp/solr.cloud.OverseerTest_51AAE98999A64DCF-001/init-core-data-001
[junit4] 2> 1109974 INFO
(SUITE-OverseerTest-seed#[51AAE98999A64DCF]-worker) [ ] o.a.s.SolrTestCaseJ4
Randomized ssl (false) and clientAuth (false)
[junit4] 2> 1109974 INFO
(SUITE-OverseerTest-seed#[51AAE98999A64DCF]-worker) [ ] o.a.s.SolrTestCaseJ4
####initCore
[junit4] 2> 1109974 INFO
(SUITE-OverseerTest-seed#[51AAE98999A64DCF]-worker) [ ] o.a.s.SolrTestCaseJ4
####initCore end
[junit4] 2> 1109977 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testReplay
[junit4] 2> 1109977 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1109978 INFO (Thread-3127) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1109978 INFO (Thread-3127) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1110078 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.ZkTestServer start zk server on port:52729
[junit4] 2> 1110078 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1110079 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1110081 INFO (zkCallback-938-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@487be44f
name:ZooKeeperConnection Watcher:127.0.0.1:52729/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1110081 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1110081 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1110081 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1110084 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1110084 INFO (zkCallback-939-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@257aa73c
name:ZooKeeperConnection Watcher:127.0.0.1:52729 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1110085 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1110085 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1110086 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1110090 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1110090 INFO (zkCallback-940-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@33aa6026
name:ZooKeeperConnection Watcher:127.0.0.1:52729 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1110090 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1110090 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1110090 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1110093 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1110095 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1110096 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1110097 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1110098 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1110099 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1110102 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
[junit4] 2> 1110104 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1110106 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1110106 INFO (zkCallback-941-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@20bb791f
name:ZooKeeperConnection Watcher:127.0.0.1:52729/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1110106 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1110106 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1110107 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=600000&connTimeout=60000&retry=true
[junit4] 2> 1110113 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 1110115 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
[junit4] 2> 1110116 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ] o.a.s.c.Overseer
Overseer (id=null) closing
[junit4] 2> 1110116 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.LeaderElector Joined leadership election with path:
/overseer_elect/election/94815754447159299-127.0.0.1:52729_solr-n_0000000000
[junit4] 2> 1110117 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:52729_solr
[junit4] 2> 1110117 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
[junit4] 2> 1110118 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ] o.a.s.c.Overseer
Overseer (id=94815754447159299-127.0.0.1:52729_solr-n_0000000000) starting
[junit4] 2> 1110119 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 1110121 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
[junit4] 2> 1110122 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
[junit4] 2> 1110123 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
[junit4] 2> 1110124 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
[junit4] 2> 1110126 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.OverseerAutoReplicaFailoverThread Starting
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 1110127 INFO
(OverseerStateUpdate-94815754447159299-127.0.0.1:52729_solr-n_0000000000) [
] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 1110127 INFO
(OverseerCollectionConfigSetProcessor-94815754447159299-127.0.0.1:52729_solr-n_0000000000)
[ ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer
operations
[junit4] 2> 1110128 INFO
(OverseerStateUpdate-94815754447159299-127.0.0.1:52729_solr-n_0000000000) [
] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1110130 INFO
(OverseerStateUpdate-94815754447159299-127.0.0.1:52729_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: workQueueSize: 2, message = {
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1/solr",
[junit4] 2> "node_name":"node1",
[junit4] 2> "shard":"s1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "core":"core1",
[junit4] 2> "roles":"",
[junit4] 2> "state":"recovering"}
[junit4] 2> 1110131 INFO
(OverseerStateUpdate-94815754447159299-127.0.0.1:52729_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Update state numShards=null message={
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1/solr",
[junit4] 2> "node_name":"node1",
[junit4] 2> "shard":"s1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "core":"core1",
[junit4] 2> "roles":"",
[junit4] 2> "state":"recovering"}
[junit4] 2> 1110132 INFO (zkCallback-938-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> 1110133 INFO (zkCallback-941-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> 1110134 INFO
(OverseerStateUpdate-94815754447159299-127.0.0.1:52729_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: workQueueSize: 2, message = {
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1/solr",
[junit4] 2> "node_name":"node1",
[junit4] 2> "shard":"s1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "core":"core2",
[junit4] 2> "roles":"",
[junit4] 2> "state":"recovering"}
[junit4] 2> 1110134 INFO
(OverseerStateUpdate-94815754447159299-127.0.0.1:52729_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Update state numShards=null message={
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1/solr",
[junit4] 2> "node_name":"node1",
[junit4] 2> "shard":"s1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "core":"core2",
[junit4] 2> "roles":"",
[junit4] 2> "state":"recovering"}
[junit4] 2> 1110135 INFO (zkCallback-938-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> 1110136 INFO
(OverseerStateUpdate-94815754447159299-127.0.0.1:52729_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1/solr",
[junit4] 2> "node_name":"node1",
[junit4] 2> "shard":"s1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "core":"core3",
[junit4] 2> "roles":"",
[junit4] 2> "state":"recovering"} current state version: 2
[junit4] 2> 1110136 INFO
(OverseerStateUpdate-94815754447159299-127.0.0.1:52729_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Update state numShards=null message={
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1/solr",
[junit4] 2> "node_name":"node1",
[junit4] 2> "shard":"s1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "core":"core3",
[junit4] 2> "roles":"",
[junit4] 2> "state":"recovering"}
[junit4] 2> 1110142 INFO (zkCallback-941-thread-3) [ ]
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> 1110239 INFO (zkCallback-938-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> 1110239 INFO (zkCallback-941-thread-3) [ ]
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> 1110335 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:52729 52729
[junit4] 2> 1110557 INFO (Thread-3127) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:52729 52729
[junit4] 2> 1110558 WARN (Thread-3127) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 2 /solr/aliases.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 2 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 2 /solr/live_nodes
[junit4] 2> 2 /solr/collections
[junit4] 2>
[junit4] 2> 1110558 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testReplay
[junit4] 2> 1110558 INFO
(TEST-OverseerTest.testReplay-seed#[51AAE98999A64DCF]) [ ] o.a.s.c.Overseer
Overseer (id=94815754447159299-127.0.0.1:52729_solr-n_0000000000) closing
[junit4] 2> 1110559 INFO
(OverseerStateUpdate-94815754447159299-127.0.0.1:52729_solr-n_0000000000) [
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:52729_solr
[junit4] 2> 1110559 ERROR (OverseerExitThread) [ ] o.a.s.c.Overseer
could not read the data
[junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException:
KeeperErrorCode = Session expired for /overseer_elect/leader
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at
org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1155)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:353)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:350)
[junit4] 2> at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:61)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:350)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.checkIfIamStillLeader(Overseer.java:304)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.access$300(Overseer.java:87)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater$2.run(Overseer.java:265)
[junit4] 2> 1110561 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testShardAssignment
[junit4] 2> 1110561 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1110562 INFO (Thread-3128) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1110562 INFO (Thread-3128) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1110662 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.ZkTestServer start zk server on port:37419
[junit4] 2> 1110662 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1110662 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1110665 INFO (zkCallback-943-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@2a5cb1e name:ZooKeeperConnection
Watcher:127.0.0.1:37419 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1110665 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1110665 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1110666 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1110666 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1110667 INFO (zkCallback-944-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@67c092ca
name:ZooKeeperConnection Watcher:127.0.0.1:37419 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1110667 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1110667 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1110668 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1110670 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1110670 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1110671 INFO (zkCallback-945-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@5c7542cd
name:ZooKeeperConnection Watcher:127.0.0.1:37419/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1110671 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1110671 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1110671 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1110672 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1110674 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1110680 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1110681 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1110682 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1110686 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1110686 INFO (zkCallback-946-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@82452bd name:ZooKeeperConnection
Watcher:127.0.0.1:37419/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 1110686 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1110686 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1110686 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=600000&connTimeout=60000&retry=true
[junit4] 2> 1110687 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 1110689 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
[junit4] 2> 1110690 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1110690 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.LeaderElector Joined leadership election with path:
/overseer_elect/election/94815754485235715-127.0.0.1:37419_solr-n_0000000000
[junit4] 2> 1110691 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:37419_solr
[junit4] 2> 1110691 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
[junit4] 2> 1110692 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.Overseer Overseer
(id=94815754485235715-127.0.0.1:37419_solr-n_0000000000) starting
[junit4] 2> 1110693 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 1110694 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
[junit4] 2> 1110696 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
[junit4] 2> 1110698 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
[junit4] 2> 1110699 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
[junit4] 2> 1110701 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
[junit4] 2> 1110703 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.OverseerAutoReplicaFailoverThread Starting
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 1110704 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1110704 INFO
(OverseerCollectionConfigSetProcessor-94815754485235715-127.0.0.1:37419_solr-n_0000000000)
[ ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer
operations
[junit4] 2> 1110704 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 1110705 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1110706 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1110707 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1110708 INFO (zkCallback-948-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@642d7047
name:ZooKeeperConnection Watcher:127.0.0.1:37419/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1110708 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1110708 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1110710 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1110711 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1
[junit4] 2> 1110713 INFO (zkCallback-946-thread-1) [ ]
o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live
nodes size: 0)
[junit4] 2> 1110713 INFO (zkCallback-945-thread-1) [ ]
o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live
nodes size: 0)
[junit4] 2> 1110713 INFO (zkCallback-948-thread-1) [ ]
o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live
nodes size: 0)
[junit4] 2> 1110715 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "node_name":"127.0.0.1",
[junit4] 2> "core":"core1",
[junit4] 2> "core_node_name":"node1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"3",
[junit4] 2> "base_url":"http://127.0.0.1/solr/"} current state version: 0
[junit4] 2> 1110716 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Update state numShards=3 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "node_name":"127.0.0.1",
[junit4] 2> "core":"core1",
[junit4] 2> "core_node_name":"node1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"3",
[junit4] 2> "base_url":"http://127.0.0.1/solr/"}
[junit4] 2> 1110716 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.o.ClusterStateMutator building a new cName: collection1
[junit4] 2> 1110716 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard2
[junit4] 2> 1110717 INFO (zkCallback-946-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: 1)
[junit4] 2> 1110717 INFO (zkCallback-945-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: 1)
[junit4] 2> 1110717 INFO (zkCallback-948-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: 1)
[junit4] 2> 1111215 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath:
/collections/collection1/leader_elect/shard2/election
[junit4] 2> 1111217 INFO (zkCallback-946-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections, has occurred - updating...
[junit4] 2> 1111217 INFO (zkCallback-945-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections, has occurred - updating...
[junit4] 2> 1111217 INFO (zkCallback-948-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections, has occurred - updating...
[junit4] 2> 1111220 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.LeaderElector Joined leadership election with path:
/collections/collection1/leader_elect/shard2/election/94815754485235716-127.0.0.1_core1-n_0000000000
[junit4] 2> 1111226 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/leaders/shard2
[junit4] 2> 1111227 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
[junit4] 2> 1111229 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "base_url":"http://127.0.0.1/solr/",
[junit4] 2> "core":"core1"} current state version: 1
[junit4] 2> 1111231 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "node_name":"127.0.0.1",
[junit4] 2> "core":"core2",
[junit4] 2> "core_node_name":"node2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"3",
[junit4] 2> "base_url":"http://127.0.0.1/solr/"} current state version: 1
[junit4] 2> 1111231 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Update state numShards=3 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "node_name":"127.0.0.1",
[junit4] 2> "core":"core2",
[junit4] 2> "core_node_name":"node2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"3",
[junit4] 2> "base_url":"http://127.0.0.1/solr/"}
[junit4] 2> 1111231 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Collection already exists with numShards=3
[junit4] 2> 1111231 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard3
[junit4] 2> 1111333 INFO (zkCallback-946-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: 1)
[junit4] 2> 1111333 INFO (zkCallback-945-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: 1)
[junit4] 2> 1111333 INFO (zkCallback-948-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: 1)
[junit4] 2> 1111730 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath:
/collections/collection1/leader_elect/shard3/election
[junit4] 2> 1111733 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.LeaderElector Joined leadership election with path:
/collections/collection1/leader_elect/shard3/election/94815754485235716-127.0.0.1_core2-n_0000000000
[junit4] 2> 1111734 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/leaders/shard3
[junit4] 2> 1111735 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
[junit4] 2> 1111738 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard3",
[junit4] 2> "collection":"collection1",
[junit4] 2> "base_url":"http://127.0.0.1/solr/",
[junit4] 2> "core":"core2"} current state version: 2
[junit4] 2> 1111740 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "node_name":"127.0.0.1",
[junit4] 2> "core":"core3",
[junit4] 2> "core_node_name":"node3",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"3",
[junit4] 2> "base_url":"http://127.0.0.1/solr/"} current state version: 2
[junit4] 2> 1111740 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Update state numShards=3 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "node_name":"127.0.0.1",
[junit4] 2> "core":"core3",
[junit4] 2> "core_node_name":"node3",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"3",
[junit4] 2> "base_url":"http://127.0.0.1/solr/"}
[junit4] 2> 1111741 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Collection already exists with numShards=3
[junit4] 2> 1111741 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
[junit4] 2> 1111843 INFO (zkCallback-946-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: 1)
[junit4] 2> 1111843 INFO (zkCallback-948-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: 1)
[junit4] 2> 1111843 INFO (zkCallback-945-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: 1)
[junit4] 2> 1112239 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath:
/collections/collection1/leader_elect/shard1/election
[junit4] 2> 1112242 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.LeaderElector Joined leadership election with path:
/collections/collection1/leader_elect/shard1/election/94815754485235716-127.0.0.1_core3-n_0000000000
[junit4] 2> 1112243 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/leaders/shard1
[junit4] 2> 1112244 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
[junit4] 2> 1112247 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "base_url":"http://127.0.0.1/solr/",
[junit4] 2> "core":"core3"} current state version: 3
[junit4] 2> 1112248 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "node_name":"127.0.0.1",
[junit4] 2> "core":"core4",
[junit4] 2> "core_node_name":"node4",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"3",
[junit4] 2> "base_url":"http://127.0.0.1/solr/"} current state version: 3
[junit4] 2> 1112249 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Update state numShards=3 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "node_name":"127.0.0.1",
[junit4] 2> "core":"core4",
[junit4] 2> "core_node_name":"node4",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"3",
[junit4] 2> "base_url":"http://127.0.0.1/solr/"}
[junit4] 2> 1112249 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Collection already exists with numShards=3
[junit4] 2> 1112249 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard2
[junit4] 2> 1112351 INFO (zkCallback-946-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: 1)
[junit4] 2> 1112351 INFO (zkCallback-945-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: 1)
[junit4] 2> 1112351 INFO (zkCallback-948-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: 1)
[junit4] 2> 1112748 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath:
/collections/collection1/leader_elect/shard2/election
[junit4] 2> 1112751 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.LeaderElector Joined leadership election with path:
/collections/collection1/leader_elect/shard2/election/94815754485235716-127.0.0.1_core4-n_0000000001
[junit4] 2> 1112751 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.LeaderElector Watching path
/collections/collection1/leader_elect/shard2/election/94815754485235716-127.0.0.1_core1-n_0000000000
to know if I could be the leader
[junit4] 2> 1112753 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "node_name":"127.0.0.1",
[junit4] 2> "core":"core5",
[junit4] 2> "core_node_name":"node5",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"3",
[junit4] 2> "base_url":"http://127.0.0.1/solr/"} current state version: 4
[junit4] 2> 1112754 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Update state numShards=3 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "node_name":"127.0.0.1",
[junit4] 2> "core":"core5",
[junit4] 2> "core_node_name":"node5",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"3",
[junit4] 2> "base_url":"http://127.0.0.1/solr/"}
[junit4] 2> 1112754 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Collection already exists with numShards=3
[junit4] 2> 1112754 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard3
[junit4] 2> 1112856 INFO (zkCallback-948-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: 1)
[junit4] 2> 1112856 INFO (zkCallback-946-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: 1)
[junit4] 2> 1112856 INFO (zkCallback-945-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: 1)
[junit4] 2> 1113253 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath:
/collections/collection1/leader_elect/shard3/election
[junit4] 2> 1113256 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.LeaderElector Joined leadership election with path:
/collections/collection1/leader_elect/shard3/election/94815754485235716-127.0.0.1_core5-n_0000000001
[junit4] 2> 1113256 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.LeaderElector Watching path
/collections/collection1/leader_elect/shard3/election/94815754485235716-127.0.0.1_core2-n_0000000000
to know if I could be the leader
[junit4] 2> 1113258 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "node_name":"127.0.0.1",
[junit4] 2> "core":"core6",
[junit4] 2> "core_node_name":"node6",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"3",
[junit4] 2> "base_url":"http://127.0.0.1/solr/"} current state version: 5
[junit4] 2> 1113259 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Update state numShards=3 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "node_name":"127.0.0.1",
[junit4] 2> "core":"core6",
[junit4] 2> "core_node_name":"node6",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"3",
[junit4] 2> "base_url":"http://127.0.0.1/solr/"}
[junit4] 2> 1113259 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Collection already exists with numShards=3
[junit4] 2> 1113259 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
[junit4] 2> 1113361 INFO (zkCallback-946-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: 1)
[junit4] 2> 1113361 INFO (zkCallback-948-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: 1)
[junit4] 2> 1113361 INFO (zkCallback-945-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: 1)
[junit4] 2> 1113758 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath:
/collections/collection1/leader_elect/shard1/election
[junit4] 2> 1113760 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.LeaderElector Joined leadership election with path:
/collections/collection1/leader_elect/shard1/election/94815754485235716-127.0.0.1_core6-n_0000000001
[junit4] 2> 1113761 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.LeaderElector Watching path
/collections/collection1/leader_elect/shard1/election/94815754485235716-127.0.0.1_core3-n_0000000000
to know if I could be the leader
[junit4] 2> 1113763 INFO (zkCallback-946-thread-1) [ ]
o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live
nodes size: 1)
[junit4] 2> 1113763 INFO (zkCallback-948-thread-1) [ ]
o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live
nodes size: 1)
[junit4] 2> 1113772 ERROR
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]-EventThread) [
] o.a.z.ClientCnxn Error while calling watcher
[junit4] 2> java.util.concurrent.RejectedExecutionException: Task
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1@2a8c7919
rejected from
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@6f8ef22c[Shutting
down, pool size = 1, active threads = 1, queued tasks = 0, completed tasks =
10]
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2047)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:823)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1369)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.execute(ExecutorUtil.java:214)
[junit4] 2> at
java.util.concurrent.AbstractExecutorService.submit(AbstractExecutorService.java:112)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$3.process(SolrZkClient.java:266)
[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> 1113779 ERROR
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]-EventThread) [
] o.a.z.ClientCnxn Error while calling watcher
[junit4] 2> java.util.concurrent.RejectedExecutionException: Task
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1@5eab7c54
rejected from
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@6f8ef22c[Shutting
down, pool size = 1, active threads = 1, queued tasks = 0, completed tasks =
10]
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2047)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:823)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1369)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.execute(ExecutorUtil.java:214)
[junit4] 2> at
java.util.concurrent.AbstractExecutorService.submit(AbstractExecutorService.java:112)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$3.process(SolrZkClient.java:266)
[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> 1113779 WARN (zkCallback-948-thread-2) [ ]
o.a.s.c.LeaderElector
[junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException:
KeeperErrorCode = Session expired for
/collections/collection1/leader_elect/shard2/election
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at
org.apache.zookeeper.ZooKeeper.getChildren(ZooKeeper.java:1472)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:336)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:333)
[junit4] 2> at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:61)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.getChildren(SolrZkClient.java:333)
[junit4] 2> at
org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:107)
[junit4] 2> at
org.apache.solr.cloud.LeaderElector.access$200(LeaderElector.java:58)
[junit4] 2> at
org.apache.solr.cloud.LeaderElector$ElectionWatcher.process(LeaderElector.java:388)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$3$1.run(SolrZkClient.java:269)
[junit4] 2> at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at
java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:231)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 1113786 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:37419 37419
[junit4] 2> 1113911 INFO (Thread-3128) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:37419 37419
[junit4] 2> 1113912 WARN (Thread-3128) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 3 /solr/aliases.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 3 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 3 /solr/live_nodes
[junit4] 2> 3 /solr/collections
[junit4] 2>
[junit4] 2> 1113913 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testShardAssignment
[junit4] 2> 1113913 INFO
(TEST-OverseerTest.testShardAssignment-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.Overseer Overseer
(id=94815754485235715-127.0.0.1:37419_solr-n_0000000000) closing
[junit4] 2> 1113913 INFO
(OverseerStateUpdate-94815754485235715-127.0.0.1:37419_solr-n_0000000000) [
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:37419_solr
[junit4] 2> 1113927 ERROR (OverseerExitThread) [ ] o.a.s.c.Overseer
could not read the data
[junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException:
KeeperErrorCode = Session expired for /overseer_elect/leader
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at
org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1155)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:353)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:350)
[junit4] 2> at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:61)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:350)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.checkIfIamStillLeader(Overseer.java:304)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.access$300(Overseer.java:87)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater$2.run(Overseer.java:265)
[junit4] 2> 1113927 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testOverseerStatsReset
[junit4] 2> 1113928 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1113928 INFO (Thread-3129) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1113928 INFO (Thread-3129) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1114028 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.ZkTestServer start zk server on port:48334
[junit4] 2> 1114028 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1114033 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1114041 INFO (zkCallback-949-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@5f855beb
name:ZooKeeperConnection Watcher:127.0.0.1:48334 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1114041 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1114041 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1114042 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1114044 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1114045 INFO (zkCallback-950-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@75cb05d8
name:ZooKeeperConnection Watcher:127.0.0.1:48334 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1114045 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1114045 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1114045 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1114049 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1114058 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1114060 INFO (zkCallback-951-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@21477ec8
name:ZooKeeperConnection Watcher:127.0.0.1:48334/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1114060 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1114060 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1114062 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1114066 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1114067 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1114069 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1114071 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1114074 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1114076 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1114079 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1114082 INFO (zkCallback-952-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@627b41f7
name:ZooKeeperConnection Watcher:127.0.0.1:48334/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1114082 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1114082 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1114084 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1114086 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /live_nodes/node1
[junit4] 2> 1114087 INFO (zkCallback-951-thread-1) [ ]
o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live
nodes size: 0)
[junit4] 2> 1114087 INFO (zkCallback-952-thread-1) [ ]
o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live
nodes size: 0)
[junit4] 2> 1114091 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=600000&connTimeout=60000&retry=true
[junit4] 2> 1114097 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 1114100 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
[junit4] 2> 1114101 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1114102 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.LeaderElector Joined leadership election with path:
/overseer_elect/election/94815754706485250-127.0.0.1:48334_solr-n_0000000000
[junit4] 2> 1114103 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:48334_solr
[junit4] 2> 1114103 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
[junit4] 2> 1114106 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.Overseer Overseer
(id=94815754706485250-127.0.0.1:48334_solr-n_0000000000) starting
[junit4] 2> 1114107 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 1114111 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
[junit4] 2> 1114112 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
[junit4] 2> 1114114 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
[junit4] 2> 1114115 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
[junit4] 2> 1114116 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
[junit4] 2> 1114118 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.OverseerAutoReplicaFailoverThread Starting
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 1114123 INFO
(OverseerStateUpdate-94815754706485250-127.0.0.1:48334_solr-n_0000000000) [
] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 1114126 INFO
(OverseerCollectionConfigSetProcessor-94815754706485250-127.0.0.1:48334_solr-n_0000000000)
[ ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer
operations
[junit4] 2> 1114132 INFO
(OverseerStateUpdate-94815754706485250-127.0.0.1:48334_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"state",
[junit4] 2> "state":"recovering",
[junit4] 2> "node_name":"node1",
[junit4] 2> "core":"core1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"1",
[junit4] 2> "base_url":"http://node1/solr/"} current state version: 0
[junit4] 2> 1114133 INFO
(OverseerStateUpdate-94815754706485250-127.0.0.1:48334_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"recovering",
[junit4] 2> "node_name":"node1",
[junit4] 2> "core":"core1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"1",
[junit4] 2> "base_url":"http://node1/solr/"}
[junit4] 2> 1114133 INFO
(OverseerStateUpdate-94815754706485250-127.0.0.1:48334_solr-n_0000000000) [
] o.a.s.c.o.ClusterStateMutator building a new cName: collection1
[junit4] 2> 1114133 INFO
(OverseerStateUpdate-94815754706485250-127.0.0.1:48334_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
[junit4] 2> 1114134 INFO (zkCallback-952-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: 1)
[junit4] 2> 1114134 INFO (zkCallback-951-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: 1)
[junit4] 2> 1114632 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath:
/collections/collection1/leader_elect/shard1/election
[junit4] 2> 1114633 INFO (zkCallback-952-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections, has occurred - updating...
[junit4] 2> 1114633 INFO (zkCallback-951-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections, has occurred - updating...
[junit4] 2> 1114643 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.LeaderElector Joined leadership election with path:
/collections/collection1/leader_elect/shard1/election/94815754706485251-node1_core1-n_0000000000
[junit4] 2> 1114644 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/leaders/shard1
[junit4] 2> 1114645 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
[junit4] 2> 1114648 INFO
(OverseerStateUpdate-94815754706485250-127.0.0.1:48334_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "base_url":"http://node1/solr/",
[junit4] 2> "node_name":"node1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "core":"core1"} current state version: 1
[junit4] 2> 1114649 INFO
(OverseerStateUpdate-94815754706485250-127.0.0.1:48334_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Update state numShards=null message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "base_url":"http://node1/solr/",
[junit4] 2> "node_name":"node1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "core":"core1"}
[junit4] 2> 1114650 INFO (zkCallback-951-thread-2) [ ]
o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live
nodes size: 1)
[junit4] 2> 1114650 INFO (zkCallback-952-thread-1) [ ]
o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live
nodes size: 1)
[junit4] 2> 1114651 INFO
(OverseerStateUpdate-94815754706485250-127.0.0.1:48334_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "base_url":"http://node1/solr/",
[junit4] 2> "core":"core1"} current state version: 1
[junit4] 2> 1114651 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 0x150da6d32640003, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 1114652 WARN
(OverseerStateUpdate-94815754706485250-127.0.0.1:48334_solr-n_0000000000) [
] o.a.s.c.Overseer Solr cannot talk to ZK, exiting Overseer main queue loop
[junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException:
KeeperErrorCode = Session expired for /overseer/queue/qn-0000000002
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at
org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1155)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:353)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:350)
[junit4] 2> at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:61)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:350)
[junit4] 2> at
org.apache.solr.cloud.DistributedQueue.removeFirst(DistributedQueue.java:384)
[junit4] 2> at
org.apache.solr.cloud.DistributedQueue.poll(DistributedQueue.java:187)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.run(Overseer.java:229)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 1114652 INFO
(OverseerStateUpdate-94815754706485250-127.0.0.1:48334_solr-n_0000000000) [
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:48334_solr
[junit4] 2> 1114653 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:48334 48334
[junit4] 2> 1114653 ERROR (OverseerExitThread) [ ] o.a.s.c.Overseer
could not read the data
[junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException:
KeeperErrorCode = Session expired for /overseer_elect/leader
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at
org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1155)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:353)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:350)
[junit4] 2> at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:61)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:350)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.checkIfIamStillLeader(Overseer.java:304)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.access$300(Overseer.java:87)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater$2.run(Overseer.java:265)
[junit4] 2> 1114828 INFO (Thread-3129) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:48334 48334
[junit4] 2> 1114829 WARN (Thread-3129) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 2 /solr/aliases.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 2 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 2 /solr/live_nodes
[junit4] 2> 2 /solr/collections
[junit4] 2>
[junit4] 2> 1114829 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testOverseerStatsReset
[junit4] 2> 1114829 INFO
(TEST-OverseerTest.testOverseerStatsReset-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.Overseer Overseer
(id=94815754706485250-127.0.0.1:48334_solr-n_0000000000) closing
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=OverseerTest
-Dtests.method=testOverseerStatsReset -Dtests.seed=51AAE98999A64DCF
-Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=ja_JP_JP_#u-ca-japanese
-Dtests.timezone=America/Cambridge_Bay -Dtests.asserts=true
-Dtests.file.encoding=US-ASCII
[junit4] FAILURE 0.92s J2 | OverseerTest.testOverseerStatsReset <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<1> but
was:<2>
[junit4] > at
__randomizedtesting.SeedInfo.seed([51AAE98999A64DCF:FAFE0EB50C7CEEC1]:0)
[junit4] > at
org.apache.solr.cloud.OverseerTest.testOverseerStatsReset(OverseerTest.java:722)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 1114837 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testPlaceholders
[junit4] 2> 1114838 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1114838 INFO (Thread-3130) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1114838 INFO (Thread-3130) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1114938 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.ZkTestServer start zk server on port:59195
[junit4] 2> 1114938 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1114939 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1114942 INFO (zkCallback-954-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@3e1bb0a4
name:ZooKeeperConnection Watcher:127.0.0.1:59195/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1114942 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1114942 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1114943 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1114943 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1114944 INFO (zkCallback-955-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1ce5a34f
name:ZooKeeperConnection Watcher:127.0.0.1:59195 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1114944 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1114945 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1114946 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1114946 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1114949 INFO (zkCallback-956-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@575cd6c name:ZooKeeperConnection
Watcher:127.0.0.1:59195 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1114949 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1114949 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1114949 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1114952 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1114954 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1114955 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1114956 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1114957 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1114958 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1114960 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1114960 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1114962 INFO (zkCallback-957-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@6486ef1 name:ZooKeeperConnection
Watcher:127.0.0.1:59195/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 1114962 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1114962 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1114964 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1114973 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /live_nodes/node1
[junit4] 2> 1114973 INFO (zkCallback-954-thread-1) [ ]
o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live
nodes size: 0)
[junit4] 2> 1114974 INFO (zkCallback-957-thread-1) [ ]
o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live
nodes size: 0)
[junit4] 2> 1114974 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1114975 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1114979 INFO (zkCallback-958-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@7866fe2f
name:ZooKeeperConnection Watcher:127.0.0.1:59195/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1114979 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1114980 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1114980 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=600000&connTimeout=60000&retry=true
[junit4] 2> 1114986 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 1114989 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
[junit4] 2> 1114990 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1114991 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.LeaderElector Joined leadership election with path:
/overseer_elect/election/94815754765598724-127.0.0.1:59195_solr-n_0000000000
[junit4] 2> 1114991 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:59195_solr
[junit4] 2> 1114991 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
[junit4] 2> 1114994 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.Overseer Overseer
(id=94815754765598724-127.0.0.1:59195_solr-n_0000000000) starting
[junit4] 2> 1114995 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 1114998 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
[junit4] 2> 1115000 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
[junit4] 2> 1115002 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
[junit4] 2> 1115005 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
[junit4] 2> 1115010 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
[junit4] 2> 1115015 INFO
(TEST-OverseerTest.testPlaceholders-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.OverseerAutoReplicaFailoverThread Starting
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 1115015 INFO
(OverseerCollectionConfigSetProcessor-94815754765598724-127.0.0.1:59195_solr-n_0000000000)
[ ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer
operations
[junit4] 2> 1115017 INFO
(OverseerStateUpdate-94815754765598724-127.0.0.1:59195_solr-n_0000000000) [
] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 1115017 INFO
(OverseerStateUpdate-94815754765598724-127.0.0.1:59195_solr-n_0000000000) [
] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1115020 INFO
(OverseerStateUpdate-94815754765598724-127.0.0.1:59195_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"state",
[junit4] 2> "state":"recovering",
[junit4] 2> "node_name":"node1",
[junit4] 2> "core":"core1",
[junit4] 2> "core_node_name":"node1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"12",
[junit4] 2> "base_url":"http://node1/solr/"} current state version: 0
[junit4] 2> 1115021 INFO
(OverseerStateUpdate-94815754765598724-127.0.0.1:59195_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Update state numShards=12 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"recovering",
[junit4] 2> "node_name":"node1",
[junit4] 2> "core":"core1",
[junit4] 2> "core_node_name":"node1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"12",
[junit4] 2> "base_url":"http://node1/solr/"}
[junit4] 2> 1115021 INFO
(OverseerStateUpdate-94815754765598724-127.0.0.1:59195_solr-n_0000000000) [
] o.a.s.c.o.ClusterStateMutator building a new cName: collection1
[junit4] 2> 1115022 INFO
(OverseerStateUpdate-94815754765598724-127.0.0.1:59195_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard2
[junit4] 2> 1115024 INFO (zkCallback-954-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: 1)
[junit4] 2> 1115025 INFO (zkCallback-957-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: 1)
[junit4] 2> 1115025 INFO (zkCallback-958-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged p
[...truncated too long message...]
tateUpdate-94815758215020547-127.0.0.1:47325_solr-n_0000000000) [ ]
o.a.s.c.o.ReplicaMutator Update state numShards=null message={
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1/solr",
[junit4] 2> "node_name":"node1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "core":"core1",
[junit4] 2> "roles":"",
[junit4] 2> "state":"recovering"}
[junit4] 2> 1167615 INFO
(OverseerStateUpdate-94815758215020547-127.0.0.1:47325_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
[junit4] 2> 1167616 INFO (zkCallback-1055-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> 1167616 INFO (zkCallback-1058-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> 1167666 INFO
(OverseerStateUpdate-94815758215020547-127.0.0.1:47325_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1/solr",
[junit4] 2> "node_name":"node1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "core":"core1",
[junit4] 2> "roles":"",
[junit4] 2> "state":"active"} current state version: 1
[junit4] 2> 1167666 INFO
(OverseerStateUpdate-94815758215020547-127.0.0.1:47325_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Update state numShards=null message={
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1/solr",
[junit4] 2> "node_name":"node1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "core":"core1",
[junit4] 2> "roles":"",
[junit4] 2> "state":"active"}
[junit4] 2> 1167667 INFO
(OverseerStateUpdate-94815758215020547-127.0.0.1:47325_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator node=core_node1 is already registered
[junit4] 2> 1167667 INFO
(OverseerStateUpdate-94815758215020547-127.0.0.1:47325_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator shard=shard1 is already registered
[junit4] 2> 1167769 INFO (zkCallback-1055-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> 1167769 INFO (zkCallback-1058-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> 1167818 INFO
(TEST-OverseerTest.testStateChange-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:47325 47325
[junit4] 2> 1167976 INFO (Thread-3138) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:47325 47325
[junit4] 2> 1167978 WARN (Thread-3138) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 2 /solr/aliases.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 2 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 2 /solr/live_nodes
[junit4] 2> 2 /solr/collections
[junit4] 2>
[junit4] 2> 1167978 INFO
(TEST-OverseerTest.testStateChange-seed#[51AAE98999A64DCF]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testStateChange
[junit4] 2> 1167978 INFO
(TEST-OverseerTest.testStateChange-seed#[51AAE98999A64DCF]) [ ]
o.a.s.c.Overseer Overseer
(id=94815758215020547-127.0.0.1:47325_solr-n_0000000000) closing
[junit4] 2> 1167979 INFO
(OverseerStateUpdate-94815758215020547-127.0.0.1:47325_solr-n_0000000000) [
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:47325_solr
[junit4] 2> 1167979 ERROR (OverseerExitThread) [ ] o.a.s.c.Overseer
could not read the data
[junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException:
KeeperErrorCode = Session expired for /overseer_elect/leader
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at
org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1155)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:353)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:350)
[junit4] 2> at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:61)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:350)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.checkIfIamStillLeader(Overseer.java:304)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.access$300(Overseer.java:87)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater$2.run(Overseer.java:265)
[junit4] 2> 1170980 INFO
(SUITE-OverseerTest-seed#[51AAE98999A64DCF]-worker) [ ] o.a.s.SolrTestCaseJ4
###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J2/temp/solr.cloud.OverseerTest_51AAE98999A64DCF-001
[junit4] 2> NOTE: test params are:
codec=FastDecompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST_DECOMPRESSION,
chunkSize=2, maxDocsPerChunk=1, blockSize=781),
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST_DECOMPRESSION,
chunkSize=2, blockSize=781)),
sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {},
locale=ja_JP_JP_#u-ca-japanese, timezone=America/Cambridge_Bay
[junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation
1.8.0_66 (64-bit)/cpus=4,threads=1,free=133960776,total=528482304
[junit4] 2> NOTE: All tests run in this JVM: [TestCollectionAPI,
TestSolrDeletionPolicy1, TestMacros, CoreAdminCreateDiscoverTest,
OverriddenZkACLAndCredentialsProvidersTest, TestCrossCoreJoin,
TestClassNameShortening, TestGroupingSearch, HighlighterMaxOffsetTest,
TestJettySolrRunner, TestJmxIntegration, HardAutoCommitTest,
RAMDirectoryFactoryTest, TestNonDefinedSimilarityFactory,
TestConfigSetImmutable, FieldMutatingUpdateProcessorTest,
TestPerFieldSimilarity, TestWriterPerf, DateRangeFieldTest, TestFastLRUCache,
RegexBoostProcessorTest, TestBulkSchemaAPI, DeleteReplicaTest,
TestSolrQueryParser, TestRecovery, TestDistributedStatsComponentCardinality,
TestCloudSchemaless, TestDistribIDF, SaslZkACLProviderTest, ActionThrottleTest,
SuggesterTest, TestDefaultSearchFieldResource, TestSchemaVersionResource,
DistributedQueueTest, TestXIncludeConfig, TestImplicitCoreProperties,
PluginInfoTest, TestReversedWildcardFilterFactory,
TestSweetSpotSimilarityFactory, TestMiniSolrCloudClusterSSL,
TestComplexPhraseQParserPlugin, DistributedIntervalFacetingTest,
TestIndexingPerformance, TermVectorComponentDistributedTest, SuggesterWFSTTest,
SampleTest, TestFieldResource, TestBulkSchemaConcurrent, TestSearchPerf,
PKIAuthenticationIntegrationTest, ParsingFieldUpdateProcessorsTest,
SolrCoreCheckLockOnStartupTest, TestSolrCloudWithKerberosAlt,
TestExtendedDismaxParser, TestExactSharedStatsCache, TestCustomDocTransformer,
TestCloudManagedSchema, TestIndexSearcher, TestFastWriter,
TestElisionMultitermQuery, BigEndianAscendingWordDeserializerTest,
TestScoreJoinQPNoScore, ScriptEngineTest, RulesTest,
TestSolrQueryParserResource, TestSerializedLuceneMatchVersion,
DocValuesMultiTest, RuleEngineTest, TestRandomRequestDistribution,
ExplicitHLLTest, RequestLoggingTest, TestDynamicLoading, ResponseHeaderTest,
BasicDistributedZk2Test, TestSchemaSimilarityResource, TestCSVResponseWriter,
HdfsLockFactoryTest, TestRemoveLastDynamicCopyField, AutoCommitTest,
BadIndexSchemaTest, RollingRestartTest, UpdateParamsTest,
HdfsDirectoryFactoryTest, TestSQLHandler, TestStressRecovery,
TestSortByMinMaxFunction, DirectSolrConnectionTest, HdfsRecoverLeaseTest,
TestSearcherReuse, ChaosMonkeySafeLeaderTest, CollectionsAPIDistributedZkTest,
OpenCloseCoreStressTest, OverseerTest]
[junit4] Completed [286/555] on J2 in 61.03s, 12 tests, 1 failure, 1 skipped
<<< FAILURES!
[...truncated 855 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/build.xml:775:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/build.xml:719:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/build.xml:59:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build.xml:233:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/common-build.xml:516:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/lucene/common-build.xml:1432:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/lucene/common-build.xml:987:
There were test failures: 555 suites (8 ignored), 2185 tests, 1 failure, 52
ignored (38 assumptions) [seed: 51AAE98999A64DCF]
Total time: 60 minutes 5 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
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]