Hi Frank, what is your question?
Bernd On Fri, May 10, 2013 at 9:48 PM, Frank Arico <[email protected]> wrote: > I am trying to intercept XMPP messages and do some non XMPP event handling > on the message content. The actual XMPP client will be sending messages > to another applications's XMPP server but will also send to my instance > of vysper for event processing. I do not want to set up a client session > on my server but just want to intercept and do some processing on the > message content. Is this possible? ( Apologies in advance, I am new to > XMPP.) > This processing would in no way participate in the XMPPconversion > occurring on the other server. The use case is to intercept > XMPP traffic and use a Stanza filter to only receive the message , do some > processing on the message and not send out the Message. The other > XMPPserver is handling all the client/server interaction. > > Here the filter I am using to intercept the XMPP message. I adapted it > from the Standard Logging filter. > > public class HomeSecurityStanzaFilter extends IoFilterAdapter { > > final Logger serverLogger = LoggerFactory.getLogger("stanza.server"); > > > final Logger clientLogger = LoggerFactory.getLogger("stanza.client"); > > > > public void messageReceived(NextFilter nextFilter, IoSession session, > Object message) throws Exception { > if (message instanceof XMLElement) { > XMLElement element = (XMLElement) message; > > > > boolean openElement = true; > > > boolean closeElement = true; > > > // this is somewhat of a hack, can we detect opening and > closing elements only cleaner? > if (element.getName().equals("stream")) { > if (element.getAttributes().size() > 0) { > // is stream element, and with attributes, should be > opening tag > closeElement = false; > > > } else { > // is stream element, without attributes, should be > closing tag > openElement = false; > > > } > } > > String xml = toXml(element, openElement, closeElement); > > > clientLogger.debug("< " + xml); > > > > } > > nextFilter.messageReceived(session, message); > > > } > > public void messageSent(NextFilter nextFilter, IoSession session, > WriteRequest request) throws Exception { > > Object message = request.getMessage(); > > > if (message instanceof StanzaWriteInfo) { > StanzaWriteInfo stanzaWriteInfo = (StanzaWriteInfo) message; > > > > String xml = toXml(stanzaWriteInfo.getStanza(), stanzaWriteInfo. > isWriteOpeningElement(), > stanzaWriteInfo.isWriteClosingElement()); > > > serverLogger.debug("> " + xml); > > > } > nextFilter.messageSent(session, request); > > > } > > private String toXml(XMLElement element, boolean openElement, boolean > closeElement) { > Renderer renderer = new Renderer(element); > > > > StringBuffer xml = new StringBuffer(); > > > if (openElement) { > xml.append(renderer.getOpeningElement()); > > > } > > ... > ... > } > > Here's my client test program using Smack API > > import java.util.*; > import java.io.*; > > import org.jivesoftware.smack.Chat; > import org.jivesoftware.smack.ConnectionConfiguration; > import org.jivesoftware.smack.MessageListener; > import org.jivesoftware.smack.Roster; > import org.jivesoftware.smack.RosterEntry; > import org.jivesoftware.smack.XMPPConnection; > import org.jivesoftware.smack.XMPPException; > import org.jivesoftware.smack.packet.Message; > > public class SendMessage implements MessageListener{ > > XMPPConnection connection; > > public void login(String userName, String password) throws > XMPPException > { > ConnectionConfiguration config = new > ConnectionConfiguration("localhost",5222, > "Work"); > connection = new XMPPConnection(config); > > connection.connect(); > connection.login(userName, password); > } > > public void sendMessage(String message, String to) throws XMPPException > { > Chat chat = connection.getChatManager().createChat(to, this); > chat.sendMessage(message); > } > > > public void disconnect() > { > connection.disconnect(); > } > > > public static void main(String args[]) throws XMPPException, > IOException > { > // declare variables > SendMessage c = new SendMessage(); > BufferedReader br = new BufferedReader(new InputStreamReader > (System.in)); > String msg; > > > // turn on the enhanced debugger > XMPPConnection.DEBUG_ENABLED = true; > > > // Enter your login information here > c.login("user1", "password"); > > String talkTo = "[email protected]"; > System.out.println("All messages will be sent to " + talkTo); > > c.sendMessage("THIS IS MY TEST MESSAGE",talkTo); > > c.disconnect(); > System.exit(0); > } > > } > > When I start my copy of vysper and then run my client test program I get > the following stack trace > > DEBUG [2013 May 10 15:31:36.308] (VysperMain.java:main:51) - > HSvysperstarting > > INFO [2013 May 10 15:31:36.334] (OpenStorageProviderRegistry.java:add:81) > - could not load storage provider class org.apache.vysper.xmpp > .modules.extension.xep0060_pubsub.storageprovider. > LeafNodeInMemoryStorageProvider > > INFO [2013 May 10 15:31:36.335] (OpenStorageProviderRegistry.java:add:81) > - could not load storage provider class org.apache.vysper.xmpp > .modules.extension.xep0060_pubsub.storageprovider. > CollectionNodeInMemoryStorageProvider > > INFO [2013 May 10 15:31:36.689] (DefaultServerRuntimeContext.java: > setStorageProviderRegistry:267) - replacing the storage provider registry > with org.apache.vysper.storage.inmemory.MemoryStorageProviderRegistry > > INFO [2013 May 10 15:31:36.726] (DefaultServerRuntimeContext.java: > addModuleInternal:316) - adding module... servicediscovery (1.0beta) > > INFO [2013 May 10 15:31:36.737] (DefaultServerRuntimeContext.java: > addModuleInternal:316) - adding module... roster (1.0beta) > > DEBUG [2013 May 10 15:31:36.811] (VysperMain.java:main:86) - > HSvysperserver is running... > > INFO [2013 May 10 15:31:36.813] (DefaultServerRuntimeContext.java: > addModuleInternal:316) - adding module... XEP-0092 Software Version (1.0) > > INFO [2013 May 10 15:31:36.818] (DefaultServerRuntimeContext.java: > addModuleInternal:316) - adding module... XEP-0202 Entity Time (1.0) > > INFO [2013 May 10 15:31:36.825] (DefaultServerRuntimeContext.java: > addModuleInternal:316) - adding module... XEP-0054 Vcard-temp (1.0) > > ERROR [2013 May 10 15:31:36.825] (VcardTempModule.java:initialize:55) - no > VcardTempPersistenceManager found > > INFO [2013 May 10 15:31:36.826] (DefaultServerRuntimeContext.java: > addModuleInternal:316) - adding module... XEP-0199 XMPP Ping (2.0) > > INFO [2013 May 10 15:31:36.840] (DefaultServerRuntimeContext.java: > addModuleInternal:316) - adding module... XEP-0049 Private Data (1.2) > > ERROR [2013 May 10 15:31:36.841] (PrivateDataModule.java:initialize:55) - > no PrivateDataPersistenceManager found > > INFO [2013 May 10 15:31:36.842] (DefaultServerRuntimeContext.java: > addModuleInternal:316) - adding module... XEP-0077 In-Band Registration > (2.3) > > INFO [2013 May 10 15:31:36.844] (DefaultServerRuntimeContext.java: > addModuleInternal:316) - adding module... XEP-0050 Ad-hoc Commands (1.2) > > INFO [2013 May 10 15:31:36.850] (DefaultServerRuntimeContext.java: > addModuleInternal:316) - adding module... XEP-0133 Service Administration > (1.1) > > DEBUG [2013 May 10 15:31:40.913] (SessionStateHolder.java:setState:43) - > session state changed to = INITIATED > > INFO [2013 May 10 15:31:40.916] (XmppIoHandlerAdapter.java:sessionOpened > :110) - new session from /127.0.0.1:61499 has been opened > > DEBUG [2013 May 10 15:31:42.092] (ProtocolCodecFilter.java:messageReceived > :220) - Processing a MESSAGE_RECEIVED for session 1 > > DEBUG [2013 May 10 15:31:42.250] (XMPPContentHandler.java:emitStanza:124) - > Decoder writing stanza: <stream:stream xmlns:stream="http://etherx. > jabber.org/streams" to="Work" version="1.0"></stream:stream> > > DEBUG [2013 May 10 15:31:42.251] (StanzaLoggingFilter.java:messageReceived > :61) - < <stream:stream xmlns:stream="http://etherx.jabber.org/streams"; > to="Work" version="1.0"> > > DEBUG [2013 May 10 15:31:42.251] (HomeSecurityStanzaFilter.java: > messageReceived:56) - < <stream:stream xmlns:stream="http://etherx. > jabber.org/streams" to="Work" version="1.0"> > > DEBUG [2013 May 10 15:31:42.258] (SessionStateHolder.java:setState:43) - > session state changed to = STARTED > > DEBUG [2013 May 10 15:31:42.272] (StanzaLoggingFilter.java:messageSent:79) > - > <stream:stream xmlns="jabber:client" xmlns:stream="http://etherx. > jabber.org/streams" from="hsvysper.org" version="1.0" > id="d81fde63f689463a8e138031d0713139"><stream:features > xmlns:stream="http:// > etherx.jabber.org/streams"><starttls > xmlns="urn:ietf:params:xml:ns:xmpp-tls > "><required></required></starttls><register xmlns=" > http://jabber.org/features/iq-register";></register></stream:features> > > DEBUG [2013 May 10 15:31:42.273] > (HomeSecurityStanzaFilter.java:messageSent: > 72) - > <stream:stream xmlns="jabber:client" xmlns:stream="http://etherx. > jabber.org/streams" from="hsvysper.org" version="1.0" > id="d81fde63f689463a8e138031d0713139"><stream:features > xmlns:stream="http:// > etherx.jabber.org/streams"><starttls > xmlns="urn:ietf:params:xml:ns:xmpp-tls > "><required></required></starttls><register xmlns=" > http://jabber.org/features/iq-register";></register></stream:features> > > DEBUG [2013 May 10 15:31:42.276] (ProtocolCodecFilter.java:messageReceived > :220) - Processing a MESSAGE_RECEIVED for session 1 > > DEBUG [2013 May 10 15:31:42.277] (XMPPContentHandler.java:emitStanza:124) - > Decoder writing stanza: <starttls > xmlns="urn:ietf:params:xml:ns:xmpp-tls"></ > starttls> > > DEBUG [2013 May 10 15:31:42.277] (StanzaLoggingFilter.java:messageReceived > :61) - < <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"></starttls> > > DEBUG [2013 May 10 15:31:42.277] (HomeSecurityStanzaFilter.java: > messageReceived:56) - < <starttls > xmlns="urn:ietf:params:xml:ns:xmpp-tls"></ > starttls> > > DEBUG [2013 May 10 15:31:42.278] (SessionStateHolder.java:setState:43) - > session state changed to = ENCRYPTION_STARTED > > DEBUG [2013 May 10 15:31:42.280] (SslFilter.java:onPreAdd:410) - Adding the > SSL Filter sslFilter to the chain > > DEBUG [2013 May 10 15:31:42.282] (SslHandler.java:init:137) - Session > Server[1](no sslEngine) Initializing the SSL Handler > > DEBUG [2013 May 10 15:31:42.441] (SslHandler.java:init:188) - Session > Server[1](no sslEngine) SSL Handler Initialization done. > > DEBUG [2013 May 10 15:31:42.441] (SslFilter.java:initiateHandshake:664) - > Session Server[1](ssl...) : Starting the first handshake > > DEBUG [2013 May 10 15:31:42.441] (SslHandler.java:handshake:546) - Session > Server[1](ssl...) processing the NEED_UNWRAP state > > DEBUG [2013 May 10 15:31:42.443] (SslFilter.java:filterWrite:581) - Session > Server[1](ssl...): Writing Message : WriteRequest: HeapBuffer[pos=0 lim=59 > cap=64: 3C 70 72 6F 63 65 65 64 20 78 6D 6C 6E 73 3D 22...] > > DEBUG [2013 May 10 15:31:42.445] (SslFilter.java:filterWrite:581) - Session > Server[1](ssl...): Writing Message : MessageWriteRequest, parent : WR > WrapperWriteRequest: [ prolog=false, open=true, close=true, content=true, > stanza=[proceed] > > DEBUG [2013 May 10 15:31:42.772] (SslFilter.java:messageReceived:460) - > Session Server[1](ssl...): Message received : HeapBuffer[pos=0 lim=112 > cap=1024: 80 6E 01 03 01 00 45 00 00 00 20 00 00 04 01 00...] > > DEBUG [2013 May 10 15:31:42.773] (SslHandler.java:messageReceived:335) - > Session Server[1](ssl...) Processing the received message > > DEBUG [2013 May 10 15:31:42.773] (SslHandler.java:handshake:546) - Session > Server[1](ssl...) processing the NEED_UNWRAP state > > DEBUG [2013 May 10 15:31:42.774] (SslHandler.java:handshake:538) - Session > Server[1](ssl...) processing the NEED_TASK state > > DEBUG [2013 May 10 15:31:42.777] (SslHandler.java:handshake:561) - Session > Server[1](ssl...) processing the NEED_WRAP state > > DEBUG [2013 May 10 15:31:42.777] (SslFilter.java:filterWrite:581) - Session > Server[1](ssl...): Writing Message : WriteRequest: HeapBuffer[pos=0 lim=560 > cap=1041: 16 03 01 02 2B 02 00 00 4D 03 01 51 8D 4B 1E ED...] > > DEBUG [2013 May 10 15:31:42.778] (SslHandler.java:handshake:546) - Session > Server[1](ssl...) processing the NEED_UNWRAP state > > DEBUG [2013 May 10 15:31:42.778] (SslFilter.java:handleSslData:706) - > Session Server[1](ssl...): Processing the SSL Data > > DEBUG [2013 May 10 15:31:42.786] (SslFilter.java:messageReceived:460) - > Session Server[1](ssl...): Message received : HeapBuffer[pos=0 lim=75 > cap=1024: 16 03 01 00 46 10 00 00 42 00 40 56 AE 13 A9 64...] > > DEBUG [2013 May 10 15:31:42.786] (SslHandler.java:messageReceived:335) - > Session Server[1](ssl...) Processing the received message > > DEBUG [2013 May 10 15:31:42.786] (SslHandler.java:handshake:546) - Session > Server[1](ssl...) processing the NEED_UNWRAP state > > DEBUG [2013 May 10 15:31:42.786] (SslHandler.java:handshake:538) - Session > Server[1](ssl...) processing the NEED_TASK state > > DEBUG [2013 May 10 15:31:42.802] (SslHandler.java:handshake:546) - Session > Server[1](ssl...) processing the NEED_UNWRAP state > > DEBUG [2013 May 10 15:31:42.803] (SslFilter.java:handleSslData:706) - > Session Server[1](ssl...): Processing the SSL Data > > DEBUG [2013 May 10 15:31:42.803] (SslFilter.java:messageReceived:460) - > Session Server[1](ssl...): Message received : HeapBuffer[pos=0 lim=6 > cap=512: 14 03 01 00 01 01] > > DEBUG [2013 May 10 15:31:42.803] (SslHandler.java:messageReceived:335) - > Session Server[1](ssl...) Processing the received message > > DEBUG [2013 May 10 15:31:42.804] (SslHandler.java:handshake:546) - Session > Server[1](ssl...) processing the NEED_UNWRAP state > > DEBUG [2013 May 10 15:31:42.988] (SslFilter.java:handleSslData:706) - > Session Server[1](ssl...): Processing the SSL Data > > DEBUG [2013 May 10 15:31:42.989] (SslFilter.java:messageReceived:460) - > Session Server[1](ssl...): Message received : HeapBuffer[pos=0 lim=37 > cap=512: 16 03 01 00 20 39 DE 97 6B B8 D5 13 8D B9 4B 78...] > > DEBUG [2013 May 10 15:31:42.989] (SslHandler.java:messageReceived:335) - > Session Server[1](ssl...) Processing the received message > > DEBUG [2013 May 10 15:31:42.989] (SslHandler.java:handshake:546) - Session > Server[1](ssl...) processing the NEED_UNWRAP state > > DEBUG [2013 May 10 15:31:42.990] (SslHandler.java:handshake:561) - Session > Server[1](ssl...) processing the NEED_WRAP state > > DEBUG [2013 May 10 15:31:42.990] (SslFilter.java:filterWrite:581) - Session > Server[1](ssl...): Writing Message : WriteRequest: HeapBuffer[pos=0 lim=6 > cap=8: 14 03 01 00 01 01] > > DEBUG [2013 May 10 15:31:42.991] (SslHandler.java:handshake:561) - Session > Server[1](ssl...) processing the NEED_WRAP state > > DEBUG [2013 May 10 15:31:42.991] (SslFilter.java:filterWrite:581) - Session > Server[1](ssl...): Writing Message : WriteRequest: HeapBuffer[pos=0 lim=37 > cap=65: 16 03 01 00 20 90 65 38 FC 3B 9C 4C 1F C1 95 32...] > > DEBUG [2013 May 10 15:31:42.991] (SslHandler.java:handshake:513) - Session > Server[1](ssl...) processing the FINISHED state > > DEBUG [2013 May 10 15:31:42.991] (SslHandler.java:handshake:528) - Session > Server[1](SSL) is now secured > > DEBUG [2013 May 10 15:31:42.991] (SslHandler.java:handshake:513) - Session > Server[1](SSL) processing the FINISHED state > > DEBUG [2013 May 10 15:31:42.991] (SslHandler.java:handshake:528) - Session > Server[1](SSL) is now secured > > DEBUG [2013 May 10 15:31:42.992] (SslFilter.java:handleSslData:706) - > Session Server[1](SSL): Processing the SSL Data > > DEBUG [2013 May 10 15:31:42.992] (SslFilter.java:filterWrite:581) - Session > Server[1](SSL): Writing Message : MessageWriteRequest, parent : WR > WrapperWriteRequest: [ prolog=false, open=true, close=true, content=true, > stanza=[proceed] > > DEBUG [2013 May 10 15:31:42.992] (ProtocolCodecFilter.java:messageReceived > :220) - Processing a MESSAGE_RECEIVED for session 1 > > DEBUG [2013 May 10 15:31:42.993] (SessionStateHolder.java:setState:43) - > session state changed to = ENCRYPTED > > DEBUG [2013 May 10 15:31:42.994] (StanzaLoggingFilter.java:messageSent:79) > - > <proceed xmlns="urn:ietf:params:xml:ns:xmpp-tls"></proceed> > > DEBUG [2013 May 10 15:31:42.994] > (HomeSecurityStanzaFilter.java:messageSent: > 72) - > <proceed xmlns="urn:ietf:params:xml:ns:xmpp-tls"></proceed> > > DEBUG [2013 May 10 15:31:42.995] (SslFilter.java:messageReceived:460) - > Session Server[1](SSL): Message received : HeapBuffer[pos=0 lim=138 > cap=256: 17 03 01 00 85 85 6E 34 E2 F6 17 97 3D BF 1C 31...] > > DEBUG [2013 May 10 15:31:42.995] (SslHandler.java:messageReceived:335) - > Session Server[1](SSL) Processing the received message > > DEBUG [2013 May 10 15:31:42.996] (SslFilter.java:handleSslData:706) - > Session Server[1](SSL): Processing the SSL Data > > DEBUG [2013 May 10 15:31:42.996] (ProtocolCodecFilter.java:messageReceived > :220) - Processing a MESSAGE_RECEIVED for session 1 > > DEBUG [2013 May 10 15:31:42.997] (XMPPContentHandler.java:emitStanza:124) - > Decoder writing stanza: <stream:stream xmlns:stream="http://etherx. > jabber.org/streams" to="hsvysper.org" version="1.0"></stream:stream> > > DEBUG [2013 May 10 15:31:42.998] (StanzaLoggingFilter.java:messageReceived > :61) - < <stream:stream xmlns:stream="http://etherx.jabber.org/streams"; > to=" > hsvysper.org" version="1.0"> > > DEBUG [2013 May 10 15:31:42.999] (HomeSecurityStanzaFilter.java: > messageReceived:56) - < <stream:stream xmlns:stream="http://etherx. > jabber.org/streams" to="hsvysper.org" version="1.0"> > > DEBUG [2013 May 10 15:31:43.000] (SslFilter.java:filterWrite:581) - Session > Server[1](SSL): Writing Message : WriteRequest: HeapBuffer[pos=0 lim=372 > cap=512: 3C 3F 78 6D 6C 20 76 65 72 73 69 6F 6E 3D 22 31...] > > DEBUG [2013 May 10 15:31:43.001] (SslFilter.java:filterWrite:581) - Session > Server[1](SSL): Writing Message : MessageWriteRequest, parent : WR > WrapperWriteRequest: [ prolog=true, open=true, close=false, content=true, > stanza=[stream.features.mechanisms[PLAIN]] > > DEBUG [2013 May 10 15:31:43.002] (StanzaLoggingFilter.java:messageSent:79) > - > <stream:stream xmlns="jabber:client" xmlns:stream="http://etherx. > jabber.org/streams" from="hsvysper.org" version="1.0" > id="d81fde63f689463a8e138031d0713139"><stream:features > xmlns:stream="http:// > etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp- > sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features> > > DEBUG [2013 May 10 15:31:43.003] > (HomeSecurityStanzaFilter.java:messageSent: > 72) - > <stream:stream xmlns="jabber:client" xmlns:stream="http://etherx. > jabber.org/streams" from="hsvysper.org" version="1.0" > id="d81fde63f689463a8e138031d0713139"><stream:features > xmlns:stream="http:// > etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp- > sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features> > > DEBUG [2013 May 10 15:31:43.041] (SslFilter.java:messageReceived:460) - > Session Server[1](SSL): Message received : HeapBuffer[pos=0 lim=121 > cap=256: 17 03 01 00 74 5F 48 29 9E 01 73 DC B4 E5 E1 5A...] > > DEBUG [2013 May 10 15:31:43.041] (SslHandler.java:messageReceived:335) - > Session Server[1](SSL) Processing the received message > > DEBUG [2013 May 10 15:31:43.042] (SslFilter.java:handleSslData:706) - > Session Server[1](SSL): Processing the SSL Data > > DEBUG [2013 May 10 15:31:43.042] (ProtocolCodecFilter.java:messageReceived > :220) - Processing a MESSAGE_RECEIVED for session 1 > > DEBUG [2013 May 10 15:31:43.043] (XMPPContentHandler.java:emitStanza:124) - > Decoder writing stanza: <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" > mechanism="PLAIN">dXNlcjEAdXNlcjEAcGFzc3dvcmQ=</auth> > > DEBUG [2013 May 10 15:31:43.043] (StanzaLoggingFilter.java:messageReceived > :61) - < <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" > mechanism="PLAIN">dXNlcjEAdXNlcjEAcGFzc3dvcmQ=</auth> > > DEBUG [2013 May 10 15:31:43.043] (HomeSecurityStanzaFilter.java: > messageReceived:56) - < <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" > mechanism="PLAIN">dXNlcjEAdXNlcjEAcGFzc3dvcmQ=</auth> > > DEBUG [2013 May 10 15:31:43.048] (SessionStateHolder.java:setState:43) - > session state changed to = AUTHENTICATED > > DEBUG [2013 May 10 15:31:43.049] (SslFilter.java:filterWrite:581) - Session > Server[1](SSL): Writing Message : WriteRequest: HeapBuffer[pos=0 lim=60 > cap=64: 3C 73 75 63 63 65 73 73 20 78 6D 6C 6E 73 3D 22...] > > DEBUG [2013 May 10 15:31:43.049] (SslFilter.java:filterWrite:581) - Session > Server[1](SSL): Writing Message : MessageWriteRequest, parent : WR > WrapperWriteRequest: [ prolog=false, open=true, close=true, content=true, > stanza=[success] > > DEBUG [2013 May 10 15:31:43.050] (StanzaLoggingFilter.java:messageSent:79) > - > <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl"></success> > > DEBUG [2013 May 10 15:31:43.050] > (HomeSecurityStanzaFilter.java:messageSent: > 72) - > <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl"></success> > > DEBUG [2013 May 10 15:31:43.052] (SslFilter.java:messageReceived:460) - > Session Server[1](SSL): Message received : HeapBuffer[pos=0 lim=138 > cap=256: 17 03 01 00 85 C2 DF 03 22 4B B4 8B 73 7C 63 BF...] > > DEBUG [2013 May 10 15:31:43.052] (SslHandler.java:messageReceived:335) - > Session Server[1](SSL) Processing the received message > > DEBUG [2013 May 10 15:31:43.052] (SslFilter.java:handleSslData:706) - > Session Server[1](SSL): Processing the SSL Data > > DEBUG [2013 May 10 15:31:43.053] (ProtocolCodecFilter.java:messageReceived > :220) - Processing a MESSAGE_RECEIVED for session 1 > > DEBUG [2013 May 10 15:31:43.054] (XMPPContentHandler.java:emitStanza:124) - > Decoder writing stanza: <stream:stream xmlns:stream="http://etherx. > jabber.org/streams" to="hsvysper.org" version="1.0"></stream:stream> > > DEBUG [2013 May 10 15:31:43.055] (StanzaLoggingFilter.java:messageReceived > :61) - < <stream:stream xmlns:stream="http://etherx.jabber.org/streams"; > to=" > hsvysper.org" version="1.0"> > > DEBUG [2013 May 10 15:31:43.055] (HomeSecurityStanzaFilter.java: > messageReceived:56) - < <stream:stream xmlns:stream="http://etherx. > jabber.org/streams" to="hsvysper.org" version="1.0"> > > DEBUG [2013 May 10 15:31:43.057] (SslFilter.java:filterWrite:581) - Session > Server[1](SSL): Writing Message : WriteRequest: HeapBuffer[pos=0 lim=437 > cap=512: 3C 3F 78 6D 6C 20 76 65 72 73 69 6F 6E 3D 22 31...] > > DEBUG [2013 May 10 15:31:43.058] (SslFilter.java:filterWrite:581) - Session > Server[1](SSL): Writing Message : MessageWriteRequest, parent : WR > WrapperWriteRequest: [ prolog=true, open=true, close=false, content=true, > stanza=[stream] > > DEBUG [2013 May 10 15:31:43.059] (StanzaLoggingFilter.java:messageSent:79) > - > <stream:stream xmlns="jabber:client" xmlns:stream="http://etherx. > jabber.org/streams" from="hsvysper.org" version="1.0" > id="d81fde63f689463a8e138031d0713139"><stream:features > xmlns:stream="http:// > etherx.jabber.org/streams"><bind > > xmlns="urn:ietf:params:xml:ns:xmpp-bind"><required></required></bind><session > xmlns="urn:ietf:params:xml:ns:xmpp > -session"><required></required></session></stream:features> > > DEBUG [2013 May 10 15:31:43.060] > (HomeSecurityStanzaFilter.java:messageSent: > 72) - > <stream:stream xmlns="jabber:client" xmlns:stream="http://etherx. > jabber.org/streams" from="hsvysper.org" version="1.0" > id="d81fde63f689463a8e138031d0713139"><stream:features > xmlns:stream="http:// > etherx.jabber.org/streams"><bind > > xmlns="urn:ietf:params:xml:ns:xmpp-bind"><required></required></bind><session > xmlns="urn:ietf:params:xml:ns:xmpp > -session"><required></required></session></stream:features> > > DEBUG [2013 May 10 15:31:43.062] (SslFilter.java:messageReceived:460) - > Session Server[1](SSL): Message received : HeapBuffer[pos=0 lim=134 > cap=256: 17 03 01 00 81 D0 8D C4 43 9D DA 8F EA 69 52 5D...] > > DEBUG [2013 May 10 15:31:43.062] (SslHandler.java:messageReceived:335) - > Session Server[1](SSL) Processing the received message > > DEBUG [2013 May 10 15:31:43.063] (SslFilter.java:handleSslData:706) - > Session Server[1](SSL): Processing the SSL Data > > DEBUG [2013 May 10 15:31:43.063] (ProtocolCodecFilter.java:messageReceived > :220) - Processing a MESSAGE_RECEIVED for session 1 > > DEBUG [2013 May 10 15:31:43.065] (XMPPContentHandler.java:emitStanza:124) - > Decoder writing stanza: <iq xmlns="jabber:client" id="5aOWt-0" > type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp > -bind"><resource>Smack</resource></bind></iq> > > DEBUG [2013 May 10 15:31:43.065] (StanzaLoggingFilter.java:messageReceived > :61) - < <iq xmlns="jabber:client" id="5aOWt-0" type="set"><bind > xmlns="urn: > ietf:params:xml:ns:xmpp-bind"><resource>Smack</resource></bind></iq> > > DEBUG [2013 May 10 15:31:43.066] (HomeSecurityStanzaFilter.java: > messageReceived:56) - < <iq xmlns="jabber:client" id="5aOWt-0" > type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp > -bind"><resource>Smack</resource></bind></iq> > > INFO [2013 May 10 15:31:43.070] (ResourceRegistry.java:bindSession:112) - > added resource no. 1 to entity [email protected] <- > 7f19e37e0555455ab4fa3e51ef3e9f2b > > INFO [2013 May 10 15:31:43.070] (ResourceRegistry.java:bindSession:121) - > added resource no. 1 to session d81fde63f689463a8e138031d0713139 <- > 7f19e37e0555455ab4fa3e51ef3e9f2b > > DEBUG [2013 May 10 15:31:43.154] (SslFilter.java:filterWrite:581) - Session > Server[1](SSL): Writing Message : WriteRequest: HeapBuffer[pos=0 lim=174 > cap=256: 3C 69 71 20 78 6D 6C 6E 73 3D 22 6A 61 62 62 65...] > > DEBUG [2013 May 10 15:31:43.155] (SslFilter.java:filterWrite:581) - Session > Server[1](SSL): Writing Message : MessageWriteRequest, parent : WR > WrapperWriteRequest: [ prolog=false, open=true, close=true, content=true, > stanza=[iq.id='5aOWt-0'.type='result'.bind.xmlns='urn:ietf:params:xml:ns: > xmpp-bind'] > > DEBUG [2013 May 10 15:31:43.155] (StanzaLoggingFilter.java:messageSent:79) > - > <iq xmlns="jabber:client" type="result" id="5aOWt-0"><bind xmlns="urn: > ietf:params:xml:ns:xmpp-bind"><jid>user1@hsvysper > .org/7f19e37e0555455ab4fa3e51ef3e9f2b</jid></bind></iq> > > DEBUG [2013 May 10 15:31:43.156] > (HomeSecurityStanzaFilter.java:messageSent: > 72) - > <iq xmlns="jabber:client" type="result" id="5aOWt-0"><bind xmlns > ="urn:ietf:params:xml:ns:xmpp-bind"><jid>user1@hsvysper > .org/7f19e37e0555455ab4fa3e51ef3e9f2b</jid></bind></iq> > > DEBUG [2013 May 10 15:31:43.157] (SslFilter.java:messageReceived:460) - > Session Server[1](SSL): Message received : HeapBuffer[pos=0 lim=108 > cap=256: 17 03 01 00 67 17 34 D0 2C CF 0D 3D F2 57 CB 46...] > > DEBUG [2013 May 10 15:31:43.158] (SslHandler.java:messageReceived:335) - > Session Server[1](SSL) Processing the received message > > DEBUG [2013 May 10 15:31:43.158] (SslFilter.java:handleSslData:706) - > Session Server[1](SSL): Processing the SSL Data > > DEBUG [2013 May 10 15:31:43.158] (ProtocolCodecFilter.java:messageReceived > :220) - Processing a MESSAGE_RECEIVED for session 1 > > DEBUG [2013 May 10 15:31:43.160] (XMPPContentHandler.java:emitStanza:124) - > Decoder writing stanza: <iq xmlns="jabber:client" id="5aOWt-1" > type="set"><session > xmlns="urn:ietf:params:xml:ns:xmpp-session"></session></ > iq> > > DEBUG [2013 May 10 15:31:43.160] (StanzaLoggingFilter.java:messageReceived > :61) - < <iq xmlns="jabber:client" id="5aOWt-1" type="set"><session xmlns > ="urn:ietf:params:xml:ns:xmpp-session"></session></iq> > > DEBUG [2013 May 10 15:31:43.161] (HomeSecurityStanzaFilter.java: > messageReceived:56) - < <iq xmlns="jabber:client" id="5aOWt-1" > type="set"><session > xmlns="urn:ietf:params:xml:ns:xmpp-session"></session></ > iq> > > DEBUG [2013 May 10 15:31:43.164] (SslFilter.java:filterWrite:581) - Session > Server[1](SSL): Writing Message : WriteRequest: HeapBuffer[pos=0 lim=78 > cap=128: 3C 69 71 20 78 6D 6C 6E 73 3D 22 6A 61 62 62 65...] > > DEBUG [2013 May 10 15:31:43.164] (SslFilter.java:filterWrite:581) - Session > Server[1](SSL): Writing Message : MessageWriteRequest, parent : WR > WrapperWriteRequest: [ prolog=false, open=true, close=true, content=true, > stanza=[iq.id='5aOWt-1'.from='hsvysper.org'.type='result'] > > DEBUG [2013 May 10 15:31:43.165] (StanzaLoggingFilter.java:messageSent:79) > - > <iq xmlns="jabber:client" type="result" id="5aOWt-1" from="hsvysper > .org"></iq> > > DEBUG [2013 May 10 15:31:43.166] > (HomeSecurityStanzaFilter.java:messageSent: > 72) - > <iq xmlns="jabber:client" type="result" id="5aOWt-1" from="hsvysper > .org"></iq> > > DEBUG [2013 May 10 15:31:43.171] (SslFilter.java:messageReceived:460) - > Session Server[1](SSL): Message received : HeapBuffer[pos=0 lim=128 > cap=128: 17 03 01 00 7B 65 5A AF 63 B8 88 40 0B C7 92 41...] > > DEBUG [2013 May 10 15:31:43.171] (SslHandler.java:messageReceived:335) - > Session Server[1](SSL) Processing the received message > > DEBUG [2013 May 10 15:31:43.172] (SslFilter.java:handleSslData:706) - > Session Server[1](SSL): Processing the SSL Data > > DEBUG [2013 May 10 15:31:43.172] (ProtocolCodecFilter.java:messageReceived > :220) - Processing a MESSAGE_RECEIVED for session 1 > > DEBUG [2013 May 10 15:31:43.174] (XMPPContentHandler.java:emitStanza:124) - > Decoder writing stanza: <iq xmlns="jabber:client" id="5aOWt-2" > type="get"><query xmlns="jabber:iq:roster"></query></iq> > > DEBUG [2013 May 10 15:31:43.174] (XMPPContentHandler.java:emitStanza:124) - > Decoder writing stanza: <presence xmlns="jabber:client" > id="5aOWt-3"></presence> > > DEBUG [2013 May 10 15:31:43.175] (StanzaLoggingFilter.java:messageReceived > :61) - < <iq xmlns="jabber:client" id="5aOWt-2" type="get"><query xmlns > ="jabber:iq:roster"></query></iq> > > DEBUG [2013 May 10 15:31:43.175] (HomeSecurityStanzaFilter.java: > messageReceived:56) - < <iq xmlns="jabber:client" id="5aOWt-2" > type="get"><query xmlns="jabber:iq:roster"></query></iq> > > DEBUG [2013 May 10 15:31:43.230] (StanzaLoggingFilter.java:messageReceived > :61) - < <presence xmlns="jabber:client" id="5aOWt-3"></presence> > > DEBUG [2013 May 10 15:31:43.230] (HomeSecurityStanzaFilter.java: > messageReceived:56) - < <presence xmlns="jabber:client" > id="5aOWt-3"></presence> > > DEBUG [2013 May 10 15:31:43.231] (SslFilter.java:messageReceived:460) - > Session Server[1](SSL): Message received : HeapBuffer[pos=0 lim=256 > cap=256: 17 03 01 00 FF 70 08 22 A9 D2 E4 DC 97 7C 36 52...] > > DEBUG [2013 May 10 15:31:43.231] (SslHandler.java:messageReceived:335) - > Session Server[1](SSL) Processing the received message > > DEBUG [2013 May 10 15:31:43.231] (SslFilter.java:handleSslData:706) - > Session Server[1](SSL): Processing the SSL Data > > DEBUG [2013 May 10 15:31:43.232] (SslFilter.java:messageReceived:460) - > Session Server[1](SSL): Message received : HeapBuffer[pos=0 lim=64 cap=512: > 26 59 DD 7F 17 03 01 00 20 E3 06 CF FD BC 61 B6...] > > DEBUG [2013 May 10 15:31:43.232] (SslHandler.java:messageReceived:335) - > Session Server[1](SSL) Processing the received message > > DEBUG [2013 May 10 15:31:43.233] (SslFilter.java:handleSslData:706) - > Session Server[1](SSL): Processing the SSL Data > > DEBUG [2013 May 10 15:31:43.233] (SslFilter.java:filterWrite:581) - Session > Server[1]: Writing Message : WriteRequest: HeapBuffer[pos=0 lim=23 cap=32: > 15 03 01 00 12 8D F0 20 B1 C7 09 50 C8 B8 51 EE...] > > DEBUG [2013 May 10 15:31:43.233] (ProtocolCodecFilter.java:messageReceived > :220) - Processing a MESSAGE_RECEIVED for session 1 > > DEBUG [2013 May 10 15:31:43.233] (SslFilter.java:filterWrite:581) - Session > Server[1]: Writing Message : WriteRequest: HeapBuffer[pos=0 lim=155 > cap=256: 3C 69 71 20 78 6D 6C 6E 73 3D 22 6A 61 62 62 65...] > > WARN [2013 May 10 15:31:43.233] (PresenceAvailabilityHandler.java: > handleOutboundAvailable:262) - No Offline Storage Provider configured > > DEBUG [2013 May 10 15:31:43.234] (ProtocolCodecFilter.java:messageReceived > :220) - Processing a MESSAGE_RECEIVED for session 1 > > DEBUG [2013 May 10 15:31:43.234] (SslFilter.java:filterWrite:581) - Session > Server[1]: Writing Message : MessageWriteRequest, parent : WR > WrapperWriteRequest: [ prolog=false, open=true, close=true, content=true, > stanza=[iq.id='5aOWt-2'.to='user1@hsvysper > .org/7f19e37e0555455ab4fa3e51ef3e9f2b'.type='result'.query.xmlns='jabber:iq > :roster'] > > DEBUG [2013 May 10 15:31:43.235] (XMPPContentHandler.java:emitStanza:124) - > Decoder writing stanza: <message xmlns="jabber:client" to=" > [email protected]" > id="5aOWt-4" from="[email protected]/7f19e37e0555455ab4fa3e51ef3e9f2b" > type="chat"><body>THIS IS MY TEST > MESSAGE</body><thread>3XvCC0</thread></message> > > DEBUG [2013 May 10 15:31:43.236] (XMPPContentHandler.java:emitStanza:124) - > Decoder writing stanza: <presence xmlns="jabber:client" id="5aOWt-5" > type="unavailable"></presence> > > DEBUG [2013 May 10 15:31:43.236] (StanzaLoggingFilter.java:messageReceived > :61) - < <message xmlns="jabber:client" to="[email protected]" > id="5aOWt-4" from="[email protected]/7f19e37e0555455ab4fa3e51ef3e9f2b" > type="chat"><body>THIS IS MY TEST > MESSAGE</body><thread>3XvCC0</thread></message> > > DEBUG [2013 May 10 15:31:43.237] (HomeSecurityStanzaFilter.java: > messageReceived:56) - < <message xmlns="jabber:client" to=" > [email protected]" > id="5aOWt-4" from="[email protected]/7f19e37e0555455ab4fa3e51ef3e9f2b" > type="chat"><body>THIS IS MY TEST > MESSAGE</body><thread>3XvCC0</thread></message> > > DEBUG [2013 May 10 15:31:43.237] (StanzaLoggingFilter.java:messageReceived > :61) - < <presence xmlns="jabber:client" id="5aOWt-5" > type="unavailable"></presence> > > DEBUG [2013 May 10 15:31:43.238] (HomeSecurityStanzaFilter.java: > messageReceived:56) - < <presence xmlns="jabber:client" id="5aOWt-5" > type="unavailable"></presence> > > WARN [2013 May 10 15:31:43.257] > (XmppIoHandlerAdapter.java:exceptionCaught: > 140) - error caught on transportation layer: {} > > java.io.IOException: Broken pipe > > at sun.nio.ch.FileDispatcher.write0(Native Method) > > at sun.nio.ch.SocketDispatcher.write(SocketDispatcher.java:29) > > at sun.nio.ch.IOUtil.writeFromNativeBuffer(IOUtil.java:69) > > at sun.nio.ch.IOUtil.write(IOUtil.java:40) > > at sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:336) > > at org.apache.mina.transport.socket.nio.NioProcessor.write(NioProcessor > .java:221) > > at org.apache.mina.transport.socket.nio.NioProcessor.write(NioProcessor > .java:42) > > at org.apache.mina.core.polling.AbstractPollingIoProcessor.writeBuffer( > AbstractPollingIoProcessor.java:928) > > at org.apache.mina.core.polling.AbstractPollingIoProcessor.flushNow( > AbstractPollingIoProcessor.java:852) > > at org.apache.mina.core.polling.AbstractPollingIoProcessor.flush( > AbstractPollingIoProcessor.java:777) > > at org.apache.mina.core.polling.AbstractPollingIoProcessor.access$500( > AbstractPollingIoProcessor.java:67) > > at org.apache.mina.core.polling.AbstractPollingIoProcessor$Processor.run( > AbstractPollingIoProcessor.java:1084) > > at org.apache.mina.util.NamePreservingRunnable.run(NamePreservingRunnable > .java:64) > > at > java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor > .java:895) > > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor > .java:918) > > at java.lang.Thread.run(Thread.java:680) > > DEBUG [2013 May 10 15:31:43.265] (SslFilter.java:filterWrite:581) - Session > Server[1]: Writing Message : WriteRequest: HeapBuffer[pos=0 lim=145 > cap=256: 3C 65 72 72 6F 72 20 78 6D 6C 6E 73 3D 22 75 72...] > > DEBUG [2013 May 10 15:31:43.265] (SslFilter.java:filterWrite:581) - Session > Server[1]: Writing Message : MessageWriteRequest, parent : WR > WrapperWriteRequest: [ prolog=false, open=true, close=true, content=true, > stanza=[error.undefined-condition] > > INFO [2013 May 10 15:31:43.266] (MinaBackedSessionContext.java:close:110) > - session will be closed now > > INFO [2013 May 10 15:31:43.266] (MinaBackedSessionContext.java: > operationComplete:126) - close future called > > INFO [2013 May 10 15:31:43.266] (MinaBackedSessionContext.java:close:121) > - session closed > > DEBUG [2013 May 10 15:31:43.267] (SslFilter.java:filterWrite:581) - Session > Server[1]: Writing Message : WriteRequest: HeapBuffer[pos=0 lim=208 > cap=256: 3C 6D 65 73 73 61 67 65 20 78 6D 6C 6E 73 3D 22...] > > DEBUG [2013 May 10 15:31:43.266] (SslFilter.java:filterWrite:581) - Session > Server[1]: Writing Message : WriteRequest: HeapBuffer[pos=0 lim=172 > cap=256: 3C 70 72 65 73 65 6E 63 65 20 78 6D 6C 6E 73 3D...] > > DEBUG [2013 May 10 15:31:43.267] (SslFilter.java:filterWrite:581) - Session > Server[1]: Writing Message : MessageWriteRequest, parent : WR > WrapperWriteRequest: [ prolog=false, open=true, close=true, content=true, > stanza=[message.body.THIS IS MY TEST MESSAGE] > > DEBUG [2013 May 10 15:31:43.267] (SessionStateHolder.java:setState:43) - > session state changed to = CLOSED > > DEBUG [2013 May 10 15:31:43.267] (SslFilter.java:filterWrite:581) - Session > Server[1]: Writing Message : MessageWriteRequest, parent : WR > WrapperWriteRequest: [ prolog=false, open=true, close=true, content=true, > stanza=[presence.from='user1@hsvysper > .org/7f19e37e0555455ab4fa3e51ef3e9f2b'.to='user1@hsvysper > .org/7f19e37e0555455ab4fa3e51ef3e9f2b'] > > INFO [2013 May 10 15:31:43.268] (PresenceAvailabilityHandler.java: > handleInboundAvailable:447) - > [email protected]/7f19e37e0555455ab4fa3e51ef3e9f2b > has become available > > INFO [2013 May 10 15:31:43.269] (MinaBackedSessionContext.java:close:110) > - session will be closed now > > INFO [2013 May 10 15:31:43.270] (MinaBackedSessionContext.java:close:121) > - session closed > > DEBUG [2013 May 10 15:31:43.270] (SessionStateHolder.java:setState:43) - > session state changed to = CLOSED > > INFO [2013 May 10 15:31:43.270] (XmppIoHandlerAdapter.java:sessionClosed: > 120) - session d81fde63f689463a8e138031d0713139 has been closed > > > > > > -- > Frank Arico > [email protected]< > https://mail.google.com/mail/?view=cm&fs=1&tf=1&[email protected]> > Home: 610-902-0950 > Cell: 610-212-5476 >
