gistfile1.txt

Dec 14 23:41:54 socket	debug	server.lua: accepted new client connection from 127.0.0.1:58480 to 5222
Dec 14 23:41:54 sessionmanager	debug	open sessions now: 9
Dec 14 23:41:54 c2s7f97d2d2d400	info	Client connected
Dec 14 23:41:54 c2s7f97d2d2d400	debug	Client sent opening <stream:stream> to localhost
Dec 14 23:41:54 c2s7f97d2d2d400	debug	Sent reply <stream:stream> to client
Dec 14 23:41:54 c2s7f97d2d2d400	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 14 23:41:54 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 14 23:41:54 c2s7f97d2d2d400	debug	TLS negotiation started for c2s_unauthed...
Dec 14 23:41:54 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x7f97d3130828
Dec 14 23:41:54 socket	debug	server.lua: ssl handshake done
Dec 14 23:41:54 c2s7f97d2d2d400	debug	Client sent opening <stream:stream> to localhost
Dec 14 23:41:54 c2s7f97d2d2d400	debug	Sent reply <stream:stream> to client
Dec 14 23:41:54 c2s7f97d2d2d400	debug	Received[c2s_unauthed]: <auth mechanism='DIGEST-MD5' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 14 23:41:54 localhost:saslauth	debug	sasl reply: <challenge xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>cmVhbG09ImxvY2FsaG9zdCIsbm9uY2U9IjcyZWM1M2Q0LTAxOGEtNDA4Zi1hZjlmLWI1YWZkZGRiY2M1OCIscW9wPSJhdXRoIixjaGFyc2V0PXV0Zi04LGFsZ29yaXRobT1tZDUtc2Vzcw==</challenge>
Dec 14 23:41:54 c2s7f97d2d2d400	debug	Received[c2s_unauthed]: <response xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 14 23:41:54 auth_internal_plain	debug	get_password for username 'hubot' at host 'localhost'
Dec 14 23:41:54 sasl	warn	Client is violating RFC 3920 (section 6.1, point 7).
Dec 14 23:41:54 localhost:saslauth	debug	sasl reply: <challenge xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>cnNwYXV0aD0xZjQ0OTA1YzIyZTk1YzNlOTBjOWE4Y2U5NzI5N2RhMw==</challenge>
Dec 14 23:41:54 c2s7f97d2d2d400	debug	Received[c2s_unauthed]: <response xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 14 23:41:54 c2s7f97d2d2d400	info	Authenticated as hubot@localhost
Dec 14 23:41:54 localhost:saslauth	debug	sasl reply: <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'></success>
Dec 14 23:41:54 c2s7f97d2d2d400	debug	Client sent opening <stream:stream> to localhost
Dec 14 23:41:54 c2s7f97d2d2d400	debug	Sent reply <stream:stream> to client
Dec 14 23:41:54 c2s7f97d2d2d400	debug	Received[c2s]: <iq id='bind' type='set'>
Dec 14 23:41:54 rostermanager	debug	load_roster: asked for: hubot@localhost
Dec 14 23:41:54 c2s7f97d2d2d400	debug	Resource bound: hubot@localhost/f4d53afc-24e4-41e1-804a-34cbde253ca8
Dec 14 23:41:54 c2s7f97d2d2d400	debug	Received[c2s]: <iq id='sess' type='set' to='localhost'>
Dec 14 23:41:54 c2s7f97d2d2d400	debug	Received[c2s]: <presence type='available'>
Dec 14 23:41:54 c2s7f97d2d2d400	debug	Received[c2s]: <presence to='david@conference.localhost/Hubot'>
Dec 14 23:41:54 mod_muc	debug	room: david@conference.localhost, current_nick: nil, stanza: <presence to='david@conference.localhost/Hubot' from='hubot@localhost/f4d53afc-24e4-41e1-804a-34cbde253ca8'>
Dec 14 23:41:54 mod_muc	debug	hubot@localhost/f4d53afc-24e4-41e1-804a-34cbde253ca8 joining as david@conference.localhost/Hubot