Volker Lendecke bb683535f1 winbindd: Do request profiling ...

By default we log a request that takes more than 60 seconds. This can be
changed by setting

winbind:request profile threshold = <seconds>

Another parameter controls the depth of the request hierarchy printed:

winbind:request profile depth = <n>

The default request logged to syslog via DEBUG(0) looks like the
following for a wbinfo -P:

[struct process_request_state] ../source3/winbindd/winbindd.c:683 [2018/06/19 13:33:14.190365] ../source3/winbindd/winbindd.c:853 [2018/06/19 13:33:14.192737] [0.002372] -> TEVENT_REQ_DONE (2 0))
 [struct winbindd_ping_dc_state] ../source3/winbindd/winbindd_ping_dc.c:41 [2018/06/19 13:33:14.190369] ../source3/winbindd/winbindd_ping_dc.c:112 [2018/06/19 13:33:14.192681] [0.002312] -> TEVENT_REQ_DONE (2 0))
  [struct dcerpc_wbint_PingDc_state] default/librpc/gen_ndr/ndr_winbind_c.c:4335 [2018/06/19 13:33:14.190383] default/librpc/gen_ndr/ndr_winbind_c.c:4396 [2018/06/19 13:33:14.192680] [0.002297] -> TEVENT_REQ_DONE (2 0))
   [struct dcerpc_wbint_PingDc_r_state] default/librpc/gen_ndr/ndr_winbind_c.c:4251 [2018/06/19 13:33:14.190385] default/librpc/gen_ndr/ndr_winbind_c.c:4285 [2018/06/19 13:33:14.192678] [0.002293] -> TEVENT_REQ_DONE (2 0))
    [struct dcerpc_binding_handle_call_state] ../librpc/rpc/binding_handle.c:371 [2018/06/19 13:33:14.190387] ../librpc/rpc/binding_handle.c:520 [2018/06/19 13:33:14.192675] [0.002288] -> TEVENT_REQ_DONE (2 0))
     [struct dcerpc_binding_handle_raw_call_state] ../librpc/rpc/binding_handle.c:149 [2018/06/19 13:33:14.190400] ../librpc/rpc/binding_handle.c:203 [2018/06/19 13:33:14.192646] [0.002246] -> TEVENT_REQ_DONE (2 0))
      [struct wbint_bh_raw_call_state] ../source3/winbindd/winbindd_dual_ndr.c:89 [2018/06/19 13:33:14.190402] ../source3/winbindd/winbindd_dual_ndr.c:204 [2018/06/19 13:33:14.192644] [0.002242] -> TEVENT_REQ_DONE (2 0))
       [struct wb_domain_request_state] ../source3/winbindd/winbindd_dual.c:473 [2018/06/19 13:33:14.190404] ../source3/winbindd/winbindd_dual.c:708 [2018/06/19 13:33:14.192640] [0.002236] -> TEVENT_REQ_DONE (2 0))
        [struct wb_child_request_state] ../source3/winbindd/winbindd_dual.c:198 [2018/06/19 13:33:14.190411] ../source3/winbindd/winbindd_dual.c:273 [2018/06/19 13:33:14.192638] [0.002227] -> TEVENT_REQ_DONE (2 0))
         [struct tevent_queue_wait_state] ../lib/tevent/tevent_queue.c:336 [2018/06/19 13:33:14.190412] ../lib/tevent/tevent_queue.c:355 [2018/06/19 13:33:14.190415] [0.000003] -> TEVENT_REQ_DONE (2 0))
         [struct wb_simple_trans_state] ../nsswitch/wb_reqtrans.c:375 [2018/06/19 13:33:14.190424] ../nsswitch/wb_reqtrans.c:432 [2018/06/19 13:33:14.192630] [0.002206] -> TEVENT_REQ_DONE (2 0))
          [struct req_write_state] ../nsswitch/wb_reqtrans.c:158 [2018/06/19 13:33:14.190425] ../nsswitch/wb_reqtrans.c:194 [2018/06/19 13:33:14.190472] [0.000047] -> TEVENT_REQ_DONE (2 0))
           [struct writev_state] ../lib/async_req/async_sock.c:263 [2018/06/19 13:33:14.190432] ../lib/async_req/async_sock.c:412 [2018/06/19 13:33:14.190470] [0.000038] -> TEVENT_REQ_DONE (2 0))
          [struct resp_read_state] ../nsswitch/wb_reqtrans.c:222 [2018/06/19 13:33:14.190475] ../nsswitch/wb_reqtrans.c:275 [2018/06/19 13:33:14.192629] [0.002154] -> TEVENT_REQ_DONE (2 0))
           [struct read_packet_state] ../lib/async_req/async_sock.c:458 [2018/06/19 13:33:14.190476] ../lib/async_req/async_sock.c:546 [2018/06/19 13:33:14.192626] [0.002150] -> TEVENT_REQ_DONE (2 0))
 [struct resp_write_state] ../nsswitch/wb_reqtrans.c:307 [2018/06/19 13:33:14.192693] ../nsswitch/wb_reqtrans.c:344 [2018/06/19 13:33:14.192734] [0.000041] -> TEVENT_REQ_DONE (2 0))
  [struct writev_state] ../lib/async_req/async_sock.c:263 [2018/06/19 13:33:14.192694] ../lib/async_req/async_sock.c:412 [2018/06/19 13:33:14.192732] [0.000038] -> TEVENT_REQ_DONE (2 0))

Signed-off-by: Volker Lendecke <vl@samba.org>
Reviewed-by: Ralph Boehme <slow@samba.org>

2018-07-11 23:04:23 +02:00

..

idmap_hash

idmap_hash: Align integer types

2018-06-19 08:59:11 +02:00

idmap_ad_nss.c

idmap: Fix CID 1363261 Resource leak

2018-04-07 02:11:20 +02:00

idmap_ad.c

libsmb: Give namequery.c its own header

2018-04-11 01:06:39 +02:00

idmap_autorid_tdb.c

idmap_autorid: Simplify idmap_autorid_loadconfig

2016-12-16 21:30:28 +01:00

idmap_autorid.c

s3:winbindd: Add FALL_THROUGH statements in idmap_autorid.c

2018-03-01 04:37:43 +01:00

idmap_ldap.c

winbind: Replace winbind_event_context with server_event_context

2017-11-18 00:09:16 +01:00

idmap_nss.c

lib: modules: Change XXX_init interface from XXX_init(void) to XXX_init(TALLOC_CTX *)

2017-04-22 01:17:00 +02:00

idmap_passdb.c

lib: modules: Change XXX_init interface from XXX_init(void) to XXX_init(TALLOC_CTX *)

2017-04-22 01:17:00 +02:00

idmap_proto.h

winbindd: pass domain SID to wbint_UnixIDs2Sids

2017-10-10 15:51:27 +02:00

idmap_rfc2307.c

winbind: Replace winbind_event_context with server_event_context

2017-11-18 00:09:16 +01:00

idmap_rid.c

winbindd: idmap_rid: error code for failing id-to-sid mapping request

2017-10-10 19:57:37 +02:00

idmap_rw.c

…

idmap_rw.h

…

idmap_script.c

lib: modules: Change XXX_init interface from XXX_init(void) to XXX_init(TALLOC_CTX *)

2017-04-22 01:17:00 +02:00

idmap_tdb2.c

lib: modules: Change XXX_init interface from XXX_init(void) to XXX_init(TALLOC_CTX *)

2017-04-22 01:17:00 +02:00

idmap_tdb_common.c

s3:winbindd: Fix size types in idmap_tdb_common

2018-03-20 23:16:15 +01:00

idmap_tdb_common.h

…

idmap_tdb.c

lib: modules: Change XXX_init interface from XXX_init(void) to XXX_init(TALLOC_CTX *)

2017-04-22 01:17:00 +02:00

idmap_util.c

idmap_rfc2307: Don't stop after 30 entries

2017-05-08 21:08:23 +02:00

idmap.c

winbindd: pass domain SID to wbint_UnixIDs2Sids

2017-10-10 15:51:27 +02:00

nss_info_template.c

lib: modules: Change XXX_init interface from XXX_init(void) to XXX_init(TALLOC_CTX *)

2017-04-22 01:17:00 +02:00

nss_info.c

winbindd: Remove ads.h include from nss_info

2018-07-11 22:39:36 +02:00

wb_dsgetdcname.c

winbind: add locator_child_handle() and use it instead of child->binding_handle

2018-02-23 04:09:18 +01:00

wb_getgrsid.c

winbindd: remove 'winbind trusted domains only' handling

2018-01-10 01:01:23 +01:00

wb_getpwsid.c

s3:winbind: Fix regression introduced with bso #12851

2018-06-21 01:03:52 +02:00

wb_gettoken.c

Re-enable token groups fallback

2017-03-06 19:18:31 +01:00

wb_group_members.c

winbind: Remove the use of "talloc_dict"

2017-09-30 08:01:24 +02:00

wb_lookupname.c

winbind: Pass upn unmodified to lookup names

2018-05-11 09:07:36 +02:00

wb_lookupsid.c

winbindd: remove bogus fallback to the forest root in wb_lookupsid*()

2017-03-11 21:05:09 +01:00

wb_lookupsids.c

winbindd: make use of talloc_zero_array() in wb_lookupsids*()

2018-02-21 14:19:17 +01:00

wb_lookupuseraliases.c

librpc/idl: Merge wbint.idl with winbind.idl so we can forward IRPC requests to internal winbind calls

2014-06-11 10:18:26 +02:00

wb_lookupusergroups.c

winbindd: find the domain based on the sid within wb_lookupusergroups_send()

2017-03-06 15:09:18 +01:00

wb_next_grent.c

winbind: Remove the use of "talloc_dict"

2017-09-30 08:01:24 +02:00

wb_next_pwent.c

winbind: Go throught wb_getpwsid for listing users

2017-01-02 18:04:14 +01:00

wb_query_group_list.c

s3:winbind: add wb_query_group_list module - async query group list

2015-03-16 20:26:51 +01:00

wb_query_user_list.c

s3-winbindd: use fill_domain_username_talloc() in winbind.

2018-05-17 17:30:08 +02:00

wb_queryuser.c

winbindd: remove 'winbind trusted domains only' handling

2018-01-10 01:01:23 +01:00

wb_seqnum.c

librpc/idl: Merge wbint.idl with winbind.idl so we can forward IRPC requests to internal winbind calls

2014-06-11 10:18:26 +02:00

wb_seqnums.c

winbindd: Use talloc_zero_array for consistency with other winbindd_domain allocators

2018-03-24 07:21:37 +01:00

wb_sids2xids.c

winbind: add idmap_child_handle() and use it instead of child->binding_handle

2018-02-23 04:09:18 +01:00

wb_xids2sids.c

winbind: Pass upn unmodified to lookup names

2018-05-11 09:07:36 +02:00

winbindd_ads.c

libsmb: Give namequery.c its own header

2018-04-11 01:06:39 +02:00

winbindd_ads.h

winbindd: Give winbindd_ads.c its own header

2017-05-17 01:47:17 +02:00

winbindd_allocate_gid.c

winbind: add idmap_child_handle() and use it instead of child->binding_handle

2018-02-23 04:09:18 +01:00

winbindd_allocate_uid.c

winbind: add idmap_child_handle() and use it instead of child->binding_handle

2018-02-23 04:09:18 +01:00

winbindd_async.c

…

winbindd_cache.c

winbindd: Use is_domain_offline() where appropriate

2018-06-16 01:06:36 +02:00

winbindd_ccache_access.c

winbindd: winbindd_ccache_save() -> bool_dispatch_table

2018-05-17 08:44:19 +02:00

winbindd_change_machine_acct.c

librpc/idl: Merge wbint.idl with winbind.idl so we can forward IRPC requests to internal winbind calls

2014-06-11 10:18:26 +02:00

winbindd_check_machine_acct.c

librpc/idl: Merge wbint.idl with winbind.idl so we can forward IRPC requests to internal winbind calls

2014-06-11 10:18:26 +02:00

winbindd_cm.c

s3:winbind: Check if we have an open file descriptor

2018-05-17 17:30:08 +02:00

winbindd_cred_cache.c

winbind: Replace winbind_event_context with server_event_context

2017-11-18 00:09:16 +01:00

winbindd_creds.c

winbind: Fix UPN handling in parse_domain_user()

2018-05-11 09:07:37 +02:00

winbindd_domain_info.c

winbindd: Make DOMAIN_INFO a proper async request

2018-05-17 08:44:19 +02:00

winbindd_domain.c

…

winbindd_dsgetdcname.c

winbind: add locator_child_handle() and use it instead of child->binding_handle

2018-02-23 04:09:18 +01:00

winbindd_dual_ndr.c

winbind: Maintain a binding handle per domain and always go via wb_domain_request_send()

2018-02-23 04:09:18 +01:00

winbindd_dual_srv.c

libsmb: Give dsgetdcname.c its own header

2018-04-11 01:06:39 +02:00

winbindd_dual.c

source3: initilize_password_db after a fork.

2018-04-06 02:08:45 +02:00

winbindd_endgrent.c

…

winbindd_endpwent.c

…

winbindd_getdcname.c

librpc/idl: Merge wbint.idl with winbind.idl so we can forward IRPC requests to internal winbind calls

2014-06-11 10:18:26 +02:00

winbindd_getgrent.c

winbind: cleanup winbindd_cli_state->grent_state if winbindd_getgrent_recv() returns an error

2018-02-23 04:09:18 +01:00

winbindd_getgrgid.c

winbind: Remove the use of "talloc_dict"

2017-09-30 08:01:24 +02:00

winbindd_getgrnam.c

winbind: Fix UPN handling in parse_domain_user()

2018-05-11 09:07:37 +02:00

winbindd_getgroups.c

winbind: Fix UPN handling in parse_domain_user()

2018-05-11 09:07:37 +02:00

winbindd_getpwent.c

winbind: cleanup winbindd_cli_state->pwent_state if winbindd_getpwent_recv() returns an error

2018-02-23 04:09:18 +01:00

winbindd_getpwnam.c

winbind: Fix UPN handling in parse_domain_user()

2018-05-11 09:07:37 +02:00

winbindd_getpwsid.c

…

winbindd_getpwuid.c

winbind: Use xids2sids in getpwuid

2016-02-22 20:29:15 +01:00

winbindd_getsidaliases.c

…

winbindd_getuserdomgroups.c

winbind: Use wb_gettoken in getuserdomgroups

2017-01-04 12:22:12 +01:00

winbindd_getusersids.c

winbind: Add "expand_local_aliases" to wb_gettoken

2017-01-04 12:22:12 +01:00

winbindd_gpupdate.c

samba-gpupdate: Change machine option to target

2018-07-04 13:23:09 +02:00

winbindd_group.c

s3-winbindd: use fill_domain_username_talloc() in winbind.

2018-05-17 17:30:08 +02:00

winbindd_idmap.c

winbind: add idmap_child_handle() and use it instead of child->binding_handle

2018-02-23 04:09:18 +01:00

winbindd_irpc.c

winbind: Pass upn unmodified to lookup names

2018-05-11 09:07:36 +02:00

winbindd_list_groups.c

s3-winbindd: use fill_domain_username_talloc() in winbind.

2018-05-17 17:30:08 +02:00

winbindd_list_users.c

s3:winbind: work around coverity false positive.

2017-02-23 23:54:48 +01:00

winbindd_locator.c

winbind: add locator_child_handle() and use it instead of child->binding_handle

2018-02-23 04:09:18 +01:00

winbindd_lookupname.c

winbind: Pass upn unmodified to lookup names

2018-05-11 09:07:36 +02:00

winbindd_lookuprids.c

librpc/idl: Merge wbint.idl with winbind.idl so we can forward IRPC requests to internal winbind calls

2014-06-11 10:18:26 +02:00

winbindd_lookupsid.c

…

winbindd_lookupsids.c

…

winbindd_misc.c

winbindd: Make DOMAIN_INFO a proper async request

2018-05-17 08:44:19 +02:00

winbindd_msrpc.c

winbindd: don't force using LSA_LOOKUP_NAMES_ALL for non workstation trusts.

2018-02-10 08:35:16 +01:00

winbindd_ndr.c

winbind: Remove the "winbindd_children" global

2018-03-01 09:53:46 +01:00

winbindd_pam_auth_crap.c

winbindd: WBFLAG_PAM_AUTH_PAC should call add_trusted_domain_from_auth() is the result is trusted

2018-02-10 13:08:50 +01:00

winbindd_pam_auth.c

winbind: Fix UPN handling in canonicalize_username()

2018-05-11 12:02:37 +02:00

winbindd_pam_chauthtok.c

winbind: Fix UPN handling in canonicalize_username()

2018-05-11 12:02:37 +02:00

winbindd_pam_chng_pswd_auth_crap.c

winbind: Replace winbind_event_context with server_event_context

2017-11-18 00:09:16 +01:00

winbindd_pam_logoff.c

winbind: Fix UPN handling in canonicalize_username()

2018-05-11 12:02:37 +02:00

winbindd_pam.c

s3-winbindd: use fill_domain_username_talloc() in winbind.

2018-05-17 17:30:08 +02:00

winbindd_ping_dc.c

winbindd: Fix winbindd_ping_dc_recv

2018-06-16 01:06:36 +02:00

winbindd_proto.h

s3-winbindd: remove unused fill_domain_username()

2018-05-17 17:30:09 +02:00

winbindd_reconnect_ads.c

winbindd: add and use ldap_reconnect_need_retry() in winbindd_reconnect_ads.c

2018-03-15 15:46:09 +01:00

winbindd_reconnect.c

winbindd: call dcerpc_binding_handle_is_connected() from reset_cm_connection_on_error()

2018-03-15 15:46:09 +01:00

winbindd_rpc.c

winbindd: let normalize_name_map() call find_domain_from_name_noinit()

2017-11-29 16:59:15 +01:00

winbindd_rpc.h

Revert "winbind: Remove rpc_lookup_usergroups"

2017-03-06 15:09:17 +01:00

winbindd_samr.c

winbindd: Do re-connect if the RPC call fails in the passdb case

2018-03-24 02:31:15 +01:00

winbindd_setgrent.c

winbind: call lp_winbind_enum_{users,groups}() already in set{pw,gr}ent()

2018-02-23 04:09:18 +01:00

winbindd_setpwent.c

winbind: call lp_winbind_enum_{users,groups}() already in set{pw,gr}ent()

2018-02-23 04:09:18 +01:00

winbindd_show_sequence.c

…

winbindd_sids_to_xids.c

winbind: Make wb_sids2xids_recv work on an array

2015-03-07 15:28:59 +01:00

winbindd_util.c

s3:winbind: Do not lookup local system accounts in AD

2018-07-04 23:55:56 +02:00

winbindd_wins_byip.c

libsmb: Give namequery.c its own header

2018-04-11 01:06:39 +02:00

winbindd_wins_byname.c

libsmb: Give namequery.c its own header

2018-04-11 01:06:39 +02:00

winbindd_xids_to_sids.c

winbind: Expose WINBINDD_XIDS_TO_SIDS externally

2016-02-22 20:29:15 +01:00

winbindd.c

winbindd: Do request profiling

2018-07-11 23:04:23 +02:00

winbindd.h

winbind: Remove an unused struct declaration

2018-04-24 04:44:30 +02:00

wscript_build

winbindd: Make DOMAIN_INFO a proper async request

2018-05-17 08:44:19 +02:00