Attachment 3781 Details for Bug 21207 – лог успешного добавления

лог успешного добавления

success.log (text/plain), 15.30 KB, created by Timur Batyrshin on 2009-08-24 18:29:11 MSD

(hide)

Description:

Filename:

MIME Type:

Creator: Timur Batyrshin

Created: 2009-08-24 18:29:11 MSD

Size: 15.30 KB

patch

obsolete

>Aug 24 14:11:44 box1 slapd[15628]: daemon: activity on 1 descriptor 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: activity on:
>Aug 24 14:11:44 box1 slapd[15628]:  
>Aug 24 14:11:44 box1 slapd[15628]: >>> slap_listener(ldap:///) 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: listen=7, new connection on 14 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: added 14r (active) listener=(nil) 
>Aug 24 14:11:44 box1 slapd[15628]: conn=6 fd=14 ACCEPT from IP=127.0.0.1:54860 (IP=0.0.0.0:389) 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: epoll: listen=7 active_threads=0 tvp=NULL 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: epoll: listen=8 active_threads=0 tvp=NULL 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: activity on 1 descriptor 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: activity on:
>Aug 24 14:11:44 box1 slapd[15628]:  14r
>Aug 24 14:11:44 box1 slapd[15628]:  
>Aug 24 14:11:44 box1 slapd[15628]: daemon: read active on 14 
>Aug 24 14:11:44 box1 slapd[15628]: connection_get(14) 
>Aug 24 14:11:44 box1 slapd[15628]: connection_get(14): got connid=6 
>Aug 24 14:11:44 box1 slapd[15628]: connection_read(14): checking for input on id=6 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: epoll: listen=7 active_threads=0 tvp=NULL 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: epoll: listen=8 active_threads=0 tvp=NULL 
>Aug 24 14:11:44 box1 slapd[15628]: do_bind 
>Aug 24 14:11:44 box1 slapd[15628]: >>> dnPrettyNormal: <cn=admin,dc=example,dc=com> 
>Aug 24 14:11:44 box1 slapd[15628]: <<< dnPrettyNormal: <cn=admin,dc=example,dc=com>, <cn=admin,dc=example,dc=com> 
>Aug 24 14:11:44 box1 slapd[15628]: do_bind: version=3 dn="cn=admin,dc=example,dc=com" method=128 
>Aug 24 14:11:44 box1 slapd[15628]: conn=6 op=0 BIND dn="cn=admin,dc=example,dc=com" method=128 
>Aug 24 14:11:44 box1 slapd[15628]: ==> hdb_bind: dn: cn=admin,dc=example,dc=com 
>Aug 24 14:11:44 box1 slapd[15628]: conn=6 op=0 BIND dn="cn=admin,dc=example,dc=com" mech=SIMPLE ssf=0 
>Aug 24 14:11:44 box1 slapd[15628]: do_bind: v3 bind: "cn=admin,dc=example,dc=com" to "cn=admin,dc=example,dc=com" 
>Aug 24 14:11:44 box1 slapd[15628]: send_ldap_result: conn=6 op=0 p=3 
>Aug 24 14:11:44 box1 slapd[15628]: send_ldap_result: err=0 matched="" text="" 
>Aug 24 14:11:44 box1 slapd[15628]: send_ldap_response: msgid=1 tag=97 err=0 
>Aug 24 14:11:44 box1 slapd[15628]: conn=6 op=0 RESULT tag=97 err=0 text= 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: activity on 1 descriptor 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: activity on:
>Aug 24 14:11:44 box1 slapd[15628]:  14r
>Aug 24 14:11:44 box1 slapd[15628]:  
>Aug 24 14:11:44 box1 slapd[15628]: daemon: read active on 14 
>Aug 24 14:11:44 box1 slapd[15628]: connection_get(14) 
>Aug 24 14:11:44 box1 slapd[15628]: connection_get(14): got connid=6 
>Aug 24 14:11:44 box1 slapd[15628]: connection_read(14): checking for input on id=6 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: epoll: listen=7 active_threads=0 tvp=NULL 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: epoll: listen=8 active_threads=0 tvp=NULL 
>Aug 24 14:11:44 box1 slapd[15628]: do_add 
>Aug 24 14:11:44 box1 slapd[15628]: >>> dnPrettyNormal: <ou=ldif7,ou=branch2,dc=example,dc=com> 
>Aug 24 14:11:44 box1 slapd[15628]: <<< dnPrettyNormal: <ou=ldif7,ou=branch2,dc=example,dc=com>, <ou=ldif7,ou=branch2,dc=example,dc=com> 
>Aug 24 14:11:44 box1 slapd[15628]: do_add: dn (ou=ldif7,ou=branch2,dc=example,dc=com) 
>Aug 24 14:11:44 box1 slapd[15628]: conn=6 op=1 ADD dn="ou=ldif7,ou=branch2,dc=example,dc=com" 
>Aug 24 14:11:44 box1 slapd[15628]: bdb_dn2entry("ou=ldif7,ou=branch2,dc=example,dc=com") 
>Aug 24 14:11:44 box1 slapd[15628]: => hdb_dn2id("ou=ldif7,ou=branch2,dc=example,dc=com") 
>Aug 24 14:11:44 box1 slapd[15628]: <= hdb_dn2id: get failed: DB_NOTFOUND: No matching key/data pair found (-30989) 
>Aug 24 14:11:44 box1 slapd[15628]: hdb_referrals: op=104 target="ou=ldif7,ou=branch2,dc=example,dc=com" matched="ou=branch2,dc=example,dc=com" 
>Aug 24 14:11:44 box1 slapd[15628]: ==> hdb_add: ou=ldif7,ou=branch2,dc=example,dc=com 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_required entry (ou=ldif7,ou=branch2,dc=example,dc=com), objectClass "organizationalUnit" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "objectClass" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "ou" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "structuralObjectClass" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "entryUUID" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "creatorsName" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "createTimestamp" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "entryCSN" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "modifiersName" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "modifyTimestamp" 
>Aug 24 14:11:44 box1 slapd[15628]: bdb_dn2entry("ou=ldif7,ou=branch2,dc=example,dc=com") 
>Aug 24 14:11:44 box1 slapd[15628]: => hdb_dn2id("ou=ldif7,ou=branch2,dc=example,dc=com") 
>Aug 24 14:11:44 box1 slapd[15628]: <= hdb_dn2id: get failed: DB_NOTFOUND: No matching key/data pair found (-30989) 
>Aug 24 14:11:44 box1 slapd[15628]: => access_allowed: add access to "ou=branch2,dc=example,dc=com" "children" requested 
>Aug 24 14:11:44 box1 slapd[15628]: <= root access granted 
>Aug 24 14:11:44 box1 slapd[15628]: => access_allowed: add access to "ou=ldif7,ou=branch2,dc=example,dc=com" "entry" requested 
>Aug 24 14:11:44 box1 slapd[15628]: <= root access granted 
>Aug 24 14:11:44 box1 slapd[15628]: => hdb_dn2id_add 0x18: "ou=ldif7,ou=branch2,dc=example,dc=com" 
>Aug 24 14:11:44 box1 slapd[15628]: <= hdb_dn2id_add 0x18: 0 
>Aug 24 14:11:44 box1 slapd[15628]: => index_entry_add( 24, "ou=ldif7,ou=branch2,dc=example,dc=com" ) 
>Aug 24 14:11:44 box1 slapd[15628]: => key_change(ADD,18) 
>Aug 24 14:11:44 box1 slapd[15628]: bdb_idl_insert_key: 18 [9bee355f] 
>Aug 24 14:11:44 box1 slapd[15628]: <= key_change 0 
>Aug 24 14:11:44 box1 slapd[15628]: => key_change(ADD,18) 
>Aug 24 14:11:44 box1 slapd[15628]: bdb_idl_insert_key: 18 [0096defd] 
>Aug 24 14:11:44 box1 slapd[15628]: <= key_change 0 
>Aug 24 14:11:44 box1 slapd[15628]: => key_change(ADD,18) 
>Aug 24 14:11:44 box1 slapd[15628]: bdb_idl_insert_key: 18 [0c24a57a] 
>Aug 24 14:11:44 box1 slapd[15628]: <= key_change 0 
>Aug 24 14:11:44 box1 slapd[15628]: => key_change(ADD,18) 
>Aug 24 14:11:44 box1 slapd[15628]: bdb_idl_insert_key: 18  
>Aug 24 14:11:44 box1 slapd[15628]: <= key_change 0 
>Aug 24 14:11:44 box1 slapd[15628]: <= index_entry_add( 24, "ou=ldif7,ou=branch2,dc=example,dc=com" ) success 
>Aug 24 14:11:44 box1 slapd[15628]: => entry_encode(0x00000018):  
>Aug 24 14:11:44 box1 slapd[15628]: hdb_add: added id=00000018 dn="ou=ldif7,ou=branch2,dc=example,dc=com" 
>Aug 24 14:11:44 box1 slapd[15628]: send_ldap_result: conn=6 op=1 p=3 
>Aug 24 14:11:44 box1 slapd[15628]: send_ldap_result: err=0 matched="" text="" 
>Aug 24 14:11:44 box1 slapd[15628]: hdb_modify: dc=example,dc=com 
>Aug 24 14:11:44 box1 slapd[15628]: bdb_dn2entry("dc=example,dc=com") 
>Aug 24 14:11:44 box1 slapd[15628]: bdb_modify_internal: 0x00000001: dc=example,dc=com 
>Aug 24 14:11:44 box1 slapd[15628]: <= acl_access_allowed: granted to database root 
>Aug 24 14:11:44 box1 slapd[15628]: bdb_modify_internal: replace contextCSN 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_required entry (dc=example,dc=com), objectClass "organizationalUnit" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_required entry (dc=example,dc=com), objectClass "dcObject" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "objectClass" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "dc" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "ou" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "structuralObjectClass" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "entryUUID" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "creatorsName" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "createTimestamp" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "entryCSN" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "modifiersName" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "modifyTimestamp" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "contextCSN" 
>Aug 24 14:11:44 box1 slapd[15628]: => entry_encode(0x00000001):  
>Aug 24 14:11:44 box1 slapd[15628]: hdb_modify: updated id=00000001 dn="dc=example,dc=com" 
>Aug 24 14:11:44 box1 slapd[15628]: send_ldap_result: conn=6 op=1 p=3 
>Aug 24 14:11:44 box1 slapd[15628]: send_ldap_result: err=0 matched="" text="" 
>Aug 24 14:11:44 box1 slapd[15628]: => test_filter 
>Aug 24 14:11:44 box1 slapd[15628]:     PRESENT 
>Aug 24 14:11:44 box1 slapd[15628]: => access_allowed: search access to "ou=ldif7,ou=branch2,dc=example,dc=com" "objectClass" requested 
>Aug 24 14:11:44 box1 slapd[15628]: <= root access granted 
>Aug 24 14:11:44 box1 slapd[15628]: <= test_filter 6 
>Aug 24 14:11:44 box1 slapd[15628]: send_ldap_response: msgid=2 tag=105 err=0 
>Aug 24 14:11:44 box1 slapd[15628]: conn=6 op=1 RESULT tag=105 err=0 text= 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: activity on 1 descriptor 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: activity on:
>Aug 24 14:11:44 box1 slapd[15628]:  14r
>Aug 24 14:11:44 box1 slapd[15628]:  
>Aug 24 14:11:44 box1 slapd[15628]: daemon: read active on 14 
>Aug 24 14:11:44 box1 slapd[15628]: connection_get(14) 
>Aug 24 14:11:44 box1 slapd[15628]: connection_get(14): got connid=6 
>Aug 24 14:11:44 box1 slapd[15628]: connection_read(14): checking for input on id=6 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: epoll: listen=7 active_threads=0 tvp=NULL 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: epoll: listen=8 active_threads=0 tvp=NULL 
>Aug 24 14:11:44 box1 slapd[15628]: do_add 
>Aug 24 14:11:44 box1 slapd[15628]: >>> dnPrettyNormal: <ou=ldif8,ou=branch1,dc=example,dc=com> 
>Aug 24 14:11:44 box1 slapd[15628]: <<< dnPrettyNormal: <ou=ldif8,ou=branch1,dc=example,dc=com>, <ou=ldif8,ou=branch1,dc=example,dc=com> 
>Aug 24 14:11:44 box1 slapd[15628]: do_add: dn (ou=ldif8,ou=branch1,dc=example,dc=com) 
>Aug 24 14:11:44 box1 slapd[15628]: conn=6 op=2 ADD dn="ou=ldif8,ou=branch1,dc=example,dc=com" 
>Aug 24 14:11:44 box1 slapd[15628]: bdb_dn2entry("ou=ldif8,ou=branch1,dc=example,dc=com") 
>Aug 24 14:11:44 box1 slapd[15628]: => hdb_dn2id("ou=ldif8,ou=branch1,dc=example,dc=com") 
>Aug 24 14:11:44 box1 slapd[15628]: <= hdb_dn2id: get failed: DB_NOTFOUND: No matching key/data pair found (-30989) 
>Aug 24 14:11:44 box1 slapd[15628]: hdb_referrals: op=104 target="ou=ldif8,ou=branch1,dc=example,dc=com" matched="ou=branch1,dc=example,dc=com" 
>Aug 24 14:11:44 box1 slapd[15628]: ==> hdb_add: ou=ldif8,ou=branch1,dc=example,dc=com 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_required entry (ou=ldif8,ou=branch1,dc=example,dc=com), objectClass "organizationalUnit" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "objectClass" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "ou" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "structuralObjectClass" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "entryUUID" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "creatorsName" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "createTimestamp" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "entryCSN" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "modifiersName" 
>Aug 24 14:11:44 box1 slapd[15628]: oc_check_allowed type "modifyTimestamp" 
>Aug 24 14:11:44 box1 slapd[15628]: bdb_dn2entry("ou=ldif8,ou=branch1,dc=example,dc=com") 
>Aug 24 14:11:44 box1 slapd[15628]: => hdb_dn2id("ou=ldif8,ou=branch1,dc=example,dc=com") 
>Aug 24 14:11:44 box1 slapd[15628]: <= hdb_dn2id: get failed: DB_NOTFOUND: No matching key/data pair found (-30989) 
>Aug 24 14:11:44 box1 slapd[15628]: => access_allowed: add access to "ou=branch1,dc=example,dc=com" "children" requested 
>Aug 24 14:11:44 box1 slapd[15628]: <= root access granted 
>Aug 24 14:11:44 box1 slapd[15628]: => access_allowed: add access to "ou=ldif8,ou=branch1,dc=example,dc=com" "entry" requested 
>Aug 24 14:11:44 box1 slapd[15628]: <= root access granted 
>Aug 24 14:11:44 box1 slapd[15628]: => hdb_dn2id_add 0x19: "ou=ldif8,ou=branch1,dc=example,dc=com" 
>Aug 24 14:11:44 box1 slapd[15628]: <= hdb_dn2id_add 0x19: 0 
>Aug 24 14:11:44 box1 slapd[15628]: => index_entry_add( 25, "ou=ldif8,ou=branch1,dc=example,dc=com" ) 
>Aug 24 14:11:44 box1 slapd[15628]: => key_change(ADD,19) 
>Aug 24 14:11:44 box1 slapd[15628]: bdb_idl_insert_key: 19 [9bee355f] 
>Aug 24 14:11:44 box1 slapd[15628]: <= key_change 0 
>Aug 24 14:11:44 box1 slapd[15628]: => key_change(ADD,19) 
>Aug 24 14:11:44 box1 slapd[15628]: bdb_idl_insert_key: 19 [0096defd] 
>Aug 24 14:11:44 box1 slapd[15628]: <= key_change 0 
>Aug 24 14:11:44 box1 slapd[15628]: => key_change(ADD,19) 
>Aug 24 14:11:44 box1 slapd[15628]: bdb_idl_insert_key: 19 [b2832d50] 
>Aug 24 14:11:44 box1 slapd[15628]: <= key_change 0 
>Aug 24 14:11:44 box1 slapd[15628]: => key_change(ADD,19) 
>Aug 24 14:11:44 box1 slapd[15628]: bdb_idl_insert_key: 19  
>Aug 24 14:11:44 box1 slapd[15628]: <= key_change 0 
>Aug 24 14:11:44 box1 slapd[15628]: <= index_entry_add( 25, "ou=ldif8,ou=branch1,dc=example,dc=com" ) success 
>Aug 24 14:11:44 box1 slapd[15628]: => entry_encode(0x00000019):  
>Aug 24 14:11:44 box1 slapd[15628]: hdb_add: added id=00000019 dn="ou=ldif8,ou=branch1,dc=example,dc=com" 
>Aug 24 14:11:44 box1 slapd[15628]: send_ldap_result: conn=6 op=2 p=3 
>Aug 24 14:11:44 box1 slapd[15628]: send_ldap_result: err=0 matched="" text="" 
>Aug 24 14:11:44 box1 slapd[15628]: => test_filter 
>Aug 24 14:11:44 box1 slapd[15628]:     PRESENT 
>Aug 24 14:11:44 box1 slapd[15628]: => access_allowed: search access to "ou=ldif8,ou=branch1,dc=example,dc=com" "objectClass" requested 
>Aug 24 14:11:44 box1 slapd[15628]: <= root access granted 
>Aug 24 14:11:44 box1 slapd[15628]: <= test_filter 6 
>Aug 24 14:11:44 box1 slapd[15628]: send_ldap_response: msgid=3 tag=105 err=0 
>Aug 24 14:11:44 box1 slapd[15628]: conn=6 op=2 RESULT tag=105 err=0 text= 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: activity on 1 descriptor 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: activity on:
>Aug 24 14:11:44 box1 slapd[15628]:  14r
>Aug 24 14:11:44 box1 slapd[15628]:  
>Aug 24 14:11:44 box1 slapd[15628]: daemon: read active on 14 
>Aug 24 14:11:44 box1 slapd[15628]: connection_get(14) 
>Aug 24 14:11:44 box1 slapd[15628]: connection_get(14): got connid=6 
>Aug 24 14:11:44 box1 slapd[15628]: connection_read(14): checking for input on id=6 
>Aug 24 14:11:44 box1 slapd[15628]: ber_get_next on fd 14 failed errno=0 (Success) 
>Aug 24 14:11:44 box1 slapd[15628]: connection_read(14): input error=-2 id=6, closing. 
>Aug 24 14:11:44 box1 slapd[15628]: connection_closing: readying conn=6 sd=14 for close 
>Aug 24 14:11:44 box1 slapd[15628]: connection_close: deferring conn=6 sd=-1 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: epoll: listen=7 active_threads=0 tvp=NULL 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: epoll: listen=8 active_threads=0 tvp=NULL 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: activity on 1 descriptor 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: activity on:
>Aug 24 14:11:44 box1 slapd[15628]:  
>Aug 24 14:11:44 box1 slapd[15628]: daemon: epoll: listen=7 active_threads=0 tvp=NULL 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: epoll: listen=8 active_threads=0 tvp=NULL 
>Aug 24 14:11:44 box1 slapd[15628]: do_unbind 
>Aug 24 14:11:44 box1 slapd[15628]: conn=6 op=3 UNBIND 
>Aug 24 14:11:44 box1 slapd[15628]: connection_resched: attempting closing conn=6 sd=14 
>Aug 24 14:11:44 box1 slapd[15628]: connection_close: conn=6 sd=-1 
>Aug 24 14:11:44 box1 slapd[15628]: daemon: removing 14 
>Aug 24 14:11:44 box1 slapd[15628]: conn=6 fd=14 closed

Actions: View

Attachments on bug 21207: 3777 | 3778 | 3779 | 3780 | 3781