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