[Sysadmins] ldap долго думает...

[Maks Re]

-1 достаточно?

# date; ldapsearch -x -LLL -h 127.0.0.1  -b dc=perfect-ltd,dc=ru  -D
cn=ldapadmin,dc=perfect-ltd,dc=ru -W uid=maks; date

Wed Aug 27 16:25:23 MSD 2008

Enter LDAP Password:
dn: uid=maks,ou=it,ou=People,dc=perfect-ltd,dc=ru
objectClass: posixAccount
objectClass: top
objectClass: CourierMailAlias
objectClass: CourierMailAccount
objectClass: account
userPassword:: U2VjcmV0
mail: maks на perfect-ltd.ru
maildrop: postmaster на perfect-ltd.ru
cn: Maks D.
uid: maks
uidNumber: 5001
gidNumber: 5001
homeDirectory: /var/spool/mail/maks
gecos: Maks D.
mailbox: /var/spool/mail/maks/Maildir
quota: 51200000S

Wed Aug 27 16:25:31 MSD 2008

4 секунд на запрос (3 сек на ввод пароля)? многовато..



лог запроса

Aug 27 16:22:28 ldap slapd[22089]: conn=16 op=1 SRCH
base="dc=perfect-ltd,dc=ru" scope=2 deref=0 filter="(objectClass=*)"
Aug 27 16:22:28 ldap slapd[22089]: => hdb_search
Aug 27 16:22:28 ldap slapd[22089]: bdb_dn2entry("dc=perfect-ltd,dc=ru")
Aug 27 16:22:28 ldap slapd[22089]: search_candidates:
base="dc=perfect-ltd,dc=ru" (0x00000001) scope=2
Aug 27 16:22:28 ldap slapd[22089]: => hdb_dn2idl("dc=perfect-ltd,dc=ru")
Aug 27 16:22:28 ldap slapd[22089]: => bdb_filter_candidates
Aug 27 16:22:28 ldap slapd[22089]: ^IAND
Aug 27 16:22:28 ldap slapd[22089]: => bdb_list_candidates 0xa0
Aug 27 16:22:29 ldap slapd[22089]: => bdb_filter_candidates
Aug 27 16:22:29 ldap slapd[22089]: ^IPRESENT
Aug 27 16:22:29 ldap slapd[22089]: => bdb_presence_candidates (objectClass)
Aug 27 16:22:29 ldap slapd[22089]: <= bdb_filter_candidates: id=-1
first=1 last=4
Aug 27 16:22:29 ldap slapd[22089]: <= bdb_list_candidates: id=-1 first=1 last=4
Aug 27 16:22:29 ldap slapd[22089]: <= bdb_filter_candidates: id=-1
first=1 last=4
Aug 27 16:22:29 ldap slapd[22089]: bdb_search_candidates: id=-1 first=1 last=4
Aug 27 16:22:29 ldap slapd[22089]: => test_filter
Aug 27 16:22:29 ldap slapd[22089]:     PRESENT
Aug 27 16:22:29 ldap slapd[22089]: => access_allowed: search access to
"dc=perfect-ltd,dc=ru" "objectClass" requested
Aug 27 16:22:29 ldap slapd[22089]: <= root access granted
Aug 27 16:22:29 ldap slapd[22089]: <= test_filter 6
Aug 27 16:22:29 ldap slapd[22089]: => send_search_entry: conn 16
dn="dc=perfect-ltd,dc=ru"
Aug 27 16:22:29 ldap slapd[22089]: => access_allowed: read access to
"dc=perfect-ltd,dc=ru" "entry" requested
Aug 27 16:22:29 ldap slapd[22089]: <= root access granted
Aug 27 16:22:29 ldap slapd[22089]: => access_allowed: read access to
"dc=perfect-ltd,dc=ru" "objectClass" requested
Aug 27 16:22:29 ldap slapd[22089]: <= root access granted
Aug 27 16:22:29 ldap slapd[22089]: => access_allowed: read access to
"dc=perfect-ltd,dc=ru" "dc" requested
Aug 27 16:22:29 ldap slapd[22089]: <= root access granted
Aug 27 16:22:29 ldap slapd[22089]: => access_allowed: read access to
"dc=perfect-ltd,dc=ru" "o" requested
Aug 27 16:22:29 ldap slapd[22089]: <= root access granted
Aug 27 16:22:29 ldap slapd[22089]: conn=16 op=1 ENTRY dn="dc=perfect-ltd,dc=ru"
Aug 27 16:22:29 ldap slapd[22089]: <= send_search_entry: conn 16 exit.
Aug 27 16:22:29 ldap slapd[22089]: => test_filter
Aug 27 16:22:29 ldap slapd[22089]:     PRESENT
Aug 27 16:22:29 ldap slapd[22089]: => access_allowed: search access to
"ou=People,dc=perfect-ltd,dc=ru" "objectClass" requested
Aug 27 16:22:29 ldap slapd[22089]: <= root access granted
Aug 27 16:22:29 ldap slapd[22089]: <= test_filter 6
Aug 27 16:22:30 ldap slapd[22089]: => send_search_entry: conn 16
dn="ou=People,dc=perfect-ltd,dc=ru"
Aug 27 16:22:30 ldap slapd[22089]: => access_allowed: read access to
"ou=People,dc=perfect-ltd,dc=ru" "entry" requested
Aug 27 16:22:30 ldap slapd[22089]: <= root access granted
Aug 27 16:22:30 ldap slapd[22089]: => access_allowed: read access to
"ou=People,dc=perfect-ltd,dc=ru" "objectClass" requested
Aug 27 16:22:30 ldap slapd[22089]: <= root access granted
Aug 27 16:22:30 ldap slapd[22089]: => access_allowed: read access to
"ou=People,dc=perfect-ltd,dc=ru" "ou" requested
Aug 27 16:22:30 ldap slapd[22089]: <= root access granted
Aug 27 16:22:30 ldap slapd[22089]: conn=16 op=1 ENTRY
dn="ou=people,dc=perfect-ltd,dc=ru"
Aug 27 16:22:30 ldap slapd[22089]: <= send_search_entry: conn 16 exit.
Aug 27 16:22:30 ldap slapd[22089]: => test_filter
Aug 27 16:22:30 ldap slapd[22089]:     PRESENT
Aug 27 16:22:30 ldap slapd[22089]: => access_allowed: search access to
"ou=it,ou=People,dc=perfect-ltd,dc=ru" "objectClass" requested
Aug 27 16:22:30 ldap slapd[22089]: <= root access granted
Aug 27 16:22:30 ldap slapd[22089]: <= test_filter 6
Aug 27 16:22:30 ldap slapd[22089]: => send_search_entry: conn 16
dn="ou=it,ou=People,dc=perfect-ltd,dc=ru"
Aug 27 16:22:30 ldap slapd[22089]: => access_allowed: read access to
"ou=it,ou=People,dc=perfect-ltd,dc=ru" "entry" requested
Aug 27 16:22:30 ldap slapd[22089]: <= root access granted
Aug 27 16:22:30 ldap slapd[22089]: => access_allowed: read access to
"ou=it,ou=People,dc=perfect-ltd,dc=ru" "objectClass" requested
Aug 27 16:22:30 ldap slapd[22089]: <= root access granted
Aug 27 16:22:30 ldap slapd[22089]: => access_allowed: read access to
"ou=it,ou=People,dc=perfect-ltd,dc=ru" "ou" requested
Aug 27 16:22:30 ldap slapd[22089]: <= root access granted
Aug 27 16:22:30 ldap slapd[22089]: => access_allowed: read access to
"ou=it,ou=People,dc=perfect-ltd,dc=ru" "mail" requested
Aug 27 16:22:30 ldap slapd[22089]: <= root access granted
Aug 27 16:22:30 ldap slapd[22089]: => access_allowed: read access to
"ou=it,ou=People,dc=perfect-ltd,dc=ru" "maildrop" requested
Aug 27 16:22:30 ldap slapd[22089]: <= root access granted
Aug 27 16:22:30 ldap slapd[22089]: conn=16 op=1 ENTRY
dn="ou=it,ou=people,dc=perfect-ltd,dc=ru"
Aug 27 16:22:30 ldap slapd[22089]: <= send_search_entry: conn 16 exit.
Aug 27 16:22:30 ldap slapd[22089]: => test_filter
Aug 27 16:22:30 ldap slapd[22089]:     PRESENT
Aug 27 16:22:30 ldap slapd[22089]: => access_allowed: search access to
"uid=maks,ou=it,ou=People,dc=perfect-ltd,dc=ru" "objectClass"
requested
Aug 27 16:22:30 ldap slapd[22089]: <= root access granted
Aug 27 16:22:31 ldap slapd[22089]: <= test_filter 6
Aug 27 16:22:31 ldap slapd[22089]: => send_search_entry: conn 16
dn="uid=maks,ou=it,ou=People,dc=perfect-ltd,dc=ru"
Aug 27 16:22:31 ldap slapd[22089]: => access_allowed: read access to
"uid=maks,ou=it,ou=People,dc=perfect-ltd,dc=ru" "entry" requested
Aug 27 16:22:31 ldap slapd[22089]: <= root access granted
Aug 27 16:22:31 ldap slapd[22089]: => access_allowed: read access to
"uid=maks,ou=it,ou=People,dc=perfect-ltd,dc=ru" "objectClass"
requested
Aug 27 16:22:31 ldap slapd[22089]: <= root access granted
Aug 27 16:22:31 ldap slapd[22089]: => access_allowed: read access to
"uid=maks,ou=it,ou=People,dc=perfect-ltd,dc=ru" "userPassword"
requested
Aug 27 16:22:31 ldap slapd[22089]: <= root access granted
Aug 27 16:22:31 ldap slapd[22089]: => access_allowed: read access to
"uid=maks,ou=it,ou=People,dc=perfect-ltd,dc=ru" "mail" requested
Aug 27 16:22:31 ldap slapd[22089]: <= root access granted
Aug 27 16:22:31 ldap slapd[22089]: => access_allowed: read access to
"uid=maks,ou=it,ou=People,dc=perfect-ltd,dc=ru" "maildrop" requested
Aug 27 16:22:31 ldap slapd[22089]: <= root access granted
Aug 27 16:22:31 ldap slapd[22089]: => access_allowed: read access to
"uid=maks,ou=it,ou=People,dc=perfect-ltd,dc=ru" "cn" requested
Aug 27 16:22:31 ldap slapd[22089]: <= root access granted
Aug 27 16:22:31 ldap slapd[22089]: => access_allowed: read access to
"uid=maks,ou=it,ou=People,dc=perfect-ltd,dc=ru" "uid" requested
Aug 27 16:22:31 ldap slapd[22089]: <= root access granted
Aug 27 16:22:31 ldap slapd[22089]: => access_allowed: read access to
"uid=maks,ou=it,ou=People,dc=perfect-ltd,dc=ru" "uidNumber" requested
Aug 27 16:22:31 ldap slapd[22089]: <= root access granted
Aug 27 16:22:31 ldap slapd[22089]: => access_allowed: read access to
"uid=maks,ou=it,ou=People,dc=perfect-ltd,dc=ru" "gidNumber" requested
Aug 27 16:22:31 ldap slapd[22089]: <= root access granted
Aug 27 16:22:31 ldap slapd[22089]: => access_allowed: read access to
"uid=maks,ou=it,ou=People,dc=perfect-ltd,dc=ru" "homeDirectory"
requested
Aug 27 16:22:31 ldap slapd[22089]: <= root access granted
Aug 27 16:22:31 ldap slapd[22089]: => access_allowed: read access to
"uid=maks,ou=it,ou=People,dc=perfect-ltd,dc=ru" "gecos" requested
Aug 27 16:22:31 ldap slapd[22089]: <= root access granted
Aug 27 16:22:31 ldap slapd[22089]: => access_allowed: read access to
"uid=maks,ou=it,ou=People,dc=perfect-ltd,dc=ru" "mailbox" requested
Aug 27 16:22:31 ldap slapd[22089]: <= root access granted
Aug 27 16:22:31 ldap slapd[22089]: => access_allowed: read access to
"uid=maks,ou=it,ou=People,dc=perfect-ltd,dc=ru" "quota" requested
Aug 27 16:22:31 ldap slapd[22089]: <= root access granted
Aug 27 16:22:31 ldap slapd[22089]: conn=16 op=1 ENTRY
dn="uid=maks,ou=it,ou=people,dc=perfect-ltd,dc=ru"
Aug 27 16:22:31 ldap slapd[22089]: <= send_search_entry: conn 16 exit.
Aug 27 16:22:31 ldap slapd[22089]: send_ldap_result: conn=16 op=1 p=3
Aug 27 16:22:32 ldap slapd[22089]: send_ldap_result: err=0 matched="" text=""
Aug 27 16:22:32 ldap slapd[22089]: send_ldap_response: msgid=2 tag=101 err=0
Aug 27 16:22:32 ldap slapd[22089]: conn=16 op=1 SEARCH RESULT tag=101
err=0 nentries=4 text=
Aug 27 16:22:32 ldap slapd[22089]: daemon: activity on 1 descriptor
Aug 27 16:22:32 ldap slapd[22089]: daemon: activity on:
Aug 27 16:22:32 ldap slapd[22089]:  26r
Aug 27 16:22:32 ldap slapd[22089]:
Aug 27 16:22:32 ldap slapd[22089]: daemon: read active on 26
Aug 27 16:22:32 ldap slapd[22089]: connection_get(26)
Aug 27 16:22:32 ldap slapd[22089]: connection_get(26): got connid=16
Aug 27 16:22:32 ldap slapd[22089]: connection_read(26): checking for
input on id=16
Aug 27 16:22:32 ldap slapd[22089]: ber_get_next on fd 26 failed
errno=0 (Success)
Aug 27 16:22:32 ldap slapd[22089]: connection_read(26): input error=-2
id=16, closing.
Aug 27 16:22:32 ldap slapd[22089]: connection_closing: readying
conn=16 sd=26 for close
Aug 27 16:22:32 ldap slapd[22089]: connection_close: deferring conn=16 sd=-1
Aug 27 16:22:32 ldap slapd[22089]: daemon: epoll: listen=7
active_threads=0 tvp=NULL
Aug 27 16:22:32 ldap slapd[22089]: daemon: epoll: listen=8
active_threads=0 tvp=NULL
Aug 27 16:22:32 ldap slapd[22089]: daemon: activity on 1 descriptor
Aug 27 16:22:32 ldap slapd[22089]: daemon: activity on:
Aug 27 16:22:32 ldap slapd[22089]:
Aug 27 16:22:32 ldap slapd[22089]: daemon: epoll: listen=7
active_threads=0 tvp=NULL
Aug 27 16:22:32 ldap slapd[22089]: daemon: epoll: listen=8
active_threads=0 tvp=NULL
Aug 27 16:22:32 ldap slapd[22089]: do_unbind
Aug 27 16:22:32 ldap slapd[22089]: conn=16 op=2 UNBIND
Aug 27 16:22:32 ldap slapd[22089]: connection_resched: attempting
closing conn=16 sd=26
Aug 27 16:22:32 ldap slapd[22089]: connection_close: conn=16 sd=-1
Aug 27 16:22:32 ldap slapd[22089]: daemon: removing 26
Aug 27 16:22:32 ldap slapd[22089]: conn=16 fd=26 closed






-- 
С уважением,
  Макс.