[Pkg-samba-maint] Bug#531344: Bug#531344: samba: Long delay for login with Vista SP2 as a Samba domain member
Dr. Jürgen Pfennig
info at j-pfennig.de
Mon Jun 1 14:26:44 UTC 2009
On Mon 01.06.2009 08:19:10 Christian Perrier wrote:
> found 531344 2:3.3.4-1
> thanks
>
> Quoting Juergen Pfennig (info at j-pfennig.de):
> > Package: samba
> > Version: 2:3.3.4-1~bpo50+2
> > Severity: normal
> >
> > Since 3.3.4 Vista can work (again) as a domain member - but logins
> > for domain users take VERY long (60s or so). This is not related to
> > roaming profiles. The PDC works fine for linux and windows 2003 but
> > not for Vista.
>
> A (level 10) debug log as well as the output of "testparm
> /etc/samba/smb.conf" might help here.
>
>
> I'll assum this also affects the 3.3.4 packages in squeeze and sid as
> well and not only backported packages...
Hi, I'm unhappy as the requested output is of several MByte size. For the
moment (1) the testparm output (2) a part from log.smbd with level 4. Just to
be mentioned:
a) The same problem (30s delay) has been reported to several mailing lists a
while ago and also affected older samba versions (back to 3.0). But there is
no such Debian bug entry.
b) It's actiually 2 delays as I learned from the log: 10s + 20s.
I could sent you full level 10 logs via private E-Mail (if you really want it)
Yours Jürgen
################################## testparam ############################
Load smb config files from /etc/samba/smb.conf
Processing section "[netlogon]"
Processing section "[homes]"
Processing section "[printers]"
Processing section "[print$]"
Processing section "[alpha1_export]"
Processing section "[alpha1_images]"
Processing section "[alpha1_vol1]"
Processing section "[alpha1_vol2]"
Loaded services file OK.
WARNING: You have some share names that are longer than 12 characters.
These may not be accessible to some older clients.
(Eg. Windows9x, WindowsMe, and smbclient prior to Samba 3.0.)
Server role: ROLE_DOMAIN_PDC
[global]
workgroup = CENTAURI
server string = Centauri Domain, Samba %v
interfaces = 127.0.0.1, 10.21.2.0/24, 10.21.3.0/24
bind interfaces only = Yes
passdb backend = ldapsam:ldap://alpha.centauri.home
log level = 1
syslog only = Yes
printcap name = cups
show add printer wizard = No
add user script = /usr/local/bin/centaurildap -x -w -c -r adduser '%u'
users
rename user script = /usr/local/bin/centaurildap -x -w
renameuser '%uold' '%unew'
delete user script = /usr/local/bin/centaurildap -x -w
deleteuser '%u'
add group script = /usr/local/bin/centaurildap -x -w addgroup '%g'
delete group script = /usr/local/bin/centaurildap -x -w
deletegroup '%g'
add user to group script = /usr/local/bin/centaurildap -x -w
addusertogroup '%u' '%g'
delete user from group script = /usr/local/bin/centaurildap -x -w
deleteuserfromgroup '%u' '%g'
set primary group script = /usr/local/bin/centaurildap -x -w
setprimarygroup '%u' '%g'
add machine script = /usr/local/bin/centaurildap -x -w
addmachine '%u' machines
logon path = \\%N\%U\Roaming\Profiles\win
logon drive = Z:
domain logons = Yes
os level = 49
preferred master = Yes
domain master = Yes
dns proxy = No
wins support = Yes
ldap admin dn = uid=domain,ou=Users,ou=samba,dc=centauri,dc=home
ldap group suffix = ou=Groups
ldap machine suffix = ou=Computers
ldap passwd sync = yes
ldap suffix = ou=samba,dc=centauri,dc=home
ldap user suffix = ou=Users
create mask = 0775
directory mask = 0775
hide unreadable = Yes
include = /etc/samba/services.conf
[netlogon]
path = /var/lib/samba/netlogon
write list = @trusted, root
guest ok = Yes
browseable = No
[homes]
comment = Home Directories
valid users = %S
read only = No
create mask = 0640
directory mask = 0750
browseable = No
[printers]
comment = All Printers
path = /var/tmp
guest ok = Yes
printable = Yes
browseable = No
[print$]
comment = Printer Drivers
path = /var/lib/samba/drivers
write list = @ntadmin, root
force group = ntadmin
create mask = 0664
[alpha1_export]
comment = Access to all exports
path = /export
read only = No
[alpha1_images]
comment = Virtual machine images
path = /.autolocal/alpha1_images
read only = No
[alpha1_vol1]
comment = Data Volume #1
path = /.autolocal/alpha1_vol1
read only = No
[alpha1_vol2]
comment = Data Volume #2
path = /.autolocal/alpha1_vol2
read only = No
################################## log.smbd (level 4) ####################
#### login start
[2009/06/01 15:57:03, 3] smbd/process.c:check_reload(1873)
Printcap cache time expired.
[2009/06/01 15:57:03, 3] printing/pcap.c:pcap_cache_reload(136)
reloading printcap cache
[2009/06/01 15:57:03, 3] printing/pcap.c:pcap_cache_reload(243)
reload status: ok
[2009/06/01 15:57:03, 3] smbd/oplock.c:init_oplocks(912)
init_oplocks: initializing messages.
[2009/06/01 15:57:03, 3] smbd/oplock_linux.c:linux_init_kernel_oplocks(241)
Linux kernel oplocks enabled
[2009/06/01 15:57:03, 3] smbd/process.c:process_smb(1554)
Transaction 0 of length 148 (0 toread)
[2009/06/01 15:57:03, 3] smbd/process.c:switch_message(1378)
switch message SMBnegprot (pid 27874) conn 0x0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/negprot.c:reply_negprot(569)
Requested protocol [PC NETWORK PROGRAM 1.0]
[2009/06/01 15:57:03, 3] smbd/negprot.c:reply_negprot(569)
Requested protocol [LANMAN1.0]
[2009/06/01 15:57:03, 3] smbd/negprot.c:reply_negprot(569)
Requested protocol [Windows for Workgroups 3.1a]
[2009/06/01 15:57:03, 3] smbd/negprot.c:reply_negprot(569)
Requested protocol [LM1.2X002]
[2009/06/01 15:57:03, 3] smbd/negprot.c:reply_negprot(569)
Requested protocol [LANMAN2.1]
[2009/06/01 15:57:03, 3] smbd/negprot.c:reply_negprot(569)
Requested protocol [NT LM 0.12]
[2009/06/01 15:57:03, 3] smbd/negprot.c:reply_negprot(569)
Requested protocol [SMB 2.002]
[2009/06/01 15:57:03, 3] smbd/negprot.c:reply_nt1(392)
using SPNEGO
[2009/06/01 15:57:03, 3] smbd/negprot.c:reply_negprot(674)
Selected protocol NT LM 0.12
[2009/06/01 15:57:03, 3] smbd/process.c:process_smb(1554)
Transaction 1 of length 142 (0 toread)
[2009/06/01 15:57:03, 3] smbd/process.c:switch_message(1378)
switch message SMBsesssetupX (pid 27874) conn 0x0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sesssetup.c:reply_sesssetup_and_X(1412)
wct=12 flg2=0xc807
[2009/06/01 15:57:03, 2] smbd/sesssetup.c:setup_new_vc_session(1368)
setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all
old resources.
[2009/06/01 15:57:03, 3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1175)
Doing spnego session setup
[2009/06/01 15:57:03, 3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1210)
NativeOS=[] NativeLanMan=[] PrimaryDomain=[]
[2009/06/01 15:57:03, 3] smbd/sesssetup.c:reply_spnego_negotiate(802)
reply_spnego_negotiate: Got secblob of size 40
[2009/06/01 15:57:03, 3] libsmb/ntlmssp.c:debug_ntlmssp_flags(62)
Got NTLMSSP neg_flags=0xe2088297
[2009/06/01 15:57:03, 3] smbd/process.c:process_smb(1554)
Transaction 2 of length 192 (0 toread)
[2009/06/01 15:57:03, 3] smbd/process.c:switch_message(1378)
switch message SMBsesssetupX (pid 27874) conn 0x0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sesssetup.c:reply_sesssetup_and_X(1412)
wct=12 flg2=0xc807
[2009/06/01 15:57:03, 2] smbd/sesssetup.c:setup_new_vc_session(1368)
setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all
old resources.
[2009/06/01 15:57:03, 3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1175)
Doing spnego session setup
[2009/06/01 15:57:03, 3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1210)
NativeOS=[] NativeLanMan=[] PrimaryDomain=[]
[2009/06/01 15:57:03, 3] libsmb/ntlmssp.c:ntlmssp_server_auth(747)
Got user=[] domain=[] workstation=[DELTA5] len1=1 len2=0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] lib/smbldap.c:smb_ldap_start_tls(604)
StartTLS issued: using a TLS connection
[2009/06/01 15:57:03, 2] lib/smbldap.c:smbldap_open_connection(800)
smbldap_open_connection: connection opened
[2009/06/01 15:57:03, 3] lib/smbldap.c:smbldap_connect_system(1011)
ldap_connect_system: successful connection to the LDAP server
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] auth/auth.c:check_ntlm_password(220)
check_ntlm_password: Checking password for unmapped user []\[]@[DELTA5]
with the new password interface
[2009/06/01 15:57:03, 3] auth/auth.c:check_ntlm_password(223)
check_ntlm_password: mapped user is: [CENTAURI]\[]@[DELTA5]
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] auth/auth.c:check_ntlm_password(269)
check_ntlm_password: guest authentication for user [] succeeded
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID
[S-1-5-21-726356159-1313063555-1301796730-501]
[2009/06/01 15:57:03, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID [S-1-5-2]
[2009/06/01 15:57:03, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID [S-1-5-32-546]
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] libsmb/ntlmssp_sign.c:ntlmssp_sign_init(337)
NTLMSSP Sign/Seal - Initialising with flags:
[2009/06/01 15:57:03, 3] libsmb/ntlmssp.c:debug_ntlmssp_flags(62)
Got NTLMSSP neg_flags=0xe2088215
[2009/06/01 15:57:03, 3] smbd/password.c:register_existing_vuid(289)
register_existing_vuid: User name: nobody Real name: nobody
[2009/06/01 15:57:03, 3] smbd/password.c:register_existing_vuid(299)
register_existing_vuid: UNIX uid 65534 is UNIX user nobody, and will be vuid
100
[2009/06/01 15:57:03, 3] smbd/process.c:process_smb(1554)
Transaction 3 of length 82 (0 toread)
[2009/06/01 15:57:03, 3] smbd/process.c:switch_message(1378)
switch message SMBtconX (pid 27874) conn 0x0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/service.c:make_connection_snum(871)
Connect path is '/tmp' for service [IPC$]
[2009/06/01 15:57:03, 3] smbd/vfs.c:vfs_init_default(96)
Initialising default vfs hooks
[2009/06/01 15:57:03, 3] smbd/vfs.c:vfs_init_custom(130)
Initialising custom vfs hooks from [/[Default VFS]/]
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (65534, 65534) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/service.c:make_connection_snum(1111)
delta5 (10.21.2.133) connect to service IPC$ initially as user nobody
(uid=65534, gid=65534) (pid 27874)
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/reply.c:reply_tcon_and_X(794)
tconX service=IPC$
[2009/06/01 15:57:03, 3] smbd/process.c:process_smb(1554)
Transaction 4 of length 108 (0 toread)
[2009/06/01 15:57:03, 3] smbd/process.c:switch_message(1378)
switch message SMBntcreateX (pid 27874) conn 0x8bf13d8
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (65534, 65534) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/nttrans.c:nt_open_pipe(286)
nt_open_pipe: Known pipe NETLOGON opening.
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(65534, 65534) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (65534, 65534) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(65534, 65534) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (65534, 65534) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/process.c:process_smb(1554)
Transaction 5 of length 76 (0 toread)
[2009/06/01 15:57:03, 3] smbd/process.c:switch_message(1378)
switch message SMBtrans2 (pid 27874) conn 0x8bf13d8
[2009/06/01 15:57:03, 3] smbd/process.c:process_smb(1554)
Transaction 6 of length 224 (0 toread)
[2009/06/01 15:57:03, 3] smbd/process.c:switch_message(1378)
switch message SMBwriteX (pid 27874) conn 0x8bf13d8
[2009/06/01 15:57:03, 3] rpc_server/srv_pipe.c:api_pipe_bind_req(1617)
api_pipe_bind_req: \PIPE\netlogon -> \PIPE\netlogon
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(65534, 65534) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3]
passdb/secrets.c:secrets_restore_schannel_session_info(1310)
secrets_restore_schannel_session_info: restored schannel info key
SECRETS/SCHANNEL/DELTA5
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (65534, 65534) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] rpc_server/srv_pipe.c:check_bind_req(991)
check_bind_req for netlogon
[2009/06/01 15:57:03, 3] smbd/pipes.c:reply_pipe_write_and_X(241)
writeX-IPC pnum=72cd nwritten=156
[2009/06/01 15:57:03, 3] smbd/process.c:process_smb(1554)
Transaction 7 of length 63 (0 toread)
[2009/06/01 15:57:03, 3] smbd/process.c:switch_message(1378)
switch message SMBreadX (pid 27874) conn 0x8bf13d8
[2009/06/01 15:57:03, 3] smbd/pipes.c:reply_pipe_read_and_X(291)
readX-IPC pnum=72cd min=1024 max=1024 nread=92
[2009/06/01 15:57:03, 3] smbd/process.c:process_smb(1554)
Transaction 8 of length 452 (0 toread)
[2009/06/01 15:57:03, 3] smbd/process.c:switch_message(1378)
switch message SMBwriteX (pid 27874) conn 0x8bf13d8
[2009/06/01 15:57:03, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(500)
free_pipe_context: destroying talloc pool of size 120
[2009/06/01 15:57:03, 3] rpc_server/srv_pipe.c:api_rpcTNP(2359)
api_rpcTNP: rpc command: NETR_LOGONSAMLOGON
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(65534, 65534) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3]
passdb/secrets.c:secrets_restore_schannel_session_info(1310)
secrets_restore_schannel_session_info: restored schannel info key
SECRETS/SCHANNEL/DELTA5
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (65534, 65534) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(65534, 65534) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3]
passdb/secrets.c:secrets_store_schannel_session_info(1217)
secrets_store_schannel_session_info: stored schannel info with key
SECRETS/SCHANNEL/DELTA5
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (65534, 65534) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] rpc_server/srv_netlog_nt.c:_netr_LogonSamLogon(855)
SAM Logon (Interactive). Domain:[CENTAURI]. User:[jpf at DELTA5] Requested
Domain:[CENTAURI]
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(65534, 65534) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (65534, 65534) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] auth/auth.c:check_ntlm_password(220)
check_ntlm_password: Checking password for unmapped user
[CENTAURI]\[jpf]@[DELTA5] with the new password interface
[2009/06/01 15:57:03, 3] auth/auth.c:check_ntlm_password(223)
check_ntlm_password: mapped user is: [CENTAURI]\[jpf]@[DELTA5]
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(65534, 65534) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 2] passdb/pdb_ldap.c:init_sam_from_ldap(571)
init_sam_from_ldap: Entry found for user: jpf
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 2] passdb/pdb_ldap.c:init_group_from_ldap(2348)
init_group_from_ldap: Entry found for group: 1001
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
[2009/06/01 15:57:03, 2] passdb/pdb_ldap.c:init_group_from_ldap(2348)
init_group_from_ldap: Entry found for group: 1001
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (65534, 65534) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(65534, 65534) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (65534, 65534) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(65534, 65534) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 2] passdb/pdb_ldap.c:init_group_from_ldap(2348)
init_group_from_ldap: Entry found for group: 1001
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 2] passdb/pdb_ldap.c:init_group_from_ldap(2348)
init_group_from_ldap: Entry found for group: 100
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 2] passdb/pdb_ldap.c:init_group_from_ldap(2348)
init_group_from_ldap: Entry found for group: 1002
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (65534, 65534) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] auth/auth.c:check_ntlm_password(269)
check_ntlm_password: sam authentication for user [jpf] succeeded
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(65534, 65534) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (65534, 65534) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 2] auth/auth.c:check_ntlm_password(308)
check_ntlm_password: authentication for user [jpf] -> [jpf] -> [jpf]
succeeded
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(65534, 65534) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (65534, 65534) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(65534, 65534) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:03, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (65534, 65534) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:03, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(500)
free_pipe_context: destroying talloc pool of size 400
[2009/06/01 15:57:03, 3] smbd/pipes.c:reply_pipe_write_and_X(241)
writeX-IPC pnum=72cd nwritten=384
[2009/06/01 15:57:03, 3] smbd/process.c:process_smb(1554)
Transaction 9 of length 63 (0 toread)
[2009/06/01 15:57:03, 3] smbd/process.c:switch_message(1378)
switch message SMBreadX (pid 27874) conn 0x8bf13d8
[2009/06/01 15:57:03, 3] smbd/pipes.c:reply_pipe_read_and_X(291)
readX-IPC pnum=72cd min=1024 max=1024 nread=616
[2009/06/01 15:57:04, 3] smbd/process.c:process_smb(1554)
Transaction 10 of length 142 (0 toread)
[2009/06/01 15:57:04, 3] smbd/process.c:switch_message(1378)
switch message SMBsesssetupX (pid 27874) conn 0x0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sesssetup.c:reply_sesssetup_and_X(1412)
wct=12 flg2=0xc807
[2009/06/01 15:57:04, 3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1175)
Doing spnego session setup
[2009/06/01 15:57:04, 3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1210)
NativeOS=[] NativeLanMan=[] PrimaryDomain=[]
[2009/06/01 15:57:04, 3] smbd/sesssetup.c:reply_spnego_negotiate(802)
reply_spnego_negotiate: Got secblob of size 40
[2009/06/01 15:57:04, 3] libsmb/ntlmssp.c:debug_ntlmssp_flags(62)
Got NTLMSSP neg_flags=0xe2088297
[2009/06/01 15:57:04, 3] smbd/process.c:process_smb(1554)
Transaction 11 of length 192 (0 toread)
[2009/06/01 15:57:04, 3] smbd/process.c:switch_message(1378)
switch message SMBsesssetupX (pid 27874) conn 0x0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sesssetup.c:reply_sesssetup_and_X(1412)
wct=12 flg2=0xc807
[2009/06/01 15:57:04, 3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1175)
Doing spnego session setup
[2009/06/01 15:57:04, 3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1210)
NativeOS=[] NativeLanMan=[] PrimaryDomain=[]
[2009/06/01 15:57:04, 3] libsmb/ntlmssp.c:ntlmssp_server_auth(747)
Got user=[] domain=[] workstation=[DELTA5] len1=1 len2=0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] auth/auth.c:check_ntlm_password(220)
check_ntlm_password: Checking password for unmapped user []\[]@[DELTA5]
with the new password interface
[2009/06/01 15:57:04, 3] auth/auth.c:check_ntlm_password(223)
check_ntlm_password: mapped user is: [CENTAURI]\[]@[DELTA5]
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] auth/auth.c:check_ntlm_password(269)
check_ntlm_password: guest authentication for user [] succeeded
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:04, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:04, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID
[S-1-5-21-726356159-1313063555-1301796730-501]
[2009/06/01 15:57:04, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID [S-1-5-2]
[2009/06/01 15:57:04, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID [S-1-5-32-546]
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] libsmb/ntlmssp_sign.c:ntlmssp_sign_init(337)
NTLMSSP Sign/Seal - Initialising with flags:
[2009/06/01 15:57:04, 3] libsmb/ntlmssp.c:debug_ntlmssp_flags(62)
Got NTLMSSP neg_flags=0xe2088215
[2009/06/01 15:57:04, 3] smbd/password.c:register_existing_vuid(289)
register_existing_vuid: User name: nobody Real name: nobody
[2009/06/01 15:57:04, 3] smbd/password.c:register_existing_vuid(299)
register_existing_vuid: UNIX uid 65534 is UNIX user nobody, and will be vuid
101
[2009/06/01 15:57:04, 3] smbd/process.c:process_smb(1554)
Transaction 12 of length 82 (0 toread)
[2009/06/01 15:57:04, 3] smbd/process.c:switch_message(1378)
switch message SMBtconX (pid 27874) conn 0x0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/service.c:make_connection_snum(871)
Connect path is '/tmp' for service [IPC$]
[2009/06/01 15:57:04, 3] smbd/vfs.c:vfs_init_default(96)
Initialising default vfs hooks
[2009/06/01 15:57:04, 3] smbd/vfs.c:vfs_init_custom(130)
Initialising custom vfs hooks from [/[Default VFS]/]
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (65534, 65534) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/service.c:make_connection_snum(1111)
delta5 (10.21.2.133) connect to service IPC$ initially as user nobody
(uid=65534, gid=65534) (pid 27874)
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/reply.c:reply_tcon_and_X(794)
tconX service=IPC$
[2009/06/01 15:57:04, 3] smbd/process.c:process_smb(1554)
Transaction 13 of length 104 (0 toread)
[2009/06/01 15:57:04, 3] smbd/process.c:switch_message(1378)
switch message SMBntcreateX (pid 27874) conn 0x8bfe4b8
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (65534, 65534) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/nttrans.c:nt_open_pipe(286)
nt_open_pipe: Known pipe lsarpc opening.
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(65534, 65534) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(101) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (65534, 65534) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(65534, 65534) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(101) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (65534, 65534) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/process.c:process_smb(1554)
Transaction 14 of length 76 (0 toread)
[2009/06/01 15:57:04, 3] smbd/process.c:switch_message(1378)
switch message SMBtrans2 (pid 27874) conn 0x8bfe4b8
[2009/06/01 15:57:04, 3] smbd/process.c:process_smb(1554)
Transaction 15 of length 184 (0 toread)
[2009/06/01 15:57:04, 3] smbd/process.c:switch_message(1378)
switch message SMBwriteX (pid 27874) conn 0x8bfe4b8
[2009/06/01 15:57:04, 3] rpc_server/srv_pipe.c:api_pipe_bind_req(1617)
api_pipe_bind_req: \PIPE\lsarpc -> \PIPE\lsarpc
[2009/06/01 15:57:04, 3] rpc_server/srv_pipe.c:check_bind_req(991)
check_bind_req for lsarpc
[2009/06/01 15:57:04, 3] smbd/pipes.c:reply_pipe_write_and_X(241)
writeX-IPC pnum=72ce nwritten=116
[2009/06/01 15:57:04, 3] smbd/process.c:process_smb(1554)
Transaction 16 of length 63 (0 toread)
[2009/06/01 15:57:04, 3] smbd/process.c:switch_message(1378)
switch message SMBreadX (pid 27874) conn 0x8bfe4b8
[2009/06/01 15:57:04, 3] smbd/pipes.c:reply_pipe_read_and_X(291)
readX-IPC pnum=72ce min=1024 max=1024 nread=68
[2009/06/01 15:57:04, 3] smbd/process.c:process_smb(1554)
Transaction 17 of length 176 (0 toread)
[2009/06/01 15:57:04, 3] smbd/process.c:switch_message(1378)
switch message SMBtrans (pid 27874) conn 0x8bfe4b8
[2009/06/01 15:57:04, 3] smbd/ipc.c:handle_trans(439)
trans <\PIPE\> data=88 params=0 setup=2
[2009/06/01 15:57:04, 3] smbd/ipc.c:named_pipe(390)
named pipe command on <> name
[2009/06/01 15:57:04, 3] smbd/ipc.c:api_fd_reply(348)
Got API command 0x26 on pipe "lsarpc" (pnum 72ce)
[2009/06/01 15:57:04, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(500)
free_pipe_context: destroying talloc pool of size 118
[2009/06/01 15:57:04, 3] rpc_server/srv_pipe.c:api_rpcTNP(2359)
api_rpcTNP: rpc command: LSA_OPENPOLICY2
[2009/06/01 15:57:04, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(500)
free_pipe_context: destroying talloc pool of size 820
[2009/06/01 15:57:04, 3] smbd/process.c:process_smb(1554)
Transaction 18 of length 140 (0 toread)
[2009/06/01 15:57:04, 3] smbd/process.c:switch_message(1378)
switch message SMBtrans (pid 27874) conn 0x8bfe4b8
[2009/06/01 15:57:04, 3] smbd/ipc.c:handle_trans(439)
trans <\PIPE\> data=52 params=0 setup=2
[2009/06/01 15:57:04, 3] smbd/ipc.c:named_pipe(390)
named pipe command on <> name
[2009/06/01 15:57:04, 3] smbd/ipc.c:api_fd_reply(348)
Got API command 0x26 on pipe "lsarpc" (pnum 72ce)
[2009/06/01 15:57:04, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(500)
free_pipe_context: destroying talloc pool of size 0
[2009/06/01 15:57:04, 3] rpc_server/srv_pipe.c:api_rpcTNP(2359)
api_rpcTNP: rpc command: LSA_ENUMTRUSTDOM
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(65534, 65534) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(101) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:04, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (65534, 65534) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:04, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(500)
free_pipe_context: destroying talloc pool of size 8
[2009/06/01 15:57:04, 3] smbd/process.c:process_smb(1554)
Transaction 19 of length 132 (0 toread)
[2009/06/01 15:57:04, 3] smbd/process.c:switch_message(1378)
switch message SMBtrans (pid 27874) conn 0x8bfe4b8
[2009/06/01 15:57:04, 3] smbd/ipc.c:handle_trans(439)
trans <\PIPE\> data=44 params=0 setup=2
[2009/06/01 15:57:04, 3] smbd/ipc.c:named_pipe(390)
named pipe command on <> name
[2009/06/01 15:57:04, 3] smbd/ipc.c:api_fd_reply(348)
Got API command 0x26 on pipe "lsarpc" (pnum 72ce)
[2009/06/01 15:57:04, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(500)
free_pipe_context: destroying talloc pool of size 0
[2009/06/01 15:57:04, 3] rpc_server/srv_pipe.c:api_rpcTNP(2359)
api_rpcTNP: rpc command: LSA_CLOSE
[2009/06/01 15:57:04, 3] rpc_server/srv_lsa_hnd.c:close_policy_hnd(209)
Closed policy
[2009/06/01 15:57:04, 3] rpc_server/srv_pipe_hnd.c:free_pipe_context(500)
free_pipe_context: destroying talloc pool of size 0
[2009/06/01 15:57:04, 3] smbd/process.c:process_smb(1554)
Transaction 20 of length 45 (0 toread)
[2009/06/01 15:57:04, 3] smbd/process.c:switch_message(1378)
switch message SMBclose (pid 27874) conn 0x8bfe4b8
#### 1st delay (10 seconds)
[2009/06/01 15:57:14, 3] smbd/process.c:process_smb(1554)
Transaction 21 of length 39 (0 toread)
[2009/06/01 15:57:14, 3] smbd/process.c:switch_message(1378)
switch message SMBtdis (pid 27874) conn 0x8bfe4b8
[2009/06/01 15:57:14, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:14, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:14, 3] smbd/service.c:close_cnum(1323)
delta5 (10.21.2.133) closed connection to service IPC$
[2009/06/01 15:57:14, 3] smbd/connection.c:yield_connection(31)
Yielding connection to IPC$
[2009/06/01 15:57:14, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:14, 3] smbd/process.c:process_smb(1554)
Transaction 22 of length 43 (0 toread)
[2009/06/01 15:57:14, 3] smbd/process.c:switch_message(1378)
switch message SMBulogoffX (pid 27874) conn 0x0
[2009/06/01 15:57:14, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:14, 3] smbd/reply.c:reply_ulogoffX(1977)
ulogoffX vuid=101
#### 2nd delay (20 seconds)
[2009/06/01 15:57:34, 3] smbd/process.c:process_smb(1554)
Transaction 23 of length 164 (0 toread)
[2009/06/01 15:57:34, 3] smbd/process.c:switch_message(1378)
switch message SMBsesssetupX (pid 27874) conn 0x0
[2009/06/01 15:57:34, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:34, 3] smbd/sesssetup.c:reply_sesssetup_and_X(1412)
wct=12 flg2=0xc807
[2009/06/01 15:57:34, 3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1175)
Doing spnego session setup
[2009/06/01 15:57:34, 3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1210)
NativeOS=[] NativeLanMan=[] PrimaryDomain=[]
[2009/06/01 15:57:34, 3] smbd/sesssetup.c:reply_spnego_negotiate(802)
reply_spnego_negotiate: Got secblob of size 40
[2009/06/01 15:57:34, 3] libsmb/ntlmssp.c:debug_ntlmssp_flags(62)
Got NTLMSSP neg_flags=0xe2088297
[2009/06/01 15:57:34, 3] smbd/process.c:process_smb(1554)
Transaction 24 of length 460 (0 toread)
[2009/06/01 15:57:34, 3] smbd/process.c:switch_message(1378)
switch message SMBsesssetupX (pid 27874) conn 0x0
[2009/06/01 15:57:34, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:34, 3] smbd/sesssetup.c:reply_sesssetup_and_X(1412)
wct=12 flg2=0xc807
[2009/06/01 15:57:34, 3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1175)
Doing spnego session setup
[2009/06/01 15:57:34, 3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1210)
NativeOS=[] NativeLanMan=[] PrimaryDomain=[]
[2009/06/01 15:57:34, 3] libsmb/ntlmssp.c:ntlmssp_server_auth(747)
Got user=[jpf] domain=[CENTAURI] workstation=[DELTA5] len1=24 len2=214
[2009/06/01 15:57:34, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:34, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:34, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:34, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:34, 3] auth/auth.c:check_ntlm_password(220)
check_ntlm_password: Checking password for unmapped user
[CENTAURI]\[jpf]@[DELTA5] with the new password interface
[2009/06/01 15:57:34, 3] auth/auth.c:check_ntlm_password(223)
check_ntlm_password: mapped user is: [CENTAURI]\[jpf]@[DELTA5]
[2009/06/01 15:57::34, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:34, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:34, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:34, 2] passdb/pdb_ldap.c:init_sam_from_ldap(571)
init_sam_from_ldap: Entry found for user: jpf
[2009/06/01 15:57:34, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:34, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:34, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:34, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:34, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:34, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:34, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:34, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:34, 2] passdb/pdb_ldap.c:init_group_from_ldap(2348)
init_group_from_ldap: Entry found for group: 1001
[2009/06/01 15:57:34, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:34, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:34, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:34, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
[2009/06/01 15:57:34, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 2
[2009/06/01 15:57:34, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
[2009/06/01 15:57:35, 2] passdb/pdb_ldap.c:init_group_from_ldap(2348)
init_group_from_ldap: Entry found for group: 1001
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:35, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:35, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] auth/auth.c:check_ntlm_password(269)
check_ntlm_password: sam authentication for user [jpf] succeeded
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 2] auth/auth.c:check_ntlm_password(308)
check_ntlm_password: authentication for user [jpf] -> [jpf] -> [jpf]
succeeded
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:35, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:35, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID
[S-1-5-21-726356159-1313063555-1301796730-61020]
[2009/06/01 15:57:35, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID
[S-1-5-21-726356159-1313063555-1301796730-999]
[2009/06/01 15:57:35, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID [S-1-5-2]
[2009/06/01 15:57:35, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID [S-1-5-11]
[2009/06/01 15:57:35, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID [S-1-22-2-4]
[2009/06/01 15:57:35, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID [S-1-22-2-20]
[2009/06/01 15:57:35, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID [S-1-22-2-28]
[2009/06/01 15:57:35, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID [S-1-22-2-29]
[2009/06/01 15:57:35, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID [S-1-22-2-40]
[2009/06/01 15:57:35, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID [S-1-22-2-44]
[2009/06/01 15:57:35, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID [S-1-22-2-46]
[2009/06/01 15:57:35, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID [S-1-22-2-50]
[2009/06/01 15:57:35, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID
[S-1-5-21-726356159-1313063555-1301796730-513]
[2009/06/01 15:57:35, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID [S-1-22-2-109]
[2009/06/01 15:57:35, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID [S-1-22-2-112]
[2009/06/01 15:57:35, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID [S-1-22-2-117]
[2009/06/01 15:57:35, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID [S-1-22-2-123]
[2009/06/01 15:57:35, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID [S-1-22-2-1003]
[2009/06/01 15:57:35, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID
[S-1-5-21-726356159-1313063555-1301796730-514]
[2009/06/01 15:57:35, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID [S-1-22-2-1004]
[2009/06/01 15:57:35, 3] lib/privileges.c:get_privileges(63)
get_privileges: No privileges assigned to SID [S-1-22-2-1005]
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:35, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:35, 2] passdb/pdb_ldap.c:init_group_from_ldap(2348)
init_group_from_ldap: Entry found for group: 1001
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:35, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:35, 2] passdb/pdb_ldap.c:init_group_from_ldap(2348)
init_group_from_ldap: Entry found for group: 100
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:push_sec_ctx(224)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/06/01 15:57:35, 3] smbd/uid.c:push_conn_ctx(399)
push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:set_sec_ctx(324)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/06/01 15:57:35, 2] passdb/pdb_ldap.c:init_group_from_ldap(2348)
init_group_from_ldap: Entry found for group: 1002
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/06/01 15:57:35, 3] smbd/sec_ctx.c:pop_sec_ctx(432)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/06/01 15:57:35, 3] libsmb/ntlmssp_sign.c:ntlmssp_sign_init(337)
NTLMSSP Sign/Seal - Initialising with flags:
[2009/06/01 15:57:35, 3] libsmb/ntlmssp.c:debug_ntlmssp_flags(62)
Got NTLMSSP neg_flags=0xe2088215
[2009/06/01 15:57:35, 3] smbd/password.c:register_existing_vuid(289)
register_existing_vuid: User name: jpf Real name: Juergen Pfennig
[2009/06/01 15:57:35, 3] smbd/password.c:register_existing_vuid(299)
register_existing_vuid: UNIX uid 30010 is UNIX user jpf, and will be vuid
102
[2009/06/01 15:57:35, 3] smbd/password.c:register_homes_share(231)
Adding homes service for user 'jpf' using home directory: '/home/jpf'
[2009/06/01 15:57:35, 3] param/loadparm.c:lp_add_home(5926)
adding home's share [jpf] for user 'jpf' at '/home/jpf'
### now they talk to each other
More information about the Pkg-samba-maint
mailing list