Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/14807/
Java: 64bit/jdk1.9.0-ea-b90 -XX:+UseCompressedOops -XX:+UseG1GC

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([B3178102A7C387E9:1843663E321924E7]: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:520)
        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:747)




Build Log:
[...truncated 9937 lines...]
   [junit4] Suite: org.apache.solr.cloud.OverseerTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.OverseerTest_B3178102A7C387E9-001/init-core-data-001
   [junit4]   2> 551144 INFO  
(SUITE-OverseerTest-seed#[B3178102A7C387E9]-worker) [    ] o.a.s.SolrTestCaseJ4 
Randomized ssl (false) and clientAuth (true)
   [junit4]   2> 551144 INFO  
(SUITE-OverseerTest-seed#[B3178102A7C387E9]-worker) [    ] o.a.s.SolrTestCaseJ4 
####initCore
   [junit4]   2> 551144 INFO  
(SUITE-OverseerTest-seed#[B3178102A7C387E9]-worker) [    ] o.a.s.SolrTestCaseJ4 
####initCore end
   [junit4]   2> 551153 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testOverseerFailure
   [junit4]   2> 551153 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 551153 INFO  (Thread-1637) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 551153 INFO  (Thread-1637) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 551253 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:60922
   [junit4]   2> 551254 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 551254 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 551257 INFO  (zkCallback-712-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@3c8ce5d3 
name:ZooKeeperConnection Watcher:127.0.0.1:60922 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 551258 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 551258 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 551279 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 551279 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 551281 INFO  (zkCallback-713-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@3835ff04 
name:ZooKeeperConnection Watcher:127.0.0.1:60922 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 551281 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 551281 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 551281 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 551283 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 551283 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 551284 INFO  (zkCallback-714-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@4025c53c 
name:ZooKeeperConnection Watcher:127.0.0.1:60922/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 551284 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 551284 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 551289 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 551290 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 551290 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 551292 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 551301 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 551301 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 551303 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 551305 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 551305 INFO  (zkCallback-715-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@3d4e4601 
name:ZooKeeperConnection Watcher:127.0.0.1:60922/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 551306 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 551306 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 551306 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 551307 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes/node1
   [junit4]   2> 551307 INFO  (zkCallback-715-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> 551307 INFO  (zkCallback-714-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> 551307 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 551316 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 551326 INFO  (zkCallback-716-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@770f27ba 
name:ZooKeeperConnection Watcher:127.0.0.1:60922/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 551326 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 551326 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 551326 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=600000&connTimeout=60000&retry=true
   [junit4]   2> 551332 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 551334 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
   [junit4]   2> 551334 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 551335 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/overseer_elect/election/94817775805595652-127.0.0.1:60922_solr-n_0000000000
   [junit4]   2> 551335 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:60922_solr
   [junit4]   2> 551335 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 551335 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.Overseer Overseer 
(id=94817775805595652-127.0.0.1:60922_solr-n_0000000000) starting
   [junit4]   2> 551336 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 551337 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 551348 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
   [junit4]   2> 551349 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
   [junit4]   2> 551350 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
   [junit4]   2> 551351 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
   [junit4]   2> 551354 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 551354 INFO  
(OverseerCollectionConfigSetProcessor-94817775805595652-127.0.0.1:60922_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer 
operations
   [junit4]   2> 551354 INFO  
(OverseerStateUpdate-94817775805595652-127.0.0.1:60922_solr-n_0000000000) [    
] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 551354 INFO  
(OverseerStateUpdate-94817775805595652-127.0.0.1:60922_solr-n_0000000000) [    
] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 552358 INFO  
(OverseerStateUpdate-94817775805595652-127.0.0.1:60922_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> 552359 INFO  
(OverseerStateUpdate-94817775805595652-127.0.0.1:60922_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> 552359 INFO  
(OverseerStateUpdate-94817775805595652-127.0.0.1:60922_solr-n_0000000000) [    
] o.a.s.c.o.ClusterStateMutator building a new cName: collection1
   [junit4]   2> 552359 INFO  
(OverseerStateUpdate-94817775805595652-127.0.0.1:60922_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
   [junit4]   2> 552364 INFO  (zkCallback-714-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> 552364 INFO  (zkCallback-715-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> 552369 INFO  (zkCallback-716-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> 552865 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/collections/collection1/leader_elect/shard1/election
   [junit4]   2> 552868 INFO  (zkCallback-715-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 552868 INFO  (zkCallback-714-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 552868 INFO  (zkCallback-716-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 552870 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/collections/collection1/leader_elect/shard1/election/94817775805595651-node1_core1-n_0000000000
   [junit4]   2> 552870 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/leaders/shard1
   [junit4]   2> 552871 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
   [junit4]   2> 552873 INFO  
(OverseerStateUpdate-94817775805595652-127.0.0.1:60922_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> 552873 INFO  
(OverseerStateUpdate-94817775805595652-127.0.0.1:60922_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> 552875 INFO  
(OverseerStateUpdate-94817775805595652-127.0.0.1:60922_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> 552879 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/collections/collection1/leader_elect/shard1/election
   [junit4]   2> 552879 INFO  
(OverseerStateUpdate-94817775805595652-127.0.0.1:60922_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [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: 1
   [junit4]   2> 552879 INFO  
(OverseerStateUpdate-94817775805595652-127.0.0.1:60922_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [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> 552879 INFO  
(OverseerStateUpdate-94817775805595652-127.0.0.1:60922_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator shard=shard1 is already registered
   [junit4]   2> 552882 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/collections/collection1/leader_elect/shard1/election/94817775805595651-node1_core1-n_0000000001
   [junit4]   2> 552882 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.LeaderElector was going to be leader 
/collections/collection1/leader_elect/shard1/election/94817775805595651-node1_core1-n_0000000001
 , seq(0) 
/collections/collection1/leader_elect/shard1/election/94817775805595651-node1_core1-n_0000000000
   [junit4]   2> 552981 INFO  (zkCallback-715-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> 552981 INFO  (zkCallback-716-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> 552985 INFO  (zkCallback-714-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> 553356 INFO  
(OverseerCollectionConfigSetProcessor-94817775805595652-127.0.0.1:60922_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskProcessor 
   [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.OverseerTaskProcessor.amILeader(OverseerTaskProcessor.java:355)
   [junit4]   2>        at 
org.apache.solr.cloud.OverseerTaskProcessor.run(OverseerTaskProcessor.java:172)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:747)
   [junit4]   2> 553356 INFO  
(OverseerCollectionConfigSetProcessor-94817775805595652-127.0.0.1:60922_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskProcessor According to ZK I 
(id=94817775805595652-127.0.0.1:60922_solr-n_0000000000) am no longer a leader.
   [junit4]   2> 554038 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/collections/collection1/leader_elect/shard1/election
   [junit4]   2> 554039 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/collections/collection1/leader_elect/shard1/election/94817775805595651-node1_core1-n_0000000002
   [junit4]   2> 554040 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.LeaderElector was going to be leader 
/collections/collection1/leader_elect/shard1/election/94817775805595651-node1_core1-n_0000000002
 , seq(0) 
/collections/collection1/leader_elect/shard1/election/94817775805595651-node1_core1-n_0000000000
   [junit4]   2> 554041 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 554052 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 554053 INFO  (zkCallback-718-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@62546d61 
name:ZooKeeperConnection Watcher:127.0.0.1:60922/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 554053 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 554053 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 554053 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.Overseer Overseer 
(id=94817775805595652-127.0.0.1:60922_solr-n_0000000000) closing
   [junit4]   2> 554053 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=600000&connTimeout=60000&retry=true
   [junit4]   2> 554053 INFO  
(OverseerStateUpdate-94817775805595652-127.0.0.1:60922_solr-n_0000000000) [    
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:60922_solr
   [junit4]   2> 554055 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 554055 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/overseer_elect/election/94817775805595653-127.0.0.1:60922_solr-n_0000000001
   [junit4]   2> 554055 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:60922_solr
   [junit4]   2> 554055 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 554056 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.Overseer Overseer 
(id=94817775805595653-127.0.0.1:60922_solr-n_0000000001) starting
   [junit4]   2> 554066 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 554066 INFO  
(OverseerCollectionConfigSetProcessor-94817775805595653-127.0.0.1:60922_solr-n_0000000001)
 [    ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer 
operations
   [junit4]   2> 554067 INFO  
(OverseerStateUpdate-94817775805595653-127.0.0.1:60922_solr-n_0000000001) [    
] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 554067 INFO  
(OverseerStateUpdate-94817775805595653-127.0.0.1:60922_solr-n_0000000001) [    
] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 554068 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> 554087 INFO  
(OverseerStateUpdate-94817775805595653-127.0.0.1:60922_solr-n_0000000001) [    
] 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: 2
   [junit4]   2> 554087 INFO  
(OverseerStateUpdate-94817775805595653-127.0.0.1:60922_solr-n_0000000001) [    
] 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> 554087 INFO  
(OverseerStateUpdate-94817775805595653-127.0.0.1:60922_solr-n_0000000001) [    
] o.a.s.c.o.ReplicaMutator shard=shard1 is already registered
   [junit4]   2> 554089 INFO  (zkCallback-715-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> 554089 INFO  (zkCallback-714-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> 554089 INFO  (zkCallback-718-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> 554142 INFO  
(OverseerStateUpdate-94817775805595653-127.0.0.1:60922_solr-n_0000000001) [    
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"deletecore",
   [junit4]   2>   "node_name":"node1",
   [junit4]   2>   "core":"core1",
   [junit4]   2>   "core_node_name":"core_node1",
   [junit4]   2>   "collection":"collection1"} current state version: 3
   [junit4]   2> 554244 INFO  
(OverseerStateUpdate-94817775805595653-127.0.0.1:60922_solr-n_0000000001) [    
] o.a.s.c.o.ZkStateWriter going to delete_collection 
/collections/collection1/state.json
   [junit4]   2> 554301 INFO  (zkCallback-714-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 554301 INFO  (zkCallback-718-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 554301 INFO  (zkCallback-715-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 554301 INFO  (zkCallback-718-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> 554301 INFO  (zkCallback-715-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> 554302 INFO  (zkCallback-714-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> 554802 INFO  (zkCallback-718-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> 554802 INFO  (zkCallback-715-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> 554802 INFO  (zkCallback-714-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> 554805 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:60922 60922
   [junit4]   2> 554807 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 0x150dc43c5490002, 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:747)
   [junit4]   2> 554912 INFO  (Thread-1637) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:60922 60922
   [junit4]   2> 554915 WARN  (Thread-1637) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        4       /solr/aliases.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        4       /solr/clusterstate.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        4       /solr/live_nodes
   [junit4]   2>        4       /solr/collections
   [junit4]   2>        2       /solr/overseer/queue
   [junit4]   2>        2       /solr/overseer/collection-queue-work
   [junit4]   2>        2       /solr/overseer/queue-work
   [junit4]   2> 
   [junit4]   2> 554915 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testOverseerFailure
   [junit4]   2> 554915 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.Overseer Overseer 
(id=94817775805595653-127.0.0.1:60922_solr-n_0000000001) closing
   [junit4]   2> 554916 INFO  
(OverseerStateUpdate-94817775805595653-127.0.0.1:60922_solr-n_0000000001) [    
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:60922_solr
   [junit4]   2> 554931 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testOverseerStatsReset
   [junit4]   2> 554931 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 554936 INFO  (Thread-1638) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 554936 INFO  (Thread-1638) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 554937 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> 555031 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:50912
   [junit4]   2> 555032 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 555040 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 555045 INFO  (zkCallback-720-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@5bad10f name:ZooKeeperConnection 
Watcher:127.0.0.1:50912 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 555045 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 555045 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 555046 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 555049 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 555064 INFO  (zkCallback-721-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@9db99ad name:ZooKeeperConnection 
Watcher:127.0.0.1:50912 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 555064 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 555064 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 555064 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 555074 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 555075 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 555075 INFO  (zkCallback-722-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@677bc227 
name:ZooKeeperConnection Watcher:127.0.0.1:50912/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 555075 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 555076 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 555076 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 555076 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 555077 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 555077 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 555078 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 555078 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 555079 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 555079 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 555080 INFO  (zkCallback-723-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7a41f073 
name:ZooKeeperConnection Watcher:127.0.0.1:50912/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 555080 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 555080 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 555081 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 555081 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes/node1
   [junit4]   2> 555082 INFO  (zkCallback-722-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> 555082 INFO  (zkCallback-723-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> 555083 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=600000&connTimeout=60000&retry=true
   [junit4]   2> 555085 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 555087 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
   [junit4]   2> 555090 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 555090 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/overseer_elect/election/94817776054501378-127.0.0.1:50912_solr-n_0000000000
   [junit4]   2> 555091 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:50912_solr
   [junit4]   2> 555091 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 555092 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.Overseer Overseer 
(id=94817776054501378-127.0.0.1:50912_solr-n_0000000000) starting
   [junit4]   2> 555093 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 555094 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 555095 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
   [junit4]   2> 555097 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
   [junit4]   2> 555100 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
   [junit4]   2> 555101 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
   [junit4]   2> 555103 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 555105 INFO  
(OverseerStateUpdate-94817776054501378-127.0.0.1:50912_solr-n_0000000000) [    
] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 555106 INFO  
(OverseerCollectionConfigSetProcessor-94817776054501378-127.0.0.1:50912_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer 
operations
   [junit4]   2> 555106 INFO  
(OverseerStateUpdate-94817776054501378-127.0.0.1:50912_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> 555106 INFO  
(OverseerStateUpdate-94817776054501378-127.0.0.1:50912_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> 555106 INFO  
(OverseerStateUpdate-94817776054501378-127.0.0.1:50912_solr-n_0000000000) [    
] o.a.s.c.o.ClusterStateMutator building a new cName: collection1
   [junit4]   2> 555106 INFO  
(OverseerStateUpdate-94817776054501378-127.0.0.1:50912_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
   [junit4]   2> 555107 INFO  (zkCallback-722-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> 555107 INFO  (zkCallback-723-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> 555606 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/collections/collection1/leader_elect/shard1/election
   [junit4]   2> 555607 INFO  (zkCallback-722-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 555607 INFO  (zkCallback-723-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 555609 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/collections/collection1/leader_elect/shard1/election/94817776054501379-node1_core1-n_0000000000
   [junit4]   2> 555609 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/leaders/shard1
   [junit4]   2> 555610 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
   [junit4]   2> 555612 INFO  
(OverseerStateUpdate-94817776054501378-127.0.0.1:50912_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> 555613 INFO  
(OverseerStateUpdate-94817776054501378-127.0.0.1:50912_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> 555614 INFO  
(OverseerStateUpdate-94817776054501378-127.0.0.1:50912_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> 555615 INFO  (zkCallback-722-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> 555615 INFO  (zkCallback-723-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> 555720 INFO  (zkCallback-722-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 0)
   [junit4]   2> 557116 WARN  (zkCallback-723-thread-1) [    ] 
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK
   [junit4]   2> 557119 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:50912 50912
   [junit4]   2> 557121 INFO  
(OverseerCollectionConfigSetProcessor-94817776054501378-127.0.0.1:50912_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskProcessor 
   [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.OverseerTaskProcessor.amILeader(OverseerTaskProcessor.java:355)
   [junit4]   2>        at 
org.apache.solr.cloud.OverseerTaskProcessor.run(OverseerTaskProcessor.java:172)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:747)
   [junit4]   2> 557121 INFO  
(OverseerCollectionConfigSetProcessor-94817776054501378-127.0.0.1:50912_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskProcessor According to ZK I 
(id=94817776054501378-127.0.0.1:50912_solr-n_0000000000) am no longer a leader.
   [junit4]   2> 557139 INFO  (Thread-1638) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:50912 50912
   [junit4]   2> 557144 WARN  (Thread-1638) [    ] 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> 557146 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testOverseerStatsReset
   [junit4]   2> 557146 INFO  
(TEST-OverseerTest.testOverseerStatsReset-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.Overseer Overseer 
(id=94817776054501378-127.0.0.1:50912_solr-n_0000000000) closing
   [junit4]   2> 557146 INFO  
(OverseerStateUpdate-94817776054501378-127.0.0.1:50912_solr-n_0000000000) [    
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:50912_solr
   [junit4]   2> 557146 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> NOTE: reproduce with: ant test  -Dtestcase=OverseerTest 
-Dtests.method=testOverseerStatsReset -Dtests.seed=B3178102A7C387E9 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=cy_GB 
-Dtests.timezone=ECT -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] FAILURE 2.23s J2 | OverseerTest.testOverseerStatsReset <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: expected:<1> but 
was:<2>
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([B3178102A7C387E9:1843663E321924E7]:0)
   [junit4]    >        at 
org.apache.solr.cloud.OverseerTest.testOverseerStatsReset(OverseerTest.java:722)
   [junit4]    >        at java.lang.Thread.run(Thread.java:747)
   [junit4]   2> 557172 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testPlaceholders
   [junit4]   2> 557173 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 557173 INFO  (Thread-1639) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 557173 INFO  (Thread-1639) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 557276 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:45405
   [junit4]   2> 557276 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 557276 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 557278 INFO  (zkCallback-725-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@4d2fe1d2 
name:ZooKeeperConnection Watcher:127.0.0.1:45405/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 557278 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 557279 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 557279 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 557322 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 557322 INFO  (zkCallback-726-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@49778e00 
name:ZooKeeperConnection Watcher:127.0.0.1:45405 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 557322 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 557322 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 557323 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 557323 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 557325 INFO  (zkCallback-727-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@515504cc 
name:ZooKeeperConnection Watcher:127.0.0.1:45405 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 557325 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 557325 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 557325 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 557328 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 557329 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 557330 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 557330 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 557331 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 557332 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 557333 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 557351 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 557351 INFO  (zkCallback-728-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@28a4bf32 
name:ZooKeeperConnection Watcher:127.0.0.1:45405/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 557351 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 557353 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 557372 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 557373 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes/node1
   [junit4]   2> 557374 INFO  (zkCallback-725-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> 557374 INFO  (zkCallback-728-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> 557375 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 557394 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 557395 INFO  (zkCallback-729-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@71acc9d3 
name:ZooKeeperConnection Watcher:127.0.0.1:45405/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 557395 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 557395 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 557395 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=600000&connTimeout=60000&retry=true
   [junit4]   2> 557396 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 557397 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
   [junit4]   2> 557398 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 557398 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/overseer_elect/election/94817776200974340-127.0.0.1:45405_solr-n_0000000000
   [junit4]   2> 557398 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:45405_solr
   [junit4]   2> 557398 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 557399 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.Overseer Overseer 
(id=94817776200974340-127.0.0.1:45405_solr-n_0000000000) starting
   [junit4]   2> 557399 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 557406 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 557411 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
   [junit4]   2> 557412 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
   [junit4]   2> 557413 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
   [junit4]   2> 557414 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
   [junit4]   2> 557416 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 557436 INFO  
(OverseerCollectionConfigSetProcessor-94817776200974340-127.0.0.1:45405_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer 
operations
   [junit4]   2> 557449 INFO  
(OverseerStateUpdate-94817776200974340-127.0.0.1:45405_solr-n_0000000000) [    
] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 557449 INFO  
(OverseerStateUpdate-94817776200974340-127.0.0.1:45405_solr-n_0000000000) [    
] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 557454 INFO  
(OverseerStateUpdate-94817776200974340-127.0.0.1:45405_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> 557454 INFO  
(OverseerStateUpdate-94817776200974340-127.0.0.1:45405_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> 557454 INFO  
(OverseerStateUpdate-94817776200974340-127.0.0.1:45405_solr-n_0000000000) [    
] o.a.s.c.o.ClusterStateMutator building a new cName: collection1
   [junit4]   2> 557454 INFO  
(OverseerStateUpdate-94817776200974340-127.0.0.1:45405_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard2
   [junit4]   2> 557455 INFO  (zkCallback-728-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> 557455 INFO  (zkCallback-725-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> 557464 INFO  (zkCallback-729-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> 557937 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/collections/collection1/leader_elect/shard2/election
   [junit4]   2> 557938 INFO  (zkCallback-728-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 557938 INFO  (zkCallback-725-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 557938 INFO  (zkCallback-729-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 557941 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/collections/collection1/leader_elect/shard2/election/94817776200974339-node1_core1-n_0000000000
   [junit4]   2> 557941 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/leaders/shard2
   [junit4]   2> 557942 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
   [junit4]   2> 557944 INFO  
(OverseerStateUpdate-94817776200974340-127.0.0.1:45405_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "base_url":"http://node1/solr/";,
   [junit4]   2>   "node_name":"node1",
   [junit4]   2>   "core_node_name":"node1",
   [junit4]   2>   "core":"core1"} current state version: 1
   [junit4]   2> 557944 INFO  
(OverseerStateUpdate-94817776200974340-127.0.0.1:45405_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":"shard2",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "base_url":"http://node1/solr/";,
   [junit4]   2>   "node_name":"node1",
   [junit4]   2>   "core_node_name":"node1",
   [junit4]   2>   "core":"core1"}
   [junit4]   2> 557947 INFO  
(OverseerStateUpdate-94817776200974340-127.0.0.1:45405_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://node1/solr/";,
   [junit4]   2>   "core":"core1"} current state version: 1
   [junit4]   2> 557949 INFO  (zkCallback-725-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> 557949 INFO  (zkCallback-728-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> 559448 INFO  
(OverseerCollectionConfigSetProcessor-94817776200974340-127.0.0.1:45405_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskProcessor 
   [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.OverseerTaskProcessor.amILeader(OverseerTaskProcessor.java:355)
   [junit4]   2>        at 
org.apache.solr.cloud.OverseerTaskProcessor.run(OverseerTaskProcessor.java:172)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:747)
   [junit4]   2> 559448 INFO  
(OverseerCollectionConfigSetProcessor-94817776200974340-127.0.0.1:45405_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskProcessor According to ZK I 
(id=94817776200974340-127.0.0.1:45405_solr-n_0000000000) am no longer a leader.
   [junit4]   2> 559449 WARN  
(OverseerStateUpdate-94817776200974340-127.0.0.1:45405_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
   [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.DistributedQueue.fetchZkChildren(DistributedQueue.java:310)
   [junit4]   2>        at 
org.apache.solr.cloud.DistributedQueue.firstChild(DistributedQueue.java:289)
   [junit4]   2>        at 
org.apache.solr.cloud.DistributedQueue.firstElement(DistributedQueue.java:358)
   [junit4]   2>        at 
org.apache.solr.cloud.DistributedQueue.peek(DistributedQueue.java:165)
   [junit4]   2>        at 
org.apache.solr.cloud.Overseer$ClusterStateUpdater.run(Overseer.java:233)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:747)
   [junit4]   2> 559449 INFO  
(OverseerStateUpdate-94817776200974340-127.0.0.1:45405_solr-n_0000000000) [    
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:45405_solr
   [junit4]   2> 559449 WARN  (zkCallback-728-thread-1) [    ] 
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK
   [junit4]   2> 559473 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:45405 45405
   [junit4]   2> 559484 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> 559549 INFO  (Thread-1639) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:45405 45405
   [junit4]   2> 559550 WARN  (Thread-1639) [    ] 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> 559551 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testPlaceholders
   [junit4]   2> 559551 INFO  
(TEST-OverseerTest.testPlaceholders-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.Overseer Overseer 
(id=94817776200974340-127.0.0.1:45405_solr-n_0000000000) closing
   [junit4]   2> 559561 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testExternalClusterStateChangeBehavior
   [junit4]   2> 559562 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 559562 INFO  (Thread-1640) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 559562 INFO  (Thread-1640) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 559662 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.ZkTestServer start zk server on port:33478
   [junit4]   2> 559662 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 559669 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 559672 INFO  (zkCallback-731-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7e6a0bfa 
name:ZooKeeperConnection Watcher:127.0.0.1:33478/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 559672 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 559673 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 559673 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 559696 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 559702 INFO  (zkCallback-732-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@275d6feb 
name:ZooKeeperConnection Watcher:127.0.0.1:33478 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 559702 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 559702 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 559705 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 559713 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 559724 INFO  (zkCallback-733-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7806bd58 
name:ZooKeeperConnection Watcher:127.0.0.1:33478 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 559724 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 559725 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 559725 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 559730 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 559730 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 559731 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 559731 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 559732 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 559733 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 559736 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 559760 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 559772 INFO  (zkCallback-734-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@342c2f01 
name:ZooKeeperConnection Watcher:127.0.0.1:33478/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 559773 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 559773 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 559773 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with 
params: socketTimeout=600000&connTimeout=60000&retry=true
   [junit4]   2> 559774 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 559775 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
   [junit4]   2> 559775 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 559775 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.LeaderElector Joined leadership election with path: 
/overseer_elect/election/94817776356687875-127.0.0.1:33478_solr-n_0000000000
   [junit4]   2> 559775 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.OverseerElectionContext I am going to be the leader 
127.0.0.1:33478_solr
   [junit4]   2> 559775 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 559777 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.Overseer Overseer 
(id=94817776356687875-127.0.0.1:33478_solr-n_0000000000) starting
   [junit4]   2> 559777 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 559778 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 559778 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
   [junit4]   2> 559779 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
   [junit4]   2> 559780 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
   [junit4]   2> 559780 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
   [junit4]   2> 559782 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[B3178102A7C387E9])
 [    ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 559782 INFO  
(OverseerCollectionConfigSetProcessor-94817776356687875-127.0.0.1:33478_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer 
operations
   [junit4]   2> 559782 INFO  
(OverseerStateUpdate-94817776356687875-127.0.0.1:33478_solr-n_0000000000) [    
] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 559782 INFO  
(OverseerStateUpdate-94817776356687875-127.0.0.1:33478_solr-n_0000000000) [    
] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 559783 INFO  
(OverseerStateUpdate-94817776356687875-127.0.0.1:33478_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":"c1",
   [junit4]   2>   "core":"core1",
   [junit4]   2>   "roles":"",
   [junit4]   2>   "state":"down"} current state version: 0
   [junit4]   2> 559784 INFO  
(OverseerStateUpdate-94817776356687875-127.0.0.1:33478_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":"c1",
   [junit4]   2>   "core":"core1",
   [junit4]   2>   "roles":"",
   [junit4]   2>   "state":"down"}
   [junit4]   2> 559784 INFO  
(OverseerStateUpdate-94817776356687875-127.0.0.1:33478_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
   [junit4]   2> 559784 INFO  (zkCallback-734-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> 559784 INFO  (zkCallback-731-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> 559842 IN

[...truncated too long message...]

4]   2>   "numShards":"3",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr/"} current state version: 6
   [junit4]   2> 615191 INFO  
(OverseerStateUpdate-94817779819479043-127.0.0.1:33399_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":"collection2",
   [junit4]   2>   "numShards":"3",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr/"}
   [junit4]   2> 615191 INFO  
(OverseerStateUpdate-94817779819479043-127.0.0.1:33399_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Collection already exists with numShards=3
   [junit4]   2> 615191 INFO  
(OverseerStateUpdate-94817779819479043-127.0.0.1:33399_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
   [junit4]   2> 615293 INFO  (zkCallback-840-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> 615293 INFO  (zkCallback-841-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> 615293 INFO  (zkCallback-843-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> 615690 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/collections/collection2/leader_elect/shard1/election
   [junit4]   2> 615691 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/collections/collection2/leader_elect/shard1/election/94817779819479044-127.0.0.1_core3-n_0000000000
   [junit4]   2> 615692 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection2/leaders/shard1
   [junit4]   2> 615692 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
   [junit4]   2> 615693 INFO  
(OverseerStateUpdate-94817779819479043-127.0.0.1:33399_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"leader",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"collection2",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr/";,
   [junit4]   2>   "core":"core3"} current state version: 7
   [junit4]   2> 615794 INFO  (zkCallback-843-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> 615794 INFO  (zkCallback-841-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> 615794 INFO  (zkCallback-840-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> 615844 INFO  (zkCallback-843-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> 615844 INFO  (zkCallback-841-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> 617344 WARN  (zkCallback-843-thread-1) [    ] 
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK
   [junit4]   2> 617345 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:33399 33399
   [junit4]   2> 617415 INFO  (Thread-1648) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:33399 33399
   [junit4]   2> 617416 WARN  (Thread-1648) [    ] 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> 617416 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[B3178102A7C387E9]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testBadQueueItem
   [junit4]   2> 617416 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[B3178102A7C387E9]) [    ] 
o.a.s.c.Overseer Overseer 
(id=94817779819479043-127.0.0.1:33399_solr-n_0000000000) closing
   [junit4]   2> 617416 INFO  
(OverseerStateUpdate-94817779819479043-127.0.0.1:33399_solr-n_0000000000) [    
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:33399_solr
   [junit4]   2> 617417 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> 620417 INFO  
(SUITE-OverseerTest-seed#[B3178102A7C387E9]-worker) [    ] o.a.s.SolrTestCaseJ4 
###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.OverseerTest_B3178102A7C387E9-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene60), 
sim=ClassicSimilarity, locale=cy_GB, timezone=ECT
   [junit4]   2> NOTE: Linux 3.19.0-31-generic amd64/Oracle Corporation 
1.9.0-ea (64-bit)/cpus=12,threads=1,free=223377576,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [SSLMigrationTest, 
ShowFileRequestHandlerTest, TestSearchPerf, 
OverriddenZkACLAndCredentialsProvidersTest, 
DocExpirationUpdateProcessorFactoryTest, TestSerializedLuceneMatchVersion, 
ResponseHeaderTest, SaslZkACLProviderTest, TestXIncludeConfig, 
SuggestComponentContextFilterQueryTest, TestCursorMarkWithoutUniqueKey, 
TestRecovery, ActionThrottleTest, TestGroupingSearch, TestMacros, 
DirectUpdateHandlerOptimizeTest, TestSolrIndexConfig, 
BinaryUpdateRequestHandlerTest, TestConfigSetImmutable, TestCSVResponseWriter, 
TestSolrQueryParser, TestCryptoKeys, TestMiniSolrCloudClusterSSL, 
HdfsWriteToMultipleCollectionsTest, UnloadDistributedZkTest, 
TestClassNameShortening, TestCloudManagedSchema, TestFieldSortValues, 
PluginInfoTest, DebugComponentTest, TestPHPSerializedResponseWriter, 
AsyncMigrateRouteKeyTest, ConnectionManagerTest, TestTolerantSearch, 
TestDynamicLoading, HdfsDirectoryFactoryTest, TestDistribIDF, 
CollectionTooManyReplicasTest, TestZkChroot, TestElisionMultitermQuery, 
CurrencyFieldXmlFileTest, DirectSolrConnectionTest, TestBulkSchemaAPI, 
FullSolrCloudDistribCmdsTest, TestExclusionRuleCollectionAccess, 
ParsingFieldUpdateProcessorsTest, CoreAdminCreateDiscoverTest, 
TestFuzzyAnalyzedSuggestions, BasicDistributedZk2Test, 
TestSolrQueryParserDefaultOperatorResource, OverseerTest]
   [junit4] Completed [163/555] on J2 in 69.44s, 12 tests, 1 failure, 1 skipped 
<<< FAILURES!

[...truncated 1231 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:775: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:719: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:59: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:233: The 
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:516: The 
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1432: 
The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:987: 
There were test failures: 555 suites (8 ignored), 2185 tests, 1 failure, 77 
ignored (38 assumptions) [seed: B3178102A7C387E9]

Total time: 50 minutes 0 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any


---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to