Attachment 5930 Details for Bug 7652 – level 10 log showing access denied

level 10 log showing access denied

log.10.193.46.36-ico-denied (text/plain), 195.29 KB, created by Kevin Shanahan (dead mail address) on 2010-08-27 01:32:02 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Kevin Shanahan (dead mail address)

Created: 2010-08-27 01:32:02 UTC

Size: 195.29 KB

patch

obsolete

>[2010/08/27 14:43:46, 10] lib/events.c:105(run_events)
>  Running timed event "smbd_idle_event_handler" 0xb9174388
>[2010/08/27 14:43:46, 10] lib/events.c:287(s3_event_debug)
>  s3_event: Destroying timer event 0xb9174388 "smbd_idle_event_handler"
>[2010/08/27 14:43:46, 10] smbd/process.c:663(smbd_idle_event_handler)
>  smbd_idle_event_handler: idle_evt(deadtime) (nil) called
>[2010/08/27 14:43:46, 10] smbd/process.c:674(smbd_idle_event_handler)
>  smbd_idle_event_handler: idle_evt(deadtime) (nil) rescheduled
>[2010/08/27 14:43:46, 10] lib/events.c:287(s3_event_debug)
>  s3_event: Added timed event "smbd_idle_event_handler": 0xb9174388
>[2010/08/27 14:43:46, 10] lib/events.c:105(run_events)
>  Running timed event "smbd_idle_event_handler" 0xb9195be0
>[2010/08/27 14:43:46, 10] lib/events.c:287(s3_event_debug)
>  s3_event: Destroying timer event 0xb9195be0 "smbd_idle_event_handler"
>[2010/08/27 14:43:46, 10] smbd/process.c:663(smbd_idle_event_handler)
>  smbd_idle_event_handler: idle_evt(housekeeping) (nil) called
>[2010/08/27 14:43:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:43:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:43:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:43:46,  5] smbd/uid.c:368(change_to_root_user)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2010/08/27 14:43:46, 10] smbd/process.c:674(smbd_idle_event_handler)
>  smbd_idle_event_handler: idle_evt(housekeeping) (nil) rescheduled
>[2010/08/27 14:43:46, 10] lib/events.c:287(s3_event_debug)
>  s3_event: Added timed event "smbd_idle_event_handler": 0xb9195be0
>[2010/08/27 14:44:46, 10] lib/events.c:105(run_events)
>  Running timed event "smbd_idle_event_handler" 0xb9174388
>[2010/08/27 14:44:46, 10] lib/events.c:287(s3_event_debug)
>  s3_event: Destroying timer event 0xb9174388 "smbd_idle_event_handler"
>[2010/08/27 14:44:46, 10] smbd/process.c:663(smbd_idle_event_handler)
>  smbd_idle_event_handler: idle_evt(deadtime) (nil) called
>[2010/08/27 14:44:46, 10] smbd/process.c:674(smbd_idle_event_handler)
>  smbd_idle_event_handler: idle_evt(deadtime) (nil) rescheduled
>[2010/08/27 14:44:46, 10] lib/events.c:287(s3_event_debug)
>  s3_event: Added timed event "smbd_idle_event_handler": 0xb9174388
>[2010/08/27 14:44:46, 10] lib/events.c:105(run_events)
>  Running timed event "smbd_idle_event_handler" 0xb9195be0
>[2010/08/27 14:44:46, 10] lib/events.c:287(s3_event_debug)
>  s3_event: Destroying timer event 0xb9195be0 "smbd_idle_event_handler"
>[2010/08/27 14:44:46, 10] smbd/process.c:663(smbd_idle_event_handler)
>  smbd_idle_event_handler: idle_evt(housekeeping) (nil) called
>[2010/08/27 14:44:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:44:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:44:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:44:46,  5] smbd/uid.c:368(change_to_root_user)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2010/08/27 14:44:46,  6] param/loadparm.c:7017(lp_file_list_changed)
>  lp_file_list_changed()
>  file /etc/samba/smb.conf -> /etc/samba/smb.conf  last mod_time: Fri Aug 27 08:26:16 2010
>  
>[2010/08/27 14:44:46, 10] smbd/process.c:674(smbd_idle_event_handler)
>  smbd_idle_event_handler: idle_evt(housekeeping) (nil) rescheduled
>[2010/08/27 14:44:46, 10] lib/events.c:287(s3_event_debug)
>  s3_event: Added timed event "smbd_idle_event_handler": 0xb9195be0
>[2010/08/27 14:45:33, 10] lib/events.c:105(run_events)
>  Running timed event "smbd_idle_event_handler" 0xb9181140
>[2010/08/27 14:45:33, 10] lib/events.c:287(s3_event_debug)
>  s3_event: Destroying timer event 0xb9181140 "smbd_idle_event_handler"
>[2010/08/27 14:45:33, 10] smbd/process.c:663(smbd_idle_event_handler)
>  smbd_idle_event_handler: idle_evt(keepalive) (nil) called
>[2010/08/27 14:45:33, 10] smbd/process.c:674(smbd_idle_event_handler)
>  smbd_idle_event_handler: idle_evt(keepalive) (nil) rescheduled
>[2010/08/27 14:45:33, 10] lib/events.c:287(s3_event_debug)
>  s3_event: Added timed event "smbd_idle_event_handler": 0xb9181140
>[2010/08/27 14:45:46, 10] lib/events.c:105(run_events)
>  Running timed event "smbd_idle_event_handler" 0xb9174388
>[2010/08/27 14:45:46, 10] lib/events.c:287(s3_event_debug)
>  s3_event: Destroying timer event 0xb9174388 "smbd_idle_event_handler"
>[2010/08/27 14:45:46, 10] smbd/process.c:663(smbd_idle_event_handler)
>  smbd_idle_event_handler: idle_evt(deadtime) (nil) called
>[2010/08/27 14:45:46, 10] smbd/process.c:674(smbd_idle_event_handler)
>  smbd_idle_event_handler: idle_evt(deadtime) (nil) rescheduled
>[2010/08/27 14:45:46, 10] lib/events.c:287(s3_event_debug)
>  s3_event: Added timed event "smbd_idle_event_handler": 0xb9174388
>[2010/08/27 14:45:46, 10] lib/events.c:105(run_events)
>  Running timed event "smbd_idle_event_handler" 0xb9195be0
>[2010/08/27 14:45:46, 10] lib/events.c:287(s3_event_debug)
>  s3_event: Destroying timer event 0xb9195be0 "smbd_idle_event_handler"
>[2010/08/27 14:45:46, 10] smbd/process.c:663(smbd_idle_event_handler)
>  smbd_idle_event_handler: idle_evt(housekeeping) (nil) called
>[2010/08/27 14:45:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:45:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:45:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:45:46,  5] smbd/uid.c:368(change_to_root_user)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2010/08/27 14:45:46, 10] smbd/process.c:674(smbd_idle_event_handler)
>  smbd_idle_event_handler: idle_evt(housekeeping) (nil) rescheduled
>[2010/08/27 14:45:46, 10] lib/events.c:287(s3_event_debug)
>  s3_event: Added timed event "smbd_idle_event_handler": 0xb9195be0
>[2010/08/27 14:46:46, 10] lib/events.c:105(run_events)
>  Running timed event "smbd_idle_event_handler" 0xb9174388
>[2010/08/27 14:46:46, 10] lib/events.c:287(s3_event_debug)
>  s3_event: Destroying timer event 0xb9174388 "smbd_idle_event_handler"
>[2010/08/27 14:46:46, 10] smbd/process.c:663(smbd_idle_event_handler)
>  smbd_idle_event_handler: idle_evt(deadtime) (nil) called
>[2010/08/27 14:46:46, 10] smbd/process.c:674(smbd_idle_event_handler)
>  smbd_idle_event_handler: idle_evt(deadtime) (nil) rescheduled
>[2010/08/27 14:46:46, 10] lib/events.c:287(s3_event_debug)
>  s3_event: Added timed event "smbd_idle_event_handler": 0xb9174388
>[2010/08/27 14:46:46, 10] lib/events.c:105(run_events)
>  Running timed event "smbd_idle_event_handler" 0xb9195be0
>[2010/08/27 14:46:46, 10] lib/events.c:287(s3_event_debug)
>  s3_event: Destroying timer event 0xb9195be0 "smbd_idle_event_handler"
>[2010/08/27 14:46:46, 10] smbd/process.c:663(smbd_idle_event_handler)
>  smbd_idle_event_handler: idle_evt(housekeeping) (nil) called
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46,  5] smbd/uid.c:368(change_to_root_user)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2010/08/27 14:46:46, 10] smbd/process.c:674(smbd_idle_event_handler)
>  smbd_idle_event_handler: idle_evt(housekeeping) (nil) rescheduled
>[2010/08/27 14:46:46, 10] lib/events.c:287(s3_event_debug)
>  s3_event: Added timed event "smbd_idle_event_handler": 0xb9195be0
>[2010/08/27 14:46:46, 10] lib/util_sock.c:789(read_smb_length_return_keepalive)
>  got smb length of 1404
>[2010/08/27 14:46:46,  6] smbd/process.c:1456(process_smb)
>  got message type 0x0 of len 0x57c
>[2010/08/27 14:46:46,  3] smbd/process.c:1459(process_smb)
>  Transaction 23 of length 1408 (0 toread)
>[2010/08/27 14:46:46,  5] lib/util.c:632(show_msg)
>[2010/08/27 14:46:46,  5] lib/util.c:642(show_msg)
>  size=1404
>  smb_com=0x73
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=0
>  smb_pid=65279
>  smb_uid=0
>  smb_mid=1472
>  smt_wct=12
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]= 1404 (0x57C)
>  smb_vwv[ 2]=16644 (0x4104)
>  smb_vwv[ 3]=   50 (0x32)
>  smb_vwv[ 4]=    1 (0x1)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]= 1242 (0x4DA)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=    0 (0x0)
>  smb_vwv[10]=  212 (0xD4)
>  smb_vwv[11]=40960 (0xA000)
>  smb_bcc=1345
>[2010/08/27 14:46:46, 10] ../lib/util/util.c:304(_dump_data)
>  [0000] 60 82 04 D6 06 06 2B 06   01 05 05 02 A0 82 04 CA   `.....+. ........
>  [0010] 30 82 04 C6 A0 24 30 22   06 09 2A 86 48 82 F7 12   0....$0" ..*.H...
>  [0020] 01 02 02 06 09 2A 86 48   86 F7 12 01 02 02 06 0A   .....*.H ........
>  [0030] 2B 06 01 04 01 82 37 02   02 0A A2 82 04 9C 04 82   +.....7. ........
>  [0040] 04 98 60 82 04 94 06 09   2A 86 48 86 F7 12 01 02   ..`..... *.H.....
>  [0050] 02 01 00 6E 82 04 83 30   82 04 7F A0 03 02 01 05   ...n...0 ........
>  [0060] A1 03 02 01 0E A2 07 03   05 00 20 00 00 00 A3 82   ........ .. .....
>  [0070] 03 A8 61 82 03 A4 30 82   03 A0 A0 03 02 01 05 A1   ..a...0. ........
>  [0080] 0D 1B 0B 57 55 4D 49 2E   4F 52 47 2E 41 55 A2 27   ...WUMI. ORG.AU.'
>  [0090] 30 25 A0 03 02 01 02 A1   1E 30 1C 1B 04 63 69 66   0%...... .0...cif
>  [00A0] 73 1B 14 62 72 69 67 68   74 6F 6E 2E 77 75 6D 69   s..brigh ton.wumi
>  [00B0] 2E 6F 72 67 2E 61 75 A3   82 03 5F 30 82 03 5B A0   .org.au. .._0..[.
>  [00C0] 03 02 01 17 A2 82 03 52   04 82 03 4E 38 88 3C 15   .......R ...N8.<.
>  [00D0] F7 64 3B 05 36 8C 92 07   DD 78 07 77 8F D4 A8 60   .d;.6... .x.w...`
>  [00E0] FB E7 D9 73 78 FC DE 3B   A0 51 0A A4 08 10 76 0F   ...sx..; .Q....v.
>  [00F0] 88 8E 6F 83 DF C8 75 45   91 53 84 84 C8 11 F9 44   ..o...uE .S.....D
>  [0100] FD C7 D3 EA 5B B5 A6 03   38 C8 98 AD D4 44 8C 3F   ....[... 8....D.?
>  [0110] D3 EC 96 0D 62 E3 97 AA   BE 13 3C CB 0B 52 06 A9   ....b... ..<..R..
>  [0120] 13 E4 D0 90 4D BD 92 EF   4C 3C BA 0A D5 F4 C9 71   ....M... L<.....q
>  [0130] D5 99 2F 5D 8C BA BE 0D   FF 2A 3D A2 11 0C 1E CE   ../].... .*=.....
>  [0140] 19 93 6F 36 7E F2 D9 9B   22 BD E9 39 25 EE C3 69   ..o6~... "..9%..i
>  [0150] CE A1 BC EC 4D F9 B5 AF   54 BE BE 66 DB A0 B0 CB   ....M... T..f....
>  [0160] B3 E9 BB AC F0 8B 54 3B   9C 58 73 1D 45 54 CF A2   ......T; .Xs.ET..
>  [0170] F8 19 83 98 C3 A9 18 24   FD 64 1D 5E 46 F5 58 D0   .......$ .d.^F.X.
>  [0180] 6E 3A 68 12 C4 44 6B DC   37 78 21 A8 61 F1 9C 69   n:h..Dk. 7x!.a..i
>  [0190] 51 4C A6 2B 49 0A 4F 08   BD CB BD 4E 12 A1 87 07   QL.+I.O. ...N....
>  [01A0] F1 3D 67 4A 49 14 46 9B   49 96 7B 14 E9 0C CE 58   .=gJI.F. I.{....X
>  [01B0] 81 05 84 E8 02 B1 58 7B   AA CB CE DF 57 68 63 F4   ......X{ ....Whc.
>  [01C0] FB 8E 26 97 36 4C 52 90   57 BB F5 72 C3 98 C7 A7   ..&.6LR. W..r....
>  [01D0] 34 FC 76 F0 AA E5 2D 0F   CD 2F 71 FB 02 3B 97 13   4.v...-. ./q..;..
>  [01E0] 2E D9 E7 5A 71 DC 83 65   B9 62 62 30 E5 EF B6 1A   ...Zq..e .bb0....
>  [01F0] 82 0A 26 7D 2A AD 21 7E   C8 4D AC D2 2F 71 2F DC   ..&}*.!~ .M../q/.
>[2010/08/27 14:46:46,  3] smbd/process.c:1273(switch_message)
>  switch message SMBsesssetupX (pid 29920) conn 0x0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46,  5] smbd/uid.c:368(change_to_root_user)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2010/08/27 14:46:46,  3] smbd/sesssetup.c:1434(reply_sesssetup_and_X)
>  wct=12 flg2=0xc807
>[2010/08/27 14:46:46,  3] smbd/sesssetup.c:1190(reply_sesssetup_and_X_spnego)
>  Doing spnego session setup
>[2010/08/27 14:46:46,  3] smbd/sesssetup.c:1232(reply_sesssetup_and_X_spnego)
>  NativeOS=[Windows 2002 Service Pack 3 2600] NativeLanMan=[Windows 2002 5.1] PrimaryDomain=[]
>[2010/08/27 14:46:46, 10] smbd/password.c:172(register_initial_vuid)
>  register_initial_vuid: allocated vuid = 104
>[2010/08/27 14:46:46, 10] smbd/sesssetup.c:1136(check_spnego_blob_complete)
>  check_spnego_blob_complete: needed_len = 1242, pblob->length = 1242
>[2010/08/27 14:46:46,  5] smbd/sesssetup.c:765(parse_spnego_mechanisms)
>  parse_spnego_mechanisms: Got OID 1.2.840.48018.1.2.2
>[2010/08/27 14:46:46,  5] smbd/sesssetup.c:765(parse_spnego_mechanisms)
>  parse_spnego_mechanisms: Got OID 1.2.840.113554.1.2.2
>[2010/08/27 14:46:46,  5] smbd/sesssetup.c:765(parse_spnego_mechanisms)
>  parse_spnego_mechanisms: Got OID 1.3.6.1.4.1.311.2.2.10
>[2010/08/27 14:46:46,  3] smbd/sesssetup.c:816(reply_spnego_negotiate)
>  reply_spnego_negotiate: Got secblob of size 1176
>[2010/08/27 14:46:46, 10] libads/kerberos_verify.c:369(ads_secrets_verify_ticket)
>  ads_secrets_verify_ticket: enc type [23] decrypted message !
>[2010/08/27 14:46:46, 10] libsmb/clikrb5.c:896(get_krb5_smb_session_key)
>  Got KRB5 session key of length 16
>[2010/08/27 14:46:46,  3] libads/authdata.c:304(decode_pac_data)
>  Found account name from PAC: UCWB-0151$ [UCWB-0151$]
>[2010/08/27 14:46:46, 10] libads/authdata.c:306(decode_pac_data)
>  Successfully validated Kerberos PAC
>[2010/08/27 14:46:46, 10] ../lib/util/util.c:304(_dump_data)
>  [0000] 59 AF 14 AB 9F F3 8A FB   B0 EE CB 7C 96 B5 97 EF   Y....... ...|....
>[2010/08/27 14:46:46, 10] ../lib/util/util.c:304(_dump_data)
>  [0000] E4 84 9E 82 20 87 4A CE   C9 FD 3A BD 82 C9 44 4B   .... .J. ..:...DK
>      pac_data: struct PAC_DATA
>          num_buffers              : 0x00000004 (4)
>          version                  : 0x00000000 (0)
>          buffers: ARRAY(4)
>              buffers: struct PAC_BUFFER
>                  type                     : PAC_TYPE_LOGON_INFO (1)
>                  _ndr_size                : 0x000001c0 (448)
>                  info                     : *
>                      info                     : union PAC_INFO(case 1)
>                      logon_info: struct PAC_LOGON_INFO_CTR
>                          info                     : *
>                              info: struct PAC_LOGON_INFO
>                                  info3: struct netr_SamInfo3
>                                      base: struct netr_SamBaseInfo
>                                          last_logon               : Fri 27 Aug 2010 09:07:55 CST CST
>                                          last_logoff              : Tue 19 Jan 2038 13:44:07 CST CST
>                                          acct_expiry              : Tue 19 Jan 2038 13:44:07 CST CST
>                                          last_password_change     : Thu 26 Aug 2010 09:11:26 CST CST
>                                          allow_password_change    : Thu 26 Aug 2010 09:11:26 CST CST
>                                          force_password_change    : Tue 19 Jan 2038 13:44:07 CST CST
>                                          account_name: struct lsa_String
>                                              length                   : 0x0014 (20)
>                                              size                     : 0x0014 (20)
>                                              string                   : *
>                                                  string                   : 'UCWB-0151$'
>                                          full_name: struct lsa_String
>                                              length                   : 0x0014 (20)
>                                              size                     : 0x0014 (20)
>                                              string                   : *
>                                                  string                   : 'UCWB-0151$'
>                                          logon_script: struct lsa_String
>                                              length                   : 0x0000 (0)
>                                              size                     : 0x0000 (0)
>                                              string                   : *
>                                                  string                   : ''
>                                          profile_path: struct lsa_String
>                                              length                   : 0x0000 (0)
>                                              size                     : 0x0000 (0)
>                                              string                   : *
>                                                  string                   : ''
>                                          home_directory: struct lsa_String
>                                              length                   : 0x0000 (0)
>                                              size                     : 0x0000 (0)
>                                              string                   : *
>                                                  string                   : ''
>                                          home_drive: struct lsa_String
>                                              length                   : 0x0000 (0)
>                                              size                     : 0x0000 (0)
>                                              string                   : *
>                                                  string                   : ''
>                                          logon_count              : 0x0013 (19)
>                                          bad_password_count       : 0x0000 (0)
>                                          rid                      : 0x000008bb (2235)
>                                          primary_gid              : 0x00000203 (515)
>                                          groups: struct samr_RidWithAttributeArray
>                                              count                    : 0x00000001 (1)
>                                              rids                     : *
>                                                  rids: ARRAY(1)
>                                                      rids: struct samr_RidWithAttribute
>                                                          rid                      : 0x00000203 (515)
>                                                          attributes               : 0x00000007 (7)
>                                                                 1: SE_GROUP_MANDATORY       
>                                                                 1: SE_GROUP_ENABLED_BY_DEFAULT
>                                                                 1: SE_GROUP_ENABLED         
>                                                                 0: SE_GROUP_OWNER           
>                                                                 0: SE_GROUP_USE_FOR_DENY_ONLY
>                                                                 0: SE_GROUP_RESOURCE        
>                                                              0x00: SE_GROUP_LOGON_ID         (0)
>                                          user_flags               : 0x00000020 (32)
>                                                 0: NETLOGON_GUEST           
>                                                 0: NETLOGON_NOENCRYPTION    
>                                                 0: NETLOGON_CACHED_ACCOUNT  
>                                                 0: NETLOGON_USED_LM_PASSWORD
>                                                 1: NETLOGON_EXTRA_SIDS      
>                                                 0: NETLOGON_SUBAUTH_SESSION_KEY
>                                                 0: NETLOGON_SERVER_TRUST_ACCOUNT
>                                                 0: NETLOGON_NTLMV2_ENABLED  
>                                                 0: NETLOGON_RESOURCE_GROUPS 
>                                                 0: NETLOGON_PROFILE_PATH_RETURNED
>                                                 0: NETLOGON_GRACE_LOGON     
>                                          key: struct netr_UserSessionKey
>                                              key                      : 00000000000000000000000000000000
>                                          logon_server: struct lsa_StringLarge
>                                              length                   : 0x0016 (22)
>                                              size                     : 0x0018 (24)
>                                              string                   : *
>                                                  string                   : 'UCWB-KVM-18'
>                                          domain: struct lsa_StringLarge
>                                              length                   : 0x0008 (8)
>                                              size                     : 0x000a (10)
>                                              string                   : *
>                                                  string                   : 'WUM3'
>                                          domain_sid               : *
>                                              domain_sid               : S-1-5-21-1202660629-583907252-725345543
>                                          LMSessKey: struct netr_LMSessionKey
>                                              key                      : 0000000000000000
>                                          acct_flags               : 0x00000080 (128)
>                                                 0: ACB_DISABLED             
>                                                 0: ACB_HOMDIRREQ            
>                                                 0: ACB_PWNOTREQ             
>                                                 0: ACB_TEMPDUP              
>                                                 0: ACB_NORMAL               
>                                                 0: ACB_MNS                  
>                                                 0: ACB_DOMTRUST             
>                                                 1: ACB_WSTRUST              
>                                                 0: ACB_SVRTRUST             
>                                                 0: ACB_PWNOEXP              
>                                                 0: ACB_AUTOLOCK             
>                                                 0: ACB_ENC_TXT_PWD_ALLOWED  
>                                                 0: ACB_SMARTCARD_REQUIRED   
>                                                 0: ACB_TRUSTED_FOR_DELEGATION
>                                                 0: ACB_NOT_DELEGATED        
>                                                 0: ACB_USE_DES_KEY_ONLY     
>                                                 0: ACB_DONT_REQUIRE_PREAUTH 
>                                                 0: ACB_PW_EXPIRED           
>                                                 0: ACB_NO_AUTH_DATA_REQD    
>                                          unknown: ARRAY(7)
>                                              unknown                  : 0x00000000 (0)
>                                              unknown                  : 0x00000000 (0)
>                                              unknown                  : 0x00000000 (0)
>                                              unknown                  : 0x00000000 (0)
>                                              unknown                  : 0x00000000 (0)
>                                              unknown                  : 0x00000000 (0)
>                                              unknown                  : 0x00000000 (0)
>                                      sidcount                 : 0x00000000 (0)
>                                      sids                     : NULL
>                                  res_group_dom_sid        : NULL
>                                  res_groups: struct samr_RidWithAttributeArray
>                                      count                    : 0x00000000 (0)
>                                      rids                     : NULL
>                  _pad                     : 0x00000000 (0)
>              buffers: struct PAC_BUFFER
>                  type                     : PAC_TYPE_LOGON_NAME (10)
>                  _ndr_size                : 0x0000001e (30)
>                  info                     : *
>                      info                     : union PAC_INFO(case 10)
>                      logon_name: struct PAC_LOGON_NAME
>                          logon_time               : Fri 27 Aug 2010 09:07:55 CST CST
>                          size                     : 0x0014 (20)
>                          account_name             : 'UCWB-0151$'
>                  _pad                     : 0x00000000 (0)
>              buffers: struct PAC_BUFFER
>                  type                     : PAC_TYPE_SRV_CHECKSUM (6)
>                  _ndr_size                : 0x00000014 (20)
>                  info                     : *
>                      info                     : union PAC_INFO(case 6)
>                      srv_cksum: struct PAC_SIGNATURE_DATA
>                          type                     : 0xffffff76 (4294967158)
>                          signature                : DATA_BLOB length=16
>                  _pad                     : 0x00000000 (0)
>              buffers: struct PAC_BUFFER
>                  type                     : PAC_TYPE_KDC_CHECKSUM (7)
>                  _ndr_size                : 0x00000014 (20)
>                  info                     : *
>                      info                     : union PAC_INFO(case 7)
>                      kdc_cksum: struct PAC_SIGNATURE_DATA
>                          type                     : 0xffffff76 (4294967158)
>                          signature                : DATA_BLOB length=16
>                  _pad                     : 0x00000000 (0)
>  
>[2010/08/27 14:46:46,  3] smbd/sesssetup.c:348(reply_spnego_kerberos)
>  Ticket name is [UCWB-0151$@WUMI.ORG.AU]
>[2010/08/27 14:46:46, 10] libsmb/samlogon_cache.c:122(netsamlogon_cache_store)
>  netsamlogon_cache_store: SID [S-1-5-21-1202660629-583907252-725345543-2235]
>[2010/08/27 14:46:46,  1] ../librpc/ndr/ndr.c:214(ndr_print_debug)
>       &r: struct netsamlogoncache_entry
>          timestamp                : Fri 27 Aug 2010 14:46:46 CST CST
>          info3: struct netr_SamInfo3
>              base: struct netr_SamBaseInfo
>                  last_logon               : Fri 27 Aug 2010 09:07:55 CST CST
>                  last_logoff              : Tue 19 Jan 2038 13:44:07 CST CST
>                  acct_expiry              : Tue 19 Jan 2038 13:44:07 CST CST
>                  last_password_change     : Thu 26 Aug 2010 09:11:26 CST CST
>                  allow_password_change    : Thu 26 Aug 2010 09:11:26 CST CST
>                  force_password_change    : Tue 19 Jan 2038 13:44:07 CST CST
>                  account_name: struct lsa_String
>                      length                   : 0x0014 (20)
>                      size                     : 0x0014 (20)
>                      string                   : *
>                          string                   : 'UCWB-0151$'
>                  full_name: struct lsa_String
>                      length                   : 0x0014 (20)
>                      size                     : 0x0014 (20)
>                      string                   : *
>                          string                   : 'UCWB-0151$'
>                  logon_script: struct lsa_String
>                      length                   : 0x0000 (0)
>                      size                     : 0x0000 (0)
>                      string                   : *
>                          string                   : ''
>                  profile_path: struct lsa_String
>                      length                   : 0x0000 (0)
>                      size                     : 0x0000 (0)
>                      string                   : *
>                          string                   : ''
>                  home_directory: struct lsa_String
>                      length                   : 0x0000 (0)
>                      size                     : 0x0000 (0)
>                      string                   : *
>                          string                   : ''
>                  home_drive: struct lsa_String
>                      length                   : 0x0000 (0)
>                      size                     : 0x0000 (0)
>                      string                   : *
>                          string                   : ''
>                  logon_count              : 0x0013 (19)
>                  bad_password_count       : 0x0000 (0)
>                  rid                      : 0x000008bb (2235)
>                  primary_gid              : 0x00000203 (515)
>                  groups: struct samr_RidWithAttributeArray
>                      count                    : 0x00000001 (1)
>                      rids                     : *
>                          rids: ARRAY(1)
>                              rids: struct samr_RidWithAttribute
>                                  rid                      : 0x00000203 (515)
>                                  attributes               : 0x00000007 (7)
>                                         1: SE_GROUP_MANDATORY       
>                                         1: SE_GROUP_ENABLED_BY_DEFAULT
>                                         1: SE_GROUP_ENABLED         
>                                         0: SE_GROUP_OWNER           
>                                         0: SE_GROUP_USE_FOR_DENY_ONLY
>                                         0: SE_GROUP_RESOURCE        
>                                      0x00: SE_GROUP_LOGON_ID         (0)
>                  user_flags               : 0x00000020 (32)
>                         0: NETLOGON_GUEST           
>                         0: NETLOGON_NOENCRYPTION    
>                         0: NETLOGON_CACHED_ACCOUNT  
>                         0: NETLOGON_USED_LM_PASSWORD
>                         1: NETLOGON_EXTRA_SIDS      
>                         0: NETLOGON_SUBAUTH_SESSION_KEY
>                         0: NETLOGON_SERVER_TRUST_ACCOUNT
>                         0: NETLOGON_NTLMV2_ENABLED  
>                         0: NETLOGON_RESOURCE_GROUPS 
>                         0: NETLOGON_PROFILE_PATH_RETURNED
>                         0: NETLOGON_GRACE_LOGON     
>                  key: struct netr_UserSessionKey
>                      key                      : 00000000000000000000000000000000
>                  logon_server: struct lsa_StringLarge
>                      length                   : 0x0016 (22)
>                      size                     : 0x0018 (24)
>                      string                   : *
>                          string                   : 'UCWB-KVM-18'
>                  domain: struct lsa_StringLarge
>                      length                   : 0x0008 (8)
>                      size                     : 0x000a (10)
>                      string                   : *
>                          string                   : 'WUM3'
>                  domain_sid               : *
>                      domain_sid               : S-1-5-21-1202660629-583907252-725345543
>                  LMSessKey: struct netr_LMSessionKey
>                      key                      : 0000000000000000
>                  acct_flags               : 0x00000080 (128)
>                         0: ACB_DISABLED             
>                         0: ACB_HOMDIRREQ            
>                         0: ACB_PWNOTREQ             
>                         0: ACB_TEMPDUP              
>                         0: ACB_NORMAL               
>                         0: ACB_MNS                  
>                         0: ACB_DOMTRUST             
>                         1: ACB_WSTRUST              
>                         0: ACB_SVRTRUST             
>                         0: ACB_PWNOEXP              
>                         0: ACB_AUTOLOCK             
>                         0: ACB_ENC_TXT_PWD_ALLOWED  
>                         0: ACB_SMARTCARD_REQUIRED   
>                         0: ACB_TRUSTED_FOR_DELEGATION
>                         0: ACB_NOT_DELEGATED        
>                         0: ACB_USE_DES_KEY_ONLY     
>                         0: ACB_DONT_REQUIRE_PREAUTH 
>                         0: ACB_PW_EXPIRED           
>                         0: ACB_NO_AUTH_DATA_REQD    
>                  unknown: ARRAY(7)
>                      unknown                  : 0x00000000 (0)
>                      unknown                  : 0x00000000 (0)
>                      unknown                  : 0x00000000 (0)
>                      unknown                  : 0x00000000 (0)
>                      unknown                  : 0x00000000 (0)
>                      unknown                  : 0x00000000 (0)
>                      unknown                  : 0x00000000 (0)
>              sidcount                 : 0x00000000 (0)
>              sids                     : NULL
>[2010/08/27 14:46:46, 10] smbd/sesssetup.c:392(reply_spnego_kerberos)
>  Mapped to [WUM3] (using PAC)
>[2010/08/27 14:46:46,  5] lib/username.c:133(Get_Pwnam_alloc)
>  Finding user WUM3\UCWB-0151$
>[2010/08/27 14:46:46,  5] lib/username.c:77(Get_Pwnam_internals)
>  Trying _Get_Pwnam(), username as lowercase is wum3\ucwb-0151$
>[2010/08/27 14:46:46,  5] lib/username.c:110(Get_Pwnam_internals)
>  Get_Pwnam_internals did find user [WUM3\UCWB-0151$]!
>[2010/08/27 14:46:46,  6] param/loadparm.c:7017(lp_file_list_changed)
>  lp_file_list_changed()
>  file /etc/samba/smb.conf -> /etc/samba/smb.conf  last mod_time: Fri Aug 27 08:26:16 2010
>  
>[2010/08/27 14:46:46,  5] lib/username.c:133(Get_Pwnam_alloc)
>  Finding user WUM3\ucwb-0151$
>[2010/08/27 14:46:46,  5] lib/username.c:77(Get_Pwnam_internals)
>  Trying _Get_Pwnam(), username as lowercase is wum3\ucwb-0151$
>[2010/08/27 14:46:46,  5] lib/username.c:110(Get_Pwnam_internals)
>  Get_Pwnam_internals did find user [WUM3\ucwb-0151$]!
>[2010/08/27 14:46:46,  5] auth/auth_util.c:1517(fill_sam_account)
>  fill_sam_account: located username was [WUM3\ucwb-0151$]
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:607(pdb_set_username)
>  pdb_set_username: setting username WUM3\ucwb-0151$, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:676(pdb_set_fullname)
>  pdb_set_full_name: setting full name , was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:630(pdb_set_domain)
>  pdb_set_domain: setting domain BRIGHTON, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:536(pdb_set_user_sid)
>  pdb_set_user_sid: setting user sid S-1-5-21-1410203337-155486731-3094506392-22336
>[2010/08/27 14:46:46, 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-1410203337-155486731-3094506392-22336 from rid 22336
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:653(pdb_set_nt_username)
>  pdb_set_nt_username: setting nt username UCWB-0151$, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:607(pdb_set_username)
>  pdb_set_username: setting username UCWB-0151$, was WUM3\ucwb-0151$
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:630(pdb_set_domain)
>  pdb_set_domain: setting domain WUM3, was BRIGHTON
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:536(pdb_set_user_sid)
>  pdb_set_user_sid: setting user sid S-1-5-21-1202660629-583907252-725345543-2235
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:594(pdb_set_group_sid)
>  pdb_set_group_sid: setting group sid S-1-5-21-1202660629-583907252-725345543-515
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:676(pdb_set_fullname)
>  pdb_set_full_name: setting full name UCWB-0151$, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:699(pdb_set_logon_script)
>  pdb_set_logon_script: setting logon script , was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:722(pdb_set_profile_path)
>  pdb_set_profile_path: setting profile path , was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:769(pdb_set_homedir)
>  pdb_set_homedir: setting home dir , was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:745(pdb_set_dir_drive)
>  pdb_set_dir_drive: setting dir drive , was NULL
>[2010/08/27 14:46:46, 10] auth/token_util.c:353(create_local_nt_token)
>  Create local NT token for S-1-5-21-1202660629-583907252-725345543-2235
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-5-21-1202660629-583907252-725345543-2235]
>[2010/08/27 14:46:46,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-5-21-1202660629-583907252-725345543-515]
>[2010/08/27 14:46:46,  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
>[2010/08/27 14:46:46,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-5-2]
>[2010/08/27 14:46:46,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-5-11]
>[2010/08/27 14:46:46, 10] auth/token_util.c:528(debug_nt_user_token)
>  NT user token of user S-1-5-21-1202660629-583907252-725345543-2235
>  contains 10 SIDs
>  SID[  0]: S-1-5-21-1202660629-583907252-725345543-2235
>  SID[  1]: S-1-5-21-1202660629-583907252-725345543-515
>  SID[  2]: S-1-1-0
>  SID[  3]: S-1-5-2
>  SID[  4]: S-1-5-11
>  SID[  5]: S-1-22-1-10668
>  SID[  6]: S-1-22-2-10001
>  SID[  7]: S-1-22-2-10347
>  SID[  8]: S-1-22-2-10348
>  SID[  9]: S-1-22-2-10363
>  SE_PRIV  0x0 0x0 0x0 0x0
>[2010/08/27 14:46:46, 10] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 10668
>  Primary group is 10001 and contains 4 supplementary groups
>  Group[  0]: 10001
>  Group[  1]: 10347
>  Group[  2]: 10348
>  Group[  3]: 10363
>[2010/08/27 14:46:46, 10] smbd/password.c:172(register_initial_vuid)
>  register_initial_vuid: allocated vuid = 105
>[2010/08/27 14:46:46, 10] smbd/password.c:265(register_existing_vuid)
>  register_existing_vuid: (10668,10001) WUM3\ucwb-0151$ UCWB-0151$ WUM3 guest=0
>[2010/08/27 14:46:46,  3] smbd/password.c:269(register_existing_vuid)
>  register_existing_vuid: User name: WUM3\ucwb-0151$	Real name: UCWB-0151$
>[2010/08/27 14:46:46,  3] smbd/password.c:279(register_existing_vuid)
>  register_existing_vuid: UNIX uid 10668 is UNIX user WUM3\ucwb-0151$, and will be vuid 105
>[2010/08/27 14:46:46, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)
>  Locking key 49442F32393932302F31
>[2010/08/27 14:46:46, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)
>  Allocated locked data 0x0xb9180460
>[2010/08/27 14:46:46, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)
>  Unlocking key 49442F32393932302F31
>[2010/08/27 14:46:46,  7] param/loadparm.c:9279(lp_servicenumber)
>  lp_servicenumber: couldn't find WUM3\ucwb-0151$
>[2010/08/27 14:46:46,  3] smbd/password.c:211(register_homes_share)
>  Adding homes service for user 'WUM3\ucwb-0151$' using home directory: '/home/WUM3/ucwb-0151_'
>[2010/08/27 14:46:46,  3] param/loadparm.c:6149(lp_add_home)
>  adding home's share [ucwb-0151$] for user 'WUM3\ucwb-0151$' at '/home/WUM3/ucwb-0151_'
>[2010/08/27 14:46:46,  6] param/loadparm.c:7017(lp_file_list_changed)
>  lp_file_list_changed()
>  file /etc/samba/smb.conf -> /etc/samba/smb.conf  last mod_time: Fri Aug 27 08:26:16 2010
>  
>[2010/08/27 14:46:46,  5] lib/util.c:632(show_msg)
>[2010/08/27 14:46:46,  5] lib/util.c:642(show_msg)
>  size=238
>  smb_com=0x73
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=51201
>  smb_tid=0
>  smb_pid=65279
>  smb_uid=105
>  smb_mid=1472
>  smt_wct=4
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]=  151 (0x97)
>  smb_bcc=195
>[2010/08/27 14:46:46, 10] ../lib/util/util.c:304(_dump_data)
>  [0000] A1 81 94 30 81 91 A0 03   0A 01 00 A1 0B 06 09 2A   ...0.... .......*
>  [0010] 86 48 82 F7 12 01 02 02   A2 7D 04 7B 60 79 06 09   .H...... .}.{`y..
>  [0020] 2A 86 48 86 F7 12 01 02   02 02 00 6F 6A 30 68 A0   *.H..... ...oj0h.
>  [0030] 03 02 01 05 A1 03 02 01   0F A2 5C 30 5A A0 03 02   ........ ..\0Z...
>  [0040] 01 17 A2 53 04 51 75 28   5C 07 76 C1 72 E8 33 82   ...S.Qu( \.v.r.3.
>  [0050] 2A E7 2C D3 E7 D1 5C 39   2B AA 46 F9 15 F5 2F B3   *.,...\9 +.F.../.
>  [0060] 5D DD DE 19 A4 38 04 45   6F A5 4E E1 7E 66 40 0B   ]....8.E o.N.~f@.
>  [0070] 7A 2F 0F D0 63 2F F3 3E   AC 01 95 39 38 2F 18 64   z/..c/.> ...98/.d
>  [0080] C3 DE 0C 59 94 92 27 31   49 9D A8 31 89 F4 49 86   ...Y..'1 I..1..I.
>  [0090] 40 50 E5 4C C8 9F 70 55   00 6E 00 69 00 78 00 00   @P.L..pU .n.i.x..
>  [00A0] 00 53 00 61 00 6D 00 62   00 61 00 20 00 33 00 2E   .S.a.m.b .a. .3..
>  [00B0] 00 34 00 2E 00 38 00 00   00 57 00 55 00 4D 00 33   .4...8.. .W.U.M.3
>  [00C0] 00 00 00                                          ... 
>[2010/08/27 14:46:46, 10] lib/util_sock.c:789(read_smb_length_return_keepalive)
>  got smb length of 106
>[2010/08/27 14:46:46,  6] smbd/process.c:1456(process_smb)
>  got message type 0x0 of len 0x6a
>[2010/08/27 14:46:46,  3] smbd/process.c:1459(process_smb)
>  Transaction 24 of length 110 (0 toread)
>[2010/08/27 14:46:46,  5] lib/util.c:632(show_msg)
>[2010/08/27 14:46:46,  5] lib/util.c:642(show_msg)
>  size=106
>  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=105
>  smb_mid=1536
>  smt_wct=4
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]=  106 (0x6A)
>  smb_vwv[ 2]=    8 (0x8)
>  smb_vwv[ 3]=    1 (0x1)
>  smb_bcc=63
>[2010/08/27 14:46:46, 10] ../lib/util/util.c:304(_dump_data)
>  [0000] 00 5C 00 5C 00 42 00 52   00 49 00 47 00 48 00 54   .\.\.B.R .I.G.H.T
>  [0010] 00 4F 00 4E 00 2E 00 57   00 55 00 4D 00 49 00 2E   .O.N...W .U.M.I..
>  [0020] 00 4F 00 52 00 47 00 2E   00 41 00 55 00 5C 00 49   .O.R.G.. .A.U.\.I
>  [0030] 00 50 00 43 00 24 00 00   00 3F 3F 3F 3F 3F 00     .P.C.$.. .?????.
>[2010/08/27 14:46:46,  3] smbd/process.c:1273(switch_message)
>  switch message SMBtconX (pid 29920) conn 0x0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46,  5] smbd/uid.c:368(change_to_root_user)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2010/08/27 14:46:46,  4] smbd/reply.c:680(reply_tcon_and_X)
>  Client requested device type [?????] for share [IPC$]
>[2010/08/27 14:46:46,  5] smbd/service.c:1216(make_connection)
>  making a connection to 'normal' service ipc$
>[2010/08/27 14:46:46,  3] lib/util_sid.c:228(string_to_sid)
>  string_to_sid: Sid root does not start with 'S-'.
>[2010/08/27 14:46:46, 10] passdb/lookup_sid.c:69(lookup_name)
>  lookup_name: BRIGHTON\root => BRIGHTON (domain), root (name)
>[2010/08/27 14:46:46, 10] passdb/lookup_sid.c:70(lookup_name)
>  lookup_name: flags = 0x073
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:607(pdb_set_username)
>  pdb_set_username: setting username root, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:630(pdb_set_domain)
>  pdb_set_domain: setting domain BRIGHTON, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:653(pdb_set_nt_username)
>  pdb_set_nt_username: setting nt username , was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:676(pdb_set_fullname)
>  pdb_set_full_name: setting full name root, was 
>[2010/08/27 14:46:46,  4] lib/substitute.c:504(automount_server)
>  Home server: brighton
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:769(pdb_set_homedir)
>  pdb_set_homedir: setting home dir \\brighton\root, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:745(pdb_set_dir_drive)
>  pdb_set_dir_drive: setting dir drive , was NULL
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:699(pdb_set_logon_script)
>  pdb_set_logon_script: setting logon script , was 
>[2010/08/27 14:46:46,  4] lib/substitute.c:504(automount_server)
>  Home server: brighton
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:722(pdb_set_profile_path)
>  pdb_set_profile_path: setting profile path \\brighton\root\profile, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:812(pdb_set_workstations)
>  pdb_set_workstations: setting workstations , was 
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:536(pdb_set_user_sid)
>  pdb_set_user_sid: setting user sid S-1-5-21-1410203337-155486731-3094506392-1000
>[2010/08/27 14:46:46, 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-1410203337-155486731-3094506392-1000 from rid 1000
>[2010/08/27 14:46:46,  5] lib/username.c:133(Get_Pwnam_alloc)
>  Finding user root
>[2010/08/27 14:46:46,  5] lib/username.c:77(Get_Pwnam_internals)
>  Trying _Get_Pwnam(), username as lowercase is root
>[2010/08/27 14:46:46,  5] lib/username.c:110(Get_Pwnam_internals)
>  Get_Pwnam_internals did find user [root]!
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:607(pdb_set_username)
>  pdb_set_username: setting username root, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:630(pdb_set_domain)
>  pdb_set_domain: setting domain BRIGHTON, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:653(pdb_set_nt_username)
>  pdb_set_nt_username: setting nt username , was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:676(pdb_set_fullname)
>  pdb_set_full_name: setting full name root, was 
>[2010/08/27 14:46:46,  4] lib/substitute.c:504(automount_server)
>  Home server: brighton
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:769(pdb_set_homedir)
>  pdb_set_homedir: setting home dir \\brighton\root, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:745(pdb_set_dir_drive)
>  pdb_set_dir_drive: setting dir drive , was NULL
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:699(pdb_set_logon_script)
>  pdb_set_logon_script: setting logon script , was 
>[2010/08/27 14:46:46,  4] lib/substitute.c:504(automount_server)
>  Home server: brighton
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:722(pdb_set_profile_path)
>  pdb_set_profile_path: setting profile path \\brighton\root\profile, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:812(pdb_set_workstations)
>  pdb_set_workstations: setting workstations , was 
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:536(pdb_set_user_sid)
>  pdb_set_user_sid: setting user sid S-1-5-21-1410203337-155486731-3094506392-1000
>[2010/08/27 14:46:46, 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-1410203337-155486731-3094506392-1000 from rid 1000
>[2010/08/27 14:46:46, 10] lib/gencache.c:208(gencache_get)
>  Returning valid cache entry: key = IDMAP/SID2GID/S-1-5-21-1410203337-155486731-3094506392-513, value = -1, timeout = Fri Aug 27 14:47:12 2010
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46,  5] passdb/pdb_interface.c:1513(lookup_global_sam_rid)
>  lookup_global_sam_rid: looking up RID 513.
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46,  5] passdb/pdb_tdb.c:609(tdbsam_getsampwrid)
>  pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201.
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  5] passdb/pdb_interface.c:1576(lookup_global_sam_rid)
>  Can't find a unix id for an unmapped group
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46, 10] passdb/lookup_sid.c:1274(legacy_sid_to_gid)
>  LEGACY: mapping failed for sid S-1-5-21-1410203337-155486731-3094506392-513
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:594(pdb_set_group_sid)
>  pdb_set_group_sid: setting group sid S-1-5-21-1410203337-155486731-3094506392-513
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46, 10] smbd/share_access.c:234(user_ok_token)
>  user_ok_token: share IPC$ is ok for unix user WUM3\ucwb-0151$
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: maximum password age, val: -1
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:607(pdb_set_username)
>  pdb_set_username: setting username UCWB-0151$, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:630(pdb_set_domain)
>  pdb_set_domain: setting domain WUM3, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:653(pdb_set_nt_username)
>  pdb_set_nt_username: setting nt username UCWB-0151$, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:676(pdb_set_fullname)
>  pdb_set_full_name: setting full name UCWB-0151$, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:769(pdb_set_homedir)
>  pdb_set_homedir: setting home dir , was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:745(pdb_set_dir_drive)
>  pdb_set_dir_drive: setting dir drive , was NULL
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:699(pdb_set_logon_script)
>  pdb_set_logon_script: setting logon script , was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:722(pdb_set_profile_path)
>  pdb_set_profile_path: setting profile path , was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:812(pdb_set_workstations)
>  pdb_set_workstations: setting workstations , was 
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:536(pdb_set_user_sid)
>  pdb_set_user_sid: setting user sid S-1-5-21-1410203337-155486731-3094506392-0
>[2010/08/27 14:46:46, 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-1410203337-155486731-3094506392-0 from rid 0
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:594(pdb_set_group_sid)
>  pdb_set_group_sid: setting group sid S-1-5-21-1202660629-583907252-725345543-515
>[2010/08/27 14:46:46,  5] lib/username.c:133(Get_Pwnam_alloc)
>  Finding user WUM3\ucwb-0151$
>[2010/08/27 14:46:46,  5] lib/username.c:77(Get_Pwnam_internals)
>  Trying _Get_Pwnam(), username as lowercase is wum3\ucwb-0151$
>[2010/08/27 14:46:46,  5] lib/username.c:110(Get_Pwnam_internals)
>  Get_Pwnam_internals did find user [WUM3\ucwb-0151$]!
>[2010/08/27 14:46:46, 10] smbd/service.c:163(set_conn_connectpath)
>  set_conn_connectpath: service IPC$, connectpath = /tmp
>[2010/08/27 14:46:46,  3] smbd/service.c:807(make_connection_snum)
>  Connect path is '/tmp' for service [IPC$]
>[2010/08/27 14:46:46, 10] lib/util_seaccess.c:58(se_map_generic)
>  se_map_generic(): mapped mask 0x10000000 to 0x001f01ff
>[2010/08/27 14:46:46,  3] smbd/vfs.c:95(vfs_init_default)
>  Initialising default vfs hooks
>[2010/08/27 14:46:46,  3] smbd/vfs.c:129(vfs_init_custom)
>  Initialising custom vfs hooks from [/[Default VFS]/]
>[2010/08/27 14:46:46, 10] smbd/vfs.c:47(vfs_find_backend_entry)
>  vfs_find_backend_entry called for /[Default VFS]/
>  Successfully loaded vfs module [/[Default VFS]/] with the new modules system
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #0 (type 0, layer 0)
>  Making operation type 0 opaque [module /[Default VFS]/]
>  Accepting operation type 0 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #1 (type 1, layer 0)
>  Making operation type 1 opaque [module /[Default VFS]/]
>  Accepting operation type 1 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #2 (type 2, layer 0)
>  Making operation type 2 opaque [module /[Default VFS]/]
>  Accepting operation type 2 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #3 (type 3, layer 0)
>  Making operation type 3 opaque [module /[Default VFS]/]
>  Accepting operation type 3 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #4 (type 4, layer 0)
>  Making operation type 4 opaque [module /[Default VFS]/]
>  Accepting operation type 4 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #5 (type 5, layer 0)
>  Making operation type 5 opaque [module /[Default VFS]/]
>  Accepting operation type 5 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #6 (type 6, layer 0)
>  Making operation type 6 opaque [module /[Default VFS]/]
>  Accepting operation type 6 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #7 (type 7, layer 0)
>  Making operation type 7 opaque [module /[Default VFS]/]
>  Accepting operation type 7 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #8 (type 8, layer 0)
>  Making operation type 8 opaque [module /[Default VFS]/]
>  Accepting operation type 8 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #9 (type 9, layer 0)
>  Making operation type 9 opaque [module /[Default VFS]/]
>  Accepting operation type 9 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #10 (type 10, layer 0)
>  Making operation type 10 opaque [module /[Default VFS]/]
>  Accepting operation type 10 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #11 (type 11, layer 0)
>  Making operation type 11 opaque [module /[Default VFS]/]
>  Accepting operation type 11 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #12 (type 12, layer 0)
>  Making operation type 12 opaque [module /[Default VFS]/]
>  Accepting operation type 12 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #13 (type 13, layer 0)
>  Making operation type 13 opaque [module /[Default VFS]/]
>  Accepting operation type 13 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #14 (type 14, layer 0)
>  Making operation type 14 opaque [module /[Default VFS]/]
>  Accepting operation type 14 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #15 (type 15, layer 0)
>  Making operation type 15 opaque [module /[Default VFS]/]
>  Accepting operation type 15 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #16 (type 16, layer 0)
>  Making operation type 16 opaque [module /[Default VFS]/]
>  Accepting operation type 16 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #17 (type 17, layer 0)
>  Making operation type 17 opaque [module /[Default VFS]/]
>  Accepting operation type 17 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #18 (type 18, layer 0)
>  Making operation type 18 opaque [module /[Default VFS]/]
>  Accepting operation type 18 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #19 (type 19, layer 0)
>  Making operation type 19 opaque [module /[Default VFS]/]
>  Accepting operation type 19 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #20 (type 20, layer 0)
>  Making operation type 20 opaque [module /[Default VFS]/]
>  Accepting operation type 20 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #21 (type 21, layer 0)
>  Making operation type 21 opaque [module /[Default VFS]/]
>  Accepting operation type 21 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #22 (type 22, layer 0)
>  Making operation type 22 opaque [module /[Default VFS]/]
>  Accepting operation type 22 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #23 (type 23, layer 0)
>  Making operation type 23 opaque [module /[Default VFS]/]
>  Accepting operation type 23 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #24 (type 24, layer 0)
>  Making operation type 24 opaque [module /[Default VFS]/]
>  Accepting operation type 24 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #25 (type 25, layer 0)
>  Making operation type 25 opaque [module /[Default VFS]/]
>  Accepting operation type 25 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #26 (type 26, layer 0)
>  Making operation type 26 opaque [module /[Default VFS]/]
>  Accepting operation type 26 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #27 (type 27, layer 0)
>  Making operation type 27 opaque [module /[Default VFS]/]
>  Accepting operation type 27 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #28 (type 28, layer 0)
>  Making operation type 28 opaque [module /[Default VFS]/]
>  Accepting operation type 28 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #29 (type 29, layer 0)
>  Making operation type 29 opaque [module /[Default VFS]/]
>  Accepting operation type 29 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #30 (type 30, layer 0)
>  Making operation type 30 opaque [module /[Default VFS]/]
>  Accepting operation type 30 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #31 (type 31, layer 0)
>  Making operation type 31 opaque [module /[Default VFS]/]
>  Accepting operation type 31 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #32 (type 32, layer 0)
>  Making operation type 32 opaque [module /[Default VFS]/]
>  Accepting operation type 32 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #33 (type 33, layer 0)
>  Making operation type 33 opaque [module /[Default VFS]/]
>  Accepting operation type 33 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #34 (type 34, layer 0)
>  Making operation type 34 opaque [module /[Default VFS]/]
>  Accepting operation type 34 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #35 (type 35, layer 0)
>  Making operation type 35 opaque [module /[Default VFS]/]
>  Accepting operation type 35 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #36 (type 36, layer 0)
>  Making operation type 36 opaque [module /[Default VFS]/]
>  Accepting operation type 36 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #37 (type 37, layer 0)
>  Making operation type 37 opaque [module /[Default VFS]/]
>  Accepting operation type 37 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #38 (type 38, layer 0)
>  Making operation type 38 opaque [module /[Default VFS]/]
>  Accepting operation type 38 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #39 (type 39, layer 0)
>  Making operation type 39 opaque [module /[Default VFS]/]
>  Accepting operation type 39 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #40 (type 40, layer 0)
>  Making operation type 40 opaque [module /[Default VFS]/]
>  Accepting operation type 40 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #41 (type 41, layer 0)
>  Making operation type 41 opaque [module /[Default VFS]/]
>  Accepting operation type 41 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #42 (type 42, layer 0)
>  Making operation type 42 opaque [module /[Default VFS]/]
>  Accepting operation type 42 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #43 (type 43, layer 0)
>  Making operation type 43 opaque [module /[Default VFS]/]
>  Accepting operation type 43 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #44 (type 44, layer 0)
>  Making operation type 44 opaque [module /[Default VFS]/]
>  Accepting operation type 44 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #45 (type 45, layer 0)
>  Making operation type 45 opaque [module /[Default VFS]/]
>  Accepting operation type 45 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #46 (type 46, layer 0)
>  Making operation type 46 opaque [module /[Default VFS]/]
>  Accepting operation type 46 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #47 (type 47, layer 0)
>  Making operation type 47 opaque [module /[Default VFS]/]
>  Accepting operation type 47 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #48 (type 48, layer 0)
>  Making operation type 48 opaque [module /[Default VFS]/]
>  Accepting operation type 48 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #49 (type 49, layer 0)
>  Making operation type 49 opaque [module /[Default VFS]/]
>  Accepting operation type 49 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #50 (type 50, layer 0)
>  Making operation type 50 opaque [module /[Default VFS]/]
>  Accepting operation type 50 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #51 (type 51, layer 0)
>  Making operation type 51 opaque [module /[Default VFS]/]
>  Accepting operation type 51 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #52 (type 52, layer 0)
>  Making operation type 52 opaque [module /[Default VFS]/]
>  Accepting operation type 52 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #53 (type 53, layer 0)
>  Making operation type 53 opaque [module /[Default VFS]/]
>  Accepting operation type 53 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #54 (type 54, layer 0)
>  Making operation type 54 opaque [module /[Default VFS]/]
>  Accepting operation type 54 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #55 (type 55, layer 0)
>  Making operation type 55 opaque [module /[Default VFS]/]
>  Accepting operation type 55 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #56 (type 56, layer 0)
>  Making operation type 56 opaque [module /[Default VFS]/]
>  Accepting operation type 56 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #57 (type 57, layer 0)
>  Making operation type 57 opaque [module /[Default VFS]/]
>  Accepting operation type 57 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #58 (type 58, layer 0)
>  Making operation type 58 opaque [module /[Default VFS]/]
>  Accepting operation type 58 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #59 (type 59, layer 0)
>  Making operation type 59 opaque [module /[Default VFS]/]
>  Accepting operation type 59 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #60 (type 60, layer 0)
>  Making operation type 60 opaque [module /[Default VFS]/]
>  Accepting operation type 60 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #61 (type 61, layer 0)
>  Making operation type 61 opaque [module /[Default VFS]/]
>  Accepting operation type 61 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #62 (type 62, layer 0)
>  Making operation type 62 opaque [module /[Default VFS]/]
>  Accepting operation type 62 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #63 (type 63, layer 0)
>  Making operation type 63 opaque [module /[Default VFS]/]
>  Accepting operation type 63 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #64 (type 64, layer 0)
>  Making operation type 64 opaque [module /[Default VFS]/]
>  Accepting operation type 64 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #65 (type 65, layer 0)
>  Making operation type 65 opaque [module /[Default VFS]/]
>  Accepting operation type 65 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #66 (type 66, layer 0)
>  Making operation type 66 opaque [module /[Default VFS]/]
>  Accepting operation type 66 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #67 (type 67, layer 0)
>  Making operation type 67 opaque [module /[Default VFS]/]
>  Accepting operation type 67 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #68 (type 68, layer 0)
>  Making operation type 68 opaque [module /[Default VFS]/]
>  Accepting operation type 68 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #69 (type 69, layer 0)
>  Making operation type 69 opaque [module /[Default VFS]/]
>  Accepting operation type 69 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #70 (type 70, layer 0)
>  Making operation type 70 opaque [module /[Default VFS]/]
>  Accepting operation type 70 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #71 (type 71, layer 0)
>  Making operation type 71 opaque [module /[Default VFS]/]
>  Accepting operation type 71 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #72 (type 72, layer 0)
>  Making operation type 72 opaque [module /[Default VFS]/]
>  Accepting operation type 72 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #73 (type 73, layer 0)
>  Making operation type 73 opaque [module /[Default VFS]/]
>  Accepting operation type 73 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #74 (type 74, layer 0)
>  Making operation type 74 opaque [module /[Default VFS]/]
>  Accepting operation type 74 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #75 (type 75, layer 0)
>  Making operation type 75 opaque [module /[Default VFS]/]
>  Accepting operation type 75 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #76 (type 76, layer 0)
>  Making operation type 76 opaque [module /[Default VFS]/]
>  Accepting operation type 76 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #77 (type 77, layer 0)
>  Making operation type 77 opaque [module /[Default VFS]/]
>  Accepting operation type 77 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #78 (type 78, layer 0)
>  Making operation type 78 opaque [module /[Default VFS]/]
>  Accepting operation type 78 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #79 (type 79, layer 0)
>  Making operation type 79 opaque [module /[Default VFS]/]
>  Accepting operation type 79 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #80 (type 80, layer 0)
>  Making operation type 80 opaque [module /[Default VFS]/]
>  Accepting operation type 80 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #81 (type 81, layer 0)
>  Making operation type 81 opaque [module /[Default VFS]/]
>  Accepting operation type 81 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #82 (type 82, layer 0)
>  Making operation type 82 opaque [module /[Default VFS]/]
>  Accepting operation type 82 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #83 (type 83, layer 0)
>  Making operation type 83 opaque [module /[Default VFS]/]
>  Accepting operation type 83 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #84 (type 84, layer 0)
>  Making operation type 84 opaque [module /[Default VFS]/]
>  Accepting operation type 84 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #85 (type 85, layer 0)
>  Making operation type 85 opaque [module /[Default VFS]/]
>  Accepting operation type 85 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #86 (type 86, layer 0)
>  Making operation type 86 opaque [module /[Default VFS]/]
>  Accepting operation type 86 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #87 (type 87, layer 0)
>  Making operation type 87 opaque [module /[Default VFS]/]
>  Accepting operation type 87 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #88 (type 88, layer 0)
>  Making operation type 88 opaque [module /[Default VFS]/]
>  Accepting operation type 88 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #89 (type 89, layer 0)
>  Making operation type 89 opaque [module /[Default VFS]/]
>  Accepting operation type 89 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #90 (type 90, layer 0)
>  Making operation type 90 opaque [module /[Default VFS]/]
>  Accepting operation type 90 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #91 (type 91, layer 0)
>  Making operation type 91 opaque [module /[Default VFS]/]
>  Accepting operation type 91 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #92 (type 92, layer 0)
>  Making operation type 92 opaque [module /[Default VFS]/]
>  Accepting operation type 92 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #93 (type 93, layer 0)
>  Making operation type 93 opaque [module /[Default VFS]/]
>  Accepting operation type 93 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #94 (type 94, layer 0)
>  Making operation type 94 opaque [module /[Default VFS]/]
>  Accepting operation type 94 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #95 (type 95, layer 0)
>  Making operation type 95 opaque [module /[Default VFS]/]
>  Accepting operation type 95 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #96 (type 96, layer 0)
>  Making operation type 96 opaque [module /[Default VFS]/]
>  Accepting operation type 96 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #97 (type 97, layer 0)
>  Making operation type 97 opaque [module /[Default VFS]/]
>  Accepting operation type 97 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #98 (type 98, layer 0)
>  Making operation type 98 opaque [module /[Default VFS]/]
>  Accepting operation type 98 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #99 (type 99, layer 0)
>  Making operation type 99 opaque [module /[Default VFS]/]
>  Accepting operation type 99 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #100 (type 100, layer 0)
>  Making operation type 100 opaque [module /[Default VFS]/]
>  Accepting operation type 100 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #101 (type 101, layer 0)
>  Making operation type 101 opaque [module /[Default VFS]/]
>  Accepting operation type 101 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #102 (type 102, layer 0)
>  Making operation type 102 opaque [module /[Default VFS]/]
>  Accepting operation type 102 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #103 (type 103, layer 0)
>  Making operation type 103 opaque [module /[Default VFS]/]
>  Accepting operation type 103 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #104 (type 104, layer 0)
>  Making operation type 104 opaque [module /[Default VFS]/]
>  Accepting operation type 104 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #105 (type 105, layer 0)
>  Making operation type 105 opaque [module /[Default VFS]/]
>  Accepting operation type 105 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #106 (type 106, layer 0)
>  Making operation type 106 opaque [module /[Default VFS]/]
>  Accepting operation type 106 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #107 (type 107, layer 0)
>  Making operation type 107 opaque [module /[Default VFS]/]
>  Accepting operation type 107 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #108 (type 108, layer 0)
>  Making operation type 108 opaque [module /[Default VFS]/]
>  Accepting operation type 108 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #109 (type 109, layer 0)
>  Making operation type 109 opaque [module /[Default VFS]/]
>  Accepting operation type 109 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #110 (type 110, layer 0)
>  Making operation type 110 opaque [module /[Default VFS]/]
>  Accepting operation type 110 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/connection.c:142(claim_connection)
>  claiming [IPC$]
>[2010/08/27 14:46:46, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)
>  Locking key E0740000FFFFFFFF0100
>[2010/08/27 14:46:46, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)
>  Allocated locked data 0x0xb918cf78
>[2010/08/27 14:46:46, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)
>  Unlocking key E0740000FFFFFFFF0100
>[2010/08/27 14:46:46, 10] smbd/service.c:163(set_conn_connectpath)
>  set_conn_connectpath: service IPC$, connectpath = /tmp
>[2010/08/27 14:46:46,  3] lib/util_sid.c:228(string_to_sid)
>  string_to_sid: Sid root does not start with 'S-'.
>[2010/08/27 14:46:46, 10] passdb/lookup_sid.c:69(lookup_name)
>  lookup_name: BRIGHTON\root => BRIGHTON (domain), root (name)
>[2010/08/27 14:46:46, 10] passdb/lookup_sid.c:70(lookup_name)
>  lookup_name: flags = 0x073
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:607(pdb_set_username)
>  pdb_set_username: setting username root, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:630(pdb_set_domain)
>  pdb_set_domain: setting domain BRIGHTON, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:653(pdb_set_nt_username)
>  pdb_set_nt_username: setting nt username , was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:676(pdb_set_fullname)
>  pdb_set_full_name: setting full name root, was 
>[2010/08/27 14:46:46,  4] lib/substitute.c:504(automount_server)
>  Home server: brighton
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:769(pdb_set_homedir)
>  pdb_set_homedir: setting home dir \\brighton\root, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:745(pdb_set_dir_drive)
>  pdb_set_dir_drive: setting dir drive , was NULL
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:699(pdb_set_logon_script)
>  pdb_set_logon_script: setting logon script , was 
>[2010/08/27 14:46:46,  4] lib/substitute.c:504(automount_server)
>  Home server: brighton
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:722(pdb_set_profile_path)
>  pdb_set_profile_path: setting profile path \\brighton\root\profile, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:812(pdb_set_workstations)
>  pdb_set_workstations: setting workstations , was 
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:536(pdb_set_user_sid)
>  pdb_set_user_sid: setting user sid S-1-5-21-1410203337-155486731-3094506392-1000
>[2010/08/27 14:46:46, 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-1410203337-155486731-3094506392-1000 from rid 1000
>[2010/08/27 14:46:46,  5] lib/username.c:133(Get_Pwnam_alloc)
>  Finding user root
>[2010/08/27 14:46:46,  5] lib/username.c:77(Get_Pwnam_internals)
>  Trying _Get_Pwnam(), username as lowercase is root
>[2010/08/27 14:46:46,  5] lib/username.c:110(Get_Pwnam_internals)
>  Get_Pwnam_internals did find user [root]!
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:607(pdb_set_username)
>  pdb_set_username: setting username root, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:630(pdb_set_domain)
>  pdb_set_domain: setting domain BRIGHTON, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:653(pdb_set_nt_username)
>  pdb_set_nt_username: setting nt username , was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:676(pdb_set_fullname)
>  pdb_set_full_name: setting full name root, was 
>[2010/08/27 14:46:46,  4] lib/substitute.c:504(automount_server)
>  Home server: brighton
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:769(pdb_set_homedir)
>  pdb_set_homedir: setting home dir \\brighton\root, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:745(pdb_set_dir_drive)
>  pdb_set_dir_drive: setting dir drive , was NULL
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:699(pdb_set_logon_script)
>  pdb_set_logon_script: setting logon script , was 
>[2010/08/27 14:46:46,  4] lib/substitute.c:504(automount_server)
>  Home server: brighton
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:722(pdb_set_profile_path)
>  pdb_set_profile_path: setting profile path \\brighton\root\profile, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:812(pdb_set_workstations)
>  pdb_set_workstations: setting workstations , was 
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:536(pdb_set_user_sid)
>  pdb_set_user_sid: setting user sid S-1-5-21-1410203337-155486731-3094506392-1000
>[2010/08/27 14:46:46, 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-1410203337-155486731-3094506392-1000 from rid 1000
>[2010/08/27 14:46:46, 10] lib/gencache.c:208(gencache_get)
>  Returning valid cache entry: key = IDMAP/SID2GID/S-1-5-21-1410203337-155486731-3094506392-513, value = -1, timeout = Fri Aug 27 14:47:12 2010
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46,  5] passdb/pdb_interface.c:1513(lookup_global_sam_rid)
>  lookup_global_sam_rid: looking up RID 513.
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46,  5] passdb/pdb_tdb.c:609(tdbsam_getsampwrid)
>  pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201.
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  5] passdb/pdb_interface.c:1576(lookup_global_sam_rid)
>  Can't find a unix id for an unmapped group
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46, 10] passdb/lookup_sid.c:1274(legacy_sid_to_gid)
>  LEGACY: mapping failed for sid S-1-5-21-1410203337-155486731-3094506392-513
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:594(pdb_set_group_sid)
>  pdb_set_group_sid: setting group sid S-1-5-21-1410203337-155486731-3094506392-513
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46, 10] smbd/share_access.c:234(user_ok_token)
>  user_ok_token: share IPC$ is ok for unix user WUM3\ucwb-0151$
>[2010/08/27 14:46:46, 10] smbd/share_access.c:279(is_share_read_only_for_token)
>  is_share_read_only_for_user: share IPC$ is read-only for unix user WUM3\ucwb-0151$
>[2010/08/27 14:46:46, 10] lib/util_seaccess.c:58(se_map_generic)
>  se_map_generic(): mapped mask 0x10000000 to 0x001f01ff
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: maximum password age, val: -1
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:607(pdb_set_username)
>  pdb_set_username: setting username UCWB-0151$, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:630(pdb_set_domain)
>  pdb_set_domain: setting domain WUM3, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:653(pdb_set_nt_username)
>  pdb_set_nt_username: setting nt username UCWB-0151$, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:676(pdb_set_fullname)
>  pdb_set_full_name: setting full name UCWB-0151$, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:769(pdb_set_homedir)
>  pdb_set_homedir: setting home dir , was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:745(pdb_set_dir_drive)
>  pdb_set_dir_drive: setting dir drive , was NULL
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:699(pdb_set_logon_script)
>  pdb_set_logon_script: setting logon script , was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:722(pdb_set_profile_path)
>  pdb_set_profile_path: setting profile path , was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:812(pdb_set_workstations)
>  pdb_set_workstations: setting workstations , was 
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:536(pdb_set_user_sid)
>  pdb_set_user_sid: setting user sid S-1-5-21-1410203337-155486731-3094506392-0
>[2010/08/27 14:46:46, 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-1410203337-155486731-3094506392-0 from rid 0
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:594(pdb_set_group_sid)
>  pdb_set_group_sid: setting group sid S-1-5-21-1202660629-583907252-725345543-515
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (10668, 10001) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  5] auth/token_util.c:528(debug_nt_user_token)
>  NT user token of user S-1-5-21-1202660629-583907252-725345543-2235
>  contains 10 SIDs
>  SID[  0]: S-1-5-21-1202660629-583907252-725345543-2235
>  SID[  1]: S-1-5-21-1202660629-583907252-725345543-515
>  SID[  2]: S-1-1-0
>  SID[  3]: S-1-5-2
>  SID[  4]: S-1-5-11
>  SID[  5]: S-1-22-1-10668
>  SID[  6]: S-1-22-2-10001
>  SID[  7]: S-1-22-2-10347
>  SID[  8]: S-1-22-2-10348
>  SID[  9]: S-1-22-2-10363
>  SE_PRIV  0x0 0x0 0x0 0x0
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 10668
>  Primary group is 10001 and contains 4 supplementary groups
>  Group[  0]: 10001
>  Group[  1]: 10347
>  Group[  2]: 10348
>  Group[  3]: 10363
>[2010/08/27 14:46:46,  5] smbd/uid.c:353(change_to_user)
>  change_to_user uid=(0,10668) gid=(0,10001)
>[2010/08/27 14:46:46,  3] smbd/service.c:1063(make_connection_snum)
>  10.193.46.36 (10.193.46.36) connect to service IPC$ initially as user WUM3\ucwb-0151$ (uid=10668, gid=10001) (pid 29920)
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46,  5] smbd/uid.c:368(change_to_root_user)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2010/08/27 14:46:46,  2] smbd/reply.c:751(reply_tcon_and_X)
>  Serving IPC$ as a Dfs root
>[2010/08/27 14:46:46,  3] smbd/reply.c:759(reply_tcon_and_X)
>  tconX service=IPC$ 
>[2010/08/27 14:46:46, 10] lib/util_sock.c:789(read_smb_length_return_keepalive)
>  got smb length of 128
>[2010/08/27 14:46:46,  6] smbd/process.c:1456(process_smb)
>  got message type 0x0 of len 0x80
>[2010/08/27 14:46:46,  3] smbd/process.c:1459(process_smb)
>  Transaction 25 of length 132 (0 toread)
>[2010/08/27 14:46:46,  5] lib/util.c:632(show_msg)
>[2010/08/27 14:46:46,  5] lib/util.c:642(show_msg)
>  size=128
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=4
>  smb_uid=105
>  smb_mid=1600
>  smt_wct=15
>  smb_vwv[ 0]=   60 (0x3C)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]= 4096 (0x1000)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]=    0 (0x0)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=   60 (0x3C)
>  smb_vwv[10]=   68 (0x44)
>  smb_vwv[11]=    0 (0x0)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=    1 (0x1)
>  smb_vwv[14]=   16 (0x10)
>  smb_bcc=63
>[2010/08/27 14:46:46, 10] ../lib/util/util.c:304(_dump_data)
>  [0000] 00 00 00 04 00 5C 00 62   00 72 00 69 00 67 00 68   .....\.b .r.i.g.h
>  [0010] 00 74 00 6F 00 6E 00 2E   00 77 00 75 00 6D 00 69   .t.o.n.. .w.u.m.i
>  [0020] 00 2E 00 6F 00 72 00 67   00 2E 00 61 00 75 00 5C   ...o.r.g ...a.u.\
>  [0030] 00 73 00 68 00 61 00 72   00 65 00 64 00 00 00     .s.h.a.r .e.d...
>[2010/08/27 14:46:46,  3] smbd/process.c:1273(switch_message)
>  switch message SMBtrans2 (pid 29920) conn 0xb919af38
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (10668, 10001) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  5] auth/token_util.c:528(debug_nt_user_token)
>  NT user token of user S-1-5-21-1202660629-583907252-725345543-2235
>  contains 10 SIDs
>  SID[  0]: S-1-5-21-1202660629-583907252-725345543-2235
>  SID[  1]: S-1-5-21-1202660629-583907252-725345543-515
>  SID[  2]: S-1-1-0
>  SID[  3]: S-1-5-2
>  SID[  4]: S-1-5-11
>  SID[  5]: S-1-22-1-10668
>  SID[  6]: S-1-22-2-10001
>  SID[  7]: S-1-22-2-10347
>  SID[  8]: S-1-22-2-10348
>  SID[  9]: S-1-22-2-10363
>  SE_PRIV  0x0 0x0 0x0 0x0
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 10668
>  Primary group is 10001 and contains 4 supplementary groups
>  Group[  0]: 10001
>  Group[  1]: 10347
>  Group[  2]: 10348
>  Group[  3]: 10363
>[2010/08/27 14:46:46,  5] smbd/uid.c:353(change_to_user)
>  change_to_user uid=(0,10668) gid=(0,10001)
>[2010/08/27 14:46:46,  4] smbd/vfs.c:753(vfs_ChDir)
>  vfs_ChDir to /tmp
>[2010/08/27 14:46:46, 10] smbd/trans2.c:7362(call_trans2getdfsreferral)
>  call_trans2getdfsreferral
>[2010/08/27 14:46:46, 10] smbd/msdfs.c:107(parse_dfs_path)
>  parse_dfs_path: temp = |brighton.wumi.org.au\shared| after trimming \'s
>[2010/08/27 14:46:46, 10] smbd/msdfs.c:132(parse_dfs_path)
>  parse_dfs_path: hostname: brighton.wumi.org.au
>[2010/08/27 14:46:46, 10] smbd/msdfs.c:174(parse_dfs_path)
>  parse_dfs_path: servicename: shared
>[2010/08/27 14:46:46, 10] smbd/msdfs.c:1229(setup_dfs_referral)
>  max_referral_level :4
>[2010/08/27 14:46:46, 10] smbd/msdfs.c:1067(setup_ver3_dfs_referral)
>  setting up version3 referral
>[2010/08/27 14:46:46, 10] smbd/msdfs.c:1074(setup_ver3_dfs_referral)
>[2010/08/27 14:46:46,  0] ../lib/util/util.c:304(_dump_data)
>  [0000] 5C 00 62 00 72 00 69 00   67 00 68 00 74 00 6F 00   \.b.r.i. g.h.t.o.
>  [0010] 6E 00 2E 00 77 00 75 00   6D 00 69 00 2E 00 6F 00   n...w.u. m.i...o.
>  [0020] 72 00 67 00 2E 00 61 00   75 00 5C 00 73 00 68 00   r.g...a. u.\.s.h.
>  [0030] 61 00 72 00 65 00 64 00   00 00                    a.r.e.d. ..
>[2010/08/27 14:46:46, 10] smbd/msdfs.c:1087(setup_ver3_dfs_referral)
>  referral 0 : \brighton.wumi.org.au\shared
>[2010/08/27 14:46:46, 10] smbd/msdfs.c:1257(setup_dfs_referral)
>  DFS Referral pdata:
>[2010/08/27 14:46:46,  0] ../lib/util/util.c:304(_dump_data)
>  [0000] 38 00 01 00 03 00 00 00   03 00 22 00 01 00 00 00   8....... ..".....
>  [0010] 58 02 00 00 22 00 5C 00   96 00 00 00 00 00 00 00   X...".\. ........
>  [0020] 00 00 00 00 00 00 00 00   00 00 5C 00 62 00 72 00   ........ ..\.b.r.
>  [0030] 69 00 67 00 68 00 74 00   6F 00 6E 00 2E 00 77 00   i.g.h.t. o.n...w.
>  [0040] 75 00 6D 00 69 00 2E 00   6F 00 72 00 67 00 2E 00   u.m.i... o.r.g...
>  [0050] 61 00 75 00 5C 00 73 00   68 00 61 00 72 00 65 00   a.u.\.s. h.a.r.e.
>  [0060] 64 00 00 00 5C 00 62 00   72 00 69 00 67 00 68 00   d...\.b. r.i.g.h.
>  [0070] 74 00 6F 00 6E 00 2E 00   77 00 75 00 6D 00 69 00   t.o.n... w.u.m.i.
>  [0080] 2E 00 6F 00 72 00 67 00   2E 00 61 00 75 00 5C 00   ..o.r.g. ..a.u.\.
>  [0090] 73 00 68 00 61 00 72 00   65 00 64 00 00 00 5C 00   s.h.a.r. e.d...\.
>  [00A0] 62 00 72 00 69 00 67 00   68 00 74 00 6F 00 6E 00   b.r.i.g. h.t.o.n.
>  [00B0] 2E 00 77 00 75 00 6D 00   69 00 2E 00 6F 00 72 00   ..w.u.m. i...o.r.
>  [00C0] 67 00 2E 00 61 00 75 00   5C 00 73 00 68 00 61 00   g...a.u. \.s.h.a.
>  [00D0] 72 00 65 00 64 00 00 00                            r.e.d... 
>[2010/08/27 14:46:46,  9] smbd/trans2.c:820(send_trans2_replies)
>  t2_rep: params_sent_thistime = 0, data_sent_thistime = 216, useable_space = 131012
>[2010/08/27 14:46:46,  9] smbd/trans2.c:822(send_trans2_replies)
>  t2_rep: params_to_send = 0, data_to_send = 216, paramsize = 0, datasize = 216
>[2010/08/27 14:46:46,  5] lib/util.c:632(show_msg)
>[2010/08/27 14:46:46,  5] lib/util.c:642(show_msg)
>  size=272
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=51201
>  smb_tid=1
>  smb_pid=4
>  smb_uid=105
>  smb_mid=1600
>  smt_wct=10
>  smb_vwv[ 0]=    0 (0x0)
>  smb_vwv[ 1]=  216 (0xD8)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]=    0 (0x0)
>  smb_vwv[ 4]=   56 (0x38)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=  216 (0xD8)
>  smb_vwv[ 7]=   56 (0x38)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=    0 (0x0)
>  smb_bcc=217
>[2010/08/27 14:46:46, 10] ../lib/util/util.c:304(_dump_data)
>  [0000] 00 38 00 01 00 03 00 00   00 03 00 22 00 01 00 00   .8...... ..."....
>  [0010] 00 58 02 00 00 22 00 5C   00 96 00 00 00 00 00 00   .X...".\ ........
>  [0020] 00 00 00 00 00 00 00 00   00 00 00 5C 00 62 00 72   ........ ...\.b.r
>  [0030] 00 69 00 67 00 68 00 74   00 6F 00 6E 00 2E 00 77   .i.g.h.t .o.n...w
>  [0040] 00 75 00 6D 00 69 00 2E   00 6F 00 72 00 67 00 2E   .u.m.i.. .o.r.g..
>  [0050] 00 61 00 75 00 5C 00 73   00 68 00 61 00 72 00 65   .a.u.\.s .h.a.r.e
>  [0060] 00 64 00 00 00 5C 00 62   00 72 00 69 00 67 00 68   .d...\.b .r.i.g.h
>  [0070] 00 74 00 6F 00 6E 00 2E   00 77 00 75 00 6D 00 69   .t.o.n.. .w.u.m.i
>  [0080] 00 2E 00 6F 00 72 00 67   00 2E 00 61 00 75 00 5C   ...o.r.g ...a.u.\
>  [0090] 00 73 00 68 00 61 00 72   00 65 00 64 00 00 00 5C   .s.h.a.r .e.d...\
>  [00A0] 00 62 00 72 00 69 00 67   00 68 00 74 00 6F 00 6E   .b.r.i.g .h.t.o.n
>  [00B0] 00 2E 00 77 00 75 00 6D   00 69 00 2E 00 6F 00 72   ...w.u.m .i...o.r
>  [00C0] 00 67 00 2E 00 61 00 75   00 5C 00 73 00 68 00 61   .g...a.u .\.s.h.a
>  [00D0] 00 72 00 65 00 64 00 00   00                       .r.e.d.. .
>[2010/08/27 14:46:46, 10] lib/util_sock.c:789(read_smb_length_return_keepalive)
>  got smb length of 110
>[2010/08/27 14:46:46,  6] smbd/process.c:1456(process_smb)
>  got message type 0x0 of len 0x6e
>[2010/08/27 14:46:46,  3] smbd/process.c:1459(process_smb)
>  Transaction 26 of length 114 (0 toread)
>[2010/08/27 14:46:46,  5] lib/util.c:632(show_msg)
>[2010/08/27 14:46:46,  5] lib/util.c:642(show_msg)
>  size=110
>  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=103
>  smb_mid=1664
>  smt_wct=4
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]=  110 (0x6E)
>  smb_vwv[ 2]=    8 (0x8)
>  smb_vwv[ 3]=    1 (0x1)
>  smb_bcc=67
>[2010/08/27 14:46:46, 10] ../lib/util/util.c:304(_dump_data)
>  [0000] 00 5C 00 5C 00 42 00 52   00 49 00 47 00 48 00 54   .\.\.B.R .I.G.H.T
>  [0010] 00 4F 00 4E 00 2E 00 57   00 55 00 4D 00 49 00 2E   .O.N...W .U.M.I..
>  [0020] 00 4F 00 52 00 47 00 2E   00 41 00 55 00 5C 00 53   .O.R.G.. .A.U.\.S
>  [0030] 00 48 00 41 00 52 00 45   00 44 00 00 00 3F 3F 3F   .H.A.R.E .D...???
>  [0040] 3F 3F 00                                          ??. 
>[2010/08/27 14:46:46,  3] smbd/process.c:1273(switch_message)
>  switch message SMBtconX (pid 29920) conn 0x0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46,  5] smbd/uid.c:368(change_to_root_user)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2010/08/27 14:46:46,  4] smbd/reply.c:680(reply_tcon_and_X)
>  Client requested device type [?????] for share [SHARED]
>[2010/08/27 14:46:46,  5] smbd/service.c:1216(make_connection)
>  making a connection to 'normal' service shared
>[2010/08/27 14:46:46,  3] lib/util_sid.c:228(string_to_sid)
>  string_to_sid: Sid root does not start with 'S-'.
>[2010/08/27 14:46:46, 10] passdb/lookup_sid.c:69(lookup_name)
>  lookup_name: BRIGHTON\root => BRIGHTON (domain), root (name)
>[2010/08/27 14:46:46, 10] passdb/lookup_sid.c:70(lookup_name)
>  lookup_name: flags = 0x073
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:607(pdb_set_username)
>  pdb_set_username: setting username root, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:630(pdb_set_domain)
>  pdb_set_domain: setting domain BRIGHTON, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:653(pdb_set_nt_username)
>  pdb_set_nt_username: setting nt username , was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:676(pdb_set_fullname)
>  pdb_set_full_name: setting full name root, was 
>[2010/08/27 14:46:46,  4] lib/substitute.c:504(automount_server)
>  Home server: brighton
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:769(pdb_set_homedir)
>  pdb_set_homedir: setting home dir \\brighton\root, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:745(pdb_set_dir_drive)
>  pdb_set_dir_drive: setting dir drive , was NULL
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:699(pdb_set_logon_script)
>  pdb_set_logon_script: setting logon script , was 
>[2010/08/27 14:46:46,  4] lib/substitute.c:504(automount_server)
>  Home server: brighton
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:722(pdb_set_profile_path)
>  pdb_set_profile_path: setting profile path \\brighton\root\profile, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:812(pdb_set_workstations)
>  pdb_set_workstations: setting workstations , was 
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:536(pdb_set_user_sid)
>  pdb_set_user_sid: setting user sid S-1-5-21-1410203337-155486731-3094506392-1000
>[2010/08/27 14:46:46, 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-1410203337-155486731-3094506392-1000 from rid 1000
>[2010/08/27 14:46:46,  5] lib/username.c:133(Get_Pwnam_alloc)
>  Finding user root
>[2010/08/27 14:46:46,  5] lib/username.c:77(Get_Pwnam_internals)
>  Trying _Get_Pwnam(), username as lowercase is root
>[2010/08/27 14:46:46,  5] lib/username.c:110(Get_Pwnam_internals)
>  Get_Pwnam_internals did find user [root]!
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:607(pdb_set_username)
>  pdb_set_username: setting username root, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:630(pdb_set_domain)
>  pdb_set_domain: setting domain BRIGHTON, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:653(pdb_set_nt_username)
>  pdb_set_nt_username: setting nt username , was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:676(pdb_set_fullname)
>  pdb_set_full_name: setting full name root, was 
>[2010/08/27 14:46:46,  4] lib/substitute.c:504(automount_server)
>  Home server: brighton
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:769(pdb_set_homedir)
>  pdb_set_homedir: setting home dir \\brighton\root, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:745(pdb_set_dir_drive)
>  pdb_set_dir_drive: setting dir drive , was NULL
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:699(pdb_set_logon_script)
>  pdb_set_logon_script: setting logon script , was 
>[2010/08/27 14:46:46,  4] lib/substitute.c:504(automount_server)
>  Home server: brighton
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:722(pdb_set_profile_path)
>  pdb_set_profile_path: setting profile path \\brighton\root\profile, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:812(pdb_set_workstations)
>  pdb_set_workstations: setting workstations , was 
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:536(pdb_set_user_sid)
>  pdb_set_user_sid: setting user sid S-1-5-21-1410203337-155486731-3094506392-1000
>[2010/08/27 14:46:46, 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-1410203337-155486731-3094506392-1000 from rid 1000
>[2010/08/27 14:46:46, 10] lib/gencache.c:208(gencache_get)
>  Returning valid cache entry: key = IDMAP/SID2GID/S-1-5-21-1410203337-155486731-3094506392-513, value = -1, timeout = Fri Aug 27 14:47:12 2010
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46,  5] passdb/pdb_interface.c:1513(lookup_global_sam_rid)
>  lookup_global_sam_rid: looking up RID 513.
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46,  5] passdb/pdb_tdb.c:609(tdbsam_getsampwrid)
>  pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201.
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  5] passdb/pdb_interface.c:1576(lookup_global_sam_rid)
>  Can't find a unix id for an unmapped group
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46, 10] passdb/lookup_sid.c:1274(legacy_sid_to_gid)
>  LEGACY: mapping failed for sid S-1-5-21-1410203337-155486731-3094506392-513
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:594(pdb_set_group_sid)
>  pdb_set_group_sid: setting group sid S-1-5-21-1410203337-155486731-3094506392-513
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46, 10] smbd/share_access.c:234(user_ok_token)
>  user_ok_token: share shared is ok for unix user WUM3\jkaye
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:607(pdb_set_username)
>  pdb_set_username: setting username jkaye, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:630(pdb_set_domain)
>  pdb_set_domain: setting domain WUM3, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:653(pdb_set_nt_username)
>  pdb_set_nt_username: setting nt username jkaye, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:676(pdb_set_fullname)
>  pdb_set_full_name: setting full name Jill Kaye, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:769(pdb_set_homedir)
>  pdb_set_homedir: setting home dir , was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:745(pdb_set_dir_drive)
>  pdb_set_dir_drive: setting dir drive , was NULL
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:699(pdb_set_logon_script)
>  pdb_set_logon_script: setting logon script generic-logon.vbs, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:722(pdb_set_profile_path)
>  pdb_set_profile_path: setting profile path , was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:812(pdb_set_workstations)
>  pdb_set_workstations: setting workstations , was 
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:536(pdb_set_user_sid)
>  pdb_set_user_sid: setting user sid S-1-5-21-1410203337-155486731-3094506392-0
>[2010/08/27 14:46:46, 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-1410203337-155486731-3094506392-0 from rid 0
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:594(pdb_set_group_sid)
>  pdb_set_group_sid: setting group sid S-1-5-21-1202660629-583907252-725345543-513
>[2010/08/27 14:46:46,  5] lib/username.c:133(Get_Pwnam_alloc)
>  Finding user WUM3\jkaye
>[2010/08/27 14:46:46,  5] lib/username.c:77(Get_Pwnam_internals)
>  Trying _Get_Pwnam(), username as lowercase is wum3\jkaye
>[2010/08/27 14:46:46,  5] lib/username.c:110(Get_Pwnam_internals)
>  Get_Pwnam_internals did find user [WUM3\jkaye]!
>[2010/08/27 14:46:46, 10] smbd/service.c:163(set_conn_connectpath)
>  set_conn_connectpath: service shared, connectpath = /srv/samba/local/shared
>[2010/08/27 14:46:46,  3] smbd/service.c:807(make_connection_snum)
>  Connect path is '/srv/samba/local/shared' for service [shared]
>[2010/08/27 14:46:46, 10] lib/util_seaccess.c:58(se_map_generic)
>  se_map_generic(): mapped mask 0x10000000 to 0x001f01ff
>[2010/08/27 14:46:46,  3] smbd/vfs.c:95(vfs_init_default)
>  Initialising default vfs hooks
>[2010/08/27 14:46:46,  3] smbd/vfs.c:129(vfs_init_custom)
>  Initialising custom vfs hooks from [/[Default VFS]/]
>[2010/08/27 14:46:46, 10] smbd/vfs.c:47(vfs_find_backend_entry)
>  vfs_find_backend_entry called for /[Default VFS]/
>  Successfully loaded vfs module [/[Default VFS]/] with the new modules system
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #0 (type 0, layer 0)
>  Making operation type 0 opaque [module /[Default VFS]/]
>  Accepting operation type 0 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #1 (type 1, layer 0)
>  Making operation type 1 opaque [module /[Default VFS]/]
>  Accepting operation type 1 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #2 (type 2, layer 0)
>  Making operation type 2 opaque [module /[Default VFS]/]
>  Accepting operation type 2 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #3 (type 3, layer 0)
>  Making operation type 3 opaque [module /[Default VFS]/]
>  Accepting operation type 3 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #4 (type 4, layer 0)
>  Making operation type 4 opaque [module /[Default VFS]/]
>  Accepting operation type 4 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #5 (type 5, layer 0)
>  Making operation type 5 opaque [module /[Default VFS]/]
>  Accepting operation type 5 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #6 (type 6, layer 0)
>  Making operation type 6 opaque [module /[Default VFS]/]
>  Accepting operation type 6 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #7 (type 7, layer 0)
>  Making operation type 7 opaque [module /[Default VFS]/]
>  Accepting operation type 7 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #8 (type 8, layer 0)
>  Making operation type 8 opaque [module /[Default VFS]/]
>  Accepting operation type 8 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #9 (type 9, layer 0)
>  Making operation type 9 opaque [module /[Default VFS]/]
>  Accepting operation type 9 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #10 (type 10, layer 0)
>  Making operation type 10 opaque [module /[Default VFS]/]
>  Accepting operation type 10 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #11 (type 11, layer 0)
>  Making operation type 11 opaque [module /[Default VFS]/]
>  Accepting operation type 11 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #12 (type 12, layer 0)
>  Making operation type 12 opaque [module /[Default VFS]/]
>  Accepting operation type 12 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #13 (type 13, layer 0)
>  Making operation type 13 opaque [module /[Default VFS]/]
>  Accepting operation type 13 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #14 (type 14, layer 0)
>  Making operation type 14 opaque [module /[Default VFS]/]
>  Accepting operation type 14 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #15 (type 15, layer 0)
>  Making operation type 15 opaque [module /[Default VFS]/]
>  Accepting operation type 15 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #16 (type 16, layer 0)
>  Making operation type 16 opaque [module /[Default VFS]/]
>  Accepting operation type 16 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #17 (type 17, layer 0)
>  Making operation type 17 opaque [module /[Default VFS]/]
>  Accepting operation type 17 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #18 (type 18, layer 0)
>  Making operation type 18 opaque [module /[Default VFS]/]
>  Accepting operation type 18 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #19 (type 19, layer 0)
>  Making operation type 19 opaque [module /[Default VFS]/]
>  Accepting operation type 19 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #20 (type 20, layer 0)
>  Making operation type 20 opaque [module /[Default VFS]/]
>  Accepting operation type 20 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #21 (type 21, layer 0)
>  Making operation type 21 opaque [module /[Default VFS]/]
>  Accepting operation type 21 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #22 (type 22, layer 0)
>  Making operation type 22 opaque [module /[Default VFS]/]
>  Accepting operation type 22 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #23 (type 23, layer 0)
>  Making operation type 23 opaque [module /[Default VFS]/]
>  Accepting operation type 23 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #24 (type 24, layer 0)
>  Making operation type 24 opaque [module /[Default VFS]/]
>  Accepting operation type 24 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #25 (type 25, layer 0)
>  Making operation type 25 opaque [module /[Default VFS]/]
>  Accepting operation type 25 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #26 (type 26, layer 0)
>  Making operation type 26 opaque [module /[Default VFS]/]
>  Accepting operation type 26 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #27 (type 27, layer 0)
>  Making operation type 27 opaque [module /[Default VFS]/]
>  Accepting operation type 27 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #28 (type 28, layer 0)
>  Making operation type 28 opaque [module /[Default VFS]/]
>  Accepting operation type 28 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #29 (type 29, layer 0)
>  Making operation type 29 opaque [module /[Default VFS]/]
>  Accepting operation type 29 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #30 (type 30, layer 0)
>  Making operation type 30 opaque [module /[Default VFS]/]
>  Accepting operation type 30 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #31 (type 31, layer 0)
>  Making operation type 31 opaque [module /[Default VFS]/]
>  Accepting operation type 31 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #32 (type 32, layer 0)
>  Making operation type 32 opaque [module /[Default VFS]/]
>  Accepting operation type 32 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #33 (type 33, layer 0)
>  Making operation type 33 opaque [module /[Default VFS]/]
>  Accepting operation type 33 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #34 (type 34, layer 0)
>  Making operation type 34 opaque [module /[Default VFS]/]
>  Accepting operation type 34 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #35 (type 35, layer 0)
>  Making operation type 35 opaque [module /[Default VFS]/]
>  Accepting operation type 35 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #36 (type 36, layer 0)
>  Making operation type 36 opaque [module /[Default VFS]/]
>  Accepting operation type 36 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #37 (type 37, layer 0)
>  Making operation type 37 opaque [module /[Default VFS]/]
>  Accepting operation type 37 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #38 (type 38, layer 0)
>  Making operation type 38 opaque [module /[Default VFS]/]
>  Accepting operation type 38 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #39 (type 39, layer 0)
>  Making operation type 39 opaque [module /[Default VFS]/]
>  Accepting operation type 39 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #40 (type 40, layer 0)
>  Making operation type 40 opaque [module /[Default VFS]/]
>  Accepting operation type 40 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #41 (type 41, layer 0)
>  Making operation type 41 opaque [module /[Default VFS]/]
>  Accepting operation type 41 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #42 (type 42, layer 0)
>  Making operation type 42 opaque [module /[Default VFS]/]
>  Accepting operation type 42 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #43 (type 43, layer 0)
>  Making operation type 43 opaque [module /[Default VFS]/]
>  Accepting operation type 43 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #44 (type 44, layer 0)
>  Making operation type 44 opaque [module /[Default VFS]/]
>  Accepting operation type 44 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #45 (type 45, layer 0)
>  Making operation type 45 opaque [module /[Default VFS]/]
>  Accepting operation type 45 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #46 (type 46, layer 0)
>  Making operation type 46 opaque [module /[Default VFS]/]
>  Accepting operation type 46 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #47 (type 47, layer 0)
>  Making operation type 47 opaque [module /[Default VFS]/]
>  Accepting operation type 47 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #48 (type 48, layer 0)
>  Making operation type 48 opaque [module /[Default VFS]/]
>  Accepting operation type 48 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #49 (type 49, layer 0)
>  Making operation type 49 opaque [module /[Default VFS]/]
>  Accepting operation type 49 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #50 (type 50, layer 0)
>  Making operation type 50 opaque [module /[Default VFS]/]
>  Accepting operation type 50 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #51 (type 51, layer 0)
>  Making operation type 51 opaque [module /[Default VFS]/]
>  Accepting operation type 51 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #52 (type 52, layer 0)
>  Making operation type 52 opaque [module /[Default VFS]/]
>  Accepting operation type 52 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #53 (type 53, layer 0)
>  Making operation type 53 opaque [module /[Default VFS]/]
>  Accepting operation type 53 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #54 (type 54, layer 0)
>  Making operation type 54 opaque [module /[Default VFS]/]
>  Accepting operation type 54 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #55 (type 55, layer 0)
>  Making operation type 55 opaque [module /[Default VFS]/]
>  Accepting operation type 55 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #56 (type 56, layer 0)
>  Making operation type 56 opaque [module /[Default VFS]/]
>  Accepting operation type 56 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #57 (type 57, layer 0)
>  Making operation type 57 opaque [module /[Default VFS]/]
>  Accepting operation type 57 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #58 (type 58, layer 0)
>  Making operation type 58 opaque [module /[Default VFS]/]
>  Accepting operation type 58 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #59 (type 59, layer 0)
>  Making operation type 59 opaque [module /[Default VFS]/]
>  Accepting operation type 59 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #60 (type 60, layer 0)
>  Making operation type 60 opaque [module /[Default VFS]/]
>  Accepting operation type 60 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #61 (type 61, layer 0)
>  Making operation type 61 opaque [module /[Default VFS]/]
>  Accepting operation type 61 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #62 (type 62, layer 0)
>  Making operation type 62 opaque [module /[Default VFS]/]
>  Accepting operation type 62 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #63 (type 63, layer 0)
>  Making operation type 63 opaque [module /[Default VFS]/]
>  Accepting operation type 63 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #64 (type 64, layer 0)
>  Making operation type 64 opaque [module /[Default VFS]/]
>  Accepting operation type 64 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #65 (type 65, layer 0)
>  Making operation type 65 opaque [module /[Default VFS]/]
>  Accepting operation type 65 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #66 (type 66, layer 0)
>  Making operation type 66 opaque [module /[Default VFS]/]
>  Accepting operation type 66 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #67 (type 67, layer 0)
>  Making operation type 67 opaque [module /[Default VFS]/]
>  Accepting operation type 67 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #68 (type 68, layer 0)
>  Making operation type 68 opaque [module /[Default VFS]/]
>  Accepting operation type 68 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #69 (type 69, layer 0)
>  Making operation type 69 opaque [module /[Default VFS]/]
>  Accepting operation type 69 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #70 (type 70, layer 0)
>  Making operation type 70 opaque [module /[Default VFS]/]
>  Accepting operation type 70 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #71 (type 71, layer 0)
>  Making operation type 71 opaque [module /[Default VFS]/]
>  Accepting operation type 71 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #72 (type 72, layer 0)
>  Making operation type 72 opaque [module /[Default VFS]/]
>  Accepting operation type 72 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #73 (type 73, layer 0)
>  Making operation type 73 opaque [module /[Default VFS]/]
>  Accepting operation type 73 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #74 (type 74, layer 0)
>  Making operation type 74 opaque [module /[Default VFS]/]
>  Accepting operation type 74 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #75 (type 75, layer 0)
>  Making operation type 75 opaque [module /[Default VFS]/]
>  Accepting operation type 75 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #76 (type 76, layer 0)
>  Making operation type 76 opaque [module /[Default VFS]/]
>  Accepting operation type 76 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #77 (type 77, layer 0)
>  Making operation type 77 opaque [module /[Default VFS]/]
>  Accepting operation type 77 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #78 (type 78, layer 0)
>  Making operation type 78 opaque [module /[Default VFS]/]
>  Accepting operation type 78 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #79 (type 79, layer 0)
>  Making operation type 79 opaque [module /[Default VFS]/]
>  Accepting operation type 79 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #80 (type 80, layer 0)
>  Making operation type 80 opaque [module /[Default VFS]/]
>  Accepting operation type 80 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #81 (type 81, layer 0)
>  Making operation type 81 opaque [module /[Default VFS]/]
>  Accepting operation type 81 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #82 (type 82, layer 0)
>  Making operation type 82 opaque [module /[Default VFS]/]
>  Accepting operation type 82 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #83 (type 83, layer 0)
>  Making operation type 83 opaque [module /[Default VFS]/]
>  Accepting operation type 83 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #84 (type 84, layer 0)
>  Making operation type 84 opaque [module /[Default VFS]/]
>  Accepting operation type 84 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #85 (type 85, layer 0)
>  Making operation type 85 opaque [module /[Default VFS]/]
>  Accepting operation type 85 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #86 (type 86, layer 0)
>  Making operation type 86 opaque [module /[Default VFS]/]
>  Accepting operation type 86 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #87 (type 87, layer 0)
>  Making operation type 87 opaque [module /[Default VFS]/]
>  Accepting operation type 87 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #88 (type 88, layer 0)
>  Making operation type 88 opaque [module /[Default VFS]/]
>  Accepting operation type 88 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #89 (type 89, layer 0)
>  Making operation type 89 opaque [module /[Default VFS]/]
>  Accepting operation type 89 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #90 (type 90, layer 0)
>  Making operation type 90 opaque [module /[Default VFS]/]
>  Accepting operation type 90 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #91 (type 91, layer 0)
>  Making operation type 91 opaque [module /[Default VFS]/]
>  Accepting operation type 91 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #92 (type 92, layer 0)
>  Making operation type 92 opaque [module /[Default VFS]/]
>  Accepting operation type 92 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #93 (type 93, layer 0)
>  Making operation type 93 opaque [module /[Default VFS]/]
>  Accepting operation type 93 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #94 (type 94, layer 0)
>  Making operation type 94 opaque [module /[Default VFS]/]
>  Accepting operation type 94 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #95 (type 95, layer 0)
>  Making operation type 95 opaque [module /[Default VFS]/]
>  Accepting operation type 95 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #96 (type 96, layer 0)
>  Making operation type 96 opaque [module /[Default VFS]/]
>  Accepting operation type 96 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #97 (type 97, layer 0)
>  Making operation type 97 opaque [module /[Default VFS]/]
>  Accepting operation type 97 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #98 (type 98, layer 0)
>  Making operation type 98 opaque [module /[Default VFS]/]
>  Accepting operation type 98 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #99 (type 99, layer 0)
>  Making operation type 99 opaque [module /[Default VFS]/]
>  Accepting operation type 99 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #100 (type 100, layer 0)
>  Making operation type 100 opaque [module /[Default VFS]/]
>  Accepting operation type 100 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #101 (type 101, layer 0)
>  Making operation type 101 opaque [module /[Default VFS]/]
>  Accepting operation type 101 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #102 (type 102, layer 0)
>  Making operation type 102 opaque [module /[Default VFS]/]
>  Accepting operation type 102 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #103 (type 103, layer 0)
>  Making operation type 103 opaque [module /[Default VFS]/]
>  Accepting operation type 103 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #104 (type 104, layer 0)
>  Making operation type 104 opaque [module /[Default VFS]/]
>  Accepting operation type 104 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #105 (type 105, layer 0)
>  Making operation type 105 opaque [module /[Default VFS]/]
>  Accepting operation type 105 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #106 (type 106, layer 0)
>  Making operation type 106 opaque [module /[Default VFS]/]
>  Accepting operation type 106 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #107 (type 107, layer 0)
>  Making operation type 107 opaque [module /[Default VFS]/]
>  Accepting operation type 107 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #108 (type 108, layer 0)
>  Making operation type 108 opaque [module /[Default VFS]/]
>  Accepting operation type 108 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #109 (type 109, layer 0)
>  Making operation type 109 opaque [module /[Default VFS]/]
>  Accepting operation type 109 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #110 (type 110, layer 0)
>  Making operation type 110 opaque [module /[Default VFS]/]
>  Accepting operation type 110 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/connection.c:142(claim_connection)
>  claiming [shared]
>[2010/08/27 14:46:46, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)
>  Locking key E0740000FFFFFFFF0300
>[2010/08/27 14:46:46, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)
>  Allocated locked data 0x0xb918d1b8
>[2010/08/27 14:46:46, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)
>  Unlocking key E0740000FFFFFFFF0300
>[2010/08/27 14:46:46, 10] smbd/service.c:163(set_conn_connectpath)
>  set_conn_connectpath: service shared, connectpath = /srv/samba/local/shared
>[2010/08/27 14:46:46,  3] lib/util_sid.c:228(string_to_sid)
>  string_to_sid: Sid root does not start with 'S-'.
>[2010/08/27 14:46:46, 10] passdb/lookup_sid.c:69(lookup_name)
>  lookup_name: BRIGHTON\root => BRIGHTON (domain), root (name)
>[2010/08/27 14:46:46, 10] passdb/lookup_sid.c:70(lookup_name)
>  lookup_name: flags = 0x073
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:607(pdb_set_username)
>  pdb_set_username: setting username root, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:630(pdb_set_domain)
>  pdb_set_domain: setting domain BRIGHTON, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:653(pdb_set_nt_username)
>  pdb_set_nt_username: setting nt username , was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:676(pdb_set_fullname)
>  pdb_set_full_name: setting full name root, was 
>[2010/08/27 14:46:46,  4] lib/substitute.c:504(automount_server)
>  Home server: brighton
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:769(pdb_set_homedir)
>  pdb_set_homedir: setting home dir \\brighton\root, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:745(pdb_set_dir_drive)
>  pdb_set_dir_drive: setting dir drive , was NULL
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:699(pdb_set_logon_script)
>  pdb_set_logon_script: setting logon script , was 
>[2010/08/27 14:46:46,  4] lib/substitute.c:504(automount_server)
>  Home server: brighton
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:722(pdb_set_profile_path)
>  pdb_set_profile_path: setting profile path \\brighton\root\profile, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:812(pdb_set_workstations)
>  pdb_set_workstations: setting workstations , was 
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:536(pdb_set_user_sid)
>  pdb_set_user_sid: setting user sid S-1-5-21-1410203337-155486731-3094506392-1000
>[2010/08/27 14:46:46, 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-1410203337-155486731-3094506392-1000 from rid 1000
>[2010/08/27 14:46:46,  5] lib/username.c:133(Get_Pwnam_alloc)
>  Finding user root
>[2010/08/27 14:46:46,  5] lib/username.c:77(Get_Pwnam_internals)
>  Trying _Get_Pwnam(), username as lowercase is root
>[2010/08/27 14:46:46,  5] lib/username.c:110(Get_Pwnam_internals)
>  Get_Pwnam_internals did find user [root]!
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:607(pdb_set_username)
>  pdb_set_username: setting username root, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:630(pdb_set_domain)
>  pdb_set_domain: setting domain BRIGHTON, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:653(pdb_set_nt_username)
>  pdb_set_nt_username: setting nt username , was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:676(pdb_set_fullname)
>  pdb_set_full_name: setting full name root, was 
>[2010/08/27 14:46:46,  4] lib/substitute.c:504(automount_server)
>  Home server: brighton
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:769(pdb_set_homedir)
>  pdb_set_homedir: setting home dir \\brighton\root, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:745(pdb_set_dir_drive)
>  pdb_set_dir_drive: setting dir drive , was NULL
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:699(pdb_set_logon_script)
>  pdb_set_logon_script: setting logon script , was 
>[2010/08/27 14:46:46,  4] lib/substitute.c:504(automount_server)
>  Home server: brighton
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:722(pdb_set_profile_path)
>  pdb_set_profile_path: setting profile path \\brighton\root\profile, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:812(pdb_set_workstations)
>  pdb_set_workstations: setting workstations , was 
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:536(pdb_set_user_sid)
>  pdb_set_user_sid: setting user sid S-1-5-21-1410203337-155486731-3094506392-1000
>[2010/08/27 14:46:46, 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-1410203337-155486731-3094506392-1000 from rid 1000
>[2010/08/27 14:46:46, 10] lib/gencache.c:208(gencache_get)
>  Returning valid cache entry: key = IDMAP/SID2GID/S-1-5-21-1410203337-155486731-3094506392-513, value = -1, timeout = Fri Aug 27 14:47:12 2010
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46,  5] passdb/pdb_interface.c:1513(lookup_global_sam_rid)
>  lookup_global_sam_rid: looking up RID 513.
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46,  5] passdb/pdb_tdb.c:609(tdbsam_getsampwrid)
>  pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201.
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2010/08/27 14:46:46,  5] passdb/pdb_interface.c:1576(lookup_global_sam_rid)
>  Can't find a unix id for an unmapped group
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46, 10] passdb/lookup_sid.c:1274(legacy_sid_to_gid)
>  LEGACY: mapping failed for sid S-1-5-21-1410203337-155486731-3094506392-513
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:594(pdb_set_group_sid)
>  pdb_set_group_sid: setting group sid S-1-5-21-1410203337-155486731-3094506392-513
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46, 10] smbd/share_access.c:234(user_ok_token)
>  user_ok_token: share shared is ok for unix user WUM3\jkaye
>[2010/08/27 14:46:46, 10] smbd/share_access.c:279(is_share_read_only_for_token)
>  is_share_read_only_for_user: share shared is read-write for unix user WUM3\jkaye
>[2010/08/27 14:46:46, 10] lib/util_seaccess.c:58(se_map_generic)
>  se_map_generic(): mapped mask 0x10000000 to 0x001f01ff
>[2010/08/27 14:46:46, 10] lib/util_seaccess.c:58(se_map_generic)
>  se_map_generic(): mapped mask 0x10000000 to 0x001f01ff
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:607(pdb_set_username)
>  pdb_set_username: setting username jkaye, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:630(pdb_set_domain)
>  pdb_set_domain: setting domain WUM3, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:653(pdb_set_nt_username)
>  pdb_set_nt_username: setting nt username jkaye, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:676(pdb_set_fullname)
>  pdb_set_full_name: setting full name Jill Kaye, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:769(pdb_set_homedir)
>  pdb_set_homedir: setting home dir , was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:745(pdb_set_dir_drive)
>  pdb_set_dir_drive: setting dir drive , was NULL
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:699(pdb_set_logon_script)
>  pdb_set_logon_script: setting logon script generic-logon.vbs, was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:722(pdb_set_profile_path)
>  pdb_set_profile_path: setting profile path , was 
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:812(pdb_set_workstations)
>  pdb_set_workstations: setting workstations , was 
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:536(pdb_set_user_sid)
>  pdb_set_user_sid: setting user sid S-1-5-21-1410203337-155486731-3094506392-0
>[2010/08/27 14:46:46, 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-1410203337-155486731-3094506392-0 from rid 0
>[2010/08/27 14:46:46, 10] passdb/pdb_get_set.c:594(pdb_set_group_sid)
>  pdb_set_group_sid: setting group sid S-1-5-21-1202660629-583907252-725345543-513
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (10660, 10000) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  5] auth/token_util.c:528(debug_nt_user_token)
>  NT user token of user S-1-5-21-1202660629-583907252-725345543-2642
>  contains 20 SIDs
>  SID[  0]: S-1-5-21-1202660629-583907252-725345543-2642
>  SID[  1]: S-1-5-21-1202660629-583907252-725345543-513
>  SID[  2]: S-1-1-0
>  SID[  3]: S-1-5-2
>  SID[  4]: S-1-5-11
>  SID[  5]: S-1-5-21-1202660629-583907252-725345543-1842
>  SID[  6]: S-1-5-21-1202660629-583907252-725345543-1863
>  SID[  7]: S-1-5-21-1202660629-583907252-725345543-1166
>  SID[  8]: S-1-5-21-1202660629-583907252-725345543-2646
>  SID[  9]: S-1-5-32-545
>  SID[ 10]: S-1-22-1-10660
>  SID[ 11]: S-1-22-2-10000
>  SID[ 12]: S-1-22-2-10347
>  SID[ 13]: S-1-22-2-10348
>  SID[ 14]: S-1-22-2-10363
>  SID[ 15]: S-1-22-2-10197
>  SID[ 16]: S-1-22-2-10225
>  SID[ 17]: S-1-22-2-10011
>  SID[ 18]: S-1-22-2-10362
>  SID[ 19]: S-1-22-2-10346
>  SE_PRIV  0x0 0x0 0x0 0x0
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 10660
>  Primary group is 10000 and contains 9 supplementary groups
>  Group[  0]: 10000
>  Group[  1]: 10347
>  Group[  2]: 10348
>  Group[  3]: 10363
>  Group[  4]: 10197
>  Group[  5]: 10225
>  Group[  6]: 10011
>  Group[  7]: 10362
>  Group[  8]: 10346
>[2010/08/27 14:46:46,  5] smbd/uid.c:353(change_to_user)
>  change_to_user uid=(0,10660) gid=(0,10000)
>[2010/08/27 14:46:46,  1] smbd/service.c:1063(make_connection_snum)
>  10.193.46.36 (10.193.46.36) connect to service shared initially as user WUM3\jkaye (uid=10660, gid=10000) (pid 29920)
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2010/08/27 14:46:46,  5] smbd/uid.c:368(change_to_root_user)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2010/08/27 14:46:46,  2] smbd/reply.c:751(reply_tcon_and_X)
>  Serving shared as a Dfs root
>[2010/08/27 14:46:46,  3] smbd/reply.c:759(reply_tcon_and_X)
>  tconX service=SHARED 
>[2010/08/27 14:46:46, 10] lib/util_sock.c:789(read_smb_length_return_keepalive)
>  got smb length of 328
>[2010/08/27 14:46:46,  6] smbd/process.c:1456(process_smb)
>  got message type 0x0 of len 0x148
>[2010/08/27 14:46:46,  3] smbd/process.c:1459(process_smb)
>  Transaction 27 of length 332 (0 toread)
>[2010/08/27 14:46:46,  5] lib/util.c:632(show_msg)
>[2010/08/27 14:46:46,  5] lib/util.c:642(show_msg)
>  size=328
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=55303
>  smb_tid=3
>  smb_pid=708
>  smb_uid=103
>  smb_mid=1728
>  smt_wct=15
>  smb_vwv[ 0]=  260 (0x104)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    2 (0x2)
>  smb_vwv[ 3]=   40 (0x28)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]=    0 (0x0)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=  260 (0x104)
>  smb_vwv[10]=   68 (0x44)
>  smb_vwv[11]=    0 (0x0)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=    1 (0x1)
>  smb_vwv[14]=    5 (0x5)
>  smb_bcc=263
>[2010/08/27 14:46:46, 10] ../lib/util/util.c:304(_dump_data)
>  [0000] 00 00 00 EC 03 00 00 00   00 5C 00 62 00 72 00 69   ........ .\.b.r.i
>  [0010] 00 67 00 68 00 74 00 6F   00 6E 00 2E 00 77 00 75   .g.h.t.o .n...w.u
>  [0020] 00 6D 00 69 00 2E 00 6F   00 72 00 67 00 2E 00 61   .m.i...o .r.g...a
>  [0030] 00 75 00 5C 00 73 00 68   00 61 00 72 00 65 00 64   .u.\.s.h .a.r.e.d
>  [0040] 00 5C 00 46 00 61 00 6D   00 69 00 6C 00 79 00 20   .\.F.a.m .i.l.y. 
>  [0050] 00 61 00 6E 00 64 00 20   00 43 00 6F 00 6D 00 6D   .a.n.d.  .C.o.m.m
>  [0060] 00 75 00 6E 00 69 00 74   00 79 00 20 00 44 00 65   .u.n.i.t .y. .D.e
>  [0070] 00 76 00 65 00 6C 00 6F   00 70 00 6D 00 65 00 6E   .v.e.l.o .p.m.e.n
>  [0080] 00 74 00 20 00 53 00 65   00 72 00 76 00 69 00 63   .t. .S.e .r.v.i.c
>  [0090] 00 65 00 73 00 5C 00 53   00 6F 00 75 00 74 00 68   .e.s.\.S .o.u.t.h
>  [00A0] 00 65 00 72 00 6E 00 20   00 48 00 6F 00 6D 00 65   .e.r.n.  .H.o.m.e
>  [00B0] 00 6C 00 65 00 73 00 73   00 6E 00 65 00 73 00 73   .l.e.s.s .n.e.s.s
>  [00C0] 00 20 00 53 00 65 00 72   00 76 00 69 00 63 00 65   . .S.e.r .v.i.c.e
>  [00D0] 00 73 00 5C 00 44 00 61   00 74 00 61 00 62 00 61   .s.\.D.a .t.a.b.a
>  [00E0] 00 73 00 65 00 5C 00 53   00 4D 00 41 00 52 00 54   .s.e.\.S .M.A.R.T
>  [00F0] 00 5C 00 53 00 6D 00 61   00 72 00 74 00 2E 00 69   .\.S.m.a .r.t...i
>  [0100] 00 63 00 6F 00 00 00                              .c.o... 
>[2010/08/27 14:46:46,  3] smbd/process.c:1273(switch_message)
>  switch message SMBtrans2 (pid 29920) conn 0xb91952c8
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (10660, 10000) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  5] auth/token_util.c:528(debug_nt_user_token)
>  NT user token of user S-1-5-21-1202660629-583907252-725345543-2642
>  contains 20 SIDs
>  SID[  0]: S-1-5-21-1202660629-583907252-725345543-2642
>  SID[  1]: S-1-5-21-1202660629-583907252-725345543-513
>  SID[  2]: S-1-1-0
>  SID[  3]: S-1-5-2
>  SID[  4]: S-1-5-11
>  SID[  5]: S-1-5-21-1202660629-583907252-725345543-1842
>  SID[  6]: S-1-5-21-1202660629-583907252-725345543-1863
>  SID[  7]: S-1-5-21-1202660629-583907252-725345543-1166
>  SID[  8]: S-1-5-21-1202660629-583907252-725345543-2646
>  SID[  9]: S-1-5-32-545
>  SID[ 10]: S-1-22-1-10660
>  SID[ 11]: S-1-22-2-10000
>  SID[ 12]: S-1-22-2-10347
>  SID[ 13]: S-1-22-2-10348
>  SID[ 14]: S-1-22-2-10363
>  SID[ 15]: S-1-22-2-10197
>  SID[ 16]: S-1-22-2-10225
>  SID[ 17]: S-1-22-2-10011
>  SID[ 18]: S-1-22-2-10362
>  SID[ 19]: S-1-22-2-10346
>  SE_PRIV  0x0 0x0 0x0 0x0
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 10660
>  Primary group is 10000 and contains 9 supplementary groups
>  Group[  0]: 10000
>  Group[  1]: 10347
>  Group[  2]: 10348
>  Group[  3]: 10363
>  Group[  4]: 10197
>  Group[  5]: 10225
>  Group[  6]: 10011
>  Group[  7]: 10362
>  Group[  8]: 10346
>[2010/08/27 14:46:46,  5] smbd/uid.c:353(change_to_user)
>  change_to_user uid=(0,10660) gid=(0,10000)
>[2010/08/27 14:46:46,  4] smbd/vfs.c:753(vfs_ChDir)
>  vfs_ChDir to /srv/samba/local/shared
>[2010/08/27 14:46:46,  3] smbd/trans2.c:3956(call_trans2qfilepathinfo)
>  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 1004
>[2010/08/27 14:46:46, 10] smbd/msdfs.c:107(parse_dfs_path)
>  parse_dfs_path: temp = |brighton.wumi.org.au\shared\Family and Community Development Services\Southern Homelessness Services\Database\SMART\Smart.ico| after trimming \'s
>[2010/08/27 14:46:46, 10] smbd/msdfs.c:132(parse_dfs_path)
>  parse_dfs_path: hostname: brighton.wumi.org.au
>[2010/08/27 14:46:46, 10] smbd/msdfs.c:174(parse_dfs_path)
>  parse_dfs_path: servicename: shared
>[2010/08/27 14:46:46, 10] smbd/msdfs.c:208(parse_dfs_path)
>  parse_dfs_path: rest of the path: Family and Community Development Services/Southern Homelessness Services/Database/SMART/Smart.ico
>[2010/08/27 14:46:46, 10] smbd/msdfs.c:525(dfs_path_lookup)
>  dfs_path_lookup: Conn path = /srv/samba/local/shared reqpath = Family and Community Development Services/Southern Homelessness Services/Database/SMART/Smart.ico
>[2010/08/27 14:46:46,  5] smbd/filename.c:148(unix_convert)
>  unix_convert called on file "Family and Community Development Services/Southern Homelessness Services/Database/SMART/Smart.ico"
>[2010/08/27 14:46:46, 10] smbd/statcache.c:235(stat_cache_lookup)
>  stat_cache_lookup: lookup failed for name [FAMILY AND COMMUNITY DEVELOPMENT SERVICES/SOUTHERN HOMELESSNESS SERVICES/DATABASE/SMART/SMART.ICO]
>[2010/08/27 14:46:46, 10] smbd/statcache.c:235(stat_cache_lookup)
>  stat_cache_lookup: lookup failed for name [FAMILY AND COMMUNITY DEVELOPMENT SERVICES/SOUTHERN HOMELESSNESS SERVICES/DATABASE/SMART]
>[2010/08/27 14:46:46, 10] smbd/statcache.c:235(stat_cache_lookup)
>  stat_cache_lookup: lookup failed for name [FAMILY AND COMMUNITY DEVELOPMENT SERVICES/SOUTHERN HOMELESSNESS SERVICES/DATABASE]
>[2010/08/27 14:46:46, 10] smbd/statcache.c:235(stat_cache_lookup)
>  stat_cache_lookup: lookup failed for name [FAMILY AND COMMUNITY DEVELOPMENT SERVICES/SOUTHERN HOMELESSNESS SERVICES]
>[2010/08/27 14:46:46, 10] smbd/statcache.c:235(stat_cache_lookup)
>  stat_cache_lookup: lookup failed for name [FAMILY AND COMMUNITY DEVELOPMENT SERVICES]
>[2010/08/27 14:46:46,  5] smbd/filename.c:303(unix_convert)
>  unix_convert begin: name = Family and Community Development Services/Southern Homelessness Services/Database/SMART/Smart.ico, dirpath = , start = Family and Community Development Services/Southern Homelessness Services/Database/SMART/Smart.ico
>[2010/08/27 14:46:46, 10] smbd/mangle_hash2.c:239(is_mangled)
>  is_mangled Family and Community Development Services/Southern Homelessness Services/Database/SMART/Smart.ico ?
>[2010/08/27 14:46:46, 10] smbd/mangle_hash2.c:178(is_mangled_component)
>  is_mangled_component Family and Community Development Services/Southern Homelessness Services/Database/SMART/Smart.ico (len 41) ?
>[2010/08/27 14:46:46, 10] smbd/mangle_hash2.c:178(is_mangled_component)
>  is_mangled_component Southern Homelessness Services/Database/SMART/Smart.ico (len 30) ?
>[2010/08/27 14:46:46, 10] smbd/mangle_hash2.c:178(is_mangled_component)
>  is_mangled_component Database/SMART/Smart.ico (len 8) ?
>[2010/08/27 14:46:46, 10] smbd/mangle_hash2.c:178(is_mangled_component)
>  is_mangled_component SMART/Smart.ico (len 5) ?
>[2010/08/27 14:46:46, 10] smbd/mangle_hash2.c:178(is_mangled_component)
>  is_mangled_component Smart.ico (len 9) ?
>[2010/08/27 14:46:46,  5] smbd/statcache.c:138(stat_cache_add)
>  stat_cache_add: Added entry (b918c068:size 29) FAMILY AND COMMUNITY DEVELOPMENT SERVICES -> Family and Community Development Services
>[2010/08/27 14:46:46, 10] smbd/mangle_hash2.c:239(is_mangled)
>  is_mangled Southern Homelessness Services ?
>[2010/08/27 14:46:46, 10] smbd/mangle_hash2.c:178(is_mangled_component)
>  is_mangled_component Southern Homelessness Services (len 30) ?
>[2010/08/27 14:46:46,  5] smbd/statcache.c:138(stat_cache_add)
>  stat_cache_add: Added entry (b918c308:size 48) FAMILY AND COMMUNITY DEVELOPMENT SERVICES/SOUTHERN HOMELESSNESS SERVICES -> Family and Community Development Services/Southern Homelessness Services
>[2010/08/27 14:46:46, 10] smbd/mangle_hash2.c:239(is_mangled)
>  is_mangled Database ?
>[2010/08/27 14:46:46, 10] smbd/mangle_hash2.c:178(is_mangled_component)
>  is_mangled_component Database (len 8) ?
>[2010/08/27 14:46:46,  5] smbd/dir.c:1131(OpenDir)
>  OpenDir: Can't open Family and Community Development Services/Southern Homelessness Services. No such file or directory
>[2010/08/27 14:46:46,  3] smbd/filename.c:848(get_real_filename_full_scan)
>  scan dir didn't open dir [Family and Community Development Services/Southern Homelessness Services]
>[2010/08/27 14:46:46,  5] smbd/filename.c:461(unix_convert)
>  Intermediate not found Database
>[2010/08/27 14:46:46, 10] smbd/filename.c:729(unix_convert)
>  dirpath = [Family and Community Development Services/Southern Homelessness Services] start = [Database/SMART/Smart.ico]
>[2010/08/27 14:46:46,  5] smbd/msdfs.c:442(is_msdfs_link_internal)
>  is_msdfs_link_read_target: Family and Community Development Services/Southern Homelessness Services/Database/SMART/Smart.ico does not exist.
>[2010/08/27 14:46:46,  5] smbd/msdfs.c:442(is_msdfs_link_internal)
>  is_msdfs_link_read_target: Family and Community Development Services/Southern Homelessness Services/Database/SMART does not exist.
>[2010/08/27 14:46:46,  5] smbd/msdfs.c:442(is_msdfs_link_internal)
>  is_msdfs_link_read_target: Family and Community Development Services/Southern Homelessness Services/Database does not exist.
>[2010/08/27 14:46:46,  5] smbd/msdfs.c:462(is_msdfs_link_internal)
>  is_msdfs_link_internal: Family and Community Development Services/Southern Homelessness Services -> msdfs:
>[2010/08/27 14:46:46,  4] smbd/msdfs.c:607(dfs_path_lookup)
>  dfs_path_lookup: Redirecting \brighton.wumi.org.au\shared\Family and Community Development Services\Southern Homelessness Services\Database\SMART\Smart.ico because parent Family and Community Development Services/Southern Homelessness Services is dfs link
>[2010/08/27 14:46:46,  3] smbd/msdfs.c:717(dfs_redirect)
>  dfs_redirect: Redirecting \brighton.wumi.org.au\shared\Family and Community Development Services\Southern Homelessness Services\Database\SMART\Smart.ico
>[2010/08/27 14:46:46,  3] smbd/error.c:60(error_packet_set)
>  error packet at smbd/trans2.c(3980) cmd=50 (SMBtrans2) NT_STATUS_PATH_NOT_COVERED
>[2010/08/27 14:46:46,  3] smbd/error.c:60(error_packet_set)
>  error packet at smbd/trans2.c(3982) cmd=50 (SMBtrans2) NT_STATUS_PATH_NOT_COVERED
>[2010/08/27 14:46:46,  5] lib/util.c:632(show_msg)
>[2010/08/27 14:46:46,  5] lib/util.c:642(show_msg)
>  size=35
>  smb_com=0x32
>  smb_rcls=87
>  smb_reh=2
>  smb_err=49152
>  smb_flg=136
>  smb_flg2=51201
>  smb_tid=3
>  smb_pid=708
>  smb_uid=103
>  smb_mid=1728
>  smt_wct=0
>  smb_bcc=0
>[2010/08/27 14:46:46, 10] lib/util_sock.c:789(read_smb_length_return_keepalive)
>  got smb length of 324
>[2010/08/27 14:46:46,  6] smbd/process.c:1456(process_smb)
>  got message type 0x0 of len 0x144
>[2010/08/27 14:46:46,  3] smbd/process.c:1459(process_smb)
>  Transaction 28 of length 328 (0 toread)
>[2010/08/27 14:46:46,  5] lib/util.c:632(show_msg)
>[2010/08/27 14:46:46,  5] lib/util.c:642(show_msg)
>  size=324
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=708
>  smb_uid=105
>  smb_mid=1792
>  smt_wct=15
>  smb_vwv[ 0]=  256 (0x100)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]= 4096 (0x1000)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]=    0 (0x0)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=  256 (0x100)
>  smb_vwv[10]=   68 (0x44)
>  smb_vwv[11]=    0 (0x0)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=    1 (0x1)
>  smb_vwv[14]=   16 (0x10)
>  smb_bcc=259
>[2010/08/27 14:46:46, 10] ../lib/util/util.c:304(_dump_data)
>  [0000] 00 00 00 04 00 5C 00 62   00 72 00 69 00 67 00 68   .....\.b .r.i.g.h
>  [0010] 00 74 00 6F 00 6E 00 2E   00 77 00 75 00 6D 00 69   .t.o.n.. .w.u.m.i
>  [0020] 00 2E 00 6F 00 72 00 67   00 2E 00 61 00 75 00 5C   ...o.r.g ...a.u.\
>  [0030] 00 73 00 68 00 61 00 72   00 65 00 64 00 5C 00 46   .s.h.a.r .e.d.\.F
>  [0040] 00 61 00 6D 00 69 00 6C   00 79 00 20 00 61 00 6E   .a.m.i.l .y. .a.n
>  [0050] 00 64 00 20 00 43 00 6F   00 6D 00 6D 00 75 00 6E   .d. .C.o .m.m.u.n
>  [0060] 00 69 00 74 00 79 00 20   00 44 00 65 00 76 00 65   .i.t.y.  .D.e.v.e
>  [0070] 00 6C 00 6F 00 70 00 6D   00 65 00 6E 00 74 00 20   .l.o.p.m .e.n.t. 
>  [0080] 00 53 00 65 00 72 00 76   00 69 00 63 00 65 00 73   .S.e.r.v .i.c.e.s
>  [0090] 00 5C 00 53 00 6F 00 75   00 74 00 68 00 65 00 72   .\.S.o.u .t.h.e.r
>  [00A0] 00 6E 00 20 00 48 00 6F   00 6D 00 65 00 6C 00 65   .n. .H.o .m.e.l.e
>  [00B0] 00 73 00 73 00 6E 00 65   00 73 00 73 00 20 00 53   .s.s.n.e .s.s. .S
>  [00C0] 00 65 00 72 00 76 00 69   00 63 00 65 00 73 00 5C   .e.r.v.i .c.e.s.\
>  [00D0] 00 44 00 61 00 74 00 61   00 62 00 61 00 73 00 65   .D.a.t.a .b.a.s.e
>  [00E0] 00 5C 00 53 00 4D 00 41   00 52 00 54 00 5C 00 53   .\.S.M.A .R.T.\.S
>  [00F0] 00 6D 00 61 00 72 00 74   00 2E 00 69 00 63 00 6F   .m.a.r.t ...i.c.o
>  [0100] 00 00 00                                          ... 
>[2010/08/27 14:46:46,  3] smbd/process.c:1273(switch_message)
>  switch message SMBtrans2 (pid 29920) conn 0xb919af38
>[2010/08/27 14:46:46,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (10668, 10001) - sec_ctx_stack_ndx = 0
>[2010/08/27 14:46:46,  5] auth/token_util.c:528(debug_nt_user_token)
>  NT user token of user S-1-5-21-1202660629-583907252-725345543-2235
>  contains 10 SIDs
>  SID[  0]: S-1-5-21-1202660629-583907252-725345543-2235
>  SID[  1]: S-1-5-21-1202660629-583907252-725345543-515
>  SID[  2]: S-1-1-0
>  SID[  3]: S-1-5-2
>  SID[  4]: S-1-5-11
>  SID[  5]: S-1-22-1-10668
>  SID[  6]: S-1-22-2-10001
>  SID[  7]: S-1-22-2-10347
>  SID[  8]: S-1-22-2-10348
>  SID[  9]: S-1-22-2-10363
>  SE_PRIV  0x0 0x0 0x0 0x0
>[2010/08/27 14:46:46,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 10668
>  Primary group is 10001 and contains 4 supplementary groups
>  Group[  0]: 10001
>  Group[  1]: 10347
>  Group[  2]: 10348
>  Group[  3]: 10363
>[2010/08/27 14:46:46,  5] smbd/uid.c:353(change_to_user)
>  change_to_user uid=(0,10668) gid=(0,10001)
>[2010/08/27 14:46:46,  4] smbd/vfs.c:753(vfs_ChDir)
>  vfs_ChDir to /tmp
>[2010/08/27 14:46:46, 10] smbd/trans2.c:7362(call_trans2getdfsreferral)
>  call_trans2getdfsreferral
>[2010/08/27 14:46:46, 10] smbd/msdfs.c:107(parse_dfs_path)
>  parse_dfs_path: temp = |brighton.wumi.org.au\shared\Family and Community Development Services\Southern Homelessness Services\Database\SMART\Smart.ico| after trimming \'s
>[2010/08/27 14:46:46, 10] smbd/msdfs.c:132(parse_dfs_path)
>  parse_dfs_path: hostname: brighton.wumi.org.au
>[2010/08/27 14:46:46, 10] smbd/msdfs.c:174(parse_dfs_path)
>  parse_dfs_path: servicename: shared
>[2010/08/27 14:46:46, 10] smbd/msdfs.c:208(parse_dfs_path)
>  parse_dfs_path: rest of the path: Family and Community Development Services/Southern Homelessness Services/Database/SMART/Smart.ico
>[2010/08/27 14:46:46, 10] smbd/service.c:163(set_conn_connectpath)
>  set_conn_connectpath: service shared, connectpath = /srv/samba/local/shared
>[2010/08/27 14:46:46,  3] smbd/vfs.c:95(vfs_init_default)
>  Initialising default vfs hooks
>[2010/08/27 14:46:46,  3] smbd/vfs.c:129(vfs_init_custom)
>  Initialising custom vfs hooks from [/[Default VFS]/]
>[2010/08/27 14:46:46, 10] smbd/vfs.c:47(vfs_find_backend_entry)
>  vfs_find_backend_entry called for /[Default VFS]/
>  Successfully loaded vfs module [/[Default VFS]/] with the new modules system
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #0 (type 0, layer 0)
>  Making operation type 0 opaque [module /[Default VFS]/]
>  Accepting operation type 0 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #1 (type 1, layer 0)
>  Making operation type 1 opaque [module /[Default VFS]/]
>  Accepting operation type 1 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #2 (type 2, layer 0)
>  Making operation type 2 opaque [module /[Default VFS]/]
>  Accepting operation type 2 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #3 (type 3, layer 0)
>  Making operation type 3 opaque [module /[Default VFS]/]
>  Accepting operation type 3 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #4 (type 4, layer 0)
>  Making operation type 4 opaque [module /[Default VFS]/]
>  Accepting operation type 4 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #5 (type 5, layer 0)
>  Making operation type 5 opaque [module /[Default VFS]/]
>  Accepting operation type 5 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #6 (type 6, layer 0)
>  Making operation type 6 opaque [module /[Default VFS]/]
>  Accepting operation type 6 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #7 (type 7, layer 0)
>  Making operation type 7 opaque [module /[Default VFS]/]
>  Accepting operation type 7 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #8 (type 8, layer 0)
>  Making operation type 8 opaque [module /[Default VFS]/]
>  Accepting operation type 8 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #9 (type 9, layer 0)
>  Making operation type 9 opaque [module /[Default VFS]/]
>  Accepting operation type 9 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #10 (type 10, layer 0)
>  Making operation type 10 opaque [module /[Default VFS]/]
>  Accepting operation type 10 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #11 (type 11, layer 0)
>  Making operation type 11 opaque [module /[Default VFS]/]
>  Accepting operation type 11 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #12 (type 12, layer 0)
>  Making operation type 12 opaque [module /[Default VFS]/]
>  Accepting operation type 12 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #13 (type 13, layer 0)
>  Making operation type 13 opaque [module /[Default VFS]/]
>  Accepting operation type 13 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #14 (type 14, layer 0)
>  Making operation type 14 opaque [module /[Default VFS]/]
>  Accepting operation type 14 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #15 (type 15, layer 0)
>  Making operation type 15 opaque [module /[Default VFS]/]
>  Accepting operation type 15 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #16 (type 16, layer 0)
>  Making operation type 16 opaque [module /[Default VFS]/]
>  Accepting operation type 16 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #17 (type 17, layer 0)
>  Making operation type 17 opaque [module /[Default VFS]/]
>  Accepting operation type 17 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #18 (type 18, layer 0)
>  Making operation type 18 opaque [module /[Default VFS]/]
>  Accepting operation type 18 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #19 (type 19, layer 0)
>  Making operation type 19 opaque [module /[Default VFS]/]
>  Accepting operation type 19 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #20 (type 20, layer 0)
>  Making operation type 20 opaque [module /[Default VFS]/]
>  Accepting operation type 20 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #21 (type 21, layer 0)
>  Making operation type 21 opaque [module /[Default VFS]/]
>  Accepting operation type 21 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #22 (type 22, layer 0)
>  Making operation type 22 opaque [module /[Default VFS]/]
>  Accepting operation type 22 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #23 (type 23, layer 0)
>  Making operation type 23 opaque [module /[Default VFS]/]
>  Accepting operation type 23 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #24 (type 24, layer 0)
>  Making operation type 24 opaque [module /[Default VFS]/]
>  Accepting operation type 24 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #25 (type 25, layer 0)
>  Making operation type 25 opaque [module /[Default VFS]/]
>  Accepting operation type 25 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #26 (type 26, layer 0)
>  Making operation type 26 opaque [module /[Default VFS]/]
>  Accepting operation type 26 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #27 (type 27, layer 0)
>  Making operation type 27 opaque [module /[Default VFS]/]
>  Accepting operation type 27 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #28 (type 28, layer 0)
>  Making operation type 28 opaque [module /[Default VFS]/]
>  Accepting operation type 28 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #29 (type 29, layer 0)
>  Making operation type 29 opaque [module /[Default VFS]/]
>  Accepting operation type 29 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #30 (type 30, layer 0)
>  Making operation type 30 opaque [module /[Default VFS]/]
>  Accepting operation type 30 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #31 (type 31, layer 0)
>  Making operation type 31 opaque [module /[Default VFS]/]
>  Accepting operation type 31 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #32 (type 32, layer 0)
>  Making operation type 32 opaque [module /[Default VFS]/]
>  Accepting operation type 32 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #33 (type 33, layer 0)
>  Making operation type 33 opaque [module /[Default VFS]/]
>  Accepting operation type 33 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #34 (type 34, layer 0)
>  Making operation type 34 opaque [module /[Default VFS]/]
>  Accepting operation type 34 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #35 (type 35, layer 0)
>  Making operation type 35 opaque [module /[Default VFS]/]
>  Accepting operation type 35 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #36 (type 36, layer 0)
>  Making operation type 36 opaque [module /[Default VFS]/]
>  Accepting operation type 36 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #37 (type 37, layer 0)
>  Making operation type 37 opaque [module /[Default VFS]/]
>  Accepting operation type 37 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #38 (type 38, layer 0)
>  Making operation type 38 opaque [module /[Default VFS]/]
>  Accepting operation type 38 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #39 (type 39, layer 0)
>  Making operation type 39 opaque [module /[Default VFS]/]
>  Accepting operation type 39 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #40 (type 40, layer 0)
>  Making operation type 40 opaque [module /[Default VFS]/]
>  Accepting operation type 40 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #41 (type 41, layer 0)
>  Making operation type 41 opaque [module /[Default VFS]/]
>  Accepting operation type 41 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #42 (type 42, layer 0)
>  Making operation type 42 opaque [module /[Default VFS]/]
>  Accepting operation type 42 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #43 (type 43, layer 0)
>  Making operation type 43 opaque [module /[Default VFS]/]
>  Accepting operation type 43 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #44 (type 44, layer 0)
>  Making operation type 44 opaque [module /[Default VFS]/]
>  Accepting operation type 44 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #45 (type 45, layer 0)
>  Making operation type 45 opaque [module /[Default VFS]/]
>  Accepting operation type 45 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #46 (type 46, layer 0)
>  Making operation type 46 opaque [module /[Default VFS]/]
>  Accepting operation type 46 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #47 (type 47, layer 0)
>  Making operation type 47 opaque [module /[Default VFS]/]
>  Accepting operation type 47 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #48 (type 48, layer 0)
>  Making operation type 48 opaque [module /[Default VFS]/]
>  Accepting operation type 48 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #49 (type 49, layer 0)
>  Making operation type 49 opaque [module /[Default VFS]/]
>  Accepting operation type 49 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #50 (type 50, layer 0)
>  Making operation type 50 opaque [module /[Default VFS]/]
>  Accepting operation type 50 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #51 (type 51, layer 0)
>  Making operation type 51 opaque [module /[Default VFS]/]
>  Accepting operation type 51 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #52 (type 52, layer 0)
>  Making operation type 52 opaque [module /[Default VFS]/]
>  Accepting operation type 52 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #53 (type 53, layer 0)
>  Making operation type 53 opaque [module /[Default VFS]/]
>  Accepting operation type 53 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #54 (type 54, layer 0)
>  Making operation type 54 opaque [module /[Default VFS]/]
>  Accepting operation type 54 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #55 (type 55, layer 0)
>  Making operation type 55 opaque [module /[Default VFS]/]
>  Accepting operation type 55 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #56 (type 56, layer 0)
>  Making operation type 56 opaque [module /[Default VFS]/]
>  Accepting operation type 56 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #57 (type 57, layer 0)
>  Making operation type 57 opaque [module /[Default VFS]/]
>  Accepting operation type 57 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #58 (type 58, layer 0)
>  Making operation type 58 opaque [module /[Default VFS]/]
>  Accepting operation type 58 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #59 (type 59, layer 0)
>  Making operation type 59 opaque [module /[Default VFS]/]
>  Accepting operation type 59 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #60 (type 60, layer 0)
>  Making operation type 60 opaque [module /[Default VFS]/]
>  Accepting operation type 60 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #61 (type 61, layer 0)
>  Making operation type 61 opaque [module /[Default VFS]/]
>  Accepting operation type 61 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #62 (type 62, layer 0)
>  Making operation type 62 opaque [module /[Default VFS]/]
>  Accepting operation type 62 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #63 (type 63, layer 0)
>  Making operation type 63 opaque [module /[Default VFS]/]
>  Accepting operation type 63 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #64 (type 64, layer 0)
>  Making operation type 64 opaque [module /[Default VFS]/]
>  Accepting operation type 64 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #65 (type 65, layer 0)
>  Making operation type 65 opaque [module /[Default VFS]/]
>  Accepting operation type 65 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #66 (type 66, layer 0)
>  Making operation type 66 opaque [module /[Default VFS]/]
>  Accepting operation type 66 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #67 (type 67, layer 0)
>  Making operation type 67 opaque [module /[Default VFS]/]
>  Accepting operation type 67 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #68 (type 68, layer 0)
>  Making operation type 68 opaque [module /[Default VFS]/]
>  Accepting operation type 68 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #69 (type 69, layer 0)
>  Making operation type 69 opaque [module /[Default VFS]/]
>  Accepting operation type 69 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #70 (type 70, layer 0)
>  Making operation type 70 opaque [module /[Default VFS]/]
>  Accepting operation type 70 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #71 (type 71, layer 0)
>  Making operation type 71 opaque [module /[Default VFS]/]
>  Accepting operation type 71 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #72 (type 72, layer 0)
>  Making operation type 72 opaque [module /[Default VFS]/]
>  Accepting operation type 72 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #73 (type 73, layer 0)
>  Making operation type 73 opaque [module /[Default VFS]/]
>  Accepting operation type 73 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #74 (type 74, layer 0)
>  Making operation type 74 opaque [module /[Default VFS]/]
>  Accepting operation type 74 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #75 (type 75, layer 0)
>  Making operation type 75 opaque [module /[Default VFS]/]
>  Accepting operation type 75 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #76 (type 76, layer 0)
>  Making operation type 76 opaque [module /[Default VFS]/]
>  Accepting operation type 76 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #77 (type 77, layer 0)
>  Making operation type 77 opaque [module /[Default VFS]/]
>  Accepting operation type 77 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #78 (type 78, layer 0)
>  Making operation type 78 opaque [module /[Default VFS]/]
>  Accepting operation type 78 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #79 (type 79, layer 0)
>  Making operation type 79 opaque [module /[Default VFS]/]
>  Accepting operation type 79 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #80 (type 80, layer 0)
>  Making operation type 80 opaque [module /[Default VFS]/]
>  Accepting operation type 80 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #81 (type 81, layer 0)
>  Making operation type 81 opaque [module /[Default VFS]/]
>  Accepting operation type 81 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #82 (type 82, layer 0)
>  Making operation type 82 opaque [module /[Default VFS]/]
>  Accepting operation type 82 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #83 (type 83, layer 0)
>  Making operation type 83 opaque [module /[Default VFS]/]
>  Accepting operation type 83 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #84 (type 84, layer 0)
>  Making operation type 84 opaque [module /[Default VFS]/]
>  Accepting operation type 84 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #85 (type 85, layer 0)
>  Making operation type 85 opaque [module /[Default VFS]/]
>  Accepting operation type 85 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #86 (type 86, layer 0)
>  Making operation type 86 opaque [module /[Default VFS]/]
>  Accepting operation type 86 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #87 (type 87, layer 0)
>  Making operation type 87 opaque [module /[Default VFS]/]
>  Accepting operation type 87 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #88 (type 88, layer 0)
>  Making operation type 88 opaque [module /[Default VFS]/]
>  Accepting operation type 88 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #89 (type 89, layer 0)
>  Making operation type 89 opaque [module /[Default VFS]/]
>  Accepting operation type 89 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #90 (type 90, layer 0)
>  Making operation type 90 opaque [module /[Default VFS]/]
>  Accepting operation type 90 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #91 (type 91, layer 0)
>  Making operation type 91 opaque [module /[Default VFS]/]
>  Accepting operation type 91 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #92 (type 92, layer 0)
>  Making operation type 92 opaque [module /[Default VFS]/]
>  Accepting operation type 92 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #93 (type 93, layer 0)
>  Making operation type 93 opaque [module /[Default VFS]/]
>  Accepting operation type 93 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #94 (type 94, layer 0)
>  Making operation type 94 opaque [module /[Default VFS]/]
>  Accepting operation type 94 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #95 (type 95, layer 0)
>  Making operation type 95 opaque [module /[Default VFS]/]
>  Accepting operation type 95 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #96 (type 96, layer 0)
>  Making operation type 96 opaque [module /[Default VFS]/]
>  Accepting operation type 96 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #97 (type 97, layer 0)
>  Making operation type 97 opaque [module /[Default VFS]/]
>  Accepting operation type 97 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #98 (type 98, layer 0)
>  Making operation type 98 opaque [module /[Default VFS]/]
>  Accepting operation type 98 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #99 (type 99, layer 0)
>  Making operation type 99 opaque [module /[Default VFS]/]
>  Accepting operation type 99 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #100 (type 100, layer 0)
>  Making operation type 100 opaque [module /[Default VFS]/]
>  Accepting operation type 100 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #101 (type 101, layer 0)
>  Making operation type 101 opaque [module /[Default VFS]/]
>  Accepting operation type 101 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #102 (type 102, layer 0)
>  Making operation type 102 opaque [module /[Default VFS]/]
>  Accepting operation type 102 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #103 (type 103, layer 0)
>  Making operation type 103 opaque [module /[Default VFS]/]
>  Accepting operation type 103 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #104 (type 104, layer 0)
>  Making operation type 104 opaque [module /[Default VFS]/]
>  Accepting operation type 104 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #105 (type 105, layer 0)
>  Making operation type 105 opaque [module /[Default VFS]/]
>  Accepting operation type 105 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #106 (type 106, layer 0)
>  Making operation type 106 opaque [module /[Default VFS]/]
>  Accepting operation type 106 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #107 (type 107, layer 0)
>  Making operation type 107 opaque [module /[Default VFS]/]
>  Accepting operation type 107 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #108 (type 108, layer 0)
>  Making operation type 108 opaque [module /[Default VFS]/]
>  Accepting operation type 108 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #109 (type 109, layer 0)
>  Making operation type 109 opaque [module /[Default VFS]/]
>  Accepting operation type 109 from module /[Default VFS]/
>[2010/08/27 14:46:46,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #110 (type 110, layer 0)
>  Making operation type 110 opaque [module /[Default VFS]/]
>  Accepting operation type 110 from module /[Default VFS]/
>[2010/08/27 14:46:46,  4] smbd/vfs.c:753(vfs_ChDir)
>  vfs_ChDir to /srv/samba/local/shared
>[2010/08/27 14:46:46,  3] smbd/msdfs.c:295(create_conn_struct)
>  create_conn_struct: Can't ChDir to new conn path /srv/samba/local/shared. Error was Permission denied
>[2010/08/27 14:46:46,  3] smbd/error.c:60(error_packet_set)
>  error packet at smbd/trans2.c(7384) cmd=50 (SMBtrans2) NT_STATUS_ACCESS_DENIED

Actions: View

Attachments on bug 7652: 5929 | 5930 | 5931 | 5991