daemon: activity on 1 descriptor daemon: activity on: slap_listener_activate(7): daemon: epoll: listen=7 busy daemon: epoll: listen=8 active_threads=0 tvp=zero >>> slap_listener(ldap:///) daemon: listen=7, new connection on 15 daemon: added 15r (active) listener=(nil) daemon: activity on 2 descriptors daemon: activity on: 15r daemon: read active on 15 daemon: epoll: listen=7 active_threads=0 tvp=zero daemon: epoll: listen=8 active_threads=0 tvp=zero connection_get(15) connection_get(15): got connid=1003 connection_read(15): checking for input on id=1003 ber_get_next ldap_read: want=8, got=8 0000: 30 84 00 00 00 62 02 01 0....b.. ldap_read: want=96, got=96 0000: 01 60 84 00 00 00 2f 02 01 03 04 22 75 69 64 3d .`..../...."uid= 0010: 73 63 6e 65 2c 6f 75 3d 50 65 6f 70 6c 65 2c 64 test,ou=People,d 0020: 63 3d 61 78 69 2c 64 63 3d 69 6e 74 72 61 80 06 c=xxx,dc=intra.. 0030: 70 6c 61 6e 65 74 a0 84 00 00 00 24 30 84 00 00 secret.....$0... 0040: 00 1e 04 19 31 2e 33 2e 36 2e 31 2e 34 2e 31 2e ....1.3.6.1.4.1. 0050: 34 32 2e 32 2e 32 37 2e 38 2e 35 2e 31 01 01 00 42.2.27.8.5.1... ber_get_next: tag 0x30 len 98 contents: ber_dump: buf=0x218079c8 ptr=0x218079c8 end=0x21807a2a len=98 0000: 02 01 01 60 84 00 00 00 2f 02 01 03 04 22 75 69 ...`..../...."ui 0010: 64 3d 73 63 6e 65 2c 6f 75 3d 50 65 6f 70 6c 65 d=test,ou=People 0020: 2c 64 63 3d 61 78 69 2c 64 63 3d 69 6e 74 72 61 ,dc=xxx,dc=intra 0030: 80 06 70 6c 61 6e 65 74 a0 84 00 00 00 24 30 84 ..secret.....$0. 0040: 00 00 00 1e 04 19 31 2e 33 2e 36 2e 31 2e 34 2e ......1.3.6.1.4. 0050: 31 2e 34 32 2e 32 2e 32 37 2e 38 2e 35 2e 31 01 1.42.2.27.8.5.1. 0060: 01 00 .. op tag 0x60, time 1289814810 ber_get_next ldap_read: want=8 error=Resource temporarily unavailable conn=1003 op=0 do_bind ber_scanf fmt ({imt) ber: ber_dump: buf=0x218079c8 ptr=0x218079cb end=0x21807a2a len=95 0000: 60 84 00 00 00 2f 02 01 03 04 22 75 69 64 3d 73 `..../...."uid=t 0010: 63 6e 65 2c 6f 75 3d 50 65 6f 70 6c 65 2c 64 63 est,ou=People,dc 0020: 3d 61 78 69 2c 64 63 3d 69 6e 74 72 61 80 06 70 =xxx,dc=intra..s 0030: 6c 61 6e 65 74 a0 84 00 00 00 24 30 84 00 00 00 ecret.....$0.... 0040: 1e 04 19 31 2e 33 2e 36 2e 31 2e 34 2e 31 2e 34 ...1.3.6.1.4.1.4 0050: 32 2e 32 2e 32 37 2e 38 2e 35 2e 31 01 01 00 2.2.27.8.5.1... ber_scanf fmt (m}) ber: ber_dump: buf=0x218079c8 ptr=0x218079f8 end=0x21807a2a len=50 0000: 00 06 70 6c 61 6e 65 74 a0 84 00 00 00 24 30 84 ..secret.....$0. 0010: 00 00 00 1e 04 19 31 2e 33 2e 36 2e 31 2e 34 2e ......1.3.6.1.4. 0020: 31 2e 34 32 2e 32 2e 32 37 2e 38 2e 35 2e 31 01 1.42.2.27.8.5.1. 0030: 01 00 .. => get_ctrls ber_scanf fmt ({m) ber: ber_dump: buf=0x218079c8 ptr=0x21807a06 end=0x21807a2a len=36 0000: 30 84 00 00 00 1e 04 19 31 2e 33 2e 36 2e 31 2e 0.......1.3.6.1. 0010: 34 2e 31 2e 34 32 2e 32 2e 32 37 2e 38 2e 35 2e 4.1.42.2.27.8.5. 0020: 31 01 01 00 1... ber_scanf fmt (b) ber: ber_dump: buf=0x218079c8 ptr=0x21807a27 end=0x21807a2a len=3 0000: 00 01 00 ... => get_ctrls: oid="1.3.6.1.4.1.42.2.27.8.5.1" (noncritical) <= get_ctrls: n=1 rc=0 err="" >>> dnPrettyNormal: => ldap_bv2dn(uid=test,ou=People,dc=xxx,dc=intra,0) <= ldap_bv2dn(uid=test,ou=People,dc=xxx,dc=intra)=0 => ldap_dn2bv(272) <= ldap_dn2bv(uid=test,ou=People,dc=xxx,dc=intra)=0 => ldap_dn2bv(272) <= ldap_dn2bv(uid=test,ou=people,dc=xxx,dc=intra)=0 <<< dnPrettyNormal: , do_bind: version=3 dn="uid=test,ou=People,dc=xxx,dc=intra" method=128 slap_global_control: unrecognized control: 1.3.6.1.4.1.42.2.27.8.5.1 daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=zero daemon: epoll: listen=8 active_threads=0 tvp=zero backend_check_controls: unrecognized non-critical control: 1.3.6.1.4.1.42.2.27.8.5.1 ==> hdb_bind: dn: uid=test,ou=People,dc=xxx,dc=intra bdb_dn2entry("uid=test,ou=people,dc=xxx,dc=intra") => access_allowed: result not in cache (userPassword) => access_allowed: auth access to "uid=test,ou=People,dc=xxx,dc=intra" "userPassword" requested => acl_get: [1] attr userPassword => acl_mask: access to entry "uid=test,ou=People,dc=xxx,dc=intra", attr "userPassword" requested => acl_mask: to value by "", (=0) <= check a_dn_pat: gidNumber=0+uidNumber=0,cn=peercred,cn=external,cn=auth <= check a_dn_pat: * <= acl_mask: [2] applying +0 (break) <= acl_mask: [2] mask: =0 => dn: [2] => dn: [3] cn=subschema => dn: [4] cn=monitor <= acl_get: done. => slap_access_allowed: no more rules => access_allowed: no more rules send_ldap_result: conn=1003 op=0 p=3 send_ldap_result: err=49 matched="" text="" send_ldap_response: msgid=1 tag=97 err=49 ber_flush2: 14 bytes to sd 15 0000: 30 0c 02 01 01 61 07 0a 01 31 04 00 04 00 0....a...1.... ldap_write: want=14, written=14 0000: 30 0c 02 01 01 61 07 0a 01 31 04 00 04 00 0....a...1.... daemon: activity on 1 descriptor daemon: activity on: 15r daemon: read active on 15 daemon: epoll: listen=7 active_threads=0 tvp=zero daemon: epoll: listen=8 active_threads=0 tvp=zero connection_get(15) connection_get(15): got connid=1003 connection_read(15): checking for input on id=1003 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=1003, closing. connection_closing: readying conn=1003 sd=15 for close connection_close: conn=1003 sd=15 daemon: removing 15 daemon: activity on 1 descriptor daemon: activity on: daemon: epoll: listen=7 active_threads=0 tvp=zero daemon: epoll: listen=8 active_threads=0 tvp=zero