You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@directory.apache.org by Si...@saaconsultants.com on 2006/11/24 18:39:22 UTC

Windows LDAP Clients Hanging - DS 1.0

Following an upgrade from 1.0-RC3 to 1.0 our windows LDAP connectivity
appears to "hang".

I have re-run some simple tests with both 1.0 and 1.0.1 (svn built) using
the windows native LDAP client: ldp v3 (uses wldap32.dll).

The first log output shows the initial PDU exchange - this causes the
client code to 'hand' waiting for a response it never gets.

The second log output is running the same test against 1.0-RC3 - this
returns a response as expected.

Can anyone help me with this?

TIA

SimonT.

============
V1.0 / V1.0.1
============

2006-11-24 17:04:35,390 DEBUG
[org.apache.mina.filter.executor.ExecutorFilter](SocketAcceptorIoProcessor-0.0)
 Launching thread for /127.0.0.1:3543
2006-11-24 17:04:35,390 DEBUG
[org.apache.mina.filter.executor.ExecutorFilter](pool-3-thread-1) Exiting
since queue is empty for /127.0.0.1:3543
2006-11-24 17:04:35,390 DEBUG
[org.apache.mina.filter.executor.ExecutorFilter](SocketAcceptorIoProcessor-0.0)
 Launching thread for /127.0.0.1:3543
2006-11-24 17:04:35,625 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
>>>==========================================
2006-11-24 17:04:35,625 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) -->
Decoding a PDU
2006-11-24 17:04:35,625 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
>>>------------------------------------------
2006-11-24 17:04:35,625 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = TAG_STATE_START ---
2006-11-24 17:04:35,625 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x30
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Tag
0x30 has been decoded
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_START ---
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x84
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_PENDING ---
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x2D
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_END ---
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x02
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Parent
length : TLV expected length stack :  - null
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Root
TLV[45]
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Length
45 has been decoded
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = VALUE_STATE_START ---
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x02
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = TLV_STATE_DONE ---
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x02
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) TLV
Tree : TLV0x30(45)
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](pool-3-thread-2)
 Transition from state <START_STATE> to state <LDAP_MESSAGE_STATE>, tag
<0x30>, action : LdapMessage initialization>
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = TAG_STATE_START ---
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x02
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Tag
0x02 has been decoded
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_START ---
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x01
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_END ---
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x01
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Parent
length : TLV expected length stack :  - 45 - null
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Length
1 has been decoded
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = VALUE_STATE_START ---
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x01
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = TLV_STATE_DONE ---
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x63
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) TLV
Tree : TLV0x02(1)-TLV0x30(42)
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](pool-3-thread-2)
 Transition from state <LDAP_MESSAGE_STATE> to state <MESSAGE_ID_STATE>,
tag <0x02>, action : Store MessageId>
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.ldap.codec.LdapMessageGrammar](pool-3-thread-2)
 Ldap Message Id has been decoded : 1
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = TAG_STATE_START ---
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x63
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Tag
0x63 has been decoded
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_START ---
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x84
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_PENDING ---
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,640 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x24
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_END ---
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x04
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Parent
length : TLV expected length stack :  - 42 - null
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Length
36 has been decoded
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = VALUE_STATE_START ---
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x04
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = TLV_STATE_DONE ---
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x04
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) TLV
Tree : TLV0x63(36)-TLV0x30(0)
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](pool-3-thread-2)
 Transition from state <MESSAGE_ID_STATE> to state <SEARCH_REQUEST_STATE>,
tag <0x63>, action : Init SearchRequest>
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = TAG_STATE_START ---
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x04
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Tag
0x04 has been decoded
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_START ---
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_END ---
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x0A
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Parent
length : TLV expected length stack :  - 36 - 0 - null
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Length
0 has been decoded
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = TLV_STATE_DONE ---
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x0A
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) TLV
Tree : TLV0x04(0)-TLV0x63(34)-TLV0x30(0)
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](pool-3-thread-2)
 Transition from state <SEARCH_REQUEST_STATE> to state <BASE_OBJECT_STATE>,
tag <0x04>, action : store base object value>
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.ldap.codec.LdapMessageGrammar](pool-3-thread-2)
 Searching with root DN :
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = TAG_STATE_START ---
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x0A
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Tag
0x0A has been decoded
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_START ---
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x01
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_END ---
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Parent
length : TLV expected length stack :  - 34 - 0 - null
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Length
1 has been decoded
2006-11-24 17:04:35,781 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = VALUE_STATE_START ---
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = TLV_STATE_DONE ---
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x0A
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) TLV
Tree : TLV0x0A(1)-TLV0x63(31)-TLV0x30(0)
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](pool-3-thread-2)
 Transition from state <BASE_OBJECT_STATE> to state <SCOPE_STATE>, tag
<0x0A>, action : store scope value>
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.ldap.codec.LdapMessageGrammar](pool-3-thread-2)
 Searching within BASE_OBJECT scope
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = TAG_STATE_START ---
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x0A
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Tag
0x0A has been decoded
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_START ---
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x01
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_END ---
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Parent
length : TLV expected length stack :  - 31 - 0 - null
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Length
1 has been decoded
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = VALUE_STATE_START ---
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = TLV_STATE_DONE ---
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x02
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) TLV
Tree : TLV0x0A(1)-TLV0x63(28)-TLV0x30(0)
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](pool-3-thread-2)
 Transition from state <SCOPE_STATE> to state <DEREF_ALIAS_STATE>, tag
<0x0A>, action : store derefAliases value>
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.ldap.codec.LdapMessageGrammar](pool-3-thread-2)
 Handling object strategy : NEVER_DEREF_ALIASES
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = TAG_STATE_START ---
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x02
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Tag
0x02 has been decoded
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_START ---
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x01
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_END ---
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Parent
length : TLV expected length stack :  - 28 - 0 - null
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Length
1 has been decoded
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = VALUE_STATE_START ---
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = TLV_STATE_DONE ---
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x02
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) TLV
Tree : TLV0x02(1)-TLV0x63(25)-TLV0x30(0)
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](pool-3-thread-2)
 Transition from state <DEREF_ALIAS_STATE> to state <SIZE_LIMIT_STATE>, tag
<0x02>, action : store sizeLimit value>
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.ldap.codec.LdapMessageGrammar](pool-3-thread-2)
 The sizeLimit value is set to 0 objects
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = TAG_STATE_START ---
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x02
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Tag
0x02 has been decoded
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_START ---
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x01
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_END ---
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Parent
length : TLV expected length stack :  - 25 - 0 - null
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Length
1 has been decoded
2006-11-24 17:04:35,796 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = VALUE_STATE_START ---
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = TLV_STATE_DONE ---
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x01
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) TLV
Tree : TLV0x02(1)-TLV0x63(22)-TLV0x30(0)
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](pool-3-thread-2)
 Transition from state <SIZE_LIMIT_STATE> to state <TIME_LIMIT_STATE>, tag
<0x02>, action : store timeLimit value>
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.ldap.codec.LdapMessageGrammar](pool-3-thread-2)
 The timeLimit value is set to 0 seconds
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = TAG_STATE_START ---
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x01
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Tag
0x01 has been decoded
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_START ---
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x01
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_END ---
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Parent
length : TLV expected length stack :  - 22 - 0 - null
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Length
1 has been decoded
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = VALUE_STATE_START ---
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = TLV_STATE_DONE ---
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x87
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) TLV
Tree : TLV0x01(1)-TLV0x63(19)-TLV0x30(0)
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](pool-3-thread-2)
 Transition from state <TIME_LIMIT_STATE> to state <TYPES_ONLY_STATE>, tag
<0x01>, action : store typesOnly value>
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.ldap.codec.LdapMessageGrammar](pool-3-thread-2)
 The search will return attributes types and values
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = TAG_STATE_START ---
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x87
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Tag
0x87 has been decoded
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_START ---
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x0B
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_END ---
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x6F
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Parent
length : TLV expected length stack :  - 19 - 0 - null
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Length
11 has been decoded
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = VALUE_STATE_START ---
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x6F
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = TLV_STATE_DONE ---
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x30
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) TLV
Tree : TLV0x87(11)-TLV0x63(6)-TLV0x30(0)
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](pool-3-thread-2)
 Transition from state <TYPES_ONLY_STATE> to state <PRESENT_STATE>, tag
<0x87>, action : Init present filter Value>
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.ldap.codec.actions.InitPresentFilterAction](pool-3-thread-2)
 Initialize Present filter
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = TAG_STATE_START ---
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x30
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Tag
0x30 has been decoded
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_START ---
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x84
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
State = LENGTH_STATE_PENDING ---
2006-11-24 17:04:35,812 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,828 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,828 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,828 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,828 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
current byte : 0x00
2006-11-24 17:04:35,828 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
<<<------------------------------------------
2006-11-24 17:04:35,828 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) <-- End
decoding : TLV[ 0x30, 0, []]
2006-11-24 17:04:35,828 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
<<<==========================================
2006-11-24 17:04:35,828 DEBUG
[org.apache.directory.shared.ldap.codec.TwixDecoder](pool-3-thread-2)
Decoding the PDU :
2006-11-24 17:04:35,828 DEBUG
[org.apache.directory.shared.ldap.codec.TwixDecoder](pool-3-thread-2) 0x30
0x84 0x00 0x00 0x00 0x2D 0x02 0x01 0x01 0x63 0x84 0x00 0x00 0x00 0x24 0x04
0x00 0x0A 0x01 0x00 0x0A 0x01 0x00 0x02 0x01 0x00 0x02 0x01 0x00 0x01 0x01
0x00 0x87 0x0B 0x6F 0x62 0x6A 0x65 0x63 0x74 0x43 0x6C 0x61 0x73 0x73 0x30
0x84 0x00 0x00 0x00 0x00
2006-11-24 17:04:35,828 DEBUG
[org.apache.mina.filter.executor.ExecutorFilter](pool-3-thread-2) Exiting
since queue is empty for /127.0.0.1:3543

============
V1.0-RC3
============
2006-11-24 17:31:09,796 INFO
[org.apache.directory.server.ldap.LdapProtocolProvider$LdapProtocolHandler](IoThreadPool-1)
 [/127.0.0.1:3728] OPENED
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.ldap.codec.TwixDecoder](IoThreadPool-4)
Decoding the PDU :
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.ldap.codec.TwixDecoder](IoThreadPool-4) 0x30
0x84 0x00 0x00 0x00 0x2D 0x02 0x01 0x01 0x63 0x84 0x00 0x00 0x00 0x24 0x04
0x00 0x0A 0x01 0x00 0x0A 0x01 0x00 0x02 0x01 0x00 0x02 0x01 0x00 0x01 0x01
0x00 0x87 0x0B 0x6F 0x62 0x6A 0x65 0x63 0x74 0x43 0x6C 0x61 0x73 0x73 0x30
0x84 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00
0x00 0x00 0x00
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
>>>==========================================
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) -->
Decoding a PDU
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
>>>------------------------------------------
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TAG_STATE_START ---
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x30
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TAG_STATE_END ---
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x84
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Tag
TAG[CONSTRUCTED, UNIVERSAL, SEQUENCE_SEQUENCE_OF](size=1) has been decoded
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <LDAP_MESSAGE_TAG> to <LDAP_MESSAGE_VALUE>, action : no
action>
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_START ---
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x84
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_PENDING ---
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x2D
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_END ---
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x02
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Parent
length : TLV expected length stack :  - null
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Root
TLV[45]
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Length
LENGTH[45](indefinite)size=5) has been decoded
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = VALUE_STATE_START ---
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x02
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TLV_STATE_DONE ---
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x02
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) TLV Tree
: TLV0x30(45)
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <LDAP_MESSAGE_VALUE> to <LDAP_MESSAGE_ID_TAG>, action :
LdapMessage initialization>
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TAG_STATE_START ---
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x02
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TAG_STATE_END ---
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x01
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Tag
TAG[PRIMITIVE, UNIVERSAL, INTEGER](size=1) has been decoded
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <LDAP_MESSAGE_ID_TAG> to <LDAP_MESSAGE_ID_VALUE>, action :
no action>
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_START ---
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x01
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_END ---
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x01
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Parent
length : TLV expected length stack :  - 45 - null
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Length
LENGTH[1](indefinite)size=1) has been decoded
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = VALUE_STATE_START ---
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x01
2006-11-24 17:31:10,000 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TLV_STATE_DONE ---
2006-11-24 17:31:10,156 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x63
2006-11-24 17:31:10,156 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) TLV Tree
: TLV0x02(1)-TLV0x30(42)
2006-11-24 17:31:10,156 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <LDAP_MESSAGE_ID_VALUE> to <PROTOCOL_OP_TAG>, action :
Store MessageId>
2006-11-24 17:31:10,156 DEBUG
[org.apache.directory.shared.ldap.codec.LdapMessageGrammar](IoThreadPool-4)
Ldap Message Id has been decoded : 1
2006-11-24 17:31:10,156 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TAG_STATE_START ---
2006-11-24 17:31:10,156 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x63
2006-11-24 17:31:10,156 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TAG_STATE_END ---
2006-11-24 17:31:10,156 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x84
2006-11-24 17:31:10,156 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Tag
TAG[CONSTRUCTED, APPLICATION, ](size=1) has been decoded
2006-11-24 17:31:10,156 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <PROTOCOL_OP_TAG> to <SEARCH_REQUEST_GRAMMAR_SWITCH>,
action : no action>
2006-11-24 17:31:10,156 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Switching from grammar LDAP_MESSAGE_GRAMMAR to grammar
SEARCH_REQUEST_GRAMMAR
2006-11-24 17:31:10,156 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <SEARCH_REQUEST_TAG> to <SEARCH_REQUEST_VALUE>, action :
no action>
2006-11-24 17:31:10,156 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_START ---
2006-11-24 17:31:10,156 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x84
2006-11-24 17:31:10,156 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_PENDING ---
2006-11-24 17:31:10,156 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,156 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,156 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,156 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,156 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x24
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_END ---
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x04
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Parent
length : TLV expected length stack :  - 42 - null
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Length
LENGTH[36](indefinite)size=5) has been decoded
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = VALUE_STATE_START ---
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x04
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TLV_STATE_DONE ---
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x04
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) TLV Tree
: TLV0x63(36)-TLV0x30(0)
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <SEARCH_REQUEST_VALUE> to
<SEARCH_REQUEST_BASE_OBJECT_TAG>, action : Init SearchRequest>
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TAG_STATE_START ---
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x04
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TAG_STATE_END ---
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Tag
TAG[PRIMITIVE, UNIVERSAL, OCTET_STRING](size=1) has been decoded
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <SEARCH_REQUEST_BASE_OBJECT_TAG> to
<SEARCH_REQUEST_BASE_OBJECT_VALUE>, action : no action>
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_START ---
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_END ---
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x0A
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Parent
length : TLV expected length stack :  - 36 - 0 - null
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Length
LENGTH[0](indefinite)size=1) has been decoded
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TLV_STATE_DONE ---
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x0A
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) TLV Tree
: TLV0x04(0)-TLV0x63(34)-TLV0x30(0)
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <SEARCH_REQUEST_BASE_OBJECT_VALUE> to
<SEARCH_REQUEST_SCOPE_TAG>, action : store base object value>
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.ldap.codec.search.SearchRequestGrammar](IoThreadPool-4)
 Searching with root DN :
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TAG_STATE_START ---
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x0A
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TAG_STATE_END ---
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x01
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Tag
TAG[PRIMITIVE, UNIVERSAL, ENUMERATED](size=1) has been decoded
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <SEARCH_REQUEST_SCOPE_TAG> to
<SEARCH_REQUEST_SCOPE_VALUE>, action : no action>
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_START ---
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x01
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_END ---
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Parent
length : TLV expected length stack :  - 34 - 0 - null
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Length
LENGTH[1](indefinite)size=1) has been decoded
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = VALUE_STATE_START ---
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TLV_STATE_DONE ---
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x0A
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) TLV Tree
: TLV0x0A(1)-TLV0x63(31)-TLV0x30(0)
2006-11-24 17:31:10,171 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <SEARCH_REQUEST_SCOPE_VALUE> to
<SEARCH_REQUEST_DEREF_ALIASES_TAG>, action : store scope value>
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.ldap.codec.search.SearchRequestGrammar](IoThreadPool-4)
 Searching within BASE_OBJECT scope
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TAG_STATE_START ---
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x0A
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TAG_STATE_END ---
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x01
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Tag
TAG[PRIMITIVE, UNIVERSAL, ENUMERATED](size=1) has been decoded
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <SEARCH_REQUEST_DEREF_ALIASES_TAG> to
<SEARCH_REQUEST_DEREF_ALIASES_VALUE>, action : no action>
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_START ---
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x01
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_END ---
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Parent
length : TLV expected length stack :  - 31 - 0 - null
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Length
LENGTH[1](indefinite)size=1) has been decoded
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = VALUE_STATE_START ---
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TLV_STATE_DONE ---
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x02
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) TLV Tree
: TLV0x0A(1)-TLV0x63(28)-TLV0x30(0)
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <SEARCH_REQUEST_DEREF_ALIASES_VALUE> to
<SEARCH_REQUEST_SIZE_LIMIT_TAG>, action : store derefAliases value>
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.ldap.codec.search.SearchRequestGrammar](IoThreadPool-4)
 Handling object strategy : NEVER_DEREF_ALIASES
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TAG_STATE_START ---
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x02
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TAG_STATE_END ---
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x01
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Tag
TAG[PRIMITIVE, UNIVERSAL, INTEGER](size=1) has been decoded
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <SEARCH_REQUEST_SIZE_LIMIT_TAG> to
<SEARCH_REQUEST_SIZE_LIMIT_VALUE>, action : no action>
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_START ---
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x01
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_END ---
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Parent
length : TLV expected length stack :  - 28 - 0 - null
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Length
LENGTH[1](indefinite)size=1) has been decoded
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = VALUE_STATE_START ---
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TLV_STATE_DONE ---
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x02
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) TLV Tree
: TLV0x02(1)-TLV0x63(25)-TLV0x30(0)
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <SEARCH_REQUEST_SIZE_LIMIT_VALUE> to
<SEARCH_REQUEST_TIME_LIMIT_TAG>, action : store sizeLimit value>
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.ldap.codec.search.SearchRequestGrammar](IoThreadPool-4)
 The sizeLimit value is set to 0 objects
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TAG_STATE_START ---
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x02
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TAG_STATE_END ---
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x01
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Tag
TAG[PRIMITIVE, UNIVERSAL, INTEGER](size=1) has been decoded
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <SEARCH_REQUEST_TIME_LIMIT_TAG> to
<SEARCH_REQUEST_TIME_LIMIT_VALUE>, action : no action>
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_START ---
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x01
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_END ---
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Parent
length : TLV expected length stack :  - 25 - 0 - null
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Length
LENGTH[1](indefinite)size=1) has been decoded
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = VALUE_STATE_START ---
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TLV_STATE_DONE ---
2006-11-24 17:31:10,187 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x01
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) TLV Tree
: TLV0x02(1)-TLV0x63(22)-TLV0x30(0)
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <SEARCH_REQUEST_TIME_LIMIT_VALUE> to
<SEARCH_REQUEST_TYPES_ONLY_TAG>, action : store timeLimit value>
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.ldap.codec.search.SearchRequestGrammar](IoThreadPool-4)
 The timeLimit value is set to 0 seconds
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TAG_STATE_START ---
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x01
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TAG_STATE_END ---
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x01
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Tag
TAG[PRIMITIVE, UNIVERSAL, BOOLEAN](size=1) has been decoded
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <SEARCH_REQUEST_TYPES_ONLY_TAG> to
<SEARCH_REQUEST_TYPES_ONLY_VALUE>, action : no action>
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_START ---
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x01
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_END ---
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Parent
length : TLV expected length stack :  - 22 - 0 - null
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Length
LENGTH[1](indefinite)size=1) has been decoded
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = VALUE_STATE_START ---
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TLV_STATE_DONE ---
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x87
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) TLV Tree
: TLV0x01(1)-TLV0x63(19)-TLV0x30(0)
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <SEARCH_REQUEST_TYPES_ONLY_VALUE> to
<SEARCH_REQUEST_FILTER>, action : store typesOnly value>
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.ldap.codec.search.SearchRequestGrammar](IoThreadPool-4)
 The search will return attributes types and values
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TAG_STATE_START ---
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x87
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TAG_STATE_END ---
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x0B
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Tag
TAG[PRIMITIVE, CONTEXTUAL, 7](size=1) has been decoded
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <SEARCH_REQUEST_FILTER> to <FILTER_GRAMMAR_SWITCH>, action
: no action>
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Switching from grammar SEARCH_REQUEST_GRAMMAR to grammar FILTER_GRAMMAR
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <FILTER_TAG> to <FILTER_PRESENT_VALUE>, action : no
action>
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_START ---
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x0B
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_END ---
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x6F
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Parent
length : TLV expected length stack :  - 19 - 0 - null
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Length
LENGTH[11](indefinite)size=1) has been decoded
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = VALUE_STATE_START ---
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x6F
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TLV_STATE_DONE ---
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x30
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) TLV Tree
: TLV0x87(11)-TLV0x63(6)-TLV0x30(0)
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <FILTER_PRESENT_VALUE> to <FILTER_TAG>, action : Init
present filter Value>
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TAG_STATE_START ---
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x30
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TAG_STATE_END ---
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x84
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Tag
TAG[CONSTRUCTED, UNIVERSAL, SEQUENCE_SEQUENCE_OF](size=1) has been decoded
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Pop grammar FILTER_GRAMMAR, state = FILTER_TAG
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <SEARCH_REQUEST_FILTER> to
<SEARCH_REQUEST_ATTRIBUTE_DESCRIPTION_LIST_VALUE>, action : no action>
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_START ---
2006-11-24 17:31:10,203 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x84
2006-11-24 17:31:10,218 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_PENDING ---
2006-11-24 17:31:10,218 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,218 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,218 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,218 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,218 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
current byte : 0x00
2006-11-24 17:31:10,218 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = LENGTH_STATE_END ---
2006-11-24 17:31:10,218 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)   no
more byte to decode in the stream
2006-11-24 17:31:10,218 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Parent
length : TLV expected length stack :  - 6 - 0 - null
2006-11-24 17:31:10,218 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Length
LENGTH[0](indefinite)size=5) has been decoded
2006-11-24 17:31:10,218 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
State = TLV_STATE_DONE ---
2006-11-24 17:31:10,218 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)   no
more byte to decode in the stream
2006-11-24 17:31:10,218 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) TLV Tree
: TLV0x30(0)
2006-11-24 17:31:10,218 DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPool-4)
 Transition from <SEARCH_REQUEST_ATTRIBUTE_DESCRIPTION_LIST_VALUE> to
<SEARCH_REQUEST_ATTRIBUTE_DESCRIPTION_TAG>, action : store Attribute
Description List value>
2006-11-24 17:31:10,218 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
<<<------------------------------------------
2006-11-24 17:31:10,218 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) <-- Stop
decoding : TLV[ TAG[CONSTRUCTED, UNIVERSAL, SEQUENCE_SEQUENCE_OF](size=1),
LENGTH[0](indefinite)size=5), []]
2006-11-24 17:31:10,218 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
<<<==========================================
2006-11-24 17:31:10,218 DEBUG
[org.apache.directory.shared.ldap.codec.TwixDecoder](IoThreadPool-4)
Decoded LdapMessage : LdapMessage
    message Id : 1
    Search Request
        Base Object : ''
        Scope : base object
        Deref Aliases : never Deref Aliases
        Size Limit : no limit
        Time Limit : no limit
        Types Only : false
        Filter : '(objectClass=*)'

2006-11-24 17:31:10,218 DEBUG
[org.apache.directory.shared.ldap.codec.TwixTransformer](IoThreadPool-4)
Transforming LdapMessage <1, SEARCH_REQUEST> from Twix to Snickers.
2006-11-24 17:31:10,218 INFO
[org.apache.directory.server.ldap.LdapProtocolProvider$LdapProtocolHandler](IoThreadPool-4)
 [/127.0.0.1:3728] RECEIVED:     SearchRequest
        baseDn : ''
        filter : '(objectClass=*) '
        scope : base object
        typesOnly : false
no limit
        Time Limit : no limit
        Deref Aliases : never Deref Aliases
        attributes :

2006-11-24 17:31:10,234 DEBUG
[org.apache.directory.server.ldap.support.SearchHandler](IoThreadPool-4)
Message received :     SearchRequest
        baseDn : ''
        filter : '(objectClass=*) '
        scope : base object
        typesOnly : false
no limit
        Time Limit : no limit
        Deref Aliases : never Deref Aliases
        attributes :

2006-11-24 17:31:10,250 INFO
[org.apache.directory.server.ldap.LdapProtocolProvider$LdapProtocolHandler](IoThreadPool-4)
 [/127.0.0.1:3728] WRITE:         Ldap Result
            Result code : (ResultCodeEnum[INSUFFICIENTACCESSRIGHTS=50])
insufficientAccessRights
            Matched DN : 'null'
            Error message : 'failed on search operation:
    SearchRequest
        baseDn : ''
        filter : '(objectClass=*) '
        scope : base object
        typesOnly : false
no limit
        Time Limit : no limit
        Deref Aliases : never Deref Aliases
        attributes :
:
org.apache.directory.shared.ldap.exception.LdapNoPermissionException:
Anonymous access disabled.
      at
org.apache.directory.server.core.DefaultDirectoryService.checkSecuritySettings(DefaultDirectoryService.java:395)
      at
org.apache.directory.server.core.DefaultDirectoryService.getJndiContext(DefaultDirectoryService.java:134)
      at
org.apache.directory.server.core.jndi.AbstractContextFactory.getInitialContext(AbstractContextFactory.java:121)
      at
javax.naming.spi.NamingManager.getInitialContext(NamingManager.java:662)
      at
javax.naming.InitialContext.getDefaultInitCtx(InitialContext.java:243)
      at javax.naming.InitialContext.init(InitialContext.java:219)
      at
javax.naming.ldap.InitialLdapContext.<init>(InitialLdapContext.java:133)
      at
org.apache.directory.server.ldap.SessionRegistry.getLdapContextOnRootDSEAccess(SessionRegistry.java:358)
      at
org.apache.directory.server.ldap.support.SearchHandler.messageReceived(SearchHandler.java:152)
      at
org.apache.mina.handler.demux.DemuxingIoHandler.messageReceived(DemuxingIoHandler.java:128)
      at
org.apache.directory.server.ldap.LdapProtocolProvider$LdapProtocolHandler.messageReceived(LdapProtocolProvider.java:431)
      at
org.apache.mina.common.support.AbstractIoFilterChain$2.messageReceived(AbstractIoFilterChain.java:188)
      at
org.apache.mina.common.support.AbstractIoFilterChain.callNextMessageReceived(AbstractIoFilterChain.java:504)
      at
org.apache.mina.common.support.AbstractIoFilterChain.access$1000(AbstractIoFilterChain.java:51)
      at
org.apache.mina.common.support.AbstractIoFilterChain$3.messageReceived(AbstractIoFilterChain.java:790)
      at
org.apache.mina.filter.LoggingFilter.messageReceived(LoggingFilter.java:95)
      at
org.apache.mina.common.support.AbstractIoFilterChain.callNextMessageReceived(AbstractIoFilterChain.java:504)
      at
org.apache.mina.common.support.AbstractIoFilterChain.access$1000(AbstractIoFilterChain.java:51)
      at
org.apache.mina.common.support.AbstractIoFilterChain$3.messageReceived(AbstractIoFilterChain.java:790)
      at
org.apache.mina.filter.codec.ProtocolCodecFilter.messageReceived(ProtocolCodecFilter.java:187)
      at
org.apache.mina.common.support.AbstractIoFilterChain.callNextMessageReceived(AbstractIoFilterChain.java:504)
      at
org.apache.mina.common.support.AbstractIoFilterChain.access$1000(AbstractIoFilterChain.java:51)
      at
org.apache.mina.common.support.AbstractIoFilterChain$3.messageReceived(AbstractIoFilterChain.java:790)
      at
org.apache.mina.filter.ThreadPoolFilter.processEvent(ThreadPoolFilter.java:706)
      at
org.apache.mina.filter.ThreadPoolFilter$Worker.processEvents(ThreadPoolFilter.java:462)
      at
org.apache.mina.filter.ThreadPoolFilter$Worker.run(ThreadPoolFilter.java:417)


Re: Windows LDAP Clients Hanging - DS 1.0

Posted by Emmanuel Lecharny <el...@gmail.com>.
Hey,
we have a stupid NPE somwhere in the code when in DEBUG mode.

Just try to switch to WARN mode, and see if it works.

Emmanuel


On 11/24/06, Simon.Temple@saaconsultants.com <
Simon.Temple@saaconsultants.com> wrote:
>
>
> Following an upgrade from 1.0-RC3 to 1.0 our windows LDAP connectivity
> appears to "hang".
>
> I have re-run some simple tests with both 1.0 and 1.0.1 (svn built) using
> the windows native LDAP client: ldp v3 (uses wldap32.dll).
>
> The first log output shows the initial PDU exchange - this causes the
> client code to 'hand' waiting for a response it never gets.
>
> The second log output is running the same test against 1.0-RC3 - this
> returns a response as expected.
>
> Can anyone help me with this?
>
> TIA
>
> SimonT.
>
> ============
> V1.0 / V1.0.1
> ============
>
> 2006-11-24 17:04:35,390 DEBUG
> [org.apache.mina.filter.executor.ExecutorFilter](
> SocketAcceptorIoProcessor-0.0)
> Launching thread for /127.0.0.1:3543
> 2006-11-24 17:04:35,390 DEBUG
> [org.apache.mina.filter.executor.ExecutorFilter](pool-3-thread-1) Exiting
> since queue is empty for /127.0.0.1:3543
> 2006-11-24 17:04:35,390 DEBUG
> [org.apache.mina.filter.executor.ExecutorFilter](
> SocketAcceptorIoProcessor-0.0)
> Launching thread for /127.0.0.1:3543
> 2006-11-24 17:04:35,625 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> >>>==========================================
> 2006-11-24 17:04:35,625 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) -->
> Decoding a PDU
> 2006-11-24 17:04:35,625 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> >>>------------------------------------------
> 2006-11-24 17:04:35,625 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = TAG_STATE_START ---
> 2006-11-24 17:04:35,625 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x30
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Tag
> 0x30 has been decoded
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_START ---
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x84
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_PENDING ---
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x2D
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_END ---
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x02
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Parent
> length : TLV expected length stack :  - null
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Root
> TLV[45]
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Length
> 45 has been decoded
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = VALUE_STATE_START ---
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x02
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = TLV_STATE_DONE ---
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x02
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) TLV
> Tree : TLV0x30(45)
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](pool-3-thread-2)
> Transition from state <START_STATE> to state <LDAP_MESSAGE_STATE>, tag
> <0x30>, action : LdapMessage initialization>
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = TAG_STATE_START ---
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x02
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Tag
> 0x02 has been decoded
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_START ---
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x01
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_END ---
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x01
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Parent
> length : TLV expected length stack :  - 45 - null
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Length
> 1 has been decoded
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = VALUE_STATE_START ---
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x01
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = TLV_STATE_DONE ---
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x63
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) TLV
> Tree : TLV0x02(1)-TLV0x30(42)
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](pool-3-thread-2)
> Transition from state <LDAP_MESSAGE_STATE> to state <MESSAGE_ID_STATE>,
> tag <0x02>, action : Store MessageId>
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.ldap.codec.LdapMessageGrammar
> ](pool-3-thread-2)
> Ldap Message Id has been decoded : 1
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = TAG_STATE_START ---
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x63
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Tag
> 0x63 has been decoded
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_START ---
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x84
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_PENDING ---
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,640 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x24
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_END ---
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x04
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Parent
> length : TLV expected length stack :  - 42 - null
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Length
> 36 has been decoded
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = VALUE_STATE_START ---
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x04
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = TLV_STATE_DONE ---
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x04
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) TLV
> Tree : TLV0x63(36)-TLV0x30(0)
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](pool-3-thread-2)
> Transition from state <MESSAGE_ID_STATE> to state <SEARCH_REQUEST_STATE>,
> tag <0x63>, action : Init SearchRequest>
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = TAG_STATE_START ---
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x04
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Tag
> 0x04 has been decoded
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_START ---
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_END ---
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x0A
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Parent
> length : TLV expected length stack :  - 36 - 0 - null
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Length
> 0 has been decoded
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = TLV_STATE_DONE ---
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x0A
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) TLV
> Tree : TLV0x04(0)-TLV0x63(34)-TLV0x30(0)
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](pool-3-thread-2)
> Transition from state <SEARCH_REQUEST_STATE> to state <BASE_OBJECT_STATE>,
> tag <0x04>, action : store base object value>
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.ldap.codec.LdapMessageGrammar
> ](pool-3-thread-2)
> Searching with root DN :
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = TAG_STATE_START ---
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x0A
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Tag
> 0x0A has been decoded
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_START ---
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x01
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_END ---
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Parent
> length : TLV expected length stack :  - 34 - 0 - null
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Length
> 1 has been decoded
> 2006-11-24 17:04:35,781 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = VALUE_STATE_START ---
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = TLV_STATE_DONE ---
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x0A
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) TLV
> Tree : TLV0x0A(1)-TLV0x63(31)-TLV0x30(0)
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](pool-3-thread-2)
> Transition from state <BASE_OBJECT_STATE> to state <SCOPE_STATE>, tag
> <0x0A>, action : store scope value>
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.ldap.codec.LdapMessageGrammar
> ](pool-3-thread-2)
> Searching within BASE_OBJECT scope
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = TAG_STATE_START ---
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x0A
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Tag
> 0x0A has been decoded
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_START ---
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x01
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_END ---
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Parent
> length : TLV expected length stack :  - 31 - 0 - null
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Length
> 1 has been decoded
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = VALUE_STATE_START ---
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = TLV_STATE_DONE ---
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x02
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) TLV
> Tree : TLV0x0A(1)-TLV0x63(28)-TLV0x30(0)
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](pool-3-thread-2)
> Transition from state <SCOPE_STATE> to state <DEREF_ALIAS_STATE>, tag
> <0x0A>, action : store derefAliases value>
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.ldap.codec.LdapMessageGrammar
> ](pool-3-thread-2)
> Handling object strategy : NEVER_DEREF_ALIASES
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = TAG_STATE_START ---
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x02
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Tag
> 0x02 has been decoded
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_START ---
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x01
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_END ---
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Parent
> length : TLV expected length stack :  - 28 - 0 - null
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Length
> 1 has been decoded
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = VALUE_STATE_START ---
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = TLV_STATE_DONE ---
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x02
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) TLV
> Tree : TLV0x02(1)-TLV0x63(25)-TLV0x30(0)
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](pool-3-thread-2)
> Transition from state <DEREF_ALIAS_STATE> to state <SIZE_LIMIT_STATE>, tag
> <0x02>, action : store sizeLimit value>
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.ldap.codec.LdapMessageGrammar
> ](pool-3-thread-2)
> The sizeLimit value is set to 0 objects
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = TAG_STATE_START ---
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x02
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Tag
> 0x02 has been decoded
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_START ---
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x01
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_END ---
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Parent
> length : TLV expected length stack :  - 25 - 0 - null
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Length
> 1 has been decoded
> 2006-11-24 17:04:35,796 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = VALUE_STATE_START ---
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = TLV_STATE_DONE ---
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x01
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) TLV
> Tree : TLV0x02(1)-TLV0x63(22)-TLV0x30(0)
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](pool-3-thread-2)
> Transition from state <SIZE_LIMIT_STATE> to state <TIME_LIMIT_STATE>, tag
> <0x02>, action : store timeLimit value>
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.ldap.codec.LdapMessageGrammar
> ](pool-3-thread-2)
> The timeLimit value is set to 0 seconds
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = TAG_STATE_START ---
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x01
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Tag
> 0x01 has been decoded
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_START ---
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x01
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_END ---
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Parent
> length : TLV expected length stack :  - 22 - 0 - null
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Length
> 1 has been decoded
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = VALUE_STATE_START ---
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = TLV_STATE_DONE ---
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x87
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) TLV
> Tree : TLV0x01(1)-TLV0x63(19)-TLV0x30(0)
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](pool-3-thread-2)
> Transition from state <TIME_LIMIT_STATE> to state <TYPES_ONLY_STATE>, tag
> <0x01>, action : store typesOnly value>
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.ldap.codec.LdapMessageGrammar
> ](pool-3-thread-2)
> The search will return attributes types and values
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = TAG_STATE_START ---
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x87
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Tag
> 0x87 has been decoded
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_START ---
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x0B
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_END ---
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x6F
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Parent
> length : TLV expected length stack :  - 19 - 0 - null
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Length
> 11 has been decoded
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = VALUE_STATE_START ---
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x6F
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = TLV_STATE_DONE ---
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x30
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) TLV
> Tree : TLV0x87(11)-TLV0x63(6)-TLV0x30(0)
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](pool-3-thread-2)
> Transition from state <TYPES_ONLY_STATE> to state <PRESENT_STATE>, tag
> <0x87>, action : Init present filter Value>
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.ldap.codec.actions.InitPresentFilterAction
> ](pool-3-thread-2)
> Initialize Present filter
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = TAG_STATE_START ---
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x30
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) Tag
> 0x30 has been decoded
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_START ---
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x84
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) ---
> State = LENGTH_STATE_PENDING ---
> 2006-11-24 17:04:35,812 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,828 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,828 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,828 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,828 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> current byte : 0x00
> 2006-11-24 17:04:35,828 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> <<<------------------------------------------
> 2006-11-24 17:04:35,828 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) <--
> End
> decoding : TLV[ 0x30, 0, []]
> 2006-11-24 17:04:35,828 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2)
> <<<==========================================
> 2006-11-24 17:04:35,828 DEBUG
> [org.apache.directory.shared.ldap.codec.TwixDecoder](pool-3-thread-2)
> Decoding the PDU :
> 2006-11-24 17:04:35,828 DEBUG
> [org.apache.directory.shared.ldap.codec.TwixDecoder](pool-3-thread-2) 0x30
> 0x84 0x00 0x00 0x00 0x2D 0x02 0x01 0x01 0x63 0x84 0x00 0x00 0x00 0x24 0x04
> 0x00 0x0A 0x01 0x00 0x0A 0x01 0x00 0x02 0x01 0x00 0x02 0x01 0x00 0x01 0x01
> 0x00 0x87 0x0B 0x6F 0x62 0x6A 0x65 0x63 0x74 0x43 0x6C 0x61 0x73 0x73 0x30
> 0x84 0x00 0x00 0x00 0x00
> 2006-11-24 17:04:35,828 DEBUG
> [org.apache.mina.filter.executor.ExecutorFilter](pool-3-thread-2) Exiting
> since queue is empty for /127.0.0.1:3543
>
> ============
> V1.0-RC3
> ============
> 2006-11-24 17:31:09,796 INFO
> [org.apache.directory.server.ldap.LdapProtocolProvider$LdapProtocolHandler
> ](IoThreadPool-1)
> [/127.0.0.1:3728] OPENED
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.ldap.codec.TwixDecoder](IoThreadPool-4)
> Decoding the PDU :
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.ldap.codec.TwixDecoder](IoThreadPool-4) 0x30
> 0x84 0x00 0x00 0x00 0x2D 0x02 0x01 0x01 0x63 0x84 0x00 0x00 0x00 0x24 0x04
> 0x00 0x0A 0x01 0x00 0x0A 0x01 0x00 0x02 0x01 0x00 0x02 0x01 0x00 0x01 0x01
> 0x00 0x87 0x0B 0x6F 0x62 0x6A 0x65 0x63 0x74 0x43 0x6C 0x61 0x73 0x73 0x30
> 0x84 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00
> 0x00 0x00 0x00
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> >>>==========================================
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) -->
> Decoding a PDU
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> >>>------------------------------------------
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TAG_STATE_START ---
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x30
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TAG_STATE_END ---
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x84
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Tag
> TAG[CONSTRUCTED, UNIVERSAL, SEQUENCE_SEQUENCE_OF](size=1) has been decoded
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <LDAP_MESSAGE_TAG> to <LDAP_MESSAGE_VALUE>, action : no
> action>
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_START ---
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x84
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_PENDING ---
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x2D
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_END ---
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x02
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Parent
> length : TLV expected length stack :  - null
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Root
> TLV[45]
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Length
> LENGTH[45](indefinite)size=5) has been decoded
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = VALUE_STATE_START ---
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x02
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TLV_STATE_DONE ---
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x02
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) TLV
> Tree
> : TLV0x30(45)
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <LDAP_MESSAGE_VALUE> to <LDAP_MESSAGE_ID_TAG>, action :
> LdapMessage initialization>
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TAG_STATE_START ---
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x02
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TAG_STATE_END ---
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x01
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Tag
> TAG[PRIMITIVE, UNIVERSAL, INTEGER](size=1) has been decoded
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <LDAP_MESSAGE_ID_TAG> to <LDAP_MESSAGE_ID_VALUE>, action :
> no action>
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_START ---
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x01
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_END ---
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x01
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Parent
> length : TLV expected length stack :  - 45 - null
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Length
> LENGTH[1](indefinite)size=1) has been decoded
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = VALUE_STATE_START ---
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x01
> 2006-11-24 17:31:10,000 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TLV_STATE_DONE ---
> 2006-11-24 17:31:10,156 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x63
> 2006-11-24 17:31:10,156 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) TLV
> Tree
> : TLV0x02(1)-TLV0x30(42)
> 2006-11-24 17:31:10,156 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <LDAP_MESSAGE_ID_VALUE> to <PROTOCOL_OP_TAG>, action :
> Store MessageId>
> 2006-11-24 17:31:10,156 DEBUG
> [org.apache.directory.shared.ldap.codec.LdapMessageGrammar
> ](IoThreadPool-4)
> Ldap Message Id has been decoded : 1
> 2006-11-24 17:31:10,156 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TAG_STATE_START ---
> 2006-11-24 17:31:10,156 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x63
> 2006-11-24 17:31:10,156 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TAG_STATE_END ---
> 2006-11-24 17:31:10,156 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x84
> 2006-11-24 17:31:10,156 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Tag
> TAG[CONSTRUCTED, APPLICATION, ](size=1) has been decoded
> 2006-11-24 17:31:10,156 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <PROTOCOL_OP_TAG> to <SEARCH_REQUEST_GRAMMAR_SWITCH>,
> action : no action>
> 2006-11-24 17:31:10,156 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Switching from grammar LDAP_MESSAGE_GRAMMAR to grammar
> SEARCH_REQUEST_GRAMMAR
> 2006-11-24 17:31:10,156 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <SEARCH_REQUEST_TAG> to <SEARCH_REQUEST_VALUE>, action :
> no action>
> 2006-11-24 17:31:10,156 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_START ---
> 2006-11-24 17:31:10,156 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x84
> 2006-11-24 17:31:10,156 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_PENDING ---
> 2006-11-24 17:31:10,156 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,156 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,156 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,156 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,156 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x24
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_END ---
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x04
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Parent
> length : TLV expected length stack :  - 42 - null
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Length
> LENGTH[36](indefinite)size=5) has been decoded
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = VALUE_STATE_START ---
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x04
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TLV_STATE_DONE ---
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x04
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) TLV
> Tree
> : TLV0x63(36)-TLV0x30(0)
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <SEARCH_REQUEST_VALUE> to
> <SEARCH_REQUEST_BASE_OBJECT_TAG>, action : Init SearchRequest>
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TAG_STATE_START ---
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x04
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TAG_STATE_END ---
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Tag
> TAG[PRIMITIVE, UNIVERSAL, OCTET_STRING](size=1) has been decoded
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <SEARCH_REQUEST_BASE_OBJECT_TAG> to
> <SEARCH_REQUEST_BASE_OBJECT_VALUE>, action : no action>
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_START ---
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_END ---
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x0A
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Parent
> length : TLV expected length stack :  - 36 - 0 - null
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Length
> LENGTH[0](indefinite)size=1) has been decoded
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TLV_STATE_DONE ---
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x0A
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) TLV
> Tree
> : TLV0x04(0)-TLV0x63(34)-TLV0x30(0)
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <SEARCH_REQUEST_BASE_OBJECT_VALUE> to
> <SEARCH_REQUEST_SCOPE_TAG>, action : store base object value>
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.ldap.codec.search.SearchRequestGrammar
> ](IoThreadPool-4)
> Searching with root DN :
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TAG_STATE_START ---
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x0A
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TAG_STATE_END ---
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x01
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Tag
> TAG[PRIMITIVE, UNIVERSAL, ENUMERATED](size=1) has been decoded
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <SEARCH_REQUEST_SCOPE_TAG> to
> <SEARCH_REQUEST_SCOPE_VALUE>, action : no action>
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_START ---
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x01
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_END ---
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Parent
> length : TLV expected length stack :  - 34 - 0 - null
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Length
> LENGTH[1](indefinite)size=1) has been decoded
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = VALUE_STATE_START ---
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TLV_STATE_DONE ---
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x0A
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) TLV
> Tree
> : TLV0x0A(1)-TLV0x63(31)-TLV0x30(0)
> 2006-11-24 17:31:10,171 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <SEARCH_REQUEST_SCOPE_VALUE> to
> <SEARCH_REQUEST_DEREF_ALIASES_TAG>, action : store scope value>
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.ldap.codec.search.SearchRequestGrammar
> ](IoThreadPool-4)
> Searching within BASE_OBJECT scope
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TAG_STATE_START ---
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x0A
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TAG_STATE_END ---
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x01
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Tag
> TAG[PRIMITIVE, UNIVERSAL, ENUMERATED](size=1) has been decoded
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <SEARCH_REQUEST_DEREF_ALIASES_TAG> to
> <SEARCH_REQUEST_DEREF_ALIASES_VALUE>, action : no action>
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_START ---
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x01
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_END ---
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Parent
> length : TLV expected length stack :  - 31 - 0 - null
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Length
> LENGTH[1](indefinite)size=1) has been decoded
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = VALUE_STATE_START ---
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TLV_STATE_DONE ---
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x02
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) TLV
> Tree
> : TLV0x0A(1)-TLV0x63(28)-TLV0x30(0)
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <SEARCH_REQUEST_DEREF_ALIASES_VALUE> to
> <SEARCH_REQUEST_SIZE_LIMIT_TAG>, action : store derefAliases value>
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.ldap.codec.search.SearchRequestGrammar
> ](IoThreadPool-4)
> Handling object strategy : NEVER_DEREF_ALIASES
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TAG_STATE_START ---
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x02
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TAG_STATE_END ---
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x01
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Tag
> TAG[PRIMITIVE, UNIVERSAL, INTEGER](size=1) has been decoded
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <SEARCH_REQUEST_SIZE_LIMIT_TAG> to
> <SEARCH_REQUEST_SIZE_LIMIT_VALUE>, action : no action>
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_START ---
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x01
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_END ---
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Parent
> length : TLV expected length stack :  - 28 - 0 - null
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Length
> LENGTH[1](indefinite)size=1) has been decoded
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = VALUE_STATE_START ---
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TLV_STATE_DONE ---
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x02
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) TLV
> Tree
> : TLV0x02(1)-TLV0x63(25)-TLV0x30(0)
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <SEARCH_REQUEST_SIZE_LIMIT_VALUE> to
> <SEARCH_REQUEST_TIME_LIMIT_TAG>, action : store sizeLimit value>
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.ldap.codec.search.SearchRequestGrammar
> ](IoThreadPool-4)
> The sizeLimit value is set to 0 objects
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TAG_STATE_START ---
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x02
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TAG_STATE_END ---
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x01
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Tag
> TAG[PRIMITIVE, UNIVERSAL, INTEGER](size=1) has been decoded
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <SEARCH_REQUEST_TIME_LIMIT_TAG> to
> <SEARCH_REQUEST_TIME_LIMIT_VALUE>, action : no action>
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_START ---
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x01
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_END ---
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Parent
> length : TLV expected length stack :  - 25 - 0 - null
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Length
> LENGTH[1](indefinite)size=1) has been decoded
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = VALUE_STATE_START ---
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TLV_STATE_DONE ---
> 2006-11-24 17:31:10,187 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x01
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) TLV
> Tree
> : TLV0x02(1)-TLV0x63(22)-TLV0x30(0)
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <SEARCH_REQUEST_TIME_LIMIT_VALUE> to
> <SEARCH_REQUEST_TYPES_ONLY_TAG>, action : store timeLimit value>
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.ldap.codec.search.SearchRequestGrammar
> ](IoThreadPool-4)
> The timeLimit value is set to 0 seconds
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TAG_STATE_START ---
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x01
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TAG_STATE_END ---
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x01
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Tag
> TAG[PRIMITIVE, UNIVERSAL, BOOLEAN](size=1) has been decoded
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <SEARCH_REQUEST_TYPES_ONLY_TAG> to
> <SEARCH_REQUEST_TYPES_ONLY_VALUE>, action : no action>
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_START ---
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x01
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_END ---
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Parent
> length : TLV expected length stack :  - 22 - 0 - null
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Length
> LENGTH[1](indefinite)size=1) has been decoded
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = VALUE_STATE_START ---
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TLV_STATE_DONE ---
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x87
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) TLV
> Tree
> : TLV0x01(1)-TLV0x63(19)-TLV0x30(0)
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <SEARCH_REQUEST_TYPES_ONLY_VALUE> to
> <SEARCH_REQUEST_FILTER>, action : store typesOnly value>
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.ldap.codec.search.SearchRequestGrammar
> ](IoThreadPool-4)
> The search will return attributes types and values
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TAG_STATE_START ---
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x87
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TAG_STATE_END ---
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x0B
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Tag
> TAG[PRIMITIVE, CONTEXTUAL, 7](size=1) has been decoded
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <SEARCH_REQUEST_FILTER> to <FILTER_GRAMMAR_SWITCH>, action
> : no action>
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Switching from grammar SEARCH_REQUEST_GRAMMAR to grammar FILTER_GRAMMAR
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <FILTER_TAG> to <FILTER_PRESENT_VALUE>, action : no
> action>
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_START ---
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x0B
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_END ---
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x6F
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Parent
> length : TLV expected length stack :  - 19 - 0 - null
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Length
> LENGTH[11](indefinite)size=1) has been decoded
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = VALUE_STATE_START ---
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x6F
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TLV_STATE_DONE ---
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x30
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) TLV
> Tree
> : TLV0x87(11)-TLV0x63(6)-TLV0x30(0)
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <FILTER_PRESENT_VALUE> to <FILTER_TAG>, action : Init
> present filter Value>
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TAG_STATE_START ---
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x30
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TAG_STATE_END ---
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x84
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Tag
> TAG[CONSTRUCTED, UNIVERSAL, SEQUENCE_SEQUENCE_OF](size=1) has been decoded
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Pop grammar FILTER_GRAMMAR, state = FILTER_TAG
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <SEARCH_REQUEST_FILTER> to
> <SEARCH_REQUEST_ATTRIBUTE_DESCRIPTION_LIST_VALUE>, action : no action>
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_START ---
> 2006-11-24 17:31:10,203 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x84
> 2006-11-24 17:31:10,218 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_PENDING ---
> 2006-11-24 17:31:10,218 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,218 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,218 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,218 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,218 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> current byte : 0x00
> 2006-11-24 17:31:10,218 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = LENGTH_STATE_END ---
> 2006-11-24 17:31:10,218 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)   no
> more byte to decode in the stream
> 2006-11-24 17:31:10,218 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Parent
> length : TLV expected length stack :  - 6 - 0 - null
> 2006-11-24 17:31:10,218 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) Length
> LENGTH[0](indefinite)size=5) has been decoded
> 2006-11-24 17:31:10,218 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) ---
> State = TLV_STATE_DONE ---
> 2006-11-24 17:31:10,218 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)   no
> more byte to decode in the stream
> 2006-11-24 17:31:10,218 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) TLV
> Tree
> : TLV0x30(0)
> 2006-11-24 17:31:10,218 DEBUG
> [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar
> ](IoThreadPool-4)
> Transition from <SEARCH_REQUEST_ATTRIBUTE_DESCRIPTION_LIST_VALUE> to
> <SEARCH_REQUEST_ATTRIBUTE_DESCRIPTION_TAG>, action : store Attribute
> Description List value>
> 2006-11-24 17:31:10,218 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> <<<------------------------------------------
> 2006-11-24 17:31:10,218 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) <--
> Stop
> decoding : TLV[ TAG[CONSTRUCTED, UNIVERSAL, SEQUENCE_SEQUENCE_OF](size=1),
> LENGTH[0](indefinite)size=5), []]
> 2006-11-24 17:31:10,218 DEBUG
> [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4)
> <<<==========================================
> 2006-11-24 17:31:10,218 DEBUG
> [org.apache.directory.shared.ldap.codec.TwixDecoder](IoThreadPool-4)
> Decoded LdapMessage : LdapMessage
>     message Id : 1
>     Search Request
>         Base Object : ''
>         Scope : base object
>         Deref Aliases : never Deref Aliases
>         Size Limit : no limit
>         Time Limit : no limit
>         Types Only : false
>         Filter : '(objectClass=*)'
>
> 2006-11-24 17:31:10,218 DEBUG
> [org.apache.directory.shared.ldap.codec.TwixTransformer](IoThreadPool-4)
> Transforming LdapMessage <1, SEARCH_REQUEST> from Twix to Snickers.
> 2006-11-24 17:31:10,218 INFO
> [org.apache.directory.server.ldap.LdapProtocolProvider$LdapProtocolHandler
> ](IoThreadPool-4)
> [/127.0.0.1:3728] RECEIVED:     SearchRequest
>         baseDn : ''
>         filter : '(objectClass=*) '
>         scope : base object
>         typesOnly : false
> no limit
>         Time Limit : no limit
>         Deref Aliases : never Deref Aliases
>         attributes :
>
> 2006-11-24 17:31:10,234 DEBUG
> [org.apache.directory.server.ldap.support.SearchHandler](IoThreadPool-4)
> Message received :     SearchRequest
>         baseDn : ''
>         filter : '(objectClass=*) '
>         scope : base object
>         typesOnly : false
> no limit
>         Time Limit : no limit
>         Deref Aliases : never Deref Aliases
>         attributes :
>
> 2006-11-24 17:31:10,250 INFO
> [org.apache.directory.server.ldap.LdapProtocolProvider$LdapProtocolHandler
> ](IoThreadPool-4)
> [/127.0.0.1:3728] WRITE:         Ldap Result
>             Result code : (ResultCodeEnum[INSUFFICIENTACCESSRIGHTS=50])
> insufficientAccessRights
>             Matched DN : 'null'
>             Error message : 'failed on search operation:
>     SearchRequest
>         baseDn : ''
>         filter : '(objectClass=*) '
>         scope : base object
>         typesOnly : false
> no limit
>         Time Limit : no limit
>         Deref Aliases : never Deref Aliases
>         attributes :
> :
> org.apache.directory.shared.ldap.exception.LdapNoPermissionException:
> Anonymous access disabled.
>       at
>
> org.apache.directory.server.core.DefaultDirectoryService.checkSecuritySettings
> (DefaultDirectoryService.java:395)
>       at
> org.apache.directory.server.core.DefaultDirectoryService.getJndiContext(
> DefaultDirectoryService.java:134)
>       at
>
> org.apache.directory.server.core.jndi.AbstractContextFactory.getInitialContext
> (AbstractContextFactory.java:121)
>       at
> javax.naming.spi.NamingManager.getInitialContext(NamingManager.java:662)
>       at
> javax.naming.InitialContext.getDefaultInitCtx(InitialContext.java:243)
>       at javax.naming.InitialContext.init(InitialContext.java:219)
>       at
> javax.naming.ldap.InitialLdapContext.<init>(InitialLdapContext.java:133)
>       at
>
> org.apache.directory.server.ldap.SessionRegistry.getLdapContextOnRootDSEAccess
> (SessionRegistry.java:358)
>       at
> org.apache.directory.server.ldap.support.SearchHandler.messageReceived(
> SearchHandler.java:152)
>       at
> org.apache.mina.handler.demux.DemuxingIoHandler.messageReceived(
> DemuxingIoHandler.java:128)
>       at
>
> org.apache.directory.server.ldap.LdapProtocolProvider$LdapProtocolHandler.messageReceived
> (LdapProtocolProvider.java:431)
>       at
> org.apache.mina.common.support.AbstractIoFilterChain$2.messageReceived(
> AbstractIoFilterChain.java:188)
>       at
>
> org.apache.mina.common.support.AbstractIoFilterChain.callNextMessageReceived
> (AbstractIoFilterChain.java:504)
>       at
> org.apache.mina.common.support.AbstractIoFilterChain.access$1000(
> AbstractIoFilterChain.java:51)
>       at
> org.apache.mina.common.support.AbstractIoFilterChain$3.messageReceived(
> AbstractIoFilterChain.java:790)
>       at
> org.apache.mina.filter.LoggingFilter.messageReceived(LoggingFilter.java
> :95)
>       at
>
> org.apache.mina.common.support.AbstractIoFilterChain.callNextMessageReceived
> (AbstractIoFilterChain.java:504)
>       at
> org.apache.mina.common.support.AbstractIoFilterChain.access$1000(
> AbstractIoFilterChain.java:51)
>       at
> org.apache.mina.common.support.AbstractIoFilterChain$3.messageReceived(
> AbstractIoFilterChain.java:790)
>       at
> org.apache.mina.filter.codec.ProtocolCodecFilter.messageReceived(
> ProtocolCodecFilter.java:187)
>       at
>
> org.apache.mina.common.support.AbstractIoFilterChain.callNextMessageReceived
> (AbstractIoFilterChain.java:504)
>       at
> org.apache.mina.common.support.AbstractIoFilterChain.access$1000(
> AbstractIoFilterChain.java:51)
>       at
> org.apache.mina.common.support.AbstractIoFilterChain$3.messageReceived(
> AbstractIoFilterChain.java:790)
>       at
> org.apache.mina.filter.ThreadPoolFilter.processEvent(ThreadPoolFilter.java
> :706)
>       at
> org.apache.mina.filter.ThreadPoolFilter$Worker.processEvents(
> ThreadPoolFilter.java:462)
>       at
> org.apache.mina.filter.ThreadPoolFilter$Worker.run(ThreadPoolFilter.java
> :417)
>
>


-- 
Cordialement,
Emmanuel Lécharny