Skip to content

Instantly share code, notes, and snippets.

@lloydwatkin
Last active December 10, 2015 18:48
Show Gist options
  • Save lloydwatkin/4476672 to your computer and use it in GitHub Desktop.
Save lloydwatkin/4476672 to your computer and use it in GitHub Desktop.
Authentication issues buddycloud API server and Tigase Server: ip-10-66-2-93 Username: romeo@ip-10-66-2-93 Password: romeo "INCOMING"/"OUTGOING" logs from api server, everything else is coming from tigase with full logging switched on. Note: System is up and working using old strophe.js based webclient. Config: // Default settings (apply to all …
Request: <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="DIGEST-MD5"/>, conn: user_jid=null, connectioId=c2s@ip-10-66-2-93/127.0.0.1_5222_127.0.0.1_49388
2013-01-07 16:53:45 SessionManager.processPacket() FINEST: Packet processed by: [urn:ietf:params:xml:ns:xmpp-sasl]
2013-01-07 16:53:45 UserAuthRepositoryImpl.saslAuth() FINEST: response:
2013-01-07 16:53:45 UserAuthRepositoryImpl.saslAuth() FINEST: challenge: realm="ip-10-66-2-93",nonce="xMN7Xh9l9XZgadq5mTSBi5QmHBtPo53EZV2cPy1y",qop="auth",charset=utf-8,algorithm=md5-sess
2013-01-07 16:53:45 DomainFilter.getDomains() FINEST: domains read from user session: null
2013-01-07 16:53:45 MessageRouter.processPacket() FINEST: Processing packet: from=sess-man@ip-10-66-2-93, to=c2s@ip-10-66-2-93/127.0.0.1_5222_127.0.0.1_49388, data=<challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">CData size: 152</challenge>, XMLNS=urn:ietf:params:xml:ns:xmpp-sasl, priority=NORMAL
2013-01-07 16:53:45 MessageRouter.processPacket() FINEST: Packet will be processed by: c2s@ip-10-66-2-93
2013-01-07 16:53:45 ClientConnectionManager.processPacket() FINER: Processing packet: challenge, type: null
2013-01-07 16:53:45 ClientConnectionManager.processPacket() FINEST: Processing packet: from=sess-man@ip-10-66-2-93, to=c2s@ip-10-66-2-93/127.0.0.1_5222_127.0.0.1_49388, data=<challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">CData size: 152</challenge>, XMLNS=urn:ietf:params:xml:ns:xmpp-sasl, priority=NORMAL
2013-01-07 16:53:45 ConnectionManager.writePacketToSocket() FINEST: 127.0.0.1_5222_127.0.0.1_49388, type: accept, Socket: TLS: Socket[addr=/127.0.0.1,port=49388,localport=5222], Writing packet to: c2s@ip-10-66-2-93/127.0.0.1_5222_127.0.0.1_49388
INCOMING: <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl" xmlns:stream="http://etherx.jabber.org/streams">cmVhbG09ImlwLTEwLTY2LTItOTMiLG5vbmNlPSJ4TU43WGg5bDlYWmdhZHE1bVRTQmk1UW1IQnRQbzUzRVpWMmNQeTF5Iixxb3A9ImF1dGgiLGNoYXJzZXQ9dXRmLTgsYWxnb3JpdGhtPW1kNS1zZXNz</challenge>
OUTGOING: <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dXNlcm5hbWU9InJvbWVvIixyZWFsbT0iaXAtMTAtNjYtMi05MyIsbm9uY2U9InhNTjdYaDlsOVhaZ2FkcTVtVFNCaTVRbUhCdFBvNTNFWlYyY1B5MXkiLGNub25jZT0iOjQzOjY5NDoiLG5jPSIwMDAwMDAwMSIscW9wPSJhdXRoIixkaWdlc3QtdXJpPSJ4bXBwL2lwLTEwLTY2LTItOTMiLHJlc3BvbnNlPSIwNzIxNTU4NGQ1OWQxYmYxNGNjNzI0MWIzOTVmYzQwMyIsYXV0aHppZD0icm9tZW9AaXAtMTAtNjYtMi05MyIsY2hhcnNldD0idXRmLTgi</response>
2013-01-07 16:53:45 ClientConnectionManager.processSocketData() FINER: Processing packet: response, type: null
2013-01-07 16:53:45 ClientConnectionManager.processSocketData() FINEST: Processing socket data: from=null, to=null, data=<response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">CData size: 336</response>, XMLNS=urn:ietf:params:xml:ns:xmpp-sasl, priority=NORMAL
2013-01-07 16:53:45 MessageRouter.processPacket() FINEST: Processing packet: from=c2s@ip-10-66-2-93/127.0.0.1_5222_127.0.0.1_49388, to=sess-man@ip-10-66-2-93, data=<response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">CData size: 336</response>, XMLNS=urn:ietf:params:xml:ns:xmpp-sasl, priority=NORMAL
2013-01-07 16:53:45 MessageRouter.processPacket() FINEST: Packet will be processed by: sess-man@ip-10-66-2-93
2013-01-07 16:53:45 SessionManager.processPacket() FINEST: Received packet: from=c2s@ip-10-66-2-93/127.0.0.1_5222_127.0.0.1_49388, to=sess-man@ip-10-66-2-93, data=<response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">CData size: 336</response>, XMLNS=urn:ietf:params:xml:ns:xmpp-sasl, priority=NORMAL
2013-01-07 16:53:45 SessionManager.processPacket() FINEST: processing packet: from=c2s@ip-10-66-2-93/127.0.0.1_5222_127.0.0.1_49388, to=sess-man@ip-10-66-2-93, data=<response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">CData size: 336</response>, XMLNS=urn:ietf:params:xml:ns:xmpp-sasl, priority=NORMAL, connection: user_jid=null, connectioId=c2s@ip-10-66-2-93/127.0.0.1_5222_127.0.0.1_49388
2013-01-07 16:53:45 DomainFilter.preProcess() FINEST: Processing: from=c2s@ip-10-66-2-93/127.0.0.1_5222_127.0.0.1_49388, to=sess-man@ip-10-66-2-93, data=<response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dXNlcm5hbWU9InJvbWVvIixyZWFsbT0iaXAtMTAtNjYtMi05MyIsbm9uY2U9InhNTjdYaDlsOVhaZ2FkcTVtVFNCaTVRbUhCdFBvNTNFWlYyY1B5MXkiLGNub25jZT0iOjQzOjY5NDoiLG5jPSIwMDAwMDAwMSIscW9wPSJhdXRoIixkaWdlc3QtdXJpPSJ4bXBwL2lwLTEwLTY2LTItOTMiLHJlc3BvbnNlPSIwNzIxNTU4NGQ1OWQxYmYxNGNjNzI0MWIzOTVmYzQwMyIsYXV0aHppZD0icm9tZW9AaXAtMTAtNjYtMi05MyIsY2hhcnNldD0idXRmLTgi</response>, XMLNS=urn:ietf:params:xml:ns:xmpp-sasl, priority=NORMAL
2013-01-07 16:53:45 DomainFilter.getDomains() FINEST: domains read from user session: null
2013-01-07 16:53:45 SessionManager.walk() FINEST: XMPPProcessorIfc: SaslAuth (urn:ietf:params:xml:ns:xmpp-sasl)
Request: <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dXNlcm5hbWU9InJvbWVvIixyZWFsbT0iaXAtMTAtNjYtMi05MyIsbm9uY2U9InhNTjdYaDlsOVhaZ2FkcTVtVFNCaTVRbUhCdFBvNTNFWlYyY1B5MXkiLGNub25jZT0iOjQzOjY5NDoiLG5jPSIwMDAwMDAwMSIscW9wPSJhdXRoIixkaWdlc3QtdXJpPSJ4bXBwL2lwLTEwLTY2LTItOTMiLHJlc3BvbnNlPSIwNzIxNTU4NGQ1OWQxYmYxNGNjNzI0MWIzOTVmYzQwMyIsYXV0aHppZD0icm9tZW9AaXAtMTAtNjYtMi05MyIsY2hhcnNldD0idXRmLTgi</response>, conn: user_jid=null, connectioId=c2s@ip-10-66-2-93/127.0.0.1_5222_127.0.0.1_49388
2013-01-07 16:53:45 SessionManager.processPacket() FINEST: Packet processed by: [urn:ietf:params:xml:ns:xmpp-sasl]
2013-01-07 16:53:45 UserAuthRepositoryImpl.saslAuth() FINEST: response: username="romeo",realm="ip-10-66-2-93",nonce="xMN7Xh9l9XZgadq5mTSBi5QmHBtPo53EZV2cPy1y",cnonce=":43:694:",nc="00000001",qop="auth",digest-uri="xmpp/ip-10-66-2-93",response="07215584d59d1bf14cc7241b395fc403",authzid="romeo@ip-10-66-2-93",charset="utf-8"
2013-01-07 16:53:45 UserAuthRepositoryImpl$SaslCallbackHandler.handle() FINEST: Callback: RealmCallback
2013-01-07 16:53:45 UserAuthRepositoryImpl$SaslCallbackHandler.handle() FINEST: RealmCallback: ip-10-66-2-93
2013-01-07 16:53:45 UserAuthRepositoryImpl$SaslCallbackHandler.handle() FINEST: Callback: NameCallback
2013-01-07 16:53:45 UserAuthRepositoryImpl$SaslCallbackHandler.handle() FINEST: NameCallback: romeo
2013-01-07 16:53:45 UserAuthRepositoryImpl$SaslCallbackHandler.handle() FINEST: Callback: PasswordCallback
2013-01-07 16:53:45 JDBCRepository.getNodeNID() FINEST: select nid as nid1 from tig_nodes where (uid = 63) AND (parent_nid is null) AND (node = 'root')
2013-01-07 16:53:45 JDBCRepository.getData() FINEST: Loading data for key: password, user: romeo@ip-10-66-2-93, node: null, def: null, found nid: 12
2013-01-07 16:53:45 JDBCRepository.getData() FINEST: Found data: romeo
2013-01-07 16:53:45 UserAuthRepositoryImpl$SaslCallbackHandler.handle() FINEST: PasswordCallback: romeo
2013-01-07 16:53:45 UserAuthRepositoryImpl$SaslCallbackHandler.handle() FINEST: Callback: AuthorizeCallback
2013-01-07 16:53:45 UserAuthRepositoryImpl$SaslCallbackHandler.handle() FINEST: AuthorizeCallback: authenId: romeo
2013-01-07 16:53:45 UserAuthRepositoryImpl$SaslCallbackHandler.handle() FINEST: AuthorizeCallback: authorId: romeo@ip-10-66-2-93
2013-01-07 16:53:45 DomainFilter.getDomains() FINEST: domains read from user session: null
2013-01-07 16:53:45 MessageRouter.processPacket() FINEST: Processing packet: from=sess-man@ip-10-66-2-93, to=c2s@ip-10-66-2-93/127.0.0.1_5222_127.0.0.1_49388, data=<failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl">CData size: 17</failure>, XMLNS=urn:ietf:params:xml:ns:xmpp-sasl, priority=NORMAL
2013-01-07 16:53:45 MessageRouter.processPacket() FINEST: Packet will be processed by: c2s@ip-10-66-2-93
2013-01-07 16:53:45 ClientConnectionManager.processPacket() FINER: Processing packet: failure, type: null
2013-01-07 16:53:45 ClientConnectionManager.processPacket() FINEST: Processing packet: from=sess-man@ip-10-66-2-93, to=c2s@ip-10-66-2-93/127.0.0.1_5222_127.0.0.1_49388, data=<failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl">CData size: 17</failure>, XMLNS=urn:ietf:params:xml:ns:xmpp-sasl, priority=NORMAL
2013-01-07 16:53:45 ConnectionManager.writePacketToSocket() FINEST: 127.0.0.1_5222_127.0.0.1_49388, type: accept, Socket: TLS: Socket[addr=/127.0.0.1,port=49388,localport=5222], Writing packet to: c2s@ip-10-66-2-93/127.0.0.1_5222_127.0.0.1_49388
INCOMING: <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl" xmlns:stream="http://etherx.jabber.org/streams"><not-authorized/></failure>
Authentication fail: XMPP authentication failure
10.66.254.10 - - [Mon, 07 Jan 2013 16:53:45 GMT] "POST /romeo@ip-10-66-2-93/content/posts HTTP/1.1" 401 12 "-" "curl/7.21.4 (universal-apple-darwin11.0) libcurl/7.21.4 OpenSSL/0.9.8r zlib/1.2.5"
@lloydwatkin
Copy link
Author

cURL command used to post to HTTP API server:

curl -u romeo:romeo --data-binary "<entry xmwww.w3.org/2005/Atom'>Hey" http://ip-10-66-2-93:3000/romeo@ip-10-66-2-93/content/posts

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment