[Samba] strange DOS-Error 58

Ulf Dettmer ulf.dettmer at imk.fraunhofer.de
Wed Jul 21 07:18:25 GMT 2004


Hi,
based on Bart Lagerweij's ( www.nu2.nu ) bootdisk, I've created a small 
DOS system that users can start by booting from network ( PXE ). The 
system is configured to map a network drive from a Suse 9.0 Pro / Samba 
server with various tools on it. The connection is anonymous.
Until recently everything worked fine but suddenly there are strange 
errors:
When I try to launch an EXE from that share I get "Access denied". After 
that I can no longer work with that share. No matter what I do ( e.g. 
'dir' ) the result is 'Extended Error 58'. Also, when I copy an EXE from 
the share to the bootdisk's ramdrive, the file seems to get broken - the 
computer hangs up as soon as I launch it from the ramdrive.
Apart from starting programs I can do almost everything on the network 
drive, e.g. 'type' a text file or execute all other kinds DOS commands.
This problem does not occur at all when I access the same share from a 
WinXP box.
I'm pretty sure the only change in the whole system was an upgrade from 
Samba 3.0.4 to 3.0.5RC1 . That was because of a printing problem. For 
this reason I would not want to downgrade back to Samba 3.0.4.
You will find the usual bunch of logs and conf's below. Thanks in 
advance for any help you can give !
Regards, Ulf


smb.conf:

# 'privacy enhanced' smb.conf

# Global parameters
[global]
    workgroup = MYDOMAIN
    server string = Fileserver
    client schannel = auto
    map to guest = Bad User
    null passwords = Yes
    obey pam restrictions = Yes
    passdb backend = ldapsam:ldap://dir-server, guest
    passwd program = /usr/bin/passwd -q %u
    passwd chat = *New*password* %n\n *Re-enter*new*password* %n\n \n
    unix password sync = Yes
    client plaintext auth = No
    log level = 2
    syslog = 0
    log file = /var/log/samba/%m.log
    time server = Yes
    client signing = Yes
    deadtime = 1440
    socket options = SO_KEEPALIVE IPTOS_LOWDELAY TCP_NODELAY
    add user script = /etc/samba/scripts/smbldap-useradd.pl '%u'
    delete user script = /etc/samba/scripts/userdel.sh '%u'
    add group script = /etc/samba/scripts/smbldap-groupadd.pl '%g' && 
/etc/samba/scripts/smbldap-groupshow.pl %g|awk '/^gidNumber:/ {print $2}'
    delete group script = /etc/samba/scripts/groupdel.sh '%g'
    add user to group script = /etc/samba/scripts/smbldap-groupmod.pl -m 
'%u' '%g'
    delete user from group script = 
/etc/samba/scripts/smbldap-groupmod.pl -x '%u' '%g'
    set primary group script = /etc/samba/scripts/smbldap-usermod.pl -g 
'%g' '%u'
    add machine script = /etc/samba/scripts/machadd.sh %u
    shutdown script = /sbin/shutdown +1
    abort shutdown script = /sbin/shutdown -c
    logon script = scripts\%m.bat
    logon path = \\%L\%U\.winprofile
    logon drive = m:
    logon home = \\%L\%U
    domain logons = Yes
    os level = 65
    domain master = Yes
    wins server = 10.0.0.2
    ldap admin dn = cn=proxy-user,ou=department,o=company,c=DE
    ldap group suffix = ou=Group
    ldap suffix = ou=department,o=company,c=DE
    ldap ssl = no
    ldap user suffix = ou=People
    message command = /bin/mail -s 'Nachricht von %f auf %m' root < %s; 
rm %s
    host msdfs = Yes
    idmap uid = 10000-20000
    idmap gid = 10000-20000
    admin users = @domadm
    write list = @domadm
    printer admin = @it-s, @domadm, @printop
    map acl inherit = Yes
    printer name = normal
    map system = Yes
    map hidden = Yes

[install]
    comment = windows installation source
    path = /data/pxe/client
    write list = root, @it-s, @domadm
    guest ok = Yes
    map system = No
    map hidden = No
    map archive = No
    browseable = No


smbd.log:

[2004/07/20 09:45:36, 5] lib/debug.c:debug_dump_status(369)
  INFO: Current debug levels:
    all: True/5
    tdb: False/0
    printdrivers: False/0
    lanman: False/0
    smb: False/0
    rpc_parse: False/0
    rpc_srv: False/0
    rpc_cli: False/0
    passdb: False/0
    sam: False/0
    auth: False/0
    winbind: False/0
    vfs: False/0
    idmap: False/0
    quota: False/0
    acls: False/0
[2004/07/20 09:45:36, 5] lib/debug.c:debug_dump_status(369)
  INFO: Current debug levels:
    all: True/5
    tdb: False/0
    printdrivers: False/0
    lanman: False/0
    smb: False/0
    rpc_parse: False/0
    rpc_srv: False/0
    rpc_cli: False/0
    passdb: False/0
    sam: False/0
    auth: False/0
    winbind: False/0
    vfs: False/0
    idmap: False/0
    quota: False/0
    acls: False/0
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option SO_KEEPALIVE = 1
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option SO_REUSEADDR = 1
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option SO_BROADCAST = 0
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option TCP_NODELAY = 1
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option IPTOS_LOWDELAY = 16
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option IPTOS_THROUGHPUT = 16
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option SO_SNDBUF = 16384
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option SO_RCVBUF = 87380
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option SO_SNDLOWAT = 1
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option SO_RCVLOWAT = 1
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option SO_SNDTIMEO = 0
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option SO_RCVTIMEO = 0
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option SO_KEEPALIVE = 1
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option SO_REUSEADDR = 1
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option SO_BROADCAST = 0
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option TCP_NODELAY = 1
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option IPTOS_LOWDELAY = 16
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option IPTOS_THROUGHPUT = 16
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option SO_SNDBUF = 16384
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option SO_RCVBUF = 87380
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option SO_SNDLOWAT = 1
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option SO_RCVLOWAT = 1
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option SO_SNDTIMEO = 0
[2004/07/20 09:45:55, 5] lib/util_sock.c:print_socket_options(147)
  socket option SO_RCVTIMEO = 0
[2004/07/20 09:45:55, 5] passdb/pdb_interface.c:make_pdb_context_list(763)
  Trying to load: ldapsam:ldap://dir-server
[2004/07/20 09:45:55, 5] passdb/pdb_interface.c:smb_register_passdb(93)
  Attempting to register passdb backend ldapsam
[2004/07/20 09:45:55, 5] passdb/pdb_interface.c:smb_register_passdb(106)
  Successfully added passdb backend 'ldapsam'
[2004/07/20 09:45:55, 5] passdb/pdb_interface.c:smb_register_passdb(93)
  Attempting to register passdb backend ldapsam_compat
[2004/07/20 09:45:55, 5] passdb/pdb_interface.c:smb_register_passdb(106)
  Successfully added passdb backend 'ldapsam_compat'
[2004/07/20 09:45:55, 5] passdb/pdb_interface.c:smb_register_passdb(93)
  Attempting to register passdb backend smbpasswd
[2004/07/20 09:45:55, 5] passdb/pdb_interface.c:smb_register_passdb(106)
  Successfully added passdb backend 'smbpasswd'
[2004/07/20 09:45:55, 5] passdb/pdb_interface.c:smb_register_passdb(93)
  Attempting to register passdb backend tdbsam
[2004/07/20 09:45:55, 5] passdb/pdb_interface.c:smb_register_passdb(106)
  Successfully added passdb backend 'tdbsam'
[2004/07/20 09:45:55, 5] passdb/pdb_interface.c:smb_register_passdb(93)
  Attempting to register passdb backend guest
[2004/07/20 09:45:55, 5] passdb/pdb_interface.c:smb_register_passdb(106)
  Successfully added passdb backend 'guest'
[2004/07/20 09:45:55, 5] passdb/pdb_interface.c:make_pdb_methods_name(648)
  Attempting to find an passdb backend to match 
ldapsam:ldap://dir-server (ldapsam)
[2004/07/20 09:45:55, 5] passdb/pdb_interface.c:make_pdb_methods_name(669)
  Found pdb backend ldapsam
[2004/07/20 09:45:55, 2] lib/smbldap.c:smbldap_search_domain_info(1343)
  Searching for:[(&(objectClass=sambaDomain)(sambaDomainName=MYDOMAIN))]
[2004/07/20 09:45:55, 5] lib/smbldap.c:smbldap_search(931)
  smbldap_search: base => [ou=department,o=company,c=DE], filter => 
[(&(objectClass=sambaDomain)(sambaDomainName=MYDOMAIN))], scope => [2]
[2004/07/20 09:45:55, 2] lib/smbldap.c:smbldap_open_connection(639)
  smbldap_open_connection: connection opened
[2004/07/20 09:45:55, 3] lib/smbldap.c:smbldap_connect_system(805)
  ldap_connect_system: succesful connection to the LDAP server
[2004/07/20 09:45:55, 4] lib/smbldap.c:smbldap_open(856)
  The LDAP server is succesfully connected
[2004/07/20 09:45:56, 5] passdb/pdb_interface.c:make_pdb_methods_name(672)
  pdb backend ldapsam:ldap://dir-server has a valid init
[2004/07/20 09:45:56, 5] passdb/pdb_interface.c:make_pdb_context_list(763)
  Trying to load: guest
[2004/07/20 09:45:56, 5] passdb/pdb_interface.c:make_pdb_methods_name(648)
  Attempting to find an passdb backend to match guest (guest)
[2004/07/20 09:45:56, 5] passdb/pdb_interface.c:make_pdb_methods_name(669)
  Found pdb backend guest
[2004/07/20 09:45:56, 5] passdb/pdb_interface.c:make_pdb_methods_name(672)
  pdb backend guest has a valid init
[2004/07/20 09:46:03, 5] printing/print_cups.c:cups_queue_get(850)
  cups_queue_get(18, 0xbfffd0f4, 0xbfffd530)
[2004/07/20 09:46:03, 3] 
printing/printing.c:print_queue_update_internal(1061)
  0 jobs in queue for nm-infoprint
[2004/07/20 09:46:09, 5] printing/print_cups.c:cups_queue_get(850)
  cups_queue_get(12, 0xbfffd0f4, 0xbfffd530)
[2004/07/20 09:46:09, 3] 
printing/printing.c:print_queue_update_internal(1061)
  0 jobs in queue for ColorMax
[2004/07/20 09:46:09, 5] printing/print_cups.c:cups_queue_get(850)
  cups_queue_get(21, 0xbfffd0f4, 0xbfffd530)
[2004/07/20 09:46:09, 3] 
printing/printing.c:print_queue_update_internal(1061)
  0 jobs in queue for nm-qms2560
[2004/07/20 09:46:09, 5] printing/print_cups.c:cups_queue_get(850)
  cups_queue_get(20, 0xbfffd0f4, 0xbfffd530)
[2004/07/20 09:46:09, 3] 
printing/printing.c:print_queue_update_internal(1061)
  0 jobs in queue for nm-qms1725
[2004/07/20 09:46:22, 3] lib/debug.c:debug_message(464)
  INFO: Remote set of debug to `1'  (pid 13180 from pid 16977)
[2004/07/20 09:46:22, 5] printing/print_cups.c:cups_queue_get(850)
  cups_queue_get(21, 0xbfffd0f4, 0xbfffd530)
[2004/07/20 09:46:22, 3] 
printing/printing.c:print_queue_update_internal(1061)
  0 jobs in queue for nm-qms2560
[2004/07/20 09:46:22, 3] lib/debug.c:debug_message(464)
  INFO: Remote set of debug to `1'  (pid 13181 from pid 16977)
[2004/07/20 09:46:29, 1] lib/debug.c:debuglevel_message(489)
  INFO: Received REQ_DEBUGLEVEL message from PID 16978
[2004/07/20 09:46:29, 1] lib/debug.c:debuglevel_message(489)
  INFO: Received REQ_DEBUGLEVEL message from PID 16978


client logfile ( mail me if you need the complete log - 75 Kb ):

[2004/07/20 09:45:36, 5] lib/debug.c:debug_dump_status(369)
  INFO: Current debug levels:
    all: True/5
    tdb: False/0
    printdrivers: False/0
    lanman: False/0
    smb: False/0
    rpc_parse: False/0
    rpc_srv: False/0
    rpc_cli: False/0
    passdb: False/0
    sam: False/0
    auth: False/0
    winbind: False/0
    vfs: False/0
    idmap: False/0
    quota: False/0
    acls: False/0
[2004/07/20 09:45:55, 3] smbd/process.c:process_smb(1092)
  Transaction 15 of length 39
[2004/07/20 09:45:55, 5] lib/util.c:show_msg(443)
[2004/07/20 09:45:55, 5] lib/util.c:show_msg(453)
  size=35
  smb_com=0x71
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=0
  smb_flg2=0
  smb_tid=1
  smb_pid=31311
  smb_uid=100
  smb_mid=0
  smt_wct=0
  smb_bcc=0
[2004/07/20 09:45:55, 3] smbd/process.c:switch_message(887)
  switch message SMBtdis (pid 16923) conn 0x83c2040
[2004/07/20 09:45:55, 3] smbd/sec_ctx.c:set_sec_ctx(288)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2004/07/20 09:45:55, 5] auth/auth_util.c:debug_nt_user_token(486)
  NT user token: (NULL)
[2004/07/20 09:45:55, 5] auth/auth_util.c:debug_unix_user_token(505)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2004/07/20 09:45:55, 5] smbd/uid.c:change_to_root_user(295)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2004/07/20 09:45:55, 4] smbd/dir.c:dptr_close_internal(224)
  closing dptr key 2
[2004/07/20 09:45:55, 4] smbd/dir.c:dptr_close_internal(224)
  closing dptr key 1
[2004/07/20 09:45:55, 3] smbd/sec_ctx.c:set_sec_ctx(288)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2004/07/20 09:45:55, 5] auth/auth_util.c:debug_nt_user_token(486)
  NT user token: (NULL)
[2004/07/20 09:45:55, 5] auth/auth_util.c:debug_unix_user_token(505)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2004/07/20 09:45:55, 5] smbd/uid.c:change_to_root_user(295)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2004/07/20 09:45:55, 1] smbd/service.c:close_cnum(833)
  pc-091590 (10.0.0.54) closed connection to service install
[2004/07/20 09:45:55, 3] smbd/connection.c:yield_connection(69)
  Yielding connection to install
[2004/07/20 09:45:55, 4] smbd/vfs.c:vfs_ChDir(654)
  vfs_ChDir to /
[2004/07/20 09:45:55, 3] smbd/sec_ctx.c:set_sec_ctx(288)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2004/07/20 09:45:55, 5] auth/auth_util.c:debug_nt_user_token(486)
  NT user token: (NULL)
[2004/07/20 09:45:55, 5] auth/auth_util.c:debug_unix_user_token(505)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2004/07/20 09:45:55, 5] smbd/uid.c:change_to_root_user(295)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2004/07/20 09:45:55, 5] lib/util.c:show_msg(443)
[2004/07/20 09:45:55, 5] lib/util.c:show_msg(453)
  size=35
  smb_com=0x71
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=128
  smb_flg2=18433
  smb_tid=1
  smb_pid=31311
  smb_uid=100
  smb_mid=0
  smt_wct=0
  smb_bcc=0
[2004/07/20 09:45:55, 3] smbd/process.c:timeout_processing(1332)
  timeout_processing: End of file from client (client has disconnected).
[2004/07/20 09:45:55, 5] lib/gencache.c:gencache_shutdown(88)
  Closing cache file
[2004/07/20 09:45:55, 5] libsmb/namecache.c:namecache_shutdown(79)
  namecache_shutdown: netbios namecache closed successfully.
[2004/07/20 09:45:55, 3] smbd/sec_ctx.c:set_sec_ctx(288)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2004/07/20 09:45:55, 5] auth/auth_util.c:debug_nt_user_token(486)
  NT user token: (NULL)
[2004/07/20 09:45:55, 5] auth/auth_util.c:debug_unix_user_token(505)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2004/07/20 09:45:55, 5] smbd/uid.c:change_to_root_user(295)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2004/07/20 09:45:55, 2] smbd/server.c:exit_server(570)
  Closing connections
[2004/07/20 09:45:55, 5] auth/auth_util.c:free_server_info(1332)
  attempting to free (and zero) a server_info structure
[2004/07/20 09:45:55, 3] smbd/connection.c:yield_connection(69)
  Yielding connection to
[2004/07/20 09:45:55, 5] smbd/oplock.c:receive_local_message(107)
  receive_local_message: doing select with timeout of 1 ms
[2004/07/20 09:45:55, 3] smbd/server.c:exit_server(613)
  Server exit (normal exit)
[2004/07/20 09:45:56, 5] smbd/connection.c:claim_connection(170)
  claiming  0
[2004/07/20 09:45:56, 5] smbd/reply.c:reply_special(268)
  init msg_type=0x81 msg_flags=0x0
[2004/07/20 09:45:56, 3] smbd/process.c:process_smb(1092)
  Transaction 1 of length 102
[2004/07/20 09:45:56, 5] lib/util.c:show_msg(443)
[2004/07/20 09:45:56, 5] lib/util.c:show_msg(453)
  size=98
  smb_com=0x72
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=0
  smb_flg2=0
  smb_tid=0
  smb_pid=31311
  smb_uid=1
  smb_mid=0
  smt_wct=0
  smb_bcc=63
[2004/07/20 09:45:56, 3] smbd/process.c:switch_message(887)
  switch message SMBnegprot (pid 16976) conn 0x0
[2004/07/20 09:45:56, 3] smbd/sec_ctx.c:set_sec_ctx(288)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2004/07/20 09:45:56, 5] auth/auth_util.c:debug_nt_user_token(486)
  NT user token: (NULL)
[2004/07/20 09:45:56, 5] auth/auth_util.c:debug_unix_user_token(505)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2004/07/20 09:45:56, 5] smbd/uid.c:change_to_root_user(295)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2004/07/20 09:45:56, 3] smbd/negprot.c:reply_negprot(457)
  Requested protocol [PC NETWORK PROGRAM 1.0]
[2004/07/20 09:45:56, 3] smbd/negprot.c:reply_negprot(457)
  Requested protocol [MICROSOFT NETWORKS 3.0]
[2004/07/20 09:45:56, 3] smbd/negprot.c:reply_negprot(457)
  Requested protocol [DOS LM1.2X002]
[2004/07/20 09:45:56, 5] auth/auth.c:make_auth_context_subsystem(477)
  Making default auth method list for DC, security=user, encrypt 
passwords = yes
[2004/07/20 09:45:56, 5] auth/auth.c:smb_register_auth(45)
  Attempting to register auth backend rhosts
[2004/07/20 09:45:56, 5] auth/auth.c:smb_register_auth(57)
  Successfully added auth method 'rhosts'
[2004/07/20 09:45:56, 5] auth/auth.c:smb_register_auth(45)
  Attempting to register auth backend hostsequiv
[2004/07/20 09:45:56, 5] auth/auth.c:smb_register_auth(57)
  Successfully added auth method 'hostsequiv'
[2004/07/20 09:45:56, 5] auth/auth.c:smb_register_auth(45)
  Attempting to register auth backend sam
[2004/07/20 09:45:56, 5] auth/auth.c:smb_register_auth(57)
  Successfully added auth method 'sam'
[2004/07/20 09:45:56, 5] auth/auth.c:smb_register_auth(45)
  Attempting to register auth backend sam_ignoredomain
[2004/07/20 09:45:56, 5] auth/auth.c:smb_register_auth(57)
  Successfully added auth method 'sam_ignoredomain'
[2004/07/20 09:45:56, 5] auth/auth.c:smb_register_auth(45)
  Attempting to register auth backend unix
[2004/07/20 09:45:56, 5] auth/auth.c:smb_register_auth(57)
  Successfully added auth method 'unix'
[2004/07/20 09:45:56, 5] auth/auth.c:smb_register_auth(45)
  Attempting to register auth backend winbind
[2004/07/20 09:45:56, 5] auth/auth.c:smb_register_auth(57)
  Successfully added auth method 'winbind'
[2004/07/20 09:45:56, 5] auth/auth.c:smb_register_auth(45)
  Attempting to register auth backend smbserver
[2004/07/20 09:45:56, 5] auth/auth.c:smb_register_auth(57)
  Successfully added auth method 'smbserver'
[2004/07/20 09:45:56, 5] auth/auth.c:smb_register_auth(45)
  Attempting to register auth backend trustdomain
[2004/07/20 09:45:56, 5] auth/auth.c:smb_register_auth(57)
  Successfully added auth method 'trustdomain'
[2004/07/20 09:45:56, 5] auth/auth.c:smb_register_auth(45)
  Attempting to register auth backend ntdomain
[2004/07/20 09:45:56, 5] auth/auth.c:smb_register_auth(57)
  Successfully added auth method 'ntdomain'
[2004/07/20 09:45:56, 5] auth/auth.c:smb_register_auth(45)
  Attempting to register auth backend guest
[2004/07/20 09:45:56, 5] auth/auth.c:smb_register_auth(57)
  Successfully added auth method 'guest'
[2004/07/20 09:45:56, 5] auth/auth.c:load_auth_module(384)
  load_auth_module: Attempting to find an auth method to match guest
[2004/07/20 09:45:56, 5] auth/auth.c:load_auth_module(409)
  load_auth_module: auth method guest has a valid init
[2004/07/20 09:45:56, 5] auth/auth.c:load_auth_module(384)
  load_auth_module: Attempting to find an auth method to match sam
[2004/07/20 09:45:56, 5] auth/auth.c:load_auth_module(409)
  load_auth_module: auth method sam has a valid init
[2004/07/20 09:45:56, 5] auth/auth.c:load_auth_module(384)
  load_auth_module: Attempting to find an auth method to match 
winbind:trustdomain
[2004/07/20 09:45:56, 5] auth/auth.c:load_auth_module(384)
  load_auth_module: Attempting to find an auth method to match trustdomain
[2004/07/20 09:45:56, 5] auth/auth.c:load_auth_module(409)
  load_auth_module: auth method trustdomain has a valid init
[2004/07/20 09:45:56, 5] auth/auth.c:load_auth_module(409)
  load_auth_module: auth method winbind has a valid init
[2004/07/20 09:45:56, 5] auth/auth.c:get_ntlm_challenge(95)
  auth_get_challenge: module guest did not want to specify a challenge
[2004/07/20 09:45:56, 5] auth/auth.c:get_ntlm_challenge(95)
  auth_get_challenge: module sam did not want to specify a challenge
[2004/07/20 09:45:56, 5] auth/auth.c:get_ntlm_challenge(95)
  auth_get_challenge: module winbind did not want to specify a challenge
[2004/07/20 09:45:56, 5] auth/auth.c:get_ntlm_challenge(135)
  auth_context challenge created by random
[2004/07/20 09:45:56, 5] auth/auth.c:get_ntlm_challenge(136)
  challenge is:
[2004/07/20 09:45:56, 5] lib/util.c:dump_data(1839)
  [000] 08 AC 6B 8F 5E 05 75 17                           .¬k.^.u.
[2004/07/20 09:45:56, 3] smbd/negprot.c:reply_negprot(545)
  Selected protocol DOS LM1.2X002
[2004/07/20 09:45:56, 5] smbd/negprot.c:reply_negprot(551)
  negprot index=2
[2004/07/20 09:45:56, 5] lib/util.c:show_msg(443)
[2004/07/20 09:45:56, 5] lib/util.c:show_msg(453)
  size=69
  smb_com=0x72
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=129
  smb_flg2=18433
  smb_tid=0
  smb_pid=31311
  smb_uid=1
  smb_mid=0
  smt_wct=13
  smb_vwv[ 0]=    2 (0x2)
  smb_vwv[ 1]=    3 (0x3)
  smb_vwv[ 2]=16644 (0x4104)
  smb_vwv[ 3]=   50 (0x32)
  smb_vwv[ 4]=    1 (0x1)
  smb_vwv[ 5]=    3 (0x3)
  smb_vwv[ 6]=16976 (0x4250)
  smb_vwv[ 7]=    0 (0x0)
  smb_vwv[ 8]=19900 (0x4DBC)
  smb_vwv[ 9]=12532 (0x30F4)
  smb_vwv[10]=65416 (0xFF88)
  smb_vwv[11]=    8 (0x8)
  smb_vwv[12]=    0 (0x0)
  smb_bcc=8
[2004/07/20 09:45:56, 3] smbd/process.c:process_smb(1092)
  Transaction 2 of length 94
[2004/07/20 09:45:56, 5] lib/util.c:show_msg(443)
[2004/07/20 09:45:56, 5] lib/util.c:show_msg(453)
  size=90
  smb_com=0x73
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=0
  smb_flg2=0
  smb_tid=0
  smb_pid=31311
  smb_uid=1
  smb_mid=0
  smt_wct=10
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]= 1024 (0x400)
  smb_vwv[ 3]=    0 (0x0)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=16976 (0x4250)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=   24 (0x18)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    0 (0x0)
  smb_bcc=35
[2004/07/20 09:45:56, 3] smbd/process.c:switch_message(887)
  switch message SMBsesssetupX (pid 16976) conn 0x0
[2004/07/20 09:45:56, 3] smbd/sec_ctx.c:set_sec_ctx(288)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2004/07/20 09:45:56, 5] auth/auth_util.c:debug_nt_user_token(486)
  NT user token: (NULL)
[2004/07/20 09:45:56, 5] auth/auth_util.c:debug_unix_user_token(505)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2004/07/20 09:45:56, 5] smbd/uid.c:change_to_root_user(295)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2004/07/20 09:45:56, 3] smbd/sesssetup.c:reply_sesssetup_and_X(655)
  wct=10 flg2=0x0
[2004/07/20 09:45:56, 2] smbd/sesssetup.c:setup_new_vc_session(608)
  setup_new_vc_session: New VC == 0, if NT4.x compatible we would close 
all old resources.
[2004/07/20 09:45:56, 3] smbd/sesssetup.c:reply_sesssetup_and_X(804)
  sesssetupX:name=[]\[KFSDKFJDSF]@[pc-091590]
[2004/07/20 09:45:56, 5] auth/auth_util.c:make_user_info_map(225)
  make_user_info_map: Mapping user []\[KFSDKFJDSF] from workstation 
[pc-091590]
[2004/07/20 09:45:56, 3] smbd/sec_ctx.c:push_sec_ctx(256)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2004/07/20 09:45:56, 3] smbd/uid.c:push_conn_ctx(364)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2004/07/20 09:45:56, 3] smbd/sec_ctx.c:set_sec_ctx(288)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2004/07/20 09:45:56, 5] auth/auth_util.c:debug_nt_user_token(486)
  NT user token: (NULL)
[2004/07/20 09:45:56, 5] auth/auth_util.c:debug_unix_user_token(505)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2004/07/20 09:45:56, 5] auth/auth_util.c:is_trusted_domain(1436)
  is_trusted_domain: Checking for domain trust with [MYDOMAIN]
[2004/07/20 09:45:56, 5] 
passdb/secrets.c:secrets_fetch_trusted_domain_password(305)
  secrets_fetch failed!
[2004/07/20 09:45:56, 3] smbd/sec_ctx.c:pop_sec_ctx(386)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2004/07/20 09:45:56, 5] libsmb/trustdom_cache.c:trustdom_cache_fetch(184)
  no entry for trusted domain MYDOMAIN found.
[2004/07/20 09:45:56, 5] auth/auth_util.c:make_user_info(133)
  attempting to make a user_info for KFSDKFJDSF (KFSDKFJDSF)
[2004/07/20 09:45:56, 5] auth/auth_util.c:make_user_info(143)
  making strings for KFSDKFJDSF's user_info struct
[2004/07/20 09:45:56, 5] auth/auth_util.c:make_user_info(185)
  making blobs for KFSDKFJDSF's user_info struct
[2004/07/20 09:45:56, 3] auth/auth.c:check_ntlm_password(219)
  check_ntlm_password:  Checking password for unmapped user 
[]\[KFSDKFJDSF]@[pc-091590] with the new password interface
[2004/07/20 09:45:56, 3] auth/auth.c:check_ntlm_password(222)
  check_ntlm_password:  mapped user is: [MYDOMAIN]\[KFSDKFJDSF]@[pc-091590]
[2004/07/20 09:45:56, 5] lib/util.c:dump_data(1839)
  [000] 08 AC 6B 8F 5E 05 75 17                           .¬k.^.u.
[2004/07/20 09:45:56, 3] smbd/sec_ctx.c:push_sec_ctx(256)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2004/07/20 09:45:56, 3] smbd/uid.c:push_conn_ctx(364)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2004/07/20 09:45:56, 3] smbd/sec_ctx.c:set_sec_ctx(288)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2004/07/20 09:45:56, 5] auth/auth_util.c:debug_nt_user_token(486)
  NT user token: (NULL)
[2004/07/20 09:45:56, 5] auth/auth_util.c:debug_unix_user_token(505)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2004/07/20 09:45:56, 5] lib/smbldap.c:smbldap_search(931)
  smbldap_search: base => [ou=department,o=company,c=DE], filter => 
[(&(uid=KFSDKFJDSF)(objectclass=sambaSamAccount))], scope => [2]
[2004/07/20 09:45:56, 4] passdb/pdb_ldap.c:ldapsam_getsampwnam(1175)
  ldapsam_getsampwnam: Unable to locate user [KFSDKFJDSF] count=0
[2004/07/20 09:45:56, 3] smbd/sec_ctx.c:pop_sec_ctx(386)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2004/07/20 09:45:56, 3] auth/auth_sam.c:check_sam_security(202)
  check_sam_security: Couldn't find user 'KFSDKFJDSF' in passdb file.
[2004/07/20 09:45:56, 5] auth/auth.c:check_ntlm_password(271)
  check_ntlm_password: sam authentication for user [KFSDKFJDSF] FAILED 
with error NT_STATUS_NO_SUCH_USER
[2004/07/20 09:45:56, 3] auth/auth_winbind.c:check_winbind_security(80)
  check_winbind_security: Not using winbind, requested domain [MYDOMAIN] 
was for this SAM.
[2004/07/20 09:45:56, 2] auth/auth.c:check_ntlm_password(312)
  check_ntlm_password:  Authentication for user [KFSDKFJDSF] -> 
[KFSDKFJDSF] FAILED with error NT_STATUS_NO_SUCH_USER
[2004/07/20 09:45:56, 5] auth/auth_util.c:free_user_info(1306)
  attempting to free (and zero) a user_info structure
[2004/07/20 09:45:56, 3] smbd/sesssetup.c:do_map_to_guest(41)
  No such user KFSDKFJDSF [] - using guest account
[2004/07/20 09:45:56, 3] smbd/sec_ctx.c:push_sec_ctx(256)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2004/07/20 09:45:56, 3] smbd/uid.c:push_conn_ctx(364)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2004/07/20 09:45:56, 3] smbd/sec_ctx.c:set_sec_ctx(288)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2004/07/20 09:45:56, 5] auth/auth_util.c:debug_nt_user_token(486)
  NT user token: (NULL)
[2004/07/20 09:45:56, 5] auth/auth_util.c:debug_unix_user_token(505)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2004/07/20 09:45:56, 5] lib/smbldap.c:smbldap_search(931)
  smbldap_search: base => [ou=department,o=company,c=DE], filter => 
[(&(sambaSID=S-1-5-21-3466722526-4184884194-3283262122-501)(objectclass=sambaSamAccount))], 
scope => [2]
[2004/07/20 09:45:56, 4] passdb/pdb_ldap.c:ldapsam_getsampwsid(1257)
  ldapsam_getsampwsid: Unable to locate SID 
[S-1-5-21-3466722526-4184884194-3283262122-501] count=0
[2004/07/20 09:45:56, 3] smbd/sec_ctx.c:pop_sec_ctx(386)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2004/07/20 09:45:56, 3] smbd/sec_ctx.c:push_sec_ctx(256)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2004/07/20 09:45:56, 3] smbd/uid.c:push_conn_ctx(364)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2004/07/20 09:45:56, 3] smbd/sec_ctx.c:set_sec_ctx(288)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2004/07/20 09:45:56, 5] auth/auth_util.c:debug_nt_user_token(486)
  NT user token: (NULL)
[2004/07/20 09:45:56, 5] auth/auth_util.c:debug_unix_user_token(505)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2004/07/20 09:45:56, 3] smbd/sec_ctx.c:pop_sec_ctx(386)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2004/07/20 09:45:56, 5] auth/auth_util.c:debug_unix_user_token(505)
  UNIX token of user 65534
  Primary group is 65533 and contains 2 supplementary groups
  Group[  0]: 65533
  Group[  1]: 65534
[2004/07/20 09:45:56, 3] smbd/sec_ctx.c:push_sec_ctx(256)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2004/07/20 09:45:56, 3] smbd/uid.c:push_conn_ctx(364)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2004/07/20 09:45:56, 3] smbd/sec_ctx.c:set_sec_ctx(288)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2004/07/20 09:45:56, 5] auth/auth_util.c:debug_nt_user_token(486)
  NT user token: (NULL)
[2004/07/20 09:45:56, 5] auth/auth_util.c:debug_unix_user_token(505)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2004/07/20 09:45:56, 5] lib/smbldap.c:smbldap_search(931)
  smbldap_search: base => [ou=Group,ou=department,o=company,c=DE], 
filter => [(&(objectClass=sambaGroupMapping)(gidNumber=65533))], scope 
=> [2]
[2004/07/20 09:45:56, 4] passdb/pdb_ldap.c:ldapsam_getgroup(1917)
  ldapsam_getgroup: Did not find group
[2004/07/20 09:45:56, 3] smbd/sec_ctx.c:pop_sec_ctx(386)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2004/07/20 09:45:56, 3] smbd/sec_ctx.c:push_sec_ctx(256)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2004/07/20 09:45:56, 3] smbd/uid.c:push_conn_ctx(364)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2004/07/20 09:45:56, 3] smbd/sec_ctx.c:set_sec_ctx(288)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2004/07/20 09:45:56, 5] auth/auth_util.c:debug_nt_user_token(486)
  NT user token: (NULL)
[2004/07/20 09:45:56, 5] auth/auth_util.c:debug_unix_user_token(505)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2004/07/20 09:45:56, 5] lib/smbldap.c:smbldap_search(931)
  smbldap_search: base => [ou=Group,ou=department,o=company,c=DE], 
filter => [(&(objectClass=sambaGroupMapping)(gidNumber=65534))], scope 
=> [2]
[2004/07/20 09:45:56, 4] passdb/pdb_ldap.c:ldapsam_getgroup(1917)
  ldapsam_getgroup: Did not find group
[2004/07/20 09:45:56, 3] smbd/sec_ctx.c:pop_sec_ctx(386)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2004/07/20 09:45:56, 5] auth/auth_util.c:make_server_info_sam(844)
  make_server_info_sam: made server info for user nobody -> nobody
[2004/07/20 09:45:56, 3] smbd/password.c:register_vuid(222)
  User name: nobody    Real name: nobody
[2004/07/20 09:45:56, 3] smbd/password.c:register_vuid(241)
  UNIX uid 65534 is UNIX user nobody, and will be vuid 100
[2004/07/20 09:45:56, 5] lib/util.c:show_msg(443)


[---SNIP---]
[Repeats many times]


[2004/07/20 09:46:13, 5] lib/util.c:show_msg(453)
  size=51
  smb_com=0x1a
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=0
  smb_flg2=0
  smb_tid=1
  smb_pid=58030
  smb_uid=100
  smb_mid=0
  smt_wct=8
  smb_vwv[ 0]= 7749 (0x1E45)
  smb_vwv[ 1]= 7344 (0x1CB0)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=65024 (0xFE00)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=    0 (0x0)
  smb_bcc=0
[2004/07/20 09:46:13, 3] smbd/process.c:switch_message(887)
  switch message SMBreadbraw (pid 16976) conn 0x83c2038
[2004/07/20 09:46:13, 4] smbd/uid.c:change_to_user(193)
  change_to_user: Skipping user change - already user
[2004/07/20 09:46:13, 3] smbd/reply.c:reply_readbraw(1897)
  readbraw fnum=7749 start=7344 max=65024 min=0 nread=65024




More information about the samba mailing list