[2005/06/22 22:53:49, 6] param/loadparm.c:lp_file_list_changed(2689) lp_file_list_changed() file /etc/samba/%L.conf -> /etc/samba/nas2.conf last mod_time: Mon Jun 13 22:37:06 2005 file /etc/samba/nas2.conf modified: Mon Jun 13 22:37:06 2005 [2005/06/22 22:53:49, 5] param/loadparm.c:free_service(2195) free_service: Freeing service data [2005/06/22 22:53:49, 5] param/loadparm.c:free_service(2195) free_service: Freeing service IPC$ [2005/06/22 22:53:49, 5] param/loadparm.c:free_service(2195) free_service: Freeing service ADMIN$ [2005/06/22 22:53:49, 3] param/loadparm.c:lp_load(3911) lp_load: refreshing parameters [2005/06/22 22:53:49, 3] param/loadparm.c:init_globals(1312) Initialising global parameters [2005/06/22 22:53:49, 3] param/params.c:pm_process(566) params.c:pm_process() - Processing configuration file "/etc/samba/smb.conf" [2005/06/22 22:53:49, 3] param/loadparm.c:do_section(3404) Processing section "[global]" doing parameter workgroup = mshome doing parameter netbios name = nas2 [2005/06/22 22:53:49, 4] param/loadparm.c:handle_netbios_name(2749) handle_netbios_name: set global_myname to: NAS2 doing parameter netbios aliases = server1 server2 doing parameter security = share doing parameter server string = Samba Server %L doing parameter log file = /var/log/samba/%L.%m.log doing parameter log level = 10 [2005/06/22 22:53:49, 5] lib/debug.c:debug_dump_status(366) INFO: Current debug levels: all: True/10 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 doing parameter max log size = 50 doing parameter preferred master = yes doing parameter include = /etc/samba/%L.conf [2005/06/22 22:53:49, 3] param/params.c:pm_process(566) params.c:pm_process() - Processing configuration file "/etc/samba/nas2.conf" [2005/06/22 22:53:49, 2] param/loadparm.c:do_section(3421) Processing section "[data]" [2005/06/22 22:53:49, 8] param/loadparm.c:add_a_service(2300) add_a_service: Creating snum = 0 for data doing parameter comment = data doing parameter browseable = yes doing parameter path = /data doing parameter force user = nobody doing parameter force group = nobody doing parameter read only = No doing parameter guest ok = Yes [2005/06/22 22:53:49, 4] param/loadparm.c:lp_load(3942) pm_process() returned Yes [2005/06/22 22:53:49, 7] param/loadparm.c:lp_servicenumber(4052) lp_servicenumber: couldn't find homes [2005/06/22 22:53:49, 8] param/loadparm.c:add_a_service(2300) add_a_service: Creating snum = 1 for IPC$ [2005/06/22 22:53:49, 3] param/loadparm.c:lp_add_ipc(2382) adding IPC service [2005/06/22 22:53:49, 8] param/loadparm.c:add_a_service(2300) add_a_service: Creating snum = 2 for ADMIN$ [2005/06/22 22:53:49, 3] param/loadparm.c:lp_add_ipc(2382) adding IPC service [2005/06/22 22:53:49, 10] param/loadparm.c:set_server_role(3851) set_server_role: role = ROLE_STANDALONE [2005/06/22 22:53:49, 5] lib/charcnv.c:charset_name(81) Substituting charset 'UTF-8' for LOCALE [2005/06/22 22:53:49, 5] lib/charcnv.c:charset_name(81) Substituting charset 'UTF-8' for LOCALE [2005/06/22 22:53:49, 5] lib/charcnv.c:charset_name(81) Substituting charset 'UTF-8' for LOCALE [2005/06/22 22:53:49, 5] lib/charcnv.c:charset_name(81) Substituting charset 'UTF-8' for LOCALE [2005/06/22 22:53:49, 5] lib/charcnv.c:charset_name(81) Substituting charset 'UTF-8' for LOCALE [2005/06/22 22:53:49, 5] lib/charcnv.c:charset_name(81) Substituting charset 'UTF-8' for LOCALE [2005/06/22 22:53:49, 5] lib/charcnv.c:charset_name(81) Substituting charset 'UTF-8' for LOCALE [2005/06/22 22:53:49, 5] lib/charcnv.c:charset_name(81) Substituting charset 'UTF-8' for LOCALE [2005/06/22 22:53:49, 5] lib/charcnv.c:charset_name(81) Substituting charset 'UTF-8' for LOCALE [2005/06/22 22:53:49, 5] lib/charcnv.c:charset_name(81) Substituting charset 'UTF-8' for LOCALE [2005/06/22 22:53:49, 7] param/loadparm.c:lp_servicenumber(4052) lp_servicenumber: couldn't find printers [2005/06/22 22:53:49, 7] param/loadparm.c:lp_servicenumber(4052) lp_servicenumber: couldn't find printers [2005/06/22 22:53:49, 2] lib/interface.c:add_interface(79) added interface ip=192.168.1.132 bcast=192.168.1.255 nmask=255.255.255.0 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option SO_KEEPALIVE = 1 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option SO_REUSEADDR = 1 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option SO_BROADCAST = 0 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option TCP_NODELAY = 1 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option IPTOS_LOWDELAY = 0 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option IPTOS_THROUGHPUT = 0 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option SO_SNDBUF = 50388 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option SO_RCVBUF = 87616 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option SO_SNDLOWAT = 1 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option SO_RCVLOWAT = 1 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option SO_SNDTIMEO = 0 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option SO_RCVTIMEO = 0 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option SO_KEEPALIVE = 1 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option SO_REUSEADDR = 1 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option SO_BROADCAST = 0 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option TCP_NODELAY = 1 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option IPTOS_LOWDELAY = 0 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option IPTOS_THROUGHPUT = 0 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option SO_SNDBUF = 50388 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option SO_RCVBUF = 87616 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option SO_SNDLOWAT = 1 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option SO_RCVLOWAT = 1 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option SO_SNDTIMEO = 0 [2005/06/22 22:53:49, 5] lib/util_sock.c:print_socket_options(147) socket option SO_RCVTIMEO = 0 [2005/06/22 22:53:49, 3] smbd/oplock.c:init_oplocks(1302) open_oplock_ipc: opening loopback UDP socket. [2005/06/22 22:53:49, 10] lib/util_sock.c:open_socket_in(717) bind succeeded on port 0 [2005/06/22 22:53:49, 3] smbd/oplock_linux.c:linux_init_kernel_oplocks(303) Linux kernel oplocks enabled [2005/06/22 22:53:49, 3] smbd/oplock.c:init_oplocks(1333) open_oplock ipc: pid = 20130, global_oplock_port = 32883 [2005/06/22 22:53:49, 4] lib/time.c:get_serverzone(122) Serverzone is 25200 [2005/06/22 22:53:49, 10] lib/util_sock.c:read_smb_length_return_keepalive(505) got smb length of 179 [2005/06/22 22:53:49, 6] smbd/process.c:process_smb(1090) got message type 0x0 of len 0xb3 [2005/06/22 22:53:49, 3] smbd/process.c:process_smb(1091) Transaction 0 of length 183 [2005/06/22 22:53:49, 5] lib/util.c:show_msg(486) [2005/06/22 22:53:49, 5] lib/util.c:show_msg(496) size=179 smb_com=0x72 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=8 smb_flg2=51201 smb_tid=0 smb_pid=20129 smb_uid=0 smb_mid=1 smt_wct=0 smb_bcc=144 [2005/06/22 22:53:49, 10] lib/util.c:dump_data(1999) [000] 02 50 43 20 4E 45 54 57 4F 52 4B 20 50 52 4F 47 .PC NETW ORK PROG [010] 52 41 4D 20 31 2E 30 00 02 4D 49 43 52 4F 53 4F RAM 1.0. .MICROSO [020] 46 54 20 4E 45 54 57 4F 52 4B 53 20 31 2E 30 33 FT NETWO RKS 1.03 [030] 00 02 4D 49 43 52 4F 53 4F 46 54 20 4E 45 54 57 ..MICROS OFT NETW [040] 4F 52 4B 53 20 33 2E 30 00 02 4C 41 4E 4D 41 4E ORKS 3.0 ..LANMAN [050] 31 2E 30 00 02 4C 4D 31 2E 32 58 30 30 32 00 02 1.0..LM1 .2X002.. [060] 44 4F 53 20 4C 41 4E 4D 41 4E 32 2E 31 00 02 53 DOS LANM AN2.1..S [070] 61 6D 62 61 00 02 4E 54 20 4C 41 4E 4D 41 4E 20 amba..NT LANMAN [080] 31 2E 30 00 02 4E 54 20 4C 4D 20 30 2E 31 32 00 1.0..NT LM 0.12. [2005/06/22 22:53:49, 3] smbd/process.c:switch_message(886) switch message SMBnegprot (pid 20130) conn 0x0 [2005/06/22 22:53:49, 3] smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2005/06/22 22:53:49, 5] auth/auth_util.c:debug_nt_user_token(486) NT user token: (NULL) [2005/06/22 22:53:49, 5] auth/auth_util.c:debug_unix_user_token(505) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2005/06/22 22:53:49, 5] smbd/uid.c:change_to_root_user(296) change_to_root_user: now uid=(0,0) gid=(0,0) [2005/06/22 22:53:49, 3] smbd/negprot.c:reply_negprot(461) Requested protocol [PC NETWORK PROGRAM 1.0] [2005/06/22 22:53:49, 3] smbd/negprot.c:reply_negprot(461) Requested protocol [MICROSOFT NETWORKS 1.03] [2005/06/22 22:53:49, 3] smbd/negprot.c:reply_negprot(461) Requested protocol [MICROSOFT NETWORKS 3.0] [2005/06/22 22:53:49, 3] smbd/negprot.c:reply_negprot(461) Requested protocol [LANMAN1.0] [2005/06/22 22:53:49, 3] smbd/negprot.c:reply_negprot(461) Requested protocol [LM1.2X002] [2005/06/22 22:53:49, 3] smbd/negprot.c:reply_negprot(461) Requested protocol [DOS LANMAN2.1] [2005/06/22 22:53:49, 3] smbd/negprot.c:reply_negprot(461) Requested protocol [Samba] [2005/06/22 22:53:49, 10] lib/util.c:set_remote_arch(1974) set_remote_arch: Client arch is 'Samba' [2005/06/22 22:53:49, 6] param/loadparm.c:lp_file_list_changed(2689) lp_file_list_changed() file /etc/samba/%L.conf -> /etc/samba/nas2.conf last mod_time: Mon Jun 13 22:37:06 2005 file /etc/samba/smb.conf -> /etc/samba/smb.conf last mod_time: Wed Jun 22 22:15:54 2005 [2005/06/22 22:53:49, 6] param/loadparm.c:lp_file_list_changed(2689) lp_file_list_changed() file /etc/samba/%L.conf -> /etc/samba/nas2.conf last mod_time: Mon Jun 13 22:37:06 2005 file /etc/samba/smb.conf -> /etc/samba/smb.conf last mod_time: Wed Jun 22 22:15:54 2005 [2005/06/22 22:53:49, 10] smbd/negprot.c:get_challenge(40) get challenge: creating negprot_global_auth_context [2005/06/22 22:53:49, 5] auth/auth.c:make_auth_context_subsystem(490) Making default auth method list for security=share, encrypt passwords = yes [2005/06/22 22:53:49, 5] auth/auth.c:smb_register_auth(45) Attempting to register auth backend rhosts [2005/06/22 22:53:49, 5] auth/auth.c:smb_register_auth(57) Successfully added auth method 'rhosts' [2005/06/22 22:53:49, 5] auth/auth.c:smb_register_auth(45) Attempting to register auth backend hostsequiv [2005/06/22 22:53:49, 5] auth/auth.c:smb_register_auth(57) Successfully added auth method 'hostsequiv' [2005/06/22 22:53:49, 5] auth/auth.c:smb_register_auth(45) Attempting to register auth backend sam [2005/06/22 22:53:49, 5] auth/auth.c:smb_register_auth(57) Successfully added auth method 'sam' [2005/06/22 22:53:49, 5] auth/auth.c:smb_register_auth(45) Attempting to register auth backend sam_ignoredomain [2005/06/22 22:53:49, 5] auth/auth.c:smb_register_auth(57) Successfully added auth method 'sam_ignoredomain' [2005/06/22 22:53:49, 5] auth/auth.c:smb_register_auth(45) Attempting to register auth backend unix [2005/06/22 22:53:49, 5] auth/auth.c:smb_register_auth(57) Successfully added auth method 'unix' [2005/06/22 22:53:49, 5] auth/auth.c:smb_register_auth(45) Attempting to register auth backend winbind [2005/06/22 22:53:49, 5] auth/auth.c:smb_register_auth(57) Successfully added auth method 'winbind' [2005/06/22 22:53:49, 5] auth/auth.c:smb_register_auth(45) Attempting to register auth backend smbserver [2005/06/22 22:53:49, 5] auth/auth.c:smb_register_auth(57) Successfully added auth method 'smbserver' [2005/06/22 22:53:49, 5] auth/auth.c:smb_register_auth(45) Attempting to register auth backend trustdomain [2005/06/22 22:53:49, 5] auth/auth.c:smb_register_auth(57) Successfully added auth method 'trustdomain' [2005/06/22 22:53:49, 5] auth/auth.c:smb_register_auth(45) Attempting to register auth backend ntdomain [2005/06/22 22:53:49, 5] auth/auth.c:smb_register_auth(57) Successfully added auth method 'ntdomain' [2005/06/22 22:53:49, 5] auth/auth.c:smb_register_auth(45) Attempting to register auth backend guest [2005/06/22 22:53:49, 5] auth/auth.c:smb_register_auth(57) Successfully added auth method 'guest' [2005/06/22 22:53:49, 5] auth/auth.c:load_auth_module(384) load_auth_module: Attempting to find an auth method to match guest [2005/06/22 22:53:49, 5] auth/auth.c:load_auth_module(409) load_auth_module: auth method guest has a valid init [2005/06/22 22:53:49, 5] auth/auth.c:load_auth_module(384) load_auth_module: Attempting to find an auth method to match sam [2005/06/22 22:53:49, 5] auth/auth.c:load_auth_module(409) load_auth_module: auth method sam has a valid init [2005/06/22 22:53:49, 10] smbd/negprot.c:get_challenge(45) get challenge: getting challenge [2005/06/22 22:53:49, 5] auth/auth.c:get_ntlm_challenge(95) auth_get_challenge: module guest did not want to specify a challenge [2005/06/22 22:53:49, 5] auth/auth.c:get_ntlm_challenge(95) auth_get_challenge: module sam did not want to specify a challenge [2005/06/22 22:53:49, 5] auth/auth.c:get_ntlm_challenge(135) auth_context challenge created by random [2005/06/22 22:53:49, 5] auth/auth.c:get_ntlm_challenge(136) challenge is: [2005/06/22 22:53:49, 5] lib/util.c:dump_data(1999) [000] DA 5C F1 C7 0D EC A2 9C .\...... [2005/06/22 22:53:49, 3] smbd/negprot.c:reply_nt1(327) not using SPNEGO [2005/06/22 22:53:49, 3] smbd/negprot.c:reply_negprot(549) Selected protocol NT LANMAN 1.0 [2005/06/22 22:53:49, 5] smbd/negprot.c:reply_negprot(555) negprot index=7 [2005/06/22 22:53:49, 5] lib/util.c:show_msg(486) [2005/06/22 22:53:49, 5] lib/util.c:show_msg(496) size=91 smb_com=0x72 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=49153 smb_tid=0 smb_pid=20129 smb_uid=0 smb_mid=1 smt_wct=17 smb_vwv[ 0]= 7 (0x7) smb_vwv[ 1]=12802 (0x3202) smb_vwv[ 2]= 256 (0x100) smb_vwv[ 3]= 1024 (0x400) smb_vwv[ 4]= 65 (0x41) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 256 (0x100) smb_vwv[ 7]=41472 (0xA200) smb_vwv[ 8]= 78 (0x4E) smb_vwv[ 9]=64768 (0xFD00) smb_vwv[10]=32995 (0x80E3) smb_vwv[11]=32768 (0x8000) smb_vwv[12]= 4500 (0x1194) smb_vwv[13]=47085 (0xB7ED) smb_vwv[14]=50551 (0xC577) smb_vwv[15]=41985 (0xA401) smb_vwv[16]= 2049 (0x801) smb_bcc=22 [2005/06/22 22:53:49, 10] lib/util.c:dump_data(1999) [000] DA 5C F1 C7 0D EC A2 9C 4D 00 53 00 48 00 4F 00 .\...... M.S.H.O. [010] 4D 00 45 00 00 00 M.E... [2005/06/22 22:53:49, 6] lib/util_sock.c:write_socket(449) write_socket(22,95) [2005/06/22 22:53:49, 6] lib/util_sock.c:write_socket(452) write_socket(22,95) wrote 95 [2005/06/22 22:53:50, 10] lib/util_sock.c:read_smb_length_return_keepalive(505) got smb length of 136 [2005/06/22 22:53:50, 6] smbd/process.c:process_smb(1090) got message type 0x0 of len 0x88 [2005/06/22 22:53:50, 3] smbd/process.c:process_smb(1091) Transaction 1 of length 140 [2005/06/22 22:53:50, 5] lib/util.c:show_msg(486) [2005/06/22 22:53:50, 5] lib/util.c:show_msg(496) size=136 smb_com=0x73 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=8 smb_flg2=51201 smb_tid=0 smb_pid=20129 smb_uid=0 smb_mid=2 smt_wct=13 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]=65535 (0xFFFF) smb_vwv[ 3]= 2 (0x2) smb_vwv[ 4]=20129 (0x4EA1) smb_vwv[ 5]=20130 (0x4EA2) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 3 (0x3) smb_vwv[ 9]= 0 (0x0) smb_vwv[10]= 0 (0x0) smb_vwv[11]= 92 (0x5C) smb_vwv[12]= 0 (0x0) smb_bcc=75 [2005/06/22 22:53:50, 10] lib/util.c:dump_data(1999) [000] 00 00 00 72 00 6F 00 6F 00 74 00 00 00 4D 00 53 ...r.o.o .t...M.S [010] 00 48 00 4F 00 4D 00 45 00 00 00 55 00 6E 00 69 .H.O.M.E ...U.n.i [020] 00 78 00 00 00 53 00 61 00 6D 00 62 00 61 00 20 .x...S.a .m.b.a. [030] 00 33 00 2E 00 30 00 2E 00 31 00 30 00 2D 00 31 .3...0.. .1.0.-.1 [040] 00 2E 00 66 00 63 00 32 00 00 00 ...f.c.2 ... [2005/06/22 22:53:50, 3] smbd/process.c:switch_message(886) switch message SMBsesssetupX (pid 20130) conn 0x0 [2005/06/22 22:53:50, 3] smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2005/06/22 22:53:50, 5] auth/auth_util.c:debug_nt_user_token(486) NT user token: (NULL) [2005/06/22 22:53:50, 5] auth/auth_util.c:debug_unix_user_token(505) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2005/06/22 22:53:50, 5] smbd/uid.c:change_to_root_user(296) change_to_root_user: now uid=(0,0) gid=(0,0) [2005/06/22 22:53:50, 3] smbd/sesssetup.c:reply_sesssetup_and_X(655) wct=13 flg2=0xc801 [2005/06/22 22:53:50, 3] smbd/sesssetup.c:reply_sesssetup_and_X(789) Domain=[MSHOME] NativeOS=[Unix] NativeLanMan=[Samba 3.0.10-1.fc2] PrimaryDomain=[null] [2005/06/22 22:53:50, 3] smbd/sesssetup.c:reply_sesssetup_and_X(804) sesssetupX:name=[MSHOME]\[root]@[192.168.1.132] [2005/06/22 22:53:50, 6] param/loadparm.c:lp_file_list_changed(2689) lp_file_list_changed() file /etc/samba/%L.conf -> /etc/samba/nas2.conf last mod_time: Mon Jun 13 22:37:06 2005 file /etc/samba/smb.conf -> /etc/samba/smb.conf last mod_time: Wed Jun 22 22:15:54 2005 [2005/06/22 22:53:50, 5] lib/username.c:Get_Pwnam(293) Finding user root [2005/06/22 22:53:50, 5] lib/username.c:Get_Pwnam_internals(223) Trying _Get_Pwnam(), username as lowercase is root [2005/06/22 22:53:50, 5] lib/username.c:Get_Pwnam_internals(251) Get_Pwnam_internals did find user [root]! [2005/06/22 22:53:50, 3] smbd/sesssetup.c:check_guest_password(116) Got anonymous request [2005/06/22 22:53:50, 5] auth/auth.c:make_auth_context_subsystem(490) Making default auth method list for security=share, encrypt passwords = yes [2005/06/22 22:53:50, 5] auth/auth.c:load_auth_module(384) load_auth_module: Attempting to find an auth method to match guest [2005/06/22 22:53:50, 5] auth/auth.c:load_auth_module(409) load_auth_module: auth method guest has a valid init [2005/06/22 22:53:50, 5] auth/auth.c:load_auth_module(384) load_auth_module: Attempting to find an auth method to match sam [2005/06/22 22:53:50, 5] auth/auth.c:load_auth_module(409) load_auth_module: auth method sam has a valid init [2005/06/22 22:53:50, 5] auth/auth_util.c:make_user_info(133) attempting to make a user_info for () [2005/06/22 22:53:50, 5] auth/auth_util.c:make_user_info(143) making strings for 's user_info struct [2005/06/22 22:53:50, 5] auth/auth_util.c:make_user_info(185) making blobs for 's user_info struct [2005/06/22 22:53:50, 10] auth/auth_util.c:make_user_info(201) made an encrypted user_info for () [2005/06/22 22:53:50, 3] auth/auth.c:check_ntlm_password(219) check_ntlm_password: Checking password for unmapped user []\[]@[] with the new password interface [2005/06/22 22:53:50, 3] auth/auth.c:check_ntlm_password(222) check_ntlm_password: mapped user is: []\[]@[] [2005/06/22 22:53:50, 10] auth/auth.c:check_ntlm_password(231) check_ntlm_password: auth_context challenge created by fixed [2005/06/22 22:53:50, 10] auth/auth.c:check_ntlm_password(233) challenge is: [2005/06/22 22:53:50, 5] lib/util.c:dump_data(1999) [000] 00 00 00 00 00 00 00 00 ........ [2005/06/22 22:53:50, 3] smbd/sec_ctx.c:push_sec_ctx(256) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2005/06/22 22:53:50, 3] smbd/uid.c:push_conn_ctx(365) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2005/06/22 22:53:50, 3] smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2005/06/22 22:53:50, 5] auth/auth_util.c:debug_nt_user_token(486) NT user token: (NULL) [2005/06/22 22:53:50, 5] auth/auth_util.c:debug_unix_user_token(505) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2005/06/22 22:53:50, 10] passdb/pdb_smbpasswd.c:smbpasswd_getsampwsid(1367) smbpasswd_getsampwrid: search by sid: S-1-5-21-4117795899-678105330-4244905587-501 [2005/06/22 22:53:50, 10] passdb/pdb_smbpasswd.c:smbpasswd_getsampwnam(1318) getsampwnam (smbpasswd): search by name: nobody [2005/06/22 22:53:50, 10] passdb/pdb_smbpasswd.c:startsmbfilepwent(184) startsmbfilepwent_internal: opening file /etc/samba/smbpasswd [2005/06/22 22:53:50, 10] passdb/pdb_smbpasswd.c:getsmbfilepwent(460) getsmbfilepwent: LM password for user nobody invalidated [2005/06/22 22:53:50, 5] passdb/pdb_smbpasswd.c:getsmbfilepwent(486) getsmbfilepwent: returning passwd entry for user nobody, uid 99 [2005/06/22 22:53:50, 7] passdb/pdb_smbpasswd.c:endsmbfilepwent(301) endsmbfilepwent_internal: closed password file. [2005/06/22 22:53:50, 10] passdb/pdb_smbpasswd.c:smbpasswd_getsampwnam(1340) getsampwnam (smbpasswd): found by name: nobody [2005/06/22 22:53:50, 10] passdb/pdb_get_set.c:pdb_set_username(625) pdb_set_username: setting username nobody, was [2005/06/22 22:53:50, 10] passdb/pdb_get_set.c:pdb_set_init_flags(525) element 12 -> now SET [2005/06/22 22:53:50, 10] passdb/pdb_get_set.c:pdb_set_fullname(706) pdb_set_full_name: setting full name Nobody, was [2005/06/22 22:53:50, 10] passdb/pdb_get_set.c:pdb_set_init_flags(525) element 13 -> now SET [2005/06/22 22:53:50, 10] passdb/pdb_get_set.c:pdb_set_unix_homedir(841) pdb_set_unix_homedir: setting home dir /, was NULL [2005/06/22 22:53:50, 10] passdb/pdb_get_set.c:pdb_set_init_flags(525) element 22 -> now SET [2005/06/22 22:53:50, 10] passdb/pdb_get_set.c:pdb_set_domain(652) pdb_set_domain: setting domain NAS2, was [2005/06/22 22:53:50, 10] passdb/pdb_get_set.c:pdb_set_user_sid(552) pdb_set_user_sid: setting user sid S-1-5-21-4117795899-678105330-4244905587-501 [2005/06/22 22:53:50, 10] passdb/pdb_compat.c:pdb_set_user_sid_from_rid(73) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-4117795899-678105330-4244905587-501 from rid 501 [2005/06/22 22:53:50, 10] passdb/pdb_get_set.c:pdb_set_group_sid(588) pdb_set_group_sid: setting group sid S-1-5-21-4117795899-678105330-4244905587-514 [2005/06/22 22:53:50, 10] passdb/pdb_compat.c:pdb_set_group_sid_from_rid(100) pdb_set_group_sid_from_rid: setting group sid S-1-5-21-4117795899-678105330-4244905587-514 from rid 514 [2005/06/22 22:53:50, 4] lib/substitute.c:automount_server(323) Home server: nas2 [2005/06/22 22:53:50, 10] passdb/pdb_get_set.c:pdb_set_profile_path(760) pdb_set_profile_path: setting profile path \\nas2\nobody\profile, was [2005/06/22 22:53:50, 4] lib/substitute.c:automount_server(323) Home server: nas2 [2005/06/22 22:53:50, 10] passdb/pdb_get_set.c:pdb_set_homedir(814) pdb_set_homedir: setting home dir \\nas2\nobody, was [2005/06/22 22:53:50, 10] passdb/pdb_get_set.c:pdb_set_dir_drive(787) pdb_set_dir_drive: setting dir drive , was NULL [2005/06/22 22:53:50, 10] passdb/pdb_get_set.c:pdb_set_logon_script(733) pdb_set_logon_script: setting logon script , was [2005/06/22 22:53:50, 10] passdb/pdb_get_set.c:pdb_set_init_flags(525) element 33 -> now SET [2005/06/22 22:53:50, 10] passdb/pdb_get_set.c:pdb_set_init_flags(525) element 32 -> now SET [2005/06/22 22:53:50, 10] passdb/pdb_get_set.c:pdb_set_init_flags(525) element 20 -> now SET [2005/06/22 22:53:50, 10] passdb/pdb_get_set.c:pdb_set_init_flags(525) element 21 -> now SET [2005/06/22 22:53:50, 10] passdb/pdb_get_set.c:pdb_set_init_flags(525) element 9 -> now SET [2005/06/22 22:53:50, 3] smbd/sec_ctx.c:pop_sec_ctx(386) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2005/06/22 22:53:50, 10] lib/system_smbd.c:sys_getgrouplist(117) sys_getgrouplist: user [nobody] [2005/06/22 22:53:50, 10] lib/system_smbd.c:sys_getgrouplist(126) sys_getgrouplist(): disabled winbindd for group lookup [user == nobody] [2005/06/22 22:53:50, 3] smbd/sec_ctx.c:push_sec_ctx(256) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2005/06/22 22:53:50, 3] smbd/uid.c:push_conn_ctx(365) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2005/06/22 22:53:50, 3] smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2005/06/22 22:53:50, 5] auth/auth_util.c:debug_nt_user_token(486) NT user token: (NULL) [2005/06/22 22:53:50, 5] auth/auth_util.c:debug_unix_user_token(505) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2005/06/22 22:53:50, 8] lib/util_getent.c:remove_duplicate_gids(330) remove_duplicate_gids: Enter 2 gids [2005/06/22 22:53:50, 8] lib/util_getent.c:remove_duplicate_gids(348) remove_duplicate_gids: Exit 1 gids [2005/06/22 22:53:50, 3] smbd/sec_ctx.c:pop_sec_ctx(386) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2005/06/22 22:53:50, 5] auth/auth_util.c:debug_unix_user_token(505) UNIX token of user 99 Primary group is 99 and contains 1 supplementary groups Group[ 0]: 99 [2005/06/22 22:53:50, 3] smbd/sec_ctx.c:push_sec_ctx(256) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2005/06/22 22:53:50, 3] smbd/uid.c:push_conn_ctx(365) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2005/06/22 22:53:50, 3] smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2005/06/22 22:53:50, 5] auth/auth_util.c:debug_nt_user_token(486) NT user token: (NULL) [2005/06/22 22:53:50, 5] auth/auth_util.c:debug_unix_user_token(505) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2005/06/22 22:53:50, 3] smbd/sec_ctx.c:pop_sec_ctx(386) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2005/06/22 22:53:50, 10] passdb/passdb.c:local_gid_to_sid(1264) local_gid_to_sid: Fall back to algorithmic mapping: 99 -> S-0-0 [2005/06/22 22:53:50, 8] passdb/passdb.c:algorithmic_gid_to_sid(1230) algorithmic_gid_to_sid: falling back to RID algorithm [2005/06/22 22:53:50, 10] passdb/passdb.c:algorithmic_gid_to_sid(1234) algorithmic_gid_to_sid: gid (99) -> SID S-1-5-21-4117795899-678105330-4244905587-1199. [2005/06/22 22:53:50, 10] passdb/lookup_sid.c:gid_to_sid(365) gid_to_sid: local 99 -> S-1-5-21-4117795899-678105330-4244905587-1199 [2005/06/22 22:53:50, 10] auth/auth_util.c:debug_nt_user_token(491) NT user token of user S-1-5-21-4117795899-678105330-4244905587-501 contains 6 SIDs SID[ 0]: S-1-5-21-4117795899-678105330-4244905587-501 SID[ 1]: S-1-5-21-4117795899-678105330-4244905587-514 SID[ 2]: S-1-1-0 SID[ 3]: S-1-5-2 SID[ 4]: S-1-5-32-546 SID[ 5]: S-1-5-21-4117795899-678105330-4244905587-1199 [2005/06/22 22:53:50, 5] auth/auth_util.c:make_server_info_sam(844) make_server_info_sam: made server info for user nobody -> nobody [2005/06/22 22:53:50, 3] auth/auth.c:check_ntlm_password(268) check_ntlm_password: guest authentication for user [] succeeded [2005/06/22 22:53:50, 5] auth/auth.c:check_ntlm_password(305) check_ntlm_password: guest authentication for user [] -> [] -> [nobody] succeeded [2005/06/22 22:53:50, 5] auth/auth_util.c:free_user_info(1318) attempting to free (and zero) a user_info structure [2005/06/22 22:53:50, 10] auth/auth_util.c:free_user_info(1321) structure was created for [2005/06/22 22:53:50, 5] auth/auth_util.c:free_user_info(1318) attempting to free (and zero) a user_info structure [2005/06/22 22:53:50, 6] param/loadparm.c:lp_file_list_changed(2689) lp_file_list_changed() file /etc/samba/%L.conf -> /etc/samba/nas2.conf last mod_time: Mon Jun 13 22:37:06 2005 file /etc/samba/smb.conf -> /etc/samba/smb.conf last mod_time: Wed Jun 22 22:15:54 2005 [2005/06/22 22:53:50, 5] lib/util.c:show_msg(486) [2005/06/22 22:53:50, 5] lib/util.c:show_msg(496) size=104 smb_com=0x73 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=49153 smb_tid=0 smb_pid=20129 smb_uid=0 smb_mid=2 smt_wct=3 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 1 (0x1) smb_bcc=63 [2005/06/22 22:53:50, 10] lib/util.c:dump_data(1999) [000] 00 55 00 6E 00 69 00 78 00 00 00 53 00 61 00 6D .U.n.i.x ...S.a.m [010] 00 62 00 61 00 20 00 33 00 2E 00 30 00 2E 00 31 .b.a. .3 ...0...1 [020] 00 30 00 2D 00 31 00 2E 00 66 00 63 00 32 00 00 .0.-.1.. .f.c.2.. [030] 00 4D 00 53 00 48 00 4F 00 4D 00 45 00 00 00 .M.S.H.O .M.E... [2005/06/22 22:53:50, 6] lib/util_sock.c:write_socket(449) write_socket(22,108) [2005/06/22 22:53:50, 6] lib/util_sock.c:write_socket(452) write_socket(22,108) wrote 108 [2005/06/22 22:53:50, 10] lib/util_sock.c:read_smb_length_return_keepalive(505) got smb length of 82 [2005/06/22 22:53:50, 6] smbd/process.c:process_smb(1090) got message type 0x0 of len 0x52 [2005/06/22 22:53:50, 3] smbd/process.c:process_smb(1091) Transaction 2 of length 86 [2005/06/22 22:53:50, 5] lib/util.c:show_msg(486) [2005/06/22 22:53:50, 5] lib/util.c:show_msg(496) size=82 smb_com=0x75 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=8 smb_flg2=51201 smb_tid=0 smb_pid=20129 smb_uid=0 smb_mid=3 smt_wct=4 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 1 (0x1) smb_bcc=39 [2005/06/22 22:53:50, 10] lib/util.c:dump_data(1999) [000] 00 5C 00 5C 00 53 00 45 00 52 00 56 00 45 00 52 .\.\.S.E .R.V.E.R [010] 00 32 00 5C 00 4D 00 55 00 53 00 49 00 43 00 00 .2.\.M.U .S.I.C.. [020] 00 3F 3F 3F 3F 3F 00 .?????. [2005/06/22 22:53:50, 3] smbd/process.c:switch_message(886) switch message SMBtconX (pid 20130) conn 0x0 [2005/06/22 22:53:50, 3] smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2005/06/22 22:53:50, 5] auth/auth_util.c:debug_nt_user_token(486) NT user token: (NULL) [2005/06/22 22:53:50, 5] auth/auth_util.c:debug_unix_user_token(505) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2005/06/22 22:53:50, 5] smbd/uid.c:change_to_root_user(296) change_to_root_user: now uid=(0,0) gid=(0,0) [2005/06/22 22:53:50, 4] smbd/reply.c:reply_tcon_and_X(408) Client requested device type [?????] for share [MUSIC] [2005/06/22 22:53:50, 7] param/loadparm.c:lp_servicenumber(4052) lp_servicenumber: couldn't find music [2005/06/22 22:53:50, 5] lib/username.c:Get_Pwnam(293) Finding user music [2005/06/22 22:53:50, 5] lib/username.c:Get_Pwnam_internals(223) Trying _Get_Pwnam(), username as lowercase is music [2005/06/22 22:53:50, 5] lib/username.c:Get_Pwnam_internals(239) Trying _Get_Pwnam(), username as uppercase is MUSIC [2005/06/22 22:53:50, 5] lib/username.c:Get_Pwnam_internals(247) Checking combinations of 0 uppercase letters in music [2005/06/22 22:53:50, 5] lib/username.c:Get_Pwnam_internals(251) Get_Pwnam_internals didn't find user [music]! [2005/06/22 22:53:50, 3] smbd/service.c:find_service(145) checking for home directory music gave (NULL) [2005/06/22 22:53:50, 7] param/loadparm.c:lp_servicenumber(4052) lp_servicenumber: couldn't find printers [2005/06/22 22:53:50, 3] smbd/service.c:find_service(205) find_service() failed to find service music [2005/06/22 22:53:50, 0] smbd/service.c:make_connection(800) 192.168.1.132 (192.168.1.132) couldn't find service music [2005/06/22 22:53:50, 3] smbd/error.c:error_packet(129) error packet at smbd/reply.c(416) cmd=117 (SMBtconX) NT_STATUS_BAD_NETWORK_NAME [2005/06/22 22:53:50, 5] lib/util.c:show_msg(486) [2005/06/22 22:53:50, 5] lib/util.c:show_msg(496) size=35 smb_com=0x75 smb_rcls=204 smb_reh=0 smb_err=49152 smb_flg=136 smb_flg2=49153 smb_tid=0 smb_pid=20129 smb_uid=0 smb_mid=3 smt_wct=0 smb_bcc=0 [2005/06/22 22:53:50, 6] lib/util_sock.c:write_socket(449) write_socket(22,39) [2005/06/22 22:53:50, 6] lib/util_sock.c:write_socket(452) write_socket(22,39) wrote 39 [2005/06/22 22:53:50, 10] lib/util_sock.c:read_socket_data(378) read_socket_data: recv of 4 returned 0. Error = Success [2005/06/22 22:53:50, 10] lib/util_sock.c:receive_smb_raw(556) receive_smb_raw: length < 0! [2005/06/22 22:53:50, 3] smbd/process.c:timeout_processing(1336) timeout_processing: End of file from client (client has disconnected). [2005/06/22 22:53:50, 5] lib/gencache.c:gencache_shutdown(88) Closing cache file [2005/06/22 22:53:50, 5] libsmb/namecache.c:namecache_shutdown(79) namecache_shutdown: netbios namecache closed successfully. [2005/06/22 22:53:50, 3] smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2005/06/22 22:53:50, 5] auth/auth_util.c:debug_nt_user_token(486) NT user token: (NULL) [2005/06/22 22:53:50, 5] auth/auth_util.c:debug_unix_user_token(505) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2005/06/22 22:53:50, 5] smbd/uid.c:change_to_root_user(296) change_to_root_user: now uid=(0,0) gid=(0,0) [2005/06/22 22:53:50, 2] smbd/server.c:exit_server(571) Closing connections [2005/06/22 22:53:50, 3] smbd/connection.c:yield_connection(69) Yielding connection to [2005/06/22 22:53:50, 3] smbd/connection.c:yield_connection(76) yield_connection: tdb_delete for name failed with error Record does not exist. [2005/06/22 22:53:50, 5] smbd/oplock.c:receive_local_message(107) receive_local_message: doing select with timeout of 1 ms [2005/06/22 22:53:50, 3] smbd/server.c:exit_server(614) Server exit (normal exit)