Bug #4704
closedclone range short read
0%
Description
3:25:12.181924 7fd0257fa700 15 filestore(/var/lib/ceph/osd/ceph-1) get_omap_iterator meta/a468ec03/snapmapper/0//-1
2013-04-10 13:25:12.182007 7fd0257fa700 15 filestore(/var/lib/ceph/osd/ceph-1) get_omap_iterator meta/a468ec03/snapmapper/0//-1
2013-04-10 13:25:12.182088 7fd0257fa700 10 osd.1 pg_epoch: 3525 pg[3.ec( empty local-les=3515 n=0 ec=6 les/c 3515/3525 3510/3510/3510) [1,0] r=0 lpr=3510 mlcod 0'0 active+clean snaptrimq=[840~2,843~3,847~4,84c~4,852~1,854~1,856~2,85a~1,85c~1,85e~1]] SnapTrimmer state<Trimming/TrimmingObjects>: TrimmingObjects: got ENOENT
2013-04-10 13:25:12.182107 7fd0257fa700 20 osd.1 pg_epoch: 3525 pg[3.ec( empty local-les=3515 n=0 ec=6 les/c 3515/3525 3510/3510/3510) [1,0] r=0 lpr=3510 mlcod 0'0 active+clean snaptrimq=[840~2,843~3,847~4,84c~4,852~1,854~1,856~2,85a~1,85c~1,85e~1]] exit Trimming/TrimmingObjects
2013-04-10 13:25:12.182121 7fd0257fa700 20 osd.1 pg_epoch: 3525 pg[3.ec( empty local-les=3515 n=0 ec=6 les/c 3515/3525 3510/3510/3510) [1,0] r=0 lpr=3510 mlcod 0'0 active+clean snaptrimq=[840~2,843~3,847~4,84c~4,852~1,854~1,856~2,85a~1,85c~1,85e~1]] enter Trimming/WaitingOnReplicas
2013-04-10 13:25:12.182135 7fd0257fa700 10 osd.1 pg_epoch: 3525 pg[3.ec( empty local-les=3515 n=0 ec=6 les/c 3515/3525 3510/3510/3510) [1,0] r=0 lpr=3510 mlcod 0'0 active+clean snaptrimq=[840~2,843~3,847~4,84c~4,852~1,854~1,856~2,85a~1,85c~1,85e~1]] SnapTrimmer state<Trimming/WaitingOnReplicas>: Waiting on Replicas react
2013-04-10 13:25:12.182144 7fd0327fc700 20 filestore(/var/lib/ceph/osd/ceph-1) _do_copy_range 852682~3382 to 852682
2013-04-10 13:25:12.182148 7fd0257fa700 10 osd.1 pg_epoch: 3525 pg[3.ec( empty local-les=3515 n=0 ec=6 les/c 3515/3525 3510/3510/3510) [1,0] r=0 lpr=3510 mlcod 0'0 active+clean snaptrimq=[840~2,843~3,847~4,84c~4,852~1,854~1,856~2,85a~1,85c~1,85e~1]] SnapTrimmer state<Trimming/WaitingOnReplicas>: WaitingOnReplicas: adding snap 840 to purged_snaps
2013-04-10 13:25:12.182184 7fd0327fc700 20 filestore(/var/lib/ceph/osd/ceph-1) _do_copy_range 852682~3382 to 852682 = 3382
2013-04-10 13:25:12.182189 7fd0327fc700 20 filestore(/var/lib/ceph/osd/ceph-1) _do_copy_range 3211264~239 to 3211264
2013-04-10 13:25:12.182164 7fd0257fa700 10 osd.1 pg_epoch: 3525 pg[3.ec( empty local-les=3515 n=0 ec=6 les/c 3515/3525 3510/3510/3510) [1,0] r=0 lpr=3510 mlcod 0'0 active+clean snaptrimq=[841~1,843~3,847~4,84c~4,852~1,854~1,856~2,85a~1,85c~1,85e~1]] SnapTrimmer state<Trimming/WaitingOnReplicas>: purged_snaps now [1~601,603~40,644~5e,6a3~1a,6be~2a,6e9~17,701~5,707~5,70d~13,721~a,72c~a,737~15,74d~5,753~25,779~5,77f~13,793~5,799~7,7a2~1,7a5~4,7aa~6,7b1~3,7b5~5,7bb~3,7bf~1,7c1~2,7c5~7,7cd~3,7d1~3,7d5~2,7d8~1,7da~4,7e1~2,7e5~2,7e8~1,7ea~2,7ed~1,7ef~e,7ff~8,808~6,80f~2,812~1,817~2,81a~1,81c~2,81f~3,824~2,827~2,82a~2,82e~4,833~1,836~1,838~7,840~1], snap_trimq now [841~1,843~3,847~4,84c~4,852~1,854~1,856~2,85a~1,85c~1,85e~1]
2013-04-10 13:25:12.182216 7fd0327fc700 -1 filestore(/var/lib/ceph/osd/ceph-1) FileStore::_do_copy_range got short read result at 3211264 of fd 51 len 239
2013-04-10 13:25:12.182219 7fd0327fc700 20 filestore(/var/lib/ceph/osd/ceph-1) _do_copy_range 3211264~239 to 3211264 = -34
2013-04-10 13:25:12.182227 7fd0327fc700 10 filestore(/var/lib/ceph/osd/ceph-1) clone_range 3.117_head/8dd4a517/mira0375291-19/722//3 -> 3.117_head/8dd4a517/mira0375291-19/76d//3 852682~2358821 to 852682 = -2
2013-04-10 13:25:12.182232 7fd0327fc700 0 filestore(/var/lib/ceph/osd/ceph-1) error (2) No such file or directory not handled on operation 30 (1449644.0.12, or op 12, counting from 0)
2013-04-10 13:25:12.182242 7fd0327fc700 0 filestore(/var/lib/ceph/osd/ceph-1) ENOENT on clone suggests osd bug
2013-04-10 13:25:12.182230 7fd0257fa700 20 osd.1 pg_epoch: 3525 pg[3.ec( empty local-les=3515 n=0 ec=6 les/c 3515/3525 3510/3510/3510) [1,0] r=0 lpr=3510 mlcod 0'0 active+clean snaptrimq=[841~1,843~3,847~4,84c~4,852~1,854~1,856~2,85a~1,85c~1,85e~1]] write_info bigbl 876
2013-04-10 13:25:12.182250 7fd0257fa700 5 filestore(/var/lib/ceph/osd/ceph-1) queue_transactions existing osr(3.ec 0x2a3f020)/0x2a3f020
2013-04-10 13:25:12.182255 7fd0257fa700 5 filestore(/var/lib/ceph/osd/ceph-1) queue_transactions (parallel) 1449660 0x7fd01810c290
2013-04-10 13:25:12.182263 7fd0257fa700 5 filestore(/var/lib/ceph/osd/ceph-1) queue_op 0x7fd0181150e0 seq 1449660 osr(3.ec 0x2a3f020) 1573 bytes (queue has 9 ops and 1275327 bytes)
2013-04-10 13:25:12.182268 7fd0257fa700 20 osd.1 pg_epoch: 3525 pg[3.ec( empty local-les=3515 n=0 ec=6 les/c 3515/3525 3510/3510/3510) [1,0] r=0 lpr=3510 mlcod 0'0 active+clean snaptrimq=[841~1,843~3,847~4,84c~4,852~1,854~1,856~2,85a~1,85c~1,85e~1]] exit Trimming/WaitingOnReplicas
2013-04-10 13:25:12.182283 7fd0257fa700 20 osd.1 pg_epoch: 3525 pg[3.ec( empty local-les=3515 n=0 ec=6 les/c 3515/3525 3510/3510/3510) [1,0] r=0 lpr=3510 mlcod 0'0 active+clean snaptrimq=[841~1,843~3,847~4,84c~4,852~1,854~1,856~2,85a~1,85c~1,85e~1]] enter NotTrimming
2013-04-10 13:25:12.182297 7fd0257fa700 10 osd.1 pg_epoch: 3525 pg[3.ec( empty local-les=3515 n=0 ec=6 les/c 3515/3525 3510/3510/3510) [1,0] r=0 lpr=3510 mlcod 0'0 active+clean snaptrimq=[841~1,843~3,847~4,84c~4,852~1,854~1,856~2,85a~1,85c~1,85e~1]] SnapTrimmer state<NotTrimming>: NotTrimming react
2013-04-10 13:25:12.182312 7fd0257fa700 10 osd.1 pg_epoch: 3525 pg[3.ec( empty local-les=3515 n=0 ec=6 les/c 3515/3525 3510/3510/3510) [1,0] r=0 lpr=3510 mlcod 0'0 active+clean snaptrimq=[841~1,843~3,847~4,84c~4,852~1,854~1,856~2,85a~1,85c~1,85e~1]] SnapTrimmer state<NotTrimming>: NotTrimming: trimming 841
2013-04-10 13:25:12.182328 7fd0257fa700 20 osd.1 pg_epoch: 3525 pg[3.ec( empty local-les=3515 n=0 ec=6 les/c 3515/3525 3510/3510/3510) [1,0] r=0 lpr=3510 mlcod 0'0 active+clean snaptrimq=[841~1,843~3,847~4,84c~4,852~1,854~1,856~2,85a~1,85c~1,85e~1]] exit NotTrimming
2013-04-10 13:25:12.182343 7fd0257fa700 20 osd.1 pg_epoch: 3525 pg[3.ec( empty local-les=3515 n=0 ec=6 les/c 3515/3525 3510/3510/3510) [1,0] r=0 lpr=3510 mlcod 0'0 active+clean snaptrimq=[841~1,843~3,847~4,84c~4,852~1,854~1,856~2,85a~1,85c~1,85e~1]] enter Trimming/TrimmingObjects
2013-04-10 13:25:12.182357 7fd0257fa700 10 osd.1 pg_epoch: 3525 pg[3.ec( empty local-les=3515 n=0 ec=6 les/c 3515/3525 3510/3510/3510) [1,0] r=0 lpr=3510 mlcod 0'0 active+clean snaptrimq=[841~1,843~3,847~4,84c~4,852~1,854~1,856~2,85a~1,85c~1,85e~1]] SnapTrimmer state<Trimming/TrimmingObjects>: TrimmingObjects react
2013-04-10 13:25:12.182371 7fd0257fa700 10 osd.1 pg_epoch: 3525 pg[3.ec( empty local-les=3515 n=0 ec=6 les/c 3515/3525 3510/3510/3510) [1,0] r=0 lpr=3510 mlcod 0'0 active+clean snaptrimq=[841~1,843~3,847~4,84c~4,852~1,854~1,856~2,85a~1,85c~1,85e~1]] SnapTrimmer state<Trimming/TrimmingObjects>: TrimmingObjects: trimming snap 841
2013-04-10 13:25:12.182388 7fd0257fa700 15 filestore(/var/lib/ceph/osd/ceph-1) get_omap_iterator meta/a468ec03/snapmapper/0//-1
2013-04-10 13:25:12.182483 7fd0257fa700 15 filestore(/var/lib/ceph/osd/ceph-1) get_omap_iterator meta/a468ec03/snapmapper/0//-1
2013-04-10 13:25:12.182568 7fd0257fa700 15 filestore(/var/lib/ceph/osd/ceph-1) get_omap_iterator meta/a468ec03/snapmapper/0//-1
2013-04-10 13:25:12.182653 7fd0257fa700 15 filestore(/var/lib/ceph/osd/ceph-1) get_omap_iterator meta/
Updated by Samuel Just about 11 years ago
Of particular interest is the following line:
2013-04-10 13:25:11.539807 7f21d07f8700 10 filestore(/var/lib/ceph/osd/ceph-3) FileStore::read 3.117_head/8dd4a517/mira0375291-19/722//3 3145728~65536/65775
It seems we got a short read on the object. As near as I can tell, this object should have the correct length, it was created on osd.3 with a push. The final write operation of the push was a clone_range including a _do_copy_range which appears to have output indicating that the full object was successfully written. Looks like the object may have been truncated in the mean time?
Full logs in slider:~samuelj/log_output/4704
-- snippet --
2013-04-10 13:25:11.539449 7f21d07f8700 5 --OSD::tracker-- reqid: unknown.0.0:0, seq: 1099, time: 2013-04-10 13:25:11.539449, event: started, request: osd_sub_op_reply(osd.3.0:51 3.117 8dd4a517/mira0375291-19/722//3 [push] ack, result = 0) v1
2013-04-10 13:25:11.539437 7f21d8ff9700 1 -- 10.214.137.130:6801/23274 <== osd.1 10.214.132.104:6803/20453 312 ==== osd_sub_op_reply(osd.3.0:54 3.117 8dd4a517/mira0375291-19/704//3 [push] ack, result = 0) v1 ==== 178+0+0 (4072223861 0 0) 0x7f2154006ef0 con 0x7f21c846e2e0
2013-04-10 13:25:11.539446 7f21cf7f6700 10 osd.3 pg_epoch: 3525 pg[3.26d( v 1886'529 (1886'529,1886'529] local-les=3525 n=6 ec=6 les/c 3525/3525 3510/3524/3510) [3,1] r=0 lpr=3524 lcod 0'0 mlcod 0'0 active+clean snaptrimq=[7e2~1,85e~1]] snap_trimmer posting
2013-04-10 13:25:11.539476 7f21d8ff9700 10 osd.3 3525 do_waiters -- start
2013-04-10 13:25:11.539483 7f21d8ff9700 10 osd.3 3525 do_waiters -- finish
2013-04-10 13:25:11.539486 7f21d8ff9700 20 osd.3 3525 _dispatch 0x7f2154006ef0 osd_sub_op_reply(osd.3.0:54 3.117 8dd4a517/mira0375291-19/704//3 [push] ack, result = 0) v1
2013-04-10 13:25:11.539476 7f21d07f8700 10 osd.3 pg_epoch: 3525 pg[3.117( v 3469'1919 (0'0,3469'1919] local-les=3514 n=17 ec=6 les/c 3514/3436 3510/3510/3510) [3,1] r=0 lpr=3510 pi=3297-3509/4 rops=5 lcod 0'0 mlcod 0'0 active+recovering snaptrimq=[7e2~1,85e~1]] pushing more from, 3145728 of [0~3211503]
2013-04-10 13:25:11.539502 7f21d8ff9700 5 --OSD::tracker-- reqid: unknown.0.0:0, seq: 1102, time: 2013-04-10 13:25:11.539326, event: header_read, request: osd_sub_op_reply(osd.3.0:54 3.117 8dd4a517/mira0375291-19/704//3 [push] ack, result = 0) v1
2013-04-10 13:25:11.539484 7f21cf7f6700 10 osd.3 pg_epoch: 3525 pg[3.26d( v 1886'529 (1886'529,1886'529] local-les=3525 n=6 ec=6 les/c 3525/3525 3510/3524/3510) [3,1] r=0 lpr=3524 lcod 0'0 mlcod 0'0 active+clean snaptrimq=[7e2~1,85e~1]] SnapTrimmer state<NotTrimming>: NotTrimming react
2013-04-10 13:25:11.539523 7f21d8ff9700 5 --OSD::tracker-- reqid: unknown.0.0:0, seq: 1102, time: 2013-04-10 13:25:11.539329, event: throttled, request: osd_sub_op_reply(osd.3.0:54 3.117 8dd4a517/mira0375291-19/704//3 [push] ack, result = 0) v1
2013-04-10 13:25:11.539527 7f21cf7f6700 10 osd.3 pg_epoch: 3525 pg[3.26d( v 1886'529 (1886'529,1886'529] local-les=3525 n=6 ec=6 les/c 3525/3525 3510/3524/3510) [3,1] r=0 lpr=3524 lcod 0'0 mlcod 0'0 active+clean snaptrimq=[7e2~1,85e~1]] SnapTrimmer state<NotTrimming>: NotTrimming: trimming 7e2
2013-04-10 13:25:11.539543 7f21d8ff9700 5 --OSD::tracker-- reqid: unknown.0.0:0, seq: 1102, time: 2013-04-10 13:25:11.539398, event: all_read, request: osd_sub_op_reply(osd.3.0:54 3.117 8dd4a517/mira0375291-19/704//3 [push] ack, result = 0) v1
2013-04-10 13:25:11.539552 7f21d8ff9700 5 --OSD::tracker-- reqid: unknown.0.0:0, seq: 1102, time: 2013-04-10 13:25:11.539474, event: dispatched, request: osd_sub_op_reply(osd.3.0:54 3.117 8dd4a517/mira0375291-19/704//3 [push] ack, result = 0) v1
2013-04-10 13:25:11.539539 7f21d07f8700 7 osd.3 pg_epoch: 3525 pg[3.117( v 3469'1919 (0'0,3469'1919] local-les=3514 n=17 ec=6 les/c 3514/3436 3510/3510/3510) [3,1] r=0 lpr=3510 pi=3297-3509/4 rops=5 lcod 0'0 mlcod 0'0 active+recovering snaptrimq=[7e2~1,85e~1]] send_push_op 8dd4a517/mira0375291-19/722//3 v 3342'1838 size 3211503 to osd.1 recovery_info: ObjectRecoveryInfo(8dd4a517/mira0375291-19/722//3@3342'1838, copy_subset: [0~3211503], clone_subset: {})
2013-04-10 13:25:11.539553 7f21cf7f6700 20 osd.3 pg_epoch: 3525 pg[3.26d( v 1886'529 (1886'529,1886'529] local-les=3525 n=6 ec=6 les/c 3525/3525 3510/3524/3510) [3,1] r=0 lpr=3524 lcod 0'0 mlcod 0'0 active+clean snaptrimq=[7e2~1,85e~1]] exit NotTrimming
2013-04-10 13:25:11.539561 7f21d8ff9700 5 --OSD::tracker-- reqid: unknown.0.0:0, seq: 1102, time: 2013-04-10 13:25:11.539561, event: waiting_for_osdmap, request: osd_sub_op_reply(osd.3.0:54 3.117 8dd4a517/mira0375291-19/704//3 [push] ack, result = 0) v1
2013-04-10 13:25:11.539567 7f21d07f8700 15 filestore(/var/lib/ceph/osd/ceph-3) read 3.117_head/8dd4a517/mira0375291-19/722//3 3145728~65775
2013-04-10 13:25:11.539570 7f21d8ff9700 15 osd.3 3525 require_same_or_newer_map 3525 (i am 3525) 0x7f2154006ef0
2013-04-10 13:25:11.539574 7f21d8ff9700 20 osd.3 3525 _share_map_incoming osd.1 10.214.132.104:6803/20453 3525
2013-04-10 13:25:11.539568 7f21cf7f6700 20 osd.3 pg_epoch: 3525 pg[3.26d( v 1886'529 (1886'529,1886'529] local-les=3525 n=6 ec=6 les/c 3525/3525 3510/3524/3510) [3,1] r=0 lpr=3524 lcod 0'0 mlcod 0'0 active+clean snaptrimq=[7e2~1,85e~1]] enter Trimming/TrimmingObjects
2013-04-10 13:25:11.539581 7f21d8ff9700 15 osd.3 3525 enqueue_op 0x7f215c146080 prio 127 cost 0 latency 0.000255 osd_sub_op_reply(osd.3.0:54 3.117 8dd4a517/mira0375291-19/704//3 [push] ack, result = 0) v1
2013-04-10 13:25:11.539584 7f21cf7f6700 10 osd.3 pg_epoch: 3525 pg[3.26d( v 1886'529 (1886'529,1886'529] local-les=3525 n=6 ec=6 les/c 3525/3525 3510/3524/3510) [3,1] r=0 lpr=3524 lcod 0'0 mlcod 0'0 active+clean snaptrimq=[7e2~1,85e~1]] SnapTrimmer state<Trimming/TrimmingObjects>: TrimmingObjects react
2013-04-10 13:25:11.539596 7f21d8ff9700 10 osd.3 3525 do_waiters -- start
2013-04-10 13:25:11.539599 7f21d8ff9700 10 osd.3 3525 do_waiters -- finish
2013-04-10 13:25:11.539598 7f21cf7f6700 10 osd.3 pg_epoch: 3525 pg[3.26d( v 1886'529 (1886'529,1886'529] local-les=3525 n=6 ec=6 les/c 3525/3525 3510/3524/3510) [3,1] r=0 lpr=3524 lcod 0'0 mlcod 0'0 active+clean snaptrimq=[7e2~1,85e~1]] SnapTrimmer state<Trimming/TrimmingObjects>: TrimmingObjects: trimming snap 7e2
2013-04-10 13:25:11.539619 7f21cf7f6700 15 filestore(/var/lib/ceph/osd/ceph-3) get_omap_iterator meta/a468ec03/snapmapper/0//-1
2013-04-10 13:25:11.539717 7f21ed7fa700 10 filestore hoid: 16ef7597/infos/head//-1 not skipping op, *spos 1458727.0.0
2013-04-10 13:25:11.539725 7f21ed7fa700 10 filestore > header.spos 0.0.0
2013-04-10 13:25:11.539807 7f21d07f8700 10 filestore(/var/lib/ceph/osd/ceph-3) FileStore::read 3.117_head/8dd4a517/mira0375291-19/722//3 3145728~65536/65775
Updated by Samuel Just about 11 years ago
In dmesg on mira114 (where osd.3 was):
[ 540.131502] btrfs: unlinked 1 orphans
[ 1467.232908] btrfs: truncated 1 orphans
[ 3642.260130] btrfs: unlinked 1 orphans
[ 6820.821976] btrfs: unlinked 1 orphans
[ 7636.615241] btrfs: unlinked 1 orphans
Updated by Samuel Just about 11 years ago
2013-04-10 12:47:54.368871 7f7b1bfff700 15 filestore(/var/lib/ceph/osd/ceph-3) clone 3.117_head/8dd4a517/mira0375291-19/head//3 -> 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 12:47:54.369810 7f7b1bfff700 20 filestore set_map_header: setting 12623 hoid 8dd4a517/mira0375291-19/722//3 parent seq 11892
2013-04-10 12:47:54.370072 7f7b1bfff700 10 filestore(/var/lib/ceph/osd/ceph-3) clone 3.117_head/8dd4a517/mira0375291-19/head//3 -> 3.117_head/8dd4a517/mira0375291-19/722//3 = 0
2013-04-10 12:47:54.370296 7f7b1bfff700 15 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 12:47:54.370376 7f7b1bfff700 10 filestore hoid: 8dd4a517/mira0375291-19/722//3 not skipping op, *spos 1243397.1.1
2013-04-10 12:47:54.370396 7f7b1bfff700 10 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_head/8dd4a517/mira0375291-19/722//3 = 0
2013-04-10 12:47:54.370403 7f7b1bfff700 15 filestore(/var/lib/ceph/osd/ceph-3) rmattr 3.117_head/8dd4a517/mira0375291-19/722//3 'snapset'
2013-04-10 12:47:54.370495 7f7b1bfff700 10 filestore hoid: 8dd4a517/mira0375291-19/722//3 not skipping op, *spos 1243397.1.2
2013-04-10 12:47:54.370516 7f7b1bfff700 10 filestore(/var/lib/ceph/osd/ceph-3) rmattr 3.117_head/8dd4a517/mira0375291-19/722//3 'snapset' = 0
2013-04-10 12:48:05.379900 7f7b2cff9700 15 filestore(/var/lib/ceph/osd/ceph-3) clone 3.117_head/8dd4a517/mira0375291-19/722//3 -> 3.117_head/8dd4a517/mira0375291-19/head//3
2013-04-10 12:48:05.380767 7f7b2cff9700 20 filestore set_map_header: setting 12626 hoid 8dd4a517/mira0375291-19/722//3 parent seq 12623
2013-04-10 12:48:05.380952 7f7b2cff9700 10 filestore(/var/lib/ceph/osd/ceph-3) clone 3.117_head/8dd4a517/mira0375291-19/722//3 -> 3.117_head/8dd4a517/mira0375291-19/head//3 = 0
2013-04-10 12:48:07.525049 7f7b1bfff700 15 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 12:48:07.526479 7f7b1bfff700 10 filestore hoid: 8dd4a517/mira0375291-19/722//3 not skipping op, *spos 1247487.1.2
2013-04-10 12:48:07.526499 7f7b1bfff700 10 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_head/8dd4a517/mira0375291-19/722//3 = 0
2013-04-10 12:49:04.903376 7f4802ffd700 15 filestore(/var/lib/ceph/osd/ceph-3) remove 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 12:49:04.903443 7f4802ffd700 20 filestore(/var/lib/ceph/osd/ceph-3) lfn_unlink: clearing omap on 8dd4a517/mira0375291-19/722//3 in cid 3.117_head
2013-04-10 12:49:04.903495 7f4802ffd700 10 filestore hoid: 8dd4a517/mira0375291-19/722//3 not skipping op, *spos 1254878.0.0
2013-04-10 12:49:04.903499 7f4802ffd700 20 filestore remove_map_header: removing 12626 hoid 8dd4a517/mira0375291-19/722//3
2013-04-10 12:49:04.903978 7f4802ffd700 10 filestore(/var/lib/ceph/osd/ceph-3) remove 3.117_head/8dd4a517/mira0375291-19/722//3 = 0
2013-04-10 12:49:04.904265 7f4802ffd700 15 filestore(/var/lib/ceph/osd/ceph-3) remove 3.117_TEMP/8dd4a517/mira0375291-19/722//3
2013-04-10 12:49:04.904309 7f4802ffd700 10 filestore(/var/lib/ceph/osd/ceph-3) remove 3.117_TEMP/8dd4a517/mira0375291-19/722//3 = -2
2013-04-10 12:49:04.904314 7f4802ffd700 15 filestore(/var/lib/ceph/osd/ceph-3) touch 3.117_TEMP/8dd4a517/mira0375291-19/722//3
2013-04-10 12:49:04.904458 7f4802ffd700 10 filestore(/var/lib/ceph/osd/ceph-3) touch 3.117_TEMP/8dd4a517/mira0375291-19/722//3 = 0
2013-04-10 12:49:04.904466 7f4802ffd700 15 filestore(/var/lib/ceph/osd/ceph-3) omap_setheader 3.117_TEMP/8dd4a517/mira0375291-19/722//3
2013-04-10 12:49:04.904589 7f4802ffd700 20 filestore set_map_header: setting 12882 hoid 8dd4a517/mira0375291-19/722//3 parent seq 0
2013-04-10 12:49:04.904604 7f4802ffd700 10 filestore hoid: 8dd4a517/mira0375291-19/722//3 not skipping op, *spos 1254878.0.6
2013-04-10 12:49:04.904622 7f4802ffd700 15 filestore(/var/lib/ceph/osd/ceph-3) write 3.117_TEMP/8dd4a517/mira0375291-19/722//3 0~57
2013-04-10 12:49:04.904686 7f4802ffd700 10 filestore(/var/lib/ceph/osd/ceph-3) write 3.117_TEMP/8dd4a517/mira0375291-19/722//3 0~57 = 57
2013-04-10 12:49:04.904693 7f4802ffd700 15 filestore(/var/lib/ceph/osd/ceph-3) write 3.117_TEMP/8dd4a517/mira0375291-19/722//3 452682~400000
2013-04-10 12:49:04.905087 7f4802ffd700 10 filestore(/var/lib/ceph/osd/ceph-3) write 3.117_TEMP/8dd4a517/mira0375291-19/722//3 452682~400000 = 400000
2013-04-10 12:49:04.905092 7f4802ffd700 15 filestore(/var/lib/ceph/osd/ceph-3) _omap_setkeys 3.117_TEMP/8dd4a517/mira0375291-19/722//3
2013-04-10 12:49:04.905152 7f4802ffd700 10 filestore hoid: 8dd4a517/mira0375291-19/722//3 not skipping op, *spos 1254878.0.9
2013-04-10 12:49:04.905198 7f4802ffd700 15 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_TEMP/8dd4a517/mira0375291-19/722//3
2013-04-10 12:49:04.905264 7f4802ffd700 10 filestore hoid: 8dd4a517/mira0375291-19/722//3 not skipping op, *spos 1254878.0.10
2013-04-10 12:49:04.905286 7f4802ffd700 10 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_TEMP/8dd4a517/mira0375291-19/722//3 = 0
2013-04-10 12:49:04.905295 7f4802ffd700 15 filestore(/var/lib/ceph/osd/ceph-3) remove 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 12:49:04.905328 7f4802ffd700 10 filestore(/var/lib/ceph/osd/ceph-3) remove 3.117_head/8dd4a517/mira0375291-19/722//3 = -2
2013-04-10 12:49:04.905336 7f4802ffd700 15 filestore(/var/lib/ceph/osd/ceph-3) collection_add 3.117_head/8dd4a517/mira0375291-19/722//3 from 3.117_TEMP/8dd4a517/mira0375291-19/722//3
2013-04-10 12:49:04.905545 7f4802ffd700 10 filestore(/var/lib/ceph/osd/ceph-3) collection_add 3.117_head/8dd4a517/mira0375291-19/722//3 from 3.117_TEMP/8dd4a517/mira0375291-19/722//3 = 0
2013-04-10 12:49:04.905558 7f4802ffd700 15 filestore(/var/lib/ceph/osd/ceph-3) remove 3.117_TEMP/8dd4a517/mira0375291-19/722//3
2013-04-10 12:49:04.905674 7f4802ffd700 10 filestore(/var/lib/ceph/osd/ceph-3) remove 3.117_TEMP/8dd4a517/mira0375291-19/722//3 = 0
2013-04-10 12:49:04.905686 7f4802ffd700 15 filestore(/var/lib/ceph/osd/ceph-3) clone_range 3.117_head/8dd4a517/mira0375291-19/704//3 -> 3.117_head/8dd4a517/mira0375291-19/722//3 57~441244 to 57
2013-04-10 12:49:04.911457 7f4802ffd700 10 filestore(/var/lib/ceph/osd/ceph-3) clone_range 3.117_head/8dd4a517/mira0375291-19/704//3 -> 3.117_head/8dd4a517/mira0375291-19/722//3 57~441244 to 57 = 7068
2013-04-10 12:49:04.911467 7f4802ffd700 15 filestore(/var/lib/ceph/osd/ceph-3) clone_range 3.117_head/8dd4a517/mira0375291-19/704//3 -> 3.117_head/8dd4a517/mira0375291-19/722//3 1341212~123372 to 1341212
2013-04-10 12:49:04.929044 7f4802ffd700 10 filestore(/var/lib/ceph/osd/ceph-3) clone_range 3.117_head/8dd4a517/mira0375291-19/704//3 -> 3.117_head/8dd4a517/mira0375291-19/722//3 1341212~123372 to 1341212 = 4588
2013-04-10 12:49:04.929051 7f4802ffd700 15 filestore(/var/lib/ceph/osd/ceph-3) clone_range 3.117_head/8dd4a517/mira0375291-19/704//3 -> 3.117_head/8dd4a517/mira0375291-19/722//3 1913647~56846 to 1913647
2013-04-10 12:49:04.941630 7f4802ffd700 10 filestore(/var/lib/ceph/osd/ceph-3) clone_range 3.117_head/8dd4a517/mira0375291-19/704//3 -> 3.117_head/8dd4a517/mira0375291-19/722//3 1913647~56846 to 1913647 = 3598
2013-04-10 12:49:04.941638 7f4802ffd700 15 filestore(/var/lib/ceph/osd/ceph-3) clone_range 3.117_head/8dd4a517/mira0375291-19/704//3 -> 3.117_head/8dd4a517/mira0375291-19/722//3 3093454~118049 to 3093454
2013-04-10 12:49:04.955929 7f4802ffd700 10 filestore(/var/lib/ceph/osd/ceph-3) clone_range 3.117_head/8dd4a517/mira0375291-19/704//3 -> 3.117_head/8dd4a517/mira0375291-19/722//3 3093454~118049 to 3093454 = 3361
2013-04-10 12:49:04.955936 7f4802ffd700 15 filestore(/var/lib/ceph/osd/ceph-3) clone_range 3.117_head/8dd4a517/mira0375291-19/728//3 -> 3.117_head/8dd4a517/mira0375291-19/722//3 57~452625 to 57
2013-04-10 12:49:04.972944 7f4802ffd700 10 filestore(/var/lib/ceph/osd/ceph-3) clone_range 3.117_head/8dd4a517/mira0375291-19/728//3 -> 3.117_head/8dd4a517/mira0375291-19/722//3 57~452625 to 57 = 6161
2013-04-10 12:49:04.972951 7f4802ffd700 15 filestore(/var/lib/ceph/osd/ceph-3) clone_range 3.117_head/8dd4a517/mira0375291-19/728//3 -> 3.117_head/8dd4a517/mira0375291-19/722//3 852682~2358821 to 852682
2013-04-10 12:49:04.977343 7f4802ffd700 10 filestore(/var/lib/ceph/osd/ceph-3) clone_range 3.117_head/8dd4a517/mira0375291-19/728//3 -> 3.117_head/8dd4a517/mira0375291-19/722//3 852682~2358821 to 852682 = 3382
2013-04-10 12:58:36.793914 7f48037fe700 15 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 12:58:36.794009 7f48037fe700 10 filestore hoid: 8dd4a517/mira0375291-19/722//3 not skipping op, *spos 1277848.1.2
2013-04-10 12:58:36.794030 7f48037fe700 10 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_head/8dd4a517/mira0375291-19/722//3 = 0
2013-04-10 12:59:02.869829 7f48037fe700 15 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 12:59:02.870779 7f48037fe700 10 filestore hoid: 8dd4a517/mira0375291-19/722//3 not skipping op, *spos 1282206.1.2
2013-04-10 12:59:02.870797 7f48037fe700 10 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_head/8dd4a517/mira0375291-19/722//3 = 0
2013-04-10 12:59:20.765751 7f48037fe700 15 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 12:59:20.765862 7f48037fe700 10 filestore hoid: 8dd4a517/mira0375291-19/722//3 not skipping op, *spos 1292652.1.2
2013-04-10 12:59:20.765922 7f48037fe700 10 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_head/8dd4a517/mira0375291-19/722//3 = 0
2013-04-10 13:02:02.264733 7f48037fe700 15 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 13:02:02.264832 7f48037fe700 10 filestore hoid: 8dd4a517/mira0375291-19/722//3 not skipping op, *spos 1325479.1.2
2013-04-10 13:02:02.264858 7f48037fe700 10 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_head/8dd4a517/mira0375291-19/722//3 = 0
2013-04-10 13:03:40.263294 7f47f67f4700 15 filestore(/var/lib/ceph/osd/ceph-3) getattr 3.117_head/8dd4a517/mira0375291-19/722//3 ''
2013-04-10 13:03:40.263366 7f47f67f4700 10 filestore(/var/lib/ceph/osd/ceph-3) getattr 3.117_head/8dd4a517/mira0375291-19/722//3 '_' = 242
2013-04-10 13:03:40.263738 7f47f67f4700 15 filestore(/var/lib/ceph/osd/ceph-3) omap_get_header 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 13:03:40.263831 7f47f67f4700 15 filestore(/var/lib/ceph/osd/ceph-3) getattrs 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 13:03:40.263966 7f47f67f4700 10 filestore(/var/lib/ceph/osd/ceph-3) getattrs 3.117_head/8dd4a517/mira0375291-19/722//3 = 0
2013-04-10 13:03:40.263978 7f47f67f4700 15 filestore(/var/lib/ceph/osd/ceph-3) get_omap_iterator 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 13:03:40.264045 7f47f67f4700 15 filestore(/var/lib/ceph/osd/ceph-3) read 3.117_head/8dd4a517/mira0375291-19/722//3 0~57
2013-04-10 13:03:40.264077 7f47f67f4700 10 filestore(/var/lib/ceph/osd/ceph-3) FileStore::read 3.117_head/8dd4a517/mira0375291-19/722//3 0~57/57
2013-04-10 13:03:40.264082 7f47f67f4700 15 filestore(/var/lib/ceph/osd/ceph-3) read 3.117_head/8dd4a517/mira0375291-19/722//3 403771~1048519
2013-04-10 13:03:40.266167 7f47f67f4700 10 filestore(/var/lib/ceph/osd/ceph-3) FileStore::read 3.117_head/8dd4a517/mira0375291-19/722//3 403771~1048519/1048519
2013-04-10 13:03:40.308977 7f47f6ff5700 15 filestore(/var/lib/ceph/osd/ceph-3) read 3.117_head/8dd4a517/mira0375291-19/722//3 1452290~1048576
2013-04-10 13:03:40.317080 7f47f6ff5700 10 filestore(/var/lib/ceph/osd/ceph-3) FileStore::read 3.117_head/8dd4a517/mira0375291-19/722//3 1452290~1048576/1048576
2013-04-10 13:03:40.657445 7f47f77f6700 15 filestore(/var/lib/ceph/osd/ceph-3) read 3.117_head/8dd4a517/mira0375291-19/722//3 2500866~710637
2013-04-10 13:03:40.657874 7f47f77f6700 10 filestore(/var/lib/ceph/osd/ceph-3) FileStore::read 3.117_head/8dd4a517/mira0375291-19/722//3 2500866~710637/710637
2013-04-10 13:04:51.563349 7f47f5ff3700 15 filestore(/var/lib/ceph/osd/ceph-3) getattr 3.117_head/8dd4a517/mira0375291-19/722//3 '_'
2013-04-10 13:04:51.563412 7f47f5ff3700 10 filestore(/var/lib/ceph/osd/ceph-3) getattr 3.117_head/8dd4a517/mira0375291-19/722//3 '_' = 242
2013-04-10 13:04:51.564871 7f4802ffd700 15 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 13:04:51.565454 7f4802ffd700 10 filestore hoid: 8dd4a517/mira0375291-19/722//3 not skipping op, *spos 1369017.1.2
2013-04-10 13:04:51.565476 7f4802ffd700 10 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_head/8dd4a517/mira0375291-19/722//3 = 0
2013-04-10 13:05:10.453545 7f47f5ff3700 15 filestore(/var/lib/ceph/osd/ceph-3) getattr 3.117_head/8dd4a517/mira0375291-19/722//3 '_'
2013-04-10 13:05:10.453624 7f47f5ff3700 10 filestore(/var/lib/ceph/osd/ceph-3) getattr 3.117_head/8dd4a517/mira0375291-19/722//3 '_' = 234
2013-04-10 13:05:10.455585 7f48037fe700 15 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 13:05:10.455667 7f48037fe700 10 filestore hoid: 8dd4a517/mira0375291-19/722//3 not skipping op, *spos 1373610.1.2
2013-04-10 13:05:10.457494 7f48037fe700 10 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_head/8dd4a517/mira0375291-19/722//3 = 0
2013-04-10 13:05:13.167583 7f47f5ff3700 15 filestore(/var/lib/ceph/osd/ceph-3) getattr 3.117_head/8dd4a517/mira0375291-19/722//3 '_'
2013-04-10 13:05:13.167632 7f47f5ff3700 10 filestore(/var/lib/ceph/osd/ceph-3) getattr 3.117_head/8dd4a517/mira0375291-19/722//3 '_' = 226
2013-04-10 13:05:13.169401 7f4802ffd700 15 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 13:05:13.169493 7f4802ffd700 10 filestore hoid: 8dd4a517/mira0375291-19/722//3 not skipping op, *spos 1378021.1.2
2013-04-10 13:05:13.169598 7f4802ffd700 10 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_head/8dd4a517/mira0375291-19/722//3 = 0
2013-04-10 13:25:08.418350 7f21cfff7700 15 filestore(/var/lib/ceph/osd/ceph-3) getattr 3.117_head/8dd4a517/mira0375291-19/722//3 '_'
2013-04-10 13:25:08.418445 7f21cfff7700 10 filestore(/var/lib/ceph/osd/ceph-3) getattr 3.117_head/8dd4a517/mira0375291-19/722//3 '_' = 218
2013-04-10 13:25:08.418939 7f21cfff7700 15 filestore(/var/lib/ceph/osd/ceph-3) omap_get_header 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 13:25:08.419036 7f21cfff7700 15 filestore(/var/lib/ceph/osd/ceph-3) getattrs 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 13:25:08.419322 7f21cfff7700 10 filestore(/var/lib/ceph/osd/ceph-3) getattrs 3.117_head/8dd4a517/mira0375291-19/722//3 = 0
2013-04-10 13:25:08.419331 7f21cfff7700 15 filestore(/var/lib/ceph/osd/ceph-3) get_omap_iterator 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 13:25:08.419382 7f21cfff7700 15 filestore(/var/lib/ceph/osd/ceph-3) read 3.117_head/8dd4a517/mira0375291-19/722//3 0~1048576
2013-04-10 13:25:08.441658 7f21cfff7700 10 filestore(/var/lib/ceph/osd/ceph-3) FileStore::read 3.117_head/8dd4a517/mira0375291-19/722//3 0~1048576/1048576
2013-04-10 13:25:09.393756 7f21d07f8700 15 filestore(/var/lib/ceph/osd/ceph-3) read 3.117_head/8dd4a517/mira0375291-19/722//3 1048576~1048576
2013-04-10 13:25:09.396294 7f21d07f8700 10 filestore(/var/lib/ceph/osd/ceph-3) FileStore::read 3.117_head/8dd4a517/mira0375291-19/722//3 1048576~1048576/1048576
2013-04-10 13:25:10.574744 7f21d07f8700 15 filestore(/var/lib/ceph/osd/ceph-3) read 3.117_head/8dd4a517/mira0375291-19/722//3 2097152~1048576
2013-04-10 13:25:10.575783 7f21d07f8700 10 filestore(/var/lib/ceph/osd/ceph-3) FileStore::read 3.117_head/8dd4a517/mira0375291-19/722//3 2097152~1048576/1048576
2013-04-10 13:25:11.539567 7f21d07f8700 15 filestore(/var/lib/ceph/osd/ceph-3) read 3.117_head/8dd4a517/mira0375291-19/722//3 3145728~65775
2013-04-10 13:25:11.539807 7f21d07f8700 10 filestore(/var/lib/ceph/osd/ceph-3) FileStore::read 3.117_head/8dd4a517/mira0375291-19/722//3 3145728~65536/65775
2013-04-10 13:36:04.766905 7f21d0ff9700 10 filestore(/var/lib/ceph/osd/ceph-3) stat 3.117_head/8dd4a517/mira0375291-19/722//3 = 0 (size 3211264)
2013-04-10 13:36:04.767009 7f21d0ff9700 15 filestore(/var/lib/ceph/osd/ceph-3) omap_get_header 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 13:36:04.767141 7f21d0ff9700 15 filestore(/var/lib/ceph/osd/ceph-3) getattrs 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 13:36:04.767265 7f21d0ff9700 10 filestore(/var/lib/ceph/osd/ceph-3) getattrs 3.117_head/8dd4a517/mira0375291-19/722//3 = 0
2013-04-10 13:36:04.767274 7f21d0ff9700 15 filestore(/var/lib/ceph/osd/ceph-3) get_omap_iterator 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 13:36:04.767331 7f21d0ff9700 15 filestore(/var/lib/ceph/osd/ceph-3) read 3.117_head/8dd4a517/mira0375291-19/722//3 0~57
2013-04-10 13:36:04.767382 7f21d0ff9700 10 filestore(/var/lib/ceph/osd/ceph-3) FileStore::read 3.117_head/8dd4a517/mira0375291-19/722//3 0~57/57
2013-04-10 13:36:04.767388 7f21d0ff9700 15 filestore(/var/lib/ceph/osd/ceph-3) read 3.117_head/8dd4a517/mira0375291-19/722//3 441301~899911
2013-04-10 13:36:04.768309 7f21d0ff9700 10 filestore(/var/lib/ceph/osd/ceph-3) FileStore::read 3.117_head/8dd4a517/mira0375291-19/722//3 441301~899911/899911
2013-04-10 13:36:04.768318 7f21d0ff9700 15 filestore(/var/lib/ceph/osd/ceph-3) read 3.117_head/8dd4a517/mira0375291-19/722//3 1464584~148608
2013-04-10 13:36:04.768448 7f21d0ff9700 10 filestore(/var/lib/ceph/osd/ceph-3) FileStore::read 3.117_head/8dd4a517/mira0375291-19/722//3 1464584~148608/148608
2013-04-10 13:36:27.287516 7f21d07f8700 10 filestore(/var/lib/ceph/osd/ceph-3) stat 3.117_head/8dd4a517/mira0375291-19/722//3 = 0 (size 3211264)
2013-04-10 13:36:27.287614 7f21d07f8700 15 filestore(/var/lib/ceph/osd/ceph-3) read 3.117_head/8dd4a517/mira0375291-19/722//3 1613192~300455
2013-04-10 13:36:27.287975 7f21d07f8700 10 filestore(/var/lib/ceph/osd/ceph-3) FileStore::read 3.117_head/8dd4a517/mira0375291-19/722//3 1613192~300455/300455
2013-04-10 13:36:27.287990 7f21d07f8700 15 filestore(/var/lib/ceph/osd/ceph-3) read 3.117_head/8dd4a517/mira0375291-19/722//3 1970493~748121
2013-04-10 13:36:27.288757 7f21d07f8700 10 filestore(/var/lib/ceph/osd/ceph-3) FileStore::read 3.117_head/8dd4a517/mira0375291-19/722//3 1970493~748121/748121
2013-04-10 13:36:36.896998 7f21d07f8700 10 filestore(/var/lib/ceph/osd/ceph-3) stat 3.117_head/8dd4a517/mira0375291-19/722//3 = 0 (size 3211264)
2013-04-10 13:36:36.897044 7f21d07f8700 15 filestore(/var/lib/ceph/osd/ceph-3) read 3.117_head/8dd4a517/mira0375291-19/722//3 2718614~374840
2013-04-10 13:36:36.897395 7f21d07f8700 10 filestore(/var/lib/ceph/osd/ceph-3) FileStore::read 3.117_head/8dd4a517/mira0375291-19/722//3 2718614~374840/374840
2013-04-10 13:37:25.075604 7f21ed7fa700 15 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 13:37:25.075712 7f21ed7fa700 10 filestore hoid: 8dd4a517/mira0375291-19/722//3 not skipping op, *spos 1487744.1.2
2013-04-10 13:37:25.075736 7f21ed7fa700 10 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_head/8dd4a517/mira0375291-19/722//3 = 0
2013-04-10 13:37:34.104814 7f21ed7fa700 15 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 13:37:34.104889 7f21ed7fa700 10 filestore hoid: 8dd4a517/mira0375291-19/722//3 not skipping op, *spos 1497663.1.2
2013-04-10 13:37:34.104906 7f21ed7fa700 10 filestore(/var/lib/ceph/osd/ceph-3) setattrs 3.117_head/8dd4a517/mira0375291-19/722//3 = 0
2013-04-10 13:37:39.368988 7f21ecff9700 15 filestore(/var/lib/ceph/osd/ceph-3) remove 3.117_head/8dd4a517/mira0375291-19/722//3
2013-04-10 13:37:39.369085 7f21ecff9700 20 filestore(/var/lib/ceph/osd/ceph-3) lfn_unlink: clearing omap on 8dd4a517/mira0375291-19/722//3 in cid 3.117_head
2013-04-10 13:37:39.369138 7f21ecff9700 10 filestore hoid: 8dd4a517/mira0375291-19/722//3 not skipping op, *spos 1500653.1.2
2013-04-10 13:37:39.369145 7f21ecff9700 20 filestore remove_map_header: removing 12882 hoid 8dd4a517/mira0375291-19/722//3
2013-04-10 13:37:39.372905 7f21ecff9700 10 filestore(/var/lib/ceph/osd/ceph-3) remove 3.117_head/8dd4a517/mira0375291-19/722//3 = 0
(END)
Updated by Samuel Just about 11 years ago
- Status changed from New to Rejected
this seems likely to be a btrfs bug.