[2011/09/12 14:00:47.101533, 6] param/loadparm.c:7144(lp_file_list_changed) lp_file_list_changed() file /10/samba-3.5.11/lib/smb.conf -> /10/samba-3.5.11/lib/smb.conf last mod_time: Mon Sep 12 13:53:53 2011 [2011/09/12 14:00:47.101638, 3] lib/access.c:365(only_ipaddrs_in_list) only_ipaddrs_in_list: list has non-ip address (147.8.101.) [2011/09/12 14:00:47.101665, 3] lib/access.c:399(check_access) check_access: hostnames in host allow/deny list. [2011/09/12 14:00:47.103494, 2] lib/access.c:409(check_access) Allowed connection from 147.8.101.181 (147.8.101.181) [2011/09/12 14:00:47.103640, 3] smbd/oplock.c:895(init_oplocks) init_oplocks: initializing messages. [2011/09/12 14:00:47.103688, 3] smbd/oplock_linux.c:224(linux_init_kernel_oplocks) Linux kernel oplocks enabled [2011/09/12 14:00:47.103712, 5] lib/messages.c:329(messaging_deregister) Deregistering messaging pointer for type 1 - private_data=(nil) [2011/09/12 14:00:47.103744, 10] smbd/process.c:740(event_add_idle) event_add_idle: idle_evt(keepalive) 0xb81210e8 [2011/09/12 14:00:47.103771, 10] smbd/process.c:740(event_add_idle) event_add_idle: idle_evt(deadtime) 0xb8122298 [2011/09/12 14:00:47.103795, 10] smbd/process.c:740(event_add_idle) event_add_idle: idle_evt(housekeeping) 0xb8121800 [2011/09/12 14:00:47.103846, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 155 [2011/09/12 14:00:47.103877, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x9b [2011/09/12 14:00:47.103899, 3] smbd/process.c:1489(process_smb) Transaction 0 of length 159 (0 toread) [2011/09/12 14:00:47.103925, 5] lib/util.c:617(show_msg) [2011/09/12 14:00:47.103940, 5] lib/util.c:627(show_msg) size=155 smb_com=0x72 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=24 smb_flg2=51283 smb_tid=65535 smb_pid=65279 smb_uid=0 smb_mid=0 smt_wct=0 smb_bcc=120 [2011/09/12 14:00:47.104005, 10] ../lib/util/util.c:278(_dump_data) [0000] 02 50 43 20 4E 45 54 57 4F 52 4B 20 50 52 4F 47 .PC NETW ORK PROG [0010] 52 41 4D 20 31 2E 30 00 02 4C 41 4E 4D 41 4E 31 RAM 1.0. .LANMAN1 [0020] 2E 30 00 02 57 69 6E 64 6F 77 73 20 66 6F 72 20 .0..Wind ows for [0030] 57 6F 72 6B 67 72 6F 75 70 73 20 33 2E 31 61 00 Workgrou ps 3.1a. [0040] 02 4C 4D 31 2E 32 58 30 30 32 00 02 4C 41 4E 4D .LM1.2X0 02..LANM [0050] 41 4E 32 2E 31 00 02 4E 54 20 4C 4D 20 30 2E 31 AN2.1..N T LM 0.1 [0060] 32 00 02 53 4D 42 20 32 2E 30 30 32 00 02 53 4D 2..SMB 2 .002..SM [0070] 42 20 32 2E 3F 3F 3F 00 B 2.???. [2011/09/12 14:00:47.104198, 3] smbd/process.c:1298(switch_message) switch message SMBnegprot (pid 446) conn 0x0 [2011/09/12 14:00:47.104224, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:47.104249, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:47.104272, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:47.104319, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2011/09/12 14:00:47.104384, 3] smbd/negprot.c:587(reply_negprot) Requested protocol [PC NETWORK PROGRAM 1.0] [2011/09/12 14:00:47.104410, 3] smbd/negprot.c:587(reply_negprot) Requested protocol [LANMAN1.0] [2011/09/12 14:00:47.104433, 3] smbd/negprot.c:587(reply_negprot) Requested protocol [Windows for Workgroups 3.1a] [2011/09/12 14:00:47.104455, 3] smbd/negprot.c:587(reply_negprot) Requested protocol [LM1.2X002] [2011/09/12 14:00:47.104476, 3] smbd/negprot.c:587(reply_negprot) Requested protocol [LANMAN2.1] [2011/09/12 14:00:47.104498, 3] smbd/negprot.c:587(reply_negprot) Requested protocol [NT LM 0.12] [2011/09/12 14:00:47.104519, 3] smbd/negprot.c:587(reply_negprot) Requested protocol [SMB 2.002] [2011/09/12 14:00:47.104541, 3] smbd/negprot.c:587(reply_negprot) Requested protocol [SMB 2.???] [2011/09/12 14:00:47.104567, 10] lib/util.c:1972(set_remote_arch) set_remote_arch: Client arch is 'Win2K' [2011/09/12 14:00:47.104624, 6] param/loadparm.c:7144(lp_file_list_changed) lp_file_list_changed() file /10/samba-3.5.11/lib/smb.conf -> /10/samba-3.5.11/lib/smb.conf last mod_time: Mon Sep 12 13:53:53 2011 [2011/09/12 14:00:47.104675, 5] smbd/connection.c:142(claim_connection) claiming [] [2011/09/12 14:00:47.104771, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked) Locking key BE010000FFFFFFFF0000 [2011/09/12 14:00:47.104809, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked) Allocated locked data 0x0xb813ffc8 [2011/09/12 14:00:47.104860, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr) Unlocking key BE010000FFFFFFFF0000 [2011/09/12 14:00:47.104971, 6] param/loadparm.c:7144(lp_file_list_changed) lp_file_list_changed() file /10/samba-3.5.11/lib/smb.conf -> /10/samba-3.5.11/lib/smb.conf last mod_time: Mon Sep 12 13:53:53 2011 [2011/09/12 14:00:47.105060, 3] smbd/negprot.c:405(reply_nt1) using SPNEGO [2011/09/12 14:00:47.105082, 3] smbd/negprot.c:692(reply_negprot) Selected protocol NT LM 0.12 [2011/09/12 14:00:47.105102, 5] smbd/negprot.c:699(reply_negprot) negprot index=5 [2011/09/12 14:00:47.105122, 5] lib/util.c:617(show_msg) [2011/09/12 14:00:47.105137, 5] lib/util.c:627(show_msg) size=127 smb_com=0x72 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51283 smb_tid=65535 smb_pid=65279 smb_uid=0 smb_mid=0 smt_wct=17 smb_vwv[ 0]= 5 (0x5) smb_vwv[ 1]=12803 (0x3203) 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]=48640 (0xBE00) smb_vwv[ 8]= 1 (0x1) smb_vwv[ 9]=64768 (0xFD00) smb_vwv[10]=33011 (0x80F3) smb_vwv[11]=32896 (0x8080) smb_vwv[12]=48977 (0xBF51) smb_vwv[13]= 4432 (0x1150) smb_vwv[14]=52337 (0xCC71) smb_vwv[15]= 8193 (0x2001) smb_vwv[16]= 254 (0xFE) smb_bcc=58 [2011/09/12 14:00:47.105283, 10] ../lib/util/util.c:278(_dump_data) [0000] 78 30 30 39 00 00 00 00 00 00 00 00 00 00 00 00 x009.... ........ [0010] 60 28 06 06 2B 06 01 05 05 02 A0 1E 30 1C A0 0E `(..+... ....0... [0020] 30 0C 06 0A 2B 06 01 04 01 82 37 02 02 0A A3 0A 0...+... ..7..... [0030] 30 08 A0 06 1B 04 4E 4F 4E 45 0.....NO NE [2011/09/12 14:00:47.106946, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 138 [2011/09/12 14:00:47.106985, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x8a [2011/09/12 14:00:47.107017, 3] smbd/process.c:1489(process_smb) Transaction 1 of length 142 (0 toread) [2011/09/12 14:00:47.107048, 5] lib/util.c:617(show_msg) [2011/09/12 14:00:47.107071, 5] lib/util.c:627(show_msg) size=138 smb_com=0x73 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=24 smb_flg2=51207 smb_tid=65535 smb_pid=65279 smb_uid=0 smb_mid=64 smt_wct=12 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]=16644 (0x4104) smb_vwv[ 3]= 50 (0x32) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 74 (0x4A) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_vwv[10]= 212 (0xD4) smb_vwv[11]=40960 (0xA000) smb_bcc=79 [2011/09/12 14:00:47.107233, 10] ../lib/util/util.c:278(_dump_data) [0000] 60 48 06 06 2B 06 01 05 05 02 A0 3E 30 3C A0 0E `H..+... ...>0<.. [0010] 30 0C 06 0A 2B 06 01 04 01 82 37 02 02 0A A2 2A 0...+... ..7....* [0020] 04 28 4E 54 4C 4D 53 53 50 00 01 00 00 00 97 82 .(NTLMSS P....... [0030] 08 E2 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0040] 00 00 06 01 B1 1D 00 00 00 0F 00 00 00 00 00 ........ ....... [2011/09/12 14:00:47.107357, 3] smbd/process.c:1298(switch_message) switch message SMBsesssetupX (pid 446) conn 0x0 [2011/09/12 14:00:47.107378, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:47.107399, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:47.107419, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:47.107461, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2011/09/12 14:00:47.107486, 3] smbd/sesssetup.c:1458(reply_sesssetup_and_X) wct=12 flg2=0xc807 [2011/09/12 14:00:47.107510, 2] smbd/sesssetup.c:1413(setup_new_vc_session) setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources. [2011/09/12 14:00:47.107534, 3] smbd/sesssetup.c:1212(reply_sesssetup_and_X_spnego) Doing spnego session setup [2011/09/12 14:00:47.107557, 3] smbd/sesssetup.c:1254(reply_sesssetup_and_X_spnego) NativeOS=[] NativeLanMan=[] PrimaryDomain=[] [2011/09/12 14:00:47.107578, 10] lib/util.c:1972(set_remote_arch) set_remote_arch: Client arch is 'Vista' [2011/09/12 14:00:47.107601, 10] smbd/password.c:184(register_initial_vuid) register_initial_vuid: allocated vuid = 100 [2011/09/12 14:00:47.107648, 5] smbd/sesssetup.c:754(parse_spnego_mechanisms) parse_spnego_mechanisms: Got OID 1.3.6.1.4.1.311.2.2.10 [2011/09/12 14:00:47.107670, 3] smbd/sesssetup.c:806(reply_spnego_negotiate) reply_spnego_negotiate: Got secblob of size 40 [2011/09/12 14:00:47.107704, 5] auth/auth.c:487(make_auth_context_subsystem) Making default auth method list for standalone security=user, encrypt passwords = yes [2011/09/12 14:00:47.107733, 5] auth/auth.c:46(smb_register_auth) Attempting to register auth backend sam [2011/09/12 14:00:47.107754, 5] auth/auth.c:58(smb_register_auth) Successfully added auth method 'sam' [2011/09/12 14:00:47.107774, 5] auth/auth.c:46(smb_register_auth) Attempting to register auth backend sam_ignoredomain [2011/09/12 14:00:47.107794, 5] auth/auth.c:58(smb_register_auth) Successfully added auth method 'sam_ignoredomain' [2011/09/12 14:00:47.107816, 5] auth/auth.c:46(smb_register_auth) Attempting to register auth backend unix [2011/09/12 14:00:47.107837, 5] auth/auth.c:58(smb_register_auth) Successfully added auth method 'unix' [2011/09/12 14:00:47.107859, 5] auth/auth.c:46(smb_register_auth) Attempting to register auth backend winbind [2011/09/12 14:00:47.107880, 5] auth/auth.c:58(smb_register_auth) Successfully added auth method 'winbind' [2011/09/12 14:00:47.107899, 5] auth/auth.c:46(smb_register_auth) Attempting to register auth backend wbc [2011/09/12 14:00:47.107919, 5] auth/auth.c:58(smb_register_auth) Successfully added auth method 'wbc' [2011/09/12 14:00:47.107939, 5] auth/auth.c:46(smb_register_auth) Attempting to register auth backend smbserver [2011/09/12 14:00:47.107959, 5] auth/auth.c:58(smb_register_auth) Successfully added auth method 'smbserver' [2011/09/12 14:00:47.107981, 5] auth/auth.c:46(smb_register_auth) Attempting to register auth backend trustdomain [2011/09/12 14:00:47.108002, 5] auth/auth.c:58(smb_register_auth) Successfully added auth method 'trustdomain' [2011/09/12 14:00:47.108021, 5] auth/auth.c:46(smb_register_auth) Attempting to register auth backend ntdomain [2011/09/12 14:00:47.108041, 5] auth/auth.c:58(smb_register_auth) Successfully added auth method 'ntdomain' [2011/09/12 14:00:47.108065, 5] auth/auth.c:46(smb_register_auth) Attempting to register auth backend guest [2011/09/12 14:00:47.108086, 5] auth/auth.c:58(smb_register_auth) Successfully added auth method 'guest' [2011/09/12 14:00:47.108106, 5] auth/auth.c:46(smb_register_auth) Attempting to register auth backend netlogond [2011/09/12 14:00:47.108128, 5] auth/auth.c:58(smb_register_auth) Successfully added auth method 'netlogond' [2011/09/12 14:00:47.108148, 5] auth/auth.c:383(load_auth_module) load_auth_module: Attempting to find an auth method to match guest [2011/09/12 14:00:47.108171, 5] auth/auth.c:408(load_auth_module) load_auth_module: auth method guest has a valid init [2011/09/12 14:00:47.108192, 5] auth/auth.c:383(load_auth_module) load_auth_module: Attempting to find an auth method to match sam [2011/09/12 14:00:47.108212, 5] auth/auth.c:408(load_auth_module) load_auth_module: auth method sam has a valid init [2011/09/12 14:00:47.108259, 3] libsmb/ntlmssp.c:65(debug_ntlmssp_flags) Got NTLMSSP neg_flags=0xe2088297 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_NEGOTIATE_OEM NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_LM_KEY NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_NEGOTIATE_VERSION NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH NTLMSSP_NEGOTIATE_56 [2011/09/12 14:00:47.108366, 1] ../librpc/ndr/ndr.c:214(ndr_print_debug) &negotiate: struct NEGOTIATE_MESSAGE Signature : 'NTLMSSP' MessageType : NtLmNegotiate (1) NegotiateFlags : 0xe2088297 (3792208535) 1: NTLMSSP_NEGOTIATE_UNICODE 1: NTLMSSP_NEGOTIATE_OEM 1: NTLMSSP_REQUEST_TARGET 1: NTLMSSP_NEGOTIATE_SIGN 0: NTLMSSP_NEGOTIATE_SEAL 0: NTLMSSP_NEGOTIATE_DATAGRAM 1: NTLMSSP_NEGOTIATE_LM_KEY 0: NTLMSSP_NEGOTIATE_NETWARE 1: NTLMSSP_NEGOTIATE_NTLM 0: NTLMSSP_NEGOTIATE_NT_ONLY 0: NTLMSSP_ANONYMOUS 0: NTLMSSP_NEGOTIATE_OEM_DOMAIN_SUPPLIED 0: NTLMSSP_NEGOTIATE_OEM_WORKSTATION_SUPPLIED 0: NTLMSSP_NEGOTIATE_THIS_IS_LOCAL_CALL 1: NTLMSSP_NEGOTIATE_ALWAYS_SIGN 0: NTLMSSP_TARGET_TYPE_DOMAIN 0: NTLMSSP_TARGET_TYPE_SERVER 0: NTLMSSP_TARGET_TYPE_SHARE 1: NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY 0: NTLMSSP_NEGOTIATE_IDENTIFY 0: NTLMSSP_REQUEST_NON_NT_SESSION_KEY 0: NTLMSSP_NEGOTIATE_TARGET_INFO 1: NTLMSSP_NEGOTIATE_VERSION 1: NTLMSSP_NEGOTIATE_128 1: NTLMSSP_NEGOTIATE_KEY_EXCH 1: NTLMSSP_NEGOTIATE_56 DomainNameLen : 0x0000 (0) DomainNameMaxLen : 0x0000 (0) DomainName : NULL WorkstationLen : 0x0000 (0) WorkstationMaxLen : 0x0000 (0) Workstation : NULL Version: struct VERSION ProductMajorVersion : NTLMSSP_WINDOWS_MAJOR_VERSION_6 (6) ProductMinorVersion : NTLMSSP_WINDOWS_MINOR_VERSION_1 (1) ProductBuild : 0x1db1 (7601) Reserved: ARRAY(3) [0] : 0x00 (0) [1] : 0x00 (0) [2] : 0x00 (0) NTLMRevisionCurrent : NTLMSSP_REVISION_W2K3 (15) [2011/09/12 14:00:47.108706, 5] auth/auth.c:97(get_ntlm_challenge) auth_get_challenge: module guest did not want to specify a challenge [2011/09/12 14:00:47.108728, 5] auth/auth.c:97(get_ntlm_challenge) auth_get_challenge: module sam did not want to specify a challenge [2011/09/12 14:00:47.108762, 5] auth/auth.c:132(get_ntlm_challenge) auth_context challenge created by random [2011/09/12 14:00:47.108782, 5] auth/auth.c:133(get_ntlm_challenge) challenge is: [2011/09/12 14:00:47.108802, 5] ../lib/util/util.c:278(_dump_data) [0000] A7 DF 3C 38 4B 63 71 FD ..<8Kcq. [2011/09/12 14:00:47.108948, 1] ../librpc/ndr/ndr.c:214(ndr_print_debug) &challenge: struct CHALLENGE_MESSAGE Signature : 'NTLMSSP' MessageType : NtLmChallenge (0x2) TargetNameLen : 0x0008 (8) TargetNameMaxLen : 0x0008 (8) TargetName : * TargetName : 'X009' NegotiateFlags : 0xe28a8295 (3800728213) 1: NTLMSSP_NEGOTIATE_UNICODE 0: NTLMSSP_NEGOTIATE_OEM 1: NTLMSSP_REQUEST_TARGET 1: NTLMSSP_NEGOTIATE_SIGN 0: NTLMSSP_NEGOTIATE_SEAL 0: NTLMSSP_NEGOTIATE_DATAGRAM 1: NTLMSSP_NEGOTIATE_LM_KEY 0: NTLMSSP_NEGOTIATE_NETWARE 1: NTLMSSP_NEGOTIATE_NTLM 0: NTLMSSP_NEGOTIATE_NT_ONLY 0: NTLMSSP_ANONYMOUS 0: NTLMSSP_NEGOTIATE_OEM_DOMAIN_SUPPLIED 0: NTLMSSP_NEGOTIATE_OEM_WORKSTATION_SUPPLIED 0: NTLMSSP_NEGOTIATE_THIS_IS_LOCAL_CALL 1: NTLMSSP_NEGOTIATE_ALWAYS_SIGN 0: NTLMSSP_TARGET_TYPE_DOMAIN 1: NTLMSSP_TARGET_TYPE_SERVER 0: NTLMSSP_TARGET_TYPE_SHARE 1: NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY 0: NTLMSSP_NEGOTIATE_IDENTIFY 0: NTLMSSP_REQUEST_NON_NT_SESSION_KEY 1: NTLMSSP_NEGOTIATE_TARGET_INFO 1: NTLMSSP_NEGOTIATE_VERSION 1: NTLMSSP_NEGOTIATE_128 1: NTLMSSP_NEGOTIATE_KEY_EXCH 1: NTLMSSP_NEGOTIATE_56 ServerChallenge : a7df3c384b6371fd Reserved : 0000000000000000 TargetInfoLen : 0x0046 (70) TargetNameInfoMaxLen : 0x0046 (70) TargetInfo : * TargetInfo: struct AV_PAIR_LIST count : 0x00000005 (5) pair: ARRAY(5) pair: struct AV_PAIR AvId : MsvAvNbDomainName (0x2) AvLen : 0x0008 (8) Value : union ntlmssp_AvValue(case 0x2) AvNbDomainName : 'X009' pair: struct AV_PAIR AvId : MsvAvNbComputerName (0x1) AvLen : 0x0008 (8) Value : union ntlmssp_AvValue(case 0x1) AvNbComputerName : 'X009' pair: struct AV_PAIR AvId : MsvAvDnsDomainName (0x4) AvLen : 0x000c (12) Value : union ntlmssp_AvValue(case 0x4) AvDnsDomainName : 'hku.hk' pair: struct AV_PAIR AvId : MsvAvDnsComputerName (0x3) AvLen : 0x0016 (22) Value : union ntlmssp_AvValue(case 0x3) AvDnsComputerName : 'x009.hku.hk' pair: struct AV_PAIR AvId : MsvAvEOL (0x0) AvLen : 0x0000 (0) Value : union ntlmssp_AvValue(case 0x0) Version: struct VERSION ProductMajorVersion : UNKNOWN_ENUM_VALUE (0x58) ProductMinorVersion : NTLMSSP_WINDOWS_MINOR_VERSION_0 (0x0) ProductBuild : 0x0030 (48) Reserved : 300039 NTLMRevisionCurrent : UNKNOWN_ENUM_VALUE (0x0) [2011/09/12 14:00:47.109549, 5] lib/util.c:617(show_msg) [2011/09/12 14:00:47.109567, 5] lib/util.c:627(show_msg) size=256 smb_com=0x73 smb_rcls=22 smb_reh=0 smb_err=49152 smb_flg=136 smb_flg2=51203 smb_tid=65535 smb_pid=65279 smb_uid=100 smb_mid=64 smt_wct=4 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 156 (0x9C) smb_bcc=213 [2011/09/12 14:00:47.109651, 10] ../lib/util/util.c:278(_dump_data) [0000] A1 81 99 30 81 96 A0 03 0A 01 01 A1 0C 06 0A 2B ...0.... .......+ [0010] 06 01 04 01 82 37 02 02 0A A2 81 80 04 7E 4E 54 .....7.. .....~NT [0020] 4C 4D 53 53 50 00 02 00 00 00 08 00 08 00 30 00 LMSSP... ......0. [0030] 00 00 95 82 8A E2 A7 DF 3C 38 4B 63 71 FD 00 00 ........ <8Kcq... [0040] 00 00 00 00 00 00 46 00 46 00 38 00 00 00 58 00 ......F. F.8...X. [0050] 30 00 30 00 39 00 02 00 08 00 58 00 30 00 30 00 0.0.9... ..X.0.0. [0060] 39 00 01 00 08 00 58 00 30 00 30 00 39 00 04 00 9.....X. 0.0.9... [0070] 0C 00 68 00 6B 00 75 00 2E 00 68 00 6B 00 03 00 ..h.k.u. ..h.k... [0080] 16 00 78 00 30 00 30 00 39 00 2E 00 68 00 6B 00 ..x.0.0. 9...h.k. [0090] 75 00 2E 00 68 00 6B 00 00 00 00 00 00 55 00 6E u...h.k. .....U.n [00A0] 00 69 00 78 00 00 00 53 00 61 00 6D 00 62 00 61 .i.x...S .a.m.b.a [00B0] 00 20 00 33 00 2E 00 35 00 2E 00 31 00 31 00 00 . .3...5 ...1.1.. [00C0] 00 57 00 4F 00 52 00 4B 00 47 00 52 00 4F 00 55 .W.O.R.K .G.R.O.U [00D0] 00 50 00 00 00 .P... [2011/09/12 14:00:47.111059, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 470 [2011/09/12 14:00:47.111100, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x1d6 [2011/09/12 14:00:47.111131, 3] smbd/process.c:1489(process_smb) Transaction 2 of length 474 (0 toread) [2011/09/12 14:00:47.111162, 5] lib/util.c:617(show_msg) [2011/09/12 14:00:47.111184, 5] lib/util.c:627(show_msg) size=470 smb_com=0x73 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=24 smb_flg2=51207 smb_tid=65535 smb_pid=65279 smb_uid=100 smb_mid=128 smt_wct=12 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]=16644 (0x4104) smb_vwv[ 3]= 50 (0x32) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 406 (0x196) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_vwv[10]= 212 (0xD4) smb_vwv[11]=40960 (0xA000) smb_bcc=411 [2011/09/12 14:00:47.111345, 10] ../lib/util/util.c:278(_dump_data) [0000] A1 82 01 92 30 82 01 8E A2 82 01 8A 04 82 01 86 ....0... ........ [0010] 4E 54 4C 4D 53 53 50 00 03 00 00 00 18 00 18 00 NTLMSSP. ........ [0020] 7C 00 00 00 E2 00 E2 00 94 00 00 00 12 00 12 00 |....... ........ [0030] 58 00 00 00 0A 00 0A 00 6A 00 00 00 08 00 08 00 X....... j....... [0040] 74 00 00 00 10 00 10 00 76 01 00 00 15 82 88 E2 t....... v....... [0050] 06 01 B1 1D 00 00 00 0F 89 F4 DE 9F E9 51 04 DF ........ .....Q.. [0060] D0 64 32 58 EC E9 89 92 77 00 6F 00 72 00 6B 00 .d2X.... w.o.r.k. [0070] 67 00 72 00 6F 00 75 00 70 00 75 00 73 00 65 00 g.r.o.u. p.u.s.e. [0080] 72 00 30 00 58 00 31 00 38 00 31 00 00 00 00 00 r.0.X.1. 8.1..... [0090] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [00A0] 00 00 00 00 5B 50 FD 0F 34 DB 3B AD CF 85 30 1F ....[P.. 4.;...0. [00B0] F3 91 97 AB 01 01 00 00 00 00 00 00 55 0D 67 50 ........ ....U.gP [00C0] 11 71 CC 01 A3 BB BE FC 1E A8 55 60 00 00 00 00 .q...... ..U`.... [00D0] 02 00 08 00 58 00 30 00 30 00 39 00 01 00 08 00 ....X.0. 0.9..... [00E0] 58 00 30 00 30 00 39 00 04 00 0C 00 68 00 6B 00 X.0.0.9. ....h.k. [00F0] 75 00 2E 00 68 00 6B 00 03 00 16 00 78 00 30 00 u...h.k. ....x.0. [0100] 30 00 39 00 2E 00 68 00 6B 00 75 00 2E 00 68 00 0.9...h. k.u...h. [0110] 6B 00 08 00 30 00 30 00 00 00 00 00 00 00 01 00 k...0.0. ........ [0120] 00 00 00 20 00 00 10 D4 D9 7A D7 00 EF BA 32 9C ... .... .z....2. [0130] C5 2E 3C 97 63 94 59 F3 21 3A B9 2E 75 C8 20 E1 ..<.c.Y. !:..u. . [0140] D7 00 B2 DF 8E 49 0A 00 10 00 00 00 00 00 00 00 .....I.. ........ [0150] 00 00 00 00 00 00 00 00 00 00 09 00 20 00 63 00 ........ .... .c. [0160] 69 00 66 00 73 00 2F 00 31 00 34 00 37 00 2E 00 i.f.s./. 1.4.7... [0170] 38 00 2E 00 31 00 30 00 31 00 2E 00 39 00 00 00 8...1.0. 1...9... [0180] 00 00 00 00 00 00 28 5F 06 69 00 51 E0 0D CC 23 ......(_ .i.Q...# [0190] 66 7C 36 99 A6 5E 00 00 00 00 00 f|6..^.. ... [2011/09/12 14:00:47.111903, 3] smbd/process.c:1298(switch_message) switch message SMBsesssetupX (pid 446) conn 0x0 [2011/09/12 14:00:47.111926, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:47.111959, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:47.111979, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:47.112008, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2011/09/12 14:00:47.112030, 3] smbd/sesssetup.c:1458(reply_sesssetup_and_X) wct=12 flg2=0xc807 [2011/09/12 14:00:47.112050, 2] smbd/sesssetup.c:1413(setup_new_vc_session) setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources. [2011/09/12 14:00:47.112070, 3] smbd/sesssetup.c:1212(reply_sesssetup_and_X_spnego) Doing spnego session setup [2011/09/12 14:00:47.112092, 3] smbd/sesssetup.c:1254(reply_sesssetup_and_X_spnego) NativeOS=[] NativeLanMan=[] PrimaryDomain=[] [2011/09/12 14:00:47.112151, 1] ../librpc/ndr/ndr.c:214(ndr_print_debug) &authenticate: struct AUTHENTICATE_MESSAGE Signature : 'NTLMSSP' MessageType : NtLmAuthenticate (3) LmChallengeResponseLen : 0x0018 (24) LmChallengeResponseMaxLen: 0x0018 (24) LmChallengeResponse : * LmChallengeResponse : union ntlmssp_LM_RESPONSE(case 24) v1: struct LM_RESPONSE Response : 000000000000000000000000000000000000000000000000 NtChallengeResponseLen : 0x00e2 (226) NtChallengeResponseMaxLen: 0x00e2 (226) NtChallengeResponse : * NtChallengeResponse : union ntlmssp_NTLM_RESPONSE(case 226) v2: struct NTLMv2_RESPONSE Response : 5b50fd0f34db3badcf85301ff39197ab Challenge: struct NTLMv2_CLIENT_CHALLENGE RespType : 0x01 (1) HiRespType : 0x01 (1) Reserved1 : 0x0000 (0) Reserved2 : 0x00000000 (0) TimeStamp : Mon Sep 12 14:00:46 2011 HKT ChallengeFromClient : a3bbbefc1ea85560 Reserved3 : 0x00000000 (0) AvPairs: struct AV_PAIR_LIST count : 0x00000008 (8) pair: ARRAY(8) pair: struct AV_PAIR AvId : MsvAvNbDomainName (0x2) AvLen : 0x0008 (8) Value : union ntlmssp_AvValue(case 0x2) AvNbDomainName : 'X009' pair: struct AV_PAIR AvId : MsvAvNbComputerName (0x1) AvLen : 0x0008 (8) Value : union ntlmssp_AvValue(case 0x1) AvNbComputerName : 'X009' pair: struct AV_PAIR AvId : MsvAvDnsDomainName (0x4) AvLen : 0x000c (12) Value : union ntlmssp_AvValue(case 0x4) AvDnsDomainName : 'hku.hk' pair: struct AV_PAIR AvId : MsvAvDnsComputerName (0x3) AvLen : 0x0016 (22) Value : union ntlmssp_AvValue(case 0x3) AvDnsComputerName : 'x009.hku.hk' pair: struct AV_PAIR AvId : MsAvRestrictions (0x8) AvLen : 0x0030 (48) Value : union ntlmssp_AvValue(case 0x8) AvRestrictions: struct Restriction_Encoding Size : 0x00000030 (48) Z4 : 0x00000000 (0) IntegrityLevel : 0x00000001 (1) SubjectIntegrityLevel : 0x00002000 (8192) MachineId : 10d4d97ad700efba329cc52e3c97639459f3213ab92e75c820e1d700b2df8e49 pair: struct AV_PAIR AvId : MsvChannelBindings (0xA) AvLen : 0x0010 (16) Value : union ntlmssp_AvValue(case 0xA) ChannelBindings : 00000000000000000000000000000000 pair: struct AV_PAIR AvId : MsvAvTargetName (0x9) AvLen : 0x0020 (32) Value : union ntlmssp_AvValue(case 0x9) AvTargetName : 'cifs/147.8.101.9' pair: struct AV_PAIR AvId : MsvAvEOL (0x0) AvLen : 0x0000 (0) Value : union ntlmssp_AvValue(case 0x0) DomainNameLen : 0x0012 (18) DomainNameMaxLen : 0x0012 (18) DomainName : * DomainName : 'workgroup' UserNameLen : 0x000a (10) UserNameMaxLen : 0x000a (10) UserName : * UserName : 'user0' WorkstationLen : 0x0008 (8) WorkstationMaxLen : 0x0008 (8) Workstation : * Workstation : 'X181' EncryptedRandomSessionKeyLen: 0x0010 (16) EncryptedRandomSessionKeyMaxLen: 0x0010 (16) EncryptedRandomSessionKey: * EncryptedRandomSessionKey: DATA_BLOB length=16 [2011/09/12 14:00:47.112937, 10] ../lib/util/util.c:278(_dump_data) [0000] 28 5F 06 69 00 51 E0 0D CC 23 66 7C 36 99 A6 5E (_.i.Q.. .#f|6..^ NegotiateFlags : 0xe2888215 (3800597013) 1: NTLMSSP_NEGOTIATE_UNICODE 0: NTLMSSP_NEGOTIATE_OEM 1: NTLMSSP_REQUEST_TARGET 1: NTLMSSP_NEGOTIATE_SIGN 0: NTLMSSP_NEGOTIATE_SEAL 0: NTLMSSP_NEGOTIATE_DATAGRAM 0: NTLMSSP_NEGOTIATE_LM_KEY 0: NTLMSSP_NEGOTIATE_NETWARE 1: NTLMSSP_NEGOTIATE_NTLM 0: NTLMSSP_NEGOTIATE_NT_ONLY 0: NTLMSSP_ANONYMOUS 0: NTLMSSP_NEGOTIATE_OEM_DOMAIN_SUPPLIED 0: NTLMSSP_NEGOTIATE_OEM_WORKSTATION_SUPPLIED 0: NTLMSSP_NEGOTIATE_THIS_IS_LOCAL_CALL 1: NTLMSSP_NEGOTIATE_ALWAYS_SIGN 0: NTLMSSP_TARGET_TYPE_DOMAIN 0: NTLMSSP_TARGET_TYPE_SERVER 0: NTLMSSP_TARGET_TYPE_SHARE 1: NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY 0: NTLMSSP_NEGOTIATE_IDENTIFY 0: NTLMSSP_REQUEST_NON_NT_SESSION_KEY 1: NTLMSSP_NEGOTIATE_TARGET_INFO 1: NTLMSSP_NEGOTIATE_VERSION 1: NTLMSSP_NEGOTIATE_128 1: NTLMSSP_NEGOTIATE_KEY_EXCH 1: NTLMSSP_NEGOTIATE_56 Version: struct VERSION ProductMajorVersion : NTLMSSP_WINDOWS_MAJOR_VERSION_6 (6) ProductMinorVersion : NTLMSSP_WINDOWS_MINOR_VERSION_1 (1) ProductBuild : 0x1db1 (7601) Reserved: ARRAY(3) [0] : 0x00 (0) [1] : 0x00 (0) [2] : 0x00 (0) NTLMRevisionCurrent : NTLMSSP_REVISION_W2K3 (15) [2011/09/12 14:00:47.113233, 3] libsmb/ntlmssp.c:747(ntlmssp_server_auth) Got user=[user0] domain=[workgroup] workstation=[X181] len1=24 len2=226 [2011/09/12 14:00:47.113277, 6] param/loadparm.c:7144(lp_file_list_changed) lp_file_list_changed() file /10/samba-3.5.11/lib/smb.conf -> /10/samba-3.5.11/lib/smb.conf last mod_time: Mon Sep 12 13:53:53 2011 [2011/09/12 14:00:47.113335, 5] auth/auth_util.c:211(make_user_info_map) Mapping user [workgroup]\[user0] from workstation [X181] [2011/09/12 14:00:47.113360, 5] auth/auth_util.c:232(make_user_info_map) Mapped domain from [workgroup] to [X009] for user [user0] from workstation [X181] [2011/09/12 14:00:47.113382, 5] auth/auth_util.c:122(make_user_info) attempting to make a user_info for user0 (user0) [2011/09/12 14:00:47.113402, 5] auth/auth_util.c:132(make_user_info) making strings for user0's user_info struct [2011/09/12 14:00:47.113423, 5] auth/auth_util.c:164(make_user_info) making blobs for user0's user_info struct [2011/09/12 14:00:47.113444, 10] auth/auth_util.c:182(make_user_info) made an encrypted user_info for user0 (user0) [2011/09/12 14:00:47.113465, 3] auth/auth.c:216(check_ntlm_password) check_ntlm_password: Checking password for unmapped user [workgroup]\[user0]@[X181] with the new password interface [2011/09/12 14:00:47.113488, 3] auth/auth.c:219(check_ntlm_password) check_ntlm_password: mapped user is: [X009]\[user0]@[X181] [2011/09/12 14:00:47.113508, 10] auth/auth.c:228(check_ntlm_password) check_ntlm_password: auth_context challenge created by random [2011/09/12 14:00:47.113528, 10] auth/auth.c:230(check_ntlm_password) challenge is: [2011/09/12 14:00:47.113548, 5] ../lib/util/util.c:278(_dump_data) [0000] A7 DF 3C 38 4B 63 71 FD ..<8Kcq. [2011/09/12 14:00:47.113585, 10] auth/auth.c:256(check_ntlm_password) check_ntlm_password: guest had nothing to say [2011/09/12 14:00:47.113608, 8] lib/util.c:1872(is_myname) is_myname("X009") returns 1 [2011/09/12 14:00:47.113632, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:47.113656, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:47.113677, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:47.113697, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:47.113717, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:47.113786, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username user0, was [2011/09/12 14:00:47.113811, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain X009, was [2011/09/12 14:00:47.113844, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2011/09/12 14:00:47.113865, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2011/09/12 14:00:47.113887, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:47.113912, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\x009\user0, was [2011/09/12 14:00:47.113934, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive F:, was NULL [2011/09/12 14:00:47.113955, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2011/09/12 14:00:47.113977, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:47.114012, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\x009\user0\profile, was [2011/09/12 14:00:47.114035, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2011/09/12 14:00:47.114058, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:47.114079, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:47.114100, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:47.114120, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:47.114140, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:47.114182, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:47.114209, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:47.114235, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1002 [2011/09/12 14:00:47.114262, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1002 from rid 1002 [2011/09/12 14:00:47.114296, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:47.114317, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:47.114338, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:47.114358, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:47.114377, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:47.114409, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: maximum password age, val: -1 [2011/09/12 14:00:47.114434, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:47.114457, 5] lib/username.c:133(Get_Pwnam_alloc) Finding user user0 [2011/09/12 14:00:47.114478, 5] lib/username.c:77(Get_Pwnam_internals) Trying _Get_Pwnam(), username as lowercase is user0 [2011/09/12 14:00:47.114552, 5] lib/username.c:110(Get_Pwnam_internals) Get_Pwnam_internals did find user [user0]! [2011/09/12 14:00:47.114595, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = IDMAP/GID2SID/100 couldn't be found [2011/09/12 14:00:47.114656, 5] passdb/lookup_sid.c:1387(gid_to_sid) gid_to_sid: winbind failed to find a sid for gid 100 [2011/09/12 14:00:47.114679, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:47.114700, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:47.114721, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:47.114741, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:47.114761, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:47.114865, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:47.114889, 10] passdb/lookup_sid.c:1182(legacy_gid_to_sid) LEGACY: gid 100 -> sid S-1-22-2-100 [2011/09/12 14:00:47.114936, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:47.114959, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:47.114980, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:47.115013, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:47.115034, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:47.115067, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:47.115091, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:47.115122, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username user0, was [2011/09/12 14:00:47.115143, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain X009, was [2011/09/12 14:00:47.115164, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2011/09/12 14:00:47.115185, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2011/09/12 14:00:47.115206, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:47.115231, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\x009\user0, was [2011/09/12 14:00:47.115253, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive F:, was NULL [2011/09/12 14:00:47.115274, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2011/09/12 14:00:47.115296, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:47.115320, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\x009\user0\profile, was [2011/09/12 14:00:47.115342, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2011/09/12 14:00:47.115365, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:47.115386, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:47.115407, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:47.115427, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:47.115447, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:47.115479, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:47.115503, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:47.115525, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1002 [2011/09/12 14:00:47.115549, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1002 from rid 1002 [2011/09/12 14:00:47.115592, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = IDMAP/SID2GID/S-1-5-21-4090241009-3592364035-1401512610-513 couldn't be found [2011/09/12 14:00:47.115636, 10] passdb/lookup_sid.c:1511(sid_to_gid) winbind failed to find a gid for sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:47.115662, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:47.115684, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:47.115704, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:47.115724, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:47.115744, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:47.115775, 5] passdb/pdb_interface.c:1473(lookup_global_sam_rid) lookup_global_sam_rid: looking up RID 513. [2011/09/12 14:00:47.115812, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2011/09/12 14:00:47.115833, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2011/09/12 14:00:47.115855, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2011/09/12 14:00:47.115876, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:47.115895, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:47.115930, 5] passdb/pdb_tdb.c:609(tdbsam_getsampwrid) pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201. [2011/09/12 14:00:47.116004, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:47.116029, 5] passdb/pdb_interface.c:1536(lookup_global_sam_rid) Can't find a unix id for an unmapped group [2011/09/12 14:00:47.116053, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:47.116074, 10] passdb/lookup_sid.c:1283(legacy_sid_to_gid) LEGACY: mapping failed for sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:47.116098, 10] passdb/pdb_get_set.c:595(pdb_set_group_sid) pdb_set_group_sid: setting group sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:47.116127, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:47.116149, 9] passdb/passdb.c:2182(pdb_update_autolock_flag) pdb_update_autolock_flag: Account user0 not autolocked, no check needed [2011/09/12 14:00:47.116172, 4] ../libcli/auth/ntlm_check.c:351(ntlm_password_check) ntlm_password_check: Checking NTLMv2 password with domain [workgroup] [2011/09/12 14:00:47.116213, 4] ../libcli/auth/ntlm_check.c:365(ntlm_password_check) ntlm_password_check: Checking NTLMv2 password with uppercased version of domain [workgroup] [2011/09/12 14:00:47.116245, 4] ../libcli/auth/ntlm_check.c:379(ntlm_password_check) ntlm_password_check: Checking NTLMv2 password without a domain [2011/09/12 14:00:47.116283, 3] ../libcli/auth/ntlm_check.c:392(ntlm_password_check) ntlm_password_check: NTLMv2 password check failed [2011/09/12 14:00:47.116305, 4] ../libcli/auth/ntlm_check.c:445(ntlm_password_check) ntlm_password_check: Checking LM password [2011/09/12 14:00:47.116413, 4] ../libcli/auth/ntlm_check.c:473(ntlm_password_check) ntlm_password_check: Checking LMv2 password with domain workgroup [2011/09/12 14:00:47.116442, 4] ../libcli/auth/ntlm_check.c:503(ntlm_password_check) ntlm_password_check: Checking LMv2 password with upper-cased version of domain workgroup [2011/09/12 14:00:47.116472, 4] ../libcli/auth/ntlm_check.c:533(ntlm_password_check) ntlm_password_check: Checking LMv2 password without a domain [2011/09/12 14:00:47.116502, 4] ../libcli/auth/ntlm_check.c:566(ntlm_password_check) ntlm_password_check: Checking NT MD4 password in LM field [2011/09/12 14:00:47.116605, 3] ../libcli/auth/ntlm_check.c:585(ntlm_password_check) ntlm_password_check: LM password, NT MD4 password in LM field and LMv2 failed for user user0 [2011/09/12 14:00:47.116627, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:47.116648, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:47.116668, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:47.116688, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:47.116708, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:47.116741, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:47.116765, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:47.116788, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:47.116829, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:47.116850, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:47.116870, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:47.116890, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:47.116920, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:47.116941, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:47.116961, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:47.116982, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:47.117001, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:47.117033, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: bad lockout attempt, val: 0 [2011/09/12 14:00:47.117057, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:47.117082, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:47.117103, 9] passdb/passdb.c:2248(pdb_increment_bad_password_count) No lockout policy, don't track bad passwords [2011/09/12 14:00:47.117123, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:47.117143, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:47.117164, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:47.117184, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:47.117203, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:47.117277, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username user0, was [2011/09/12 14:00:47.117301, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain X009, was [2011/09/12 14:00:47.117321, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2011/09/12 14:00:47.117341, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2011/09/12 14:00:47.117362, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:47.117387, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\x009\user0, was [2011/09/12 14:00:47.117408, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive F:, was NULL [2011/09/12 14:00:47.117429, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2011/09/12 14:00:47.117451, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:47.117475, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\x009\user0\profile, was [2011/09/12 14:00:47.117497, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2011/09/12 14:00:47.117519, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:47.117540, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:47.117560, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:47.117580, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:47.117600, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:47.117645, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:47.117670, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:47.117692, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1002 [2011/09/12 14:00:47.117716, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1002 from rid 1002 [2011/09/12 14:00:47.117749, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:47.117771, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:47.117791, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:47.117811, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:47.117831, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:47.117862, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: maximum password age, val: -1 [2011/09/12 14:00:47.117887, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:47.117910, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:47.117931, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:47.117951, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:47.117971, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:47.117991, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:47.118022, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:47.118047, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:47.118070, 5] passdb/pdb_tdb.c:758(tdb_update_samacct_only) Storing account user0 with RID 1002 [2011/09/12 14:00:47.118096, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked) Locking key 555345525F7573657230 [2011/09/12 14:00:47.118119, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked) Allocated locked data 0x0xb8127310 [2011/09/12 14:00:47.118142, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr) Unlocking key 555345525F7573657230 [2011/09/12 14:00:47.118166, 10] passdb/pdb_tdb.c:891(tdb_update_sam) tdb_update_sam: Updating key for RID 1002 [2011/09/12 14:00:47.118192, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked) Locking key 5249445F303030303033 [2011/09/12 14:00:47.118215, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked) Allocated locked data 0x0xb813d598 [2011/09/12 14:00:47.118237, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr) Unlocking key 5249445F303030303033 [2011/09/12 14:00:47.118269, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:47.118293, 5] auth/auth.c:268(check_ntlm_password) check_ntlm_password: sam authentication for user [user0] FAILED with error NT_STATUS_WRONG_PASSWORD [2011/09/12 14:00:47.118320, 2] auth/auth.c:314(check_ntlm_password) check_ntlm_password: Authentication for user [user0] -> [user0] FAILED with error NT_STATUS_WRONG_PASSWORD [2011/09/12 14:00:47.118342, 5] auth/auth_util.c:2119(free_user_info) attempting to free (and zero) a user_info structure [2011/09/12 14:00:47.118362, 10] auth/auth_util.c:2123(free_user_info) structure was created for user0 [2011/09/12 14:00:47.118394, 3] smbd/error.c:80(error_packet_set) error packet at smbd/sesssetup.c(111) cmd=115 (SMBsesssetupX) NT_STATUS_LOGON_FAILURE [2011/09/12 14:00:47.118425, 5] lib/util.c:617(show_msg) [2011/09/12 14:00:47.118454, 5] lib/util.c:627(show_msg) size=35 smb_com=0x73 smb_rcls=109 smb_reh=0 smb_err=49152 smb_flg=136 smb_flg2=51203 smb_tid=65535 smb_pid=65279 smb_uid=100 smb_mid=128 smt_wct=0 smb_bcc=0 [2011/09/12 14:00:50.262506, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 138 [2011/09/12 14:00:50.262559, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x8a [2011/09/12 14:00:50.262592, 3] smbd/process.c:1489(process_smb) Transaction 3 of length 142 (0 toread) [2011/09/12 14:00:50.262624, 5] lib/util.c:617(show_msg) [2011/09/12 14:00:50.262646, 5] lib/util.c:627(show_msg) size=138 smb_com=0x73 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=24 smb_flg2=51207 smb_tid=65535 smb_pid=65279 smb_uid=0 smb_mid=192 smt_wct=12 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]=16644 (0x4104) smb_vwv[ 3]= 50 (0x32) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 74 (0x4A) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_vwv[10]= 212 (0xD4) smb_vwv[11]=40960 (0xA000) smb_bcc=79 [2011/09/12 14:00:50.262801, 10] ../lib/util/util.c:278(_dump_data) [0000] 60 48 06 06 2B 06 01 05 05 02 A0 3E 30 3C A0 0E `H..+... ...>0<.. [0010] 30 0C 06 0A 2B 06 01 04 01 82 37 02 02 0A A2 2A 0...+... ..7....* [0020] 04 28 4E 54 4C 4D 53 53 50 00 01 00 00 00 97 82 .(NTLMSS P....... [0030] 08 E2 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [0040] 00 00 06 01 B1 1D 00 00 00 0F 00 00 00 00 00 ........ ....... [2011/09/12 14:00:50.262922, 3] smbd/process.c:1298(switch_message) switch message SMBsesssetupX (pid 446) conn 0x0 [2011/09/12 14:00:50.262944, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.262965, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.262985, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.263013, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2011/09/12 14:00:50.263035, 3] smbd/sesssetup.c:1458(reply_sesssetup_and_X) wct=12 flg2=0xc807 [2011/09/12 14:00:50.263056, 2] smbd/sesssetup.c:1413(setup_new_vc_session) setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources. [2011/09/12 14:00:50.263076, 3] smbd/sesssetup.c:1212(reply_sesssetup_and_X_spnego) Doing spnego session setup [2011/09/12 14:00:50.263099, 3] smbd/sesssetup.c:1254(reply_sesssetup_and_X_spnego) NativeOS=[] NativeLanMan=[] PrimaryDomain=[] [2011/09/12 14:00:50.263120, 10] smbd/password.c:184(register_initial_vuid) register_initial_vuid: allocated vuid = 101 [2011/09/12 14:00:50.263164, 5] smbd/sesssetup.c:754(parse_spnego_mechanisms) parse_spnego_mechanisms: Got OID 1.3.6.1.4.1.311.2.2.10 [2011/09/12 14:00:50.263185, 3] smbd/sesssetup.c:806(reply_spnego_negotiate) reply_spnego_negotiate: Got secblob of size 40 [2011/09/12 14:00:50.263212, 5] auth/auth.c:487(make_auth_context_subsystem) Making default auth method list for standalone security=user, encrypt passwords = yes [2011/09/12 14:00:50.263237, 5] auth/auth.c:383(load_auth_module) load_auth_module: Attempting to find an auth method to match guest [2011/09/12 14:00:50.263258, 5] auth/auth.c:408(load_auth_module) load_auth_module: auth method guest has a valid init [2011/09/12 14:00:50.263279, 5] auth/auth.c:383(load_auth_module) load_auth_module: Attempting to find an auth method to match sam [2011/09/12 14:00:50.263299, 5] auth/auth.c:408(load_auth_module) load_auth_module: auth method sam has a valid init [2011/09/12 14:00:50.263323, 3] libsmb/ntlmssp.c:65(debug_ntlmssp_flags) Got NTLMSSP neg_flags=0xe2088297 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_NEGOTIATE_OEM NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_LM_KEY NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_NEGOTIATE_VERSION NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH NTLMSSP_NEGOTIATE_56 [2011/09/12 14:00:50.263418, 1] ../librpc/ndr/ndr.c:214(ndr_print_debug) &negotiate: struct NEGOTIATE_MESSAGE Signature : 'NTLMSSP' MessageType : NtLmNegotiate (1) NegotiateFlags : 0xe2088297 (3792208535) 1: NTLMSSP_NEGOTIATE_UNICODE 1: NTLMSSP_NEGOTIATE_OEM 1: NTLMSSP_REQUEST_TARGET 1: NTLMSSP_NEGOTIATE_SIGN 0: NTLMSSP_NEGOTIATE_SEAL 0: NTLMSSP_NEGOTIATE_DATAGRAM 1: NTLMSSP_NEGOTIATE_LM_KEY 0: NTLMSSP_NEGOTIATE_NETWARE 1: NTLMSSP_NEGOTIATE_NTLM 0: NTLMSSP_NEGOTIATE_NT_ONLY 0: NTLMSSP_ANONYMOUS 0: NTLMSSP_NEGOTIATE_OEM_DOMAIN_SUPPLIED 0: NTLMSSP_NEGOTIATE_OEM_WORKSTATION_SUPPLIED 0: NTLMSSP_NEGOTIATE_THIS_IS_LOCAL_CALL 1: NTLMSSP_NEGOTIATE_ALWAYS_SIGN 0: NTLMSSP_TARGET_TYPE_DOMAIN 0: NTLMSSP_TARGET_TYPE_SERVER 0: NTLMSSP_TARGET_TYPE_SHARE 1: NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY 0: NTLMSSP_NEGOTIATE_IDENTIFY 0: NTLMSSP_REQUEST_NON_NT_SESSION_KEY 0: NTLMSSP_NEGOTIATE_TARGET_INFO 1: NTLMSSP_NEGOTIATE_VERSION 1: NTLMSSP_NEGOTIATE_128 1: NTLMSSP_NEGOTIATE_KEY_EXCH 1: NTLMSSP_NEGOTIATE_56 DomainNameLen : 0x0000 (0) DomainNameMaxLen : 0x0000 (0) DomainName : NULL WorkstationLen : 0x0000 (0) WorkstationMaxLen : 0x0000 (0) Workstation : NULL Version: struct VERSION ProductMajorVersion : NTLMSSP_WINDOWS_MAJOR_VERSION_6 (6) ProductMinorVersion : NTLMSSP_WINDOWS_MINOR_VERSION_1 (1) ProductBuild : 0x1db1 (7601) Reserved: ARRAY(3) [0] : 0x00 (0) [1] : 0x00 (0) [2] : 0x00 (0) NTLMRevisionCurrent : NTLMSSP_REVISION_W2K3 (15) [2011/09/12 14:00:50.263742, 5] auth/auth.c:97(get_ntlm_challenge) auth_get_challenge: module guest did not want to specify a challenge [2011/09/12 14:00:50.263763, 5] auth/auth.c:97(get_ntlm_challenge) auth_get_challenge: module sam did not want to specify a challenge [2011/09/12 14:00:50.263795, 5] auth/auth.c:132(get_ntlm_challenge) auth_context challenge created by random [2011/09/12 14:00:50.263816, 5] auth/auth.c:133(get_ntlm_challenge) challenge is: [2011/09/12 14:00:50.263835, 5] ../lib/util/util.c:278(_dump_data) [0000] A9 C3 A6 6E D8 E7 5F 74 ...n.._t [2011/09/12 14:00:50.263890, 1] ../librpc/ndr/ndr.c:214(ndr_print_debug) &challenge: struct CHALLENGE_MESSAGE Signature : 'NTLMSSP' MessageType : NtLmChallenge (0x2) TargetNameLen : 0x0008 (8) TargetNameMaxLen : 0x0008 (8) TargetName : * TargetName : 'X009' NegotiateFlags : 0xe28a8295 (3800728213) 1: NTLMSSP_NEGOTIATE_UNICODE 0: NTLMSSP_NEGOTIATE_OEM 1: NTLMSSP_REQUEST_TARGET 1: NTLMSSP_NEGOTIATE_SIGN 0: NTLMSSP_NEGOTIATE_SEAL 0: NTLMSSP_NEGOTIATE_DATAGRAM 1: NTLMSSP_NEGOTIATE_LM_KEY 0: NTLMSSP_NEGOTIATE_NETWARE 1: NTLMSSP_NEGOTIATE_NTLM 0: NTLMSSP_NEGOTIATE_NT_ONLY 0: NTLMSSP_ANONYMOUS 0: NTLMSSP_NEGOTIATE_OEM_DOMAIN_SUPPLIED 0: NTLMSSP_NEGOTIATE_OEM_WORKSTATION_SUPPLIED 0: NTLMSSP_NEGOTIATE_THIS_IS_LOCAL_CALL 1: NTLMSSP_NEGOTIATE_ALWAYS_SIGN 0: NTLMSSP_TARGET_TYPE_DOMAIN 1: NTLMSSP_TARGET_TYPE_SERVER 0: NTLMSSP_TARGET_TYPE_SHARE 1: NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY 0: NTLMSSP_NEGOTIATE_IDENTIFY 0: NTLMSSP_REQUEST_NON_NT_SESSION_KEY 1: NTLMSSP_NEGOTIATE_TARGET_INFO 1: NTLMSSP_NEGOTIATE_VERSION 1: NTLMSSP_NEGOTIATE_128 1: NTLMSSP_NEGOTIATE_KEY_EXCH 1: NTLMSSP_NEGOTIATE_56 ServerChallenge : a9c3a66ed8e75f74 Reserved : 0000000000000000 TargetInfoLen : 0x0046 (70) TargetNameInfoMaxLen : 0x0046 (70) TargetInfo : * TargetInfo: struct AV_PAIR_LIST count : 0x00000005 (5) pair: ARRAY(5) pair: struct AV_PAIR AvId : MsvAvNbDomainName (0x2) AvLen : 0x0008 (8) Value : union ntlmssp_AvValue(case 0x2) AvNbDomainName : 'X009' pair: struct AV_PAIR AvId : MsvAvNbComputerName (0x1) AvLen : 0x0008 (8) Value : union ntlmssp_AvValue(case 0x1) AvNbComputerName : 'X009' pair: struct AV_PAIR AvId : MsvAvDnsDomainName (0x4) AvLen : 0x000c (12) Value : union ntlmssp_AvValue(case 0x4) AvDnsDomainName : 'hku.hk' pair: struct AV_PAIR AvId : MsvAvDnsComputerName (0x3) AvLen : 0x0016 (22) Value : union ntlmssp_AvValue(case 0x3) AvDnsComputerName : 'x009.hku.hk' pair: struct AV_PAIR AvId : MsvAvEOL (0x0) AvLen : 0x0000 (0) Value : union ntlmssp_AvValue(case 0x0) Version: struct VERSION ProductMajorVersion : UNKNOWN_ENUM_VALUE (0x58) ProductMinorVersion : NTLMSSP_WINDOWS_MINOR_VERSION_0 (0x0) ProductBuild : 0x0030 (48) Reserved : 300039 NTLMRevisionCurrent : UNKNOWN_ENUM_VALUE (0x0) [2011/09/12 14:00:50.264474, 5] lib/util.c:617(show_msg) [2011/09/12 14:00:50.264491, 5] lib/util.c:627(show_msg) size=256 smb_com=0x73 smb_rcls=22 smb_reh=0 smb_err=49152 smb_flg=136 smb_flg2=51203 smb_tid=65535 smb_pid=65279 smb_uid=101 smb_mid=192 smt_wct=4 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 156 (0x9C) smb_bcc=213 [2011/09/12 14:00:50.264576, 10] ../lib/util/util.c:278(_dump_data) [0000] A1 81 99 30 81 96 A0 03 0A 01 01 A1 0C 06 0A 2B ...0.... .......+ [0010] 06 01 04 01 82 37 02 02 0A A2 81 80 04 7E 4E 54 .....7.. .....~NT [0020] 4C 4D 53 53 50 00 02 00 00 00 08 00 08 00 30 00 LMSSP... ......0. [0030] 00 00 95 82 8A E2 A9 C3 A6 6E D8 E7 5F 74 00 00 ........ .n.._t.. [0040] 00 00 00 00 00 00 46 00 46 00 38 00 00 00 58 00 ......F. F.8...X. [0050] 30 00 30 00 39 00 02 00 08 00 58 00 30 00 30 00 0.0.9... ..X.0.0. [0060] 39 00 01 00 08 00 58 00 30 00 30 00 39 00 04 00 9.....X. 0.0.9... [0070] 0C 00 68 00 6B 00 75 00 2E 00 68 00 6B 00 03 00 ..h.k.u. ..h.k... [0080] 16 00 78 00 30 00 30 00 39 00 2E 00 68 00 6B 00 ..x.0.0. 9...h.k. [0090] 75 00 2E 00 68 00 6B 00 00 00 00 00 00 55 00 6E u...h.k. .....U.n [00A0] 00 69 00 78 00 00 00 53 00 61 00 6D 00 62 00 61 .i.x...S .a.m.b.a [00B0] 00 20 00 33 00 2E 00 35 00 2E 00 31 00 31 00 00 . .3...5 ...1.1.. [00C0] 00 57 00 4F 00 52 00 4B 00 47 00 52 00 4F 00 55 .W.O.R.K .G.R.O.U [00D0] 00 50 00 00 00 .P... [2011/09/12 14:00:50.265992, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 470 [2011/09/12 14:00:50.266033, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x1d6 [2011/09/12 14:00:50.266065, 3] smbd/process.c:1489(process_smb) Transaction 4 of length 474 (0 toread) [2011/09/12 14:00:50.266095, 5] lib/util.c:617(show_msg) [2011/09/12 14:00:50.266117, 5] lib/util.c:627(show_msg) size=470 smb_com=0x73 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=24 smb_flg2=51207 smb_tid=65535 smb_pid=65279 smb_uid=101 smb_mid=256 smt_wct=12 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]=16644 (0x4104) smb_vwv[ 3]= 50 (0x32) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 406 (0x196) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_vwv[10]= 212 (0xD4) smb_vwv[11]=40960 (0xA000) smb_bcc=411 [2011/09/12 14:00:50.266279, 10] ../lib/util/util.c:278(_dump_data) [0000] A1 82 01 92 30 82 01 8E A2 82 01 8A 04 82 01 86 ....0... ........ [0010] 4E 54 4C 4D 53 53 50 00 03 00 00 00 18 00 18 00 NTLMSSP. ........ [0020] 7C 00 00 00 E2 00 E2 00 94 00 00 00 12 00 12 00 |....... ........ [0030] 58 00 00 00 0A 00 0A 00 6A 00 00 00 08 00 08 00 X....... j....... [0040] 74 00 00 00 10 00 10 00 76 01 00 00 15 82 88 E2 t....... v....... [0050] 06 01 B1 1D 00 00 00 0F 3E 0C 60 C6 E8 42 EE BA ........ >.`..B.. [0060] 7C 64 60 78 EB D7 8D C7 77 00 6F 00 72 00 6B 00 |d`x.... w.o.r.k. [0070] 67 00 72 00 6F 00 75 00 70 00 75 00 73 00 65 00 g.r.o.u. p.u.s.e. [0080] 72 00 30 00 58 00 31 00 38 00 31 00 00 00 00 00 r.0.X.1. 8.1..... [0090] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [00A0] 00 00 00 00 8A 70 75 56 AD F1 82 DE 90 B3 9D 72 .....puV .......r [00B0] E1 AE F9 C5 01 01 00 00 00 00 00 00 4D E3 47 52 ........ ....M.GR [00C0] 11 71 CC 01 E2 A6 CF 66 14 59 C8 6F 00 00 00 00 .q.....f .Y.o.... [00D0] 02 00 08 00 58 00 30 00 30 00 39 00 01 00 08 00 ....X.0. 0.9..... [00E0] 58 00 30 00 30 00 39 00 04 00 0C 00 68 00 6B 00 X.0.0.9. ....h.k. [00F0] 75 00 2E 00 68 00 6B 00 03 00 16 00 78 00 30 00 u...h.k. ....x.0. [0100] 30 00 39 00 2E 00 68 00 6B 00 75 00 2E 00 68 00 0.9...h. k.u...h. [0110] 6B 00 08 00 30 00 30 00 00 00 00 00 00 00 01 00 k...0.0. ........ [0120] 00 00 00 20 00 00 10 D4 D9 7A D7 00 EF BA 32 9C ... .... .z....2. [0130] C5 2E 3C 97 63 94 59 F3 21 3A B9 2E 75 C8 20 E1 ..<.c.Y. !:..u. . [0140] D7 00 B2 DF 8E 49 0A 00 10 00 00 00 00 00 00 00 .....I.. ........ [0150] 00 00 00 00 00 00 00 00 00 00 09 00 20 00 63 00 ........ .... .c. [0160] 69 00 66 00 73 00 2F 00 31 00 34 00 37 00 2E 00 i.f.s./. 1.4.7... [0170] 38 00 2E 00 31 00 30 00 31 00 2E 00 39 00 00 00 8...1.0. 1...9... [0180] 00 00 00 00 00 00 5E 0E 24 FD 16 C3 75 30 98 BB ......^. $...u0.. [0190] 79 93 66 22 E5 42 00 00 00 00 00 y.f".B.. ... [2011/09/12 14:00:50.266842, 3] smbd/process.c:1298(switch_message) switch message SMBsesssetupX (pid 446) conn 0x0 [2011/09/12 14:00:50.266864, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.266885, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.266905, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.266947, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2011/09/12 14:00:50.266970, 3] smbd/sesssetup.c:1458(reply_sesssetup_and_X) wct=12 flg2=0xc807 [2011/09/12 14:00:50.266990, 2] smbd/sesssetup.c:1413(setup_new_vc_session) setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources. [2011/09/12 14:00:50.267011, 3] smbd/sesssetup.c:1212(reply_sesssetup_and_X_spnego) Doing spnego session setup [2011/09/12 14:00:50.267033, 3] smbd/sesssetup.c:1254(reply_sesssetup_and_X_spnego) NativeOS=[] NativeLanMan=[] PrimaryDomain=[] [2011/09/12 14:00:50.267088, 1] ../librpc/ndr/ndr.c:214(ndr_print_debug) &authenticate: struct AUTHENTICATE_MESSAGE Signature : 'NTLMSSP' MessageType : NtLmAuthenticate (3) LmChallengeResponseLen : 0x0018 (24) LmChallengeResponseMaxLen: 0x0018 (24) LmChallengeResponse : * LmChallengeResponse : union ntlmssp_LM_RESPONSE(case 24) v1: struct LM_RESPONSE Response : 000000000000000000000000000000000000000000000000 NtChallengeResponseLen : 0x00e2 (226) NtChallengeResponseMaxLen: 0x00e2 (226) NtChallengeResponse : * NtChallengeResponse : union ntlmssp_NTLM_RESPONSE(case 226) v2: struct NTLMv2_RESPONSE Response : 8a707556adf182de90b39d72e1aef9c5 Challenge: struct NTLMv2_CLIENT_CHALLENGE RespType : 0x01 (1) HiRespType : 0x01 (1) Reserved1 : 0x0000 (0) Reserved2 : 0x00000000 (0) TimeStamp : Mon Sep 12 14:00:50 2011 HKT ChallengeFromClient : e2a6cf661459c86f Reserved3 : 0x00000000 (0) AvPairs: struct AV_PAIR_LIST count : 0x00000008 (8) pair: ARRAY(8) pair: struct AV_PAIR AvId : MsvAvNbDomainName (0x2) AvLen : 0x0008 (8) Value : union ntlmssp_AvValue(case 0x2) AvNbDomainName : 'X009' pair: struct AV_PAIR AvId : MsvAvNbComputerName (0x1) AvLen : 0x0008 (8) Value : union ntlmssp_AvValue(case 0x1) AvNbComputerName : 'X009' pair: struct AV_PAIR AvId : MsvAvDnsDomainName (0x4) AvLen : 0x000c (12) Value : union ntlmssp_AvValue(case 0x4) AvDnsDomainName : 'hku.hk' pair: struct AV_PAIR AvId : MsvAvDnsComputerName (0x3) AvLen : 0x0016 (22) Value : union ntlmssp_AvValue(case 0x3) AvDnsComputerName : 'x009.hku.hk' pair: struct AV_PAIR AvId : MsAvRestrictions (0x8) AvLen : 0x0030 (48) Value : union ntlmssp_AvValue(case 0x8) AvRestrictions: struct Restriction_Encoding Size : 0x00000030 (48) Z4 : 0x00000000 (0) IntegrityLevel : 0x00000001 (1) SubjectIntegrityLevel : 0x00002000 (8192) MachineId : 10d4d97ad700efba329cc52e3c97639459f3213ab92e75c820e1d700b2df8e49 pair: struct AV_PAIR AvId : MsvChannelBindings (0xA) AvLen : 0x0010 (16) Value : union ntlmssp_AvValue(case 0xA) ChannelBindings : 00000000000000000000000000000000 pair: struct AV_PAIR AvId : MsvAvTargetName (0x9) AvLen : 0x0020 (32) Value : union ntlmssp_AvValue(case 0x9) AvTargetName : 'cifs/147.8.101.9' pair: struct AV_PAIR AvId : MsvAvEOL (0x0) AvLen : 0x0000 (0) Value : union ntlmssp_AvValue(case 0x0) DomainNameLen : 0x0012 (18) DomainNameMaxLen : 0x0012 (18) DomainName : * DomainName : 'workgroup' UserNameLen : 0x000a (10) UserNameMaxLen : 0x000a (10) UserName : * UserName : 'user0' WorkstationLen : 0x0008 (8) WorkstationMaxLen : 0x0008 (8) Workstation : * Workstation : 'X181' EncryptedRandomSessionKeyLen: 0x0010 (16) EncryptedRandomSessionKeyMaxLen: 0x0010 (16) EncryptedRandomSessionKey: * EncryptedRandomSessionKey: DATA_BLOB length=16 [2011/09/12 14:00:50.267866, 10] ../lib/util/util.c:278(_dump_data) [0000] 5E 0E 24 FD 16 C3 75 30 98 BB 79 93 66 22 E5 42 ^.$...u0 ..y.f".B NegotiateFlags : 0xe2888215 (3800597013) 1: NTLMSSP_NEGOTIATE_UNICODE 0: NTLMSSP_NEGOTIATE_OEM 1: NTLMSSP_REQUEST_TARGET 1: NTLMSSP_NEGOTIATE_SIGN 0: NTLMSSP_NEGOTIATE_SEAL 0: NTLMSSP_NEGOTIATE_DATAGRAM 0: NTLMSSP_NEGOTIATE_LM_KEY 0: NTLMSSP_NEGOTIATE_NETWARE 1: NTLMSSP_NEGOTIATE_NTLM 0: NTLMSSP_NEGOTIATE_NT_ONLY 0: NTLMSSP_ANONYMOUS 0: NTLMSSP_NEGOTIATE_OEM_DOMAIN_SUPPLIED 0: NTLMSSP_NEGOTIATE_OEM_WORKSTATION_SUPPLIED 0: NTLMSSP_NEGOTIATE_THIS_IS_LOCAL_CALL 1: NTLMSSP_NEGOTIATE_ALWAYS_SIGN 0: NTLMSSP_TARGET_TYPE_DOMAIN 0: NTLMSSP_TARGET_TYPE_SERVER 0: NTLMSSP_TARGET_TYPE_SHARE 1: NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY 0: NTLMSSP_NEGOTIATE_IDENTIFY 0: NTLMSSP_REQUEST_NON_NT_SESSION_KEY 1: NTLMSSP_NEGOTIATE_TARGET_INFO 1: NTLMSSP_NEGOTIATE_VERSION 1: NTLMSSP_NEGOTIATE_128 1: NTLMSSP_NEGOTIATE_KEY_EXCH 1: NTLMSSP_NEGOTIATE_56 Version: struct VERSION ProductMajorVersion : NTLMSSP_WINDOWS_MAJOR_VERSION_6 (6) ProductMinorVersion : NTLMSSP_WINDOWS_MINOR_VERSION_1 (1) ProductBuild : 0x1db1 (7601) Reserved: ARRAY(3) [0] : 0x00 (0) [1] : 0x00 (0) [2] : 0x00 (0) NTLMRevisionCurrent : NTLMSSP_REVISION_W2K3 (15) [2011/09/12 14:00:50.268168, 3] libsmb/ntlmssp.c:747(ntlmssp_server_auth) Got user=[user0] domain=[workgroup] workstation=[X181] len1=24 len2=226 [2011/09/12 14:00:50.268215, 6] param/loadparm.c:7144(lp_file_list_changed) lp_file_list_changed() file /10/samba-3.5.11/lib/smb.conf -> /10/samba-3.5.11/lib/smb.conf last mod_time: Mon Sep 12 13:53:53 2011 [2011/09/12 14:00:50.268268, 5] auth/auth_util.c:211(make_user_info_map) Mapping user [workgroup]\[user0] from workstation [X181] [2011/09/12 14:00:50.268295, 5] auth/auth_util.c:232(make_user_info_map) Mapped domain from [workgroup] to [X009] for user [user0] from workstation [X181] [2011/09/12 14:00:50.268317, 5] auth/auth_util.c:122(make_user_info) attempting to make a user_info for user0 (user0) [2011/09/12 14:00:50.268337, 5] auth/auth_util.c:132(make_user_info) making strings for user0's user_info struct [2011/09/12 14:00:50.268358, 5] auth/auth_util.c:164(make_user_info) making blobs for user0's user_info struct [2011/09/12 14:00:50.268379, 10] auth/auth_util.c:182(make_user_info) made an encrypted user_info for user0 (user0) [2011/09/12 14:00:50.268399, 3] auth/auth.c:216(check_ntlm_password) check_ntlm_password: Checking password for unmapped user [workgroup]\[user0]@[X181] with the new password interface [2011/09/12 14:00:50.268422, 3] auth/auth.c:219(check_ntlm_password) check_ntlm_password: mapped user is: [X009]\[user0]@[X181] [2011/09/12 14:00:50.268442, 10] auth/auth.c:228(check_ntlm_password) check_ntlm_password: auth_context challenge created by random [2011/09/12 14:00:50.268462, 10] auth/auth.c:230(check_ntlm_password) challenge is: [2011/09/12 14:00:50.268481, 5] ../lib/util/util.c:278(_dump_data) [0000] A9 C3 A6 6E D8 E7 5F 74 ...n.._t [2011/09/12 14:00:50.268518, 10] auth/auth.c:256(check_ntlm_password) check_ntlm_password: guest had nothing to say [2011/09/12 14:00:50.268541, 8] lib/util.c:1872(is_myname) is_myname("X009") returns 1 [2011/09/12 14:00:50.268563, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.268584, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.268604, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.268625, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.268645, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.268686, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username user0, was [2011/09/12 14:00:50.268709, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain X009, was [2011/09/12 14:00:50.268730, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2011/09/12 14:00:50.268750, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2011/09/12 14:00:50.268772, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.268796, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\x009\user0, was [2011/09/12 14:00:50.268818, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive F:, was NULL [2011/09/12 14:00:50.268839, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2011/09/12 14:00:50.268861, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.268884, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\x009\user0\profile, was [2011/09/12 14:00:50.268906, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2011/09/12 14:00:50.268944, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.268966, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.268986, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.269006, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.269026, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.269060, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.269084, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.269106, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1002 [2011/09/12 14:00:50.269130, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1002 from rid 1002 [2011/09/12 14:00:50.269162, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.269183, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.269203, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.269224, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.269243, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.269274, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: maximum password age, val: -1 [2011/09/12 14:00:50.269298, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.269321, 5] lib/username.c:133(Get_Pwnam_alloc) Finding user user0 [2011/09/12 14:00:50.269341, 5] lib/username.c:77(Get_Pwnam_internals) Trying _Get_Pwnam(), username as lowercase is user0 [2011/09/12 14:00:50.269364, 5] lib/username.c:110(Get_Pwnam_internals) Get_Pwnam_internals did find user [user0]! [2011/09/12 14:00:50.269414, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.269438, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.269458, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.269479, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.269498, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.269530, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.269554, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.269581, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username user0, was [2011/09/12 14:00:50.269603, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain X009, was [2011/09/12 14:00:50.269623, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2011/09/12 14:00:50.269643, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2011/09/12 14:00:50.269665, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.269690, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\x009\user0, was [2011/09/12 14:00:50.269711, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive F:, was NULL [2011/09/12 14:00:50.269732, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2011/09/12 14:00:50.269766, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.269791, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\x009\user0\profile, was [2011/09/12 14:00:50.269813, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2011/09/12 14:00:50.269835, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.269856, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.269876, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.269897, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.269916, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.269949, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.269973, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.269995, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1002 [2011/09/12 14:00:50.270019, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1002 from rid 1002 [2011/09/12 14:00:50.270062, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = IDMAP/SID2GID/S-1-5-21-4090241009-3592364035-1401512610-513 couldn't be found [2011/09/12 14:00:50.270100, 10] passdb/lookup_sid.c:1511(sid_to_gid) winbind failed to find a gid for sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.270125, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.270146, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.270167, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.270187, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.270207, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.270236, 5] passdb/pdb_interface.c:1473(lookup_global_sam_rid) lookup_global_sam_rid: looking up RID 513. [2011/09/12 14:00:50.270258, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2011/09/12 14:00:50.270279, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2011/09/12 14:00:50.270299, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2011/09/12 14:00:50.270319, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.270339, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.270372, 5] passdb/pdb_tdb.c:609(tdbsam_getsampwrid) pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201. [2011/09/12 14:00:50.270440, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.270464, 5] passdb/pdb_interface.c:1536(lookup_global_sam_rid) Can't find a unix id for an unmapped group [2011/09/12 14:00:50.270487, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.270508, 10] passdb/lookup_sid.c:1283(legacy_sid_to_gid) LEGACY: mapping failed for sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.270532, 10] passdb/pdb_get_set.c:595(pdb_set_group_sid) pdb_set_group_sid: setting group sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.270574, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.270597, 9] passdb/passdb.c:2182(pdb_update_autolock_flag) pdb_update_autolock_flag: Account user0 not autolocked, no check needed [2011/09/12 14:00:50.270618, 4] ../libcli/auth/ntlm_check.c:351(ntlm_password_check) ntlm_password_check: Checking NTLMv2 password with domain [workgroup] [2011/09/12 14:00:50.270656, 4] auth/auth_sam.c:180(sam_account_ok) sam_account_ok: Checking SMB password for user user0 [2011/09/12 14:00:50.270690, 5] auth/auth_sam.c:162(logon_hours_ok) logon_hours_ok: user user0 allowed to logon at this time (Mon Sep 12 06:00:50 2011 ) [2011/09/12 14:00:50.270716, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.270737, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.270757, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.270777, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.270797, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.270829, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: maximum password age, val: -1 [2011/09/12 14:00:50.270854, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.270876, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.270897, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.270917, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.270937, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.270956, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.270988, 5] lib/username.c:133(Get_Pwnam_alloc) Finding user user0 [2011/09/12 14:00:50.271008, 5] lib/username.c:77(Get_Pwnam_internals) Trying _Get_Pwnam(), username as lowercase is user0 [2011/09/12 14:00:50.271030, 5] lib/username.c:110(Get_Pwnam_internals) Get_Pwnam_internals did find user [user0]! [2011/09/12 14:00:50.271052, 5] lib/username.c:133(Get_Pwnam_alloc) Finding user user0 [2011/09/12 14:00:50.271072, 5] lib/username.c:77(Get_Pwnam_internals) Trying _Get_Pwnam(), username as lowercase is user0 [2011/09/12 14:00:50.271093, 5] lib/username.c:110(Get_Pwnam_internals) Get_Pwnam_internals did find user [user0]! [2011/09/12 14:00:50.271153, 10] lib/system_smbd.c:173(sys_getgrouplist) sys_getgrouplist: user [user0] [2011/09/12 14:00:50.271230, 5] auth/auth_util.c:649(make_server_info_sam) make_server_info_sam: made server info for user user0 -> user0 [2011/09/12 14:00:50.271257, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.271280, 3] auth/auth.c:265(check_ntlm_password) check_ntlm_password: sam authentication for user [user0] succeeded [2011/09/12 14:00:50.271301, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.271322, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.271342, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.271362, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.271381, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.271410, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.271431, 5] auth/auth.c:291(check_ntlm_password) check_ntlm_password: PAM Account for user [user0] succeeded [2011/09/12 14:00:50.271464, 2] auth/auth.c:304(check_ntlm_password) check_ntlm_password: authentication for user [user0] -> [user0] -> [user0] succeeded [2011/09/12 14:00:50.271485, 5] auth/auth_util.c:2119(free_user_info) attempting to free (and zero) a user_info structure [2011/09/12 14:00:50.271505, 10] auth/auth_util.c:2123(free_user_info) structure was created for user0 [2011/09/12 14:00:50.271526, 10] auth/token_util.c:356(create_local_nt_token) Create local NT token for S-1-5-21-4090241009-3592364035-1401512610-1002 [2011/09/12 14:00:50.271563, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = IDMAP/SID2GID/S-1-5-32-544 couldn't be found [2011/09/12 14:00:50.271593, 10] passdb/lookup_sid.c:1511(sid_to_gid) winbind failed to find a gid for sid S-1-5-32-544 [2011/09/12 14:00:50.271616, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.271637, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.271657, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.271677, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.271697, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.271769, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.271792, 10] passdb/lookup_sid.c:1256(legacy_sid_to_gid) LEGACY: mapping failed for sid S-1-5-32-544 [2011/09/12 14:00:50.271815, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.271836, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.271857, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.271877, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.271897, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.271938, 3] auth/token_util.c:436(create_local_nt_token) Failed to fetch domain sid for WORKGROUP [2011/09/12 14:00:50.271962, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.271994, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = IDMAP/SID2GID/S-1-5-32-545 couldn't be found [2011/09/12 14:00:50.272023, 10] passdb/lookup_sid.c:1511(sid_to_gid) winbind failed to find a gid for sid S-1-5-32-545 [2011/09/12 14:00:50.272046, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.272066, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.272087, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.272107, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.272126, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.272192, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.272216, 10] passdb/lookup_sid.c:1256(legacy_sid_to_gid) LEGACY: mapping failed for sid S-1-5-32-545 [2011/09/12 14:00:50.272238, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.272267, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.272287, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.272308, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.272327, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.272374, 3] auth/token_util.c:467(create_local_nt_token) Failed to fetch domain sid for WORKGROUP [2011/09/12 14:00:50.272398, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.272420, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.272440, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.272460, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.272481, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.272500, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.272723, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.272757, 3] lib/privileges.c:63(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-21-4090241009-3592364035-1401512610-1002] [2011/09/12 14:00:50.272788, 3] lib/privileges.c:63(get_privileges) get_privileges: No privileges assigned to SID [S-1-22-2-100] [2011/09/12 14:00:50.272816, 5] lib/privileges.c:128(get_privileges_for_sids) get_privileges_for_sids: sid = S-1-1-0 Privilege set: SE_PRIV 0x0 0x0 0x0 0x0 [2011/09/12 14:00:50.272854, 3] lib/privileges.c:63(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-2] [2011/09/12 14:00:50.272880, 3] lib/privileges.c:63(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-11] [2011/09/12 14:00:50.272912, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = IDMAP/SID2GID/S-1-1-0 couldn't be found [2011/09/12 14:00:50.272941, 10] passdb/lookup_sid.c:1511(sid_to_gid) winbind failed to find a gid for sid S-1-1-0 [2011/09/12 14:00:50.272963, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.272984, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.273005, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.273025, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.273045, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.273109, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.273133, 10] passdb/lookup_sid.c:1256(legacy_sid_to_gid) LEGACY: mapping failed for sid S-1-1-0 [2011/09/12 14:00:50.273154, 10] auth/auth_util.c:753(create_local_token) Could not convert SID S-1-1-0 to gid, ignoring it [2011/09/12 14:00:50.273185, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = IDMAP/SID2GID/S-1-5-2 couldn't be found [2011/09/12 14:00:50.273213, 10] passdb/lookup_sid.c:1511(sid_to_gid) winbind failed to find a gid for sid S-1-5-2 [2011/09/12 14:00:50.273235, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.273257, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.273278, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.273298, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.273318, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.273381, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.273404, 10] passdb/lookup_sid.c:1256(legacy_sid_to_gid) LEGACY: mapping failed for sid S-1-5-2 [2011/09/12 14:00:50.273426, 10] auth/auth_util.c:753(create_local_token) Could not convert SID S-1-5-2 to gid, ignoring it [2011/09/12 14:00:50.273470, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = IDMAP/SID2GID/S-1-5-11 couldn't be found [2011/09/12 14:00:50.273498, 10] passdb/lookup_sid.c:1511(sid_to_gid) winbind failed to find a gid for sid S-1-5-11 [2011/09/12 14:00:50.273521, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.273542, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.273562, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.273583, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.273602, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.273670, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.273694, 10] passdb/lookup_sid.c:1256(legacy_sid_to_gid) LEGACY: mapping failed for sid S-1-5-11 [2011/09/12 14:00:50.273716, 10] auth/auth_util.c:753(create_local_token) Could not convert SID S-1-5-11 to gid, ignoring it [2011/09/12 14:00:50.273739, 10] auth/token_util.c:531(debug_nt_user_token) NT user token of user S-1-5-21-4090241009-3592364035-1401512610-1002 contains 6 SIDs SID[ 0]: S-1-5-21-4090241009-3592364035-1401512610-1002 SID[ 1]: S-1-22-2-100 SID[ 2]: S-1-1-0 SID[ 3]: S-1-5-2 SID[ 4]: S-1-5-11 SID[ 5]: S-1-22-1-1000 SE_PRIV 0x0 0x0 0x0 0x0 [2011/09/12 14:00:50.273813, 10] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 1000 Primary group is 100 and contains 1 supplementary groups Group[ 0]: 100 [2011/09/12 14:00:50.273846, 10] auth/auth_ntlmssp.c:140(auth_ntlmssp_check_password) Got NT session key of length 16 [2011/09/12 14:00:50.273866, 10] auth/auth_ntlmssp.c:147(auth_ntlmssp_check_password) Got LM session key of length 8 [2011/09/12 14:00:50.273887, 10] libsmb/ntlmssp.c:853(ntlmssp_server_auth) ntlmssp_server_auth: Using unmodified nt session key. [2011/09/12 14:00:50.273916, 3] libsmb/ntlmssp_sign.c:343(ntlmssp_sign_init) NTLMSSP Sign/Seal - Initialising with flags: [2011/09/12 14:00:50.273937, 3] libsmb/ntlmssp.c:65(debug_ntlmssp_flags) Got NTLMSSP neg_flags=0xe2088215 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_NEGOTIATE_VERSION NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH NTLMSSP_NEGOTIATE_56 [2011/09/12 14:00:50.274016, 10] smbd/password.c:278(register_existing_vuid) register_existing_vuid: (1000,100) user0 user0 X009 guest=0 [2011/09/12 14:00:50.274038, 3] smbd/password.c:282(register_existing_vuid) register_existing_vuid: User name: user0 Real name: [2011/09/12 14:00:50.274059, 3] smbd/password.c:292(register_existing_vuid) register_existing_vuid: UNIX uid 1000 is UNIX user user0, and will be vuid 101 [2011/09/12 14:00:50.274089, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked) Locking key 49442F3434362F313031 [2011/09/12 14:00:50.274115, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked) Allocated locked data 0x0xb8122c50 [2011/09/12 14:00:50.274187, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr) Unlocking key 49442F3434362F313031 [2011/09/12 14:00:50.274223, 7] param/loadparm.c:9410(lp_servicenumber) lp_servicenumber: couldn't find user0 [2011/09/12 14:00:50.274245, 5] lib/username.c:133(Get_Pwnam_alloc) Finding user user0 [2011/09/12 14:00:50.274264, 5] lib/username.c:77(Get_Pwnam_internals) Trying _Get_Pwnam(), username as lowercase is user0 [2011/09/12 14:00:50.274286, 5] lib/username.c:110(Get_Pwnam_internals) Get_Pwnam_internals did find user [user0]! [2011/09/12 14:00:50.274305, 3] smbd/password.c:223(register_homes_share) Adding homes service for user 'user0' using home directory: '/home/user0' [2011/09/12 14:00:50.274329, 7] param/loadparm.c:9410(lp_servicenumber) lp_servicenumber: couldn't find homes [2011/09/12 14:00:50.274381, 6] param/loadparm.c:7144(lp_file_list_changed) lp_file_list_changed() file /10/samba-3.5.11/lib/smb.conf -> /10/samba-3.5.11/lib/smb.conf last mod_time: Mon Sep 12 13:53:53 2011 [2011/09/12 14:00:50.274443, 5] lib/util.c:617(show_msg) [2011/09/12 14:00:50.274459, 5] lib/util.c:627(show_msg) size=108 smb_com=0x73 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51203 smb_tid=65535 smb_pid=65279 smb_uid=101 smb_mid=256 smt_wct=4 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 9 (0x9) smb_bcc=65 [2011/09/12 14:00:50.274542, 10] ../lib/util/util.c:278(_dump_data) [0000] A1 07 30 05 A0 03 0A 01 00 55 00 6E 00 69 00 78 ..0..... .U.n.i.x [0010] 00 00 00 53 00 61 00 6D 00 62 00 61 00 20 00 33 ...S.a.m .b.a. .3 [0020] 00 2E 00 35 00 2E 00 31 00 31 00 00 00 57 00 4F ...5...1 .1...W.O [0030] 00 52 00 4B 00 47 00 52 00 4F 00 55 00 50 00 00 .R.K.G.R .O.U.P.. [0040] 00 . [2011/09/12 14:00:50.275479, 10] lib/util_sock.c:731(read_smb_length_return_keepalive) got smb length of 96 [2011/09/12 14:00:50.275519, 6] smbd/process.c:1486(process_smb) got message type 0x0 of len 0x60 [2011/09/12 14:00:50.275550, 3] smbd/process.c:1489(process_smb) Transaction 5 of length 100 (0 toread) [2011/09/12 14:00:50.275580, 5] lib/util.c:617(show_msg) [2011/09/12 14:00:50.275602, 5] lib/util.c:627(show_msg) size=96 smb_com=0x75 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=24 smb_flg2=51207 smb_tid=0 smb_pid=65279 smb_uid=101 smb_mid=320 smt_wct=4 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 96 (0x60) smb_vwv[ 2]= 8 (0x8) smb_vwv[ 3]= 1 (0x1) smb_bcc=53 [2011/09/12 14:00:50.275726, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 5C 00 5C 00 31 00 34 00 37 00 2E 00 38 00 2E .\.\.1.4 .7...8.. [0010] 00 31 00 30 00 31 00 2E 00 39 00 5C 00 53 00 4F .1.0.1.. .9.\.S.O [0020] 00 46 00 54 00 57 00 41 00 52 00 45 00 00 00 3F .F.T.W.A .R.E...? [0030] 3F 3F 3F 3F 00 ????. [2011/09/12 14:00:50.275816, 3] smbd/process.c:1298(switch_message) switch message SMBtconX (pid 446) conn 0x0 [2011/09/12 14:00:50.275837, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.275858, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.275877, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.275905, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2011/09/12 14:00:50.275934, 4] smbd/reply.c:786(reply_tcon_and_X) Client requested device type [?????] for share [SOFTWARE] [2011/09/12 14:00:50.275968, 5] smbd/service.c:1227(make_connection) making a connection to 'normal' service software [2011/09/12 14:00:50.275992, 3] lib/access.c:365(only_ipaddrs_in_list) only_ipaddrs_in_list: list has non-ip address (147.8.101.) [2011/09/12 14:00:50.276012, 3] lib/access.c:399(check_access) check_access: hostnames in host allow/deny list. [2011/09/12 14:00:50.276039, 2] lib/access.c:409(check_access) Allowed connection from 147.8.101.181 (147.8.101.181) [2011/09/12 14:00:50.276074, 3] lib/util_sid.c:228(string_to_sid) string_to_sid: Sid root does not start with 'S-'. [2011/09/12 14:00:50.276103, 10] passdb/lookup_sid.c:69(lookup_name) lookup_name: X009\root => X009 (domain), root (name) [2011/09/12 14:00:50.276124, 10] passdb/lookup_sid.c:70(lookup_name) lookup_name: flags = 0x073 [2011/09/12 14:00:50.276147, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.276168, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.276189, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.276222, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.276242, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.276287, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username root, was [2011/09/12 14:00:50.276309, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain X009, was [2011/09/12 14:00:50.276331, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2011/09/12 14:00:50.276352, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2011/09/12 14:00:50.276374, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.276398, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\x009\root, was [2011/09/12 14:00:50.276420, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive F:, was NULL [2011/09/12 14:00:50.276441, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2011/09/12 14:00:50.276463, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.276487, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\x009\root\profile, was [2011/09/12 14:00:50.276508, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2011/09/12 14:00:50.276531, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.276552, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.276572, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.276592, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.276612, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.276645, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.276669, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.276691, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1000 [2011/09/12 14:00:50.276715, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1000 from rid 1000 [2011/09/12 14:00:50.276746, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.276767, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.276787, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.276808, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.276827, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.276859, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: maximum password age, val: -1 [2011/09/12 14:00:50.276884, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.276906, 5] lib/username.c:133(Get_Pwnam_alloc) Finding user root [2011/09/12 14:00:50.276926, 5] lib/username.c:77(Get_Pwnam_internals) Trying _Get_Pwnam(), username as lowercase is root [2011/09/12 14:00:50.276973, 5] lib/username.c:110(Get_Pwnam_internals) Get_Pwnam_internals did find user [root]! [2011/09/12 14:00:50.277024, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.277047, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.277081, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.277101, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.277121, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.277153, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.277178, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.277205, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username root, was [2011/09/12 14:00:50.277226, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain X009, was [2011/09/12 14:00:50.277246, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2011/09/12 14:00:50.277267, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2011/09/12 14:00:50.277288, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.277313, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\x009\root, was [2011/09/12 14:00:50.277334, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive F:, was NULL [2011/09/12 14:00:50.277356, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2011/09/12 14:00:50.277377, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.277401, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\x009\root\profile, was [2011/09/12 14:00:50.277423, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2011/09/12 14:00:50.277445, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.277466, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.277487, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.277508, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.277527, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.277560, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.277585, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.277607, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1000 [2011/09/12 14:00:50.277631, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1000 from rid 1000 [2011/09/12 14:00:50.277674, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = IDMAP/SID2GID/S-1-5-21-4090241009-3592364035-1401512610-513 couldn't be found [2011/09/12 14:00:50.277710, 10] passdb/lookup_sid.c:1511(sid_to_gid) winbind failed to find a gid for sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.277734, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.277755, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.277776, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.277796, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.277815, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.277857, 5] passdb/pdb_interface.c:1473(lookup_global_sam_rid) lookup_global_sam_rid: looking up RID 513. [2011/09/12 14:00:50.277879, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2011/09/12 14:00:50.277900, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2011/09/12 14:00:50.277920, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2011/09/12 14:00:50.277940, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.277960, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.277996, 5] passdb/pdb_tdb.c:609(tdbsam_getsampwrid) pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201. [2011/09/12 14:00:50.278063, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.278087, 5] passdb/pdb_interface.c:1536(lookup_global_sam_rid) Can't find a unix id for an unmapped group [2011/09/12 14:00:50.278110, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.278131, 10] passdb/lookup_sid.c:1283(legacy_sid_to_gid) LEGACY: mapping failed for sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.278155, 10] passdb/pdb_get_set.c:595(pdb_set_group_sid) pdb_set_group_sid: setting group sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.278184, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.278214, 3] lib/util_sid.c:228(string_to_sid) string_to_sid: Sid root does not start with 'S-'. [2011/09/12 14:00:50.278237, 10] passdb/lookup_sid.c:69(lookup_name) lookup_name: X009\root => X009 (domain), root (name) [2011/09/12 14:00:50.278258, 10] passdb/lookup_sid.c:70(lookup_name) lookup_name: flags = 0x073 [2011/09/12 14:00:50.278279, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.278300, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.278320, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.278341, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.278360, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.278396, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username root, was [2011/09/12 14:00:50.278418, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain X009, was [2011/09/12 14:00:50.278439, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2011/09/12 14:00:50.278459, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2011/09/12 14:00:50.278481, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.278505, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\x009\root, was [2011/09/12 14:00:50.278527, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive F:, was NULL [2011/09/12 14:00:50.278548, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2011/09/12 14:00:50.278569, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.278593, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\x009\root\profile, was [2011/09/12 14:00:50.278615, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2011/09/12 14:00:50.278637, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.278671, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.278693, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.278714, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.278733, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.278765, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.278790, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.278812, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1000 [2011/09/12 14:00:50.278836, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1000 from rid 1000 [2011/09/12 14:00:50.278867, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.278888, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.278909, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.278929, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.278949, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.278981, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: maximum password age, val: -1 [2011/09/12 14:00:50.279006, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.279028, 5] lib/username.c:133(Get_Pwnam_alloc) Finding user root [2011/09/12 14:00:50.279048, 5] lib/username.c:77(Get_Pwnam_internals) Trying _Get_Pwnam(), username as lowercase is root [2011/09/12 14:00:50.279070, 5] lib/username.c:110(Get_Pwnam_internals) Get_Pwnam_internals did find user [root]! [2011/09/12 14:00:50.279113, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.279136, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.279157, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.279177, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.279197, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.279228, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.279252, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.279278, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username root, was [2011/09/12 14:00:50.279299, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain X009, was [2011/09/12 14:00:50.279320, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2011/09/12 14:00:50.279340, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2011/09/12 14:00:50.279362, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.279386, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\x009\root, was [2011/09/12 14:00:50.279407, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive F:, was NULL [2011/09/12 14:00:50.279428, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2011/09/12 14:00:50.279450, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.279487, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\x009\root\profile, was [2011/09/12 14:00:50.279510, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2011/09/12 14:00:50.279532, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.279553, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.279573, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.279593, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.279613, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.279647, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.279672, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.279694, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1000 [2011/09/12 14:00:50.279718, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1000 from rid 1000 [2011/09/12 14:00:50.279761, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = IDMAP/SID2GID/S-1-5-21-4090241009-3592364035-1401512610-513 couldn't be found [2011/09/12 14:00:50.279796, 10] passdb/lookup_sid.c:1511(sid_to_gid) winbind failed to find a gid for sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.279821, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.279843, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.279864, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.279884, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.279903, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.279932, 5] passdb/pdb_interface.c:1473(lookup_global_sam_rid) lookup_global_sam_rid: looking up RID 513. [2011/09/12 14:00:50.279954, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2011/09/12 14:00:50.279975, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2011/09/12 14:00:50.279995, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2011/09/12 14:00:50.280015, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.280034, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.280068, 5] passdb/pdb_tdb.c:609(tdbsam_getsampwrid) pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201. [2011/09/12 14:00:50.280134, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.280157, 5] passdb/pdb_interface.c:1536(lookup_global_sam_rid) Can't find a unix id for an unmapped group [2011/09/12 14:00:50.280180, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.280201, 10] passdb/lookup_sid.c:1283(legacy_sid_to_gid) LEGACY: mapping failed for sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.280224, 10] passdb/pdb_get_set.c:595(pdb_set_group_sid) pdb_set_group_sid: setting group sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.280262, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.280291, 3] lib/util_sid.c:228(string_to_sid) string_to_sid: Sid nobody does not start with 'S-'. [2011/09/12 14:00:50.280328, 10] passdb/lookup_sid.c:69(lookup_name) lookup_name: X009\nobody => X009 (domain), nobody (name) [2011/09/12 14:00:50.280349, 10] passdb/lookup_sid.c:70(lookup_name) lookup_name: flags = 0x073 [2011/09/12 14:00:50.280370, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.280391, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.280411, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.280432, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.280452, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.280488, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username nobody, was [2011/09/12 14:00:50.280511, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain X009, was [2011/09/12 14:00:50.280531, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2011/09/12 14:00:50.280552, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name nobody, was [2011/09/12 14:00:50.280573, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.280598, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\x009\nobody, was [2011/09/12 14:00:50.280620, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive F:, was NULL [2011/09/12 14:00:50.280641, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2011/09/12 14:00:50.280663, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.280687, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\x009\nobody\profile, was [2011/09/12 14:00:50.280710, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2011/09/12 14:00:50.280731, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.280752, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.280772, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.280793, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.280812, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.280844, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.280868, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.280890, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-501 [2011/09/12 14:00:50.280914, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-501 from rid 501 [2011/09/12 14:00:50.280946, 5] lib/username.c:133(Get_Pwnam_alloc) Finding user nobody [2011/09/12 14:00:50.280967, 5] lib/username.c:77(Get_Pwnam_internals) Trying _Get_Pwnam(), username as lowercase is nobody [2011/09/12 14:00:50.280989, 5] lib/username.c:110(Get_Pwnam_internals) Get_Pwnam_internals did find user [nobody]! [2011/09/12 14:00:50.281033, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.281057, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.281077, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.281110, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.281130, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.281162, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.281187, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.281214, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username nobody, was [2011/09/12 14:00:50.281235, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain X009, was [2011/09/12 14:00:50.281256, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2011/09/12 14:00:50.281276, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name nobody, was [2011/09/12 14:00:50.281298, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.281323, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\x009\nobody, was [2011/09/12 14:00:50.281344, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive F:, was NULL [2011/09/12 14:00:50.281366, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2011/09/12 14:00:50.281387, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.281412, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\x009\nobody\profile, was [2011/09/12 14:00:50.281434, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2011/09/12 14:00:50.281455, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.281475, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.281496, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.281516, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.281536, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.281570, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.281595, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.281616, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-501 [2011/09/12 14:00:50.281640, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-501 from rid 501 [2011/09/12 14:00:50.281683, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = IDMAP/SID2GID/S-1-5-21-4090241009-3592364035-1401512610-513 couldn't be found [2011/09/12 14:00:50.281719, 10] passdb/lookup_sid.c:1511(sid_to_gid) winbind failed to find a gid for sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.281744, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.281765, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.281785, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.281806, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.281825, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.281854, 5] passdb/pdb_interface.c:1473(lookup_global_sam_rid) lookup_global_sam_rid: looking up RID 513. [2011/09/12 14:00:50.281887, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2011/09/12 14:00:50.281908, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2011/09/12 14:00:50.281928, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2011/09/12 14:00:50.281949, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.281969, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.282002, 5] passdb/pdb_tdb.c:609(tdbsam_getsampwrid) pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201. [2011/09/12 14:00:50.282069, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.282093, 5] passdb/pdb_interface.c:1536(lookup_global_sam_rid) Can't find a unix id for an unmapped group [2011/09/12 14:00:50.282116, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.282137, 10] passdb/lookup_sid.c:1283(legacy_sid_to_gid) LEGACY: mapping failed for sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.282161, 10] passdb/pdb_get_set.c:595(pdb_set_group_sid) pdb_set_group_sid: setting group sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.282190, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.282219, 3] lib/util_sid.c:228(string_to_sid) string_to_sid: Sid @users does not start with 'S-'. [2011/09/12 14:00:50.282267, 5] smbd/password.c:423(user_in_netgroup) Unable to get default yp domain, let's try without specifying it [2011/09/12 14:00:50.282288, 5] smbd/password.c:430(user_in_netgroup) looking for user user0 of domain (ANY) in netgroup users [2011/09/12 14:00:50.282373, 10] passdb/lookup_sid.c:69(lookup_name) lookup_name: X009\users => X009 (domain), users (name) [2011/09/12 14:00:50.282397, 10] passdb/lookup_sid.c:70(lookup_name) lookup_name: flags = 0x077 [2011/09/12 14:00:50.282418, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.282439, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.282459, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.282480, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.282499, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.282556, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.282583, 10] passdb/lookup_sid.c:69(lookup_name) lookup_name: Unix Group\users => Unix Group (domain), users (name) [2011/09/12 14:00:50.282604, 10] passdb/lookup_sid.c:70(lookup_name) lookup_name: flags = 0x077 [2011/09/12 14:00:50.282718, 10] smbd/share_access.c:238(user_ok_token) user_ok_token: share Software is ok for unix user user0 [2011/09/12 14:00:50.282748, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.282770, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.282790, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.282809, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.282829, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.282861, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: maximum password age, val: -1 [2011/09/12 14:00:50.282887, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.282911, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.282945, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.282966, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.282986, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.283005, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.283037, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.283061, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.283087, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username user0, was [2011/09/12 14:00:50.283108, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain X009, was [2011/09/12 14:00:50.283128, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2011/09/12 14:00:50.283149, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2011/09/12 14:00:50.283170, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.283195, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\x009\user0, was [2011/09/12 14:00:50.283216, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive F:, was NULL [2011/09/12 14:00:50.283238, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2011/09/12 14:00:50.283259, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.283283, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\x009\user0\profile, was [2011/09/12 14:00:50.283305, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2011/09/12 14:00:50.283327, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.283348, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.283368, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.283389, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.283408, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.283440, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.283464, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.283485, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1002 [2011/09/12 14:00:50.283510, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1002 from rid 1002 [2011/09/12 14:00:50.283554, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = IDMAP/SID2GID/S-1-5-21-4090241009-3592364035-1401512610-513 couldn't be found [2011/09/12 14:00:50.283590, 10] passdb/lookup_sid.c:1511(sid_to_gid) winbind failed to find a gid for sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.283615, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.283636, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.283656, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.283676, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.283695, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.283738, 5] passdb/pdb_interface.c:1473(lookup_global_sam_rid) lookup_global_sam_rid: looking up RID 513. [2011/09/12 14:00:50.283760, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.283781, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.283801, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.283821, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.283841, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.283874, 5] passdb/pdb_tdb.c:609(tdbsam_getsampwrid) pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201. [2011/09/12 14:00:50.283942, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.283965, 5] passdb/pdb_interface.c:1536(lookup_global_sam_rid) Can't find a unix id for an unmapped group [2011/09/12 14:00:50.283988, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.284009, 10] passdb/lookup_sid.c:1283(legacy_sid_to_gid) LEGACY: mapping failed for sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.284033, 10] passdb/pdb_get_set.c:595(pdb_set_group_sid) pdb_set_group_sid: setting group sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.284058, 5] lib/username.c:133(Get_Pwnam_alloc) Finding user user0 [2011/09/12 14:00:50.284078, 5] lib/username.c:77(Get_Pwnam_internals) Trying _Get_Pwnam(), username as lowercase is user0 [2011/09/12 14:00:50.284100, 5] lib/username.c:110(Get_Pwnam_internals) Get_Pwnam_internals did find user [user0]! [2011/09/12 14:00:50.284133, 10] smbd/service.c:163(set_conn_connectpath) set_conn_connectpath: service Software, connectpath = /Software [2011/09/12 14:00:50.284158, 3] smbd/service.c:807(make_connection_snum) Connect path is '/Software' for service [Software] [2011/09/12 14:00:50.284197, 10] lib/util_seaccess.c:58(se_map_generic) se_map_generic(): mapped mask 0x10000000 to 0x001f01ff [2011/09/12 14:00:50.284225, 3] smbd/vfs.c:97(vfs_init_default) Initialising default vfs hooks [2011/09/12 14:00:50.284254, 10] smbd/vfs.c:48(vfs_find_backend_entry) vfs_find_backend_entry called for /[Default VFS]/ [2011/09/12 14:00:50.284275, 5] smbd/vfs.c:87(smb_register_vfs) Successfully added vfs backend '/[Default VFS]/' [2011/09/12 14:00:50.284295, 3] smbd/vfs.c:122(vfs_init_custom) Initialising custom vfs hooks from [/[Default VFS]/] [2011/09/12 14:00:50.284316, 10] smbd/vfs.c:48(vfs_find_backend_entry) vfs_find_backend_entry called for /[Default VFS]/ Successfully loaded vfs module [/[Default VFS]/] with the new modules system [2011/09/12 14:00:50.284501, 0] param/loadparm.c:9923(widelinks_warning) Share 'Software' has wide links and unix extensions enabled. These parameters are incompatible. Wide links will be disabled for this share. [2011/09/12 14:00:50.284531, 5] smbd/connection.c:142(claim_connection) claiming [Software] [2011/09/12 14:00:50.284620, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked) Locking key BE01000001000000536F [2011/09/12 14:00:50.284646, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked) Allocated locked data 0x0xb813cfd0 [2011/09/12 14:00:50.284678, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr) Unlocking key BE01000001000000536F [2011/09/12 14:00:50.284790, 10] smbd/service.c:163(set_conn_connectpath) set_conn_connectpath: service Software, connectpath = /Software [2011/09/12 14:00:50.284818, 3] lib/util_sid.c:228(string_to_sid) string_to_sid: Sid root does not start with 'S-'. [2011/09/12 14:00:50.284841, 10] passdb/lookup_sid.c:69(lookup_name) lookup_name: X009\root => X009 (domain), root (name) [2011/09/12 14:00:50.284861, 10] passdb/lookup_sid.c:70(lookup_name) lookup_name: flags = 0x073 [2011/09/12 14:00:50.284896, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.284917, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.284937, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.284958, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.284978, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.285015, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username root, was [2011/09/12 14:00:50.285037, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain X009, was [2011/09/12 14:00:50.285058, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2011/09/12 14:00:50.285079, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2011/09/12 14:00:50.285101, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.285126, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\x009\root, was [2011/09/12 14:00:50.285147, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive F:, was NULL [2011/09/12 14:00:50.285169, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2011/09/12 14:00:50.285190, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.285214, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\x009\root\profile, was [2011/09/12 14:00:50.285236, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2011/09/12 14:00:50.285259, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.285279, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.285300, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.285320, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.285339, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.285374, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.285398, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.285420, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1000 [2011/09/12 14:00:50.285444, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1000 from rid 1000 [2011/09/12 14:00:50.285475, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.285496, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.285516, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.285536, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.285556, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.285587, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: maximum password age, val: -1 [2011/09/12 14:00:50.285611, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.285634, 5] lib/username.c:133(Get_Pwnam_alloc) Finding user root [2011/09/12 14:00:50.285668, 5] lib/username.c:77(Get_Pwnam_internals) Trying _Get_Pwnam(), username as lowercase is root [2011/09/12 14:00:50.285690, 5] lib/username.c:110(Get_Pwnam_internals) Get_Pwnam_internals did find user [root]! [2011/09/12 14:00:50.285735, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.285758, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.285778, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.285799, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.285818, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.285850, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.285875, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.285901, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username root, was [2011/09/12 14:00:50.285922, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain X009, was [2011/09/12 14:00:50.285943, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2011/09/12 14:00:50.285963, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2011/09/12 14:00:50.285985, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.286009, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\x009\root, was [2011/09/12 14:00:50.286031, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive F:, was NULL [2011/09/12 14:00:50.286052, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2011/09/12 14:00:50.286073, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.286098, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\x009\root\profile, was [2011/09/12 14:00:50.286120, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2011/09/12 14:00:50.286142, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.286162, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.286183, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.286204, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.286224, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.286256, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.286281, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.286303, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1000 [2011/09/12 14:00:50.286327, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1000 from rid 1000 [2011/09/12 14:00:50.286369, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = IDMAP/SID2GID/S-1-5-21-4090241009-3592364035-1401512610-513 couldn't be found [2011/09/12 14:00:50.286405, 10] passdb/lookup_sid.c:1511(sid_to_gid) winbind failed to find a gid for sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.286430, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.286451, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.286484, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.286505, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.286525, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.286554, 5] passdb/pdb_interface.c:1473(lookup_global_sam_rid) lookup_global_sam_rid: looking up RID 513. [2011/09/12 14:00:50.286575, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2011/09/12 14:00:50.286596, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2011/09/12 14:00:50.286617, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2011/09/12 14:00:50.286637, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.286656, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.286690, 5] passdb/pdb_tdb.c:609(tdbsam_getsampwrid) pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201. [2011/09/12 14:00:50.286760, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.286783, 5] passdb/pdb_interface.c:1536(lookup_global_sam_rid) Can't find a unix id for an unmapped group [2011/09/12 14:00:50.286807, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.286828, 10] passdb/lookup_sid.c:1283(legacy_sid_to_gid) LEGACY: mapping failed for sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.286851, 10] passdb/pdb_get_set.c:595(pdb_set_group_sid) pdb_set_group_sid: setting group sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.286882, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.286912, 3] lib/util_sid.c:228(string_to_sid) string_to_sid: Sid root does not start with 'S-'. [2011/09/12 14:00:50.286936, 10] passdb/lookup_sid.c:69(lookup_name) lookup_name: X009\root => X009 (domain), root (name) [2011/09/12 14:00:50.286956, 10] passdb/lookup_sid.c:70(lookup_name) lookup_name: flags = 0x073 [2011/09/12 14:00:50.286977, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.286998, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.287018, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.287038, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.287058, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.287094, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username root, was [2011/09/12 14:00:50.287116, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain X009, was [2011/09/12 14:00:50.287137, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2011/09/12 14:00:50.287157, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2011/09/12 14:00:50.287179, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.287203, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\x009\root, was [2011/09/12 14:00:50.287224, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive F:, was NULL [2011/09/12 14:00:50.287246, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2011/09/12 14:00:50.287267, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.287304, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\x009\root\profile, was [2011/09/12 14:00:50.287327, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2011/09/12 14:00:50.287350, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.287371, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.287391, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.287412, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.287432, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.287464, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.287488, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.287510, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1000 [2011/09/12 14:00:50.287534, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1000 from rid 1000 [2011/09/12 14:00:50.287566, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.287587, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.287607, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.287628, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.287648, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.287679, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: maximum password age, val: -1 [2011/09/12 14:00:50.287703, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.287726, 5] lib/username.c:133(Get_Pwnam_alloc) Finding user root [2011/09/12 14:00:50.287746, 5] lib/username.c:77(Get_Pwnam_internals) Trying _Get_Pwnam(), username as lowercase is root [2011/09/12 14:00:50.287767, 5] lib/username.c:110(Get_Pwnam_internals) Get_Pwnam_internals did find user [root]! [2011/09/12 14:00:50.287810, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.287833, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.287854, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.287874, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.287894, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.287927, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.287952, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.287978, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username root, was [2011/09/12 14:00:50.287999, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain X009, was [2011/09/12 14:00:50.288020, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2011/09/12 14:00:50.288040, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2011/09/12 14:00:50.288062, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.288086, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\x009\root, was [2011/09/12 14:00:50.288118, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive F:, was NULL [2011/09/12 14:00:50.288140, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2011/09/12 14:00:50.288162, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.288186, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\x009\root\profile, was [2011/09/12 14:00:50.288207, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2011/09/12 14:00:50.288230, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.288258, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.288279, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.288299, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.288320, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.288352, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.288379, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.288401, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1000 [2011/09/12 14:00:50.288425, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1000 from rid 1000 [2011/09/12 14:00:50.288468, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = IDMAP/SID2GID/S-1-5-21-4090241009-3592364035-1401512610-513 couldn't be found [2011/09/12 14:00:50.288504, 10] passdb/lookup_sid.c:1511(sid_to_gid) winbind failed to find a gid for sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.288529, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.288550, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.288571, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.288592, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.288612, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.288640, 5] passdb/pdb_interface.c:1473(lookup_global_sam_rid) lookup_global_sam_rid: looking up RID 513. [2011/09/12 14:00:50.288663, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2011/09/12 14:00:50.288684, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2011/09/12 14:00:50.288704, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2011/09/12 14:00:50.288725, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.288744, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.288778, 5] passdb/pdb_tdb.c:609(tdbsam_getsampwrid) pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201. [2011/09/12 14:00:50.288845, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.288868, 5] passdb/pdb_interface.c:1536(lookup_global_sam_rid) Can't find a unix id for an unmapped group [2011/09/12 14:00:50.288891, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.288912, 10] passdb/lookup_sid.c:1283(legacy_sid_to_gid) LEGACY: mapping failed for sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.288949, 10] passdb/pdb_get_set.c:595(pdb_set_group_sid) pdb_set_group_sid: setting group sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.288980, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.289008, 3] lib/util_sid.c:228(string_to_sid) string_to_sid: Sid nobody does not start with 'S-'. [2011/09/12 14:00:50.289032, 10] passdb/lookup_sid.c:69(lookup_name) lookup_name: X009\nobody => X009 (domain), nobody (name) [2011/09/12 14:00:50.289053, 10] passdb/lookup_sid.c:70(lookup_name) lookup_name: flags = 0x073 [2011/09/12 14:00:50.289075, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.289095, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.289116, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.289136, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.289156, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.289192, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username nobody, was [2011/09/12 14:00:50.289214, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain X009, was [2011/09/12 14:00:50.289234, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2011/09/12 14:00:50.289255, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name nobody, was [2011/09/12 14:00:50.289276, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.289301, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\x009\nobody, was [2011/09/12 14:00:50.289323, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive F:, was NULL [2011/09/12 14:00:50.289344, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2011/09/12 14:00:50.289366, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.289390, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\x009\nobody\profile, was [2011/09/12 14:00:50.289413, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2011/09/12 14:00:50.289434, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.289455, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.289475, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.289495, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.289515, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.289547, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.289571, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.289593, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-501 [2011/09/12 14:00:50.289617, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-501 from rid 501 [2011/09/12 14:00:50.289649, 5] lib/username.c:133(Get_Pwnam_alloc) Finding user nobody [2011/09/12 14:00:50.289670, 5] lib/username.c:77(Get_Pwnam_internals) Trying _Get_Pwnam(), username as lowercase is nobody [2011/09/12 14:00:50.289692, 5] lib/username.c:110(Get_Pwnam_internals) Get_Pwnam_internals did find user [nobody]! [2011/09/12 14:00:50.289750, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.289773, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.289794, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.289814, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.289834, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.289866, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.289890, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.289916, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username nobody, was [2011/09/12 14:00:50.289937, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain X009, was [2011/09/12 14:00:50.289958, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2011/09/12 14:00:50.289978, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name nobody, was [2011/09/12 14:00:50.290000, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.290024, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\x009\nobody, was [2011/09/12 14:00:50.290045, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive F:, was NULL [2011/09/12 14:00:50.290067, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2011/09/12 14:00:50.290089, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.290113, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\x009\nobody\profile, was [2011/09/12 14:00:50.290135, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2011/09/12 14:00:50.290156, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.290177, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.290197, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.290217, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.290237, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.290271, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.290296, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.290321, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-501 [2011/09/12 14:00:50.290345, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-501 from rid 501 [2011/09/12 14:00:50.290386, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = IDMAP/SID2GID/S-1-5-21-4090241009-3592364035-1401512610-513 couldn't be found [2011/09/12 14:00:50.290421, 10] passdb/lookup_sid.c:1511(sid_to_gid) winbind failed to find a gid for sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.290447, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.290467, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.290487, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.290520, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.290540, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.290568, 5] passdb/pdb_interface.c:1473(lookup_global_sam_rid) lookup_global_sam_rid: looking up RID 513. [2011/09/12 14:00:50.290590, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2011/09/12 14:00:50.290610, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2011/09/12 14:00:50.290630, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2011/09/12 14:00:50.290650, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.290670, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.290702, 5] passdb/pdb_tdb.c:609(tdbsam_getsampwrid) pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201. [2011/09/12 14:00:50.290768, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.290792, 5] passdb/pdb_interface.c:1536(lookup_global_sam_rid) Can't find a unix id for an unmapped group [2011/09/12 14:00:50.290814, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.290835, 10] passdb/lookup_sid.c:1283(legacy_sid_to_gid) LEGACY: mapping failed for sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.290859, 10] passdb/pdb_get_set.c:595(pdb_set_group_sid) pdb_set_group_sid: setting group sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.290892, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.290920, 3] lib/util_sid.c:228(string_to_sid) string_to_sid: Sid @users does not start with 'S-'. [2011/09/12 14:00:50.290943, 5] smbd/password.c:423(user_in_netgroup) Unable to get default yp domain, let's try without specifying it [2011/09/12 14:00:50.290963, 5] smbd/password.c:430(user_in_netgroup) looking for user user0 of domain (ANY) in netgroup users [2011/09/12 14:00:50.291016, 10] passdb/lookup_sid.c:69(lookup_name) lookup_name: X009\users => X009 (domain), users (name) [2011/09/12 14:00:50.291040, 10] passdb/lookup_sid.c:70(lookup_name) lookup_name: flags = 0x077 [2011/09/12 14:00:50.291060, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.291081, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.291101, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.291121, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.291141, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.291194, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.291220, 10] passdb/lookup_sid.c:69(lookup_name) lookup_name: Unix Group\users => Unix Group (domain), users (name) [2011/09/12 14:00:50.291241, 10] passdb/lookup_sid.c:70(lookup_name) lookup_name: flags = 0x077 [2011/09/12 14:00:50.291295, 10] smbd/share_access.c:238(user_ok_token) user_ok_token: share Software is ok for unix user user0 [2011/09/12 14:00:50.291321, 10] smbd/share_access.c:283(is_share_read_only_for_token) is_share_read_only_for_user: share Software is read-only for unix user user0 [2011/09/12 14:00:50.291350, 10] lib/util_seaccess.c:58(se_map_generic) se_map_generic(): mapped mask 0x10000000 to 0x001f01ff [2011/09/12 14:00:50.291377, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.291402, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.291448, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.291469, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.291489, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.291522, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: maximum password age, val: -1 [2011/09/12 14:00:50.291548, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.291571, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.291592, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.291612, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.291632, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.291652, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.291682, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.291706, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.291732, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username user0, was [2011/09/12 14:00:50.291754, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain X009, was [2011/09/12 14:00:50.291774, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2011/09/12 14:00:50.291794, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2011/09/12 14:00:50.291816, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.291841, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\x009\user0, was [2011/09/12 14:00:50.291862, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive F:, was NULL [2011/09/12 14:00:50.291884, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2011/09/12 14:00:50.291909, 4] lib/substitute.c:504(automount_server) Home server: x009 [2011/09/12 14:00:50.291933, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\x009\user0\profile, was [2011/09/12 14:00:50.291955, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2011/09/12 14:00:50.291977, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.291998, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.292018, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.292039, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.292058, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.292089, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2011/09/12 14:00:50.292113, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.292135, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1002 [2011/09/12 14:00:50.292160, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-4090241009-3592364035-1401512610-1002 from rid 1002 [2011/09/12 14:00:50.292202, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = IDMAP/SID2GID/S-1-5-21-4090241009-3592364035-1401512610-513 couldn't be found [2011/09/12 14:00:50.292257, 10] passdb/lookup_sid.c:1511(sid_to_gid) winbind failed to find a gid for sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.292283, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.292304, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2011/09/12 14:00:50.292324, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.292344, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.292364, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.292423, 5] passdb/pdb_interface.c:1473(lookup_global_sam_rid) lookup_global_sam_rid: looking up RID 513. [2011/09/12 14:00:50.292445, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.292468, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2011/09/12 14:00:50.292489, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2011/09/12 14:00:50.292510, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.292530, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.292564, 5] passdb/pdb_tdb.c:609(tdbsam_getsampwrid) pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201. [2011/09/12 14:00:50.292631, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2011/09/12 14:00:50.292654, 5] passdb/pdb_interface.c:1536(lookup_global_sam_rid) Can't find a unix id for an unmapped group [2011/09/12 14:00:50.292677, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.292697, 10] passdb/lookup_sid.c:1283(legacy_sid_to_gid) LEGACY: mapping failed for sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.292721, 10] passdb/pdb_get_set.c:595(pdb_set_group_sid) pdb_set_group_sid: setting group sid S-1-5-21-4090241009-3592364035-1401512610-513 [2011/09/12 14:00:50.292753, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (1000, 100) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.292775, 5] auth/token_util.c:531(debug_nt_user_token) NT user token of user S-1-5-21-4090241009-3592364035-1401512610-1002 contains 6 SIDs SID[ 0]: S-1-5-21-4090241009-3592364035-1401512610-1002 SID[ 1]: S-1-22-2-100 SID[ 2]: S-1-1-0 SID[ 3]: S-1-5-2 SID[ 4]: S-1-5-11 SID[ 5]: S-1-22-1-1000 SE_PRIV 0x0 0x0 0x0 0x0 [2011/09/12 14:00:50.292848, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 1000 Primary group is 100 and contains 1 supplementary groups Group[ 0]: 100 [2011/09/12 14:00:50.292882, 5] smbd/uid.c:354(change_to_user) change_to_user uid=(0,1000) gid=(0,100) [2011/09/12 14:00:50.292919, 10] smbd/service.c:163(set_conn_connectpath) set_conn_connectpath: service Software, connectpath = /Software [2011/09/12 14:00:50.292961, 1] smbd/service.c:1070(make_connection_snum) x181 (147.8.101.181) connect to service Software initially as user user0 (uid=1000, gid=100) (pid 446) [2011/09/12 14:00:50.292990, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:00:50.293011, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:00:50.293030, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:00:50.293062, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2011/09/12 14:00:50.293092, 3] smbd/reply.c:865(reply_tcon_and_X) tconX service=SOFTWARE [2011/09/12 14:01:28.154393, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:01:28.154448, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:01:28.154471, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:01:28.154504, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2011/09/12 14:01:28.154533, 4] smbd/vfs.c:751(vfs_ChDir) vfs_ChDir to /Software [2011/09/12 14:01:28.154569, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:01:28.154593, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:01:28.154613, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:01:28.154642, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2011/09/12 14:01:28.154664, 1] smbd/service.c:1251(close_cnum) x181 (147.8.101.181) closed connection to service Software [2011/09/12 14:01:28.154689, 3] smbd/connection.c:31(yield_connection) Yielding connection to Software [2011/09/12 14:01:28.154782, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked) Locking key BE01000001000000536F [2011/09/12 14:01:28.154814, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked) Allocated locked data 0x0xb812bcd8 [2011/09/12 14:01:28.154848, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr) Unlocking key BE01000001000000536F [2011/09/12 14:01:28.154944, 4] smbd/vfs.c:751(vfs_ChDir) vfs_ChDir to / [2011/09/12 14:01:28.154968, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2011/09/12 14:01:28.154989, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2011/09/12 14:01:28.155008, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2011/09/12 14:01:28.155035, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2011/09/12 14:01:28.155070, 5] lib/messages.c:329(messaging_deregister) Deregistering messaging pointer for type 784 - private_data=0xb8139ab8 [2011/09/12 14:01:28.155117, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked) Locking key 49442F3434362F313031 [2011/09/12 14:01:28.155152, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked) Allocated locked data 0x0xb81364f8 [2011/09/12 14:01:28.155191, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr) Unlocking key 49442F3434362F313031 [2011/09/12 14:01:28.155229, 3] smbd/connection.c:31(yield_connection) Yielding connection to [2011/09/12 14:01:28.155319, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked) Locking key BE010000FFFFFFFF0000 [2011/09/12 14:01:28.155351, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked) Allocated locked data 0x0xb812bcd8 [2011/09/12 14:01:28.155384, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr) Unlocking key BE010000FFFFFFFF0000 [2011/09/12 14:01:28.155514, 3] smbd/server.c:924(exit_server_common) Server exit (termination signal)