[Samba] Locking problem reported when starting smbd on a second systen!

Ebbe Hansen e_hansen at charter.net
Sun Aug 11 15:16:13 GMT 2002


I was successful installing and configured Samba 2.2.5 on my first Solaris
machine.

However, the second Solaris machine returns errno=11 (EAGAIN ~ Service
Temporary Unavailable).

I have tried to delete the "locks" directory to remove possible "old"
locks - upon startup the smbd create new log files, but the same errors are
reported again. Why only on one of my systems - I have checked all directory
privileges and tried to work with almost identical smb.conf files? I have
verified that both systems run with identical kernel-tuning parameters!

Same problem occurs even when the first Solaris server is not running - I
suspect something must be different on the two Solaris systems - just can't
find-out what! I even tried to compile Samba on each system!


This is the error I see reported 7 times when starting (see dump below).

2002/08/11 16:35:42, 5] tdb/tdbutil.c:(492)
  tdb(unknown): tdb_brlock failed (fd=14) at offset 4 rw_type=2 lck_type=34
errno=11

(Note I changed the Samba 2.2.5 source code to dump the "errno" value).


Regards Ebbe Hansen


-----------------  smbd log file upon startup - failing
ock-calls  -------------------------
[2002/08/11 16:35:39, 6] param/loadparm.c:(2285)
  lp_file_list_changed()
  file /usr/local/samba/lib/smb.conf -> /usr/local/samba/lib/smb.conf  last
mod_
time: Sun Aug 11 16:33:31 2002

[2002/08/11 16:35:39, 2] lib/interface.c:(81)
  added interface ip=10.101.12.217 bcast=10.101.255.255 nmask=255.255.0.0
[2002/08/11 16:35:39, 5] lib/hash.c:(68)
  Hash size = 521.
[2002/08/11 16:35:39, 6] lib/charset.c:(336)
  codepage_initialise: client code page = 850
[2002/08/11 16:35:39, 5] lib/charset.c:(194)
  load_client_codepage: loading codepage 850.
  Adding chars 0x85 0xb7 (l->u = True) (u->l = True)
  Adding chars 0xa0 0xb5 (l->u = True) (u->l = True)
  Adding chars 0x83 0xb6 (l->u = True) (u->l = True)
  Adding chars 0xc6 0xc7 (l->u = True) (u->l = True)
  Adding chars 0x84 0x8e (l->u = True) (u->l = True)
  Adding chars 0x86 0x8f (l->u = True) (u->l = True)
  Adding chars 0x91 0x92 (l->u = True) (u->l = True)
  Adding chars 0x87 0x80 (l->u = True) (u->l = True)
  Adding chars 0x8a 0xd4 (l->u = True) (u->l = True)
  Adding chars 0x82 0x90 (l->u = True) (u->l = True)
  Adding chars 0x88 0xd2 (l->u = True) (u->l = True)
  Adding chars 0x89 0xd3 (l->u = True) (u->l = True)
  Adding chars 0x8d 0xde (l->u = True) (u->l = True)
  Adding chars 0xa1 0xd6 (l->u = True) (u->l = True)
  Adding chars 0x8c 0xd7 (l->u = True) (u->l = True)
  Adding chars 0x8b 0xd8 (l->u = True) (u->l = True)
  Adding chars 0xd0 0xd1 (l->u = True) (u->l = True)
  Adding chars 0xa4 0xa5 (l->u = True) (u->l = True)
  Adding chars 0x95 0xe3 (l->u = True) (u->l = True)
  Adding chars 0xa2 0xe0 (l->u = True) (u->l = True)
  Adding chars 0x93 0xe2 (l->u = True) (u->l = True)
  Adding chars 0xe4 0xe5 (l->u = True) (u->l = True)
  Adding chars 0x94 0x99 (l->u = True) (u->l = True)
  Adding chars 0x9b 0x9d (l->u = True) (u->l = True)
  Adding chars 0x97 0xeb (l->u = True) (u->l = True)
  Adding chars 0xa3 0xe9 (l->u = True) (u->l = True)
  Adding chars 0x96 0xea (l->u = True) (u->l = True)
  Adding chars 0x81 0x9a (l->u = True) (u->l = True)
  Adding chars 0xec 0xed (l->u = True) (u->l = True)
  Adding chars 0xe7 0xe8 (l->u = True) (u->l = True)
  Adding chars 0x9c 0x0 (l->u = False) (u->l = False)
[2002/08/11 16:35:39, 5] lib/util_unistr.c:(597)
  load_unicode_map: loading unicode map for codepage 850.
[2002/08/11 16:35:39, 5] lib/util_unistr.c:(597)
  load_unicode_map: loading unicode map for codepage ISO8859-1.
[2002/08/11 16:35:39, 3] smbd/server.c:(747)
  loaded services
[2002/08/11 16:35:39, 3] smbd/server.c:(762)
  Becoming a daemon.
[2002/08/11 16:35:39, 8] lib/util.c:(1302)
  fcntl_lock 7 34 0 1 2
[2002/08/11 16:35:39, 8] lib/util.c:(1340)
  fcntl_lock: Lock call successful
[2002/08/11 16:35:39, 5] smbd/connection.c:(156)
  claiming  0
[2002/08/11 16:35:39, 3] lib/util_sock.c:(813)
  bind succeeded on port 139
[2002/08/11 16:35:39, 5] lib/util_sock.c:(111)
  socket option SO_KEEPALIVE = 8
[2002/08/11 16:35:39, 5] lib/util_sock.c:(111)
  socket option SO_REUSEADDR = 4
[2002/08/11 16:35:39, 5] lib/util_sock.c:(111)
  socket option SO_BROADCAST = 0
[2002/08/11 16:35:39, 5] lib/util_sock.c:(111)
  socket option TCP_NODELAY = 0
[2002/08/11 16:35:39, 5] lib/util_sock.c:(111)
  socket option IPTOS_LOWDELAY = 0
[2002/08/11 16:35:39, 5] lib/util_sock.c:(111)
  socket option IPTOS_THROUGHPUT = 0
[2002/08/11 16:35:39, 5] lib/util_sock.c:(111)
  socket option SO_SNDBUF = 16384
[2002/08/11 16:35:39, 5] lib/util_sock.c:(111)
  socket option SO_RCVBUF = 24576
[2002/08/11 16:35:39, 5] lib/util_sock.c:(109)
  Could not test socket option SO_SNDLOWAT.
[2002/08/11 16:35:39, 5] lib/util_sock.c:(109)
  Could not test socket option SO_RCVLOWAT.
[2002/08/11 16:35:39, 5] lib/util_sock.c:(109)
  Could not test socket option SO_SNDTIMEO.
[2002/08/11 16:35:39, 5] lib/util_sock.c:(109)
  Could not test socket option SO_RCVTIMEO.
[2002/08/11 16:35:39, 5] lib/util_sock.c:(111)
  socket option SO_KEEPALIVE = 8
[2002/08/11 16:35:39, 5] lib/util_sock.c:(111)
  socket option SO_REUSEADDR = 4
[2002/08/11 16:35:39, 5] lib/util_sock.c:(111)
  socket option SO_BROADCAST = 0
[2002/08/11 16:35:39, 5] lib/util_sock.c:(111)
  socket option TCP_NODELAY = 1
[2002/08/11 16:35:39, 5] lib/util_sock.c:(111)
  socket option IPTOS_LOWDELAY = 0
[2002/08/11 16:35:39, 5] lib/util_sock.c:(111)
  socket option IPTOS_THROUGHPUT = 0
[2002/08/11 16:35:39, 5] lib/util_sock.c:(111)
  socket option SO_SNDBUF = 16384
[2002/08/11 16:35:39, 5] lib/util_sock.c:(111)
  socket option SO_RCVBUF = 24576
[2002/08/11 16:35:39, 5] lib/util_sock.c:(109)
  Could not test socket option SO_SNDLOWAT.
[2002/08/11 16:35:39, 5] lib/util_sock.c:(109)
  Could not test socket option SO_RCVLOWAT.
[2002/08/11 16:35:39, 5] lib/util_sock.c:(109)
  Could not test socket option SO_SNDTIMEO.
[2002/08/11 16:35:39, 5] lib/util_sock.c:(109)
  Could not test socket option SO_RCVTIMEO.
[2002/08/11 16:35:39, 2] smbd/server.c:(215)
  waiting for a connection
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option SO_KEEPALIVE = 8
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option SO_REUSEADDR = 4
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option SO_BROADCAST = 0
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option TCP_NODELAY = 1
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option IPTOS_LOWDELAY = 0
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option IPTOS_THROUGHPUT = 0
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option SO_SNDBUF = 32768
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option SO_RCVBUF = 32768
[2002/08/11 16:35:42, 5] lib/util_sock.c:(109)
  Could not test socket option SO_SNDLOWAT.
[2002/08/11 16:35:42, 5] lib/util_sock.c:(109)
  Could not test socket option SO_RCVLOWAT.
[2002/08/11 16:35:42, 5] lib/util_sock.c:(109)
  Could not test socket option SO_SNDTIMEO.
[2002/08/11 16:35:42, 5] lib/util_sock.c:(109)
  Could not test socket option SO_RCVTIMEO.
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option SO_KEEPALIVE = 8
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option SO_REUSEADDR = 4
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option SO_BROADCAST = 0
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option TCP_NODELAY = 1
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option IPTOS_LOWDELAY = 0
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option IPTOS_THROUGHPUT = 0
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option SO_SNDBUF = 32768
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option SO_RCVBUF = 32768
[2002/08/11 16:35:42, 5] lib/util_sock.c:(109)
  Could not test socket option SO_SNDLOWAT.
[2002/08/11 16:35:42, 5] lib/util_sock.c:(109)
  Could not test socket option SO_RCVLOWAT.
[2002/08/11 16:35:42, 5] lib/util_sock.c:(109)
  Could not test socket option SO_SNDTIMEO.
[2002/08/11 16:35:42, 5] lib/util_sock.c:(109)
  Could not test socket option SO_RCVTIMEO.
[2002/08/11 16:35:42, 6] param/loadparm.c:(2285)
  lp_file_list_changed()
  file /usr/local/samba/lib/smb.conf -> /usr/local/samba/lib/smb.conf  last
mod_
time: Sun Aug 11 16:33:31 2002

[2002/08/11 16:35:42, 3] smbd/oplock.c:(1211)
  open_oplock_ipc: opening loopback UDP socket.
[2002/08/11 16:35:42, 3] lib/util_sock.c:(813)
  bind succeeded on port 0
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option SO_KEEPALIVE = 8
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option SO_REUSEADDR = 4
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option SO_BROADCAST = 0
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option TCP_NODELAY = 1
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option IPTOS_LOWDELAY = 0
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option IPTOS_THROUGHPUT = 0
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option SO_SNDBUF = 32768
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option SO_RCVBUF = 32768
[2002/08/11 16:35:42, 5] lib/util_sock.c:(109)
  Could not test socket option SO_SNDLOWAT.
[2002/08/11 16:35:42, 5] lib/util_sock.c:(109)
  Could not test socket option SO_RCVLOWAT.
[2002/08/11 16:35:42, 5] lib/util_sock.c:(109)
  Could not test socket option SO_SNDTIMEO.
[2002/08/11 16:35:42, 5] lib/util_sock.c:(109)
  Could not test socket option SO_RCVTIMEO.
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option SO_KEEPALIVE = 8
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option SO_REUSEADDR = 4
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option SO_BROADCAST = 0
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option TCP_NODELAY = 1
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option IPTOS_LOWDELAY = 0
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option IPTOS_THROUGHPUT = 0
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option SO_SNDBUF = 32768
[2002/08/11 16:35:42, 5] lib/util_sock.c:(111)
  socket option SO_RCVBUF = 32768
[2002/08/11 16:35:42, 5] lib/util_sock.c:(109)
  Could not test socket option SO_SNDLOWAT.
[2002/08/11 16:35:42, 5] lib/util_sock.c:(109)
  Could not test socket option SO_RCVLOWAT.
[2002/08/11 16:35:42, 5] lib/util_sock.c:(109)
  Could not test socket option SO_SNDTIMEO.
[2002/08/11 16:35:42, 5] lib/util_sock.c:(109)
  Could not test socket option SO_RCVTIMEO.
[2002/08/11 16:35:42, 5] tdb/tdbutil.c:(492)
  tdb(unknown): tdb_brlock failed (fd=10) at offset 4 rw_type=2 lck_type=34
errno=11
[2002/08/11 16:35:42, 5] tdb/tdbutil.c:(492)
  tdb(unknown): tdb_brlock failed (fd=14) at offset 4 rw_type=2 lck_type=34
errno=11
[2002/08/11 16:35:42, 5] tdb/tdbutil.c:(492)
  tdb(unknown): tdb_brlock failed (fd=15) at offset 4 rw_type=2 lck_type=34
errno=11
[2002/08/11 16:35:42, 5] tdb/tdbutil.c:(492)
  tdb(unknown): tdb_brlock failed (fd=16) at offset 4 rw_type=2 lck_type=34
errno=11
[2002/08/11 16:35:42, 5] tdb/tdbutil.c:(492)
  tdb(unknown): tdb_brlock failed (fd=17) at offset 4 rw_type=2 lck_type=34
errno=11
[2002/08/11 16:35:42, 5] tdb/tdbutil.c:(492)
  tdb(unknown): tdb_brlock failed (fd=18) at offset 4 rw_type=2 lck_type=34
errno=11
[2002/08/11 16:35:42, 5] tdb/tdbutil.c:(492)
  tdb(unknown): tdb_brlock failed (fd=19) at offset 4 rw_type=2 lck_type=34
errno=11
[2002/08/11 16:35:42, 6] param/loadparm.c:(2285)
  lp_file_list_changed()
  file /usr/local/samba/lib/smb.conf -> /usr/local/samba/lib/smb.conf  last
mod_
time: Sun Aug 11 16:33:31 2002

[2002/08/11 16:35:42, 3] smbd/oplock.c:(1211)
  open_oplock_ipc: opening loopback UDP socket.
[2002/08/11 16:35:42, 3] lib/util_sock.c:(813)
  bind succeeded on port 0
[2002/08/11 16:35:42, 3] smbd/oplock.c:(1242)
  open_oplock ipc: pid = 2462, global_oplock_port = 32896
[2002/08/11 16:35:42, 4] lib/time.c:(114)
  Serverzone is 25200
[2002/08/11 16:35:42, 3] smbd/process.c:(1102)
  end of file from client
[2002/08/11 16:35:42, 3] smbd/sec_ctx.c:(314)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2002/08/11 16:35:42, 5] smbd/uid.c:(217)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2002/08/11 16:35:42, 2] smbd/server.c:(461)
  Closing connections
[2002/08/11 16:35:42, 3] smbd/connection.c:(48)
  Yielding connection to
[2002/08/11 16:35:42, 3] smbd/connection.c:(62)
  yield_connection: tdb_delete for name  failed with error Record does not
exist
.
[2002/08/11 16:35:42, 5] smbd/oplock.c:(108)
  receive_local_message: doing select with timeout of 1 ms
[2002/08/11 16:35:42, 3] smbd/server.c:(495)
  Server exit (normal exit)
[2002/08/11 16:35:42, 3] smbd/oplock.c:(1242)
  open_oplock ipc: pid = 2463, global_oplock_port = 32897
[2002/08/11 16:35:42, 4] lib/time.c:(114)
  Serverzone is 25200
[2002/08/11 16:35:42, 3] smbd/process.c:(1102)
  end of file from client
[2002/08/11 16:35:42, 3] smbd/sec_ctx.c:(314)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2002/08/11 16:35:42, 5] smbd/uid.c:(217)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2002/08/11 16:35:42, 2] smbd/server.c:(461)
  Closing connections
[2002/08/11 16:35:42, 3] smbd/connection.c:(48)
  Yielding connection to
[2002/08/11 16:35:42, 3] smbd/connection.c:(62)
  yield_connection: tdb_delete for name  failed with error Record does not
exist
.
[2002/08/11 16:35:42, 5] smbd/oplock.c:(108)
  receive_local_message: doing select with timeout of 1 ms
[2002/08/11 16:35:42, 3] smbd/server.c:(495)
  Server exit (normal exit)









More information about the samba mailing list