Skip to content

Instantly share code, notes, and snippets.

@cmatheson
Last active August 29, 2015 14:01
Show Gist options
  • Save cmatheson/4f3ab531e9ee0fd05cb5 to your computer and use it in GitHub Desktop.
Save cmatheson/4f3ab531e9ee0fd05cb5 to your computer and use it in GitHub Desktop.
(Thu May 8 13:58:44 2014) [[sssd[krb5_child[7187]]]] [main] (0x0400): krb5_child started.
(Thu May 8 13:58:44 2014) [[sssd[krb5_child[7187]]]] [unpack_buffer] (0x1000): total buffer size: [140]
(Thu May 8 13:58:44 2014) [[sssd[krb5_child[7187]]]] [unpack_buffer] (0x0100): cmd [241] uid [1628202302] gid [1628200513] validate [true] enterprise principal [true] offline [false] UPN [[email protected]]
(Thu May 8 13:58:44 2014) [[sssd[krb5_child[7187]]]] [unpack_buffer] (0x0100): ccname: [FILE:/tmp/krb5cc_1628202302_XXXXXX] keytab: [/etc/krb5.keytab]
(Thu May 8 13:58:44 2014) [[sssd[krb5_child[7187]]]] [set_lifetime_options] (0x0100): Cannot read [SSSD_KRB5_RENEWABLE_LIFETIME] from environment.
(Thu May 8 13:58:44 2014) [[sssd[krb5_child[7187]]]] [set_lifetime_options] (0x0100): Cannot read [SSSD_KRB5_LIFETIME] from environment.
(Thu May 8 13:58:44 2014) [[sssd[krb5_child[7187]]]] [set_canonicalize_option] (0x0100): SSSD_KRB5_CANONICALIZE is set to [true]
(Thu May 8 13:58:44 2014) [[sssd[krb5_child[7187]]]] [k5c_setup] (0x0100): Not using FAST.
(Thu May 8 13:58:44 2014) [[sssd[krb5_child[7187]]]] [main] (0x0400): Will perform online auth
(Thu May 8 13:58:44 2014) [[sssd[krb5_child[7187]]]] [tgt_req_child] (0x1000): Attempting to get a TGT
(Thu May 8 13:58:44 2014) [[sssd[krb5_child[7187]]]] [get_and_save_tgt] (0x0400): Attempting kinit for realm [CORP.EXAMPLE.COM]
(Thu May 8 13:58:44 2014) [[sssd[krb5_child[7187]]]] [get_and_save_tgt] (0x0020): 979: [-1765328360][Preauthentication failed]
(Thu May 8 13:58:44 2014) [[sssd[krb5_child[7187]]]] [map_krb5_error] (0x0020): 1040: [-1765328360][Preauthentication failed]
(Thu May 8 13:58:44 2014) [[sssd[krb5_child[7187]]]] [k5c_send_data] (0x0200): Received error code 1432158214
(Thu May 8 13:58:44 2014) [[sssd[krb5_child[7187]]]] [main] (0x0400): krb5_child completed successfully
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [be_get_account_info] (0x0100): Got request for [3][1][name=me]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [be_req_set_domain] (0x0400): Changing request domain from [corp.example.com] to [corp.example.com]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_initgr_next_base] (0x0400): Searching for users with base [DC=corp,DC=example,DC=com]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_step] (0x0400): calling ldap_search_ext with [(&(sAMAccountName=me)(objectclass=user)(objectSID=*))][DC=corp,DC=example,DC=com].
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_step] (0x1000): Requesting attrs: [objectClass]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_step] (0x1000): Requesting attrs: [sAMAccountName]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_step] (0x1000): Requesting attrs: [unixUserPassword]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_step] (0x1000): Requesting attrs: [uidNumber]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_step] (0x1000): Requesting attrs: [gidNumber]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_step] (0x1000): Requesting attrs: [gecos]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_step] (0x1000): Requesting attrs: [unixHomeDirectory]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_step] (0x1000): Requesting attrs: [loginShell]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_step] (0x1000): Requesting attrs: [nosuchattribute]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_step] (0x1000): Requesting attrs: [name]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_step] (0x1000): Requesting attrs: [memberOf]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_step] (0x1000): Requesting attrs: [objectGUID]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_step] (0x1000): Requesting attrs: [objectSID]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_step] (0x1000): Requesting attrs: [primaryGroupID]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_step] (0x1000): Requesting attrs: [whenChanged]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_step] (0x1000): Requesting attrs: [uSNChanged]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_step] (0x1000): Requesting attrs: [accountExpires]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_step] (0x1000): Requesting attrs: [userAccountControl]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_done] (0x0400): Search result: Success(0), no errmsg set
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_save_user] (0x0400): Save user
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_primary_name] (0x0400): Processing object me
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_save_user] (0x0400): Processing user me
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_save_user] (0x1000): Mapping user [me] objectSID [S-1-5-21-3322822159-133036858-2408800093-2302] to unix ID
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_save_user] (0x0400): Adding original memberOf attributes to [me].
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_save_user] (0x0400): User principal is not available for [me].
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_save_user] (0x0400): Storing info for user me
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_step] (0x0400): calling ldap_search_ext with [no filter][CN=Me,OU=Example Users,DC=corp,DC=example,DC=com].
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_step] (0x1000): Requesting attrs: [tokenGroups]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_generic_ext_done] (0x0400): Search result: Success(0), no errmsg set
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_ad_tokengroups_initgr_mapping_done] (0x1000): Processing membership SID [S-1-5-32-545]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_idmap_sid_to_unix] (0x0400): Object SID [S-1-5-32-545] is a built-in one.
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_ad_tokengroups_initgr_mapping_done] (0x0400): Skipping built-in object.
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_ad_tokengroups_initgr_mapping_done] (0x1000): Processing membership SID [S-1-5-21-3322822159-133036858-2408800093-513]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_ad_tokengroups_initgr_mapping_done] (0x1000): SID [S-1-5-21-3322822159-133036858-2408800093-513] maps to GID [1628200513]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_ad_tokengroups_initgr_mapping_done] (0x1000): Processing membership SID [S-1-5-21-3322822159-133036858-2408800093-3102]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_ad_tokengroups_initgr_mapping_done] (0x1000): SID [S-1-5-21-3322822159-133036858-2408800093-3102] maps to GID [1628203102]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_ad_tokengroups_initgr_mapping_done] (0x1000): Processing membership SID [S-1-5-21-3322822159-133036858-2408800093-2616]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_ad_tokengroups_initgr_mapping_done] (0x1000): SID [S-1-5-21-3322822159-133036858-2408800093-2616] maps to GID [1628202616]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_ad_tokengroups_initgr_mapping_done] (0x1000): Processing membership SID [S-1-5-21-3322822159-133036858-2408800093-2623]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_ad_tokengroups_initgr_mapping_done] (0x1000): SID [S-1-5-21-3322822159-133036858-2408800093-2623] maps to GID [1628202623]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_ad_tokengroups_update_members] (0x1000): Updating memberships for [me]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [sdap_get_initgr_done] (0x1000): Mapping primary group to unix ID
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [acctinfo_callback] (0x0100): Request processed. Returned 0,0,Success
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [be_req_set_domain] (0x0400): Changing request domain from [corp.example.com] to [corp.example.com]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [be_pam_handler] (0x0100): Got request with the following data
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [pam_print_data] (0x0100): command: PAM_AUTHENTICATE
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [pam_print_data] (0x0100): domain: corp.example.com
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [pam_print_data] (0x0100): user: me
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [pam_print_data] (0x0100): service: su-l
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [pam_print_data] (0x0100): tty: pts/1
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [pam_print_data] (0x0100): ruser: cmatheson
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [pam_print_data] (0x0100): rhost:
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [pam_print_data] (0x0100): authtok type: 1
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [pam_print_data] (0x0100): newauthtok type: 0
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [pam_print_data] (0x0100): priv: 0
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [pam_print_data] (0x0100): cli_pid: 7186
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [krb5_pam_handler] (0x1000): Wait queue of user [me] is empty, running request immediately.
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [compare_principal_realm] (0x0020): *** UPN! [[email protected]] REALM! [CORP.EXAMPLE.COM] DIFFERENT REALM! [0]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [krb5_auth_send] (0x0100): Home directory for user [me] not known.
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [switch_creds] (0x0200): Switch user to [1628202302][1628200513].
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [switch_creds] (0x0200): Switch user to [0][0].
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [fo_resolve_service_send] (0x0100): Trying to resolve service 'AD'
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [get_server_status] (0x1000): Status of server 'it-dc02.corp.example.com' is 'working'
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [get_port_status] (0x1000): Port status of port 389 for server 'it-dc02.corp.example.com' is 'working'
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [resolve_srv_send] (0x0200): The status of SRV lookup is resolved
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [get_server_status] (0x1000): Status of server 'it-dc02.corp.example.com' is 'working'
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [be_resolve_server_process] (0x1000): Saving the first resolved server
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [be_resolve_server_process] (0x0200): Found address for server it-dc02.corp.example.com: [10.0.34.17] TTL 3600
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [write_pipe_handler] (0x0400): All data has been sent!
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [child_sig_handler] (0x1000): Waiting for child [7187].
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [child_sig_handler] (0x0100): child [7187] finished successfully.
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [read_pipe_handler] (0x0400): EOF received, client finished
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [check_wait_queue] (0x1000): Wait queue for user [me] is empty.
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [be_pam_handler_callback] (0x0100): Backend returned: (0, 17, <NULL>) [Success]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [be_pam_handler_callback] (0x0100): Sending result [17][corp.example.com]
(Thu May 8 13:58:44 2014) [sssd[be[corp.example.com]]] [be_pam_handler_callback] (0x0100): Sent result [17][corp.example.com]
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment