diff --git a/hbase-client/src/main/java/org/apache/hadoop/hbase/ipc/AbstractRpcClient.java b/hbase-client/src/main/java/org/apache/hadoop/hbase/ipc/AbstractRpcClient.java index e5863948a58..0afd07d7951 100644 --- a/hbase-client/src/main/java/org/apache/hadoop/hbase/ipc/AbstractRpcClient.java +++ b/hbase-client/src/main/java/org/apache/hadoop/hbase/ipc/AbstractRpcClient.java @@ -379,8 +379,8 @@ public abstract class AbstractRpcClient implements RpcC metrics.updateRpc(call.md, call.param, call.callStats); } if (LOG.isTraceEnabled()) { - LOG.trace( - "Call: " + call.md.getName() + ", callTime: " + call.callStats.getCallTimeMs() + "ms"); + LOG.trace("CallId: {}, call: {}, startTime: {}ms, callTime: {}ms", call.id, call.md.getName(), + call.getStartTime(), call.callStats.getCallTimeMs()); } if (call.error != null) { if (call.error instanceof RemoteException) { diff --git a/hbase-server/src/main/java/org/apache/hadoop/hbase/ipc/RpcServer.java b/hbase-server/src/main/java/org/apache/hadoop/hbase/ipc/RpcServer.java index 2ca86f57f74..66d5b8f43d8 100644 --- a/hbase-server/src/main/java/org/apache/hadoop/hbase/ipc/RpcServer.java +++ b/hbase-server/src/main/java/org/apache/hadoop/hbase/ipc/RpcServer.java @@ -390,9 +390,10 @@ public abstract class RpcServer implements RpcServerInterface, ConfigurationObse int qTime = (int) (startTime - receiveTime); int totalTime = (int) (endTime - receiveTime); if (LOG.isTraceEnabled()) { - LOG.trace(CurCall.get().toString() + ", response " + TextFormat.shortDebugString(result) - + " queueTime: " + qTime + " processingTime: " + processingTime + " totalTime: " - + totalTime); + LOG.trace( + "{}, response: {}, receiveTime: {}, queueTime: {}, processingTime: {}, totalTime: {}", + CurCall.get().toString(), TextFormat.shortDebugString(result), + CurCall.get().getReceiveTime(), qTime, processingTime, totalTime); } // Use the raw request call size for now. long requestSize = call.getSize();