[2010/05/27 23:19:18, 5] lib/debug.c:405(debug_dump_status) 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 registry: False/0 [2010/05/27 23:19:18, 3] param/loadparm.c:9158(lp_load_ex) lp_load_ex: refreshing parameters [2010/05/27 23:19:18, 3] param/loadparm.c:4929(init_globals) Initialising global parameters [2010/05/27 23:19:18, 2] param/loadparm.c:4788(max_open_files) rlimit_max: rlimit_max (1024) below minimum Windows limit (16384) [2010/05/27 23:19:18.339611, 3] ../lib/util/params.c:550(pm_process) params.c:pm_process() - Processing configuration file "/etc/samba/smb.conf" [2010/05/27 23:19:18.339639, 3] param/loadparm.c:7842(do_section) Processing section "[global]" doing parameter workgroup = SAMBA4 doing parameter netbios name = SMBFSVZ01 [2010/05/27 23:19:18.339665, 4] param/loadparm.c:7204(handle_netbios_name) handle_netbios_name: set global_myname to: SMBFSVZ01 doing parameter realm = smb4.tst doing parameter security = ADS doing parameter encrypt passwords = true doing parameter password server = * doing parameter browseable = yes doing parameter log level = 2 doing parameter server string = %h server doing parameter dns proxy = no doing parameter interfaces = 127.0.0.0/8 eth0 doing parameter log file = /var/log/samba/log.%m doing parameter max log size = 1000 doing parameter syslog = 0 doing parameter panic action = /usr/share/samba/panic-action %d doing parameter obey pam restrictions = yes doing parameter unix password sync = no doing parameter passwd program = /usr/bin/passwd %u doing parameter passwd chat = *Enter\snew\s*\spassword:* %n\n *Retype\snew\s*\spassword:* %n\n *password\supdated\ssuccessfully* . doing parameter pam password change = yes doing parameter load printers = yes doing parameter printing = cups doing parameter printcap name = cups doing parameter template shell = /bin/bash doing parameter idmap config SAMBA4: default = yes doing parameter idmap config SAMBA4: backend = rid doing parameter idmap config SAMBA4: range = 10000-20000 doing parameter idmap uid = 10000-20000 doing parameter idmap gid = 10002-20000 doing parameter winbind enum groups = yes doing parameter winbind use default domain = yes doing parameter winbind enum users = yes doing parameter allow trusted domains = No [2010/05/27 23:19:18.340021, 4] param/loadparm.c:9193(lp_load_ex) pm_process() returned Yes [2010/05/27 23:19:18.340035, 7] param/loadparm.c:9399(lp_servicenumber) lp_servicenumber: couldn't find homes [2010/05/27 23:19:18.340048, 10] param/loadparm.c:8403(set_server_role) set_server_role: role = ROLE_DOMAIN_MEMBER [2010/05/27 23:19:18.340063, 5] lib/iconv.c:104(smb_register_charset) Attempting to register new charset UCS-2LE [2010/05/27 23:19:18.340075, 5] lib/iconv.c:112(smb_register_charset) Registered charset UCS-2LE [2010/05/27 23:19:18.340084, 5] lib/iconv.c:104(smb_register_charset) Attempting to register new charset UTF-16LE [2010/05/27 23:19:18.340097, 5] lib/iconv.c:112(smb_register_charset) Registered charset UTF-16LE [2010/05/27 23:19:18.340107, 5] lib/iconv.c:104(smb_register_charset) Attempting to register new charset UCS-2BE [2010/05/27 23:19:18.340116, 5] lib/iconv.c:112(smb_register_charset) Registered charset UCS-2BE [2010/05/27 23:19:18.340125, 5] lib/iconv.c:104(smb_register_charset) Attempting to register new charset UTF-16BE [2010/05/27 23:19:18.340134, 5] lib/iconv.c:112(smb_register_charset) Registered charset UTF-16BE [2010/05/27 23:19:18.340143, 5] lib/iconv.c:104(smb_register_charset) Attempting to register new charset UTF8 [2010/05/27 23:19:18.340153, 5] lib/iconv.c:112(smb_register_charset) Registered charset UTF8 [2010/05/27 23:19:18.340167, 5] lib/iconv.c:104(smb_register_charset) Attempting to register new charset UTF-8 [2010/05/27 23:19:18.340177, 5] lib/iconv.c:112(smb_register_charset) Registered charset UTF-8 [2010/05/27 23:19:18.340186, 5] lib/iconv.c:104(smb_register_charset) Attempting to register new charset ASCII [2010/05/27 23:19:18.340198, 5] lib/iconv.c:112(smb_register_charset) Registered charset ASCII [2010/05/27 23:19:18.340211, 5] lib/iconv.c:104(smb_register_charset) Attempting to register new charset 646 [2010/05/27 23:19:18.340223, 5] lib/iconv.c:112(smb_register_charset) Registered charset 646 [2010/05/27 23:19:18.340232, 5] lib/iconv.c:104(smb_register_charset) Attempting to register new charset ISO-8859-1 [2010/05/27 23:19:18.340241, 5] lib/iconv.c:112(smb_register_charset) Registered charset ISO-8859-1 [2010/05/27 23:19:18.340250, 5] lib/iconv.c:104(smb_register_charset) Attempting to register new charset UCS2-HEX [2010/05/27 23:19:18.340260, 5] lib/iconv.c:112(smb_register_charset) Registered charset UCS2-HEX [2010/05/27 23:19:18.340283, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.340407, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.340435, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.340451, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.340466, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.340480, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.340495, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.340515, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.340531, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.340547, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.340576, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.340621, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.340647, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.340673, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.340712, 5] lib/util.c:276(init_names) Netbios name list:- my_netbios_names[0]="SMBFSVZ01" [2010/05/27 23:19:18.340812, 2] lib/interface.c:463(interpret_interface) interpret_interface: using netmask value 8 from config file on interface lo [2010/05/27 23:19:18.340825, 2] lib/interface.c:340(add_interface) added interface lo ip=127.0.0.1 bcast=127.255.255.255 netmask=255.0.0.0 [2010/05/27 23:19:18.340849, 2] lib/interface.c:340(add_interface) added interface eth0 ip=fe80::216:3eff:fe53:7324%eth0 bcast=fe80::ffff:ffff:ffff:ffff%eth0 netmask=ffff:ffff:ffff:ffff:: [2010/05/27 23:19:18.340903, 2] lib/interface.c:340(add_interface) added interface eth0 ip=192.168.99.9 bcast=192.168.99.255 netmask=255.255.255.0 [2010/05/27 23:19:18.340943, 6] libads/ldap.c:359(ads_find_dc) ads_find_dc: (ldap) looking for realm 'SMB4.TST' [2010/05/27 23:19:18.340978, 5] lib/gencache.c:65(gencache_init) Opening cache file at /var/run/samba/gencache.tdb [2010/05/27 23:19:18.341047, 5] lib/gencache.c:108(gencache_init) Opening cache file at /var/run/samba/gencache_notrans.tdb [2010/05/27 23:19:18.341127, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = AD_SITENAME/DOMAIN/SMB4.TST, value = Default-First-Site-Name, timeout = Tue Jan 19 06:14:07 2038 [2010/05/27 23:19:18.341166, 5] libads/dns.c:810(sitename_fetch) sitename_fetch: Returning sitename for SMB4.TST: "Default-First-Site-Name" [2010/05/27 23:19:18.341181, 4] libsmb/namequery_dc.c:73(ads_dc_name) ads_dc_name: domain=SAMBA4 [2010/05/27 23:19:18.341203, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = AD_SITENAME/DOMAIN/SMB4.TST, value = Default-First-Site-Name, timeout = Tue Jan 19 06:14:07 2038 [2010/05/27 23:19:18.341223, 5] libads/dns.c:810(sitename_fetch) sitename_fetch: Returning sitename for SMB4.TST: "Default-First-Site-Name" [2010/05/27 23:19:18.341234, 6] libads/ldap.c:379(ads_find_dc) ads_find_dc: (cldap) looking for realm 'SMB4.TST' [2010/05/27 23:19:18.341245, 8] libsmb/namequery.c:2071(get_sorted_dc_list) get_sorted_dc_list: attempting lookup for name SMB4.TST (sitename Default-First-Site-Name) using [ads] [2010/05/27 23:19:18.341268, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = SAFJOIN/DOMAIN/SMB4.TST, value = test.smb4.tst, timeout = Fri May 28 00:10:59 2010 [2010/05/27 23:19:18.341285, 5] libsmb/namequery.c:173(saf_fetch) saf_fetch[join]: Returning "test.smb4.tst" for "SMB4.TST" domain [2010/05/27 23:19:18.341297, 3] libsmb/namequery.c:1880(get_dc_list) get_dc_list: preferred server list: "test.smb4.tst, *" [2010/05/27 23:19:18.341310, 10] libsmb/namequery.c:1400(internal_resolve_name) internal_resolve_name: looking up SMB4.TST#1c (sitename Default-First-Site-Name) [2010/05/27 23:19:18.341331, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = NBT/SMB4.TST#1C, value = 192.168.99.2:389, timeout = Thu May 27 23:19:20 2010 [2010/05/27 23:19:18.341347, 5] libsmb/namecache.c:192(namecache_fetch) name SMB4.TST#1C found. [2010/05/27 23:19:18.341377, 8] libsmb/namequery.c:1901(get_dc_list) Adding 1 DC's from auto lookup [2010/05/27 23:19:18.341398, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = AD_SITENAME/DOMAIN/SMB4.TST, value = Default-First-Site-Name, timeout = Tue Jan 19 06:14:07 2038 [2010/05/27 23:19:18.341419, 5] libads/dns.c:810(sitename_fetch) sitename_fetch: Returning sitename for SMB4.TST: "Default-First-Site-Name" [2010/05/27 23:19:18.341430, 10] libsmb/namequery.c:1400(internal_resolve_name) internal_resolve_name: looking up test.smb4.tst#20 (sitename Default-First-Site-Name) [2010/05/27 23:19:18.341445, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = NBT/TEST.SMB4.TST#20, value = 192.168.99.2:0, timeout = Thu May 27 23:19:20 2010 [2010/05/27 23:19:18.341461, 5] libsmb/namecache.c:192(namecache_fetch) name test.smb4.tst#20 found. [2010/05/27 23:19:18.341494, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = NEG_CONN_CACHE/SMB4.TST,192.168.99.2 couldn't be found [2010/05/27 23:19:18.341505, 9] libsmb/conncache.c:150(check_negative_conn_cache) check_negative_conn_cache returning result 0 for domain SMB4.TST server 192.168.99.2 [2010/05/27 23:19:18.341523, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = NEG_CONN_CACHE/SMB4.TST,192.168.99.2 couldn't be found [2010/05/27 23:19:18.341533, 9] libsmb/conncache.c:150(check_negative_conn_cache) check_negative_conn_cache returning result 0 for domain SMB4.TST server 192.168.99.2 [2010/05/27 23:19:18.341548, 10] libsmb/namequery.c:572(remove_duplicate_addrs2) remove_duplicate_addrs2: looking for duplicate address/port pairs [2010/05/27 23:19:18.341559, 4] libsmb/namequery.c:2020(get_dc_list) get_dc_list: returning 1 ip addresses in an ordered list [2010/05/27 23:19:18.341568, 4] libsmb/namequery.c:2021(get_dc_list) get_dc_list: 192.168.99.2:389 [2010/05/27 23:19:18.341586, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = NEG_CONN_CACHE/SMB4.TST,192.168.99.2 couldn't be found [2010/05/27 23:19:18.341596, 9] libsmb/conncache.c:150(check_negative_conn_cache) check_negative_conn_cache returning result 0 for domain SMB4.TST server 192.168.99.2 [2010/05/27 23:19:18.341608, 5] libads/ldap.c:226(ads_try_connect) ads_try_connect: sending CLDAP request to 192.168.99.2 (realm: SMB4.TST) [2010/05/27 23:19:18.342824, 10] libads/dns.c:775(sitename_store) sitename_store: realm = [SAMBA4], sitename = [Default-First-Site-Name], expire = [2147483647] [2010/05/27 23:19:18.342849, 10] lib/gencache.c:180(gencache_set_data_blob) Adding cache entry with key = AD_SITENAME/DOMAIN/SAMBA4 and timeout = Tue Jan 19 06:14:07 2038 (872495689 seconds ahead) [2010/05/27 23:19:18.409884, 10] libads/dns.c:775(sitename_store) sitename_store: realm = [smb4.tst], sitename = [Default-First-Site-Name], expire = [2147483647] [2010/05/27 23:19:18.409908, 10] lib/gencache.c:180(gencache_set_data_blob) Adding cache entry with key = AD_SITENAME/DOMAIN/SMB4.TST and timeout = Tue Jan 19 06:14:07 2038 (872495689 seconds ahead) [2010/05/27 23:19:18.409960, 3] libads/ldap.c:634(ads_connect) Successfully contacted LDAP server 192.168.99.2 [2010/05/27 23:19:18.409984, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = AD_SITENAME/DOMAIN/SMB4.TST, value = Default-First-Site-Name, timeout = Tue Jan 19 06:14:07 2038 [2010/05/27 23:19:18.410015, 5] libads/dns.c:810(sitename_fetch) sitename_fetch: Returning sitename for SMB4.TST: "Default-First-Site-Name" [2010/05/27 23:19:18.410037, 10] libads/ldap.c:165(ads_closest_dc) ads_closest_dc: NBT_SERVER_CLOSEST flag set [2010/05/27 23:19:18.410075, 10] libads/kerberos.c:910(create_local_private_krb5_conf_for_domain) create_local_private_krb5_conf_for_domain: fname = /var/run/samba/smb_krb5/krb5.conf.SAMBA4, realm = SMB4.TST, domain = SAMBA4 [2010/05/27 23:19:18.410107, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = SAFJOIN/DOMAIN/SMB4.TST, value = test.smb4.tst, timeout = Fri May 28 00:10:59 2010 [2010/05/27 23:19:18.410135, 5] libsmb/namequery.c:173(saf_fetch) saf_fetch[join]: Returning "test.smb4.tst" for "SMB4.TST" domain [2010/05/27 23:19:18.410147, 3] libsmb/namequery.c:1880(get_dc_list) get_dc_list: preferred server list: "test.smb4.tst, *" [2010/05/27 23:19:18.410158, 10] libsmb/namequery.c:1400(internal_resolve_name) internal_resolve_name: looking up SMB4.TST#1c (sitename Default-First-Site-Name) [2010/05/27 23:19:18.410173, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = NBT/SMB4.TST#1C, value = 192.168.99.2:389, timeout = Thu May 27 23:19:20 2010 [2010/05/27 23:19:18.410190, 5] libsmb/namecache.c:192(namecache_fetch) name SMB4.TST#1C found. [2010/05/27 23:19:18.410216, 8] libsmb/namequery.c:1901(get_dc_list) Adding 1 DC's from auto lookup [2010/05/27 23:19:18.410233, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = AD_SITENAME/DOMAIN/SMB4.TST, value = Default-First-Site-Name, timeout = Tue Jan 19 06:14:07 2038 [2010/05/27 23:19:18.410254, 5] libads/dns.c:810(sitename_fetch) sitename_fetch: Returning sitename for SMB4.TST: "Default-First-Site-Name" [2010/05/27 23:19:18.410265, 10] libsmb/namequery.c:1400(internal_resolve_name) internal_resolve_name: looking up test.smb4.tst#20 (sitename Default-First-Site-Name) [2010/05/27 23:19:18.410281, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = NBT/TEST.SMB4.TST#20, value = 192.168.99.2:0, timeout = Thu May 27 23:19:20 2010 [2010/05/27 23:19:18.410297, 5] libsmb/namecache.c:192(namecache_fetch) name test.smb4.tst#20 found. [2010/05/27 23:19:18.410328, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = NEG_CONN_CACHE/SMB4.TST,192.168.99.2 couldn't be found [2010/05/27 23:19:18.410339, 9] libsmb/conncache.c:150(check_negative_conn_cache) check_negative_conn_cache returning result 0 for domain SMB4.TST server 192.168.99.2 [2010/05/27 23:19:18.410356, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = NEG_CONN_CACHE/SMB4.TST,192.168.99.2 couldn't be found [2010/05/27 23:19:18.410366, 9] libsmb/conncache.c:150(check_negative_conn_cache) check_negative_conn_cache returning result 0 for domain SMB4.TST server 192.168.99.2 [2010/05/27 23:19:18.410376, 10] libsmb/namequery.c:572(remove_duplicate_addrs2) remove_duplicate_addrs2: looking for duplicate address/port pairs [2010/05/27 23:19:18.410386, 4] libsmb/namequery.c:2020(get_dc_list) get_dc_list: returning 1 ip addresses in an ordered list [2010/05/27 23:19:18.410400, 4] libsmb/namequery.c:2021(get_dc_list) get_dc_list: 192.168.99.2:389 [2010/05/27 23:19:18.410420, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = SAFJOIN/DOMAIN/SMB4.TST, value = test.smb4.tst, timeout = Fri May 28 00:10:59 2010 [2010/05/27 23:19:18.410437, 5] libsmb/namequery.c:173(saf_fetch) saf_fetch[join]: Returning "test.smb4.tst" for "SMB4.TST" domain [2010/05/27 23:19:18.410449, 3] libsmb/namequery.c:1880(get_dc_list) get_dc_list: preferred server list: "test.smb4.tst, *" [2010/05/27 23:19:18.410459, 10] libsmb/namequery.c:1400(internal_resolve_name) internal_resolve_name: looking up SMB4.TST#1c (sitename (null)) [2010/05/27 23:19:18.410474, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = NBT/SMB4.TST#1C, value = 192.168.99.2:389, timeout = Thu May 27 23:19:20 2010 [2010/05/27 23:19:18.410490, 5] libsmb/namecache.c:192(namecache_fetch) name SMB4.TST#1C found. [2010/05/27 23:19:18.410514, 8] libsmb/namequery.c:1901(get_dc_list) Adding 1 DC's from auto lookup [2010/05/27 23:19:18.410530, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = AD_SITENAME/DOMAIN/SMB4.TST, value = Default-First-Site-Name, timeout = Tue Jan 19 06:14:07 2038 [2010/05/27 23:19:18.410551, 5] libads/dns.c:810(sitename_fetch) sitename_fetch: Returning sitename for SMB4.TST: "Default-First-Site-Name" [2010/05/27 23:19:18.410562, 10] libsmb/namequery.c:1400(internal_resolve_name) internal_resolve_name: looking up test.smb4.tst#20 (sitename Default-First-Site-Name) [2010/05/27 23:19:18.410577, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = NBT/TEST.SMB4.TST#20, value = 192.168.99.2:0, timeout = Thu May 27 23:19:20 2010 [2010/05/27 23:19:18.410593, 5] libsmb/namecache.c:192(namecache_fetch) name test.smb4.tst#20 found. [2010/05/27 23:19:18.410623, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = NEG_CONN_CACHE/SMB4.TST,192.168.99.2 couldn't be found [2010/05/27 23:19:18.410635, 9] libsmb/conncache.c:150(check_negative_conn_cache) check_negative_conn_cache returning result 0 for domain SMB4.TST server 192.168.99.2 [2010/05/27 23:19:18.410652, 10] lib/gencache.c:334(gencache_get_data_blob) Cache entry with key = NEG_CONN_CACHE/SMB4.TST,192.168.99.2 couldn't be found [2010/05/27 23:19:18.410662, 9] libsmb/conncache.c:150(check_negative_conn_cache) check_negative_conn_cache returning result 0 for domain SMB4.TST server 192.168.99.2 [2010/05/27 23:19:18.410672, 10] libsmb/namequery.c:572(remove_duplicate_addrs2) remove_duplicate_addrs2: looking for duplicate address/port pairs [2010/05/27 23:19:18.410682, 4] libsmb/namequery.c:2020(get_dc_list) get_dc_list: returning 1 ip addresses in an ordered list [2010/05/27 23:19:18.410692, 4] libsmb/namequery.c:2021(get_dc_list) get_dc_list: 192.168.99.2:389 [2010/05/27 23:19:18.410703, 10] libads/kerberos.c:856(get_kdc_ip_string) get_kdc_ip_string: Returning kdc = 192.168.99.2 [2010/05/27 23:19:18.410790, 5] libads/kerberos.c:978(create_local_private_krb5_conf_for_domain) create_local_private_krb5_conf_for_domain: wrote file /var/run/samba/smb_krb5/krb5.conf.SAMBA4 with realm SMB4.TST KDC list = kdc = 192.168.99.2 [2010/05/27 23:19:18.410810, 4] libsmb/namequery_dc.c:143(ads_dc_name) ads_dc_name: using server='TEST.SMB4.TST' IP=192.168.99.2 [2010/05/27 23:19:18.410826, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = AD_SITENAME/DOMAIN/SMB4.TST, value = Default-First-Site-Name, timeout = Tue Jan 19 06:14:07 2038 [2010/05/27 23:19:18.410848, 5] libads/dns.c:810(sitename_fetch) sitename_fetch: Returning sitename for SMB4.TST: "Default-First-Site-Name" [2010/05/27 23:19:18.410859, 10] libsmb/namequery.c:1400(internal_resolve_name) internal_resolve_name: looking up TEST.SMB4.TST#20 (sitename Default-First-Site-Name) [2010/05/27 23:19:18.410878, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = NBT/TEST.SMB4.TST#20, value = 192.168.99.2:0, timeout = Thu May 27 23:19:20 2010 [2010/05/27 23:19:18.410895, 5] libsmb/namecache.c:192(namecache_fetch) name TEST.SMB4.TST#20 found. [2010/05/27 23:19:18.410921, 5] libads/ldap.c:226(ads_try_connect) ads_try_connect: sending CLDAP request to 192.168.99.2 (realm: SMB4.TST) [2010/05/27 23:19:18.411853, 10] libads/dns.c:775(sitename_store) sitename_store: realm = [SAMBA4], sitename = [Default-First-Site-Name], expire = [2147483647] [2010/05/27 23:19:18.411870, 10] lib/gencache.c:180(gencache_set_data_blob) Adding cache entry with key = AD_SITENAME/DOMAIN/SAMBA4 and timeout = Tue Jan 19 06:14:07 2038 (872495689 seconds ahead) [2010/05/27 23:19:18.411904, 10] libads/dns.c:775(sitename_store) sitename_store: realm = [smb4.tst], sitename = [Default-First-Site-Name], expire = [2147483647] [2010/05/27 23:19:18.411917, 10] lib/gencache.c:180(gencache_set_data_blob) Adding cache entry with key = AD_SITENAME/DOMAIN/SMB4.TST and timeout = Tue Jan 19 06:14:07 2038 (872495689 seconds ahead) [2010/05/27 23:19:18.411947, 3] libads/ldap.c:634(ads_connect) Successfully contacted LDAP server 192.168.99.2 [2010/05/27 23:19:18.411960, 10] libads/ldap.c:62(ldap_open_with_timeout) Opening connection to LDAP server 'test.smb4.tst:389', timeout 15 seconds [2010/05/27 23:19:18.413024, 10] libads/ldap.c:76(ldap_open_with_timeout) Connected to LDAP server 'test.smb4.tst:389' [2010/05/27 23:19:18.413041, 3] libads/ldap.c:688(ads_connect) Connected to LDAP server test.smb4.tst [2010/05/27 23:19:18.413052, 10] libads/ldap.c:165(ads_closest_dc) ads_closest_dc: NBT_SERVER_CLOSEST flag set [2010/05/27 23:19:18.413064, 10] libsmb/namequery.c:83(saf_store) saf_store: domain = [SAMBA4], server = [test.smb4.tst], expire = [1274988858] [2010/05/27 23:19:18.413075, 10] lib/gencache.c:180(gencache_set_data_blob) Adding cache entry with key = SAF/DOMAIN/SAMBA4 and timeout = Thu May 27 23:34:18 2010 (900 seconds ahead) [2010/05/27 23:19:18.413106, 10] libsmb/namequery.c:83(saf_store) saf_store: domain = [SMB4.TST], server = [test.smb4.tst], expire = [1274988858] [2010/05/27 23:19:18.413118, 10] lib/gencache.c:180(gencache_set_data_blob) Adding cache entry with key = SAF/DOMAIN/SMB4.TST and timeout = Thu May 27 23:34:18 2010 (900 seconds ahead) [2010/05/27 23:19:18.413161, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.413180, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.413198, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.413212, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.413228, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.413243, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.413258, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.413272, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.413287, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.413301, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.413321, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.413339, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.413355, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.413371, 5] lib/charcnv.c:98(charset_name) Substituting charset 'UTF-8' for LOCALE [2010/05/27 23:19:18.416760, 4] libads/ldap.c:2850(ads_current_time) time offset is 0 seconds [2010/05/27 23:19:18.417060, 4] libads/sasl.c:1113(ads_sasl_bind) Found SASL mechanism GSS-SPNEGO [2010/05/27 23:19:18.417441, 3] libads/sasl.c:781(ads_sasl_spnego_bind) ads_sasl_spnego_bind: got OID=1.2.840.48018.1.2.2 [2010/05/27 23:19:18.417455, 3] libads/sasl.c:781(ads_sasl_spnego_bind) ads_sasl_spnego_bind: got OID=1.2.840.113554.1.2.2 [2010/05/27 23:19:18.417465, 3] libads/sasl.c:781(ads_sasl_spnego_bind) ads_sasl_spnego_bind: got OID=1.3.6.1.4.1.311.2.2.10 [2010/05/27 23:19:18.417476, 3] libads/sasl.c:790(ads_sasl_spnego_bind) ads_sasl_spnego_bind: got server principal name = TEST$@SMB4.TST [2010/05/27 23:19:18.417904, 3] libsmb/clikrb5.c:620(ads_cleanup_expired_creds) ads_cleanup_expired_creds: Ticket in ccache[FILE:/tmp/krb5cc_0] expiration Fri, 28 May 2010 05:48:25 MSD [2010/05/27 23:19:18.417928, 10] libsmb/clikrb5.c:732(ads_krb5_mk_req) ads_krb5_mk_req: Ticket (TEST$@SMB4.TST) in ccache (FILE:/tmp/krb5cc_0) is valid until: (Fri, 28 May 2010 05:48:25 MSD - 1275011305) [2010/05/27 23:19:18.417944, 3] libsmb/clikrb5.c:743(ads_krb5_mk_req) ads_krb5_mk_req: server marked as OK to delegate to, building forwardable TGT [2010/05/27 23:19:18.425756, 1] libsmb/clikrb5.c:1907(ads_krb5_get_fwd_ticket) ads_krb5_get_fwd_ticket: krb5_fwd_tgt_creds failed (KDC can't fulfill requested option) [2010/05/27 23:19:18.425776, 3] libsmb/clikrb5.c:777(ads_krb5_mk_req) ads_krb5_get_fwd_ticket failed (KDC can't fulfill requested option) [2010/05/27 23:19:18.425841, 10] libsmb/clikrb5.c:915(get_krb5_smb_session_key) Got KRB5 session key of length 16 [2010/05/27 23:19:18.429367, 10] libads/ldap.c:165(ads_closest_dc) ads_closest_dc: NBT_SERVER_CLOSEST flag set [2010/05/27 23:19:18.429412, 10] lib/util.c:2598(name_to_fqdn) name_to_fqdn: lookup for SMBFSVZ01 -> smbfsvz01.smb4.tst. [2010/05/27 23:19:18.429468, 2] lib/interface.c:463(interpret_interface) interpret_interface: using netmask value 8 from config file on interface lo [2010/05/27 23:19:18.429481, 2] lib/interface.c:340(add_interface) added interface lo ip=127.0.0.1 bcast=127.255.255.255 netmask=255.0.0.0 [2010/05/27 23:19:18.429496, 2] lib/interface.c:340(add_interface) added interface eth0 ip=fe80::216:3eff:fe53:7324%eth0 bcast=fe80::ffff:ffff:ffff:ffff%eth0 netmask=ffff:ffff:ffff:ffff:: [2010/05/27 23:19:18.429523, 2] lib/interface.c:340(add_interface) added interface eth0 ip=192.168.99.9 bcast=192.168.99.255 netmask=255.255.255.0 [2010/05/27 23:19:18.429686, 4] libads/dns.c:621(ads_dns_lookup_ns) ads_dns_lookup_ns: 1 records returned in the answer section. [2010/05/27 23:19:18.478534, 10] intl/lang_tdb.c:138(lang_tdb_init) lang_tdb_init: /usr/share/samba/en_US.UTF-8.msg: No such file or directory DNS update failed! [2010/05/27 23:19:18.478642, 2] utils/net.c:916(main) return code = -1