I have set up a couple of ejabberd servers communicating with each other over TLS. Everything seems to work and messages are flowing between the ejabberd servers. Once in a while though one of the messages goes missing. I am not sure how to trace this. I have enabled debugging message in the ejabberd conf file. (Ubuntu 10.04 LTS, ejabbered 2.1.5 binary installer) and can follow the message trail but I don't know where the message went. Here is a summary from the log with message content removed for brevity from the node that is sending the msg (dist.morphbius.com)
Can anyone give me a hint on how to trace this further? The log on the receiving node doesn't show any corresponding messages being received. I
=INFO REPORT==== 2010-11-11 21:06:12 ===
D(<0.366.0>:ejabberd_router:313) : route
from {jid,"cdn_op","dist.morphbius.com","cdn","cdn_op",
"dist.morphbius.com","cdn"}
to {jid,"cdn_op","leaf2.morphbius.com","cdn","cdn_op",
"leaf2.morphbius.com","cdn"}
packet {xmlelement,"message",
[{"xml:lang","en"},
{"sn","294"},
{"to","cdn_op@leaf2.morphbius.com/cdn"},
{"type","normal"}],
[{xmlelement,"body",[],
[{xmlcdata,<<"2010-11-11T21:05:54-05:00:Transferred">>}]},
{xmlelement,"transaction",
[...body of msg removed...]
>>}]}]}]}
=INFO REPORT==== 2010-11-11 21:06:12 ===
D(<0.366.0>:ejabberd_s2s:251) : s2s manager
from {jid,"cdn_op","dist.morphbius.com","cdn","cdn_op",
"dist.morphbius.com","cdn"}
to {jid,"cdn_op","leaf2.morphbius.com","cdn","cdn_op",
"leaf2.morphbius.com","cdn"}
packet {xmlelement,"message",
[{"xml:lang","en"},{"sn",[...]},{[...],...},{...}],
[{xmlelement,[...],...},{xmlelement,...},{...}]}
=INFO REPORT==== 2010-11-11 21:06:12 ===
D(<0.366.0>:ejabberd_s2s:286) : Finding connection for {"dist.morphbius.com",
"leaf2.morphbius.com"}
=INFO REPORT==== 2010-11-11 21:06:12 ===
D(<0.366.0>:ejabberd_s2s:336) : Using ejabberd_s2s_out <0.488.0>
=INFO REPORT==== 2010-11-11 21:06:12 ===
D(<0.366.0>:ejabberd_s2s:255) : sending to process <0.488.0>
=INFO REPORT==== 2010-11-11 21:06:16 ===
D(<0.365.0>:ejabberd_receiver:320) : Received XML on stream = "<message sn='296' to='cdn_op@audit.morphbius.com/cdn' type='normal\
'><body>Starting transfer for 1059b190-d02f-012d-43ec-000c291809ee to leaf2.morphbius.com</body><transaction version='1.0' xmlns=\
'http://startimes.com.cn/ns/cdn/1.0'><log node='dist.morphbius.com'><severity>info</severity><eventStr>Starting transfer for 1059\
b [...more stuff removed...]
=INFO REPORT==== 2010-11-11 21:06:16 ===
D(<0.365.0>:shaper:61) : State: {maxrate,1000,999.9576444042286,
1289527576783112}, Size=2126
M=2125.909955817265, I=9.362
=INFO REPORT==== 2010-11-11 21:06:16 ===
D(<0.366.0>:ejabberd_router:313) : route
from {jid,"cdn_op","dist.morphbius.com","cdn","cdn_op",
"dist.morphbius.com","cdn"}
to {jid,"cdn_op","audit.morphbius.com","cdn","cdn_op",
"audit.morphbius.com","cdn"}
=INFO REPORT==== 2010-11-11 21:06:16 ===
D(<0.366.0>:ejabberd_s2s:251) : s2s manager
from {jid,"cdn_op","dist.morphbius.com","cdn","cdn_op",
"dist.morphbius.com","cdn"}
to {jid,"cdn_op","audit.morphbius.com","cdn","cdn_op",
"audit.morphbius.com","cdn"}
packet {xmlelement,"message",
[{"xml:lang","en"},{"sn",[...]},{[...],...},{...}],
[{xmlelement,[...],...},{xmlelement,...},{...}]}
=INFO REPORT==== 2010-11-11 21:06:16 ===
D(<0.366.0>:ejabberd_s2s:286) : Finding connection for {"dist.morphbius.com",
"audit.morphbius.com"}
=INFO REPORT==== 2010-11-11 21:06:16 ===
D(<0.366.0>:ejabberd_s2s:336) : Using ejabberd_s2s_out <0.482.0>
=INFO REPORT==== 2010-11-11 21:06:16 ===
D(<0.366.0>:ejabberd_s2s:255) : sending to process <0.482.0>