Attachment 3039 Details for Bug 5138 – smbd log (tail)

smbd log (tail)

log.smbd.tail (text/plain), 43.52 KB, created by rvjcallanan on 2007-12-12 17:22:12 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: rvjcallanan

Created: 2007-12-12 17:22:12 UTC

Size: 43.52 KB

patch

obsolete

>[2007/12/12 23:05:54, 5] auth/auth.c:smb_register_auth(45)
>  Attempting to register auth backend trustdomain
>[2007/12/12 23:05:54, 5] auth/auth.c:smb_register_auth(57)
>  Successfully added auth method 'trustdomain'
>[2007/12/12 23:05:54, 5] auth/auth.c:smb_register_auth(45)
>  Attempting to register auth backend ntdomain
>[2007/12/12 23:05:54, 5] auth/auth.c:smb_register_auth(57)
>  Successfully added auth method 'ntdomain'
>[2007/12/12 23:05:54, 5] auth/auth.c:smb_register_auth(45)
>  Attempting to register auth backend guest
>[2007/12/12 23:05:54, 5] auth/auth.c:smb_register_auth(57)
>  Successfully added auth method 'guest'
>[2007/12/12 23:05:54, 5] auth/auth.c:load_auth_module(389)
>  load_auth_module: Attempting to find an auth method to match guest
>[2007/12/12 23:05:54, 5] auth/auth.c:load_auth_module(414)
>  load_auth_module: auth method guest has a valid init
>[2007/12/12 23:05:54, 5] auth/auth.c:load_auth_module(389)
>  load_auth_module: Attempting to find an auth method to match sam
>[2007/12/12 23:05:54, 5] auth/auth.c:load_auth_module(414)
>  load_auth_module: auth method sam has a valid init
>[2007/12/12 23:05:54, 3] libsmb/ntlmssp.c:debug_ntlmssp_flags(63)
>  Got NTLMSSP neg_flags=0xe2088297
>    NTLMSSP_NEGOTIATE_UNICODE
>    NTLMSSP_NEGOTIATE_OEM
>    NTLMSSP_REQUEST_TARGET
>    NTLMSSP_NEGOTIATE_SIGN
>    NTLMSSP_NEGOTIATE_LM_KEY
>    NTLMSSP_NEGOTIATE_NTLM
>    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
>    NTLMSSP_NEGOTIATE_NTLM2
>    NTLMSSP_NEGOTIATE_128
>    NTLMSSP_NEGOTIATE_KEY_EXCH
>    NTLMSSP_NEGOTIATE_56
>[2007/12/12 23:05:54, 5] auth/auth.c:get_ntlm_challenge(95)
>  auth_get_challenge: module guest did not want to specify a challenge
>[2007/12/12 23:05:54, 5] auth/auth.c:get_ntlm_challenge(95)
>  auth_get_challenge: module sam did not want to specify a challenge
>[2007/12/12 23:05:54, 5] auth/auth.c:get_ntlm_challenge(135)
>  auth_context challenge created by random
>[2007/12/12 23:05:54, 5] auth/auth.c:get_ntlm_challenge(136)
>  challenge is: 
>[2007/12/12 23:05:54, 5] lib/util.c:dump_data(2058)
>  [000] EB 3E BC BA 01 86 DA 54                           .>.....T 
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(454)
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(464)
>  size=308
>  smb_com=0x73
>  smb_rcls=22
>  smb_reh=0
>  smb_err=49152
>  smb_flg=136
>  smb_flg2=51201
>  smb_tid=0
>  smb_pid=65279
>  smb_uid=100
>  smb_mid=1728
>  smt_wct=4
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]=  221 (0xDD)
>  smb_bcc=265
>[2007/12/12 23:05:54, 10] lib/util.c:dump_data(2058)
>  [000] A1 81 DA 30 81 D7 A0 03  0A 01 01 A1 0C 06 0A 2B  ...0.... .......+
>  [010] 06 01 04 01 82 37 02 02  0A A2 81 C1 04 81 BE 4E  .....7.. .......N
>  [020] 54 4C 4D 53 53 50 00 02  00 00 00 0A 00 0A 00 30  TLMSSP.. .......0
>  [030] 00 00 00 B5 82 8A 60 EB  3E BC BA 01 86 DA 54 00  ......`. >.....T.
>  [040] 00 00 00 00 00 00 00 84  00 84 00 3A 00 00 00 49  ........ ...:...I
>  [050] 00 4D 00 41 00 47 00 45  00 02 00 0A 00 49 00 4D  .M.A.G.E .....I.M
>  [060] 00 41 00 47 00 45 00 01  00 0A 00 49 00 4D 00 41  .A.G.E.. ...I.M.A
>  [070] 00 47 00 45 00 04 00 28  00 70 00 65 00 72 00 69  .G.E...( .p.e.r.i
>  [080] 00 6D 00 65 00 74 00 65  00 72 00 2E 00 62 00 65  .m.e.t.e .r...b.e
>  [090] 00 6E 00 6E 00 65 00 74  00 74 00 2E 00 69 00 65  .n.n.e.t .t...i.e
>  [0A0] 00 03 00 34 00 69 00 6D  00 61 00 67 00 65 00 2E  ...4.i.m .a.g.e..
>  [0B0] 00 70 00 65 00 72 00 69  00 6D 00 65 00 74 00 65  .p.e.r.i .m.e.t.e
>  [0C0] 00 72 00 2E 00 62 00 65  00 6E 00 6E 00 65 00 74  .r...b.e .n.n.e.t
>  [0D0] 00 74 00 2E 00 69 00 65  00 00 00 00 00 55 00 6E  .t...i.e .....U.n
>  [0E0] 00 69 00 78 00 00 00 53  00 61 00 6D 00 62 00 61  .i.x...S .a.m.b.a
>  [0F0] 00 20 00 33 00 2E 00 30  00 2E 00 32 00 32 00 00  . .3...0 ...2.2..
>  [100] 00 49 00 4D 00 47 00 00  00                       .I.M.G.. .
>[2007/12/12 23:05:54, 10] smbd/process.c:setup_select_timeout(1372)
>  change_notify_timeout: 300
>[2007/12/12 23:05:54, 10] smbd/process.c:run_events(299)
>  run_events: No events
>[2007/12/12 23:05:54, 10] lib/util_sock.c:read_smb_length_return_keepalive(618)
>  got smb length of 350
>[2007/12/12 23:05:54, 6] smbd/process.c:process_smb(1193)
>  got message type 0x0 of len 0x15e
>[2007/12/12 23:05:54, 3] smbd/process.c:process_smb(1194)
>  Transaction 3 of length 354
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(454)
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(464)
>  size=350
>  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=100
>  smb_mid=1792
>  smt_wct=12
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]=  350 (0x15E)
>  smb_vwv[ 2]=16644 (0x4104)
>  smb_vwv[ 3]=   50 (0x32)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]=  188 (0xBC)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=    0 (0x0)
>  smb_vwv[10]=  212 (0xD4)
>  smb_vwv[11]=40960 (0xA000)
>  smb_bcc=291
>[2007/12/12 23:05:54, 10] lib/util.c:dump_data(2058)
>  [000] A1 81 B9 30 81 B6 A2 81  B3 04 81 B0 4E 54 4C 4D  ...0.... ....NTLM
>  [010] 53 53 50 00 03 00 00 00  18 00 18 00 70 00 00 00  SSP..... ....p...
>  [020] 18 00 18 00 88 00 00 00  0C 00 0C 00 48 00 00 00  ........ ....H...
>  [030] 10 00 10 00 54 00 00 00  0C 00 0C 00 64 00 00 00  ....T... ....d...
>  [040] 10 00 10 00 A0 00 00 00  15 82 88 62 05 01 28 0A  ........ ...b..(.
>  [050] 00 00 00 0F 48 00 50 00  4E 00 30 00 31 00 58 00  ....H.P. N.0.1.X.
>  [060] 6C 00 73 00 69 00 6D 00  61 00 67 00 65 00 72 00  l.s.i.m. a.g.e.r.
>  [070] 48 00 50 00 4E 00 30 00  31 00 58 00 53 7E 62 B7  H.P.N.0. 1.X.S~b.
>  [080] 78 AA 1E 4E 00 00 00 00  00 00 00 00 00 00 00 00  x..N.... ........
>  [090] 00 00 00 00 20 A0 D8 CE  88 16 42 0C 86 2D E9 28  .... ... ..B..-.(
>  [0A0] 37 8A E4 35 66 92 EC 6E  E6 C7 98 80 A4 2C 00 A3  7..5f..n .....,..
>  [0B0] 65 CE F9 44 41 A8 0F BF  60 73 62 16 00 57 00 69  e..DA... `sb..W.i
>  [0C0] 00 6E 00 64 00 6F 00 77  00 73 00 20 00 32 00 30  .n.d.o.w .s. .2.0
>  [0D0] 00 30 00 32 00 20 00 53  00 65 00 72 00 76 00 69  .0.2. .S .e.r.v.i
>  [0E0] 00 63 00 65 00 20 00 50  00 61 00 63 00 6B 00 20  .c.e. .P .a.c.k. 
>  [0F0] 00 32 00 20 00 32 00 36  00 30 00 30 00 00 00 57  .2. .2.6 .0.0...W
>  [100] 00 69 00 6E 00 64 00 6F  00 77 00 73 00 20 00 32  .i.n.d.o .w.s. .2
>  [110] 00 30 00 30 00 32 00 20  00 35 00 2E 00 31 00 00  .0.0.2.  .5...1..
>  [120] 00 00 00                                          ... 
>[2007/12/12 23:05:54, 3] smbd/process.c:switch_message(993)
>  switch message SMBsesssetupX (pid 4341) conn 0x0
>[2007/12/12 23:05:54, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2007/12/12 23:05:54, 5] auth/auth_util.c:debug_nt_user_token(433)
>  NT user token: (NULL)
>[2007/12/12 23:05:54, 5] auth/auth_util.c:debug_unix_user_token(454)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2007/12/12 23:05:54, 5] smbd/uid.c:change_to_root_user(324)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2007/12/12 23:05:54, 3] smbd/sesssetup.c:reply_sesssetup_and_X(822)
>  wct=12 flg2=0xc807
>[2007/12/12 23:05:54, 2] smbd/sesssetup.c:setup_new_vc_session(772)
>  setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources.
>[2007/12/12 23:05:54, 3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(633)
>  Doing spnego session setup
>[2007/12/12 23:05:54, 3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(664)
>  NativeOS=[Windows 2002 Service Pack 2 2600] NativeLanMan=[Windows 2002 5.1] PrimaryDomain=[]
>[2007/12/12 23:05:54, 3] libsmb/ntlmssp.c:ntlmssp_server_auth(662)
>  Got user=[lsimager] domain=[HPN01X] workstation=[HPN01X] len1=24 len2=24
>[2007/12/12 23:05:54, 5] auth/auth_ntlmssp.c:auth_ntlmssp_set_challenge(66)
>  auth_context challenge set by NTLMSSP callback (NTLM2)
>[2007/12/12 23:05:54, 5] auth/auth_ntlmssp.c:auth_ntlmssp_set_challenge(67)
>  challenge is: 
>[2007/12/12 23:05:54, 5] lib/util.c:dump_data(2058)
>  [000] 4C 43 F2 28 FB 99 99 E8                           LC.(.... 
>[2007/12/12 23:05:54, 6] param/loadparm.c:lp_file_list_changed(2955)
>  lp_file_list_changed()
>  file /etc/samba/smb.conf -> /etc/samba/smb.conf  last mod_time: Wed Dec 12 22:50:33 2007
>  
>[2007/12/12 23:05:54, 5] auth/auth_util.c:make_user_info_map(163)
>  make_user_info_map: Mapping user [HPN01X]\[lsimager] from workstation [HPN01X]
>[2007/12/12 23:05:54, 5] auth/auth_util.c:make_user_info(69)
>  attempting to make a user_info for lsimager (lsimager)
>[2007/12/12 23:05:54, 5] auth/auth_util.c:make_user_info(79)
>  making strings for lsimager's user_info struct
>[2007/12/12 23:05:54, 5] auth/auth_util.c:make_user_info(121)
>  making blobs for lsimager's user_info struct
>[2007/12/12 23:05:54, 10] auth/auth_util.c:make_user_info(139)
>  made an encrypted user_info for lsimager (lsimager)
>[2007/12/12 23:05:54, 3] auth/auth.c:check_ntlm_password(219)
>  check_ntlm_password:  Checking password for unmapped user [HPN01X]\[lsimager]@[HPN01X] with the new password interface
>[2007/12/12 23:05:54, 3] auth/auth.c:check_ntlm_password(222)
>  check_ntlm_password:  mapped user is: [IMAGE]\[lsimager]@[HPN01X]
>[2007/12/12 23:05:54, 10] auth/auth.c:check_ntlm_password(231)
>  check_ntlm_password: auth_context challenge created by NTLMSSP callback (NTLM2)
>[2007/12/12 23:05:54, 10] auth/auth.c:check_ntlm_password(233)
>  challenge is: 
>[2007/12/12 23:05:54, 5] lib/util.c:dump_data(2058)
>  [000] 4C 43 F2 28 FB 99 99 E8                           LC.(.... 
>[2007/12/12 23:05:54, 10] auth/auth.c:check_ntlm_password(259)
>  check_ntlm_password: guest had nothing to say
>[2007/12/12 23:05:54, 8] lib/util.c:is_myname(1879)
>  is_myname("IMAGE") returns 1
>[2007/12/12 23:05:54, 3] smbd/sec_ctx.c:push_sec_ctx(256)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2007/12/12 23:05:54, 3] smbd/uid.c:push_conn_ctx(393)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2007/12/12 23:05:54, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2007/12/12 23:05:54, 5] auth/auth_util.c:debug_nt_user_token(433)
>  NT user token: (NULL)
>[2007/12/12 23:05:54, 5] auth/auth_util.c:debug_unix_user_token(454)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2007/12/12 23:05:54, 10] passdb/pdb_get_set.c:pdb_set_username(617)
>  pdb_set_username: setting username lsimager, was 
>[2007/12/12 23:05:54, 10] passdb/pdb_get_set.c:pdb_set_domain(644)
>  pdb_set_domain: setting domain IMAGE, was 
>[2007/12/12 23:05:54, 10] passdb/pdb_get_set.c:pdb_set_nt_username(671)
>  pdb_set_nt_username: setting nt username , was 
>[2007/12/12 23:05:54, 10] passdb/pdb_get_set.c:pdb_set_fullname(698)
>  pdb_set_full_name: setting full name Lifesaver Imager,,,, was 
>[2007/12/12 23:05:54, 4] lib/substitute.c:automount_server(359)
>  Home server: image
>[2007/12/12 23:05:54, 10] passdb/pdb_get_set.c:pdb_set_homedir(806)
>  pdb_set_homedir: setting home dir \\image\lsimager, was 
>[2007/12/12 23:05:54, 10] passdb/pdb_get_set.c:pdb_set_dir_drive(779)
>  pdb_set_dir_drive: setting dir drive , was NULL
>[2007/12/12 23:05:54, 10] passdb/pdb_get_set.c:pdb_set_logon_script(725)
>  pdb_set_logon_script: setting logon script , was 
>[2007/12/12 23:05:54, 4] lib/substitute.c:automount_server(359)
>  Home server: image
>[2007/12/12 23:05:54, 10] passdb/pdb_get_set.c:pdb_set_profile_path(752)
>  pdb_set_profile_path: setting profile path \\image\lsimager\profile, was 
>[2007/12/12 23:05:54, 10] passdb/pdb_get_set.c:pdb_set_workstations(885)
>  pdb_set_workstations: setting workstations , was 
>[2007/12/12 23:05:54, 10] lib/account_pol.c:account_policy_get(332)
>  account_policy_get: name: password history, val: 0
>[2007/12/12 23:05:54, 10] passdb/pdb_get_set.c:pdb_set_user_sid(544)
>  pdb_set_user_sid: setting user sid S-1-5-21-3956963022-3790210548-4125552707-3002
>[2007/12/12 23:05:54, 10] passdb/pdb_compat.c:pdb_set_user_sid_from_rid(73)
>  pdb_set_user_sid_from_rid:
>  	setting user sid S-1-5-21-3956963022-3790210548-4125552707-3002 from rid 3002
>[2007/12/12 23:05:54, 10] passdb/pdb_get_set.c:pdb_set_group_sid(580)
>  pdb_set_group_sid: setting group sid S-1-5-21-3956963022-3790210548-4125552707-3003
>[2007/12/12 23:05:54, 10] passdb/pdb_compat.c:pdb_set_group_sid_from_rid(100)
>  pdb_set_group_sid_from_rid:
>  	setting group sid S-1-5-21-3956963022-3790210548-4125552707-3003 from rid 3003
>[2007/12/12 23:05:54, 10] lib/account_pol.c:account_policy_get(332)
>  account_policy_get: name: password history, val: 0
>[2007/12/12 23:05:54, 10] passdb/pdb_get_set.c:pdb_set_username(617)
>  pdb_set_username: setting username lsimager, was 
>[2007/12/12 23:05:54, 10] passdb/pdb_get_set.c:pdb_set_domain(644)
>  pdb_set_domain: setting domain IMAGE, was 
>[2007/12/12 23:05:54, 10] passdb/pdb_get_set.c:pdb_set_nt_username(671)
>  pdb_set_nt_username: setting nt username , was 
>[2007/12/12 23:05:54, 10] passdb/pdb_get_set.c:pdb_set_fullname(698)
>  pdb_set_full_name: setting full name Lifesaver Imager,,,, was 
>[2007/12/12 23:05:54, 4] lib/substitute.c:automount_server(359)
>  Home server: image
>[2007/12/12 23:05:54, 10] passdb/pdb_get_set.c:pdb_set_homedir(806)
>  pdb_set_homedir: setting home dir \\image\lsimager, was 
>[2007/12/12 23:05:54, 10] passdb/pdb_get_set.c:pdb_set_dir_drive(779)
>  pdb_set_dir_drive: setting dir drive , was NULL
>[2007/12/12 23:05:54, 10] passdb/pdb_get_set.c:pdb_set_logon_script(725)
>  pdb_set_logon_script: setting logon script , was 
>[2007/12/12 23:05:54, 4] lib/substitute.c:automount_server(359)
>  Home server: image
>[2007/12/12 23:05:54, 10] passdb/pdb_get_set.c:pdb_set_profile_path(752)
>  pdb_set_profile_path: setting profile path \\image\lsimager\profile, was 
>[2007/12/12 23:05:54, 10] passdb/pdb_get_set.c:pdb_set_workstations(885)
>  pdb_set_workstations: setting workstations , was 
>[2007/12/12 23:05:54, 10] lib/account_pol.c:account_policy_get(332)
>  account_policy_get: name: password history, val: 0
>[2007/12/12 23:05:54, 10] passdb/pdb_get_set.c:pdb_set_user_sid(544)
>  pdb_set_user_sid: setting user sid S-1-5-21-3956963022-3790210548-4125552707-3002
>[2007/12/12 23:05:54, 10] passdb/pdb_compat.c:pdb_set_user_sid_from_rid(73)
>  pdb_set_user_sid_from_rid:
>  	setting user sid S-1-5-21-3956963022-3790210548-4125552707-3002 from rid 3002
>[2007/12/12 23:05:54, 10] passdb/pdb_get_set.c:pdb_set_group_sid(580)
>  pdb_set_group_sid: setting group sid S-1-5-21-3956963022-3790210548-4125552707-3003
>[2007/12/12 23:05:54, 10] passdb/pdb_compat.c:pdb_set_group_sid_from_rid(100)
>  pdb_set_group_sid_from_rid:
>  	setting group sid S-1-5-21-3956963022-3790210548-4125552707-3003 from rid 3003
>[2007/12/12 23:05:54, 3] smbd/sec_ctx.c:pop_sec_ctx(386)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2007/12/12 23:05:54, 9] passdb/passdb.c:pdb_update_autolock_flag(2338)
>  pdb_update_autolock_flag: Account lsimager not autolocked, no check needed
>[2007/12/12 23:05:54, 4] libsmb/ntlm_check.c:ntlm_password_check(326)
>  ntlm_password_check: Checking NT MD4 password
>[2007/12/12 23:05:54, 4] auth/auth_sam.c:sam_account_ok(123)
>  sam_account_ok: Checking SMB password for user lsimager
>[2007/12/12 23:05:54, 5] auth/auth_sam.c:logon_hours_ok(105)
>  logon_hours_ok: user lsimager allowed to logon at this time (Wed Dec 12 23:05:54 2007
>  )
>[2007/12/12 23:05:54, 3] smbd/sec_ctx.c:push_sec_ctx(256)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2007/12/12 23:05:54, 3] smbd/uid.c:push_conn_ctx(393)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2007/12/12 23:05:54, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2007/12/12 23:05:54, 5] auth/auth_util.c:debug_nt_user_token(433)
>  NT user token: (NULL)
>[2007/12/12 23:05:54, 5] auth/auth_util.c:debug_unix_user_token(454)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2007/12/12 23:05:54, 10] lib/system_smbd.c:sys_getgrouplist(167)
>  sys_getgrouplist: user [lsimager]
>[2007/12/12 23:05:54, 10] lib/system_smbd.c:sys_getgrouplist(176)
>  sys_getgrouplist(): disabled winbindd for group lookup [user == lsimager]
>[2007/12/12 23:05:54, 3] smbd/sec_ctx.c:push_sec_ctx(256)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2007/12/12 23:05:54, 3] smbd/uid.c:push_conn_ctx(393)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2007/12/12 23:05:54, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2007/12/12 23:05:54, 5] auth/auth_util.c:debug_nt_user_token(433)
>  NT user token: (NULL)
>[2007/12/12 23:05:54, 5] auth/auth_util.c:debug_unix_user_token(454)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2007/12/12 23:05:54, 8] lib/system_smbd.c:remove_duplicate_gids(49)
>  remove_duplicate_gids: Enter 2 gids
>[2007/12/12 23:05:54, 8] lib/system_smbd.c:remove_duplicate_gids(67)
>  remove_duplicate_gids: Exit 1 gids
>[2007/12/12 23:05:54, 3] smbd/sec_ctx.c:pop_sec_ctx(386)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2007/12/12 23:05:54, 3] smbd/sec_ctx.c:push_sec_ctx(256)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2007/12/12 23:05:54, 3] smbd/uid.c:push_conn_ctx(393)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2007/12/12 23:05:54, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2007/12/12 23:05:54, 5] auth/auth_util.c:debug_nt_user_token(433)
>  NT user token: (NULL)
>[2007/12/12 23:05:54, 5] auth/auth_util.c:debug_unix_user_token(454)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2007/12/12 23:05:54, 3] smbd/sec_ctx.c:pop_sec_ctx(386)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2007/12/12 23:05:54, 10] passdb/passdb.c:local_gid_to_sid(1245)
>  local_gid_to_sid: Fall back to algorithmic mapping: 1001 -> S-1-5-21-3956963022-3790210548-4125552707-3003
>[2007/12/12 23:05:54, 10] passdb/lookup_sid.c:gid_to_sid(406)
>  gid_to_sid: local 1001 -> S-1-5-21-3956963022-3790210548-4125552707-3003
>[2007/12/12 23:05:54, 3] smbd/sec_ctx.c:pop_sec_ctx(386)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2007/12/12 23:05:54, 10] auth/auth_util.c:debug_nt_user_token(438)
>  NT user token of user S-1-5-21-3956963022-3790210548-4125552707-3002
>  contains 5 SIDs
>  SID[  0]: S-1-5-21-3956963022-3790210548-4125552707-3002
>  SID[  1]: S-1-5-21-3956963022-3790210548-4125552707-3003
>  SID[  2]: S-1-1-0
>  SID[  3]: S-1-5-2
>  SID[  4]: S-1-5-11
>  SE_PRIV  0x0 0x0 0x0 0x0
>[2007/12/12 23:05:54, 5] auth/auth_util.c:make_server_info_sam(898)
>  make_server_info_sam: made server info for user lsimager -> lsimager
>[2007/12/12 23:05:54, 3] auth/auth.c:check_ntlm_password(268)
>  check_ntlm_password: sam authentication for user [lsimager] succeeded
>[2007/12/12 23:05:54, 3] smbd/sec_ctx.c:push_sec_ctx(256)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2007/12/12 23:05:54, 3] smbd/uid.c:push_conn_ctx(393)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2007/12/12 23:05:54, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2007/12/12 23:05:54, 5] auth/auth_util.c:debug_nt_user_token(433)
>  NT user token: (NULL)
>[2007/12/12 23:05:54, 5] auth/auth_util.c:debug_unix_user_token(454)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2007/12/12 23:05:54, 3] smbd/sec_ctx.c:pop_sec_ctx(386)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2007/12/12 23:05:54, 5] auth/auth.c:check_ntlm_password(294)
>  check_ntlm_password:  PAM Account for user [lsimager] succeeded
>[2007/12/12 23:05:54, 2] auth/auth.c:check_ntlm_password(307)
>  check_ntlm_password:  authentication for user [lsimager] -> [lsimager] -> [lsimager] succeeded
>[2007/12/12 23:05:54, 5] auth/auth_util.c:free_user_info(1485)
>  attempting to free (and zero) a user_info structure
>[2007/12/12 23:05:54, 10] auth/auth_util.c:free_user_info(1488)
>  structure was created for lsimager
>[2007/12/12 23:05:54, 10] auth/auth_ntlmssp.c:auth_ntlmssp_check_password(120)
>  Got NT session key of length 16
>[2007/12/12 23:05:54, 10] auth/auth_ntlmssp.c:auth_ntlmssp_check_password(127)
>  Got LM session key of length 16
>[2007/12/12 23:05:54, 10] libsmb/ntlmssp.c:ntlmssp_server_auth(728)
>  ntlmssp_server_auth: Created NTLM2 session key.
>[2007/12/12 23:05:54, 3] libsmb/ntlmssp_sign.c:ntlmssp_sign_init(338)
>  NTLMSSP Sign/Seal - Initialising with flags:
>[2007/12/12 23:05:54, 3] libsmb/ntlmssp.c:debug_ntlmssp_flags(63)
>  Got NTLMSSP neg_flags=0x60088235
>    NTLMSSP_NEGOTIATE_UNICODE
>    NTLMSSP_REQUEST_TARGET
>    NTLMSSP_NEGOTIATE_SIGN
>    NTLMSSP_NEGOTIATE_SEAL
>    NTLMSSP_NEGOTIATE_NTLM
>    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
>    NTLMSSP_NEGOTIATE_NTLM2
>    NTLMSSP_NEGOTIATE_128
>    NTLMSSP_NEGOTIATE_KEY_EXCH
>[2007/12/12 23:05:54, 10] smbd/password.c:register_vuid(182)
>  register_vuid: allocated vuid = 101
>[2007/12/12 23:05:54, 10] lib/util_pw.c:getpwnam_alloc(98)
>  Got lsimager from pwnam_cache
>[2007/12/12 23:05:54, 10] smbd/password.c:register_vuid(255)
>  register_vuid: (1001,1001) lsimager lsimager IMAGE guest=0
>[2007/12/12 23:05:54, 3] smbd/password.c:register_vuid(257)
>  User name: lsimager	Real name: Lifesaver Imager,,,
>[2007/12/12 23:05:54, 3] smbd/password.c:register_vuid(276)
>  UNIX uid 1001 is UNIX user lsimager, and will be vuid 101
>[2007/12/12 23:05:54, 7] param/loadparm.c:lp_servicenumber(4351)
>  lp_servicenumber: couldn't find lsimager
>[2007/12/12 23:05:54, 3] smbd/password.c:register_vuid(305)
>  Adding homes service for user 'lsimager' using home directory: '/home/lsimager'
>[2007/12/12 23:05:54, 7] param/loadparm.c:lp_servicenumber(4351)
>  lp_servicenumber: couldn't find homes
>[2007/12/12 23:05:54, 6] param/loadparm.c:lp_file_list_changed(2955)
>  lp_file_list_changed()
>  file /etc/samba/smb.conf -> /etc/samba/smb.conf  last mod_time: Wed Dec 12 22:50:33 2007
>  
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(454)
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(464)
>  size=96
>  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=101
>  smb_mid=1792
>  smt_wct=4
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]=    9 (0x9)
>  smb_bcc=53
>[2007/12/12 23:05:54, 10] lib/util.c:dump_data(2058)
>  [000] A1 07 30 05 A0 03 0A 01  00 55 00 6E 00 69 00 78  ..0..... .U.n.i.x
>  [010] 00 00 00 53 00 61 00 6D  00 62 00 61 00 20 00 33  ...S.a.m .b.a. .3
>  [020] 00 2E 00 30 00 2E 00 32  00 32 00 00 00 49 00 4D  ...0...2 .2...I.M
>  [030] 00 47 00 00 00                                    .G... 
>[2007/12/12 23:05:54, 10] smbd/process.c:setup_select_timeout(1372)
>  change_notify_timeout: 300
>[2007/12/12 23:05:54, 10] smbd/process.c:run_events(299)
>  run_events: No events
>[2007/12/12 23:05:54, 10] lib/util_sock.c:read_smb_length_return_keepalive(618)
>  got smb length of 80
>[2007/12/12 23:05:54, 6] smbd/process.c:process_smb(1193)
>  got message type 0x0 of len 0x50
>[2007/12/12 23:05:54, 3] smbd/process.c:process_smb(1194)
>  Transaction 4 of length 84
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(454)
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(464)
>  size=80
>  smb_com=0x75
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=0
>  smb_pid=65279
>  smb_uid=101
>  smb_mid=1856
>  smt_wct=4
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]=   80 (0x50)
>  smb_vwv[ 2]=    8 (0x8)
>  smb_vwv[ 3]=    1 (0x1)
>  smb_bcc=37
>[2007/12/12 23:05:54, 10] lib/util.c:dump_data(2058)
>  [000] 00 5C 00 5C 00 49 00 4D  00 41 00 47 00 45 00 5C  .\.\.I.M .A.G.E.\
>  [010] 00 49 00 4D 00 41 00 47  00 45 00 31 00 00 00 3F  .I.M.A.G .E.1...?
>  [020] 3F 3F 3F 3F 00                                    ????. 
>[2007/12/12 23:05:54, 3] smbd/process.c:switch_message(993)
>  switch message SMBtconX (pid 4341) conn 0x0
>[2007/12/12 23:05:54, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2007/12/12 23:05:54, 5] auth/auth_util.c:debug_nt_user_token(433)
>  NT user token: (NULL)
>[2007/12/12 23:05:54, 5] auth/auth_util.c:debug_unix_user_token(454)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2007/12/12 23:05:54, 5] smbd/uid.c:change_to_root_user(324)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2007/12/12 23:05:54, 4] smbd/reply.c:reply_tcon_and_X(660)
>  Client requested device type [?????] for share [IMAGE1]
>[2007/12/12 23:05:54, 5] smbd/service.c:make_connection(865)
>  making a connection to 'normal' service image1
>[2007/12/12 23:05:54, 5] lib/username.c:Get_Pwnam_alloc(290)
>  Finding user lsimager
>[2007/12/12 23:05:54, 5] lib/username.c:Get_Pwnam_internals(234)
>  Trying _Get_Pwnam(), username as lowercase is lsimager
>[2007/12/12 23:05:54, 10] lib/util_pw.c:getpwnam_alloc(98)
>  Got lsimager from pwnam_cache
>[2007/12/12 23:05:54, 5] lib/username.c:Get_Pwnam_internals(267)
>  Get_Pwnam_internals did find user [lsimager]!
>[2007/12/12 23:05:54, 3] smbd/service.c:make_connection_snum(488)
>  Connect path is '/data/Image1' for service [Image1]
>[2007/12/12 23:05:54, 4] rpc_server/srv_srvsvc_nt.c:get_share_security(240)
>  get_share_security: using default secdesc for Image1
>[2007/12/12 23:05:54, 10] lib/util_seaccess.c:se_map_generic(176)
>  se_map_generic(): mapped mask 0x10000000 to 0x001f01ff
>[2007/12/12 23:05:54, 10] lib/util_seaccess.c:se_access_check(233)
>  se_access_check: requested access 0x00000002, for NT token with 5 entries and first sid S-1-5-21-3956963022-3790210548-4125552707-3002.
>[2007/12/12 23:05:54, 3] lib/util_seaccess.c:se_access_check(250)
>[2007/12/12 23:05:54, 3] lib/util_seaccess.c:se_access_check(251)
>  se_access_check: user sid is S-1-5-21-3956963022-3790210548-4125552707-3002
>  se_access_check: also S-1-5-21-3956963022-3790210548-4125552707-3003
>  se_access_check: also S-1-1-0
>  se_access_check: also S-1-5-2
>  se_access_check: also S-1-5-11
>  se_access_check: ACE 0: type 0, flags = 0x00, SID = S-1-1-0 mask = 101f01ff, current desired = 2
>[2007/12/12 23:05:54, 5] lib/util_seaccess.c:se_access_check(308)
>  se_access_check: access (2) granted.
>[2007/12/12 23:05:54, 3] smbd/vfs.c:vfs_init_default(216)
>  Initialising default vfs hooks
>[2007/12/12 23:05:54, 5] smbd/connection.c:claim_connection(170)
>  claiming Image1 0
>[2007/12/12 23:05:54, 10] smbd/uid.c:is_share_read_only_for_user(127)
>  is_share_read_only_for_user: share Image1 is read-write for unix user lsimager
>[2007/12/12 23:05:54, 4] rpc_server/srv_srvsvc_nt.c:get_share_security(240)
>  get_share_security: using default secdesc for Image1
>[2007/12/12 23:05:54, 10] lib/util_seaccess.c:se_map_generic(176)
>  se_map_generic(): mapped mask 0x10000000 to 0x001f01ff
>[2007/12/12 23:05:54, 10] lib/util_seaccess.c:se_access_check(233)
>  se_access_check: requested access 0x00000002, for NT token with 5 entries and first sid S-1-5-21-3956963022-3790210548-4125552707-3002.
>[2007/12/12 23:05:54, 3] lib/util_seaccess.c:se_access_check(250)
>[2007/12/12 23:05:54, 3] lib/util_seaccess.c:se_access_check(251)
>  se_access_check: user sid is S-1-5-21-3956963022-3790210548-4125552707-3002
>  se_access_check: also S-1-5-21-3956963022-3790210548-4125552707-3003
>  se_access_check: also S-1-1-0
>  se_access_check: also S-1-5-2
>  se_access_check: also S-1-5-11
>  se_access_check: ACE 0: type 0, flags = 0x00, SID = S-1-1-0 mask = 101f01ff, current desired = 2
>[2007/12/12 23:05:54, 5] lib/util_seaccess.c:se_access_check(308)
>  se_access_check: access (2) granted.
>[2007/12/12 23:05:54, 4] rpc_server/srv_srvsvc_nt.c:get_share_security(240)
>  get_share_security: using default secdesc for Image1
>[2007/12/12 23:05:54, 10] lib/util_seaccess.c:se_map_generic(176)
>  se_map_generic(): mapped mask 0x10000000 to 0x001f01ff
>[2007/12/12 23:05:54, 10] lib/util_seaccess.c:se_access_check(233)
>  se_access_check: requested access 0x00000002, for NT token with 5 entries and first sid S-1-5-21-3956963022-3790210548-4125552707-3002.
>[2007/12/12 23:05:54, 3] lib/util_seaccess.c:se_access_check(250)
>[2007/12/12 23:05:54, 3] lib/util_seaccess.c:se_access_check(251)
>  se_access_check: user sid is S-1-5-21-3956963022-3790210548-4125552707-3002
>  se_access_check: also S-1-5-21-3956963022-3790210548-4125552707-3003
>  se_access_check: also S-1-1-0
>  se_access_check: also S-1-5-2
>  se_access_check: also S-1-5-11
>  se_access_check: ACE 0: type 0, flags = 0x00, SID = S-1-1-0 mask = 101f01ff, current desired = 2
>[2007/12/12 23:05:54, 5] lib/util_seaccess.c:se_access_check(308)
>  se_access_check: access (2) granted.
>[2007/12/12 23:05:54, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>  setting sec ctx (1001, 1001) - sec_ctx_stack_ndx = 0
>[2007/12/12 23:05:54, 5] auth/auth_util.c:debug_nt_user_token(438)
>  NT user token of user S-1-5-21-3956963022-3790210548-4125552707-3002
>  contains 5 SIDs
>  SID[  0]: S-1-5-21-3956963022-3790210548-4125552707-3002
>  SID[  1]: S-1-5-21-3956963022-3790210548-4125552707-3003
>  SID[  2]: S-1-1-0
>  SID[  3]: S-1-5-2
>  SID[  4]: S-1-5-11
>  SE_PRIV  0x0 0x0 0x0 0x0
>[2007/12/12 23:05:54, 5] auth/auth_util.c:debug_unix_user_token(454)
>  UNIX token of user 1001
>  Primary group is 1001 and contains 1 supplementary groups
>  Group[  0]: 1001
>[2007/12/12 23:05:54, 5] smbd/uid.c:change_to_user(309)
>  change_to_user uid=(1001,1001) gid=(0,1001)
>[2007/12/12 23:05:54, 1] smbd/service.c:make_connection_snum(693)
>  hpn01x (192.168.4.199) connect to service Image1 initially as user lsimager (uid=1001, gid=1001) (pid 4341)
>[2007/12/12 23:05:54, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2007/12/12 23:05:54, 5] auth/auth_util.c:debug_nt_user_token(433)
>  NT user token: (NULL)
>[2007/12/12 23:05:54, 5] auth/auth_util.c:debug_unix_user_token(454)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2007/12/12 23:05:54, 5] smbd/uid.c:change_to_root_user(324)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2007/12/12 23:05:54, 3] smbd/reply.c:reply_tcon_and_X(708)
>  tconX service=IMAGE1 
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(454)
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(464)
>  size=54
>  smb_com=0x75
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=51201
>  smb_tid=1
>  smb_pid=65279
>  smb_uid=101
>  smb_mid=1856
>  smt_wct=3
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=   13 (0xD)
>  smb_bcc=13
>[2007/12/12 23:05:54, 10] lib/util.c:dump_data(2058)
>  [000] 41 3A 00 4E 00 54 00 46  00 53 00 00 00           A:.N.T.F .S...
>[2007/12/12 23:05:54, 10] smbd/process.c:setup_select_timeout(1372)
>  change_notify_timeout: 300
>[2007/12/12 23:05:54, 10] smbd/process.c:run_events(299)
>  run_events: No events
>[2007/12/12 23:05:54, 10] lib/util_sock.c:read_smb_length_return_keepalive(618)
>  got smb length of 76
>[2007/12/12 23:05:54, 6] smbd/process.c:process_smb(1193)
>  got message type 0x0 of len 0x4c
>[2007/12/12 23:05:54, 3] smbd/process.c:process_smb(1194)
>  Transaction 5 of length 80
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(454)
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(464)
>  size=76
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=912
>  smb_uid=101
>  smb_mid=1920
>  smt_wct=15
>  smb_vwv[ 0]=    8 (0x8)
>  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]=    8 (0x8)
>  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=11
>[2007/12/12 23:05:54, 10] lib/util.c:dump_data(2058)
>  [000] 00 00 00 EC 03 00 00 00  00 00 00                 ........ ...
>[2007/12/12 23:05:54, 3] smbd/process.c:switch_message(993)
>  switch message SMBtrans2 (pid 4341) conn 0x83a7708
>[2007/12/12 23:05:54, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>  setting sec ctx (1001, 1001) - sec_ctx_stack_ndx = 0
>[2007/12/12 23:05:54, 5] auth/auth_util.c:debug_nt_user_token(438)
>  NT user token of user S-1-5-21-3956963022-3790210548-4125552707-3002
>  contains 5 SIDs
>  SID[  0]: S-1-5-21-3956963022-3790210548-4125552707-3002
>  SID[  1]: S-1-5-21-3956963022-3790210548-4125552707-3003
>  SID[  2]: S-1-1-0
>  SID[  3]: S-1-5-2
>  SID[  4]: S-1-5-11
>  SE_PRIV  0x0 0x0 0x0 0x0
>[2007/12/12 23:05:54, 5] auth/auth_util.c:debug_unix_user_token(454)
>  UNIX token of user 1001
>  Primary group is 1001 and contains 1 supplementary groups
>  Group[  0]: 1001
>[2007/12/12 23:05:54, 5] smbd/uid.c:change_to_user(309)
>  change_to_user uid=(1001,1001) gid=(0,1001)
>[2007/12/12 23:05:54, 4] smbd/vfs.c:vfs_ChDir(738)
>  vfs_ChDir to /data/Image1
>[2007/12/12 23:05:54, 3] smbd/trans2.c:call_trans2qfilepathinfo(2861)
>  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 1004
>[2007/12/12 23:05:54, 5] smbd/filename.c:unix_convert(108)
>  unix_convert called on file ""
>[2007/12/12 23:05:54, 5] smbd/filename.c:unix_convert(137)
>  conversion finished "" -> .
>[2007/12/12 23:05:54, 3] smbd/trans2.c:call_trans2qfilepathinfo(2913)
>  call_trans2qfilepathinfo . (fnum = -1) level=1004 call=5 total_data=0
>[2007/12/12 23:05:54, 8] smbd/dosmode.c:dos_mode(300)
>  dos_mode: .
>[2007/12/12 23:05:54, 8] smbd/dosmode.c:dos_mode_from_sbuf(167)
>  dos_mode_from_sbuf returning d
>[2007/12/12 23:05:54, 8] smbd/dosmode.c:dos_mode(334)
>  dos_mode returning d
>[2007/12/12 23:05:54, 10] smbd/trans2.c:call_trans2qfilepathinfo(3108)
>  call_trans2qfilepathinfo: SMB_FILE_BASIC_INFORMATION
>[2007/12/12 23:05:54, 5] smbd/trans2.c:call_trans2qfilepathinfo(3118)
>  SMB_QFBI - create: Sat Dec  8 15:36:34 2007
>   access: Wed Dec 12 22:51:28 2007
>   write: Sat Dec  8 15:36:34 2007
>   change: Sat Dec  8 15:36:34 2007
>   mode: 10
>[2007/12/12 23:05:54, 9] smbd/trans2.c:send_trans2_replies(685)
>  t2_rep: params_sent_thistime = 2, data_sent_thistime = 40, useable_space = 131010
>[2007/12/12 23:05:54, 9] smbd/trans2.c:send_trans2_replies(687)
>  t2_rep: params_to_send = 2, data_to_send = 40, paramsize = 2, datasize = 40
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(454)
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(464)
>  size=100
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=51265
>  smb_tid=1
>  smb_pid=912
>  smb_uid=101
>  smb_mid=1920
>  smt_wct=10
>  smb_vwv[ 0]=    2 (0x2)
>  smb_vwv[ 1]=   40 (0x28)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]=    2 (0x2)
>  smb_vwv[ 4]=   56 (0x38)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=   40 (0x28)
>  smb_vwv[ 7]=   60 (0x3C)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=    0 (0x0)
>  smb_bcc=45
>[2007/12/12 23:05:54, 10] lib/util.c:dump_data(2058)
>  [000] 00 00 00 00 00 00 AD C8  1C B0 39 C8 01 00 18 AC  ........ ..9.....
>  [010] 87 11 3D C8 01 00 AD C8  1C B0 39 C8 01 00 AD C8  ..=..... ..9.....
>  [020] 1C B0 39 C8 01 10 00 00  00 00 00 00 00           ..9..... .....
>[2007/12/12 23:05:54, 10] smbd/process.c:setup_select_timeout(1372)
>  change_notify_timeout: 300
>[2007/12/12 23:05:54, 10] smbd/process.c:run_events(299)
>  run_events: No events
>[2007/12/12 23:05:54, 10] lib/util_sock.c:read_smb_length_return_keepalive(618)
>  got smb length of 70
>[2007/12/12 23:05:54, 6] smbd/process.c:process_smb(1193)
>  got message type 0x0 of len 0x46
>[2007/12/12 23:05:54, 3] smbd/process.c:process_smb(1194)
>  Transaction 6 of length 74
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(454)
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(464)
>  size=70
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=912
>  smb_uid=101
>  smb_mid=1984
>  smt_wct=15
>  smb_vwv[ 0]=    2 (0x2)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]=  560 (0x230)
>  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]=    2 (0x2)
>  smb_vwv[10]=   68 (0x44)
>  smb_vwv[11]=    0 (0x0)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=    1 (0x1)
>  smb_vwv[14]=    3 (0x3)
>  smb_bcc=5
>[2007/12/12 23:05:54, 10] lib/util.c:dump_data(2058)
>  [000] 00 00 00 02 01                                    ..... 
>[2007/12/12 23:05:54, 3] smbd/process.c:switch_message(993)
>  switch message SMBtrans2 (pid 4341) conn 0x83a7708
>[2007/12/12 23:05:54, 4] smbd/uid.c:change_to_user(222)
>  change_to_user: Skipping user change - already user
>[2007/12/12 23:05:54, 3] smbd/trans2.c:call_trans2qfsinfo(2136)
>  call_trans2qfsinfo: level = 258
>[2007/12/12 23:05:54, 5] smbd/trans2.c:call_trans2qfsinfo(2249)
>  call_trans2qfsinfo : SMB_QUERY_FS_VOLUME_INFO namelen = 6, vol=Image1 serv=Image1
>[2007/12/12 23:05:54, 9] smbd/trans2.c:send_trans2_replies(685)
>  t2_rep: params_sent_thistime = 0, data_sent_thistime = 30, useable_space = 131012
>[2007/12/12 23:05:54, 9] smbd/trans2.c:send_trans2_replies(687)
>  t2_rep: params_to_send = 0, data_to_send = 30, paramsize = 0, datasize = 30
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(454)
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(464)
>  size=86
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=51265
>  smb_tid=1
>  smb_pid=912
>  smb_uid=101
>  smb_mid=1984
>  smt_wct=10
>  smb_vwv[ 0]=    0 (0x0)
>  smb_vwv[ 1]=   30 (0x1E)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]=    0 (0x0)
>  smb_vwv[ 4]=   56 (0x38)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=   30 (0x1E)
>  smb_vwv[ 7]=   56 (0x38)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=    0 (0x0)
>  smb_bcc=31
>[2007/12/12 23:05:54, 10] lib/util.c:dump_data(2058)
>  [000] 00 00 00 00 00 00 00 00  00 5F 02 5F 04 0C 00 00  ........ ._._....
>  [010] 00 00 00 49 00 6D 00 61  00 67 00 65 00 31 00     ...I.m.a .g.e.1.
>[2007/12/12 23:05:54, 4] smbd/trans2.c:call_trans2qfsinfo(2465)
>  SMBtrans2 info_level = 258
>[2007/12/12 23:05:54, 10] smbd/process.c:setup_select_timeout(1372)
>  change_notify_timeout: 300
>[2007/12/12 23:05:54, 10] smbd/process.c:run_events(299)
>  run_events: No events
>[2007/12/12 23:05:54, 10] lib/util_sock.c:read_smb_length_return_keepalive(618)
>  got smb length of 70
>[2007/12/12 23:05:54, 6] smbd/process.c:process_smb(1193)
>  got message type 0x0 of len 0x46
>[2007/12/12 23:05:54, 3] smbd/process.c:process_smb(1194)
>  Transaction 7 of length 74
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(454)
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(464)
>  size=70
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=912
>  smb_uid=101
>  smb_mid=2048
>  smt_wct=15
>  smb_vwv[ 0]=    2 (0x2)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]=  560 (0x230)
>  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]=    2 (0x2)
>  smb_vwv[10]=   68 (0x44)
>  smb_vwv[11]=    0 (0x0)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=    1 (0x1)
>  smb_vwv[14]=    3 (0x3)
>  smb_bcc=5
>[2007/12/12 23:05:54, 10] lib/util.c:dump_data(2058)
>  [000] 00 00 00 05 01                                    ..... 
>[2007/12/12 23:05:54, 3] smbd/process.c:switch_message(993)
>  switch message SMBtrans2 (pid 4341) conn 0x83a7708
>[2007/12/12 23:05:54, 4] smbd/uid.c:change_to_user(222)
>  change_to_user: Skipping user change - already user
>[2007/12/12 23:05:54, 3] smbd/trans2.c:call_trans2qfsinfo(2136)
>  call_trans2qfsinfo: level = 261
>[2007/12/12 23:05:54, 9] smbd/trans2.c:send_trans2_replies(685)
>  t2_rep: params_sent_thistime = 0, data_sent_thistime = 20, useable_space = 131012
>[2007/12/12 23:05:54, 9] smbd/trans2.c:send_trans2_replies(687)
>  t2_rep: params_to_send = 0, data_to_send = 20, paramsize = 0, datasize = 20
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(454)
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(464)
>  size=76
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=51265
>  smb_tid=1
>  smb_pid=912
>  smb_uid=101
>  smb_mid=2048
>  smt_wct=10
>  smb_vwv[ 0]=    0 (0x0)
>  smb_vwv[ 1]=   20 (0x14)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]=    0 (0x0)
>  smb_vwv[ 4]=   56 (0x38)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=   20 (0x14)
>  smb_vwv[ 7]=   56 (0x38)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=    0 (0x0)
>  smb_bcc=21
>[2007/12/12 23:05:54, 10] lib/util.c:dump_data(2058)
>  [000] 00 23 00 00 00 FF 00 00  00 08 00 00 00 4E 00 54  .#...... .....N.T
>  [010] 00 46 00 53 00                                    .F.S. 
>[2007/12/12 23:05:54, 4] smbd/trans2.c:call_trans2qfsinfo(2465)
>  SMBtrans2 info_level = 261
>[2007/12/12 23:05:54, 10] smbd/process.c:setup_select_timeout(1372)
>  change_notify_timeout: 300
>[2007/12/12 23:05:54, 10] smbd/process.c:run_events(299)
>  run_events: No events
>[2007/12/12 23:05:54, 10] lib/util_sock.c:read_smb_length_return_keepalive(618)
>  got smb length of 70
>[2007/12/12 23:05:54, 6] smbd/process.c:process_smb(1193)
>  got message type 0x0 of len 0x46
>[2007/12/12 23:05:54, 3] smbd/process.c:process_smb(1194)
>  Transaction 8 of length 74
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(454)
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(464)
>  size=70
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=912
>  smb_uid=101
>  smb_mid=2112
>  smt_wct=15
>  smb_vwv[ 0]=    2 (0x2)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]=  560 (0x230)
>  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]=    2 (0x2)
>  smb_vwv[10]=   68 (0x44)
>  smb_vwv[11]=    0 (0x0)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=    1 (0x1)
>  smb_vwv[14]=    3 (0x3)
>  smb_bcc=5
>[2007/12/12 23:05:54, 10] lib/util.c:dump_data(2058)
>  [000] 00 00 00 05 01                                    ..... 
>[2007/12/12 23:05:54, 3] smbd/process.c:switch_message(993)
>  switch message SMBtrans2 (pid 4341) conn 0x83a7708
>[2007/12/12 23:05:54, 4] smbd/uid.c:change_to_user(222)
>  change_to_user: Skipping user change - already user
>[2007/12/12 23:05:54, 3] smbd/trans2.c:call_trans2qfsinfo(2136)
>  call_trans2qfsinfo: level = 261
>[2007/12/12 23:05:54, 9] smbd/trans2.c:send_trans2_replies(685)
>  t2_rep: params_sent_thistime = 0, data_sent_thistime = 20, useable_space = 131012
>[2007/12/12 23:05:54, 9] smbd/trans2.c:send_trans2_replies(687)
>  t2_rep: params_to_send = 0, data_to_send = 20, paramsize = 0, datasize = 20
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(454)
>[2007/12/12 23:05:54, 5] lib/util.c:show_msg(464)
>  size=76
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=51265
>  smb_tid=1
>  smb_pid=912
>  smb_uid=101
>  smb_mid=2112
>  smt_wct=10
>  smb_vwv[ 0]=    0 (0x0)
>  smb_vwv[ 1]=   20 (0x14)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]=    0 (0x0)
>  smb_vwv[ 4]=   56 (0x38)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=   20 (0x14)
>  smb_vwv[ 7]=   56 (0x38)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=    0 (0x0)
>  smb_bcc=21
>[2007/12/12 23:05:54, 10] lib/util.c:dump_data(2058)
>  [000] 00 23 00 00 00 FF 00 00  00 08 00 00 00 4E 00 54  .#...... .....N.T
>  [010] 00 46 00 53 00                                    .F.S. 
>[2007/12/12 23:05:54, 4] smbd/trans2.c:call_trans2qfsinfo(2465)
>  SMBtrans2 info_level = 261
>[2007/12/12 23:05:54, 10] smbd/process.c:setup_select_timeout(1372)
>  change_notify_timeout: 300
>[2007/12/12 23:05:54, 10] smbd/process.c:run_events(299)
>  run_events: No events
>[2007/12/12 23:06:54, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2007/12/12 23:06:54, 5] auth/auth_util.c:debug_nt_user_token(433)
>  NT user token: (NULL)
>[2007/12/12 23:06:54, 5] auth/auth_util.c:debug_unix_user_token(454)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2007/12/12 23:06:54, 5] smbd/uid.c:change_to_root_user(324)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2007/12/12 23:06:54, 10] smbd/process.c:setup_select_timeout(1372)
>  change_notify_timeout: 300
>[2007/12/12 23:07:54, 3] smbd/sec_ctx.c:set_sec_ctx(288)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2007/12/12 23:07:54, 5] auth/auth_util.c:debug_nt_user_token(433)
>  NT user token: (NULL)
>[2007/12/12 23:07:54, 5] auth/auth_util.c:debug_unix_user_token(454)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups
>[2007/12/12 23:07:54, 5] smbd/uid.c:change_to_root_user(324)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2007/12/12 23:07:54, 3] smbd/process.c:check_reload(1428)
>  Printcap cache time expired.
>[2007/12/12 23:07:54, 7] param/loadparm.c:lp_servicenumber(4351)
>  lp_servicenumber: couldn't find printers
>[2007/12/12 23:07:54, 3] printing/pcap.c:pcap_cache_reload(117)
>  reloading printcap cache
>[2007/12/12 23:07:54, 3] printing/pcap.c:pcap_cache_reload(223)
>  reload status: ok
>[2007/12/12 23:07:54, 3] printing/pcap.c:pcap_cache_reload(117)
>  reloading printcap cache
>[2007/12/12 23:07:54, 3] printing/pcap.c:pcap_cache_reload(223)
>  reload status: ok
>[2007/12/12 23:07:54, 7] param/loadparm.c:lp_servicenumber(4351)
>  lp_servicenumber: couldn't find printers
>[2007/12/12 23:07:54, 10] smbd/process.c:setup_select_timeout(1372)
>  change_notify_timeout: 300

Actions: View

Attachments on bug 5138: 3039 | 3040 | 3041 | 3042 | 11066