I have spent 2+ days trying to get a MacOS 10.5.3 machine configured to authenticate against a basic openldap 2.4.10 server with SSL on a Linux box - no SASL, no kerberos - I was hoping it would be trivial, and from the looks of all the postings around on the web, it should be. I know I'm doing the right things, yet I must be missing one minor detail.
I did the initial openldap setup, and within a very short time, I was able to authenticate the MacOS box against the Linux box NON-SSSL without any trouble. When I enable SSL on the Mac, I can use ldapsearch to probe the whole ldaps:// server without any trouble at all. On the Mac, I can verify the SSL certificate:
openssl s_client -connect server:636 -CApath /certs
(I've created the proper hash files for the parts of the CA path)
and I can see: . . Verify return code: 0 (ok)
In the /etc/openldap/ldap.conf on the MAC, I have:
TLS_REQCERT demand (MAC default) TLS_CACERTDIR /certs
(Even if I change "TLS_REQCERT to never", it doesn't make any difference.)
When I'm in the "Directory Utility" and creating a new connection, I click "Continue", then it hangs for a bit, and just comes back. The connection doesn't work.
The slapd.config on the Linux side has all the correct TLS paths as well (of course if it didn't, my ldapsearch -x queries wouldn't even work):
TLSCipherSuite HIGH:MEDIUM:+SSLv2 TLSCACertificatePath /openssl/certs TLSCertificateFile /openssl/certs/mycert.pem TLSCertificateKeyFile /openssl/certs/mycert.pem
(The certificate and key are appended together in mycert.pem - that seems to be allowed)
The certificate is a paid one - not a self-signed one.
Here's the openldap debug info that is printed while I'm waiting for initialization of the connection ... I do see:
TLS: can't accept.
connection_read(14): TLS accept failure error=-1 id=0, closing connection_closing: readying conn=0 sd=14 for close
... but I just don't understand why given that everything seems set up properly. If it wasn't, why would the ldapsearch work!?
Thanks!
jas.
------ verbose openldap debugging output
connection_get(15) connection_get(15): got connid=1 connection_read(15): checking for input on id=1 TLS trace: SSL_accept:before/accept initialization tls_read: want=11, got=11 tls_read: want=107, got=107 TLS trace: SSL_accept:SSLv3 read client hello A TLS trace: SSL_accept:SSLv3 write server hello A tls_write: want=4096, written=4096 TLS trace: SSL_accept:SSLv3 write certificate A TLS trace: SSL_accept:SSLv3 write server done A tls_write: want=723, written=723 TLS trace: SSL_accept:SSLv3 flush data tls_read: want=5 error=Resource temporarily unavailable TLS trace: SSL_accept:error in SSLv3 read client certificate A TLS trace: SSL_accept:error in SSLv3 read client certificate A daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL daemon: activity on 1 descriptor daemon: activity on: 15r daemon: read active on 15 daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_get(15) connection_get(15): got connid=1 connection_read(15): checking for input on id=1 tls_read: want=5, got=5 tls_read: want=134, got=134 TLS trace: SSL_accept:SSLv3 read client key exchange A tls_read: want=5, got=5 tls_read: want=1, got=1 tls_read: want=5, got=5 tls_read: want=48, got=48 TLS trace: SSL_accept:SSLv3 read finished A TLS trace: SSL_accept:SSLv3 write change cipher spec A TLS trace: SSL_accept:SSLv3 write finished A tls_write: want=59, written=59 TLS trace: SSL_accept:SSLv3 flush data connection_read(15): unable to get TLS client DN, error=49 id=1 daemon: activity on 1 descriptor daemon: activity on: 15r daemon: read active on 15 daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_get(15) connection_get(15): got connid=1 connection_read(15): checking for input on id=1 ber_get_next tls_read: want=5, got=5 tls_read: want=32, got=32 TLS trace: SSL3 alert read:warning:close notify ldap_read: want=8, got=0
ber_get_next on fd 15 failed errno=0 (Success) connection_read(15): input error=-2 id=1, closing. connection_closing: readying conn=1 sd=15 for close daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_close: conn=1 sd=15 daemon: removing 15 tls_write: want=37, written=37 TLS trace: SSL3 alert write:warning:close notify daemon: activity on 1 descriptor daemon: activity on: 14r daemon: read active on 14 daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_get(14) connection_get(14): got connid=0 connection_read(14): checking for input on id=0 TLS trace: SSL_accept:before/accept initialization tls_read: want=11, got=0
TLS: can't accept. connection_read(14): TLS accept failure error=-1 id=0, closing connection_closing: readying conn=0 sd=14 for close connection_close: conn=0 sd=14 daemon: removing 14 daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL daemon: activity on 1 descriptor daemon: activity on: slap_listener_activate(8): daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 busy daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL
slap_listener(ldap:///)
daemon: listen=8, new connection on 14 daemon: added 14r (active) listener=(nil) daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL daemon: activity on 1 descriptor daemon: activity on: slap_listener_activate(8): daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 busy daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL
slap_listener(ldap:///)
daemon: activity on 1 descriptor daemon: activity on: daemon: listen=8, new connection on 15 daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL daemon: activity on 1 descriptor daemon: activity on: 15r daemon: read active on 15 daemon: added 15r (active) listener=(nil) daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_get(15) connection_get(15): got connid=3 connection_read(15): checking for input on id=3 ber_get_next ldap_read: want=8, got=8 ldap_read: want=94, got=94 ber_get_next: tag 0x30 len 100 contents: ber_dump: buf=0x82b9598 ptr=0x82b9598 end=0x82b95fc len=100 ber_get_next ldap_read: want=8 error=Resource temporarily unavailable conn=3 op=0 do_search daemon: activity on 1 descriptor ber_scanf fmt ({miiiib) ber: ber_dump: buf=0x82b9598 ptr=0x82b959b end=0x82b95fc len=97
dnPrettyNormal: <>
<<< dnPrettyNormal: <>, <> SRCH "" 0 0begin get_filter PRESENT ber_scanf fmt (m) ber: ber_dump: buf=0x82b9598 ptr=0x82b95ae end=0x82b95fc len=78 end get_filter 0 ber_scanf fmt ({M}}) ber: ber_dump: buf=0x82b9598 ptr=0x82b95bb end=0x82b95fc len=65 daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL => test_filter => access_allowed: search access to "" "objectClass" requested => slap_access_allowed: backend default search access granted to "(anonymous)" => access_allowed: search access granted by read(=rscxd) <= test_filter 6 => send_search_entry: conn 3 dn="" => access_allowed: read access to "" "entry" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "" "namingContexts" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) ber_flush2: 54 bytes to sd 15 ldap_write: want=54, written=54 <= send_search_entry: conn 3 exit. send_ldap_result: conn=3 op=0 p=3 send_ldap_result: err=0 matched="" text="" send_ldap_response: msgid=1 tag=101 err=0 ber_flush2: 14 bytes to sd 15 ldap_write: want=14, written=14 daemon: activity on 1 descriptor daemon: activity on: 14r daemon: read active on 14 daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_get(14) connection_get(14): got connid=2 connection_read(14): checking for input on id=2 ber_get_next ldap_read: want=8, got=0
ber_get_next on fd 14 failed errno=0 (Success) connection_read(14): input error=-2 id=2, closing. connection_closing: readying conn=2 sd=14 for close connection_close: conn=2 sd=14 daemon: removing 14 daemon: activity on 1 descriptor daemon: activity on: 15r daemon: read active on 15 daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_get(15) connection_get(15): got connid=3 connection_read(15): checking for input on id=3 ber_get_next ldap_read: want=8, got=8 ldap_read: want=50, got=50 ber_get_next: tag 0x30 len 56 contents: ber_dump: buf=0x82cab08 ptr=0x82cab08 end=0x82cab40 len=56 ber_get_next ldap_read: want=8 error=Resource temporarily unavailable conn=3 op=1 do_search ber_scanf fmt ({miiiib) ber: ber_dump: buf=0x82cab08 ptr=0x82cab0b end=0x82cab40 len=53
dnPrettyNormal: <>
<<< dnPrettyNormal: <>, <> SRCH "" 0 0begin get_filter daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL PRESENT ber_scanf fmt (m) ber: ber_dump: buf=0x82cab08 ptr=0x82cab1e end=0x82cab40 len=34 end get_filter 0 ber_scanf fmt ({M}}) ber: ber_dump: buf=0x82cab08 ptr=0x82cab2b end=0x82cab40 len=21 => test_filter => access_allowed: search access to "" "objectClass" requested => slap_access_allowed: backend default search access granted to "(anonymous)" => access_allowed: search access granted by read(=rscxd) <= test_filter 6 => send_search_entry: conn 3 dn="" => access_allowed: read access to "" "entry" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "" "subschemaSubentry" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "" "subschemaSubentry" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) ber_flush2: 48 bytes to sd 15 ldap_write: want=48, written=48 <= send_search_entry: conn 3 exit. send_ldap_result: conn=3 op=1 p=3 send_ldap_result: err=0 matched="" text="" send_ldap_response: msgid=2 tag=101 err=0 ber_flush2: 14 bytes to sd 15 ldap_write: want=14, written=14 daemon: activity on 1 descriptor daemon: activity on: 15r daemon: read active on 15 daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_get(15) connection_get(15): got connid=3 connection_read(15): checking for input on id=3 ber_get_next ldap_read: want=8, got=8 ldap_read: want=71, got=71 ber_get_next: tag 0x30 len 77 contents: ber_dump: buf=0x82b9578 ptr=0x82b9578 end=0x82b95c5 len=77 ber_get_next ldap_read: want=8 error=Resource temporarily unavailable conn=3 op=2 do_search ber_scanf fmt ({miiiib) ber: daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL ber_dump: buf=0x82b9578 ptr=0x82b957b end=0x82b95c5 len=74
dnPrettyNormal: <cn=Subschema>
=> ldap_bv2dn(cn=Subschema,0) <= ldap_bv2dn(cn=Subschema)=0 => ldap_dn2bv(272) <= ldap_dn2bv(cn=Subschema)=0 => ldap_dn2bv(272) <= ldap_dn2bv(cn=subschema)=0 <<< dnPrettyNormal: <cn=Subschema>, <cn=subschema> SRCH "cn=Subschema" 0 0begin get_filter EQUALITY ber_scanf fmt ({mm}) ber: ber_dump: buf=0x82b9578 ptr=0x82b959a end=0x82b95c5 len=43 end get_filter 0 ber_scanf fmt ({M}}) ber: ber_dump: buf=0x82b9578 ptr=0x82b95b4 end=0x82b95c5 len=17 => test_filter => access_allowed: search access to "cn=Subschema" "objectClass" requested => slap_access_allowed: backend default search access granted to "(anonymous)" => access_allowed: search access granted by read(=rscxd) <= test_filter 6 => send_search_entry: conn 3 dn="cn=Subschema" => access_allowed: read access to "cn=Subschema" "entry" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) ber_flush2: 16753 bytes to sd 15 ldap_write: want=16753, written=13032 ldap_write: want=3721, written=3721 <= send_search_entry: conn 3 exit. send_ldap_result: conn=3 op=2 p=3 send_ldap_result: err=0 matched="" text="" send_ldap_response: msgid=3 tag=101 err=0 ber_flush2: 14 bytes to sd 15 ldap_write: want=14, written=14 daemon: activity on 1 descriptor daemon: activity on: 15r daemon: read active on 15 daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_get(15) connection_get(15): got connid=3 connection_read(15): checking for input on id=3 ber_get_next ldap_read: want=8, got=8 ldap_read: want=111, got=111 ber_get_next: tag 0x30 len 117 contents: ber_dump: buf=0x82ba928 ptr=0x82ba928 end=0x82ba99d len=117 ber_get_next ldap_read: want=8 error=Resource temporarily unavailable daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL conn=3 op=3 do_search ber_scanf fmt ({miiiib) ber: ber_dump: buf=0x82ba928 ptr=0x82ba92b end=0x82ba99d len=114
dnPrettyNormal: <dc=cse,dc=yorku,dc=ca>
=> ldap_bv2dn(dc=cse,dc=yorku,dc=ca,0) <= ldap_bv2dn(dc=cse,dc=yorku,dc=ca)=0 => ldap_dn2bv(272) <= ldap_dn2bv(dc=cse,dc=yorku,dc=ca)=0 => ldap_dn2bv(272) <= ldap_dn2bv(dc=cse,dc=yorku,dc=ca)=0 <<< dnPrettyNormal: <dc=cse,dc=yorku,dc=ca>, <dc=cse,dc=yorku,dc=ca> SRCH "dc=cse,dc=yorku,dc=ca" 2 0begin get_filter AND begin get_filter_list begin get_filter EQUALITY ber_scanf fmt ({mm}) ber: ber_dump: buf=0x82ba928 ptr=0x82ba955 end=0x82ba99d len=72 end get_filter 0 begin get_filter EQUALITY ber_scanf fmt ({mm}) ber: ber_dump: buf=0x82ba928 ptr=0x82ba978 end=0x82ba99d len=37 end get_filter 0 end get_filter_list end get_filter 0 ber_scanf fmt ({M}}) ber: ber_dump: buf=0x82ba928 ptr=0x82ba98e end=0x82ba99d len=15 ==> limits_get: conn=3 op=3 dn="[anonymous]" => bdb_search bdb_dn2entry("dc=cse,dc=yorku,dc=ca") => bdb_dn2id("dc=cse,dc=yorku,dc=ca") <= bdb_dn2id: got id=0x1 entry_decode: "dc=cse,dc=yorku,dc=ca" <= entry_decode(dc=cse,dc=yorku,dc=ca) => access_allowed: search access to "dc=cse,dc=yorku,dc=ca" "entry" requested => slap_access_allowed: backend default search access granted to "(anonymous)" => access_allowed: search access granted by read(=rscxd) search_candidates: base="dc=cse,dc=yorku,dc=ca" (0x00000001) scope=2 => bdb_dn2idl("dc=cse,dc=yorku,dc=ca") => bdb_filter_candidates AND => bdb_list_candidates 0xa0 => bdb_filter_candidates OR => bdb_list_candidates 0xa1 => bdb_filter_candidates EQUALITY => bdb_equality_candidates (objectClass) => key_read bdb_idl_fetch_key: [b49d1940] <= bdb_index_read: failed (-30989) <= bdb_equality_candidates: id=0, first=0, last=0 <= bdb_filter_candidates: id=0 first=0 last=0 => bdb_filter_candidates AND => bdb_list_candidates 0xa0 => bdb_filter_candidates EQUALITY => bdb_equality_candidates (objectClass) => key_read bdb_idl_fetch_key: [9bee355f] <= bdb_index_read 2 candidates <= bdb_equality_candidates: id=2, first=3, last=4 <= bdb_filter_candidates: id=2 first=3 last=4 => bdb_filter_candidates EQUALITY => bdb_equality_candidates (ou) <= bdb_equality_candidates: (ou) not indexed <= bdb_filter_candidates: id=-1 first=1 last=7 <= bdb_list_candidates: id=-1 first=3 last=4 <= bdb_filter_candidates: id=-1 first=3 last=4 <= bdb_list_candidates: id=-1 first=3 last=4 <= bdb_filter_candidates: id=-1 first=3 last=4 <= bdb_list_candidates: id=-1 first=3 last=4 <= bdb_filter_candidates: id=-1 first=3 last=4 bdb_search_candidates: id=-1 first=3 last=4 entry_decode: "ou=people,dc=cse,dc=yorku,dc=ca" <= entry_decode(ou=people,dc=cse,dc=yorku,dc=ca) => bdb_dn2id("ou=people,dc=cse,dc=yorku,dc=ca") <= bdb_dn2id: got id=0x3 => test_filter => test_filter_and => test_filter => access_allowed: search access to "ou=people,dc=cse,dc=yorku,dc=ca" "objectClass" requested => slap_access_allowed: backend default search access granted to "(anonymous)" => access_allowed: search access granted by read(=rscxd) <= test_filter 6 => test_filter => access_allowed: search access to "ou=people,dc=cse,dc=yorku,dc=ca" "ou" requested => slap_access_allowed: backend default search access granted to "(anonymous)" => access_allowed: search access granted by read(=rscxd) <= test_filter 5 <= test_filter_and 5 <= test_filter 5 bdb_search: 3 does not match filter entry_decode: "ou=group,dc=cse,dc=yorku,dc=ca" <= entry_decode(ou=group,dc=cse,dc=yorku,dc=ca) => bdb_dn2id("ou=group,dc=cse,dc=yorku,dc=ca") <= bdb_dn2id: got id=0x4 => test_filter => test_filter_and => test_filter => access_allowed: search access to "ou=group,dc=cse,dc=yorku,dc=ca" "objectClass" requested => slap_access_allowed: backend default search access granted to "(anonymous)" => access_allowed: search access granted by read(=rscxd) <= test_filter 6 => test_filter => access_allowed: search access to "ou=group,dc=cse,dc=yorku,dc=ca" "ou" requested => slap_access_allowed: backend default search access granted to "(anonymous)" => access_allowed: search access granted by read(=rscxd) <= test_filter 5 <= test_filter_and 5 <= test_filter 5 bdb_search: 4 does not match filter send_ldap_result: conn=3 op=3 p=3 send_ldap_result: err=0 matched="" text="" send_ldap_response: msgid=4 tag=101 err=0 ber_flush2: 14 bytes to sd 15 ldap_write: want=14, written=14 daemon: activity on 1 descriptor daemon: activity on: 15r daemon: read active on 15 connection_get(15) connection_get(15): got connid=3 connection_read(15): checking for input on id=3 ber_get_next daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL ldap_read: want=8, got=8 ldap_read: want=42, got=42 ber_get_next: tag 0x30 len 48 contents: ber_dump: buf=0x82cab08 ptr=0x82cab08 end=0x82cab38 len=48 ber_get_next ldap_read: want=8 error=Resource temporarily unavailable conn=3 op=4 do_search ber_scanf fmt ({miiiib) ber: ber_dump: buf=0x82cab08 ptr=0x82cab0b end=0x82cab38 len=45
dnPrettyNormal: <>
<<< dnPrettyNormal: <>, <> SRCH "" 0 0begin get_filter PRESENT ber_scanf fmt (m) ber: ber_dump: buf=0x82cab08 ptr=0x82cab1e end=0x82cab38 len=26 end get_filter 0 ber_scanf fmt ({M}}) ber: ber_dump: buf=0x82cab08 ptr=0x82cab2b end=0x82cab38 len=13 daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL => test_filter => access_allowed: search access to "" "objectClass" requested => slap_access_allowed: backend default search access granted to "(anonymous)" => access_allowed: search access granted by read(=rscxd) <= test_filter 6 => send_search_entry: conn 3 dn="" => access_allowed: read access to "" "entry" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) ber_flush2: 11 bytes to sd 15 ldap_write: want=11, written=11 <= send_search_entry: conn 3 exit. send_ldap_result: conn=3 op=4 p=3 send_ldap_result: err=0 matched="" text="" send_ldap_response: msgid=5 tag=101 err=0 ber_flush2: 14 bytes to sd 15 ldap_write: want=14, written=14 daemon: activity on 1 descriptor daemon: activity on: 15r daemon: read active on 15 daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_get(15) connection_get(15): got connid=3 connection_read(15): checking for input on id=3 ber_get_next ldap_read: want=8, got=7 ber_get_next: tag 0x30 len 5 contents: ber_dump: buf=0x82caea0 ptr=0x82caea0 end=0x82caea5 len=5 ber_get_next ldap_read: want=8, got=0
ber_get_next on fd 15 failed errno=0 (Success) connection_read(15): input error=-2 id=3, closing. connection_closing: readying conn=3 sd=15 for close daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_close: deferring conn=3 sd=15 conn=3 op=5 do_unbind connection_resched: attempting closing conn=3 sd=15 connection_close: conn=3 sd=15 daemon: removing 15 daemon: activity on 1 descriptor daemon: activity on: slap_listener_activate(10): daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 busy
slap_listener(ldaps:///)
daemon: activity on 1 descriptor daemon: activity on: daemon: listen=10, new connection on 15 daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL daemon: added 15r (active) listener=(nil) daemon: activity on 2 descriptors daemon: activity on: slap_listener_activate(10): daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 busy
slap_listener(ldaps:///)
daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL daemon: listen=10, new connection on 16 daemon: activity on 1 descriptor daemon: activity on: 16r daemon: read active on 16 daemon: added 16r (active) listener=(nil) daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_get(16) daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_get(16): got connid=5 connection_read(16): checking for input on id=5 TLS trace: SSL_accept:before/accept initialization tls_read: want=11, got=11 tls_read: want=107, got=107 TLS trace: SSL_accept:SSLv3 read client hello A TLS trace: SSL_accept:SSLv3 write server hello A tls_write: want=4096, written=4096 TLS trace: SSL_accept:SSLv3 write certificate A TLS trace: SSL_accept:SSLv3 write server done A tls_write: want=723, written=723 TLS trace: SSL_accept:SSLv3 flush data tls_read: want=5 error=Resource temporarily unavailable TLS trace: SSL_accept:error in SSLv3 read client certificate A TLS trace: SSL_accept:error in SSLv3 read client certificate A daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL daemon: activity on 1 descriptor daemon: activity on: 16r daemon: read active on 16 daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_get(16) connection_get(16): got connid=5 connection_read(16): checking for input on id=5 tls_read: want=5, got=5 tls_read: want=134, got=134 TLS trace: SSL_accept:SSLv3 read client key exchange A tls_read: want=5, got=5 tls_read: want=1, got=1 tls_read: want=5, got=5 tls_read: want=48, got=48 TLS trace: SSL_accept:SSLv3 read finished A TLS trace: SSL_accept:SSLv3 write change cipher spec A TLS trace: SSL_accept:SSLv3 write finished A tls_write: want=59, written=59 TLS trace: SSL_accept:SSLv3 flush data connection_read(16): unable to get TLS client DN, error=49 id=5 daemon: activity on 2 descriptors daemon: activity on: 16r daemon: read active on 16 daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_get(16) connection_get(16): got connid=5 connection_read(16): checking for input on id=5 ber_get_next tls_read: want=5, got=5 tls_read: want=32, got=32 TLS trace: SSL3 alert read:warning:close notify ldap_read: want=8, got=0
ber_get_next on fd 16 failed errno=0 (Success) connection_read(16): input error=-2 id=5, closing. connection_closing: readying conn=5 sd=16 for close connection_close: conn=5 sd=16 daemon: removing 16 tls_write: want=37, written=37 TLS trace: SSL3 alert write:warning:close notify daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL daemon: activity on 1 descriptor daemon: activity on: 15r daemon: read active on 15 daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_get(15) connection_get(15): got connid=4 connection_read(15): checking for input on id=4 TLS trace: SSL_accept:before/accept initialization tls_read: want=11, got=0
TLS: can't accept. connection_read(15): TLS accept failure error=-1 id=4, closing connection_closing: readying conn=4 sd=15 for close connection_close: conn=4 sd=15 daemon: removing 15 daemon: activity on 2 descriptors daemon: activity on: slap_listener_activate(8): daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 busy daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL
slap_listener(ldap:///)
daemon: listen=8, new connection on 15 daemon: added 15r (active) listener=(nil) daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL daemon: activity on 1 descriptor daemon: activity on: slap_listener_activate(8): daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 busy daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL
slap_listener(ldap:///)
daemon: listen=8, new connection on 16 daemon: activity on 1 descriptor daemon: activity on: daemon: added 16r (active) listener=(nil) daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL daemon: activity on 2 descriptors daemon: activity on: 16r daemon: read active on 16 daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_get(16) connection_get(16): got connid=7 connection_read(16): checking for input on id=7 ber_get_next ldap_read: want=8, got=8 ldap_read: want=94, got=94 ber_get_next: tag 0x30 len 100 contents: ber_dump: buf=0x82bd918 ptr=0x82bd918 end=0x82bd97c len=100 ber_get_next ldap_read: want=8 error=Resource temporarily unavailable conn=7 op=0 do_search daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL ber_scanf fmt ({miiiib) ber: ber_dump: buf=0x82bd918 ptr=0x82bd91b end=0x82bd97c len=97
dnPrettyNormal: <>
<<< dnPrettyNormal: <>, <> SRCH "" 0 0begin get_filter PRESENT ber_scanf fmt (m) ber: ber_dump: buf=0x82bd918 ptr=0x82bd92e end=0x82bd97c len=78 end get_filter 0 ber_scanf fmt ({M}}) ber: ber_dump: buf=0x82bd918 ptr=0x82bd93b end=0x82bd97c len=65 => test_filter => access_allowed: search access to "" "objectClass" requested => slap_access_allowed: backend default search access granted to "(anonymous)" => access_allowed: search access granted by read(=rscxd) <= test_filter 6 => send_search_entry: conn 7 dn="" => access_allowed: read access to "" "entry" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "" "namingContexts" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) ber_flush2: 54 bytes to sd 16 ldap_write: want=54, written=54 <= send_search_entry: conn 7 exit. send_ldap_result: conn=7 op=0 p=3 send_ldap_result: err=0 matched="" text="" send_ldap_response: msgid=1 tag=101 err=0 ber_flush2: 14 bytes to sd 16 ldap_write: want=14, written=14 daemon: activity on 1 descriptor daemon: activity on: 15r daemon: read active on 15 daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL daemon: activity on 1 descriptor daemon: activity on: 16r daemon: read active on 16 daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL connection_get(15) daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_get(16) connection_get(16): got connid=7 connection_read(16): checking for input on id=7 ber_get_next ldap_read: want=8, got=8 ldap_read: want=50, got=50 ber_get_next: tag 0x30 len 56 contents: connection_get(15): got connid=6 ber_dump: buf=0x82bbcd8 ptr=0x82bbcd8 end=0x82bbd10 len=56 ber_get_next ldap_read: want=8 error=Resource temporarily unavailable conn=7 op=1 do_search ber_scanf fmt ({miiiib) ber: daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL ber_dump: buf=0x82bbcd8 ptr=0x82bbcdb end=0x82bbd10 len=53
dnPrettyNormal: <>
<<< dnPrettyNormal: <>, <> SRCH "" 0 0connection_read(15): checking for input on id=6 begin get_filter PRESENT ber_scanf fmt (m) ber: ber_dump: buf=0x82bbcd8 ptr=0x82bbcee end=0x82bbd10 len=34 end get_filter 0 ber_scanf fmt ({M}}) ber: ber_dump: buf=0x82bbcd8 ptr=0x82bbcfb end=0x82bbd10 len=21 => test_filter => access_allowed: search access to "" "objectClass" requested => slap_access_allowed: backend default search access granted to "(anonymous)" => access_allowed: search access granted by read(=rscxd) <= test_filter 6 => send_search_entry: conn 7 dn="" => access_allowed: read access to "" "entry" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "" "subschemaSubentry" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "" "subschemaSubentry" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) ber_flush2: 48 bytes to sd 16 ldap_write: want=48, written=48 <= send_search_entry: conn 7 exit. send_ldap_result: conn=7 op=1 p=3 send_ldap_result: err=0 matched="" text="" send_ldap_response: msgid=2 tag=101 err=0 ber_flush2: 14 bytes to sd 16 ldap_write: want=14, written=14 daemon: activity on 1 descriptor daemon: activity on: 16r daemon: read active on 16 daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_get(16) connection_get(16): got connid=7 connection_read(16): checking for input on id=7 ber_get_next ldap_read: want=8, got=8 ldap_read: want=71, got=71 ber_get_next: tag 0x30 len 77 contents: ber_dump: buf=0x82cb5b0 ptr=0x82cb5b0 end=0x82cb5fd len=77 ber_get_next ldap_read: want=8 error=Resource temporarily unavailable conn=7 op=2 do_search daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL ber_scanf fmt ({miiiib) ber: ber_dump: buf=0x82cb5b0 ptr=0x82cb5b3 end=0x82cb5fd len=74
dnPrettyNormal: <cn=Subschema>
=> ldap_bv2dn(cn=Subschema,0) <= ldap_bv2dn(cn=Subschema)=0 => ldap_dn2bv(272) <= ldap_dn2bv(cn=Subschema)=0 => ldap_dn2bv(272) <= ldap_dn2bv(cn=subschema)=0 <<< dnPrettyNormal: <cn=Subschema>, <cn=subschema> SRCH "cn=Subschema" 0 0begin get_filter EQUALITY ber_scanf fmt ({mm}) ber: ber_dump: buf=0x82cb5b0 ptr=0x82cb5d2 end=0x82cb5fd len=43 end get_filter 0 ber_scanf fmt ({M}}) ber: ber_get_next ber_dump: buf=0x82cb5b0 ptr=0x82cb5ec end=0x82cb5fd len=17 ldap_read: want=8, got=0
ber_get_next on fd 15 failed errno=0 (Success) connection_read(15): input error=-2 id=6, closing. connection_closing: readying conn=6 sd=15 for close daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_close: conn=6 sd=15 daemon: removing 15 => test_filter => access_allowed: search access to "cn=Subschema" "objectClass" requested => slap_access_allowed: backend default search access granted to "(anonymous)" => access_allowed: search access granted by read(=rscxd) <= test_filter 6 => send_search_entry: conn 7 dn="cn=Subschema" => access_allowed: read access to "cn=Subschema" "entry" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) => access_allowed: read access to "cn=Subschema" "objectClasses" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) ber_flush2: 16753 bytes to sd 16 ldap_write: want=16753, written=13032 ldap_write: want=3721, written=3721 <= send_search_entry: conn 7 exit. send_ldap_result: conn=7 op=2 p=3 send_ldap_result: err=0 matched="" text="" send_ldap_response: msgid=3 tag=101 err=0 ber_flush2: 14 bytes to sd 16 ldap_write: want=14, written=14 daemon: activity on 1 descriptor daemon: activity on: 16r daemon: read active on 16 daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_get(16) connection_get(16): got connid=7 connection_read(16): checking for input on id=7 ber_get_next ldap_read: want=8, got=8 ldap_read: want=111, got=111 ber_get_next: tag 0x30 len 117 contents: ber_dump: buf=0x82bedb8 ptr=0x82bedb8 end=0x82bee2d len=117 ber_get_next ldap_read: want=8 error=Resource temporarily unavailable conn=7 op=3 do_search ber_scanf fmt ({miiiib) ber: daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL ber_dump: buf=0x82bedb8 ptr=0x82bedbb end=0x82bee2d len=114
dnPrettyNormal: <dc=cse,dc=yorku,dc=ca>
=> ldap_bv2dn(dc=cse,dc=yorku,dc=ca,0) <= ldap_bv2dn(dc=cse,dc=yorku,dc=ca)=0 => ldap_dn2bv(272) <= ldap_dn2bv(dc=cse,dc=yorku,dc=ca)=0 => ldap_dn2bv(272) <= ldap_dn2bv(dc=cse,dc=yorku,dc=ca)=0 <<< dnPrettyNormal: <dc=cse,dc=yorku,dc=ca>, <dc=cse,dc=yorku,dc=ca> SRCH "dc=cse,dc=yorku,dc=ca" 2 0begin get_filter AND begin get_filter_list begin get_filter EQUALITY ber_scanf fmt ({mm}) ber: ber_dump: buf=0x82bedb8 ptr=0x82bede5 end=0x82bee2d len=72 end get_filter 0 begin get_filter EQUALITY ber_scanf fmt ({mm}) ber: ber_dump: buf=0x82bedb8 ptr=0x82bee08 end=0x82bee2d len=37 end get_filter 0 end get_filter_list end get_filter 0 ber_scanf fmt ({M}}) ber: ber_dump: buf=0x82bedb8 ptr=0x82bee1e end=0x82bee2d len=15 ==> limits_get: conn=7 op=3 dn="[anonymous]" => bdb_search bdb_dn2entry("dc=cse,dc=yorku,dc=ca") => access_allowed: search access to "dc=cse,dc=yorku,dc=ca" "entry" requested => slap_access_allowed: backend default search access granted to "(anonymous)" => access_allowed: search access granted by read(=rscxd) search_candidates: base="dc=cse,dc=yorku,dc=ca" (0x00000001) scope=2 => bdb_dn2idl("dc=cse,dc=yorku,dc=ca") => bdb_filter_candidates AND => bdb_list_candidates 0xa0 => bdb_filter_candidates OR => bdb_list_candidates 0xa1 => bdb_filter_candidates EQUALITY => bdb_equality_candidates (objectClass) => key_read bdb_idl_fetch_key: [b49d1940] <= bdb_index_read: failed (-30989) <= bdb_equality_candidates: id=0, first=0, last=0 <= bdb_filter_candidates: id=0 first=0 last=0 => bdb_filter_candidates AND => bdb_list_candidates 0xa0 => bdb_filter_candidates EQUALITY => bdb_equality_candidates (objectClass) => key_read bdb_idl_fetch_key: [9bee355f] <= bdb_index_read 2 candidates <= bdb_equality_candidates: id=2, first=3, last=4 <= bdb_filter_candidates: id=2 first=3 last=4 => bdb_filter_candidates EQUALITY => bdb_equality_candidates (ou) <= bdb_equality_candidates: (ou) not indexed <= bdb_filter_candidates: id=-1 first=1 last=7 <= bdb_list_candidates: id=-1 first=3 last=4 <= bdb_filter_candidates: id=-1 first=3 last=4 <= bdb_list_candidates: id=-1 first=3 last=4 <= bdb_filter_candidates: id=-1 first=3 last=4 <= bdb_list_candidates: id=-1 first=3 last=4 <= bdb_filter_candidates: id=-1 first=3 last=4 bdb_search_candidates: id=-1 first=3 last=4 => test_filter => test_filter_and => test_filter => access_allowed: search access to "ou=people,dc=cse,dc=yorku,dc=ca" "objectClass" requested => slap_access_allowed: backend default search access granted to "(anonymous)" => access_allowed: search access granted by read(=rscxd) <= test_filter 6 => test_filter => access_allowed: search access to "ou=people,dc=cse,dc=yorku,dc=ca" "ou" requested => slap_access_allowed: backend default search access granted to "(anonymous)" => access_allowed: search access granted by read(=rscxd) <= test_filter 5 <= test_filter_and 5 <= test_filter 5 bdb_search: 3 does not match filter => test_filter => test_filter_and => test_filter => access_allowed: search access to "ou=group,dc=cse,dc=yorku,dc=ca" "objectClass" requested => slap_access_allowed: backend default search access granted to "(anonymous)" => access_allowed: search access granted by read(=rscxd) <= test_filter 6 => test_filter => access_allowed: search access to "ou=group,dc=cse,dc=yorku,dc=ca" "ou" requested => slap_access_allowed: backend default search access granted to "(anonymous)" => access_allowed: search access granted by read(=rscxd) <= test_filter 5 <= test_filter_and 5 <= test_filter 5 bdb_search: 4 does not match filter send_ldap_result: conn=7 op=3 p=3 send_ldap_result: err=0 matched="" text="" send_ldap_response: msgid=4 tag=101 err=0 ber_flush2: 14 bytes to sd 16 ldap_write: want=14, written=14 daemon: activity on 1 descriptor daemon: activity on: 16r daemon: read active on 16 daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_get(16) connection_get(16): got connid=7 connection_read(16): checking for input on id=7 ber_get_next ldap_read: want=8, got=8 ldap_read: want=42, got=42 ber_get_next: tag 0x30 len 48 contents: ber_dump: buf=0x82bbcd8 ptr=0x82bbcd8 end=0x82bbd08 len=48 ber_get_next ldap_read: want=8 error=Resource temporarily unavailable daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL conn=7 op=4 do_search ber_scanf fmt ({miiiib) ber: ber_dump: buf=0x82bbcd8 ptr=0x82bbcdb end=0x82bbd08 len=45
dnPrettyNormal: <>
<<< dnPrettyNormal: <>, <> SRCH "" 0 0begin get_filter PRESENT ber_scanf fmt (m) ber: ber_dump: buf=0x82bbcd8 ptr=0x82bbcee end=0x82bbd08 len=26 end get_filter 0 ber_scanf fmt ({M}}) ber: ber_dump: buf=0x82bbcd8 ptr=0x82bbcfb end=0x82bbd08 len=13 => test_filter => access_allowed: search access to "" "objectClass" requested => slap_access_allowed: backend default search access granted to "(anonymous)" => access_allowed: search access granted by read(=rscxd) <= test_filter 6 => send_search_entry: conn 7 dn="" => access_allowed: read access to "" "entry" requested => slap_access_allowed: backend default read access granted to "(anonymous)" => access_allowed: read access granted by read(=rscxd) ber_flush2: 11 bytes to sd 16 ldap_write: want=11, written=11 <= send_search_entry: conn 7 exit. send_ldap_result: conn=7 op=4 p=3 send_ldap_result: err=0 matched="" text="" send_ldap_response: msgid=5 tag=101 err=0 ber_flush2: 14 bytes to sd 16 ldap_write: want=14, written=14 daemon: activity on 1 descriptor daemon: activity on: 16r daemon: read active on 16 daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL connection_get(16) connection_get(16): got connid=7 connection_read(16): checking for input on id=7 ber_get_next ldap_read: want=8, got=7 ber_get_next: tag 0x30 len 5 contents: ber_dump: buf=0x82cac98 ptr=0x82cac98 end=0x82cac9d len=5 ber_get_next ldap_read: want=8, got=0
ber_get_next on fd 16 failed errno=0 (Success) connection_read(16): input error=-2 id=7, closing. connection_closing: readying conn=7 sd=16 for close connection_close: deferring conn=7 sd=16 conn=7 op=5 do_unbind connection_resched: attempting closing conn=7 sd=16 connection_close: conn=7 sd=16 daemon: removing 16 daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=NULL daemon: epoll: listen=8 active_threads=0 tvp=NULL daemon: epoll: listen=9 active_threads=0 tvp=NULL daemon: epoll: listen=10 active_threads=0 tvp=NULL daemon: shutdown requested and initiated. daemon: closing 7 daemon: closing 8 daemon: closing 9 daemon: closing 10