[HDFS-6836] HDFS INFO logging is verbose & uses file appenders

• Type: Improvement
• Status: Closed
• Priority: Major
• Resolution: Fixed
• Affects Version/s: 2.4.1
• Fix Version/s: 2.6.0
• Component/s: datanode
• Target Version/s: 2.6.0
• Hadoop Flags: Reviewed
• Assignee: Nathan Yao
• Reporter: Gopal Vijayaraghavan
• Created: 08/Aug/14 18:14
• Updated: 04/May/15 17:50
• Resolved: 12/Aug/14 21:52

Description

Reported by: gopalv.

The HDFS INFO logs is present within the inner loops of HDFS logging information like

2014-07-24 19:43:34,459 INFO  DataNode.clienttrace (BlockSender.java:sendBlock(738)) - src: /172.21.128.105:50010, dest: /172.21.128.113:43666, bytes: 786432, op: HDFS_READ, cliID: DFSClient_hb_rs_cn113-10.l42scl.hortonworks.com,50700,1406227155474_1075922312_33, offset: 86616576, srvID: 3f80f56f-a6ea-4951-8db6-86b51938d144, blockid: BP-971413386-172.21.128.105-1398117368124:blk_1074925960_1186504, duration: 6827335
2014-07-24 19:43:34,465 INFO  DataNode.clienttrace (BlockSender.java:sendBlock(738)) - src: /172.21.128.105:50010, dest: /172.21.128.117:41731, bytes: 786432, op: HDFS_READ, cliID: DFSClient_hb_rs_cn117-10.l42scl.hortonworks.com,53868,1406227155459_1689003704_33, offset: 72691200, srvID: 3f80f56f-a6ea-4951-8db6-86b51938d144, blockid: BP-971413386-172.21.128.105-1398117368124:blk_1074926372_1186916, duration: 7178626
2014-07-24 19:43:34,467 INFO  DataNode.clienttrace (BlockSender.java:sendBlock(738)) - src: /172.21.128.105:50010, dest: /172.21.128.113:43669, bytes: 786432, op: HDFS_READ, cliID: DFSClient_hb_rs_cn113-10.l42scl.hortonworks.com,50700,1406227155474_1075922312_33, offset: 86813696, srvID: 3f80f56f-a6ea-4951-8db6-86b51938d144, blockid: BP-971413386-172.21.128.105-1398117368124:blk_1074925960_1186504, duration: 8540703
2014-07-24 19:43:34,474 INFO  DataNode.clienttrace (BlockSender.java:sendBlock(738)) - src: /172.21.128.105:50010, dest: /172.21.128.117:41733, bytes: 786432, op: HDFS_READ, cliID: DFSClient_hb_rs_cn117-10.l42scl.hortonworks.com,53868,1406227155459_1689003704_33, offset: 72822272, srvID: 3f80f56f-a6ea-4951-8db6-86b51938d144, blockid: BP-971413386-172.21.128.105-1398117368124:blk_1074926372_1186916, duration: 8220422
2014-07-24 19:43:34,477 INFO  DataNode.clienttrace (BlockSender.java:sendBlock(738)) - src: /172.21.128.105:50010, dest: /172.21.128.113:43672, bytes: 786432, op: HDFS_READ, cliID: DFSClient_hb_rs_cn113-10.l42scl.hortonworks.com,50700,1406227155474_1075922312_33, offset: 86944768, srvID: 3f80f56f-a6ea-4951-8db6-86b51938d144, blockid: BP-971413386-172.21.128.105-1398117368124:blk_1074925960_1186504, duration: 8327499

Looks like future releases of log4j will fix this to be faster - https://issues.apache.org/jira/browse/LOG4J2-163

Issue Links

• breaks: HDFS-8315 Datanode does not log reads