Subject: | XML::Stream error after auth with ejabberd server |
Net-XMPP-1.0
XML-Stream-1.22
This is perl, v5.8.6 built for i686-linux
Linux gaz 2.6.11-gentoo-r4 #1 Tue Mar 29 18:32:27 PST 2005 i686 Intel(R)
Pentium(R) M processor 1.80GHz GenuineIntel GNU/Linux
the examples/client.pl program has some sort of problem with ejabberd.
the last few lines from debug are below, the full trace is attached,
hostname of server changed to 'host.name.changed' to protect the innocent.
not quite sure where to start looking for the problem. the bot account
is working serverside (tested with Psi).
...
XMPP::Conn: AuthSASL: We authed!
XML::Stream: Send: (<?xml version='1.0'?><stream:stream version='1.0'
xmlns:stream='http://etherx.jabber.org/streams' xmlns='jabber:client'
to='host.name.changed' from='gaz.localdomain' xml:lang='en' >)
XML::Stream: Read: buff(<?xml version='1.0'?><stream:stream
xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'
id='4195037885' from='host.name.changed' version='1.0' xml:lang='en'>)
XML::Stream: _handle_root: sid(4195037885)
sax(XML::Stream::Parser=HASH(0x83fd6f4)) tag(stream:stream) att(
xmlns:stream http://etherx.jabber.org/streams xmlns jabber:client
version 1.0 from host.name.changed id 4195037885 xml:lang en )
Can't use an undefined value as a HASH reference at
/usr/lib/perl5/site_perl/5.8.6/XML/Stream.pm line 1165.
Subject: | xmpp_client-ejabberd.log |
XML::Stream: new: hostname = (gaz.localdomain)
XML::Stream: SetCallBacks: tag(node) func(CODE(0x84ff3e0))
XMPP::Conn: SetCallBacks: tag(message) func(CODE(0x866a5a4))
XMPP::Conn: SetCallBacks: tag(presence) func(CODE(0x866a544))
XMPP::Conn: SetCallBacks: tag(iq) func(CODE(0x866a4e4))
XMPP::Conn: SetDirectXPathCallBacks: xpath(/[@xmlns="urn:ietf:params:xml:ns:xmpp-tls"]) func(CODE(0x866c54c))
XMPP::Conn: SetDirectXPathCallBacks: xpath(/[@xmlns="urn:ietf:params:xml:ns:xmpp-sasl"]) func(CODE(0x866c660))
XMPP::Conn: SetCallBacks: tag(iq) func(CODE(0x8666900))
XMPP::Conn: SetCallBacks: tag(presence) func(CODE(0x86685b4))
XMPP::Conn: SetCallBacks: tag(message) func(CODE(0x86665c4))
XMPP::Conn: Connect: host(gir.usc.edu:5222) namespace(jabber:client)
XMPP::Conn: Connect: timeout(10)
XML::Stream: Connect: type(tcpip)
XML::Stream: Connect: Got a connection
XML::Stream: Send: (<?xml version='1.0'?><stream:stream version='1.0' xmlns:stream='http://etherx.jabber.org/streams' xmlns='jabber:client' to='gir.usc.edu' from='gaz.localdomain' xml:lang='en' >)
XML::Stream: Read: buff(<?xml version='1.0'?><stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='2721367672' from='gir.usc.edu' version='1.0' xml:lang='en'>)
XML::Stream: _handle_root: sid(newconnection) sax(XML::Stream::Parser=HASH(0x86711dc)) tag(stream:stream) att( xmlns:stream http://etherx.jabber.org/streams xmlns jabber:client version 1.0 from gir.usc.edu id 2721367672 xml:lang en )
XML::Stream: Read: buff(<stream:features><starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/><mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><mechanism>DIGEST-MD5</mechanism><mechanism>PLAIN</mechanism></mechanisms><register xmlns='http://jabber.org/features/iq-register'/></stream:features>)
XML::Stream: Node: _handle_element: sid(2721367672) sax(XML::Stream::Parser=HASH(0x86711dc)) tag(stream:features) att( )
XML::Stream: Node: _handle_element: check( -1 )
XML::Stream: Node: _handle_element: sid(2721367672) sax(XML::Stream::Parser=HASH(0x86711dc)) tag(starttls) att( xmlns urn:ietf:params:xml:ns:xmpp-tls )
XML::Stream: Node: _handle_element: check( 0 )
XML::Stream: Node: _handle_close: sid(2721367672) sax(XML::Stream::Parser=HASH(0x86711dc)) tag(starttls)
XML::Stream: Node: _handle_close: check( 1 )
XML::Stream: Node: _handle_close: check2( 0 )
XML::Stream: Node: _handle_element: sid(2721367672) sax(XML::Stream::Parser=HASH(0x86711dc)) tag(mechanisms) att( xmlns urn:ietf:params:xml:ns:xmpp-sasl )
XML::Stream: Node: _handle_element: check( 0 )
XML::Stream: Node: _handle_element: sid(2721367672) sax(XML::Stream::Parser=HASH(0x86711dc)) tag(mechanism) att( )
XML::Stream: Node: _handle_element: check( 1 )
XML::Stream: Node: _handle_cdata: sid(2721367672) sax(XML::Stream::Parser=HASH(0x86711dc)) cdata(DIGEST-MD5)
XML::Stream: Node: _handle_cdata: sax(XML::Stream::Parser=HASH(0x86711dc)) cdata(DIGEST-MD5)
XML::Stream: Node: _handle_close: sid(2721367672) sax(XML::Stream::Parser=HASH(0x86711dc)) tag(mechanism)
XML::Stream: Node: _handle_close: check( 2 )
XML::Stream: Node: _handle_close: check2( 1 )
XML::Stream: Node: _handle_element: sid(2721367672) sax(XML::Stream::Parser=HASH(0x86711dc)) tag(mechanism) att( )
XML::Stream: Node: _handle_element: check( 1 )
XML::Stream: Node: _handle_cdata: sid(2721367672) sax(XML::Stream::Parser=HASH(0x86711dc)) cdata(PLAIN)
XML::Stream: Node: _handle_cdata: sax(XML::Stream::Parser=HASH(0x86711dc)) cdata(PLAIN)
XML::Stream: Node: _handle_close: sid(2721367672) sax(XML::Stream::Parser=HASH(0x86711dc)) tag(mechanism)
XML::Stream: Node: _handle_close: check( 2 )
XML::Stream: Node: _handle_close: check2( 1 )
XML::Stream: Node: _handle_close: sid(2721367672) sax(XML::Stream::Parser=HASH(0x86711dc)) tag(mechanisms)
XML::Stream: Node: _handle_close: check( 1 )
XML::Stream: Node: _handle_close: check2( 0 )
XML::Stream: Node: _handle_element: sid(2721367672) sax(XML::Stream::Parser=HASH(0x86711dc)) tag(register) att( xmlns http://jabber.org/features/iq-register )
XML::Stream: Node: _handle_element: check( 0 )
XML::Stream: Node: _handle_close: sid(2721367672) sax(XML::Stream::Parser=HASH(0x86711dc)) tag(register)
XML::Stream: Node: _handle_close: check( 1 )
XML::Stream: Node: _handle_close: check2( 0 )
XML::Stream: Node: _handle_close: sid(2721367672) sax(XML::Stream::Parser=HASH(0x86711dc)) tag(stream:features)
XML::Stream: Node: _handle_close: check( 0 )
XML::Stream: Node: _handle_close: check2( -1 )
XML::Stream: Process: block(0)
XMPP::Conn: Connect: connection made
XML::Stream: SetCallBacks: tag(node) func(CODE(0x866a55c))
XMPP::Conn: AuthSASL: shiney new auth
XML::Stream: Send: (<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='DIGEST-MD5'></auth>)
XMPP::Conn: AuthSASL: haven't authed yet... let's wait.
XMPP::Conn: Process: timeout(1)
XML::Stream: Read: buff(<challenge xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>bm9uY2U9IjQwMDUyNjI0NjMiLHFvcD0iYXV0aCIsY2hhcnNldD11dGYtOCxhbGdvcml0aG09bWQ1LXNlc3M=</challenge>)
XML::Stream: Node: _handle_element: sid(2721367672) sax(XML::Stream::Parser=HASH(0x86711dc)) tag(challenge) att( xmlns urn:ietf:params:xml:ns:xmpp-sasl )
XML::Stream: Node: _handle_element: check( -1 )
XML::Stream: Node: _handle_cdata: sid(2721367672) sax(XML::Stream::Parser=HASH(0x86711dc)) cdata(bm9uY2U9IjQwMDUyNjI0NjMiLHFvcD0iYXV0aCIsY2hhcnNldD11dGYtOCxhbGdvcml0aG09bWQ1LXNlc3M=)
XML::Stream: Node: _handle_cdata: sax(XML::Stream::Parser=HASH(0x86711dc)) cdata(bm9uY2U9IjQwMDUyNjI0NjMiLHFvcD0iYXV0aCIsY2hhcnNldD11dGYtOCxhbGdvcml0aG09bWQ1LXNlc3M=)
XML::Stream: Node: _handle_close: sid(2721367672) sax(XML::Stream::Parser=HASH(0x86711dc)) tag(challenge)
XML::Stream: Node: _handle_close: check( 0 )
XML::Stream: Node: _handle_close: check2( -1 )
XML::Stream: Send: (<response xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>YXV0aHppZD0idGVzdGJvdEBnaXIudXNjLmVkdSIsY2hhcnNldD11dGYtOCxjbm9uY2U9ImU4NTNlYjg0NzEwOTljMjUyNjIxYzkzNzc4MWQ1MmViIixkaWdlc3QtdXJpPSIvIixuYz0wMDAwMDAwMSxub25jZT0iNDAwNTI2MjQ2MyIscW9wPWF1dGgscmVzcG9uc2U9MjU3NTYwNzA0NzgyNjA2YjUxZDM2ZmYxNTk1ODdhYjAsdXNlcm5hbWU9InRlc3Rib3Qi</response>)
XML::Stream: Process: block(0)
XMPP::Conn: AuthSASL: haven't authed yet... let's wait.
XMPP::Conn: Process: timeout(1)
XML::Stream: Read: buff(<challenge xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>cnNwYXV0aD0zNzE2YzFkYTJlMTBlMzEwZWU2MTgyMTE4YzI5ODc5Nw==</challenge>)
XML::Stream: Node: _handle_element: sid(2721367672) sax(XML::Stream::Parser=HASH(0x86711dc)) tag(challenge) att( xmlns urn:ietf:params:xml:ns:xmpp-sasl )
XML::Stream: Node: _handle_element: check( -1 )
XML::Stream: Node: _handle_cdata: sid(2721367672) sax(XML::Stream::Parser=HASH(0x86711dc)) cdata(cnNwYXV0aD0zNzE2YzFkYTJlMTBlMzEwZWU2MTgyMTE4YzI5ODc5Nw==)
XML::Stream: Node: _handle_cdata: sax(XML::Stream::Parser=HASH(0x86711dc)) cdata(cnNwYXV0aD0zNzE2YzFkYTJlMTBlMzEwZWU2MTgyMTE4YzI5ODc5Nw==)
XML::Stream: Node: _handle_close: sid(2721367672) sax(XML::Stream::Parser=HASH(0x86711dc)) tag(challenge)
XML::Stream: Node: _handle_close: check( 0 )
XML::Stream: Node: _handle_close: check2( -1 )
XML::Stream: Send: (<response xmlns='urn:ietf:params:xml:ns:xmpp-sasl'></response>)
XML::Stream: Process: block(0)
XMPP::Conn: AuthSASL: haven't authed yet... let's wait.
XMPP::Conn: Process: timeout(1)
XML::Stream: Read: buff(<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>)
XML::Stream: Node: _handle_element: sid(2721367672) sax(XML::Stream::Parser=HASH(0x86711dc)) tag(success) att( xmlns urn:ietf:params:xml:ns:xmpp-sasl )
XML::Stream: Node: _handle_element: check( -1 )
XML::Stream: Node: _handle_close: sid(2721367672) sax(XML::Stream::Parser=HASH(0x86711dc)) tag(success)
XML::Stream: Node: _handle_close: check( 0 )
XML::Stream: Node: _handle_close: check2( -1 )
XML::Stream: Process: block(0)
XMPP::Conn: AuthSASL: We authed!
XML::Stream: Send: (<?xml version='1.0'?><stream:stream version='1.0' xmlns:stream='http://etherx.jabber.org/streams' xmlns='jabber:client' to='gir.usc.edu' from='gaz.localdomain' xml:lang='en' >)
XML::Stream: Read: buff(<?xml version='1.0'?><stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='2721367672' from='gir.usc.edu' version='1.0' xml:lang='en'>)
XML::Stream: _handle_root: sid(2721367672) sax(XML::Stream::Parser=HASH(0x83fd70c)) tag(stream:stream) att( xmlns:stream http://etherx.jabber.org/streams xmlns jabber:client version 1.0 from gir.usc.edu id 2721367672 xml:lang en )
Can't use an undefined value as a HASH reference at /usr/lib/perl5/site_perl/5.8.6/XML/Stream.pm line 1165.