[HADOOP-16531] Log more detail for slow RPC

• Type: Improvement
• Status: Resolved
• Priority: Major
• Resolution: Fixed
• Fix Version/s: 3.3.0, 3.1.4, 3.2.2
• Assignee: Chen Zhang
• Reporter: Chen Zhang
• Created: 25/Aug/19 16:28
• Updated: 03/Oct/19 02:22
• Resolved: 06/Sep/19 17:28

Description

Current implementation only log process time

if ((rpcMetrics.getProcessingSampleCount() > minSampleSize) &&
    (processingTime > threeSigma)) {
  LOG.warn("Slow RPC : {} took {} {} to process from client {}",
      methodName, processingTime, RpcMetrics.TIMEUNIT, call);
  rpcMetrics.incrSlowRpc();
}

We need to log more details to help us locate the problem (eg. how long it take to request lock, holding lock, or do other things)

Issue Links

• duplicates: HADOOP-16310 Log of a slow RPC request should contain the parameter of the request