I misspoke a bit. Actually one of the packets is sent to the external component: the unavailable presence from userA to userB. I missed it in my initial post due to a setup problem. Sorry about that.<div><br></div><div>But the one I'd like to see is the one from userA to room1@conference.mydomain. That packet is definitely not arriving. Unfortunately I'm having a bit of a hard time reading the log because it looks like there are multiple packets in transit at once but roughly speaking it seems to be this:</div>
<div><br></div><div><div>=INFO REPORT==== 2011-03-22 11:42:08 ===</div><div>D(<0.884.0>:ejabberd_router:313) : route</div><div><span class="Apple-tab-span" style="white-space:pre">      </span>from {jid,"userA","mydomain","jwchat","userA","mydomain","jwchat"}</div>
<div><span class="Apple-tab-span" style="white-space:pre">      </span>to {jid,"room1","conference.mydomain","userA","room1",</div><div>                "conference.mydomain","userA"}</div>
<div><span class="Apple-tab-span" style="white-space:pre">      </span>packet {xmlelement,"presence",[{"type","unavailable"}],[]}</div></div><div><br></div><div><div>=INFO REPORT==== 2011-03-22 11:42:08 ===</div>
<div>D(<0.332.0>:mod_muc:507) : MUC: send to process <0.340.0></div><div><br></div><div><br></div><div>=INFO REPORT==== 2011-03-22 11:42:08 ===</div><div>D(<0.340.0>:ejabberd_router:313) : route</div><div>
<span class="Apple-tab-span" style="white-space:pre"> </span>from {jid,"room1","conference.mydomain","userA","room1",</div><div>                  "conference.mydomain","userA"}</div>
<div><span class="Apple-tab-span" style="white-space:pre">      </span>to {jid,"userA","mydomain","jwchat","userA","mydomain","jwchat"}</div><div><span class="Apple-tab-span" style="white-space:pre"> </span>packet {xmlelement,"presence",</div>
<div>                   [{"type","unavailable"}],</div><div>                   [{xmlelement,"x",</div><div>                        [{"xmlns","<a href="http://jabber.org/protocol/muc#user">http://jabber.org/protocol/muc#user</a>"}],</div>
<div>                        [{xmlelement,"item",</div><div>                             [{"affiliation","owner"},{"role","none"}],</div><div>                             []}]}]}</div>
<div><br></div><div><br></div><div><div>=INFO REPORT==== 2011-03-22 11:42:08 ===</div><div>D(<0.340.0>:ejabberd_local:286) : local route</div><div><span class="Apple-tab-span" style="white-space:pre">        </span>from {jid,"room1","conference.mydomain","userA","room1",</div>
<div>                  "conference.mydomain","userA"}</div><div><span class="Apple-tab-span" style="white-space:pre">   </span>to {jid,"userA","mydomain","jwchat","userA","mydomain","jwchat"}</div>
<div><span class="Apple-tab-span" style="white-space:pre">      </span>packet {xmlelement,"presence",</div><div>                           [{"type","unavailable"}],</div><div>                           [{xmlelement,[...],...}]}</div>
<div><br></div><div><br></div><div>=INFO REPORT==== 2011-03-22 11:42:08 ===</div><div>D(<0.340.0>:ejabberd_sm:410) : session manager</div><div><span class="Apple-tab-span" style="white-space:pre">  </span>from {jid,"room1","conference.mydomain","userA","room1",</div>
<div>                  "conference.mydomain","userA"}</div><div><span class="Apple-tab-span" style="white-space:pre">   </span>to {jid,"userA","mydomain","jwchat","userA","mydomain","jwchat"}</div>
<div><span class="Apple-tab-span" style="white-space:pre">      </span>packet {xmlelement,"presence",</div><div>                           [{"type","unavailable"}],</div><div>                           [{xmlelement,[...],...}]}</div>
</div><div><br></div><div><br></div><div>=INFO REPORT==== 2011-03-22 11:42:08 ===</div><div>D(<0.340.0>:ejabberd_sm:504) : packet droped</div></div><div><br></div><div>I understand that once the room tries to send the packet back to the user, that will get dropped and not logged. That's fine. But the very first packet in my snippet above - the one *from* the user *to* the room - shouldn't that be logged?</div>
<div><br></div><div>thanks,</div><div>Dan</div><div><br><div class="gmail_quote">On Tue, Mar 22, 2011 at 12:43 AM, Daniel Dormont <span dir="ltr"><<a href="mailto:dan@greywallsoftware.com">dan@greywallsoftware.com</a>></span> wrote:<br>
<blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex;">Hi folks,<div><br></div><div>I'm continuing to explore mod_service_log and I noticed a behavior that I would like to understand or at least confirm whether it's expected or not:</div>
<div><br></div><div>Suppose that I have userA@mydomain a MUC room on room1@conference.mydomain. Suppose further that userA is connected using http_bind but then the user's session times out. I see the following in my server log. Also note that userA has userB on its roster and userB is currently online.</div>

<div><br></div><div>- a session timeout from http_bind</div><div>- a presence packet from userA to userB with type "unavailable"</div><div>- a presence packet from userA to userA with type "unavailable"</div>

<div>- a presence packet from userA to room1@conference.mydomain with type "unavailable"</div><div>- a presence packet from room1@conference.mydomain to userA with type "unavailable"</div><div><br></div>

<div>Yet, it appears that none of these packets reach the external component configured in mod_service_log. Is this expected, and if so, can someone explain why? </div><div><br></div><div>thanks,</div><div>Dan</div>
</blockquote></div><br></div>