[Freeipa-users] freeipa upgrade from CentOS7 -> CentOS8 results in SSSD backtrace (but still functional)

Hello, I'm in the middle of an upgrade from CentOS7 to CentOS8 of the existing FreeIPA master and replicas. I've added new replicas on CentOS8 and everything went seemingly find. Health checks don't report any issues, I can login to web interfaces and run ipa admin commands on them. However, I've noticed sssd backtraces that were not there before. I'm wondering where these are coming from and if this is an actual issue or not. I've included a full trace below for reference. Thanks a lot in advance! (2021-11-17 16:21:58): [be[redacted-domain.com]] [server_setup] (0x1f7c0): Starting with debug level = 0x0070 (2021-11-17 16:21:59): [be[redacted-domain.com]] [sysdb_range_create] (0x0040): [RID#1] Invalid range, skipping. Expected that either the secondary base RID or the SID of the trusted domain is set, but not both or none of them. ********************** PREVIOUS MESSAGE WAS TRIGGERED BY THE FOLLOWING BACKTRACE: * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ldap_group_external_member has value ipaExternalMember * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_netgroup_object_class has value ipaNisNetgroup * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_netgroup_name has value cn * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_netgroup_member has value member * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_netgroup_member_of has value memberOf * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_netgroup_member_user has value memberUser * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_netgroup_member_host has value memberHost * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_netgroup_member_ext_host has value externalHost * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_netgroup_domain has value nisDomainName * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_netgroup_uuid has value ipaUniqueID * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_host_object_class has value ipaHost * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_host_name has value cn * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_host_fqdn has value fqdn * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_host_serverhostname has value serverHostname * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_host_member_of has value memberOf * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_host_ssh_public_key has value ipaSshPubKey * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_host_uuid has value ipaUniqueID * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_hostgroup_objectclass has value ipaHostgroup * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_hostgroup_name has value cn * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_hostgroup_memberof has value memberOf * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_hostgroup_uuid has value ipaUniqueID * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ldap_service_object_class has value ipService * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ldap_service_name has value cn * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ldap_service_port has value ipServicePort * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ldap_service_proto has value ipServiceProtocol * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ldap_service_entry_usn has no value * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_selinux_usermap_object_class has value ipaselinuxusermap * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_selinux_usermap_name has value cn * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_selinux_usermap_member_user has value memberUser * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_selinux_usermap_member_host has value memberHost * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_selinux_usermap_see_also has value seeAlso * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_selinux_usermap_selinux_user has value ipaSELinuxUser * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_selinux_usermap_enabled has value ipaEnabledFlag * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_selinux_usermap_user_category has value userCategory * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_selinux_usermap_host_category has value hostCategory * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_selinux_usermap_uuid has value ipaUniqueID * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_view_class has value nsContainer * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_view_name has value cn * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_override_object_class has value ipaOverrideAnchor * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_anchor_uuid has value ipaAnchorUUID * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_user_override_object_class has value ipaUserOverride * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_group_override_object_class has value ipaGroupOverride * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ldap_user_name has value uid * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ldap_user_uid_number has value uidNumber * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ldap_user_gid_number has value gidNumber * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ldap_user_gecos has value gecos * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ldap_user_home_directory has value homeDirectory * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ldap_user_shell has value loginShell * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ldap_group_name has value cn * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ldap_group_gid_number has value gidNumber * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ldap_user_ssh_public_key has value ipaSshPubKey * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ldap_user_certificate has value userCertificate;binary * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option dyndns_update is FALSE * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option dyndns_update_per_family is TRUE * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option dyndns_refresh_interval has value 0 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option dyndns_iface has no value * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option dyndns_ttl has value 1200 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option dyndns_update_ptr is FALSE * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option dyndns_force_tcp is FALSE * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option dyndns_auth has value gss-tsig * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option dyndns_auth_ptr has no value * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option dyndns_server has no value * (2021-11-17 16:21:58): [be[redacted-domain.com]] [ipa_init_dyndns] (0x0100): Dynamic DNS updates are off. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_id_setup_tasks] (0x0400): Setting up enumeration for redacted-domain.com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [be_ptask_create] (0x0400): Periodic task [Enumeration [id] of redacted-domain.com] was created * (2021-11-17 16:21:58): [be[redacted-domain.com]] [be_ptask_schedule] (0x0400): Task [Enumeration [id] of redacted-domain.com]: scheduling task 10 seconds from now [1637166128] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [be_fo_set_srv_lookup_plugin] (0x0400): Trying to set SRV lookup plugin to DNS * (2021-11-17 16:21:58): [be[redacted-domain.com]] [be_fo_set_srv_lookup_plugin] (0x0400): SRV lookup plugin is now DNS * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sysdb_get_certmap] (0x0400): No certificate maps found. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_setup_certmap] (0x4000): No certmap data, nothing to do. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_domain has value redacted-domain.com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_server has value equator.redacted-domain.com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_backup_server has value alien.redacted-domain.com,bingo.redacted-domain.com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_hostname has value etestvm1.redacted-domain.com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_hbac_search_base has value cn=hbac,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_host_search_base has no value * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_selinux_search_base has value cn=selinux,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_subdomains_search_base has value cn=trusts,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_master_domain_search_base has value cn=ad,cn=etc,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option krb5_realm has value REDACTED-DOMAIN.COM * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_hbac_refresh has value 5 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_selinux_refresh has value 5 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_hbac_support_srchost is FALSE * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_automount_location has value default * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_ranges_search_base has value cn=ranges,cn=etc,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_enable_dns_sites is FALSE * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_server_mode is FALSE * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_views_search_base has value cn=views,cn=accounts,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option krb5_confd_path has value /var/lib/sss/pubconf/krb5.include.d * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_deskprofile_search_base has value cn=desktop-profile,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_deskprofile_refresh has value 5 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_deskprofile_request_interval has value 60 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option krb5_server has no value * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option krb5_backup_server has no value * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option krb5_realm has no value * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option krb5_ccachedir has value /tmp * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option krb5_ccname_template has no value * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option krb5_auth_timeout has value 6 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option krb5_keytab has value /etc/krb5.keytab * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option krb5_validate is TRUE * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option krb5_kpasswd has no value * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option krb5_backup_kpasswd has no value * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option krb5_store_password_if_offline is TRUE * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option krb5_renewable_lifetime has no value * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option krb5_lifetime has no value * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option krb5_renew_interval has no value * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option krb5_use_fast has value try * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option krb5_fast_principal has no value * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option krb5_canonicalize is TRUE * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option krb5_use_enterprise_principal is FALSE * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option krb5_use_kdcinfo is TRUE * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option krb5_kdcinfo_lookahead has no value * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option krb5_map_user has no value * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_get_options] (0x0400): Option krb5_use_subdomain_realm is FALSE * (2021-11-17 16:21:58): [be[redacted-domain.com]] [krb5_try_kdcip] (0x0100): No KDC found in configuration, trying legacy option * (2021-11-17 16:21:58): [be[redacted-domain.com]] [ipa_get_auth_options] (0x0400): Option krb5_realm set to REDACTED-DOMAIN.COM * (2021-11-17 16:21:58): [be[redacted-domain.com]] [ipa_get_auth_options] (0x0100): Option krb5_fast_principal set to host/etestvm1.redacted-domain.com(a)REDACTED-DOMAIN.COM * (2021-11-17 16:21:58): [be[redacted-domain.com]] [ipa_get_auth_options] (0x0100): Option krb5_use_kdcinfo set to true * (2021-11-17 16:21:58): [be[redacted-domain.com]] [check_lifetime] (0x0200): No lifetime configured. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [check_lifetime] (0x0200): No lifetime configured. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sss_krb5_check_options] (0x0100): No KDC explicitly configured, using defaults. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sss_krb5_check_options] (0x0100): No kpasswd server explicitly configured, using the KDC or defaults. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [parse_krb5_map_user] (0x0100): krb5_map_user is empty! * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_target_run_constructor] (0x0400): Executing target [id] constructor * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_target_init] (0x0400): Initializing target [auth] with module [ipa] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_load_module] (0x0400): Module [ipa] is already loaded. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_target_run_constructor] (0x0400): Executing target [auth] constructor * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_target_init] (0x0400): Initializing target [access] with module [ipa] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_load_module] (0x0400): Module [ipa] is already loaded. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_target_run_constructor] (0x0400): Executing target [access] constructor * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_domain has value redacted-domain.com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_server has value equator.redacted-domain.com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_backup_server has value alien.redacted-domain.com,bingo.redacted-domain.com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_hostname has value etestvm1.redacted-domain.com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_hbac_search_base has value cn=hbac,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_host_search_base has no value * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_selinux_search_base has value cn=selinux,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_subdomains_search_base has value cn=trusts,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_master_domain_search_base has value cn=ad,cn=etc,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option krb5_realm has value REDACTED-DOMAIN.COM * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_hbac_refresh has value 5 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_selinux_refresh has value 5 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_hbac_support_srchost is FALSE * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_automount_location has value default * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_ranges_search_base has value cn=ranges,cn=etc,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_enable_dns_sites is FALSE * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_server_mode is FALSE * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_views_search_base has value cn=views,cn=accounts,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option krb5_confd_path has value /var/lib/sss/pubconf/krb5.include.d * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_deskprofile_search_base has value cn=desktop-profile,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_deskprofile_refresh has value 5 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_deskprofile_request_interval has value 60 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_target_init] (0x0400): Initializing target [chpass] with module [ipa] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_load_module] (0x0400): Module [ipa] is already loaded. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_target_run_constructor] (0x0400): Executing target [chpass] constructor * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_target_init] (0x0400): Initializing target [sudo] with module [ipa] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_load_module] (0x0400): Module [ipa] is already loaded. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_target_run_constructor] (0x0400): Executing target [sudo] constructor * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sssm_ipa_sudo_init] (0x2000): Initializing IPA sudo handler * (2021-11-17 16:21:58): [be[redacted-domain.com]] [ipa_sudo_init] (0x2000): Initializing IPA sudo back end * (2021-11-17 16:21:58): [be[redacted-domain.com]] [ipa_sudo_choose_schema] (0x0400): Option ldap_sudo_search_base set to cn=sudo,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [ipa_sudo_init] (0x0400): Using IPA schema for sudo * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_object_class has value ipasudorule * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_name has value cn * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_uuid has value ipaUniqueID * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_enabled_flag has value ipaEnabledFlag * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_option has value ipaSudoOpt * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_runasuser has value ipaSudoRunAs * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_runasgroup has value ipaSudoRunAsGroup * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_allowcmd has value memberAllowCmd * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_denycmd has value memberDenyCmd * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_host has value memberHost * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_user has value memberUser * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_notafter has value sudoNotAfter * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_notbefore has value sudoNotBefore * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_sudoorder has value sudoOrder * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_cmdcategory has value cmdCategory * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_hostcategory has value hostCategory * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_usercategory has value userCategory * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_runasusercategory has value ipaSudoRunAsUserCategory * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_runasgroupcategory has value ipaSudoRunAsGroupCategory * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_runasextuser has value ipaSudoRunAsExtUser * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_runasextgroup has value ipaSudoRunAsExtGroup * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_runasextusergroup has value ipaSudoRunAsExtUserGroup * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_externaluser has value externalUser * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudorule_entry_usn has value entryUSN * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudocmdgroup_object_class has value ipasudocmdgrp * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudocmdgroup_uuid has value ipaUniqueID * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudocmdgroup_name has value cn * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudocmdgroup_member has value member * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudocmdgroup_entry_usn has value entryUSN * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudocmd_object_class has value ipasudocmd * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudocmd_uuid has value ipaUniqueID * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudocmd_sudoCmd has value sudoCmd * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ipa_sudocmd_memberof has value memberOf * (2021-11-17 16:21:58): [be[redacted-domain.com]] [common_parse_search_base] (0x0100): Search base added: [SUDO][cn=sudo,dc=redacted-domain,dc=com][SUBTREE][] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [be_ptask_create] (0x0400): Periodic task [SUDO Full Refresh] was created * (2021-11-17 16:21:58): [be[redacted-domain.com]] [be_ptask_schedule] (0x0400): Task [SUDO Full Refresh]: scheduling task 10 seconds from now [1637166128] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [be_ptask_create] (0x0400): Periodic task [SUDO Smart Refresh] was created * (2021-11-17 16:21:58): [be[redacted-domain.com]] [be_ptask_schedule] (0x0400): Task [SUDO Smart Refresh]: scheduling task 910 seconds from now [1637167028] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_target_init] (0x0400): Initializing target [autofs] with module [ipa] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_load_module] (0x0400): Module [ipa] is already loaded. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_target_run_constructor] (0x0400): Executing target [autofs] constructor * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sssm_ipa_autofs_init] (0x2000): Initializing IPA autofs handler * (2021-11-17 16:21:58): [be[redacted-domain.com]] [ipa_autofs_init] (0x2000): Initializing autofs IPA back end * (2021-11-17 16:21:58): [be[redacted-domain.com]] [ipa_get_autofs_options] (0x1000): Option ldap_autofs_search_base set to cn=default,cn=automount,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [common_parse_search_base] (0x0100): Search base added: [AUTOFS][cn=default,cn=automount,dc=redacted-domain,dc=com][SUBTREE][] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ldap_autofs_map_object_class has value automountMap * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ldap_autofs_map_name has value automountMapName * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ldap_autofs_entry_object_class has value automount * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ldap_autofs_entry_key has value automountKey * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_map] (0x0400): Option ldap_autofs_entry_value has value automountInformation * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_target_init] (0x0400): Initializing target [selinux] with module [ipa] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_load_module] (0x0400): Module [ipa] is already loaded. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_target_run_constructor] (0x0400): Executing target [selinux] constructor * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_target_init] (0x0400): Initializing target [hostid] with module [ipa] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_load_module] (0x0400): Module [ipa] is already loaded. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_target_run_constructor] (0x0400): Executing target [hostid] constructor * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sssm_ipa_hostid_init] (0x2000): Initializing IPA host handler * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_target_init] (0x0400): Initializing target [subdomains] with module [ipa] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_load_module] (0x0400): Module [ipa] is already loaded. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_target_run_constructor] (0x0400): Executing target [subdomains] constructor * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sssm_ipa_subdomains_init] (0x2000): Initializing IPA subdomains handler * (2021-11-17 16:21:58): [be[redacted-domain.com]] [be_ptask_create] (0x0400): Periodic task [Subdomains Refresh] was created * (2021-11-17 16:21:58): [be[redacted-domain.com]] [be_ptask_schedule] (0x0400): Task [Subdomains Refresh]: scheduling task 600 seconds from now [1637166718] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [ipa_subdom_reinit] (0x2000): Re-initializing domain redacted-domain.com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sss_write_krb5_localauth_snippet] (0x0200): File for localauth plugin configuration is [/var/lib/sss/pubconf/krb5.include.d/localauth_plugin] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sss_write_krb5_libdefaults_snippet] (0x0200): File for KRB5 kibdefaults configuration is [/var/lib/sss/pubconf/krb5.include.d/krb5_libdefaults] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sss_domain_get_state] (0x1000): Domain redacted-domain.com is Active * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sss_write_domain_mappings] (0x0200): Mapping file for domain [redacted-domain.com] is [/var/lib/sss/pubconf/krb5.include.d/domain_realm_redacted-domain.com] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_target_init] (0x0400): Initializing target [session] with module [ipa] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_load_module] (0x0400): Module [ipa] is already loaded. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_target_run_constructor] (0x0400): Executing target [session] constructor * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_domain has value redacted-domain.com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_server has value equator.redacted-domain.com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_backup_server has value alien.redacted-domain.com,bingo.redacted-domain.com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_hostname has value etestvm1.redacted-domain.com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_hbac_search_base has value cn=hbac,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_host_search_base has no value * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_selinux_search_base has value cn=selinux,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_subdomains_search_base has value cn=trusts,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_master_domain_search_base has value cn=ad,cn=etc,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option krb5_realm has value REDACTED-DOMAIN.COM * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_hbac_refresh has value 5 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_selinux_refresh has value 5 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_hbac_support_srchost is FALSE * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_automount_location has value default * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_ranges_search_base has value cn=ranges,cn=etc,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_enable_dns_sites is FALSE * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_server_mode is FALSE * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_views_search_base has value cn=views,cn=accounts,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option krb5_confd_path has value /var/lib/sss/pubconf/krb5.include.d * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_deskprofile_search_base has value cn=desktop-profile,dc=redacted-domain,dc=com * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_deskprofile_refresh has value 5 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_copy_options_ex] (0x0400): Option ipa_deskprofile_request_interval has value 60 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_target_init] (0x0400): Initializing target [resolver] with module [ipa] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_load_module] (0x0400): Module [ipa] is already loaded. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_target_init] (0x0100): Target [resolver] is not supported by module [ipa]. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface sssd.DataProvider.Client on path /sssd * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface sssd.DataProvider.Backend on path /sssd * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface sssd.DataProvider.Failover on path /sssd * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface sssd.DataProvider.AccessControl on path /sssd * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface sssd.dataprovider on path /sssd * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface sssd.DataProvider.Autofs on path /sssd * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dbus_connect_address] (0x0400): Connected to unix:path=/var/lib/sss/pipes/private/sbus-monitor bus as sssd.domain_redacted_2ddomain_2ecom * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Introspectable on path / * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Introspectable on path /* * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Properties on path / * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Properties on path /* * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_add] (0x2000): Created a disabled -/W watch on 19 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled R/- watch on 19 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_listen] (0x0400): Registering signal listener org.freedesktop.DBus.NameOwnerChanged on path /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_listen] (0x0400): Registering signal listener org.freedesktop.DBus.NameAcquired on path /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface sssd.service on path /sssd * (2021-11-17 16:21:58): [be[redacted-domain.com]] [become_user] (0x0200): Trying to become user [0][0]. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [become_user] (0x0200): Already user [0]. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_initialized] (0x0400): Backend provider (redacted-domain.com) started! * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_signal_handler] (0x2000): Received D-Bus signal org.freedesktop.DBus.NameAcquired on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_signal_handler] (0x2000): Received D-Bus signal org.freedesktop.DBus.NameAcquired on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_name_acquired] (0x0400): D-Bus name acquired: :1.3 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.NameAcquired: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_name_acquired] (0x0400): D-Bus name acquired: sssd.domain_redacted_2ddomain_2ecom * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.NameAcquired: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.AddMatch on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.AddMatch on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_match_rule_add] (0x4000): Adding match rule for :1.1: org.freedesktop.DBus.NameOwnerChanged * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.AddMatch: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_match_rule_add] (0x4000): Adding match rule for :1.1: org.freedesktop.DBus.NameAcquired * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.AddMatch: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sss_monitor_service_init_done] (0x0100): Got id ack and version (1) from Monitor * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_server_new_connection] (0x0200): Adding connection 0x560bb57f62e0. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Introspectable on path / * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Introspectable on path /* * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Properties on path / * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Properties on path /* * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_add] (0x2000): Created a disabled -/W watch on 20 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled R/- watch on 20 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_client_init] (0x0100): Set-up Backend ID timeout [0x560bb5783920] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to disabled R/- watch on 20 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled -/W watch on 20 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled R/- watch on 20 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to disabled -/W watch on 20 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to disabled R/- watch on 20 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled -/W watch on 20 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled R/- watch on 20 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to disabled -/W watch on 20 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.Hello on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_server_new_connection] (0x0200): Adding connection 0x560bb57f9c50. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Introspectable on path / * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Introspectable on path /* * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Properties on path / * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Properties on path /* * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_add] (0x2000): Created a disabled -/W watch on 21 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled R/- watch on 21 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_client_init] (0x0100): Set-up Backend ID timeout [0x560bb57e3410] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_server_bus_hello] (0x4000): Assigning unique name :1.2 to connection 0x560bb57ee950 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.Hello: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to disabled R/- watch on 21 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled -/W watch on 21 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_signal_handler] (0x2000): Received D-Bus signal org.freedesktop.DBus.NameOwnerChanged on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled R/- watch on 21 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to disabled -/W watch on 21 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_name_owner_changed] (0x4000): Name of owner :1.2 has changed from [] to [:1.2] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.NameOwnerChanged: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.RequestName on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to disabled R/- watch on 21 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled -/W watch on 21 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_server_bus_request_name] (0x0400): Requesting name: sssd.sudo * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.RequestName: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled R/- watch on 21 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to disabled -/W watch on 21 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_server_new_connection] (0x0200): Adding connection 0x560bb57ff920. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Introspectable on path / * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Introspectable on path /* * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Properties on path / * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Properties on path /* * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_add] (0x2000): Created a disabled -/W watch on 22 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled R/- watch on 22 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_client_init] (0x0100): Set-up Backend ID timeout [0x560bb57e9a80] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_signal_handler] (0x2000): Received D-Bus signal org.freedesktop.DBus.NameOwnerChanged on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to disabled R/- watch on 22 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled -/W watch on 22 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_name_owner_changed] (0x4000): Name of owner sssd.sudo has changed from [] to [sssd.sudo] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.NameOwnerChanged: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled R/- watch on 22 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to disabled -/W watch on 22 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.AddMatch on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.AddMatch on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_match_rule_add] (0x4000): Adding match rule for :1.2: org.freedesktop.DBus.NameOwnerChanged * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.AddMatch: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_match_rule_add] (0x4000): Adding match rule for :1.2: org.freedesktop.DBus.NameAcquired * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.AddMatch: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_server_new_connection] (0x0200): Adding connection 0x560bb5805140. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Introspectable on path / * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Introspectable on path /* * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Properties on path / * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Properties on path /* * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_add] (0x2000): Created a disabled -/W watch on 23 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled R/- watch on 23 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_client_init] (0x0100): Set-up Backend ID timeout [0x560bb58040c0] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method sssd.DataProvider.Client.Register on /sssd * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_senders_lookup] (0x2000): Looking for identity of sender [sssd.sudo] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_server_new_connection] (0x0200): Adding connection 0x560bb5809150. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Introspectable on path / * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Introspectable on path /* * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Properties on path / * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_router_add_path] (0x0400): Registering interface org.freedesktop.DBus.Properties on path /* * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_add] (0x2000): Created a disabled -/W watch on 24 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled R/- watch on 24 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_client_init] (0x0100): Set-up Backend ID timeout [0x560bb5803bd0] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to disabled R/- watch on 23 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled -/W watch on 23 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.GetConnectionUnixUser on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to disabled R/- watch on 24 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled -/W watch on 24 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.GetConnectionUnixUser: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled R/- watch on 23 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to disabled -/W watch on 23 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled R/- watch on 24 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to disabled -/W watch on 24 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_senders_lookup] (0x2000): Looking for identity of sender [sssd.sudo] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_senders_add] (0x2000): Inserting identity of sender [sssd.sudo]: 0 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to disabled R/- watch on 23 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled -/W watch on 23 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_client_register] (0x0100): Added Frontend client [sudo] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_client_register] (0x0100): Cancel DP ID timeout [0x560bb5783920] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): sssd.DataProvider.Client.Register: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to disabled R/- watch on 24 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled -/W watch on 24 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled R/- watch on 23 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to disabled -/W watch on 23 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled R/- watch on 24 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to disabled -/W watch on 24 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.Hello on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_server_bus_hello] (0x4000): Assigning unique name :1.3 to connection 0x560bb5805500 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.Hello: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.Hello on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_server_bus_hello] (0x4000): Assigning unique name :1.4 to connection 0x560bb58094b0 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.Hello: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_signal_handler] (0x2000): Received D-Bus signal org.freedesktop.DBus.NameOwnerChanged on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_name_owner_changed] (0x4000): Name of owner :1.3 has changed from [] to [:1.3] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.NameOwnerChanged: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_signal_handler] (0x2000): Received D-Bus signal org.freedesktop.DBus.NameOwnerChanged on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_name_owner_changed] (0x4000): Name of owner :1.4 has changed from [] to [:1.4] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.NameOwnerChanged: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.RequestName on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_server_bus_request_name] (0x0400): Requesting name: sssd.nss * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.RequestName: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.RequestName on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_server_bus_request_name] (0x0400): Requesting name: sssd.ssh * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.RequestName: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_signal_handler] (0x2000): Received D-Bus signal org.freedesktop.DBus.NameOwnerChanged on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_name_owner_changed] (0x4000): Name of owner sssd.nss has changed from [] to [sssd.nss] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.NameOwnerChanged: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_signal_handler] (0x2000): Received D-Bus signal org.freedesktop.DBus.NameOwnerChanged on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_name_owner_changed] (0x4000): Name of owner sssd.ssh has changed from [] to [sssd.ssh] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.NameOwnerChanged: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.AddMatch on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.AddMatch on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_match_rule_add] (0x4000): Adding match rule for :1.3: org.freedesktop.DBus.NameOwnerChanged * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.AddMatch: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_match_rule_add] (0x4000): Adding match rule for :1.3: org.freedesktop.DBus.NameAcquired * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.AddMatch: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method sssd.DataProvider.Client.Register on /sssd * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_senders_lookup] (0x2000): Looking for identity of sender [sssd.nss] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.GetConnectionUnixUser on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to disabled R/- watch on 22 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled -/W watch on 22 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.GetConnectionUnixUser: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to enabled R/- watch on 22 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_watch_toggle] (0x4000): Toggle to disabled -/W watch on 22 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_senders_lookup] (0x2000): Looking for identity of sender [sssd.nss] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_senders_add] (0x2000): Inserting identity of sender [sssd.nss]: 0 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_client_register] (0x0100): Added Frontend client [nss] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_client_register] (0x0100): Cancel DP ID timeout [0x560bb58040c0] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): sssd.DataProvider.Client.Register: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.Hello on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_server_bus_hello] (0x4000): Assigning unique name :1.5 to connection 0x560bb57ffc80 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.Hello: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_signal_handler] (0x2000): Received D-Bus signal org.freedesktop.DBus.NameOwnerChanged on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_name_owner_changed] (0x4000): Name of owner :1.5 has changed from [] to [:1.5] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.NameOwnerChanged: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.RequestName on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_server_bus_request_name] (0x0400): Requesting name: sssd.pac * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.RequestName: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.Hello on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_server_bus_hello] (0x4000): Assigning unique name :1.6 to connection 0x560bb57f9fe0 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.Hello: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_signal_handler] (0x2000): Received D-Bus signal org.freedesktop.DBus.NameOwnerChanged on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_name_owner_changed] (0x4000): Name of owner sssd.pac has changed from [] to [sssd.pac] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.NameOwnerChanged: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_signal_handler] (0x2000): Received D-Bus signal org.freedesktop.DBus.NameOwnerChanged on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_name_owner_changed] (0x4000): Name of owner :1.6 has changed from [] to [:1.6] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.NameOwnerChanged: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.AddMatch on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.AddMatch on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_match_rule_add] (0x4000): Adding match rule for :1.5: org.freedesktop.DBus.NameOwnerChanged * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.AddMatch: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_match_rule_add] (0x4000): Adding match rule for :1.5: org.freedesktop.DBus.NameAcquired * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.AddMatch: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_signal_handler] (0x2000): Received D-Bus signal org.freedesktop.DBus.NameOwnerChanged on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_signal_handler] (0x2000): Received D-Bus signal org.freedesktop.DBus.NameOwnerChanged on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_signal_handler] (0x2000): Received D-Bus signal org.freedesktop.DBus.NameOwnerChanged on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_name_owner_changed] (0x4000): Name of owner :1.4 has changed from [] to [:1.4] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.NameOwnerChanged: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_name_owner_changed] (0x4000): Name of owner sssd.sudo has changed from [] to [sssd.sudo] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.NameOwnerChanged: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_name_owner_changed] (0x4000): Name of owner :1.5 has changed from [] to [:1.5] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.NameOwnerChanged: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method sssd.DataProvider.Client.Register on /sssd * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_senders_lookup] (0x2000): Looking for identity of sender [sssd.pac] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method sssd.dataprovider.getDomains on /sssd * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_senders_lookup] (0x2000): Looking for identity of sender [sssd.sudo] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_attach_req] (0x0400): [RID#1] DP Request [Subdomains #1]: REQ_TRACE: New request. Flags [0000]. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_attach_req] (0x0400): [RID#1] Number of active DP request: 1 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_id_op_connect_step] (0x4000): [RID#1] beginning to connect * (2021-11-17 16:21:58): [be[redacted-domain.com]] [fo_resolve_service_send] (0x0100): [RID#1] Trying to resolve service 'IPA' * (2021-11-17 16:21:58): [be[redacted-domain.com]] [get_server_status] (0x1000): [RID#1] Status of server 'equator.redacted-domain.com' is 'name not resolved' * (2021-11-17 16:21:58): [be[redacted-domain.com]] [get_port_status] (0x1000): [RID#1] Port status of port 0 for server 'equator.redacted-domain.com' is 'neutral' * (2021-11-17 16:21:58): [be[redacted-domain.com]] [fo_resolve_service_activate_timeout] (0x2000): [RID#1] Resolve timeout [dns_resolver_timeout] set to 6 seconds * (2021-11-17 16:21:58): [be[redacted-domain.com]] [get_server_status] (0x1000): [RID#1] Status of server 'equator.redacted-domain.com' is 'name not resolved' * (2021-11-17 16:21:58): [be[redacted-domain.com]] [resolv_is_address] (0x4000): [RID#1] [equator.redacted-domain.com] does not look like an IP address * (2021-11-17 16:21:58): [be[redacted-domain.com]] [resolv_gethostbyname_step] (0x2000): [RID#1] Querying files * (2021-11-17 16:21:58): [be[redacted-domain.com]] [resolv_gethostbyname_files_send] (0x0100): [RID#1] Trying to resolve A record of 'equator.redacted-domain.com' in files * (2021-11-17 16:21:58): [be[redacted-domain.com]] [set_server_common_status] (0x0100): [RID#1] Marking server 'equator.redacted-domain.com' as 'resolving name' * (2021-11-17 16:21:58): [be[redacted-domain.com]] [resolv_gethostbyname_step] (0x2000): [RID#1] Querying files * (2021-11-17 16:21:58): [be[redacted-domain.com]] [resolv_gethostbyname_files_send] (0x0100): [RID#1] Trying to resolve AAAA record of 'equator.redacted-domain.com' in files * (2021-11-17 16:21:58): [be[redacted-domain.com]] [resolv_gethostbyname_next] (0x0200): [RID#1] No more address families to retry * (2021-11-17 16:21:58): [be[redacted-domain.com]] [resolv_gethostbyname_step] (0x2000): [RID#1] Querying DNS * (2021-11-17 16:21:58): [be[redacted-domain.com]] [resolv_gethostbyname_dns_query] (0x0100): [RID#1] Trying to resolve A record of 'equator.redacted-domain.com' in DNS * (2021-11-17 16:21:58): [be[redacted-domain.com]] [schedule_request_timeout] (0x2000): [RID#1] Scheduling a timeout of 3 seconds * (2021-11-17 16:21:58): [be[redacted-domain.com]] [schedule_timeout_watcher] (0x2000): [RID#1] Scheduling DNS timeout watcher * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.GetConnectionUnixUser on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.GetConnectionUnixUser: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.RequestName on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_server_bus_request_name] (0x0400): Requesting name: sssd.pam * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.RequestName: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_senders_lookup] (0x2000): Looking for identity of sender [sssd.pac] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_senders_add] (0x2000): Inserting identity of sender [sssd.pac]: 0 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_client_register] (0x0100): Added Frontend client [pac] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_client_register] (0x0100): Cancel DP ID timeout [0x560bb57e9a80] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): sssd.DataProvider.Client.Register: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_signal_handler] (0x2000): Received D-Bus signal org.freedesktop.DBus.NameOwnerChanged on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [unschedule_timeout_watcher] (0x4000): [RID#1] Unscheduling DNS timeout watcher * (2021-11-17 16:21:58): [be[redacted-domain.com]] [resolv_gethostbyname_dns_parse] (0x1000): [RID#1] Parsing an A reply * (2021-11-17 16:21:58): [be[redacted-domain.com]] [request_watch_destructor] (0x0400): [RID#1] Deleting request watch * (2021-11-17 16:21:58): [be[redacted-domain.com]] [set_server_common_status] (0x0100): [RID#1] Marking server 'equator.redacted-domain.com' as 'name resolved' * (2021-11-17 16:21:58): [be[redacted-domain.com]] [be_resolve_server_process] (0x1000): [RID#1] Saving the first resolved server * (2021-11-17 16:21:58): [be[redacted-domain.com]] [be_resolve_server_process] (0x0200): [RID#1] Found address for server equator.redacted-domain.com: [10.10.0.37] TTL 71 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [ipa_resolve_callback] (0x0400): [RID#1] Constructed uri 'ldap://equator.redacted-domain.com' * (2021-11-17 16:21:58): [be[redacted-domain.com]] [unique_filename_destructor] (0x2000): [RID#1] Unlinking [/var/lib/sss/pubconf/.krb5info_dummy_b3vuow] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [unlink_dbg] (0x2000): [RID#1] File already removed: [/var/lib/sss/pubconf/.krb5info_dummy_b3vuow] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sssd_async_socket_init_send] (0x4000): [RID#1] Using file descriptor [25] for the connection. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sssd_async_socket_init_send] (0x0400): [RID#1] Setting 6 seconds timeout [ldap_network_timeout] for connecting * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_name_owner_changed] (0x4000): Name of owner sssd.pam has changed from [] to [sssd.pam] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.NameOwnerChanged: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.AddMatch on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.AddMatch on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_match_rule_add] (0x4000): Adding match rule for :1.6: org.freedesktop.DBus.NameOwnerChanged * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.AddMatch: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_match_rule_add] (0x4000): Adding match rule for :1.6: org.freedesktop.DBus.NameAcquired * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.AddMatch: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_ldap_connect_callback_add] (0x4000): [RID#1] New connection to [ldap://equator.redacted-domain.com:389/??base] with fd [25] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_rootdse_send] (0x4000): [RID#1] Getting rootdse * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_print_server] (0x2000): [RID#1] Searching 10.10.0.37:389 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x0400): [RID#1] calling ldap_search_ext with [(objectclass=*)][]. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x1000): [RID#1] Requesting attrs: [*] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x1000): [RID#1] Requesting attrs: [altServer] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x1000): [RID#1] Requesting attrs: [namingContexts] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x1000): [RID#1] Requesting attrs: [supportedControl] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x1000): [RID#1] Requesting attrs: [supportedExtension] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x1000): [RID#1] Requesting attrs: [supportedFeatures] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x1000): [RID#1] Requesting attrs: [supportedLDAPVersion] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x1000): [RID#1] Requesting attrs: [supportedSASLMechanisms] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x1000): [RID#1] Requesting attrs: [domainControllerFunctionality] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x1000): [RID#1] Requesting attrs: [defaultNamingContext] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x1000): [RID#1] Requesting attrs: [lastUSN] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x1000): [RID#1] Requesting attrs: [highestCommittedUSN] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x2000): [RID#1] ldap_search_ext called, msgid = 1 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_op_add] (0x2000): [RID#1] New operation 1 timeout 6 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_signal_handler] (0x2000): Received D-Bus signal org.freedesktop.DBus.NameOwnerChanged on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_name_owner_changed] (0x4000): Name of owner sssd.pac has changed from [] to [sssd.pac] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.NameOwnerChanged: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method sssd.DataProvider.Client.Register on /sssd * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_senders_lookup] (0x2000): Looking for identity of sender [sssd.pam] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method sssd.dataprovider.getDomains on /sssd * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_senders_lookup] (0x2000): Looking for identity of sender [sssd.pac] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_requests_add] (0x4000): Chaining request: 0:0:sssd.dataprovider.getDomains:/sssd: * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.GetConnectionUnixUser on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.GetConnectionUnixUser: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.AddMatch on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.AddMatch on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_match_rule_add] (0x4000): Adding match rule for :1.4: org.freedesktop.DBus.NameOwnerChanged * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.AddMatch: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_match_rule_add] (0x4000): Adding match rule for :1.4: org.freedesktop.DBus.NameAcquired * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.AddMatch: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_signal_handler] (0x2000): Received D-Bus signal org.freedesktop.DBus.NameOwnerChanged on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_name_owner_changed] (0x4000): Name of owner :1.6 has changed from [] to [:1.6] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.NameOwnerChanged: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_senders_lookup] (0x2000): Looking for identity of sender [sssd.pam] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_senders_add] (0x2000): Inserting identity of sender [sssd.pam]: 0 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method sssd.DataProvider.Client.Register on /sssd * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_senders_lookup] (0x2000): Looking for identity of sender [sssd.ssh] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_client_register] (0x0100): Added Frontend client [pam] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_client_register] (0x0100): Cancel DP ID timeout [0x560bb57e3410] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): sssd.DataProvider.Client.Register: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_process_result] (0x2000): Trace: sh[0x560bb57ed2b0], connected[1], ops[0x560bb5813d60], ldap[0x560bb581c170] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_process_message] (0x4000): [RID#1] Message type: [LDAP_RES_SEARCH_ENTRY] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_parse_entry] (0x1000): [RID#1] OriginalDN: []. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [objectClass] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [vendorName] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [vendorVersion] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [dataversion] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [netscapemdsuffix] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [changeLog] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [firstchangenumber] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [lastchangenumber] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [ipatopologypluginversion] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [ipatopologyismanaged] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [ipaDomainLevel] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [namingContexts] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [supportedControl] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [supportedExtension] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [supportedFeatures] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [supportedLDAPVersion] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [supportedSASLMechanisms] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [defaultNamingContext] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [lastUSN] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_process_result] (0x2000): Trace: sh[0x560bb57ed2b0], connected[1], ops[0x560bb5813d60], ldap[0x560bb581c170] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_process_message] (0x4000): [RID#1] Message type: [LDAP_RES_SEARCH_RESULT] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_generic_op_finished] (0x0400): [RID#1] Search result: Success(0), no errmsg set * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_op_destructor] (0x2000): [RID#1] Operation 1 finished * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_rootdse_done] (0x2000): [RID#1] Got rootdse * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_rootdse_done] (0x2000): [RID#1] Skipping auto-detection of match rule * (2021-11-17 16:21:58): [be[redacted-domain.com]] [get_naming_context] (0x0200): [RID#1] Using value from [defaultNamingContext] as naming context. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_set_search_base] (0x0100): [RID#1] Setting option [ldap_sudo_search_base] to [dc=redacted-domain,dc=com]. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [common_parse_search_base] (0x0100): [RID#1] Search base added: [SUDO][dc=redacted-domain,dc=com][SUBTREE][] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_set_search_base] (0x0100): [RID#1] Setting option [ldap_iphost_search_base] to [dc=redacted-domain,dc=com]. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [common_parse_search_base] (0x0100): [RID#1] Search base added: [IPHOST][dc=redacted-domain,dc=com][SUBTREE][] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_set_search_base] (0x0100): [RID#1] Setting option [ldap_ipnetwork_search_base] to [dc=redacted-domain,dc=com]. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [common_parse_search_base] (0x0100): [RID#1] Search base added: [IPNETWORK][dc=redacted-domain,dc=com][SUBTREE][] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_server_opts_from_rootdse] (0x4000): [RID#1] USN value: 9804 (int: 9804) * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_kinit_send] (0x0400): [RID#1] Attempting kinit (default, host/etestvm1.redacted-domain.com, REDACTED-DOMAIN.COM, 86400) * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_kinit_next_kdc] (0x1000): [RID#1] Resolving next KDC for service IPA * (2021-11-17 16:21:58): [be[redacted-domain.com]] [fo_resolve_service_send] (0x0100): [RID#1] Trying to resolve service 'IPA' * (2021-11-17 16:21:58): [be[redacted-domain.com]] [get_server_status] (0x1000): [RID#1] Status of server 'equator.redacted-domain.com' is 'name resolved' * (2021-11-17 16:21:58): [be[redacted-domain.com]] [fo_resolve_service_activate_timeout] (0x2000): [RID#1] Resolve timeout [dns_resolver_timeout] set to 6 seconds * (2021-11-17 16:21:58): [be[redacted-domain.com]] [get_server_status] (0x1000): [RID#1] Status of server 'equator.redacted-domain.com' is 'name resolved' * (2021-11-17 16:21:58): [be[redacted-domain.com]] [be_resolve_server_process] (0x1000): [RID#1] Saving the first resolved server * (2021-11-17 16:21:58): [be[redacted-domain.com]] [be_resolve_server_process] (0x0200): [RID#1] Found address for server equator.redacted-domain.com: [10.10.0.37] TTL 71 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_kinit_kdc_resolved] (0x1000): [RID#1] KDC resolved, attempting to get TGT... * (2021-11-17 16:21:58): [be[redacted-domain.com]] [create_tgt_req_send_buffer] (0x0400): [RID#1] buffer size: 66 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [child_handler_setup] (0x2000): [RID#1] Setting up signal handler up for pid [94991] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [child_handler_setup] (0x2000): [RID#1] Signal handler set up for pid [94991] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [set_tgt_child_timeout] (0x0400): [RID#1] Setting 8 seconds timeout for TGT child * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_process_result] (0x2000): Trace: sh[0x560bb57ed2b0], connected[1], ops[(nil)], ldap[0x560bb581c170] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_process_result] (0x2000): Trace: end of ldap_result list * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method org.freedesktop.DBus.GetConnectionUnixUser on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.GetConnectionUnixUser: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [write_pipe_handler] (0x0400): [RID#1] All data has been sent! * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_senders_lookup] (0x2000): Looking for identity of sender [sssd.ssh] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_senders_add] (0x2000): Inserting identity of sender [sssd.ssh]: 0 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_client_register] (0x0100): Added Frontend client [ssh] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [dp_client_register] (0x0100): Cancel DP ID timeout [0x560bb5803bd0] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): sssd.DataProvider.Client.Register: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_signal_handler] (0x2000): Received D-Bus signal org.freedesktop.DBus.NameOwnerChanged on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_signal_handler] (0x2000): Received D-Bus signal org.freedesktop.DBus.NameOwnerChanged on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_name_owner_changed] (0x4000): Name of owner :1.7 has changed from [] to [:1.7] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.NameOwnerChanged: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_name_owner_changed] (0x4000): Name of owner sssd.pam has changed from [] to [sssd.pam] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.NameOwnerChanged: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_signal_handler] (0x2000): Received D-Bus signal org.freedesktop.DBus.NameOwnerChanged on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_name_owner_changed] (0x4000): Name of owner sssd.ssh has changed from [] to [sssd.ssh] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.NameOwnerChanged: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method sssd.dataprovider.getDomains on /sssd * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_senders_lookup] (0x2000): Looking for identity of sender [sssd.pam] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_requests_add] (0x4000): Chaining request: 0:0:sssd.dataprovider.getDomains:/sssd: * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method sssd.dataprovider.getDomains on /sssd * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_senders_lookup] (0x2000): Looking for identity of sender [sssd.ssh] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_requests_add] (0x4000): Chaining request: 0:0:sssd.dataprovider.getDomains:/sssd: * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_signal_handler] (0x2000): Received D-Bus signal org.freedesktop.DBus.NameOwnerChanged on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_name_owner_changed] (0x4000): Name of owner :1.8 has changed from [] to [:1.8] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.NameOwnerChanged: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_signal_handler] (0x2000): Received D-Bus signal org.freedesktop.DBus.NameOwnerChanged on /org/freedesktop/DBus * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_name_owner_changed] (0x4000): Name of owner sssd.nss has changed from [] to [sssd.nss] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_issue_request_done] (0x0400): org.freedesktop.DBus.NameOwnerChanged: Success * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_dispatch] (0x4000): Dispatching. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_method_handler] (0x2000): Received D-Bus method sssd.dataprovider.getDomains on /sssd * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_senders_lookup] (0x2000): Looking for identity of sender [sssd.nss] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sbus_requests_add] (0x4000): Chaining request: 0:0:sssd.dataprovider.getDomains:/sssd: * (2021-11-17 16:21:58): [be[redacted-domain.com]] [child_sig_handler] (0x1000): [RID#1] Waiting for child [94991]. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [child_sig_handler] (0x0100): [RID#1] child [94991] finished successfully. * (2021-11-17 16:21:58): [be[redacted-domain.com]] [read_pipe_handler] (0x0400): [RID#1] EOF received, client finished * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_get_tgt_recv] (0x0400): [RID#1] Child responded: 0 [FILE:/var/lib/sss/db/ccache_REDACTED-DOMAIN.COM], expired on [1637252518] * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_cli_auth_step] (0x0100): [RID#1] expire timeout is 900 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sdap_cli_auth_step] (0x1000): [RID#1] the connection will expire at 1637167018 * (2021-11-17 16:21:58): [be[redacted-domain.com]] [sasl_bind_send] (0x0100): [RID#1] Executing sasl bind mech: GSSAPI, user: host/etestvm1.redacted-domain.com * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_cli_connect_recv] (0x0400): [RID#1] Connection established. * (2021-11-17 16:21:59): [be[redacted-domain.com]] [_be_fo_set_port_status] (0x8000): [RID#1] Setting status: PORT_WORKING. Called from: src/providers/ldap/sdap_async_connection.c: sdap_cli_connect_recv: 2145 * (2021-11-17 16:21:59): [be[redacted-domain.com]] [fo_set_port_status] (0x0100): [RID#1] Marking port 0 of server 'equator.redacted-domain.com' as 'working' * (2021-11-17 16:21:59): [be[redacted-domain.com]] [set_server_common_status] (0x0100): [RID#1] Marking server 'equator.redacted-domain.com' as 'working' * (2021-11-17 16:21:59): [be[redacted-domain.com]] [fo_set_port_status] (0x0400): [RID#1] Marking port 0 of duplicate server 'equator.redacted-domain.com' as 'working' * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_id_op_connect_done] (0x4000): [RID#1] notify connected to op #1 * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_search_bases_ex_next_base] (0x0400): [RID#1] Issuing LDAP lookup with base [cn=ranges,cn=etc,dc=redacted-domain,dc=com] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_print_server] (0x2000): [RID#1] Searching 10.10.0.37:389 * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x0400): [RID#1] calling ldap_search_ext with [objectclass=ipaIDRange][cn=ranges,cn=etc,dc=redacted-domain,dc=com]. * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x1000): [RID#1] Requesting attrs: [objectClass] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x1000): [RID#1] Requesting attrs: [cn] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x1000): [RID#1] Requesting attrs: [ipaBaseID] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x1000): [RID#1] Requesting attrs: [ipaBaseRID] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x1000): [RID#1] Requesting attrs: [ipaSecondaryBaseRID] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x1000): [RID#1] Requesting attrs: [ipaIDRangeSize] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x1000): [RID#1] Requesting attrs: [ipaNTTrustedDomainSID] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x1000): [RID#1] Requesting attrs: [ipaRangeType] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x1000): [RID#1] Requesting attrs: [ipaAutoPrivateGroups] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_get_generic_ext_step] (0x2000): [RID#1] ldap_search_ext called, msgid = 5 * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_op_add] (0x2000): [RID#1] New operation 5 timeout 6 * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_id_op_connect_done] (0x4000): [RID#1] caching successful connection after 1 notifies * (2021-11-17 16:21:59): [be[redacted-domain.com]] [be_run_unconditional_online_cb] (0x4000): [RID#1] List of unconditional online callbacks is empty, nothing to do. * (2021-11-17 16:21:59): [be[redacted-domain.com]] [be_run_online_cb] (0x0080): [RID#1] Going online. Running callbacks. * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_process_result] (0x2000): Trace: sh[0x560bb57ed2b0], connected[1], ops[0x560bb5838b90], ldap[0x560bb581c170] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_process_message] (0x4000): [RID#1] Message type: [LDAP_RES_SEARCH_ENTRY] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_parse_entry] (0x1000): [RID#1] OriginalDN: [cn=REDACTED-DOMAIN.COM_id_range,cn=ranges,cn=etc,dc=redacted-domain,dc=com]. * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [objectClass] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [cn] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [ipaBaseID] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [ipaIDRangeSize] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [ipaRangeType] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_process_result] (0x2000): Trace: sh[0x560bb57ed2b0], connected[1], ops[0x560bb5838b90], ldap[0x560bb581c170] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_process_result] (0x2000): Trace: end of ldap_result list * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_process_result] (0x2000): Trace: sh[0x560bb57ed2b0], connected[1], ops[0x560bb5838b90], ldap[0x560bb581c170] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_process_message] (0x4000): [RID#1] Message type: [LDAP_RES_SEARCH_ENTRY] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_parse_entry] (0x1000): [RID#1] OriginalDN: [cn=REDACTED-DOMAIN.COM_new_range,cn=ranges,cn=etc,dc=redacted-domain,dc=com]. * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [objectClass] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [cn] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [ipaBaseID] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [ipaIDRangeSize] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_parse_range] (0x2000): [RID#1] No sub-attributes for [ipaRangeType] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_process_result] (0x2000): Trace: sh[0x560bb57ed2b0], connected[1], ops[0x560bb5838b90], ldap[0x560bb581c170] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_process_message] (0x4000): [RID#1] Message type: [LDAP_RES_SEARCH_RESULT] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_get_generic_op_finished] (0x0400): [RID#1] Search result: Success(0), no errmsg set * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_op_destructor] (0x2000): [RID#1] Operation 5 finished * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sdap_search_bases_ex_done] (0x0400): [RID#1] Receiving data from base [cn=ranges,cn=etc,dc=redacted-domain,dc=com] * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sysdb_update_ranges] (0x0400): [RID#1] Adding range [REDACTED-DOMAIN.COM_id_range]. * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sysdb_range_create] (0x0040): [RID#1] Invalid range, skipping. Expected that either the secondary base RID or the SID of the trusted domain is set, but not both or none of them. ********************** BACKTRACE DUMP ENDS HERE ********************************* (2021-11-17 16:21:59): [be[redacted-domain.com]] [sysdb_range_create] (0x0040): [RID#1] Invalid range, skipping. Expected that either the secondary base RID or the SID of the trusted domain is set, but not both or none of them. ********************** PREVIOUS MESSAGE WAS TRIGGERED BY THE FOLLOWING BACKTRACE: * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sysdb_update_ranges] (0x0400): [RID#1] Adding range [REDACTED-DOMAIN.COM_new_range]. * (2021-11-17 16:21:59): [be[redacted-domain.com]] [sysdb_range_create] (0x0040): [RID#1] Invalid range, skipping. Expected that either the secondary base RID or the SID of the trusted domain is set, but not both or none of them. ********************** BACKTRACE DUMP ENDS HERE *********************************