powered by Jive Software

OpenFire Installation Problems

Hello,

I’m trying to install the following constellation: JSJaC-Client (domain a.com) -> JabberHTTPBind-Connection Manager (domain a.com) -> OpenFire (domain b.com)

Can someone says what i’m doing wrong? I dint understand what the exception javax.security.sasl.SaslException: Expecting comma or linear whitespace after quoted string: “utf-8” should mean in this context.

JavaScript-Console:

registered handler for event 'message' JSJaCConsoleLogger.js:51
registered handler for event 'presence' JSJaCConsoleLogger.js:51
registered handler for event 'iq' JSJaCConsoleLogger.js:51
registered handler for event 'onconnect' JSJaCConsoleLogger.js:51
registered handler for event 'onerror' JSJaCConsoleLogger.js:51
registered handler for event 'status_changed' JSJaCConsoleLogger.js:51
registered handler for event 'ondisconnect' JSJaCConsoleLogger.js:51
registered handler for event 'iq' JSJaCConsoleLogger.js:51
registered handler for event 'iq' JSJaCConsoleLogger.js:51
incoming event 'onstatuschanged' JSJaCConsoleLogger.js:57
incoming event 'status_changed' JSJaCConsoleLogger.js:57
handling event 'status_changed' JSJaCConsoleLogger.js:51
status changed: connecting JSJaCConsoleLogger.js:45
1: 07d1fd9632bb7158f6432f733d61631d50eaeb0f JSJaCConsoleLogger.js:54
2: 9b517ea93c603a2a00cbc97ee34627c15d428c67 JSJaCConsoleLogger.js:54
3: 37b72cdae3a022d64909467b17b09c9f0f937175 JSJaCConsoleLogger.js:54
4: 4dd99d87d100b4c58b71bd2a2be7d7e7b4c677f7 JSJaCConsoleLogger.js:54
5: fc3e370a1dcb137b7d379ac3597e46449434c0f8 JSJaCConsoleLogger.js:54
6: 060627b1a464075b2543fdcd7da936eb40d51300 JSJaCConsoleLogger.js:54
7: a1ec518cb80fbf2fb0dcf08eaf0581c3b7aea568 JSJaCConsoleLogger.js:54
8: d804fa3b14425762909cda4b18c4302e5e7e670b JSJaCConsoleLogger.js:54
9: b3d4dbc24c1f45dd64857d3acc0b5d5b9efff60d JSJaCConsoleLogger.js:54
10: a2fa148a146cad060ab526175e5f63e17a9a1a87 JSJaCConsoleLogger.js:54
11: b923a7943111241064d175b2a07020362b58354d JSJaCConsoleLogger.js:54
12: d5e5a7e8c310e972ce604e966679416067497bba JSJaCConsoleLogger.js:54
13: b8c0f80244a25d1388ce9b46ca00cd2a23a95494 JSJaCConsoleLogger.js:54
14: d5e95cb39b95e4c61f56353cb643980dc88a16de JSJaCConsoleLogger.js:54
15: 7d675ae4d626834a54627b524f1fc06fafb635b2 JSJaCConsoleLogger.js:54
<body content='text/xml; charset=utf-8' hold='1' xmlns='http://jabber.org/protocol/httpbind' to='b.com' wait='300' rid='380578' secure='false' newkey='7d675ae4d626834a54627b524f1fc06fafb635b2' xml:lang='en' ver='1.6' xmlns:xmpp='urn:xmpp:xbosh' xmpp:version='1.0'/> JSJaCConsoleLogger.js:54
Connection lost ... JSJaCConsoleLogger.js:48 async recv: <body xmlns="http://jabber.org/protocol/httpbind" xmlns:stream="http://etherx.jabber.org/streams" authid="bb7235e2" inactivity="60" polling="2" requests="2" sid="1fKJFfGq-OIAwlkhBMHYy8Z2" wait="300"><stream:features><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>DIGEST-MD5</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism><mechanism>CRAM-MD5</mechanism></mechanisms><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/></stream:features></body> JSJaCConsoleLogger.js:54Date: Fri, 25 Jan 2013 16:59:22 GMTServer: Apache-Coyote/1.1Content-Length: 633Content-Type: text/xml;charset=utf-8 JSJaCConsoleLogger.js:54<body xmlns="http://jabber.org/protocol/httpbind" xmlns:stream="http://etherx.jabber.org/streams" authid="bb7235e2" inactivity="60" polling="2" requests="2" sid="1fKJFfGq-OIAwlkhBMHYy8Z2" wait="300"><stream:features><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>DIGEST-MD5</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism><mechanism>CRAM-MD5</mechanism></mechanisms><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/></stream:features></body> JSJaCConsoleLogger.js:54got sid: 1fKJFfGq-OIAwlkhBMHYy8Z2 JSJaCConsoleLogger.js:51set hold to 1 JSJaCConsoleLogger.js:51<body xmlns="http://jabber.org/protocol/httpbind" xmlns:stream="http://etherx.jabber.org/streams" authid="bb7235e2" inactivity="60" polling="2" requests="2" sid="1fKJFfGq-OIAwlkhBMHYy8Z2" wait="300"><stream:features><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>DIGEST-MD5</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism><mechanism>CRAM-MD5</mechanism></mechanisms><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/></stream:features></body> JSJaCConsoleLogger.js:54got streamid: bb7235e2 JSJaCConsoleLogger.js:51SASL detected JSJaCConsoleLogger.js:51SASL using mechanism 'DIGEST-MD5' JSJaCConsoleLogger.js:51Found working slot at 0 JSJaCConsoleLogger.js:51sending: <body rid='380579' sid='1fKJFfGq-OIAwlkhBMHYy8Z2' xmlns='http://jabber.org/protocol/httpbind' key='d5e95cb39b95e4c61f56353cb643980dc88a16de' ><auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='DIGEST-MD5'/></body> JSJaCConsoleLogger.js:54incoming event 'onstatuschanged' JSJaCConsoleLogger.js:57incoming event 'status_changed' JSJaCConsoleLogger.js:57handling event 'status_changed' JSJaCConsoleLogger.js:51status changed: processing JSJaCConsoleLogger.js:45async recv: <body xmlns="http://jabber.org/protocol/httpbind"><challenge xmlns="jabber:client">cmVhbG09ImVjMi0xNzYtMzQtMjEzLTU3LmV1LXdlc3QtMS5jb21wdXRlLmFtYXpvbmF3cy5jb20iLG5vbmNlPSJjVkY1b1ZBNG5TaUFvaGJVRTRtd1ZPd1E5YlZuRzlGRENCVUNONENQIixxb3A9ImF1dGgiLGNoYXJzZXQ9dXRmLTgsYWxnb3JpdGhtPW1kNS1zZXNz</challenge></body> JSJaCConsoleLogger.js:54got challenge: realm="b.com",nonce="cVF5oVA4nSiAohbUE4mwVOwQ9bVnG9FDCBUCN4CP",qop="auth",charset=utf-8,algorithm=md5-sess JSJaCConsoleLogger.js:51nonce: cVF5oVA4nSiAohbUE4mwVOwQ9bVnG9FDCBUCN4CP JSJaCConsoleLogger.js:51response: username="JSJaC-TestUser",realm="b.com",nonce="cVF5oVA4nSiAohbUE4mwVOwQ9bVnG9FDCBUCN4CP",cnonce="vJfpwWPsryu3kE",nc="00000001",qop=auth,digest-uri="xmpp/b.com",response="2716412f12028ba6041c4d4423b45e76",charset="utf-8" JSJaCConsoleLogger.js:51Found working slot at 0 JSJaCConsoleLogger.js:51sending: <body rid='380580' sid='1fKJFfGq-OIAwlkhBMHYy8Z2' xmlns='http://jabber.org/protocol/httpbind' key='b8c0f80244a25d1388ce9b46ca00cd2a23a95494' ><response xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>dXNlcm5hbWU9IkpTSmFDLVRlc3RVc2VyIixyZWFsbT0iZWMyLTE3Ni0zNC0yMTMtNTcuZXUtd2VzdC0xLmNvbXB1dGUuYW1hem9uYXdzLmNvbSIsbm9uY2U9ImNWRjVvVkE0blNpQW9oYlVFNG13Vk93UTliVm5HOUZEQ0JVQ040Q1AiLGNub25jZT0idkpmcHdXUHNyeXUza0UiLG5jPSIwMDAwMDAwMSIscW9wPWF1dGgsZGlnZXN0LXVyaT0ieG1wcC9lYzItMTc2LTM0LTIxMy01Ny5ldS13ZXN0LTEuY29tcHV0ZS5hbWF6b25hd3MuY29tIixyZXNwb25zZT0iMjcxNjQxMmYxMjAyOGJhNjA0MWM0ZDQ0MjNiNDVlNzYiLGNoYXJzZXQ9InV0Zi04IgA=</response></body> JSJaCConsoleLogger.js:54scheduling next poll in 100 msec JSJaCConsoleLogger.js:54all slots busy, standby ... JSJaCConsoleLogger.js:51async recv: <body xmlns="http://jabber.org/protocol/httpbind"><failure xmlns="jabber:client"><not-authorized/></failure></body> JSJaCConsoleLogger.js:54
auth error: <failure xmlns="jabber:client"><not-authorized/></failure> JSJaCConsoleLogger.js:48 incoming event 'onerror' JSJaCConsoleLogger.js:57handling event 'onerror' JSJaCConsoleLogger.js:51incoming event 'onstatuschanged' JSJaCConsoleLogger.js:57incoming event 'status_changed' JSJaCConsoleLogger.js:57handling event 'status_changed' JSJaCConsoleLogger.js:51status changed: disconnecting JSJaCConsoleLogger.js:45Disconnecting: <body rid='380581' sid='1fKJFfGq-OIAwlkhBMHYy8Z2' xmlns='http://jabber.org/protocol/httpbind' key='d5e5a7e8c310e972ce604e966679416067497bba' type='terminate'> </body> JSJaCConsoleLogger.js:54disconnected JSJaCConsoleLogger.js:45incoming event 'ondisconnect' JSJaCConsoleLogger.js:57handling event 'ondisconnect' JSJaCConsoleLogger.js:51scheduling next poll in 100 msec JSJaCConsoleLogger.js:54
Connection lost ... JSJaCConsoleLogger.js:48

This from Debugger from JabberHTTPBind

Jan 25, 2013 5:59:51 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [2] Succesfully connected to b.com
Jan 25, 2013 5:59:51 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [2] creating session with id 5DZdj35gIzglSZ0AXYq2YmYQ
Jan 25, 2013 5:59:51 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [2] inQueue: <?xml version='1.0' encoding='UTF-8'?><stream:stream xmlns:stream="http://etherx.jabber.org/streams" xmlns="jabber:client" from="b.com" id="d47f4e8" xml:lang="en" version="1.0">
Jan 25, 2013 5:59:51 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [2] failed to get stream features
Jan 25, 2013 5:59:52 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [2] inQueue: <?xml version='1.0' encoding='UTF-8'?><stream:stream xmlns:stream="http://etherx.jabber.org/streams" xmlns="jabber:client" from="b.com" id="d47f4e8" xml:lang="en" version="1.0"><stream:features><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"></starttls><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>DIGEST-MD5</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism><mechanism>CRAM-MD5</mechanism></mechanisms><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/></stream:features>
Jan 25, 2013 5:59:52 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [2] inQueue: <stream:features><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"></starttls><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>DIGEST-MD5</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism><mechanism>CRAM-MD5</mechanism></mechanisms><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/></stream:features>
Jan 25, 2013 5:59:52 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [2] starttls present, trying to use it
Jan 25, 2013 5:59:52 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [2] <proceed xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>
Jan 25, 2013 5:59:52 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [0] initiating handshake
Jan 25, 2013 5:59:52 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [1] STARTTLS failed: javax.net.ssl.SSLHandshakeException: sun.security.validator.ValidatorException: PKIX path building failed: sun.security.provider.certpath.SunCertPathBuilderException: unable to find valid certification path to requested target
Jan 25, 2013 5:59:52 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [2] tls failed but we don't need to be secure
Jan 25, 2013 5:59:52 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [1] socket closed
Jan 25, 2013 5:59:52 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [2] inQueue: <?xml version='1.0' encoding='UTF-8'?><stream:stream xmlns:stream="http://etherx.jabber.org/streams" xmlns="jabber:client" from="b.com" id="7048f2a3" xml:lang="en" version="1.0">
Jan 25, 2013 5:59:52 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [2] failed to get stream features
Jan 25, 2013 5:59:52 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [2] inQueue: <?xml version='1.0' encoding='UTF-8'?><stream:stream xmlns:stream="http://etherx.jabber.org/streams" xmlns="jabber:client" from="b.com" id="7048f2a3" xml:lang="en" version="1.0"><stream:features><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"></starttls><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>DIGEST-MD5</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism><mechanism>CRAM-MD5</mechanism></mechanisms><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/></stream:features>
Jan 25, 2013 5:59:52 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [2] inQueue: <stream:features><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"></starttls><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>DIGEST-MD5</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism><mechanism>CRAM-MD5</mechanism></mechanisms><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/></stream:features>
Jan 25, 2013 5:59:52 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [2] sending response [563211]: <body xmlns="http://jabber.org/protocol/httpbind" xmlns:stream="http://etherx.jabber.org/streams" authid="7048f2a3" inactivity="60" polling="2" requests="2" sid="5DZdj35gIzglSZ0AXYq2YmYQ" wait="300"><stream:features><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>DIGEST-MD5</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism><mechanism>CRAM-MD5</mechanism></mechanisms><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/></stream:features></body>
Jan 25, 2013 5:59:53 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [2] inQueue: <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cmVhbG09ImVjMi0xNzYtMzQtMjEzLTU3LmV1LXdlc3QtMS5jb21wdXRlLmFtYXpvbmF3cy5jb20iLG5vbmNlPSJGM1YydkZieVdUVndPTmdtSFIyVk9uc2dQSHZzTGZaQWh5djF5VUNyIixxb3A9ImF1dGgiLGNoYXJzZXQ9dXRmLTgsYWxnb3JpdGhtPW1kNS1zZXNz</challenge>
Jan 25, 2013 5:59:53 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [2] sending response [563212]: <body xmlns="http://jabber.org/protocol/httpbind"><challenge xmlns="jabber:client">cmVhbG09ImVjMi0xNzYtMzQtMjEzLTU3LmV1LXdlc3QtMS5jb21wdXRlLmFtYXpvbmF3cy5jb20iLG5vbmNlPSJGM1YydkZieVdUVndPTmdtSFIyVk9uc2dQSHZzTGZaQWh5djF5VUNyIixxb3A9ImF1dGgiLGNoYXJzZXQ9dXRmLTgsYWxnb3JpdGhtPW1kNS1zZXNz</challenge></body>
Jan 25, 2013 5:59:53 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [2] inQueue: <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/></failure>
Jan 25, 2013 5:59:53 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [2] sending response [563213]: <body xmlns="http://jabber.org/protocol/httpbind"><failure xmlns="jabber:client"><not-authorized/></failure></body>
Jan 25, 2013 5:59:53 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [2] terminating session 5DZdj35gIzglSZ0AXYq2YmYQ
Jan 25, 2013 5:59:53 PM org.apache.catalina.core.ApplicationContext log
INFO: Jabber HTTP Binding Servlet: [2] sending response [563214]: <body xmlns="http://jabber.org/protocol/httpbind"/>

and this from OpenFire-Logger:

2013.01.25 17:01:47 org.jivesoftware.util.log.util.JettyLog - JettyLog: servlet holder= 2013.01.25 17:01:47 org.jivesoftware.util.log.util.JettyLog - JettyLog: chain= 2013.01.25 17:01:47 org.jivesoftware.util.log.util.JettyLog - JettyLog: servlet holder= 2013.01.25 17:01:47 org.jivesoftware.util.log.util.JettyLog - JettyLog: chain= 2013.01.25 17:01:48 org.jivesoftware.util.log.util.JettyLog - JettyLog: servlet holder= 2013.01.25 17:01:48 org.jivesoftware.util.log.util.JettyLog - JettyLog: chain= 2013.01.25 17:01:51 org.apache.mina.filter.executor.ExecutorFilter - Launching thread for /77.177.27.92:56567 2013.01.25 17:01:52 org.apache.mina.filter.executor.ExecutorFilter - Exiting since queue is empty for /77.177.27.92:56567 2013.01.25 17:01:52 org.apache.mina.filter.executor.ExecutorFilter - Launching thread for /77.177.27.92:56567 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.NIOConnection - NIOConnection: startTLS: using c2s 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] doHandshake() 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] handshakeStatus=NEED_UNWRAP 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] unwrapHandshake() 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] inNetBuffer: java.nio.DirectByteBuffer[pos=0 lim=0 cap=16665] 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] appBuffer: java.nio.DirectByteBuffer[pos=0 lim=33330 cap=33330] 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] Unwrap res:Status = BUFFER_UNDERFLOW HandshakeStatus = NEED_UNWRAP bytesConsumed = 0 bytesProduced = 0 2013.01.25 17:01:52 org.apache.mina.filter.executor.ExecutorFilter - Exiting since queue is empty for /77.177.27.92:56567 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] Data Read: org.apache.mina.filter.support.SSLHandler@19a0c4e (HeapBuffer[pos=0 lim=212 cap=512: 16 03 01 00 CF 01 00 00 CB 03 01 51 02 BA 59 F6 98 F0 0B 3B ED 0A 3F FD EC AB 97 CB 7F C2 EA 96 5F 7E 08 55 54 CC 2F C2 D2 72 CB 00 00 2A C0 09 C0 13 00 2F C0 04 C0 0E 00 33 00 32 C0 07 C0 11 00 05 C0 02 C0 0C C0 08 C0 12 00 0A C0 03 C0 0D 00 16 00 13 00 04 00 FF 01 00 00 78 00 0A 00 34 00 32 00 17 00 01 00 03 00 13 00 15 00 06 00 07 00 09 00 0A 00 18 00 0B 00 0C 00 19 00 0D 00 0E 00 0F 00 10 00 11 00 02 00 12 00 04 00 05 00 14 00 08 00 16 00 0B 00 02 01 00 00 00 00 36 00 34 00 00 31 65 63 32 2D 31 37 36 2D 33 34 2D 32 31 33 2D 35 37 2E 65 75 2D 77 65 73 74 2D 31 2E 63 6F 6D 70 75 74 65 2E 61 6D 61 7A 6F 6E 61 77 73 2E 63 6F 6D]) 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] doHandshake() 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] handshakeStatus=NEED_UNWRAP 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] unwrapHandshake() 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] inNetBuffer: java.nio.DirectByteBuffer[pos=0 lim=212 cap=16665] 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] appBuffer: java.nio.DirectByteBuffer[pos=0 lim=33330 cap=33330] 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] Unwrap res:Status = OK HandshakeStatus = NEED_TASK bytesConsumed = 212 bytesProduced = 0 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] handshakeStatus=NEED_TASK 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] doTasks() 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] doTask: com.sun.net.ssl.internal.ssl.Handshaker$DelegatedTask@53f89f 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] doTasks(): NEED_WRAP 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] handshakeStatus=NEED_WRAP 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] Wrap res:Status = OK HandshakeStatus = NEED_UNWRAP bytesConsumed = 0 bytesProduced = 1270 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] write outNetBuffer: java.nio.DirectByteBuffer[pos=0 lim=1270 cap=16665] 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] session write: HeapBuffer[pos=0 lim=1270 cap=1270: 16 03 01 04 F1 02 00 00 46 03 01 51 02 BA 80 57 5C 8D 27 49 98 9B 71 AE 08 53 F9 53 B9 77 5F 08 E3 91 33 46 D7 92 E0 BD 2B FE 01 20 51 02 BA 80 BD D5 48 1A 5A 52 6D 0A B9 7A 5E C7 A2 80 99 0B E6 F9 94 1E 21 78 6F 5F 72 45 C1 7D C0 13 00 0B 00 03 54 00 03 51 00 03 4E 30 82 03 4A 30 82 02 32 A0 03 02 01 02 02 08 59 42 87 25 83 43 96 50 30 0D 06 09 2A 86 48 86 F7 0D 01 01 05 05 00 30 3C 31 3A 30 38 06 03 55 04 03 0C 31 65 63 32 2D 31 37 36 2D 33 34 2D 32 31 33 2D 35 37 2E 65 75 2D 77 65 73 74 2D 31 2E 63 6F 6D 70 75 74 65 2E 61 6D 61 7A 6F 6E 61 77 73 2E 63 6F 6D 30 1E 17 0D 31 33 30 31 32 35 31 36 33 37 32 39 5A 17 0D 31 37 31 32 33 30 31 36 33 37 32 39 5A 30 3C 31 3A 30 38 06 03 55 04 03 0C 31 65 63 32 2D 31 37 36 2D 33 34 2D 32 31 33 2D 35 37 2E 65 75 2D 77 65 73 74 2D 31 2E 63 6F 6D 70 75 74 65 2E 61 6D 61 7A 6F 6E 61 77 73 2E 63 6F 6D 30 82 01 22 30 0D 06 09 2A 86 48 86 F7 0D 01 01 01 05 00 03 82 01 0F 00 30 82 01 0A 02 82 01 01 00 BD 22 95 9F 66 39 48 AD A9 C1 E9 BC A9 19 36 5F 24 8A 1D 61 F7 18 EF 4C 5E 84 3D FB D7 CB 11 1E C9 BC C9 3F D7 5A 4E 99 B2 20 62 4A 69 52 FE 5C DC 6E 03 99 60 32 F4 D4 D3 5F 66 08 1E 73 3E 85 83 F7 2D A2 F2 4B 23 14 C4 3D 54 34 C5 81 82 BB 1F C6 6A E7 98 31 17 01 10 A3 B7 CB 1E 01 79 44 93 B9 BD 1A 0D 1E 89 B4 A2 72 24 EE D1 AB D6 B9 14 D1 5D 2D DF BC FB E6 45 44 44 03 2D 47 E0 3E 09 9C 66 07 48 AD 3C 87 14 49 AF 71 BA D0 BD E8 00 82 37 E3 BD CC 78 68 7B 44 C0 58 2E 70 5C 6E 7C A7 EE E4 44 77 A9 97 4D DA 8C 23 B6 3D 93 74 27 F9 F0 7F 49 5D 1C 8E 8E 55 84 3E 92 52 00 F2 BA 5B DC 61 FC 34 B3 C1 D1 6F 50 8A 97 C0 93 4D 16 E1 20 D0 7A 69 5D CC 3E AA B1 F6 77 75 85 6F BA EE 50 5A 17 35 C8 EB 14 60 61 F9 82 DC 8D 10 4C 8C 5A CE AA 46 77 88 CA 66 02 5C 17 69 23 AF 02 03 01 00 01 A3 50 30 4E 30 4C 06 03 55 1D 11 04 45 30 43 A0 41 06 08 2B 06 01 05 05 07 08 05 A0 35 0C 33 2A 2E 65 63 32 2D 31 37 36 2D 33 34 2D 32 31 33 2D 35 37 2E 65 75 2D 77 65 73 74 2D 31 2E 63 6F 6D 70 75 74 65 2E 61 6D 61 7A 6F 6E 61 77 73 2E 63 6F 6D 30 0D 06 09 2A 86 48 86 F7 0D 01 01 05 05 00 03 82 01 01 00 5A F0 00 5B CD 64 F1 A0 29 74 4B B3 72 79 C1 1D F6 37 13 82 34 B1 4F E2 F8 E3 26 1A B6 60 BB B3 A9 66 20 AF 22 D6 3A 5D E9 0D 64 14 57 C6 95 56 52 04 65 F6 9A 08 05 56 41 96 70 92 90 BA F0 2E E4 AD 18 A3 82 A4 9E 0C 83 BB 76 01 ED 1A 81 2A 74 DC 8F FF 9D 51 BB 37 12 40 53 05 10 2B E0 8B 2E 2E 7D 0C 30 4A 62 C7 97 D3 26 F9 72 E7 6A E3 A0 57 3E C3 5E BF 0B A9 F9 03 4D F5 6E 9C 99 99 C3 DB 20 39 DA 6A 15 F8 A9 57 13 70 60 5F 9A FC E2 CD 30 A0 53 99 AA 30 C4 6D 87 98 36 E1 B0 B2 8A 61 C9 96 CB 83 B9 3C FF B3 76 87 6A B2 05 CD 4B 71 42 A5 BC 8C F0 62 D5 84 36 46 94 94 F0 78 2F AD FD E7 E9 FD E9 A6 A0 94 D8 1F 91 BB 6F 78 05 1B 0F 2F 2E 82 B2 C1 9C BD A1 31 3F 3F DD 5F A5 24 7F 51 F0 1F 8B 68 66 4C EE 9B 5C B6 05 89 9B 8B CB 6D 5A BE 5B 62 C8 B0 DC D8 FA 2D D2 4E 0C 00 01 47 03 00 17 41 04 2C 05 71 F6 9F 39 A3 CD 40 20 72 81 F9 E2 48 F8 8D D4 82 84 85 E5 41 2D FA 09 82 C6 26 47 6B 35 EA 6B 72 A4 FA A3 59 21 37 73 85 ED 40 90 7D 82 A2 0E 62 C1 94 F5 E7 A2 84 15 66 3A C1 41 B5 3D 01 00 9A 87 32 B6 50 2F F7 63 ED F5 C7 E2 07 FD 50 21 1F C4 63 2F FB 72 DD 72 E3 D2 5B 17 7A F8 76 C2 E7 AA 3F 69 C9 38 D7 6F AD 44 F4 85 E4 FB 85 FD 77 70 AD 83 E8 29 F2 2D 41 AC E1 16 ED F6 00 9D A9 67 69 5E 8E 64 02 6E 89 29 70 22 13 65 4F 79 F1 CA 91 8B 37 92 67 75 85 F1 68 7C 84 BA 5A 07 75 D5 AB BC 81 E0 4B CA 3C FF 1B 60 9B 73 2F 54 0E 2B 54 37 8A 2B FB 0E 45 1D 76 26 4B 34 97 C1 BB 47 C2 18 94 7A E4 C3 CE 56 9B 69 DD 05 DC 82 68 9D C1 08 EA 5B B7 AD 2A 06 FE 07 23 9D B3 4F 82 86 CD A4 A9 10 E3 F7 AC 62 5A 35 D7 A7 6D 17 3D 41 BB 9C 15 0E C8 97 2A 28 E2 45 51 49 6A F3 44 FE BF 3B 19 AD 51 A3 87 DB D7 E0 B9 98 D9 81 09 4B 83 F6 D7 41 64 82 B1 69 59 6B 31 56 9B C0 FD A8 94 99 09 98 E9 BA 4A 82 B1 67 B4 EC 3E D0 33 0D 43 F0 47 9F AF 0F F0 C6 11 2C F9 DD 32 A0 0E 00 00 00] 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] Filtered Write: org.apache.mina.filter.support.SSLHandler@19a0c4e 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] already encrypted: HeapBuffer[pos=0 lim=1270 cap=1270: 16 03 01 04 F1 02 00 00 46 03 01 51 02 BA 80 57 5C 8D 27 49 98 9B 71 AE 08 53 F9 53 B9 77 5F 08 E3 91 33 46 D7 92 E0 BD 2B FE 01 20 51 02 BA 80 BD D5 48 1A 5A 52 6D 0A B9 7A 5E C7 A2 80 99 0B E6 F9 94 1E 21 78 6F 5F 72 45 C1 7D C0 13 00 0B 00 03 54 00 03 51 00 03 4E 30 82 03 4A 30 82 02 32 A0 03 02 01 02 02 08 59 42 87 25 83 43 96 50 30 0D 06 09 2A 86 48 86 F7 0D 01 01 05 05 00 30 3C 31 3A 30 38 06 03 55 04 03 0C 31 65 63 32 2D 31 37 36 2D 33 34 2D 32 31 33 2D 35 37 2E 65 75 2D 77 65 73 74 2D 31 2E 63 6F 6D 70 75 74 65 2E 61 6D 61 7A 6F 6E 61 77 73 2E 63 6F 6D 30 1E 17 0D 31 33 30 31 32 35 31 36 33 37 32 39 5A 17 0D 31 37 31 32 33 30 31 36 33 37 32 39 5A 30 3C 31 3A 30 38 06 03 55 04 03 0C 31 65 63 32 2D 31 37 36 2D 33 34 2D 32 31 33 2D 35 37 2E 65 75 2D 77 65 73 74 2D 31 2E 63 6F 6D 70 75 74 65 2E 61 6D 61 7A 6F 6E 61 77 73 2E 63 6F 6D 30 82 01 22 30 0D 06 09 2A 86 48 86 F7 0D 01 01 01 05 00 03 82 01 0F 00 30 82 01 0A 02 82 01 01 00 BD 22 95 9F 66 39 48 AD A9 C1 E9 BC A9 19 36 5F 24 8A 1D 61 F7 18 EF 4C 5E 84 3D FB D7 CB 11 1E C9 BC C9 3F D7 5A 4E 99 B2 20 62 4A 69 52 FE 5C DC 6E 03 99 60 32 F4 D4 D3 5F 66 08 1E 73 3E 85 83 F7 2D A2 F2 4B 23 14 C4 3D 54 34 C5 81 82 BB 1F C6 6A E7 98 31 17 01 10 A3 B7 CB 1E 01 79 44 93 B9 BD 1A 0D 1E 89 B4 A2 72 24 EE D1 AB D6 B9 14 D1 5D 2D DF BC FB E6 45 44 44 03 2D 47 E0 3E 09 9C 66 07 48 AD 3C 87 14 49 AF 71 BA D0 BD E8 00 82 37 E3 BD CC 78 68 7B 44 C0 58 2E 70 5C 6E 7C A7 EE E4 44 77 A9 97 4D DA 8C 23 B6 3D 93 74 27 F9 F0 7F 49 5D 1C 8E 8E 55 84 3E 92 52 00 F2 BA 5B DC 61 FC 34 B3 C1 D1 6F 50 8A 97 C0 93 4D 16 E1 20 D0 7A 69 5D CC 3E AA B1 F6 77 75 85 6F BA EE 50 5A 17 35 C8 EB 14 60 61 F9 82 DC 8D 10 4C 8C 5A CE AA 46 77 88 CA 66 02 5C 17 69 23 AF 02 03 01 00 01 A3 50 30 4E 30 4C 06 03 55 1D 11 04 45 30 43 A0 41 06 08 2B 06 01 05 05 07 08 05 A0 35 0C 33 2A 2E 65 63 32 2D 31 37 36 2D 33 34 2D 32 31 33 2D 35 37 2E 65 75 2D 77 65 73 74 2D 31 2E 63 6F 6D 70 75 74 65 2E 61 6D 61 7A 6F 6E 61 77 73 2E 63 6F 6D 30 0D 06 09 2A 86 48 86 F7 0D 01 01 05 05 00 03 82 01 01 00 5A F0 00 5B CD 64 F1 A0 29 74 4B B3 72 79 C1 1D F6 37 13 82 34 B1 4F E2 F8 E3 26 1A B6 60 BB B3 A9 66 20 AF 22 D6 3A 5D E9 0D 64 14 57 C6 95 56 52 04 65 F6 9A 08 05 56 41 96 70 92 90 BA F0 2E E4 AD 18 A3 82 A4 9E 0C 83 BB 76 01 ED 1A 81 2A 74 DC 8F FF 9D 51 BB 37 12 40 53 05 10 2B E0 8B 2E 2E 7D 0C 30 4A 62 C7 97 D3 26 F9 72 E7 6A E3 A0 57 3E C3 5E BF 0B A9 F9 03 4D F5 6E 9C 99 99 C3 DB 20 39 DA 6A 15 F8 A9 57 13 70 60 5F 9A FC E2 CD 30 A0 53 99 AA 30 C4 6D 87 98 36 E1 B0 B2 8A 61 C9 96 CB 83 B9 3C FF B3 76 87 6A B2 05 CD 4B 71 42 A5 BC 8C F0 62 D5 84 36 46 94 94 F0 78 2F AD FD E7 E9 FD E9 A6 A0 94 D8 1F 91 BB 6F 78 05 1B 0F 2F 2E 82 B2 C1 9C BD A1 31 3F 3F DD 5F A5 24 7F 51 F0 1F 8B 68 66 4C EE 9B 5C B6 05 89 9B 8B CB 6D 5A BE 5B 62 C8 B0 DC D8 FA 2D D2 4E 0C 00 01 47 03 00 17 41 04 2C 05 71 F6 9F 39 A3 CD 40 20 72 81 F9 E2 48 F8 8D D4 82 84 85 E5 41 2D FA 09 82 C6 26 47 6B 35 EA 6B 72 A4 FA A3 59 21 37 73 85 ED 40 90 7D 82 A2 0E 62 C1 94 F5 E7 A2 84 15 66 3A C1 41 B5 3D 01 00 9A 87 32 B6 50 2F F7 63 ED F5 C7 E2 07 FD 50 21 1F C4 63 2F FB 72 DD 72 E3 D2 5B 17 7A F8 76 C2 E7 AA 3F 69 C9 38 D7 6F AD 44 F4 85 E4 FB 85 FD 77 70 AD 83 E8 29 F2 2D 41 AC E1 16 ED F6 00 9D A9 67 69 5E 8E 64 02 6E 89 29 70 22 13 65 4F 79 F1 CA 91 8B 37 92 67 75 85 F1 68 7C 84 BA 5A 07 75 D5 AB BC 81 E0 4B CA 3C FF 1B 60 9B 73 2F 54 0E 2B 54 37 8A 2B FB 0E 45 1D 76 26 4B 34 97 C1 BB 47 C2 18 94 7A E4 C3 CE 56 9B 69 DD 05 DC 82 68 9D C1 08 EA 5B B7 AD 2A 06 FE 07 23 9D B3 4F 82 86 CD A4 A9 10 E3 F7 AC 62 5A 35 D7 A7 6D 17 3D 41 BB 9C 15 0E C8 97 2A 28 E2 45 51 49 6A F3 44 FE BF 3B 19 AD 51 A3 87 DB D7 E0 B9 98 D9 81 09 4B 83 F6 D7 41 64 82 B1 69 59 6B 31 56 9B C0 FD A8 94 99 09 98 E9 BA 4A 82 B1 67 B4 EC 3E D0 33 0D 43 F0 47 9F AF 0F F0 C6 11 2C F9 DD 32 A0 0E 00 00 00] 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] handshakeStatus=NEED_UNWRAP 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] unwrapHandshake() 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] inNetBuffer: java.nio.DirectByteBuffer[pos=0 lim=0 cap=16665] 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] appBuffer: java.nio.DirectByteBuffer[pos=0 lim=33330 cap=33330] 2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] Unwrap res:Status = BUFFER_UNDERFLOW HandshakeStatus = NEED_UNWRAP bytesConsumed = 0 bytesProduced = 0
2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] Data Read: org.apache.mina.filter.support.SSLHandler@19a0c4e (HeapBuffer[pos=0 lim=7 cap=512: 15 03 01 00 02 02 2E])
2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] doHandshake()
2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] handshakeStatus=NEED_UNWRAP
2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] unwrapHandshake()
2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] inNetBuffer: java.nio.DirectByteBuffer[pos=0 lim=7 cap=16665]
2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] appBuffer: java.nio.DirectByteBuffer[pos=0 lim=33330 cap=33330]
2013.01.25 17:01:52 org.apache.mina.filter.executor.ExecutorFilter - Launching thread for /77.177.27.92:56567
2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] Closed: org.apache.mina.filter.support.SSLHandler@19a0c4e
2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/77.177.27.92:56567] Unexpected exception from SSLEngine.closeInbound().
javax.net.ssl.SSLException: Inbound closed before receiving peer's close_notify: possible truncation attack?
at com.sun.net.ssl.internal.ssl.Alerts.getSSLException(Unknown Source)
at com.sun.net.ssl.internal.ssl.SSLEngineImpl.fatal(Unknown Source)
at com.sun.net.ssl.internal.ssl.SSLEngineImpl.fatal(Unknown Source)
at com.sun.net.ssl.internal.ssl.SSLEngineImpl.closeInbound(Unknown Source)
at org.apache.mina.filter.support.SSLHandler.destroy(SSLHandler.java:167)
at org.apache.mina.filter.SSLFilter.sessionClosed(SSLFilter.java:367)
at org.apache.mina.common.support.AbstractIoFilterChain.callNextSessionClosed(AbstractIoFilterChain.java:269)
at org.apache.mina.common.support.AbstractIoFilterChain.access$800(AbstractIoFilterChain.java:53)
at org.apache.mina.common.support.AbstractIoFilterChain$EntryImpl$1.sessionClosed(AbstractIoFilterChain.java:633)
at org.apache.mina.common.support.AbstractIoFilterChain$HeadFilter.sessionClosed(AbstractIoFilterChain.java:484)
at org.apache.mina.common.support.AbstractIoFilterChain.callNextSessionClosed(AbstractIoFilterChain.java:269)
at org.apache.mina.common.support.AbstractIoFilterChain.fireSessionClosed(AbstractIoFilterChain.java:264)
at org.apache.mina.common.support.IoServiceListenerSupport.fireSessionDestroyed(IoServiceListenerSupport.java:224)
at org.apache.mina.transport.socket.nio.SocketIoProcessor.doRemove(SocketIoProcessor.java:188)
at org.apache.mina.transport.socket.nio.SocketIoProcessor.access$600(SocketIoProcessor.java:45)
at org.apache.mina.transport.socket.nio.SocketIoProcessor$Worker.run(SocketIoProcessor.java:489)
at org.apache.mina.util.NamePreservingRunnable.run(NamePreservingRunnable.java:51)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)
2013.01.25 17:01:52 org.jivesoftware.openfire.nio.ConnectionHandler - ConnectionHandler:
javax.net.ssl.SSLHandshakeException: SSL handshake failed.
at org.apache.mina.filter.SSLFilter.messageReceived(SSLFilter.java:416)
at org.apache.mina.common.support.AbstractIoFilterChain.callNextMessageReceived(AbstractIoFilterChain.java:299)
at org.apache.mina.common.support.AbstractIoFilterChain.access$1100(AbstractIoFilterChain.java:53)
at org.apache.mina.common.support.AbstractIoFilterChain$EntryImpl$1.messageReceived(AbstractIoFilterChain.java:648)
at org.apache.mina.common.support.AbstractIoFilterChain$HeadFilter.messageReceived(AbstractIoFilterChain.java:499)
at org.apache.mina.common.support.AbstractIoFilterChain.callNextMessageReceived(AbstractIoFilterChain.java:299)
at org.apache.mina.common.support.AbstractIoFilterChain.fireMessageReceived(AbstractIoFilterChain.java:293)
at org.apache.mina.transport.socket.nio.SocketIoProcessor.read(SocketIoProcessor.java:228)
at org.apache.mina.transport.socket.nio.SocketIoProcessor.process(SocketIoProcessor.java:198)
at org.apache.mina.transport.socket.nio.SocketIoProcessor.access$400(SocketIoProcessor.java:45)
at org.apache.mina.transport.socket.nio.SocketIoProcessor$Worker.run(SocketIoProcessor.java:485)
at org.apache.mina.util.NamePreservingRunnable.run(NamePreservingRunnable.java:51)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)
Caused by: javax.net.ssl.SSLException: Received fatal alert: certificate_unknown
at com.sun.net.ssl.internal.ssl.Alerts.getSSLException(Unknown Source)
at com.sun.net.ssl.internal.ssl.SSLEngineImpl.fatal(Unknown Source)
at com.sun.net.ssl.internal.ssl.SSLEngineImpl.fatal(Unknown Source)
at com.sun.net.ssl.internal.ssl.SSLEngineImpl.recvAlert(Unknown Source)
at com.sun.net.ssl.internal.ssl.SSLEngineImpl.readRecord(Unknown Source)
at com.sun.net.ssl.internal.ssl.SSLEngineImpl.readNetRecord(Unknown Source)
at com.sun.net.ssl.internal.ssl.SSLEngineImpl.unwrap(Unknown Source)
at javax.net.ssl.SSLEngine.unwrap(Unknown Source)
at org.apache.mina.filter.support.SSLHandler.unwrap0(SSLHandler.java:658)
at org.apache.mina.filter.support.SSLHandler.unwrapHandshake(SSLHandler.java:614)
at org.apache.mina.filter.support.SSLHandler.handshake(SSLHandler.java:493)
at org.apache.mina.filter.support.SSLHandler.messageReceived(SSLHandler.java:306)
at org.apache.mina.filter.SSLFilter.messageReceived(SSLFilter.java:392)
... 14 more
2013.01.25 17:01:52 org.apache.mina.filter.executor.ExecutorFilter - Exiting since queue is empty for /77.177.27.92:56567
2013.01.25 17:01:52 org.apache.mina.filter.executor.ExecutorFilter - Launching thread for /77.177.27.92:56568
2013.01.25 17:01:52 org.apache.mina.filter.executor.ExecutorFilter - Exiting since queue is empty for /77.177.27.92:56568
2013.01.25 17:01:53 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.58.179.234:44345] Data Read: org.apache.mina.filter.support.SSLHandler@364ef (HeapBuffer[pos=0 lim=22 cap=64: 17 03 01 00 11 E3 0A 50 6E 6A 3F D5 25 0C F9 5E D6 A3 9B 38 F5 AA])
2013.01.25 17:01:53 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.58.179.234:44345] unwrap()
2013.01.25 17:01:53 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.58.179.234:44345] inNetBuffer: java.nio.DirectByteBuffer[pos=0 lim=22 cap=16665]
2013.01.25 17:01:53 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.58.179.234:44345] appBuffer: java.nio.DirectByteBuffer[pos=0 lim=33330 cap=33330]
2013.01.25 17:01:53 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.58.179.234:44345] Unwrap res:Status = OK HandshakeStatus = NOT_HANDSHAKING
bytesConsumed = 22 bytesProduced = 1
2013.01.25 17:01:53 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.58.179.234:44345] inNetBuffer: java.nio.DirectByteBuffer[pos=22 lim=22 cap=16665]
2013.01.25 17:01:53 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.58.179.234:44345] appBuffer: java.nio.DirectByteBuffer[pos=1 lim=33330 cap=33330]
2013.01.25 17:01:53 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.58.179.234:44345] Unwrap res:Status = BUFFER_UNDERFLOW HandshakeStatus = NOT_HANDSHAKING
bytesConsumed = 0 bytesProduced = 0
2013.01.25 17:01:53 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.58.179.234:44345] appBuffer: java.nio.DirectByteBuffer[pos=0 lim=1 cap=33330]
2013.01.25 17:01:53 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.58.179.234:44345] app data read: HeapBuffer[pos=0 lim=1 cap=1: 20] (20)
2013.01.25 17:01:53 org.apache.mina.filter.executor.ExecutorFilter - Launching thread for /10.58.179.234:44345
2013.01.25 17:01:53 org.apache.mina.filter.executor.ExecutorFilter - Exiting since queue is empty for /10.58.179.234:44345
2013.01.25 17:01:53 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.235.54.167:56181] Data Read: org.apache.mina.filter.support.SSLHandler@19fc4e (HeapBuffer[pos=0 lim=22 cap=64: 17 03 01 00 11 83 3D 7D D7 1C D8 0F 78 A8 79 ED 7F E4 DA 14 91 62])
2013.01.25 17:01:53 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.235.54.167:56181] unwrap()
2013.01.25 17:01:53 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.235.54.167:56181] inNetBuffer: java.nio.DirectByteBuffer[pos=0 lim=22 cap=16665]
2013.01.25 17:01:53 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.235.54.167:56181] appBuffer: java.nio.DirectByteBuffer[pos=0 lim=33330 cap=33330]
2013.01.25 17:01:53 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.235.54.167:56181] Unwrap res:Status = OK HandshakeStatus = NOT_HANDSHAKING
bytesConsumed = 22 bytesProduced = 1
2013.01.25 17:01:53 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.235.54.167:56181] inNetBuffer: java.nio.DirectByteBuffer[pos=22 lim=22 cap=16665]
2013.01.25 17:01:53 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.235.54.167:56181] appBuffer: java.nio.DirectByteBuffer[pos=1 lim=33330 cap=33330]
2013.01.25 17:01:53 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.235.54.167:56181] Unwrap res:Status = BUFFER_UNDERFLOW HandshakeStatus = NOT_HANDSHAKING
bytesConsumed = 0 bytesProduced = 0
2013.01.25 17:01:53 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.235.54.167:56181] appBuffer: java.nio.DirectByteBuffer[pos=0 lim=1 cap=33330]
2013.01.25 17:01:53 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.235.54.167:56181] app data read: HeapBuffer[pos=0 lim=1 cap=1: 20] (20)
2013.01.25 17:01:53 org.apache.mina.filter.executor.ExecutorFilter - Launching thread for /10.235.54.167:56181
2013.01.25 17:01:53 org.apache.mina.filter.executor.ExecutorFilter - Exiting since queue is empty for /10.235.54.167:56181
2013.01.25 17:01:53 org.apache.mina.filter.executor.ExecutorFilter - Launching thread for /77.177.27.92:56568 2013.01.25 17:01:53 org.apache.mina.filter.executor.ExecutorFilter - Exiting since queue is empty for /77.177.27.92:56568
2013.01.25 17:01:53 org.apache.mina.filter.executor.ExecutorFilter - Launching thread for /77.177.27.92:56568
2013.01.25 17:01:53 org.jivesoftware.openfire.net.SASLAuthentication - SASLAuthentication: SaslException
javax.security.sasl.SaslException: Expecting comma or linear whitespace after quoted string: "utf-8"
at com.sun.security.sasl.digest.DigestMD5Base.parseDirectives(Unknown Source) at com.sun.security.sasl.digest.DigestMD5Server.evaluateResponse(Unknown Source)
at org.jivesoftware.openfire.net.SASLAuthentication.handle(SASLAuthentication.java:325)
at org.jivesoftware.openfire.net.StanzaHandler.process(StanzaHandler.java:183)
at org.jivesoftware.openfire.nio.ConnectionHandler.messageReceived(ConnectionHandler.java:169)
at org.apache.mina.common.support.AbstractIoFilterChain$TailFilter.messageReceived(AbstractIoFilterChain.java:570)
at org.apache.mina.common.support.AbstractIoFilterChain.callNextMessageReceived(AbstractIoFilterChain.java:299)
at org.apache.mina.common.support.AbstractIoFilterChain.access$1100(AbstractIoFilterChain.java:53)
at org.apache.mina.common.support.AbstractIoFilterChain$EntryImpl$1.messageReceived(AbstractIoFilterChain.java:648)
at org.apache.mina.common.IoFilterAdapter.messageReceived(IoFilterAdapter.java:80)
at org.apache.mina.common.support.AbstractIoFilterChain.callNextMessageReceived(AbstractIoFilterChain.java:299)
at org.apache.mina.common.support.AbstractIoFilterChain.access$1100(AbstractIoFilterChain.java:53)
at org.apache.mina.common.support.AbstractIoFilterChain$EntryImpl$1.messageReceived(AbstractIoFilterChain.java:648)
at org.apache.mina.filter.codec.support.SimpleProtocolDecoderOutput.flush(SimpleProtocolDecoderOutput.java:58)
at org.apache.mina.filter.codec.ProtocolCodecFilter.messageReceived(ProtocolCodecFilter.java:185)
at org.apache.mina.common.support.AbstractIoFilterChain.callNextMessageReceived(AbstractIoFilterChain.java:299)
at org.apache.mina.common.support.AbstractIoFilterChain.access$1100(AbstractIoFilterChain.java:53)
at org.apache.mina.common.support.AbstractIoFilterChain$EntryImpl$1.messageReceived(AbstractIoFilterChain.java:648)
at org.apache.mina.filter.executor.ExecutorFilter.processEvent(ExecutorFilter.java:239)
at org.apache.mina.filter.executor.ExecutorFilter$ProcessEventsRunnable.run(ExecutorFilter.java:283)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at org.apache.mina.util.NamePreservingRunnable.run(NamePreservingRunnable.java:51)
at java.lang.Thread.run(Unknown Source)
2013.01.25 17:01:53 org.apache.mina.filter.executor.ExecutorFilter - Exiting since queue is empty for /77.177.27.92:56568
2013.01.25 17:01:54 org.apache.mina.filter.executor.ExecutorFilter - Launching thread for /77.177.27.92:56568
2013.01.25 17:01:54 org.apache.mina.filter.executor.ExecutorFilter - Exiting since queue is empty for /77.177.27.92:56568
2013.01.25 17:01:55 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.58.179.234:44360] Data Read: org.apache.mina.filter.support.SSLHandler@d79c75 (HeapBuffer[pos=0 lim=22 cap=64: 17 03 01 00 11 A2 51 34 48 C2 51 CE C6 A3 49 15 91 0F 30 76 DC 16])
2013.01.25 17:01:55 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.58.179.234:44360] unwrap()
2013.01.25 17:01:55 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.58.179.234:44360] inNetBuffer: java.nio.DirectByteBuffer[pos=0 lim=22 cap=16665]
2013.01.25 17:01:55 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.58.179.234:44360] appBuffer: java.nio.DirectByteBuffer[pos=0 lim=33330 cap=33330]
2013.01.25 17:01:55 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.58.179.234:44360] Unwrap res:Status = OK HandshakeStatus = NOT_HANDSHAKING
bytesConsumed = 22 bytesProduced = 1
2013.01.25 17:01:55 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.58.179.234:44360] inNetBuffer: java.nio.DirectByteBuffer[pos=22 lim=22 cap=16665]
2013.01.25 17:01:55 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.58.179.234:44360] appBuffer: java.nio.DirectByteBuffer[pos=1 lim=33330 cap=33330]
2013.01.25 17:01:55 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.58.179.234:44360] Unwrap res:Status = BUFFER_UNDERFLOW HandshakeStatus = NOT_HANDSHAKING
bytesConsumed = 0 bytesProduced = 0 2013.01.25 17:01:55 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.58.179.234:44360] appBuffer: java.nio.DirectByteBuffer[pos=0 lim=1 cap=33330]
2013.01.25 17:01:55 org.jivesoftware.openfire.nio.ClientConnectionHandler - [/10.58.179.234:44360] app data read: HeapBuffer[pos=0 lim=1 cap=1: 20] (20)
2013.01.25 17:01:55 org.apache.mina.filter.executor.ExecutorFilter - Launching thread for /10.58.179.234:44360
2013.01.25 17:01:55 org.apache.mina.filter.executor.ExecutorFilter - Exiting since queue is empty for /10.58.179.234:44360
2013.01.25 17:01:58 org.jivesoftware.util.log.util.JettyLog - JettyLog: servlet holder=
2013.01.25 17:01:58 org.jivesoftware.util.log.util.JettyLog - JettyLog: chain=
2013.01.25 17:01:58 org.jivesoftware.util.log.util.JettyLog - JettyLog: servlet holder=
2013.01.25 17:01:58 org.jivesoftware.util.log.util.JettyLog - JettyLog: chain=
2013.01.25 17:01:59 org.jivesoftware.util.log.util.JettyLog - JettyLog: servlet holder=
2013.01.25 17:01:59 org.jivesoftware.util.log.util.JettyLog - JettyLog: chain=

example.xml.zip (1849 Bytes)

Did you ever find a solution for this? I think I am experiencing a similar issue.