Dec  3 13:39:06 hiro slapd[11134]: daemon: activity on 1 descriptor
Dec  3 13:39:06 hiro slapd[11134]: daemon: activity on:
Dec  3 13:39:06 hiro slapd[11134]:
Dec  3 13:39:06 hiro slapd[11134]: >>> slap_listener(ldapi:///)
Dec  3 13:39:06 hiro slapd[11134]: daemon: listen=12, new connection on 16
Dec  3 13:39:06 hiro slapd[11134]: daemon: added 16r (active) listener=(nil)
Dec  3 13:39:06 hiro slapd[11134]: conn=3 fd=16 ACCEPT from PATH=/var/run/slapd/ldapi (PATH=/var/run/slapd/ldapi)
Dec  3 13:39:06 hiro slapd[11134]: daemon: epoll: listen=8 active_threads=0 tvp=NULL
Dec  3 13:39:06 hiro slapd[11134]: daemon: epoll: listen=9 active_threads=0 tvp=NULL
Dec  3 13:39:06 hiro slapd[11134]: daemon: epoll: listen=10 active_threads=0 tvp=NULL
Dec  3 13:39:06 hiro slapd[11134]: daemon: epoll: listen=11 active_threads=0 tvp=NULL
Dec  3 13:39:06 hiro slapd[11134]: daemon: epoll: listen=12 active_threads=0 tvp=NULL
Dec  3 13:39:06 hiro slapd[11134]: daemon: activity on 1 descriptor
Dec  3 13:39:06 hiro slapd[11134]: daemon: activity on:
Dec  3 13:39:06 hiro slapd[11134]:  16r
Dec  3 13:39:06 hiro slapd[11134]:
Dec  3 13:39:06 hiro slapd[11134]: daemon: read active on 16
Dec  3 13:39:06 hiro slapd[11134]: connection_get(16)
Dec  3 13:39:06 hiro slapd[11134]: connection_get(16): got connid=3
Dec  3 13:39:06 hiro slapd[11134]: connection_read(16): checking for input on id=3
Dec  3 13:39:06 hiro slapd[11134]: daemon: epoll: listen=8 active_threads=0 tvp=NULL
Dec  3 13:39:06 hiro slapd[11134]: daemon: epoll: listen=9 active_threads=0 tvp=NULL
Dec  3 13:39:06 hiro slapd[11134]: do_bind
Dec  3 13:39:06 hiro slapd[11134]: daemon: epoll: listen=10 active_threads=0 tvp=NULL
Dec  3 13:39:06 hiro slapd[11134]: >>> dnPrettyNormal: <>
Dec  3 13:39:06 hiro slapd[11134]: daemon: epoll: listen=11 active_threads=0 tvp=NULL
Dec  3 13:39:06 hiro slapd[11134]: <<< dnPrettyNormal: <>, <>
Dec  3 13:39:06 hiro slapd[11134]: daemon: epoll: listen=12 active_threads=0 tvp=NULL
Dec  3 13:39:06 hiro slapd[11134]: do_sasl_bind: dn () mech OTP
Dec  3 13:39:06 hiro slapd[11134]: conn=3 op=0 BIND dn="" method=163
Dec  3 13:39:06 hiro slapd[11134]: ==> sasl_bind: dn="" mech=OTP datalen=29
Dec  3 13:39:06 hiro slapd[11134]: SASL Canonicalize [conn=3]: authcid="abrown@olp.net"
Dec  3 13:39:06 hiro slapd[11134]: slap_sasl_getdn: conn 3 id=abrown@olp.net [len=14]
Dec  3 13:39:06 hiro slapd[11134]: slap_sasl_getdn: u:id converted to uid=abrown@olp.net,cn=OTP,cn=auth
Dec  3 13:39:06 hiro slapd[11134]: >>> dnNormalize: <uid=abrown@olp.net,cn=OTP,cn=auth>
Dec  3 13:39:06 hiro slapd[11134]: <<< dnNormalize: <uid=abrown@olp.net,cn=otp,cn=auth>
Dec  3 13:39:06 hiro slapd[11134]: ==>slap_sasl2dn: converting SASL name uid=abrown@olp.net,cn=otp,cn=auth to a DN
Dec  3 13:39:06 hiro slapd[11134]: slap_authz_regexp: converting SASL name uid=abrown@olp.net,cn=otp,cn=auth
Dec  3 13:39:06 hiro slapd[11134]: slap_authz_regexp: converted SASL name to ldap:///ou=people,dc=olp,dc=net??one?(btcAltUid=abrown@olp.net)
Dec  3 13:39:06 hiro slapd[11134]: slap_parseURI: parsing ldap:///ou=people,dc=olp,dc=net??one?(btcAltUid=abrown@olp.net)
Dec  3 13:39:06 hiro slapd[11134]: str2filter "(btcAltUid=abrown@olp.net)"
Dec  3 13:39:06 hiro slapd[11134]: begin get_filter
Dec  3 13:39:06 hiro slapd[11134]: EQUALITY
Dec  3 13:39:06 hiro slapd[11134]: end get_filter 0
Dec  3 13:39:06 hiro slapd[11134]: >>> dnNormalize: <ou=people,dc=olp,dc=net>
Dec  3 13:39:06 hiro slapd[11134]: <<< dnNormalize: <ou=people,dc=olp,dc=net>
Dec  3 13:39:06 hiro slapd[11134]: slap_sasl2dn: performing internal search (base=ou=people,dc=olp,dc=net, scope=1)
Dec  3 13:39:06 hiro slapd[11134]: => bdb_search
Dec  3 13:39:06 hiro slapd[11134]: bdb_dn2entry("ou=people,dc=olp,dc=net")
Dec  3 13:39:06 hiro slapd[11134]: search_candidates: base="ou=people,dc=olp,dc=net" (0x00000003) scope=1
Dec  3 13:39:06 hiro slapd[11134]: => bdb_dn2idl("ou=people,dc=olp,dc=net")
Dec  3 13:39:06 hiro slapd[11134]: bdb_idl_fetch_key: %ou=people,dc=olp,dc=net
Dec  3 13:39:06 hiro slapd[11134]: <= bdb_dn2idl: id=68 first=7 last=136
Dec  3 13:39:06 hiro slapd[11134]: => bdb_filter_candidates
Dec  3 13:39:06 hiro slapd[11134]: ^IAND
Dec  3 13:39:06 hiro slapd[11134]: => bdb_list_candidates 0xa0
Dec  3 13:39:06 hiro slapd[11134]: => bdb_filter_candidates
Dec  3 13:39:06 hiro slapd[11134]: ^IOR
Dec  3 13:39:06 hiro slapd[11134]: => bdb_list_candidates 0xa1
Dec  3 13:39:06 hiro slapd[11134]: => bdb_filter_candidates
Dec  3 13:39:06 hiro slapd[11134]: ^IEQUALITY
Dec  3 13:39:06 hiro slapd[11134]: => bdb_equality_candidates (objectClass)
Dec  3 13:39:06 hiro slapd[11134]: => key_read
Dec  3 13:39:06 hiro slapd[11134]: bdb_idl_fetch_key: [b49d1940]
Dec  3 13:39:06 hiro slapd[11134]: <= bdb_index_read: failed (-30990)
Dec  3 13:39:06 hiro slapd[11134]: <= bdb_equality_candidates: id=0, first=0, last=0
Dec  3 13:39:06 hiro slapd[11134]: <= bdb_filter_candidates: id=0 first=0 last=0
Dec  3 13:39:06 hiro slapd[11134]: => bdb_filter_candidates
Dec  3 13:39:06 hiro slapd[11134]: ^IEQUALITY
Dec  3 13:39:06 hiro slapd[11134]: => bdb_equality_candidates (btcAltUID)
Dec  3 13:39:06 hiro slapd[11134]: => key_read
Dec  3 13:39:06 hiro slapd[11134]: bdb_idl_fetch_key: [b0f0ea63]
Dec  3 13:39:06 hiro slapd[11134]: <= bdb_index_read 1 candidates
Dec  3 13:39:06 hiro slapd[11134]: <= bdb_equality_candidates: id=1, first=7, last=7
Dec  3 13:39:06 hiro slapd[11134]: <= bdb_filter_candidates: id=1 first=7 last=7
Dec  3 13:39:06 hiro slapd[11134]: <= bdb_list_candidates: id=1 first=7 last=7
Dec  3 13:39:06 hiro slapd[11134]: <= bdb_filter_candidates: id=1 first=7 last=7
Dec  3 13:39:06 hiro slapd[11134]: <= bdb_list_candidates: id=1 first=7 last=7
Dec  3 13:39:06 hiro slapd[11134]: <= bdb_filter_candidates: id=1 first=7 last=7
Dec  3 13:39:06 hiro slapd[11134]: bdb_search_candidates: id=1 first=7 last=7
Dec  3 13:39:06 hiro slapd[11134]: => test_filter
Dec  3 13:39:06 hiro slapd[11134]:     EQUALITY
Dec  3 13:39:06 hiro slapd[11134]: => access_allowed: auth access to "uid=abrown@olp.net,ou=People,dc=olp,dc=net" "btcAltUID" requested
Dec  3 13:39:06 hiro slapd[11134]: => dnpat: [1] ou=addressbooks,uid=([^,]+),ou=people,dc=olp,dc=net$ nsub: 1
Dec  3 13:39:06 hiro slapd[11134]: => dnpat: [2] .*,ou=addressbooks,uid=([^,]+),ou=people,dc=olp,dc=net$ nsub: 1
Dec  3 13:39:06 hiro slapd[11134]: => dn: [3] ou=people,dc=olp,dc=net
Dec  3 13:39:06 hiro slapd[11134]: => dn: [4] ou=groups,dc=olp,dc=net
Dec  3 13:39:06 hiro slapd[11134]: => acl_get: [7] attr btcAltUID
Dec  3 13:39:06 hiro slapd[11134]: => acl_mask: access to entry "uid=abrown@olp.net,ou=People,dc=olp,dc=net", attr "btcAltUID" requested
Dec  3 13:39:06 hiro slapd[11134]: => acl_mask: to value by "", (=0)
Dec  3 13:39:06 hiro slapd[11134]: <= check a_dn_pat: anonymous
Dec  3 13:39:06 hiro slapd[11134]: <= acl_mask: [1] applying auth(=xd) (stop)
Dec  3 13:39:06 hiro slapd[11134]: <= acl_mask: [1] mask: auth(=xd)
Dec  3 13:39:06 hiro slapd[11134]: => slap_access_allowed: auth access granted by auth(=xd)
Dec  3 13:39:06 hiro slapd[11134]: => access_allowed: auth access granted by auth(=xd)
Dec  3 13:39:06 hiro slapd[11134]: <= test_filter 6
Dec  3 13:39:06 hiro slapd[11134]: send_ldap_result: conn=3 op=0 p=3
Dec  3 13:39:06 hiro slapd[11134]: send_ldap_result: err=0 matched="" text=""
Dec  3 13:39:06 hiro slapd[11134]: <==slap_sasl2dn: Converted SASL name to uid=abrown@olp.net,ou=people,dc=olp,dc=net
Dec  3 13:39:06 hiro slapd[11134]: slap_sasl_getdn: dn:id converted to uid=abrown@olp.net,ou=people,dc=olp,dc=net
Dec  3 13:39:06 hiro slapd[11134]: SASL Canonicalize [conn=3]: slapAuthcDN="uid=abrown@olp.net,ou=people,dc=olp,dc=net"
Dec  3 13:39:06 hiro slapd[11134]: => bdb_search
Dec  3 13:39:06 hiro slapd[11134]: bdb_dn2entry("uid=abrown@olp.net,ou=people,dc=olp,dc=net")
Dec  3 13:39:06 hiro slapd[11134]: base_candidates: base: "uid=abrown@olp.net,ou=people,dc=olp,dc=net" (0x00000007)
Dec  3 13:39:06 hiro slapd[11134]: => test_filter
Dec  3 13:39:06 hiro slapd[11134]:     PRESENT
Dec  3 13:39:06 hiro slapd[11134]: => access_allowed: auth access to "uid=abrown@olp.net,ou=People,dc=olp,dc=net" "objectClass" requested
Dec  3 13:39:06 hiro slapd[11134]: => dnpat: [1] ou=addressbooks,uid=([^,]+),ou=people,dc=olp,dc=net$ nsub: 1
Dec  3 13:39:06 hiro slapd[11134]: => dnpat: [2] .*,ou=addressbooks,uid=([^,]+),ou=people,dc=olp,dc=net$ nsub: 1
Dec  3 13:39:06 hiro slapd[11134]: => dn: [3] ou=people,dc=olp,dc=net
Dec  3 13:39:06 hiro slapd[11134]: => dn: [4] ou=groups,dc=olp,dc=net
Dec  3 13:39:06 hiro slapd[11134]: => dnpat: [12] .*n=([^,]+),ou=groups,dc=olp,dc=net$ nsub: 1
Dec  3 13:39:06 hiro slapd[11134]: => dnpat: [13] .*n=([^,]+),ou=groups,dc=olp,dc=net$ nsub: 1
Dec  3 13:39:06 hiro slapd[11134]: => dnpat: [14] ^cn=admin,cn=([^,]+),ou=groups,dc=olp,dc=net$ nsub: 1
Dec  3 13:39:06 hiro slapd[11134]: => dnpat: [15] ^cn=([^,]+),ou=groups,dc=olp,dc=net$ nsub: 1
Dec  3 13:39:06 hiro slapd[11134]: => dnpat: [16] ^cn=admin,cn=([^,]+),ou=groups,dc=olp,dc=net$ nsub: 1
Dec  3 13:39:06 hiro slapd[11134]: => acl_get: [17] attr objectClass
Dec  3 13:39:06 hiro slapd[11134]: => acl_mask: access to entry "uid=abrown@olp.net,ou=People,dc=olp,dc=net", attr "objectClass" requested
Dec  3 13:39:06 hiro slapd[11134]: => acl_mask: to all values by "", (=0)
Dec  3 13:39:06 hiro slapd[11134]: <= check a_dn_pat: self
Dec  3 13:39:06 hiro slapd[11134]: <= check a_dn_pat: anonymous
Dec  3 13:39:06 hiro slapd[11134]: <= acl_mask: [8] applying auth(=xd) (stop)
Dec  3 13:39:06 hiro slapd[11134]: <= acl_mask: [8] mask: auth(=xd)
Dec  3 13:39:06 hiro slapd[11134]: => slap_access_allowed: auth access granted by auth(=xd)
Dec  3 13:39:06 hiro slapd[11134]: => access_allowed: auth access granted by auth(=xd)
Dec  3 13:39:06 hiro slapd[11134]: <= test_filter 6
Dec  3 13:39:06 hiro slapd[11134]: => access_allowed: auth access to "uid=abrown@olp.net,ou=People,dc=olp,dc=net" "cmusaslsecretOTP" requested
Dec  3 13:39:06 hiro slapd[11134]: => dnpat: [1] ou=addressbooks,uid=([^,]+),ou=people,dc=olp,dc=net$ nsub: 1
Dec  3 13:39:06 hiro slapd[11134]: => dnpat: [2] .*,ou=addressbooks,uid=([^,]+),ou=people,dc=olp,dc=net$ nsub: 1
Dec  3 13:39:06 hiro slapd[11134]: => dn: [3] ou=people,dc=olp,dc=net
Dec  3 13:39:06 hiro slapd[11134]: => dn: [4] ou=groups,dc=olp,dc=net
Dec  3 13:39:06 hiro slapd[11134]: => acl_get: [8] attr cmusaslsecretOTP
Dec  3 13:39:06 hiro slapd[11134]: => acl_mask: access to entry "uid=abrown@olp.net,ou=People,dc=olp,dc=net", attr "cmusaslsecretOTP" requested
Dec  3 13:39:06 hiro slapd[11134]: => acl_mask: to all values by "", (=0)
Dec  3 13:39:06 hiro slapd[11134]: <= check a_dn_pat: anonymous
Dec  3 13:39:06 hiro slapd[11134]: <= acl_mask: [1] applying auth(=xd) (stop)
Dec  3 13:39:06 hiro slapd[11134]: <= acl_mask: [1] mask: auth(=xd)
Dec  3 13:39:06 hiro slapd[11134]: => slap_access_allowed: auth access granted by auth(=xd)
Dec  3 13:39:06 hiro slapd[11134]: => access_allowed: auth access granted by auth(=xd)
Dec  3 13:39:06 hiro slapd[11134]: send_ldap_result: conn=3 op=0 p=3
Dec  3 13:39:06 hiro slapd[11134]: send_ldap_result: err=0 matched="" text=""
Dec  3 13:39:06 hiro slapd[11134]: SASL Canonicalize [conn=3]: authzid="abrown@olp.net"
Dec  3 13:39:06 hiro slapd[11134]: slap_auxprop_store [conn=3]: Getting ready to set cmusaslsecretOTP to md5^I0499^Ihi5935^I0e81b33e30182715^I00000000001196711046.
Dec  3 13:39:06 hiro slapd[11134]: bdb_modify: uid=abrown@olp.net,ou=people,dc=olp,dc=net
Dec  3 13:39:06 hiro slapd[11134]: bdb_dn2entry("uid=abrown@olp.net,ou=people,dc=olp,dc=net")
Dec  3 13:39:06 hiro slapd[11134]: bdb_modify_internal: 0x00000007: uid=abrown@olp.net,ou=People,dc=olp,dc=net
Dec  3 13:39:06 hiro slapd[11134]: => access_allowed: delete access to "uid=abrown@olp.net,ou=People,dc=olp,dc=net" "cmusaslsecretOTP" requested
Dec  3 13:39:06 hiro slapd[11134]: => dnpat: [1] ou=addressbooks,uid=([^,]+),ou=people,dc=olp,dc=net$ nsub: 1
Dec  3 13:39:06 hiro slapd[11134]: => dnpat: [2] .*,ou=addressbooks,uid=([^,]+),ou=people,dc=olp,dc=net$ nsub: 1
Dec  3 13:39:06 hiro slapd[11134]: => dn: [3] ou=people,dc=olp,dc=net
Dec  3 13:39:06 hiro slapd[11134]: => dn: [4] ou=groups,dc=olp,dc=net
Dec  3 13:39:06 hiro slapd[11134]: => acl_get: [8] attr cmusaslsecretOTP
Dec  3 13:39:06 hiro slapd[11134]: => slap_access_allowed: no res from state (cmusaslsecretOTP)
Dec  3 13:39:06 hiro slapd[11134]: => acl_mask: access to entry "uid=abrown@olp.net,ou=People,dc=olp,dc=net", attr "cmusaslsecretOTP" requested
Dec  3 13:39:06 hiro slapd[11134]: => acl_mask: to all values by "uid=abrown@olp.net,ou=people,dc=olp,dc=net", (=0)
Dec  3 13:39:06 hiro slapd[11134]: <= check a_dn_pat: anonymous
Dec  3 13:39:06 hiro slapd[11134]: <= check a_dn_pat: self
Dec  3 13:39:06 hiro slapd[11134]: <= acl_mask: [2] applying write(=wrscxd) (stop)
Dec  3 13:39:06 hiro slapd[11134]: <= acl_mask: [2] mask: write(=wrscxd)
Dec  3 13:39:06 hiro slapd[11134]: => slap_access_allowed: delete access granted by write(=wrscxd)
Dec  3 13:39:06 hiro slapd[11134]: => access_allowed: delete access granted by write(=wrscxd)
Dec  3 13:39:06 hiro slapd[11134]: acl: internal mod entryCSN: modify access granted
Dec  3 13:39:06 hiro slapd[11134]: acl: internal mod modifiersName: modify access granted
Dec  3 13:39:06 hiro slapd[11134]: acl: internal mod modifyTimestamp: modify access granted
Dec  3 13:39:06 hiro slapd[11134]: bdb_modify_internal: replace cmusaslsecretOTP
Dec  3 13:39:06 hiro slapd[11134]: bdb_modify_internal: replace entryCSN
Dec  3 13:39:06 hiro slapd[11134]: bdb_modify_internal: replace modifiersName
Dec  3 13:39:06 hiro slapd[11134]: bdb_modify_internal: replace modifyTimestamp
Dec  3 13:39:06 hiro slapd[11134]: oc_check_required entry (uid=abrown@olp.net,ou=People,dc=olp,dc=net), objectClass "account"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_required entry (uid=abrown@olp.net,ou=People,dc=olp,dc=net), objectClass "posixAccount"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_required entry (uid=abrown@olp.net,ou=People,dc=olp,dc=net), objectClass "shadowAccount"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_required entry (uid=abrown@olp.net,ou=People,dc=olp,dc=net), objectClass "krb5KDCEntry"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_required entry (uid=abrown@olp.net,ou=People,dc=olp,dc=net), objectClass "krb5Principal"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_required entry (uid=abrown@olp.net,ou=People,dc=olp,dc=net), objectClass "sambaSamAccount"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_required entry (uid=abrown@olp.net,ou=People,dc=olp,dc=net), objectClass "radiusprofile"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_required entry (uid=abrown@olp.net,ou=People,dc=olp,dc=net), objectClass "btcAuthUser"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_required entry (uid=abrown@olp.net,ou=People,dc=olp,dc=net), objectClass "cmuSaslUser"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_required entry (uid=abrown@olp.net,ou=People,dc=olp,dc=net), objectClass "pkiUser"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "uid"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "cn"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "uidNumber"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "gidNumber"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "homeDirectory"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "loginShell"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "shadowMin"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "shadowMax"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "shadowWarning"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "shadowExpire"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "gecos"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "structuralObjectClass"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "entryUUID"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "creatorsName"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "createTimestamp"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "krb5PrincipalName"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "krb5MaxLife"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "krb5MaxRenew"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "krb5KDCFlags"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "sambaSID"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "sambaAcctFlags"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "sambaPrimaryGroupSID"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "shadowLastChange"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "radiusGroupName"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "btcCertificatePassword"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "btcAltUID"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "UNDEFINED"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "userPassword"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "sambaPwdLastSet"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "sambaLMPassword"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "sambaNTPassword"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "krb5KeyVersionNumber"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "krb5Key"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "UNDEFINED"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "objectClass"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "UNDEFINED"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "cmusaslsecretOTP"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "entryCSN"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "modifiersName"
Dec  3 13:39:06 hiro slapd[11134]: oc_check_allowed type "modifyTimestamp"
Dec  3 13:39:06 hiro slapd[11134]: => entry_encode(0x00000007): uid=abrown@olp.net,ou=People,dc=olp,dc=net
Dec  3 13:39:06 hiro slapd[11134]: bdb_modify: updated id=00000007 dn="uid=abrown@olp.net,ou=people,dc=olp,dc=net"
Dec  3 13:39:06 hiro slapd[11134]: send_ldap_result: conn=3 op=0 p=3
Dec  3 13:39:06 hiro slapd[11134]: send_ldap_result: err=0 matched="" text=""
Dec  3 13:39:06 hiro slapd[11134]: send_ldap_sasl: err=14 len=22
Dec  3 13:39:06 hiro slapd[11134]: send_ldap_response: msgid=1 tag=97 err=14
Dec  3 13:39:06 hiro slapd[11134]: conn=3 op=0 RESULT tag=97 err=14 text=
Dec  3 13:39:06 hiro slapd[11134]: <== slap_sasl_bind: rc=14
Dec  3 13:39:07 hiro slapd[11134]: daemon: activity on 1 descriptor
Dec  3 13:39:07 hiro slapd[11134]: daemon: activity on:
Dec  3 13:39:07 hiro slapd[11134]:  16r
Dec  3 13:39:07 hiro slapd[11134]:
Dec  3 13:39:07 hiro slapd[11134]: daemon: read active on 16
Dec  3 13:39:07 hiro slapd[11134]: connection_get(16)
Dec  3 13:39:07 hiro slapd[11134]: connection_get(16): got connid=3
Dec  3 13:39:07 hiro slapd[11134]: connection_read(16): checking for input on id=3
Dec  3 13:39:07 hiro slapd[11134]: ber_get_next on fd 16 failed errno=0 (Success)
Dec  3 13:39:07 hiro slapd[11134]: connection_read(16): input error=-2 id=3, closing.
Dec  3 13:39:07 hiro slapd[11134]: connection_closing: readying conn=3 sd=16 for close
Dec  3 13:39:07 hiro slapd[11134]: connection_close: conn=3 sd=-1
Dec  3 13:39:07 hiro slapd[11134]: slap_auxprop_store [conn=-1]: Getting ready to set cmusaslsecretOTP to md5^I0499^Ihi5935^I0e81b33e30182715^I00000000000000000000.