[Samba] share connection dropped after 10 minutes

Carsten John cjohn at mpi-bremen.de
Thu Sep 22 11:00:09 GMT 2005 

Hello everybody,

I have to face a problem here with a samba share disconnecting after
about 10 minutes.

Situation:

- debian woody, samba 3.0.14a
- server configured as PDC
- typically 100-150 smbd processes running

everything runs smoothly but one client (W2K SP4) that obviously needs a
quasi static connection to the PDC.

The client runs a software that stores regularly data on a dedicated
share called aekta. The software logs a warning that it lost the
connection to the server every 12 minutes. A few seconds later, the
connection is reestablished and the software writes it's data as
planned. There is no loss of data, but the warning messages fills up the
logs of the software. As the scientists using the software need to read
the logs for other purposes, they are quite annoyed about these warnings.

I also already tried to set "deadtime = 60" to ensure a defines timeout,
without success.

Any suggestions?





smb.conf (some share definitions cut):

; /etc/samba/smb.conf
[global]
workgroup = MPI
log level = 5
security = user
map to guest = Bad Password
guest account = nobody
admin users = root,administrator
netbios name = tux
server string = Samba Fileserver
add machine script = /usr/sbin/useradd -c "Machine account for %u to use
tux's NT-services." -g machines -d /dev/null -s /bin/false %u
dos charset = CP850
unix charset = CP850
socket options = TCP_NODELAY
veto files = /quota.user/
encrypt passwords = true
obey pam restrictions = yes
passdb backend = tdbsam guest
unix password sync = yes
passwd program = /usr/bin/passwd %u
passwd chat = *Enter\snew\sUNIX\spassword:* %n\n
*Retype\snew\sUNIX\spassword:* %n\n .
null passwords = no
os level = 65
preferred master = yes
name resolve order = lmhosts hosts wins bcast
domain master = yes
domain logons = yes
local master= yes
wins support = yes
preserve case = yes
short preserve case = yes
logon script = logon.bat
logon path = \\%L\%U\.profiledata
logon home = \\%L\%U
logon drive = y:
log file = /var/log/samba/log.%m
max log size = 1000
syslog only = no

[homes]
comment = Home-directory
writeable = yes
create mask = 0600
directory mask = 2700
inherit permissions = yes
map archive = yes
browseable = yes

[netlogon]
comment = Windows-logon-scripts
path = /home/logon-script
writeable = no
create mask = 0604
directory mask = 0755
browseable = yes
invalid users = nobody

[aekta]
comment = aekta
path = /groups/aekta
create mask = 0664
directory mask = 2777
force directory mode = 0775
browseable = yes
valid users = @microbio
write list = ogrundma aekta ogunderm
read only = yes
posix locking = no
oplocks = no
strict locking = no


relevant log entries:

2005/09/22 12:28:49, 3] smbd/process.c:switch_message(886)
  switch message SMBtrans2 (pid 6739) conn 0x836fd38
[2005/09/22 12:28:49, 4] smbd/uid.c:change_to_user(194)
  change_to_user: Skipping user change - already user
[2005/09/22 12:28:49, 3] smbd/trans2.c:call_trans2qfilepathinfo(2418)
  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 1004
[2005/09/22 12:28:49, 5] smbd/filename.c:unix_convert(108)
  unix_convert called on file "UNICORN/Server"
[2005/09/22 12:28:49, 3] smbd/trans2.c:call_trans2qfilepathinfo(2452)
  call_trans2qfilepathinfo UNICORN/Server (fnum = -1) level=1004 call=5
total_data=0
[2005/09/22 12:28:49, 5] smbd/trans2.c:call_trans2qfilepathinfo(2596)
  SMB_QFBI - create: Tue Aug 23 13:30:54 2005
   access: Thu Sep 22 09:11:16 2005
   write: Tue Aug 23 13:30:54 2005
   change: Tue Aug 23 13:30:54 2005
   mode: 10
[2005/09/22 12:28:53, 3] smbd/process.c:timeout_processing(1334)
  timeout_processing: End of file from client (client has disconnected).
[2005/09/22 12:28:53, 5] lib/gencache.c:gencache_shutdown(88)
  Closing cache file
[2005/09/22 12:28:53, 5] libsmb/namecache.c:namecache_shutdown(79)
  namecache_shutdown: netbios namecache closed successfully.
[2005/09/22 12:28:53, 3] smbd/sec_ctx.c:set_sec_ctx(288)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2005/09/22 12:28:53, 5] auth/auth_util.c:debug_nt_user_token(485)
  NT user token: (NULL)
[2005/09/22 12:28:53, 5] auth/auth_util.c:debug_unix_user_token(506)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2005/09/22 12:28:53, 5] smbd/uid.c:change_to_root_user(296)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2005/09/22 12:28:53, 2] smbd/server.c:exit_server(609)
  Closing connections
[2005/09/22 12:28:53, 3] smbd/sec_ctx.c:set_sec_ctx(288)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2005/09/22 12:28:53, 5] auth/auth_util.c:debug_nt_user_token(485)
  NT user token: (NULL)
[2005/09/22 12:28:53, 5] auth/auth_util.c:debug_unix_user_token(506)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2005/09/22 12:28:53, 5] smbd/uid.c:change_to_root_user(296)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2005/09/22 12:28:53, 1] smbd/service.c:close_cnum(830)
  gigas (194.95.7.119) closed connection to service aekta
[2005/09/22 12:28:53, 3] smbd/connection.c:yield_connection(69)
  Yielding connection to aekta
[2005/09/22 12:28:53, 4] smbd/vfs.c:vfs_ChDir(660)
  vfs_ChDir to /
[2005/09/22 12:28:53, 3] smbd/sec_ctx.c:set_sec_ctx(288)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2005/09/22 12:28:53, 5] auth/auth_util.c:debug_nt_user_token(485)
  NT user token: (NULL)
[2005/09/22 12:28:53, 5] auth/auth_util.c:debug_unix_user_token(506)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2005/09/22 12:28:53, 5] smbd/uid.c:change_to_root_user(296)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2005/09/22 12:28:53, 4] auth/pampass.c:smb_pam_start(459)
  smb_pam_start: PAM: Init user: aekta
[2005/09/22 12:28:53, 4] auth/pampass.c:smb_pam_start(476)
  smb_pam_start: PAM: setting rhost to: 194.95.7.119
[2005/09/22 12:28:53, 4] auth/pampass.c:smb_pam_start(485)
  smb_pam_start: PAM: setting tty
[2005/09/22 12:28:53, 4] auth/pampass.c:smb_pam_start(493)
  smb_pam_start: PAM: Init passed for user: aekta
[2005/09/22 12:28:53, 4] auth/pampass.c:smb_internal_pam_session(630)
  smb_internal_pam_session: PAM: tty set to: smb/6739/100
[2005/09/22 12:28:53, 4] auth/pampass.c:smb_pam_end(440)
  smb_pam_end: PAM: PAM_END OK.
[2005/09/22 12:28:53, 5] auth/auth_util.c:free_server_info(1406)
  attempting to free (and zero) a server_info structure
[2005/09/22 12:28:53, 3] smbd/connection.c:yield_connection(69)
  Yielding connection to
[2005/09/22 12:28:53, 5] smbd/oplock.c:receive_local_message(107)
  receive_local_message: doing select with timeout of 1 ms
[2005/09/22 12:28:53, 3] smbd/server.c:exit_server(652)
  Server exit (normal exit)
[2005/09/22 12:29:08, 5] auth/auth_util.c:make_user_info_map(224)
  make_user_info_map: Mapping user [MPI]\[aekta] from workstation [GIGAS]
[2005/09/22 12:29:08, 3] smbd/sec_ctx.c:push_sec_ctx(256)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2005/09/22 12:29:08, 3] smbd/uid.c:push_conn_ctx(365)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2005/09/22 12:29:08, 3] smbd/sec_ctx.c:set_sec_ctx(288)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2005/09/22 12:29:08, 5] auth/auth_util.c:debug_nt_user_token(485)
  NT user token: (NULL)
[2005/09/22 12:29:08, 5] auth/auth_util.c:debug_unix_user_token(506)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2005/09/22 12:29:08, 5] auth/auth_util.c:is_trusted_domain(1560)
  is_trusted_domain: Checking for domain trust with [MPI]
[2005/09/22 12:29:08, 5]
passdb/secrets.c:secrets_fetch_trusted_domain_password(333)
  secrets_fetch failed!
[2005/09/22 12:29:08, 3] smbd/sec_ctx.c:pop_sec_ctx(386)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2005/09/22 12:29:08, 5] libsmb/trustdom_cache.c:trustdom_cache_fetch(184)
  no entry for trusted domain MPI found.
[2005/09/22 12:29:08, 5] auth/auth_util.c:make_user_info(132)
  attempting to make a user_info for aekta (aekta)
[2005/09/22 12:29:08, 5] auth/auth_util.c:make_user_info(142)
  making strings for aekta's user_info struct
[2005/09/22 12:29:08, 5] auth/auth_util.c:make_user_info(184)
  making blobs for aekta's user_info struct
[2005/09/22 12:29:08, 3] auth/auth.c:check_ntlm_password(219)
  check_ntlm_password:  Checking password for unmapped user
[MPI]\[aekta]@[GIGAS] with the new password interface
[2005/09/22 12:29:08, 3] auth/auth.c:check_ntlm_password(222)
  check_ntlm_password:  mapped user is: [MPI]\[aekta]@[GIGAS]
[2005/09/22 12:29:08, 5] lib/util.c:dump_data(1995)
  [000] AD 3F 07 03 8A A4 46 0E                           .?....F.
[2005/09/22 12:29:08, 3] smbd/sec_ctx.c:push_sec_ctx(256)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2005/09/22 12:29:08, 3] smbd/uid.c:push_conn_ctx(365)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2005/09/22 12:29:08, 3] smbd/sec_ctx.c:set_sec_ctx(288)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2005/09/22 12:29:08, 5] auth/auth_util.c:debug_nt_user_token(485)
  NT user token: (NULL)
[2005/09/22 12:29:08, 5] auth/auth_util.c:debug_unix_user_token(506)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2005/09/22 12:29:08, 3] smbd/sec_ctx.c:pop_sec_ctx(386)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2005/09/22 12:29:08, 4] libsmb/ntlm_check.c:ntlm_password_check(326)
  ntlm_password_check: Checking NT MD4 password
[2005/09/22 12:29:08, 4] auth/auth_sam.c:sam_account_ok(119)
  sam_account_ok: Checking SMB password for user aekta
[2005/09/22 12:29:08, 5] auth/auth_sam.c:logon_hours_ok(101)
  logon_hours_ok: user aekta allowed to logon at this time (Thu Sep 22
12:29:08 2005
  )
[2005/09/22 12:29:08, 3] smbd/sec_ctx.c:push_sec_ctx(256)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2005/09/22 12:29:08, 3] smbd/uid.c:push_conn_ctx(365)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2005/09/22 12:29:08, 3] smbd/sec_ctx.c:set_sec_ctx(288)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2005/09/22 12:29:08, 5] auth/auth_util.c:debug_nt_user_token(485)
  NT user token: (NULL)
[2005/09/22 12:29:08, 5] auth/auth_util.c:debug_unix_user_token(506)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2005/09/22 12:29:08, 3] smbd/sec_ctx.c:push_sec_ctx(256)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2005/09/22 12:29:08, 3] smbd/uid.c:push_conn_ctx(365)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2005/09/22 12:29:08, 3] smbd/sec_ctx.c:set_sec_ctx(288)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2005/09/22 12:29:08, 5] auth/auth_util.c:debug_nt_user_token(485)
  NT user token: (NULL)
[2005/09/22 12:29:08, 5] auth/auth_util.c:debug_unix_user_token(506)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2005/09/22 12:29:08, 3] smbd/sec_ctx.c:pop_sec_ctx(386)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2005/09/22 12:29:08, 3] smbd/sec_ctx.c:push_sec_ctx(256)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2005/09/22 12:29:08, 3] smbd/uid.c:push_conn_ctx(365)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2005/09/22 12:29:08, 3] smbd/sec_ctx.c:set_sec_ctx(288)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2005/09/22 12:29:08, 5] auth/auth_util.c:debug_nt_user_token(485)
  NT user token: (NULL)
[2005/09/22 12:29:08, 5] auth/auth_util.c:debug_unix_user_token(506)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2005/09/22 12:29:08, 3] smbd/sec_ctx.c:pop_sec_ctx(386)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2005/09/22 12:29:08, 3] smbd/sec_ctx.c:pop_sec_ctx(386)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2005/09/22 12:29:08, 5] auth/auth_util.c:make_server_info_sam(862)
  make_server_info_sam: made server info for user aekta -> aekta
[2005/09/22 12:29:08, 3] auth/auth.c:check_ntlm_password(268)
  check_ntlm_password: sam authentication for user [aekta] succeeded
[2005/09/22 12:29:08, 3] smbd/sec_ctx.c:push_sec_ctx(256)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2005/09/22 12:29:08, 3] smbd/uid.c:push_conn_ctx(365)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2005/09/22 12:29:08, 3] smbd/sec_ctx.c:set_sec_ctx(288)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2005/09/22 12:29:08, 5] auth/auth_util.c:debug_nt_user_token(485)
  NT user token: (NULL)
[2005/09/22 12:29:08, 5] auth/auth_util.c:debug_unix_user_token(506)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2005/09/22 12:29:08, 4] auth/pampass.c:smb_pam_start(459)
  smb_pam_start: PAM: Init user: aekta
[2005/09/22 12:29:08, 4] auth/pampass.c:smb_pam_start(476)
  smb_pam_start: PAM: setting rhost to: 194.95.7.119
[2005/09/22 12:29:08, 4] auth/pampass.c:smb_pam_start(485)
  smb_pam_start: PAM: setting tty
[2005/09/22 12:29:08, 4] auth/pampass.c:smb_pam_start(493)
  smb_pam_start: PAM: Init passed for user: aekta
[2005/09/22 12:29:08, 4] auth/pampass.c:smb_pam_account(551)
  smb_pam_account: PAM: Account Management for User: aekta
[2005/09/22 12:29:08, 4] auth/pampass.c:smb_pam_account(570)
  smb_pam_account: PAM: Account OK for User: aekta
[2005/09/22 12:29:08, 4] auth/pampass.c:smb_pam_end(440)
  smb_pam_end: PAM: PAM_END OK.

More information about the samba mailing list