Attachment 6158 Details for Bug 7860 – cifs debug info

cifs debug info

cifsmount-fshome-20101222.log (text/plain), 10.28 KB, created by Burkhard Obergoeker on 2010-12-22 07:22:39 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Burkhard Obergoeker

Created: 2010-12-22 07:22:39 UTC

Size: 10.28 KB

patch

obsolete

>Dec 22 11:33:36 suseadm1 kernel: [ 9884.246821]  fs/cifs/inode.c: CIFS VFS: in cifs_revalidate as Xid: 30 with uid: 0
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.246830]  fs/cifs/inode.c: Revalidate: \\fs-home\home\burkhard\\1234567890 inode 0xffff880064c46090 count 1 dentry: 0xffff88007d3e28c0 d_time 4297360157 jiffies 4297363357
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.246835]  fs/cifs/inode.c: Getting info on \\fs-home\home\burkhard\\1234567890
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.246849]  fs/cifs/transport.c: For smb_command 50
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.246852]  fs/cifs/transport.c: Sending smb:  total_len 148
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247219]  fs/cifs/connect.c: rfc1002 length 0xbc
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247228]  fs/cifs/misc.c: Calculated size 178 vs length 188 mismatch for mid 15
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247246]  fs/cifs/inode.c: inode 0xffff880064c46090 old_time=4297360157 new_time=4297363357
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247252]  fs/cifs/inode.c: CIFS VFS: leaving cifs_revalidate (xid = 30) rc = 0
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247258]  fs/cifs/dir.c: CIFS VFS: in cifs_lookup as Xid: 31 with uid: 0
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247262]  fs/cifs/dir.c: parent inode = 0xffff880064c46090 name is: 12 and dentry = 0xffff88007d0ec680
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247265]  fs/cifs/dir.c: NULL inode in lookup
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247268]  fs/cifs/dir.c: Full path: \\fs-home\home\burkhard\\1234567890\12 inode = 0x(null)
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247270]  fs/cifs/inode.c: Getting info on \\fs-home\home\burkhard\\1234567890\12
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247275]  fs/cifs/transport.c: For smb_command 50
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247277]  fs/cifs/transport.c: Sending smb:  total_len 154
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247597]  fs/cifs/connect.c: rfc1002 length 0xac
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247602]  fs/cifs/misc.c: Calculated size 184 vs length 172 mismatch for mid 16
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247615]  fs/cifs/inode.c: looking for uniqueid=83
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247622]  fs/cifs/inode.c: inode 0xffff880064c7aaf0 old_time=0 new_time=4297363357
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247628]  fs/cifs/dir.c: CIFS VFS: leaving cifs_lookup (xid = 31) rc = 0
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247633]  fs/cifs/inode.c: CIFS VFS: in cifs_revalidate as Xid: 32 with uid: 0
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247638]  fs/cifs/inode.c: Revalidate: \\fs-home\home\burkhard\\1234567890\12 inode 0xffff880064c7aaf0 count 1 dentry: 0xffff88007d0ec680 d_time 4297363357 jiffies 4297363357
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247642]  fs/cifs/inode.c: CIFS VFS: leaving cifs_revalidate (xid = 32) rc = 0
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247662]  fs/cifs/inode.c: CIFS VFS: in cifs_revalidate as Xid: 33 with uid: 0
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247667]  fs/cifs/inode.c: Revalidate: \\fs-home\home\burkhard\\1234567890 inode 0xffff880064c46090 count 1 dentry: 0xffff88007d3e28c0 d_time 4297363357 jiffies 4297363357
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247671]  fs/cifs/inode.c: CIFS VFS: leaving cifs_revalidate (xid = 33) rc = 0
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247674]  fs/cifs/inode.c: CIFS VFS: in cifs_revalidate as Xid: 34 with uid: 0
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247678]  fs/cifs/inode.c: Revalidate: \\fs-home\home\burkhard\\1234567890\12 inode 0xffff880064c7aaf0 count 1 dentry: 0xffff88007d0ec680 d_time 4297363357 jiffies 4297363357
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247681]  fs/cifs/inode.c: CIFS VFS: leaving cifs_revalidate (xid = 34) rc = 0
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247687]  fs/cifs/xattr.c: CIFS VFS: in cifs_getxattr as Xid: 35 with uid: 0
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247691]  fs/cifs/xattr.c: illegal xattr request security.selinux (only user namespace supported)
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247694]  fs/cifs/xattr.c: CIFS VFS: leaving cifs_getxattr (xid = 35) rc = -95
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247714]  fs/cifs/inode.c: CIFS VFS: in cifs_revalidate as Xid: 36 with uid: 0
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247719]  fs/cifs/inode.c: Revalidate: \\fs-home\home\burkhard\\1234567890 inode 0xffff880064c46090 count 1 dentry: 0xffff88007d3e28c0 d_time 4297363357 jiffies 4297363357
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247723]  fs/cifs/inode.c: CIFS VFS: leaving cifs_revalidate (xid = 36) rc = 0
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247726]  fs/cifs/inode.c: CIFS VFS: in cifs_revalidate as Xid: 37 with uid: 0
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247730]  fs/cifs/inode.c: Revalidate: \\fs-home\home\burkhard\\1234567890\12 inode 0xffff880064c7aaf0 count 1 dentry: 0xffff88007d0ec680 d_time 4297363357 jiffies 4297363357
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247733]  fs/cifs/inode.c: CIFS VFS: leaving cifs_revalidate (xid = 37) rc = 0
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247737]  fs/cifs/xattr.c: CIFS VFS: in cifs_getxattr as Xid: 38 with uid: 0
>Dec 22 11:33:36 suseadm1 kernel: [ 9884.247740]  fs/cifs/xattr.c: CIFS VFS: leaving cifs_getxattr (xid = 38) rc = -95
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758111]  fs/cifs/inode.c: CIFS VFS: in cifs_revalidate as Xid: 39 with uid: 0
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758120]  fs/cifs/inode.c: Revalidate: \\fs-home\home\burkhard\\1234567890 inode 0xffff880064c46090 count 1 dentry: 0xffff88007d3e28c0 d_time 4297363357 jiffies 4297372735
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758124]  fs/cifs/inode.c: Getting info on \\fs-home\home\burkhard\\1234567890
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758140]  fs/cifs/transport.c: For smb_command 50
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758143]  fs/cifs/transport.c: Sending smb:  total_len 148
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758564]  fs/cifs/connect.c: rfc1002 length 0xbc
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758571]  fs/cifs/misc.c: Calculated size 178 vs length 188 mismatch for mid 17
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758589]  fs/cifs/inode.c: inode 0xffff880064c46090 old_time=4297363357 new_time=4297372735
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758594]  fs/cifs/inode.c: cifs_revalidate - inode unchanged
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758598]  fs/cifs/inode.c: CIFS VFS: leaving cifs_revalidate (xid = 39) rc = 0
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758603]  fs/cifs/inode.c: CIFS VFS: in cifs_revalidate as Xid: 40 with uid: 0
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758608]  fs/cifs/inode.c: Revalidate: \\fs-home\home\burkhard\\1234567890\12 inode 0xffff880064c7aaf0 count 1 dentry: 0xffff88007d0ec680 d_time 4297363357 jiffies 4297372735
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758612]  fs/cifs/inode.c: Getting info on \\fs-home\home\burkhard\\1234567890\12
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758616]  fs/cifs/transport.c: For smb_command 50
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758618]  fs/cifs/transport.c: Sending smb:  total_len 154
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758928]  fs/cifs/connect.c: rfc1002 length 0xac
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758933]  fs/cifs/misc.c: Calculated size 184 vs length 172 mismatch for mid 18
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758946]  fs/cifs/inode.c: inode 0xffff880064c7aaf0 old_time=4297363357 new_time=4297372735
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758950]  fs/cifs/inode.c: cifs_revalidate - inode unchanged
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758954]  fs/cifs/file.c: CIFS VFS: in cifs_writepages as Xid: 41 with uid: 0
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758959]  fs/cifs/file.c: CIFS VFS: leaving cifs_writepages (xid = 41) rc = 0
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758962]  fs/cifs/inode.c: CIFS VFS: leaving cifs_revalidate (xid = 40) rc = 0
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758968]  fs/cifs/file.c: CIFS VFS: in cifs_open as Xid: 42 with uid: 0
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758972]  fs/cifs/file.c: inode = 0xffff880064c7aaf0 file flags are 0x8000 for \\fs-home\home\burkhard\\1234567890\12
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758978]  fs/cifs/transport.c: For smb_command 162
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.758980]  fs/cifs/transport.c: Sending smb:  total_len 166
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.759355]  fs/cifs/connect.c: rfc1002 length 0x6b
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.759368]  fs/cifs/file.c: inode unchanged on server
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.759371]  fs/cifs/inode.c: Getting info on \\fs-home\home\burkhard\\1234567890\12
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.759374]  fs/cifs/inode.c: inode 0xffff880064c7aaf0 old_time=4297372735 new_time=4297372735
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.759380]  fs/cifs/file.c: CIFS VFS: leaving cifs_open (xid = 42) rc = 0
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.759402]  fs/cifs/file.c: CIFS VFS: in cifs_readpages as Xid: 43 with uid: 0
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.759406]  fs/cifs/cifssmb.c: Reading 4096 bytes on fid 3
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.759409]  fs/cifs/transport.c: For smb_command 46
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.759411]  fs/cifs/transport.c: Sending smb:  total_len 63
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.767167]  fs/cifs/connect.c: rfc1002 length 0x363
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.767197]  fs/cifs/file.c: CIFS VFS: leaving cifs_readpages (xid = 43) rc = 0
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.767272]  fs/cifs/file.c: CIFS VFS: in cifs_writepages as Xid: 44 with uid: 0
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.767276]  fs/cifs/file.c: CIFS VFS: leaving cifs_writepages (xid = 44) rc = 0
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.767280]  fs/cifs/file.c: Flush inode ffff880064c7aaf0 file ffff88007b9b1d80 rc 0
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.767284]  fs/cifs/file.c: CIFS VFS: in cifs_close as Xid: 45 with uid: 0
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.767287]  fs/cifs/cifssmb.c: In CIFSSMBClose
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.767292]  fs/cifs/transport.c: For smb_command 4
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.767294]  fs/cifs/transport.c: Sending smb:  total_len 45
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.767548]  fs/cifs/connect.c: rfc1002 length 0x27
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.767563]  fs/cifs/file.c: closing last open instance for inode ffff880064c7aaf0
>Dec 22 11:34:13 suseadm1 kernel: [ 9921.767567]  fs/cifs/file.c: CIFS VFS: leaving cifs_close (xid = 45) rc = 0

Actions: View

Attachments on bug 7860: 6129 | 6156 | 6158