[2008/06/20 11:54:14, 5] lib/debug.c:debug_dump_status(391) INFO: Current debug levels: all: True/10 tdb: False/0 printdrivers: False/0 lanman: False/0 smb: False/0 rpc_parse: False/0 rpc_srv: False/0 rpc_cli: False/0 passdb: False/0 sam: False/0 auth: False/0 winbind: False/0 vfs: False/0 idmap: False/0 quota: False/0 acls: False/0 locking: False/0 msdfs: False/0 dmapi: False/0 [2008/06/20 11:54:14, 1] nsswitch/winbindd.c:main(1001) winbindd version 3.0.30-2leo.fc5 started. Copyright Andrew Tridgell and the Samba Team 1992-2008 [2008/06/20 11:54:14, 3] param/loadparm.c:lp_load(5064) lp_load: refreshing parameters [2008/06/20 11:54:14, 3] param/loadparm.c:init_globals(1440) Initialising global parameters [2008/06/20 11:54:14, 3] param/params.c:pm_process(572) params.c:pm_process() - Processing configuration file "/etc/samba/smb.conf" [2008/06/20 11:54:14, 3] param/loadparm.c:do_section(3803) Processing section "[global]" doing parameter workgroup = RK_KLBG doing parameter server string = Samba doing parameter log file = /var/log/samba/log.%m doing parameter max log size = 2048 doing parameter log level = 1 doing parameter security = user doing parameter passdb backend = ldapsam:ldap://ldap-master.intern.rk-klosterneuburg.at/ doing parameter domain master = yes doing parameter domain logons = yes doing parameter logon script = LOGON.BAT doing parameter logon path = \\%L\Profile doing parameter logon home = \\%L\%U doing parameter logon drive = z: doing parameter profile acls = no doing parameter add user to group script = /usr/sbin/smbldap-groupmod -m "%u" "%g" doing parameter delete user from group script = /usr/sbin/smbldap-groupmod -x "%u" "%g" doing parameter set primary group script = /usr/sbin/smbldap-usermod -g "%g" "%u" doing parameter add machine script = /usr/sbin/smbldap-useradd -w '%u' doing parameter admin users = smbadmin doing parameter unix password sync = Yes doing parameter pam password change = yes doing parameter ldap suffix = dc=rk-klbg,dc=at doing parameter ldap user suffix = ou=Users doing parameter ldap group suffix = ou=Groups doing parameter ldap machine suffix = ou=Computers doing parameter ldap idmap suffix = ou=Idmap doing parameter ldap admin dn = cn=Manager,dc=rk-klbg,dc=at doing parameter ldap ssl = no doing parameter ldap passwd sync = yes doing parameter ldap delete dn = yes doing parameter admin users = smbadmin RK_KLBG\smbadmin doing parameter enable privileges = yes doing parameter idmap domains = ALLDOMAINS doing parameter idmap config ALLDOMAINS:default = yes doing parameter idmap config ALLDOMAINS:backend = ldap doing parameter idmap config ALLDOMAINS:ldap_url = ldap://ldap.intern.rk-klosterneuburg.at/ doing parameter idmap config ALLDOMAINS:range = 16777216-33554431 doing parameter idmap alloc backend = ldap doing parameter idmap alloc config:ldap_url = ldap://ldap-master.intern.rk-klosterneuburg.at/ doing parameter idmap alloc config:range = 16777216-33554431 doing parameter winbind trusted domains only = Yes doing parameter template shell = /bin/false doing parameter time server = Yes doing parameter local master = yes doing parameter os level = 64 doing parameter preferred master = yes doing parameter wins support = yes doing parameter dns proxy = yes doing parameter load printers = yes doing parameter cups options = raw doing parameter printing = cups doing parameter printcap name = cups doing parameter preserve case = yes doing parameter short preserve case = yes doing parameter case sensitive = no doing parameter default case = lower doing parameter unix charset = ISO-8859-15 [2008/06/20 11:54:14, 5] lib/iconv.c:smb_register_charset(105) Attempting to register new charset UCS-2LE [2008/06/20 11:54:14, 5] lib/iconv.c:smb_register_charset(113) Registered charset UCS-2LE [2008/06/20 11:54:14, 5] lib/iconv.c:smb_register_charset(105) Attempting to register new charset UTF-16LE [2008/06/20 11:54:14, 5] lib/iconv.c:smb_register_charset(113) Registered charset UTF-16LE [2008/06/20 11:54:14, 5] lib/iconv.c:smb_register_charset(105) Attempting to register new charset UCS-2BE [2008/06/20 11:54:14, 5] lib/iconv.c:smb_register_charset(113) Registered charset UCS-2BE [2008/06/20 11:54:14, 5] lib/iconv.c:smb_register_charset(105) Attempting to register new charset UTF-16BE [2008/06/20 11:54:14, 5] lib/iconv.c:smb_register_charset(113) Registered charset UTF-16BE [2008/06/20 11:54:14, 5] lib/iconv.c:smb_register_charset(105) Attempting to register new charset UTF8 [2008/06/20 11:54:14, 5] lib/iconv.c:smb_register_charset(113) Registered charset UTF8 [2008/06/20 11:54:14, 5] lib/iconv.c:smb_register_charset(105) Attempting to register new charset UTF-8 [2008/06/20 11:54:14, 5] lib/iconv.c:smb_register_charset(113) Registered charset UTF-8 [2008/06/20 11:54:14, 5] lib/iconv.c:smb_register_charset(105) Attempting to register new charset ASCII [2008/06/20 11:54:14, 5] lib/iconv.c:smb_register_charset(113) Registered charset ASCII [2008/06/20 11:54:14, 5] lib/iconv.c:smb_register_charset(105) Attempting to register new charset 646 [2008/06/20 11:54:14, 5] lib/iconv.c:smb_register_charset(113) Registered charset 646 [2008/06/20 11:54:14, 5] lib/iconv.c:smb_register_charset(105) Attempting to register new charset ISO-8859-1 [2008/06/20 11:54:14, 5] lib/iconv.c:smb_register_charset(113) Registered charset ISO-8859-1 [2008/06/20 11:54:14, 5] lib/iconv.c:smb_register_charset(105) Attempting to register new charset UCS2-HEX [2008/06/20 11:54:14, 5] lib/iconv.c:smb_register_charset(113) Registered charset UCS2-HEX [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE [2008/06/20 11:54:14, 5] lib/charcnv.c:charset_name(82) Substituting charset 'ISO-8859-1' for LOCALE doing parameter display charset = ISO-8859-15 doing parameter dos charset = 850 doing parameter deadtime = 15 doing parameter socket options = SO_KEEPALIVE IPTOS_LOWDELAY TCP_NODELAY SO_SNDBUF=8192 SO_RCVBUF=8192 [2008/06/20 11:54:14, 2] param/loadparm.c:do_section(3820) Processing section "[homes]" [2008/06/20 11:54:14, 8] param/loadparm.c:add_a_service(2593) add_a_service: Creating snum = 0 for homes [2008/06/20 11:54:14, 10] param/loadparm.c:hash_a_service(2630) hash_a_service: creating tdb servicehash [2008/06/20 11:54:14, 10] param/loadparm.c:hash_a_service(2640) hash_a_service: hashing index 0 for service name homes doing parameter comment = Home Directories doing parameter browseable = yes doing parameter writable = yes [2008/06/20 11:54:14, 2] param/loadparm.c:do_section(3820) Processing section "[printers]" [2008/06/20 11:54:14, 8] param/loadparm.c:add_a_service(2593) add_a_service: Creating snum = 1 for printers [2008/06/20 11:54:14, 10] param/loadparm.c:hash_a_service(2640) hash_a_service: hashing index 1 for service name printers doing parameter comment = All Printers doing parameter path = /var/spool/samba doing parameter browseable = no doing parameter guest ok = no doing parameter writable = no doing parameter printable = yes [2008/06/20 11:54:14, 2] param/loadparm.c:do_section(3820) Processing section "[netlogon]" [2008/06/20 11:54:14, 8] param/loadparm.c:add_a_service(2593) add_a_service: Creating snum = 2 for netlogon [2008/06/20 11:54:14, 10] param/loadparm.c:hash_a_service(2640) hash_a_service: hashing index 2 for service name netlogon doing parameter comment = Network Logon Service doing parameter path = /home/samba/netlogon-%a doing parameter guest ok = yes doing parameter writable = no doing parameter share modes = no doing parameter browseable = yes [2008/06/20 11:54:14, 2] param/loadparm.c:do_section(3820) Processing section "[Profile]" [2008/06/20 11:54:14, 8] param/loadparm.c:add_a_service(2593) add_a_service: Creating snum = 3 for Profile [2008/06/20 11:54:14, 10] param/loadparm.c:hash_a_service(2640) hash_a_service: hashing index 3 for service name Profile doing parameter path = /home/%U/Profile-%a doing parameter browseable = yes doing parameter guest ok = no doing parameter writable = yes doing parameter csc policy = disable doing parameter root preexec = /etc/samba/buildprofile.sh "%U" "%G" "%P" [2008/06/20 11:54:14, 2] param/loadparm.c:do_section(3820) Processing section "[home]" [2008/06/20 11:54:14, 8] param/loadparm.c:add_a_service(2593) add_a_service: Creating snum = 4 for home [2008/06/20 11:54:14, 10] param/loadparm.c:hash_a_service(2640) hash_a_service: hashing index 4 for service name home doing parameter comment = User homes doing parameter path = /home doing parameter public = no doing parameter writeable = yes doing parameter printable = no [2008/06/20 11:54:14, 2] param/loadparm.c:do_section(3820) Processing section "[app]" [2008/06/20 11:54:14, 8] param/loadparm.c:add_a_service(2593) add_a_service: Creating snum = 5 for app [2008/06/20 11:54:14, 10] param/loadparm.c:hash_a_service(2640) hash_a_service: hashing index 5 for service name app doing parameter comment = Applications doing parameter path = /home/samba/app doing parameter public = no doing parameter writeable = yes doing parameter printable = no [2008/06/20 11:54:14, 2] param/loadparm.c:do_section(3820) Processing section "[data]" [2008/06/20 11:54:14, 8] param/loadparm.c:add_a_service(2593) add_a_service: Creating snum = 6 for data [2008/06/20 11:54:14, 10] param/loadparm.c:hash_a_service(2640) hash_a_service: hashing index 6 for service name data doing parameter comment = Data doing parameter path = /home/samba/data doing parameter public = no doing parameter writeable = yes doing parameter printable = no [2008/06/20 11:54:14, 2] param/loadparm.c:do_section(3820) Processing section "[dienst]" [2008/06/20 11:54:14, 8] param/loadparm.c:add_a_service(2593) add_a_service: Creating snum = 7 for dienst [2008/06/20 11:54:14, 10] param/loadparm.c:hash_a_service(2640) hash_a_service: hashing index 7 for service name dienst doing parameter comment = Dienstplan doing parameter path = /home/samba/data/DIENST doing parameter public = no doing parameter writeable = yes doing parameter printable = no doing parameter valid users = nbs [2008/06/20 11:54:14, 2] param/loadparm.c:do_section(3820) Processing section "[U1]" [2008/06/20 11:54:14, 8] param/loadparm.c:add_a_service(2593) add_a_service: Creating snum = 8 for U1 [2008/06/20 11:54:14, 10] param/loadparm.c:hash_a_service(2640) hash_a_service: hashing index 8 for service name U1 doing parameter copy = dienst [2008/06/20 11:54:14, 3] param/loadparm.c:handle_copy(3236) Copying service from service dienst doing parameter path = /home/samba/data/DIENST/U1 [2008/06/20 11:54:14, 2] param/loadparm.c:do_section(3820) Processing section "[U2]" [2008/06/20 11:54:14, 8] param/loadparm.c:add_a_service(2593) add_a_service: Creating snum = 9 for U2 [2008/06/20 11:54:14, 10] param/loadparm.c:hash_a_service(2640) hash_a_service: hashing index 9 for service name U2 doing parameter copy = dienst [2008/06/20 11:54:14, 3] param/loadparm.c:handle_copy(3236) Copying service from service dienst doing parameter path = /home/samba/data/DIENST/U2 [2008/06/20 11:54:14, 2] param/loadparm.c:do_section(3820) Processing section "[U3]" [2008/06/20 11:54:14, 8] param/loadparm.c:add_a_service(2593) add_a_service: Creating snum = 10 for U3 [2008/06/20 11:54:14, 10] param/loadparm.c:hash_a_service(2640) hash_a_service: hashing index 10 for service name U3 doing parameter copy = dienst [2008/06/20 11:54:14, 3] param/loadparm.c:handle_copy(3236) Copying service from service dienst doing parameter path = /home/samba/data/DIENST/U3 [2008/06/20 11:54:14, 2] param/loadparm.c:do_section(3820) Processing section "[U4]" [2008/06/20 11:54:14, 8] param/loadparm.c:add_a_service(2593) add_a_service: Creating snum = 11 for U4 [2008/06/20 11:54:14, 10] param/loadparm.c:hash_a_service(2640) hash_a_service: hashing index 11 for service name U4 doing parameter copy = dienst [2008/06/20 11:54:14, 3] param/loadparm.c:handle_copy(3236) Copying service from service dienst doing parameter path = /home/samba/data/DIENST/U4 [2008/06/20 11:54:14, 2] param/loadparm.c:do_section(3820) Processing section "[U8]" [2008/06/20 11:54:14, 8] param/loadparm.c:add_a_service(2593) add_a_service: Creating snum = 12 for U8 [2008/06/20 11:54:14, 10] param/loadparm.c:hash_a_service(2640) hash_a_service: hashing index 12 for service name U8 doing parameter copy = dienst [2008/06/20 11:54:14, 3] param/loadparm.c:handle_copy(3236) Copying service from service dienst doing parameter path = /home/samba/data/DIENST/U8 [2008/06/20 11:54:14, 2] param/loadparm.c:do_section(3820) Processing section "[U9]" [2008/06/20 11:54:14, 8] param/loadparm.c:add_a_service(2593) add_a_service: Creating snum = 13 for U9 [2008/06/20 11:54:14, 10] param/loadparm.c:hash_a_service(2640) hash_a_service: hashing index 13 for service name U9 doing parameter copy = dienst [2008/06/20 11:54:14, 3] param/loadparm.c:handle_copy(3236) Copying service from service dienst doing parameter path = /home/samba/data/DIENST/U9 [2008/06/20 11:54:14, 4] param/loadparm.c:lp_load(5095) pm_process() returned Yes [2008/06/20 11:54:14, 8] param/loadparm.c:add_a_service(2593) add_a_service: Creating snum = 14 for IPC$ [2008/06/20 11:54:14, 10] param/loadparm.c:hash_a_service(2640) hash_a_service: hashing index 14 for service name IPC$ [2008/06/20 11:54:14, 3] param/loadparm.c:lp_add_ipc(2728) adding IPC service [2008/06/20 11:54:14, 10] param/loadparm.c:set_server_role(4339) set_server_role: role = ROLE_DOMAIN_PDC [2008/06/20 11:54:14, 2] lib/interface.c:add_interface(81) added interface ip=192.168.60.3 bcast=192.168.60.255 nmask=255.255.255.0 [2008/06/20 11:54:14, 5] lib/util.c:init_names(309) Netbios name list:- my_netbios_names[0]="SAMBA" [2008/06/20 11:54:14, 2] lib/interface.c:add_interface(81) added interface ip=192.168.60.3 bcast=192.168.60.255 nmask=255.255.255.0 [2008/06/20 11:54:14, 5] lib/gencache.c:gencache_init(61) Opening cache file at /var/lib/samba/gencache.tdb [2008/06/20 11:54:14, 5] libsmb/namecache.c:namecache_enable(58) namecache_enable: enabling netbios namecache, timeout 660 seconds [2008/06/20 11:54:14, 10] nsswitch/idmap_cache.c:idmap_cache_init(60) Opening cache file at /var/lib/samba/idmap_cache.tdb [2008/06/20 11:54:14, 8] lib/util.c:fcntl_lock(2014) fcntl_lock fd=8 op=13 offset=0 count=1 type=1 [2008/06/20 11:54:14, 8] lib/util.c:fcntl_lock(2033) fcntl_lock: Lock call successful [2008/06/20 11:54:14, 4] lib/time.c:TimeInit(1258) TimeInit: Serverzone is -7200 [2008/06/20 11:54:14, 2] lib/tallocmsg.c:register_msg_pool_usage(105) Registered MSG_REQ_POOL_USAGE [2008/06/20 11:54:14, 2] lib/dmallocmsg.c:register_dmalloc_msgs(75) Registered MSG_REQ_DMALLOC_MARK and LOG_CHANGED [2008/06/20 11:54:14, 0] nsswitch/winbindd_cache.c:initialize_winbindd_cache(2229) initialize_winbindd_cache: clearing cache and re-creating with version number 1 [2008/06/20 11:54:14, 2] nsswitch/winbindd_util.c:add_trusted_domain(178) Added domain RK_KLBG S-1-5-21-181998944-1107627502-2274996074 [2008/06/20 11:54:14, 2] nsswitch/winbindd_util.c:add_trusted_domain(178) Added domain BUILTIN S-1-5-32 [2008/06/20 11:54:14, 10] nsswitch/winbindd_util.c:open_winbindd_socket(928) open_winbindd_socket: opened socket fd 12 [2008/06/20 11:54:14, 10] nsswitch/winbindd_util.c:open_winbindd_priv_socket(940) open_winbindd_priv_socket: opened socket fd 13 [2008/06/20 11:54:14, 10] lib/events.c:event_add_timed(129) Added timed event "async_request_timeout": 8088c338 [2008/06/20 11:54:14, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/999854 [2008/06/20 11:54:15, 6] nsswitch/winbindd.c:new_connection(628) accepted socket 17 [2008/06/20 11:54:15, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 298/895401 [2008/06/20 11:54:15, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 298/895356 [2008/06/20 11:54:15, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn INTERFACE_VERSION [2008/06/20 11:54:15, 3] nsswitch/winbindd_misc.c:winbindd_interface_version(491) [ 5812]: request interface version [2008/06/20 11:54:15, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 298/895251 [2008/06/20 11:54:15, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 298/895205 [2008/06/20 11:54:15, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 298/895154 [2008/06/20 11:54:15, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn WINBINDD_PRIV_PIPE_DIR [2008/06/20 11:54:15, 3] nsswitch/winbindd_misc.c:winbindd_priv_pipe_dir(524) [ 5812]: request location of privileged pipe [2008/06/20 11:54:15, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 298/895031 [2008/06/20 11:54:15, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 298/894989 [2008/06/20 11:54:15, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 298/894940 [2008/06/20 11:54:15, 6] nsswitch/winbindd.c:new_connection(628) accepted socket 18 [2008/06/20 11:54:15, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 298/894797 [2008/06/20 11:54:15, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 298/894737 [2008/06/20 11:54:15, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:54:15, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 5812]: sid to gid S-1-1-0 [2008/06/20 11:54:15, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-1-0) [2008/06/20 11:54:15, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:54:15, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-1-0 [2008/06/20 11:54:15, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-1-0 [2008/06/20 11:54:15, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 298/894458 [2008/06/20 11:54:15, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 298/894408 [2008/06/20 11:54:15, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 298/894355 [2008/06/20 11:54:15, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:54:15, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 5812]: ping [2008/06/20 11:54:15, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 298/894256 [2008/06/20 11:54:15, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 298/894213 [2008/06/20 11:54:15, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 298/894160 [2008/06/20 11:54:15, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:54:15, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 5812]: sid to gid S-1-5-2 [2008/06/20 11:54:15, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-5-2) [2008/06/20 11:54:15, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:54:15, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-5-2 [2008/06/20 11:54:15, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-5-2 [2008/06/20 11:54:15, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 298/893951 [2008/06/20 11:54:15, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 298/893908 [2008/06/20 11:54:15, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 298/893860 [2008/06/20 11:54:15, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:54:15, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 5812]: ping [2008/06/20 11:54:15, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 298/893755 [2008/06/20 11:54:15, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 298/893712 [2008/06/20 11:54:17, 6] nsswitch/winbindd.c:new_connection(628) accepted socket 17 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/371174 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/371131 [2008/06/20 11:54:17, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn INTERFACE_VERSION [2008/06/20 11:54:17, 3] nsswitch/winbindd_misc.c:winbindd_interface_version(491) [ 8198]: request interface version [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/371026 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/370977 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/370926 [2008/06/20 11:54:17, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn WINBINDD_PRIV_PIPE_DIR [2008/06/20 11:54:17, 3] nsswitch/winbindd_misc.c:winbindd_priv_pipe_dir(524) [ 8198]: request location of privileged pipe [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/370808 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/370766 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/370717 [2008/06/20 11:54:17, 6] nsswitch/winbindd.c:new_connection(628) accepted socket 19 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/370557 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/370516 [2008/06/20 11:54:17, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn GID_TO_SID [2008/06/20 11:54:17, 3] nsswitch/winbindd_sid.c:winbindd_gid_to_sid(477) [ 8198]: gid to sid 515 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/369199 [2008/06/20 11:54:17, 10] lib/events.c:event_add_timed(129) Added timed event "async_request_timeout": 809039e8 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/369033 [2008/06/20 11:54:17, 10] lib/events.c:timed_event_destructor(66) Destroying timed event 809039e8 "async_request_timeout" [2008/06/20 11:54:17, 10] nsswitch/winbindd_cache.c:cache_retrieve_response(2307) Retrieving response for pid 8200 [2008/06/20 11:54:17, 10] nsswitch/winbindd_sid.c:gid2sid_recv(462) gid2sid: gid 515 has sid S-1-5-21-181998944-1107627502-2274996074-515 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/350878 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/350823 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/348430 [2008/06/20 11:54:17, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:54:17, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 8198]: sid to gid S-1-1-0 [2008/06/20 11:54:17, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-1-0) [2008/06/20 11:54:17, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:54:17, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-1-0 [2008/06/20 11:54:17, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-1-0 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/348145 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/348097 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/348039 [2008/06/20 11:54:17, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:54:17, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 8198]: ping [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/347933 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/347881 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/347828 [2008/06/20 11:54:17, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:54:17, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 8198]: sid to gid S-1-5-2 [2008/06/20 11:54:17, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-5-2) [2008/06/20 11:54:17, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:54:17, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-5-2 [2008/06/20 11:54:17, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-5-2 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/347611 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/347562 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/347513 [2008/06/20 11:54:17, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:54:17, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 8198]: ping [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/347411 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/347368 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/347294 [2008/06/20 11:54:17, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:54:17, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 8198]: sid to gid S-1-5-11 [2008/06/20 11:54:17, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-5-11) [2008/06/20 11:54:17, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:54:17, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-5-11 [2008/06/20 11:54:17, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-5-11 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/347081 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/347037 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/346980 [2008/06/20 11:54:17, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:54:17, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 8198]: ping [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/346852 [2008/06/20 11:54:17, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 297/346807 [2008/06/20 11:54:17, 10] lib/events.c:timed_event_destructor(66) Destroying timed event 8088c338 "async_request_timeout" [2008/06/20 11:54:17, 10] nsswitch/winbindd_cache.c:cache_retrieve_response(2307) Retrieving response for pid 8196 [2008/06/20 11:54:17, 5] nsswitch/winbindd_util.c:init_child_recv(426) Received child initialization response for domain RK_KLBG [2008/06/20 11:54:17, 8] nsswitch/winbindd_cm.c:connection_ok(1498) connection_ok: Connection to for domain RK_KLBG has NULL cli! [2008/06/20 11:54:17, 10] lib/gencache.c:gencache_get(226) Returning valid cache entry: key = SAF/DOMAIN/RK_KLBG, value = SAMBA, timeout = Fri Jun 20 12:09:17 2008 [2008/06/20 11:54:17, 5] libsmb/namequery.c:saf_fetch(136) saf_fetch: Returning "SAMBA" for "RK_KLBG" domain [2008/06/20 11:54:17, 10] nsswitch/winbindd_cm.c:cm_open_connection(1338) cm_open_connection: saf_servername is 'SAMBA' for domain RK_KLBG [2008/06/20 11:54:17, 10] nsswitch/winbindd_cm.c:cm_open_connection(1368) cm_open_connection: dcname is 'SAMBA' for domain RK_KLBG [2008/06/20 11:54:17, 10] lib/gencache.c:gencache_get(212) Cache entry with key = AD_SITENAME/DOMAIN/ couldn't be found [2008/06/20 11:54:17, 5] libads/dns.c:sitename_fetch(706) sitename_fetch: No stored sitename for [2008/06/20 11:54:17, 10] libsmb/namequery.c:internal_resolve_name(1166) internal_resolve_name: looking up SAMBA#20 (sitename (null)) [2008/06/20 11:54:17, 10] lib/gencache.c:gencache_get(226) Returning valid cache entry: key = NBT/SAMBA#20, value = 192.168.60.3:0, timeout = Fri Jun 20 12:05:17 2008 [2008/06/20 11:54:17, 5] libsmb/namecache.c:namecache_fetch(214) name SAMBA#20 found. [2008/06/20 11:54:17, 10] nsswitch/winbindd_cm.c:cm_prepare_connection(654) cm_prepare_connection: connecting to DC SAMBA for domain RK_KLBG [2008/06/20 11:54:17, 10] passdb/secrets.c:secrets_named_mutex(983) secrets_named_mutex: got mutex for SAMBA [2008/06/20 11:54:17, 6] libsmb/clientgen.c:write_socket(152) write_socket(21,194) [2008/06/20 11:54:17, 6] libsmb/clientgen.c:write_socket(155) write_socket(21,194) wrote 194 [2008/06/20 11:54:17, 10] lib/util_sock.c:read_smb_length_return_keepalive(623) got smb length of 127 [2008/06/20 11:54:17, 5] lib/util.c:show_msg(506) [2008/06/20 11:54:17, 5] lib/util.c:show_msg(516) size=127 smb_com=0x72 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51201 smb_tid=0 smb_pid=8195 smb_uid=0 smb_mid=1 smt_wct=17 smb_vwv[ 0]= 8 (0x8) smb_vwv[ 1]=12803 (0x3203) smb_vwv[ 2]= 256 (0x100) smb_vwv[ 3]= 1024 (0x400) smb_vwv[ 4]= 65 (0x41) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 256 (0x100) smb_vwv[ 7]= 2304 (0x900) smb_vwv[ 8]= 32 (0x20) smb_vwv[ 9]=64768 (0xFD00) smb_vwv[10]=33011 (0x80F3) smb_vwv[11]=32896 (0x8080) smb_vwv[12]=21610 (0x546A) smb_vwv[13]=48026 (0xBB9A) smb_vwv[14]=51410 (0xC8D2) smb_vwv[15]=34817 (0x8801) smb_vwv[16]= 255 (0xFF) smb_bcc=58 [2008/06/20 11:54:17, 10] lib/util.c:dump_data(2286) [000] 73 61 6D 62 61 00 00 00 00 00 00 00 00 00 00 00 samba... ........ [010] 60 28 06 06 2B 06 01 05 05 02 A0 1E 30 1C A0 0E `(..+... .. .0. . [020] 30 0C 06 0A 2B 06 01 04 01 82 37 02 02 0A A3 0A 0...+... ..7...£. [030] 30 08 A0 06 1B 04 4E 4F 4E 45 0. ...NO NE [2008/06/20 11:54:17, 5] lib/util.c:show_msg(506) [2008/06/20 11:54:17, 5] lib/util.c:show_msg(516) size=127 smb_com=0x72 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51201 smb_tid=0 smb_pid=8195 smb_uid=0 smb_mid=1 smt_wct=17 smb_vwv[ 0]= 8 (0x8) smb_vwv[ 1]=12803 (0x3203) smb_vwv[ 2]= 256 (0x100) smb_vwv[ 3]= 1024 (0x400) smb_vwv[ 4]= 65 (0x41) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 256 (0x100) smb_vwv[ 7]= 2304 (0x900) smb_vwv[ 8]= 32 (0x20) smb_vwv[ 9]=64768 (0xFD00) smb_vwv[10]=33011 (0x80F3) smb_vwv[11]=32896 (0x8080) smb_vwv[12]=21610 (0x546A) smb_vwv[13]=48026 (0xBB9A) smb_vwv[14]=51410 (0xC8D2) smb_vwv[15]=34817 (0x8801) smb_vwv[16]= 255 (0xFF) smb_bcc=58 [2008/06/20 11:54:17, 10] lib/util.c:dump_data(2286) [000] 73 61 6D 62 61 00 00 00 00 00 00 00 00 00 00 00 samba... ........ [010] 60 28 06 06 2B 06 01 05 05 02 A0 1E 30 1C A0 0E `(..+... .. .0. . [020] 30 0C 06 0A 2B 06 01 04 01 82 37 02 02 0A A3 0A 0...+... ..7...£. [030] 30 08 A0 06 1B 04 4E 4F 4E 45 0. ...NO NE [2008/06/20 11:54:17, 5] nsswitch/winbindd_cm.c:cm_prepare_connection(758) connecting to SAMBA from SAMBA with username [RK_KLBG]\[SAMBA$] [2008/06/20 11:54:17, 3] libsmb/cliconnect.c:cli_session_setup_spnego(801) Doing spnego session setup (blob length=58) [2008/06/20 11:54:17, 3] libsmb/cliconnect.c:cli_session_setup_spnego(826) got OID=1 3 6 1 4 1 311 2 2 10 [2008/06/20 11:54:17, 3] libsmb/cliconnect.c:cli_session_setup_spnego(834) got principal=NONE [2008/06/20 11:54:17, 6] libsmb/clientgen.c:write_socket(152) write_socket(21,164) [2008/06/20 11:54:17, 6] libsmb/clientgen.c:write_socket(155) write_socket(21,164) wrote 164 [2008/06/20 11:54:17, 10] lib/util_sock.c:read_smb_length_return_keepalive(623) got smb length of 370 [2008/06/20 11:54:17, 5] lib/util.c:show_msg(506) [2008/06/20 11:54:17, 5] lib/util.c:show_msg(516) size=370 smb_com=0x73 smb_rcls=22 smb_reh=0 smb_err=49152 smb_flg=136 smb_flg2=51201 smb_tid=0 smb_pid=8195 smb_uid=100 smb_mid=2 smt_wct=4 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 257 (0x101) smb_bcc=327 [2008/06/20 11:54:17, 10] lib/util.c:dump_data(2286) [000] A1 81 FE 30 81 FB A0 03 0A 01 01 A1 0C 06 0A 2B ¡.þ0.û . ...¡...+ [010] 06 01 04 01 82 37 02 02 0A A2 81 E5 04 81 E2 4E .....7.. .¢.å..âN [020] 54 4C 4D 53 53 50 00 02 00 00 00 0E 00 0E 00 30 TLMSSP.. .......0 [030] 00 00 00 15 82 89 60 CC 7B 74 70 66 32 B8 A5 00 ......`Ì {tpf2¸¥. [040] 00 00 00 00 00 00 00 A4 00 A4 00 3E 00 00 00 52 .......¤ .¤.>...R [050] 00 4B 00 5F 00 4B 00 4C 00 42 00 47 00 02 00 0E .K._.K.L .B.G.... [060] 00 52 00 4B 00 5F 00 4B 00 4C 00 42 00 47 00 01 .R.K._.K .L.B.G.. [070] 00 0A 00 53 00 41 00 4D 00 42 00 41 00 04 00 36 ...S.A.M .B.A...6 [080] 00 69 00 6E 00 74 00 65 00 72 00 6E 00 2E 00 72 .i.n.t.e .r.n...r [090] 00 6B 00 2D 00 6B 00 6C 00 6F 00 73 00 74 00 65 .k.-.k.l .o.s.t.e [0A0] 00 72 00 6E 00 65 00 75 00 62 00 75 00 72 00 67 .r.n.e.u .b.u.r.g [0B0] 00 2E 00 61 00 74 00 03 00 42 00 73 00 61 00 6D ...a.t.. .B.s.a.m [0C0] 00 62 00 61 00 2E 00 69 00 6E 00 74 00 65 00 72 .b.a...i .n.t.e.r [0D0] 00 6E 00 2E 00 72 00 6B 00 2D 00 6B 00 6C 00 6F .n...r.k .-.k.l.o [0E0] 00 73 00 74 00 65 00 72 00 6E 00 65 00 75 00 62 .s.t.e.r .n.e.u.b [0F0] 00 75 00 72 00 67 00 2E 00 61 00 74 00 00 00 00 .u.r.g.. .a.t.... [100] 00 55 00 6E 00 69 00 78 00 00 00 53 00 61 00 6D .U.n.i.x ...S.a.m [110] 00 62 00 61 00 20 00 33 00 2E 00 30 00 2E 00 33 .b.a. .3 ...0...3 [120] 00 30 00 2D 00 32 00 6C 00 65 00 6F 00 2E 00 66 .0.-.2.l .e.o...f [130] 00 63 00 35 00 00 00 52 00 4B 00 5F 00 4B 00 4C .c.5...R .K._.K.L [140] 00 42 00 47 00 00 00 .B.G... [2008/06/20 11:54:17, 5] lib/util.c:show_msg(506) [2008/06/20 11:54:17, 5] lib/util.c:show_msg(516) size=370 smb_com=0x73 smb_rcls=22 smb_reh=0 smb_err=49152 smb_flg=136 smb_flg2=51201 smb_tid=0 smb_pid=8195 smb_uid=100 smb_mid=2 smt_wct=4 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 257 (0x101) smb_bcc=327 [2008/06/20 11:54:17, 10] lib/util.c:dump_data(2286) [000] A1 81 FE 30 81 FB A0 03 0A 01 01 A1 0C 06 0A 2B ¡.þ0.û . ...¡...+ [010] 06 01 04 01 82 37 02 02 0A A2 81 E5 04 81 E2 4E .....7.. .¢.å..âN [020] 54 4C 4D 53 53 50 00 02 00 00 00 0E 00 0E 00 30 TLMSSP.. .......0 [030] 00 00 00 15 82 89 60 CC 7B 74 70 66 32 B8 A5 00 ......`Ì {tpf2¸¥. [040] 00 00 00 00 00 00 00 A4 00 A4 00 3E 00 00 00 52 .......¤ .¤.>...R [050] 00 4B 00 5F 00 4B 00 4C 00 42 00 47 00 02 00 0E .K._.K.L .B.G.... [060] 00 52 00 4B 00 5F 00 4B 00 4C 00 42 00 47 00 01 .R.K._.K .L.B.G.. [070] 00 0A 00 53 00 41 00 4D 00 42 00 41 00 04 00 36 ...S.A.M .B.A...6 [080] 00 69 00 6E 00 74 00 65 00 72 00 6E 00 2E 00 72 .i.n.t.e .r.n...r [090] 00 6B 00 2D 00 6B 00 6C 00 6F 00 73 00 74 00 65 .k.-.k.l .o.s.t.e [0A0] 00 72 00 6E 00 65 00 75 00 62 00 75 00 72 00 67 .r.n.e.u .b.u.r.g [0B0] 00 2E 00 61 00 74 00 03 00 42 00 73 00 61 00 6D ...a.t.. .B.s.a.m [0C0] 00 62 00 61 00 2E 00 69 00 6E 00 74 00 65 00 72 .b.a...i .n.t.e.r [0D0] 00 6E 00 2E 00 72 00 6B 00 2D 00 6B 00 6C 00 6F .n...r.k .-.k.l.o [0E0] 00 73 00 74 00 65 00 72 00 6E 00 65 00 75 00 62 .s.t.e.r .n.e.u.b [0F0] 00 75 00 72 00 67 00 2E 00 61 00 74 00 00 00 00 .u.r.g.. .a.t.... [100] 00 55 00 6E 00 69 00 78 00 00 00 53 00 61 00 6D .U.n.i.x ...S.a.m [110] 00 62 00 61 00 20 00 33 00 2E 00 30 00 2E 00 33 .b.a. .3 ...0...3 [120] 00 30 00 2D 00 32 00 6C 00 65 00 6F 00 2E 00 66 .0.-.2.l .e.o...f [130] 00 63 00 35 00 00 00 52 00 4B 00 5F 00 4B 00 4C .c.5...R .K._.K.L [140] 00 42 00 47 00 00 00 .B.G... [2008/06/20 11:54:17, 3] libsmb/ntlmssp.c:ntlmssp_client_challenge(1018) Got challenge flags: [2008/06/20 11:54:17, 3] libsmb/ntlmssp.c:debug_ntlmssp_flags(63) Got NTLMSSP neg_flags=0x60898215 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_CHAL_TARGET_INFO NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH [2008/06/20 11:54:17, 3] libsmb/ntlmssp.c:ntlmssp_client_challenge(1040) NTLMSSP: Set final flags: [2008/06/20 11:54:17, 3] libsmb/ntlmssp.c:debug_ntlmssp_flags(63) Got NTLMSSP neg_flags=0x60088215 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH [2008/06/20 11:54:17, 5] libsmb/ntlmssp.c:ntlmssp_client_challenge(1112) NTLMSSP challenge set by NTLM2 [2008/06/20 11:54:17, 5] libsmb/ntlmssp.c:ntlmssp_client_challenge(1113) challenge is: [2008/06/20 11:54:17, 5] lib/util.c:dump_data(2286) [000] 4D 01 93 3C 92 DC 47 55 M..<.ÜGU [2008/06/20 11:54:17, 3] libsmb/ntlmssp_sign.c:ntlmssp_sign_init(338) NTLMSSP Sign/Seal - Initialising with flags: [2008/06/20 11:54:17, 3] libsmb/ntlmssp.c:debug_ntlmssp_flags(63) Got NTLMSSP neg_flags=0x60088215 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH [2008/06/20 11:54:17, 6] libsmb/clientgen.c:write_socket(152) write_socket(21,262) [2008/06/20 11:54:17, 6] libsmb/clientgen.c:write_socket(155) write_socket(21,262) wrote 262 [2008/06/20 11:54:27, 10] lib/util_sock.c:read_socket_with_timeout(476) read_socket_with_timeout: timeout read. select timed out. [2008/06/20 11:54:27, 10] lib/util_sock.c:receive_smb_raw(671) receive_smb_raw: length < 0! [2008/06/20 11:54:27, 10] libsmb/clientgen.c:client_receive_smb(64) client_receive_smb failed [2008/06/20 11:54:27, 5] lib/util.c:show_msg(506) [2008/06/20 11:54:27, 5] lib/util.c:show_msg(516) size=370 smb_com=0x73 smb_rcls=22 smb_reh=0 smb_err=49152 smb_flg=136 smb_flg2=51201 smb_tid=0 smb_pid=8195 smb_uid=100 smb_mid=2 smt_wct=4 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 257 (0x101) smb_bcc=327 [2008/06/20 11:54:27, 10] lib/util.c:dump_data(2286) [000] A1 81 FE 30 81 FB A0 03 0A 01 01 A1 0C 06 0A 2B ¡.þ0.û . ...¡...+ [010] 06 01 04 01 82 37 02 02 0A A2 81 E5 04 81 E2 4E .....7.. .¢.å..âN [020] 54 4C 4D 53 53 50 00 02 00 00 00 0E 00 0E 00 30 TLMSSP.. .......0 [030] 00 00 00 15 82 89 60 CC 7B 74 70 66 32 B8 A5 00 ......`Ì {tpf2¸¥. [040] 00 00 00 00 00 00 00 A4 00 A4 00 3E 00 00 00 52 .......¤ .¤.>...R [050] 00 4B 00 5F 00 4B 00 4C 00 42 00 47 00 02 00 0E .K._.K.L .B.G.... [060] 00 52 00 4B 00 5F 00 4B 00 4C 00 42 00 47 00 01 .R.K._.K .L.B.G.. [070] 00 0A 00 53 00 41 00 4D 00 42 00 41 00 04 00 36 ...S.A.M .B.A...6 [080] 00 69 00 6E 00 74 00 65 00 72 00 6E 00 2E 00 72 .i.n.t.e .r.n...r [090] 00 6B 00 2D 00 6B 00 6C 00 6F 00 73 00 74 00 65 .k.-.k.l .o.s.t.e [0A0] 00 72 00 6E 00 65 00 75 00 62 00 75 00 72 00 67 .r.n.e.u .b.u.r.g [0B0] 00 2E 00 61 00 74 00 03 00 42 00 73 00 61 00 6D ...a.t.. .B.s.a.m [0C0] 00 62 00 61 00 2E 00 69 00 6E 00 74 00 65 00 72 .b.a...i .n.t.e.r [0D0] 00 6E 00 2E 00 72 00 6B 00 2D 00 6B 00 6C 00 6F .n...r.k .-.k.l.o [0E0] 00 73 00 74 00 65 00 72 00 6E 00 65 00 75 00 62 .s.t.e.r .n.e.u.b [0F0] 00 75 00 72 00 67 00 2E 00 61 00 74 00 00 00 00 .u.r.g.. .a.t.... [100] 00 55 00 6E 00 69 00 78 00 00 00 53 00 61 00 6D .U.n.i.x ...S.a.m [110] 00 62 00 61 00 20 00 33 00 2E 00 30 00 2E 00 33 .b.a. .3 ...0...3 [120] 00 30 00 2D 00 32 00 6C 00 65 00 6F 00 2E 00 66 .0.-.2.l .e.o...f [130] 00 63 00 35 00 00 00 52 00 4B 00 5F 00 4B 00 4C .c.5...R .K._.K.L [140] 00 42 00 47 00 00 00 .B.G... [2008/06/20 11:54:27, 0] libsmb/clientgen.c:cli_receive_smb(111) Receiving SMB: Server stopped responding [2008/06/20 11:54:27, 4] nsswitch/winbindd_cm.c:cm_prepare_connection(766) authenticated session setup failed with NT_STATUS_IO_TIMEOUT [2008/06/20 11:54:27, 3] nsswitch/winbindd_cm.c:cm_get_ipc_userpass(504) cm_get_ipc_userpass: Retrieved auth-user from secrets.tdb [RK_KLBG\smbadmin] [2008/06/20 11:54:27, 5] nsswitch/winbindd_cm.c:cm_prepare_connection(790) connecting to SAMBA from SAMBA with username [RK_KLBG]\[smbadmin] [2008/06/20 11:54:27, 3] libsmb/cliconnect.c:cli_session_setup_spnego(801) Doing spnego session setup (blob length=58) [2008/06/20 11:54:27, 3] libsmb/cliconnect.c:cli_session_setup_spnego(826) got OID=1 3 6 1 4 1 311 2 2 10 [2008/06/20 11:54:27, 3] libsmb/cliconnect.c:cli_session_setup_spnego(834) got principal=NONE [2008/06/20 11:54:27, 3] libsmb/cliconnect.c:cli_session_setup_ntlmssp(704) Failed to send NTLMSSP/SPNEGO blob to server! [2008/06/20 11:54:27, 3] libsmb/cliconnect.c:cli_session_setup(1014) SPNEGO login failed: Undetermined error [2008/06/20 11:54:27, 4] nsswitch/winbindd_cm.c:cm_prepare_connection(802) authenticated session setup with user RK_KLBG\smbadmin failed. [2008/06/20 11:54:27, 10] passdb/secrets.c:secrets_named_mutex_release(995) secrets_named_mutex: released mutex for SAMBA [2008/06/20 11:54:27, 10] libsmb/conncache.c:add_failed_connection_entry(140) add_failed_connection_entry: added domain RK_KLBG (SAMBA) to failed conn cache [2008/06/20 11:54:27, 10] lib/gencache.c:gencache_del(173) Deleting cache entry (key = SAF/DOMAIN/RK_KLBG) [2008/06/20 11:54:27, 10] libsmb/namequery.c:saf_delete(100) saf_delete: domain = [RK_KLBG] [2008/06/20 11:54:27, 10] nsswitch/winbindd_cm.c:cm_open_connection(1368) cm_open_connection: dcname is 'SAMBA' for domain RK_KLBG [2008/06/20 11:54:27, 10] libsmb/conncache.c:check_negative_conn_cache_timeout(86) check_negative_conn_cache: returning negative entry for RK_KLBG, SAMBA [2008/06/20 11:54:27, 8] libsmb/namequery.c:get_sorted_dc_list(1626) get_sorted_dc_list: attempting lookup for name RK_KLBG (sitename NULL) using [lmhosts wins host bcast] [2008/06/20 11:54:27, 10] lib/gencache.c:gencache_get(212) Cache entry with key = SAF/DOMAIN/RK_KLBG couldn't be found [2008/06/20 11:54:27, 5] libsmb/namequery.c:saf_fetch(133) saf_fetch: failed to find server for "RK_KLBG" domain [2008/06/20 11:54:27, 3] libsmb/namequery.c:get_dc_list(1489) get_dc_list: preferred server list: ", *" [2008/06/20 11:54:27, 10] libsmb/namequery.c:internal_resolve_name(1166) internal_resolve_name: looking up RK_KLBG#1c (sitename (null)) [2008/06/20 11:54:27, 10] lib/gencache.c:gencache_get(226) Returning valid cache entry: key = NBT/RK_KLBG#1C, value = 192.168.60.3:0, timeout = Fri Jun 20 12:05:14 2008 [2008/06/20 11:54:27, 5] libsmb/namecache.c:namecache_fetch(214) name RK_KLBG#1C found. [2008/06/20 11:54:27, 8] libsmb/namequery.c:get_dc_list(1505) Adding 1 DC's from auto lookup [2008/06/20 11:54:27, 10] libsmb/namequery.c:remove_duplicate_addrs2(435) remove_duplicate_addrs2: looking for duplicate address/port pairs [2008/06/20 11:54:27, 4] libsmb/namequery.c:get_dc_list(1599) get_dc_list: returning 1 ip addresses in an unordered list [2008/06/20 11:54:27, 4] libsmb/namequery.c:get_dc_list(1600) get_dc_list: 192.168.60.3:0 [2008/06/20 11:54:27, 8] lib/util.c:fcntl_lock(2014) fcntl_lock fd=22 op=13 offset=0 count=1 type=0 [2008/06/20 11:54:27, 3] lib/util.c:fcntl_lock(2027) fcntl_lock: lock failed at offset 0 count 1 op 13 type 0 (Resource temporarily unavailable) [2008/06/20 11:54:27, 4] libsmb/clidgram.c:cli_send_mailslot(109) send_mailslot: Sending to mailslot \MAILSLOT\NET\NTLOGON from SAMBA<00> to RK_KLBG<1c> IP 192.168.60.3 [2008/06/20 11:54:27, 5] nsswitch/winbindd_cm.c:receive_getdc_response(1010) Did not receive packet for \MAILSLOT\NET\GETDC33CA8C0 [2008/06/20 11:54:27, 5] nsswitch/winbindd_cm.c:receive_getdc_response(1010) Did not receive packet for \MAILSLOT\NET\GETDC33CA8C0 [2008/06/20 11:54:28, 5] nsswitch/winbindd_cm.c:receive_getdc_response(1010) Did not receive packet for \MAILSLOT\NET\GETDC33CA8C0 [2008/06/20 11:54:28, 5] nsswitch/winbindd_cm.c:receive_getdc_response(1010) Did not receive packet for \MAILSLOT\NET\GETDC33CA8C0 [2008/06/20 11:54:29, 5] nsswitch/winbindd_cm.c:receive_getdc_response(1010) Did not receive packet for \MAILSLOT\NET\GETDC33CA8C0 [2008/06/20 11:54:29, 10] libsmb/namequery.c:name_status_find(303) name_status_find: looking up RK_KLBG#1c at 192.168.60.3 [2008/06/20 11:54:29, 10] lib/gencache.c:gencache_get(212) Cache entry with key = NBT/RK_KLBG#1C.20.192.168.60.3 couldn't be found [2008/06/20 11:54:29, 5] libsmb/namecache.c:namecache_status_fetch(346) namecache_status_fetch: no entry for NBT/RK_KLBG#1C.20.192.168.60.3 found. [2008/06/20 11:54:29, 10] lib/util_sock.c:open_socket_in(831) bind succeeded on port 0 [2008/06/20 11:54:29, 5] libsmb/nmblib.c:send_udp(779) Sending a packet of len 50 to (192.168.60.3) on port 137 [2008/06/20 11:54:29, 10] lib/util_sock.c:read_udp_socket(294) read_udp_socket: lastip 192.168.60.3 lastport 137 read: 265 [2008/06/20 11:54:29, 10] libsmb/nmblib.c:parse_nmb(506) parse_nmb: packet id = 2697 [2008/06/20 11:54:29, 5] libsmb/nmblib.c:read_packet(757) Received a packet of len 265 from (192.168.60.3) port 137 [2008/06/20 11:54:29, 4] libsmb/nmblib.c:debug_nmb_packet(112) nmb packet from 192.168.60.3(137) header: id=2697 opcode=Query(0) response=Yes header: flags: bcast=No rec_avail=No rec_des=No trunc=No auth=Yes header: rcode=0 qdcount=0 ancount=1 nscount=0 arcount=0 answers: nmb_name=RK_KLBG<1c> rr_type=33 rr_class=1 ttl=0 answers 0 char .SAMBA hex 0953414D424120202020202020202020 answers 10 char .d.SAMBA hex 00640053414D42412020202020202020 answers 20 char .d.SAMBA hex 202003640053414D4241202020202020 answers 30 char d...__MSBRO hex 2020202020640001025F5F4D5342524F answers 40 char WSE__....RK_KLBG hex 5753455F5F0201E400524B5F4B4C4247 answers 50 char .d.RK_KL hex 20202020202020201D6400524B5F4B4C answers 60 char BG .d.RK_ hex 424720202020202020201B6400524B5F answers 70 char KLBG ...R hex 4B4C424720202020202020201CE40052 answers 80 char K_KLBG .. hex 4B5F4B4C424720202020202020201EE4 answers 90 char .RK_KLBG hex 00524B5F4B4C42472020202020202020 answers a0 char ................ hex 00E40000000000000000000000000000 answers b0 char ................ hex 00000000000000000000000000000000 answers c0 char ................ hex 00000000000000000000000000000000 answers d0 char . hex 00 [2008/06/20 11:54:29, 10] libsmb/namequery.c:parse_node_status(185) SAMBA#00: flags = 0x64 [2008/06/20 11:54:29, 10] libsmb/namequery.c:parse_node_status(185) SAMBA#03: flags = 0x64 [2008/06/20 11:54:29, 10] libsmb/namequery.c:parse_node_status(185) SAMBA#20: flags = 0x64 [2008/06/20 11:54:29, 10] libsmb/namequery.c:parse_node_status(185) __MSBROWSE__#01: flags = 0xe4 [2008/06/20 11:54:29, 10] libsmb/namequery.c:parse_node_status(185) RK_KLBG#1d: flags = 0x64 [2008/06/20 11:54:29, 10] libsmb/namequery.c:parse_node_status(185) RK_KLBG#1b: flags = 0x64 [2008/06/20 11:54:29, 10] libsmb/namequery.c:parse_node_status(185) RK_KLBG#1c: flags = 0xe4 [2008/06/20 11:54:29, 10] libsmb/namequery.c:parse_node_status(185) RK_KLBG#1e: flags = 0xe4 [2008/06/20 11:54:29, 10] libsmb/namequery.c:parse_node_status(185) RK_KLBG#00: flags = 0xe4 [2008/06/20 11:54:29, 10] libsmb/namequery.c:name_status_find(342) name_status_find: name found, name SAMBA ip address is 192.168.60.3 [2008/06/20 11:54:29, 5] libsmb/namecache.c:namecache_store(135) namecache_store: storing 1 address for SAMBA#20: 192.168.60.3:0 [2008/06/20 11:54:29, 10] lib/gencache.c:gencache_set(140) Adding cache entry with key = NBT/SAMBA#20; value = 192.168.60.3:0 and timeout = Fri Jun 20 12:05:29 2008 (660 seconds ahead) [2008/06/20 11:54:29, 10] nsswitch/winbindd_cm.c:cm_prepare_connection(654) cm_prepare_connection: connecting to DC SAMBA for domain RK_KLBG [2008/06/20 11:54:29, 10] passdb/secrets.c:secrets_named_mutex(983) secrets_named_mutex: got mutex for SAMBA [2008/06/20 11:54:29, 6] libsmb/clientgen.c:write_socket(152) write_socket(21,194) [2008/06/20 11:54:29, 6] libsmb/clientgen.c:write_socket(155) write_socket(21,194) wrote 194 [2008/06/20 11:54:29, 10] lib/util_sock.c:read_smb_length_return_keepalive(623) got smb length of 127 [2008/06/20 11:54:29, 5] lib/util.c:show_msg(506) [2008/06/20 11:54:29, 5] lib/util.c:show_msg(516) size=127 smb_com=0x72 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51201 smb_tid=0 smb_pid=8195 smb_uid=0 smb_mid=1 smt_wct=17 smb_vwv[ 0]= 8 (0x8) smb_vwv[ 1]=12803 (0x3203) smb_vwv[ 2]= 256 (0x100) smb_vwv[ 3]= 1024 (0x400) smb_vwv[ 4]= 65 (0x41) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 256 (0x100) smb_vwv[ 7]= 3584 (0xE00) smb_vwv[ 8]= 32 (0x20) smb_vwv[ 9]=64768 (0xFD00) smb_vwv[10]=33011 (0x80F3) smb_vwv[11]=32896 (0x8080) smb_vwv[12]=31608 (0x7B78) smb_vwv[13]=48033 (0xBBA1) smb_vwv[14]=51410 (0xC8D2) smb_vwv[15]=34817 (0x8801) smb_vwv[16]= 255 (0xFF) smb_bcc=58 [2008/06/20 11:54:29, 10] lib/util.c:dump_data(2286) [000] 73 61 6D 62 61 00 00 00 00 00 00 00 00 00 00 00 samba... ........ [010] 60 28 06 06 2B 06 01 05 05 02 A0 1E 30 1C A0 0E `(..+... .. .0. . [020] 30 0C 06 0A 2B 06 01 04 01 82 37 02 02 0A A3 0A 0...+... ..7...£. [030] 30 08 A0 06 1B 04 4E 4F 4E 45 0. ...NO NE [2008/06/20 11:54:29, 5] lib/util.c:show_msg(506) [2008/06/20 11:54:29, 5] lib/util.c:show_msg(516) size=127 smb_com=0x72 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51201 smb_tid=0 smb_pid=8195 smb_uid=0 smb_mid=1 smt_wct=17 smb_vwv[ 0]= 8 (0x8) smb_vwv[ 1]=12803 (0x3203) smb_vwv[ 2]= 256 (0x100) smb_vwv[ 3]= 1024 (0x400) smb_vwv[ 4]= 65 (0x41) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 256 (0x100) smb_vwv[ 7]= 3584 (0xE00) smb_vwv[ 8]= 32 (0x20) smb_vwv[ 9]=64768 (0xFD00) smb_vwv[10]=33011 (0x80F3) smb_vwv[11]=32896 (0x8080) smb_vwv[12]=31608 (0x7B78) smb_vwv[13]=48033 (0xBBA1) smb_vwv[14]=51410 (0xC8D2) smb_vwv[15]=34817 (0x8801) smb_vwv[16]= 255 (0xFF) smb_bcc=58 [2008/06/20 11:54:29, 10] lib/util.c:dump_data(2286) [000] 73 61 6D 62 61 00 00 00 00 00 00 00 00 00 00 00 samba... ........ [010] 60 28 06 06 2B 06 01 05 05 02 A0 1E 30 1C A0 0E `(..+... .. .0. . [020] 30 0C 06 0A 2B 06 01 04 01 82 37 02 02 0A A3 0A 0...+... ..7...£. [030] 30 08 A0 06 1B 04 4E 4F 4E 45 0. ...NO NE [2008/06/20 11:54:29, 5] nsswitch/winbindd_cm.c:cm_prepare_connection(758) connecting to SAMBA from SAMBA with username [RK_KLBG]\[SAMBA$] [2008/06/20 11:54:29, 3] libsmb/cliconnect.c:cli_session_setup_spnego(801) Doing spnego session setup (blob length=58) [2008/06/20 11:54:29, 3] libsmb/cliconnect.c:cli_session_setup_spnego(826) got OID=1 3 6 1 4 1 311 2 2 10 [2008/06/20 11:54:29, 3] libsmb/cliconnect.c:cli_session_setup_spnego(834) got principal=NONE [2008/06/20 11:54:29, 6] libsmb/clientgen.c:write_socket(152) write_socket(21,164) [2008/06/20 11:54:29, 6] libsmb/clientgen.c:write_socket(155) write_socket(21,164) wrote 164 [2008/06/20 11:54:29, 10] lib/util_sock.c:read_smb_length_return_keepalive(623) got smb length of 370 [2008/06/20 11:54:29, 5] lib/util.c:show_msg(506) [2008/06/20 11:54:29, 5] lib/util.c:show_msg(516) size=370 smb_com=0x73 smb_rcls=22 smb_reh=0 smb_err=49152 smb_flg=136 smb_flg2=51201 smb_tid=0 smb_pid=8195 smb_uid=100 smb_mid=2 smt_wct=4 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 257 (0x101) smb_bcc=327 [2008/06/20 11:54:29, 10] lib/util.c:dump_data(2286) [000] A1 81 FE 30 81 FB A0 03 0A 01 01 A1 0C 06 0A 2B ¡.þ0.û . ...¡...+ [010] 06 01 04 01 82 37 02 02 0A A2 81 E5 04 81 E2 4E .....7.. .¢.å..âN [020] 54 4C 4D 53 53 50 00 02 00 00 00 0E 00 0E 00 30 TLMSSP.. .......0 [030] 00 00 00 15 82 89 60 0E 49 E6 C1 D0 0F 5D 4C 00 ......`. IæÁÐ.]L. [040] 00 00 00 00 00 00 00 A4 00 A4 00 3E 00 00 00 52 .......¤ .¤.>...R [050] 00 4B 00 5F 00 4B 00 4C 00 42 00 47 00 02 00 0E .K._.K.L .B.G.... [060] 00 52 00 4B 00 5F 00 4B 00 4C 00 42 00 47 00 01 .R.K._.K .L.B.G.. [070] 00 0A 00 53 00 41 00 4D 00 42 00 41 00 04 00 36 ...S.A.M .B.A...6 [080] 00 69 00 6E 00 74 00 65 00 72 00 6E 00 2E 00 72 .i.n.t.e .r.n...r [090] 00 6B 00 2D 00 6B 00 6C 00 6F 00 73 00 74 00 65 .k.-.k.l .o.s.t.e [0A0] 00 72 00 6E 00 65 00 75 00 62 00 75 00 72 00 67 .r.n.e.u .b.u.r.g [0B0] 00 2E 00 61 00 74 00 03 00 42 00 73 00 61 00 6D ...a.t.. .B.s.a.m [0C0] 00 62 00 61 00 2E 00 69 00 6E 00 74 00 65 00 72 .b.a...i .n.t.e.r [0D0] 00 6E 00 2E 00 72 00 6B 00 2D 00 6B 00 6C 00 6F .n...r.k .-.k.l.o [0E0] 00 73 00 74 00 65 00 72 00 6E 00 65 00 75 00 62 .s.t.e.r .n.e.u.b [0F0] 00 75 00 72 00 67 00 2E 00 61 00 74 00 00 00 00 .u.r.g.. .a.t.... [100] 00 55 00 6E 00 69 00 78 00 00 00 53 00 61 00 6D .U.n.i.x ...S.a.m [110] 00 62 00 61 00 20 00 33 00 2E 00 30 00 2E 00 33 .b.a. .3 ...0...3 [120] 00 30 00 2D 00 32 00 6C 00 65 00 6F 00 2E 00 66 .0.-.2.l .e.o...f [130] 00 63 00 35 00 00 00 52 00 4B 00 5F 00 4B 00 4C .c.5...R .K._.K.L [140] 00 42 00 47 00 00 00 .B.G... [2008/06/20 11:54:29, 5] lib/util.c:show_msg(506) [2008/06/20 11:54:29, 5] lib/util.c:show_msg(516) size=370 smb_com=0x73 smb_rcls=22 smb_reh=0 smb_err=49152 smb_flg=136 smb_flg2=51201 smb_tid=0 smb_pid=8195 smb_uid=100 smb_mid=2 smt_wct=4 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 257 (0x101) smb_bcc=327 [2008/06/20 11:54:29, 10] lib/util.c:dump_data(2286) [000] A1 81 FE 30 81 FB A0 03 0A 01 01 A1 0C 06 0A 2B ¡.þ0.û . ...¡...+ [010] 06 01 04 01 82 37 02 02 0A A2 81 E5 04 81 E2 4E .....7.. .¢.å..âN [020] 54 4C 4D 53 53 50 00 02 00 00 00 0E 00 0E 00 30 TLMSSP.. .......0 [030] 00 00 00 15 82 89 60 0E 49 E6 C1 D0 0F 5D 4C 00 ......`. IæÁÐ.]L. [040] 00 00 00 00 00 00 00 A4 00 A4 00 3E 00 00 00 52 .......¤ .¤.>...R [050] 00 4B 00 5F 00 4B 00 4C 00 42 00 47 00 02 00 0E .K._.K.L .B.G.... [060] 00 52 00 4B 00 5F 00 4B 00 4C 00 42 00 47 00 01 .R.K._.K .L.B.G.. [070] 00 0A 00 53 00 41 00 4D 00 42 00 41 00 04 00 36 ...S.A.M .B.A...6 [080] 00 69 00 6E 00 74 00 65 00 72 00 6E 00 2E 00 72 .i.n.t.e .r.n...r [090] 00 6B 00 2D 00 6B 00 6C 00 6F 00 73 00 74 00 65 .k.-.k.l .o.s.t.e [0A0] 00 72 00 6E 00 65 00 75 00 62 00 75 00 72 00 67 .r.n.e.u .b.u.r.g [0B0] 00 2E 00 61 00 74 00 03 00 42 00 73 00 61 00 6D ...a.t.. .B.s.a.m [0C0] 00 62 00 61 00 2E 00 69 00 6E 00 74 00 65 00 72 .b.a...i .n.t.e.r [0D0] 00 6E 00 2E 00 72 00 6B 00 2D 00 6B 00 6C 00 6F .n...r.k .-.k.l.o [0E0] 00 73 00 74 00 65 00 72 00 6E 00 65 00 75 00 62 .s.t.e.r .n.e.u.b [0F0] 00 75 00 72 00 67 00 2E 00 61 00 74 00 00 00 00 .u.r.g.. .a.t.... [100] 00 55 00 6E 00 69 00 78 00 00 00 53 00 61 00 6D .U.n.i.x ...S.a.m [110] 00 62 00 61 00 20 00 33 00 2E 00 30 00 2E 00 33 .b.a. .3 ...0...3 [120] 00 30 00 2D 00 32 00 6C 00 65 00 6F 00 2E 00 66 .0.-.2.l .e.o...f [130] 00 63 00 35 00 00 00 52 00 4B 00 5F 00 4B 00 4C .c.5...R .K._.K.L [140] 00 42 00 47 00 00 00 .B.G... [2008/06/20 11:54:29, 3] libsmb/ntlmssp.c:ntlmssp_client_challenge(1018) Got challenge flags: [2008/06/20 11:54:29, 3] libsmb/ntlmssp.c:debug_ntlmssp_flags(63) Got NTLMSSP neg_flags=0x60898215 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_CHAL_TARGET_INFO NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH [2008/06/20 11:54:29, 3] libsmb/ntlmssp.c:ntlmssp_client_challenge(1040) NTLMSSP: Set final flags: [2008/06/20 11:54:29, 3] libsmb/ntlmssp.c:debug_ntlmssp_flags(63) Got NTLMSSP neg_flags=0x60088215 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH [2008/06/20 11:54:29, 5] libsmb/ntlmssp.c:ntlmssp_client_challenge(1112) NTLMSSP challenge set by NTLM2 [2008/06/20 11:54:29, 5] libsmb/ntlmssp.c:ntlmssp_client_challenge(1113) challenge is: [2008/06/20 11:54:29, 5] lib/util.c:dump_data(2286) [000] B1 EC 25 47 41 54 C0 93 ±ì%GATÀ. [2008/06/20 11:54:29, 3] libsmb/ntlmssp_sign.c:ntlmssp_sign_init(338) NTLMSSP Sign/Seal - Initialising with flags: [2008/06/20 11:54:29, 3] libsmb/ntlmssp.c:debug_ntlmssp_flags(63) Got NTLMSSP neg_flags=0x60088215 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH [2008/06/20 11:54:29, 6] libsmb/clientgen.c:write_socket(152) write_socket(21,262) [2008/06/20 11:54:29, 6] libsmb/clientgen.c:write_socket(155) write_socket(21,262) wrote 262 [2008/06/20 11:54:39, 10] lib/util_sock.c:read_socket_with_timeout(476) read_socket_with_timeout: timeout read. select timed out. [2008/06/20 11:54:39, 10] lib/util_sock.c:receive_smb_raw(671) receive_smb_raw: length < 0! [2008/06/20 11:54:39, 10] libsmb/clientgen.c:client_receive_smb(64) client_receive_smb failed [2008/06/20 11:54:39, 5] lib/util.c:show_msg(506) [2008/06/20 11:54:39, 5] lib/util.c:show_msg(516) size=370 smb_com=0x73 smb_rcls=22 smb_reh=0 smb_err=49152 smb_flg=136 smb_flg2=51201 smb_tid=0 smb_pid=8195 smb_uid=100 smb_mid=2 smt_wct=4 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 257 (0x101) smb_bcc=327 [2008/06/20 11:54:39, 10] lib/util.c:dump_data(2286) [000] A1 81 FE 30 81 FB A0 03 0A 01 01 A1 0C 06 0A 2B ¡.þ0.û . ...¡...+ [010] 06 01 04 01 82 37 02 02 0A A2 81 E5 04 81 E2 4E .....7.. .¢.å..âN [020] 54 4C 4D 53 53 50 00 02 00 00 00 0E 00 0E 00 30 TLMSSP.. .......0 [030] 00 00 00 15 82 89 60 0E 49 E6 C1 D0 0F 5D 4C 00 ......`. IæÁÐ.]L. [040] 00 00 00 00 00 00 00 A4 00 A4 00 3E 00 00 00 52 .......¤ .¤.>...R [050] 00 4B 00 5F 00 4B 00 4C 00 42 00 47 00 02 00 0E .K._.K.L .B.G.... [060] 00 52 00 4B 00 5F 00 4B 00 4C 00 42 00 47 00 01 .R.K._.K .L.B.G.. [070] 00 0A 00 53 00 41 00 4D 00 42 00 41 00 04 00 36 ...S.A.M .B.A...6 [080] 00 69 00 6E 00 74 00 65 00 72 00 6E 00 2E 00 72 .i.n.t.e .r.n...r [090] 00 6B 00 2D 00 6B 00 6C 00 6F 00 73 00 74 00 65 .k.-.k.l .o.s.t.e [0A0] 00 72 00 6E 00 65 00 75 00 62 00 75 00 72 00 67 .r.n.e.u .b.u.r.g [0B0] 00 2E 00 61 00 74 00 03 00 42 00 73 00 61 00 6D ...a.t.. .B.s.a.m [0C0] 00 62 00 61 00 2E 00 69 00 6E 00 74 00 65 00 72 .b.a...i .n.t.e.r [0D0] 00 6E 00 2E 00 72 00 6B 00 2D 00 6B 00 6C 00 6F .n...r.k .-.k.l.o [0E0] 00 73 00 74 00 65 00 72 00 6E 00 65 00 75 00 62 .s.t.e.r .n.e.u.b [0F0] 00 75 00 72 00 67 00 2E 00 61 00 74 00 00 00 00 .u.r.g.. .a.t.... [100] 00 55 00 6E 00 69 00 78 00 00 00 53 00 61 00 6D .U.n.i.x ...S.a.m [110] 00 62 00 61 00 20 00 33 00 2E 00 30 00 2E 00 33 .b.a. .3 ...0...3 [120] 00 30 00 2D 00 32 00 6C 00 65 00 6F 00 2E 00 66 .0.-.2.l .e.o...f [130] 00 63 00 35 00 00 00 52 00 4B 00 5F 00 4B 00 4C .c.5...R .K._.K.L [140] 00 42 00 47 00 00 00 .B.G... [2008/06/20 11:54:39, 0] libsmb/clientgen.c:cli_receive_smb(111) Receiving SMB: Server stopped responding [2008/06/20 11:54:39, 4] nsswitch/winbindd_cm.c:cm_prepare_connection(766) authenticated session setup failed with NT_STATUS_IO_TIMEOUT [2008/06/20 11:54:39, 3] nsswitch/winbindd_cm.c:cm_get_ipc_userpass(504) cm_get_ipc_userpass: Retrieved auth-user from secrets.tdb [RK_KLBG\smbadmin] [2008/06/20 11:54:39, 5] nsswitch/winbindd_cm.c:cm_prepare_connection(790) connecting to SAMBA from SAMBA with username [RK_KLBG]\[smbadmin] [2008/06/20 11:54:39, 3] libsmb/cliconnect.c:cli_session_setup_spnego(801) Doing spnego session setup (blob length=58) [2008/06/20 11:54:39, 3] libsmb/cliconnect.c:cli_session_setup_spnego(826) got OID=1 3 6 1 4 1 311 2 2 10 [2008/06/20 11:54:39, 3] libsmb/cliconnect.c:cli_session_setup_spnego(834) got principal=NONE [2008/06/20 11:54:39, 3] libsmb/cliconnect.c:cli_session_setup_ntlmssp(704) Failed to send NTLMSSP/SPNEGO blob to server! [2008/06/20 11:54:39, 3] libsmb/cliconnect.c:cli_session_setup(1014) SPNEGO login failed: Undetermined error [2008/06/20 11:54:39, 4] nsswitch/winbindd_cm.c:cm_prepare_connection(802) authenticated session setup with user RK_KLBG\smbadmin failed. [2008/06/20 11:54:39, 10] passdb/secrets.c:secrets_named_mutex_release(995) secrets_named_mutex: released mutex for SAMBA [2008/06/20 11:54:39, 10] libsmb/conncache.c:add_failed_connection_entry(118) add_failed_connection_entry: domain RK_KLBG (SAMBA) already tried and failed [2008/06/20 11:54:39, 10] lib/gencache.c:gencache_del(173) Deleting cache entry (key = SAF/DOMAIN/RK_KLBG) [2008/06/20 11:54:39, 10] nsswitch/winbindd_cm.c:cm_open_connection(1368) cm_open_connection: dcname is 'SAMBA' for domain RK_KLBG [2008/06/20 11:54:39, 10] libsmb/conncache.c:check_negative_conn_cache_timeout(86) check_negative_conn_cache: returning negative entry for RK_KLBG, SAMBA [2008/06/20 11:54:39, 8] libsmb/namequery.c:get_sorted_dc_list(1626) get_sorted_dc_list: attempting lookup for name RK_KLBG (sitename NULL) using [lmhosts wins host bcast] [2008/06/20 11:54:39, 10] lib/gencache.c:gencache_get(212) Cache entry with key = SAF/DOMAIN/RK_KLBG couldn't be found [2008/06/20 11:54:39, 5] libsmb/namequery.c:saf_fetch(133) saf_fetch: failed to find server for "RK_KLBG" domain [2008/06/20 11:54:39, 3] libsmb/namequery.c:get_dc_list(1489) get_dc_list: preferred server list: ", *" [2008/06/20 11:54:39, 10] libsmb/namequery.c:internal_resolve_name(1166) internal_resolve_name: looking up RK_KLBG#1c (sitename (null)) [2008/06/20 11:54:39, 10] lib/gencache.c:gencache_get(226) Returning valid cache entry: key = NBT/RK_KLBG#1C, value = 192.168.60.3:0, timeout = Fri Jun 20 12:05:14 2008 [2008/06/20 11:54:39, 5] libsmb/namecache.c:namecache_fetch(214) name RK_KLBG#1C found. [2008/06/20 11:54:39, 8] libsmb/namequery.c:get_dc_list(1505) Adding 1 DC's from auto lookup [2008/06/20 11:54:39, 10] libsmb/namequery.c:remove_duplicate_addrs2(435) remove_duplicate_addrs2: looking for duplicate address/port pairs [2008/06/20 11:54:39, 4] libsmb/namequery.c:get_dc_list(1599) get_dc_list: returning 1 ip addresses in an unordered list [2008/06/20 11:54:39, 4] libsmb/namequery.c:get_dc_list(1600) get_dc_list: 192.168.60.3:0 [2008/06/20 11:54:39, 8] lib/util.c:fcntl_lock(2014) fcntl_lock fd=22 op=13 offset=0 count=1 type=0 [2008/06/20 11:54:39, 3] lib/util.c:fcntl_lock(2027) fcntl_lock: lock failed at offset 0 count 1 op 13 type 0 (Resource temporarily unavailable) [2008/06/20 11:54:39, 4] libsmb/clidgram.c:cli_send_mailslot(109) send_mailslot: Sending to mailslot \MAILSLOT\NET\NTLOGON from SAMBA<00> to RK_KLBG<1c> IP 192.168.60.3 [2008/06/20 11:54:40, 5] nsswitch/winbindd_cm.c:receive_getdc_response(1010) Did not receive packet for \MAILSLOT\NET\GETDC33CA8C0 [2008/06/20 11:54:40, 5] nsswitch/winbindd_cm.c:receive_getdc_response(1010) Did not receive packet for \MAILSLOT\NET\GETDC33CA8C0 [2008/06/20 11:54:41, 5] nsswitch/winbindd_cm.c:receive_getdc_response(1010) Did not receive packet for \MAILSLOT\NET\GETDC33CA8C0 [2008/06/20 11:54:41, 5] nsswitch/winbindd_cm.c:receive_getdc_response(1010) Did not receive packet for \MAILSLOT\NET\GETDC33CA8C0 [2008/06/20 11:54:42, 5] nsswitch/winbindd_cm.c:receive_getdc_response(1010) Did not receive packet for \MAILSLOT\NET\GETDC33CA8C0 [2008/06/20 11:54:42, 10] libsmb/namequery.c:name_status_find(303) name_status_find: looking up RK_KLBG#1c at 192.168.60.3 [2008/06/20 11:54:42, 10] lib/gencache.c:gencache_get(212) Cache entry with key = NBT/RK_KLBG#1C.20.192.168.60.3 couldn't be found [2008/06/20 11:54:42, 5] libsmb/namecache.c:namecache_status_fetch(346) namecache_status_fetch: no entry for NBT/RK_KLBG#1C.20.192.168.60.3 found. [2008/06/20 11:54:42, 10] lib/util_sock.c:open_socket_in(831) bind succeeded on port 0 [2008/06/20 11:54:42, 5] libsmb/nmblib.c:send_udp(779) Sending a packet of len 50 to (192.168.60.3) on port 137 [2008/06/20 11:54:42, 10] lib/util_sock.c:read_udp_socket(294) read_udp_socket: lastip 192.168.60.3 lastport 137 read: 265 [2008/06/20 11:54:42, 10] libsmb/nmblib.c:parse_nmb(506) parse_nmb: packet id = 9381 [2008/06/20 11:54:42, 5] libsmb/nmblib.c:read_packet(757) Received a packet of len 265 from (192.168.60.3) port 137 [2008/06/20 11:54:42, 4] libsmb/nmblib.c:debug_nmb_packet(112) nmb packet from 192.168.60.3(137) header: id=9381 opcode=Query(0) response=Yes header: flags: bcast=No rec_avail=No rec_des=No trunc=No auth=Yes header: rcode=0 qdcount=0 ancount=1 nscount=0 arcount=0 answers: nmb_name=RK_KLBG<1c> rr_type=33 rr_class=1 ttl=0 answers 0 char .SAMBA hex 0953414D424120202020202020202020 answers 10 char .d.SAMBA hex 00640053414D42412020202020202020 answers 20 char .d.SAMBA hex 202003640053414D4241202020202020 answers 30 char d...__MSBRO hex 2020202020640001025F5F4D5342524F answers 40 char WSE__....RK_KLBG hex 5753455F5F0201E400524B5F4B4C4247 answers 50 char .d.RK_KL hex 20202020202020201D6400524B5F4B4C answers 60 char BG .d.RK_ hex 424720202020202020201B6400524B5F answers 70 char KLBG ...R hex 4B4C424720202020202020201CE40052 answers 80 char K_KLBG .. hex 4B5F4B4C424720202020202020201EE4 answers 90 char .RK_KLBG hex 00524B5F4B4C42472020202020202020 answers a0 char ................ hex 00E40000000000000000000000000000 answers b0 char ................ hex 00000000000000000000000000000000 answers c0 char ................ hex 00000000000000000000000000000000 answers d0 char . hex 00 [2008/06/20 11:54:42, 10] libsmb/namequery.c:parse_node_status(185) SAMBA#00: flags = 0x64 [2008/06/20 11:54:42, 10] libsmb/namequery.c:parse_node_status(185) SAMBA#03: flags = 0x64 [2008/06/20 11:54:42, 10] libsmb/namequery.c:parse_node_status(185) SAMBA#20: flags = 0x64 [2008/06/20 11:54:42, 10] libsmb/namequery.c:parse_node_status(185) __MSBROWSE__#01: flags = 0xe4 [2008/06/20 11:54:42, 10] libsmb/namequery.c:parse_node_status(185) RK_KLBG#1d: flags = 0x64 [2008/06/20 11:54:42, 10] libsmb/namequery.c:parse_node_status(185) RK_KLBG#1b: flags = 0x64 [2008/06/20 11:54:42, 10] libsmb/namequery.c:parse_node_status(185) RK_KLBG#1c: flags = 0xe4 [2008/06/20 11:54:42, 10] libsmb/namequery.c:parse_node_status(185) RK_KLBG#1e: flags = 0xe4 [2008/06/20 11:54:42, 10] libsmb/namequery.c:parse_node_status(185) RK_KLBG#00: flags = 0xe4 [2008/06/20 11:54:42, 10] libsmb/namequery.c:name_status_find(342) name_status_find: name found, name SAMBA ip address is 192.168.60.3 [2008/06/20 11:54:42, 5] libsmb/namecache.c:namecache_store(135) namecache_store: storing 1 address for SAMBA#20: 192.168.60.3:0 [2008/06/20 11:54:42, 10] lib/gencache.c:gencache_set(140) Adding cache entry with key = NBT/SAMBA#20; value = 192.168.60.3:0 and timeout = Fri Jun 20 12:05:42 2008 (660 seconds ahead) [2008/06/20 11:54:42, 10] nsswitch/winbindd_cm.c:cm_prepare_connection(654) cm_prepare_connection: connecting to DC SAMBA for domain RK_KLBG [2008/06/20 11:54:42, 10] passdb/secrets.c:secrets_named_mutex(983) secrets_named_mutex: got mutex for SAMBA [2008/06/20 11:54:42, 6] libsmb/clientgen.c:write_socket(152) write_socket(21,194) [2008/06/20 11:54:42, 6] libsmb/clientgen.c:write_socket(155) write_socket(21,194) wrote 194 [2008/06/20 11:54:42, 10] lib/util_sock.c:read_smb_length_return_keepalive(623) got smb length of 127 [2008/06/20 11:54:42, 5] lib/util.c:show_msg(506) [2008/06/20 11:54:42, 5] lib/util.c:show_msg(516) size=127 smb_com=0x72 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51201 smb_tid=0 smb_pid=8195 smb_uid=0 smb_mid=1 smt_wct=17 smb_vwv[ 0]= 8 (0x8) smb_vwv[ 1]=12803 (0x3203) smb_vwv[ 2]= 256 (0x100) smb_vwv[ 3]= 1024 (0x400) smb_vwv[ 4]= 65 (0x41) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 256 (0x100) smb_vwv[ 7]= 4352 (0x1100) smb_vwv[ 8]= 32 (0x20) smb_vwv[ 9]=64768 (0xFD00) smb_vwv[10]=33011 (0x80F3) smb_vwv[11]= 128 (0x80) smb_vwv[12]=15133 (0x3B1D) smb_vwv[13]=48041 (0xBBA9) smb_vwv[14]=51410 (0xC8D2) smb_vwv[15]=34817 (0x8801) smb_vwv[16]= 255 (0xFF) smb_bcc=58 [2008/06/20 11:54:42, 10] lib/util.c:dump_data(2286) [000] 73 61 6D 62 61 00 00 00 00 00 00 00 00 00 00 00 samba... ........ [010] 60 28 06 06 2B 06 01 05 05 02 A0 1E 30 1C A0 0E `(..+... .. .0. . [020] 30 0C 06 0A 2B 06 01 04 01 82 37 02 02 0A A3 0A 0...+... ..7...£. [030] 30 08 A0 06 1B 04 4E 4F 4E 45 0. ...NO NE [2008/06/20 11:54:42, 5] lib/util.c:show_msg(506) [2008/06/20 11:54:42, 5] lib/util.c:show_msg(516) size=127 smb_com=0x72 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51201 smb_tid=0 smb_pid=8195 smb_uid=0 smb_mid=1 smt_wct=17 smb_vwv[ 0]= 8 (0x8) smb_vwv[ 1]=12803 (0x3203) smb_vwv[ 2]= 256 (0x100) smb_vwv[ 3]= 1024 (0x400) smb_vwv[ 4]= 65 (0x41) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 256 (0x100) smb_vwv[ 7]= 4352 (0x1100) smb_vwv[ 8]= 32 (0x20) smb_vwv[ 9]=64768 (0xFD00) smb_vwv[10]=33011 (0x80F3) smb_vwv[11]= 128 (0x80) smb_vwv[12]=15133 (0x3B1D) smb_vwv[13]=48041 (0xBBA9) smb_vwv[14]=51410 (0xC8D2) smb_vwv[15]=34817 (0x8801) smb_vwv[16]= 255 (0xFF) smb_bcc=58 [2008/06/20 11:54:42, 10] lib/util.c:dump_data(2286) [000] 73 61 6D 62 61 00 00 00 00 00 00 00 00 00 00 00 samba... ........ [010] 60 28 06 06 2B 06 01 05 05 02 A0 1E 30 1C A0 0E `(..+... .. .0. . [020] 30 0C 06 0A 2B 06 01 04 01 82 37 02 02 0A A3 0A 0...+... ..7...£. [030] 30 08 A0 06 1B 04 4E 4F 4E 45 0. ...NO NE [2008/06/20 11:54:42, 5] nsswitch/winbindd_cm.c:cm_prepare_connection(758) connecting to SAMBA from SAMBA with username [RK_KLBG]\[SAMBA$] [2008/06/20 11:54:42, 3] libsmb/cliconnect.c:cli_session_setup_spnego(801) Doing spnego session setup (blob length=58) [2008/06/20 11:54:42, 3] libsmb/cliconnect.c:cli_session_setup_spnego(826) got OID=1 3 6 1 4 1 311 2 2 10 [2008/06/20 11:54:42, 3] libsmb/cliconnect.c:cli_session_setup_spnego(834) got principal=NONE [2008/06/20 11:54:42, 6] libsmb/clientgen.c:write_socket(152) write_socket(21,164) [2008/06/20 11:54:42, 6] libsmb/clientgen.c:write_socket(155) write_socket(21,164) wrote 164 [2008/06/20 11:54:42, 10] lib/util_sock.c:read_smb_length_return_keepalive(623) got smb length of 370 [2008/06/20 11:54:42, 5] lib/util.c:show_msg(506) [2008/06/20 11:54:42, 5] lib/util.c:show_msg(516) size=370 smb_com=0x73 smb_rcls=22 smb_reh=0 smb_err=49152 smb_flg=136 smb_flg2=51201 smb_tid=0 smb_pid=8195 smb_uid=100 smb_mid=2 smt_wct=4 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 257 (0x101) smb_bcc=327 [2008/06/20 11:54:42, 10] lib/util.c:dump_data(2286) [000] A1 81 FE 30 81 FB A0 03 0A 01 01 A1 0C 06 0A 2B ¡.þ0.û . ...¡...+ [010] 06 01 04 01 82 37 02 02 0A A2 81 E5 04 81 E2 4E .....7.. .¢.å..âN [020] 54 4C 4D 53 53 50 00 02 00 00 00 0E 00 0E 00 30 TLMSSP.. .......0 [030] 00 00 00 15 82 89 60 AE C4 99 8C AF 01 2B 85 00 ......`® Ä..¯.+.. [040] 00 00 00 00 00 00 00 A4 00 A4 00 3E 00 00 00 52 .......¤ .¤.>...R [050] 00 4B 00 5F 00 4B 00 4C 00 42 00 47 00 02 00 0E .K._.K.L .B.G.... [060] 00 52 00 4B 00 5F 00 4B 00 4C 00 42 00 47 00 01 .R.K._.K .L.B.G.. [070] 00 0A 00 53 00 41 00 4D 00 42 00 41 00 04 00 36 ...S.A.M .B.A...6 [080] 00 69 00 6E 00 74 00 65 00 72 00 6E 00 2E 00 72 .i.n.t.e .r.n...r [090] 00 6B 00 2D 00 6B 00 6C 00 6F 00 73 00 74 00 65 .k.-.k.l .o.s.t.e [0A0] 00 72 00 6E 00 65 00 75 00 62 00 75 00 72 00 67 .r.n.e.u .b.u.r.g [0B0] 00 2E 00 61 00 74 00 03 00 42 00 73 00 61 00 6D ...a.t.. .B.s.a.m [0C0] 00 62 00 61 00 2E 00 69 00 6E 00 74 00 65 00 72 .b.a...i .n.t.e.r [0D0] 00 6E 00 2E 00 72 00 6B 00 2D 00 6B 00 6C 00 6F .n...r.k .-.k.l.o [0E0] 00 73 00 74 00 65 00 72 00 6E 00 65 00 75 00 62 .s.t.e.r .n.e.u.b [0F0] 00 75 00 72 00 67 00 2E 00 61 00 74 00 00 00 00 .u.r.g.. .a.t.... [100] 00 55 00 6E 00 69 00 78 00 00 00 53 00 61 00 6D .U.n.i.x ...S.a.m [110] 00 62 00 61 00 20 00 33 00 2E 00 30 00 2E 00 33 .b.a. .3 ...0...3 [120] 00 30 00 2D 00 32 00 6C 00 65 00 6F 00 2E 00 66 .0.-.2.l .e.o...f [130] 00 63 00 35 00 00 00 52 00 4B 00 5F 00 4B 00 4C .c.5...R .K._.K.L [140] 00 42 00 47 00 00 00 .B.G... [2008/06/20 11:54:42, 5] lib/util.c:show_msg(506) [2008/06/20 11:54:42, 5] lib/util.c:show_msg(516) size=370 smb_com=0x73 smb_rcls=22 smb_reh=0 smb_err=49152 smb_flg=136 smb_flg2=51201 smb_tid=0 smb_pid=8195 smb_uid=100 smb_mid=2 smt_wct=4 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 257 (0x101) smb_bcc=327 [2008/06/20 11:54:42, 10] lib/util.c:dump_data(2286) [000] A1 81 FE 30 81 FB A0 03 0A 01 01 A1 0C 06 0A 2B ¡.þ0.û . ...¡...+ [010] 06 01 04 01 82 37 02 02 0A A2 81 E5 04 81 E2 4E .....7.. .¢.å..âN [020] 54 4C 4D 53 53 50 00 02 00 00 00 0E 00 0E 00 30 TLMSSP.. .......0 [030] 00 00 00 15 82 89 60 AE C4 99 8C AF 01 2B 85 00 ......`® Ä..¯.+.. [040] 00 00 00 00 00 00 00 A4 00 A4 00 3E 00 00 00 52 .......¤ .¤.>...R [050] 00 4B 00 5F 00 4B 00 4C 00 42 00 47 00 02 00 0E .K._.K.L .B.G.... [060] 00 52 00 4B 00 5F 00 4B 00 4C 00 42 00 47 00 01 .R.K._.K .L.B.G.. [070] 00 0A 00 53 00 41 00 4D 00 42 00 41 00 04 00 36 ...S.A.M .B.A...6 [080] 00 69 00 6E 00 74 00 65 00 72 00 6E 00 2E 00 72 .i.n.t.e .r.n...r [090] 00 6B 00 2D 00 6B 00 6C 00 6F 00 73 00 74 00 65 .k.-.k.l .o.s.t.e [0A0] 00 72 00 6E 00 65 00 75 00 62 00 75 00 72 00 67 .r.n.e.u .b.u.r.g [0B0] 00 2E 00 61 00 74 00 03 00 42 00 73 00 61 00 6D ...a.t.. .B.s.a.m [0C0] 00 62 00 61 00 2E 00 69 00 6E 00 74 00 65 00 72 .b.a...i .n.t.e.r [0D0] 00 6E 00 2E 00 72 00 6B 00 2D 00 6B 00 6C 00 6F .n...r.k .-.k.l.o [0E0] 00 73 00 74 00 65 00 72 00 6E 00 65 00 75 00 62 .s.t.e.r .n.e.u.b [0F0] 00 75 00 72 00 67 00 2E 00 61 00 74 00 00 00 00 .u.r.g.. .a.t.... [100] 00 55 00 6E 00 69 00 78 00 00 00 53 00 61 00 6D .U.n.i.x ...S.a.m [110] 00 62 00 61 00 20 00 33 00 2E 00 30 00 2E 00 33 .b.a. .3 ...0...3 [120] 00 30 00 2D 00 32 00 6C 00 65 00 6F 00 2E 00 66 .0.-.2.l .e.o...f [130] 00 63 00 35 00 00 00 52 00 4B 00 5F 00 4B 00 4C .c.5...R .K._.K.L [140] 00 42 00 47 00 00 00 .B.G... [2008/06/20 11:54:42, 3] libsmb/ntlmssp.c:ntlmssp_client_challenge(1018) Got challenge flags: [2008/06/20 11:54:42, 3] libsmb/ntlmssp.c:debug_ntlmssp_flags(63) Got NTLMSSP neg_flags=0x60898215 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_CHAL_TARGET_INFO NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH [2008/06/20 11:54:42, 3] libsmb/ntlmssp.c:ntlmssp_client_challenge(1040) NTLMSSP: Set final flags: [2008/06/20 11:54:42, 3] libsmb/ntlmssp.c:debug_ntlmssp_flags(63) Got NTLMSSP neg_flags=0x60088215 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH [2008/06/20 11:54:42, 5] libsmb/ntlmssp.c:ntlmssp_client_challenge(1112) NTLMSSP challenge set by NTLM2 [2008/06/20 11:54:42, 5] libsmb/ntlmssp.c:ntlmssp_client_challenge(1113) challenge is: [2008/06/20 11:54:42, 5] lib/util.c:dump_data(2286) [000] BC 08 36 C4 39 B1 FB 00 ¼.6Ä9±û. [2008/06/20 11:54:42, 3] libsmb/ntlmssp_sign.c:ntlmssp_sign_init(338) NTLMSSP Sign/Seal - Initialising with flags: [2008/06/20 11:54:42, 3] libsmb/ntlmssp.c:debug_ntlmssp_flags(63) Got NTLMSSP neg_flags=0x60088215 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH [2008/06/20 11:54:42, 6] libsmb/clientgen.c:write_socket(152) write_socket(21,262) [2008/06/20 11:54:42, 6] libsmb/clientgen.c:write_socket(155) write_socket(21,262) wrote 262 [2008/06/20 11:54:52, 10] lib/util_sock.c:read_socket_with_timeout(476) read_socket_with_timeout: timeout read. select timed out. [2008/06/20 11:54:52, 10] lib/util_sock.c:receive_smb_raw(671) receive_smb_raw: length < 0! [2008/06/20 11:54:52, 10] libsmb/clientgen.c:client_receive_smb(64) client_receive_smb failed [2008/06/20 11:54:52, 5] lib/util.c:show_msg(506) [2008/06/20 11:54:52, 5] lib/util.c:show_msg(516) size=370 smb_com=0x73 smb_rcls=22 smb_reh=0 smb_err=49152 smb_flg=136 smb_flg2=51201 smb_tid=0 smb_pid=8195 smb_uid=100 smb_mid=2 smt_wct=4 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 257 (0x101) smb_bcc=327 [2008/06/20 11:54:52, 10] lib/util.c:dump_data(2286) [000] A1 81 FE 30 81 FB A0 03 0A 01 01 A1 0C 06 0A 2B ¡.þ0.û . ...¡...+ [010] 06 01 04 01 82 37 02 02 0A A2 81 E5 04 81 E2 4E .....7.. .¢.å..âN [020] 54 4C 4D 53 53 50 00 02 00 00 00 0E 00 0E 00 30 TLMSSP.. .......0 [030] 00 00 00 15 82 89 60 AE C4 99 8C AF 01 2B 85 00 ......`® Ä..¯.+.. [040] 00 00 00 00 00 00 00 A4 00 A4 00 3E 00 00 00 52 .......¤ .¤.>...R [050] 00 4B 00 5F 00 4B 00 4C 00 42 00 47 00 02 00 0E .K._.K.L .B.G.... [060] 00 52 00 4B 00 5F 00 4B 00 4C 00 42 00 47 00 01 .R.K._.K .L.B.G.. [070] 00 0A 00 53 00 41 00 4D 00 42 00 41 00 04 00 36 ...S.A.M .B.A...6 [080] 00 69 00 6E 00 74 00 65 00 72 00 6E 00 2E 00 72 .i.n.t.e .r.n...r [090] 00 6B 00 2D 00 6B 00 6C 00 6F 00 73 00 74 00 65 .k.-.k.l .o.s.t.e [0A0] 00 72 00 6E 00 65 00 75 00 62 00 75 00 72 00 67 .r.n.e.u .b.u.r.g [0B0] 00 2E 00 61 00 74 00 03 00 42 00 73 00 61 00 6D ...a.t.. .B.s.a.m [0C0] 00 62 00 61 00 2E 00 69 00 6E 00 74 00 65 00 72 .b.a...i .n.t.e.r [0D0] 00 6E 00 2E 00 72 00 6B 00 2D 00 6B 00 6C 00 6F .n...r.k .-.k.l.o [0E0] 00 73 00 74 00 65 00 72 00 6E 00 65 00 75 00 62 .s.t.e.r .n.e.u.b [0F0] 00 75 00 72 00 67 00 2E 00 61 00 74 00 00 00 00 .u.r.g.. .a.t.... [100] 00 55 00 6E 00 69 00 78 00 00 00 53 00 61 00 6D .U.n.i.x ...S.a.m [110] 00 62 00 61 00 20 00 33 00 2E 00 30 00 2E 00 33 .b.a. .3 ...0...3 [120] 00 30 00 2D 00 32 00 6C 00 65 00 6F 00 2E 00 66 .0.-.2.l .e.o...f [130] 00 63 00 35 00 00 00 52 00 4B 00 5F 00 4B 00 4C .c.5...R .K._.K.L [140] 00 42 00 47 00 00 00 .B.G... [2008/06/20 11:54:52, 0] libsmb/clientgen.c:cli_receive_smb(111) Receiving SMB: Server stopped responding [2008/06/20 11:54:52, 4] nsswitch/winbindd_cm.c:cm_prepare_connection(766) authenticated session setup failed with NT_STATUS_IO_TIMEOUT [2008/06/20 11:54:52, 3] nsswitch/winbindd_cm.c:cm_get_ipc_userpass(504) cm_get_ipc_userpass: Retrieved auth-user from secrets.tdb [RK_KLBG\smbadmin] [2008/06/20 11:54:52, 5] nsswitch/winbindd_cm.c:cm_prepare_connection(790) connecting to SAMBA from SAMBA with username [RK_KLBG]\[smbadmin] [2008/06/20 11:54:52, 3] libsmb/cliconnect.c:cli_session_setup_spnego(801) Doing spnego session setup (blob length=58) [2008/06/20 11:54:52, 3] libsmb/cliconnect.c:cli_session_setup_spnego(826) got OID=1 3 6 1 4 1 311 2 2 10 [2008/06/20 11:54:52, 3] libsmb/cliconnect.c:cli_session_setup_spnego(834) got principal=NONE [2008/06/20 11:54:52, 3] libsmb/cliconnect.c:cli_session_setup_ntlmssp(704) Failed to send NTLMSSP/SPNEGO blob to server! [2008/06/20 11:54:52, 3] libsmb/cliconnect.c:cli_session_setup(1014) SPNEGO login failed: Undetermined error [2008/06/20 11:54:52, 4] nsswitch/winbindd_cm.c:cm_prepare_connection(802) authenticated session setup with user RK_KLBG\smbadmin failed. [2008/06/20 11:54:52, 10] passdb/secrets.c:secrets_named_mutex_release(995) secrets_named_mutex: released mutex for SAMBA [2008/06/20 11:54:52, 10] libsmb/conncache.c:add_failed_connection_entry(118) add_failed_connection_entry: domain RK_KLBG (SAMBA) already tried and failed [2008/06/20 11:54:52, 10] lib/gencache.c:gencache_del(173) Deleting cache entry (key = SAF/DOMAIN/RK_KLBG) [2008/06/20 11:54:52, 10] nsswitch/winbindd_cm.c:set_domain_offline(302) set_domain_offline: called for domain RK_KLBG [2008/06/20 11:54:52, 10] lib/events.c:event_add_timed(129) Added timed event "check_domain_online_handler": 8089a550 [2008/06/20 11:54:52, 10] nsswitch/winbindd_cm.c:set_domain_offline(347) set_domain_offline: added event handler for domain RK_KLBG [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/999916 [2008/06/20 11:54:52, 10] lib/events.c:event_add_timed(129) Added timed event "async_request_timeout": 808abf98 [2008/06/20 11:54:52, 6] nsswitch/winbindd.c:new_connection(628) accepted socket 21 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/999716 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:54:52, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 5812]: sid to gid S-1-1-0 [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-1-0) [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:54:52, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-1-0 [2008/06/20 11:54:52, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-1-0 [2008/06/20 11:54:52, 6] nsswitch/winbindd.c:new_connection(628) accepted socket 22 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/999294 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn INTERFACE_VERSION [2008/06/20 11:54:52, 3] nsswitch/winbindd_misc.c:winbindd_interface_version(491) [ 8201]: request interface version [2008/06/20 11:54:52, 6] nsswitch/winbindd.c:new_connection(628) accepted socket 23 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/999055 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn INTERFACE_VERSION [2008/06/20 11:54:52, 3] nsswitch/winbindd_misc.c:winbindd_interface_version(491) [ 8206]: request interface version [2008/06/20 11:54:52, 10] lib/events.c:timed_event_destructor(66) Destroying timed event 808abf98 "async_request_timeout" [2008/06/20 11:54:52, 10] nsswitch/winbindd_cache.c:cache_retrieve_response(2307) Retrieving response for pid 8196 [2008/06/20 11:54:52, 6] nsswitch/winbindd.c:new_connection(628) accepted socket 24 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/998776 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn INTERFACE_VERSION [2008/06/20 11:54:52, 3] nsswitch/winbindd_misc.c:winbindd_interface_version(491) [ 8209]: request interface version [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:54:52, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 5812]: ping [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/998543 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn INTERFACE_VERSION [2008/06/20 11:54:52, 3] nsswitch/winbindd_misc.c:winbindd_interface_version(491) [ 8201]: request interface version [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/998414 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn WINBINDD_PRIV_PIPE_DIR [2008/06/20 11:54:52, 3] nsswitch/winbindd_misc.c:winbindd_priv_pipe_dir(524) [ 8206]: request location of privileged pipe [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/998233 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:54:52, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 5812]: sid to gid S-1-5-2 [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-5-2) [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:54:52, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-5-2 [2008/06/20 11:54:52, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-5-2 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/998000 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn WINBINDD_PRIV_PIPE_DIR [2008/06/20 11:54:52, 3] nsswitch/winbindd_misc.c:winbindd_priv_pipe_dir(524) [ 8201]: request location of privileged pipe [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn WINBINDD_PRIV_PIPE_DIR [2008/06/20 11:54:52, 3] nsswitch/winbindd_misc.c:winbindd_priv_pipe_dir(524) [ 8209]: request location of privileged pipe [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/997764 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/997680 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:54:52, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 5812]: ping [2008/06/20 11:54:52, 6] nsswitch/winbindd.c:new_connection(628) accepted socket 21 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/997404 [2008/06/20 11:54:52, 6] nsswitch/winbindd.c:new_connection(628) accepted socket 22 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/997271 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn GID_TO_SID [2008/06/20 11:54:52, 3] nsswitch/winbindd_sid.c:winbindd_gid_to_sid(477) [ 8206]: gid to sid 515 [2008/06/20 11:54:52, 6] nsswitch/winbindd.c:new_connection(628) accepted socket 23 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/996986 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:54:52, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 8201]: ping [2008/06/20 11:54:52, 10] lib/events.c:event_add_timed(129) Added timed event "async_request_timeout": 808abf98 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/996723 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn GID_TO_SID [2008/06/20 11:54:52, 3] nsswitch/winbindd_sid.c:winbindd_gid_to_sid(477) [ 8209]: gid to sid 515 [2008/06/20 11:54:52, 10] lib/events.c:timed_event_destructor(66) Destroying timed event 808abf98 "async_request_timeout" [2008/06/20 11:54:52, 10] nsswitch/winbindd_cache.c:cache_retrieve_response(2307) Retrieving response for pid 8200 [2008/06/20 11:54:52, 10] nsswitch/winbindd_sid.c:gid2sid_recv(462) gid2sid: gid 515 has sid S-1-5-21-181998944-1107627502-2274996074-515 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/995321 [2008/06/20 11:54:52, 10] lib/events.c:event_add_timed(129) Added timed event "async_request_timeout": 808abf98 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/995202 [2008/06/20 11:54:52, 10] lib/events.c:timed_event_destructor(66) Destroying timed event 808abf98 "async_request_timeout" [2008/06/20 11:54:52, 10] nsswitch/winbindd_cache.c:cache_retrieve_response(2307) Retrieving response for pid 8200 [2008/06/20 11:54:52, 10] nsswitch/winbindd_sid.c:gid2sid_recv(462) gid2sid: gid 515 has sid S-1-5-21-181998944-1107627502-2274996074-515 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/993333 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/992077 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/988326 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:54:52, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 8201]: sid to gid S-1-0-0 [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-0-0) [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:54:52, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-0-0 [2008/06/20 11:54:52, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-0-0 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/987903 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/987800 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/987435 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:54:52, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 8206]: sid to gid S-1-1-0 [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-1-0) [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:54:52, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-1-0 [2008/06/20 11:54:52, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-1-0 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/987080 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/987018 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/986885 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:54:52, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 8206]: ping [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/986731 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/986673 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/986555 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:54:52, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 8206]: sid to gid S-1-5-2 [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-5-2) [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:54:52, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-5-2 [2008/06/20 11:54:52, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-5-2 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/986253 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/986196 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/986094 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:54:52, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 8206]: ping [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/985948 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/985881 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/985723 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:54:52, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 8206]: sid to gid S-1-5-11 [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-5-11) [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:54:52, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-5-11 [2008/06/20 11:54:52, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-5-11 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/985211 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/985156 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/985028 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:54:52, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 8206]: ping [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/984884 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/984828 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/982221 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:54:52, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 8201]: ping [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/981983 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/981891 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/981793 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:54:52, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 8201]: sid to gid S-1-1-0 [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-1-0) [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:54:52, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-1-0 [2008/06/20 11:54:52, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-1-0 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/981476 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/981413 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/980945 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/979124 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:54:52, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 8201]: ping [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/978901 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/978835 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/978768 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:54:52, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 8201]: sid to gid S-1-5-2 [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-5-2) [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:54:52, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-5-2 [2008/06/20 11:54:52, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-5-2 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/978470 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/978402 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/978338 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:54:52, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 8201]: ping [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/978206 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/978120 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/978056 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:54:52, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 8201]: sid to gid S-1-5-11 [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-5-11) [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:54:52, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-5-11 [2008/06/20 11:54:52, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-5-11 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/977757 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/977692 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/977581 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:54:52, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 8201]: ping [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/977424 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/977352 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/977004 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:54:52, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 8209]: sid to gid S-1-1-0 [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-1-0) [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:54:52, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-1-0 [2008/06/20 11:54:52, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-1-0 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/976579 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/976505 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/976360 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:54:52, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 8209]: ping [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/976182 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/976109 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/975960 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:54:52, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 8209]: sid to gid S-1-5-2 [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-5-2) [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:54:52, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-5-2 [2008/06/20 11:54:52, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-5-2 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/975545 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/975430 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/975286 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:54:52, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 8209]: ping [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/975139 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/975082 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/974959 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:54:52, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 8209]: sid to gid S-1-5-11 [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-5-11) [2008/06/20 11:54:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:54:52, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-5-11 [2008/06/20 11:54:52, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-5-11 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/974611 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/974296 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/974175 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/973992 [2008/06/20 11:54:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:54:52, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 8209]: ping [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/973795 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/973725 [2008/06/20 11:54:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 299/970314 [2008/06/20 11:55:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 284/936105 [2008/06/20 11:55:07, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:55:07, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 5812]: sid to gid S-1-1-0 [2008/06/20 11:55:07, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-1-0) [2008/06/20 11:55:07, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:55:07, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-1-0 [2008/06/20 11:55:07, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-1-0 [2008/06/20 11:55:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 284/935814 [2008/06/20 11:55:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 284/935768 [2008/06/20 11:55:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 284/935717 [2008/06/20 11:55:07, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:55:07, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 5812]: ping [2008/06/20 11:55:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 284/935608 [2008/06/20 11:55:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 284/935564 [2008/06/20 11:55:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 284/935512 [2008/06/20 11:55:07, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:55:07, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 5812]: sid to gid S-1-5-2 [2008/06/20 11:55:07, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-5-2) [2008/06/20 11:55:07, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:55:07, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-5-2 [2008/06/20 11:55:07, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-5-2 [2008/06/20 11:55:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 284/935279 [2008/06/20 11:55:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 284/935234 [2008/06/20 11:55:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 284/935185 [2008/06/20 11:55:07, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:55:07, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 5812]: ping [2008/06/20 11:55:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 284/935048 [2008/06/20 11:55:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 284/935002 [2008/06/20 11:55:22, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 269/902152 [2008/06/20 11:55:22, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:55:22, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 5812]: sid to gid S-1-1-0 [2008/06/20 11:55:22, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-1-0) [2008/06/20 11:55:22, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:55:22, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-1-0 [2008/06/20 11:55:22, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-1-0 [2008/06/20 11:55:22, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 269/901879 [2008/06/20 11:55:22, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 269/901830 [2008/06/20 11:55:22, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 269/901774 [2008/06/20 11:55:22, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:55:22, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 5812]: ping [2008/06/20 11:55:22, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 269/901676 [2008/06/20 11:55:22, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 269/901633 [2008/06/20 11:55:22, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 269/901582 [2008/06/20 11:55:22, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:55:22, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 5812]: sid to gid S-1-5-2 [2008/06/20 11:55:22, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-5-2) [2008/06/20 11:55:22, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:55:22, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-5-2 [2008/06/20 11:55:22, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-5-2 [2008/06/20 11:55:22, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 269/901376 [2008/06/20 11:55:22, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 269/901334 [2008/06/20 11:55:22, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 269/901286 [2008/06/20 11:55:22, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:55:22, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 5812]: ping [2008/06/20 11:55:22, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 269/901160 [2008/06/20 11:55:22, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 269/901116 [2008/06/20 11:55:37, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 254/870176 [2008/06/20 11:55:37, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:55:37, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 5812]: sid to gid S-1-1-0 [2008/06/20 11:55:37, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-1-0) [2008/06/20 11:55:37, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:55:37, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-1-0 [2008/06/20 11:55:37, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-1-0 [2008/06/20 11:55:37, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 254/869901 [2008/06/20 11:55:37, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 254/869856 [2008/06/20 11:55:37, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 254/869805 [2008/06/20 11:55:37, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:55:37, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 5812]: ping [2008/06/20 11:55:37, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 254/869706 [2008/06/20 11:55:37, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 254/869663 [2008/06/20 11:55:37, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 254/869612 [2008/06/20 11:55:37, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:55:37, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 5812]: sid to gid S-1-5-2 [2008/06/20 11:55:37, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-5-2) [2008/06/20 11:55:37, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:55:37, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-5-2 [2008/06/20 11:55:37, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-5-2 [2008/06/20 11:55:37, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 254/869407 [2008/06/20 11:55:37, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 254/869364 [2008/06/20 11:55:37, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 254/869315 [2008/06/20 11:55:37, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:55:37, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 5812]: ping [2008/06/20 11:55:37, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 254/869215 [2008/06/20 11:55:37, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 254/869172 [2008/06/20 11:55:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 239/837618 [2008/06/20 11:55:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:55:52, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 5812]: sid to gid S-1-1-0 [2008/06/20 11:55:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-1-0) [2008/06/20 11:55:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:55:52, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-1-0 [2008/06/20 11:55:52, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-1-0 [2008/06/20 11:55:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 239/837309 [2008/06/20 11:55:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 239/837261 [2008/06/20 11:55:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 239/837206 [2008/06/20 11:55:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:55:52, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 5812]: ping [2008/06/20 11:55:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 239/837106 [2008/06/20 11:55:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 239/837056 [2008/06/20 11:55:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 239/837004 [2008/06/20 11:55:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:55:52, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 5812]: sid to gid S-1-5-2 [2008/06/20 11:55:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-5-2) [2008/06/20 11:55:52, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:55:52, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-5-2 [2008/06/20 11:55:52, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-5-2 [2008/06/20 11:55:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 239/836798 [2008/06/20 11:55:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 239/836755 [2008/06/20 11:55:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 239/836707 [2008/06/20 11:55:52, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:55:52, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 5812]: ping [2008/06/20 11:55:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 239/836610 [2008/06/20 11:55:52, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 239/836568 [2008/06/20 11:56:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 224/804617 [2008/06/20 11:56:07, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:56:07, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 5812]: sid to gid S-1-1-0 [2008/06/20 11:56:07, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-1-0) [2008/06/20 11:56:07, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:56:07, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-1-0 [2008/06/20 11:56:07, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-1-0 [2008/06/20 11:56:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 224/804338 [2008/06/20 11:56:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 224/804291 [2008/06/20 11:56:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 224/804240 [2008/06/20 11:56:07, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:56:07, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 5812]: ping [2008/06/20 11:56:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 224/804134 [2008/06/20 11:56:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 224/804089 [2008/06/20 11:56:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 224/804036 [2008/06/20 11:56:07, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn SID_TO_GID [2008/06/20 11:56:07, 3] nsswitch/winbindd_sid.c:winbindd_sid_to_gid(308) [ 5812]: sid to gid S-1-5-2 [2008/06/20 11:56:07, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(680) find_lookup_domain_from_sid(S-1-5-2) [2008/06/20 11:56:07, 10] nsswitch/winbindd_util.c:find_lookup_domain_from_sid(683) calling find_domain_from_sid [2008/06/20 11:56:07, 5] nsswitch/winbindd_async.c:winbindd_lookupsid_async(729) Could not find domain for sid S-1-5-2 [2008/06/20 11:56:07, 5] nsswitch/winbindd_sid.c:sid2gid_lookupsid_recv(274) sid2gid_lookupsid_recv: Could not convert get sid type for S-1-5-2 [2008/06/20 11:56:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 224/803810 [2008/06/20 11:56:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 224/803766 [2008/06/20 11:56:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 224/803718 [2008/06/20 11:56:07, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn PING [2008/06/20 11:56:07, 3] nsswitch/winbindd_misc.c:winbindd_ping(470) [ 5812]: ping [2008/06/20 11:56:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 224/803618 [2008/06/20 11:56:07, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 224/803574 [2008/06/20 11:56:14, 6] nsswitch/winbindd.c:new_connection(628) accepted socket 21 [2008/06/20 11:56:14, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 217/711587 [2008/06/20 11:56:14, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 217/711541 [2008/06/20 11:56:14, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn INTERFACE_VERSION [2008/06/20 11:56:14, 3] nsswitch/winbindd_misc.c:winbindd_interface_version(491) [ 8222]: request interface version [2008/06/20 11:56:14, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 217/711423 [2008/06/20 11:56:14, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 217/711376 [2008/06/20 11:56:14, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 217/711324 [2008/06/20 11:56:14, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn WINBINDD_PRIV_PIPE_DIR [2008/06/20 11:56:14, 3] nsswitch/winbindd_misc.c:winbindd_priv_pipe_dir(524) [ 8222]: request location of privileged pipe [2008/06/20 11:56:14, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 217/711204 [2008/06/20 11:56:14, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 217/711156 [2008/06/20 11:56:14, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 217/711105 [2008/06/20 11:56:14, 6] nsswitch/winbindd.c:new_connection(628) accepted socket 22 [2008/06/20 11:56:14, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 217/710967 [2008/06/20 11:56:14, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 217/710917 [2008/06/20 11:56:14, 10] nsswitch/winbindd.c:process_request(314) process_request: request fn LIST_GROUPS [2008/06/20 11:56:14, 3] nsswitch/winbindd_group.c:winbindd_list_groups(1162) [ 8222]: list groups [2008/06/20 11:56:14, 4] nsswitch/winbindd_group.c:get_sam_group_entries(854) get_sam_group_entries: BUILTIN or local domain; enumerating local groups as well [2008/06/20 11:56:14, 5] passdb/pdb_interface.c:smb_register_passdb(68) Attempting to register passdb backend ldapsam [2008/06/20 11:56:14, 5] passdb/pdb_interface.c:smb_register_passdb(81) Successfully added passdb backend 'ldapsam' [2008/06/20 11:56:14, 5] passdb/pdb_interface.c:smb_register_passdb(68) Attempting to register passdb backend ldapsam_compat [2008/06/20 11:56:14, 5] passdb/pdb_interface.c:smb_register_passdb(81) Successfully added passdb backend 'ldapsam_compat' [2008/06/20 11:56:14, 5] passdb/pdb_interface.c:smb_register_passdb(68) Attempting to register passdb backend NDS_ldapsam [2008/06/20 11:56:14, 5] passdb/pdb_interface.c:smb_register_passdb(81) Successfully added passdb backend 'NDS_ldapsam' [2008/06/20 11:56:14, 5] passdb/pdb_interface.c:smb_register_passdb(68) Attempting to register passdb backend NDS_ldapsam_compat [2008/06/20 11:56:14, 5] passdb/pdb_interface.c:smb_register_passdb(81) Successfully added passdb backend 'NDS_ldapsam_compat' [2008/06/20 11:56:14, 5] passdb/pdb_interface.c:smb_register_passdb(68) Attempting to register passdb backend smbpasswd [2008/06/20 11:56:14, 5] passdb/pdb_interface.c:smb_register_passdb(81) Successfully added passdb backend 'smbpasswd' [2008/06/20 11:56:14, 5] passdb/pdb_interface.c:smb_register_passdb(68) Attempting to register passdb backend tdbsam [2008/06/20 11:56:14, 5] passdb/pdb_interface.c:smb_register_passdb(81) Successfully added passdb backend 'tdbsam' [2008/06/20 11:56:14, 5] passdb/pdb_interface.c:make_pdb_method_name(121) Attempting to find an passdb backend to match ldapsam:ldap://ldap-master.intern.rk-klosterneuburg.at/ (ldapsam) [2008/06/20 11:56:14, 5] passdb/pdb_interface.c:make_pdb_method_name(142) Found pdb backend ldapsam [2008/06/20 11:56:14, 2] lib/smbldap_util.c:smbldap_search_domain_info(256) smbldap_search_domain_info: Searching for:[(&(objectClass=sambaDomain)(sambaDomainName=RK_KLBG))] [2008/06/20 11:56:14, 5] lib/smbldap.c:smbldap_search_ext(1182) smbldap_search_ext: base => [dc=rk-klbg,dc=at], filter => [(&(objectClass=sambaDomain)(sambaDomainName=RK_KLBG))], scope => [2] [2008/06/20 11:56:14, 5] lib/smbldap.c:smbldap_close(1085) The connection to the LDAP server was closed [2008/06/20 11:56:14, 10] lib/smbldap.c:smb_ldap_setup_conn(630) smb_ldap_setup_connection: ldap://ldap-master.intern.rk-klosterneuburg.at/ [2008/06/20 11:56:14, 2] lib/smbldap.c:smbldap_open_connection(786) smbldap_open_connection: connection opened [2008/06/20 11:56:14, 10] lib/smbldap.c:smbldap_connect_system(951) ldap_connect_system: Binding to ldap server ldap://ldap-master.intern.rk-klosterneuburg.at/ as "cn=Manager,dc=rk-klbg,dc=at" [2008/06/20 11:56:14, 3] lib/smbldap.c:smbldap_connect_system(997) ldap_connect_system: successful connection to the LDAP server ldap_connect_system: LDAP server does support paged results [2008/06/20 11:56:14, 4] lib/smbldap.c:smbldap_open(1065) The LDAP server is successfully connected [2008/06/20 11:56:14, 5] passdb/pdb_interface.c:make_pdb_method_name(153) pdb backend ldapsam:ldap://ldap-master.intern.rk-klosterneuburg.at/ has a valid init [2008/06/20 11:56:14, 3] lib/smbldap.c:smbldap_search_paged(1294) smbldap_search_paged: base => [ou=Groups,dc=rk-klbg,dc=at], filter => [(&(objectclass=sambaGroupMapping)(sambaGroupType=4)(sambaSID=S-1-5-32*))],scope => [2], pagesize => [1024] [2008/06/20 11:56:14, 5] lib/smbldap.c:smbldap_search_ext(1182) smbldap_search_ext: base => [ou=Groups,dc=rk-klbg,dc=at], filter => [(&(objectclass=sambaGroupMapping)(sambaGroupType=4)(sambaSID=S-1-5-32*))], scope => [2] [2008/06/20 11:56:14, 3] lib/smbldap.c:smbldap_search_paged(1333) smbldap_search_paged: search was successfull [2008/06/20 11:56:14, 3] nsswitch/winbindd_group.c:get_sam_group_entries(859) get_sam_group_entries: Failed to enumerate domain local groups! [2008/06/20 11:56:14, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 217/703546 [2008/06/20 11:56:14, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 217/703467 [2008/06/20 11:56:14, 10] lib/events.c:get_timed_events_timeout(295) timed_events_timeout: 217/702758 [2008/06/20 11:56:18, 5] lib/gencache.c:gencache_shutdown(94) Closing cache file