Issue 8653 - ber_flus2 assertion fail leads to a crash of slapd
Summary: ber_flus2 assertion fail leads to a crash of slapd
Status: VERIFIED DUPLICATE of issue 8864
Alias: None
Product: OpenLDAP
Classification: Unclassified
Component: slapd (show other issues)
Version: 2.4.44
Hardware: All All
: --- normal
Target Milestone: 2.5.0
Assignee: OpenLDAP project
URL:
Keywords:
Depends on:
Blocks:
 
Reported: 2017-05-15 11:11 UTC by mail@artemil.de
Modified: 2021-04-01 16:23 UTC (History)
0 users

See Also:


Attachments

Note You need to log in before you can comment on or make changes to this issue.
Description mail@artemil.de 2017-05-15 11:11:01 UTC
Full_Name: 
Version: 2.4.44
OS: centos 7, sles 12.2
URL: ftp://ftp.openldap.org/incoming/
Submission from: (NULL) (91.224.226.197)


Hello,

we are trying to run openldap in a proxy mode to our AD as a virtual machine on
a VMWARE ESXi 5.5.

Unfortunately slapd crashes by receiving a SIGABRT very often, but not on every
request. But the issue can be reproduced easily by just typing several times the
"id corporateID" command. 
I reduced the configuration file to a minimum, - the issue remains. 

I'm running in to the same issue on SLES 12.2 with openldap 2.4.41 and also on a
CentOS 7 with openldap 2.4.44 from the "tlb project".

The crash happens, as far as i can determine, always in the ber_flush2 function
after a failed assert.

Here is the minimal config where the issue persists:

include         /usr/local/openldap/etc/openldap/schema/core.schema
include         /usr/local/openldap/etc/openldap/schema/cosine.schema
include         /usr/local/openldap/etc/openldap/schema/inetorgperson.schema
include         /usr/local/openldap/etc/openldap/schema/nis.schema
include         /usr/local/openldap/etc/openldap/schema/misc.schema

pidfile         /usr/local/openldap/var/run/slapd.pid
argsfile        /usr/local/openldap/var/run/slapd.args

database                ldap
readonly                yes
protocol-version        3
rebind-as-user          yes
uri                     ldap://ldap.corp.de:389
suffix                  "DC=corp,DC=de"
rootdn                 
"DC=corp,DC=de?sub?&(memberof=CN=DMS-SSH-User,OU=administrative Gruppen\\,
Admin- und Dienstkonten,OU=Berechtigungen,DC=corp,DC=de)"
loglevel 256


Here comes the backtrace:
(gdb) bt
#0  0x00007ffff64281d7 in __GI_raise (sig=sig@entry=6) at
../nptl/sysdeps/unix/sysv/linux/raise.c:56
#1  0x00007ffff64298c8 in __GI_abort () at abort.c:90
#2  0x00007ffff6421146 in __assert_fail_base (fmt=0x7ffff65723a8 "%s%s%s:%u:
%s%sAssertion `%s' failed.\n%n", assertion=assertion@entry=0x649ab8 "(
(sb)->sb_opts.lbo_valid == 0x3 )",
    file=file@entry=0x649a21 "io.c", line=line@entry=224,
function=function@entry=0x649be6 <__PRETTY_FUNCTION__.6214> "ber_flush2") at
assert.c:92
#3  0x00007ffff64211f2 in __GI___assert_fail (assertion=assertion@entry=0x649ab8
"( (sb)->sb_opts.lbo_valid == 0x3 )", file=file@entry=0x649a21 "io.c",
line=line@entry=224,
    function=function@entry=0x649be6 <__PRETTY_FUNCTION__.6214> "ber_flush2") at
assert.c:101
#4  0x00000000005b95d8 in ber_flush2 (sb=0x7fffe40000d8, ber=0x7fffe4119d40,
freeit=freeit@entry=0) at io.c:224
#5  0x00000000005a3491 in ldap_int_flush_request (ld=ld@entry=0x7fffe8102800,
lr=lr@entry=0x7fffe410d570) at request.c:186
#6  0x00000000005a38fa in ldap_send_server_request (ld=ld@entry=0x7fffe8102800,
ber=ber@entry=0x7fffe4119d40, msgid=msgid@entry=134,
parentreq=parentreq@entry=0x0, srvlist=srvlist@entry=0x0,
    lc=0x7fffe4116f70, lc@entry=0x0, bind=bind@entry=0x0,
m_noconn=m_noconn@entry=0, m_res=m_res@entry=0) at request.c:408
#7  0x00000000005a3aa8 in ldap_send_initial_request (ld=ld@entry=0x7fffe8102800,
msgtype=msgtype@entry=99, dn=dn@entry=0x7fffe4002e48 "dc=corp,dc=de",
ber=0x7fffe4119d40, msgid=134)
    at request.c:169
#8  0x00000000005946e4 in ldap_pvt_search (ld=0x7fffe8102800,
base=0x7fffe4002e48 "dc=corp,dc=de", scope=2,
    filter=filter@entry=0x7fffe40031a8
"(&(objectClass=group)(gidNumber=20000)(&(OBJECTCATEGORY=group)(gidNumber=*)))",
attrs=attrs@entry=0x7fffe4003170, attrsonly=0, sctrls=0x0,
    cctrls=cctrls@entry=0x0, timeout=0x7ffff35d07f0, sizelimit=1, deref=0,
msgidp=msgidp@entry=0x7ffff35d07cc) at search.c:128
#9  0x00000000004c902d in ldap_back_search (op=0x7fffe40028e0, rs=<optimized
out>) at search.c:233
#10 0x0000000000442f41 in fe_op_search (op=0x7fffe40028e0, rs=0x7ffff35d19a0) at
search.c:402
#11 0x0000000000442926 in do_search (op=0x7fffe40028e0, rs=0x7ffff35d19a0) at
search.c:247
#12 0x00000000004407de in connection_operation (ctx=ctx@entry=0x7ffff35d1ad0,
arg_v=arg_v@entry=0x7fffe40028e0) at connection.c:1158
#13 0x0000000000440aba in connection_read_thread (ctx=0x7ffff35d1ad0, argv=0xd)
at connection.c:1294
#14 0x00000000005901c9 in ldap_int_thread_pool_wrapper (xpool=0x969360) at
tpool.c:696
#15 0x00007ffff7896dc5 in start_thread (arg=0x7ffff35d2700) at
pthread_create.c:308
#16 0x00007ffff64ea73d in clone () at
../sysdeps/unix/sysv/linux/x86_64/clone.S:113

Here is a full backtrace:
https://pastebin.com/Ya3F3WAW



Thank you!
Comment 1 Mil, Artem 2017-05-16 08:28:42 UTC
Here is are the last 1000 lines of outpit from the command :

/usr/sbin/slapd -u ldap -h ldap:/// -f /etc/openldap/slapd.conf -o slp=off -d 3 2&amp;amp;amp;gt; slapd.log2 &amp;amp;amp;gt; slapd.log1


ldap_send_server_request
ldap_new_connection 0 1 1
ldap_int_open_connection
ldap_connect_to_host: TCP DomainDnsZones.corp.de:389
ldap_new_socket: 12
ldap_prepare_socket: 12
ldap_connect_to_host: Trying 10.30.0.90:389
ldap_pvt_connect: fd: 12 tm: -1 async: 0
attempting to connect:
connect success
Call application rebind_proc
ldap_sasl_bind_s
ldap_sasl_bind
wait4msg ld 0x7fb9c4000ea0 msgid 116 (infinite timeout)
wait4msg continue ld 0x7fb9c4000ea0 msgid 116 all 1
** ld 0x7fb9c4000ea0 Connections:
ldap_send_initial_request
ldap_send_server_request
ber_scanf fmt ({it) ber:
ber_scanf fmt ({i) ber:
ber_flush2: 87 bytes to sd 12
ldap_write: want=87, written=87
  0000:  30 55 02 01 76 60 50 02  01 03 04 3e 63 6e 3d 6f   0U..v`P....>cn=o
  0010:  70 65 6e 6c 64 61 70 63  6f 6e 6e 65 63 74 2c 6f   penldapconnect,o
  0020:  75 3d 6f 70 65 6e 6c 64  61 70 2c 6f 75 3d 62 65   u=openldap,ou=be
  0030:  72 65 63 68 74 69 67 75  6e 67 65 6e 2c 64 63 3d   rechtigungen,dc=
  0040:  62 67 68 77 2c 64 63 3d  64 65 80 0b 24 23 63 6f   corp,dc=de..$#co
  0050:  6e 6e 65 63 74 24 31                               nnect$1
ldap_result ld 0x7fb9c4000ea0 msgid 118
* host: DomainDnsZones.corp.de  port: 0
  refcnt: 2  status: Connected
  last used: Tue May 16 10:11:22 2017
  rebind in progress
    queue is empty

* host: ForestDnsZones.corp.de  port: 0
  refcnt: 3  status: Connected
  last used: Tue May 16 10:11:22 2017
  rebind in progress
    queue is empty

* host: ldap.corp.de  port: 389  (default)
  refcnt: 4  status: Connected
  last used: Tue May 16 10:11:22 2017


** ld 0x7fb9c4000ea0 Outstanding Requests:
* msgid 118,  origid 118, status InProgress
   outstanding referrals 0, parent count 0
* msgid 116,  origid 116, status InProgress
   outstanding referrals 0, parent count 0
* msgid 115,  origid 115, status InProgress
   outstanding referrals 0, parent count 0
* msgid 112,  origid 112, status InProgress
   outstanding referrals 2, parent count 0
  ld 0x7fb9c4000ea0 request count 4 (abandoned 0)
** ld 0x7fb9c4000ea0 Response Queue:
   Empty
  ld 0x7fb9c4000ea0 response count 0
ldap_chkResponseList ld 0x7fb9c4000ea0 msgid 116 all 1
ldap_chkResponseList returns ld 0x7fb9c4000ea0 NULL
ldap_int_select
read1msg: ld 0x7fb9c4000ea0 msgid 116 all 1
ber_get_next
ldap_read: want=8, got=8
  0000:  30 84 00 00 00 a8 02 01                            0.......
ldap_read: want=166, got=166
  0000:  73 65 84 00 00 00 9f 0a  01 01 04 00 04 84 00 00   se..............
  0010:  00 94 30 30 30 30 30 34  44 43 3a 20 4c 64 61 70   ..000004DC: Ldap
  0020:  45 72 72 3a 20 44 53 49  44 2d 30 43 30 39 30 37   Err: DSID-0C0907
  0030:  35 32 2c 20 63 6f 6d 6d  65 6e 74 3a 20 49 6e 20   52, comment: In
  0040:  6f 72 64 65 72 20 74 6f  20 70 65 72 66 6f 72 6d   order to perform
  0050:  20 74 68 69 73 20 6f 70  65 72 61 74 69 6f 6e 20    this operation
  0060:  61 20 73 75 63 63 65 73  73 66 75 6c 20 62 69 6e   a successful bin
  0070:  64 20 6d 75 73 74 20 62  65 20 63 6f 6d 70 6c 65   d must be comple
  0080:  74 65 64 20 6f 6e 20 74  68 65 20 63 6f 6e 6e 65   ted on the conne
  0090:  63 74 69 6f 6e 2e 2c 20  64 61 74 61 20 30 2c 20   ction., data 0,
  00a0:  76 32 35 38 30 00                                  v2580.
ber_get_next: tag 0x30 len 168 contents:
read1msg: ld 0x7fb9c4000ea0 msgid 115 message type search-result
ber_scanf fmt ({eAA) ber:
ldap_chase_referrals
read1msg:  V2 referral chased, mark request completed, id = 115
read1msg: ld 0x7fb9c4000ea0 0 new referrals
read1msg:  mark request completed, ld 0x7fb9c4000ea0 msgid 115
request done: ld 0x7fb9c4000ea0 msgid 115
res_errno: 1, res_error: <000004DC: LdapErr: DSID-0C090752, comment: In order to perform this operation a successful bind must be completed on the connection., data 0, v2580>, res_matched: <>
ldap_free_request (origid 115, msgid 115)
read1msg: ld 0x7fb9c4000ea0 msgid 116 all 1
ber_get_next
ldap_read: want=8, got=8
  0000:  30 84 00 00 00 38 02 01                            0....8..
ldap_read: want=54, got=54
  0000:  70 73 84 00 00 00 2f 04  2d 6c 64 61 70 3a 2f 2f   ps..../.-ldap://
  0010:  62 67 68 77 2e 64 65 2f  43 4e 3d 43 6f 6e 66 69   corp.de/CN=Confi
  0020:  67 75 72 61 74 69 6f 6e  2c 44 43 3d 62 67 68 77   guration,DC=corp
  0030:  2c 44 43 3d 64 65                                  ,DC=de
ber_get_next: tag 0x30 len 56 contents:
read1msg: ld 0x7fb9c4000ea0 msgid 112 message type search-reference
ber_scanf fmt ({v}) ber:
ldap_chase_v3referrals
ldap_url_parse_ext(ldap://corp.de/CN=Configuration,DC=corp,DC=de)
re_encode_request: new msgid 119, new dn <CN=Configuration,DC=corp,DC=de>
ber_scanf fmt ({it) ber:
ber_scanf fmt ({me) ber:
re_encode_request new request is:
ldap_chase_v3referral: msgid 112, url "ldap://corp.de/CN=Configuration,DC=corp,DC=de"
ldap_send_server_request
ldap_new_connection 0 1 1
ldap_int_open_connection
ldap_connect_to_host: TCP corp.de:389
ldap_new_socket: 13
ldap_prepare_socket: 13
ldap_connect_to_host: Trying 10.30.0.90:389
ldap_pvt_connect: fd: 13 tm: -1 async: 0
attempting to connect:
connect success
Call application rebind_proc
ldap_sasl_bind_s
ldap_sasl_bind
ldap_send_initial_request
ldap_send_server_request
ber_scanf fmt ({it) ber:
ber_scanf fmt ({i) ber:
ber_flush2: 87 bytes to sd 13
ldap_write: want=87, written=87
  0000:  30 55 02 01 78 60 50 02  01 03 04 3e 63 6e 3d 6f   0U..x`P....>cn=o
  0010:  70 65 6e 6c 64 61 70 63  6f 6e 6e 65 63 74 2c 6f   penldapconnect,o
  0020:  75 3d 6f 70 65 6e 6c 64  61 70 2c 6f 75 3d 62 65   u=openldap,ou=be
  0030:  72 65 63 68 74 69 67 75  6e 67 65 6e 2c 64 63 3d   rechtigungen,dc=
  0040:  62 67 68 77 2c 64 63 3d  64 65 80 0b 24 23 63 6f   corp,dc=de..$#co
  0050:  6e 6e 65 63 74 24 31                               nnect$1
ldap_result ld 0x7fb9c4000ea0 msgid 120
wait4msg ld 0x7fb9c4000ea0 msgid 120 (infinite timeout)
wait4msg continue ld 0x7fb9c4000ea0 msgid 120 all 1
** ld 0x7fb9c4000ea0 Connections:
* host: corp.de  port: 0
  refcnt: 2  status: Connected
  last used: Tue May 16 10:11:22 2017
  rebind in progress
    queue is empty

* host: DomainDnsZones.corp.de  port: 0
  refcnt: 2  status: Connected
  last used: Tue May 16 10:11:22 2017
  rebind in progress
    queue is empty

* host: ForestDnsZones.corp.de  port: 0
  refcnt: 2  status: Connected
  last used: Tue May 16 10:11:22 2017
  rebind in progress
    queue is empty

* host: ldap.corp.de  port: 389  (default)
  refcnt: 5  status: Connected
  last used: Tue May 16 10:11:22 2017


** ld 0x7fb9c4000ea0 Outstanding Requests:
* msgid 120,  origid 120, status InProgress
   outstanding referrals 0, parent count 0
* msgid 118,  origid 118, status InProgress
   outstanding referrals 0, parent count 0
* msgid 116,  origid 116, status InProgress
   outstanding referrals 0, parent count 0
* msgid 112,  origid 112, status InProgress
   outstanding referrals 3, parent count 0
  ld 0x7fb9c4000ea0 request count 4 (abandoned 0)
** ld 0x7fb9c4000ea0 Response Queue:
* msgid 115,  type 101
  ld 0x7fb9c4000ea0 response count 1
ldap_chkResponseList ld 0x7fb9c4000ea0 msgid 120 all 1
ldap_chkResponseList returns ld 0x7fb9c4000ea0 NULL
ldap_int_select
read1msg: ld 0x7fb9c4000ea0 msgid 120 all 1
ber_get_next
ldap_read: want=8, got=8
  0000:  30 84 00 00 00 10 02 01                            0.......
ldap_read: want=14, got=14
  0000:  76 61 84 00 00 00 07 0a  01 00 04 00 04 00         va............
ber_get_next: tag 0x30 len 16 contents:
read1msg: ld 0x7fb9c4000ea0 msgid 118 message type bind
ber_scanf fmt ({eAA) ber:
read1msg: ld 0x7fb9c4000ea0 0 new referrals
read1msg:  mark request completed, ld 0x7fb9c4000ea0 msgid 118
request done: ld 0x7fb9c4000ea0 msgid 118
res_errno: 0, res_error: <>, res_matched: <>
ldap_free_request (origid 118, msgid 118)
read1msg: ld 0x7fb9c4000ea0 msgid 120 all 1
ber_get_next
ldap_read: want=8, got=8
  0000:  30 84 00 00 00 10 02 01                            0.......
ldap_read: want=14, got=14
  0000:  74 61 84 00 00 00 07 0a  01 00 04 00 04 00         ta............
ber_get_next: tag 0x30 len 16 contents:
read1msg: ld 0x7fb9c4000ea0 msgid 116 message type bind
ber_scanf fmt ({eAA) ber:
read1msg: ld 0x7fb9c4000ea0 0 new referrals
read1msg:  mark request completed, ld 0x7fb9c4000ea0 msgid 116
request done: ld 0x7fb9c4000ea0 msgid 116
res_errno: 0, res_error: <>, res_matched: <>
ldap_free_request (origid 116, msgid 116)
read1msg: ld 0x7fb9c4000ea0 msgid 120 all 1
ber_get_next
ldap_read: want=8, got=8
  0000:  30 84 00 00 00 41 02 01                            0....A..
ldap_read: want=63, got=63
  0000:  70 65 84 00 00 00 07 0a  01 00 04 00 04 00 a0 84   pe..............
  0010:  00 00 00 2b 30 84 00 00  00 25 04 16 31 2e 32 2e   ...+0....%..1.2.
  0020:  38 34 30 2e 31 31 33 35  35 36 2e 31 2e 34 2e 33   840.113556.1.4.3
  0030:  31 39 04 0b 30 84 00 00  00 05 02 01 00 04 00      19..0..........
ber_get_next: tag 0x30 len 65 contents:
read1msg: ld 0x7fb9c4000ea0 msgid 112 message type search-result
ber_scanf fmt ({eAA) ber:
read1msg: ld 0x7fb9c4000ea0 0 new referrals
read1msg:  mark request completed, ld 0x7fb9c4000ea0 msgid 112
wait4msg continue ld 0x7fb9c4000ea0 msgid 120 all 1
** ld 0x7fb9c4000ea0 Connections:
* host: corp.de  port: 0
  refcnt: 2  status: Connected
  last used: Tue May 16 10:11:22 2017
  rebind in progress
    queue is empty

* host: DomainDnsZones.corp.de  port: 0
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017
  rebind in progress
    queue is empty

* host: ForestDnsZones.corp.de  port: 0
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017
  rebind in progress
    queue is empty

* host: ldap.corp.de  port: 389  (default)
  refcnt: 4  status: Connected
  last used: Tue May 16 10:11:22 2017


** ld 0x7fb9c4000ea0 Outstanding Requests:
* msgid 120,  origid 120, status InProgress
   outstanding referrals 0, parent count 0
* msgid 112,  origid 112, status RequestCompleted
   outstanding referrals 3, parent count 0
  ld 0x7fb9c4000ea0 request count 2 (abandoned 0)
** ld 0x7fb9c4000ea0 Response Queue:
* msgid 116,  type 97
* msgid 118,  type 97
* msgid 115,  type 101
  ld 0x7fb9c4000ea0 response count 3
ldap_chkResponseList ld 0x7fb9c4000ea0 msgid 120 all 1
ldap_chkResponseList returns ld 0x7fb9c4000ea0 NULL
ldap_int_select
read1msg: ld 0x7fb9c4000ea0 msgid 120 all 1
ber_get_next
ldap_read: want=8, got=8
  0000:  30 84 00 00 00 10 02 01                            0.......
ldap_read: want=14, got=14
  0000:  78 61 84 00 00 00 07 0a  01 00 04 00 04 00         xa............
ber_get_next: tag 0x30 len 16 contents:
read1msg: ld 0x7fb9c4000ea0 msgid 120 message type bind
ber_scanf fmt ({eAA) ber:
read1msg: ld 0x7fb9c4000ea0 0 new referrals
read1msg:  mark request completed, ld 0x7fb9c4000ea0 msgid 120
request done: ld 0x7fb9c4000ea0 msgid 120
res_errno: 0, res_error: <>, res_matched: <>
ldap_free_request (origid 120, msgid 120)
ldap_parse_result
ber_scanf fmt ({iAA) ber:
ber_scanf fmt (}) ber:
ldap_msgfree
ber_scanf fmt ({it) ber:
ber_scanf fmt ({) ber:
ber_flush2: 311 bytes to sd 13
ldap_write: want=311, written=311
  0000:  30 82 01 33 02 01 77 63  82 01 2c 04 1e 43 4e 3d   0..3..wc..,..CN=
  0010:  43 6f 6e 66 69 67 75 72  61 74 69 6f 6e 2c 44 43   Configuration,DC
  0020:  3d 62 67 68 77 2c 44 43  3d 64 65 0a 01 02 0a 01   =corp,DC=de.....
  0030:  00 02 02 01 f4 02 01 0a  01 01 00 a0 81 c6 a3 14   ................
  0040:  04 0b 6f 62 6a 65 63 74  43 6c 61 73 73 04 05 67   ..objectClass..g
  0050:  72 6f 75 70 a1 81 87 a3  15 04 09 6d 65 6d 62 65   roup.......membe
  0060:  72 55 69 64 04 08 50 34  30 30 33 34 37 32 a3 6e   rUid..P4003472.n
  0070:  04 06 6d 65 6d 62 65 72  04 64 63 6e 3d 6d 69 6c   ..member.dcn=mil
  0080:  5c 32 43 20 61 72 74 65  6d 2c 6f 75 3d 64 6d 73   \2C artem,ou=dms
  0090:  2d 61 64 6d 69 6e 69 73  74 72 61 74 69 6f 6e 2c   -administration,
  00a0:  6f 75 3d 64 69 20 62 6f  6e 6e 2c 6f 75 3d 69 74   ou=di bonn,ou=it
  00b0:  2c 6f 75 3d 62 65 6e 75  74 7a 65 72 20 70 72 6f   ,ou=benutzer pro
  00c0:  64 75 6b 74 69 6f 6e 73  75 6d 67 65 62 75 6e 67   duktionsumgebung
  00d0:  2c 64 63 3d 62 67 68 77  2c 64 63 3d 64 65 a0 24   ,dc=corp,dc=de.$
  00e0:  a3 17 04 0e 4f 42 4a 45  43 54 43 41 54 45 47 4f   ....OBJECTCATEGO
  00f0:  52 59 04 05 67 72 6f 75  70 87 09 67 69 64 4e 75   RY..group..gidNu
  0100:  6d 62 65 72 30 0b 04 09  67 69 64 4e 75 6d 62 65   mber0...gidNumbe
  0110:  72 a0 24 30 22 04 16 31  2e 32 2e 38 34 30 2e 31   r.$0"..1.2.840.1
  0120:  31 33 35 35 36 2e 31 2e  34 2e 33 31 39 04 08 30   13556.1.4.319..0
  0130:  06 02 02 03 e8 04 00                               .......
wait4msg continue ld 0x7fb9c4000ea0 msgid 116 all 1
** ld 0x7fb9c4000ea0 Connections:
* host: corp.de  port: 0
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017


* host: DomainDnsZones.corp.de  port: 0
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017
  rebind in progress
    queue is empty

* host: ForestDnsZones.corp.de  port: 0
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017
  rebind in progress
    queue is empty

* host: ldap.corp.de  port: 389  (default)
  refcnt: 3  status: Connected
  last used: Tue May 16 10:11:22 2017


** ld 0x7fb9c4000ea0 Outstanding Requests:
* msgid 119,  origid 112, status InProgress
   outstanding referrals 0, parent count 1
* msgid 112,  origid 112, status RequestCompleted
   outstanding referrals 3, parent count 1
  ld 0x7fb9c4000ea0 request count 2 (abandoned 0)
** ld 0x7fb9c4000ea0 Response Queue:
* msgid 112,  type 115
* msgid 116,  type 97
* msgid 118,  type 97
* msgid 115,  type 101
  ld 0x7fb9c4000ea0 response count 4
ldap_chkResponseList ld 0x7fb9c4000ea0 msgid 116 all 1
ldap_chkResponseList returns ld 0x7fb9c4000ea0 msgid 116, type 0x61
ldap_parse_result
ber_scanf fmt ({iAA) ber:
ber_scanf fmt (}) ber:
ldap_msgfree
ber_scanf fmt ({it) ber:
ber_scanf fmt ({) ber:
ber_flush2: 312 bytes to sd 11
ldap_write: want=312, written=312
  0000:  30 82 01 34 02 01 71 63  82 01 2d 04 1f 44 43 3d   0..4..qc..-..DC=
  0010:  46 6f 72 65 73 74 44 6e  73 5a 6f 6e 65 73 2c 44   ForestDnsZones,D
  0020:  43 3d 62 67 68 77 2c 44  43 3d 64 65 0a 01 02 0a   C=corp,DC=de....
  0030:  01 00 02 02 01 f4 02 01  0a 01 01 00 a0 81 c6 a3   ................
  0040:  14 04 0b 6f 62 6a 65 63  74 43 6c 61 73 73 04 05   ...objectClass..
  0050:  67 72 6f 75 70 a1 81 87  a3 15 04 09 6d 65 6d 62   group.......memb
  0060:  65 72 55 69 64 04 08 50  34 30 30 33 34 37 32 a3   erUid..P4003472.
  0070:  6e 04 06 6d 65 6d 62 65  72 04 64 63 6e 3d 6d 69   n..member.dcn=mi
  0080:  6c 5c 32 43 20 61 72 74  65 6d 2c 6f 75 3d 64 6d   l\2C artem,ou=dm
  0090:  73 2d 61 64 6d 69 6e 69  73 74 72 61 74 69 6f 6e   s-administration
  00a0:  2c 6f 75 3d 64 69 20 62  6f 6e 6e 2c 6f 75 3d 69   ,ou=di bonn,ou=i
  00b0:  74 2c 6f 75 3d 62 65 6e  75 74 7a 65 72 20 70 72   t,ou=benutzer pr
  00c0:  6f 64 75 6b 74 69 6f 6e  73 75 6d 67 65 62 75 6e   oduktionsumgebun
  00d0:  67 2c 64 63 3d 62 67 68  77 2c 64 63 3d 64 65 a0   g,dc=corp,dc=de.
  00e0:  24 a3 17 04 0e 4f 42 4a  45 43 54 43 41 54 45 47   $....OBJECTCATEG
  00f0:  4f 52 59 04 05 67 72 6f  75 70 87 09 67 69 64 4e   ORY..group..gidN
  0100:  75 6d 62 65 72 30 0b 04  09 67 69 64 4e 75 6d 62   umber0...gidNumb
  0110:  65 72 a0 24 30 22 04 16  31 2e 32 2e 38 34 30 2e   er.$0"..1.2.840.
  0120:  31 31 33 35 35 36 2e 31  2e 34 2e 33 31 39 04 08   113556.1.4.319..
  0130:  30 06 02 02 03 e8 04 00                            0.......
ber_scanf fmt ({v) ber:
ber_scanf fmt (}) ber:
ldap_msgfree
591ab42a => send_search_reference: dn="(null)"
ber_flush2: 70 bytes to sd 9
ldap_write: want=70, written=70
  0000:  30 44 02 01 6a 73 3f 04  3d 6c 64 61 70 3a 2f 2f   0D..js?.=ldap://
  0010:  46 6f 72 65 73 74 44 6e  73 5a 6f 6e 65 73 2e 62   ForestDnsZones.b
  0020:  67 68 77 2e 64 65 2f 44  43 3d 46 6f 72 65 73 74   ghw.de/DC=Forest
  0030:  44 6e 73 5a 6f 6e 65 73  2c 44 43 3d 62 67 68 77   DnsZones,DC=corp
  0040:  2c 44 43 3d 64 65                                  ,DC=de
591ab42a <= send_search_reference
ldap_result ld 0x7fb9c4000ea0 msgid 112
wait4msg ld 0x7fb9c4000ea0 msgid 112 (timeout 100000 usec)
wait4msg continue ld 0x7fb9c4000ea0 msgid 112 all 0
** ld 0x7fb9c4000ea0 Connections:
* host: corp.de  port: 0
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017


* host: DomainDnsZones.corp.de  port: 0
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017
  rebind in progress
    queue is empty

* host: ForestDnsZones.corp.de  port: 0
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017


* host: ldap.corp.de  port: 389  (default)
  refcnt: 2  status: Connected
  last used: Tue May 16 10:11:22 2017


** ld 0x7fb9c4000ea0 Outstanding Requests:
* msgid 113,  origid 112, status InProgress
   outstanding referrals 0, parent count 2
* msgid 119,  origid 112, status InProgress
   outstanding referrals 0, parent count 1
* msgid 112,  origid 112, status RequestCompleted
   outstanding referrals 3, parent count 2
  ld 0x7fb9c4000ea0 request count 3 (abandoned 0)
** ld 0x7fb9c4000ea0 Response Queue:
* msgid 112,  type 115
* msgid 118,  type 97
* msgid 115,  type 101
  ld 0x7fb9c4000ea0 response count 3
ldap_chkResponseList ld 0x7fb9c4000ea0 msgid 112 all 0
ldap_chkResponseList returns ld 0x7fb9c4000ea0 msgid 112, type 0x73
ber_scanf fmt ({v) ber:
ber_scanf fmt (}) ber:
ldap_msgfree
591ab42a => send_search_reference: dn="(null)"
ber_flush2: 54 bytes to sd 9
ldap_write: want=54, written=54
  0000:  30 34 02 01 6a 73 2f 04  2d 6c 64 61 70 3a 2f 2f   04..js/.-ldap://
  0010:  62 67 68 77 2e 64 65 2f  43 4e 3d 43 6f 6e 66 69   corp.de/CN=Confi
  0020:  67 75 72 61 74 69 6f 6e  2c 44 43 3d 62 67 68 77   guration,DC=corp
  0030:  2c 44 43 3d 64 65                                  ,DC=de
591ab42a <= send_search_reference
ldap_result ld 0x7fb9c4000ea0 msgid 112
wait4msg ld 0x7fb9c4000ea0 msgid 112 (timeout 100000 usec)
wait4msg continue ld 0x7fb9c4000ea0 msgid 112 all 0
** ld 0x7fb9c4000ea0 Connections:
* host: corp.de  port: 0
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017


* host: DomainDnsZones.corp.de  port: 0
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017
  rebind in progress
    queue is empty

* host: ForestDnsZones.corp.de  port: 0
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017


* host: ldap.corp.de  port: 389  (default)
  refcnt: 2  status: Connected
  last used: Tue May 16 10:11:22 2017


** ld 0x7fb9c4000ea0 Outstanding Requests:
* msgid 113,  origid 112, status InProgress
   outstanding referrals 0, parent count 2
* msgid 119,  origid 112, status InProgress
  outstanding referrals 0, parent count 1
* msgid 112,  origid 112, status RequestCompleted
   outstanding referrals 3, parent count 2
  ld 0x7fb9c4000ea0 request count 3 (abandoned 0)
** ld 0x7fb9c4000ea0 Response Queue:
* msgid 118,  type 97
* msgid 115,  type 101
  ld 0x7fb9c4000ea0 response count 2
ldap_chkResponseList ld 0x7fb9c4000ea0 msgid 112 all 0
ldap_chkResponseList returns ld 0x7fb9c4000ea0 NULL
ldap_int_select
read1msg: ld 0x7fb9c4000ea0 msgid 112 all 0
ber_get_next
ldap_read: want=8, got=8
  0000:  30 84 00 00 00 42 02 01                            0....B..
ldap_read: want=64, got=64
  0000:  77 73 84 00 00 00 39 04  37 6c 64 61 70 3a 2f 2f   ws....9.7ldap://
  0010:  62 67 68 77 2e 64 65 2f  43 4e 3d 53 63 68 65 6d   corp.de/CN=Schem
  0020:  61 2c 43 4e 3d 43 6f 6e  66 69 67 75 72 61 74 69   a,CN=Configurati
  0030:  6f 6e 2c 44 43 3d 62 67  68 77 2c 44 43 3d 64 65   on,DC=corp,DC=de
ber_get_next: tag 0x30 len 66 contents:
read1msg: ld 0x7fb9c4000ea0 msgid 119 message type search-reference
ber_scanf fmt ({v}) ber:
ldap_chase_v3referrals
ldap_url_parse_ext(ldap://corp.de/CN=Schema,CN=Configuration,DC=corp,DC=de)
re_encode_request: new msgid 121, new dn <CN=Schema,CN=Configuration,DC=corp,DC=de>
ber_scanf fmt ({it) ber:
ber_scanf fmt ({me) ber:
re_encode_request new request is:
ldap_chase_v3referral: msgid 119, url "ldap://corp.de/CN=Schema,CN=Configuration,DC=corp,DC=de"
ldap_send_server_request
ber_scanf fmt ({it) ber:
ber_scanf fmt ({) ber:
ber_flush2: 321 bytes to sd 13
ldap_write: want=321, written=321
  0000:  30 82 01 3d 02 01 79 63  82 01 36 04 28 43 4e 3d   0..=..yc..6.(CN=
  0010:  53 63 68 65 6d 61 2c 43  4e 3d 43 6f 6e 66 69 67   Schema,CN=Config
  0020:  75 72 61 74 69 6f 6e 2c  44 43 3d 62 67 68 77 2c   uration,DC=corp,
  0030:  44 43 3d 64 65 0a 01 02  0a 01 00 02 02 01 f4 02   DC=de...........
  0040:  01 0a 01 01 00 a0 81 c6  a3 14 04 0b 6f 62 6a 65   ............obje
  0050:  63 74 43 6c 61 73 73 04  05 67 72 6f 75 70 a1 81   ctClass..group..
  0060:  87 a3 15 04 09 6d 65 6d  62 65 72 55 69 64 04 08   .....memberUid..
  0070:  50 34 30 30 33 34 37 32  a3 6e 04 06 6d 65 6d 62   P4003472.n..memb
  0080:  65 72 04 64 63 6e 3d 6d  69 6c 5c 32 43 20 61 72   er.dcn=mil\2C ar
  0090:  74 65 6d 2c 6f 75 3d 64  6d 73 2d 61 64 6d 69 6e   tem,ou=dms-admin
  00a0:  69 73 74 72 61 74 69 6f  6e 2c 6f 75 3d 64 69 20   istration,ou=di
  00b0:  62 6f 6e 6e 2c 6f 75 3d  69 74 2c 6f 75 3d 62 65   bonn,ou=it,ou=be
  00c0:  6e 75 74 7a 65 72 20 70  72 6f 64 75 6b 74 69 6f   nutzer produktio
  00d0:  6e 73 75 6d 67 65 62 75  6e 67 2c 64 63 3d 62 67   nsumgebung,dc=bg
  00e0:  68 77 2c 64 63 3d 64 65  a0 24 a3 17 04 0e 4f 42   hw,dc=de.$....OB
  00f0:  4a 45 43 54 43 41 54 45  47 4f 52 59 04 05 67 72   JECTCATEGORY..gr
  0100:  6f 75 70 87 09 67 69 64  4e 75 6d 62 65 72 30 0b   oup..gidNumber0.
  0110:  04 09 67 69 64 4e 75 6d  62 65 72 a0 24 30 22 04   ..gidNumber.$0".
  0120:  16 31 2e 32 2e 38 34 30  2e 31 31 33 35 35 36 2e   .1.2.840.113556.
  0130:  31 2e 34 2e 33 31 39 04  08 30 06 02 02 03 e8 04   1.4.319..0......
  0140:  00                                                 .
read1msg:  search ref chased, mark request chasing refs, id = 119
ber_scanf fmt ({v) ber:
ber_scanf fmt (}) ber:
ldap_msgfree
591ab42a => send_search_reference: dn="(null)"
ber_flush2: 64 bytes to sd 9
ldap_write: want=64, written=64
  0000:  30 3e 02 01 6a 73 39 04  37 6c 64 61 70 3a 2f 2f   0>..js9.7ldap://
  0010:  62 67 68 77 2e 64 65 2f  43 4e 3d 53 63 68 65 6d   corp.de/CN=Schem
  0020:  61 2c 43 4e 3d 43 6f 6e  66 69 67 75 72 61 74 69   a,CN=Configurati
  0030:  6f 6e 2c 44 43 3d 62 67  68 77 2c 44 43 3d 64 65   on,DC=corp,DC=de
591ab42a <= send_search_reference
ldap_result ld 0x7fb9c4000ea0 msgid 112
wait4msg ld 0x7fb9c4000ea0 msgid 112 (timeout 100000 usec)
wait4msg continue ld 0x7fb9c4000ea0 msgid 112 all 0
** ld 0x7fb9c4000ea0 Connections:
* host: corp.de  port: 0
  refcnt: 2  status: Connected
  last used: Tue May 16 10:11:22 2017


* host: DomainDnsZones.corp.de  port: 0
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017
  rebind in progress
    queue is empty

* host: ForestDnsZones.corp.de  port: 0
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017


* host: ldap.corp.de  port: 389  (default)
  refcnt: 2  status: Connected
  last used: Tue May 16 10:11:22 2017


** ld 0x7fb9c4000ea0 Outstanding Requests:
* msgid 121,  origid 112, status InProgress
   outstanding referrals 0, parent count 3
* msgid 113,  origid 112, status InProgress
   outstanding referrals 0, parent count 2
* msgid 119,  origid 112, status ChasingRefs
   outstanding referrals 0, parent count 1
* msgid 112,  origid 112, status RequestCompleted
   outstanding referrals 4, parent count 3
  ld 0x7fb9c4000ea0 request count 4 (abandoned 0)
** ld 0x7fb9c4000ea0 Response Queue:
* msgid 118,  type 97
* msgid 115,  type 101
  ld 0x7fb9c4000ea0 response count 2
ldap_chkResponseList ld 0x7fb9c4000ea0 msgid 112 all 0
ldap_chkResponseList returns ld 0x7fb9c4000ea0 NULL
ldap_int_select
read1msg: ld 0x7fb9c4000ea0 msgid 112 all 0
ber_get_next
ldap_read: want=8, got=8
  0000:  30 84 00 00 00 41 02 01                            0....A..
ldap_read: want=63, got=63
  0000:  77 65 84 00 00 00 07 0a  01 00 04 00 04 00 a0 84   we..............
  0010:  00 00 00 2b 30 84 00 00  00 25 04 16 31 2e 32 2e   ...+0....%..1.2.
  0020:  38 34 30 2e 31 31 33 35  35 36 2e 31 2e 34 2e 33   840.113556.1.4.3
  0030:  31 39 04 0b 30 84 00 00  00 05 02 01 00 04 00      19..0..........
ber_get_next: tag 0x30 len 65 contents:
read1msg: ld 0x7fb9c4000ea0 msgid 119 message type search-result
ber_scanf fmt ({eAA) ber:
read1msg: ld 0x7fb9c4000ea0 0 new referrals
read1msg:  mark request completed, ld 0x7fb9c4000ea0 msgid 119
merged parent (id 112) error info:  result errno 0, error <>, matched <>
wait4msg ld 0x7fb9c4000ea0 0 s 99738 us to go
wait4msg continue ld 0x7fb9c4000ea0 msgid 112 all 0
** ld 0x7fb9c4000ea0 Connections:
* host: corp.de  port: 0
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017


* host: DomainDnsZones.corp.de  port: 0
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017
  rebind in progress
    queue is empty

* host: ForestDnsZones.corp.de  port: 0
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017


* host: ldap.corp.de  port: 389  (default)
  refcnt: 2  status: Connected
  last used: Tue May 16 10:11:22 2017


** ld 0x7fb9c4000ea0 Outstanding Requests:
* msgid 121,  origid 112, status InProgress
   outstanding referrals 0, parent count 3
* msgid 113,  origid 112, status InProgress
   outstanding referrals 0, parent count 2
* msgid 119,  origid 112, status RequestCompleted
   outstanding referrals 0, parent count 1
* msgid 112,  origid 112, status RequestCompleted
   outstanding referrals 3, parent count 3
  ld 0x7fb9c4000ea0 request count 4 (abandoned 0)
** ld 0x7fb9c4000ea0 Response Queue:
* msgid 118,  type 97
* msgid 115,  type 101
  ld 0x7fb9c4000ea0 response count 2
ldap_chkResponseList ld 0x7fb9c4000ea0 msgid 112 all 0
ldap_chkResponseList returns ld 0x7fb9c4000ea0 NULL
ldap_int_select
read1msg: ld 0x7fb9c4000ea0 msgid 112 all 0
ber_get_next
ldap_read: want=8, got=8
  0000:  30 84 00 00 00 41 02 01                            0....A..
ldap_read: want=63, got=63
  0000:  71 65 84 00 00 00 07 0a  01 00 04 00 04 00 a0 84   qe..............
  0010:  00 00 00 2b 30 84 00 00  00 25 04 16 31 2e 32 2e   ...+0....%..1.2.
  0020:  38 34 30 2e 31 31 33 35  35 36 2e 31 2e 34 2e 33   840.113556.1.4.3
  0030:  31 39 04 0b 30 84 00 00  00 05 02 01 00 04 00      19..0..........
ber_get_next: tag 0x30 len 65 contents:
read1msg: ld 0x7fb9c4000ea0 msgid 113 message type search-result
ber_scanf fmt ({eAA) ber:
read1msg: ld 0x7fb9c4000ea0 0 new referrals
read1msg:  mark request completed, ld 0x7fb9c4000ea0 msgid 113
merged parent (id 112) error info:  result errno 0, error <>, matched <>
ldap_free_connection 0 1
ldap_send_unbind
ber_flush2: 7 bytes to sd 11
ldap_write: want=7, written=7
  0000:  30 05 02 01 7a 42 00                               0...zB.
ldap_free_connection: actually freed
wait4msg ld 0x7fb9c4000ea0 0 s 99409 us to go
wait4msg continue ld 0x7fb9c4000ea0 msgid 112 all 0
** ld 0x7fb9c4000ea0 Connections:
* host: corp.de  port: 0
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017


* host: DomainDnsZones.corp.de  port: 0
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017
  rebind in progress
    queue is empty

* host: ldap.corp.de  port: 389  (default)
  refcnt: 2  status: Connected
  last used: Tue May 16 10:11:22 2017


** ld 0x7fb9c4000ea0 Outstanding Requests:
* msgid 121,  origid 112, status InProgress
   outstanding referrals 0, parent count 3
* msgid 113,  origid 112, status RequestCompleted
   outstanding referrals 0, parent count 2
* msgid 119,  origid 112, status RequestCompleted
   outstanding referrals 0, parent count 1
* msgid 112,  origid 112, status RequestCompleted
   outstanding referrals 2, parent count 3
  ld 0x7fb9c4000ea0 request count 4 (abandoned 0)
** ld 0x7fb9c4000ea0 Response Queue:
* msgid 118,  type 97
* msgid 115,  type 101
  ld 0x7fb9c4000ea0 response count 2
ldap_chkResponseList ld 0x7fb9c4000ea0 msgid 112 all 0
ldap_chkResponseList returns ld 0x7fb9c4000ea0 NULL
ldap_int_select
read1msg: ld 0x7fb9c4000ea0 msgid 112 all 0
ber_get_next
ldap_read: want=8, got=8
  0000:  30 84 00 00 00 41 02 01                            0....A..
ldap_read: want=63, got=63
  0000:  79 65 84 00 00 00 07 0a  01 00 04 00 04 00 a0 84   ye..............
  0010:  00 00 00 2b 30 84 00 00  00 25 04 16 31 2e 32 2e   ...+0....%..1.2.
  0020:  38 34 30 2e 31 31 33 35  35 36 2e 31 2e 34 2e 33   840.113556.1.4.3
  0030:  31 39 04 0b 30 84 00 00  00 05 02 01 00 04 00      19..0..........
ber_get_next: tag 0x30 len 65 contents:
read1msg: ld 0x7fb9c4000ea0 msgid 121 message type search-result
ber_scanf fmt ({eAA) ber:
read1msg: ld 0x7fb9c4000ea0 0 new referrals
read1msg:  mark request completed, ld 0x7fb9c4000ea0 msgid 121
merged parent (id 112) error info:  result errno 0, error <>, matched <>
ldap_free_connection 0 1
ldap_send_unbind
ber_flush2: 7 bytes to sd 13
ldap_write: want=7, written=7
  0000:  30 05 02 01 7b 42 00                               0...{B.
ldap_free_connection: actually freed
wait4msg ld 0x7fb9c4000ea0 0 s 99075 us to go
wait4msg continue ld 0x7fb9c4000ea0 msgid 112 all 0
** ld 0x7fb9c4000ea0 Connections:
* host: DomainDnsZones.corp.de  port: 0
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017
  rebind in progress
    queue is empty

* host: ldap.corp.de  port: 389  (default)
  refcnt: 2  status: Connected
  last used: Tue May 16 10:11:22 2017


** ld 0x7fb9c4000ea0 Outstanding Requests:
* msgid 121,  origid 112, status RequestCompleted
   outstanding referrals 0, parent count 3
* msgid 113,  origid 112, status RequestCompleted
   outstanding referrals 0, parent count 2
* msgid 119,  origid 112, status RequestCompleted
   outstanding referrals 0, parent count 1
* msgid 112,  origid 112, status RequestCompleted
   outstanding referrals 1, parent count 3
  ld 0x7fb9c4000ea0 request count 4 (abandoned 0)
** ld 0x7fb9c4000ea0 Response Queue:
* msgid 118,  type 97
* msgid 115,  type 101
  ld 0x7fb9c4000ea0 response count 2
ldap_chkResponseList ld 0x7fb9c4000ea0 msgid 112 all 0
ldap_chkResponseList returns ld 0x7fb9c4000ea0 NULL
ldap_int_select
wait4msg ld 0x7fb9c4000ea0 msgid 118 (infinite timeout)
wait4msg continue ld 0x7fb9c4000ea0 msgid 118 all 1
** ld 0x7fb9c4000ea0 Connections:
* host: DomainDnsZones.corp.de  port: 0
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017
  rebind in progress
    queue is empty

* host: ldap.corp.de  port: 389  (default)
  refcnt: 2  status: Connected
  last used: Tue May 16 10:11:22 2017


** ld 0x7fb9c4000ea0 Outstanding Requests:
* msgid 121,  origid 112, status RequestCompleted
   outstanding referrals 0, parent count 3
* msgid 113,  origid 112, status RequestCompleted
   outstanding referrals 0, parent count 2
* msgid 119,  origid 112, status RequestCompleted
   outstanding referrals 0, parent count 1
* msgid 112,  origid 112, status RequestCompleted
   outstanding referrals 1, parent count 3
  ld 0x7fb9c4000ea0 request count 4 (abandoned 0)
** ld 0x7fb9c4000ea0 Response Queue:
* msgid 118,  type 97
* msgid 115,  type 101
  ld 0x7fb9c4000ea0 response count 2
ldap_chkResponseList ld 0x7fb9c4000ea0 msgid 118 all 1
ldap_chkResponseList returns ld 0x7fb9c4000ea0 msgid 118, type 0x61
ldap_parse_result
ber_scanf fmt ({iAA) ber:
ber_scanf fmt (}) ber:
ldap_msgfree
ber_scanf fmt ({it) ber:
ber_scanf fmt ({) ber:
ber_flush2: 312 bytes to sd 12
ldap_write: want=312, written=312
  0000:  30 82 01 34 02 01 75 63  82 01 2d 04 1f 44 43 3d   0..4..uc..-..DC=
  0010:  44 6f 6d 61 69 6e 44 6e  73 5a 6f 6e 65 73 2c 44   DomainDnsZones,D
  0020:  43 3d 62 67 68 77 2c 44  43 3d 64 65 0a 01 02 0a   C=corp,DC=de....
  0030:  01 00 02 02 01 f4 02 01  0a 01 01 00 a0 81 c6 a3   ................
  0040:  14 04 0b 6f 62 6a 65 63  74 43 6c 61 73 73 04 05   ...objectClass..
  0050:  67 72 6f 75 70 a1 81 87  a3 15 04 09 6d 65 6d 62   group.......memb
  0060:  65 72 55 69 64 04 08 50  34 30 30 33 34 37 32 a3   erUid..P4003472.
  0070:  6e 04 06 6d 65 6d 62 65  72 04 64 63 6e 3d 6d 69   n..member.dcn=mi
  0080:  6c 5c 32 43 20 61 72 74  65 6d 2c 6f 75 3d 64 6d   l\2C artem,ou=dm
  0090:  73 2d 61 64 6d 69 6e 69  73 74 72 61 74 69 6f 6e   s-administration
  00a0:  2c 6f 75 3d 64 69 20 62  6f 6e 6e 2c 6f 75 3d 69   ,ou=di bonn,ou=i
  00b0:  74 2c 6f 75 3d 62 65 6e  75 74 7a 65 72 20 70 72   t,ou=benutzer pr
  00c0:  6f 64 75 6b 74 69 6f 6e  73 75 6d 67 65 62 75 6e   oduktionsumgebun
  00d0:  67 2c 64 63 3d 62 67 68  77 2c 64 63 3d 64 65 a0   g,dc=corp,dc=de.
  00e0:  24 a3 17 04 0e 4f 42 4a  45 43 54 43 41 54 45 47   $....OBJECTCATEG
  00f0:  4f 52 59 04 05 67 72 6f  75 70 87 09 67 69 64 4e   ORY..group..gidN
  0100:  75 6d 62 65 72 30 0b 04  09 67 69 64 4e 75 6d 62   umber0...gidNumb
  0110:  65 72 a0 24 30 22 04 16  31 2e 32 2e 38 34 30 2e   er.$0"..1.2.840.
  0120:  31 31 33 35 35 36 2e 31  2e 34 2e 33 31 39 04 08   113556.1.4.319..
  0130:  30 06 02 02 03 e8 04 00                            0.......
ldap_result ld 0x7fb9c4000ea0 msgid 112
wait4msg ld 0x7fb9c4000ea0 msgid 112 (timeout 100000 usec)
wait4msg continue ld 0x7fb9c4000ea0 msgid 112 all 0
** ld 0x7fb9c4000ea0 Connections:
* host: DomainDnsZones.corp.de  port: 0
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017


* host: ldap.corp.de  port: 389  (default)
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017


** ld 0x7fb9c4000ea0 Outstanding Requests:
* msgid 117,  origid 112, status InProgress
   outstanding referrals 0, parent count 4
* msgid 121,  origid 112, status RequestCompleted
   outstanding referrals 0, parent count 3
* msgid 113,  origid 112, status RequestCompleted
   outstanding referrals 0, parent count 2
* msgid 119,  origid 112, status RequestCompleted
   outstanding referrals 0, parent count 1
* msgid 112,  origid 112, status RequestCompleted
   outstanding referrals 1, parent count 4
  ld 0x7fb9c4000ea0 request count 5 (abandoned 0)
** ld 0x7fb9c4000ea0 Response Queue:
* msgid 112,  type 115
* msgid 115,  type 101
  ld 0x7fb9c4000ea0 response count 2
ldap_chkResponseList ld 0x7fb9c4000ea0 msgid 112 all 0
ldap_chkResponseList returns ld 0x7fb9c4000ea0 msgid 112, type 0x73
ber_scanf fmt ({v) ber:
ber_scanf fmt (}) ber:
ldap_msgfree
591ab42a => send_search_reference: dn="(null)"
ber_flush2: 70 bytes to sd 9
ldap_write: want=70, written=70
  0000:  30 44 02 01 6a 73 3f 04  3d 6c 64 61 70 3a 2f 2f   0D..js?.=ldap://
  0010:  44 6f 6d 61 69 6e 44 6e  73 5a 6f 6e 65 73 2e 62   DomainDnsZones.b
  0020:  67 68 77 2e 64 65 2f 44  43 3d 44 6f 6d 61 69 6e   ghw.de/DC=Domain
  0030:  44 6e 73 5a 6f 6e 65 73  2c 44 43 3d 62 67 68 77   DnsZones,DC=corp
  0040:  2c 44 43 3d 64 65                                  ,DC=de
591ab42a <= send_search_reference
ldap_result ld 0x7fb9c4000ea0 msgid 112
wait4msg ld 0x7fb9c4000ea0 msgid 112 (timeout 100000 usec)
wait4msg continue ld 0x7fb9c4000ea0 msgid 112 all 0
** ld 0x7fb9c4000ea0 Connections:
* host: DomainDnsZones.corp.de  port: 0
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017


* host: ldap.corp.de  port: 389  (default)
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017


** ld 0x7fb9c4000ea0 Outstanding Requests:
* msgid 117,  origid 112, status InProgress
   outstanding referrals 0, parent count 4
* msgid 121,  origid 112, status RequestCompleted
   outstanding referrals 0, parent count 3
* msgid 113,  origid 112, status RequestCompleted
   outstanding referrals 0, parent count 2
* msgid 119,  origid 112, status RequestCompleted
   outstanding referrals 0, parent count 1
* msgid 112,  origid 112, status RequestCompleted
   outstanding referrals 1, parent count 4
  ld 0x7fb9c4000ea0 request count 5 (abandoned 0)
** ld 0x7fb9c4000ea0 Response Queue:
* msgid 115,  type 101
  ld 0x7fb9c4000ea0 response count 1
ldap_chkResponseList ld 0x7fb9c4000ea0 msgid 112 all 0
ldap_chkResponseList returns ld 0x7fb9c4000ea0 NULL
ldap_int_select
ldap_result ld 0x7fb9c4000ea0 msgid 115
read1msg: ld 0x7fb9c4000ea0 msgid 112 all 0
ber_get_next
ldap_read: want=8, got=8
  0000:  30 84 00 00 00 41 02 01                            0....A..
ldap_read: want=63, got=63
  0000:  75 65 84 00 00 00 07 0a  01 00 04 00 04 00 a0 84   ue..............
  0010:  00 00 00 2b 30 84 00 00  00 25 04 16 31 2e 32 2e   ...+0....%..1.2.
  0020:  38 34 30 2e 31 31 33 35  35 36 2e 31 2e 34 2e 33   840.113556.1.4.3
  0030:  31 39 04 0b 30 84 00 00  00 05 02 01 00 04 00      19..0..........
ber_get_next: tag 0x30 len 65 contents:
read1msg: ld 0x7fb9c4000ea0 msgid 117 message type search-result
ber_scanf fmt ({eAA) ber:
read1msg: ld 0x7fb9c4000ea0 0 new referrals
read1msg:  mark request completed, ld 0x7fb9c4000ea0 msgid 117
merged parent (id 112) error info:  result errno 0, error <>, matched <>
request done: ld 0x7fb9c4000ea0 msgid 112
res_errno: 0, res_error: <>, res_matched: <>
ldap_free_request (origid 112, msgid 112)
ldap_free_request (origid 112, msgid 117)
ldap_free_request (origid 112, msgid 121)
ldap_free_request (origid 112, msgid 113)
ldap_free_request (origid 112, msgid 119)
ldap_free_connection 0 1
ldap_send_unbind
ber_flush2: 7 bytes to sd 12
ldap_write: want=7, written=7
  0000:  30 05 02 01 7c 42 00                               0...|B.
ldap_free_connection: actually freed
ldap_parse_result
ber_scanf fmt ({iAA) ber:
ber_scanf fmt (}) ber:
ldap_msgfree
591ab42a send_ldap_result: conn=1051 op=55 p=3
591ab42a send_ldap_response: msgid=106 tag=101 err=0
ber_flush2: 14 bytes to sd 9
ldap_write: want=14, written=14
  0000:  30 0c 02 01 6a 65 07 0a  01 00 04 00 04 00         0...je........
wait4msg ld 0x7fb9c4000ea0 msgid 115 (timeout 100000 usec)
wait4msg continue ld 0x7fb9c4000ea0 msgid 115 all 0
** ld 0x7fb9c4000ea0 Connections:
* host: ldap.corp.de  port: 389  (default)
  refcnt: 1  status: Connected
  last used: Tue May 16 10:11:22 2017


** ld 0x7fb9c4000ea0 Outstanding Requests:
   Empty
  ld 0x7fb9c4000ea0 request count 0 (abandoned 0)
** ld 0x7fb9c4000ea0 Response Queue:
* msgid 115,  type 101
  ld 0x7fb9c4000ea0 response count 1
ldap_chkResponseList ld 0x7fb9c4000ea0 msgid 115 all 0
ldap_chkResponseList returns ld 0x7fb9c4000ea0 msgid 115, type 0x65
ldap_parse_result
ber_scanf fmt ({iAA) ber:
ber_scanf fmt (}) ber:
ldap_msgfree
591ab42a send_ldap_result: conn=1051 op=56 p=3
591ab42a send_ldap_response: msgid=107 tag=101 err=1
ber_flush2: 164 bytes to sd 9
ldap_write: want=164, written=164
  0000:  30 81 a1 02 01 6b 65 81  9b 0a 01 01 04 00 04 81   0....ke.........
  0010:  93 30 30 30 30 30 34 44  43 3a 20 4c 64 61 70 45   .000004DC: LdapE
  0020:  72 72 3a 20 44 53 49 44  2d 30 43 30 39 30 37 35   rr: DSID-0C09075
  0030:  32 2c 20 63 6f 6d 6d 65  6e 74 3a 20 49 6e 20 6f   2, comment: In o
  0040:  72 64 65 72 20 74 6f 20  70 65 72 66 6f 72 6d 20   rder to perform
  0050:  74 68 69 73 20 6f 70 65  72 61 74 69 6f 6e 20 61   this operation a
  0060:  20 73 75 63 63 65 73 73  66 75 6c 20 62 69 6e 64    successful bind
  0070:  20 6d 75 73 74 20 62 65  20 63 6f 6d 70 6c 65 74    must be complet
  0080:  65 64 20 6f 6e 20 74 68  65 20 63 6f 6e 6e 65 63   ed on the connec
  0090:  74 69 6f 6e 2e 2c 20 64  61 74 61 20 30 2c 20 76   tion., data 0, v
  00a0:  32 35 38 30                                        2580
591ab42a connection_get(9): got connid=1051
591ab42a connection_read(9): checking for input on id=1051
ber_get_next
ldap_read: want=8, got=8
  0000:  30 81 a8 02 01 76 63 81                            0....vc.
ldap_read: want=163, got=163
  0000:  a2 04 0d 64 63 3d 62 67  68 77 2c 64 63 3d 64 65   ...dc=corp,dc=de
  0010:  0a 01 02 0a 01 00 02 01  01 02 01 0a 01 01 00 a0   ................
  0020:  50 a3 14 04 0b 6f 62 6a  65 63 74 43 6c 61 73 73   P....objectClass
  0030:  04 05 67 72 6f 75 70 a3  12 04 09 67 69 64 4e 75   ..group....gidNu
  0040:  6d 62 65 72 04 05 32 30  30 30 30 a0 24 a3 17 04   mber..20000.$...
  0050:  0e 6f 62 6a 65 63 74 43  61 74 65 67 6f 72 79 04   .objectCategory.
 0060:  05 67 72 6f 75 70 87 09  67 69 64 6e 75 6d 62 65   .group..gidnumbe
  0070:  72 30 30 04 02 63 6e 04  0c 75 73 65 72 50 61 73   r00..cn..userPas
  0080:  73 77 6f 72 64 04 09 6d  65 6d 62 65 72 55 69 64   sword..memberUid
  0090:  04 06 6d 65 6d 62 65 72  04 09 67 69 64 4e 75 6d   ..member..gidNum
  00a0:  62 65 72                                           ber
ber_get_next: tag 0x30 len 168 contents:
591ab42a op tag 0x63, time 1494922282
ber_get_next
ldap_read: want=8 error=Resource temporarily unavailable
591ab42a conn=1051 op=57 do_search
ber_scanf fmt ({miiiib) ber:
591ab42a >>> dnPrettyNormal: <dc=corp,dc=de>
591ab42a <<< dnPrettyNormal: <dc=corp,dc=de>, <dc=corp,dc=de>
ber_scanf fmt ({mm}) ber:
ber_scanf fmt ({mm}) ber:
ber_scanf fmt ({mm}) ber:
ber_scanf fmt (m) ber:
ber_scanf fmt ({M}}) ber:
591ab42a ==> limits_get: conn=1051 op=57 self="cn=openldapconnect,ou=openldap,ou=berechtigungen,dc=corp,dc=de" this="dc=corp,dc=de"
591ab42a =>ldap_back_getconn: conn 0x7fb9c4102730 fetched refcnt=1.
ldap_search_ext
put_filter: "(&(?objectClass=group)(gidNumber=20000)(&(?OBJECTCATEGORY=group)(gidNumber=*)))"
put_filter: AND
put_filter_list "(?objectClass=group)(gidNumber=20000)(&(?OBJECTCATEGORY=group)(gidNumber=*))"
put_filter: "(?objectClass=group)"
put_filter: simple
put_simple_filter: "?objectClass=group"
ldap_search_ext
put_filter: "(&(objectClass=group)(gidNumber=20000)(&(OBJECTCATEGORY=group)(gidNumber=*)))"
put_filter: AND
put_filter_list "(objectClass=group)(gidNumber=20000)(&(OBJECTCATEGORY=group)(gidNumber=*))"
put_filter: "(objectClass=group)"
put_filter: simple
put_simple_filter: "objectClass=group"
put_filter: "(gidNumber=20000)"
put_filter: simple
put_simple_filter: "gidNumber=20000"
put_filter: "(&(OBJECTCATEGORY=group)(gidNumber=*))"
put_filter: AND
put_filter_list "(OBJECTCATEGORY=group)(gidNumber=*)"
put_filter: "(OBJECTCATEGORY=group)"
put_filter: simple
put_simple_filter: "OBJECTCATEGORY=group"
put_filter: "(gidNumber=*)"
put_filter: simple
put_simple_filter: "gidNumber=*"
ldap_send_initial_request
ldap_send_server_request
ber_scanf fmt ({it) ber:
ber_scanf fmt ({) ber:







Comment 2 Quanah Gibson-Mount 2020-08-28 22:05:07 UTC
This looks to be ITS#8864, which was fixed in OpenLDAP 2.4.48.  Please confirm if you get an opportunity to do so, thanks!

*** This issue has been marked as a duplicate of issue 8864 ***