Return-Path: Delivered-To: apmail-directory-dev-archive@www.apache.org Received: (qmail 31725 invoked from network); 27 Nov 2006 14:01:26 -0000 Received: from hermes.apache.org (HELO mail.apache.org) (140.211.11.2) by minotaur.apache.org with SMTP; 27 Nov 2006 14:01:26 -0000 Received: (qmail 28699 invoked by uid 500); 27 Nov 2006 14:01:35 -0000 Delivered-To: apmail-directory-dev-archive@directory.apache.org Received: (qmail 28482 invoked by uid 500); 27 Nov 2006 14:01:34 -0000 Mailing-List: contact dev-help@directory.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: "Apache Directory Developers List" Delivered-To: mailing list dev@directory.apache.org Received: (qmail 28471 invoked by uid 99); 27 Nov 2006 14:01:34 -0000 Received: from herse.apache.org (HELO herse.apache.org) (140.211.11.133) by apache.org (qpsmtpd/0.29) with ESMTP; Mon, 27 Nov 2006 06:01:34 -0800 X-ASF-Spam-Status: No, hits=2.5 required=10.0 tests=HTML_MESSAGE,NO_REAL_NAME X-Spam-Check-By: apache.org Received-SPF: pass (herse.apache.org: local policy) Received: from [194.75.234.2] (HELO smtpgate.saa-cons.co.uk) (194.75.234.2) by apache.org (qpsmtpd/0.29) with ESMTP; Mon, 27 Nov 2006 06:01:19 -0800 Received: (from mailnull@localhost) by smtpgate.saa-cons.co.uk (8.13.1/8.12.8) id kARE1aUQ095461 for ; Mon, 27 Nov 2006 14:01:36 GMT (envelope-from Simon.Temple@saaconsultants.com) Received: from domino-mail.saa-cons.co.uk(10.10.10.4) by smtpgate.saa-cons.co.uk via smap (V2.1) id xma095455; Mon, 27 Nov 06 14:01:28 GMT To: "Apache Directory Developers List" Subject: Re: Windows LDAP Clients Hanging - DS 1.0 MIME-Version: 1.0 Date: Mon, 27 Nov 2006 14:00:45 +0000 Message-ID: From: Simon.Temple@saaconsultants.com X-MIMETrack: Serialize by Router on domino-mail/Saa(Release 7.0.1FP1|April 17, 2006) at 27/11/2006 14:00:48, Serialize complete at 27/11/2006 14:00:48 Content-Type: multipart/alternative; boundary=alternative_NB3672_26109 X-Virus-Checked: Checked by ClamAV on apache.org --alternative_NB3672_26109 Content-Type: text/plain; charset="iso-8859-1" Content-Transfer-Encoding: quoted-printable Emmanuel The client is a windows program called ldp v3 (it uses wldap32.dll). Its here: http://www.computerperformance.co.uk/w2k3/utilities/ldp.htm You are correct, it is performing a search for rootDSE. On the subject of test cases. I found that I could not build directory-s= hared becuase \shared\0.9.5\ldap\src\test has references to a Java 1.5 cl= ass :-( To clarify, the server is *not* hanging... the client is hanging, waiting= for a response to the search. If I can help anymore, please ask. Simon 27 November 2006 13:28 To: "Apache Directory Developers List" cc: = From: "Emmanuel Lecharny" Subject: Re: Windows LDAP Clients Hanging - DS 1.0 Simon, what I can say from those two TLVs is that their length is supposed to be= : 0x30 0x84 0x00 0x00 0x00 0x2D ;; LdapMessage, length =3D 45 bytes 0x02 0x01 0x01 ;; Message ID =3D 1 0x63 0x84 0x00 0x00 0x00 0x24 ;; SearchRequest, length =3D 36 bytes 0x04 0x00 ;; Base object is null (rootDSE= request) = 0x0A 0x01 0x00 ;; Scope is Base 0x0A 0x01 0x00 ;; Deref alias is NO 0x02 0x01 0x00 ;; No size limit 0x02 0x01 0x00 ;; No time limit = 0x01 0x01 0x00 ;; Types only is NO 0x87 0x0B ;; PRESENT filter, size is 11 by= tes, value is 'objectClass' 0x6F 0x62 0x6A 0x65 0x63 0x74 0x43 0x6C 0x61 0x73 0x73 = 0x30 0x84 0x00 0x00 0x00 0x00 ;; Attribute description list is null plus some remaining 0, which is not a problem : 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 Now, I guess that this is a search for rootDSE. What I don't get is why i= s your client construct lenght like the one we get (0x84 0x00 0x00 0x00 0= x2D). Which kind of client do you use? = Anyway, the server should not hang with such a PDU. I gonna create a unit= test with the PDU you sent me, just to be sure. Emmanuel On 11/27/06, Simon.Temple@saaconsultants.com wrote: Emmanuel The results I first attached are for the 1.0.1 trunk I built from SVN on = Friday. Starting to look a little deeper I note the PDU decoded by each is versio= n different. (i.e. the short PDU fails to decode and hence hangs the cli= ent - see below) Looking at the last two changes you made to Asn1Decoder.java, one for DIR= SERVER-745 and another for "simplified the TLV handling" is it possible e= ither of these introduced the new behaviour? SimonT ------------ 1.0.1 ------------ Decoding the PDU : 2006-11-24 17:04:35,828 DEBUG [org.apache.directory.shared.ldap.codec.TwixDecoder](pool-3-thread-2) 0x3= 0 0x84 0x00 0x00 0x00 0x2D 0x02 0x01 0x01 0x63 0x84 0x00 0x00 0x00 0x24 0x0= 4 = 0x00 0x0A 0x01 0x00 0x0A 0x01 0x00 0x02 0x01 0x00 0x02 0x01 0x00 0x01 0x0= 1 0x00 0x87 0x0B 0x6F 0x62 0x6A 0x65 0x63 0x74 0x43 0x6C 0x61 0x73 0x73 0x3= 0 0x84 0x00 0x00 0x00 0x00 ------------ 1.0-RC3 ------------ Decoding the PDU : 2006-11-24 17:31:10,000 DEBUG [org.apache.directory.shared.ldap.codec.TwixDecoder ](IoThreadPool-4) 0x3= 0 0x84 0x00 0x00 0x00 0x2D 0x02 0x01 0x01 0x63 0x84 0x00 0x00 0x00 0x24 0x0= 4 0x00 0x0A 0x01 0x00 0x0A 0x01 0x00 0x02 0x01 0x00 0x02 0x01 0x00 0x01 0x0= 1 0x00 0x87 0x0B 0x6F 0x62 0x6A 0x65 0x63 0x74 0x43 0x6C 0x61 0x73 0x73 0x3= 0 = 0x84 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x0= 0 0x00 0x00 0x00 27 November 2006 10:54 To: "Apache Directory Developers List" cc: = From: "Emmanuel Lecharny" Subject: Re: Windows LDAP Clients Hanging - DS 1.0 Hi Simon, can you give 1.0.1 tunks a try? I just committed some fix for this NPE pr= oblem. = Could you be kind enough to give me a feedback? Thanks a lot ! Emmanuel On 11/27/06, Simon.Temple@saaconsultants.com wrote: = Emmanuel Yeah... I spotted the NPE which is why I pulled the 1.0.1 branch from SVN= =2E The attached DEBUG output is just so you can contrast a working 1.0-RC3 w= ith a 'hanging' 1.0 Regards SimonT 24 November 2006 17:59 To: "Apache Directory Developers List" cc: = From: "Emmanuel Lecharny" Subject: Re: Windows LDAP Clients Hanging - DS 1.0 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 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. =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D V1.0 / V1.0.1 =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D 2006-11-24 17:04:35,390 DEBUG [org.apache.mina.filter.executor.ExecutorFilter ](SocketAcceptorIoProcess= or-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](SocketAcceptorIoProcesso= r-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) >>>=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D 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 =3D 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 =3D 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 =3D 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 =3D 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) Pare= nt 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) Lengt= h 45 has been decoded 2006-11-24 17:04:35,640 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) --- State =3D 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 =3D 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-thr= ead-2) Transition from state to 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 =3D 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 =3D 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 =3D 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) Paren= t 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) Lengt= h 1 has been decoded 2006-11-24 17:04:35,640 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) --- State =3D 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 =3D 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-thr= ead-2) Transition from state to 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 =3D 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 =3D 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 =3D 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 =3D 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) Paren= t 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) Lengt= h 36 has been decoded 2006-11-24 17:04:35,781 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) --- State =3D 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 =3D 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-thr= ead-2) Transition from state to 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 =3D 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 =3D 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 =3D 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) Paren= t 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) Lengt= h 0 has been decoded 2006-11-24 17:04:35,781 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) --- State =3D 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-thr= ead-2) Transition from state to 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 =3D 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 =3D 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 =3D 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) Pare= nt 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) Lengt= h 1 has been decoded 2006-11-24 17:04:35,781 DEBUG = [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) --- State =3D 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 =3D 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-thr= ead-2) Transition from state to 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 =3D 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 =3D 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 =3D 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) Paren= t = 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) Lengt= h 1 has been decoded 2006-11-24 17:04:35,796 DEBUG = [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) --- State =3D 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 =3D 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-thr= ead-2) Transition from state to 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 =3D 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 =3D 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 =3D 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) Paren= t = 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) Lengt= h 1 has been decoded 2006-11-24 17:04:35,796 DEBUG = [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) --- State =3D 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 =3D 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-thr= ead-2) Transition from state to state , ta= g <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 =3D 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 =3D 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 =3D 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) Paren= t = 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) Lengt= h 1 has been decoded 2006-11-24 17:04:35,796 DEBUG = [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) --- State =3D 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 =3D 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-thr= ead-2) Transition from state to 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 =3D 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 =3D 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 =3D 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) Paren= t = 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) Lengt= h 1 has been decoded 2006-11-24 17:04:35,812 DEBUG = [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) --- State =3D 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 =3D 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-thr= ead-2) Transition from state to 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 =3D 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 =3D 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 =3D 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) Paren= t = 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) Lengt= h 11 has been decoded 2006-11-24 17:04:35,812 DEBUG = [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) --- State =3D 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 =3D 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-thr= ead-2) Transition from state to 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 =3D 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 =3D 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 =3D 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) <-- E= nd decoding : TLV[ 0x30, 0, []] = 2006-11-24 17:04:35,828 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-thread-2) <<<=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D 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) 0x3= 0 0x84 0x00 0x00 0x00 0x2D 0x02 0x01 0x01 0x63 0x84 0x00 0x00 0x00 0x24 0x0= 4 = 0x00 0x0A 0x01 0x00 0x0A 0x01 0x00 0x02 0x01 0x00 0x02 0x01 0x00 0x01 0x0= 1 0x00 0x87 0x0B 0x6F 0x62 0x6A 0x65 0x63 0x74 0x43 0x6C 0x61 0x73 0x73 0x3= 0 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 =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D V1.0-RC3 =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D 2006-11-24 17:31:09,796 INFO [org.apache.directory.server.ldap.LdapProtocolProvider$LdapProtocolHandle= r ](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) 0x3= 0 0x84 0x00 0x00 0x00 0x2D 0x02 0x01 0x01 0x63 0x84 0x00 0x00 0x00 0x24 0x0= 4 0x00 0x0A 0x01 0x00 0x0A 0x01 0x00 0x02 0x01 0x00 0x02 0x01 0x00 0x01 0x0= 1 0x00 0x87 0x0B 0x6F 0x62 0x6A 0x65 0x63 0x74 0x43 0x6C 0x61 0x73 0x73 0x3= 0 = 0x84 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x0= 0 0x00 0x00 0x00 2006-11-24 17:31:10,000 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) >>>=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D = 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 =3D 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 =3D 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=3D1) has been deco= ded 2006-11-24 17:31:10,000 DEBUG [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPo= ol-4) Transition from to , action : no = action> 2006-11-24 17:31:10,000 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- State =3D 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 =3D 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 =3D 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) Paren= t 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=3D5) has been decoded 2006-11-24 17:31:10,000 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- = State =3D 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 =3D 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 T= ree : TLV0x30(45) 2006-11-24 17:31:10,000 DEBUG [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPo= ol-4) Transition from to , action : = LdapMessage initialization> 2006-11-24 17:31:10,000 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- State =3D 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 =3D 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=3D1) has been decoded 2006-11-24 17:31:10,000 DEBUG = [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPo= ol-4) Transition from to , action = : no action> 2006-11-24 17:31:10,000 DEBUG = [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- State =3D 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 =3D 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=3D1) has been decoded 2006-11-24 17:31:10,000 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- = State =3D 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 =3D 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 T= ree : TLV0x02(1)-TLV0x30(42) 2006-11-24 17:31:10,156 DEBUG [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPo= ol-4) Transition from to , 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 =3D 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 =3D 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=3D1) has been decoded 2006-11-24 17:31:10,156 DEBUG [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPo= ol-4) Transition from to , = action : no action> 2006-11-24 17:31:10,156 DEBUG [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPo= ol-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](IoThreadPo= ol-4) Transition from to , action : no action> = 2006-11-24 17:31:10,156 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- State =3D 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 =3D 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 =3D 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) Paren= t 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=3D5) has been decoded = 2006-11-24 17:31:10,171 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- State =3D 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 =3D 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 Tr= ee : TLV0x63(36)-TLV0x30(0) 2006-11-24 17:31:10,171 DEBUG [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar ](IoThreadP= ool-4) Transition from to , action : Init SearchRequest> 2006-11-24 17:31:10,171 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder ](IoThreadPool-4) --- State =3D 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 =3D 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=3D1) has been decoded 2006-11-24 17:31:10,171 DEBUG [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPo= ol-4) Transition from to = , action : no action> 2006-11-24 17:31:10,171 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- State =3D 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 =3D 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=3D1) has been decoded 2006-11-24 17:31:10,171 DEBUG = [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- State =3D 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 Tr= ee : TLV0x04(0)-TLV0x63(34)-TLV0x30(0) 2006-11-24 17:31:10,171 DEBUG [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar ](IoThreadP= ool-4) Transition from to , action : store base object value> 2006-11-24 17:31:10,171 DEBUG [org.apache.directory.shared.ldap.codec.search.SearchRequestGrammar ](IoT= hreadPool-4) Searching with root DN : 2006-11-24 17:31:10,171 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- State =3D 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 =3D 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=3D1) has been decoded 2006-11-24 17:31:10,171 DEBUG [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPo= ol-4) Transition from to = , action : no action> 2006-11-24 17:31:10,171 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- State =3D 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 =3D 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=3D1) has been decoded 2006-11-24 17:31:10,171 DEBUG = [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- State =3D 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 =3D 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 Tr= ee : TLV0x0A(1)-TLV0x63(31)-TLV0x30(0) 2006-11-24 17:31:10,171 DEBUG = [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPo= ol-4) Transition from to , action : store scope value> 2006-11-24 17:31:10,187 DEBUG = [org.apache.directory.shared.ldap.codec.search.SearchRequestGrammar](IoTh= readPool-4) Searching within BASE_OBJECT scope 2006-11-24 17:31:10,187 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- = State =3D 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 =3D 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=3D1) has been decoded 2006-11-24 17:31:10,187 DEBUG [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPo= ol-4) Transition from to = , action : no action> 2006-11-24 17:31:10,187 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- State =3D 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 =3D 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=3D1) has been decoded 2006-11-24 17:31:10,187 DEBUG = [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- State =3D 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 =3D 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 Tr= ee : TLV0x0A(1)-TLV0x63(28)-TLV0x30(0) 2006-11-24 17:31:10,187 DEBUG = [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPo= ol-4) Transition from to , action : store derefAliases value> = 2006-11-24 17:31:10,187 DEBUG [org.apache.directory.shared.ldap.codec.search.SearchRequestGrammar](IoTh= readPool-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 =3D 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 =3D 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=3D1) has been decoded 2006-11-24 17:31:10,187 DEBUG [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPo= ol-4) Transition from to = , action : no action> 2006-11-24 17:31:10,187 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- State =3D 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 =3D 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=3D1) has been decoded 2006-11-24 17:31:10,187 DEBUG = [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- State =3D 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 =3D 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 Tr= ee : TLV0x02(1)-TLV0x63(25)-TLV0x30(0) 2006-11-24 17:31:10,187 DEBUG = [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPo= ol-4) Transition from to , action : store sizeLimit value> = 2006-11-24 17:31:10,187 DEBUG [org.apache.directory.shared.ldap.codec.search.SearchRequestGrammar](IoTh= readPool-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 =3D 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 =3D 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=3D1) has been decoded 2006-11-24 17:31:10,187 DEBUG [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPo= ol-4) Transition from to = , action : no action> 2006-11-24 17:31:10,187 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- State =3D 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 =3D 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=3D1) has been decoded 2006-11-24 17:31:10,187 DEBUG = [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- State =3D 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 =3D 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 Tr= ee : TLV0x02(1)-TLV0x63(22)-TLV0x30(0) 2006-11-24 17:31:10,203 DEBUG = [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPo= ol-4) Transition from to , action : store timeLimit value> = 2006-11-24 17:31:10,203 DEBUG [org.apache.directory.shared.ldap.codec.search.SearchRequestGrammar](IoTh= readPool-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 =3D 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 =3D 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=3D1) has been decoded 2006-11-24 17:31:10,203 DEBUG [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPo= ol-4) Transition from to = , action : no action> 2006-11-24 17:31:10,203 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- State =3D 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 =3D 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=3D1) has been decoded 2006-11-24 17:31:10,203 DEBUG = [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- State =3D 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 =3D 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 Tr= ee : TLV0x01(1)-TLV0x63(19)-TLV0x30(0) 2006-11-24 17:31:10,203 DEBUG = [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPo= ol-4) Transition from to , action : store typesOnly value> 2006-11-24 17:31:10,203 DEBUG = [org.apache.directory.shared.ldap.codec.search.SearchRequestGrammar](IoTh= readPool-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 =3D 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 =3D 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=3D1) has been decoded 2006-11-24 17:31:10,203 DEBUG [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPo= ol-4) Transition from to , actio= n = : no action> 2006-11-24 17:31:10,203 DEBUG [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPo= ol-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](IoThreadPo= ol-4) Transition from to , action : no action> 2006-11-24 17:31:10,203 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder ](IoThreadPool-4) --- State =3D 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 =3D 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) Paren= t 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=3D1) has been decoded = 2006-11-24 17:31:10,203 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- State =3D 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 =3D 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 Tr= ee : TLV0x87(11)-TLV0x63(6)-TLV0x30(0) 2006-11-24 17:31:10,203 DEBUG = [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPo= ol-4) Transition from to , action : Init present filter Value> 2006-11-24 17:31:10,203 DEBUG = [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) --- State =3D 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 =3D 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=3D1) has been deco= ded = 2006-11-24 17:31:10,203 DEBUG [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPo= ol-4) Pop grammar FILTER_GRAMMAR, state =3D FILTER_TAG 2006-11-24 17:31:10,203 DEBUG [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar ](IoThreadP= ool-4) Transition from to , action : no action> 2006-11-24 17:31:10,203 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder ](IoThreadPool-4) --- State =3D 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 =3D 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 =3D 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=3D5) has been decoded 2006-11-24 17:31:10,218 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder ](IoThreadPool-4) --- State =3D 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 Tr= ee : TLV0x30(0) 2006-11-24 17:31:10,218 DEBUG [org.apache.directory.shared.asn1.ber.grammar.AbstractGrammar](IoThreadPo= ol-4) Transition from to = , 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) <-- St= op decoding : TLV[ TAG[CONSTRUCTED, UNIVERSAL, SEQUENCE_SEQUENCE_OF](size=3D= 1), LENGTH[0](indefinite)size=3D5), []] = 2006-11-24 17:31:10,218 DEBUG [org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool-4) <<<=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D 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=3D*)' 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$LdapProtocolHandle= r](IoThreadPool-4) [/127.0.0.1:3728] RECEIVED: SearchRequest baseDn : '' filter : '(objectClass=3D*) ' = 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=3D*) ' 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$LdapProtocolHandle= r](IoThreadPool-4) [/127.0.0.1:3728] WRITE: Ldap Result = Result code : (ResultCodeEnum[INSUFFICIENTACCESSRIGHTS=3D50])= insufficientAccessRights Matched DN : 'null' Error message : 'failed on search operation: SearchRequest baseDn : '' filter : '(objectClass=3D*) ' 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.checkSecuritySet= tings(DefaultDirectoryService.java :395) at org.apache.directory.server.core.DefaultDirectoryService.getJndiContext(D= efaultDirectoryService.java:134) at org.apache.directory.server.core.jndi.AbstractContextFactory.getInitialCo= ntext ( 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.(InitialLdapContext.java:133) at org.apache.directory.server.ldap.SessionRegistry.getLdapContextOnRootDSEA= ccess(SessionRegistry.java :358) at org.apache.directory.server.ldap.support.SearchHandler.messageReceived(Se= archHandler.java:152) at org.apache.mina.handler.demux.DemuxingIoHandler.messageReceived(DemuxingI= oHandler.java :128) = at org.apache.directory.server.ldap.LdapProtocolProvider$LdapProtocolHandler= =2EmessageReceived(LdapProtocolProvider.java:431) at org.apache.mina.common.support.AbstractIoFilterChain$2.messageReceived (A= bstractIoFilterChain.java:188) at org.apache.mina.common.support.AbstractIoFilterChain.callNextMessageRecei= ved(AbstractIoFilterChain.java:504) at org.apache.mina.common.support.AbstractIoFilterChain.access$1000 (Abstrac= tIoFilterChain.java:51) at org.apache.mina.common.support.AbstractIoFilterChain$3.messageReceived(Ab= stractIoFilterChain.java:790) at org.apache.mina.filter.LoggingFilter.messageReceived ( LoggingFilter.java= :95) at org.apache.mina.common.support.AbstractIoFilterChain.callNextMessageRecei= ved(AbstractIoFilterChain.java:504) at org.apache.mina.common.support.AbstractIoFilterChain.access$1000(Abstract= IoFilterChain.java :51) at org.apache.mina.common.support.AbstractIoFilterChain$3.messageReceived(Ab= stractIoFilterChain.java:790) at org.apache.mina.filter.codec.ProtocolCodecFilter.messageReceived(Protocol= CodecFilter.java :187) at org.apache.mina.common.support.AbstractIoFilterChain.callNextMessageRecei= ved(AbstractIoFilterChain.java:504) at org.apache.mina.common.support.AbstractIoFilterChain.access$1000(Abstract= IoFilterChain.java :51) at org.apache.mina.common.support.AbstractIoFilterChain$3.messageReceived(Ab= stractIoFilterChain.java:790) at org.apache.mina.filter.ThreadPoolFilter.processEvent(ThreadPoolFilter.jav= a:706) = at org.apache.mina.filter.ThreadPoolFilter$Worker.processEvents(ThreadPoolFi= lter.java:462) at org.apache.mina.filter.ThreadPoolFilter$Worker.run(ThreadPoolFilter.java:= 417) -- = Cordialement, Emmanuel L=EF=BF=BDcharny = -- = Cordialement, Emmanuel L=C3=A9charny = -- = Cordialement, Emmanuel L=C3=A9charny = --alternative_NB3672_26109 Content-Type: text/html; charset="iso-8859-1" Content-Transfer-Encoding: quoted-printable
Emmanuel
The client is a windows program called ldp v3 (it uses wldap32.dll).=
 
 
You are correct, it is performing a search for rootDSE.
 
On the subject of test cases.  I found that I could not bu= ild = directory-shared becuase \shared\0.9.5\ldap\src\test has references to a = Java = 1.5 class :-(
To clarify, the server is *not* hanging... the client is hanging, wa= iting = for a response to the search.
 
If I can help anymore, please ask.
 
Simon
 
27 November 2006 13:28
To: "Apache Directory Developers List" = <dev@directory.apache.org>
cc:
From: "Emmanuel Lecharny" = <elecharny@gmail.com>
Subject: Re: Windows LDAP Clients Hanging = - DS = 1.0

Simon,

what I can say from those two TL= Vs is = that their length is supposed to be :
0x30 = 0x84 0x00 0x00 0x00 0x2D ;; LdapMessage, length =3D 45 bytes
  0x= 02 0x01 = 0x01           &nb= sp;           = ;; Message ID =3D 1
  0x63 0x84 0x00 0x00 0x00 0x24 ;; SearchRequ= est, = length =3D 36 bytes
    0x04 = 0x00           &nb= sp;           &nbs= p;     = ;; Base object is null (rootDSE request)
    0x0A 0x01= = 0x00           &nb= sp;         = ;; Scope is Base
    0x0A 0x01 = 0x00           &nb= sp;         = ;; Deref alias is NO
    0x02 0x01 = 0x00           &nb= sp;         = ;; No size limit
    0x02 0x01 = 0x00           &nb= sp;         = ;; No time limit
    0x01 0x01 = 0x00           &nb= sp;         = ;; Types only is NO
    0x87 = 0x0B           &nb= sp;           &nbs= p;    = ;; PRESENT filter, size is 11 bytes, value is = 'objectClass'
      0x6F 0x62 0x6A 0x65 0x63 = 0x74 = 0x43 0x6C 0x61 0x73 0x73
    0x30 0x84 0x00 0x00 0x00 = 0x00 ;; = Attribute description list is null

plus some remaining 0, which is= not a = problem :

0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0= x00 = 0x00

Now, I guess that this is a search for rootDSE.= What I = don't get is why is your client construct lenght like the one we get (0x8= 4 0x00 = 0x00 0x00 0x2D). Which kind of client do you use?

Anyway, the ser= ver = should not hang with such a PDU. I gonna create a unit test with the PDU = you = sent me, just to be sure.

Emmanuel

On 11/27/06, <= A = href=3D"mailto:Simon.Temple@saaconsultants.com">Simon.Temple@saaconsultan= ts.com = <Simon.Temple@saaconsultan= ts.com> = wrote:
Emmanuel
The = results I first attached are for the 1.0.1 trunk I built from SVN on = Friday.
 
Starting = to look a little deeper I note the PDU decoded by each is version = different.  (i.e. the short PDU fails to decode and hence hangs th= e = client - see below)
 
Looking = at the last two changes you made to Asn1Decoder.java, one for DIRSERVER= -745 = and another for "simplified the TLV handling" is it possible either of = these = introduced the new behaviour?
 
 
SimonT
 
------------
1.0.1
------------
Decoding = the PDU :
2006-11-24 17:04:35,828 = DEBUG
[org.apache.directory.shared.ldap.codec.TwixDecoder](pool-3-th= read-2) = 0x30
0x84 0x00 0x00 0x00 0x2D 0x02 0x01 0x01 0x63 0x84 0x00 0x00 0x0= 0 0x24 = 0x04
0x00 0x0A 0x01 0x00 0x0A 0x01 0x00 0x02 0x01 0x00 0x02 0x01 0x= 00 0x01 = 0x01
0x00 0x87 0x0B 0x6F 0x62 0x6A 0x65 0x63 0x74 0x43 0x6C 0x61 0x7= 3 0x73 = 0x30
0x84 0x00 0x00 0x00 0x00
------------
1.0-RC3
------------
Decoding = the PDU :
2006-11-24 17:31:10,000 = DEBUG
[org.apache.directory.shared.ldap.codec.TwixDecoder ](IoThread= Pool-4) = 0x30
0x84 0x00 0x00 0x00 0x2D 0x02 0x01 0x01 0x63 0x84 0x00 0x00 0x0= 0 0x24 = 0x04
0x00 0x0A 0x01 0x00 0x0A 0x01 0x00 0x02 0x01 0x00 0x02 0x01 0x0= 0 0x01 = 0x01
0x00 0x87 0x0B 0x6F 0x62 0x6A 0x65 0x63 0x74 0x43 0x6C 0x61 0x7= 3 0x73 = 0x30
0x84 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x= 00 0x00 = 0x00
0x00 0x00 0x00
 
27 November 2006 10:54

To: "Apache Direc= tory = Developers List" <dev@directory.apache.org>
cc:
From: "Emma= nuel = Lecharny" <elecharny@gmail.com>
Subject: Re: Windows LDA= P Clients = Hanging - DS 1.0


Hi Simon,

can you= give 1.0.1 = tunks a try? I just committed some fix for this NPE problem.

Co= uld you = be kind enough to give me a feedback?

Thanks a lot = !

Emmanuel

On 11/27/06, Simon.Temple@saaconsultants.com <Simon.Temple@saaconsultants.com> wrote:
Emmanuel
Yeah... I spotted the NPE which is why I pulled the 1.0.1 b= ranch = from SVN.
 
The attached DEBUG output is just so you can contrast a working = 1.0-RC3 = with a 'hanging' 1.0
 
 
Regards
 
SimonT
 
 
24 November 2006 17:59
To: "Apache Directory Developers Li= st" = <dev@directory.apache.org>
cc:
From: "Em= manuel = Lecharny" <elecharny@gmail.com>
Subject: Re: Windows L= DAP = Clients Hanging - DS 1.0

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
app= ears 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 exc= hange - = 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.

=3D=3D=3D=3D=3D=3D=3D= =3D=3D=3D=3D=3D
V1.0 / = V1.0.1
=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D

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-th= read-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](SocketAcc= eptorIoProcessor-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)
>>>=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D=3D=3D=3D=3D=3D
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-threa= d-2)
>>>------------------------------------------
2006-11= -24 = 17:04:35,625 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-= thread-2) = ---
State =3D 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 =3D LENGTH_STATE_START ---
2006-11-24 17:04:35,640 = DEBUG =
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-threa= d-2)
current = byte : 0x84
2006-11-24 17:04:35,640 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-= thread-2) = ---
State =3D LENGTH_STATE_PENDING ---
2006-11-24 17:04:35,6= 40 = 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,64= 0 = 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 =3D 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-threa= d-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 =3D 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 =3D 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.AbstractGram= mar](pool-3-thread-2)
Transition = from state <START_STATE> to state <LDAP_MESSAGE_STATE>,= tag =
<0x30>, action : LdapMessage initialization>
2006-1= 1-24 = 17:04:35,640 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-= thread-2) = ---
State =3D TAG_STATE_START ---
2006-11-24 17:04:35,640 DEB= UG =
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-threa= d-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 =3D 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,64= 0 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-= thread-2) = ---
State =3D 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,64= 0 = 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-threa= d-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 =3D 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 =3D 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.AbstractGram= mar](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-threa= d-2) = ---
State =3D 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 =3D 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 =3D LENGTH_STATE_PENDING ---
200= 6-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 =3D 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,78= 1 = 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-threa= d-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 =3D 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 =3D 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.AbstractGram= mar](pool-3-thread-2)
Transition = from state <MESSAGE_ID_STATE> to state <SEARCH_REQUEST_STA= TE>, =
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 =3D TAG_STATE_START ---
2006-11-24 17:04:35,781 DEB= UG =
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-threa= d-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 =3D 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,78= 1 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-= thread-2) = ---
State =3D 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,78= 1 = 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-threa= d-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 =3D 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.AbstractGram= mar](pool-3-thread-2)
Transition = from state <SEARCH_REQUEST_STATE> to state = <BASE_OBJECT_STATE>,
tag <0x04>, action : store bas= e = 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-threa= d-2) = ---
State =3D 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 =3D 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 =3D 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-threa= d-2) = ---
State =3D 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 =3D 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,79= 6 = 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 =3D 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 =3D LENGTH_STATE_START ---
2006-11-24 17:04:35,796 = DEBUG =
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-threa= d-2)
current = byte : 0x01
2006-11-24 17:04:35,796 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-= thread-2) = ---
State =3D 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-threa= d-2) = ---
State =3D 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 =3D 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,79= 6 = 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 =3D 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 =3D LENGTH_STATE_START ---
2006-11-24 17:04:35,796 = DEBUG =
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-threa= d-2)
current = byte : 0x01
2006-11-24 17:04:35,796 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-= thread-2) = ---
State =3D 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-threa= d-2) = ---
State =3D 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 =3D 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,79= 6 = 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&= gt;, = 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 =3D 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 =3D LENGTH_STATE_START ---
2006-11-24 17:04:35,796 = DEBUG =
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-threa= d-2)
current = byte : 0x01
2006-11-24 17:04:35,796 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-= thread-2) = ---
State =3D 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-threa= d-2) = ---
State =3D 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 =3D 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,81= 2 = 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&g= t;, = 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 =3D 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 =3D LENGTH_STATE_START ---
2006-11-24 17:04:35,812 = DEBUG =
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-threa= d-2)
current = byte : 0x01
2006-11-24 17:04:35,812 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-= thread-2) = ---
State =3D 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-threa= d-2) = ---
State =3D 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 =3D 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,81= 2 = 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&g= t;, = 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 =3D 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 =3D LENGTH_STATE_START ---
2006-11-24 17:04:35,812 = DEBUG =
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-threa= d-2)
current = byte : 0x0B
2006-11-24 17:04:35,812 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-= thread-2) = ---
State =3D 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-threa= d-2) = ---
State =3D 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 =3D 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,81= 2 = 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>
200= 6-11-24 = 17:04:35,812 = DEBUG
[org.apache.directory.shared.ldap.codec.actions.InitPresen= tFilterAction](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 =3D 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 =3D LENGTH_STATE_START ---
2006-11-24 17:04:35,812 = DEBUG =
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-threa= d-2)
current = byte : 0x84
2006-11-24 17:04:35,812 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](pool-3-= thread-2) = ---
State =3D LENGTH_STATE_PENDING ---
2006-11-24 17:04:35,8= 12 = 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,82= 8 = 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)
<<<=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D
2006-11-24 = 17:04:35,828 DEBUG
[org.apache.directory.shared.ldap.codec.TwixD= ecoder = ](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 0x0= 2 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-th= read-2) = Exiting
since queue is empty for = /127.0.0.1:3543

=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D
V1.0= -RC3
=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D
2006-11-24 = 17:31:09,796 = INFO
[org.apache.directory.server.ldap.LdapProtocolProvider$Ldap= ProtocolHandler = ](IoThreadPool-1)
[/127.0.0.1:3728] OPENED
2006-11-24 17:31:1= 0,000 = DEBUG
[org.apache.directory.shared.ldap.codec.TwixDecoder](IoThr= eadPool-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 0= x63 = 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 0x0= 0 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](IoThrea= dPool-4)
>>>=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =
2006-11-24 17:31:10,000 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = -->
Decoding a PDU
2006-11-24 17:31:10,000 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) =
>>>------------------------------------------
2006-= 11-24 = 17:31:10,000 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = ---
State =3D TAG_STATE_START ---
2006-11-24 17:31:10,000 DEB= UG =
[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](IoThrea= dPool-4) = ---
State =3D TAG_STATE_END ---
2006-11-24 17:31:10,000 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x84
2006-11-24 17:31:10,000 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = Tag
TAG[CONSTRUCTED, UNIVERSAL, SEQUENCE_SEQUENCE_OF](size=3D1)= has been = decoded
2006-11-24 17:31:10,000 = DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGram= mar](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](IoThrea= dPool-4) = ---
State =3D 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](IoThrea= dPool-4) = ---
State =3D LENGTH_STATE_PENDING ---
2006-11-24 17:31:10,00= 0 = 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](IoThrea= dPool-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](IoThrea= dPool-4)
current = byte : 0x00
2006-11-24 17:31:10,000 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x2D
2006-11-24 17:31:10,000 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = ---
State =3D LENGTH_STATE_END ---
2006-11-24 17:31:10,000 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-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](IoThrea= dPool-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=3D5) has been decoded
2006-= 11-24 = 17:31:10,000 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = ---
State =3D VALUE_STATE_START ---
2006-11-24 17:31:10,000 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x02
2006-11-24 17:31:10,000 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder = ](IoThreadPool-4) ---
State =3D TLV_STATE_DONE ---
2006-11-24= = 17:31:10,000 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-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.AbstractGram= mar](IoThreadPool-4)
Transition = from <LDAP_MESSAGE_VALUE> to <LDAP_MESSAGE_ID_TAG>, act= ion : =
LdapMessage initialization>
2006-11-24 17:31:10,000 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = ---
State =3D 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](IoThrea= dPool-4) = ---
State =3D 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](IoThrea= dPool-4) = Tag
TAG[PRIMITIVE, UNIVERSAL, INTEGER](size=3D1) 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 =3D LENGTH_STATE_START ---
2006-11-24 17:31:10,000 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x01
2006-11-24 17:31:10,000 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = ---
State =3D 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](IoThrea= dPool-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=3D1) has been decoded
2006-1= 1-24 = 17:31:10,000 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = ---
State =3D VALUE_STATE_START ---
2006-11-24 17:31:10,000 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x01
2006-11-24 17:31:10,000 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder = ](IoThreadPool-4) ---
State =3D TLV_STATE_DONE ---
2006-11-24= = 17:31:10,156 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-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-2= 4 = 17:31:10,156 = DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGram= mar](IoThreadPool-4)
Transition = from <LDAP_MESSAGE_ID_VALUE> to <PROTOCOL_OP_TAG>, acti= on : =
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 =3D TAG_STATE_START ---
2006-11-2= 4 = 17:31:10,156 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x63
2006-11-24 17:31:10,156 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder = ](IoThreadPool-4) ---
State =3D TAG_STATE_END ---
2006-11-24 = 17:31:10,156 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-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=3D1) = has been = decoded
2006-11-24 17:31:10,156 = DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGram= mar](IoThreadPool-4)
Transition = from <PROTOCOL_OP_TAG> to <SEARCH_REQUEST_GRAMMAR_SWITCH&g= t;, =
action : no action>
2006-11-24 17:31:10,156 = DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGram= mar](IoThreadPool-4)
Switching = from grammar LDAP_MESSAGE_GRAMMAR to grammar
SEARCH_REQUEST_GRAM= MAR =
2006-11-24 17:31:10,156 = DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGram= mar](IoThreadPool-4)
Transition = from <SEARCH_REQUEST_TAG> to <SEARCH_REQUEST_VALUE>, ac= tion = :
no action>
2006-11-24 17:31:10,156 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = ---
State =3D 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](IoThrea= dPool-4) = ---
State =3D LENGTH_STATE_PENDING ---
2006-11-24 17:31:10,15= 6 = 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](IoThrea= dPool-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](IoThrea= dPool-4)
current = byte : 0x00
2006-11-24 17:31:10,156 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x24
2006-11-24 17:31:10,171 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = ---
State =3D LENGTH_STATE_END ---
2006-11-24 17:31:10,171 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-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](IoThrea= dPool-4) = Length
LENGTH[36](indefinite)size=3D5) has been decoded
2006= -11-24 = 17:31:10,171 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = ---
State =3D 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](IoThrea= dPool-4) = ---
State =3D 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](IoThrea= dPool-4) = TLV Tree
: TLV0x63(36)-TLV0x30(0)
2006-11-24 17:31:10,171 = DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGram= mar = ](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 =3D TAG_STATE_START ---
2006-11-2= 4 = 17:31:10,171 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x04
2006-11-24 17:31:10,171 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder = ](IoThreadPool-4) ---
State =3D TAG_STATE_END ---
2006-11-24 = 17:31:10,171 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-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](si= ze=3D1) = has been decoded
2006-11-24 17:31:10,171 = DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGram= mar](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](IoThrea= dPool-4) = ---
State =3D 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](IoThrea= dPool-4) = ---
State =3D LENGTH_STATE_END ---
2006-11-24 17:31:10,171 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x0A
2006-11-24 17:31:10,171 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-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](IoThrea= dPool-4) = Length
LENGTH[0](indefinite)size=3D1) has been decoded
2006-1= 1-24 = 17:31:10,171 DEBUG =
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool= -4) = ---
State =3D TLV_STATE_DONE ---
2006-11-24 17:31:10,171 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x0A
2006-11-24 17:31:10,171 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = TLV Tree
: TLV0x04(0)-TLV0x63(34)-TLV0x30(0)
2006-11-24 17:31= :10,171 = DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGram= mar = ](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.SearchReque= stGrammar = ](IoThreadPool-4)
Searching with root DN :
2006-11-24 17:31:1= 0,171 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = ---
State =3D TAG_STATE_START ---
2006-11-24 17:31:10,171 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x0A
2006-11-24 17:31:10,171 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = ---
State =3D TAG_STATE_END ---
2006-11-24 17:31:10,171 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x01
2006-11-24 17:31:10,171 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = Tag
TAG[PRIMITIVE, UNIVERSAL, ENUMERATED](size=3D1) has been = decoded
2006-11-24 17:31:10,171 = DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGram= mar](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](IoThrea= dPool-4) = ---
State =3D 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](IoThrea= dPool-4) = ---
State =3D LENGTH_STATE_END ---
2006-11-24 17:31:10,171 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x00
2006-11-24 17:31:10,171 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-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](IoThrea= dPool-4) = Length
LENGTH[1](indefinite)size=3D1) has been decoded
2006-1= 1-24 = 17:31:10,171 DEBUG =
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool= -4) = ---
State =3D VALUE_STATE_START ---
2006-11-24 17:31:10,171 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x00
2006-11-24 17:31:10,171 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = ---
State =3D 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](IoThrea= dPool-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 scop= e = value>
2006-11-24 17:31:10,187 DEBUG =
[org.apache.directory.shared.ldap.codec.search.SearchRequestGra= mmar](IoThreadPool-4)
Searching = within BASE_OBJECT scope
2006-11-24 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = ---
State =3D TAG_STATE_START ---
2006-11-24 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x0A
2006-11-24 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder = ](IoThreadPool-4) ---
State =3D TAG_STATE_END ---
2006-11-24 = 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-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= =3D1) has = been decoded
2006-11-24 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGram= mar](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](IoThrea= dPool-4) = ---
State =3D 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](IoThrea= dPool-4) = ---
State =3D LENGTH_STATE_END ---
2006-11-24 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x00
2006-11-24 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-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](IoThrea= dPool-4) = Length
LENGTH[1](indefinite)size=3D1) has been decoded
2006-1= 1-24 = 17:31:10,187 DEBUG =
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool= -4) = ---
State =3D VALUE_STATE_START ---
2006-11-24 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x00
2006-11-24 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = ---
State =3D 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](IoThrea= dPool-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 derefAl= iases = value>
2006-11-24 17:31:10,187 = DEBUG
[org.apache.directory.shared.ldap.codec.search.SearchReque= stGrammar](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 =3D TAG_STATE_START ---
2006-11-2= 4 = 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x02
2006-11-24 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder = ](IoThreadPool-4) ---
State =3D TAG_STATE_END ---
2006-11-24 = 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-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=3D= 1) has = been decoded
2006-11-24 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGram= mar](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](IoThrea= dPool-4) = ---
State =3D 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](IoThrea= dPool-4) = ---
State =3D LENGTH_STATE_END ---
2006-11-24 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x00
2006-11-24 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-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](IoThrea= dPool-4) = Length
LENGTH[1](indefinite)size=3D1) has been decoded
2006-1= 1-24 = 17:31:10,187 DEBUG =
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool= -4) = ---
State =3D VALUE_STATE_START ---
2006-11-24 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x00
2006-11-24 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = ---
State =3D 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](IoThrea= dPool-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 sizeLim= it = value>
2006-11-24 17:31:10,187 = DEBUG
[org.apache.directory.shared.ldap.codec.search.SearchReque= stGrammar](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 =3D TAG_STATE_START ---
2006-11-2= 4 = 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x02
2006-11-24 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder = ](IoThreadPool-4) ---
State =3D TAG_STATE_END ---
2006-11-24 = 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-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=3D= 1) has = been decoded
2006-11-24 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGram= mar](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](IoThrea= dPool-4) = ---
State =3D 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](IoThrea= dPool-4) = ---
State =3D LENGTH_STATE_END ---
2006-11-24 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x00
2006-11-24 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-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](IoThrea= dPool-4) = Length
LENGTH[1](indefinite)size=3D1) has been decoded
2006-1= 1-24 = 17:31:10,187 DEBUG =
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool= -4) = ---
State =3D VALUE_STATE_START ---
2006-11-24 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x00
2006-11-24 17:31:10,187 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = ---
State =3D 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](IoThrea= dPool-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 timeLim= it = value>
2006-11-24 17:31:10,203 = DEBUG
[org.apache.directory.shared.ldap.codec.search.SearchReque= stGrammar](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 =3D TAG_STATE_START ---
2006-11-2= 4 = 17:31:10,203 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x01
2006-11-24 17:31:10,203 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder = ](IoThreadPool-4) ---
State =3D TAG_STATE_END ---
2006-11-24 = 17:31:10,203 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-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=3D= 1) has = been decoded
2006-11-24 17:31:10,203 = DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGram= mar](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](IoThrea= dPool-4) = ---
State =3D 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](IoThrea= dPool-4) = ---
State =3D LENGTH_STATE_END ---
2006-11-24 17:31:10,203 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x00
2006-11-24 17:31:10,203 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-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](IoThrea= dPool-4) = Length
LENGTH[1](indefinite)size=3D1) has been decoded
2006-1= 1-24 = 17:31:10,203 DEBUG =
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThreadPool= -4) = ---
State =3D VALUE_STATE_START ---
2006-11-24 17:31:10,203 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x00
2006-11-24 17:31:10,203 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = ---
State =3D 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](IoThrea= dPool-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.SearchRequestGra= mmar](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 =3D TAG_STATE_START ---
2006-11-2= 4 = 17:31:10,203 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x87
2006-11-24 17:31:10,203 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder = ](IoThreadPool-4) ---
State =3D TAG_STATE_END ---
2006-11-24 = 17:31:10,203 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-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=3D1) ha= s been = decoded
2006-11-24 17:31:10,203 = DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGram= mar](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.AbstractGram= mar](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 =3D LENGTH_STATE_START ---
2006-1= 1-24 = 17:31:10,203 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x0B
2006-11-24 17:31:10,203 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder = ](IoThreadPool-4) ---
State =3D LENGTH_STATE_END ---
2006-11-= 24 = 17:31:10,203 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-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](IoThrea= dPool-4) = Length
LENGTH[11](indefinite)size=3D1) has been decoded
2006= -11-24 = 17:31:10,203 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = ---
State =3D 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](IoThrea= dPool-4) = ---
State =3D 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](IoThrea= dPool-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 =3D TAG_STATE_START ---
2006-11-24 17:31:10,203 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x30
2006-11-24 17:31:10,203 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = ---
State =3D 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](IoThrea= dPool-4) = Tag
TAG[CONSTRUCTED, UNIVERSAL, SEQUENCE_SEQUENCE_OF](size=3D1) = has been = decoded
2006-11-24 17:31:10,203 = DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGram= mar](IoThreadPool-4)
Pop = grammar FILTER_GRAMMAR, state =3D FILTER_TAG
2006-11-24 17:31:10= ,203 = DEBUG
[org.apache.directory.shared.asn1.ber.grammar.AbstractGram= mar = ](IoThreadPool-4)
Transition from <SEARCH_REQUEST_FILTER> = to
<SEARCH_REQUEST_ATTRIBUTE_DESCRIPTION_LIST_VALUE>, acti= on : no = action>
2006-11-24 17:31:10,203 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder = ](IoThreadPool-4) ---
State =3D LENGTH_STATE_START ---
2006-1= 1-24 = 17:31:10,203 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
current = byte : 0x84
2006-11-24 17:31:10,218 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder = ](IoThreadPool-4) ---
State =3D LENGTH_STATE_PENDING ---
2006= -11-24 = 17:31:10,218 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-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](IoThrea= dPool-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](IoThrea= dPool-4)
current = byte : 0x00
2006-11-24 17:31:10,218 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = ---
State =3D 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](IoThrea= dPool-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](IoThrea= dPool-4) = Length
LENGTH[0](indefinite)size=3D5) has been decoded
2006-1= 1-24 = 17:31:10,218 DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Dec= oder = ](IoThreadPool-4) ---
State =3D TLV_STATE_DONE ---
2006-11-24= = 17:31:10,218 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-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.AbstractGram= mar](IoThreadPool-4)
Transition = from <SEARCH_REQUEST_ATTRIBUTE_DESCRIPTION_LIST_VALUE> to =
<SEARCH_REQUEST_ATTRIBUTE_DESCRIPTION_TAG>, action : stor= e = Attribute
Description List value>
2006-11-24 17:31:10,218 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
<<<------------------------------------------ =
2006-11-24 17:31:10,218 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4) = <-- Stop
decoding : TLV[ TAG[CONSTRUCTED, UNIVERSAL, = SEQUENCE_SEQUENCE_OF](size=3D1),
LENGTH[0](indefinite)size=3D5),= []] =
2006-11-24 17:31:10,218 = DEBUG
[org.apache.directory.shared.asn1.ber.Asn1Decoder](IoThrea= dPool-4)
<<<=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
2006-11-24 = 17:31:10,218 DEBUG
[org.apache.directory.shared.ldap.codec.TwixD= ecoder = ](IoThreadPool-4)
Decoded LdapMessage : = LdapMessage
    message Id : = 1
    Search = Request
        Base Obj= ect : = ''
        Scope : base = object
        Deref Ali= ases : = never Deref = Aliases
        Size Lim= it : no = limit
        Time Limi= t : no = limit
        Types Only= : = false
        Filter : = '(objectClass=3D*)'

2006-11-24 17:31:10,218 = DEBUG
[org.apache.directory.shared.ldap.codec.TwixTransformer](I= oThreadPool-4)
Transforming = LdapMessage <1, SEARCH_REQUEST> from Twix to Snickers. =
2006-11-24 17:31:10,218 = INFO
[org.apache.directory.server.ldap.LdapProtocolProvider$Ldap= ProtocolHandler](IoThreadPool-4)
[/127.0.0.1:3728] = RECEIVED:     = SearchRequest
        ba= seDn : = ''
        filter : = '(objectClass=3D*) ' =
        scope : base = object
        typesOnly= : = false
no limit
       &nbs= p;Time = Limit : no limit
        = ;Deref = Aliases : never Deref = Aliases
        attribut= es = :

2006-11-24 17:31:10,234 = DEBUG
[org.apache.directory.server.ldap.support.SearchHandler = ](IoThreadPool-4)
Message received :     = SearchRequest
        ba= seDn : = ''
        filter : = '(objectClass=3D*) = '
        scope : base = object
        typesOnly= : = false
no limit
       &nbs= p;Time = Limit : no limit
       &nbs= p;Deref = Aliases : never Deref = Aliases
        attribut= es = :

2006-11-24 17:31:10,250 = INFO
[org.apache.directory.server.ldap.LdapProtocolProvider$Ldap= ProtocolHandler](IoThreadPool-4)
[/127.0.0.1:3728] = WRITE:         Ldap Result =
          &nb= sp; Result = code : = (ResultCodeEnum[INSUFFICIENTACCESSRIGHTS=3D50])
insufficientAcce= ssRights
          &= nbsp; Matched = DN : = 'null'
         &nb= sp;  Error = message : 'failed on search = operation:
    SearchRequest
  =       baseDn = : ''
        filter : = '(objectClass=3D*) = '
        scope : base = object
        typesOnly= : = false
no limit
       &nbs= p;Time = Limit : no limit
        = ;Deref = Aliases : never Deref = Aliases
        attribut= es : =
:
org.apache.directory.shared.ldap.exception.LdapNoPermissio= nException:
Anonymous = access = disabled.
      at
org.apache.d= irectory.server.core.DefaultDirectoryService.checkSecuritySettings(Defaul= tDirectoryService.java = :395)
      at
org.apache.direc= tory.server.core.DefaultDirectoryService.getJndiContext(DefaultDirectoryS= ervice.java:134)
      at
org.apache.= directory.server.core.jndi.AbstractContextFactory.getInitialContext = ( = AbstractContextFactory.java:121)
     &= nbsp;at
javax.naming.spi.NamingManager.getInitialContext(NamingManager= =2Ejava:662)
      at
javax.naming.In= itialContext.getDefaultInitCtx(InitialContext.java:243)
  &n= bsp;   at = javax.naming.InitialContext.init = (InitialContext.java:219)
      at=
javax.naming.ldap.InitialLdapContext.<init>(InitialLdapContext.= java:133)
      at
org.apache.directo= ry.server.ldap.SessionRegistry.getLdapContextOnRootDSEAccess(SessionRegis= try.java = :358)
      at
org.apache.direc= tory.server.ldap.support.SearchHandler.messageReceived(SearchHandler.java= :152)
      at
org.apache.mina.handle= r.demux.DemuxingIoHandler.messageReceived(DemuxingIoHandler.java = :128) =
      at
org.apache.directory.= server.ldap.LdapProtocolProvider$LdapProtocolHandler.messageReceived(Ldap= ProtocolProvider.java:431)
      at
o= rg.apache.mina.common.support.AbstractIoFilterChain$2.messageReceived = (AbstractIoFilterChain.java:188)
     &= nbsp;at
org.apache.mina.common.support.AbstractIoFilterChain.callNextM= essageReceived(AbstractIoFilterChain.java:504)
    = ;  at
org.apache.mina.common.support.AbstractIoFilterChain.a= ccess$1000 = (AbstractIoFilterChain.java:51)
     &n= bsp;at
org.apache.mina.common.support.AbstractIoFilterChain$3.messageR= eceived(AbstractIoFilterChain.java:790)
     =  at
org.apache.mina.filter.LoggingFilter.messageReceived = ( LoggingFilter.java = :95)
      at
org.apache.mina.c= ommon.support.AbstractIoFilterChain.callNextMessageReceived(AbstractIoFil= terChain.java:504)
      at
org.apach= e.mina.common.support.AbstractIoFilterChain.access$1000(AbstractIoFilterC= hain.java = :51)
      at
org.apache.mina.c= ommon.support.AbstractIoFilterChain$3.messageReceived(AbstractIoFilterCha= in.java:790)
      at
org.apache.mina= =2Efilter.codec.ProtocolCodecFilter.messageReceived(ProtocolCodecFilter.j= ava = :187)
      at
org.apache.mina.= common.support.AbstractIoFilterChain.callNextMessageReceived(AbstractIoFi= lterChain.java:504)
      at
org.apac= he.mina.common.support.AbstractIoFilterChain.access$1000(AbstractIoFilter= Chain.java = :51)
      at
org.apache.mina.c= ommon.support.AbstractIoFilterChain$3.messageReceived(AbstractIoFilterCha= in.java:790)
      at
org.apache.mina= =2Efilter.ThreadPoolFilter.processEvent(ThreadPoolFilter.java:706) =
      at
org.apache.mina.filte= r.ThreadPoolFilter$Worker.processEvents(ThreadPoolFilter.java:462)
&nb= sp;     at
org.apache.mina.filter.ThreadPoolF= ilter$Worker.run(ThreadPoolFilter.java:417)



--
Cordialement,
Emmanuel L=EF=BF= =BDcharny =



-- =
Cordialement,
Emmanuel L=C3=A9charny =



-- =
Cordialement,
Emmanuel L=C3=A9charny --alternative_NB3672_26109--