Server side SSSD logs:
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x1][BE_REQ_USER][name=<MY USERNAME>@<AD DOMAIN>]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #1]: New request. Flags [0x0001].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with [(&(objectClass=ipaUserOverride)(uid=<MY
USERNAME>))][cn=Default Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ipa_srv_ad_acct_lookup_step]
(0x0400): Looking up AD account
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_resolve_service_send]
(0x0100): Trying to resolve service 'sd_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [resolve_srv_send] (0x0200): The
status of SRV lookup is neutral
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ad_srv_plugin_send] (0x0400):
About to find domain controllers
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ad_get_dc_servers_send]
(0x0400): Looking up domain controllers in domain <AD DOMAIN> and site GMA
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[resolv_discover_srv_next_domain] (0x0400): SRV resolution of service 'ldap'. Will
use DNS discovery domain 'GMA._sites.<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [resolv_getsrv_send] (0x0100):
Trying to resolve SRV record of '_ldap._tcp.GMA._sites.<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [request_watch_destructor]
(0x0400): Deleting request watch
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_discover_srv_done] (0x0400):
Got answer. Processing...
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_discover_srv_done] (0x0400):
Got 8 servers
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ad_get_dc_servers_done]
(0x0400): Found 8 domain controllers in domain GMA._sites.<AD DOMAIN>
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ad_srv_plugin_dcs_done]
(0x0400): About to locate suitable site
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_connect_host_send]
(0x0400): Resolving host <DC1>.<AD DOMAIN>
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[resolv_gethostbyname_files_send] (0x0100): Trying to resolve A record of
'<DC1>.<AD DOMAIN>' in files
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[resolv_gethostbyname_files_send] (0x0100): Trying to resolve AAAA record of
'<DC1>.<AD DOMAIN>' in files
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [resolv_gethostbyname_next]
(0x0200): No more address families to retry
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [resolv_gethostbyname_dns_query]
(0x0100): Trying to resolve A record of '<DC1>.<AD DOMAIN>' in DNS
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [request_watch_destructor]
(0x0400): Deleting request watch
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_connect_host_resolv_done]
(0x0400): Connecting to ldap://<DC1>.<AD DOMAIN>:389
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sssd_async_socket_init_send]
(0x0400): Setting 6 seconds timeout for connecting
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_connect_host_done]
(0x0400): Successful connection to ldap://<DC1>.<AD DOMAIN>:389
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with [(&(DnsDomain=<AD
DOMAIN>)(NtVer=\14\00\00\00))][].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ad_get_client_site_done]
(0x0400): Found site: GMA
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ad_get_client_site_done]
(0x0400): Found forest: <AD DOMAIN>
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ad_srv_plugin_site_done]
(0x0400): About to discover primary and backup servers
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_discover_servers_send]
(0x0400): Looking up primary servers
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[resolv_discover_srv_next_domain] (0x0400): SRV resolution of service 'ldap'. Will
use DNS discovery domain 'GMA._sites.<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [resolv_getsrv_send] (0x0100):
Trying to resolve SRV record of '_ldap._tcp.GMA._sites.<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [request_watch_destructor]
(0x0400): Deleting request watch
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_discover_srv_done] (0x0400):
Got answer. Processing...
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_discover_srv_done] (0x0400):
Got 8 servers
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[fo_discover_servers_primary_done] (0x0400): Looking up backup servers
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[resolv_discover_srv_next_domain] (0x0400): SRV resolution of service 'ldap'. Will
use DNS discovery domain '<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [resolv_getsrv_send] (0x0100):
Trying to resolve SRV record of '_ldap._tcp.<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [request_watch_destructor]
(0x0400): Deleting request watch
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_discover_srv_done] (0x0400):
Got answer. Processing...
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_discover_srv_done] (0x0400):
Got 13 servers
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ad_srv_plugin_servers_done]
(0x0400): Got 8 primary and 13 backup servers
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted primary server '<DC2>.<AD DOMAIN>:389' to service
'sd_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted primary server '<DC3>.<AD DOMAIN>:389' to service
'sd_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted primary server '<DC4>.<AD DOMAIN>:389' to service
'sd_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted primary server '<DC5>.<AD DOMAIN>:389' to service
'sd_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted primary server '<DC6>.<AD DOMAIN>:389' to service
'sd_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted primary server '<DC1>.<AD DOMAIN>:389' to service
'sd_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted primary server '<DC7>.<AD DOMAIN>:389' to service
'sd_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted primary server '<DC8>.<AD DOMAIN>:389' to service
'sd_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted backup server '<DC9>.<AD DOMAIN>:389' to service
'sd_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Server '<DC1>.<AD DOMAIN>:389' for service 'sd_<AD
DOMAIN>' is already present
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted backup server '<DC10>.<AD DOMAIN>:389' to service
'sd_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Server '<DC6>.<AD DOMAIN>:389' for service 'sd_<AD
DOMAIN>' is already present
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted backup server '<DC11>.<AD DOMAIN>:389' to service
'sd_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted backup server '<DC12>.<AD DOMAIN>:389' to service
'sd_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted backup server '<DC13>.<AD DOMAIN>:389' to service
'sd_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted backup server '<DC14>.<AD DOMAIN>:389' to service
'sd_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Server '<DC4>.<AD DOMAIN>:389' for service 'sd_<AD
DOMAIN>' is already present
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Server '<DC7>.<AD DOMAIN>:389' for service 'sd_<AD
DOMAIN>' is already present
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Server '<DC5>.<AD DOMAIN>:389' for service 'sd_<AD
DOMAIN>' is already present
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Server '<DC2>.<AD DOMAIN>:389' for service 'sd_<AD
DOMAIN>' is already present
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted backup server '<DC15>.<AD DOMAIN>:389' to service
'sd_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [set_srv_data_status] (0x0100):
Marking SRV lookup of service 'sd_<AD DOMAIN>' as 'resolved'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[resolv_gethostbyname_files_send] (0x0100): Trying to resolve A record of
'<DC2>.<AD DOMAIN>' in files
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [set_server_common_status]
(0x0100): Marking server '<DC2>.<AD DOMAIN>' as 'resolving
name'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[resolv_gethostbyname_files_send] (0x0100): Trying to resolve AAAA record of
'<DC2>.<AD DOMAIN>' in files
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [resolv_gethostbyname_next]
(0x0200): No more address families to retry
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [resolv_gethostbyname_dns_query]
(0x0100): Trying to resolve A record of '<DC2>.<AD DOMAIN>' in DNS
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [request_watch_destructor]
(0x0400): Deleting request watch
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [set_server_common_status]
(0x0100): Marking server '<DC2>.<AD DOMAIN>' as 'name
resolved'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [be_resolve_server_process]
(0x0200): Found address for server <DC2>.<AD DOMAIN>: [<IP>] TTL 3600
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ad_resolve_callback] (0x0100):
Constructed uri 'ldap://<DC2>.<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ad_resolve_callback] (0x0100):
Constructed GC uri 'ldap://<DC2>.<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sssd_async_socket_init_send]
(0x0400): Setting 6 seconds timeout for connecting
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with [(objectclass=*)][].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [get_naming_context] (0x0200):
Using value from [defaultNamingContext] as naming context.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_set_search_base] (0x0100):
Setting option [ldap_host_search_base] to [DC=AD,DC=AD,DC=AD,DC=AD].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [common_parse_search_base]
(0x0100): Search base added: [HOST][DC=AD,DC=AD,DC=AD,DC=AD][SUBTREE][]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[sdap_get_server_opts_from_rootdse] (0x0100): Setting AD compatibility level to [4]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[sdap_get_server_opts_from_rootdse] (0x0100): Will look for schema at
[CN=Schema,CN=Configuration,DC=AD,DC=AD,DC=AD]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_kinit_send] (0x0400):
Attempting kinit (/var/lib/sss/keytabs/<AD DOMAIN>.keytab, SOC$, <AD DOMAIN>,
86400)
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_resolve_service_send]
(0x0100): Trying to resolve service 'sd_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [resolve_srv_send] (0x0200): The
status of SRV lookup is resolved
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [be_resolve_server_process]
(0x0200): Found address for server <DC2>.<AD DOMAIN>: [<IP>] TTL 3600
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [create_tgt_req_send_buffer]
(0x0400): buffer size: 88
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [set_tgt_child_timeout]
(0x0400): Setting 6 seconds timeout for TGT child
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [write_pipe_handler] (0x0400):
All data has been sent!
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [child_sig_handler] (0x0100):
child [19594] finished successfully.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [read_pipe_handler] (0x0400):
EOF received, client finished
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_tgt_recv] (0x0400):
Child responded: 0 [FILE:/var/lib/sss/db/ccache_<AD DOMAIN>], expired on
[1566340837]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_cli_auth_step] (0x0100):
expire timeout is 900
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sasl_bind_send] (0x0100):
Executing sasl bind mech: gssapi, user: SOC$
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_cli_connect_recv]
(0x0400): Connection established.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_set_port_status] (0x0100):
Marking port 389 of server '<DC2>.<AD DOMAIN>' as 'working'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [set_server_common_status]
(0x0100): Marking server '<DC2>.<AD DOMAIN>' as 'working'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_set_port_status] (0x0400):
Marking port 389 of duplicate server '<DC2>.<AD DOMAIN>' as
'working'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_search_user_next_base]
(0x0400): Searching for users with base [dc=AD,dc=AD,dc=AD,dc=AD]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with [(&(sAMAccountName=<MY
USERNAME>)(objectclass=user)(sAMAccountName=*)(objectSID=*))][dc=AD,dc=AD,dc=AD,dc=AD].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [be_run_online_cb] (0x0080):
Going online. Running callbacks.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_search_user_process]
(0x0400): Search for users, returned 1 results.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_user] (0x0400): Save
user
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_primary_name]
(0x0400): Processing object <MY USERNAME>
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_user] (0x0400):
Processing user <MY USERNAME>@<AD DOMAIN>
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_user] (0x0400):
Adding original memberOf attributes to [<MY USERNAME>@<AD DOMAIN>].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_user] (0x0400):
Adding user principal [<MY USERNAME>@<AD DOMAIN>] to attributes of [<MY
USERNAME>@<AD DOMAIN>].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_user] (0x0400):
Storing info for user <MY USERNAME>@<AD DOMAIN>
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<MY USERNAME>@<AD DOMAIN>,cn=users,cn=<AD DOMAIN>,cn=sysdb]
has set [cache, ts_cache] attrs.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<MY USERNAME>@<AD DOMAIN>,cn=users,cn=<AD DOMAIN>,cn=sysdb]
has set [cache, ts_cache] attrs.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1361432))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1503411))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ad_online_cb] (0x0400): The AD
provider is online
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1266082))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1253067))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1140136))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1503412))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1366593))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1008666))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1518318))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1181689))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1443520))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-513))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1112640))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1598605))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1320769))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-926787))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1138107))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1366580))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1354727))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-988735))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-1144159806-1873613549-2446533747-77016))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-1144159806-1873613549-2446533747-77017))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_search_bases_ex_next_base]
(0x0400): Issuing LDAP lookup with base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[objectClass=ipaexternalgroup][cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_search_bases_ex_done]
(0x0400): Receiving data from base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ipa_get_ext_groups_done]
(0x0400): [1] external groups found.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_mod_group_member]
(0x0080): ldb_modify failed: [Attribute or value exists](20)[attribute 'member':
value #14 on 'name=<POSIX GROUP 1>@<IPA DOMAIN>,cn=groups,cn=<IPA
DOMAIN>,cn=sysdb' already exists]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_mod_group_member]
(0x0400): Error: 17 (File exists)
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<MY USERNAME>@<AD DOMAIN>,cn=users,cn=<AD DOMAIN>,cn=sysdb]
has set [cache, ts_cache] attrs.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_mod_group_member]
(0x0080): ldb_modify failed: [Attribute or value exists](20)[attribute 'member':
value #14 on 'name=<POSIX GROUP 2>@<IPA DOMAIN>,cn=groups,cn=<IPA
DOMAIN>,cn=sysdb' already exists]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_mod_group_member]
(0x0400): Error: 17 (File exists)
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<MY USERNAME>@<AD DOMAIN>,cn=users,cn=<AD DOMAIN>,cn=sysdb]
has set [cache, ts_cache] attrs.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(cn=98def1e4-bde5-11e9-813b-005056bf293e)(|(objectClass=ipaUserGroup)(objectClass=posixGroup))(cn=*)(&(gidNumber=*)(!(gidNumber=0))))][cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [be_ptask_online_cb] (0x0400):
Back end is online
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [be_ptask_enable] (0x0080): Task
[Subdomains Refresh]: already enabled
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 0 results.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[ipa_add_ad_memberships_get_next] (0x0020): There are unresolved external group
memberships even after all groups have been looked up on the LDAP server.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #1]: Request handler finished [0]: Success
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #1]: Receiving request data.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #1]: Finished. Success.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:1::<AD DOMAIN>:name=<MY USERNAME>@<AD
DOMAIN>] from reply table
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #1]: Request removed.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [be_ptask_online_cb] (0x0400):
Back end is online
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [be_ptask_enable] (0x0080): Task
[SUDO Smart Refresh]: already enabled
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [be_ptask_online_cb] (0x0400):
Back end is online
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [be_ptask_enable] (0x0080): Task
[SUDO Full Refresh]: already enabled
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x3][BE_REQ_INITGROUPS][name=<MY USERNAME>@<AD
DOMAIN>]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Initgroups #2]: New request. Flags [0x0001].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with [(&(objectClass=ipaUserOverride)(uid=<MY
USERNAME>))][cn=Default Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ipa_srv_ad_acct_lookup_step]
(0x0400): Looking up AD account
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_resolve_service_send]
(0x0100): Trying to resolve service 'sd_gc_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [resolve_srv_send] (0x0200): The
status of SRV lookup is neutral
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ad_srv_plugin_send] (0x0400):
About to find domain controllers
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ad_get_dc_servers_send]
(0x0400): Looking up domain controllers in domain <AD DOMAIN> and site GMA
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[resolv_discover_srv_next_domain] (0x0400): SRV resolution of service 'ldap'. Will
use DNS discovery domain 'GMA._sites.<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [resolv_getsrv_send] (0x0100):
Trying to resolve SRV record of '_ldap._tcp.GMA._sites.<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [request_watch_destructor]
(0x0400): Deleting request watch
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_discover_srv_done] (0x0400):
Got answer. Processing...
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_discover_srv_done] (0x0400):
Got 8 servers
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ad_get_dc_servers_done]
(0x0400): Found 8 domain controllers in domain GMA._sites.<AD DOMAIN>
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ad_srv_plugin_dcs_done]
(0x0400): About to locate suitable site
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_connect_host_send]
(0x0400): Resolving host <DC2>.<AD DOMAIN>
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[resolv_gethostbyname_files_send] (0x0100): Trying to resolve A record of
'<DC2>.<AD DOMAIN>' in files
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[resolv_gethostbyname_files_send] (0x0100): Trying to resolve AAAA record of
'<DC2>.<AD DOMAIN>' in files
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [resolv_gethostbyname_next]
(0x0200): No more address families to retry
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [resolv_gethostbyname_dns_query]
(0x0100): Trying to resolve A record of '<DC2>.<AD DOMAIN>' in DNS
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [request_watch_destructor]
(0x0400): Deleting request watch
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_connect_host_resolv_done]
(0x0400): Connecting to ldap://<DC2>.<AD DOMAIN>:389
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sssd_async_socket_init_send]
(0x0400): Setting 6 seconds timeout for connecting
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_connect_host_done]
(0x0400): Successful connection to ldap://<DC2>.<AD DOMAIN>:389
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with [(&(DnsDomain=<AD
DOMAIN>)(NtVer=\14\00\00\00))][].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ad_get_client_site_done]
(0x0400): Found site: GMA
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ad_get_client_site_done]
(0x0400): Found forest: <AD DOMAIN>
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ad_srv_plugin_site_done]
(0x0400): About to discover primary and backup servers
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_discover_servers_send]
(0x0400): Looking up primary servers
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[resolv_discover_srv_next_domain] (0x0400): SRV resolution of service 'gc'. Will
use DNS discovery domain 'GMA._sites.<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [resolv_getsrv_send] (0x0100):
Trying to resolve SRV record of '_gc._tcp.GMA._sites.<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [request_watch_destructor]
(0x0400): Deleting request watch
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_discover_srv_done] (0x0400):
Got answer. Processing...
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_discover_srv_done] (0x0400):
Got 11 servers
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[fo_discover_servers_primary_done] (0x0400): Looking up backup servers
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[resolv_discover_srv_next_domain] (0x0400): SRV resolution of service 'gc'. Will
use DNS discovery domain '<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [resolv_getsrv_send] (0x0100):
Trying to resolve SRV record of '_gc._tcp.<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [request_watch_destructor]
(0x0400): Deleting request watch
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_discover_srv_done] (0x0400):
Got answer. Processing...
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_discover_srv_done] (0x0400):
Got 18 servers
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ad_srv_plugin_servers_done]
(0x0400): Got 11 primary and 18 backup servers
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted primary server '<DC2>.<AD DOMAIN>:3268' to service
'sd_gc_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted primary server '<DC4>.<AD DOMAIN>:3268' to service
'sd_gc_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted primary server '<DC8>.<AD DOMAIN>:3268' to service
'sd_gc_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted primary server '<DC7>.<AD DOMAIN>:3268' to service
'sd_gc_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted primary server '<DC6>.<AD DOMAIN>:3268' to service
'sd_gc_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted primary server '<DC5>.<AD DOMAIN>:3268' to service
'sd_gc_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted primary server '<DC1>.<AD DOMAIN>:3268' to service
'sd_gc_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted primary server '<DC3>.<AD DOMAIN>:3268' to service
'sd_gc_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted primary server '<DC16>.<AD DOMAIN>:3268' to service
'sd_gc_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted primary server '<DC17>.<AD DOMAIN>:3268' to service
'sd_gc_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted primary server '<DC18>.<AD DOMAIN>:3268' to service
'sd_gc_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Server '<DC7>.<AD DOMAIN>:3268' for service
'sd_gc_<AD DOMAIN>' is already present
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted backup server '<DC9>.<AD DOMAIN>:3268' to service
'sd_gc_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Server '<DC1>.<AD DOMAIN>:3268' for service
'sd_gc_<AD DOMAIN>' is already present
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Server '<DC16>.<AD DOMAIN>:3268' for service
'sd_gc_<AD DOMAIN>' is already present
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted backup server '<DC10>.<AD DOMAIN>:3268' to service
'sd_gc_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Server '<DC5>.<AD DOMAIN>:3268' for service
'sd_gc_<AD DOMAIN>' is already present
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Server '<DC4>.<AD DOMAIN>:3268' for service
'sd_gc_<AD DOMAIN>' is already present
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted backup server '<DC15>.<AD DOMAIN>:3268' to service
'sd_gc_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted backup server '<DC14>.<AD DOMAIN>:3268' to service
'sd_gc_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted backup server '<DC13>.<AD DOMAIN>:3268' to service
'sd_gc_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted backup server '<DC11>.<AD DOMAIN>:3268' to service
'sd_gc_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted backup server '<DC12>.<AD DOMAIN>:3268' to service
'sd_gc_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Server '<DC2>.<AD DOMAIN>:3268' for service
'sd_gc_<AD DOMAIN>' is already present
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Server '<DC6>.<AD DOMAIN>:3268' for service
'sd_gc_<AD DOMAIN>' is already present
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted backup server '<DC19>.<AD DOMAIN>:3268' to service
'sd_gc_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Server '<DC17>.<AD DOMAIN>:3268' for service
'sd_gc_<AD DOMAIN>' is already present
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted backup server '<DC20>.<AD DOMAIN>:3268' to service
'sd_gc_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_add_server_to_list]
(0x0400): Inserted backup server '<DC21>.<AD DOMAIN>:3268' to service
'sd_gc_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [set_srv_data_status] (0x0100):
Marking SRV lookup of service 'sd_gc_<AD DOMAIN>' as 'resolved'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [be_resolve_server_process]
(0x0200): Found address for server <DC2>.<AD DOMAIN>: [<IP>] TTL 3600
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ad_resolve_callback] (0x0100):
Constructed uri 'ldap://<DC2>.<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ad_resolve_callback] (0x0100):
Constructed GC uri 'ldap://<DC2>.<AD DOMAIN>:3268'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sssd_async_socket_init_send]
(0x0400): Setting 6 seconds timeout for connecting
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with [(objectclass=*)][].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[sdap_get_server_opts_from_rootdse] (0x0100): Setting AD compatibility level to [4]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[sdap_get_server_opts_from_rootdse] (0x0100): Will look for schema at
[CN=Schema,CN=Configuration,DC=AD,DC=AD,DC=AD]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_kinit_send] (0x0400):
Attempting kinit (/var/lib/sss/keytabs/<AD DOMAIN>.keytab, SOC$, <AD DOMAIN>,
86400)
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_resolve_service_send]
(0x0100): Trying to resolve service 'sd_<AD DOMAIN>'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [resolve_srv_send] (0x0200): The
status of SRV lookup is resolved
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [be_resolve_server_process]
(0x0200): Found address for server <DC2>.<AD DOMAIN>: [<IP>] TTL 3600
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [create_tgt_req_send_buffer]
(0x0400): buffer size: 88
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [set_tgt_child_timeout]
(0x0400): Setting 6 seconds timeout for TGT child
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[delayed_online_authentication_callback] (0x0200): Backend is online, starting delayed
online authentication.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [write_pipe_handler] (0x0400):
All data has been sent!
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [child_sig_handler] (0x0100):
child [19596] finished successfully.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [read_pipe_handler] (0x0400):
EOF received, client finished
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_tgt_recv] (0x0400):
Child responded: 0 [FILE:/var/lib/sss/db/ccache_<AD DOMAIN>], expired on
[1566340837]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_cli_auth_step] (0x0100):
expire timeout is 900
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sasl_bind_send] (0x0100):
Executing sasl bind mech: gssapi, user: SOC$
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_cli_connect_recv]
(0x0400): Connection established.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_set_port_status] (0x0100):
Marking port 3268 of server '<DC2>.<AD DOMAIN>' as 'working'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [set_server_common_status]
(0x0100): Marking server '<DC2>.<AD DOMAIN>' as 'working'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [fo_set_port_status] (0x0400):
Marking port 3268 of duplicate server '<DC2>.<AD DOMAIN>' as
'working'
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_initgr_next_base]
(0x0400): Searching for users with base [dc=AD,dc=AD,dc=AD,dc=AD]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with [(&(sAMAccountName=<MY
USERNAME>)(objectclass=user)(objectSID=*))][dc=AD,dc=AD,dc=AD,dc=AD].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_user] (0x0400): Save
user
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_primary_name]
(0x0400): Processing object <MY USERNAME>
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_user] (0x0400):
Processing user <MY USERNAME>@<AD DOMAIN>
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_user] (0x0400):
Adding original memberOf attributes to [<MY USERNAME>@<AD DOMAIN>].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_user] (0x0400):
Adding user principal [<MY USERNAME>@<AD DOMAIN>] to attributes of [<MY
USERNAME>@<AD DOMAIN>].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_user] (0x0400):
Storing info for user <MY USERNAME>@<AD DOMAIN>
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<MY USERNAME>@<AD DOMAIN>,cn=users,cn=<AD DOMAIN>,cn=sysdb]
has set [cache, ts_cache] attrs.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with [no filter][CN=<MY
USERNAME>,OU=<USERS>,OU=<COMPANY>,OU=Business
Units,DC=AD,DC=AD,DC=AD,DC=AD].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[sdap_ad_tokengroups_get_posix_members] (0x0080): Domain not found for SID
S-1-5-21-1851355360-2027500884-774919444-153082
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_initgr_done] (0x0400):
Primary group already cached, nothing to do.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<MY USERNAME>@<AD DOMAIN>,cn=users,cn=<AD DOMAIN>,cn=sysdb]
has set [cache, ts_cache] attrs.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1361432))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1503411))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1266082))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1253067))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1140136))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1503412))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1366593))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1008666))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1518318))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1181689))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1443520))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-513))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1112640))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1598605))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1320769))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-926787))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1138107))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1366580))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1354727))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-988735))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-1144159806-1873613549-2446533747-77016))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ipa_get_ad_memberships_send]
(0x0400): External group information still valid.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<MY USERNAME>@<AD DOMAIN>,cn=users,cn=<AD DOMAIN>,cn=sysdb]
has set [cache, ts_cache] attrs.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<MY USERNAME>@<AD DOMAIN>,cn=users,cn=<AD DOMAIN>,cn=sysdb]
has set [cache, ts_cache] attrs.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(cn=98def1e4-bde5-11e9-813b-005056bf293e)(|(objectClass=ipaUserGroup)(objectClass=posixGroup))(cn=*)(&(gidNumber=*)(!(gidNumber=0))))][cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 0 results.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[ipa_add_ad_memberships_get_next] (0x0020): There are unresolved external group
memberships even after all groups have been looked up on the LDAP server.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Initgroups #2]: Request handler finished [0]: Success
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Initgroups #2]: Receiving request data.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<MY USERNAME>@<AD DOMAIN>,cn=users,cn=<AD DOMAIN>,cn=sysdb]
has set [ts_cache] attrs.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_initgr_pp_nss_notify]
(0x0400): Ordering NSS responder to update memory cache
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Initgroups #2]: Finished. Success.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:3::<AD DOMAIN>:name=<MY USERNAME>@<AD
DOMAIN>] from reply table
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Initgroups #2]: Request removed.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [AccountDomain #3]: New request. Flags [0000].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [AccountDomain #3]: Request handler finished [0]: Success
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [AccountDomain #3]: Receiving request data.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [AccountDomain #3]: Finished. Success.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:10:0000:0x55be877fa480] from reply table
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [AccountDomain #3]: Request removed.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3361432]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #4]: New request. Flags [0x0001].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(gidNumber=3361432)(|(objectClass=ipaUserGroup)(objectClass=posixGroup))(cn=*)(&(gidNumber=*)(!(gidNumber=0))))][cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 0 results.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_search_group_by_gid]
(0x0400): No such entry
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_delete_group] (0x0400):
Error: 2 (No such file or directory)
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[ipa_id_get_account_info_orig_done] (0x0080): Object not found, ending request
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #4]: Request handler finished [0]: Success
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #4]: Receiving request data.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #4]: Finished. Success.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<IPA DOMAIN>:idnumber=3361432] from reply table
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #4]: Request removed.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3503411]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #5]: New request. Flags [0x0001].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(gidNumber=3503411)(|(objectClass=ipaUserGroup)(objectClass=posixGroup))(cn=*)(&(gidNumber=*)(!(gidNumber=0))))][cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 0 results.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_search_group_by_gid]
(0x0400): No such entry
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_delete_group] (0x0400):
Error: 2 (No such file or directory)
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[ipa_id_get_account_info_orig_done] (0x0080): Object not found, ending request
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #5]: Request handler finished [0]: Success
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #5]: Receiving request data.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #5]: Finished. Success.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<IPA DOMAIN>:idnumber=3503411] from reply table
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #5]: Request removed.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3503411]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #6]: New request. Flags [0x0001].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaGroupOverride)(gidNumber=3503411))][cn=Default Trust
View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [ipa_srv_ad_acct_lookup_step]
(0x0400): Looking up AD account
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [dc=AD,dc=AD,dc=AD,dc=AD]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectSID=S-1-5-21-2129867641-1448237841-168566570-1503411)(objectClass=group)(sAMAccountName=*))][dc=AD,dc=AD,dc=AD,dc=AD].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 1 results.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_has_deref_support]
(0x0400): The server supports deref method ASQ
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 0 users found in the hash table
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 1 groups found in the hash table
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_primary_name]
(0x0400): Processing object <AD GROUP>
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Processing group <AD GROUP>@<AD DOMAIN>
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): The group has 0 members
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): Group has 0 members
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Storing info for group <AD GROUP>@<AD DOMAIN>
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<AD GROUP>@<AD DOMAIN>,cn=groups,cn=<AD DOMAIN>,cn=sysdb]
has set [ts_cache] attrs.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_grpmem] (0x0020):
Group members are ignored, nothing to do. If you see this message it might indicate an
error in the group processing logic.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [apply_subdomain_homedir]
(0x0040): UID for user [<AD GROUP>@<AD DOMAIN>] is not known.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1503411))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #6]: Request handler finished [0]: Success
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #6]: Receiving request data.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #6]: Finished. Success.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<AD DOMAIN>:idnumber=3503411] from reply table
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #6]: Request removed.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3266082]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #7]: New request. Flags [0x0001].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(gidNumber=3266082)(|(objectClass=ipaUserGroup)(objectClass=posixGroup))(cn=*)(&(gidNumber=*)(!(gidNumber=0))))][cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 0 results.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_search_group_by_gid]
(0x0400): No such entry
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_delete_group] (0x0400):
Error: 2 (No such file or directory)
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]]
[ipa_id_get_account_info_orig_done] (0x0080): Object not found, ending request
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #7]: Request handler finished [0]: Success
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #7]: Receiving request data.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #7]: Finished. Success.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<IPA DOMAIN>:idnumber=3266082] from reply table
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #7]: Request removed.
(Tue Aug 20 08:40:37 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3266082]
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #8]: New request. Flags [0x0001].
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaGroupOverride)(gidNumber=3266082))][cn=Default Trust
View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [ipa_srv_ad_acct_lookup_step]
(0x0400): Looking up AD account
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [dc=AD,dc=AD,dc=AD,dc=AD]
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectSID=S-1-5-21-2129867641-1448237841-168566570-1266082)(objectClass=group)(sAMAccountName=*))][dc=AD,dc=AD,dc=AD,dc=AD].
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 1 results.
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_has_deref_support]
(0x0400): The server supports deref method ASQ
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 0 users found in the hash table
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 1 groups found in the hash table
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_primary_name]
(0x0400): Processing object <AD GROUP 2>
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Processing group <AD GROUP 2>@<AD DOMAIN>
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): The group has 0 members
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): Group has 0 members
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Storing info for group <AD GROUP 2>@<AD DOMAIN>
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<AD GROUP 2>@<AD DOMAIN>,cn=groups,cn=<AD DOMAIN>,cn=sysdb]
has set [ts_cache] attrs.
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_grpmem] (0x0020):
Group members are ignored, nothing to do. If you see this message it might indicate an
error in the group processing logic.
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [apply_subdomain_homedir]
(0x0040): UID for user [<AD GROUP 2>@<AD DOMAIN>] is not known.
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1266082))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #8]: Request handler finished [0]: Success
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #8]: Receiving request data.
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #8]: Finished. Success.
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<AD DOMAIN>:idnumber=3266082] from reply table
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #8]: Request removed.
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3253067]
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #9]: New request. Flags [0x0001].
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(gidNumber=3253067)(|(objectClass=ipaUserGroup)(objectClass=posixGroup))(cn=*)(&(gidNumber=*)(!(gidNumber=0))))][cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 0 results.
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_search_group_by_gid]
(0x0400): No such entry
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_delete_group] (0x0400):
Error: 2 (No such file or directory)
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]]
[ipa_id_get_account_info_orig_done] (0x0080): Object not found, ending request
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #9]: Request handler finished [0]: Success
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #9]: Receiving request data.
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #9]: Finished. Success.
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<IPA DOMAIN>:idnumber=3253067] from reply table
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #9]: Request removed.
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3253067]
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #10]: New request. Flags [0x0001].
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaGroupOverride)(gidNumber=3253067))][cn=Default Trust
View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [ipa_srv_ad_acct_lookup_step]
(0x0400): Looking up AD account
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [dc=AD,dc=AD,dc=AD,dc=AD]
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectSID=S-1-5-21-2129867641-1448237841-168566570-1253067)(objectClass=group)(sAMAccountName=*))][dc=AD,dc=AD,dc=AD,dc=AD].
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 1 results.
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_has_deref_support]
(0x0400): The server supports deref method ASQ
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 0 users found in the hash table
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 1 groups found in the hash table
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_primary_name]
(0x0400): Processing object <AD GROUP 3>
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Processing group <AD GROUP 3>@<AD DOMAIN>
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): The group has 0 members
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): Group has 0 members
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Storing info for group <AD GROUP 3>@<AD DOMAIN>
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<AD GROUP 3>@<AD DOMAIN>,cn=groups,cn=<AD DOMAIN>,cn=sysdb]
has set [ts_cache] attrs.
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_grpmem] (0x0020):
Group members are ignored, nothing to do. If you see this message it might indicate an
error in the group processing logic.
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [apply_subdomain_homedir]
(0x0040): UID for user [<AD GROUP 3>@<AD DOMAIN>] is not known.
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1253067))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #10]: Request handler finished [0]: Success
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #10]: Receiving request data.
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #10]: Finished. Success.
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<AD DOMAIN>:idnumber=3253067] from reply table
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #10]: Request removed.
(Tue Aug 20 08:40:38 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3140136]
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #11]: New request. Flags [0x0001].
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(gidNumber=3140136)(|(objectClass=ipaUserGroup)(objectClass=posixGroup))(cn=*)(&(gidNumber=*)(!(gidNumber=0))))][cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 0 results.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_search_group_by_gid]
(0x0400): No such entry
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_delete_group] (0x0400):
Error: 2 (No such file or directory)
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]]
[ipa_id_get_account_info_orig_done] (0x0080): Object not found, ending request
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #11]: Request handler finished [0]: Success
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #11]: Receiving request data.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #11]: Finished. Success.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<IPA DOMAIN>:idnumber=3140136] from reply table
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #11]: Request removed.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3140136]
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #12]: New request. Flags [0x0001].
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaGroupOverride)(gidNumber=3140136))][cn=Default Trust
View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [ipa_srv_ad_acct_lookup_step]
(0x0400): Looking up AD account
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [dc=AD,dc=AD,dc=AD,dc=AD]
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectSID=S-1-5-21-2129867641-1448237841-168566570-1140136)(objectClass=group)(sAMAccountName=*))][dc=AD,dc=AD,dc=AD,dc=AD].
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 1 results.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_has_deref_support]
(0x0400): The server supports deref method ASQ
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 0 users found in the hash table
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 1 groups found in the hash table
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_primary_name]
(0x0400): Processing object <AD GROUP 4>
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Processing group <AD GROUP 4>@<AD DOMAIN>
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): The group has 0 members
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): Group has 0 members
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Storing info for group <AD GROUP 4>@<AD DOMAIN>
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<AD GROUP 4>@<AD DOMAIN>,cn=groups,cn=<AD DOMAIN>,cn=sysdb]
has set [ts_cache] attrs.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_grpmem] (0x0020):
Group members are ignored, nothing to do. If you see this message it might indicate an
error in the group processing logic.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [apply_subdomain_homedir]
(0x0040): UID for user [<AD GROUP 4>@<AD DOMAIN>] is not known.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1140136))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #12]: Request handler finished [0]: Success
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #12]: Receiving request data.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #12]: Finished. Success.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<AD DOMAIN>:idnumber=3140136] from reply table
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #12]: Request removed.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3503412]
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #13]: New request. Flags [0x0001].
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(gidNumber=3503412)(|(objectClass=ipaUserGroup)(objectClass=posixGroup))(cn=*)(&(gidNumber=*)(!(gidNumber=0))))][cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 0 results.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_search_group_by_gid]
(0x0400): No such entry
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_delete_group] (0x0400):
Error: 2 (No such file or directory)
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]]
[ipa_id_get_account_info_orig_done] (0x0080): Object not found, ending request
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #13]: Request handler finished [0]: Success
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #13]: Receiving request data.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #13]: Finished. Success.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<IPA DOMAIN>:idnumber=3503412] from reply table
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #13]: Request removed.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3503412]
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #14]: New request. Flags [0x0001].
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaGroupOverride)(gidNumber=3503412))][cn=Default Trust
View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [ipa_srv_ad_acct_lookup_step]
(0x0400): Looking up AD account
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [dc=AD,dc=AD,dc=AD,dc=AD]
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectSID=S-1-5-21-2129867641-1448237841-168566570-1503412)(objectClass=group)(sAMAccountName=*))][dc=AD,dc=AD,dc=AD,dc=AD].
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 1 results.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_has_deref_support]
(0x0400): The server supports deref method ASQ
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 0 users found in the hash table
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 1 groups found in the hash table
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_primary_name]
(0x0400): Processing object <AD GROUP 5>
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Processing group <AD GROUP 5>@<AD DOMAIN>
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): The group has 0 members
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): Group has 0 members
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Storing info for group <AD GROUP 5>@<AD DOMAIN>
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<AD GROUP 5>@<AD DOMAIN>,cn=groups,cn=<AD DOMAIN>,cn=sysdb]
has set [ts_cache] attrs.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_grpmem] (0x0020):
Group members are ignored, nothing to do. If you see this message it might indicate an
error in the group processing logic.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [apply_subdomain_homedir]
(0x0040): UID for user [<AD GROUP 5>@<AD DOMAIN>] is not known.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1503412))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #14]: Request handler finished [0]: Success
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #14]: Receiving request data.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #14]: Finished. Success.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<AD DOMAIN>:idnumber=3503412] from reply table
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #14]: Request removed.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3366593]
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #15]: New request. Flags [0x0001].
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(gidNumber=3366593)(|(objectClass=ipaUserGroup)(objectClass=posixGroup))(cn=*)(&(gidNumber=*)(!(gidNumber=0))))][cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 0 results.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_search_group_by_gid]
(0x0400): No such entry
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_delete_group] (0x0400):
Error: 2 (No such file or directory)
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]]
[ipa_id_get_account_info_orig_done] (0x0080): Object not found, ending request
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #15]: Request handler finished [0]: Success
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #15]: Receiving request data.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #15]: Finished. Success.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<IPA DOMAIN>:idnumber=3366593] from reply table
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #15]: Request removed.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3366593]
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #16]: New request. Flags [0x0001].
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaGroupOverride)(gidNumber=3366593))][cn=Default Trust
View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [ipa_srv_ad_acct_lookup_step]
(0x0400): Looking up AD account
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [dc=AD,dc=AD,dc=AD,dc=AD]
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectSID=S-1-5-21-2129867641-1448237841-168566570-1366593)(objectClass=group)(sAMAccountName=*))][dc=AD,dc=AD,dc=AD,dc=AD].
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 1 results.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_has_deref_support]
(0x0400): The server supports deref method ASQ
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 0 users found in the hash table
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 1 groups found in the hash table
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_primary_name]
(0x0400): Processing object <AD GROUP 6>
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Processing group <AD GROUP 6>@<AD DOMAIN>
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): The group has 0 members
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): Group has 0 members
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Storing info for group <AD GROUP 6>@<AD DOMAIN>
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<AD GROUP 6>@<AD DOMAIN>,cn=groups,cn=<AD DOMAIN>,cn=sysdb]
has set [ts_cache] attrs.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_grpmem] (0x0020):
Group members are ignored, nothing to do. If you see this message it might indicate an
error in the group processing logic.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [apply_subdomain_homedir]
(0x0040): UID for user [<AD GROUP 6>@<AD DOMAIN>] is not known.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1366593))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #16]: Request handler finished [0]: Success
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #16]: Receiving request data.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #16]: Finished. Success.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<AD DOMAIN>:idnumber=3366593] from reply table
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #16]: Request removed.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3008666]
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #17]: New request. Flags [0x0001].
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(gidNumber=3008666)(|(objectClass=ipaUserGroup)(objectClass=posixGroup))(cn=*)(&(gidNumber=*)(!(gidNumber=0))))][cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 0 results.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_search_group_by_gid]
(0x0400): No such entry
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_delete_group] (0x0400):
Error: 2 (No such file or directory)
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]]
[ipa_id_get_account_info_orig_done] (0x0080): Object not found, ending request
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #17]: Request handler finished [0]: Success
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #17]: Receiving request data.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #17]: Finished. Success.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<IPA DOMAIN>:idnumber=3008666] from reply table
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #17]: Request removed.
(Tue Aug 20 08:40:39 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3008666]
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #18]: New request. Flags [0x0001].
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaGroupOverride)(gidNumber=3008666))][cn=Default Trust
View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [ipa_srv_ad_acct_lookup_step]
(0x0400): Looking up AD account
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [dc=AD,dc=AD,dc=AD,dc=AD]
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectSID=S-1-5-21-2129867641-1448237841-168566570-1008666)(objectClass=group)(sAMAccountName=*))][dc=AD,dc=AD,dc=AD,dc=AD].
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 1 results.
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_has_deref_support]
(0x0400): The server supports deref method ASQ
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 0 users found in the hash table
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 1 groups found in the hash table
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_primary_name]
(0x0400): Processing object <AD GROUP 7>
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Processing group <AD GROUP 7>@<AD DOMAIN>
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): The group has 0 members
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): Group has 0 members
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Storing info for group <AD GROUP 7>@<AD DOMAIN>
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<AD GROUP 7>@<AD DOMAIN>,cn=groups,cn=<AD DOMAIN>,cn=sysdb]
has set [ts_cache] attrs.
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_grpmem] (0x0020):
Group members are ignored, nothing to do. If you see this message it might indicate an
error in the group processing logic.
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [apply_subdomain_homedir]
(0x0040): UID for user [<AD GROUP 7>@<AD DOMAIN>] is not known.
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1008666))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #18]: Request handler finished [0]: Success
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #18]: Receiving request data.
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #18]: Finished. Success.
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<AD DOMAIN>:idnumber=3008666] from reply table
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #18]: Request removed.
(Tue Aug 20 08:40:41 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3518318]
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #19]: New request. Flags [0x0001].
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(gidNumber=3518318)(|(objectClass=ipaUserGroup)(objectClass=posixGroup))(cn=*)(&(gidNumber=*)(!(gidNumber=0))))][cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 0 results.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_search_group_by_gid]
(0x0400): No such entry
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_delete_group] (0x0400):
Error: 2 (No such file or directory)
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]]
[ipa_id_get_account_info_orig_done] (0x0080): Object not found, ending request
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #19]: Request handler finished [0]: Success
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #19]: Receiving request data.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #19]: Finished. Success.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<IPA DOMAIN>:idnumber=3518318] from reply table
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #19]: Request removed.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3518318]
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #20]: New request. Flags [0x0001].
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaGroupOverride)(gidNumber=3518318))][cn=Default Trust
View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [ipa_srv_ad_acct_lookup_step]
(0x0400): Looking up AD account
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [dc=AD,dc=AD,dc=AD,dc=AD]
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectSID=S-1-5-21-2129867641-1448237841-168566570-1518318)(objectClass=group)(sAMAccountName=*))][dc=AD,dc=AD,dc=AD,dc=AD].
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 1 results.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_has_deref_support]
(0x0400): The server supports deref method ASQ
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 0 users found in the hash table
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 1 groups found in the hash table
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_primary_name]
(0x0400): Processing object <AD GROUP 8>
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Processing group <AD GROUP 8>@<AD DOMAIN>
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): The group has 0 members
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): Group has 0 members
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Storing info for group <AD GROUP 8>@<AD DOMAIN>
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<AD GROUP 8>@<AD DOMAIN>,cn=groups,cn=<AD DOMAIN>,cn=sysdb]
has set [ts_cache] attrs.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_grpmem] (0x0020):
Group members are ignored, nothing to do. If you see this message it might indicate an
error in the group processing logic.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [apply_subdomain_homedir]
(0x0040): UID for user [<AD GROUP 8>@<AD DOMAIN>] is not known.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1518318))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #20]: Request handler finished [0]: Success
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #20]: Receiving request data.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #20]: Finished. Success.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<AD DOMAIN>:idnumber=3518318] from reply table
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #20]: Request removed.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3181689]
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #21]: New request. Flags [0x0001].
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(gidNumber=3181689)(|(objectClass=ipaUserGroup)(objectClass=posixGroup))(cn=*)(&(gidNumber=*)(!(gidNumber=0))))][cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 0 results.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_search_group_by_gid]
(0x0400): No such entry
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_delete_group] (0x0400):
Error: 2 (No such file or directory)
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]]
[ipa_id_get_account_info_orig_done] (0x0080): Object not found, ending request
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #21]: Request handler finished [0]: Success
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #21]: Receiving request data.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #21]: Finished. Success.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<IPA DOMAIN>:idnumber=3181689] from reply table
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #21]: Request removed.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3181689]
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #22]: New request. Flags [0x0001].
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaGroupOverride)(gidNumber=3181689))][cn=Default Trust
View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [ipa_srv_ad_acct_lookup_step]
(0x0400): Looking up AD account
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [dc=AD,dc=AD,dc=AD,dc=AD]
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectSID=S-1-5-21-2129867641-1448237841-168566570-1181689)(objectClass=group)(sAMAccountName=*))][dc=AD,dc=AD,dc=AD,dc=AD].
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 1 results.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_has_deref_support]
(0x0400): The server supports deref method ASQ
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 0 users found in the hash table
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 1 groups found in the hash table
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_primary_name]
(0x0400): Processing object <AD GROUP 9>
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Processing group <AD GROUP 9>@<AD DOMAIN>
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): The group has 0 members
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): Group has 0 members
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Storing info for group <AD GROUP 9>@<AD DOMAIN>
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<AD GROUP 9>@<AD DOMAIN>,cn=groups,cn=<AD DOMAIN>,cn=sysdb]
has set [ts_cache] attrs.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_grpmem] (0x0020):
Group members are ignored, nothing to do. If you see this message it might indicate an
error in the group processing logic.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [apply_subdomain_homedir]
(0x0040): UID for user [<AD GROUP 9>@<AD DOMAIN>] is not known.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1181689))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #22]: Request handler finished [0]: Success
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #22]: Receiving request data.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #22]: Finished. Success.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<AD DOMAIN>:idnumber=3181689] from reply table
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #22]: Request removed.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3443520]
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #23]: New request. Flags [0x0001].
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(gidNumber=3443520)(|(objectClass=ipaUserGroup)(objectClass=posixGroup))(cn=*)(&(gidNumber=*)(!(gidNumber=0))))][cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 0 results.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_search_group_by_gid]
(0x0400): No such entry
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_delete_group] (0x0400):
Error: 2 (No such file or directory)
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]]
[ipa_id_get_account_info_orig_done] (0x0080): Object not found, ending request
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #23]: Request handler finished [0]: Success
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #23]: Receiving request data.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #23]: Finished. Success.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<IPA DOMAIN>:idnumber=3443520] from reply table
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #23]: Request removed.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3443520]
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #24]: New request. Flags [0x0001].
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaGroupOverride)(gidNumber=3443520))][cn=Default Trust
View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [ipa_srv_ad_acct_lookup_step]
(0x0400): Looking up AD account
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [dc=AD,dc=AD,dc=AD,dc=AD]
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectSID=S-1-5-21-2129867641-1448237841-168566570-1443520)(objectClass=group)(sAMAccountName=*))][dc=AD,dc=AD,dc=AD,dc=AD].
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 1 results.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_has_deref_support]
(0x0400): The server supports deref method ASQ
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 0 users found in the hash table
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 1 groups found in the hash table
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_primary_name]
(0x0400): Processing object <AD GROUP 10>
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Processing group <AD GROUP 10>@<AD DOMAIN>
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): The group has 0 members
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): Group has 0 members
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Storing info for group <AD GROUP 10>@<AD DOMAIN>
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<AD GROUP 10>@<AD DOMAIN>,cn=groups,cn=<AD DOMAIN>,cn=sysdb]
has set [ts_cache] attrs.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_grpmem] (0x0020):
Group members are ignored, nothing to do. If you see this message it might indicate an
error in the group processing logic.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [apply_subdomain_homedir]
(0x0040): UID for user [<AD GROUP 10>@<AD DOMAIN>] is not known.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1443520))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #24]: Request handler finished [0]: Success
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #24]: Receiving request data.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #24]: Finished. Success.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<AD DOMAIN>:idnumber=3443520] from reply table
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #24]: Request removed.
(Tue Aug 20 08:40:42 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=2000513]
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #25]: New request. Flags [0x0001].
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(gidNumber=2000513)(|(objectClass=ipaUserGroup)(objectClass=posixGroup))(cn=*)(&(gidNumber=*)(!(gidNumber=0))))][cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 0 results.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_search_group_by_gid]
(0x0400): No such entry
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_delete_group] (0x0400):
Error: 2 (No such file or directory)
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]]
[ipa_id_get_account_info_orig_done] (0x0080): Object not found, ending request
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #25]: Request handler finished [0]: Success
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #25]: Receiving request data.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #25]: Finished. Success.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<IPA DOMAIN>:idnumber=2000513] from reply table
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #25]: Request removed.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=2000513]
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #26]: New request. Flags [0x0001].
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaGroupOverride)(gidNumber=2000513))][cn=Default Trust
View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [ipa_srv_ad_acct_lookup_step]
(0x0400): Looking up AD account
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [dc=AD,dc=AD,dc=AD,dc=AD]
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectSID=S-1-5-21-2129867641-1448237841-168566570-513)(objectClass=group)(sAMAccountName=*))][dc=AD,dc=AD,dc=AD,dc=AD].
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 1 results.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_has_deref_support]
(0x0400): The server supports deref method ASQ
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 0 users found in the hash table
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 1 groups found in the hash table
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_primary_name]
(0x0400): Processing object Domain Users
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Processing group Domain Users@<AD DOMAIN>
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): The group has 0 members
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): Group has 0 members
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Storing info for group Domain Users@<AD DOMAIN>
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=Domain Users@<AD DOMAIN>,cn=groups,cn=<AD DOMAIN>,cn=sysdb] has
set [ts_cache] attrs.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_grpmem] (0x0020):
Group members are ignored, nothing to do. If you see this message it might indicate an
error in the group processing logic.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [apply_subdomain_homedir]
(0x0040): UID for user [Domain Users@<AD DOMAIN>] is not known.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-513))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #26]: Request handler finished [0]: Success
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #26]: Receiving request data.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #26]: Finished. Success.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<AD DOMAIN>:idnumber=2000513] from reply table
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #26]: Request removed.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3112640]
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #27]: New request. Flags [0x0001].
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(gidNumber=3112640)(|(objectClass=ipaUserGroup)(objectClass=posixGroup))(cn=*)(&(gidNumber=*)(!(gidNumber=0))))][cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 0 results.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_search_group_by_gid]
(0x0400): No such entry
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_delete_group] (0x0400):
Error: 2 (No such file or directory)
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]]
[ipa_id_get_account_info_orig_done] (0x0080): Object not found, ending request
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #27]: Request handler finished [0]: Success
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #27]: Receiving request data.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #27]: Finished. Success.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<IPA DOMAIN>:idnumber=3112640] from reply table
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #27]: Request removed.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3112640]
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #28]: New request. Flags [0x0001].
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaGroupOverride)(gidNumber=3112640))][cn=Default Trust
View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [ipa_srv_ad_acct_lookup_step]
(0x0400): Looking up AD account
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [dc=AD,dc=AD,dc=AD,dc=AD]
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectSID=S-1-5-21-2129867641-1448237841-168566570-1112640)(objectClass=group)(sAMAccountName=*))][dc=AD,dc=AD,dc=AD,dc=AD].
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 1 results.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_has_deref_support]
(0x0400): The server supports deref method ASQ
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 0 users found in the hash table
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 1 groups found in the hash table
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_primary_name]
(0x0400): Processing object <AD GROUP 11>
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Processing group <AD GROUP 11>@<AD DOMAIN>
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): The group has 0 members
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): Group has 0 members
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Storing info for group <AD GROUP 11>@<AD DOMAIN>
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<AD GROUP 11>@<AD DOMAIN>,cn=groups,cn=<AD DOMAIN>,cn=sysdb]
has set [ts_cache] attrs.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_grpmem] (0x0020):
Group members are ignored, nothing to do. If you see this message it might indicate an
error in the group processing logic.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [apply_subdomain_homedir]
(0x0040): UID for user [<AD GROUP 11>@<AD DOMAIN>] is not known.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1112640))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #28]: Request handler finished [0]: Success
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #28]: Receiving request data.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #28]: Finished. Success.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<AD DOMAIN>:idnumber=3112640] from reply table
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #28]: Request removed.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3598605]
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #29]: New request. Flags [0x0001].
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(gidNumber=3598605)(|(objectClass=ipaUserGroup)(objectClass=posixGroup))(cn=*)(&(gidNumber=*)(!(gidNumber=0))))][cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 0 results.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_search_group_by_gid]
(0x0400): No such entry
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_delete_group] (0x0400):
Error: 2 (No such file or directory)
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]]
[ipa_id_get_account_info_orig_done] (0x0080): Object not found, ending request
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #29]: Request handler finished [0]: Success
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #29]: Receiving request data.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #29]: Finished. Success.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<IPA DOMAIN>:idnumber=3598605] from reply table
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #29]: Request removed.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3598605]
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #30]: New request. Flags [0x0001].
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaGroupOverride)(gidNumber=3598605))][cn=Default Trust
View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [ipa_srv_ad_acct_lookup_step]
(0x0400): Looking up AD account
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [dc=AD,dc=AD,dc=AD,dc=AD]
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectSID=S-1-5-21-2129867641-1448237841-168566570-1598605)(objectClass=group)(sAMAccountName=*))][dc=AD,dc=AD,dc=AD,dc=AD].
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 1 results.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_has_deref_support]
(0x0400): The server supports deref method ASQ
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 0 users found in the hash table
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 1 groups found in the hash table
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_primary_name]
(0x0400): Processing object <AD GROUP 12>
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Processing group <AD GROUP 12>@<AD DOMAIN>
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): The group has 0 members
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): Group has 0 members
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Storing info for group <AD GROUP 12>@<AD DOMAIN>
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<AD GROUP 12>@<AD DOMAIN>,cn=groups,cn=<AD DOMAIN>,cn=sysdb]
has set [ts_cache] attrs.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_grpmem] (0x0020):
Group members are ignored, nothing to do. If you see this message it might indicate an
error in the group processing logic.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [apply_subdomain_homedir]
(0x0040): UID for user [<AD GROUP 12>@<AD DOMAIN>] is not known.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1598605))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #30]: Request handler finished [0]: Success
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #30]: Receiving request data.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #30]: Finished. Success.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<AD DOMAIN>:idnumber=3598605] from reply table
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #30]: Request removed.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3320769]
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #31]: New request. Flags [0x0001].
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(gidNumber=3320769)(|(objectClass=ipaUserGroup)(objectClass=posixGroup))(cn=*)(&(gidNumber=*)(!(gidNumber=0))))][cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 0 results.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_search_group_by_gid]
(0x0400): No such entry
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_delete_group] (0x0400):
Error: 2 (No such file or directory)
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]]
[ipa_id_get_account_info_orig_done] (0x0080): Object not found, ending request
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #31]: Request handler finished [0]: Success
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #31]: Receiving request data.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #31]: Finished. Success.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<IPA DOMAIN>:idnumber=3320769] from reply table
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #31]: Request removed.
(Tue Aug 20 08:40:43 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3320769]
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #32]: New request. Flags [0x0001].
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaGroupOverride)(gidNumber=3320769))][cn=Default Trust
View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [ipa_srv_ad_acct_lookup_step]
(0x0400): Looking up AD account
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [dc=AD,dc=AD,dc=AD,dc=AD]
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectSID=S-1-5-21-2129867641-1448237841-168566570-1320769)(objectClass=group)(sAMAccountName=*))][dc=AD,dc=AD,dc=AD,dc=AD].
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 1 results.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_has_deref_support]
(0x0400): The server supports deref method ASQ
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 0 users found in the hash table
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 1 groups found in the hash table
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_primary_name]
(0x0400): Processing object <AD GROUP 13>
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Processing group <AD GROUP 13>@<AD DOMAIN>
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): The group has 0 members
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): Group has 0 members
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Storing info for group <AD GROUP 13>@<AD DOMAIN>
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<AD GROUP 13>@<AD DOMAIN>,cn=groups,cn=<AD DOMAIN>,cn=sysdb]
has set [ts_cache] attrs.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_grpmem] (0x0020):
Group members are ignored, nothing to do. If you see this message it might indicate an
error in the group processing logic.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [apply_subdomain_homedir]
(0x0040): UID for user [<AD GROUP 13>@<AD DOMAIN>] is not known.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1320769))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #32]: Request handler finished [0]: Success
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #32]: Receiving request data.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #32]: Finished. Success.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<AD DOMAIN>:idnumber=3320769] from reply table
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #32]: Request removed.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=2926787]
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #33]: New request. Flags [0x0001].
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(gidNumber=2926787)(|(objectClass=ipaUserGroup)(objectClass=posixGroup))(cn=*)(&(gidNumber=*)(!(gidNumber=0))))][cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 0 results.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_search_group_by_gid]
(0x0400): No such entry
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_delete_group] (0x0400):
Error: 2 (No such file or directory)
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]]
[ipa_id_get_account_info_orig_done] (0x0080): Object not found, ending request
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #33]: Request handler finished [0]: Success
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #33]: Receiving request data.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #33]: Finished. Success.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<IPA DOMAIN>:idnumber=2926787] from reply table
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #33]: Request removed.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=2926787]
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #34]: New request. Flags [0x0001].
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaGroupOverride)(gidNumber=2926787))][cn=Default Trust
View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [ipa_srv_ad_acct_lookup_step]
(0x0400): Looking up AD account
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [dc=AD,dc=AD,dc=AD,dc=AD]
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectSID=S-1-5-21-2129867641-1448237841-168566570-926787)(objectClass=group)(sAMAccountName=*))][dc=AD,dc=AD,dc=AD,dc=AD].
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 1 results.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_has_deref_support]
(0x0400): The server supports deref method ASQ
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 0 users found in the hash table
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 1 groups found in the hash table
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_primary_name]
(0x0400): Processing object <AD GROUP 14>
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Processing group <AD GROUP 14>@<AD DOMAIN>
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): The group has 0 members
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): Group has 0 members
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Storing info for group <AD GROUP 14>@<AD DOMAIN>
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<AD GROUP 14>@<AD DOMAIN>,cn=groups,cn=<AD DOMAIN>,cn=sysdb]
has set [ts_cache] attrs.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_grpmem] (0x0020):
Group members are ignored, nothing to do. If you see this message it might indicate an
error in the group processing logic.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [apply_subdomain_homedir]
(0x0040): UID for user [<AD GROUP 14>@<AD DOMAIN>] is not known.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-926787))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #34]: Request handler finished [0]: Success
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #34]: Receiving request data.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #34]: Finished. Success.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<AD DOMAIN>:idnumber=2926787] from reply table
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #34]: Request removed.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3138107]
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #35]: New request. Flags [0x0001].
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(gidNumber=3138107)(|(objectClass=ipaUserGroup)(objectClass=posixGroup))(cn=*)(&(gidNumber=*)(!(gidNumber=0))))][cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 0 results.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_search_group_by_gid]
(0x0400): No such entry
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_delete_group] (0x0400):
Error: 2 (No such file or directory)
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]]
[ipa_id_get_account_info_orig_done] (0x0080): Object not found, ending request
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #35]: Request handler finished [0]: Success
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #35]: Receiving request data.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #35]: Finished. Success.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<IPA DOMAIN>:idnumber=3138107] from reply table
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #35]: Request removed.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3138107]
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #36]: New request. Flags [0x0001].
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaGroupOverride)(gidNumber=3138107))][cn=Default Trust
View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [ipa_srv_ad_acct_lookup_step]
(0x0400): Looking up AD account
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [dc=AD,dc=AD,dc=AD,dc=AD]
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectSID=S-1-5-21-2129867641-1448237841-168566570-1138107)(objectClass=group)(sAMAccountName=*))][dc=AD,dc=AD,dc=AD,dc=AD].
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 1 results.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_has_deref_support]
(0x0400): The server supports deref method ASQ
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 0 users found in the hash table
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 1 groups found in the hash table
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_primary_name]
(0x0400): Processing object <AD GROUP 15>
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Processing group <AD GROUP 15>@<AD DOMAIN>
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): The group has 0 members
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): Group has 0 members
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Storing info for group <AD GROUP 15>@<AD DOMAIN>
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<AD GROUP 15>@<AD DOMAIN>,cn=groups,cn=<AD DOMAIN>,cn=sysdb]
has set [ts_cache] attrs.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_grpmem] (0x0020):
Group members are ignored, nothing to do. If you see this message it might indicate an
error in the group processing logic.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [apply_subdomain_homedir]
(0x0040): UID for user [<AD GROUP 15>@<AD DOMAIN>] is not known.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1138107))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #36]: Request handler finished [0]: Success
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #36]: Receiving request data.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #36]: Finished. Success.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<AD DOMAIN>:idnumber=3138107] from reply table
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #36]: Request removed.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3366580]
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #37]: New request. Flags [0x0001].
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(gidNumber=3366580)(|(objectClass=ipaUserGroup)(objectClass=posixGroup))(cn=*)(&(gidNumber=*)(!(gidNumber=0))))][cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 0 results.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_search_group_by_gid]
(0x0400): No such entry
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_delete_group] (0x0400):
Error: 2 (No such file or directory)
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]]
[ipa_id_get_account_info_orig_done] (0x0080): Object not found, ending request
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #37]: Request handler finished [0]: Success
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #37]: Receiving request data.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #37]: Finished. Success.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<IPA DOMAIN>:idnumber=3366580] from reply table
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #37]: Request removed.
(Tue Aug 20 08:40:44 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3366580]
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #38]: New request. Flags [0x0001].
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaGroupOverride)(gidNumber=3366580))][cn=Default Trust
View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [ipa_srv_ad_acct_lookup_step]
(0x0400): Looking up AD account
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [dc=AD,dc=AD,dc=AD,dc=AD]
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectSID=S-1-5-21-2129867641-1448237841-168566570-1366580)(objectClass=group)(sAMAccountName=*))][dc=AD,dc=AD,dc=AD,dc=AD].
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 1 results.
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_has_deref_support]
(0x0400): The server supports deref method ASQ
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 0 users found in the hash table
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 1 groups found in the hash table
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_primary_name]
(0x0400): Processing object <AD GROUP 16>
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Processing group <AD GROUP 16>@<AD DOMAIN>
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): The group has 0 members
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): Group has 0 members
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Storing info for group <AD GROUP 16>@<AD DOMAIN>
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<AD GROUP 16>@<AD DOMAIN>,cn=groups,cn=<AD DOMAIN>,cn=sysdb]
has set [ts_cache] attrs.
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_grpmem] (0x0020):
Group members are ignored, nothing to do. If you see this message it might indicate an
error in the group processing logic.
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [apply_subdomain_homedir]
(0x0040): UID for user [<AD GROUP 16>@<AD DOMAIN>] is not known.
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1366580))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #38]: Request handler finished [0]: Success
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #38]: Receiving request data.
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #38]: Finished. Success.
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<AD DOMAIN>:idnumber=3366580] from reply table
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #38]: Request removed.
(Tue Aug 20 08:40:50 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:40:55 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3354727]
(Tue Aug 20 08:40:55 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #39]: New request. Flags [0x0001].
(Tue Aug 20 08:40:55 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:40:55 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa]
(Tue Aug 20 08:40:55 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(gidNumber=3354727)(|(objectClass=ipaUserGroup)(objectClass=posixGroup))(cn=*)(&(gidNumber=*)(!(gidNumber=0))))][cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:40:55 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:40:55 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 0 results.
(Tue Aug 20 08:40:55 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_search_group_by_gid]
(0x0400): No such entry
(Tue Aug 20 08:40:55 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_delete_group] (0x0400):
Error: 2 (No such file or directory)
(Tue Aug 20 08:40:55 2019) [sssd[be[<IPA DOMAIN>]]]
[ipa_id_get_account_info_orig_done] (0x0080): Object not found, ending request
(Tue Aug 20 08:40:55 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #39]: Request handler finished [0]: Success
(Tue Aug 20 08:40:55 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #39]: Receiving request data.
(Tue Aug 20 08:40:55 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #39]: Finished. Success.
(Tue Aug 20 08:40:55 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<IPA DOMAIN>:idnumber=3354727] from reply table
(Tue Aug 20 08:40:55 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #39]: Request removed.
(Tue Aug 20 08:40:55 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0
(Tue Aug 20 08:41:00 2019) [sssd[be[<IPA DOMAIN>]]] [dp_get_account_info_handler]
(0x0200): Got request for [0x2][BE_REQ_GROUP][idnumber=3354727]
(Tue Aug 20 08:41:00 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): DP
Request [Account #40]: New request. Flags [0x0001].
(Tue Aug 20 08:41:00 2019) [sssd[be[<IPA DOMAIN>]]] [dp_attach_req] (0x0400): Number
of active DP request: 1
(Tue Aug 20 08:41:00 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaGroupOverride)(gidNumber=3354727))][cn=Default Trust
View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:41:00 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:41:00 2019) [sssd[be[<IPA DOMAIN>]]] [ipa_srv_ad_acct_lookup_step]
(0x0400): Looking up AD account
(Tue Aug 20 08:41:00 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_next_base]
(0x0400): Searching for groups with base [dc=AD,dc=AD,dc=AD,dc=AD]
(Tue Aug 20 08:41:00 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectSID=S-1-5-21-2129867641-1448237841-168566570-1354727)(objectClass=group)(sAMAccountName=*))][dc=AD,dc=AD,dc=AD,dc=AD].
(Tue Aug 20 08:41:00 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:41:00 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_groups_process]
(0x0400): Search for groups, returned 1 results.
(Tue Aug 20 08:41:00 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_has_deref_support]
(0x0400): The server supports deref method ASQ
(Tue Aug 20 08:41:00 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 0 users found in the hash table
(Tue Aug 20 08:41:00 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_nested_group_recv]
(0x0400): 1 groups found in the hash table
(Tue Aug 20 08:41:00 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_primary_name]
(0x0400): Processing object <AD GROUP 17>
(Tue Aug 20 08:41:00 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Processing group <AD GROUP 17>@<AD DOMAIN>
(Tue Aug 20 08:41:00 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): The group has 0 members
(Tue Aug 20 08:41:00 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_process_ghost_members]
(0x0400): Group has 0 members
(Tue Aug 20 08:41:00 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_group] (0x0400):
Storing info for group <AD GROUP 17>@<AD DOMAIN>
(Tue Aug 20 08:41:00 2019) [sssd[be[<IPA DOMAIN>]]] [sysdb_set_entry_attr] (0x0200):
Entry [name=<AD GROUP 17>@<AD DOMAIN>,cn=groups,cn=<AD DOMAIN>,cn=sysdb]
has set [ts_cache] attrs.
(Tue Aug 20 08:41:00 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_save_grpmem] (0x0020):
Group members are ignored, nothing to do. If you see this message it might indicate an
error in the group processing logic.
(Tue Aug 20 08:41:01 2019) [sssd[be[<IPA DOMAIN>]]] [apply_subdomain_homedir]
(0x0040): UID for user [<AD GROUP 17>@<AD DOMAIN>] is not known.
(Tue Aug 20 08:41:01 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_ext_step]
(0x0400): calling ldap_search_ext with
[(&(objectClass=ipaOverrideAnchor)(ipaAnchorUUID=:SID:S-1-5-21-2129867641-1448237841-168566570-1354727))][cn=Default
Trust View,cn=views,cn=accounts,dc=ipa,dc=ipa,dc=ipa,dc=ipa].
(Tue Aug 20 08:41:01 2019) [sssd[be[<IPA DOMAIN>]]] [sdap_get_generic_op_finished]
(0x0400): Search result: Success(0), no errmsg set
(Tue Aug 20 08:41:01 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_done] (0x0400): DP
Request [Account #40]: Request handler finished [0]: Success
(Tue Aug 20 08:41:01 2019) [sssd[be[<IPA DOMAIN>]]] [_dp_req_recv] (0x0400): DP
Request [Account #40]: Receiving request data.
(Tue Aug 20 08:41:01 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_reply_list_success]
(0x0400): DP Request [Account #40]: Finished. Success.
(Tue Aug 20 08:41:01 2019) [sssd[be[<IPA DOMAIN>]]] [dp_table_value_destructor]
(0x0400): Removing [0:1:0x0001:2::<AD DOMAIN>:idnumber=3354727] from reply table
(Tue Aug 20 08:41:01 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400): DP
Request [Account #40]: Request removed.
(Tue Aug 20 08:41:01 2019) [sssd[be[<IPA DOMAIN>]]] [dp_req_destructor] (0x0400):
Number of active DP request: 0