Skip to content

Instantly share code, notes, and snippets.

@ndarilek

ndarilek/gist:124087

Created June 5, 2009 05:24
Show Gist options
  • Save ndarilek/124087 to your computer and use it in GitHub Desktop.
Save ndarilek/124087 to your computer and use it in GitHub Desktop.
Download ZIP
Raw
gistfile1.txt
D, [2009-06-05T00:02:55.581833 #18758] DEBUG -- : NEW JID: echo@localhost/echo
D, [2009-06-05T00:02:55.582841 #18758] DEBUG -- : SENDING: (/var/lib/gems/1.8/gems/blather-0.4.0/lib/blather/stream.rb:77:in `connection_completed') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en' >
D, [2009-06-05T00:02:55.584574 #18758] DEBUG -- :
------------------------------
D, [2009-06-05T00:02:55.584796 #18758] DEBUG -- : << <?xml version='1.0'?><stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='95765323' from='localhost' version='1.0'><stream:features><mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><mechanism>DIGEST-MD5</mechanism><mechanism>PLAIN</mechanism></mechanisms><auth xmlns='http://jabber.org/features/iq-auth'></auth></stream:features>
D, [2009-06-05T00:02:55.584945 #18758] DEBUG -- : PARSING: (<?xml version='1.0'?><stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='95765323' from='localhost' version='1.0'><stream:features><mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><mechanism>DIGEST-MD5</mechanism><mechanism>PLAIN</mechanism></mechanisms><auth xmlns='http://jabber.org/features/iq-auth'></auth></stream:features>)
D, [2009-06-05T00:02:55.585422 #18758] DEBUG -- : START ELEM: ({:ns=>{"stream"=>"http://etherx.jabber.org/streams", nil=>"jabber:client"}, :elem=>"stream", :uri=>"http://etherx.jabber.org/streams", :prefix=>"stream", :attrs=>{"from"=>"localhost", "id"=>"95765323", "version"=>"1.0"}})
D, [2009-06-05T00:02:55.586262 #18758] DEBUG -- : RECEIVING (stream) <stream:stream xmlns:stream="http://etherx.jabber.org/streams" xmlns="jabber:client" from="localhost" id="95765323" version="1.0"/>
D, [2009-06-05T00:02:55.586588 #18758] DEBUG -- : START ELEM: ({:ns=>{}, :elem=>"features", :uri=>"http://etherx.jabber.org/streams", :prefix=>"stream", :attrs=>{}})
D, [2009-06-05T00:02:55.587037 #18758] DEBUG -- : START ELEM: ({:ns=>{nil=>"urn:ietf:params:xml:ns:xmpp-sasl"}, :elem=>"mechanisms", :uri=>"urn:ietf:params:xml:ns:xmpp-sasl", :prefix=>nil, :attrs=>{}})
D, [2009-06-05T00:02:55.587473 #18758] DEBUG -- : START ELEM: ({:ns=>{}, :elem=>"mechanism", :uri=>"urn:ietf:params:xml:ns:xmpp-sasl", :prefix=>nil, :attrs=>{}})
D, [2009-06-05T00:02:55.587785 #18758] DEBUG -- : CHARS: DIGEST-MD5
D, [2009-06-05T00:02:55.588045 #18758] DEBUG -- : END ELEM: {:elem=>"mechanism", :uri=>"urn:ietf:params:xml:ns:xmpp-sasl", :prefix=>nil}
D, [2009-06-05T00:02:55.588279 #18758] DEBUG -- : START ELEM: ({:ns=>{}, :elem=>"mechanism", :uri=>"urn:ietf:params:xml:ns:xmpp-sasl", :prefix=>nil, :attrs=>{}})
D, [2009-06-05T00:02:55.588556 #18758] DEBUG -- : CHARS: PLAIN
D, [2009-06-05T00:02:55.588793 #18758] DEBUG -- : END ELEM: {:elem=>"mechanism", :uri=>"urn:ietf:params:xml:ns:xmpp-sasl", :prefix=>nil}
D, [2009-06-05T00:02:55.588996 #18758] DEBUG -- : END ELEM: {:elem=>"mechanisms", :uri=>"urn:ietf:params:xml:ns:xmpp-sasl", :prefix=>nil}
D, [2009-06-05T00:02:55.589258 #18758] DEBUG -- : START ELEM: ({:ns=>{nil=>"http://jabber.org/features/iq-auth"}, :elem=>"auth", :uri=>"http://jabber.org/features/iq-auth", :prefix=>nil, :attrs=>{}})
D, [2009-06-05T00:02:55.589629 #18758] DEBUG -- : END ELEM: {:elem=>"auth", :uri=>"http://jabber.org/features/iq-auth", :prefix=>nil}
D, [2009-06-05T00:02:55.589861 #18758] DEBUG -- : END ELEM: {:elem=>"features", :uri=>"http://etherx.jabber.org/streams", :prefix=>"stream"}
D, [2009-06-05T00:02:55.590312 #18758] DEBUG -- : RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams">
<mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl">
<mechanism>DIGEST-MD5</mechanism>
<mechanism>PLAIN</mechanism>
</mechanisms>
<auth xmlns="http://jabber.org/features/iq-auth"/>
</stream:features>
D, [2009-06-05T00:02:55.591592 #18758] DEBUG -- : SENDING: (/var/lib/gems/1.8/gems/blather-0.4.0/lib/blather/stream/features/sasl.rb:67:in `authenticate_with') <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="DIGEST-MD5"/>
D, [2009-06-05T00:02:55.595732 #18758] DEBUG -- :
------------------------------
D, [2009-06-05T00:02:55.596121 #18758] DEBUG -- : << <challenge xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>bm9uY2U9IjA1NDhkNTZmLTJhMGUtNGEwMS04NjQ4LTJlZWVlYWZmMzcwNCIscW9wPSJhdXRoIixjaGFyc2V0PXV0Zi04LGFsZ29yaXRobT1tZDUtc2VzcyxyZWFsbT0ibG9jYWxob3N0Ig==</challenge>
D, [2009-06-05T00:02:55.596340 #18758] DEBUG -- : PARSING: (<challenge xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>bm9uY2U9IjA1NDhkNTZmLTJhMGUtNGEwMS04NjQ4LTJlZWVlYWZmMzcwNCIscW9wPSJhdXRoIixjaGFyc2V0PXV0Zi04LGFsZ29yaXRobT1tZDUtc2VzcyxyZWFsbT0ibG9jYWxob3N0Ig==</challenge>)
D, [2009-06-05T00:02:55.596702 #18758] DEBUG -- : START ELEM: ({:ns=>{nil=>"urn:ietf:params:xml:ns:xmpp-sasl"}, :elem=>"challenge", :uri=>"urn:ietf:params:xml:ns:xmpp-sasl", :prefix=>nil, :attrs=>{}})
D, [2009-06-05T00:02:55.629882 #18758] DEBUG -- : CHARS: bm9uY2U9IjA1NDhkNTZmLTJhMGUtNGEwMS04NjQ4LTJlZWVlYWZmMzcwNCIscW9wPSJhdXRoIixjaGFyc2V0PXV0Zi04LGFsZ29yaXRobT1tZDUtc2VzcyxyZWFsbT0ibG9jYWxob3N0Ig==
D, [2009-06-05T00:02:55.630243 #18758] DEBUG -- : END ELEM: {:elem=>"challenge", :uri=>"urn:ietf:params:xml:ns:xmpp-sasl", :prefix=>nil}
D, [2009-06-05T00:02:55.630581 #18758] DEBUG -- : RECEIVING (challenge) <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">bm9uY2U9IjA1NDhkNTZmLTJhMGUtNGEwMS04NjQ4LTJlZWVlYWZmMzcwNCIscW9wPSJhdXRoIixjaGFyc2V0PXV0Zi04LGFsZ29yaXRobT1tZDUtc2VzcyxyZWFsbT0ibG9jYWxob3N0Ig==</challenge>
D, [2009-06-05T00:02:55.631347 #18758] DEBUG -- : CHALLENGE DECODE: {"algorithm"=>"md5-sess", "nonce"=>"0548d56f-2a0e-4a01-8648-2eeeeaff3704", "charset"=>"utf-8", "qop"=>"auth", "realm"=>"localhost"}
D, [2009-06-05T00:02:55.632096 #18758] DEBUG -- : CHALLENGE RESPONSE: {:response=>"2d3f5c745e3b68af3407d96fa459343d", :nc=>"00000001", :realm=>"\"localhost\"", :qop=>"auth", :username=>"\"echo\"", :nonce=>"\"0548d56f-2a0e-4a01-8648-2eeeeaff3704\"", :"digest-uri"=>"\"xmpp/localhost\"", :cnonce=>"\"e036b79d9a70d2b82071fba75fb7c9eb\"", :charset=>"utf-8"}
D, [2009-06-05T00:02:55.632381 #18758] DEBUG -- : CH RESP TXT: response=2d3f5c745e3b68af3407d96fa459343d,nc=00000001,realm="localhost",qop=auth,username="echo",nonce="0548d56f-2a0e-4a01-8648-2eeeeaff3704",digest-uri="xmpp/localhost",cnonce="e036b79d9a70d2b82071fba75fb7c9eb",charset=utf-8
D, [2009-06-05T00:02:55.632970 #18758] DEBUG -- : SENDING: (/var/lib/gems/1.8/gems/blather-0.4.0/lib/blather/stream/features/sasl.rb:100:in `challenge') <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">bm9uY2U9IjA1NDhkNTZmLTJhMGUtNGEwMS04NjQ4LTJlZWVlYWZmMzcwNCIsY2hhcnNldD11dGYtOCx1c2VybmFtZT0iZWNobyIscmVhbG09ImxvY2FsaG9zdCIsY25vbmNlPSJlMDM2Yjc5ZDlhNzBkMmI4MjA3MWZiYTc1ZmI3YzllYiIsbmM9MDAwMDAwMDEscW9wPWF1dGgsZGlnZXN0LXVyaT0ieG1wcC9sb2NhbGhvc3QiLHJlc3BvbnNlPTJkM2Y1Yzc0NWUzYjY4YWYzNDA3ZDk2ZmE0NTkzNDNk</response>
D, [2009-06-05T00:02:55.644354 #18758] DEBUG -- :
------------------------------
D, [2009-06-05T00:02:55.644584 #18758] DEBUG -- : << <challenge xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>cnNwYXV0aD00NWE2Y2FiM2M1YmY0NzM0MzBlNDdlOTkyODlhMzJlMw==</challenge>
D, [2009-06-05T00:02:55.644739 #18758] DEBUG -- : PARSING: (<challenge xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>cnNwYXV0aD00NWE2Y2FiM2M1YmY0NzM0MzBlNDdlOTkyODlhMzJlMw==</challenge>)
D, [2009-06-05T00:02:55.645025 #18758] DEBUG -- : START ELEM: ({:ns=>{nil=>"urn:ietf:params:xml:ns:xmpp-sasl"}, :elem=>"challenge", :uri=>"urn:ietf:params:xml:ns:xmpp-sasl", :prefix=>nil, :attrs=>{}})
D, [2009-06-05T00:02:55.645447 #18758] DEBUG -- : CHARS: cnNwYXV0aD00NWE2Y2FiM2M1YmY0NzM0MzBlNDdlOTkyODlhMzJlMw==
D, [2009-06-05T00:02:55.645726 #18758] DEBUG -- : END ELEM: {:elem=>"challenge", :uri=>"urn:ietf:params:xml:ns:xmpp-sasl", :prefix=>nil}
D, [2009-06-05T00:02:55.646129 #18758] DEBUG -- : RECEIVING (challenge) <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cnNwYXV0aD00NWE2Y2FiM2M1YmY0NzM0MzBlNDdlOTkyODlhMzJlMw==</challenge>
D, [2009-06-05T00:02:55.646731 #18758] DEBUG -- : CHALLENGE DECODE: {"rspauth"=>"45a6cab3c5bf473430e47e99289a32e3"}
D, [2009-06-05T00:02:55.647295 #18758] DEBUG -- : SENDING: (/var/lib/gems/1.8/gems/blather-0.4.0/lib/blather/stream/features/sasl.rb:100:in `challenge') <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/>
D, [2009-06-05T00:02:55.649156 #18758] DEBUG -- :
------------------------------
D, [2009-06-05T00:02:55.649382 #18758] DEBUG -- : << <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'></success>
D, [2009-06-05T00:02:55.649535 #18758] DEBUG -- : PARSING: (<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'></success>)
D, [2009-06-05T00:02:55.649813 #18758] DEBUG -- : START ELEM: ({:ns=>{nil=>"urn:ietf:params:xml:ns:xmpp-sasl"}, :elem=>"success", :uri=>"urn:ietf:params:xml:ns:xmpp-sasl", :prefix=>nil, :attrs=>{}})
D, [2009-06-05T00:02:55.650320 #18758] DEBUG -- : END ELEM: {:elem=>"success", :uri=>"urn:ietf:params:xml:ns:xmpp-sasl", :prefix=>nil}
D, [2009-06-05T00:02:55.650694 #18758] DEBUG -- : RECEIVING (success) <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/>
D, [2009-06-05T00:02:55.651380 #18758] DEBUG -- : SENDING: (/var/lib/gems/1.8/gems/blather-0.4.0/lib/blather/stream/features/sasl.rb:28:in `receive_data') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en' >
D, [2009-06-05T00:02:55.658292 #18758] DEBUG -- :
------------------------------
D, [2009-06-05T00:02:55.658533 #18758] DEBUG -- : << <?xml version='1.0'?><stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='99931092' from='localhost' version='1.0'><stream:features><ver xmlns='urn:xmpp:features:rosterver'><optional></optional></ver><bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'><required></required></bind><session xmlns='urn:ietf:params:xml:ns:xmpp-session'></session><feature var='vcard-temp'></feature></stream:features>
D, [2009-06-05T00:02:55.658704 #18758] DEBUG -- : PARSING: (<?xml version='1.0'?><stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='99931092' from='localhost' version='1.0'><stream:features><ver xmlns='urn:xmpp:features:rosterver'><optional></optional></ver><bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'><required></required></bind><session xmlns='urn:ietf:params:xml:ns:xmpp-session'></session><feature var='vcard-temp'></feature></stream:features>)
D, [2009-06-05T00:02:55.659071 #18758] DEBUG -- : START ELEM: ({:ns=>{"stream"=>"http://etherx.jabber.org/streams", nil=>"jabber:client"}, :elem=>"stream", :uri=>"http://etherx.jabber.org/streams", :prefix=>"stream", :attrs=>{"from"=>"localhost", "id"=>"99931092", "version"=>"1.0"}})
D, [2009-06-05T00:02:55.659704 #18758] DEBUG -- : RECEIVING (stream) <stream:stream xmlns:stream="http://etherx.jabber.org/streams" xmlns="jabber:client" from="localhost" id="99931092" version="1.0"/>
D, [2009-06-05T00:02:55.659991 #18758] DEBUG -- : START ELEM: ({:ns=>{}, :elem=>"features", :uri=>"http://etherx.jabber.org/streams", :prefix=>"stream", :attrs=>{}})
D, [2009-06-05T00:02:55.660442 #18758] DEBUG -- : START ELEM: ({:ns=>{nil=>"urn:xmpp:features:rosterver"}, :elem=>"ver", :uri=>"urn:xmpp:features:rosterver", :prefix=>nil, :attrs=>{}})
D, [2009-06-05T00:02:55.660911 #18758] DEBUG -- : START ELEM: ({:ns=>{}, :elem=>"optional", :uri=>"urn:xmpp:features:rosterver", :prefix=>nil, :attrs=>{}})
D, [2009-06-05T00:02:55.661306 #18758] DEBUG -- : END ELEM: {:elem=>"optional", :uri=>"urn:xmpp:features:rosterver", :prefix=>nil}
D, [2009-06-05T00:02:55.661557 #18758] DEBUG -- : END ELEM: {:elem=>"ver", :uri=>"urn:xmpp:features:rosterver", :prefix=>nil}
D, [2009-06-05T00:02:55.661922 #18758] DEBUG -- : START ELEM: ({:ns=>{nil=>"urn:ietf:params:xml:ns:xmpp-bind"}, :elem=>"bind", :uri=>"urn:ietf:params:xml:ns:xmpp-bind", :prefix=>nil, :attrs=>{}})
D, [2009-06-05T00:02:55.688650 #18758] DEBUG -- : START ELEM: ({:ns=>{}, :elem=>"required", :uri=>"urn:ietf:params:xml:ns:xmpp-bind", :prefix=>nil, :attrs=>{}})
D, [2009-06-05T00:02:55.689002 #18758] DEBUG -- : END ELEM: {:elem=>"required", :uri=>"urn:ietf:params:xml:ns:xmpp-bind", :prefix=>nil}
D, [2009-06-05T00:02:55.689232 #18758] DEBUG -- : END ELEM: {:elem=>"bind", :uri=>"urn:ietf:params:xml:ns:xmpp-bind", :prefix=>nil}
D, [2009-06-05T00:02:55.689497 #18758] DEBUG -- : START ELEM: ({:ns=>{nil=>"urn:ietf:params:xml:ns:xmpp-session"}, :elem=>"session", :uri=>"urn:ietf:params:xml:ns:xmpp-session", :prefix=>nil, :attrs=>{}})
D, [2009-06-05T00:02:55.690081 #18758] DEBUG -- : END ELEM: {:elem=>"session", :uri=>"urn:ietf:params:xml:ns:xmpp-session", :prefix=>nil}
D, [2009-06-05T00:02:55.690349 #18758] DEBUG -- : START ELEM: ({:ns=>{}, :elem=>"feature", :uri=>"jabber:client", :prefix=>nil, :attrs=>{"var"=>"vcard-temp"}})
D, [2009-06-05T00:02:55.690686 #18758] DEBUG -- : END ELEM: {:elem=>"feature", :uri=>"jabber:client", :prefix=>nil}
D, [2009-06-05T00:02:55.697651 #18758] DEBUG -- : END ELEM: {:elem=>"features", :uri=>"http://etherx.jabber.org/streams", :prefix=>"stream"}
D, [2009-06-05T00:02:55.698175 #18758] DEBUG -- : RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams">
<ver xmlns="urn:xmpp:features:rosterver">
<optional/>
</ver>
<bind xmlns="urn:ietf:params:xml:ns:xmpp-bind">
<required/>
</bind>
<session xmlns="urn:ietf:params:xml:ns:xmpp-session"/>
<stream:feature var="vcard-temp"/>
</stream:features>
D, [2009-06-05T00:02:55.699630 #18758] DEBUG -- : SENDING: (/var/lib/gems/1.8/gems/blather-0.4.0/lib/blather/stream/features/resource.rb:16:in `receive_data') <iq type="set" id="blather0001">
<bind xmlns="urn:ietf:params:xml:ns:xmpp-bind">
<resource>echo</resource>
</bind>
</iq>
D, [2009-06-05T00:02:55.702031 #18758] DEBUG -- :
------------------------------
D, [2009-06-05T00:02:55.702248 #18758] DEBUG -- : << <iq id='blather0001' type='result'><bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'><jid>echo@localhost/echo</jid></bind></iq>
D, [2009-06-05T00:02:55.702394 #18758] DEBUG -- : PARSING: (<iq id='blather0001' type='result'><bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'><jid>echo@localhost/echo</jid></bind></iq>)
D, [2009-06-05T00:02:55.702655 #18758] DEBUG -- : START ELEM: ({:ns=>{}, :elem=>"iq", :uri=>"jabber:client", :prefix=>nil, :attrs=>{"id"=>"blather0001", "type"=>"result"}})
D, [2009-06-05T00:02:55.703089 #18758] DEBUG -- : START ELEM: ({:ns=>{nil=>"urn:ietf:params:xml:ns:xmpp-bind"}, :elem=>"bind", :uri=>"urn:ietf:params:xml:ns:xmpp-bind", :prefix=>nil, :attrs=>{}})
D, [2009-06-05T00:02:55.703505 #18758] DEBUG -- : START ELEM: ({:ns=>{}, :elem=>"jid", :uri=>"urn:ietf:params:xml:ns:xmpp-bind", :prefix=>nil, :attrs=>{}})
D, [2009-06-05T00:02:55.703807 #18758] DEBUG -- : CHARS: echo@localhost/echo
D, [2009-06-05T00:02:55.704034 #18758] DEBUG -- : END ELEM: {:elem=>"jid", :uri=>"urn:ietf:params:xml:ns:xmpp-bind", :prefix=>nil}
D, [2009-06-05T00:02:55.704240 #18758] DEBUG -- : END ELEM: {:elem=>"bind", :uri=>"urn:ietf:params:xml:ns:xmpp-bind", :prefix=>nil}
D, [2009-06-05T00:02:55.704448 #18758] DEBUG -- : END ELEM: {:elem=>"iq", :uri=>"jabber:client", :prefix=>nil}
D, [2009-06-05T00:02:55.704758 #18758] DEBUG -- : RECEIVING (iq) <iq id="blather0001" type="result">
<bind xmlns="urn:ietf:params:xml:ns:xmpp-bind">
<jid>echo@localhost/echo</jid>
</bind>
</iq>
D, [2009-06-05T00:02:55.705547 #18758] DEBUG -- : RESOURCE NODE <iq type="result" id="blather0001">
<bind xmlns="urn:ietf:params:xml:ns:xmpp-bind">
<jid>echo@localhost/echo</jid>
</bind>
</iq>
D, [2009-06-05T00:02:55.706201 #18758] DEBUG -- : NEW JID: echo@localhost/echo
D, [2009-06-05T00:02:55.707063 #18758] DEBUG -- : SENDING: (/var/lib/gems/1.8/gems/blather-0.4.0/lib/blather/stream/features/session.rb:16:in `receive_data') <iq type="set" id="blather0003" to="localhost">
<session xmlns="urn:ietf:params:xml:ns:xmpp-session"/>
</iq>
D, [2009-06-05T00:02:55.709160 #18758] DEBUG -- :
------------------------------
D, [2009-06-05T00:02:55.709371 #18758] DEBUG -- : << <iq id='blather0003' type='result' to='echo@localhost/echo' from='localhost'></iq>
D, [2009-06-05T00:02:55.709517 #18758] DEBUG -- : PARSING: (<iq id='blather0003' type='result' to='echo@localhost/echo' from='localhost'></iq>)
D, [2009-06-05T00:02:55.709805 #18758] DEBUG -- : START ELEM: ({:ns=>{}, :elem=>"iq", :uri=>"jabber:client", :prefix=>nil, :attrs=>{"from"=>"localhost", "to"=>"echo@localhost/echo", "id"=>"blather0003", "type"=>"result"}})
D, [2009-06-05T00:02:55.710325 #18758] DEBUG -- : END ELEM: {:elem=>"iq", :uri=>"jabber:client", :prefix=>nil}
D, [2009-06-05T00:02:55.710663 #18758] DEBUG -- : RECEIVING (iq) <iq from="localhost" to="echo@localhost/echo" id="blather0003" type="result"/>
D, [2009-06-05T00:02:55.712285 #18758] DEBUG -- : SENDING: (/var/lib/gems/1.8/gems/blather-0.4.0/lib/blather/client/client.rb:72:in `write_with_handler') <iq type="get" id="blather0005">
<query xmlns="jabber:iq:roster"/>
</iq>
D, [2009-06-05T00:02:55.723179 #18758] DEBUG -- :
------------------------------
D, [2009-06-05T00:02:55.723410 #18758] DEBUG -- : << <iq id='blather0005' type='result' to='echo@localhost/echo'><query ver='1' xmlns='jabber:iq:roster'></query></iq>
D, [2009-06-05T00:02:55.723562 #18758] DEBUG -- : PARSING: (<iq id='blather0005' type='result' to='echo@localhost/echo'><query ver='1' xmlns='jabber:iq:roster'></query></iq>)
D, [2009-06-05T00:02:55.723867 #18758] DEBUG -- : START ELEM: ({:ns=>{}, :elem=>"iq", :uri=>"jabber:client", :prefix=>nil, :attrs=>{"to"=>"echo@localhost/echo", "id"=>"blather0005", "type"=>"result"}})
D, [2009-06-05T00:02:55.724357 #18758] DEBUG -- : START ELEM: ({:ns=>{nil=>"jabber:iq:roster"}, :elem=>"query", :uri=>"jabber:iq:roster", :prefix=>nil, :attrs=>{"ver"=>"1"}})
D, [2009-06-05T00:02:55.724831 #18758] DEBUG -- : END ELEM: {:elem=>"query", :uri=>"jabber:iq:roster", :prefix=>nil}
D, [2009-06-05T00:02:55.725103 #18758] DEBUG -- : END ELEM: {:elem=>"iq", :uri=>"jabber:client", :prefix=>nil}
D, [2009-06-05T00:02:55.725457 #18758] DEBUG -- : RECEIVING (iq) <iq to="echo@localhost/echo" id="blather0005" type="result">
<query xmlns="jabber:iq:roster" ver="1"/>
</iq>
D, [2009-06-05T00:02:55.728416 #18758] DEBUG -- : SENDING: (/var/lib/gems/1.8/gems/blather-0.4.0/lib/blather/client/client.rb:124:in `client_post_init') <presence/>
Connected ! send messages to echo@localhost.
D, [2009-06-05T00:03:06.935161 #18758] DEBUG -- :
------------------------------
D, [2009-06-05T00:03:06.935381 #18758] DEBUG -- : << <message type='chat' to='echo@localhost' from='nolan@localhost/Eee' id='purple5d34f78e' xmlns='jabber:client'><body>echo</body><html xmlns='http://jabber.org/protocol/xhtml-im'><body xmlns='http://www.w3.org/1999/xhtml'>echo</body></html></message>
D, [2009-06-05T00:03:06.935526 #18758] DEBUG -- : PARSING: (<message type='chat' to='echo@localhost' from='nolan@localhost/Eee' id='purple5d34f78e' xmlns='jabber:client'><body>echo</body><html xmlns='http://jabber.org/protocol/xhtml-im'><body xmlns='http://www.w3.org/1999/xhtml'>echo</body></html></message>)
D, [2009-06-05T00:03:06.935842 #18758] DEBUG -- : START ELEM: ({:ns=>{nil=>"jabber:client"}, :elem=>"message", :uri=>"jabber:client", :prefix=>nil, :attrs=>{"from"=>"nolan@localhost/Eee", "id"=>"purple5d34f78e", "to"=>"echo@localhost", "type"=>"chat"}})
D, [2009-06-05T00:03:06.936326 #18758] DEBUG -- : START ELEM: ({:ns=>{}, :elem=>"body", :uri=>"jabber:client", :prefix=>nil, :attrs=>{}})
D, [2009-06-05T00:03:06.936625 #18758] DEBUG -- : CHARS: echo
D, [2009-06-05T00:03:06.936846 #18758] DEBUG -- : END ELEM: {:elem=>"body", :uri=>"jabber:client", :prefix=>nil}
D, [2009-06-05T00:03:06.937121 #18758] DEBUG -- : START ELEM: ({:ns=>{nil=>"http://jabber.org/protocol/xhtml-im"}, :elem=>"html", :uri=>"http://jabber.org/protocol/xhtml-im", :prefix=>nil, :attrs=>{}})
D, [2009-06-05T00:03:06.937558 #18758] DEBUG -- : START ELEM: ({:ns=>{nil=>"http://www.w3.org/1999/xhtml"}, :elem=>"body", :uri=>"http://www.w3.org/1999/xhtml", :prefix=>nil, :attrs=>{}})
D, [2009-06-05T00:03:06.937904 #18758] DEBUG -- : CHARS: echo
D, [2009-06-05T00:03:06.938167 #18758] DEBUG -- : END ELEM: {:elem=>"body", :uri=>"http://www.w3.org/1999/xhtml", :prefix=>nil}
D, [2009-06-05T00:03:06.938473 #18758] DEBUG -- : END ELEM: {:elem=>"html", :uri=>"http://jabber.org/protocol/xhtml-im", :prefix=>nil}
D, [2009-06-05T00:03:06.938746 #18758] DEBUG -- : END ELEM: {:elem=>"message", :uri=>"jabber:client", :prefix=>nil}
D, [2009-06-05T00:03:06.939183 #18758] DEBUG -- : RECEIVING (message) <message xmlns="jabber:client" from="nolan@localhost/Eee" id="purple5d34f78e" to="echo@localhost" type="chat">
<body>echo</body>
<html xmlns="http://jabber.org/protocol/xhtml-im">
<body xmlns="http://www.w3.org/1999/xhtml">echo</body>
</html>
</message>
D, [2009-06-05T00:03:12.608545 #18758] DEBUG -- :
------------------------------
D, [2009-06-05T00:03:12.608823 #18758] DEBUG -- : << <message type='chat' to='echo@localhost' from='nolan@localhost/Eee' id='purple5d34f790' xmlns='jabber:client'><body>exit</body><html xmlns='http://jabber.org/protocol/xhtml-im'><body xmlns='http://www.w3.org/1999/xhtml'>exit</body></html></message>
D, [2009-06-05T00:03:12.609056 #18758] DEBUG -- : PARSING: (<message type='chat' to='echo@localhost' from='nolan@localhost/Eee' id='purple5d34f790' xmlns='jabber:client'><body>exit</body><html xmlns='http://jabber.org/protocol/xhtml-im'><body xmlns='http://www.w3.org/1999/xhtml'>exit</body></html></message>)
D, [2009-06-05T00:03:12.609498 #18758] DEBUG -- : START ELEM: ({:ns=>{nil=>"jabber:client"}, :elem=>"message", :uri=>"jabber:client", :prefix=>nil, :attrs=>{"from"=>"nolan@localhost/Eee", "id"=>"purple5d34f790", "to"=>"echo@localhost", "type"=>"chat"}})
D, [2009-06-05T00:03:12.610157 #18758] DEBUG -- : START ELEM: ({:ns=>{}, :elem=>"body", :uri=>"jabber:client", :prefix=>nil, :attrs=>{}})
D, [2009-06-05T00:03:12.610649 #18758] DEBUG -- : CHARS: exit
D, [2009-06-05T00:03:12.611090 #18758] DEBUG -- : END ELEM: {:elem=>"body", :uri=>"jabber:client", :prefix=>nil}
D, [2009-06-05T00:03:12.611532 #18758] DEBUG -- : START ELEM: ({:ns=>{nil=>"http://jabber.org/protocol/xhtml-im"}, :elem=>"html", :uri=>"http://jabber.org/protocol/xhtml-im", :prefix=>nil, :attrs=>{}})
D, [2009-06-05T00:03:12.612163 #18758] DEBUG -- : START ELEM: ({:ns=>{nil=>"http://www.w3.org/1999/xhtml"}, :elem=>"body", :uri=>"http://www.w3.org/1999/xhtml", :prefix=>nil, :attrs=>{}})
D, [2009-06-05T00:03:12.612746 #18758] DEBUG -- : CHARS: exit
D, [2009-06-05T00:03:12.613163 #18758] DEBUG -- : END ELEM: {:elem=>"body", :uri=>"http://www.w3.org/1999/xhtml", :prefix=>nil}
D, [2009-06-05T00:03:12.613482 #18758] DEBUG -- : END ELEM: {:elem=>"html", :uri=>"http://jabber.org/protocol/xhtml-im", :prefix=>nil}
D, [2009-06-05T00:03:12.613748 #18758] DEBUG -- : END ELEM: {:elem=>"message", :uri=>"jabber:client", :prefix=>nil}
D, [2009-06-05T00:03:12.614215 #18758] DEBUG -- : RECEIVING (message) <message xmlns="jabber:client" from="nolan@localhost/Eee" id="purple5d34f790" to="echo@localhost" type="chat">
<body>exit</body>
<html xmlns="http://jabber.org/protocol/xhtml-im">
<body xmlns="http://www.w3.org/1999/xhtml">exit</body>
</html>
</message>
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment