[ 
https://issues.apache.org/jira/browse/ZOOKEEPER-3758?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=17061934#comment-17061934
 ] 

Mate Szalay-Beko commented on ZOOKEEPER-3758:
---------------------------------------------

great! Thanks for testing it!

It means that we know where the problem is and how to fix it.

Although we are not sure why the ICMP fails from Java. Actually it is not 
necessary ICMP... This is the function we call in ZooKeeper: 
https://docs.oracle.com/en/java/javase/11/docs/api/java.base/java/net/InetAddress.html#isReachable(int)
 and this function returns false in your case (but I don't know why), when the 
given Follower tries to reach the Leader. By setting 
{{multiAddress.reachabilityCheckEnabled=false}} you skipped this check.

Anyway, as I mentioned, this check should not be run unless you actually use 
the multiAddress feature, which you don't do, based on your config. So this is 
a bug. I will fix it quickly, hopefully tomorrow I can submit the PR.


> Update from 3.5.7 to 3.6.0 does not work
> ----------------------------------------
>
>                 Key: ZOOKEEPER-3758
>                 URL: https://issues.apache.org/jira/browse/ZOOKEEPER-3758
>             Project: ZooKeeper
>          Issue Type: Bug
>          Components: server
>            Reporter: Agostino Sarubbo
>            Assignee: Mate Szalay-Beko
>            Priority: Major
>
> Hello,
>  we have a cluster with 5 zookeeper servers. We tried the update from 3.5.7 
> to 3.6.0 but it does not work.
> We got the following:
> {code:java}
> 2020-03-16 10:40:45,514 [myid:1] - INFO  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):QuorumPeer@863] 
> - Peer state changed: looking 2020-03-16 10:40:45,514 [myid:1] - WARN  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):QuorumPeer@1501] 
> - PeerState set to LOOKING 2020-03-16 10:40:45,514 [myid:1] - INFO  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):QuorumPeer@1371] 
> - LOOKING 2020-03-16 10:40:45,514 [myid:1] - INFO  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):FastLeaderElection@931]
>  - New election. My id = 1, proposed zxid=0x0 2020-03-16 10:40:45,515 
> [myid:1] - INFO  
> [WorkerReceiver[myid=1]:FastLeaderElection$Messenger$WorkerReceiver@376] - 
> Notification: my state:LOOKING; n.sid:1, n.state:LOOKING , n.leader:1, 
> n.round:0x1b, n.peerEpoch:0x0, n.zxid:0x0, message format version:0x2, 
> n.config version:0x0 2020-03-16 10:40:45,517 [myid:1] - INFO  
> [WorkerReceiver[myid=1]:FastLeaderElection$Messenger$WorkerReceiver@376] - 
> Notification: my state:LOOKING; n.sid:2, n.state:FOLLOWI NG, n.leader:4, 
> n.round:0x1a, n.peerEpoch:0x5c, n.zxid:0x5b00000004, message format 
> version:0x2, n.config version:0x0 2020-03-16 10:40:45,517 [myid:1] - INFO  
> [WorkerReceiver[myid=1]:FastLeaderElection$Messenger$WorkerReceiver@376] - 
> Notification: my state:LOOKING; n.sid:3, n.state:FOLLOWI NG, n.leader:4, 
> n.round:0x1a, n.peerEpoch:0x5c, n.zxid:0x5b00000004, message format 
> version:0x2, n.config version:0x0 2020-03-16 10:40:45,517 [myid:1] - INFO  
> [WorkerReceiver[myid=1]:FastLeaderElection$Messenger$WorkerReceiver@376] - 
> Notification: my state:LOOKING; n.sid:5, n.state:FOLLOWI NG, n.leader:4, 
> n.round:0x1a, n.peerEpoch:0x5c, n.zxid:0x5b00000004, message format 
> version:0x2, n.config version:0x0 2020-03-16 10:40:45,518 [myid:1] - INFO  
> [WorkerReceiver[myid=1]:FastLeaderElection$Messenger$WorkerReceiver@376] - 
> Notification: my state:LOOKING; n.sid:4, n.state:LEADING , n.leader:4, 
> n.round:0x1a, n.peerEpoch:0x5c, n.zxid:0x5b00000004, message format 
> version:0x2, n.config version:0x0 2020-03-16 10:40:45,518 [myid:1] - INFO  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):QuorumPeer@857] 
> - Peer state changed: following 2020-03-16 10:40:45,518 [myid:1] - INFO  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):QuorumPeer@1453] 
> - FOLLOWING 2020-03-16 10:40:45,518 [myid:1] - INFO  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):ZooKeeperServer@1246]
>  - minSessionTimeout set to 4000 2020-03-16 10:40:45,518 [myid:1] - INFO  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):ZooKeeperServer@1255]
>  - maxSessionTimeout set to 40000 2020-03-16 10:40:45,519 [myid:1] - INFO  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):ResponseCache@45]
>  - Response cache size is initialized with value 400. 2020-03-16 10:40:45,519 
> [myid:1] - INFO  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):ResponseCache@45]
>  - Response cache size is initialized with value 400. 2020-03-16 10:40:45,519 
> [myid:1] - INFO  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):RequestPathMetricsCollector@111]
>  - zookeeper.pathStats.slotCapacity = 60 2020-03-16 10:40:45,519 [myid:1] - 
> INFO  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):RequestPathMetricsCollector@112]
>  - zookeeper.pathStats.slotDuration = 15 2020-03-16 10:40:45,519 [myid:1] - 
> INFO  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):RequestPathMetricsCollector@113]
>  - zookeeper.pathStats.maxDepth = 6 2020-03-16 10:40:45,519 [myid:1] - INFO  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):RequestPathMetricsCollector@114]
>  - zookeeper.pathStats.initialDelay = 5 2020-03-16 10:40:45,519 [myid:1] - 
> INFO  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):RequestPathMetricsCollector@115]
>  - zookeeper.pathStats.delay = 5 2020-03-16 10:40:45,519 [myid:1] - INFO  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):RequestPathMetricsCollector@116]
>  - zookeeper.pathStats.enabled = false 2020-03-16 10:40:45,519 [myid:1] - 
> INFO  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):ZooKeeperServer@1470]
>  - The max bytes for all large requests are set t o 104857600 2020-03-16 
> 10:40:45,519 [myid:1] - INFO  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):ZooKeeperServer@1484]
>  - The large request threshold is set to -1 2020-03-16 10:40:45,519 [myid:1] 
> - INFO  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):ZooKeeperServer@329]
>  - Created server with tickTime 2000 minSessionTim eout 4000 
> maxSessionTimeout 40000 clientPortListenBacklog -1 datadir 
> /opt/loway/zookeeper/logs/version-2 snapdir 
> /opt/loway/zookeeper/data/version-2 2020-03-16 10:40:45,519 [myid:1] - INFO  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):Follower@75] - 
> FOLLOWING - LEADER ELECTION TOOK - 4 MS 2020-03-16 10:40:45,519 [myid:1] - 
> INFO  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):QuorumPeer@863] 
> - Peer state changed: following - discovery 2020-03-16 10:40:46,521 [myid:1] 
> - WARN  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):Follower@129] - 
> Exception when following the leader java.lang.IllegalArgumentException        
> at 
> java.util.concurrent.ThreadPoolExecutor.<init>(ThreadPoolExecutor.java:1314)  
>       at 
> java.util.concurrent.ThreadPoolExecutor.<init>(ThreadPoolExecutor.java:1202)  
>       at java.util.concurrent.Executors.newFixedThreadPool(Executors.java:89) 
>        at 
> org.apache.zookeeper.server.quorum.Learner.connectToLeader(Learner.java:275)  
>       at 
> org.apache.zookeeper.server.quorum.Follower.followLeader(Follower.java:87)    
>     at 
> org.apache.zookeeper.server.quorum.QuorumPeer.run(QuorumPeer.java:1455) 
> 2020-03-16 10:40:46,521 [myid:1] - INFO  
> [QuorumPeer[myid=1](plain=0.0.0.0:2181)(secure=0.0.0.0:2281):Follower@292] - 
> shutdown Follower{code}



--
This message was sent by Atlassian Jira
(v8.3.4#803005)

Reply via email to