[Samba] CentOs 5.5 Glusterfs 3.1.0 Samba 3.5 MSOffice Files

Daniel Müller mueller at tropenklinik.de
Wed Feb 9 01:31:55 MST 2011


So I do not give up as other users may have the same problems:
I did a file test.xlsx and it seems samba does a posix lock read only?!!Why?
I did : oplocks=NO
        level2 oplocks=NO
Did another file with veto files: veto oplock files =
/*.mdb/*.MDB/*.dbf/*.DBF/*.doc/*.docx/*.xls/*.xlsx/*.tmp/*.TMP/?~$*/~$*/*.ex
e/*.com 
THE SAME


[2011/02/09 09:16:27.397588,  3] smbd/process.c:1294(switch_message)
  switch message SMBreadX (pid 6829) conn 0x2ba2aa180c30
[2011/02/09 09:16:27.397603,  4] smbd/uid.c:257(change_to_user)
  change_to_user: Skipping user change - already user
[2011/02/09 09:16:27.397619, 10] locking/posix.c:301(is_posix_locked)
  is_posix_locked: File test.xlsx, offset = 8079, count = 4012, type = READ
[2011/02/09 09:16:27.397637, 10] locking/posix.c:172(posix_lock_in_range)
  posix_lock_in_range: offset_out = 8079, count_out = 4012
[2011/02/09 09:16:27.397653,  8] locking/posix.c:250(posix_fcntl_getlock)
  posix_fcntl_getlock 38 8079 4012 0
[2011/02/09 09:16:27.397670,  8] lib/util.c:1822(fcntl_getlock)
  fcntl_getlock fd=38 offset=8079 count=4012 type=0
[2011/02/09 09:16:27.398394,  3] lib/util.c:1846(fcntl_getlock)
  fcntl_getlock: fd 38 is returned info 2 pid 0
[2011/02/09 09:16:27.398415,  8] locking/posix.c:280(posix_fcntl_getlock)
  posix_fcntl_getlock: Lock query call successful
[2011/02/09 09:16:27.398430, 10] locking/brlock.c:1308(brl_locktest)
  brl_locktest: posix start=8079 len=4012 unlocked for fnum 10267 file
test.xlsx
[2011/02/09 09:16:27.398464, 10] locking/locking.c:154(strict_lock_default)
  strict_lock_default: flavour = WINDOWS_LOCK brl start=8079 len=4012
unlocked for fnum 10267 file test.xlsx
[2011/02/09 09:16:27.398485, 10] smbd/fileio.c:106(read_file)
  read_file (test.xlsx): pos = 8079, size = 4012, returned 0
[2011/02/09 09:16:27.398522,  3] smbd/reply.c:3591(send_file_readX)
  send_file_readX fnum=10267 max=4012 nread=0
[2011/02/09 09:16:27.398646, 10]
lib/util_sock.c:726(read_smb_length_return_keepalive)
  got smb length of 59
[2011/02/09 09:16:27.398666,  6] smbd/process.c:1482(process_smb)
  got message type 0x0 of len 0x3b
[2011/02/09 09:16:27.398680,  3] smbd/process.c:1485(process_smb)
  Transaction 1989 of length 63 (0 toread)
[2011/02/09 09:16:27.398694,  5] lib/util.c:617(show_msg)
[2011/02/09 09:16:27.398702,  5] lib/util.c:627(show_msg)
  size=59
  smb_com=0x2e
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51207
  smb_tid=3
  smb_pid=65279
  smb_uid=100
  smb_mid=46401
  smt_wct=12
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=57054 (0xDEDE)
  smb_vwv[ 2]=10264 (0x2818)
  smb_vwv[ 3]= 8079 (0x1F8F)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]= 2936 (0xB78)
  smb_vwv[ 6]= 2936 (0xB78)
  smb_vwv[ 7]=    0 (0x0)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]= 2936 (0xB78)
  smb_vwv[10]=    0 (0x0)
  smb_vwv[11]=    0 (0x0)
  smb_bcc=0
[2011/02/09 09:16:27.398801,  3] smbd/process.c:1294(switch_message)
  switch message SMBreadX (pid 6829) conn 0x2ba2aa180c30
[2011/02/09 09:16:27.398815,  4] smbd/uid.c:257(change_to_user)
  change_to_user: Skipping user change - already user
[2011/02/09 09:16:27.398832, 10] locking/posix.c:301(is_posix_locked)
  is_posix_locked: File test.xlsx, offset = 8079, count = 2936, type = READ
[2011/02/09 09:16:27.398850, 10] locking/posix.c:172(posix_lock_in_range)
  posix_lock_in_range: offset_out = 8079, count_out = 2936
[2011/02/09 09:16:27.398866,  8] locking/posix.c:250(posix_fcntl_getlock)
  posix_fcntl_getlock 30 8079 2936 0
[2011/02/09 09:16:27.398883,  8] lib/util.c:1822(fcntl_getlock)
  fcntl_getlock fd=30 offset=8079 count=2936 type=0
[2011/02/09 09:16:27.399970,  3] lib/util.c:1846(fcntl_getlock)
  fcntl_getlock: fd 30 is returned info 2 pid 0
[2011/02/09 09:16:27.399991,  8] locking/posix.c:280(posix_fcntl_getlock)
  posix_fcntl_getlock: Lock query call successful
[2011/02/09 09:16:27.400006, 10] locking/brlock.c:1308(brl_locktest)
  brl_locktest: posix start=8079 len=2936 unlocked for fnum 10264 file
test.xlsx
[2011/02/09 09:16:27.400039, 10] locking/locking.c:154(strict_lock_default)
  strict_lock_default: flavour = WINDOWS_LOCK brl start=8079 len=2936
unlocked for fnum 10264 file test.xlsx
[2011/02/09 09:16:27.400061, 10] smbd/fileio.c:106(read_file)
  read_file (test.xlsx): pos = 8079, size = 2936, returned 0
[2011/02/09 09:16:27.400078,  3] smbd/reply.c:3591(send_file_readX)
  send_file_readX fnum=10264 max=2936 nread=0
[2011/02/09 09:16:27.400167, 10]
lib/util_sock.c:726(read_smb_length_return_keepalive)

[2011/02/09 09:27:21.247593,  3] smbd/process.c:1294(switch_message)
  switch message SMBreadX (pid 6921) conn 0x2ab17e5427d0
[2011/02/09 09:27:21.247607,  4] smbd/uid.c:257(change_to_user)
  change_to_user: Skipping user change - already user
[2011/02/09 09:27:21.247629, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)
  Locking key 13000000000000003E01
[2011/02/09 09:27:21.247649, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)
  Allocated locked data 0x0x2ab17e570540
[2011/02/09 09:27:21.247663, 10]
locking/brlock.c:1896(brl_get_locks_internal)
  brl_get_locks_internal: 0 current locks on file_id 13:16013e:0
[2011/02/09 09:27:21.247680, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)
  Unlocking key 13000000000000003E01
[2011/02/09 09:27:21.247702, 10] locking/posix.c:301(is_posix_locked)
  is_posix_locked: File Microsoft Office Excel-Arbeitsblatt (neu).xlsx,
offset = 0, count = 1024, type = READ
[2011/02/09 09:27:21.248243, 10] locking/posix.c:172(posix_lock_in_range)
  posix_lock_in_range: offset_out = 0, count_out = 1024
[2011/02/09 09:27:21.248259,  8] locking/posix.c:250(posix_fcntl_getlock)
  posix_fcntl_getlock 36 0 1024 0
[2011/02/09 09:27:21.248306,  8] lib/util.c:1822(fcntl_getlock)
  fcntl_getlock fd=36 offset=0 count=1024 type=0
[2011/02/09 09:27:21.248973,  3] lib/util.c:1846(fcntl_getlock)
  fcntl_getlock: fd 36 is returned info 2 pid 0
[2011/02/09 09:27:21.248994,  8] locking/posix.c:280(posix_fcntl_getlock)
  posix_fcntl_getlock: Lock query call successful
[2011/02/09 09:27:21.249008, 10] locking/brlock.c:1308(brl_locktest)
  brl_locktest: posix start=0 len=1024 unlocked for fnum 9648 file Microsoft
Office Excel-Arbeitsblatt (neu).xlsx
[2011/02/09 09:27:21.249049, 10] locking/locking.c:154(strict_lock_default)
  strict_lock_default: flavour = WINDOWS_LOCK brl start=0 len=1024 unlocked
for fnum 9648 file Microsoft Office Excel-Arbeitsblatt (neu).xlsx
[2011/02/09 09:27:21.249462, 10] smbd/fileio.c:106(read_file)
  read_file (Microsoft Office Excel-Arbeitsblatt (neu).xlsx): pos = 0, size
= 1024, returned 1024
[2011/02/09 09:27:21.249497,  3] smbd/reply.c:3591(send_file_readX)
  send_file_readX fnum=9648 max=1024 nread=1024
[2011/02/09 09:27:21.250305, 10]
lib/util_sock.c:726(read_smb_length_return_keepalive)
  got smb length of 170
[2011/02/09 09:27:21.250326,  6] smbd/process.c:1482(process_smb)
  got message type 0x0 of len 0xaa
[2011/02/09 09:27:21.250341,  3] smbd/process.c:1485(process_smb)
  Transaction 6996 of length 174 (0 toread)
[2011/02/09 09:27:21.250355,  5] lib/util.c:617(show_msg)
[2011/02/09 09:27:21.250364,  5] lib/util.c:627(show_msg)
  size=170
  smb_com=0x32
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51207
  smb_tid=1
  smb_pid=3256
  smb_uid=100
  smb_mid=51331
  smt_wct=15
  smb_vwv[ 0]=  102 (0x66)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=    2 (0x2)
  smb_vwv[ 3]=   40 (0x28)
  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]=  102 (0x66)
  smb_vwv[10]=   68 (0x44)
  smb_vwv[11]=    0 (0x0)
  smb_vwv[12]=    0 (0x0)
  smb_vwv[13]=    1 (0x1)
  smb_vwv[14]=    5 (0x5)
  smb_bcc=105
[2011/02/09 09:27:21.250472, 10] ../lib/util/util.c:278(_dump_data)
  [0000] 00 00 00 EC 03 00 00 00   00 5C 00 4D 00 69 00 63   ........
.\.M.i.c
  [0010] 00 72 00 6F 00 73 00 6F   00 66 00 74 00 20 00 4F   .r.o.s.o .f.t.
.O
  [0020] 00 66 00 66 00 69 00 63   00 65 00 20 00 45 00 78   .f.f.i.c .e.
.E.x
  [0030] 00 63 00 65 00 6C 00 2D   00 41 00 72 00 62 00 65   .c.e.l.-
.A.r.b.e
  [0040] 00 69 00 74 00 73 00 62   00 6C 00 61 00 74 00 74   .i.t.s.b
.l.a.t.t
  [0050] 00 20 00 28 00 6E 00 65   00 75 00 29 00 2E 00 78   . .(.n.e
.u.)...x
  [0060] 00 6C 00 73 00 78 00 00   00                       .l.s.x.. .
[2011/02/09 09:27:21.250579,  3] smbd/process.c:1294(switch_message)
  switch message SMBtrans2 (pid 6921) conn 0x2ab17e5427d0
[2011/02/09 09:27:21.250594,  4] smbd/uid.c:257(change_to_user)
  change_to_user: Skipping user change - already user
[2011/02/09 09:27:21.250608,  3]
smbd/trans2.c:5099(call_trans2qfilepathinfo)
  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 1004
[2011/02/09 09:27:21.250819,  5] smbd/filename.c:169(unix_convert)
  unix_convert called on file "Microsoft Office Excel-Arbeitsblatt
(neu).xlsx"
[2011/02/09 09:27:21.250872, 10] smbd/statcache.c:275(stat_cache_lookup)
  stat_cache_lookup: lookup succeeded for name [MICROSOFT OFFICE
EXCEL-ARBEITSBLATT (NEU).XLSX] -> [Microsoft Office Excel-Arbeitsblatt
(neu).xlsx]
[2011/02/09 09:27:21.253183,  3] smbd/vfs.c:851(check_reduced_name)
  check_reduced_name [Microsoft Office Excel-Arbeitsblatt (neu).xlsx]
[/mnt/glusterfs/windows/test]
[2011/02/09 09:27:21.256094, 10] smbd/vfs.c:938(check_reduced_name)
  check_reduced_name realpath [Microsoft Office Excel-Arbeitsblatt
(neu).xlsx] -> [/mnt/glusterfs/windows/test/Microsoft Office
Excel-Arbeitsblatt (neu).xlsx]
[2011/02/09 09:27:21.256130,  3] smbd/vfs.c:1008(check_reduced_name)
  check_reduced_name: Microsoft Office Excel-Arbeitsblatt (neu).xlsx reduced
to /mnt/glusterfs/windows/test/Microsoft Office Excel-Arbeitsblatt
(neu).xlsx
[2011/02/09 09:27:21.256152, 10] locking/locking.c:552(parse_share_modes)
  parse_share_modes: delete_on_close: 0, owrt: Mi 09 Feb 2011 09:27:21 CET
CET, cwrt: Do 01 Jan 1970 01:00:00 CET CET, tok: 0, num_share_modes: 2
[2011/02/09 09:27:21.256197, 10] locking/locking.c:655(parse_share_modes)
  parse_share_modes: share_mode_entry[0]:  pid = 6921, share_access = 0x5,
private_options = 0x40, access_mask = 0x20089, mid = 0x0, type= 0x10, gen_id
= 356, uid = 0, flags = 0, file_id 13:16013e:0
[2011/02/09 09:27:21.256230, 10] locking/locking.c:655(parse_share_modes)
  parse_share_modes: share_mode_entry[1]:  pid = 6921, share_access = 0x5,
private_options = 0x40, access_mask = 0x20089, mid = 0x0, type= 0x10, gen_id
= 359, uid = 0, flags = 0, file_id 13:16013e:0
[2011/02/09 09:27:21.256246,  3]
smbd/trans2.c:5225(call_trans2qfilepathinfo)
  call_trans2qfilepathinfo Microsoft Office Excel-Arbeitsblatt (neu).xlsx
(fnum = -1) level=1004 call=5 total_data=0
[2011/02/09 09:27:21.256263,  5] smbd/trans2.c:4197(smbd_do_qfilepathinfo)
  smbd_do_qfilepathinfo: Microsoft Office Excel-Arbeitsblatt (neu).xlsx
(fnum = -1) level=1004 max_data=40
[2011/02/09 09:27:21.256278,  8] smbd/dosmode.c:613(dos_mode)
  dos_mode: Microsoft Office Excel-Arbeitsblatt (neu).xlsx
[2011/02/09 09:27:21.256292,  8] smbd/dosmode.c:207(dos_mode_from_sbuf)
  dos_mode_from_sbuf returning a
[2011/02/09 09:27:21.256306,  8] smbd/dosmode.c:666(dos_mode)
  dos_mode returning a
[2011/02/09 09:27:21.256323, 10] smbd/trans2.c:4431(smbd_do_qfilepathinfo)
  smbd_do_qfilepathinfo: SMB_FILE_BASIC_INFORMATION
[2011/02/09 09:27:21.256337,  5] smbd/trans2.c:4441(smbd_do_qfilepathinfo)
  SMB_QFBI - create: Wed Feb  9 09:27:21 2011
   access: Wed Feb  9 09:39:19 2011
   write: Wed Feb  9 09:27:21 2011



-----------------------------------------------
EDV Daniel Müller

Leitung EDV
Tropenklinik Paul-Lechler-Krankenhaus
Paul-Lechler-Str. 24
72076 Tübingen

Tel.: 07071/206-463, Fax: 07071/206-499
eMail: mueller at tropenklinik.de
Internet: www.tropenklinik.de
-----------------------------------------------

-----Ursprüngliche Nachricht-----
Von: Volker Lendecke [mailto:Volker.Lendecke at SerNet.DE] 
Gesendet: Dienstag, 8. Februar 2011 16:17
An: Daniel Müller
Cc: samba at lists.samba.org
Betreff: Re: [Samba] CentOs 5.5 Glusterfs 3.1.0 Samba 3.5 MSOffice Files

On Tue, Feb 08, 2011 at 03:51:26PM +0100, Daniel Müller wrote:
> So I created the file versuch.docx on the glusterd-vol. At the end of my
> smbd.log the file is read only. Only one change in the file possible

If that is all the logs that you can ever get out of your
Server (your "max log size" must be EXTREMELY small) then I
don't see any chance to help you.

A full debug level 10 log, a network sniff and at some point
potentially a strace of smbd, that would be the information
that you might have a chance with. But that is probably more
effort for you than installing GFS2.

Sorry for that,

Volker Lendecke

-- 
SerNet GmbH, Bahnhofsallee 1b, 37081 Göttingen
phone: +49-551-370000-0, fax: +49-551-370000-9
AG Göttingen, HRB 2816, GF: Dr. Johannes Loxen



More information about the samba mailing list