Build: https://builds.apache.org/job/Lucene-Solr-Tests-trunk-Java8/376/

1 tests failed.
REGRESSION:  
org.apache.solr.cloud.OverseerTest.testExternalClusterStateChangeBehavior

Error Message:
Illegal state, was: down expected:active clusterState:live 
nodes:[]collections:{c1=DocCollection(c1)={   "shards":{"shard1":{       
"parent":null,       "range":null,       "state":"active",       
"replicas":{"core_node1":{           "base_url":"http://127.0.0.1/solr";,        
   "node_name":"node1",           "core":"core1",           "roles":"",         
  "state":"down"}}}},   "router":{"name":"implicit"}}, 
test=LazyCollectionRef(test)}

Stack Trace:
java.lang.AssertionError: Illegal state, was: down expected:active 
clusterState:live nodes:[]collections:{c1=DocCollection(c1)={
  "shards":{"shard1":{
      "parent":null,
      "range":null,
      "state":"active",
      "replicas":{"core_node1":{
          "base_url":"http://127.0.0.1/solr";,
          "node_name":"node1",
          "core":"core1",
          "roles":"",
          "state":"down"}}}},
  "router":{"name":"implicit"}}, test=LazyCollectionRef(test)}
        at 
__randomizedtesting.SeedInfo.seed([F73FAD8CCD9EB9EE:9F21AE602F0EE3A0]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at 
org.apache.solr.cloud.OverseerTest.verifyStatus(OverseerTest.java:601)
        at 
org.apache.solr.cloud.OverseerTest.testExternalClusterStateChangeBehavior(OverseerTest.java:1261)
        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:1627)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
        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:365)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
        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:39)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        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:365)
        at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 9615 lines...]
   [junit4] Suite: org.apache.solr.cloud.OverseerTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J2/temp/solr.cloud.OverseerTest_F73FAD8CCD9EB9EE-001/init-core-data-001
   [junit4]   2> 291154 INFO  
(SUITE-OverseerTest-seed#[F73FAD8CCD9EB9EE]-worker) [    ] o.a.s.SolrTestCaseJ4 
Randomized ssl (true) and clientAuth (true)
   [junit4]   2> 291154 INFO  
(SUITE-OverseerTest-seed#[F73FAD8CCD9EB9EE]-worker) [    ] o.a.s.SolrTestCaseJ4 
####initCore
   [junit4]   2> 291154 INFO  
(SUITE-OverseerTest-seed#[F73FAD8CCD9EB9EE]-worker) [    ] o.a.s.SolrTestCaseJ4 
####initCore end
   [junit4]   2> 291156 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testOverseerFailure
   [junit4]   2> 291156 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 291156 INFO  (Thread-837) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 291157 INFO  (Thread-837) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 291257 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:46010
   [junit4]   2> 291257 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 291257 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 291263 INFO  (zkCallback-253-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@4d7eb216 
name:ZooKeeperConnection Watcher:127.0.0.1:46010 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 291263 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 291263 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 291264 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 291275 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 291283 INFO  (zkCallback-254-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@51c63ed9 
name:ZooKeeperConnection Watcher:127.0.0.1:46010 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 291283 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 291283 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 291283 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 291286 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 291295 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 291296 INFO  (zkCallback-255-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@4f16474e 
name:ZooKeeperConnection Watcher:127.0.0.1:46010/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 291296 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 291297 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 291297 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 291299 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 291300 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 291301 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 291302 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 291303 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 291305 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 291315 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 291318 INFO  (zkCallback-256-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@25038d2f 
name:ZooKeeperConnection Watcher:127.0.0.1:46010/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 291318 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 291319 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 291320 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 291322 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes/node1
   [junit4]   2> 291323 INFO  (zkCallback-255-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> 291324 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 291324 INFO  (zkCallback-256-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> 291327 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 291333 INFO  (zkCallback-257-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@321bd26c 
name:ZooKeeperConnection Watcher:127.0.0.1:46010/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 291333 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 291334 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 291334 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=600000&connTimeout=60000&retry=true
   [junit4]   2> 291342 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 291344 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
   [junit4]   2> 291346 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 291347 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/overseer_elect/election/94484489033416708-127.0.0.1:46010_solr-n_0000000000
   [junit4]   2> 291347 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:46010_solr
   [junit4]   2> 291348 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 291351 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.Overseer Overseer 
(id=94484489033416708-127.0.0.1:46010_solr-n_0000000000) starting
   [junit4]   2> 291353 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 291355 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 291357 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
   [junit4]   2> 291358 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
   [junit4]   2> 291360 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
   [junit4]   2> 291362 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
   [junit4]   2> 291365 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 291365 INFO  
(OverseerCollectionConfigSetProcessor-94484489033416708-127.0.0.1:46010_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer 
operations
   [junit4]   2> 291366 INFO  
(OverseerStateUpdate-94484489033416708-127.0.0.1:46010_solr-n_0000000000) [    
] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 291366 INFO  
(OverseerStateUpdate-94484489033416708-127.0.0.1:46010_solr-n_0000000000) [    
] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 292370 INFO  
(OverseerStateUpdate-94484489033416708-127.0.0.1:46010_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> 292370 INFO  
(OverseerStateUpdate-94484489033416708-127.0.0.1:46010_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> 292371 INFO  
(OverseerStateUpdate-94484489033416708-127.0.0.1:46010_solr-n_0000000000) [    
] o.a.s.c.o.ClusterStateMutator building a new cName: collection1
   [junit4]   2> 292371 INFO  
(OverseerStateUpdate-94484489033416708-127.0.0.1:46010_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
   [junit4]   2> 292372 INFO  (zkCallback-257-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> 292373 INFO  (zkCallback-256-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> 292373 INFO  (zkCallback-255-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> 292870 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/collections/collection1/leader_elect/shard1/election
   [junit4]   2> 292871 INFO  (zkCallback-257-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 292871 INFO  (zkCallback-255-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 292871 INFO  (zkCallback-256-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 292874 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/collections/collection1/leader_elect/shard1/election/94484489033416707-node1_core1-n_0000000000
   [junit4]   2> 292875 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/leaders/shard1
   [junit4]   2> 292876 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
   [junit4]   2> 292881 INFO  
(OverseerStateUpdate-94484489033416708-127.0.0.1:46010_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",
   [junit4]   2>   "state":"active"} current state version: 1
   [junit4]   2> 292883 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/collections/collection1/leader_elect/shard1/election
   [junit4]   2> 292884 INFO  
(OverseerStateUpdate-94484489033416708-127.0.0.1:46010_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> 292884 INFO  
(OverseerStateUpdate-94484489033416708-127.0.0.1:46010_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> 292884 INFO  
(OverseerStateUpdate-94484489033416708-127.0.0.1:46010_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator shard=shard1 is already registered
   [junit4]   2> 292886 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/collections/collection1/leader_elect/shard1/election/94484489033416707-node1_core1-n_0000000001
   [junit4]   2> 292886 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.LeaderElector was going to be leader 
/collections/collection1/leader_elect/shard1/election/94484489033416707-node1_core1-n_0000000001
 , seq(0) 
/collections/collection1/leader_elect/shard1/election/94484489033416707-node1_core1-n_0000000000
   [junit4]   2> 292986 INFO  (zkCallback-256-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> 292987 INFO  (zkCallback-255-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> 292988 INFO  (zkCallback-257-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> 293367 INFO  
(OverseerCollectionConfigSetProcessor-94484489033416708-127.0.0.1:46010_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> 293368 INFO  
(OverseerCollectionConfigSetProcessor-94484489033416708-127.0.0.1:46010_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskProcessor According to ZK I 
(id=94484489033416708-127.0.0.1:46010_solr-n_0000000000) am no longer a leader.
   [junit4]   2> 294043 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/collections/collection1/leader_elect/shard1/election
   [junit4]   2> 294045 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/collections/collection1/leader_elect/shard1/election/94484489033416707-node1_core1-n_0000000002
   [junit4]   2> 294046 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.LeaderElector was going to be leader 
/collections/collection1/leader_elect/shard1/election/94484489033416707-node1_core1-n_0000000002
 , seq(0) 
/collections/collection1/leader_elect/shard1/election/94484489033416707-node1_core1-n_0000000000
   [junit4]   2> 294046 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 294047 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 294048 INFO  (zkCallback-259-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@53174d87 
name:ZooKeeperConnection Watcher:127.0.0.1:46010/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 294048 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 294048 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 294049 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.Overseer Overseer 
(id=94484489033416708-127.0.0.1:46010_solr-n_0000000000) closing
   [junit4]   2> 294049 INFO  
(OverseerStateUpdate-94484489033416708-127.0.0.1:46010_solr-n_0000000000) [    
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:46010_solr
   [junit4]   2> 294049 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=600000&connTimeout=60000&retry=true
   [junit4]   2> 294051 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> 294053 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 294053 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/overseer_elect/election/94484489033416709-127.0.0.1:46010_solr-n_0000000001
   [junit4]   2> 294054 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:46010_solr
   [junit4]   2> 294054 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 294055 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.Overseer Overseer 
(id=94484489033416709-127.0.0.1:46010_solr-n_0000000001) starting
   [junit4]   2> 294060 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 294060 INFO  
(OverseerCollectionConfigSetProcessor-94484489033416709-127.0.0.1:46010_solr-n_0000000001)
 [    ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer 
operations
   [junit4]   2> 294061 INFO  
(OverseerStateUpdate-94484489033416709-127.0.0.1:46010_solr-n_0000000001) [    
] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 294061 INFO  
(OverseerStateUpdate-94484489033416709-127.0.0.1:46010_solr-n_0000000001) [    
] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 294064 INFO  
(OverseerStateUpdate-94484489033416709-127.0.0.1:46010_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> 294064 INFO  
(OverseerStateUpdate-94484489033416709-127.0.0.1:46010_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> 294064 INFO  
(OverseerStateUpdate-94484489033416709-127.0.0.1:46010_solr-n_0000000001) [    
] o.a.s.c.o.ReplicaMutator shard=shard1 is already registered
   [junit4]   2> 294065 INFO  (zkCallback-259-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> 294066 INFO  (zkCallback-256-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> 294066 INFO  (zkCallback-255-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> 294118 INFO  
(OverseerStateUpdate-94484489033416709-127.0.0.1:46010_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> 294221 INFO  
(OverseerStateUpdate-94484489033416709-127.0.0.1:46010_solr-n_0000000001) [    
] o.a.s.c.o.ZkStateWriter going to delete_collection 
/collections/collection1/state.json
   [junit4]   2> 294226 INFO  (zkCallback-256-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 294226 INFO  (zkCallback-259-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 294227 INFO  (zkCallback-256-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> 294231 INFO  (zkCallback-259-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> 294235 INFO  (zkCallback-255-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections, has occurred - updating...
   [junit4]   2> 294239 INFO  (zkCallback-255-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> 294736 INFO  (zkCallback-255-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> 294736 INFO  (zkCallback-256-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> 294736 INFO  (zkCallback-259-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> 296236 WARN  (zkCallback-256-thread-1) [    ] 
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK
   [junit4]   2> 296240 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:46010 46010
   [junit4]   2> 296461 INFO  (Thread-837) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:46010 46010
   [junit4]   2> 296462 WARN  (Thread-837) [    ] 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> 296462 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testOverseerFailure
   [junit4]   2> 296463 INFO  
(TEST-OverseerTest.testOverseerFailure-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.Overseer Overseer 
(id=94484489033416709-127.0.0.1:46010_solr-n_0000000001) closing
   [junit4]   2> 296463 INFO  
(OverseerStateUpdate-94484489033416709-127.0.0.1:46010_solr-n_0000000001) [    
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:46010_solr
   [junit4]   2> 296464 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> 296466 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testShardAssignmentBigger
   [junit4]   2> 296467 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 296467 INFO  (Thread-838) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 296467 INFO  (Thread-838) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 296567 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:35446
   [junit4]   2> 296568 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 296568 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 296571 INFO  (zkCallback-261-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@37ab4172 
name:ZooKeeperConnection Watcher:127.0.0.1:35446 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 296571 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 296572 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 296573 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 296574 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 296575 INFO  (zkCallback-262-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@268e7e69 
name:ZooKeeperConnection Watcher:127.0.0.1:35446 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 296575 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 296576 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 296576 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 296579 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 296579 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 296580 INFO  (zkCallback-263-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@cc403d0 name:ZooKeeperConnection 
Watcher:127.0.0.1:35446/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 296580 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 296581 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 296581 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 296583 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 296584 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 296585 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 296587 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 296588 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 296589 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 296590 INFO  (zkCallback-264-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@51f450a2 
name:ZooKeeperConnection Watcher:127.0.0.1:35446/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 296590 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 296591 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 296591 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=600000&connTimeout=60000&retry=true
   [junit4]   2> 296595 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 296596 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
   [junit4]   2> 296597 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 296598 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.LeaderElector Joined leadership election with path: 
/overseer_elect/election/94484489381478403-127.0.0.1:35446_solr-n_0000000000
   [junit4]   2> 296598 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:35446_solr
   [junit4]   2> 296598 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 296600 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.Overseer Overseer 
(id=94484489381478403-127.0.0.1:35446_solr-n_0000000000) starting
   [junit4]   2> 296601 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 296603 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 296605 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
   [junit4]   2> 296607 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
   [junit4]   2> 296609 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
   [junit4]   2> 296611 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
   [junit4]   2> 296614 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 296615 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 296615 INFO  
(OverseerCollectionConfigSetProcessor-94484489381478403-127.0.0.1:35446_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer 
operations
   [junit4]   2> 296615 INFO  
(OverseerStateUpdate-94484489381478403-127.0.0.1:35446_solr-n_0000000000) [    
] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 296616 INFO  
(OverseerStateUpdate-94484489381478403-127.0.0.1:35446_solr-n_0000000000) [    
] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 296617 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 296618 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 296619 INFO  (zkCallback-266-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@69c15046 
name:ZooKeeperConnection Watcher:127.0.0.1:35446/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 296619 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 296620 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 296621 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 296622 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes/node0
   [junit4]   2> 296624 INFO  (zkCallback-263-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> 296624 INFO  (zkCallback-266-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> 296624 INFO  (zkCallback-264-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> 296624 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 296631 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 296634 INFO  (zkCallback-267-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@68cc55f9 
name:ZooKeeperConnection Watcher:127.0.0.1:35446/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 296634 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 296634 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 296636 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 296638 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes/node1
   [junit4]   2> 296639 INFO  (zkCallback-263-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> 296639 INFO  (zkCallback-267-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> 296640 INFO  (zkCallback-266-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> 296639 INFO  (zkCallback-264-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> 296640 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 296640 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 296648 INFO  (zkCallback-268-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@79e81aaa 
name:ZooKeeperConnection Watcher:127.0.0.1:35446/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 296648 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 296648 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 296650 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 296651 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes/node2
   [junit4]   2> 296652 INFO  (zkCallback-264-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: 2)
   [junit4]   2> 296652 INFO  (zkCallback-263-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: 2)
   [junit4]   2> 296653 INFO  (zkCallback-266-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: 2)
   [junit4]   2> 296652 INFO  (zkCallback-267-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: 2)
   [junit4]   2> 296653 INFO  (zkCallback-268-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: 2)
   [junit4]   2> 296653 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 296654 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 296656 INFO  (zkCallback-269-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@63c9eb88 
name:ZooKeeperConnection Watcher:127.0.0.1:35446/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 296656 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 296657 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 296658 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 296660 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes/node3
   [junit4]   2> 296661 INFO  (zkCallback-267-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: 3)
   [junit4]   2> 296661 INFO  (zkCallback-264-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: 3)
   [junit4]   2> 296661 INFO  (zkCallback-266-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: 3)
   [junit4]   2> 296661 INFO  (zkCallback-263-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: 3)
   [junit4]   2> 296661 INFO  (zkCallback-268-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: 3)
   [junit4]   2> 296661 INFO  (zkCallback-269-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: 3)
   [junit4]   2> 296662 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 296663 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 296664 INFO  (zkCallback-270-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@26c5699f 
name:ZooKeeperConnection Watcher:127.0.0.1:35446/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 296664 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 296664 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 296665 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 296667 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes/node4
   [junit4]   2> 296668 INFO  (zkCallback-267-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: 4)
   [junit4]   2> 296668 INFO  (zkCallback-266-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: 4)
   [junit4]   2> 296668 INFO  (zkCallback-263-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: 4)
   [junit4]   2> 296669 INFO  (zkCallback-269-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: 4)
   [junit4]   2> 296668 INFO  (zkCallback-264-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: 4)
   [junit4]   2> 296668 INFO  (zkCallback-268-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: 4)
   [junit4]   2> 296668 INFO  (zkCallback-270-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: 4)
   [junit4]   2> 296669 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 296670 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 296671 INFO  (zkCallback-271-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@3a1e44f3 
name:ZooKeeperConnection Watcher:127.0.0.1:35446/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 296671 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 296672 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 296673 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 296674 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes/node5
   [junit4]   2> 296675 INFO  (zkCallback-271-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: 5)
   [junit4]   2> 296676 INFO  (zkCallback-269-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: 5)
   [junit4]   2> 296676 INFO  (zkCallback-270-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: 5)
   [junit4]   2> 296676 INFO  (zkCallback-268-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: 5)
   [junit4]   2> 296676 INFO  (zkCallback-263-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: 5)
   [junit4]   2> 296676 INFO  (zkCallback-267-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: 5)
   [junit4]   2> 296676 INFO  (zkCallback-266-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: 5)
   [junit4]   2> 296675 INFO  (zkCallback-264-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: 5)
   [junit4]   2> 296676 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 296678 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 296679 INFO  (zkCallback-272-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@37d47ac3 
name:ZooKeeperConnection Watcher:127.0.0.1:35446/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 296679 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 296680 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 296681 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 296682 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes/node6
   [junit4]   2> 296683 INFO  (zkCallback-267-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: 6)
   [junit4]   2> 296683 INFO  (zkCallback-271-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: 6)
   [junit4]   2> 296684 INFO  (zkCallback-264-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: 6)
   [junit4]   2> 296684 INFO  (zkCallback-272-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: 6)
   [junit4]   2> 296684 INFO  (zkCallback-268-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: 6)
   [junit4]   2> 296683 INFO  (zkCallback-269-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: 6)
   [junit4]   2> 296684 INFO  (zkCallback-266-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: 6)
   [junit4]   2> 296684 INFO  (zkCallback-270-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: 6)
   [junit4]   2> 296684 INFO  (zkCallback-263-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: 6)
   [junit4]   2> 296688 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 296688 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 296691 INFO  (zkCallback-273-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@9b0a8c7 name:ZooKeeperConnection 
Watcher:127.0.0.1:35446/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 296691 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 296692 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 296696 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 296697 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes/node7
   [junit4]   2> 296698 INFO  (zkCallback-271-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: 7)
   [junit4]   2> 296698 INFO  (zkCallback-263-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: 7)
   [junit4]   2> 296699 INFO  (zkCallback-264-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: 7)
   [junit4]   2> 296699 INFO  (zkCallback-270-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: 7)
   [junit4]   2> 296699 INFO  (zkCallback-266-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: 7)
   [junit4]   2> 296699 INFO  (zkCallback-269-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: 7)
   [junit4]   2> 296699 INFO  (zkCallback-268-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: 7)
   [junit4]   2> 296698 INFO  (zkCallback-267-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: 7)
   [junit4]   2> 296699 INFO  (zkCallback-272-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: 7)
   [junit4]   2> 296700 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 296700 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 296699 INFO  (zkCallback-273-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: 7)
   [junit4]   2> 296701 INFO  (zkCallback-274-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@6d0b841d 
name:ZooKeeperConnection Watcher:127.0.0.1:35446/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 296701 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 296702 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 296703 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 296705 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes/node8
   [junit4]   2> 296706 INFO  (zkCallback-269-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: 8)
   [junit4]   2> 296706 INFO  (zkCallback-266-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: 8)
   [junit4]   2> 296706 INFO  (zkCallback-264-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: 8)
   [junit4]   2> 296707 INFO  (zkCallback-273-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: 8)
   [junit4]   2> 296707 INFO  (zkCallback-263-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: 8)
   [junit4]   2> 296707 INFO  (zkCallback-274-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: 8)
   [junit4]   2> 296706 INFO  (zkCallback-271-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: 8)
   [junit4]   2> 296706 INFO  (zkCallback-270-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: 8)
   [junit4]   2> 296708 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 296708 INFO  (zkCallback-268-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: 8)
   [junit4]   2> 296708 INFO  (zkCallback-272-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: 8)
   [junit4]   2> 296708 INFO  (zkCallback-267-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: 8)
   [junit4]   2> 296709 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 296716 INFO  (zkCallback-275-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@75d3849f 
name:ZooKeeperConnection Watcher:127.0.0.1:35446/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 296716 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 296717 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 296718 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 296720 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes/node9
   [junit4]   2> 296721 INFO  (zkCallback-269-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: 9)
   [junit4]   2> 296721 INFO  (zkCallback-272-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: 9)
   [junit4]   2> 296721 INFO  (zkCallback-270-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: 9)
   [junit4]   2> 296721 INFO  (zkCallback-266-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: 9)
   [junit4]   2> 296721 INFO  (zkCallback-267-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: 9)
   [junit4]   2> 296721 INFO  (zkCallback-263-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: 9)
   [junit4]   2> 296721 INFO  (zkCallback-273-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: 9)
   [junit4]   2> 296721 INFO  (zkCallback-274-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: 9)
   [junit4]   2> 296721 INFO  (zkCallback-275-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: 9)
   [junit4]   2> 296721 INFO  (zkCallback-268-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: 9)
   [junit4]   2> 296721 INFO  (zkCallback-271-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: 9)
   [junit4]   2> 296721 INFO  (zkCallback-264-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: 9)
   [junit4]   2> 296722 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 296723 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 296724 INFO  (zkCallback-276-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7c3d3078 
name:ZooKeeperConnection Watcher:127.0.0.1:35446/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 296724 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 296725 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 296726 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 296728 INFO  
(TEST-OverseerTest.testShardAssignmentBigger-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /live_nodes/node10
   [junit4]   2> 296729 INFO  (zkCallback-267-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: 10)
   [junit4]   2> 296729 INFO  (zkCallback-269-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: 10)
   [junit4]   2> 296729 INFO  (zkCallback-264-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: 10)
   [junit4]   2> 296729 INFO  (zkCallback-274-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: 10)
   [junit4]   2> 296729 INFO  (zkCallback-271-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: 10)
   [junit4]   2> 296729 INFO  (zkCallback-268-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: 10)
   [junit4]   2> 296729 INFO  (zkCallback-270-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: 10)
   [junit4]   2> 296729 INFO  (zkCallback-276-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: 10)
   [junit4]   2> 296729 INFO  (zkCallback-272-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: 10)
   [junit4]   2> 296729 INFO  (zkCallback-263-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: 10)
   [junit4]   2> 296729 INFO  (zkCallback-273-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: 10)
   [junit4]   2> 296729 INFO  (zkCallback-266-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: 10)
   [junit4]   2> 296729 INFO  (zkCallback-275-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: 10)
   [junit4]   2> 296740 INFO  
(OverseerStateUpdate-94484489381478403-127.0.0.1:35446_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 7, message = {
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"node1",
   [junit4]   2>   "core":"core1",
   [junit4]   2>   "core_node_name":"node1",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "numShards":"5",
   [junit4]   2>   "base_url":"http://node1/solr/"} current state version: 0
   [junit4]   2> 296741 INFO  
(OverseerStateUpdate-94484489381478403-127.0.0.1:35446_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Update state numShards=5 message={
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"node1",
   [junit4]   2>   "core":"core1",
   [junit4]   2>   "core_node_name":"node1",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "numShards":"5",
   [junit4]   2>   "base_url":"http://node1/solr/"}
   [junit4]   2> 296741 INFO  
(OverseerStateUpdate-94484489381478403-127.0.0.1:35446_solr-n_0000000000) [    
] o.a.s.c.o.ClusterStateMutator building a new cName: collection1
   [junit4]   2> 296741 INFO  
(OverseerStateUpdate-94484489381478403-127.0.0.1:35446_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard2
   [junit4]   2> 296742 INFO  (zkCallback-276-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: 11)
   [junit4]   2> 296742 INFO  (zkCallback-275-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: 11)
   [junit4]   2> 296742 INFO  (zkCallback-263-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: 11)
   [junit4]   2> 296742 INFO  (zkCallback-266-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: 11)
   [junit4]   2> 296742 INFO  (zkCallback-268-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: 11)
   [junit4]   2> 296742 INFO  (zkCallback-269-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: 11)
   [junit4]   2> 296742 INFO  (zkCallback-271-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: 11)
   [junit4]   2> 296742 INFO  (zkCallback-270-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: 11)
   [junit4]   2> 296742 INFO  (zkCallback-267-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: 11)
   [junit4]   2> 296743 INFO  (zkCallback-264-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: 11)
   [junit4]   2> 296743 INFO  (zkCallback-272-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: 11)
   [junit4]   2> 296743 INFO  (zkCallback-273-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: 11)
   [junit4]   2> 296742 INFO  (zkCallback-274-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: 11)
   [junit4]   2> 296746 INFO  
(OverseerStateUpdate-94484489381478403-127.0.0.1:35446_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 0, message = {
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"node0",
   [junit4]   2>   "core":"core0",
   [junit4]   2>   "core_node_name":"node0",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "numShards":"5",
   [junit4]   2>   "base_url":"http://node0/solr/"} current state version: 1
   [junit4]   2> 296747 INFO  
(OverseerStateUpdate-94484489381478403-127.0.0.1:35446_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Update state numShards=5 message={
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"node0",
   [junit4]   2>   "core":"core0",
   [junit4]   2>   "core_node_name":"node0",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "numShards":"5",
   [junit4]   2>   "base_url":"http://node0/solr/"}
   [junit4]   2> 296747 INFO  
(OverseerStateUpdate-94484489381478403-127.0.0.1:35446_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Collection already exists with numShards=5
   [junit4]   2> 296747 INFO  
(OverseerStateUpdate-94484489381478403-127.0.0.1:35446_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard3
   [junit4]   2> 296749 INFO  
(OverseerStateUpdate-94484489381478403-127.0.0.1:35446_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 0, message = {
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"node2",
   [junit4]   2>   "core":"core2",
   [junit4]   2>   "core_node_name":"node2",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "numShards":"5",
   [junit4]   2>   "base_url":"http://node2/solr/"} current state version: 1
   [junit4]   2> 296750 INFO  
(OverseerStateUpdate-94484489381478403-127.0.0.1:35446_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Update state numShards=5 message={
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"node2",
   [junit4]   2>   "core":"core2",
   [junit4]   2>   "core_node_name":"node2",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "numShards":"5",
   [junit4]   2>   "base_url":"http://node2/solr/"}
   [junit4]   2> 296751 INFO  
(OverseerStateUpdate-94484489381478403-127.0.0.1:35446_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Collection already exists with numShards=5
   [junit4]   2> 296751 INFO  
(OverseerStateUpdate-94484489381478403-127.0.0.1:35446_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard4
   [junit4]   2> 296753 INFO  
(OverseerStateUpdate-94484489381478403-127.0.0.1:35446_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 0, message = {
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"node5",
   [junit4]   2>   "core":"core5",
   [junit4]   2>   "core_node_name":"node5",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "numShards":"5",
   [junit4]   2>   "base_url":"http://node5/solr/"} current state version: 1
   [junit4]   2> 296754 INFO  
(OverseerStateUpdate-94484489381478403-127.0.0.1:35446_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Update state numShards=5 message={
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"node5",
   [junit4]   2>   "core":"core5",
   [junit4]   2>   "core_node_name":"node5",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "numShards":"5",
   [junit4]   2>   "base_url":"http://node5/solr/"}
   [junit4]   2> 296754 INFO  
(OverseerStateUpdate-94484489381478403-127.0.0.1:35446_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Collection already exists with numShards=5
   [junit4]   2> 296754 INFO  
(OverseerStateUpdate-94484489381478403-127.0.0.1:35446_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard5
   [junit4]   2> 296756 INFO  
(OverseerStateUpdate-94484489381478403-127.0.0.1:35446_solr-n_0000000000) [    
] o.a.s.c.Overseer processMessage: queueSize: 0, message = {
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "node_name":"node4",
   [junit4]   2>   "core":"core4",
   [junit4]   2>   "core_node_name":"node4",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "numShards":"5",
   [junit4]   2>   "base_url":"http://node4/solr/"} current state version: 1
   [junit4]   2> 296756 INFO  (OverseerStateUpdate-94484489381478403-127.0.0.1:3

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

caFailoverBadNodeExpiration=60000
   [junit4]   2> 358255 INFO  
(OverseerStateUpdate-94484493419544579-127.0.0.1:36863_solr-n_0000000000) [    
] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 358255 INFO  
(OverseerStateUpdate-94484493419544579-127.0.0.1:36863_solr-n_0000000000) [    
] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 358258 INFO  
(OverseerCollectionConfigSetProcessor-94484493419544579-127.0.0.1:36863_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer 
operations
   [junit4]   2> 358261 INFO  
(OverseerStateUpdate-94484493419544579-127.0.0.1:36863_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> 358262 INFO  
(OverseerStateUpdate-94484493419544579-127.0.0.1:36863_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> 358262 INFO  
(OverseerStateUpdate-94484493419544579-127.0.0.1:36863_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
   [junit4]   2> 358263 INFO  (zkCallback-361-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> 358265 INFO  (zkCallback-358-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> 358314 INFO  
(OverseerStateUpdate-94484493419544579-127.0.0.1:36863_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> 358314 INFO  
(OverseerStateUpdate-94484493419544579-127.0.0.1:36863_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> 358314 INFO  
(OverseerStateUpdate-94484493419544579-127.0.0.1:36863_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator node=core_node1 is already registered
   [junit4]   2> 358315 INFO  
(OverseerStateUpdate-94484493419544579-127.0.0.1:36863_solr-n_0000000000) [    
] o.a.s.c.o.ReplicaMutator shard=shard1 is already registered
   [junit4]   2> 358417 INFO  (zkCallback-358-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> 358417 INFO  (zkCallback-361-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> 358468 INFO  
(TEST-OverseerTest.testStateChange-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:36863 36863
   [junit4]   2> 358468 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 0x14fad256b0e0003, 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> 358582 INFO  (Thread-848) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:36863 36863
   [junit4]   2> 358583 WARN  (Thread-848) [    ] 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> 358583 INFO  
(TEST-OverseerTest.testStateChange-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testStateChange
   [junit4]   2> 358583 INFO  
(TEST-OverseerTest.testStateChange-seed#[F73FAD8CCD9EB9EE]) [    ] 
o.a.s.c.Overseer Overseer 
(id=94484493419544579-127.0.0.1:36863_solr-n_0000000000) closing
   [junit4]   2> 358585 INFO  
(OverseerStateUpdate-94484493419544579-127.0.0.1:36863_solr-n_0000000000) [    
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:36863_solr
   [junit4]   2> 358585 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> 361585 INFO  
(SUITE-OverseerTest-seed#[F73FAD8CCD9EB9EE]-worker) [    ] o.a.s.SolrTestCaseJ4 
###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J2/temp/solr.cloud.OverseerTest_F73FAD8CCD9EB9EE-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene53): {}, 
docValues:{}, sim=RandomSimilarityProvider(queryNorm=true,coord=yes): {}, 
locale=ar_MA, timezone=America/Virgin
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 
1.8.0_45 (64-bit)/cpus=4,threads=1,free=98538472,total=449314816
   [junit4]   2> NOTE: All tests run in this JVM: [TestDefaultStatsCache, 
TestSolrCLIRunExample, TestWriterPerf, DirectUpdateHandlerTest, 
RAMDirectoryFactoryTest, TestCharFilters, AnalyticsMergeStrategyTest, 
TestFieldTypeCollectionResource, DeleteReplicaTest, TestSolr4Spatial2, 
SuggesterTSTTest, CoreAdminHandlerTest, TestChildDocTransformer, 
DistributedQueryComponentCustomSortTest, BadComponentTest, SimpleFacetsTest, 
TestSweetSpotSimilarityFactory, TestRTimerTree, TestShardHandlerFactory, 
TestDynamicFieldCollectionResource, HdfsCollectionsAPIDistributedZkTest, 
SimpleCollectionCreateDeleteTest, TestConfigSetsAPIExclusivity, 
OverseerTaskQueueTest, BasicDistributedZk2Test, ClusterStateTest, 
BasicAuthIntegrationTest, SegmentsInfoRequestHandlerTest, 
DistribJoinFromCollectionTest, OverseerTest]
   [junit4] Completed [113/544] on J2 in 70.45s, 12 tests, 1 failure, 1 skipped 
<<< FAILURES!

[...truncated 1365 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/build.xml:775:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/build.xml:719:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/build.xml:59: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build.xml:233:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/common-build.xml:514:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/lucene/common-build.xml:1432:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/lucene/common-build.xml:987:
 There were test failures: 544 suites, 2141 tests, 1 failure, 47 ignored (35 
assumptions)

Total time: 57 minutes 35 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Sending artifact delta relative to Lucene-Solr-Tests-trunk-Java8 #375
Archived 4 artifacts
Archive block size is 32768
Received 0 blocks and 342829201 bytes
Compression is 0.0%
Took 57 sec
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure


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

Reply via email to