Yiqun Lin created HDFS-12298:
--------------------------------

             Summary: Ozone: Block deletion service floods the log when 
deleting large number of blocks
                 Key: HDFS-12298
                 URL: https://issues.apache.org/jira/browse/HDFS-12298
             Project: Hadoop HDFS
          Issue Type: Sub-task
          Components: ozone
    Affects Versions: HDFS-7240
            Reporter: Yiqun Lin
            Assignee: Yiqun Lin


Block deletion service will floods the log when deleting large number of blocks.
We can write a simple performance test (create a bunch of blocks file meta data 
but doesn't create real files) to reproduce this.
The following are the logs in my local.
{noformat}
2017-08-14 16:20:59,992 [BlockDeletingService#3] INFO  utils.BackgroundService 
(BackgroundService.java:run(103)) - Number of background tasks to execute : 10
2017-08-14 16:20:59,993 [BlockDeletingService#8] INFO  
background.BlockDeletingService (BlockDeletingService.java:call(173))      - 
Container : c555fc61-d4fa-4db8-afed-3837510d301d, To-Delete blocks : 2
2017-08-14 16:20:59,993 [BlockDeletingService#1] INFO  
background.BlockDeletingService (BlockDeletingService.java:call(173))      - 
Container : db7d6a21-e0da-4409-9b72-2ade7f1fad53, To-Delete blocks : 2
2017-08-14 16:20:59,993 [BlockDeletingService#8] INFO  
background.BlockDeletingService (BlockDeletingService.java:lambda$0(177))      
- Deleting block #deleting#c555fc61-d4fa-4db8-afed-3837510d301db89
2017-08-14 16:20:59,993 [BlockDeletingService#1] INFO  
background.BlockDeletingService (BlockDeletingService.java:lambda$0(177))      
- Deleting block #deleting#db7d6a21-e0da-4409-9b72-2ade7f1fad53b89
2017-08-14 16:20:59,997 [BlockDeletingService#2] INFO  
background.BlockDeletingService (BlockDeletingService.java:call(173))      - 
Container : 005b32b3-c383-451b-a780-5a1a284a35a3, To-Delete blocks : 2
2017-08-14 16:20:59,997 [BlockDeletingService#2] INFO  
background.BlockDeletingService (BlockDeletingService.java:lambda$0(177))      
- Deleting block #deleting#005b32b3-c383-451b-a780-5a1a284a35a3b89
2017-08-14 16:20:59,998 [BlockDeletingService#6] INFO  
background.BlockDeletingService (BlockDeletingService.java:call(173))      - 
Container : 9a7a9005-26a6-445e-a887-bee693240cb2, To-Delete blocks : 2
2017-08-14 16:21:00,005 [BlockDeletingService#6] INFO  
background.BlockDeletingService (BlockDeletingService.java:lambda$0(177))      
- Deleting block #deleting#9a7a9005-26a6-445e-a887-bee693240cb2b89
2017-08-14 16:21:00,005 [BlockDeletingService#1] INFO  
background.BlockDeletingService (BlockDeletingService.java:lambda$0(177))      
- Deleting block #deleting#db7d6a21-e0da-4409-9b72-2ade7f1fad53b9
2017-08-14 16:21:00,004 [BlockDeletingService#2] INFO  
background.BlockDeletingService (BlockDeletingService.java:lambda$0(177))      
- Deleting block #deleting#005b32b3-c383-451b-a780-5a1a284a35a3b9
2017-08-14 16:21:00,003 [BlockDeletingService#9] INFO  
background.BlockDeletingService (BlockDeletingService.java:call(173))      - 
Container : 20f37c36-9ea3-46d7-9eaf-c7d3db478870, To-Delete blocks : 2
2017-08-14 16:21:00,007 [BlockDeletingService#9] INFO  
background.BlockDeletingService (BlockDeletingService.java:lambda$0(177))      
- Deleting block #deleting#20f37c36-9ea3-46d7-9eaf-c7d3db478870b89
2017-08-14 16:21:00,002 [BlockDeletingService#5] INFO  
background.BlockDeletingService (BlockDeletingService.java:call(173))      - 
Container : 2b3f389c-d7fd-4990-83b5-02d8d40569e9, To-Delete blocks : 2
2017-08-14 16:21:00,001 [BlockDeletingService#0] INFO  
background.BlockDeletingService (BlockDeletingService.java:call(173))      - 
Container : 6eabd191-54b6-4acd-bdc7-1bb05e81bd68, To-Delete blocks : 2
2017-08-14 16:21:00,000 [BlockDeletingService#4] INFO  
background.BlockDeletingService (BlockDeletingService.java:call(173))      - 
Container : 2e16e39d-c000-41ae-afb3-1a1b3a43e9bc, To-Delete blocks : 2
2017-08-14 16:21:00,009 [BlockDeletingService#4] INFO  
background.BlockDeletingService (BlockDeletingService.java:lambda$0(177))      
- Deleting block #deleting#2e16e39d-c000-41ae-afb3-1a1b3a43e9bcb89
2017-08-14 16:21:00,009 [BlockDeletingService#0] INFO  
background.BlockDeletingService (BlockDeletingService.java:lambda$0(177))      
- Deleting block #deleting#6eabd191-54b6-4acd-bdc7-1bb05e81bd68b89
2017-08-14 16:20:59,999 [BlockDeletingService#7] INFO  
background.BlockDeletingService (BlockDeletingService.java:call(173))      - 
Container : bed13000-8eea-42d2-a538-bd917cbef0fa, To-Delete blocks : 2
2017-08-14 16:21:00,011 [BlockDeletingService#7] INFO  
background.BlockDeletingService (BlockDeletingService.java:lambda$0(177))      
- Deleting block #deleting#bed13000-8eea-42d2-a538-bd917cbef0fab89
2017-08-14 16:21:00,000 [BlockDeletingService#8] INFO  
background.BlockDeletingService (BlockDeletingService.java:lambda$0(177))      
- Deleting block #deleting#c555fc61-d4fa-4db8-afed-3837510d301db9
2017-08-14 16:21:00,008 [BlockDeletingService#5] INFO  
background.BlockDeletingService (BlockDeletingService.java:lambda$0(177))      
- Deleting block #deleting#2b3f389c-d7fd-4990-83b5-02d8d40569e9b89
2017-08-14 16:21:00,023 [BlockDeletingService#0] INFO  
background.BlockDeletingService (BlockDeletingService.java:lambda$0(177))      
- Deleting block #deleting#6eabd191-54b6-4acd-bdc7-1bb05e81bd68b9
2017-08-14 16:21:00,027 [BlockDeletingService#7] INFO  
background.BlockDeletingService (BlockDeletingService.java:lambda$0(177))      
- Deleting block #deleting#bed13000-8eea-42d2-a538-bd917cbef0fab9
2017-08-14 16:21:00,037 [BlockDeletingService#4] INFO  
background.BlockDeletingService (BlockDeletingService.java:lambda$0(177))      
- Deleting block #deleting#2e16e39d-c000-41ae-afb3-1a1b3a43e9bcb9
2017-08-14 16:21:00,041 [BlockDeletingService#5] INFO  
background.BlockDeletingService (BlockDeletingService.java:lambda$0(177))      
- Deleting block #deleting#2b3f389c-d7fd-4990-83b5-02d8d40569e9b9
2017-08-14 16:21:00,055 [BlockDeletingService#6] INFO  
background.BlockDeletingService (BlockDeletingService.java:lambda$0(177))      
- Deleting block #deleting#9a7a9005-26a6-445e-a887-bee693240cb2b9
2017-08-14 16:21:00,056 [BlockDeletingService#9] INFO  
background.BlockDeletingService (BlockDeletingService.java:lambda$0(177))      
- Deleting block #deleting#20f37c36-9ea3-46d7-9eaf-c7d3db478870b9
2017-08-14 16:21:00,139 [BlockDeletingService#7] INFO  
background.BlockDeletingService (BlockDeletingService.java:call(173))      - 
Container : 0448a714-1f06-4e1c-943e-e2726fce3f05, To-Delete blocks : 2
2017-08-14 16:21:00,139 [BlockDeletingService#7] INFO  
background.BlockDeletingService (BlockDeletingService.java:lambda$0(177))      
- Deleting block #deleting#0448a714-1f06-4e1c-943e-e2726fce3f05b89
2017-08-14 16:21:00,143 [BlockDeletingService#7] INFO  
background.BlockDeletingService (BlockDeletingService.java:lambda$0(177))      
- Deleting block #deleting#0448a714-1f06-4e1c-943e-e2726fce3f05b9
2017-08-14 16:21:00,505 [main] INFO  common.TestBlockDeletingService 
(TestBlockDeletingService.java:waitComplete(252))      - Pending deleting 
blocks : 10.
2017-08-14 16:21:01,256 [BlockDeletingService#3] INFO  utils.BackgroundService 
(BackgroundService.java:run(95)) - Running background service : 
BlockDeletingService
2017-08-14 16:21:01,256 [BlockDeletingService#3] INFO  utils.BackgroundService 
(BackgroundService.java:run(103)) - Number of background tasks to execute : 10
{noformat}
We should use {{DEBUG}} or {{TRACE}} level to replace {{INFO}} level here.



--
This message was sent by Atlassian JIRA
(v6.4.14#64029)

---------------------------------------------------------------------
To unsubscribe, e-mail: hdfs-dev-unsubscr...@hadoop.apache.org
For additional commands, e-mail: hdfs-dev-h...@hadoop.apache.org

Reply via email to