https://tracker.ceph.com/
https://tracker.ceph.com/favicon.ico
2013-05-24T01:52:49Z
Ceph
CephFS - Bug #5162: File is locked unexpected and not released anymore
https://tracker.ceph.com/issues/5162?journal_id=22432
2013-05-24T01:52:49Z
Zheng Yan
ukernel@gmail.com
<ul></ul><p>looks like client's fault. try following command on client.5898 and upload debug.txt:</p>
<ol>
<li>echo module ceph +p >/sys/kernel/debug/dynamic_debug/control</li>
<li>dmesg -c > /dev/null</li>
<li>cat data/owncloud.log<br /> ctrl^c</li>
<li>ls -l data/owncloud.log<br /> ctrl^c</li>
<li>dmesg > debug.txt</li>
</ol>
CephFS - Bug #5162: File is locked unexpected and not released anymore
https://tracker.ceph.com/issues/5162?journal_id=22526
2013-05-26T20:09:03Z
joe huang
clh.joe@gmail.com
<ul></ul><p>Hi Zheng,<br /> Sorry for reply late. Here is the kernel msg.<br />[ 219.824078] ceph: mdsc delayed_work<br />[ 219.824085] ceph: check_delayed_caps<br />[ 219.824090] ceph: lookup_mds_session ffff880118e22800 3<br />[ 219.824093] ceph: mdsc get_session ffff880118e22800 3 -> 4<br />[ 219.824096] ceph: mdsc get_session ffff880118e22800 4 -> 5<br />[ 219.824098] ceph: mdsc con_get ffff880118e22800 ok (5)<br />[ 219.824102] ceph: add_cap_releases ffff880118e22800 mds0 extra 680<br />[ 219.824105] ceph: send_cap_releases mds0<br />[ 219.824107] ceph: mdsc put_session ffff880118e22800 5 -> 4<br />[ 219.824131] ceph: mdsc con_put ffff880118e22800 (3)<br />[ 219.824133] ceph: mdsc put_session ffff880118e22800 4 -> 3<br />[ 224.832061] ceph: mdsc delayed_work<br />[ 224.832065] ceph: check_delayed_caps<br />[ 224.832068] ceph: lookup_mds_session ffff880118e22800 3<br />[ 224.832069] ceph: mdsc get_session ffff880118e22800 3 -> 4<br />[ 224.832071] ceph: send_renew_caps to mds0 (up:active)<br />[ 224.832074] ceph: mdsc get_session ffff880118e22800 4 -> 5<br />[ 224.832075] ceph: mdsc con_get ffff880118e22800 ok (5)<br />[ 224.832076] ceph: mdsc get_session ffff880118e22800 5 -> 6<br />[ 224.832077] ceph: mdsc con_get ffff880118e22800 ok (6)<br />[ 224.832080] ceph: add_cap_releases ffff880118e22800 mds0 extra 680<br />[ 224.832081] ceph: send_cap_releases mds0<br />[ 224.832082] ceph: mdsc put_session ffff880118e22800 6 -> 5<br />[ 224.832118] ceph: mdsc con_put ffff880118e22800 (4)<br />[ 224.832119] ceph: mdsc put_session ffff880118e22800 5 -> 4<br />[ 224.832698] ceph: mdsc get_session ffff880118e22800 4 -> 5<br />[ 224.832701] ceph: mdsc con_get ffff880118e22800 ok (5)<br />[ 224.832727] ceph: mdsc con_put ffff880118e22800 (4)<br />[ 224.832728] ceph: mdsc put_session ffff880118e22800 5 -> 4<br />[ 224.832731] ceph: mdsc get_session ffff880118e22800 4 -> 5<br />[ 224.832732] ceph: mdsc con_get ffff880118e22800 ok (5)<br />[ 224.832736] ceph: mdsc con_put ffff880118e22800 (4)<br />[ 224.832737] ceph: mdsc put_session ffff880118e22800 5 -> 4<br />[ 224.832739] ceph: handle_session mds0 renewcaps ffff880118e22800 state open seq 11<br />[ 224.832741] ceph: renewed_caps mds0 ttl now 4294963504, was fresh, now stale<br />[ 224.832745] ceph: mdsc con_put ffff880118e22800 (3)<br />[ 224.832746] ceph: mdsc put_session ffff880118e22800 4 -> 3<br />[ 229.824053] ceph: mdsc delayed_work<br />[ 229.824057] ceph: check_delayed_caps<br />[ 229.824061] ceph: lookup_mds_session ffff880118e22800 3<br />[ 229.824063] ceph: mdsc get_session ffff880118e22800 3 -> 4<br />[ 229.824066] ceph: mdsc get_session ffff880118e22800 4 -> 5<br />[ 229.824067] ceph: mdsc con_get ffff880118e22800 ok (5)<br />[ 229.824071] ceph: add_cap_releases ffff880118e22800 mds0 extra 680<br />[ 229.824073] ceph: send_cap_releases mds0<br />[ 229.824074] ceph: mdsc put_session ffff880118e22800 5 -> 4<br />[ 229.824094] ceph: mdsc con_put ffff880118e22800 (3)<br />[ 229.824096] ceph: mdsc put_session ffff880118e22800 4 -> 3<br />[ 230.941787] ceph: do_getattr inode ffff880117218308 mask As mode 040755<br />[ 230.941792] ceph: __ceph_caps_issued_mask ffff880117218308 cap ffff8801171e2080 issued pAsLsXsFs (mask As)<br />[ 230.941794] ceph: __touch_cap ffff880117218308 cap ffff8801171e2080 mds0<br />[ 230.941796] ceph: d_revalidate ffff880117201e40 'data' inode ffff880117288308 offset 0<br />[ 230.941798] ceph: dentry_lease_is_valid - dentry ffff880117201e40 = 0<br />[ 230.941799] ceph: __ceph_caps_issued_mask ffff880117218308 cap ffff8801171e2080 issued pAsLsXsFs (mask Fs)<br />[ 230.941800] ceph: __touch_cap ffff880117218308 cap ffff8801171e2080 mds0<br />[ 230.941809] ceph: dir_lease_is_valid dir ffff880117218308 v1 dentry ffff880117201e40 v1 = 1<br />[ 230.941811] ceph: d_revalidate ffff880117201e40 valid<br />[ 230.941812] ceph: dentry_lru_touch ffff8801171e3058 ffff880117201e40 'data' (offset 0)<br />[ 230.941814] ceph: do_getattr inode ffff880117288308 mask As mode 040750<br />[ 230.941815] ceph: __ceph_caps_issued_mask ffff880117288308 cap ffff8801171e2100 issued pAsLsXsFs (mask As)<br />[ 230.941816] ceph: __touch_cap ffff880117288308 cap ffff8801171e2100 mds0<br />[ 230.941818] ceph: d_revalidate ffff880117201d80 'owncloud.log' inode ffff880117288848 offset 53<br />[ 230.941819] ceph: dentry_lease_is_valid - dentry ffff880117201d80 = 0<br />[ 230.941820] ceph: __ceph_caps_issued_mask ffff880117288308 cap ffff8801171e2100 issued pAsLsXsFs (mask Fs)<br />[ 230.941821] ceph: __touch_cap ffff880117288308 cap ffff8801171e2100 mds0<br />[ 230.941823] ceph: dir_lease_is_valid dir ffff880117288308 v1 dentry ffff880117201d80 v1 = 1<br />[ 230.941823] ceph: d_revalidate ffff880117201d80 valid<br />[ 230.941824] ceph: dentry_lru_touch ffff8801171e30b0 ffff880117201d80 'owncloud.log' (offset 53)<br />[ 230.941826] ceph: do_getattr inode ffff880117288848 mask As mode 0100644<br />[ 230.941827] ceph: __ceph_caps_issued_mask ffff880117288848 cap ffff8801171e2180 issued pAsLsXsFcb (mask As)<br />[ 230.941828] ceph: __touch_cap ffff880117288848 cap ffff8801171e2180 mds0<br />[ 230.941831] ceph: open inode ffff880117288848 ino 10000000072.fffffffffffffffe file ffff88011539bc00 flags 32768 (32768)<br />[ 230.941833] ceph: __ceph_caps_issued ffff880117288848 cap ffff8801171e2180 issued pAsLsXsFcb<br />[ 230.941834] ceph: open ffff880117288848 fmode 1 want pFscr issued pAsLsXsFcb using existing<br />[ 230.941835] ceph: init_file ffff880117288848 ffff88011539bc00 0100644 (regular)<br />[ 230.941838] ceph: do_getattr inode ffff880117288848 mask pAsLsXsFs mode 0100644<br />[ 230.941839] ceph: do_request on ffff8801197d3400<br />[ 230.941841] ceph: reserve caps ctx=ffff8801197d36e0 need=1<br />[ 230.941843] ceph: reserve caps ctx=ffff8801197d36e0 1029 = 54 used + 3 resv + 972 avail<br />[ 230.941844] ceph: __register_request ffff8801197d3400 tid 7<br />[ 230.941846] ceph: __choose_mds ffff880117288848 is_hash=0 (0) mode 0<br />[ 230.941847] ceph: choose_mds ffff880117288848 10000000072.fffffffffffffffe mds0 (auth cap ffff8801171e2180)<br />[ 230.941849] ceph: lookup_mds_session ffff880118e22800 3<br />[ 230.941850] ceph: mdsc get_session ffff880118e22800 3 -> 4<br />[ 230.941851] ceph: mdsc get_session ffff880118e22800 4 -> 5<br />[ 230.941852] ceph: do_request mds0 session ffff880118e22800 state open<br />[ 230.941854] ceph: prepare_send_request ffff8801197d3400 tid 7 getattr (attempt 1)<br />[ 230.941855] ceph: inode ffff880117288848 10000000072.fffffffffffffffe<br />[ 230.941857] ceph: r_locked_dir = (null)<br />[ 230.941859] ceph: mdsc get_session ffff880118e22800 5 -> 6<br />[ 230.941859] ceph: mdsc con_get ffff880118e22800 ok (6)<br />[ 230.941861] ceph: mdsc get_session ffff880118e22800 6 -> 7<br />[ 230.941862] ceph: mdsc con_get ffff880118e22800 ok (7)<br />[ 230.941866] ceph: mdsc put_session ffff880118e22800 7 -> 6<br />[ 230.941867] ceph: do_request waiting<br />[ 230.941895] ceph: mdsc con_put ffff880118e22800 (5)<br />[ 230.941897] ceph: mdsc put_session ffff880118e22800 6 -> 5<br />[ 231.147282] ceph: mdsc get_session ffff880118e22800 5 -> 6<br />[ 231.147290] ceph: mdsc con_get ffff880118e22800 ok (6)<br />[ 231.147318] ceph: mdsc con_put ffff880118e22800 (5)<br />[ 231.147321] ceph: mdsc put_session ffff880118e22800 6 -> 5<br />[ 231.147325] ceph: mdsc con_put ffff880118e22800 (4)<br />[ 231.147327] ceph: mdsc put_session ffff880118e22800 5 -> 4<br />[ 234.203046] ceph: do_request waited, got -512<br />[ 234.203050] ceph: aborted request 7 with -512<br />[ 234.203051] ceph: do_request ffff8801197d3400 done, result -512<br />[ 234.203053] ceph: do_getattr result=-512<br />[ 234.203119] ceph: release inode ffff880117288848 file ffff88011539bc00<br />[ 234.203120] ceph: put_fmode ffff880117288848 fmode 1 2 -> 1<br />[ 234.832063] ceph: mdsc delayed_work<br />[ 234.832068] ceph: check_delayed_caps<br />[ 234.832078] ceph: check_delayed_caps on ffff880117288848<br />[ 234.832083] ceph: __ceph_caps_issued ffff880117288848 cap ffff8801171e2180 issued pAsLsXsFcb<br />[ 234.832087] ceph: check_caps ffff880117288848 file_want pFscr used p dirty - flushing - issued pAsLsXsFcb revoking - retain pAsxLsxXsxFsxcrwbl NODELAY<br />[ 234.832089] ceph: mds0 cap ffff8801171e2180 issued pAsLsXsFcb implemented pAsLsXsFcb revoking -<br />[ 234.832092] ceph: lookup_mds_session ffff880118e22800 4<br />[ 234.832094] ceph: mdsc get_session ffff880118e22800 4 -> 5<br />[ 234.832097] ceph: mdsc get_session ffff880118e22800 5 -> 6<br />[ 234.832099] ceph: mdsc con_get ffff880118e22800 ok (6)<br />[ 234.832102] ceph: add_cap_releases ffff880118e22800 mds0 extra 680<br />[ 234.832104] ceph: send_cap_releases mds0<br />[ 234.832106] ceph: mdsc put_session ffff880118e22800 6 -> 5<br />[ 234.832147] ceph: mdsc con_put ffff880118e22800 (4)<br />[ 234.832149] ceph: mdsc put_session ffff880118e22800 5 -> 4<br />[ 239.824090] ceph: mdsc delayed_work<br />[ 239.824096] ceph: check_delayed_caps<br />[ 239.824101] ceph: lookup_mds_session ffff880118e22800 4<br />[ 239.824103] ceph: mdsc get_session ffff880118e22800 4 -> 5<br />[ 239.824107] ceph: mdsc get_session ffff880118e22800 5 -> 6<br />[ 239.824109] ceph: mdsc con_get ffff880118e22800 ok (6)<br />[ 239.824114] ceph: add_cap_releases ffff880118e22800 mds0 extra 680<br />[ 239.824116] ceph: send_cap_releases mds0<br />[ 239.824118] ceph: mdsc put_session ffff880118e22800 6 -> 5<br />[ 239.824169] ceph: mdsc con_put ffff880118e22800 (4)<br />[ 239.824173] ceph: mdsc put_session ffff880118e22800 5 -> 4<br />[ 243.829481] ceph: do_getattr inode ffff880117218308 mask pAsLsXsFs mode 040755<br />[ 243.829489] ceph: __ceph_caps_issued_mask ffff880117218308 cap ffff8801171e2080 issued pAsLsXsFs (mask pAsLsXsFs)<br />[ 243.829492] ceph: __touch_cap ffff880117218308 cap ffff8801171e2080 mds0<br />[ 244.737501] ceph: do_getattr inode ffff880117218308 mask pAsLsXsFs mode 040755<br />[ 244.737505] ceph: __ceph_caps_issued_mask ffff880117218308 cap ffff8801171e2080 issued pAsLsXsFs (mask pAsLsXsFs)<br />[ 244.737507] ceph: __touch_cap ffff880117218308 cap ffff8801171e2080 mds0<br />[ 244.738791] ceph: do_getattr inode ffff880117218308 mask pAsLsXsFs mode 040755<br />[ 244.738794] ceph: __ceph_caps_issued_mask ffff880117218308 cap ffff8801171e2080 issued pAsLsXsFs (mask pAsLsXsFs)<br />[ 244.738795] ceph: __touch_cap ffff880117218308 cap ffff8801171e2080 mds0<br />[ 244.832046] ceph: mdsc delayed_work<br />[ 244.832049] ceph: check_delayed_caps<br />[ 244.832052] ceph: lookup_mds_session ffff880118e22800 4<br />[ 244.832053] ceph: mdsc get_session ffff880118e22800 4 -> 5<br />[ 244.832055] ceph: send_renew_caps to mds0 (up:active)<br />[ 244.832058] ceph: mdsc get_session ffff880118e22800 5 -> 6<br />[ 244.832059] ceph: mdsc con_get ffff880118e22800 ok (6)<br />[ 244.832060] ceph: mdsc get_session ffff880118e22800 6 -> 7<br />[ 244.832060] ceph: mdsc con_get ffff880118e22800 ok (7)<br />[ 244.832063] ceph: add_cap_releases ffff880118e22800 mds0 extra 680<br />[ 244.832064] ceph: send_cap_releases mds0<br />[ 244.832065] ceph: mdsc put_session ffff880118e22800 7 -> 6<br />[ 244.832108] ceph: mdsc con_put ffff880118e22800 (5)<br />[ 244.832117] ceph: mdsc put_session ffff880118e22800 6 -> 5<br />[ 244.832727] ceph: mdsc get_session ffff880118e22800 5 -> 6<br />[ 244.832729] ceph: mdsc con_get ffff880118e22800 ok (6)<br />[ 244.832755] ceph: mdsc con_put ffff880118e22800 (5)<br />[ 244.832757] ceph: mdsc put_session ffff880118e22800 6 -> 5<br />[ 244.832762] ceph: mdsc get_session ffff880118e22800 5 -> 6<br />[ 244.832763] ceph: mdsc con_get ffff880118e22800 ok (6)<br />[ 244.832767] ceph: mdsc con_put ffff880118e22800 (5)<br />[ 244.832769] ceph: mdsc put_session ffff880118e22800 6 -> 5<br />[ 244.832772] ceph: handle_session mds0 renewcaps ffff880118e22800 state open seq 12<br />[ 244.832773] ceph: renewed_caps mds0 ttl now 4294968504, was fresh, now stale<br />[ 244.832778] ceph: mdsc con_put ffff880118e22800 (4)<br />[ 244.832779] ceph: mdsc put_session ffff880118e22800 5 -> 4<br />[ 246.312593] ceph: do_getattr inode ffff880117218308 mask As mode 040755<br />[ 246.312598] ceph: __ceph_caps_issued_mask ffff880117218308 cap ffff8801171e2080 issued pAsLsXsFs (mask As)<br />[ 246.312600] ceph: __touch_cap ffff880117218308 cap ffff8801171e2080 mds0<br />[ 246.312602] ceph: d_revalidate ffff880117201e40 'data' inode ffff880117288308 offset 0<br />[ 246.312604] ceph: dentry_lease_is_valid - dentry ffff880117201e40 = 0<br />[ 246.312605] ceph: __ceph_caps_issued_mask ffff880117218308 cap ffff8801171e2080 issued pAsLsXsFs (mask Fs)<br />[ 246.312606] ceph: __touch_cap ffff880117218308 cap ffff8801171e2080 mds0<br />[ 246.312607] ceph: dir_lease_is_valid dir ffff880117218308 v1 dentry ffff880117201e40 v1 = 1<br />[ 246.312608] ceph: d_revalidate ffff880117201e40 valid<br />[ 246.312609] ceph: dentry_lru_touch ffff8801171e3058 ffff880117201e40 'data' (offset 0)<br />[ 246.312611] ceph: do_getattr inode ffff880117288308 mask As mode 040750<br />[ 246.312612] ceph: __ceph_caps_issued_mask ffff880117288308 cap ffff8801171e2100 issued pAsLsXsFs (mask As)<br />[ 246.312613] ceph: __touch_cap ffff880117288308 cap ffff8801171e2100 mds0<br />[ 246.312615] ceph: d_revalidate ffff880117201d80 'owncloud.log' inode ffff880117288848 offset 53<br />[ 246.312616] ceph: dentry_lease_is_valid - dentry ffff880117201d80 = 0<br />[ 246.312618] ceph: __ceph_caps_issued_mask ffff880117288308 cap ffff8801171e2100 issued pAsLsXsFs (mask Fs)<br />[ 246.312619] ceph: __touch_cap ffff880117288308 cap ffff8801171e2100 mds0<br />[ 246.312620] ceph: dir_lease_is_valid dir ffff880117288308 v1 dentry ffff880117201d80 v1 = 1<br />[ 246.312621] ceph: d_revalidate ffff880117201d80 valid<br />[ 246.312622] ceph: dentry_lru_touch ffff8801171e30b0 ffff880117201d80 'owncloud.log' (offset 53)<br />[ 246.312623] ceph: do_getattr inode ffff880117288848 mask pAsLsXsFs mode 0100644<br />[ 246.312626] ceph: do_request on ffff88011532cc00<br />[ 246.312628] ceph: reserve caps ctx=ffff88011532cee0 need=1<br />[ 246.312629] ceph: reserve caps ctx=ffff88011532cee0 1029 = 54 used + 4 resv + 971 avail<br />[ 246.312630] ceph: __register_request ffff88011532cc00 tid 8<br />[ 246.312632] ceph: __choose_mds ffff880117288848 is_hash=0 (0) mode 0<br />[ 246.312634] ceph: choose_mds ffff880117288848 10000000072.fffffffffffffffe mds0 (auth cap ffff8801171e2180)<br />[ 246.312636] ceph: lookup_mds_session ffff880118e22800 4<br />[ 246.312637] ceph: mdsc get_session ffff880118e22800 4 -> 5<br />[ 246.312638] ceph: mdsc get_session ffff880118e22800 5 -> 6<br />[ 246.312639] ceph: do_request mds0 session ffff880118e22800 state open<br />[ 246.312641] ceph: prepare_send_request ffff88011532cc00 tid 8 getattr (attempt 1)<br />[ 246.312642] ceph: inode ffff880117288848 10000000072.fffffffffffffffe<br />[ 246.312644] ceph: r_locked_dir = (null)<br />[ 246.312646] ceph: mdsc get_session ffff880118e22800 6 -> 7<br />[ 246.312647] ceph: mdsc con_get ffff880118e22800 ok (7)<br />[ 246.312648] ceph: mdsc get_session ffff880118e22800 7 -> 8<br />[ 246.312649] ceph: mdsc con_get ffff880118e22800 ok (8)<br />[ 246.312654] ceph: mdsc put_session ffff880118e22800 8 -> 7<br />[ 246.312655] ceph: do_request waiting<br />[ 246.312690] ceph: mdsc con_put ffff880118e22800 (6)<br />[ 246.312691] ceph: mdsc put_session ffff880118e22800 7 -> 6<br />[ 246.519252] ceph: mdsc get_session ffff880118e22800 6 -> 7<br />[ 246.519264] ceph: mdsc con_get ffff880118e22800 ok (7)<br />[ 246.519291] ceph: mdsc con_put ffff880118e22800 (6)<br />[ 246.519293] ceph: mdsc put_session ffff880118e22800 7 -> 6<br />[ 246.519295] ceph: mdsc con_put ffff880118e22800 (5)<br />[ 246.519296] ceph: mdsc put_session ffff880118e22800 6 -> 5<br />[ 249.824059] ceph: mdsc delayed_work<br />[ 249.824063] ceph: check_delayed_caps<br />[ 249.824066] ceph: lookup_mds_session ffff880118e22800 5<br />[ 249.824067] ceph: mdsc get_session ffff880118e22800 5 -> 6<br />[ 249.824069] ceph: mdsc get_session ffff880118e22800 6 -> 7<br />[ 249.824070] ceph: mdsc con_get ffff880118e22800 ok (7)<br />[ 249.824073] ceph: add_cap_releases ffff880118e22800 mds0 extra 680<br />[ 249.824074] ceph: send_cap_releases mds0<br />[ 249.824075] ceph: mdsc put_session ffff880118e22800 7 -> 6<br />[ 249.824127] ceph: mdsc con_put ffff880118e22800 (5)<br />[ 249.824128] ceph: mdsc put_session ffff880118e22800 6 -> 5<br />[ 254.832060] ceph: mdsc delayed_work<br />[ 254.832064] ceph: check_delayed_caps<br />[ 254.832066] ceph: lookup_mds_session ffff880118e22800 5<br />[ 254.832068] ceph: mdsc get_session ffff880118e22800 5 -> 6<br />[ 254.832069] ceph: mdsc get_session ffff880118e22800 6 -> 7<br />[ 254.832070] ceph: mdsc con_get ffff880118e22800 ok (7)<br />[ 254.832073] ceph: add_cap_releases ffff880118e22800 mds0 extra 680<br />[ 254.832074] ceph: send_cap_releases mds0<br />[ 254.832075] ceph: mdsc put_session ffff880118e22800 7 -> 6<br />[ 254.832112] ceph: mdsc con_put ffff880118e22800 (5)<br />[ 254.832113] ceph: mdsc put_session ffff880118e22800 6 -> 5<br />[ 259.824090] ceph: mdsc delayed_work<br />[ 259.824095] ceph: check_delayed_caps<br />[ 259.824100] ceph: lookup_mds_session ffff880118e22800 5<br />[ 259.824102] ceph: mdsc get_session ffff880118e22800 5 -> 6<br />[ 259.824106] ceph: mdsc get_session ffff880118e22800 6 -> 7<br />[ 259.824108] ceph: mdsc con_get ffff880118e22800 ok (7)<br />[ 259.824113] ceph: add_cap_releases ffff880118e22800 mds0 extra 680<br />[ 259.824115] ceph: send_cap_releases mds0<br />[ 259.824117] ceph: mdsc put_session ffff880118e22800 7 -> 6<br />[ 259.824172] ceph: mdsc con_put ffff880118e22800 (5)<br />[ 259.824175] ceph: mdsc put_session ffff880118e22800 6 -> 5<br />[ 264.832072] ceph: mdsc delayed_work<br />[ 264.832078] ceph: check_delayed_caps<br />[ 264.832082] ceph: lookup_mds_session ffff880118e22800 5<br />[ 264.832085] ceph: mdsc get_session ffff880118e22800 5 -> 6<br />[ 264.832088] ceph: send_renew_caps to mds0 (up:active)<br />[ 264.832094] ceph: mdsc get_session ffff880118e22800 6 -> 7<br />[ 264.832096] ceph: mdsc con_get ffff880118e22800 ok (7)<br />[ 264.832098] ceph: mdsc get_session ffff880118e22800 7 -> 8<br />[ 264.832100] ceph: mdsc con_get ffff880118e22800 ok (8)<br />[ 264.832104] ceph: add_cap_releases ffff880118e22800 mds0 extra 680<br />[ 264.832106] ceph: send_cap_releases mds0<br />[ 264.832109] ceph: mdsc put_session ffff880118e22800 8 -> 7<br />[ 264.832166] ceph: mdsc con_put ffff880118e22800 (6)<br />[ 264.832168] ceph: mdsc put_session ffff880118e22800 7 -> 6<br />[ 264.832744] ceph: mdsc get_session ffff880118e22800 6 -> 7<br />[ 264.832749] ceph: mdsc con_get ffff880118e22800 ok (7)<br />[ 264.832797] ceph: mdsc con_put ffff880118e22800 (6)<br />[ 264.832800] ceph: mdsc put_session ffff880118e22800 7 -> 6<br />[ 264.832806] ceph: mdsc get_session ffff880118e22800 6 -> 7<br />[ 264.832808] ceph: mdsc con_get ffff880118e22800 ok (7)<br />[ 264.832813] ceph: mdsc con_put ffff880118e22800 (6)<br />[ 264.832815] ceph: mdsc put_session ffff880118e22800 7 -> 6<br />[ 264.832820] ceph: handle_session mds0 renewcaps ffff880118e22800 state open seq 13<br />[ 264.832823] ceph: renewed_caps mds0 ttl now 4294973504, was fresh, now stale<br />[ 264.832832] ceph: mdsc con_put ffff880118e22800 (5)<br />[ 264.832834] ceph: mdsc put_session ffff880118e22800 6 -> 5</p>
<p>Zheng Yan wrote:</p>
<blockquote>
<p>looks like client's fault. try following command on client.5898 and upload debug.txt:</p>
<ol>
<li>echo module ceph +p >/sys/kernel/debug/dynamic_debug/control</li>
<li>dmesg -c > /dev/null</li>
<li>cat data/owncloud.log<br />ctrl^c</li>
<li>ls -l data/owncloud.log<br />ctrl^c</li>
<li>dmesg > debug.txt</li>
</ol>
</blockquote>
CephFS - Bug #5162: File is locked unexpected and not released anymore
https://tracker.ceph.com/issues/5162?journal_id=22527
2013-05-26T22:43:53Z
Zheng Yan
ukernel@gmail.com
<ul></ul><blockquote>
<p>ceph: check_caps ffff880117288848 file_want pFscr used p dirty - flushing - issued pAsLsXsFcb revoking - retain pAsxLsxXsxFsxcrwbl NODELAY</p>
</blockquote>
<p>Client has released the caps, but the MDS thinks it hasn't. No idea what was wrong, but restarting the MDS should solve your issue.<br />If you enabled mds logging from the beginning, please grep 'inode 10000000072' from the mds log and upload the result.</p>
CephFS - Bug #5162: File is locked unexpected and not released anymore
https://tracker.ceph.com/issues/5162?journal_id=22530
2013-05-27T04:51:15Z
joe huang
clh.joe@gmail.com
<ul></ul><p>I tried restart all ceph services by issuing # /etc/init.d/ceph -a restart but didn't solve the problem. However I did this again and it worked. But I didn't see any msg by grep 'inode 10000000072' from the mds log.</p>
CephFS - Bug #5162: File is locked unexpected and not released anymore
https://tracker.ceph.com/issues/5162?journal_id=22556
2013-05-28T09:41:18Z
Anonymous
<ul><li><strong>Priority</strong> changed from <i>Urgent</i> to <i>High</i></li></ul>
CephFS - Bug #5162: File is locked unexpected and not released anymore
https://tracker.ceph.com/issues/5162?journal_id=28101
2013-10-02T12:12:44Z
Sage Weil
sage@newdream.net
<ul><li><strong>Status</strong> changed from <i>New</i> to <i>Can't reproduce</i></li></ul>
CephFS - Bug #5162: File is locked unexpected and not released anymore
https://tracker.ceph.com/issues/5162?journal_id=74503
2016-07-13T00:58:48Z
Greg Farnum
gfarnum@redhat.com
<ul><li><strong>Component(FS)</strong> <i>libcephfs</i> added</li></ul>