XEP-0163

nineinchnick — Mon, 25 Jan 2010 13:16:33 +0000

XEP-0163 is for pep plugin for mod_pubsub, am I right?

EDIT: you were right, after disabling mod_caps everything works as expected. Thanks for your time!

Let's suppose this is the

mfoss — Fri, 22 Jan 2010 12:02:32 +0000

Let's suppose this is the very first error message, and the others are related to this one:

Quote:

ejabberd.log

=ERROR REPORT==== 2010-01-19 13:49:36 ===
** Generic server ejabberd_local terminating 
** Last message in was {register_iq_response_handler,"jabber.example.com",
                           "2356691199",mod_caps,handle_disco_response}
** When Server state == {state}
** Reason for termination == 
** {aborted,{bad_type,{iq_response,"2356691199",mod_caps,
                                   handle_disco_response}}}

When your ejabberd calls ejabberd_local:register_iq_response_handler("localhost", "2356691199",mod_caps,handle_disco_response) it finds a problem.

For my plain ejabberd 2.0.1, the call returns correctly: {register_iq_response_handler,"localhost","2356691199", mod_caps,handle_disco_response}

A simple solution may be to disable mod_caps. Probably you don't even need that module at all. It's useful mostly for XEP-0163.

It is enabled, with empty

nineinchnick — Wed, 20 Jan 2010 15:28:32 +0000

It is enabled, with empty options list.

Check mod_disco is enabled

mfoss — Wed, 20 Jan 2010 14:11:12 +0000

Psi gets error 501, probably because you disabled the module mod_disco. You must have mod_disco in the modules list, but without options inside. See ejabberd.cfg.example.

You should compare (using a diff tool) your config with the example one, because maybe you're keeping useless test options that break your setup.

verbose logs

nineinchnick — Wed, 20 Jan 2010 08:55:59 +0000

I've recorded some more verbose logs (loglevel 5). There are a lot of similar entries for every client that connects.

I've replaced my JID with superuser, my hostname is "jasiek".

I hope it will help to narrow down the problem:

=INFO REPORT==== 2010-01-20 09:08:55 ===
D(<0.309.0>:ejabberd_router:301) : route
        from {jid,[],"jabber.example.com",[],[],"jabber.example.com",[]}
        to {jid,"superuser","jabber.example.com","praca","superuser",
                "jabber.example.com","praca"}
        packet {xmlelement,"iq",
                   [{"type","get"},{"id","3049269207"}],
                   [{xmlelement,"query",
                        [{"xmlns","http://jabber.org/protocol/disco#info"},
                         {"node","http://pidgin.im/#video-v1"}],
                        []}]}
=INFO REPORT==== 2010-01-20 09:08:55 ===
D(<0.309.0>:ejabberd_s2s:250) : s2s manager
        from {jid,[],"jabber.example.com",[],[],"jabber.example.com",[]}
        to {jid,"superuser","jabber.example.com","praca","superuser",
                "jabber.example.com","praca"}
        packet {xmlelement,"iq",
                           [{"type","get"},{"id",[...]}],
                           [{xmlelement,[...],...}]}
=INFO REPORT==== 2010-01-20 09:08:55 ===
D(<0.309.0>:ejabberd_s2s:280) : Finding connection for {"jabber.example.com",
                                                        "jabber.example.com"}
=INFO REPORT==== 2010-01-20 09:08:55 ===
D(<0.309.0>:ejabberd_router:301) : route
        from {jid,"superuser","jabber.example.com","praca","superuser",
                  "jabber.example.com","praca"}
        to {jid,[],"jabber.example.com",[],[],"jabber.example.com",[]}
        packet {xmlelement,"iq",
                   [{"type","error"},{"id","3049269207"}],
                   [{xmlelement,"query",
                        [{"xmlns","http://jabber.org/protocol/disco#info"},
                         {"node","http://pidgin.im/#video-v1"}],
                        []},
                    {xmlelement,"error",
                        [{"code","503"},{"type","cancel"}],
                        [{xmlelement,"service-unavailable",
                             [{"xmlns","urn:ietf:params:xml:ns:xmpp-stanzas"}],
                             []}]}]}
=INFO REPORT==== 2010-01-20 09:08:55 ===
D(<0.309.0>:ejabberd_s2s:250) : s2s manager
        from {jid,"superuser","jabber.example.com","praca","superuser",
                  "jabber.example.com","praca"}
        to {jid,[],"jabber.example.com",[],[],"jabber.example.com",[]}
        packet {xmlelement,"iq",
                           [{"type","error"},{"id",[...]}],
                           [{xmlelement,[...],...},{xmlelement,...}]}
=INFO REPORT==== 2010-01-20 09:08:55 ===
D(<0.309.0>:ejabberd_s2s:280) : Finding connection for {"jabber.example.com",
                                                        "jabber.example.com"}

After some more similar caps packets:

=ERROR REPORT==== 2010-01-20 09:08:55 ===
** Generic server ejabberd_local terminating 
** Last message in was {register_iq_response_handler,"jabber.nets.com.pl",
                           "3049269207",mod_caps,handle_disco_response}
** When Server state == {state}
** Reason for termination == 
** {aborted,{bad_type,{iq_response,"3049269207",mod_caps,
                                   handle_disco_response}}}

From sasl.log

=CRASH REPORT==== 20-Jan-2010::09:08:55 ===
  crasher:
    pid: <0.391.0>
    registered_name: ejabberd_local
    exception exit: {aborted,
                        {bad_type,
                            {iq_response,"3049269207",mod_caps,
                                handle_disco_response}}}
      in function  gen_server:terminate/6
    initial call: gen:init_it(gen_server,<0.239.0>,<0.239.0>,
                              {local,ejabberd_local},
                              ejabberd_local,[],[])
    ancestors: [ejabberd_sup,<0.40.0>]
    messages: [{register_iq_response_handler,"jabber.nets.com.pl",
                      "3906214387",mod_caps,handle_disco_response},
                  {register_iq_response_handler,"jabber.nets.com.pl",
                      "1166666722",mod_caps,handle_disco_response},
                  {register_iq_response_handler,"jabber.nets.com.pl",
                      "1464789244",mod_caps,handle_disco_response}]
    links: [<0.239.0>]
    dictionary: [{random_seed,{4090,17,25072}}]
    trap_exit: false
    status: running
    heap_size: 610
    stack_size: 23
    reductions: 2425
  neighbours:
=SUPERVISOR REPORT==== 20-Jan-2010::09:08:55 ===
     Supervisor: {local,ejabberd_sup}
     Context:    child_terminated
     Reason:     {aborted,
                     {bad_type,
                         {iq_response,"3049269207",mod_caps,
                             handle_disco_response}}}
     Offender:   [{pid,<0.391.0>},
                  {name,ejabberd_local},
                  {mfa,{ejabberd_local,start_link,[]}},
                  {restart_type,permanent},
                  {shutdown,brutal_kill},
                  {child_type,worker}]

After trying to browse services in Psi:

=INFO REPORT==== 2010-01-20 09:09:11 ===
D(<0.475.0>:ejabberd_router:301) : route
        from {jid,"superuser","jabber.example.com","jasiek","superuser",
                  "jabber.example.com","jasiek"}
        to {jid,[],"jabber.example.com",[],[],"jabber.example.com",[]}
        packet {xmlelement,"iq",
                   [{"xml:lang","pl-PL"},
                    {"type","get"},
                    {"to","jabber.example.com"},
                    {"id","aad0a"}],
                   [{xmlcdata,<<"\n">>},
                    {xmlelement,"query",
                        [{"xmlns","http://jabber.org/protocol/disco#info"}],
                        []},
                    {xmlcdata,<<"\n">>}]}
=INFO REPORT==== 2010-01-20 09:09:11 ===
D(<0.475.0>:ejabberd_local:272) : local route
        from {jid,"superuser","jabber.example.com","jasiek","superuser",
                  "jabber.example.com","jasiek"}
        to {jid,[],"jabber.example.com",[],[],"jabber.example.com",[]}
        packet {xmlelement,"iq",
                           [{"xml:lang","pl-PL"},
                            {"type",[...]},
                            {[...],...},
                            {...}],
                           [{xmlcdata,<<...>>},{xmlelement,...},{...}]}
=INFO REPORT==== 2010-01-20 09:09:11 ===
D(<0.475.0>:ejabberd_router:301) : route
        from {jid,[],"jabber.example.com",[],[],"jabber.example.com",[]}
        to {jid,"superuser","jabber.example.com","jasiek","superuser",
                "jabber.example.com","jasiek"}
        packet {xmlelement,"iq",
                   [{"type","error"},
                    {"from","jabber.example.com"},
                    {"xml:lang","pl-PL"},
                    {"id","aad0a"}],
                   [{xmlcdata,<<"\n">>},
                    {xmlelement,"query",
                        [{"xmlns","http://jabber.org/protocol/disco#info"}],
                        []},
                    {xmlcdata,<<"\n">>},
                    {xmlelement,"error",
                        [{"code","501"},{"type","cancel"}],
                        [{xmlelement,"feature-not-implemented",
                             [{"xmlns","urn:ietf:params:xml:ns:xmpp-stanzas"}],
                             []}]}]}
=INFO REPORT==== 2010-01-20 09:09:11 ===
D(<0.475.0>:ejabberd_local:272) : local route
        from {jid,[],"jabber.example.com",[],[],"jabber.example.com",[]}
        to {jid,"superuser","jabber.example.com","jasiek","superuser",
                "jabber.example.com","jasiek"}
        packet {xmlelement,"iq",
                           [{"type","error"},{"from",[...]},{[...],...},{...}],
                           [{xmlcdata,<<...>>},{xmlelement,...},{...}|...]}

I haven't found a relevant entry in sasl.log, but I guess it's ok because there were no real error, just a proper reply.

There were no errors while starting the server.

I've removed all options from

nineinchnick — Wed, 20 Jan 2010 07:59:20 +0000

I've removed all options from mod_caps and fixed SRV records in my local DNS server and redirected all subdomains for that host.

I think it's all about mod_caps there.

I was trying various

nineinchnick — Wed, 20 Jan 2010 07:57:24 +0000

I was trying various configurations. The error in the logs from mod_caps was there before I added extra_domains.

Quote: Fist, service

mfoss — Tue, 19 Jan 2010 18:31:01 +0000

Quote:

Fist, service discovery seems not to be working. Tested with PSI 0.14 on ArchLinux x86.

You added this option to mod_disco: {extra_domains, ["jabber.example.com"]},

Remove that option, it isn't needed. And maybe it's the cause of first problem.

ejabberd - Comments for "Service Discovery in ejabberd 2.0.1 from Debian Lenny"