(Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [be_res_get_opts] (0x0100): Lookup order: ipv4_first (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [recreate_ares_channel] (0x0100): Initializing new c-ares channel (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sysdb_domain_init_internal] (0x0200): DB File for ipa.sys.local: /var/lib/sss/db/cache_ipa.sys.local.ldb (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sbus_init_connection] (0x0200): Adding connection 7F2D79F25540 (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [monitor_common_send_id] (0x0100): Sending ID: (%BE_ipa.sys.local,1) (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sss_names_init_from_args] (0x0100): Using re [(((?P[^\\]+)\\(?P.+$))|((?P[^@]+)@(?P.+$))|(^(?P[^@\\]+)$))]. (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sss_fqnames_init] (0x0100): Using fq format [%1$s@%2$s]. (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sss_fqnames_init] (0x0100): Found the pattern for domain name (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [common_parse_search_base] (0x0100): Search base added: [DEFAULT][cn=accounts,dc=ipa,dc=sys,dc=local][SUBTREE][] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sdap_set_sasl_options] (0x0100): Will look for p0129ipa01.ipa.sys.local@IPA.SYS.LOCAL in default keytab (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [select_principal_from_keytab] (0x0200): trying to select the most appropriate principal from keytab (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [select_principal_from_keytab] (0x0200): Selected primary: host/p0129ipa01.ipa.sys.local (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [select_principal_from_keytab] (0x0200): Selected realm: IPA.SYS.LOCAL (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sdap_set_sasl_options] (0x0100): Option ldap_sasl_authid set to host/p0129ipa01.ipa.sys.local (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sdap_set_sasl_options] (0x0100): Option ldap_sasl_realm set to IPA.SYS.LOCAL (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [common_parse_search_base] (0x0100): Search base added: [USER][cn=accounts,dc=ipa,dc=sys,dc=local][SUBTREE][] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [common_parse_search_base] (0x0100): Search base added: [GROUP][cn=accounts,dc=ipa,dc=sys,dc=local][SUBTREE][] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [common_parse_search_base] (0x0100): Search base added: [SUDO][ou=SUDOers,dc=ipa,dc=sys,dc=local][SUBTREE][] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [common_parse_search_base] (0x0100): Search base added: [NETGROUP][cn=ng,cn=alt,dc=ipa,dc=sys,dc=local][SUBTREE][] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [ipa_get_id_options] (0x0100): Option ipa_host_search_base set to cn=accounts,dc=ipa,dc=sys,dc=local (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [common_parse_search_base] (0x0100): Search base added: [IPA_HOST][cn=accounts,dc=ipa,dc=sys,dc=local][SUBTREE][] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [common_parse_search_base] (0x0100): Search base added: [IPA_HBAC][cn=hbac,dc=ipa,dc=sys,dc=local][SUBTREE][] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [ipa_get_id_options] (0x0100): Option ipa_selinux_search_base set to cn=selinux,dc=ipa,dc=sys,dc=local (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [common_parse_search_base] (0x0100): Search base added: [IPA_SELINUX][cn=selinux,dc=ipa,dc=sys,dc=local][SUBTREE][] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [common_parse_search_base] (0x0100): Search base added: [SERVICE][cn=accounts,dc=ipa,dc=sys,dc=local][SUBTREE][] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [ipa_get_id_options] (0x0100): Option ipa_subdomains_search_base set to cn=trusts,dc=ipa,dc=sys,dc=local (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [common_parse_search_base] (0x0100): Search base added: [IPA_SUBDOMAINS][cn=trusts,dc=ipa,dc=sys,dc=local][SUBTREE][] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [ipa_get_id_options] (0x0100): Option ipa_master_domain_search_base set to cn=ad,cn=etc,dc=ipa,dc=sys,dc=local (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [common_parse_search_base] (0x0100): Search base added: [IPA_MASTER_DOMAIN][cn=ad,cn=etc,dc=ipa,dc=sys,dc=local][SUBTREE][] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [ipa_get_id_options] (0x0100): Option ipa_ranges_search_base set to cn=ranges,cn=etc,dc=ipa,dc=sys,dc=local (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [common_parse_search_base] (0x0100): Search base added: [IPA_RANGES][cn=ranges,cn=etc,dc=ipa,dc=sys,dc=local][SUBTREE][] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [ipa_idmap_init] (0x0100): Initializing [2] domains for ID-mapping (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [krb5_try_kdcip] (0x0100): No KDC found in configuration, trying legacy option (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [ipa_get_auth_options] (0x0100): Option krb5_use_kdcinfo set to true (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [check_and_export_lifetime] (0x0200): No lifetime configured. (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [check_and_export_lifetime] (0x0200): No lifetime configured. (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [check_and_export_options] (0x0100): No KDC explicitly configured, using defaults. (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [check_and_export_options] (0x0100): No kpasswd server explicitly configured, using the KDC or defaults. (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [check_and_export_options] (0x0100): ccache is of type DIR (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [be_process_init] (0x0080): No SUDO module provided for [ipa.sys.local] !! (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [load_backend_module] (0x0200): no module name found in confdb, using [ipa]. (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [common_parse_search_base] (0x0100): Search base added: [AUTOFS][cn=default,cn=automount,dc=ipa,dc=sys,dc=local][SUBTREE][] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [load_backend_module] (0x0200): no module name found in confdb, using [ipa]. (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [load_backend_module] (0x0200): no module name found in confdb, using [ipa]. (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [load_backend_module] (0x0200): no module name found in confdb, using [ipa]. (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [id_callback] (0x0100): Got id ack and version (1) from Monitor (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sbus_server_init_new_connection] (0x0200): Entering. (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sbus_server_init_new_connection] (0x0200): Adding connection 0x7f2d79f39d30. (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sbus_init_connection] (0x0200): Adding connection 7F2D79F39D30 (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sbus_server_init_new_connection] (0x0200): Got a connection (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [be_client_init] (0x0100): Set-up Backend ID timeout [0x7f2d79f3b5b0] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sbus_server_init_new_connection] (0x0200): Entering. (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sbus_server_init_new_connection] (0x0200): Adding connection 0x7f2d79f3d220. (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sbus_init_connection] (0x0200): Adding connection 7F2D79F3D220 (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sbus_server_init_new_connection] (0x0200): Got a connection (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [be_client_init] (0x0100): Set-up Backend ID timeout [0x7f2d79f3bb10] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [client_registration] (0x0100): Cancel DP ID timeout [0x7f2d79f3bb10] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [client_registration] (0x0100): Added Frontend client [PAM] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [fo_resolve_service_send] (0x0100): Trying to resolve service 'IPA' (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve A record of 'p0029ipa01.ipa.sys.local' in files (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'p0029ipa01.ipa.sys.local' as 'resolving name' (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'p0029ipa01.ipa.sys.local' as 'name resolved' (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [be_resolve_server_process] (0x0200): Found address for server p0029ipa01.ipa.sys.local: [192.168.226.62] TTL 7200 (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sbus_server_init_new_connection] (0x0200): Entering. (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sbus_server_init_new_connection] (0x0200): Adding connection 0x7f2d79f43100. (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sbus_init_connection] (0x0200): Adding connection 7F2D79F43100 (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sbus_server_init_new_connection] (0x0200): Got a connection (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [be_client_init] (0x0100): Set-up Backend ID timeout [0x7f2d79f43980] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [client_registration] (0x0100): Cancel DP ID timeout [0x7f2d79f43980] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [client_registration] (0x0100): Added Frontend client [PAC] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sbus_server_init_new_connection] (0x0200): Entering. (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sbus_server_init_new_connection] (0x0200): Adding connection 0x7f2d79f4fca0. (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sbus_init_connection] (0x0200): Adding connection 7F2D79F4FCA0 (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sbus_server_init_new_connection] (0x0200): Got a connection (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [be_client_init] (0x0100): Set-up Backend ID timeout [0x7f2d79f50550] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [client_registration] (0x0100): Cancel DP ID timeout [0x7f2d79f50550] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [client_registration] (0x0100): Added Frontend client [SSH] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [fo_resolve_service_send] (0x0100): Trying to resolve service 'IPA' (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [be_resolve_server_process] (0x0200): Found address for server p0029ipa01.ipa.sys.local: [192.168.226.62] TTL 7200 (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [client_registration] (0x0100): Cancel DP ID timeout [0x7f2d79f3b5b0] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [client_registration] (0x0100): Added Frontend client [NSS] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sdap_cli_auth_step] (0x0100): expire timeout is 900 (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sasl_bind_send] (0x0100): Executing sasl bind mech: GSSAPI, user: host/p0129ipa01.ipa.sys.local (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [child_sig_handler] (0x0100): child [874] finished successfully. (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [fo_set_port_status] (0x0100): Marking port 0 of server 'p0029ipa01.ipa.sys.local' as 'working' (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'p0029ipa01.ipa.sys.local' as 'working' (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [be_run_online_cb] (0x0080): Going online. Running callbacks. (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [ad_set_ad_id_options] (0x0100): Option krb5_realm set to IPA.SYS.LOCAL (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sdap_set_sasl_options] (0x0100): Will look for p0129ipa01.ipa.sys.local@IPA.SYS.LOCAL in default keytab (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [select_principal_from_keytab] (0x0200): trying to select the most appropriate principal from keytab (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [select_principal_from_keytab] (0x0200): Selected primary: host/p0129ipa01.ipa.sys.local (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [select_principal_from_keytab] (0x0200): Selected realm: IPA.SYS.LOCAL (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sdap_set_sasl_options] (0x0100): Option ldap_sasl_authid set to host/p0129ipa01.ipa.sys.local (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sdap_set_sasl_options] (0x0100): Option ldap_sasl_realm set to IPA.SYS.LOCAL (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [ad_failover_init] (0x0100): No primary servers defined, using service discovery (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [_ad_servers_init] (0x0100): Added service discovery for AD (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sss_write_domain_mappings] (0x0200): Mapping file for domain [ipa.sys.local] is [/var/lib/sss/pubconf/krb5.include.d/domain_realm_ipa_sys_local] (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sss_krb5_touch_config] (0x0020): Unable to change mtime of "/etc/krb5.conf" [13]: Отказано в доступе (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [sss_write_domain_mappings] (0x0020): Unable to change last modification time of krb5.conf. Created mappings may not be loaded. (Tue Sep 24 21:16:20 2013) [sssd[be[ipa.sys.local]]] [delayed_online_authentication_callback] (0x0200): Backend is online, starting delayed online authentication. (Tue Sep 24 21:16:30 2013) [sssd[be[ipa.sys.local]]] [cleanup_groups] (0x0100): Found 1 expired group entries! (Tue Sep 24 21:16:37 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Got request for [4097][1][name=mavdyushev] (Tue Sep 24 21:16:37 2013) [sssd[be[ipa.sys.local]]] [fo_resolve_service_send] (0x0100): Trying to resolve service 'sys.local' (Tue Sep 24 21:16:37 2013) [sssd[be[ipa.sys.local]]] [resolve_srv_send] (0x0200): The status of SRV lookup is neutral (Tue Sep 24 21:16:37 2013) [sssd[be[ipa.sys.local]]] [resolv_getsrv_send] (0x0100): Trying to resolve SRV record of '_ldap._tcp.sys.local' (Tue Sep 24 21:16:37 2013) [sssd[be[ipa.sys.local]]] [set_srv_data_status] (0x0100): Marking SRV lookup of service 'sys.local' as 'resolved' (Tue Sep 24 21:16:37 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve A record of 'pk329ad-dc01.sys.local' in files (Tue Sep 24 21:16:37 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'pk329ad-dc01.sys.local' as 'resolving name' (Tue Sep 24 21:16:37 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve AAAA record of 'pk329ad-dc01.sys.local' in files (Tue Sep 24 21:16:37 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_next] (0x0200): No more address families to retry (Tue Sep 24 21:16:37 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_dns_query] (0x0100): Trying to resolve A record of 'pk329ad-dc01.sys.local' in DNS (Tue Sep 24 21:16:37 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'pk329ad-dc01.sys.local' as 'name resolved' (Tue Sep 24 21:16:37 2013) [sssd[be[ipa.sys.local]]] [be_resolve_server_process] (0x0200): Found address for server pk329ad-dc01.sys.local: [172.21.71.134] TTL 2404 (Tue Sep 24 21:16:37 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed uri 'ldap://pk329ad-dc01.sys.local' (Tue Sep 24 21:16:37 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed GC uri 'ldap://pk329ad-dc01.sys.local' (Tue Sep 24 21:16:43 2013) [sssd[be[ipa.sys.local]]] [sdap_async_sys_connect_timeout] (0x0100): The LDAP connection timed out (Tue Sep 24 21:16:43 2013) [sssd[be[ipa.sys.local]]] [sss_ldap_init_sys_connect_done] (0x0020): sdap_async_sys_connect request failed. (Tue Sep 24 21:16:43 2013) [sssd[be[ipa.sys.local]]] [sdap_sys_connect_done] (0x0020): sdap_async_connect_call request failed. (Tue Sep 24 21:16:43 2013) [sssd[be[ipa.sys.local]]] [fo_set_port_status] (0x0100): Marking port 389 of server 'pk329ad-dc01.sys.local' as 'not working' (Tue Sep 24 21:16:43 2013) [sssd[be[ipa.sys.local]]] [fo_resolve_service_send] (0x0100): Trying to resolve service 'sys.local' (Tue Sep 24 21:16:43 2013) [sssd[be[ipa.sys.local]]] [resolve_srv_send] (0x0200): The status of SRV lookup is resolved (Tue Sep 24 21:16:43 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve A record of 'pk729ad-dc01.sys.local' in files (Tue Sep 24 21:16:43 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'pk729ad-dc01.sys.local' as 'resolving name' (Tue Sep 24 21:16:43 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve AAAA record of 'pk729ad-dc01.sys.local' in files (Tue Sep 24 21:16:43 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_next] (0x0200): No more address families to retry (Tue Sep 24 21:16:43 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_dns_query] (0x0100): Trying to resolve A record of 'pk729ad-dc01.sys.local' in DNS (Tue Sep 24 21:16:43 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'pk729ad-dc01.sys.local' as 'name resolved' (Tue Sep 24 21:16:43 2013) [sssd[be[ipa.sys.local]]] [be_resolve_server_process] (0x0200): Found address for server pk729ad-dc01.sys.local: [172.21.103.134] TTL 2410 (Tue Sep 24 21:16:43 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed uri 'ldap://pk729ad-dc01.sys.local' (Tue Sep 24 21:16:43 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed GC uri 'ldap://pk729ad-dc01.sys.local' (Tue Sep 24 21:16:49 2013) [sssd[be[ipa.sys.local]]] [sdap_async_sys_connect_timeout] (0x0100): The LDAP connection timed out (Tue Sep 24 21:16:49 2013) [sssd[be[ipa.sys.local]]] [sss_ldap_init_sys_connect_done] (0x0020): sdap_async_sys_connect request failed. (Tue Sep 24 21:16:49 2013) [sssd[be[ipa.sys.local]]] [sdap_sys_connect_done] (0x0020): sdap_async_connect_call request failed. (Tue Sep 24 21:16:49 2013) [sssd[be[ipa.sys.local]]] [fo_set_port_status] (0x0100): Marking port 389 of server 'pk729ad-dc01.sys.local' as 'not working' (Tue Sep 24 21:16:49 2013) [sssd[be[ipa.sys.local]]] [fo_resolve_service_send] (0x0100): Trying to resolve service 'sys.local' (Tue Sep 24 21:16:49 2013) [sssd[be[ipa.sys.local]]] [resolve_srv_send] (0x0200): The status of SRV lookup is resolved (Tue Sep 24 21:16:49 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve A record of 'pk629ad-dc01.sys.local' in files (Tue Sep 24 21:16:49 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'pk629ad-dc01.sys.local' as 'resolving name' (Tue Sep 24 21:16:49 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve AAAA record of 'pk629ad-dc01.sys.local' in files (Tue Sep 24 21:16:49 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_next] (0x0200): No more address families to retry (Tue Sep 24 21:16:49 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_dns_query] (0x0100): Trying to resolve A record of 'pk629ad-dc01.sys.local' in DNS (Tue Sep 24 21:16:49 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'pk629ad-dc01.sys.local' as 'name resolved' (Tue Sep 24 21:16:49 2013) [sssd[be[ipa.sys.local]]] [be_resolve_server_process] (0x0200): Found address for server pk629ad-dc01.sys.local: [172.21.39.134] TTL 2404 (Tue Sep 24 21:16:49 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed uri 'ldap://pk629ad-dc01.sys.local' (Tue Sep 24 21:16:49 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed GC uri 'ldap://pk629ad-dc01.sys.local' (Tue Sep 24 21:16:55 2013) [sssd[be[ipa.sys.local]]] [sdap_async_sys_connect_timeout] (0x0100): The LDAP connection timed out (Tue Sep 24 21:16:55 2013) [sssd[be[ipa.sys.local]]] [sss_ldap_init_sys_connect_done] (0x0020): sdap_async_sys_connect request failed. (Tue Sep 24 21:16:55 2013) [sssd[be[ipa.sys.local]]] [sdap_sys_connect_done] (0x0020): sdap_async_connect_call request failed. (Tue Sep 24 21:16:55 2013) [sssd[be[ipa.sys.local]]] [fo_set_port_status] (0x0100): Marking port 389 of server 'pk629ad-dc01.sys.local' as 'not working' (Tue Sep 24 21:16:55 2013) [sssd[be[ipa.sys.local]]] [fo_resolve_service_send] (0x0100): Trying to resolve service 'sys.local' (Tue Sep 24 21:16:55 2013) [sssd[be[ipa.sys.local]]] [resolve_srv_send] (0x0200): The status of SRV lookup is resolved (Tue Sep 24 21:16:55 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve A record of 'pk229ad-dc01.sys.local' in files (Tue Sep 24 21:16:55 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'pk229ad-dc01.sys.local' as 'resolving name' (Tue Sep 24 21:16:55 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve AAAA record of 'pk229ad-dc01.sys.local' in files (Tue Sep 24 21:16:55 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_next] (0x0200): No more address families to retry (Tue Sep 24 21:16:55 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_dns_query] (0x0100): Trying to resolve A record of 'pk229ad-dc01.sys.local' in DNS (Tue Sep 24 21:16:55 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'pk229ad-dc01.sys.local' as 'name resolved' (Tue Sep 24 21:16:55 2013) [sssd[be[ipa.sys.local]]] [be_resolve_server_process] (0x0200): Found address for server pk229ad-dc01.sys.local: [172.21.7.134] TTL 2392 (Tue Sep 24 21:16:55 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed uri 'ldap://pk229ad-dc01.sys.local' (Tue Sep 24 21:16:55 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed GC uri 'ldap://pk229ad-dc01.sys.local' (Tue Sep 24 21:17:01 2013) [sssd[be[ipa.sys.local]]] [sdap_async_sys_connect_timeout] (0x0100): The LDAP connection timed out (Tue Sep 24 21:17:01 2013) [sssd[be[ipa.sys.local]]] [sss_ldap_init_sys_connect_done] (0x0020): sdap_async_sys_connect request failed. (Tue Sep 24 21:17:01 2013) [sssd[be[ipa.sys.local]]] [sdap_sys_connect_done] (0x0020): sdap_async_connect_call request failed. (Tue Sep 24 21:17:01 2013) [sssd[be[ipa.sys.local]]] [fo_set_port_status] (0x0100): Marking port 389 of server 'pk229ad-dc01.sys.local' as 'not working' (Tue Sep 24 21:17:01 2013) [sssd[be[ipa.sys.local]]] [fo_resolve_service_send] (0x0100): Trying to resolve service 'sys.local' (Tue Sep 24 21:17:01 2013) [sssd[be[ipa.sys.local]]] [resolve_srv_send] (0x0200): The status of SRV lookup is resolved (Tue Sep 24 21:17:01 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve A record of 'pk729ad-dc02.sys.local' in files (Tue Sep 24 21:17:01 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'pk729ad-dc02.sys.local' as 'resolving name' (Tue Sep 24 21:17:01 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve AAAA record of 'pk729ad-dc02.sys.local' in files (Tue Sep 24 21:17:01 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_next] (0x0200): No more address families to retry (Tue Sep 24 21:17:01 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_dns_query] (0x0100): Trying to resolve A record of 'pk729ad-dc02.sys.local' in DNS (Tue Sep 24 21:17:01 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'pk729ad-dc02.sys.local' as 'name resolved' (Tue Sep 24 21:17:01 2013) [sssd[be[ipa.sys.local]]] [be_resolve_server_process] (0x0200): Found address for server pk729ad-dc02.sys.local: [172.21.103.135] TTL 2392 (Tue Sep 24 21:17:01 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed uri 'ldap://pk729ad-dc02.sys.local' (Tue Sep 24 21:17:01 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed GC uri 'ldap://pk729ad-dc02.sys.local' (Tue Sep 24 21:17:07 2013) [sssd[be[ipa.sys.local]]] [sdap_async_sys_connect_timeout] (0x0100): The LDAP connection timed out (Tue Sep 24 21:17:07 2013) [sssd[be[ipa.sys.local]]] [sss_ldap_init_sys_connect_done] (0x0020): sdap_async_sys_connect request failed. (Tue Sep 24 21:17:07 2013) [sssd[be[ipa.sys.local]]] [sdap_sys_connect_done] (0x0020): sdap_async_connect_call request failed. (Tue Sep 24 21:17:07 2013) [sssd[be[ipa.sys.local]]] [fo_set_port_status] (0x0100): Marking port 389 of server 'pk729ad-dc02.sys.local' as 'not working' (Tue Sep 24 21:17:07 2013) [sssd[be[ipa.sys.local]]] [fo_resolve_service_send] (0x0100): Trying to resolve service 'sys.local' (Tue Sep 24 21:17:07 2013) [sssd[be[ipa.sys.local]]] [resolve_srv_send] (0x0200): The status of SRV lookup is resolved (Tue Sep 24 21:17:07 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve A record of 'pk629ad-dc02.sys.local' in files (Tue Sep 24 21:17:07 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'pk629ad-dc02.sys.local' as 'resolving name' (Tue Sep 24 21:17:07 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve AAAA record of 'pk629ad-dc02.sys.local' in files (Tue Sep 24 21:17:07 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_next] (0x0200): No more address families to retry (Tue Sep 24 21:17:07 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_dns_query] (0x0100): Trying to resolve A record of 'pk629ad-dc02.sys.local' in DNS (Tue Sep 24 21:17:07 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'pk629ad-dc02.sys.local' as 'name resolved' (Tue Sep 24 21:17:07 2013) [sssd[be[ipa.sys.local]]] [be_resolve_server_process] (0x0200): Found address for server pk629ad-dc02.sys.local: [172.21.39.135] TTL 2386 (Tue Sep 24 21:17:07 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed uri 'ldap://pk629ad-dc02.sys.local' (Tue Sep 24 21:17:07 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed GC uri 'ldap://pk629ad-dc02.sys.local' (Tue Sep 24 21:17:13 2013) [sssd[be[ipa.sys.local]]] [sdap_async_sys_connect_timeout] (0x0100): The LDAP connection timed out (Tue Sep 24 21:17:13 2013) [sssd[be[ipa.sys.local]]] [sss_ldap_init_sys_connect_done] (0x0020): sdap_async_sys_connect request failed. (Tue Sep 24 21:17:13 2013) [sssd[be[ipa.sys.local]]] [sdap_sys_connect_done] (0x0020): sdap_async_connect_call request failed. (Tue Sep 24 21:17:13 2013) [sssd[be[ipa.sys.local]]] [fo_set_port_status] (0x0100): Marking port 389 of server 'pk629ad-dc02.sys.local' as 'not working' (Tue Sep 24 21:17:13 2013) [sssd[be[ipa.sys.local]]] [fo_resolve_service_send] (0x0100): Trying to resolve service 'sys.local' (Tue Sep 24 21:17:13 2013) [sssd[be[ipa.sys.local]]] [resolve_srv_send] (0x0200): The status of SRV lookup is resolved (Tue Sep 24 21:17:13 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve A record of 'pk429ad-dc02.sys.local' in files (Tue Sep 24 21:17:13 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'pk429ad-dc02.sys.local' as 'resolving name' (Tue Sep 24 21:17:13 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve AAAA record of 'pk429ad-dc02.sys.local' in files (Tue Sep 24 21:17:13 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_next] (0x0200): No more address families to retry (Tue Sep 24 21:17:13 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_dns_query] (0x0100): Trying to resolve A record of 'pk429ad-dc02.sys.local' in DNS (Tue Sep 24 21:17:13 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'pk429ad-dc02.sys.local' as 'name resolved' (Tue Sep 24 21:17:13 2013) [sssd[be[ipa.sys.local]]] [be_resolve_server_process] (0x0200): Found address for server pk429ad-dc02.sys.local: [172.21.135.135] TTL 2380 (Tue Sep 24 21:17:13 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed uri 'ldap://pk429ad-dc02.sys.local' (Tue Sep 24 21:17:13 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed GC uri 'ldap://pk429ad-dc02.sys.local' (Tue Sep 24 21:17:19 2013) [sssd[be[ipa.sys.local]]] [sdap_async_sys_connect_timeout] (0x0100): The LDAP connection timed out (Tue Sep 24 21:17:19 2013) [sssd[be[ipa.sys.local]]] [sss_ldap_init_sys_connect_done] (0x0020): sdap_async_sys_connect request failed. (Tue Sep 24 21:17:19 2013) [sssd[be[ipa.sys.local]]] [sdap_sys_connect_done] (0x0020): sdap_async_connect_call request failed. (Tue Sep 24 21:17:19 2013) [sssd[be[ipa.sys.local]]] [fo_set_port_status] (0x0100): Marking port 389 of server 'pk429ad-dc02.sys.local' as 'not working' (Tue Sep 24 21:17:19 2013) [sssd[be[ipa.sys.local]]] [fo_resolve_service_send] (0x0100): Trying to resolve service 'sys.local' (Tue Sep 24 21:17:19 2013) [sssd[be[ipa.sys.local]]] [resolve_srv_send] (0x0200): The status of SRV lookup is resolved (Tue Sep 24 21:17:19 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve A record of 'pk529ad-dc01.sys.local' in files (Tue Sep 24 21:17:19 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'pk529ad-dc01.sys.local' as 'resolving name' (Tue Sep 24 21:17:19 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve AAAA record of 'pk529ad-dc01.sys.local' in files (Tue Sep 24 21:17:19 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_next] (0x0200): No more address families to retry (Tue Sep 24 21:17:19 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_dns_query] (0x0100): Trying to resolve A record of 'pk529ad-dc01.sys.local' in DNS (Tue Sep 24 21:17:19 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'pk529ad-dc01.sys.local' as 'name resolved' (Tue Sep 24 21:17:19 2013) [sssd[be[ipa.sys.local]]] [be_resolve_server_process] (0x0200): Found address for server pk529ad-dc01.sys.local: [172.21.167.134] TTL 2356 (Tue Sep 24 21:17:19 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed uri 'ldap://pk529ad-dc01.sys.local' (Tue Sep 24 21:17:19 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed GC uri 'ldap://pk529ad-dc01.sys.local' (Tue Sep 24 21:17:25 2013) [sssd[be[ipa.sys.local]]] [sdap_async_sys_connect_timeout] (0x0100): The LDAP connection timed out (Tue Sep 24 21:17:25 2013) [sssd[be[ipa.sys.local]]] [sss_ldap_init_sys_connect_done] (0x0020): sdap_async_sys_connect request failed. (Tue Sep 24 21:17:25 2013) [sssd[be[ipa.sys.local]]] [sdap_sys_connect_done] (0x0020): sdap_async_connect_call request failed. (Tue Sep 24 21:17:25 2013) [sssd[be[ipa.sys.local]]] [fo_set_port_status] (0x0100): Marking port 389 of server 'pk529ad-dc01.sys.local' as 'not working' (Tue Sep 24 21:17:25 2013) [sssd[be[ipa.sys.local]]] [fo_resolve_service_send] (0x0100): Trying to resolve service 'sys.local' (Tue Sep 24 21:17:25 2013) [sssd[be[ipa.sys.local]]] [resolve_srv_send] (0x0200): The status of SRV lookup is resolved (Tue Sep 24 21:17:25 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve A record of 'pk229ad-dc02.sys.local' in files (Tue Sep 24 21:17:25 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'pk229ad-dc02.sys.local' as 'resolving name' (Tue Sep 24 21:17:25 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve AAAA record of 'pk229ad-dc02.sys.local' in files (Tue Sep 24 21:17:25 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_next] (0x0200): No more address families to retry (Tue Sep 24 21:17:25 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_dns_query] (0x0100): Trying to resolve A record of 'pk229ad-dc02.sys.local' in DNS (Tue Sep 24 21:17:25 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'pk229ad-dc02.sys.local' as 'name resolved' (Tue Sep 24 21:17:25 2013) [sssd[be[ipa.sys.local]]] [be_resolve_server_process] (0x0200): Found address for server pk229ad-dc02.sys.local: [172.21.7.135] TTL 2344 (Tue Sep 24 21:17:25 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed uri 'ldap://pk229ad-dc02.sys.local' (Tue Sep 24 21:17:25 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed GC uri 'ldap://pk229ad-dc02.sys.local' (Tue Sep 24 21:17:31 2013) [sssd[be[ipa.sys.local]]] [sdap_async_sys_connect_timeout] (0x0100): The LDAP connection timed out (Tue Sep 24 21:17:31 2013) [sssd[be[ipa.sys.local]]] [sss_ldap_init_sys_connect_done] (0x0020): sdap_async_sys_connect request failed. (Tue Sep 24 21:17:31 2013) [sssd[be[ipa.sys.local]]] [sdap_sys_connect_done] (0x0020): sdap_async_connect_call request failed. (Tue Sep 24 21:17:31 2013) [sssd[be[ipa.sys.local]]] [fo_set_port_status] (0x0100): Marking port 389 of server 'pk229ad-dc02.sys.local' as 'not working' (Tue Sep 24 21:17:31 2013) [sssd[be[ipa.sys.local]]] [fo_resolve_service_send] (0x0100): Trying to resolve service 'sys.local' (Tue Sep 24 21:17:31 2013) [sssd[be[ipa.sys.local]]] [resolve_srv_send] (0x0200): The status of SRV lookup is resolved (Tue Sep 24 21:17:31 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve A record of 'pk529ad-dc02.sys.local' in files (Tue Sep 24 21:17:31 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'pk529ad-dc02.sys.local' as 'resolving name' (Tue Sep 24 21:17:31 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve AAAA record of 'pk529ad-dc02.sys.local' in files (Tue Sep 24 21:17:31 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_next] (0x0200): No more address families to retry (Tue Sep 24 21:17:31 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_dns_query] (0x0100): Trying to resolve A record of 'pk529ad-dc02.sys.local' in DNS (Tue Sep 24 21:17:31 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'pk529ad-dc02.sys.local' as 'name resolved' (Tue Sep 24 21:17:31 2013) [sssd[be[ipa.sys.local]]] [be_resolve_server_process] (0x0200): Found address for server pk529ad-dc02.sys.local: [172.21.167.135] TTL 2362 (Tue Sep 24 21:17:32 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed uri 'ldap://pk529ad-dc02.sys.local' (Tue Sep 24 21:17:32 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed GC uri 'ldap://pk529ad-dc02.sys.local' (Tue Sep 24 21:17:38 2013) [sssd[be[ipa.sys.local]]] [sdap_async_sys_connect_timeout] (0x0100): The LDAP connection timed out (Tue Sep 24 21:17:38 2013) [sssd[be[ipa.sys.local]]] [sss_ldap_init_sys_connect_done] (0x0020): sdap_async_sys_connect request failed. (Tue Sep 24 21:17:38 2013) [sssd[be[ipa.sys.local]]] [sdap_sys_connect_done] (0x0020): sdap_async_connect_call request failed. (Tue Sep 24 21:17:38 2013) [sssd[be[ipa.sys.local]]] [fo_set_port_status] (0x0100): Marking port 389 of server 'pk529ad-dc02.sys.local' as 'not working' (Tue Sep 24 21:17:38 2013) [sssd[be[ipa.sys.local]]] [fo_resolve_service_send] (0x0100): Trying to resolve service 'sys.local' (Tue Sep 24 21:17:38 2013) [sssd[be[ipa.sys.local]]] [resolve_srv_send] (0x0200): The status of SRV lookup is resolved (Tue Sep 24 21:17:38 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve A record of 'pk429ad-dc01.sys.local' in files (Tue Sep 24 21:17:38 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'pk429ad-dc01.sys.local' as 'resolving name' (Tue Sep 24 21:17:38 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve AAAA record of 'pk429ad-dc01.sys.local' in files (Tue Sep 24 21:17:38 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_next] (0x0200): No more address families to retry (Tue Sep 24 21:17:38 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_dns_query] (0x0100): Trying to resolve A record of 'pk429ad-dc01.sys.local' in DNS (Tue Sep 24 21:17:38 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'pk429ad-dc01.sys.local' as 'name resolved' (Tue Sep 24 21:17:38 2013) [sssd[be[ipa.sys.local]]] [be_resolve_server_process] (0x0200): Found address for server pk429ad-dc01.sys.local: [172.21.135.134] TTL 2356 (Tue Sep 24 21:17:38 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed uri 'ldap://pk429ad-dc01.sys.local' (Tue Sep 24 21:17:38 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed GC uri 'ldap://pk429ad-dc01.sys.local' (Tue Sep 24 21:17:44 2013) [sssd[be[ipa.sys.local]]] [sdap_async_sys_connect_timeout] (0x0100): The LDAP connection timed out (Tue Sep 24 21:17:44 2013) [sssd[be[ipa.sys.local]]] [sss_ldap_init_sys_connect_done] (0x0020): sdap_async_sys_connect request failed. (Tue Sep 24 21:17:44 2013) [sssd[be[ipa.sys.local]]] [sdap_sys_connect_done] (0x0020): sdap_async_connect_call request failed. (Tue Sep 24 21:17:44 2013) [sssd[be[ipa.sys.local]]] [fo_set_port_status] (0x0100): Marking port 389 of server 'pk429ad-dc01.sys.local' as 'not working' (Tue Sep 24 21:17:44 2013) [sssd[be[ipa.sys.local]]] [fo_resolve_service_send] (0x0100): Trying to resolve service 'sys.local' (Tue Sep 24 21:17:44 2013) [sssd[be[ipa.sys.local]]] [resolve_srv_send] (0x0200): The status of SRV lookup is resolved (Tue Sep 24 21:17:44 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve A record of 'p0029ad-dc01.sys.local' in files (Tue Sep 24 21:17:44 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'p0029ad-dc01.sys.local' as 'resolving name' (Tue Sep 24 21:17:44 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_files_send] (0x0100): Trying to resolve AAAA record of 'p0029ad-dc01.sys.local' in files (Tue Sep 24 21:17:44 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_next] (0x0200): No more address families to retry (Tue Sep 24 21:17:44 2013) [sssd[be[ipa.sys.local]]] [resolv_gethostbyname_dns_query] (0x0100): Trying to resolve A record of 'p0029ad-dc01.sys.local' in DNS (Tue Sep 24 21:17:44 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'p0029ad-dc01.sys.local' as 'name resolved' (Tue Sep 24 21:17:44 2013) [sssd[be[ipa.sys.local]]] [be_resolve_server_process] (0x0200): Found address for server p0029ad-dc01.sys.local: [192.168.226.60] TTL 2350 (Tue Sep 24 21:17:44 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed uri 'ldap://p0029ad-dc01.sys.local' (Tue Sep 24 21:17:44 2013) [sssd[be[ipa.sys.local]]] [ad_resolve_callback] (0x0100): Constructed GC uri 'ldap://p0029ad-dc01.sys.local' (Tue Sep 24 21:17:44 2013) [sssd[be[ipa.sys.local]]] [sdap_get_server_opts_from_rootdse] (0x0100): Setting AD compatibility level to [5] (Tue Sep 24 21:17:44 2013) [sssd[be[ipa.sys.local]]] [fo_resolve_service_send] (0x0100): Trying to resolve service 'sys.local' (Tue Sep 24 21:17:44 2013) [sssd[be[ipa.sys.local]]] [resolve_srv_send] (0x0200): The status of SRV lookup is resolved (Tue Sep 24 21:17:44 2013) [sssd[be[ipa.sys.local]]] [be_resolve_server_process] (0x0200): Found address for server p0029ad-dc01.sys.local: [192.168.226.60] TTL 2350 (Tue Sep 24 21:17:44 2013) [sssd[be[ipa.sys.local]]] [sdap_cli_auth_step] (0x0100): expire timeout is 900 (Tue Sep 24 21:17:44 2013) [sssd[be[ipa.sys.local]]] [sasl_bind_send] (0x0100): Executing sasl bind mech: gssapi, user: host/p0129ipa01.ipa.sys.local (Tue Sep 24 21:18:28 2013) [sssd[be[ipa.sys.local]]] [sasl_bind_send] (0x0020): ldap_sasl_bind failed (-2)[Local error] (Tue Sep 24 21:18:28 2013) [sssd[be[ipa.sys.local]]] [sasl_bind_send] (0x0080): Extended failure message: [SASL(-1): generic failure: GSSAPI Error: Unspecified GSS failure. Minor code may provide more information (Cannot contact any KDC for realm 'SYS.LOCAL')] (Tue Sep 24 21:18:28 2013) [sssd[be[ipa.sys.local]]] [child_sig_handler] (0x0100): child [885] finished successfully. (Tue Sep 24 21:18:28 2013) [sssd[be[ipa.sys.local]]] [fo_set_port_status] (0x0100): Marking port 389 of server 'p0029ad-dc01.sys.local' as 'not working' (Tue Sep 24 21:18:28 2013) [sssd[be[ipa.sys.local]]] [be_run_offline_cb] (0x0080): Going offline. Running callbacks. (Tue Sep 24 21:18:28 2013) [sssd[be[ipa.sys.local]]] [ipa_get_ad_acct_done] (0x0040): AD lookup failed: 11 (Tue Sep 24 21:18:28 2013) [sssd[be[ipa.sys.local]]] [ipa_account_info_error_text] (0x0020): Bug: dp_error is OK on failed request (Tue Sep 24 21:18:28 2013) [sssd[be[ipa.sys.local]]] [acctinfo_callback] (0x0100): Request processed. Returned 3,11,Account info lookup failed (Tue Sep 24 21:18:28 2013) [sssd[be[ipa.sys.local]]] [remove_krb5_info_files] (0x0200): Could not remove [/var/lib/sss/pubconf/kpasswdinfo.IPA.SYS.LOCAL], [2][Нет такого файла или каталога] (Tue Sep 24 21:19:02 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Got request for [4097][1][name=mavdyushev] (Tue Sep 24 21:19:02 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Request processed. Returned 1,11,Fast reply - offline (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Got request for [4097][1][name=mavdyushev] (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Request processed. Returned 1,11,Fast reply - offline (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Got request for [4097][1][name=mavdyushev] (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Request processed. Returned 1,11,Fast reply - offline (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Got request for [4097][1][name=mavdyushev] (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Request processed. Returned 1,11,Fast reply - offline (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Got request for [3][1][name=mavdyushev] (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [acctinfo_callback] (0x0100): Request processed. Returned 1,11,Offline (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [be_pam_handler] (0x0100): Got request with the following data (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): command: PAM_AUTHENTICATE (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): domain: sys.local (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): user: mavdyushev@sys.local (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): service: sshd (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): tty: ssh (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): ruser: (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): rhost: 172.16.5.58 (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): authtok type: 1 (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): newauthtok type: 0 (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): priv: 1 (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): cli_pid: 886 (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [cc_residual_is_used] (0x0200): Cache file [/run/user/348602145/krb5cc] does not exist, it will be recreated (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [cc_check_template] (0x0100): ccache file name template [DIR:%d/krb5cc] doesn't contain randomizing characters (XXXXXX), file might not be rewritable (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [krb5_auth_send] (0x0200): Ignoring ccache attribute [DIR:/run/user/348602145/krb5cc], because it doesn'texist. (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [fo_resolve_service_send] (0x0100): Trying to resolve service 'IPA' (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [be_resolve_server_process] (0x0200): Found address for server p0029ipa01.ipa.sys.local: [192.168.226.62] TTL 7200 (Tue Sep 24 21:19:07 2013) [sssd[be[ipa.sys.local]]] [become_user] (0x0200): Trying to become user [348602145][348602145]. (Tue Sep 24 21:19:08 2013) [sssd[be[ipa.sys.local]]] [fo_set_port_status] (0x0100): Marking port 0 of server 'p0029ipa01.ipa.sys.local' as 'working' (Tue Sep 24 21:19:08 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'p0029ipa01.ipa.sys.local' as 'working' (Tue Sep 24 21:19:08 2013) [sssd[be[ipa.sys.local]]] [safe_remove_old_ccache_file] (0x0200): No old ccache, nothing to do (Tue Sep 24 21:19:08 2013) [sssd[be[ipa.sys.local]]] [sysdb_cache_auth] (0x0020): sysdb_search_user_by_name failed [2][Нет такого файла или каталога]. (Tue Sep 24 21:19:08 2013) [sssd[be[ipa.sys.local]]] [krb5_auth_cache_creds] (0x0020): Offline authentication failed (Tue Sep 24 21:19:08 2013) [sssd[be[ipa.sys.local]]] [be_pam_handler_callback] (0x0100): Backend returned: (0, 9, ) [Success] (Tue Sep 24 21:19:08 2013) [sssd[be[ipa.sys.local]]] [be_pam_handler_callback] (0x0100): Sending result [9][sys.local] (Tue Sep 24 21:19:08 2013) [sssd[be[ipa.sys.local]]] [be_pam_handler_callback] (0x0100): Sent result [9][sys.local] (Tue Sep 24 21:19:08 2013) [sssd[be[ipa.sys.local]]] [child_sig_handler] (0x0100): child [888] finished successfully. (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Got request for [4097][1][name=mavdyushev] (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Request processed. Returned 1,11,Fast reply - offline (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Got request for [4097][1][name=mavdyushev] (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Request processed. Returned 1,11,Fast reply - offline (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Got request for [4097][1][name=mavdyushev] (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Request processed. Returned 1,11,Fast reply - offline (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Got request for [3][1][name=mavdyushev] (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [acctinfo_callback] (0x0100): Request processed. Returned 1,11,Offline (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [be_pam_handler] (0x0100): Got request with the following data (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): command: PAM_AUTHENTICATE (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): domain: sys.local (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): user: mavdyushev@sys.local (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): service: sshd (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): tty: ssh (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): ruser: (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): rhost: 172.16.5.58 (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): authtok type: 1 (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): newauthtok type: 0 (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): priv: 1 (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): cli_pid: 886 (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [check_for_valid_tgt] (0x0020): krb5_cc_retrieve_cred failed. (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [fo_resolve_service_send] (0x0100): Trying to resolve service 'IPA' (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [be_resolve_server_process] (0x0200): Found address for server p0029ipa01.ipa.sys.local: [192.168.226.62] TTL 7200 (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [become_user] (0x0200): Trying to become user [348602145][348602145]. (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [fo_set_port_status] (0x0100): Marking port 0 of server 'p0029ipa01.ipa.sys.local' as 'working' (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'p0029ipa01.ipa.sys.local' as 'working' (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [sysdb_cache_auth] (0x0020): sysdb_search_user_by_name failed [2][Нет такого файла или каталога]. (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [krb5_auth_cache_creds] (0x0020): Offline authentication failed (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [be_pam_handler_callback] (0x0100): Backend returned: (0, 9, ) [Success] (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [be_pam_handler_callback] (0x0100): Sending result [9][sys.local] (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [be_pam_handler_callback] (0x0100): Sent result [9][sys.local] (Tue Sep 24 21:19:15 2013) [sssd[be[ipa.sys.local]]] [child_sig_handler] (0x0100): child [889] finished successfully. (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Got request for [4097][1][name=mavdyushev] (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Request processed. Returned 1,11,Fast reply - offline (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Got request for [4097][1][name=mavdyushev] (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Request processed. Returned 1,11,Fast reply - offline (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Got request for [4097][1][name=mavdyushev] (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Request processed. Returned 1,11,Fast reply - offline (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [be_get_account_info] (0x0100): Got request for [3][1][name=mavdyushev] (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [acctinfo_callback] (0x0100): Request processed. Returned 1,11,Offline (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [be_pam_handler] (0x0100): Got request with the following data (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): command: PAM_AUTHENTICATE (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): domain: sys.local (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): user: mavdyushev@sys.local (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): service: sshd (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): tty: ssh (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): ruser: (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): rhost: 172.16.5.58 (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): authtok type: 1 (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): newauthtok type: 0 (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): priv: 1 (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [pam_print_data] (0x0100): cli_pid: 886 (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [check_for_valid_tgt] (0x0020): krb5_cc_retrieve_cred failed. (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [fo_resolve_service_send] (0x0100): Trying to resolve service 'IPA' (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [be_resolve_server_process] (0x0200): Found address for server p0029ipa01.ipa.sys.local: [192.168.226.62] TTL 7200 (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [become_user] (0x0200): Trying to become user [348602145][348602145]. (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [fo_set_port_status] (0x0100): Marking port 0 of server 'p0029ipa01.ipa.sys.local' as 'working' (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [set_server_common_status] (0x0100): Marking server 'p0029ipa01.ipa.sys.local' as 'working' (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [sysdb_cache_auth] (0x0020): sysdb_search_user_by_name failed [2][Нет такого файла или каталога]. (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [krb5_auth_cache_creds] (0x0020): Offline authentication failed (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [be_pam_handler_callback] (0x0100): Backend returned: (0, 9, ) [Success] (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [be_pam_handler_callback] (0x0100): Sending result [9][sys.local] (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [be_pam_handler_callback] (0x0100): Sent result [9][sys.local] (Tue Sep 24 21:19:20 2013) [sssd[be[ipa.sys.local]]] [child_sig_handler] (0x0100): child [890] finished successfully.