Project

General

Profile

Patch #3358 » logldap.txt

seb rey, 2011-12-09 22:44

 
1
slapd startup: initiated.
2
backend_startup_one: starting "cn=config"
3
config_back_db_open
4
backend_startup_one: starting "dc=parisgeo,dc=cnrs,dc=fr"
5
hdb_db_open: "dc=parisgeo,dc=cnrs,dc=fr"
6
hdb_db_open: database "dc=parisgeo,dc=cnrs,dc=fr": dbenv_open(/var/lib/ldap).
7
slapd starting
8
daemon: added 4r listener=(nil)
9
daemon: added 7r listener=0x8ab9040
10
daemon: added 8r listener=0x8ab9c68
11
daemon: epoll: listen=7 active_threads=0 tvp=zero
12
daemon: epoll: listen=8 active_threads=0 tvp=zero
13
daemon: activity on 1 descriptor
14
daemon: activity on:
15
daemon: epoll: listen=7 active_threads=0 tvp=zero
16
daemon: epoll: listen=8 active_threads=0 tvp=zero
17
daemon: activity on 1 descriptor
18
daemon: activity on:
19
slap_listener_activate(7): 
20
daemon: epoll: listen=7 busy
21
daemon: epoll: listen=8 active_threads=0 tvp=zero
22
>>> slap_listener(ldap:///)
23
daemon: listen=7, new connection on 13
24
daemon: added 13r (active) listener=(nil)
25
daemon: activity on 1 descriptor
26
daemon: activity on:
27
daemon: epoll: listen=7 active_threads=0 tvp=zero
28
daemon: epoll: listen=8 active_threads=0 tvp=zero
29
daemon: activity on 1 descriptor
30
daemon: activity on: 13r
31
daemon: read active on 13
32
daemon: epoll: listen=7 active_threads=0 tvp=zero
33
daemon: epoll: listen=8 active_threads=0 tvp=zero
34
connection_get(13)
35
connection_get(13): got connid=1000
36
connection_read(13): checking for input on id=1000
37
ber_get_next
38
ldap_read: want=8, got=8
39
  0000:  30 3c 02 01 01 60 37 02                            0<...`7.          
40
ldap_read: want=54, got=54
41
  0000:  01 03 04 28 63 6e 3d 72  65 61 64 65 72 2d 6f 6e   ...(cn=reader-on  
42
  0010:  6c 79 2c 64 63 3d 70 61  72 69 73 67 65 6f 2c 64   ly,dc=parisgeo,d  
43
  0020:  63 3d 63 6e 72 73 2c 64  63 3d 66 72 80 08 52 33   c=cnrs,dc=fr..R3  
44
  0030:  65 31 64 33 72 24                                  e1d3r$            
45
ber_get_next: tag 0x30 len 60 contents:
46
ber_dump: buf=0x8b44d38 ptr=0x8b44d38 end=0x8b44d74 len=60
47
  0000:  02 01 01 60 37 02 01 03  04 28 63 6e 3d 72 65 61   ...`7....(cn=rea  
48
  0010:  64 65 72 2d 6f 6e 6c 79  2c 64 63 3d 70 61 72 69   der-only,dc=pari  
49
  0020:  73 67 65 6f 2c 64 63 3d  63 6e 72 73 2c 64 63 3d   sgeo,dc=cnrs,dc=  
50
  0030:  66 72 80 08 52 33 65 31  64 33 72 24               fr..R3e1d3r$      
51
op tag 0x60, time 1323466716
52
ber_get_next
53
ldap_read: want=8 error=Resource temporarily unavailable
54
conn=1000 op=0 do_bind
55
ber_scanf fmt ({imt) ber:
56
ber_dump: buf=0x8b44d38 ptr=0x8b44d3b end=0x8b44d74 len=57
57
  0000:  60 37 02 01 03 04 28 63  6e 3d 72 65 61 64 65 72   `7....(cn=reader  
58
  0010:  2d 6f 6e 6c 79 2c 64 63  3d 70 61 72 69 73 67 65   -only,dc=parisge  
59
  0020:  6f 2c 64 63 3d 63 6e 72  73 2c 64 63 3d 66 72 80   o,dc=cnrs,dc=fr.  
60
  0030:  08 52 33 65 31 64 33 72  24                        .R3e1d3r$         
61
ber_scanf fmt (m}) ber:
62
ber_dump: buf=0x8b44d38 ptr=0x8b44d6a end=0x8b44d74 len=10
63
  0000:  00 08 52 33 65 31 64 33  72 24                     ..R3e1d3r$        
64
>>> dnPrettyNormal: <cn=reader-only,dc=parisgeo,dc=cnrs,dc=fr>
65
=> ldap_bv2dn(cn=reader-only,dc=parisgeo,dc=cnrs,dc=fr,0)
66
<= ldap_bv2dn(cn=reader-only,dc=parisgeo,dc=cnrs,dc=fr)=0 
67
=> ldap_dn2bv(272)
68
<= ldap_dn2bv(cn=reader-only,dc=parisgeo,dc=cnrs,dc=fr)=0 
69
=> ldap_dn2bv(272)
70
<= ldap_dn2bv(cn=reader-only,dc=parisgeo,dc=cnrs,dc=fr)=0 
71
<<< dnPrettyNormal: <cn=reader-only,dc=parisgeo,dc=cnrs,dc=fr>, <cn=reader-only,dc=parisgeo,dc=cnrs,dc=fr>
72
do_bind: version=3 dn="cn=reader-only,dc=parisgeo,dc=cnrs,dc=fr" method=128
73
==> hdb_bind: dn: cn=reader-only,dc=parisgeo,dc=cnrs,dc=fr
74
bdb_dn2entry("cn=reader-only,dc=parisgeo,dc=cnrs,dc=fr")
75
=> hdb_dn2id("dc=parisgeo,dc=cnrs,dc=fr")
76
<= hdb_dn2id: got id=0x1
77
=> hdb_dn2id("cn=reader-only,dc=parisgeo,dc=cnrs,dc=fr")
78
<= hdb_dn2id: got id=0x7
79
entry_decode: ""
80
<= entry_decode()
81
=> access_allowed: result not in cache (userPassword)
82
=> access_allowed: auth access to "cn=reader-only,dc=parisgeo,dc=cnrs,dc=fr" "userPassword" requested
83
=> acl_get: [1] attr userPassword
84
=> acl_mask: access to entry "cn=reader-only,dc=parisgeo,dc=cnrs,dc=fr", attr "userPassword" requested
85
=> acl_mask: to value by "", (=0) 
86
<= check a_dn_pat: self
87
<= check a_dn_pat: anonymous
88
<= acl_mask: [2] applying auth(=xd) (stop)
89
<= acl_mask: [2] mask: auth(=xd)
90
=> slap_access_allowed: auth access granted by auth(=xd)
91
=> access_allowed: auth access granted by auth(=xd)
92
do_bind: v3 bind: "cn=reader-only,dc=parisgeo,dc=cnrs,dc=fr" to "cn=reader-only,dc=parisgeo,dc=cnrs,dc=fr"
93
send_ldap_result: conn=1000 op=0 p=3
94
send_ldap_result: err=0 matched="" text=""
95
send_ldap_response: msgid=1 tag=97 err=0
96
ber_flush2: 14 bytes to sd 13
97
  0000:  30 0c 02 01 01 61 07 0a  01 00 04 00 04 00         0....a........    
98
ldap_write: want=14, written=14
99
  0000:  30 0c 02 01 01 61 07 0a  01 00 04 00 04 00         0....a........    
100
daemon: activity on 1 descriptor
101
daemon: activity on:
102
daemon: epoll: listen=7 active_threads=0 tvp=zero
103
daemon: epoll: listen=8 active_threads=0 tvp=zero
104
daemon: activity on 1 descriptor
105
daemon: activity on: 13r
106
daemon: read active on 13
107
daemon: epoll: listen=7 active_threads=0 tvp=zero
108
daemon: epoll: listen=8 active_threads=0 tvp=zero
109
connection_get(13)
110
connection_get(13): got connid=1000
111
connection_read(13): checking for input on id=1000
112
ber_get_next
113
ldap_read: want=8, got=7
114
  0000:  30 05 02 01 02 42 00                               0....B.           
115
ber_get_next: tag 0x30 len 5 contents:
116
ber_dump: buf=0x8b37c78 ptr=0x8b37c78 end=0x8b37c7d len=5
117
  0000:  02 01 02 42 00                                     ...B.             
118
op tag 0x42, time 1323466717
119
ber_get_next
120
ldap_read: want=8 error=Resource temporarily unavailable
121
conn=1000 op=1 do_unbind
122
connection_closing: readying conn=1000 sd=13 for close
123
connection_resched: attempting closing conn=1000 sd=13
124
connection_close: conn=1000 sd=13
125
daemon: removing 13
126
daemon: activity on 1 descriptor
127
daemon: activity on:
128
daemon: epoll: listen=7 active_threads=0 tvp=zero
129
daemon: epoll: listen=8 active_threads=0 tvp=zero
130

    
(8-8/9)