Ceph » Linux kernel client

client appears to be sending dup flushsnap messages

this

mkdir mnt/foo
echo asdf > mnt/foo/asdf
mkdir mnt/foo/.snap/a
echo qwer >> mnt/foo/asdf
sync

10.08.05_10:06:46.077871 7f6391a13710 -- 10.0.1.252:6802/5745 <== client4107 10.0.1.200:0/4192129970 4 ==== client_request(client4107:2 lookup #1/foo) ==== 117+0+0 (2352819025 0 0) 0x1f63d90
10.08.05_10:06:46.078300 7f6391a13710 -- 10.0.1.252:6802/5745 --> 10.0.1.200:0/4192129970 -- client_reply(???:2 = -2 No such file or directory) v1 -- ?+0 0x7f638c02c950
10.08.05_10:06:46.078677 7f6391a13710 -- 10.0.1.252:6802/5745 <== client4107 10.0.1.200:0/4192129970 5 ==== client_request(client4107:3 mkdir #1/foo) ==== 161+0+0 (959283239 0 0) 0x1f5b6c0
10.08.05_10:06:46.132970 7f6391a13710 -- 10.0.1.252:6802/5745 --> 10.0.1.200:0/4192129970 -- client_reply(???:3 = 0 Success safe) v1 -- ?+0 0x7f638c046910
10.08.05_10:06:46.134177 7f6391a13710 -- 10.0.1.252:6802/5745 <== client4107 10.0.1.200:0/4192129970 6 ==== client_request(client4107:4 lookup #10000000000/asdf) ==== 118+0+0 (1874422200 0 0) 0x1f5b6c0
10.08.05_10:06:46.134529 7f6391a13710 -- 10.0.1.252:6802/5745 --> 10.0.1.200:0/4192129970 -- client_reply(???:4 = -2 No such file or directory) v1 -- ?+0 0x7f638c046410
10.08.05_10:06:46.134761 7f6391a13710 -- 10.0.1.252:6802/5745 <== client4107 10.0.1.200:0/4192129970 7 ==== client_request(client4107:5 create #10000000000/asdf) ==== 118+0+0 (3659698617 0 0) 0x1f5b6c0
10.08.05_10:06:46.135736 7f6391a13710 -- 10.0.1.252:6802/5745 --> 10.0.1.200:0/4192129970 -- client_caps(revoke ino 10000000000 2 seq 4 caps=pAsLsXsxFsx dirty=- wanted=- follows 0 size 0/0 ts 1 mtime 10.08.05_10:06:46.079663) v1 -- ?+0 0x7f638c0462a0
10.08.05_10:06:46.136053 7f6391a13710 -- 10.0.1.252:6802/5745 <== client4107 10.0.1.200:0/4192129970 8 ==== client_caps(update ino 10000000000 2 seq 4 caps=pAsLsXsxFsx dirty=- wanted=p follows 1 size 0/0 mtime 10.08.05_10:06:46.079663) ==== 176+0+0 (3365629921 0 0) 0x1f62170
10.08.05_10:06:46.138184 7f6391a13710 -- 10.0.1.252:6802/5745 --> 10.0.1.200:0/4192129970 -- client_reply(???:5 = 0 Success unsafe) v1 -- ?+0 0x7f638c04b500
10.08.05_10:06:46.153052 7f6391a13710 -- 10.0.1.252:6802/5745 <== client4107 10.0.1.200:0/4192129970 9 ==== client_request(client4107:6 lookup #10000000000/.snap) ==== 119+0+0 (1702742425 0 0) 0x1f63d90
10.08.05_10:06:46.190756 7f6391a13710 -- 10.0.1.252:6802/5745 --> 10.0.1.200:0/4192129970 -- client_reply(???:6 = -2 No such file or directory) v1 -- ?+0 0x7f638c04b4e0
10.08.05_10:06:46.191077 7f6391a13710 -- 10.0.1.252:6802/5745 <== client4107 10.0.1.200:0/4192129970 10 ==== client_request(client4107:7 lookupsnap #10000000000//a) ==== 116+0+0 (2282601261 0 0) 0x1f63d90
10.08.05_10:06:46.191257 7f6391a13710 -- 10.0.1.252:6802/5745 --> 10.0.1.200:0/4192129970 -- client_reply(???:7 = -2 No such file or directory) v1 -- ?+0 0x7f638c04b4e0
10.08.05_10:06:46.191444 7f6391a13710 -- 10.0.1.252:6802/5745 <== client4107 10.0.1.200:0/4192129970 11 ==== client_request(client4107:8 mksnap #10000000000//a) ==== 116+0+0 (1000133523 0 0) 0x1f63d90
10.08.05_10:06:46.192271 7f6391a13710 -- 10.0.1.252:6802/5745 --> 10.0.1.200:0/4192129970 -- client_caps(revoke ino 10000000000 2 seq 7 caps=pAsXsxFsx dirty=- wanted=p follows 0 size 0/0 ts 1 mtime 10.08.05_10:06:46.137045) v1 -- ?+0 0x1f65010
10.08.05_10:06:46.192619 7f6391a13710 -- 10.0.1.252:6802/5745 <== client4107 10.0.1.200:0/4192129970 12 ==== client_caps(update ino 10000000000 2 seq 7 caps=pAsXsxFsx dirty=- wanted=p follows 1 size 0/0 mtime 10.08.05_10:06:46.137045) ==== 176+0+0 (298500905 0 0) 0x1f656c0
10.08.05_10:06:46.259375 7f6391a13710 -- 10.0.1.252:6802/5745 --> 10.0.1.200:0/4192129970 -- client_reply(???:5 = 0 Success safe) v1 -- ?+0 0x7f638c04aee0
10.08.05_10:06:46.377409 7f6391a13710 mds0.locker acquire_locks request(client4107:8 cr=0x1f63d90) -- done locking
10.08.05_10:06:46.436383 7f6391a13710 mds0.locker acquire_locks request(client4107:8 cr=0x1f63d90) -- done locking
10.08.05_10:06:46.504071 7f6391a13710 -- 10.0.1.252:6802/5745 --> 10.0.1.200:0/4192129970 -- client_snap(split split=10000000000 tracelen=104) v1 -- ?+0 0x1f5dd20
10.08.05_10:06:46.504920 7f6391a13710 -- 10.0.1.252:6802/5745 --> 10.0.1.200:0/4192129970 -- client_reply(???:8 = 0 Success safe) v1 -- ?+0 0x1f65010
10.08.05_10:06:46.564950 7f6391a13710 -- 10.0.1.252:6802/5745 <== client4107 10.0.1.200:0/4192129970 13 ==== client_caps(flushsnap ino 10000000001 0 seq 0 caps=pAsxLsXsxFsxcrwb dirty=Fw wanted=- follows 0 size 5/0 mtime 10.08.05_10:06:46.126833) ==== 176+0+0 (3142566307 0 0) 0x1f65010
10.08.05_10:06:46.607350 7f6391a13710 -- 10.0.1.252:6802/5745 <== client4107 10.0.1.200:0/4192129970 14 ==== client_caps(flushsnap ino 10000000001 0 seq 0 caps=pAsxLsXsxFsxcrwb dirty=Fw wanted=- follows 0 size 5/0 mtime 10.08.05_10:06:46.126833) ==== 176+0+0 (3142566307 0 0) 0x1f65010
10.08.05_10:06:46.615681 7f6391a13710 -- 10.0.1.252:6802/5745 <== client4107 10.0.1.200:0/4192129970 15 ==== client_caps(flushsnap ino 10000000001 0 seq 0 caps=pAsxLsXsxFsxcrwb dirty=Fw wanted=- follows 0 size 5/0 mtime 10.08.05_10:06:46.126833) ==== 176+0+0 (3142566307 0 0) 0x1f6d8b0
10.08.05_10:06:46.616676 7f6391a13710 -- 10.0.1.252:6802/5745 <== client4107 10.0.1.200:0/4192129970 16 ==== client_caps(flushsnap ino 10000000001 0 seq 0 caps=pAsxLsXsxFsxcrwb dirty=Fw wanted=- follows 0 size 5/0 mtime 10.08.05_10:06:46.126833) ==== 176+0+0 (3142566307 0 0) 0x1f6dc80
10.08.05_10:06:46.617634 7f6391a13710 -- 10.0.1.252:6802/5745 <== client4107 10.0.1.200:0/4192129970 17 ==== client_caps(update ino 10000000001 3 seq 1 caps=pAsxLsXsxFsxcrwb dirty=Fw wanted=pAsxXsxFxcwb follows 2 size 10/5 mtime 10.08.05_10:06:46.486833) ==== 176+0+0 (1042561829 0 0) 0x1f661c0
10.08.05_10:06:46.623612 7f6391a13710 -- 10.0.1.252:6802/5745 <== client4107 10.0.1.200:0/4192129970 18 ==== client_caps(flushsnap ino 10000000001 0 seq 0 caps=pAsxLsXsxFsxcrwb dirty=Fw wanted=- follows 0 size 5/0 mtime 10.08.05_10:06:46.126833) ==== 176+0+0 (3142566307 0 0) 0x1f661c0
10.08.05_10:06:51.519308 7f6391a13710 -- 10.0.1.252:6802/5745 --> 10.0.1.200:0/4192129970 -- client_caps(flushsnap_ack ino 10000000001 0 seq 0 caps=- dirty=Fw wanted=- follows 0 size 0/0 mtime 0.000000) v1 -- ?+0 0x1f65570
10.08.05_10:06:51.519760 7f6391a13710 -- 10.0.1.252:6802/5745 --> 10.0.1.200:0/4192129970 -- client_caps(flushsnap_ack ino 10000000001 0 seq 0 caps=- dirty=Fw wanted=- follows 0 size 0/0 mtime 0.000000) v1 -- ?+0 0x1f664f0
10.08.05_10:06:51.520168 7f6391a13710 -- 10.0.1.252:6802/5745 --> 10.0.1.200:0/4192129970 -- client_caps(flushsnap_ack ino 10000000001 0 seq 0 caps=- dirty=Fw wanted=- follows 0 size 0/0 mtime 0.000000) v1 -- ?+0 0x1f65010
10.08.05_10:06:51.520570 7f6391a13710 -- 10.0.1.252:6802/5745 --> 10.0.1.200:0/4192129970 -- client_caps(flushsnap_ack ino 10000000001 0 seq 0 caps=- dirty=Fw wanted=- follows 0 size 0/0 mtime 0.000000) v1 -- ?+0 0x1f6d8b0
10.08.05_10:06:51.520973 7f6391a13710 -- 10.0.1.252:6802/5745 --> 10.0.1.200:0/4192129970 -- client_caps(flush_ack ino 10000000001 3 seq 1 caps=pAsxLsXsxFsxcrwb dirty=Fw wanted=- follows 0 size 0/0 mtime 0.000000) v1 -- ?+0 0x1f6dbc0
10.08.05_10:06:51.521416 7f6391a13710 -- 10.0.1.252:6802/5745 --> 10.0.1.200:0/4192129970 -- client_caps(flushsnap_ack ino 10000000001 0 seq 0 caps=- dirty=Fw wanted=- follows 0 size 0/0 mtime 0.000000) v1 -- ?+0 0x1f85b30
10.08.05_10:06:53.334353 7f6391a13710 -- 10.0.1.252:6802/5745 <== client4107 10.0.1.200:0/4192129970 19 ==== client_session(request_renewcaps seq 2) ==== 28+0+0 (4249282350 0 0) 0x1f62ff0
10.08.05_10:06:53.334418 7f6391a13710 -- 10.0.1.252:6802/5745 --> 10.0.1.200:0/4192129970 -- client_session(renewcaps seq 2) v1 -- ?+0 0x1f61f90