[328048.563382] Pid: 0, comm: swapper Tainted: G N 2.6.32.12-0.7-xen #1
[328048.563384] Call Trace:
[328048.563401] [<ffffffff80009af5>] dump_trace+0x65/0x180
[328048.563412] [<ffffffff8034f056>] dump_stack+0x69/0x73
[328048.563420] [<ffffffff8019730b>] blk_update_request+0xbb/0x3d0
[328048.563426] [<ffffffff8019763f>] blk_update_bidi_request+0x1f/0x70
[328048.563432] [<ffffffff80198447>] blk_end_bidi_request+0x27/0x80
[328048.563461] [<ffffffffa00251fa>] scsi_end_request+0x3a/0xc0 [scsi_mod]
[328048.563490] [<ffffffffa00255e9>] scsi_io_completion+0x109/0x4e0 [scsi_mod]
[328048.563505] [<ffffffff8019daf5>] blk_done_softirq+0x85/0xa0
[328048.563512] [<ffffffff80044bbe>] __do_softirq+0xde/0x1a0
[328048.563518] [<ffffffff8000800c>] call_softirq+0x1c/0x30
[328048.563524] [<ffffffff80009635>] do_softirq+0xa5/0xe0
[328048.563530] [<ffffffff80258912>] evtchn_do_upcall+0x212/0x2a0
[328048.563536] [<ffffffff80007a6e>] do_hypervisor_callback+0x1e/0x30
[328048.563543] [<ffffffff800033aa>] 0xffffffff800033aa
[328048.563555] [<ffffffff8000a8f5>] xen_safe_halt+0x15/0x50
[328048.563560] [<ffffffff8000dead>] xen_idle+0x5d/0x70
[328048.563565] [<ffffffff800065cf>] cpu_idle+0x5f/0xa0
[328046.199406] Pid: 0, comm: swapper Tainted: G N 2.6.32.12-0.7-xen #1
[328046.199408] Call Trace:
[328046.199415] [<ffffffff80009af5>] dump_trace+0x65/0x180
[328046.199421] [<ffffffff8034f056>] dump_stack+0x69/0x73
[328046.199428] [<ffffffffa06cfe6c>] flashcache_io_callback+0x33c/0x600 [flashcache]
[328046.199439] [<ffffffff8019730b>] blk_update_request+0xbb/0x3d0
[328046.199444] [<ffffffff8019763f>] blk_update_bidi_request+0x1f/0x70
[328046.199449] [<ffffffff80198447>] blk_end_bidi_request+0x27/0x80
[328046.199454] [<ffffffffa070ab11>] ssd_end_request+0xd1/0x180 [hio]
[328046.199461] [<ffffffff80044376>] tasklet_hi_action+0x96/0x140
[328046.199465] [<ffffffff80044bbe>] __do_softirq+0xde/0x1a0
[328046.199471] [<ffffffff8000800c>] call_softirq+0x1c/0x30
[328046.199475] [<ffffffff80009635>] do_softirq+0xa5/0xe0
[328046.199480] [<ffffffff80258912>] evtchn_do_upcall+0x212/0x2a0
[328046.199485] [<ffffffff80007a6e>] do_hypervisor_callback+0x1e/0x30
[328046.199493] [<ffffffff800033aa>] 0xffffffff800033aa
[328046.199503] [<ffffffff8000a8f5>] xen_safe_halt+0x15/0x50
[328046.199508] [<ffffffff8000dead>] xen_idle+0x5d/0x70
[328046.199512] [<ffffffff800065cf>] cpu_idle+0x5f/0xa0
[328046.199517] [<ffffffff80639be5>] start_kernel+0x2b4/0x383
第一次使用FlashCache设备时，加载/dev/dm-0设备，FlashCache内核调试信息:
[254774.711662] flashcache_read: Got a READ for 0 4096 bytes)
[254774.711665] hash_block: Hash: 0(0)->0
[254774.711667] flashcache_lookup: Cache lookup : dbn 0(8), set = 0
[254774.711672] flashcache_lookup: Cache lookup MISS (INVALID): dbn 0(8), set = 0, index = 0, start_index = 0
[254774.711675] hash_block: Hash: 0(0)->0
[254774.711676] hash_block: Hash: 7(0)->0
[254774.711681] flashcache_read: Cache read: Block 0(4096), index = 0:CACHE MISS & REPLACE
[254774.712037] flashcache_io_callback: flashcache_io_callback: READDISK 0
[254775.184790] flashcache_io_callback: flashcache_io_callback: READFILL 0
[254775.184829] flashcache_read: Got a READ for 8 4096 bytes)
[254775.184831] hash_block: Hash: 8(0)->0
[254775.184834] flashcache_lookup: Cache lookup : dbn 8(8), set = 0
[254775.184838] flashcache_lookup: Cache lookup MISS (INVALID): dbn 8(8), set = 0, index = 1, start_index = 0
[254775.184842] hash_block: Hash: 8(0)->0
[254775.184843] hash_block: Hash: 15(0)->0
[254775.184848] flashcache_read: Cache read: Block 8(4096), index = 1:CACHE MISS & REPLACE
[254775.185253] flashcache_io_callback: flashcache_io_callback: READDISK 1
[254775.188776] flashcache_io_callback: flashcache_io_callback: READFILL 1
[254775.188794] flashcache_read: Got a READ for 16 4096 bytes)
[254775.188797] hash_block: Hash: 16(0)->0
[254775.188799] flashcache_lookup: Cache lookup : dbn 16(8), set = 0
[254775.188803] flashcache_lookup: Cache lookup MISS (INVALID): dbn 16(8), set = 0, index = 2, start_index = 0
[254775.188805] hash_block: Hash: 16(0)->0
[254775.188807] hash_block: Hash: 23(0)->0
[254775.188811] flashcache_read: Cache read: Block 16(4096), index = 2:CACHE MISS & REPLACE
[254775.189097] flashcache_io_callback: flashcache_io_callback: READDISK 2
[254775.192771] flashcache_io_callback: flashcache_io_callback: READFILL 2
[254775.192787] flashcache_read: Got a READ for 24 4096 bytes)
[254775.192789] hash_block: Hash: 24(0)->0
[254775.192791] flashcache_lookup: Cache lookup : dbn 24(8), set = 0
[254775.192795] flashcache_lookup: Cache lookup MISS (INVALID): dbn 24(8), set = 0, index = 3, start_index = 0
[254775.192798] hash_block: Hash: 24(0)->0
[254775.192799] hash_block: Hash: 31(0)->0
[254775.192803] flashcache_read: Cache read: Block 24(4096), index = 3:CACHE MISS & REPLACE
[254775.193073] flashcache_io_callback: flashcache_io_callback: READDISK 3
[254775.196768] flashcache_io_callback: flashcache_io_callback: READFILL 3
[254775.196785] flashcache_read: Got a READ for 32 4096 bytes)
[254775.196787] hash_block: Hash: 32(0)->0
[254775.196789] flashcache_lookup: Cache lookup : dbn 32(8), set = 0
[254775.196793] flashcache_lookup: Cache lookup MISS (INVALID): dbn 32(8), set = 0, index = 4, start_index = 0
[254775.196796] hash_block: Hash: 32(0)->0
[254775.196798] hash_block: Hash: 39(0)->0
[254775.196802] flashcache_read: Cache read: Block 32(4096), index = 4:CACHE MISS & REPLACE
[254775.197071] flashcache_io_callback: flashcache_io_callback: READDISK 4
[254775.200767] flashcache_io_callback: flashcache_io_callback: READFILL 4
[254775.200783] flashcache_read: Got a READ for 40 4096 bytes)
[254775.200785] hash_block: Hash: 40(0)->0
[254775.200787] flashcache_lookup: Cache lookup : dbn 40(8), set = 0
[254775.200791] flashcache_lookup: Cache lookup MISS (INVALID): dbn 40(8), set = 0, index = 5, start_index = 0
[254775.200794] hash_block: Hash: 40(0)->0
[254775.200795] hash_block: Hash: 47(0)->0
[254775.200799] flashcache_read: Cache read: Block 40(4096), index = 5:CACHE MISS & REPLACE
[254775.201071] flashcache_io_callback: flashcache_io_callback: READDISK 5
[254775.204764] flashcache_io_callback: flashcache_io_callback: READFILL 5
[254775.204781] flashcache_read: Got a READ for 48 4096 bytes)
[254775.204783] hash_block: Hash: 48(0)->0
[254775.204785] flashcache_lookup: Cache lookup : dbn 48(8), set = 0
[254775.204789] flashcache_lookup: Cache lookup MISS (INVALID): dbn 48(8), set = 0, index = 6, start_index = 0
[254775.204792] hash_block: Hash: 48(0)->0
[254775.204794] hash_block: Hash: 55(0)->0
[254775.204798] flashcache_read: Cache read: Block 48(4096), index = 6:CACHE MISS & REPLACE
[254775.205073] flashcache_io_callback: flashcache_io_callback: READDISK 6
[254775.208754] flashcache_io_callback: flashcache_io_callback: READFILL 6
[254775.208770] flashcache_read: Got a READ for 56 4096 bytes)
[254775.208772] hash_block: Hash: 56(0)->0
[254775.208774] flashcache_lookup: Cache lookup : dbn 56(8), set = 0
[254775.208778] flashcache_lookup: Cache lookup MISS (INVALID): dbn 56(8), set = 0, index = 7, start_index = 0
[254775.208781] hash_block: Hash: 56(0)->0
[254775.208783] hash_block: Hash: 63(0)->0
[254775.208787] flashcache_read: Cache read: Block 56(4096), index = 7:CACHE MISS & REPLACE
[254775.209053] flashcache_io_callback: flashcache_io_callback: READDISK 7
[254775.212752] flashcache_io_callback: flashcache_io_callback: READFILL 7
[254775.212768] flashcache_read: Got a READ for 64 4096 bytes)
[254775.212771] hash_block: Hash: 64(0)->0
[254775.212773] flashcache_lookup: Cache lookup : dbn 64(8), set = 0
[254775.212776] flashcache_lookup: Cache lookup MISS (INVALID): dbn 64(8), set = 0, index = 8, start_index = 0
[254775.212779] hash_block: Hash: 64(0)->0
[254775.212781] hash_block: Hash: 71(0)->0
[254775.212785] flashcache_read: Cache read: Block 64(4096), index = 8:CACHE MISS & REPLACE
[254775.213053] flashcache_io_callback: flashcache_io_callback: READDISK 8
[254775.216752] flashcache_io_callback: flashcache_io_callback: READFILL 8
[254775.216767] flashcache_read: Got a READ for 72 4096 bytes)
[254775.216770] hash_block: Hash: 72(0)->0
[254775.216772] flashcache_lookup: Cache lookup : dbn 72(8), set = 0
[254775.216775] flashcache_lookup: Cache lookup MISS (INVALID): dbn 72(8), set = 0, index = 9, start_index = 0
[254775.216778] hash_block: Hash: 72(0)->0
[254775.216780] hash_block: Hash: 79(0)->0
[254775.216784] flashcache_read: Cache read: Block 72(4096), index = 9:CACHE MISS & REPLACE
[254775.217051] flashcache_io_callback: flashcache_io_callback: READDISK 9
[254775.220738] flashcache_io_callback: flashcache_io_callback: READFILL 9
[254775.220753] flashcache_read: Got a READ for 80 4096 bytes)
[254775.220755] hash_block: Hash: 80(0)->0
[254775.220757] flashcache_lookup: Cache lookup : dbn 80(8), set = 0
[254775.220761] flashcache_lookup: Cache lookup MISS (INVALID): dbn 80(8), set = 0, index = 10, start_index = 0
[254775.220764] hash_block: Hash: 80(0)->0
[254775.220765] hash_block: Hash: 87(0)->0
[254775.220769] flashcache_read: Cache read: Block 80(4096), index = 10:CACHE MISS & REPLACE
[254775.221053] flashcache_io_callback: flashcache_io_callback: READDISK 10
[254775.224751] flashcache_io_callback: flashcache_io_callback: READFILL 10
[254775.224767] flashcache_read: Got a READ for 88 4096 bytes)
[254775.224769] hash_block: Hash: 88(0)->0
[254775.224771] flashcache_lookup: Cache lookup : dbn 88(8), set = 0
[254775.224775] flashcache_lookup: Cache lookup MISS (INVALID): dbn 88(8), set = 0, index = 11, start_index = 0
[254775.224777] hash_block: Hash: 88(0)->0
[254775.224779] hash_block: Hash: 95(0)->0
[254775.224783] flashcache_read: Cache read: Block 88(4096), index = 11:CACHE MISS & REPLACE
[254775.225057] flashcache_io_callback: flashcache_io_callback: READDISK 11
[254775.228732] flashcache_io_callback: flashcache_io_callback: READFILL 11
[254775.228749] flashcache_read: Got a READ for 96 4096 bytes)
[254775.228752] hash_block: Hash: 96(0)->0
[254775.228754] flashcache_lookup: Cache lookup : dbn 96(8), set = 0
[254775.228757] flashcache_lookup: Cache lookup MISS (INVALID): dbn 96(8), set = 0, index = 12, start_index = 0
[254775.228760] hash_block: Hash: 96(0)->0
[254775.228762] hash_block: Hash: 103(0)->0
[254775.228766] flashcache_read: Cache read: Block 96(4096), index = 12:CACHE MISS & REPLACE
[254775.229035] flashcache_io_callback: flashcache_io_callback: READDISK 12
[254775.232729] flashcache_io_callback: flashcache_io_callback: READFILL 12
[254775.232743] flashcache_read: Got a READ for 104 4096 bytes)
[254775.232745] hash_block: Hash: 104(0)->0
[254775.232747] flashcache_lookup: Cache lookup : dbn 104(8), set = 0
[254775.232751] flashcache_lookup: Cache lookup MISS (INVALID): dbn 104(8), set = 0, index = 13, start_index = 0
[254775.232754] hash_block: Hash: 104(0)->0
[254775.232756] hash_block: Hash: 111(0)->0
[254775.232760] flashcache_read: Cache read: Block 104(4096), index = 13:CACHE MISS & REPLACE
[254775.233034] flashcache_io_callback: flashcache_io_callback: READDISK 13
[254775.236745] flashcache_io_callback: flashcache_io_callback: READFILL 13
[254775.236761] flashcache_read: Got a READ for 112 4096 bytes)
[254775.236763] hash_block: Hash: 112(0)->0
[254775.236765] flashcache_lookup: Cache lookup : dbn 112(8), set = 0
[254775.236769] flashcache_lookup: Cache lookup MISS (INVALID): dbn 112(8), set = 0, index = 14, start_index = 0
[254775.236772] hash_block: Hash: 112(0)->0
[254775.236774] hash_block: Hash: 119(0)->0
[254775.236777] flashcache_read: Cache read: Block 112(4096), index = 14:CACHE MISS & REPLACE
[254775.237043] flashcache_io_callback: flashcache_io_callback: READDISK 14
[254775.240723] flashcache_io_callback: flashcache_io_callback: READFILL 14
[254775.240739] flashcache_read: Got a READ for 120 4096 bytes)
[254775.240742] hash_block: Hash: 120(0)->0
[254775.240744] flashcache_lookup: Cache lookup : dbn 120(8), set = 0
[254775.240747] flashcache_lookup: Cache lookup MISS (INVALID): dbn 120(8), set = 0, index = 15, start_index = 0
[254775.240750] hash_block: Hash: 120(0)->0
[254775.240752] hash_block: Hash: 127(0)->0
[254775.240756] flashcache_read: Cache read: Block 120(4096), index = 15:CACHE MISS & REPLACE
[254775.241040] flashcache_io_callback: flashcache_io_callback: READDISK 15
[254775.244745] flashcache_io_callback: flashcache_io_callback: READFILL 15
[254775.244760] flashcache_read: Got a READ for 128 4096 bytes)
[254775.244763] hash_block: Hash: 128(0)->0
[254775.244765] flashcache_lookup: Cache lookup : dbn 128(8), set = 0
[254775.244768] flashcache_lookup: Cache lookup MISS (INVALID): dbn 128(8), set = 0, index = 16, start_index = 0
[254775.244771] hash_block: Hash: 128(0)->0
[254775.244773] hash_block: Hash: 135(0)->0
[254775.244777] flashcache_read: Cache read: Block 128(4096), index = 16:CACHE MISS & REPLACE
[254775.245046] flashcache_io_callback: flashcache_io_callback: READDISK 16
[254775.248719] flashcache_io_callback: flashcache_io_callback: READFILL 16
[254775.248735] flashcache_read: Got a READ for 136 4096 bytes)
[254775.248737] hash_block: Hash: 136(0)->0
[254775.248739] flashcache_lookup: Cache lookup : dbn 136(8), set = 0
[254775.248743] flashcache_lookup: Cache lookup MISS (INVALID): dbn 136(8), set = 0, index = 17, start_index = 0
[254775.248746] hash_block: Hash: 136(0)->0
[254775.248748] hash_block: Hash: 143(0)->0
[254775.248752] flashcache_read: Cache read: Block 136(4096), index = 17:CACHE MISS & REPLACE
[254775.249020] flashcache_io_callback: flashcache_io_callback: READDISK 17
[254775.252714] flashcache_io_callback: flashcache_io_callback: READFILL 17
[254775.252730] flashcache_read: Got a READ for 144 4096 bytes)
[254775.252733] hash_block: Hash: 144(0)->0
[254775.252735] flashcache_lookup: Cache lookup : dbn 144(8), set = 0
[254775.252738] flashcache_lookup: Cache lookup MISS (INVALID): dbn 144(8), set = 0, index = 18, start_index = 0
[254775.252741] hash_block: Hash: 144(0)->0
[254775.252743] hash_block: Hash: 151(0)->0
[254775.252747] flashcache_read: Cache read: Block 144(4096), index = 18:CACHE MISS & REPLACE
[254775.253016] flashcache_io_callback: flashcache_io_callback: READDISK 18
[254775.256738] flashcache_io_callback: flashcache_io_callback: READFILL 18
[254775.256754] flashcache_read: Got a READ for 152 4096 bytes)
[254775.256756] hash_block: Hash: 152(0)->0
[254775.256758] flashcache_lookup: Cache lookup : dbn 152(8), set = 0
[254775.256762] flashcache_lookup: Cache lookup MISS (INVALID): dbn 152(8), set = 0, index = 19, start_index = 0
[254775.256765] hash_block: Hash: 152(0)->0
[254775.256766] hash_block: Hash: 159(0)->0
[254775.256770] flashcache_read: Cache read: Block 152(4096), index = 19:CACHE MISS & REPLACE
[254775.257052] flashcache_io_callback: flashcache_io_callback: READDISK 19
[254775.260721] flashcache_io_callback: flashcache_io_callback: READFILL 19
[254775.260736] flashcache_read: Got a READ for 160 4096 bytes)
[254775.260738] hash_block: Hash: 160(0)->0
[254775.260740] flashcache_lookup: Cache lookup : dbn 160(8), set = 0
[254775.260744] flashcache_lookup: Cache lookup MISS (INVALID): dbn 160(8), set = 0, index = 20, start_index = 0
[254775.260747] hash_block: Hash: 160(0)->0
[254775.260748] hash_block: Hash: 167(0)->0
[254775.260752] flashcache_read: Cache read: Block 160(4096), index = 20:CACHE MISS & REPLACE
[254775.261023] flashcache_io_callback: flashcache_io_callback: READDISK 20
[254775.264734] flashcache_io_callback: flashcache_io_callback: READFILL 20
[254775.264750] flashcache_read: Got a READ for 168 4096 bytes)
[254775.264753] hash_block: Hash: 168(0)->0
[254775.264755] flashcache_lookup: Cache lookup : dbn 168(8), set = 0
[254775.264759] flashcache_lookup: Cache lookup MISS (INVALID): dbn 168(8), set = 0, index = 21, start_index = 0
[254775.264761] hash_block: Hash: 168(0)->0
[254775.264763] hash_block: Hash: 175(0)->0
[254775.264767] flashcache_read: Cache read: Block 168(4096), index = 21:CACHE MISS & REPLACE
[254775.265034] flashcache_io_callback: flashcache_io_callback: READDISK 21
[254775.268694] flashcache_io_callback: flashcache_io_callback: READFILL 21
[254775.268714] flashcache_read: Got a READ for 176 4096 bytes)
[254775.268717] hash_block: Hash: 176(0)->0
[254775.268719] flashcache_lookup: Cache lookup : dbn 176(8), set = 0
[254775.268723] flashcache_lookup: Cache lookup MISS (INVALID): dbn 176(8), set = 0, index = 22, start_index = 0
[254775.268725] hash_block: Hash: 176(0)->0
[254775.268727] hash_block: Hash: 183(0)->0
[254775.268731] flashcache_read: Cache read: Block 176(4096), index = 22:CACHE MISS & REPLACE
[254775.269090] flashcache_io_callback: flashcache_io_callback: READDISK 22
[254775.272729] flashcache_io_callback: flashcache_io_callback: READFILL 22
[254775.272745] flashcache_read: Got a READ for 184 4096 bytes)
[254775.272747] hash_block: Hash: 184(0)->0
[254775.272749] flashcache_lookup: Cache lookup : dbn 184(8), set = 0
[254775.272753] flashcache_lookup: Cache lookup MISS (INVALID): dbn 184(8), set = 0, index = 23, start_index = 0
[254775.272756] hash_block: Hash: 184(0)->0
[254775.272758] hash_block: Hash: 191(0)->0
[254775.272762] flashcache_read: Cache read: Block 184(4096), index = 23:CACHE MISS & REPLACE
[254775.299790] flashcache_io_callback: flashcache_io_callback: READDISK 23
[254775.304678] flashcache_io_callback: flashcache_io_callback: READFILL 23
[254775.304697] flashcache_read: Got a READ for 192 4096 bytes)
[254775.304700] hash_block: Hash: 192(0)->0
[254775.304702] flashcache_lookup: Cache lookup : dbn 192(8), set = 0
[254775.304706] flashcache_lookup: Cache lookup MISS (INVALID): dbn 192(8), set = 0, index = 24, start_index = 0
[254775.304708] hash_block: Hash: 192(0)->0
[254775.304710] hash_block: Hash: 199(0)->0
[254775.304714] flashcache_read: Cache read: Block 192(4096), index = 24:CACHE MISS & REPLACE
[254775.305017] flashcache_io_callback: flashcache_io_callback: READDISK 24
[254775.308702] flashcache_io_callback: flashcache_io_callback: READFILL 24
[254775.308719] flashcache_read: Got a READ for 200 4096 bytes)
[254775.308721] hash_block: Hash: 200(0)->0
[254775.308723] flashcache_lookup: Cache lookup : dbn 200(8), set = 0
[254775.308727] flashcache_lookup: Cache lookup MISS (INVALID): dbn 200(8), set = 0, index = 25, start_index = 0
[254775.308730] hash_block: Hash: 200(0)->0
[254775.308732] hash_block: Hash: 207(0)->0
[254775.308736] flashcache_read: Cache read: Block 200(4096), index = 25:CACHE MISS & REPLACE
[254775.311319] flashcache_io_callback: flashcache_io_callback: READDISK 25
[254775.312674] flashcache_io_callback: flashcache_io_callback: READFILL 25
[254775.312689] flashcache_read: Got a READ for 208 4096 bytes)
[254775.312692] hash_block: Hash: 208(0)->0
[254775.312694] flashcache_lookup: Cache lookup : dbn 208(8), set = 0
[254775.312697] flashcache_lookup: Cache lookup MISS (INVALID): dbn 208(8), set = 0, index = 26, start_index = 0
[254775.312700] hash_block: Hash: 208(0)->0
[254775.312702] hash_block: Hash: 215(0)->0
[254775.312706] flashcache_read: Cache read: Block 208(4096), index = 26:CACHE MISS & REPLACE
[254775.315200] flashcache_io_callback: flashcache_io_callback: READDISK 26
[254775.316672] flashcache_io_callback: flashcache_io_callback: READFILL 26
[254775.316687] flashcache_read: Got a READ for 216 4096 bytes)
[254775.316689] hash_block: Hash: 216(0)->0
[254775.316691] flashcache_lookup: Cache lookup : dbn 216(8), set = 0
[254775.316695] flashcache_lookup: Cache lookup MISS (INVALID): dbn 216(8), set = 0, index = 27, start_index = 0
[254775.316698] hash_block: Hash: 216(0)->0
[254775.316700] hash_block: Hash: 223(0)->0
[254775.316704] flashcache_read: Cache read: Block 216(4096), index = 27:CACHE MISS & REPLACE
[254775.318699] flashcache_io_callback: flashcache_io_callback: READDISK 27
[254775.320672] flashcache_io_callback: flashcache_io_callback: READFILL 27
[254775.320686] flashcache_read: Got a READ for 224 4096 bytes)
[254775.320689] hash_block: Hash: 224(0)->0
[254775.320691] flashcache_lookup: Cache lookup : dbn 224(8), set = 0
[254775.320695] flashcache_lookup: Cache lookup MISS (INVALID): dbn 224(8), set = 0, index = 28, start_index = 0
[254775.320698] hash_block: Hash: 224(0)->0
[254775.320699] hash_block: Hash: 231(0)->0
[254775.320703] flashcache_read: Cache read: Block 224(4096), index = 28:CACHE MISS & REPLACE
[254775.322169] flashcache_io_callback: flashcache_io_callback: READDISK 28
[254775.324672] flashcache_io_callback: flashcache_io_callback: READFILL 28
[254775.324687] flashcache_read: Got a READ for 232 4096 bytes)
[254775.324689] hash_block: Hash: 232(0)->0
[254775.324691] flashcache_lookup: Cache lookup : dbn 232(8), set = 0
[254775.324695] flashcache_lookup: Cache lookup MISS (INVALID): dbn 232(8), set = 0, index = 29, start_index = 0
[254775.324698] hash_block: Hash: 232(0)->0
[254775.324700] hash_block: Hash: 239(0)->0
[254775.324704] flashcache_read: Cache read: Block 232(4096), index = 29:CACHE MISS & REPLACE
[254775.325718] flashcache_io_callback: flashcache_io_callback: READDISK 29
[254775.328653] flashcache_io_callback: flashcache_io_callback: READFILL 29
[254775.328668] flashcache_read: Got a READ for 240 4096 bytes)
[254775.328670] hash_block: Hash: 240(0)->0
[254775.328672] flashcache_lookup: Cache lookup : dbn 240(8), set = 0
[254775.328676] flashcache_lookup: Cache lookup MISS (INVALID): dbn 240(8), set = 0, index = 30, start_index = 0
[254775.328679] hash_block: Hash: 240(0)->0
[254775.328680] hash_block: Hash: 247(0)->0
[254775.328684] flashcache_read: Cache read: Block 240(4096), index = 30:CACHE MISS & REPLACE
[254775.329357] flashcache_io_callback: flashcache_io_callback: READDISK 30
[254775.332669] flashcache_io_callback: flashcache_io_callback: READFILL 30
[254775.332684] flashcache_read: Got a READ for 248 4096 bytes)
[254775.332686] hash_block: Hash: 248(0)->0
[254775.332688] flashcache_lookup: Cache lookup : dbn 248(8), set = 0
[254775.332692] flashcache_lookup: Cache lookup MISS (INVALID): dbn 248(8), set = 0, index = 31, start_index = 0
[254775.332695] hash_block: Hash: 248(0)->0
[254775.332697] hash_block: Hash: 255(0)->0
[254775.332701] flashcache_read: Cache read: Block 248(4096), index = 31:CACHE MISS & REPLACE
[254775.333380] flashcache_io_callback: flashcache_io_callback: READDISK 31
[254775.336668] flashcache_io_callback: flashcache_io_callback: READFILL 31
[254775.336982] flashcache_read: Got a READ for 8216 4096 bytes)
[254775.336985] hash_block: Hash: 8216(2)->2
[254775.336987] flashcache_lookup: Cache lookup : dbn 8216(8), set = 2
[254775.336992] flashcache_lookup: Cache lookup MISS (INVALID): dbn 8216(8), set = 2, index = 1024, start_index = 1024
[254775.336995] hash_block: Hash: 8216(2)->2
[254775.336997] hash_block: Hash: 8223(2)->2
[254775.337001] flashcache_read: Cache read: Block 8216(4096), index = 1024:CACHE MISS & REPLACE
[254775.343965] flashcache_io_callback: flashcache_io_callback: READDISK 1024
[254775.348644] flashcache_io_callback: flashcache_io_callback: READFILL 1024
[254775.348669] flashcache_read: Got a READ for 511709200 4096 bytes)
[254775.348671] hash_block: Hash: 511709200(124929)->124929
[254775.348674] flashcache_lookup: Cache lookup : dbn 511709200(8), set = 124929
[254775.348679] flashcache_lookup: Cache lookup MISS (INVALID): dbn 511709200(8), set = 124929, index = 63963648, start_index = 63963648
[254775.348682] hash_block: Hash: 511709200(124929)->124929
[254775.348684] hash_block: Hash: 511709207(124929)->124929
[254775.348688] flashcache_read: Cache read: Block 511709200(4096), index = 63963648:CACHE MISS & REPLACE
[254775.359424] flashcache_io_callback: flashcache_io_callback: READDISK 63963648
[254775.364640] flashcache_io_callback: flashcache_io_callback: READFILL 63963648
[254775.337558] kjournald starting. Commit interval 15 seconds
[254775.364749] EXT3-fs warning: maximal mount count reached, running e2fsck is recommended
[254775.364842] hash_block: Hash: 0(0)->0
[254775.364844] flashcache_lookup: Cache lookup : dbn 0(8), set = 0
[254775.364847] flashcache_lookup: Cache lookup MISS (INVALID): dbn 0(8), set = 0, index = 32, start_index = 0
[254775.364850] hash_block: Hash: 0(0)->0
[254775.364852] hash_block: Hash: 7(0)->0
[254775.364854] flashcache_inval_block_set: Cache invalidate (!BUSY): Block 0 2
[254775.364882] flashcache_io_callback: flashcache_io_callback: WRITECACHE 32
[254775.368641] EXT3 FS on dm-0, internal journal
[254775.368647] EXT3-fs: mounted filesystem with ordered data mode.
linux:~/FlashCache/facebook-flashcache-0da66de/src #
重新加载FlashCache块设备分区日志：
[326800.275884] hash_block: Hash: 2(0)->0
[326800.275887] hash_block: Hash: 3(0)->0
[326800.276634] hash_block: Hash: 2(0)->0
[326800.276636] hash_block: Hash: 3(0)->0
[326800.276692] flashcache_read: Got a READ for 0 4096 bytes)
[326800.276694] hash_block: Hash: 0(0)->0
[326800.276697] flashcache_lookup: Cache lookup : dbn 0(8), set = 0
[326800.276701] flashcache_lookup: Cache lookup MISS (INVALID): dbn 0(8), set = 0, index = 0, start_index = 0
[326800.276704] hash_block: Hash: 0(0)->0
[326800.276706] hash_block: Hash: 7(0)->0
[326800.276710] flashcache_read: Cache read: Block 0(4096), index = 0:CACHE MISS & REPLACE
[326800.277004] flashcache_io_callback: flashcache_io_callback: READDISK 0
[326799.632216] flashcache_io_callback: flashcache_io_callback: READFILL 0
[326799.632244] flashcache_read: Got a READ for 8 4096 bytes)
[326799.632246] hash_block: Hash: 8(0)->0
[326799.632248] flashcache_lookup: Cache lookup : dbn 8(8), set = 0
[326799.632252] flashcache_lookup: Cache lookup MISS (INVALID): dbn 8(8), set = 0, index = 1, start_index = 0
[326799.632255] hash_block: Hash: 8(0)->0
[326799.632257] hash_block: Hash: 15(0)->0
[326799.632261] flashcache_read: Cache read: Block 8(4096), index = 1:CACHE MISS & REPLACE
[326799.632555] flashcache_io_callback: flashcache_io_callback: READDISK 1
[326799.636235] flashcache_io_callback: flashcache_io_callback: READFILL 1
[326799.636251] flashcache_read: Got a READ for 16 4096 bytes)
[326799.636254] hash_block: Hash: 16(0)->0
[326799.636256] flashcache_lookup: Cache lookup : dbn 16(8), set = 0
[326799.636260] flashcache_lookup: Cache lookup MISS (INVALID): dbn 16(8), set = 0, index = 2, start_index = 0
[326799.636262] hash_block: Hash: 16(0)->0
[326799.636264] hash_block: Hash: 23(0)->0
[326799.636268] flashcache_read: Cache read: Block 16(4096), index = 2:CACHE MISS & REPLACE
[326799.636536] flashcache_io_callback: flashcache_io_callback: READDISK 2
[326799.640195] flashcache_io_callback: flashcache_io_callback: READFILL 2
[326799.640216] flashcache_read: Got a READ for 24 4096 bytes)
[326799.640218] hash_block: Hash: 24(0)->0
[326799.640220] flashcache_lookup: Cache lookup : dbn 24(8), set = 0
[326799.640224] flashcache_lookup: Cache lookup MISS (INVALID): dbn 24(8), set = 0, index = 3, start_index = 0
[326799.640227] hash_block: Hash: 24(0)->0
[326799.640229] hash_block: Hash: 31(0)->0
[326799.640232] flashcache_read: Cache read: Block 24(4096), index = 3:CACHE MISS & REPLACE
[326799.640501] flashcache_io_callback: flashcache_io_callback: READDISK 3
[326799.644196] flashcache_io_callback: flashcache_io_callback: READFILL 3
[326799.644216] flashcache_read: Got a READ for 32 4096 bytes)
[326799.644219] hash_block: Hash: 32(0)->0
[326799.644221] flashcache_lookup: Cache lookup : dbn 32(8), set = 0
[326799.644225] flashcache_lookup: Cache lookup MISS (INVALID): dbn 32(8), set = 0, index = 4, start_index = 0
[326799.644227] hash_block: Hash: 32(0)->0
[326799.644229] hash_block: Hash: 39(0)->0
[326799.644233] flashcache_read: Cache read: Block 32(4096), index = 4:CACHE MISS & REPLACE
[326799.644505] flashcache_io_callback: flashcache_io_callback: READDISK 4
[326799.648228] flashcache_io_callback: flashcache_io_callback: READFILL 4
[326799.648244] flashcache_read: Got a READ for 40 4096 bytes)
[326799.648246] hash_block: Hash: 40(0)->0
[326799.648248] flashcache_lookup: Cache lookup : dbn 40(8), set = 0
[326799.648252] flashcache_lookup: Cache lookup MISS (INVALID): dbn 40(8), set = 0, index = 5, start_index = 0
[326799.648255] hash_block: Hash: 40(0)->0
[326799.648257] hash_block: Hash: 47(0)->0
[326799.648261] flashcache_read: Cache read: Block 40(4096), index = 5:CACHE MISS & REPLACE
[326799.648533] flashcache_io_callback: flashcache_io_callback: READDISK 5
[326799.652186] flashcache_io_callback: flashcache_io_callback: READFILL 5
[326799.652208] flashcache_read: Got a READ for 48 4096 bytes)
[326799.652210] hash_block: Hash: 48(0)->0
[326799.652212] flashcache_lookup: Cache lookup : dbn 48(8), set = 0
[326799.652216] flashcache_lookup: Cache lookup MISS (INVALID): dbn 48(8), set = 0, index = 6, start_index = 0
[326799.652219] hash_block: Hash: 48(0)->0
[326799.652221] hash_block: Hash: 55(0)->0
[326799.652225] flashcache_read: Cache read: Block 48(4096), index = 6:CACHE MISS & REPLACE
[326799.652506] flashcache_io_callback: flashcache_io_callback: READDISK 6
[326799.656223] flashcache_io_callback: flashcache_io_callback: READFILL 6
[326799.656238] flashcache_read: Got a READ for 56 4096 bytes)
[326799.656240] hash_block: Hash: 56(0)->0
[326799.656242] flashcache_lookup: Cache lookup : dbn 56(8), set = 0
[326799.656246] flashcache_lookup: Cache lookup MISS (INVALID): dbn 56(8), set = 0, index = 7, start_index = 0
[326799.656249] hash_block: Hash: 56(0)->0
[326799.656250] hash_block: Hash: 63(0)->0
[326799.656254] flashcache_read: Cache read: Block 56(4096), index = 7:CACHE MISS & REPLACE
[326799.656540] flashcache_io_callback: flashcache_io_callback: READDISK 7
[326799.660180] flashcache_io_callback: flashcache_io_callback: READFILL 7
[326799.660196] flashcache_read: Got a READ for 64 4096 bytes)
[326799.660202] hash_block: Hash: 64(0)->0
[326799.660204] flashcache_lookup: Cache lookup : dbn 64(8), set = 0
[326799.660207] flashcache_lookup: Cache lookup MISS (INVALID): dbn 64(8), set = 0, index = 8, start_index = 0
[326799.660210] hash_block: Hash: 64(0)->0
[326799.660212] hash_block: Hash: 71(0)->0
[326799.660216] flashcache_read: Cache read: Block 64(4096), index = 8:CACHE MISS & REPLACE
[326799.660484] flashcache_io_callback: flashcache_io_callback: READDISK 8
[326799.664176] flashcache_io_callback: flashcache_io_callback: READFILL 8
[326799.664202] flashcache_read: Got a READ for 72 4096 bytes)
[326799.664205] hash_block: Hash: 72(0)->0
[326799.664207] flashcache_lookup: Cache lookup : dbn 72(8), set = 0
[326799.664211] flashcache_lookup: Cache lookup MISS (INVALID): dbn 72(8), set = 0, index = 9, start_index = 0
[326799.664214] hash_block: Hash: 72(0)->0
[326799.664215] hash_block: Hash: 79(0)->0
[326799.664219] flashcache_read: Cache read: Block 72(4096), index = 9:CACHE MISS & REPLACE
[326799.664487] flashcache_io_callback: flashcache_io_callback: READDISK 9
[326799.668217] flashcache_io_callback: flashcache_io_callback: READFILL 9
[326799.668233] flashcache_read: Got a READ for 80 4096 bytes)
[326799.668235] hash_block: Hash: 80(0)->0
[326799.668237] flashcache_lookup: Cache lookup : dbn 80(8), set = 0
[326799.668241] flashcache_lookup: Cache lookup MISS (INVALID): dbn 80(8), set = 0, index = 10, start_index = 0
[326799.668244] hash_block: Hash: 80(0)->0
[326799.668246] hash_block: Hash: 87(0)->0
[326799.668250] flashcache_read: Cache read: Block 80(4096), index = 10:CACHE MISS & REPLACE
[326799.668519] flashcache_io_callback: flashcache_io_callback: READDISK 10
[326799.672163] flashcache_io_callback: flashcache_io_callback: READFILL 10
[326799.672178] flashcache_read: Got a READ for 88 4096 bytes)
[326799.672181] hash_block: Hash: 88(0)->0
[326799.672183] flashcache_lookup: Cache lookup : dbn 88(8), set = 0
[326799.672189] flashcache_lookup: Cache lookup MISS (INVALID): dbn 88(8), set = 0, index = 11, start_index = 0
[326799.672192] hash_block: Hash: 88(0)->0
[326799.672194] hash_block: Hash: 95(0)->0
[326799.672202] flashcache_read: Cache read: Block 88(4096), index = 11:CACHE MISS & REPLACE
[326799.672486] flashcache_io_callback: flashcache_io_callback: READDISK 11
[326799.676164] flashcache_io_callback: flashcache_io_callback: READFILL 11
[326799.676178] flashcache_read: Got a READ for 96 4096 bytes)
[326799.676180] hash_block: Hash: 96(0)->0
[326799.676184] flashcache_lookup: Cache lookup : dbn 96(8), set = 0
[326799.676188] flashcache_lookup: Cache lookup MISS (INVALID): dbn 96(8), set = 0, index = 12, start_index = 0
[326799.676191] hash_block: Hash: 96(0)->0
[326799.676192] hash_block: Hash: 103(0)->0
[326799.676200] flashcache_read: Cache read: Block 96(4096), index = 12:CACHE MISS & REPLACE
[326799.676468] flashcache_io_callback: flashcache_io_callback: READDISK 12
[326799.680176] flashcache_io_callback: flashcache_io_callback: READFILL 12
[326799.680197] flashcache_read: Got a READ for 104 4096 bytes)
[326799.680199] hash_block: Hash: 104(0)->0
[326799.680201] flashcache_lookup: Cache lookup : dbn 104(8), set = 0
[326799.680205] flashcache_lookup: Cache lookup MISS (INVALID): dbn 104(8), set = 0, index = 13, start_index = 0
[326799.680208] hash_block: Hash: 104(0)->0
[326799.680210] hash_block: Hash: 111(0)->0
[326799.680214] flashcache_read: Cache read: Block 104(4096), index = 13:CACHE MISS & REPLACE
[326799.680494] flashcache_io_callback: flashcache_io_callback: READDISK 13
[326799.684157] flashcache_io_callback: flashcache_io_callback: READFILL 13
[326799.684178] flashcache_read: Got a READ for 112 4096 bytes)
[326799.684183] hash_block: Hash: 112(0)->0
[326799.684185] flashcache_lookup: Cache lookup : dbn 112(8), set = 0
[326799.684189] flashcache_lookup: Cache lookup MISS (INVALID): dbn 112(8), set = 0, index = 14, start_index = 0
[326799.684192] hash_block: Hash: 112(0)->0
[326799.684194] hash_block: Hash: 119(0)->0
[326799.684198] flashcache_read: Cache read: Block 112(4096), index = 14:CACHE MISS & REPLACE
[326799.684467] flashcache_io_callback: flashcache_io_callback: READDISK 14
[326799.688150] flashcache_io_callback: flashcache_io_callback: READFILL 14
[326799.688164] flashcache_read: Got a READ for 120 4096 bytes)
[326799.688167] hash_block: Hash: 120(0)->0
[326799.688169] flashcache_lookup: Cache lookup : dbn 120(8), set = 0
[326799.688174] flashcache_lookup: Cache lookup MISS (INVALID): dbn 120(8), set = 0, index = 15, start_index = 0
[326799.688177] hash_block: Hash: 120(0)->0
[326799.688179] hash_block: Hash: 127(0)->0
[326799.688186] flashcache_read: Cache read: Block 120(4096), index = 15:CACHE MISS & REPLACE
[326799.688468] flashcache_io_callback: flashcache_io_callback: READDISK 15
[326799.692148] flashcache_io_callback: flashcache_io_callback: READFILL 15
[326799.692164] flashcache_read: Got a READ for 128 4096 bytes)
[326799.692166] hash_block: Hash: 128(0)->0
[326799.692168] flashcache_lookup: Cache lookup : dbn 128(8), set = 0
[326799.692175] flashcache_lookup: Cache lookup MISS (INVALID): dbn 128(8), set = 0, index = 16, start_index = 0
[326799.692178] hash_block: Hash: 128(0)->0
[326799.692179] hash_block: Hash: 135(0)->0
[326799.692187] flashcache_read: Cache read: Block 128(4096), index = 16:CACHE MISS & REPLACE
[326799.692469] flashcache_io_callback: flashcache_io_callback: READDISK 16
[326799.696149] flashcache_io_callback: flashcache_io_callback: READFILL 16
[326799.696169] flashcache_read: Got a READ for 136 4096 bytes)
[326799.696175] hash_block: Hash: 136(0)->0
[326799.696178] flashcache_lookup: Cache lookup : dbn 136(8), set = 0
[326799.696182] flashcache_lookup: Cache lookup MISS (INVALID): dbn 136(8), set = 0, index = 17, start_index = 0
[326799.696185] hash_block: Hash: 136(0)->0
[326799.696186] hash_block: Hash: 143(0)->0
[326799.696190] flashcache_read: Cache read: Block 136(4096), index = 17:CACHE MISS & REPLACE
[326799.696474] flashcache_io_callback: flashcache_io_callback: READDISK 17
[326799.700141] flashcache_io_callback: flashcache_io_callback: READFILL 17
[326799.700155] flashcache_read: Got a READ for 144 4096 bytes)
[326799.700158] hash_block: Hash: 144(0)->0
[326799.700160] flashcache_lookup: Cache lookup : dbn 144(8), set = 0
[326799.700163] flashcache_lookup: Cache lookup MISS (INVALID): dbn 144(8), set = 0, index = 18, start_index = 0
[326799.700168] hash_block: Hash: 144(0)->0
[326799.700170] hash_block: Hash: 151(0)->0
[326799.700177] flashcache_read: Cache read: Block 144(4096), index = 18:CACHE MISS & REPLACE
[326799.700446] flashcache_io_callback: flashcache_io_callback: READDISK 18
[326799.704137] flashcache_io_callback: flashcache_io_callback: READFILL 18
[326799.704152] flashcache_read: Got a READ for 152 4096 bytes)
[326799.704155] hash_block: Hash: 152(0)->0
[326799.704157] flashcache_lookup: Cache lookup : dbn 152(8), set = 0
[326799.704160] flashcache_lookup: Cache lookup MISS (INVALID): dbn 152(8), set = 0, index = 19, start_index = 0
[326799.704166] hash_block: Hash: 152(0)->0
[326799.704168] hash_block: Hash: 159(0)->0
[326799.704175] flashcache_read: Cache read: Block 152(4096), index = 19:CACHE MISS & REPLACE
[326799.704518] flashcache_io_callback: flashcache_io_callback: READDISK 19
[326799.708136] flashcache_io_callback: flashcache_io_callback: READFILL 19
[326799.708159] flashcache_read: Got a READ for 160 4096 bytes)
[326799.708166] hash_block: Hash: 160(0)->0
[326799.708169] flashcache_lookup: Cache lookup : dbn 160(8), set = 0
[326799.708173] flashcache_lookup: Cache lookup MISS (INVALID): dbn 160(8), set = 0, index = 20, start_index = 0
[326799.708176] hash_block: Hash: 160(0)->0
[326799.708177] hash_block: Hash: 167(0)->0
[326799.708182] flashcache_read: Cache read: Block 160(4096), index = 20:CACHE MISS & REPLACE
[326799.729448] flashcache_io_callback: flashcache_io_callback: READDISK 20
[326799.732152] flashcache_io_callback: flashcache_io_callback: READFILL 20
[326799.732174] flashcache_read: Got a READ for 168 4096 bytes)
[326799.732177] hash_block: Hash: 168(0)->0
[326799.732179] flashcache_lookup: Cache lookup : dbn 168(8), set = 0
[326799.732183] flashcache_lookup: Cache lookup MISS (INVALID): dbn 168(8), set = 0, index = 21, start_index = 0
[326799.732186] hash_block: Hash: 168(0)->0
[326799.732187] hash_block: Hash: 175(0)->0
[326799.732192] flashcache_read: Cache read: Block 168(4096), index = 21:CACHE MISS & REPLACE
[326799.734238] flashcache_io_callback: flashcache_io_callback: READDISK 21
[326799.740120] flashcache_io_callback: flashcache_io_callback: READFILL 21
[326799.740136] flashcache_read: Got a READ for 176 4096 bytes)
[326799.740139] hash_block: Hash: 176(0)->0
[326799.740141] flashcache_lookup: Cache lookup : dbn 176(8), set = 0
[326799.740145] flashcache_lookup: Cache lookup MISS (INVALID): dbn 176(8), set = 0, index = 22, start_index = 0
[326799.740147] hash_block: Hash: 176(0)->0
[326799.740149] hash_block: Hash: 183(0)->0
[326799.740153] flashcache_read: Cache read: Block 176(4096), index = 22:CACHE MISS & REPLACE
[326799.740842] flashcache_io_callback: flashcache_io_callback: READDISK 22
[326799.744123] flashcache_io_callback: flashcache_io_callback: READFILL 22
[326799.744138] flashcache_read: Got a READ for 184 4096 bytes)
[326799.744141] hash_block: Hash: 184(0)->0
[326799.744143] flashcache_lookup: Cache lookup : dbn 184(8), set = 0
[326799.744147] flashcache_lookup: Cache lookup MISS (INVALID): dbn 184(8), set = 0, index = 23, start_index = 0
[326799.744150] hash_block: Hash: 184(0)->0
[326799.744152] hash_block: Hash: 191(0)->0
[326799.744155] flashcache_read: Cache read: Block 184(4096), index = 23:CACHE MISS & REPLACE
[326799.744851] flashcache_io_callback: flashcache_io_callback: READDISK 23
[326799.748121] flashcache_io_callback: flashcache_io_callback: READFILL 23
[326799.748139] flashcache_read: Got a READ for 192 4096 bytes)
[326799.748142] hash_block: Hash: 192(0)->0
[326799.748144] flashcache_lookup: Cache lookup : dbn 192(8), set = 0
[326799.748148] flashcache_lookup: Cache lookup MISS (INVALID): dbn 192(8), set = 0, index = 24, start_index = 0
[326799.748151] hash_block: Hash: 192(0)->0
[326799.748152] hash_block: Hash: 199(0)->0
[326799.748156] flashcache_read: Cache read: Block 192(4096), index = 24:CACHE MISS & REPLACE
[326799.748849] flashcache_io_callback: flashcache_io_callback: READDISK 24
[326799.752119] flashcache_io_callback: flashcache_io_callback: READFILL 24
[326799.752134] flashcache_read: Got a READ for 200 4096 bytes)
[326799.752137] hash_block: Hash: 200(0)->0
[326799.752139] flashcache_lookup: Cache lookup : dbn 200(8), set = 0
[326799.752143] flashcache_lookup: Cache lookup MISS (INVALID): dbn 200(8), set = 0, index = 25, start_index = 0
[326799.752145] hash_block: Hash: 200(0)->0
[326799.752147] hash_block: Hash: 207(0)->0
[326799.752151] flashcache_read: Cache read: Block 200(4096), index = 25:CACHE MISS & REPLACE
[326799.752878] flashcache_io_callback: flashcache_io_callback: READDISK 25
[326799.756115] flashcache_io_callback: flashcache_io_callback: READFILL 25
[326799.756130] flashcache_read: Got a READ for 208 4096 bytes)
[326799.756133] hash_block: Hash: 208(0)->0
[326799.756135] flashcache_lookup: Cache lookup : dbn 208(8), set = 0
[326799.756138] flashcache_lookup: Cache lookup MISS (INVALID): dbn 208(8), set = 0, index = 26, start_index = 0
[326799.756141] hash_block: Hash: 208(0)->0
[326799.756143] hash_block: Hash: 215(0)->0
[326799.756147] flashcache_read: Cache read: Block 208(4096), index = 26:CACHE MISS & REPLACE
[326799.756856] flashcache_io_callback: flashcache_io_callback: READDISK 26
[326799.760103] flashcache_io_callback: flashcache_io_callback: READFILL 26
[326799.760120] flashcache_read: Got a READ for 216 4096 bytes)
[326799.760122] hash_block: Hash: 216(0)->0
[326799.760124] flashcache_lookup: Cache lookup : dbn 216(8), set = 0
[326799.760128] flashcache_lookup: Cache lookup MISS (INVALID): dbn 216(8), set = 0, index = 27, start_index = 0
[326799.760131] hash_block: Hash: 216(0)->0
[326799.760133] hash_block: Hash: 223(0)->0
[326799.760137] flashcache_read: Cache read: Block 216(4096), index = 27:CACHE MISS & REPLACE
[326799.760853] flashcache_io_callback: flashcache_io_callback: READDISK 27
[326799.764114] flashcache_io_callback: flashcache_io_callback: READFILL 27
[326799.764130] flashcache_read: Got a READ for 224 4096 bytes)
[326799.764132] hash_block: Hash: 224(0)->0
[326799.764134] flashcache_lookup: Cache lookup : dbn 224(8), set = 0
[326799.764138] flashcache_lookup: Cache lookup MISS (INVALID): dbn 224(8), set = 0, index = 28, start_index = 0
[326799.764141] hash_block: Hash: 224(0)->0
[326799.764143] hash_block: Hash: 231(0)->0
[326799.764146] flashcache_read: Cache read: Block 224(4096), index = 28:CACHE MISS & REPLACE
[326799.764855] flashcache_io_callback: flashcache_io_callback: READDISK 28
[326799.768114] flashcache_io_callback: flashcache_io_callback: READFILL 28
[326799.768129] flashcache_read: Got a READ for 232 4096 bytes)
[326799.768131] hash_block: Hash: 232(0)->0
[326799.768133] flashcache_lookup: Cache lookup : dbn 232(8), set = 0
[326799.768137] flashcache_lookup: Cache lookup MISS (INVALID): dbn 232(8), set = 0, index = 29, start_index = 0
[326799.768140] hash_block: Hash: 232(0)->0
[326799.768142] hash_block: Hash: 239(0)->0
[326799.768146] flashcache_read: Cache read: Block 232(4096), index = 29:CACHE MISS & REPLACE
[326799.768896] flashcache_io_callback: flashcache_io_callback: READDISK 29
[326799.772111] flashcache_io_callback: flashcache_io_callback: READFILL 29
[326799.772126] flashcache_read: Got a READ for 240 4096 bytes)
[326799.772128] hash_block: Hash: 240(0)->0
[326799.772131] flashcache_lookup: Cache lookup : dbn 240(8), set = 0
[326799.772134] flashcache_lookup: Cache lookup MISS (INVALID): dbn 240(8), set = 0, index = 30, start_index = 0
[326799.772137] hash_block: Hash: 240(0)->0
[326799.772139] hash_block: Hash: 247(0)->0
[326799.772143] flashcache_read: Cache read: Block 240(4096), index = 30:CACHE MISS & REPLACE
[326799.772837] flashcache_io_callback: flashcache_io_callback: READDISK 30
[326799.776113] flashcache_io_callback: flashcache_io_callback: READFILL 30
[326799.776128] flashcache_read: Got a READ for 248 4096 bytes)
[326799.776130] hash_block: Hash: 248(0)->0
[326799.776132] flashcache_lookup: Cache lookup : dbn 248(8), set = 0
[326799.776136] flashcache_lookup: Cache lookup MISS (INVALID): dbn 248(8), set = 0, index = 31, start_index = 0
[326799.776139] hash_block: Hash: 248(0)->0
[326799.776141] hash_block: Hash: 255(0)->0
[326799.776145] flashcache_read: Cache read: Block 248(4096), index = 31:CACHE MISS & REPLACE
[326799.779368] flashcache_io_callback: flashcache_io_callback: READDISK 31
[326799.780110] flashcache_io_callback: flashcache_io_callback: READFILL 31
[326799.780414] flashcache_read: Got a READ for 8216 4096 bytes)
[326799.780417] hash_block: Hash: 8216(2)->2
[326799.780419] flashcache_lookup: Cache lookup : dbn 8216(8), set = 2
[326799.780422] flashcache_lookup: Cache lookup HIT: Block 8216(8): VALID index 1024
[326799.780424] flashcache_read_hit: Cache read: Block 8216(4096), index = 1024:CACHE HIT
[326799.780630] flashcache_io_callback: flashcache_io_callback: READCACHE 1024
[326799.780654] flashcache_read: Got a READ for 511709200 4096 bytes)
[326799.780657] hash_block: Hash: 511709200(124929)->124929
[326799.780659] flashcache_lookup: Cache lookup : dbn 511709200(8), set = 124929
[326799.780662] flashcache_lookup: Cache lookup HIT: Block 511709200(8): VALID index 63963648
[326799.780665] flashcache_read_hit: Cache read: Block 511709200(4096), index = 63963648:CACHE HIT
[326799.780863] flashcache_io_callback: flashcache_io_callback: READCACHE 63963648
[326800.502191] kjournald starting. Commit interval 15 seconds
[326799.780966] EXT3-fs warning: maximal mount count reached, running e2fsck is recommended
[326799.781057] hash_block: Hash: 0(0)->0
[326799.781059] flashcache_lookup: Cache lookup : dbn 0(8), set = 0
[326799.781061] flashcache_lookup: Cache lookup MISS (INVALID): dbn 0(8), set = 0, index = 32, start_index = 0
[326799.781064] hash_block: Hash: 0(0)->0
[326799.781066] hash_block: Hash: 7(0)->0
[326799.781068] flashcache_inval_block_set: Cache invalidate (!BUSY): Block 0 2
[326799.781095] flashcache_io_callback: flashcache_io_callback: WRITECACHE 32
[326799.784125] EXT3 FS on dm-0, internal journal
[326799.784131] EXT3-fs: mounted filesystem with ordered data mode.
linux:~/FlashCache/facebook-flashcache-0da66de/src #
再次卸载分区日志
linux:~/FlashCache/facebook-flashcache-0da66de/src # dmesg -c
linux:~/FlashCache/facebook-flashcache-0da66de/src # umount /var/lib/xen/images/
linux:~/FlashCache/facebook-flashcache-0da66de/src # dmesg -c
[327291.823386] hash_block: Hash: 0(0)->0
[327291.823389] flashcache_lookup: Cache lookup : dbn 0(8), set = 0
[327291.823393] flashcache_lookup: Cache lookup HIT: Block 0(8): VALID index 32
[327291.823397] flashcache_write_hit: Queue job for 0
[327291.063361] flashcache_io_callback: flashcache_io_callback: WRITECACHE 32
linux:~/FlashCache/facebook-flashcache-0da66de/src #
删除Device Mapper设备日志
linux:~/FlashCache/facebook-flashcache-0da66de/src # dmsetup remove cachedev
linux:~/FlashCache/facebook-flashcache-0da66de/src # dmesg -c
[327326.163318] Cleaning 1 blocks please WAIT
[327326.163331] flashcache_dirty_writeback_sync: flashcache_dirty_writeback_sync: Index 32
[327327.446941] flashcache_kcopyd_callback_sync: kcopyd_callback_sync: Index 32
[327335.837013] flashcache_md_store: Store metadata to disk: block size(8), md block size(8), cache size(156671488)associativity(512)
[327335.837199] device-mapper: flashcache: Cache metadata saved to disk
[327335.837203] device-mapper: flashcache: flashcache_md_store: valid blocks = 34 dirty blocks = 0 md_sectors = 4896000
[327335.837205]
[327335.837207] device-mapper: flashcache: cache jobs 0, pending jobs 0
[327336.197477] device-mapper: flashcache: cache queued jobs 0
[327336.198205] device-mapper: flashcache: stats: reads(6211), writes(4), read hits(2), write hits(2), read hit percent(0), replacement(0), write invalidates(2), read invalidates(39), write replacement(0), pending enqueues(8), pending inval(1) cleanings(2) fallow cleanings(0)front merge(0) back merge(0)
[327336.198210] device-mapper: flashcache: conf: capacity(611998M), associativity(512), block size(4K), total blocks(156671488), cached blocks(34), cache percent(0), dirty blocks(0)
linux:~/FlashCache/facebook-flashcache-0da66de/src #
Leave a Reply