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

Hadoop QA commented on HADOOP-12186:
------------------------------------

\\
\\
| (x) *{color:red}-1 overall{color}* |
\\
\\
|| Vote || Subsystem || Runtime || Comment ||
| {color:blue}0{color} | pre-patch |  16m 46s | Pre-patch trunk compilation is 
healthy. |
| {color:green}+1{color} | @author |   0m  0s | The patch does not contain any 
@author tags. |
| {color:green}+1{color} | tests included |   0m  0s | The patch appears to 
include 1 new or modified test files. |
| {color:green}+1{color} | javac |   7m 41s | There were no new javac warning 
messages. |
| {color:green}+1{color} | javadoc |   9m 38s | There were no new javadoc 
warning messages. |
| {color:green}+1{color} | release audit |   0m 23s | The applied patch does 
not increase the total number of release audit warnings. |
| {color:green}+1{color} | checkstyle |   1m  7s | There were no new checkstyle 
issues. |
| {color:green}+1{color} | whitespace |   0m  0s | The patch has no lines that 
end in whitespace. |
| {color:green}+1{color} | install |   1m 36s | mvn install still works. |
| {color:green}+1{color} | eclipse:eclipse |   0m 33s | The patch built with 
eclipse:eclipse. |
| {color:green}+1{color} | findbugs |   1m 49s | The patch does not introduce 
any new Findbugs (version 3.0.0) warnings. |
| {color:red}-1{color} | common tests |  21m 30s | Tests failed in 
hadoop-common. |
| | |  61m  6s | |
\\
\\
|| Reason || Tests ||
| Failed unit tests | hadoop.ipc.TestCallQueueManager |
\\
\\
|| Subsystem || Report/Notes ||
| Patch URL | 
http://issues.apache.org/jira/secure/attachment/12743616/HADOOP-12186.000.patch 
|
| Optional Tests | javadoc javac unit findbugs checkstyle |
| git revision | trunk / 688617d |
| hadoop-common test log | 
https://builds.apache.org/job/PreCommit-HADOOP-Build/7150/artifact/patchprocess/testrun_hadoop-common.txt
 |
| Test Results | 
https://builds.apache.org/job/PreCommit-HADOOP-Build/7150/testReport/ |
| Java | 1.7.0_55 |
| uname | Linux asf901.gq1.ygridcore.net 3.13.0-36-lowlatency #63-Ubuntu SMP 
PREEMPT Wed Sep 3 21:56:12 UTC 2014 x86_64 x86_64 x86_64 GNU/Linux |
| Console output | 
https://builds.apache.org/job/PreCommit-HADOOP-Build/7150/console |


This message was automatically generated.

> ActiveStandbyElector shouldn't call monitorLockNodeAsync before StatCallback 
> for previous zkClient.exists is received.
> ----------------------------------------------------------------------------------------------------------------------
>
>                 Key: HADOOP-12186
>                 URL: https://issues.apache.org/jira/browse/HADOOP-12186
>             Project: Hadoop Common
>          Issue Type: Bug
>          Components: ha
>    Affects Versions: 2.7.1
>            Reporter: zhihai xu
>            Assignee: zhihai xu
>         Attachments: HADOOP-12186.000.patch
>
>
> ActiveStandbyElector shouldn't call {{monitorLockNodeAsync}} before 
> StatCallback for previous {{zkClient.exists}} is received.
> We saw RM shutdown because ActiveStandbyElector retrying monitorLockNodeAsync 
> exceeded limit. The following is the logs.
> Based on the log, it looks like multiple {{monitorLockNodeAsync}} are called 
> at the same time due to back-to-back SyncConnected event received.
> The current code doesn't prevent {{zkClient.exists}} from being called before 
> AsyncCallback.StatCallback for previous {{zkClient.exists}} is received.
> So the retry for {{monitorLockNodeAsync}} doesn't work correctly sometimes.
> {code}
> 2015-07-01 19:24:12,806 INFO org.apache.zookeeper.ClientCnxn: Client session 
> timed out, have not heard from server in 6674ms for sessionid 
> 0x14e47693cc20007, closing socket connection and attempting reconnect
> 2015-07-01 19:24:12,919 INFO org.apache.hadoop.ha.ActiveStandbyElector: 
> Session disconnected. Entering neutral mode...
> 2015-07-01 19:24:14,704 INFO org.apache.zookeeper.ClientCnxn: Opening socket 
> connection to server node-1.internal/192.168.123.3:2181. Will not attempt to 
> authenticate using SASL (unknown error)
> 2015-07-01 19:24:14,704 INFO org.apache.zookeeper.ClientCnxn: Socket 
> connection established, initiating session, client: /192.168.123.3:43487, 
> server: node-1.internal/192.168.123.3:2181
> 2015-07-01 19:24:14,707 INFO org.apache.zookeeper.ClientCnxn: Session 
> establishment complete on server node-1.internal/192.168.123.3:2181, 
> sessionid = 0x14e47693cc20007, negotiated timeout = 10000
> 2015-07-01 19:24:14,712 INFO org.apache.hadoop.ha.ActiveStandbyElector: 
> Session connected.
> 2015-07-01 19:24:21,374 INFO org.apache.zookeeper.ClientCnxn: Client session 
> timed out, have not heard from server in 6667ms for sessionid 
> 0x14e47693cc20007, closing socket connection and attempting reconnect
> 2015-07-01 19:24:21,477 INFO org.apache.hadoop.ha.ActiveStandbyElector: 
> Session disconnected. Entering neutral mode...
> 2015-07-01 19:24:22,640 INFO org.apache.zookeeper.ClientCnxn: Opening socket 
> connection to server node-1.internal/192.168.123.3:2181. Will not attempt to 
> authenticate using SASL (unknown error)
> 2015-07-01 19:24:22,640 INFO org.apache.zookeeper.ClientCnxn: Socket 
> connection established, initiating session, client: /192.168.123.3:43526, 
> server: node-1.internal/192.168.123.3:2181
> 2015-07-01 19:24:22,641 INFO org.apache.zookeeper.ClientCnxn: Session 
> establishment complete on server node-1.internal/192.168.123.3:2181, 
> sessionid = 0x14e47693cc20007, negotiated timeout = 10000
> 2015-07-01 19:24:22,642 INFO org.apache.hadoop.ha.ActiveStandbyElector: 
> Session connected.
> 2015-07-01 19:24:29,310 INFO org.apache.zookeeper.ClientCnxn: Client session 
> timed out, have not heard from server in 6669ms for sessionid 
> 0x14e47693cc20007, closing socket connection and attempting reconnect
> 2015-07-01 19:24:29,413 INFO org.apache.hadoop.ha.ActiveStandbyElector: 
> Session disconnected. Entering neutral mode...
> 2015-07-01 19:24:30,738 INFO org.apache.zookeeper.ClientCnxn: Opening socket 
> connection to server node-1.internal/192.168.123.3:2181. Will not attempt to 
> authenticate using SASL (unknown error)
> 2015-07-01 19:24:30,739 INFO org.apache.zookeeper.ClientCnxn: Socket 
> connection established, initiating session, client: /192.168.123.3:43574, 
> server: node-1.internal/192.168.123.3:2181
> 2015-07-01 19:24:30,739 INFO org.apache.zookeeper.ClientCnxn: Session 
> establishment complete on server node-1.internal/192.168.123.3:2181, 
> sessionid = 0x14e47693cc20007, negotiated timeout = 10000
> 2015-07-01 19:24:30,740 INFO org.apache.hadoop.ha.ActiveStandbyElector: 
> Session connected.
> 2015-07-01 19:24:37,409 INFO org.apache.zookeeper.ClientCnxn: Client session 
> timed out, have not heard from server in 6670ms for sessionid 
> 0x14e47693cc20007, closing socket connection and attempting reconnect
> 2015-07-01 19:24:37,512 INFO org.apache.hadoop.ha.ActiveStandbyElector: 
> Session disconnected. Entering neutral mode...
> 2015-07-01 19:24:38,979 INFO org.apache.zookeeper.ClientCnxn: Opening socket 
> connection to server node-1.internal/192.168.123.3:2181. Will not attempt to 
> authenticate using SASL (unknown error)
> 2015-07-01 19:24:38,979 INFO org.apache.zookeeper.ClientCnxn: Socket 
> connection established, initiating session, client: /192.168.123.3:43598, 
> server: node-1.internal/192.168.123.3:2181
> 2015-07-01 19:24:38,980 INFO org.apache.zookeeper.ClientCnxn: Session 
> establishment complete on server node-1.internal/192.168.123.3:2181, 
> sessionid = 0x14e47693cc20007, negotiated timeout = 10000
> 2015-07-01 19:24:38,981 INFO org.apache.hadoop.ha.ActiveStandbyElector: 
> Session connected.
> 2015-07-01 19:24:45,649 INFO org.apache.zookeeper.ClientCnxn: Client session 
> timed out, have not heard from server in 6669ms for sessionid 
> 0x14e47693cc20007, closing socket connection and attempting reconnect
> 2015-07-01 19:24:45,752 FATAL org.apache.hadoop.ha.ActiveStandbyElector: 
> Received stat error from Zookeeper. code:CONNECTIONLOSS. Not retrying further 
> znode monitoring connection errors.
> 2015-07-01 19:24:45,855 INFO org.apache.zookeeper.ZooKeeper: Session: 
> 0x14e47693cc20007 closed
> 2015-07-01 19:25:07,932 WARN org.apache.hadoop.ha.ActiveStandbyElector: 
> Ignoring stale result from old client with sessionId 0x14e47693cc20007
> 2015-07-01 19:25:07,932 FATAL 
> org.apache.hadoop.yarn.server.resourcemanager.ResourceManager: Received a 
> org.apache.hadoop.yarn.server.resourcemanager.RMFatalEvent of type 
> EMBEDDED_ELECTOR_FAILED. Cause:
> Received stat error from Zookeeper. code:CONNECTIONLOSS. Not retrying further 
> znode monitoring connection errors.
> 2015-07-01 19:25:07,932 WARN org.apache.hadoop.ha.ActiveStandbyElector: 
> Ignoring stale result from old client with sessionId 0x14e47693cc20007
> 2015-07-01 19:25:07,932 WARN org.apache.hadoop.ha.ActiveStandbyElector: 
> Ignoring stale result from old client with sessionId 0x14e47693cc20007
> 2015-07-01 19:25:07,933 WARN org.apache.hadoop.ha.ActiveStandbyElector: 
> Ignoring stale result from old client with sessionId 0x14e47693cc20007
> 2015-07-01 19:25:07,933 INFO org.apache.zookeeper.ClientCnxn: EventThread 
> shut down
> 2015-07-01 19:25:08,036 INFO org.apache.hadoop.util.ExitUtil: Exiting with 
> status 1
> {code}



--
This message was sent by Atlassian JIRA
(v6.3.4#6332)

Reply via email to