Attachment 6887 Details for Bug 8454 – samba log for the Win7 session (with the error)

samba log for the Win7 session (with the error)

Win7.log (text/plain), 195.06 KB, created by anctop on 2011-09-14 00:41:12 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: anctop

Created: 2011-09-14 00:41:12 UTC

Size: 195.06 KB

patch

obsolete

>[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)

Actions: View

Attachments on bug 8454: 6884 | 6885 | 6886 | 6887 | 6888 | 6892