[Spacewalk-list] OSA-Dispatcher can't connect to jabberd - TimeOut

Tue Aug 23 11:54:27 UTC 2011

Hello,
I've checked logs in /var/log/messages as jabberd logs in there. Here is
what I get:
Aug 23 07:43:41 jabberd/c2s[15885]: [7] [10.120.2.5, port=60643] connect
Aug 23 07:43:41 jabberd/c2s[15885]: [7] legacy authentication succeeded:
host=, username=rhn-dispatcher-sat, resource=superclient, TLS negotiated
Aug 23 07:43:41 jabberd/c2s[15885]: [7] requesting session:
jid=rhn-dispatcher-sat at spacewalk.domain/superclient
Aug 23 07:43:41 jabberd/sm[15878]: user not found and user.auto-create not
enabled, can't start session: jid=rhn-dispatcher-sat at spacewalk.domain
/superclient

Has someone already seend this problem?

Thanks,

pierre

2011/8/23 Pierre Casenove <pcasenove at gmail.com>

> Hello list,
> I've set up a spacewalk 1.5 installation on postgresql backend.
> Following this guide (
> http://unfuckablelinux.com/2008/07/02/spacewalk-and-avoiding-self-signed-certificates/),
> I've modified the SSL cert to use a certificate issued by my in-house
> certificate authority. This is a requirement from my security department.
> Everything works, except osa-dispatcher, which times out when trying to
> connect to jabberd after 5 minutes:
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0:
> osad/jabber_lib.setup_connection('Connected to jabber server', '
> spacewalk.cst.cnes.fr')
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0: osad/dispatcher_client.start
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0:
> osad/jabber_lib.auth('rhn-dispatcher-sat', 'rhn-dispatcher-q85613',
> 'superclient', 1)
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0: osad/jabber_lib.auth('Sending
> auth request', <iq type='get' id='auth-get-3497ab-12'><query xmlns =
> 'jabber:iq:auth' ><username>rhn-dispatcher-sat</username></query></iq>)
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0:
> osad/jabber_lib._waitForResponse('auth-get-3497ab-12', 60)
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0:
> osad/jabber_lib._waitForResponse('before get_one_stanza',)
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0:
> osad/jabber_lib.process(59.999981880187988,)
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0: osad/jabber_lib.process('before
> select(); timeout', 59.999981880187988)
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0:
> osad/jabber_lib.process('select() returned',)
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0: osad/jabber_lib.process('Reading
> 1024 bytes from ssl socket',)
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0: osad/jabber_lib.process('Read
> 177 bytes',)
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0:
> osad/jabber_lib._orig_dispatch(<jabber.xmlstream.Node instance at
> 0x48733f8>,)
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0: osad/jabber_lib.dispatch(<iq
> type='result' id='auth-get-3497ab-12'><query xmlns = 'jabber:iq:auth'
> ><username>rhn-dispatcher-sat</username><resource /><password /><digest
> /></query></iq>,)
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0:
> osad/jabber_lib.cleanup_expired_callbacks
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0:
> osad/jabber_lib._get_callbacks(<iq type='result'
> id='auth-get-3497ab-12'><query xmlns = 'jabber:iq:auth'
> ><username>rhn-dispatcher-sat</username><resource /><password /><digest
> /></query></iq>,)
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0:
> osad/jabber_lib.dispatch('Unhandled stanza', <iq type='result'
> id='auth-get-3497ab-12'><query xmlns = 'jabber:iq:auth'
> ><username>rhn-dispatcher-sat</username><resource /><password /><digest
> /></query></iq>)
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0:
> osad/jabber_lib._waitForResponse('after get_one_stanza',)
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0: osad/jabber_lib.auth('Auth
> response', <iq type='result' id='auth-get-3497ab-12'><query xmlns =
> 'jabber:iq:auth' ><username>rhn-dispatcher-sat</username><resource
> /><password /><digest /></query></iq>)
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0: osad/jabber_lib.auth('Sending
> auth info', <iq type='set' id='auth-set-3497ab-13'><query xmlns =
> 'jabber:iq:auth'
> ><username>rhn-dispatcher-sat</username><resource>superclient</resource><digest>12e9f1d70de0b4350c5e64b0fb93758fbad1ec74</digest></query></iq>)
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0:
> osad/jabber_lib._waitForResponse(u'auth-set-3497ab-13', 300)
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0:
> osad/jabber_lib._waitForResponse('before get_one_stanza',)
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0:
> osad/jabber_lib.process(299.99997091293335,)
> 2011/08/23 07:43:41 -00:00 15908 0.0.0.0: osad/jabber_lib.process('before
> select(); timeout', 299.99996995925903)
> 2011/08/23 07:48:41 -00:00 15908 0.0.0.0:
> osad/jabber_lib.process('select() returned',)
> 2011/08/23 07:48:41 -00:00 15908 0.0.0.0:
> osad/jabber_lib.get_one_stanza('timed out', 1314085721.992229,
> 1314085421.9916439, 299.99997210502625)
> 2011/08/23 07:48:41 -00:00 15908 0.0.0.0:
> osad/jabber_lib._waitForResponse('after get_one_stanza',)
> 2011/08/23 07:48:41 -00:00 15908 0.0.0.0: osad/jabber_lib.main('ERROR',
> 'Error caught:')
> 2011/08/23 07:48:41 -00:00 15908 0.0.0.0: osad/jabber_lib.main('ERROR',
> 'Traceback (most recent call last):\n  File
> "/usr/share/rhn/osad/jabber_lib.py", line 116, in main\n    c =
> self.setup_connection(no_fork=no_fork)\n  File
> "/usr/share/rhn/osad/jabber_lib.py", line 284, in setup_connection\n
>  resource=self._resource)\n  File
> "/usr/share/rhn/osad/dispatcher_client.py", line 33, in start\n
>  self.auth(username, password, resource)\n  File
> "/usr/share/rhn/osad/jabber_lib.py", line 873, in auth\n
>  self.SendAndWaitForResponse(auth_set_iq)\n  File
> "/usr/lib/python2.4/site-packages/jabber/jabber.py", line 401, in
> SendAndWaitForResponse\n    return self.waitForResponse(ID,timeout)\n  File
> "/usr/share/rhn/osad/jabber_lib.py", line 1141, in waitForResponse\n
>  raise TimeoutError()\nTimeoutError\n')
> 2011/08/23 07:48:41 -00:00 15908 0.0.0.0: osad/jabber_lib.main('Sleeping',
> 10, 'seconds')
>
> Could you please help me resolving this issue?
> I've already set osa-dispatcher debug level to 9. Where can I find more
> information?
> Thanks in advance for your help,
>
> Pierre
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://listman.redhat.com/archives/spacewalk-list/attachments/20110823/c1643cfe/attachment.htm>