Attachment 591188 Details for Bug 826507 – debug log with updated pam_krb5

debug log with updated pam_krb5

daemon_kern_debug_with_updated_pam_krb5 (text/plain), 26.88 KB, created by Marcus Moeller on 2012-06-12 13:27:49 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Marcus Moeller

Created: 2012-06-12 13:27:49 UTC

Size: 26.88 KB

patch

obsolete

>Jun 12 15:06:39 localhost kernel: imklog 5.8.10, log source = /proc/kmsg started.
>Jun 12 15:06:42 localhost nslcd[990]: [884adc] nslcd_passwd_byname(*): invalid user name
>Jun 12 15:06:43 localhost nslcd[990]: [ead36b] nslcd_passwd_byname(*): invalid user name
>Jun 12 15:06:43 localhost nslcd[990]: [517796] nslcd_passwd_byname(*): invalid user name
>Jun 12 15:06:43 localhost nslcd[990]: [0bd78f] nslcd_passwd_byname(*): invalid user name
>Jun 12 15:06:47 localhost kernel: [  608.370944] fs/cifs/cifsfs.c: Devname: //d.ethz.ch/dfs/users/all/mam4tst flags: 0 
>Jun 12 15:06:47 localhost kernel: [  608.370971] fs/cifs/connect.c: prefix path /users/all/mam4tst
>Jun 12 15:06:47 localhost kernel: [  608.370975] fs/cifs/connect.c: Username: mam4tst
>Jun 12 15:06:47 localhost kernel: [  608.370981] fs/cifs/connect.c: file mode: 0x1c0  dir mode: 0x1c0
>Jun 12 15:06:47 localhost kernel: [  608.371122] fs/cifs/connect.c: CIFS VFS: in cifs_mount as Xid: 62 with uid: 0
>Jun 12 15:06:47 localhost kernel: [  608.371127] fs/cifs/connect.c: UNC: \\d.ethz.ch\dfs ip: 172.31.39.201
>Jun 12 15:06:47 localhost kernel: [  608.371146] fs/cifs/connect.c: Socket created
>Jun 12 15:06:47 localhost kernel: [  608.371149] fs/cifs/connect.c: sndbuf 16384 rcvbuf 87380 rcvtimeo 0x1b58
>Jun 12 15:06:47 localhost kernel: [  608.373951] fs/cifs/connect.c: Demultiplex PID: 1961
>Jun 12 15:06:47 localhost kernel: [  608.373957] fs/cifs/fscache.c: cifs_fscache_get_client_cookie: (0xffff88012ecd4400/0xffff880130438730)
>Jun 12 15:06:47 localhost kernel: [  608.373964] fs/cifs/connect.c: CIFS VFS: in cifs_get_smb_ses as Xid: 63 with uid: 0
>Jun 12 15:06:47 localhost kernel: [  608.373968] fs/cifs/connect.c: Existing smb sess not found
>Jun 12 15:06:47 localhost kernel: [  608.373978] fs/cifs/cifssmb.c: secFlags 0x8
>Jun 12 15:06:47 localhost kernel: [  608.373982] fs/cifs/cifssmb.c: Kerberos only mechanism, enable extended security
>Jun 12 15:06:47 localhost kernel: [  608.373988] fs/cifs/transport.c: For smb_command 114
>Jun 12 15:06:47 localhost kernel: [  608.373992] fs/cifs/transport.c: Sending smb:  total_len 82
>Jun 12 15:06:47 localhost kernel: [  608.375761] fs/cifs/connect.c: RFC1002 header 0xcd
>Jun 12 15:06:47 localhost kernel: [  608.375808] fs/cifs/transport.c: cifs_sync_mid_result: cmd=114 mid=1 state=4
>Jun 12 15:06:47 localhost kernel: [  608.375815] fs/cifs/cifssmb.c: Dialect: 2
>Jun 12 15:06:47 localhost kernel: [  608.375822] fs/cifs/asn1.c: OID len = 10 oid = 0x1 0x3 0x6 0x1
>Jun 12 15:06:47 localhost kernel: [  608.375826] fs/cifs/asn1.c: OID len = 7 oid = 0x1 0x2 0x348 0xbb92
>Jun 12 15:06:47 localhost kernel: [  608.375831] fs/cifs/asn1.c: OID len = 7 oid = 0x1 0x2 0x348 0x1bb92
>Jun 12 15:06:47 localhost kernel: [  608.375835] fs/cifs/asn1.c: OID len = 8 oid = 0x1 0x2 0x348 0x1bb92
>Jun 12 15:06:47 localhost kernel: [  608.375839] fs/cifs/asn1.c: OID len = 10 oid = 0x1 0x3 0x6 0x1
>Jun 12 15:06:47 localhost kernel: [  608.375842] fs/cifs/asn1.c: Need to call asn1_octets_decode() function for not_defined_in_RFC4178@please_ignore
>Jun 12 15:06:47 localhost kernel: [  608.375846] fs/cifs/cifssmb.c: Signing disabled
>Jun 12 15:06:47 localhost kernel: [  608.375849] fs/cifs/cifssmb.c: negprot rc 0
>Jun 12 15:06:47 localhost kernel: [  608.375853] fs/cifs/connect.c: Security Mode: 0x3 Capabilities: 0x8001f3fc TimeAdjust: -7200
>Jun 12 15:06:47 localhost kernel: [  608.375857] fs/cifs/sess.c: sess setup type 4
>Jun 12 15:06:47 localhost kernel: [  608.375867] fs/cifs/cifs_spnego.c: key description = ver=0x2;host=d.ethz.ch;ip4=172.31.39.201;sec=krb5;uid=0xaf05;creduid=0xaf05;user=mam4tst;pid=0x7a7
>Jun 12 15:06:47 localhost cifs.upcall: key description: cifs.spnego;0;0;3f000000;ver=0x2;host=d.ethz.ch;ip4=172.31.39.201;sec=krb5;uid=0xaf05;creduid=0xaf05;user=mam4tst;pid=0x7a7
>Jun 12 15:06:47 localhost cifs.upcall: ver=2
>Jun 12 15:06:47 localhost cifs.upcall: host=d.ethz.ch
>Jun 12 15:06:47 localhost cifs.upcall: ip=172.31.39.201
>Jun 12 15:06:47 localhost cifs.upcall: sec=1
>Jun 12 15:06:47 localhost cifs.upcall: uid=44805
>Jun 12 15:06:47 localhost cifs.upcall: creduid=44805
>Jun 12 15:06:47 localhost cifs.upcall: user=mam4tst
>Jun 12 15:06:47 localhost cifs.upcall: pid=1959
>Jun 12 15:06:47 localhost cifs.upcall: find_krb5_cc: considering /tmp/krb5cc_44805_1CUvSS
>Jun 12 15:06:47 localhost cifs.upcall: find_krb5_cc: FILE:/tmp/krb5cc_44805_1CUvSS is valid ccache
>Jun 12 15:06:47 localhost cifs.upcall: find_krb5_cc: considering /tmp/krb5cc_44805_8wIgA6
>Jun 12 15:06:47 localhost cifs.upcall: find_krb5_cc: /tmp/krb5cc_44805_8wIgA6 is owned by 0, not 44805
>Jun 12 15:06:47 localhost cifs.upcall: find_krb5_cc: considering /tmp/krb5cc_0
>Jun 12 15:06:47 localhost cifs.upcall: find_krb5_cc: /tmp/krb5cc_0 is owned by 0, not 44805
>Jun 12 15:06:47 localhost cifs.upcall: handle_krb5_mech: getting service ticket for d.ethz.ch
>Jun 12 15:06:47 localhost cifs.upcall: cifs_krb5_get_req: unable to get credentials for d.ethz.ch
>Jun 12 15:06:47 localhost cifs.upcall: handle_krb5_mech: failed to obtain service ticket (-1765328377)
>Jun 12 15:06:47 localhost cifs.upcall: ip_to_fqdn: resolved 172.31.39.201 to metha.d.ethz.ch
>Jun 12 15:06:47 localhost cifs.upcall: handle_krb5_mech: getting service ticket for metha.d.ethz.ch
>Jun 12 15:06:47 localhost cifs.upcall: handle_krb5_mech: obtained service ticket
>Jun 12 15:06:47 localhost cifs.upcall: Exit status 0
>Jun 12 15:06:47 localhost kernel: [  608.419375] fs/cifs/transport.c: For smb_command 115
>Jun 12 15:06:47 localhost kernel: [  608.419383] fs/cifs/transport.c: Sending smb:  total_len 1674
>Jun 12 15:06:47 localhost kernel: [  608.422316] fs/cifs/connect.c: RFC1002 header 0xf9
>Jun 12 15:06:47 localhost kernel: [  608.422358] fs/cifs/transport.c: cifs_sync_mid_result: cmd=115 mid=2 state=4
>Jun 12 15:06:47 localhost kernel: [  608.422363] fs/cifs/misc.c: Null buffer passed to cifs_small_buf_release
>Jun 12 15:06:47 localhost kernel: [  608.422367] fs/cifs/sess.c: UID = 53251 
>Jun 12 15:06:47 localhost kernel: [  608.422370] fs/cifs/sess.c: bleft 183
>Jun 12 15:06:47 localhost kernel: [  608.422376] fs/cifs/sess.c: serverOS=Windows Server 2008 R2 Enterprise 7601 Service Pack 1
>Jun 12 15:06:47 localhost kernel: [  608.422382] fs/cifs/sess.c: serverNOS=Windows Server 2008 R2 Enterprise 6.1
>Jun 12 15:06:47 localhost kernel: [  608.422387] fs/cifs/sess.c: ssetup freeing small buf ffff88012e232000
>Jun 12 15:06:47 localhost kernel: [  608.422391] fs/cifs/connect.c: CIFS Session Established successfully
>Jun 12 15:06:47 localhost kernel: [  608.422395] fs/cifs/connect.c: CIFS VFS: leaving cifs_get_smb_ses (xid = 63) rc = 0
>Jun 12 15:06:47 localhost kernel: [  608.422401] fs/cifs/connect.c: CIFS VFS: in cifs_get_tcon as Xid: 64 with uid: 0
>Jun 12 15:06:47 localhost kernel: [  608.422407] fs/cifs/transport.c: For smb_command 117
>Jun 12 15:06:47 localhost kernel: [  608.422410] fs/cifs/transport.c: Sending smb:  total_len 86
>Jun 12 15:06:47 localhost kernel: [  608.423345] fs/cifs/connect.c: RFC1002 header 0x3e
>Jun 12 15:06:47 localhost kernel: [  608.423382] fs/cifs/transport.c: cifs_sync_mid_result: cmd=117 mid=3 state=4
>Jun 12 15:06:47 localhost kernel: [  608.423388] fs/cifs/connect.c: disk share connection
>Jun 12 15:06:47 localhost kernel: [  608.423392] fs/cifs/connect.c: nativeFileSystem=NTFS
>Jun 12 15:06:47 localhost kernel: [  608.423395] fs/cifs/connect.c: Tcon flags: 0x3 
>Jun 12 15:06:47 localhost kernel: [  608.423399] fs/cifs/connect.c: CIFS VFS: leaving cifs_get_tcon (xid = 64) rc = 0
>Jun 12 15:06:47 localhost kernel: [  608.423402] fs/cifs/connect.c: CIFS Tcon rc = 0
>Jun 12 15:06:47 localhost kernel: [  608.423408] fs/cifs/fscache.c: cifs_fscache_get_super_cookie: (0xffff880130438730/0xffff88012e8580a0)
>Jun 12 15:06:47 localhost kernel: [  608.423412] fs/cifs/cifssmb.c: In QFSDeviceInfo
>Jun 12 15:06:47 localhost kernel: [  608.423417] fs/cifs/transport.c: For smb_command 50
>Jun 12 15:06:47 localhost kernel: [  608.423420] fs/cifs/transport.c: Sending smb:  total_len 72
>Jun 12 15:06:47 localhost kernel: [  608.424366] fs/cifs/connect.c: RFC1002 header 0x40
>Jun 12 15:06:47 localhost kernel: [  608.424407] fs/cifs/transport.c: cifs_sync_mid_result: cmd=50 mid=4 state=4
>Jun 12 15:06:47 localhost kernel: [  608.424413] fs/cifs/cifssmb.c: In QFSAttributeInfo
>Jun 12 15:06:47 localhost kernel: [  608.424417] fs/cifs/transport.c: For smb_command 50
>Jun 12 15:06:47 localhost kernel: [  608.424420] fs/cifs/transport.c: Sending smb:  total_len 72
>Jun 12 15:06:47 localhost kernel: [  608.425379] fs/cifs/connect.c: RFC1002 header 0x4c
>Jun 12 15:06:47 localhost kernel: [  608.425409] fs/cifs/transport.c: cifs_sync_mid_result: cmd=50 mid=5 state=4
>Jun 12 15:06:47 localhost kernel: [  608.425417] fs/cifs/connect.c: build_unc_path_to_root: full_path=\\d.ethz.ch\dfs\users\all\mam4tst
>Jun 12 15:06:47 localhost kernel: [  608.425423] fs/cifs/transport.c: For smb_command 117
>Jun 12 15:06:47 localhost kernel: [  608.425426] fs/cifs/transport.c: Sending smb:  total_len 96
>Jun 12 15:06:47 localhost kernel: [  608.426383] fs/cifs/connect.c: RFC1002 header 0x38
>Jun 12 15:06:47 localhost kernel: [  608.426422] fs/cifs/transport.c: cifs_sync_mid_result: cmd=117 mid=6 state=4
>Jun 12 15:06:47 localhost kernel: [  608.426428] fs/cifs/connect.c: CIFS Tcon rc = 0 ipc_tid = 26630
>Jun 12 15:06:47 localhost kernel: [  608.426431] fs/cifs/cifssmb.c: In GetDFSRefer the path \d.ethz.ch\dfs
>Jun 12 15:06:47 localhost kernel: [  608.426437] fs/cifs/transport.c: For smb_command 50
>Jun 12 15:06:47 localhost kernel: [  608.426440] fs/cifs/transport.c: Sending smb:  total_len 104
>Jun 12 15:06:47 localhost kernel: [  608.428030] fs/cifs/connect.c: RFC1002 header 0x2a8
>Jun 12 15:06:47 localhost kernel: [  608.428075] fs/cifs/transport.c: cifs_sync_mid_result: cmd=50 mid=7 state=4
>Jun 12 15:06:47 localhost kernel: [  608.428082] fs/cifs/cifssmb.c: Decoding GetDFSRefer response BCC: 625  Offset 56
>Jun 12 15:06:47 localhost kernel: [  608.428085] fs/cifs/cifssmb.c: num_referrals: 10 dfs flags: 0x3 ...
>Jun 12 15:06:47 localhost kernel: [  608.428087] 
>Jun 12 15:06:47 localhost kernel: [  608.431351] fs/cifs/dns_resolve.c: dns_resolve_server_name_to_ip: unable to resolve: HERO
>Jun 12 15:06:47 localhost kernel: [  608.431359] fs/cifs/cifs_dfs_ref.c: cifs_compose_mount_options: Failed to resolve server part of \\HERO\dfs to IP: -126
>Jun 12 15:06:47 localhost kernel: [  608.431374] fs/cifs/transport.c: For smb_command 50
>Jun 12 15:06:47 localhost kernel: [  608.431379] fs/cifs/transport.c: Sending smb:  total_len 144
>Jun 12 15:06:47 localhost kernel: [  608.432391] fs/cifs/connect.c: RFC1002 header 0x23
>Jun 12 15:06:47 localhost kernel: [  608.432398] fs/cifs/connect.c: invalid transact2 word count
>Jun 12 15:06:47 localhost kernel: [  608.432424] fs/cifs/transport.c: cifs_sync_mid_result: cmd=50 mid=8 state=4
>Jun 12 15:06:47 localhost kernel: [  608.432431] fs/cifs/netmisc.c: Mapping smb error code 0xc0000257 to POSIX err -66
>Jun 12 15:06:47 localhost kernel: [  608.432436] fs/cifs/cifssmb.c: Send error in QPathInfo = -66
>Jun 12 15:06:47 localhost kernel: [  608.432441] fs/cifs/connect.c: build_unc_path_to_root: full_path=\\d.ethz.ch\dfs\users\all\mam4tst
>Jun 12 15:06:47 localhost kernel: [  608.432445] fs/cifs/cifssmb.c: In GetDFSRefer the path \d.ethz.ch\dfs\users\all\mam4tst
>Jun 12 15:06:47 localhost kernel: [  608.432451] fs/cifs/transport.c: For smb_command 50
>Jun 12 15:06:47 localhost kernel: [  608.432454] fs/cifs/transport.c: Sending smb:  total_len 140
>Jun 12 15:06:47 localhost kernel: [  608.433547] fs/cifs/connect.c: RFC1002 header 0xec
>Jun 12 15:06:47 localhost kernel: [  608.433565] fs/cifs/transport.c: cifs_sync_mid_result: cmd=50 mid=9 state=4
>Jun 12 15:06:47 localhost kernel: [  608.433571] fs/cifs/cifssmb.c: Decoding GetDFSRefer response BCC: 181  Offset 56
>Jun 12 15:06:47 localhost kernel: [  608.433574] fs/cifs/cifssmb.c: num_referrals: 1 dfs flags: 0x1 ...
>Jun 12 15:06:47 localhost kernel: [  608.433576] 
>Jun 12 15:06:47 localhost kernel: [  608.433586] fs/cifs/connect.c: cifs_put_tcon: tc_count=1
>Jun 12 15:06:47 localhost kernel: [  608.433587] 
>Jun 12 15:06:47 localhost kernel: [  608.433590] fs/cifs/connect.c: CIFS VFS: in cifs_put_tcon as Xid: 65 with uid: 0
>Jun 12 15:06:47 localhost kernel: [  608.433594] fs/cifs/cifssmb.c: In tree disconnect
>Jun 12 15:06:47 localhost kernel: [  608.433598] fs/cifs/transport.c: For smb_command 113
>Jun 12 15:06:47 localhost kernel: [  608.433601] fs/cifs/transport.c: Sending smb:  total_len 39
>Jun 12 15:06:47 localhost kernel: [  608.434505] fs/cifs/connect.c: RFC1002 header 0x23
>Jun 12 15:06:47 localhost kernel: [  608.434526] fs/cifs/transport.c: cifs_sync_mid_result: cmd=113 mid=10 state=4
>Jun 12 15:06:47 localhost kernel: [  608.434533] fs/cifs/fscache.c: cifs_fscache_release_super_cookie: (0xffff88012e8580a0)
>Jun 12 15:06:47 localhost kernel: [  608.434540] fs/cifs/connect.c: cifs_put_smb_ses: ses_count=1
>Jun 12 15:06:47 localhost kernel: [  608.434542] 
>Jun 12 15:06:47 localhost kernel: [  608.434546] fs/cifs/connect.c: CIFS VFS: in cifs_put_smb_ses as Xid: 66 with uid: 0
>Jun 12 15:06:47 localhost kernel: [  608.434551] fs/cifs/cifssmb.c: In SMBLogoff for session disconnect
>Jun 12 15:06:47 localhost kernel: [  608.434557] fs/cifs/transport.c: For smb_command 116
>Jun 12 15:06:47 localhost kernel: [  608.434561] fs/cifs/transport.c: Sending smb:  total_len 43
>Jun 12 15:06:47 localhost kernel: [  608.435542] fs/cifs/connect.c: RFC1002 header 0x27
>Jun 12 15:06:47 localhost kernel: [  608.435573] fs/cifs/transport.c: cifs_sync_mid_result: cmd=116 mid=11 state=4
>Jun 12 15:06:47 localhost kernel: [  608.435585] fs/cifs/fscache.c: cifs_fscache_release_client_cookie: (0xffff88012ecd4400/0xffff880130438730)
>Jun 12 15:06:47 localhost kernel: [  608.435700] fs/cifs/connect.c: CIFS VFS: leaving cifs_mount (xid = 62) rc = -22
>Jun 12 15:06:47 localhost kernel: [  608.435704] CIFS VFS: cifs_mount failed w/return code = -22
>Jun 12 15:06:47 localhost systemd[1]: getty@tty3.service holdoff time over, scheduling restart.
>Jun 12 15:06:54 localhost kernel: [  615.001208] fs/cifs/cifsfs.c: Devname: //d.ethz.ch/dfs/users/all/mam4tst flags: 0 
>Jun 12 15:06:54 localhost kernel: [  615.001237] fs/cifs/connect.c: prefix path /users/all/mam4tst
>Jun 12 15:06:54 localhost kernel: [  615.001241] fs/cifs/connect.c: Username: mam4tst
>Jun 12 15:06:54 localhost kernel: [  615.001246] fs/cifs/connect.c: file mode: 0x1c0  dir mode: 0x1c0
>Jun 12 15:06:54 localhost kernel: [  615.001389] fs/cifs/connect.c: CIFS VFS: in cifs_mount as Xid: 67 with uid: 0
>Jun 12 15:06:54 localhost kernel: [  615.001393] fs/cifs/connect.c: UNC: \\d.ethz.ch\dfs ip: 82.130.70.6
>Jun 12 15:06:54 localhost kernel: [  615.001414] fs/cifs/connect.c: Socket created
>Jun 12 15:06:54 localhost kernel: [  615.001417] fs/cifs/connect.c: sndbuf 16384 rcvbuf 87380 rcvtimeo 0x1b58
>Jun 12 15:06:54 localhost kernel: [  615.002825] fs/cifs/connect.c: Demultiplex PID: 1983
>Jun 12 15:06:54 localhost kernel: [  615.002829] fs/cifs/fscache.c: cifs_fscache_get_client_cookie: (0xffff88011eda4c00/0xffff880130438780)
>Jun 12 15:06:54 localhost kernel: [  615.002840] fs/cifs/connect.c: CIFS VFS: in cifs_get_smb_ses as Xid: 68 with uid: 0
>Jun 12 15:06:54 localhost kernel: [  615.002842] fs/cifs/connect.c: Existing smb sess not found
>Jun 12 15:06:54 localhost kernel: [  615.002847] fs/cifs/cifssmb.c: secFlags 0x8
>Jun 12 15:06:54 localhost kernel: [  615.002849] fs/cifs/cifssmb.c: Kerberos only mechanism, enable extended security
>Jun 12 15:06:54 localhost kernel: [  615.002853] fs/cifs/transport.c: For smb_command 114
>Jun 12 15:06:54 localhost kernel: [  615.002856] fs/cifs/transport.c: Sending smb:  total_len 82
>Jun 12 15:06:54 localhost kernel: [  615.005053] fs/cifs/connect.c: RFC1002 header 0xcd
>Jun 12 15:06:54 localhost kernel: [  615.005086] fs/cifs/transport.c: cifs_sync_mid_result: cmd=114 mid=1 state=4
>Jun 12 15:06:54 localhost kernel: [  615.005093] fs/cifs/cifssmb.c: Dialect: 2
>Jun 12 15:06:54 localhost kernel: [  615.005099] fs/cifs/asn1.c: OID len = 10 oid = 0x1 0x3 0x6 0x1
>Jun 12 15:06:54 localhost kernel: [  615.005104] fs/cifs/asn1.c: OID len = 7 oid = 0x1 0x2 0x348 0xbb92
>Jun 12 15:06:54 localhost kernel: [  615.005108] fs/cifs/asn1.c: OID len = 7 oid = 0x1 0x2 0x348 0x1bb92
>Jun 12 15:06:54 localhost kernel: [  615.005112] fs/cifs/asn1.c: OID len = 8 oid = 0x1 0x2 0x348 0x1bb92
>Jun 12 15:06:54 localhost kernel: [  615.005116] fs/cifs/asn1.c: OID len = 10 oid = 0x1 0x3 0x6 0x1
>Jun 12 15:06:54 localhost kernel: [  615.005120] fs/cifs/asn1.c: Need to call asn1_octets_decode() function for not_defined_in_RFC4178@please_ignore
>Jun 12 15:06:54 localhost kernel: [  615.005123] fs/cifs/cifssmb.c: Signing disabled
>Jun 12 15:06:54 localhost kernel: [  615.005126] fs/cifs/cifssmb.c: negprot rc 0
>Jun 12 15:06:54 localhost kernel: [  615.005130] fs/cifs/connect.c: Security Mode: 0x3 Capabilities: 0x8001f3fc TimeAdjust: -7200
>Jun 12 15:06:54 localhost kernel: [  615.005134] fs/cifs/sess.c: sess setup type 4
>Jun 12 15:06:54 localhost kernel: [  615.005144] fs/cifs/cifs_spnego.c: key description = ver=0x2;host=d.ethz.ch;ip4=82.130.70.6;sec=krb5;uid=0xaf05;creduid=0xaf05;user=mam4tst;pid=0x7bd
>Jun 12 15:06:54 localhost cifs.upcall: key description: cifs.spnego;0;0;3f000000;ver=0x2;host=d.ethz.ch;ip4=82.130.70.6;sec=krb5;uid=0xaf05;creduid=0xaf05;user=mam4tst;pid=0x7bd
>Jun 12 15:06:54 localhost cifs.upcall: ver=2
>Jun 12 15:06:54 localhost cifs.upcall: host=d.ethz.ch
>Jun 12 15:06:54 localhost cifs.upcall: ip=82.130.70.6
>Jun 12 15:06:54 localhost cifs.upcall: sec=1
>Jun 12 15:06:54 localhost cifs.upcall: uid=44805
>Jun 12 15:06:54 localhost cifs.upcall: creduid=44805
>Jun 12 15:06:54 localhost cifs.upcall: user=mam4tst
>Jun 12 15:06:54 localhost cifs.upcall: pid=1981
>Jun 12 15:06:54 localhost cifs.upcall: find_krb5_cc: considering /tmp/krb5cc_44805_eY7rff
>Jun 12 15:06:54 localhost cifs.upcall: find_krb5_cc: FILE:/tmp/krb5cc_44805_eY7rff is valid ccache
>Jun 12 15:06:54 localhost cifs.upcall: find_krb5_cc: considering /tmp/krb5cc_44805_8wIgA6
>Jun 12 15:06:54 localhost cifs.upcall: find_krb5_cc: /tmp/krb5cc_44805_8wIgA6 is owned by 0, not 44805
>Jun 12 15:06:54 localhost cifs.upcall: find_krb5_cc: considering /tmp/krb5cc_0
>Jun 12 15:06:54 localhost cifs.upcall: find_krb5_cc: /tmp/krb5cc_0 is owned by 0, not 44805
>Jun 12 15:06:54 localhost cifs.upcall: handle_krb5_mech: getting service ticket for d.ethz.ch
>Jun 12 15:06:54 localhost cifs.upcall: cifs_krb5_get_req: unable to get credentials for d.ethz.ch
>Jun 12 15:06:54 localhost cifs.upcall: handle_krb5_mech: failed to obtain service ticket (-1765328377)
>Jun 12 15:06:54 localhost cifs.upcall: ip_to_fqdn: resolved 82.130.70.6 to curare.d.ethz.ch
>Jun 12 15:06:54 localhost cifs.upcall: handle_krb5_mech: getting service ticket for curare.d.ethz.ch
>Jun 12 15:06:54 localhost cifs.upcall: handle_krb5_mech: obtained service ticket
>Jun 12 15:06:54 localhost cifs.upcall: Exit status 0
>Jun 12 15:06:54 localhost kernel: [  615.042094] fs/cifs/transport.c: For smb_command 115
>Jun 12 15:06:54 localhost kernel: [  615.042101] fs/cifs/transport.c: Sending smb:  total_len 1676
>Jun 12 15:06:54 localhost kernel: [  615.045607] fs/cifs/connect.c: RFC1002 header 0xf9
>Jun 12 15:06:54 localhost kernel: [  615.045648] fs/cifs/transport.c: cifs_sync_mid_result: cmd=115 mid=2 state=4
>Jun 12 15:06:54 localhost kernel: [  615.045654] fs/cifs/misc.c: Null buffer passed to cifs_small_buf_release
>Jun 12 15:06:54 localhost kernel: [  615.045658] fs/cifs/sess.c: UID = 22531 
>Jun 12 15:06:54 localhost kernel: [  615.045661] fs/cifs/sess.c: bleft 183
>Jun 12 15:06:54 localhost kernel: [  615.045667] fs/cifs/sess.c: serverOS=Windows Server 2008 R2 Enterprise 7601 Service Pack 1
>Jun 12 15:06:54 localhost kernel: [  615.045673] fs/cifs/sess.c: serverNOS=Windows Server 2008 R2 Enterprise 6.1
>Jun 12 15:06:54 localhost kernel: [  615.045678] fs/cifs/sess.c: ssetup freeing small buf ffff88012e232fc0
>Jun 12 15:06:54 localhost kernel: [  615.045682] fs/cifs/connect.c: CIFS Session Established successfully
>Jun 12 15:06:54 localhost kernel: [  615.045686] fs/cifs/connect.c: CIFS VFS: leaving cifs_get_smb_ses (xid = 68) rc = 0
>Jun 12 15:06:54 localhost kernel: [  615.045692] fs/cifs/connect.c: CIFS VFS: in cifs_get_tcon as Xid: 69 with uid: 0
>Jun 12 15:06:54 localhost kernel: [  615.045702] fs/cifs/transport.c: For smb_command 117
>Jun 12 15:06:54 localhost kernel: [  615.045705] fs/cifs/transport.c: Sending smb:  total_len 86
>Jun 12 15:06:54 localhost kernel: [  615.046682] fs/cifs/connect.c: RFC1002 header 0x3e
>Jun 12 15:06:54 localhost kernel: [  615.046738] fs/cifs/transport.c: cifs_sync_mid_result: cmd=117 mid=3 state=4
>Jun 12 15:06:54 localhost kernel: [  615.046747] fs/cifs/connect.c: disk share connection
>Jun 12 15:06:54 localhost kernel: [  615.046756] fs/cifs/connect.c: nativeFileSystem=NTFS
>Jun 12 15:06:54 localhost kernel: [  615.046762] fs/cifs/connect.c: Tcon flags: 0x3 
>Jun 12 15:06:54 localhost kernel: [  615.046769] fs/cifs/connect.c: CIFS VFS: leaving cifs_get_tcon (xid = 69) rc = 0
>Jun 12 15:06:54 localhost kernel: [  615.046777] fs/cifs/connect.c: CIFS Tcon rc = 0
>Jun 12 15:06:54 localhost kernel: [  615.046787] fs/cifs/fscache.c: cifs_fscache_get_super_cookie: (0xffff880130438780/0xffff88011fbb30f0)
>Jun 12 15:06:54 localhost kernel: [  615.046797] fs/cifs/cifssmb.c: In QFSDeviceInfo
>Jun 12 15:06:54 localhost kernel: [  615.046805] fs/cifs/transport.c: For smb_command 50
>Jun 12 15:06:54 localhost kernel: [  615.046812] fs/cifs/transport.c: Sending smb:  total_len 72
>Jun 12 15:06:54 localhost kernel: [  615.047698] fs/cifs/connect.c: RFC1002 header 0x40
>Jun 12 15:06:54 localhost kernel: [  615.047742] fs/cifs/transport.c: cifs_sync_mid_result: cmd=50 mid=4 state=4
>Jun 12 15:06:54 localhost kernel: [  615.047755] fs/cifs/cifssmb.c: In QFSAttributeInfo
>Jun 12 15:06:54 localhost kernel: [  615.047764] fs/cifs/transport.c: For smb_command 50
>Jun 12 15:06:54 localhost kernel: [  615.047771] fs/cifs/transport.c: Sending smb:  total_len 72
>Jun 12 15:06:54 localhost kernel: [  615.048699] fs/cifs/connect.c: RFC1002 header 0x4c
>Jun 12 15:06:54 localhost kernel: [  615.048731] fs/cifs/transport.c: cifs_sync_mid_result: cmd=50 mid=5 state=4
>Jun 12 15:06:54 localhost kernel: [  615.048739] fs/cifs/connect.c: build_unc_path_to_root: full_path=\\d.ethz.ch\dfs\users\all\mam4tst
>Jun 12 15:06:54 localhost kernel: [  615.048746] fs/cifs/transport.c: For smb_command 117
>Jun 12 15:06:54 localhost kernel: [  615.048749] fs/cifs/transport.c: Sending smb:  total_len 92
>Jun 12 15:06:54 localhost kernel: [  615.049668] fs/cifs/connect.c: RFC1002 header 0x38
>Jun 12 15:06:54 localhost kernel: [  615.049701] fs/cifs/transport.c: cifs_sync_mid_result: cmd=117 mid=6 state=4
>Jun 12 15:06:54 localhost kernel: [  615.049707] fs/cifs/connect.c: CIFS Tcon rc = 0 ipc_tid = 8198
>Jun 12 15:06:54 localhost kernel: [  615.049726] fs/cifs/cifssmb.c: In GetDFSRefer the path \d.ethz.ch\dfs
>Jun 12 15:06:54 localhost kernel: [  615.049737] fs/cifs/transport.c: For smb_command 50
>Jun 12 15:06:54 localhost kernel: [  615.049744] fs/cifs/transport.c: Sending smb:  total_len 104
>Jun 12 15:06:54 localhost kernel: [  615.051368] fs/cifs/connect.c: RFC1002 header 0x2a8
>Jun 12 15:06:54 localhost kernel: [  615.051409] fs/cifs/transport.c: cifs_sync_mid_result: cmd=50 mid=7 state=4
>Jun 12 15:06:54 localhost kernel: [  615.051416] fs/cifs/cifssmb.c: Decoding GetDFSRefer response BCC: 625  Offset 56
>Jun 12 15:06:54 localhost kernel: [  615.051420] fs/cifs/cifssmb.c: num_referrals: 10 dfs flags: 0x3 ...
>Jun 12 15:06:54 localhost kernel: [  615.051422] 
>Jun 12 15:06:54 localhost kernel: [  615.054656] fs/cifs/dns_resolve.c: dns_resolve_server_name_to_ip: unable to resolve: HASH
>Jun 12 15:06:54 localhost kernel: [  615.054664] fs/cifs/cifs_dfs_ref.c: cifs_compose_mount_options: Failed to resolve server part of \\HASH\dfs to IP: -126
>Jun 12 15:06:54 localhost kernel: [  615.054679] fs/cifs/transport.c: For smb_command 50
>Jun 12 15:06:54 localhost kernel: [  615.054682] fs/cifs/transport.c: Sending smb:  total_len 144
>Jun 12 15:06:54 localhost kernel: [  615.055774] fs/cifs/connect.c: RFC1002 header 0x23
>Jun 12 15:06:54 localhost kernel: [  615.055781] fs/cifs/connect.c: invalid transact2 word count
>Jun 12 15:06:54 localhost kernel: [  615.055817] fs/cifs/transport.c: cifs_sync_mid_result: cmd=50 mid=8 state=4
>Jun 12 15:06:54 localhost kernel: [  615.055823] fs/cifs/netmisc.c: Mapping smb error code 0xc0000257 to POSIX err -66
>Jun 12 15:06:54 localhost kernel: [  615.055828] fs/cifs/cifssmb.c: Send error in QPathInfo = -66
>Jun 12 15:06:54 localhost kernel: [  615.055833] fs/cifs/connect.c: build_unc_path_to_root: full_path=\\d.ethz.ch\dfs\users\all\mam4tst
>Jun 12 15:06:54 localhost kernel: [  615.055837] fs/cifs/cifssmb.c: In GetDFSRefer the path \d.ethz.ch\dfs\users\all\mam4tst
>Jun 12 15:06:54 localhost kernel: [  615.055843] fs/cifs/transport.c: For smb_command 50
>Jun 12 15:06:54 localhost kernel: [  615.055847] fs/cifs/transport.c: Sending smb:  total_len 140
>Jun 12 15:06:54 localhost kernel: [  615.057065] fs/cifs/connect.c: RFC1002 header 0xec
>Jun 12 15:06:54 localhost kernel: [  615.057095] fs/cifs/transport.c: cifs_sync_mid_result: cmd=50 mid=9 state=4
>Jun 12 15:06:54 localhost kernel: [  615.057101] fs/cifs/cifssmb.c: Decoding GetDFSRefer response BCC: 181  Offset 56
>Jun 12 15:06:54 localhost kernel: [  615.057105] fs/cifs/cifssmb.c: num_referrals: 1 dfs flags: 0x1 ...
>Jun 12 15:06:54 localhost kernel: [  615.057106] 
>Jun 12 15:06:54 localhost kernel: [  615.057116] fs/cifs/connect.c: cifs_put_tcon: tc_count=1
>Jun 12 15:06:54 localhost kernel: [  615.057118] 
>Jun 12 15:06:54 localhost kernel: [  615.057121] fs/cifs/connect.c: CIFS VFS: in cifs_put_tcon as Xid: 70 with uid: 0
>Jun 12 15:06:54 localhost kernel: [  615.057124] fs/cifs/cifssmb.c: In tree disconnect
>Jun 12 15:06:54 localhost kernel: [  615.057129] fs/cifs/transport.c: For smb_command 113
>Jun 12 15:06:54 localhost kernel: [  615.057132] fs/cifs/transport.c: Sending smb:  total_len 39
>Jun 12 15:06:54 localhost kernel: [  615.058093] fs/cifs/connect.c: RFC1002 header 0x23
>Jun 12 15:06:54 localhost kernel: [  615.058133] fs/cifs/transport.c: cifs_sync_mid_result: cmd=113 mid=10 state=4
>Jun 12 15:06:54 localhost kernel: [  615.058139] fs/cifs/fscache.c: cifs_fscache_release_super_cookie: (0xffff88011fbb30f0)
>Jun 12 15:06:54 localhost kernel: [  615.058144] fs/cifs/connect.c: cifs_put_smb_ses: ses_count=1
>Jun 12 15:06:54 localhost kernel: [  615.058146] 
>Jun 12 15:06:54 localhost kernel: [  615.058149] fs/cifs/connect.c: CIFS VFS: in cifs_put_smb_ses as Xid: 71 with uid: 0
>Jun 12 15:06:54 localhost kernel: [  615.058152] fs/cifs/cifssmb.c: In SMBLogoff for session disconnect
>Jun 12 15:06:54 localhost kernel: [  615.058157] fs/cifs/transport.c: For smb_command 116
>Jun 12 15:06:54 localhost kernel: [  615.058160] fs/cifs/transport.c: Sending smb:  total_len 43
>Jun 12 15:06:54 localhost kernel: [  615.059147] fs/cifs/connect.c: RFC1002 header 0x27
>Jun 12 15:06:54 localhost kernel: [  615.059187] fs/cifs/transport.c: cifs_sync_mid_result: cmd=116 mid=11 state=4
>Jun 12 15:06:54 localhost kernel: [  615.059199] fs/cifs/fscache.c: cifs_fscache_release_client_cookie: (0xffff88011eda4c00/0xffff880130438780)
>Jun 12 15:06:54 localhost kernel: [  615.059337] fs/cifs/connect.c: CIFS VFS: leaving cifs_mount (xid = 67) rc = -22
>Jun 12 15:06:54 localhost kernel: [  615.059343] CIFS VFS: cifs_mount failed w/return code = -22

Actions: View

Attachments on bug 826507: 588354 | 588356 | 588554 | 589065 | 589066 | 590928 | 591188