Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/5380/
Java: 32bit/jdk1.8.0_66 -server -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([A98CD3B664DFD2A8:2D8348AF10571A6]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.failNotEquals(Assert.java:647)
        at org.junit.Assert.assertEquals(Assert.java:128)
        at org.junit.Assert.assertEquals(Assert.java:472)
        at org.junit.Assert.assertEquals(Assert.java:456)
        at 
org.apache.solr.cloud.OverseerTest.testOverseerStatsReset(OverseerTest.java:722)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:497)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1660)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:866)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:902)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:875)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:777)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:811)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:822)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 10204 lines...]
   [junit4] Suite: org.apache.solr.cloud.OverseerTest
   [junit4]   2> Creating dataDir: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.OverseerTest_A98CD3B664DFD2A8-001\init-core-data-001
   [junit4]   2> 1425794 INFO  
(SUITE-OverseerTest-seed#[A98CD3B664DFD2A8]-worker) [    ] o.a.s.SolrTestCaseJ4 
Randomized ssl (true) and clientAuth (true)
   [junit4]   2> 1425794 INFO  
(SUITE-OverseerTest-seed#[A98CD3B664DFD2A8]-worker) [    ] o.a.s.SolrTestCaseJ4 
####initCore
   [junit4]   2> 1425794 INFO  
(SUITE-OverseerTest-seed#[A98CD3B664DFD2A8]-worker) [    ] o.a.s.SolrTestCaseJ4 
####initCore end
   [junit4]   2> 1425795 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testStateChange
   [junit4]   2> 1425797 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1425797 INFO  (Thread-3477) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1425797 INFO  (Thread-3477) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1425901 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:60400
   [junit4]   2> 1425901 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1425902 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1425905 INFO  (zkCallback-1219-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@21b752 name:ZooKeeperConnection 
Watcher:127.0.0.1:60400/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 1425905 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1425906 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1425906 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1425907 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1425909 INFO  (zkCallback-1220-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@d4f1bf name:ZooKeeperConnection 
Watcher:127.0.0.1:60400 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 1425909 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1425909 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1425910 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1425912 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1425913 INFO  (zkCallback-1221-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@17e647c name:ZooKeeperConnection 
Watcher:127.0.0.1:60400 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 1425913 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1425914 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1425914 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1425918 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1425920 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 1425922 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1425924 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1425926 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1425927 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1425929 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1425930 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1425931 INFO  (zkCallback-1222-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1a21df4 name:ZooKeeperConnection 
Watcher:127.0.0.1:60400/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 1425931 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1425931 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1425931 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=600000&connTimeout=60000&retry=true
   [junit4]   2> 1425940 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 1425942 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
   [junit4]   2> 1425944 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1425944 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/overseer_elect/election/94824765653319683-127.0.0.1:60400_solr-n_0000000000
   [junit4]   2> 1425945 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:60400_solr
   [junit4]   2> 1425945 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 1425947 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.Overseer Overseer 
(id=94824765653319683-127.0.0.1:60400_solr-n_0000000000) starting
   [junit4]   2> 1425948 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 1425951 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 1425955 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
   [junit4]   2> 1425957 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
   [junit4]   2> 1425960 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
   [junit4]   2> 1425962 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
   [junit4]   2> 1425967 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 1425967 INFO  
(OverseerCollectionConfigSetProcessor-94824765653319683-127.0.0.1:60400_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer 
operations
   [junit4]   2> 1425968 INFO  
(OverseerStateUpdate-94824765653319683-127.0.0.1:60400_solr-n_0000000000) [    
] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 1425968 INFO  
(OverseerStateUpdate-94824765653319683-127.0.0.1:60400_solr-n_0000000000) [    
] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1425972 INFO  
(OverseerStateUpdate-94824765653319683-127.0.0.1:60400_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr";,
   [junit4]   2>   "node_name":"node1",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "core":"core1",
   [junit4]   2>   "roles":"",
   [junit4]   2>   "state":"recovering"} current state version: 0
   [junit4]   2> 1425972 INFO  
(OverseerStateUpdate-94824765653319683-127.0.0.1:60400_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Update state numShards=null message={
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr";,
   [junit4]   2>   "node_name":"node1",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "core":"core1",
   [junit4]   2>   "roles":"",
   [junit4]   2>   "state":"recovering"}
   [junit4]   2> 1425972 INFO  
(OverseerStateUpdate-94824765653319683-127.0.0.1:60400_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
   [junit4]   2> 1425973 INFO  (zkCallback-1222-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> 1425973 INFO  (zkCallback-1219-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> 1426023 INFO  
(OverseerStateUpdate-94824765653319683-127.0.0.1:60400_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr";,
   [junit4]   2>   "node_name":"node1",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "core":"core1",
   [junit4]   2>   "roles":"",
   [junit4]   2>   "state":"active"} current state version: 1
   [junit4]   2> 1426024 INFO  
(OverseerStateUpdate-94824765653319683-127.0.0.1:60400_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Update state numShards=null message={
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr";,
   [junit4]   2>   "node_name":"node1",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "core":"core1",
   [junit4]   2>   "roles":"",
   [junit4]   2>   "state":"active"}
   [junit4]   2> 1426024 INFO  
(OverseerStateUpdate-94824765653319683-127.0.0.1:60400_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator node=core_node1 is already registered
   [junit4]   2> 1426024 INFO  
(OverseerStateUpdate-94824765653319683-127.0.0.1:60400_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator shard=shard1 is already registered
   [junit4]   2> 1426130 INFO  (zkCallback-1219-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> 1426130 INFO  (zkCallback-1222-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> 1426184 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:60400 60400
   [junit4]   2> 1428040 INFO  
(OverseerCollectionConfigSetProcessor-94824765653319683-127.0.0.1:60400_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:745)
   [junit4]   2> 1428040 INFO  
(OverseerCollectionConfigSetProcessor-94824765653319683-127.0.0.1:60400_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskProcessor According to ZK I 
(id=94824765653319683-127.0.0.1:60400_solr-n_0000000000) am no longer a leader.
   [junit4]   2> 1428516 INFO  (Thread-3477) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:60400 60400
   [junit4]   2> 1428518 WARN  (Thread-3477) [    ] 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> 1428518 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testStateChange
   [junit4]   2> 1428518 INFO  
(TEST-OverseerTest.testStateChange-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.Overseer Overseer 
(id=94824765653319683-127.0.0.1:60400_solr-n_0000000000) closing
   [junit4]   2> 1428518 INFO  
(OverseerStateUpdate-94824765653319683-127.0.0.1:60400_solr-n_0000000000) [    
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:60400_solr
   [junit4]   2> 1428520 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> 1428521 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testOverseerFailure
   [junit4]   2> 1428525 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1428526 INFO  (Thread-3478) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1428526 INFO  (Thread-3478) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1428630 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:60427
   [junit4]   2> 1428630 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1428631 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1428634 INFO  (zkCallback-1224-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@6fc836 name:ZooKeeperConnection 
Watcher:127.0.0.1:60427 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 1428634 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1428634 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1428636 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1428638 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1428640 INFO  (zkCallback-1225-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@fa96ab name:ZooKeeperConnection 
Watcher:127.0.0.1:60427 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 1428640 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1428640 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1428640 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1428643 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1428644 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1428645 INFO  (zkCallback-1226-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@e1de53 name:ZooKeeperConnection 
Watcher:127.0.0.1:60427/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 1428645 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1428645 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1428646 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1428647 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 1428649 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1428650 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1428652 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1428653 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1428655 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1428656 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1428658 INFO  (zkCallback-1227-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@11d7b1a name:ZooKeeperConnection 
Watcher:127.0.0.1:60427/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 1428658 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1428658 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1428660 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1428662 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes/node1
   [junit4]   2> 1428663 INFO  (zkCallback-1227-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> 1428663 INFO  (zkCallback-1226-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> 1428664 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1428665 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1428666 INFO  (zkCallback-1228-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@86a2ac name:ZooKeeperConnection 
Watcher:127.0.0.1:60427/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 1428667 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1428667 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1428667 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=600000&connTimeout=60000&retry=true
   [junit4]   2> 1428670 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 1428671 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
   [junit4]   2> 1428673 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1428673 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/overseer_elect/election/94824765832101892-127.0.0.1:60427_solr-n_0000000000
   [junit4]   2> 1428674 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:60427_solr
   [junit4]   2> 1428674 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 1428675 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.Overseer Overseer 
(id=94824765832101892-127.0.0.1:60427_solr-n_0000000000) starting
   [junit4]   2> 1428676 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 1428679 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 1428681 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
   [junit4]   2> 1428683 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
   [junit4]   2> 1428686 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
   [junit4]   2> 1428688 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
   [junit4]   2> 1428692 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 1428692 INFO  
(OverseerCollectionConfigSetProcessor-94824765832101892-127.0.0.1:60427_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer 
operations
   [junit4]   2> 1428693 INFO  
(OverseerStateUpdate-94824765832101892-127.0.0.1:60427_solr-n_0000000000) [    
] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 1428693 INFO  
(OverseerStateUpdate-94824765832101892-127.0.0.1:60427_solr-n_0000000000) [    
] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1429731 INFO  
(OverseerStateUpdate-94824765832101892-127.0.0.1:60427_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> 1429732 INFO  
(OverseerStateUpdate-94824765832101892-127.0.0.1:60427_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> 1429732 INFO  
(OverseerStateUpdate-94824765832101892-127.0.0.1:60427_solr-n_0000000000) [    
] o.a.s.c.o.ClusterStateMutator building a new cName: collection1
   [junit4]   2> 1429732 INFO  
(OverseerStateUpdate-94824765832101892-127.0.0.1:60427_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
   [junit4]   2> 1429734 INFO  (zkCallback-1226-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> 1429734 INFO  (zkCallback-1228-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> 1429734 INFO  (zkCallback-1227-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> 1430247 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/collections/collection1/leader_elect/shard1/election
   [junit4]   2> 1430250 INFO  (zkCallback-1226-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 1430250 INFO  (zkCallback-1227-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 1430250 INFO  (zkCallback-1228-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 1430257 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/collections/collection1/leader_elect/shard1/election/94824765832101891-node1_core1-n_0000000000
   [junit4]   2> 1430258 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/leaders/shard1
   [junit4]   2> 1430262 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
   [junit4]   2> 1430268 INFO  
(OverseerStateUpdate-94824765832101892-127.0.0.1:60427_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> 1430269 INFO  
(OverseerStateUpdate-94824765832101892-127.0.0.1:60427_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> 1430272 INFO  
(OverseerStateUpdate-94824765832101892-127.0.0.1:60427_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> 1430273 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/collections/collection1/leader_elect/shard1/election
   [junit4]   2> 1430275 INFO  
(OverseerStateUpdate-94824765832101892-127.0.0.1:60427_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> 1430276 INFO  
(OverseerStateUpdate-94824765832101892-127.0.0.1:60427_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> 1430276 INFO  
(OverseerStateUpdate-94824765832101892-127.0.0.1:60427_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator shard=shard1 is already registered
   [junit4]   2> 1430278 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/collections/collection1/leader_elect/shard1/election/94824765832101891-node1_core1-n_0000000001
   [junit4]   2> 1430279 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.LeaderElector was going to be leader 
/collections/collection1/leader_elect/shard1/election/94824765832101891-node1_core1-n_0000000001
 , seq(0) 
/collections/collection1/leader_elect/shard1/election/94824765832101891-node1_core1-n_0000000000
   [junit4]   2> 1430385 INFO  (zkCallback-1226-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> 1430385 INFO  (zkCallback-1227-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> 1430385 INFO  (zkCallback-1228-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> 1430766 INFO  
(OverseerCollectionConfigSetProcessor-94824765832101892-127.0.0.1:60427_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:745)
   [junit4]   2> 1430766 INFO  
(OverseerCollectionConfigSetProcessor-94824765832101892-127.0.0.1:60427_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskProcessor According to ZK I 
(id=94824765832101892-127.0.0.1:60427_solr-n_0000000000) am no longer a leader.
   [junit4]   2> 1431505 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/collections/collection1/leader_elect/shard1/election
   [junit4]   2> 1431509 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/collections/collection1/leader_elect/shard1/election/94824765832101891-node1_core1-n_0000000002
   [junit4]   2> 1431510 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.LeaderElector was going to be leader 
/collections/collection1/leader_elect/shard1/election/94824765832101891-node1_core1-n_0000000002
 , seq(0) 
/collections/collection1/leader_elect/shard1/election/94824765832101891-node1_core1-n_0000000000
   [junit4]   2> 1431510 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1431511 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1431513 INFO  (zkCallback-1230-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@23f358 name:ZooKeeperConnection 
Watcher:127.0.0.1:60427/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 1431513 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1431513 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1431513 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.Overseer Overseer 
(id=94824765832101892-127.0.0.1:60427_solr-n_0000000000) closing
   [junit4]   2> 1431514 INFO  
(OverseerStateUpdate-94824765832101892-127.0.0.1:60427_solr-n_0000000000) [    
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:60427_solr
   [junit4]   2> 1431515 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=600000&connTimeout=60000&retry=true
   [junit4]   2> 1431519 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> 1431521 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1431521 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/overseer_elect/election/94824765832101893-127.0.0.1:60427_solr-n_0000000001
   [junit4]   2> 1431522 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:60427_solr
   [junit4]   2> 1431522 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 1431525 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.Overseer Overseer 
(id=94824765832101893-127.0.0.1:60427_solr-n_0000000001) starting
   [junit4]   2> 1431535 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 1431536 INFO  
(OverseerCollectionConfigSetProcessor-94824765832101893-127.0.0.1:60427_solr-n_0000000001)
 [    ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer 
operations
   [junit4]   2> 1431537 INFO  
(OverseerStateUpdate-94824765832101893-127.0.0.1:60427_solr-n_0000000001) [    
] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 1431539 INFO  
(OverseerStateUpdate-94824765832101893-127.0.0.1:60427_solr-n_0000000001) [    
] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1431543 INFO  
(OverseerStateUpdate-94824765832101893-127.0.0.1:60427_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> 1431544 INFO  
(OverseerStateUpdate-94824765832101893-127.0.0.1:60427_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> 1431544 INFO  
(OverseerStateUpdate-94824765832101893-127.0.0.1:60427_solr-n_0000000001) [    
] o.a.s.c.o.ReplicaMutator shard=shard1 is already registered
   [junit4]   2> 1431546 INFO  (zkCallback-1226-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> 1431546 INFO  (zkCallback-1227-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> 1431546 INFO  (zkCallback-1230-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> 1431608 INFO  
(OverseerStateUpdate-94824765832101893-127.0.0.1:60427_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> 1431723 INFO  
(OverseerStateUpdate-94824765832101893-127.0.0.1:60427_solr-n_0000000001) [    
] o.a.s.c.o.ZkStateWriter going to delete_collection 
/collections/collection1/state.json
   [junit4]   2> 1431733 INFO  (zkCallback-1230-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 1431733 INFO  (zkCallback-1226-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 1431733 INFO  (zkCallback-1227-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 1431734 INFO  (zkCallback-1230-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> 1431734 INFO  (zkCallback-1226-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> 1431734 INFO  (zkCallback-1227-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> 1432304 INFO  (zkCallback-1226-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> 1432304 INFO  (zkCallback-1230-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> 1432304 INFO  (zkCallback-1227-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> 1434013 WARN  (zkCallback-1227-thread-2) [    ] 
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK
   [junit4]   2> 1434015 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 0x150e29f43550002, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 1434016 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:60427 60427
   [junit4]   2> 1436098 INFO  
(OverseerCollectionConfigSetProcessor-94824765832101893-127.0.0.1:60427_solr-n_0000000001)
 [    ] 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:745)
   [junit4]   2> 1436098 INFO  
(OverseerCollectionConfigSetProcessor-94824765832101893-127.0.0.1:60427_solr-n_0000000001)
 [    ] o.a.s.c.OverseerTaskProcessor According to ZK I 
(id=94824765832101893-127.0.0.1:60427_solr-n_0000000001) am no longer a leader.
   [junit4]   2> 1436582 INFO  (Thread-3478) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:60427 60427
   [junit4]   2> 1436584 WARN  (Thread-3478) [    ] 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> 1436584 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testOverseerFailure
   [junit4]   2> 1436584 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.Overseer Overseer 
(id=94824765832101893-127.0.0.1:60427_solr-n_0000000001) closing
   [junit4]   2> 1436585 INFO  
(OverseerStateUpdate-94824765832101893-127.0.0.1:60427_solr-n_0000000001) [    
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:60427_solr
   [junit4]   2> 1436587 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> 1436588 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testBadQueueItem
   [junit4]   2> 1436589 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1436590 INFO  (Thread-3479) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1436590 INFO  (Thread-3479) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1436705 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:60471
   [junit4]   2> 1436705 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1436706 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1436709 INFO  (zkCallback-1232-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7b43c6 name:ZooKeeperConnection 
Watcher:127.0.0.1:60471 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 1436709 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1436709 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1436712 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 0x150e29f62d70000, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 1436712 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1436735 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1436738 INFO  (zkCallback-1233-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@15f450 name:ZooKeeperConnection 
Watcher:127.0.0.1:60471 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 1436738 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1436738 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1436738 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1436746 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1436747 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1436751 INFO  (zkCallback-1234-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@27ff6b name:ZooKeeperConnection 
Watcher:127.0.0.1:60471/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 1436752 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1436752 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1436752 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1436755 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 1436758 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1436762 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1436763 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1436764 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1436765 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1436768 INFO  (zkCallback-1235-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@16ea53d name:ZooKeeperConnection 
Watcher:127.0.0.1:60471/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 1436770 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1436770 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1436770 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=600000&connTimeout=60000&retry=true
   [junit4]   2> 1436774 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 1436776 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
   [junit4]   2> 1436778 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1436778 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/overseer_elect/election/94824766360715267-127.0.0.1:60471_solr-n_0000000000
   [junit4]   2> 1436778 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:60471_solr
   [junit4]   2> 1436780 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 1436781 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.Overseer Overseer 
(id=94824766360715267-127.0.0.1:60471_solr-n_0000000000) starting
   [junit4]   2> 1436782 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 1436784 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 1436786 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
   [junit4]   2> 1436787 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
   [junit4]   2> 1436790 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
   [junit4]   2> 1436792 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
   [junit4]   2> 1436795 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 1436796 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1436796 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 1436797 INFO  
(OverseerCollectionConfigSetProcessor-94824766360715267-127.0.0.1:60471_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer 
operations
   [junit4]   2> 1436797 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1436800 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1436800 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1436804 INFO  (zkCallback-1237-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1a8e012 name:ZooKeeperConnection 
Watcher:127.0.0.1:60471/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 1436804 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1436804 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1436807 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1436811 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1
   [junit4]   2> 1436812 INFO  (zkCallback-1234-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> 1436812 INFO  (zkCallback-1237-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> 1436812 INFO  (zkCallback-1235-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> 1436818 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"127.0.0.1",
   [junit4]   2>   "core":"core1",
   [junit4]   2>   "core_node_name":"node1",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "numShards":"3",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr/"} current state version: 0
   [junit4]   2> 1436818 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Update state numShards=3 message={
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"127.0.0.1",
   [junit4]   2>   "core":"core1",
   [junit4]   2>   "core_node_name":"node1",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "numShards":"3",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr/"}
   [junit4]   2> 1436818 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.o.ClusterStateMutator building a new cName: collection1
   [junit4]   2> 1436818 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard2
   [junit4]   2> 1436821 INFO  (zkCallback-1234-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> 1436821 INFO  (zkCallback-1237-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> 1436821 INFO  (zkCallback-1235-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> 1437387 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/collections/collection1/leader_elect/shard2/election
   [junit4]   2> 1437441 INFO  (zkCallback-1234-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 1437441 INFO  (zkCallback-1235-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 1437441 INFO  (zkCallback-1237-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 1437443 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/collections/collection1/leader_elect/shard2/election/94824766360715268-127.0.0.1_core1-n_0000000000
   [junit4]   2> 1437443 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/leaders/shard2
   [junit4]   2> 1437444 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
   [junit4]   2> 1437447 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"leader",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr/";,
   [junit4]   2>   "core":"core1"} current state version: 1
   [junit4]   2> 1437451 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"127.0.0.1",
   [junit4]   2>   "core":"core2",
   [junit4]   2>   "core_node_name":"node2",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "numShards":"3",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr/"} current state version: 1
   [junit4]   2> 1437451 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Update state numShards=3 message={
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"127.0.0.1",
   [junit4]   2>   "core":"core2",
   [junit4]   2>   "core_node_name":"node2",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "numShards":"3",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr/"}
   [junit4]   2> 1437451 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Collection already exists with numShards=3
   [junit4]   2> 1437453 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard3
   [junit4]   2> 1437572 INFO  (zkCallback-1237-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> 1437573 INFO  (zkCallback-1234-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> 1437573 INFO  (zkCallback-1235-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> 1438017 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/collections/collection1/leader_elect/shard3/election
   [junit4]   2> 1438021 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/collections/collection1/leader_elect/shard3/election/94824766360715268-127.0.0.1_core2-n_0000000000
   [junit4]   2> 1438023 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/leaders/shard3
   [junit4]   2> 1438026 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
   [junit4]   2> 1438029 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"leader",
   [junit4]   2>   "shard":"shard3",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr/";,
   [junit4]   2>   "core":"core2"} current state version: 2
   [junit4]   2> 1438031 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"127.0.0.1",
   [junit4]   2>   "core":"core3",
   [junit4]   2>   "core_node_name":"node3",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "numShards":"3",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr/"} current state version: 2
   [junit4]   2> 1438032 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Update state numShards=3 message={
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"127.0.0.1",
   [junit4]   2>   "core":"core3",
   [junit4]   2>   "core_node_name":"node3",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "numShards":"3",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr/"}
   [junit4]   2> 1438032 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Collection already exists with numShards=3
   [junit4]   2> 1438032 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
   [junit4]   2> 1438151 INFO  (zkCallback-1237-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> 1438151 INFO  (zkCallback-1235-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> 1438151 INFO  (zkCallback-1234-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> 1438600 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/collections/collection1/leader_elect/shard1/election
   [junit4]   2> 1438604 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/collections/collection1/leader_elect/shard1/election/94824766360715268-127.0.0.1_core3-n_0000000000
   [junit4]   2> 1438605 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/leaders/shard1
   [junit4]   2> 1438607 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
   [junit4]   2> 1438611 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"leader",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr/";,
   [junit4]   2>   "core":"core3"} current state version: 3
   [junit4]   2> 1438730 INFO  (zkCallback-1234-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> 1438730 INFO  (zkCallback-1235-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> 1438730 INFO  (zkCallback-1237-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> 1438785 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"127.0.0.1",
   [junit4]   2>   "core":"core0",
   [junit4]   2>   "core_node_name":"node0",
   [junit4]   2>   "collection":"",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr/"} current state version: 4
   [junit4]   2> 1438786 ERROR 
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.o.CollectionMutator Skipping invalid Overseer message because it has 
no collection specified: {
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"127.0.0.1",
   [junit4]   2>   "core":"core0",
   [junit4]   2>   "core_node_name":"node0",
   [junit4]   2>   "collection":"",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr/"}
   [junit4]   2> 1438789 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
   [junit4]   2>   "operation":"deletecore",
   [junit4]   2>   "node_name":"127.0.0.1",
   [junit4]   2>   "core":"core0",
   [junit4]   2>   "core_node_name":"node0",
   [junit4]   2>   "collection":""} current state version: 4
   [junit4]   2> 1438789 ERROR 
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.o.CollectionMutator Skipping invalid Overseer message because it has 
no collection specified: {
   [junit4]   2>   "operation":"deletecore",
   [junit4]   2>   "node_name":"127.0.0.1",
   [junit4]   2>   "core":"core0",
   [junit4]   2>   "core_node_name":"node0",
   [junit4]   2>   "collection":""}
   [junit4]   2> 1438791 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"127.0.0.1",
   [junit4]   2>   "core":"core1",
   [junit4]   2>   "core_node_name":"node1",
   [junit4]   2>   "collection":"collection2",
   [junit4]   2>   "numShards":"3",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr/"} current state version: 4
   [junit4]   2> 1438791 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Update state numShards=3 message={
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"127.0.0.1",
   [junit4]   2>   "core":"core1",
   [junit4]   2>   "core_node_name":"node1",
   [junit4]   2>   "collection":"collection2",
   [junit4]   2>   "numShards":"3",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr/"}
   [junit4]   2> 1438791 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.o.ClusterStateMutator building a new cName: collection2
   [junit4]   2> 1438791 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard2
   [junit4]   2> 1438908 INFO  (zkCallback-1234-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> 1438908 INFO  (zkCallback-1235-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> 1438908 INFO  (zkCallback-1237-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> 1439357 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/collections/collection2/leader_elect/shard2/election
   [junit4]   2> 1439358 INFO  (zkCallback-1234-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 1439358 INFO  (zkCallback-1237-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 1439358 INFO  (zkCallback-1235-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 1439363 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/collections/collection2/leader_elect/shard2/election/94824766360715268-127.0.0.1_core1-n_0000000000
   [junit4]   2> 1439363 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection2/leaders/shard2
   [junit4]   2> 1439366 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
   [junit4]   2> 1439369 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"leader",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "collection":"collection2",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr/";,
   [junit4]   2>   "core":"core1"} current state version: 5
   [junit4]   2> 1439372 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"127.0.0.1",
   [junit4]   2>   "core":"core2",
   [junit4]   2>   "core_node_name":"node2",
   [junit4]   2>   "collection":"collection2",
   [junit4]   2>   "numShards":"3",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr/"} current state version: 5
   [junit4]   2> 1439372 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Update state numShards=3 message={
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"127.0.0.1",
   [junit4]   2>   "core":"core2",
   [junit4]   2>   "core_node_name":"node2",
   [junit4]   2>   "collection":"collection2",
   [junit4]   2>   "numShards":"3",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr/"}
   [junit4]   2> 1439373 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Collection already exists with numShards=3
   [junit4]   2> 1439373 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard3
   [junit4]   2> 1439491 INFO  (zkCallback-1234-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> 1439492 INFO  (zkCallback-1237-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> 1439492 INFO  (zkCallback-1235-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> 1439939 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/collections/collection2/leader_elect/shard3/election
   [junit4]   2> 1439945 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/collections/collection2/leader_elect/shard3/election/94824766360715268-127.0.0.1_core2-n_0000000000
   [junit4]   2> 1439945 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection2/leaders/shard3
   [junit4]   2> 1439948 INFO  
(TEST-OverseerTest.testBadQueueItem-seed#[A98CD3B664DFD2A8]) [    ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
   [junit4]   2> 1439950 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"leader",
   [junit4]   2>   "shard":"shard3",
   [junit4]   2>   "collection":"collection2",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr/";,
   [junit4]   2>   "core":"core2"} current state version: 6
   [junit4]   2> 1439953 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"127.0.0.1",
   [junit4]   2>   "core":"core3",
   [junit4]   2>   "core_node_name":"node3",
   [junit4]   2>   "collection":"collection2",
   [junit4]   2>   "numShards":"3",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr/"} current state version: 6
   [junit4]   2> 1439953 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_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> 1439953 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Collection already exists with numShards=3
   [junit4]   2> 1439953 INFO  
(OverseerStateUpdate-94824766360715267-127.0.0.1:60471_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
   [junit4]   2> 1440074 INFO  (zkCallback-1234-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> 1440074 INFO  (zkCallback-1237-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> 1440074 INFO  (zkCallback-1235-thread-1) [    ] 
o.a.s.c.c.ZkStateRead

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

 "operation":"addreplica",
   [junit4]   2>   "collection":"test",
   [junit4]   2>   "shard":"x",
   [junit4]   2>   "base_url":"http://127.0.0.1/solr";,
   [junit4]   2>   "node_name":"node1",
   [junit4]   2>   "core":"core1",
   [junit4]   2>   "state":"down"} 
   [junit4]   2> 1508346 INFO  
(OverseerStateUpdate-94824771038674947-127.0.0.1:60818_solr-n_0000000000) [    
] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/test/state.json
   [junit4]   2> 1508389 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[A98CD3B664DFD2A8])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:60818 60818
   [junit4]   2> 1510132 INFO  
(OverseerCollectionConfigSetProcessor-94824771038674947-127.0.0.1:60818_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:745)
   [junit4]   2> 1510132 INFO  
(OverseerCollectionConfigSetProcessor-94824771038674947-127.0.0.1:60818_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskProcessor According to ZK I 
(id=94824771038674947-127.0.0.1:60818_solr-n_0000000000) am no longer a leader.
   [junit4]   2> 1510619 INFO  (Thread-3488) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:60818 60818
   [junit4]   2> 1510620 WARN  (Thread-3488) [    ] 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> 1510620 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[A98CD3B664DFD2A8])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testExternalClusterStateChangeBehavior
   [junit4]   2> 1510620 INFO  
(TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[A98CD3B664DFD2A8])
 [    ] o.a.s.c.Overseer Overseer 
(id=94824771038674947-127.0.0.1:60818_solr-n_0000000000) closing
   [junit4]   2> 1510620 INFO  
(OverseerStateUpdate-94824771038674947-127.0.0.1:60818_solr-n_0000000000) [    
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:60818_solr
   [junit4]   2> 1510622 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> 1513592 INFO  
(SUITE-OverseerTest-seed#[A98CD3B664DFD2A8]-worker) [    ] o.a.s.SolrTestCaseJ4 
###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.OverseerTest_A98CD3B664DFD2A8-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene60): {}, 
docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {}, 
locale=en_AU, timezone=GB-Eire
   [junit4]   2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.8.0_66 
(32-bit)/cpus=3,threads=1,free=183191160,total=507510784
   [junit4]   2> NOTE: All tests run in this JVM: [CopyFieldTest, 
SuggesterWFSTTest, ZkSolrClientTest, TestAtomicUpdateErrorCases, 
BigEndianAscendingWordSerializerTest, HLLUtilTest, DirectSolrConnectionTest, 
TestSchemaVersionResource, DistributedFacetPivotSmallTest, 
TestAddFieldRealTimeGet, DistributedMLTComponentTest, CloudMLTQParserTest, 
HdfsChaosMonkeyNothingIsSafeTest, TestRestoreCore, TestCryptoKeys, 
TestZkChroot, TestHashQParserPlugin, TestConfigOverlay, 
OpenCloseCoreStressTest, SpellingQueryConverterTest, 
DistributedDebugComponentTest, SparseHLLTest, 
DeleteLastCustomShardedReplicaTest, TestConfigReload, 
TestFieldTypeCollectionResource, SortByFunctionTest, 
OpenExchangeRatesOrgProviderTest, TestFreeTextSuggestions, 
TestDistributedGrouping, TestSolrIndexConfig, TestJsonRequest, 
BasicDistributedZk2Test, QueryParsingTest, NumericFieldsTest, 
FieldMutatingUpdateProcessorTest, BigEndianAscendingWordDeserializerTest, 
TestRecovery, TestImplicitCoreProperties, HdfsThreadLeakTest, TestWriterPerf, 
WordBreakSolrSpellCheckerTest, TestStressUserVersions, ResponseHeaderTest, 
TestNamedUpdateProcessors, TestValueSourceCache, StatsComponentTest, 
FileUtilsTest, TestManagedResourceStorage, OverseerTaskQueueTest, 
TestMaxScoreQueryParser, TestCollationField, 
CollectionsAPIAsyncDistributedZkTest, DistributedTermsComponentTest, 
TestTrieFacet, RAMDirectoryFactoryTest, TestNonDefinedSimilarityFactory, 
HdfsBasicDistributedZk2Test, DistributedFacetPivotLargeTest, 
TestClassicSimilarityFactory, TestStressRecovery, TestSuggestSpellingConverter, 
CdcrRequestHandlerTest, BitVectorTest, TestMiniSolrCloudClusterBase, 
OutputWriterTest, TestFieldResource, TestReload, TestHdfsUpdateLog, 
TestSolrQueryParser, HdfsDirectoryTest, BasicZkTest, EnumFieldTest, 
SuggestComponentTest, TestOmitPositions, TestJettySolrRunner, 
DirectUpdateHandlerOptimizeTest, TestRecoveryHdfs, TestBadConfig, 
FileBasedSpellCheckerTest, BadIndexSchemaTest, LukeRequestHandlerTest, 
SynonymTokenizerTest, TestUtils, TestSortingResponseWriter, 
DocValuesMissingTest, TriLevelCompositeIdRoutingTest, 
CdcrVersionReplicationTest, ChangedSchemaMergeTest, TestSolrCoreProperties, 
FullHLLTest, SignatureUpdateProcessorFactoryTest, 
TermVectorComponentDistributedTest, TermVectorComponentTest, 
CoreAdminRequestStatusTest, RequestLoggingTest, TestJoin, 
SimpleCollectionCreateDeleteTest, HighlighterConfigTest, 
HdfsWriteToMultipleCollectionsTest, TestExceedMaxTermLength, 
TestInfoStreamLogging, TestCopyFieldCollectionResource, MultiThreadedOCPTest, 
CacheHeaderTest, TestRandomFaceting, ResourceLoaderTest, 
SpellCheckComponentTest, TestCloudManagedSchema, TestPerFieldSimilarity, 
SuggesterTSTTest, CdcrReplicationHandlerTest, FieldAnalysisRequestHandlerTest, 
TestObjectReleaseTracker, TestBinaryField, TestExclusionRuleCollectionAccess, 
LeaderElectionIntegrationTest, ResponseLogComponentTest, ZkNodePropsTest, 
ShardRoutingCustomTest, OverseerRolesTest, SolrIndexSplitterTest, 
TestBM25SimilarityFactory, CoreAdminHandlerTest, ShardSplitTest, 
TestRebalanceLeaders, TestFoldingMultitermQuery, TestFiltering, 
SolrCloudExampleTest, SolrTestCaseJ4Test, LeaderFailoverAfterPartitionTest, 
CSVRequestHandlerTest, SolrCmdDistributorTest, MinimalSchemaTest, 
TestReloadAndDeleteDocs, BasicDistributedZkTest, ChaosMonkeySafeLeaderTest, 
CollectionsAPIDistributedZkTest, OverseerTest]
   [junit4] Completed [237/555] on J1 in 87.82s, 12 tests, 1 failure, 1 skipped 
<<< FAILURES!

[...truncated 1028 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:775: The 
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:719: The 
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:59: The 
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:233: 
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:516:
 The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1432:
 The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:987:
 There were test failures: 555 suites (8 ignored), 2200 tests, 1 failure, 115 
ignored (77 assumptions) [seed: A98CD3B664DFD2A8]

Total time: 70 minutes 5 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