<html>
<head>
<style><!--
.hmmessage P
{
margin:0px;
padding:0px
}
body.hmmessage
{
font-size: 10pt;
font-family:Tahoma
}
--></style>
</head>
<body class='hmmessage'><div dir='ltr'>
<br><br><div>> Date: Fri, 24 Jun 2011 20:01:31 +0200<br>> From: bubulle@debian.org<br>> To: lindani@hotmail.de<br>> CC: 631364@bugs.debian.org<br>> Subject: Re: [Pkg-samba-maint] Bug#631364:<br>> <br>> reassign 631364 samba<br>> found 631364 2:3.5.6~dfsg-3<br>> thanks<br>> <br>> Quoting Dani Daniel (lindani@hotmail.de):<br>> <br>> > > What is the version of samba on the server? 3.5.6 as in squeeze?<br>> > > <br>> > > Can you reproduce this with another samba server, or with a share<br>> > > located on a Windows machine?<br>> > > <br>> > > <br>> > <br>> > Yes, it's version 3.5.6 in squeeze. I tried it on a share exported with windows xp. There it doesn't happen, only on a share exported on my debian squeeze server.<br>> > <br>> <br>> Hmm, then the problem might be server-side.<br>> <br>> Could you look in the samba server's logfile? You may need to increase<br>> the log level to 3. Maybe 10...but that will be *very* verbose and<br>> you'd then need to try isolating the issue as narrowly as possible.<br>> <br>> <br>> <br>> -- <br>> <br>> <br><br>Ok, I here is my log file:<br><br>--------------------It begins:<br><br>[2011/06/25 12:35:59.876545, 3] smbd/process.c:1294(switch_message)<br> switch message SMBreadX (pid 2337) conn 0xb87c9258<br>[2011/06/25 12:35:59.876571, 3] smbd/sec_ctx.c:310(set_sec_ctx)<br> setting sec ctx (1000, 1000) - sec_ctx_stack_ndx = 0<br>[2011/06/25 12:35:59.876591, 5] auth/token_util.c:531(debug_nt_user_token)<br> NT user token of user S-1-5-21-3324774100-1771195128-357238496-1001<br> contains 25 SIDs<br> SID[ 0]: S-1-5-21-3324774100-1771195128-357238496-1001<br> SID[ 1]: S-1-22-2-1000<br> SID[ 2]: S-1-1-0<br> SID[ 3]: S-1-5-2<br> SID[ 4]: S-1-5-11<br> SID[ 5]: S-1-22-2-24<br> SID[ 6]: S-1-22-2-25<br> SID[ 7]: S-1-22-2-29<br> SID[ 8]: S-1-22-2-30<br> SID[ 9]: S-1-22-2-44<br> SID[ 10]: S-1-22-2-46<br> SID[ 11]: S-1-22-2-108<br> SID[ 12]: S-1-22-2-109<br> SID[ 13]: S-1-22-2-115<br> SID[ 14]: S-1-22-2-1500<br> SID[ 15]: S-1-22-2-1501<br> SID[ 16]: S-1-22-2-1502<br> SID[ 17]: S-1-22-2-1503<br> SID[ 18]: S-1-22-2-1505<br> SID[ 19]: S-1-22-2-1504<br> SID[ 20]: S-1-22-2-1506<br> SID[ 21]: S-1-22-2-1507<br> SID[ 22]: S-1-22-2-1508<br> SID[ 23]: S-1-22-2-1509<br> SID[ 24]: S-1-22-1-1000<br> SE_PRIV 0x0 0x0 0x0 0x0<br>[2011/06/25 12:35:59.876821, 5] auth/token_util.c:551(debug_unix_user_token)<br> UNIX token of user 1000<br> Primary group is 1000 and contains 20 supplementary groups<br> Group[ 0]: 1000<br> Group[ 1]: 24<br> Group[ 2]: 25<br> Group[ 3]: 29<br> Group[ 4]: 30<br> Group[ 5]: 44<br> Group[ 6]: 46<br> Group[ 7]: 108<br> Group[ 8]: 109<br> Group[ 9]: 115<br> Group[ 10]: 1500<br> Group[ 11]: 1501<br> Group[ 12]: 1502<br> Group[ 13]: 1503<br> Group[ 14]: 1505<br> Group[ 15]: 1504<br> Group[ 16]: 1506<br> Group[ 17]: 1507<br> Group[ 18]: 1508<br> Group[ 19]: 1509<br>[2011/06/25 12:35:59.876974, 5] smbd/uid.c:354(change_to_user)<br> change_to_user uid=(0,1000) gid=(0,1000)<br>[2011/06/25 12:35:59.877018, 10] locking/posix.c:301(is_posix_locked)<br> is_posix_locked: File dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp, offset = 9080832, count = 16384, type = READ<br>[2011/06/25 12:35:59.877057, 10] locking/posix.c:172(posix_lock_in_range)<br> posix_lock_in_range: offset_out = 9080832, count_out = 16384<br>[2011/06/25 12:35:59.877080, 8] locking/posix.c:250(posix_fcntl_getlock)<br> posix_fcntl_getlock 33 9080832 16384 0<br>[2011/06/25 12:35:59.877102, 8] lib/util.c:1822(fcntl_getlock)<br> fcntl_getlock fd=33 offset=9080832 count=16384 type=0<br>[2011/06/25 12:35:59.877128, 3] lib/util.c:1846(fcntl_getlock)<br> fcntl_getlock: fd 33 is returned info 2 pid 0<br>[2011/06/25 12:35:59.877147, 8] locking/posix.c:280(posix_fcntl_getlock)<br> posix_fcntl_getlock: Lock query call successful<br>[2011/06/25 12:35:59.877166, 10] locking/brlock.c:1308(brl_locktest)<br> brl_locktest: posix start=9080832 len=16384 unlocked for fnum 17196 file dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp<br>[2011/06/25 12:35:59.877193, 10] locking/locking.c:154(strict_lock_default)<br> strict_lock_default: flavour = WINDOWS_LOCK brl start=9080832 len=16384 unlocked for fnum 17196 file dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp<br>[2011/06/25 12:35:59.877261, 10] smbd/fileio.c:106(read_file)<br> read_file (dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp): pos = 9080832, size = 16384, returned 16384<br>[2011/06/25 12:35:59.877303, 3] smbd/reply.c:3591(send_file_readX)<br> send_file_readX fnum=17196 max=16384 nread=16384<br>[2011/06/25 12:35:59.877878, 10] lib/util_sock.c:731(read_smb_length_return_keepalive)<br> got smb length of 59<br>[2011/06/25 12:35:59.877926, 6] smbd/process.c:1482(process_smb)<br> got message type 0x0 of len 0x3b<br>[2011/06/25 12:35:59.877947, 3] smbd/process.c:1485(process_smb)<br> Transaction 801 of length 63 (0 toread)<br>[2011/06/25 12:35:59.877968, 5] lib/util.c:617(show_msg)<br>[2011/06/25 12:35:59.877980, 5] lib/util.c:627(show_msg)<br> size=59<br> smb_com=0x2e<br> smb_rcls=0<br> smb_reh=0<br> smb_err=0<br> smb_flg=0<br> smb_flg2=49153<br> smb_tid=1<br> smb_pid=2467<br> smb_uid=100<br> smb_mid=4403<br> smt_wct=12<br> smb_vwv[ 0]= 255 (0xFF)<br> smb_vwv[ 1]= 0 (0x0)<br> smb_vwv[ 2]=17196 (0x432C)<br> smb_vwv[ 3]=53248 (0xD000)<br> smb_vwv[ 4]= 138 (0x8A)<br> smb_vwv[ 5]=16384 (0x4000)<br> smb_vwv[ 6]= 0 (0x0)<br> smb_vwv[ 7]= 0 (0x0)<br> smb_vwv[ 8]= 0 (0x0)<br> smb_vwv[ 9]= 0 (0x0)<br> smb_vwv[10]= 0 (0x0)<br> smb_vwv[11]= 0 (0x0)<br> smb_bcc=0<br>[2011/06/25 12:35:59.878121, 3] smbd/process.c:1294(switch_message)<br> switch message SMBreadX (pid 2337) conn 0xb87c9258<br>[2011/06/25 12:35:59.878143, 4] smbd/uid.c:257(change_to_user)<br> change_to_user: Skipping user change - already user<br>[2011/06/25 12:35:59.878175, 10] locking/posix.c:301(is_posix_locked)<br> is_posix_locked: File dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp, offset = 9097216, count = 16384, type = READ<br><br>-------------------------This repeats a lot of times... then it continues:<br><br>[2011/06/25 12:35:59.976141, 10] locking/locking.c:655(parse_share_modes)<br> parse_share_modes: share_mode_entry[1]: UNUSED pid = 2337, share_access = 0x7, private_options = 0x40, access_mask = 0x120089, mid = 0x0, type= 0x40, gen_id = 9, uid = 1000, flags = 0, file_id fe01:d21836:0<br>[2011/06/25 12:35:59.976171, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)<br> Unlocking key 01FE0000000000003618<br>[2011/06/25 12:35:59.976213, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)<br> Locking key 01FE0000000000003618<br>[2011/06/25 12:35:59.976239, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)<br> Allocated locked data 0x0xb87bd618<br>[2011/06/25 12:35:59.976259, 10] locking/brlock.c:1896(brl_get_locks_internal)<br> brl_get_locks_internal: 1 current locks on file_id fe01:d21836:0<br>[2011/06/25 12:35:59.976282, 10] locking/brlock.c:48(print_lock_struct)<br> [0]: smbpid = 2467, tid = 1, pid = 2337, start = 0, size = 9223372036854775808, fnum = 17196, WRITE WINDOWS_LOCK<br>[2011/06/25 12:35:59.976333, 10] locking/posix.c:480(reduce_windows_lock_ref_count)<br> reduce_windows_lock_ref_count for file now dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp = 0<br>[2011/06/25 12:35:59.976364, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)<br> Unlocking key 01FE0000000000003618<br>[2011/06/25 12:35:59.976397, 10] locking/posix.c:512(get_windows_lock_ref_count)<br> get_windows_lock_count for file dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp = 0<br>[2011/06/25 12:35:59.976436, 10] locking/posix.c:666(fd_close_posix)<br> fd_close_posix: doing close on 1 fd's.<br>[2011/06/25 12:35:59.976466, 10] locking/posix.c:538(delete_windows_lock_ref_count)<br> delete_windows_lock_ref_count for file dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp<br>[2011/06/25 12:35:59.976493, 2] smbd/close.c:656(close_normal_file)<br> dani closed file dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp (numopen=0) NT_STATUS_OK<br>[2011/06/25 12:35:59.976519, 5] smbd/files.c:497(file_free)<br> freed files structure 17196 (0 used)<br>[2011/06/25 12:35:59.976542, 5] lib/util.c:617(show_msg)<br>[2011/06/25 12:35:59.976555, 5] lib/util.c:627(show_msg)<br> size=35<br> smb_com=0x4<br> smb_rcls=0<br> smb_reh=0<br> smb_err=0<br> smb_flg=128<br> smb_flg2=49155<br> smb_tid=1<br> smb_pid=2467<br> smb_uid=100<br> smb_mid=4481<br> smt_wct=0<br> smb_bcc=0<br>[2011/06/25 12:36:00.001821, 10] lib/util_sock.c:731(read_smb_length_return_keepalive)<br> got smb length of 202<br>[2011/06/25 12:36:00.001865, 6] smbd/process.c:1482(process_smb)<br> got message type 0x0 of len 0xca<br>[2011/06/25 12:36:00.001886, 3] smbd/process.c:1485(process_smb)<br> Transaction 880 of length 206 (0 toread)<br>[2011/06/25 12:36:00.001905, 5] lib/util.c:617(show_msg)<br>[2011/06/25 12:36:00.001917, 5] lib/util.c:627(show_msg)<br> size=202<br> smb_com=0xa2<br> smb_rcls=0<br> smb_reh=0<br> smb_err=0<br> smb_flg=0<br> smb_flg2=49153<br> smb_tid=1<br> smb_pid=2467<br> smb_uid=100<br> smb_mid=4482<br> smt_wct=24<br> smb_vwv[ 0]= 255 (0xFF)<br> smb_vwv[ 1]= 0 (0x0)<br> smb_vwv[ 2]=30208 (0x7600)<br> smb_vwv[ 3]= 512 (0x200)<br> smb_vwv[ 4]= 0 (0x0)<br> smb_vwv[ 5]= 0 (0x0)<br> smb_vwv[ 6]= 0 (0x0)<br> smb_vwv[ 7]= 0 (0x0)<br> smb_vwv[ 8]= 0 (0x0)<br> smb_vwv[ 9]= 192 (0xC0)<br> smb_vwv[10]= 0 (0x0)<br> smb_vwv[11]= 0 (0x0)<br> smb_vwv[12]= 0 (0x0)<br> smb_vwv[13]=32768 (0x8000)<br> smb_vwv[14]= 0 (0x0)<br> smb_vwv[15]= 1792 (0x700)<br> smb_vwv[16]= 0 (0x0)<br> smb_vwv[17]= 256 (0x100)<br> smb_vwv[18]= 0 (0x0)<br> smb_vwv[19]=16384 (0x4000)<br> smb_vwv[20]= 0 (0x0)<br> smb_vwv[21]= 512 (0x200)<br> smb_vwv[22]= 0 (0x0)<br> smb_vwv[23]= 768 (0x300)<br> smb_bcc=119<br>[2011/06/25 12:36:00.002116, 10] ../lib/util/util.c:278(_dump_data)<br> [0000] 00 5C 00 64 00 61 00 6E 00 69 00 5C 00 73 00 63 .\.d.a.n .i.\.s.c<br> [0010] 00 68 00 75 00 6C 00 65 00 5C 00 77 00 31 00 69 .h.u.l.e .\.w.1.i<br> [0020] 00 6B 00 31 00 5C 00 69 00 74 00 73 00 5C 00 6C .k.1.\.i .t.s.\.l<br> [0030] 00 69 00 6E 00 75 00 78 00 2D 00 70 00 72 00 61 .i.n.u.x .-.p.r.a<br> [0040] 00 65 00 73 00 65 00 6E 00 74 00 61 00 74 00 69 .e.s.e.n .t.a.t.i<br> [0050] 00 6F 00 6E 00 5C 00 6C 00 69 00 6E 00 75 00 78 .o.n.\.l .i.n.u.x<br> [0060] 00 2D 00 70 00 72 00 61 00 65 00 73 00 2E 00 6F .-.p.r.a .e.s...o<br> [0070] 00 64 00 70 00 00 00 .d.p... <br>[2011/06/25 12:36:00.002322, 3] smbd/process.c:1294(switch_message)<br> switch message SMBntcreateX (pid 2337) conn 0xb87c9258<br>[2011/06/25 12:36:00.002355, 4] smbd/uid.c:257(change_to_user)<br> change_to_user: Skipping user change - already user<br>[2011/06/25 12:36:00.002386, 10] smbd/nttrans.c:498(reply_ntcreate_and_X)<br> reply_ntcreate_and_X: flags = 0x2, access_mask = 0xc0000000 file_attributes = 0x80, share_access = 0x7, create_disposition = 0x1 create_options = 0x40 root_dir_fid = 0x0, fname = dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp<br>[2011/06/25 12:36:00.002415, 5] smbd/filename.c:169(unix_convert)<br> unix_convert called on file "dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp"<br>[2011/06/25 12:36:00.002438, 5] smbd/filename.c:328(unix_convert)<br> unix_convert begin: name = dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp, dirpath = , start = dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp<br>[2011/06/25 12:36:00.002475, 5] smbd/filename.c:351(unix_convert)<br> conversion of base_name finished dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp -> dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp<br>[2011/06/25 12:36:00.002518, 3] smbd/vfs.c:851(check_reduced_name)<br> check_reduced_name [dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp] [/mnt/storage/dokumente]<br>[2011/06/25 12:36:00.002572, 10] smbd/vfs.c:938(check_reduced_name)<br> check_reduced_name realpath [dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp] -> [/mnt/storage/dokumente/dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp]<br>[2011/06/25 12:36:00.002596, 3] smbd/vfs.c:1008(check_reduced_name)<br> check_reduced_name: dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp reduced to /mnt/storage/dokumente/dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp<br>[2011/06/25 12:36:00.002619, 10] smbd/open.c:3410(create_file_default)<br> create_file: access_mask = 0xc0000000 file_attributes = 0x80, share_access = 0x7, create_disposition = 0x1 create_options = 0x40 oplock_request = 0x1 root_dir_fid = 0x0, ea_list = 0x(nil), sd = 0x(nil), fname = dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp<br>[2011/06/25 12:36:00.002649, 3] smbd/vfs.c:851(check_reduced_name)<br> check_reduced_name [dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp] [/mnt/storage/dokumente]<br>[2011/06/25 12:36:00.002689, 10] smbd/vfs.c:938(check_reduced_name)<br> check_reduced_name realpath [dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp] -> [/mnt/storage/dokumente/dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp]<br>[2011/06/25 12:36:00.002711, 3] smbd/vfs.c:1008(check_reduced_name)<br> check_reduced_name: dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp reduced to /mnt/storage/dokumente/dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp<br>[2011/06/25 12:36:00.002733, 10] smbd/open.c:2928(create_file_unixpath)<br> create_file_unixpath: access_mask = 0xc0000000 file_attributes = 0x80, share_access = 0x7, create_disposition = 0x1 create_options = 0x40 oplock_request = 0x1 ea_list = 0x(nil), sd = 0x(nil), fname = dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp<br>[2011/06/25 12:36:00.002763, 5] smbd/files.c:119(file_new)<br> allocated file structure 13103, fnum = 17199 (1 used)<br>[2011/06/25 12:36:00.002789, 2] smbd/dosmode.c:98(unix_mode)<br> unix_mode(dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp) inheriting from dani/schule/w1ik1/its/linux-praesentation<br>[2011/06/25 12:36:00.002815, 2] smbd/dosmode.c:121(unix_mode)<br> unix_mode(dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp) inherit mode 42750<br>[2011/06/25 12:36:00.002835, 3] smbd/dosmode.c:166(unix_mode)<br> unix_mode(dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp) returning 0740<br>[2011/06/25 12:36:00.002855, 10] smbd/open.c:1526(open_file_ntcreate)<br> open_file_ntcreate: fname=dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp, dos_attrs=0x80 access_mask=0xc0000000 share_access=0x7 create_disposition = 0x1 create_options=0x40 unix mode=0740 oplock_request=1<br>[2011/06/25 12:36:00.002880, 3] smbd/vfs.c:851(check_reduced_name)<br> check_reduced_name [dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp] [/mnt/storage/dokumente]<br>[2011/06/25 12:36:00.002920, 10] smbd/vfs.c:938(check_reduced_name)<br> check_reduced_name realpath [dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp] -> [/mnt/storage/dokumente/dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp]<br>[2011/06/25 12:36:00.002941, 3] smbd/vfs.c:1008(check_reduced_name)<br> check_reduced_name: dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp reduced to /mnt/storage/dokumente/dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp<br>[2011/06/25 12:36:00.002964, 8] smbd/dosmode.c:613(dos_mode)<br> dos_mode: dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp<br>[2011/06/25 12:36:00.002985, 8] smbd/dosmode.c:207(dos_mode_from_sbuf)<br> dos_mode_from_sbuf returning a<br>[2011/06/25 12:36:00.003006, 8] smbd/dosmode.c:666(dos_mode)<br> dos_mode returning a<br>[2011/06/25 12:36:00.003029, 10] lib/util_seaccess.c:58(se_map_generic)<br> se_map_generic(): mapped mask 0xc0000000 to 0x0012019f<br>[2011/06/25 12:36:00.003049, 10] smbd/open.c:1708(open_file_ntcreate)<br> open_file_ntcreate: fname=dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp, after mapping access_mask=0x12019f<br>[2011/06/25 12:36:00.003092, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)<br> Locking key 01FE0000000000003618<br>[2011/06/25 12:36:00.003126, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)<br> Allocated locked data 0x0xb87bdec8<br>[2011/06/25 12:36:00.003148, 10] smbd/open.c:1033(delay_for_oplocks)<br> delay_for_oplocks: oplock type 0x1 on file dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp<br>[2011/06/25 12:36:00.003171, 10] smbd/open.c:1033(delay_for_oplocks)<br> delay_for_oplocks: oplock type 0x1 on file dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp<br>[2011/06/25 12:36:00.003193, 4] smbd/open.c:1970(open_file_ntcreate)<br> calling open_file with flags=0x2 flags2=0x0 mode=0740, access_mask = 0x12019f, open_access_mask = 0x12019f<br>[2011/06/25 12:36:00.003226, 10] smbd/open.c:169(fd_open)<br> fd_open: name dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp, flags = 02 mode = 0740, fd = 33. <br>[2011/06/25 12:36:00.003250, 2] smbd/open.c:633(open_file)<br> dani opened file dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp read=Yes write=Yes (numopen=1)<br>[2011/06/25 12:36:00.003280, 3] smbd/oplock_linux.c:127(linux_set_kernel_oplock)<br> linux_set_kernel_oplock: got kernel oplock on file dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp, file_id = fe01:d21836:0 gen_id = 10<br>[2011/06/25 12:36:00.003309, 5] smbd/oplock.c:86(set_file_oplock)<br> set_file_oplock: granted oplock on file dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp, fe01:d21836:0/10, tv_sec = 4e05ba10, tv_usec = ac8<br>[2011/06/25 12:36:00.003340, 10] locking/locking.c:726(unparse_share_modes)<br> unparse_share_modes: del: 0, owrt: Sa 25 Jun 2011 11:35:35 CEST CEST cwrt: Do 01 Jan 1970 01:00:00 CET CET, tok: 0, num: 1<br>[2011/06/25 12:36:00.003394, 10] locking/locking.c:518(print_share_mode_table)<br> print_share_mode_table: share_mode_entry[0]: pid = 2337, share_access = 0x7, private_options = 0x40, access_mask = 0x12019f, mid = 0x0, type= 0x1, gen_id = 10, uid = 1000, flags = 0, file_id fe01:d21836:0<br>[2011/06/25 12:36:00.003422, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)<br> Unlocking key 01FE0000000000003618<br>[2011/06/25 12:36:00.003456, 10] smbd/open.c:3235(create_file_unixpath)<br> create_file_unixpath: info=1<br>[2011/06/25 12:36:00.003477, 10] smbd/open.c:3481(create_file_default)<br> create_file: info=1<br>[2011/06/25 12:36:00.003499, 8] smbd/dosmode.c:613(dos_mode)<br> dos_mode: dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp<br>[2011/06/25 12:36:00.003520, 8] smbd/dosmode.c:207(dos_mode_from_sbuf)<br> dos_mode_from_sbuf returning a<br>[2011/06/25 12:36:00.003542, 8] smbd/dosmode.c:666(dos_mode)<br> dos_mode returning a<br>[2011/06/25 12:36:00.003570, 10] locking/locking.c:552(parse_share_modes)<br> parse_share_modes: delete_on_close: 0, owrt: Sa 25 Jun 2011 11:35:35 CEST CEST, cwrt: Do 01 Jan 1970 01:00:00 CET CET, tok: 0, num_share_modes: 1<br>[2011/06/25 12:36:00.003620, 10] locking/locking.c:655(parse_share_modes)<br> parse_share_modes: share_mode_entry[0]: pid = 2337, share_access = 0x7, private_options = 0x40, access_mask = 0x12019f, mid = 0x0, type= 0x1, gen_id = 10, uid = 1000, flags = 0, file_id fe01:d21836:0<br>[2011/06/25 12:36:00.003647, 5] smbd/nttrans.c:722(reply_ntcreate_and_X)<br> reply_ntcreate_and_X: fnum = 17199, open name = dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp<br>[2011/06/25 12:36:00.004084, 10] lib/util_sock.c:731(read_smb_length_return_keepalive)<br> got smb length of 71<br>[2011/06/25 12:36:00.004125, 6] smbd/process.c:1482(process_smb)<br> got message type 0x0 of len 0x47<br>[2011/06/25 12:36:00.004147, 3] smbd/process.c:1485(process_smb)<br> Transaction 881 of length 75 (0 toread)<br>[2011/06/25 12:36:00.004166, 5] lib/util.c:617(show_msg)<br>[2011/06/25 12:36:00.004179, 5] lib/util.c:627(show_msg)<br><br>.<br>.<br>.<br>-----------------------And ends:<br> Primary group is 0 and contains 0 supplementary groups<br>[2011/06/25 12:36:18.408238, 5] smbd/uid.c:369(change_to_root_user)<br> change_to_root_user: now uid=(0,0) gid=(0,0)<br>[2011/06/25 12:36:18.408269, 5] lib/messages.c:329(messaging_deregister)<br> Deregistering messaging pointer for type 784 - private_data=0xb87cc2f8<br>[2011/06/25 12:36:18.408295, 4] smbd/vfs.c:721(vfs_ChDir)<br> vfs_ChDir to /mnt/storage/bilder<br>[2011/06/25 12:36:18.408322, 3] smbd/sec_ctx.c:310(set_sec_ctx)<br> setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0<br>[2011/06/25 12:36:18.408351, 5] auth/token_util.c:525(debug_nt_user_token)<br> NT user token: (NULL)<br>[2011/06/25 12:36:18.408370, 5] auth/token_util.c:551(debug_unix_user_token)<br> UNIX token of user 0<br> Primary group is 0 and contains 0 supplementary groups<br>[2011/06/25 12:36:18.408401, 5] smbd/uid.c:369(change_to_root_user)<br> change_to_root_user: now uid=(0,0) gid=(0,0)<br>[2011/06/25 12:36:18.408422, 1] smbd/service.c:1251(close_cnum)<br> __ffff_192.168.1.10 (::ffff:192.168.1.10) closed connection to service bilder<br>[2011/06/25 12:36:18.408446, 3] smbd/connection.c:31(yield_connection)<br> Yielding connection to bilder<br>[2011/06/25 12:36:18.408546, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)<br> Locking key 21090000FFFFFFFF0200<br>[2011/06/25 12:36:18.408578, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)<br> Allocated locked data 0x0xb87cd268<br>[2011/06/25 12:36:18.408608, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)<br> Unlocking key 21090000FFFFFFFF0200<br>[2011/06/25 12:36:18.408706, 4] smbd/vfs.c:721(vfs_ChDir)<br> vfs_ChDir to /<br>[2011/06/25 12:36:18.408729, 3] smbd/sec_ctx.c:310(set_sec_ctx)<br> setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0<br>[2011/06/25 12:36:18.408749, 5] auth/token_util.c:525(debug_nt_user_token)<br> NT user token: (NULL)<br>[2011/06/25 12:36:18.408767, 5] auth/token_util.c:551(debug_unix_user_token)<br> UNIX token of user 0<br> Primary group is 0 and contains 0 supplementary groups<br>[2011/06/25 12:36:18.408797, 5] smbd/uid.c:369(change_to_root_user)<br> change_to_root_user: now uid=(0,0) gid=(0,0)<br>[2011/06/25 12:36:18.408827, 5] lib/messages.c:329(messaging_deregister)<br> Deregistering messaging pointer for type 784 - private_data=0xb87c9788<br>[2011/06/25 12:36:18.408851, 4] smbd/vfs.c:721(vfs_ChDir)<br> vfs_ChDir to /mnt/storage/dokumente<br>[2011/06/25 12:36:18.408879, 10] smbd/oplock_linux.c:139(linux_release_kernel_oplock)<br> linux_release_kernel_oplock: file dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp, file_id = fe01:d21836:0 gen_id = 10 has kernel oplock state of 1.<br>[2011/06/25 12:36:18.408928, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)<br> Locking key 01FE0000000000003618<br>[2011/06/25 12:36:18.408956, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)<br> Allocated locked data 0x0xb87b0af0<br>[2011/06/25 12:36:18.408975, 10] locking/locking.c:552(parse_share_modes)<br> parse_share_modes: delete_on_close: 0, owrt: Sa 25 Jun 2011 11:35:35 CEST CEST, cwrt: Do 01 Jan 1970 01:00:00 CET CET, tok: 0, num_share_modes: 1<br>[2011/06/25 12:36:18.409031, 10] locking/locking.c:655(parse_share_modes)<br> parse_share_modes: share_mode_entry[0]: pid = 2337, share_access = 0x7, private_options = 0x40, access_mask = 0x12019f, mid = 0x0, type= 0x1, gen_id = 10, uid = 1000, flags = 0, file_id fe01:d21836:0<br>[2011/06/25 12:36:18.409077, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)<br> Unlocking key 01FE0000000000003618<br>[2011/06/25 12:36:18.409124, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)<br> Locking key 01FE0000000000003618<br>[2011/06/25 12:36:18.409149, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)<br> Allocated locked data 0x0xb8745a80<br>[2011/06/25 12:36:18.409170, 10] locking/brlock.c:1896(brl_get_locks_internal)<br> brl_get_locks_internal: 1 current locks on file_id fe01:d21836:0<br>[2011/06/25 12:36:18.409195, 10] locking/brlock.c:48(print_lock_struct)<br> [0]: smbpid = 2467, tid = 1, pid = 2337, start = 0, size = 9223372036854775808, fnum = 17199, WRITE WINDOWS_LOCK<br>[2011/06/25 12:36:18.409243, 10] locking/posix.c:480(reduce_windows_lock_ref_count)<br> reduce_windows_lock_ref_count for file now dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp = 0<br>[2011/06/25 12:36:18.409286, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)<br> Unlocking key 01FE0000000000003618<br>[2011/06/25 12:36:18.409321, 10] locking/posix.c:512(get_windows_lock_ref_count)<br> get_windows_lock_count for file dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp = 0<br>[2011/06/25 12:36:18.409345, 10] locking/posix.c:538(delete_windows_lock_ref_count)<br> delete_windows_lock_ref_count for file dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp<br>[2011/06/25 12:36:18.409386, 2] smbd/close.c:656(close_normal_file)<br> dani closed file dani/schule/w1ik1/its/linux-praesentation/linux-praes.odp (numopen=0) NT_STATUS_OK<br>[2011/06/25 12:36:18.409411, 5] smbd/files.c:497(file_free)<br> freed files structure 17199 (0 used)<br>[2011/06/25 12:36:18.409434, 3] smbd/sec_ctx.c:310(set_sec_ctx)<br> setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0<br>[2011/06/25 12:36:18.409454, 5] auth/token_util.c:525(debug_nt_user_token)<br> NT user token: (NULL)<br>[2011/06/25 12:36:18.409473, 5] auth/token_util.c:551(debug_unix_user_token)<br> UNIX token of user 0<br> Primary group is 0 and contains 0 supplementary groups<br>[2011/06/25 12:36:18.409508, 5] smbd/uid.c:369(change_to_root_user)<br> change_to_root_user: now uid=(0,0) gid=(0,0)<br>[2011/06/25 12:36:18.409531, 1] smbd/service.c:1251(close_cnum)<br> __ffff_192.168.1.10 (::ffff:192.168.1.10) closed connection to service dokumente<br>[2011/06/25 12:36:18.409557, 3] smbd/connection.c:31(yield_connection)<br> Yielding connection to dokumente<br>[2011/06/25 12:36:18.409661, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)<br> Locking key 21090000FFFFFFFF0100<br>[2011/06/25 12:36:18.409694, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)<br> Allocated locked data 0x0xb87cd268<br>[2011/06/25 12:36:18.409724, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)<br> Unlocking key 21090000FFFFFFFF0100<br>[2011/06/25 12:36:18.409826, 4] smbd/vfs.c:721(vfs_ChDir)<br> vfs_ChDir to /<br>[2011/06/25 12:36:18.409851, 3] smbd/sec_ctx.c:310(set_sec_ctx)<br> setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0<br>[2011/06/25 12:36:18.409871, 5] auth/token_util.c:525(debug_nt_user_token)<br> NT user token: (NULL)<br>[2011/06/25 12:36:18.409889, 5] auth/token_util.c:551(debug_unix_user_token)<br> UNIX token of user 0<br> Primary group is 0 and contains 0 supplementary groups<br>[2011/06/25 12:36:18.409920, 5] smbd/uid.c:369(change_to_root_user)<br> change_to_root_user: now uid=(0,0) gid=(0,0)<br>[2011/06/25 12:36:18.409951, 5] lib/messages.c:329(messaging_deregister)<br> Deregistering messaging pointer for type 784 - private_data=0xb87cca20<br>[2011/06/25 12:36:18.418284, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)<br> Locking key 49442F323333372F3130<br>[2011/06/25 12:36:18.418429, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)<br> Allocated locked data 0x0xb87b97f0<br>[2011/06/25 12:36:18.418456, 4] auth/pampass.c:472(smb_pam_start)<br> smb_pam_start: PAM: Init user: dani<br>[2011/06/25 12:36:18.421009, 4] auth/pampass.c:489(smb_pam_start)<br> smb_pam_start: PAM: setting rhost to: ::ffff:192.168.1.10<br>[2011/06/25 12:36:18.421080, 4] auth/pampass.c:498(smb_pam_start)<br> smb_pam_start: PAM: setting tty<br>[2011/06/25 12:36:18.421101, 4] auth/pampass.c:506(smb_pam_start)<br> smb_pam_start: PAM: Init passed for user: dani<br>[2011/06/25 12:36:18.421122, 4] auth/pampass.c:643(smb_internal_pam_session)<br> smb_internal_pam_session: PAM: tty set to: smb/2337/100<br>[2011/06/25 12:36:18.422029, 4] auth/pampass.c:450(smb_pam_end)<br> smb_pam_end: PAM: PAM_END OK.<br>[2011/06/25 12:36:18.422165, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)<br> Unlocking key 49442F323333372F3130<br>[2011/06/25 12:36:18.422226, 3] smbd/connection.c:31(yield_connection)<br> Yielding connection to <br>[2011/06/25 12:36:18.422401, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)<br> Locking key 21090000FFFFFFFFFFFF<br>[2011/06/25 12:36:18.422441, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)<br> Allocated locked data 0x0xb87ba508<br>[2011/06/25 12:36:18.422473, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)<br> Unlocking key 21090000FFFFFFFFFFFF<br>[2011/06/25 12:36:18.422844, 3] smbd/server.c:906(exit_server_common)<br> Server exit (termination signal)<br></div> </div></body>
</html>