[Samba] Samba + OS/2 LS read error

Sat Oct 23 03:23:22 GMT 2004

----- Original Message ----- 
From: "Alex Masterov" <alex at infobit.ru>
To: <samba at lists.samba.org>
Sent: Friday, October 22, 2004 11:11 AM
Subject: [Samba] Samba + OS/2 LS read error

> Hello!
>
> We have Samba 3.0.7 on FreeBSD 5.2.1-RELEASE, installed from FreeBSD
> ports as server.
>
> There is PC with OS/2 Warp Server for E-Business ("Aurora") in our LAN,
> it uses shared resourses from Samba.
>
> Problem: while OS/2 PC archives directories from network drives (from
> Samba) archivation freezes on random file about a minute, and then
> breaks with "Read error". The same effect exists while using DBF
> databases on network drives from DOS FoxPro programs (returns "File read
> error").
>
> In the moment of freezing archivation, the message "Invalid secondary
> trans2 packet" appears in the log.
>
> In Samba 2.2.8a on RedHat 7.3 everything is OK.
> Other computers in the network work without this problem.
>
> Here is smb.log (log level 3)
> ====
> [2004/10/22 15:10:03, 0] smbd/trans2.c:reply_trans2(4110)
>    reply_trans2: Invalid secondary trans2 packet
> [2004/10/22 15:10:03, 3] smbd/error.c:error_packet(145)
>    error packet at smbd/trans2.c(4293) cmd=50 (SMBtrans2) eclass=1 ecode=87
> [2004/10/22 15:10:03, 3] smbd/process.c:process_smb(1092)
>    Transaction 434366 of length 2339
> [2004/10/22 15:10:03, 3] smbd/process.c:switch_message(887)
>    switch message SMBtranss2 (pid 35438) conn 0x8325800
>
> [skip]
>
> [2004/10/22 15:11:12, 3] smbd/process.c:timeout_processing(1332)
>    timeout_processing: End of file from client (client has disconnected).
> [2004/10/22 15:11:12, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>    setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2004/10/22 15:11:12, 2] smbd/server.c:exit_server(571)
>    Closing connections
> [2004/10/22 15:11:12, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>    setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2004/10/22 15:11:12, 1] smbd/service.c:close_cnum(837)
>    bbs (192.168.1.204) closed connection to service foru
> [2004/10/22 15:11:12, 3] smbd/connection.c:yield_connection(69)
>    Yielding connection to foru
> [2004/10/22 15:11:12, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>    setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2004/10/22 15:11:12, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>    setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2004/10/22 15:11:12, 1] smbd/service.c:close_cnum(837)
>    bbs (192.168.1.204) closed connection to service forr
> [2004/10/22 15:11:12, 3] smbd/connection.c:yield_connection(69)
>    Yielding connection to forr
> [2004/10/22 15:11:12, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>    setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2004/10/22 15:11:12, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>    setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2004/10/22 15:11:12, 1] smbd/service.c:close_cnum(837)
>    bbs (192.168.1.204) closed connection to service forp
> [2004/10/22 15:11:12, 3] smbd/connection.c:yield_connection(69)
>    Yielding connection to forp
> [2004/10/22 15:11:12, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>    setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2004/10/22 15:11:12, 2] smbd/close.c:close_normal_file(262)
>    alex closed file TEMP/data_pr/FK_ZAKAZ/DATA/zakaztov.dbf (numopen=0)
> [2004/10/22 15:11:12, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>    setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2004/10/22 15:11:12, 1] smbd/service.c:close_cnum(837)
>    bbs (192.168.1.204) closed connection to service forl
> [2004/10/22 15:11:12, 3] smbd/connection.c:yield_connection(69)
>    Yielding connection to forl
> [2004/10/22 15:11:12, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>    setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2004/10/22 15:11:12, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>    setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2004/10/22 15:11:12, 1] smbd/service.c:close_cnum(837)
>    bbs (192.168.1.204) closed connection to service fork
> [2004/10/22 15:11:12, 3] smbd/connection.c:yield_connection(69)
>    Yielding connection to fork
> [2004/10/22 15:11:12, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>    setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
> [2004/10/22 15:11:12, 3] smbd/connection.c:yield_connection(69)
>    Yielding connection to
> [2004/10/22 15:11:12, 3] smbd/server.c:exit_server(614)
>    Server exit (normal exit)
> [2004/10/22 15:11:13, 2] param/loadparm.c:do_section(3407)
>    Processing section "[homes]"
> ====
>
> On the client side:
> ====
> [...]
> Adding    L:\TEMP\data_pr\FK_ZAKAZ\DATA\zakaztov.cdx          OK
> Adding    L:\TEMP\data_pr\FK_ZAKAZ\DATA\zakaztov.dbf          15%
> Read error in the file L:\TEMP\data_pr\FK_ZAKAZ\DATA\zakaztov.dbf
> Program aborted
>
> [G:\Archives\testarc]echo   | time
> Current time is: 15:11:13,29
> ====
>
> Here is my smb.conf
> ====
> [global]
>     workgroup = HELMI
>     server string = Samba Server %v on %L
>     security = user
>     hosts allow = 192.168. 212.94.111.33
>     load printers = yes
>     admin users = root, van, alex
>     printing = bsd
>     log file = /var/log/samba/log.%m
>     max log size = 50000
>     passdb backend = tdbsam
>     include = /usr/local/etc/smb.conf.%m
>     socket options = TCP_NODELAY
>     domain master = yes
>     preferred master = yes
>     domain logons = yes
>     logon script = logon.bat
>     logon home = \\prosmb\%U
>     dns proxy = no
>     display charset = koi8-r
>     unix charset = koi8-r
>     dos charset = cp866
>     add machine script = pw useradd %u -d /nonexistent -g machines -s
> sbin/nologin
>    time server = yes
>    level2 oplocks = no
>    oplocks = no
>
> [homes]
>     comment = Home Directories
>     browseable = no
>     writable = yes
>   [netlogon]
>     comment = Network Logon Service
>     path = /usr/local/lib/samba/netlogon
>     guest ok = yes
>     writable = no
>     share modes = no
>     browsable = no
> [Profiles]
>      path = /shared/disk_p/.ntprofiles
>      browseable = no
>      guest ok = yes
>      create mask = 0600
>      directory mask = 0700
> [printers]
>     comment = All Printers
>     path = /var/spool/samba
>     browseable = no
>     guest ok = no
>     writable = no
>     printable = yes
> [fork]
>     comment = Disk K:
>     path = /shared/disk_k
>     writable = yes
>     delete readonly = yes
>
> [forl]
>     comment = Disk L:
>     path = /shared/disk_l
>     writable = yes
>     delete readonly = yes
>
> [foro]
>     comment = Disk O:
>     path = /shared/disk_o
>     writable = yes
>     delete readonly = yes
>
> [forp]
>     comment = Disk P:
>     path = /shared/disk_p
>     writable = yes
>     delete readonly = yes
>     veto files = /.recycle/.ntprofiles/
>     veto files = /.recycle/.ntprofiles/
>     vfs object = recycle
>     dos filemode = yes
>     recycle: repository = .recycle/%U
>     recycle: keeptree=True
>     recycle: exclude = ~$*.doc *.lnk *.tmp *.temp *.cache
>     recycle: version=False
>     dos filetimes=yes
>     fake directory create times=yes
>     dos filetime resolution=yes
>
> [forr]
>     comment = Disk R:
>     path = /shared/disk_r
>     writable = yes
>     delete readonly = yes
>     dos filemode = yes
> [foru]
>     comment = Disk U:
>     path = /shared/disk_u
>     writable = yes
>     delete readonly = yes
> ====
>
> I've changed network card, patchcord, switch without effect :(
> May be i need to change some settings on OS/2 or Samba?
> Please, help me!
>
> Thank you.
>
> WBR, Alex.

This could result from a timeout problem.
Could you please temporarely raise the samba debuglevel to 10
- do your testing - and send the samba logfile again.

smbcontrol smbd debug 10

Do not forget to lower the debuglevel lateron.
Feel free to contact me directly.
Guenter