<!DOCTYPE HTML PUBLIC "-//W3C//DTD HTML 4.0 Transitional//EN">
<HTML><HEAD>
<META HTTP-EQUIV="Content-Type" CONTENT="text/html; charset=us-ascii">


<META content="MSHTML 6.00.2900.2523" name=GENERATOR></HEAD>
<BODY>
<DIV><FONT face=Arial size=2><SPAN class=677523123-11122004>For reasons unknown 
to me, SER and subsequently a Microsoft Live Communcations Server 2005 seems to 
have problems, matching a SIP ACK request from asterisk to the ongoing SIP 
transaction, I have attached the complete log, but the essential lines 
are:</SPAN></FONT></DIV>
<DIV><FONT face=Arial size=2><SPAN 
class=677523123-11122004></SPAN></FONT>&nbsp;</DIV>
<DIV><FONT face=Arial size=2><SPAN class=677523123-11122004>13(2894) DEBUG: 
RFC3261 transaction matching failed<BR>13(2894) DEBUG: t_lookup_request: no 
transaction found<BR>13(2894) SER: forwarding ACK&nbsp; 
statelessly<BR></SPAN></FONT></DIV>
<DIV><FONT face=Arial size=2><SPAN class=677523123-11122004>The result is a 
"half duplex" connection that will break down, as soon as the timeout for the 
missing ACK package is reached.</SPAN></FONT></DIV>
<DIV><FONT face=Arial size=2><SPAN class=677523123-11122004>Has anybody an idea 
how to fix this problem ?</SPAN></FONT></DIV>
<DIV><FONT face=Arial size=2><SPAN 
class=677523123-11122004></SPAN></FONT>&nbsp;</DIV>
<DIV><FONT face=Arial size=2><SPAN class=677523123-11122004>The problem only 
occurs when if a call originates in asterisk. Calls from the LCS system to 
asterisk work just fine.</SPAN></FONT></DIV>
<DIV><FONT face=Arial size=2><SPAN 
class=677523123-11122004></SPAN></FONT>&nbsp;</DIV>
<DIV><FONT face=Arial size=2><SPAN 
class=677523123-11122004>chris.</SPAN></FONT></DIV>
<DIV><FONT face=Arial size=2><SPAN 
class=677523123-11122004>&nbsp;</DIV></SPAN></FONT>
<DIV><FONT face=Arial size=2></FONT>&nbsp;</DIV>
<DIV><FONT face=Arial size=2></FONT>&nbsp;</DIV>
<DIV><FONT face=Arial size=2>&nbsp;9(2890) SIP Request:<BR>&nbsp;9(2890)&nbsp; 
method:&nbsp; &lt;INVITE&gt;<BR>&nbsp;9(2890)&nbsp; uri:&nbsp;&nbsp;&nbsp;&nbsp; 
&lt;sip:chriz@karlshorst.net&gt;<BR>&nbsp;9(2890)&nbsp; version: 
&lt;SIP/2.0&gt;<BR>&nbsp;9(2890) parse_headers: flags=1<BR>&nbsp;9(2890) Found 
param type 232, &lt;branch&gt; = &lt;z9hG4bK61c24316&gt;; 
state=16<BR>&nbsp;9(2890) end of header reached, state=5<BR>&nbsp;9(2890) 
parse_headers: Via found, flags=1<BR>&nbsp;9(2890) parse_headers: this is the 
first via<BR>&nbsp;9(2890) After parse_msg...<BR>&nbsp;9(2890) preparing to run 
routing scripts...<BR>&nbsp;9(2890) DEBUG : is_maxfwd_present: searching for 
max_forwards header<BR>&nbsp;9(2890) parse_headers: flags=128<BR>&nbsp;9(2890) 
end of header reached, state=9<BR>&nbsp;9(2890) DEBUG: get_hdr_field: &lt;To&gt; 
[28]; uri=[sip:chriz@karlshorst.net]<BR>&nbsp;9(2890) DEBUG: to body 
[&lt;sip:chriz@karlshorst.net&gt;<BR>]<BR>&nbsp;9(2890) get_hdr_field: cseq 
&lt;CSeq&gt;: &lt;102&gt; &lt;INVITE&gt;<BR>&nbsp;9(2890) DEBUG: get_hdr_body : 
content_length=364<BR>&nbsp;9(2890) found end of header<BR>&nbsp;9(2890) DEBUG: 
is_maxfwd_present: max_forwards header not found!<BR>&nbsp;9(2890) DEBUG: 
add_param: tag=as47998c2b<BR>&nbsp;9(2890) end of header reached, 
state=29<BR>&nbsp;9(2890) parse_headers: flags=256<BR>&nbsp;9(2890) 
find_first_route(): No Route headers found<BR>&nbsp;9(2890) loose_route(): There 
is no Route HF<BR>&nbsp;9(2890) parse_headers: flags=2048<BR>&nbsp;9(2890) 
check_via_address(192.168.4.39, 192.168.4.39, 0)<BR>&nbsp;9(2890) 
Sending:<BR>INVITE sip:chriz@karlshorst.net SIP/2.0<BR>Max-Forwards: 
10<BR>Record-Route: 
&lt;sip:chriz@192.168.4.39;transport=tcp;r2=on;ftag=as47998c2b;lr&gt;<BR>Record-Route: 
&lt;sip:chriz@192.168.4.39;r2=on;ftag=as47998c2b;lr&gt;<BR>Via: SIP/2.0/TCP 
192.168.4.39;branch=0<BR>Via: SIP/2.0/UDP 
192.168.4.39:5082;branch=z9hG4bK61c24316<BR>From: "10" 
&lt;sip:10@fedora.karlshorst.net&gt;;tag=as47998c2b<BR>To: 
&lt;sip:chriz@karlshorst.net&gt;<BR>Contact: 
&lt;sip:10@192.168.4.39:5082&gt;<BR>Call-ID: <A 
href="mailto:3f5512e931c367c566ee7d3420453098@fedora.karlshorst.net">3f5512e931c367c566ee7d3420453098@fedora.karlshorst.net</A><BR>CSeq: 
102 INVITE<BR>User-Agent: Babble/0.6.10<BR>Date: Fri, 10 Dec 2004 16:58:02 
GMT<BR>Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER<BR>Content-Type: 
application/sdp<BR>Content-Length: 364</FONT></DIV>
<DIV>&nbsp;</DIV>
<DIV><FONT face=Arial size=2>v=0<BR>o=root 2442 2442 IN IP4 
192.168.4.39<BR>s=session<BR>c=IN IP4 192.168.4.39<BR>t=0 0<BR>m=audio 30016 
RTP/AVP 8 0 97 3 2 110<BR>a=rtpmap:8 PCMA/8000<BR>a=rtpmap:0 
PCMU/8000<BR>a=rtpmap:97 iLBC/8000<BR>a=rtpmap:3 GSM/8000<BR>a=rtpmap:2 
G726-32/8000<BR>a=rtpmap:110 speex/8000<BR>a=silenceSupp:off - - - -<BR>m=video 
30000 RTP/AVP 34 31<BR>a=rtpmap:34 H263/90000<BR>a=rtpmap:31 
H261/90000<BR>.<BR>&nbsp;9(2890) orig. len=841, new_len=1043, 
proto=2<BR>&nbsp;9(2890) tcp_send: no open tcp connection found, opening new 
one<BR>&nbsp;9(2890) tcpconn_new: new tcp connection: 
192.168.4.37<BR>&nbsp;9(2890) tcpconn_new: on port 5060, type 2<BR>&nbsp;9(2890) 
tcp_send: sending...<BR>&nbsp;9(2890) tcp_send: after write: c= 0xf51740e0 
n=1043 fd=15<BR>&nbsp;9(2890) tcp_send: buf=<BR>INVITE sip:chriz@karlshorst.net 
SIP/2.0<BR>Max-Forwards: 10<BR>Record-Route: 
&lt;sip:chriz@192.168.4.39;transport=tcp;r2=on;ftag=as47998c2b;lr&gt;<BR>Record-Route: 
&lt;sip:chriz@192.168.4.39;r2=on;ftag=as47998c2b;lr&gt;<BR>Via: SIP/2.0/TCP 
192.168.4.39;branch=0<BR>Via: SIP/2.0/UDP 
192.168.4.39:5082;branch=z9hG4bK61c24316<BR>From: "10" 
&lt;sip:10@fedora.karlshorst.net&gt;;tag=as47998c2b<BR>To: 
&lt;sip:chriz@karlshorst.net&gt;<BR>Contact: 
&lt;sip:10@192.168.4.39:5082&gt;<BR>Call-ID: <A 
href="mailto:3f5512e931c367c566ee7d3420453098@fedora.karlshorst.net">3f5512e931c367c566ee7d3420453098@fedora.karlshorst.net</A><BR>CSeq: 
102 INVITE<BR>User-Agent: Babble/0.6.10<BR>Date: Fri, 10 Dec 2004 16:58:02 
GMT<BR>Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER<BR>Content-Type: 
application/sdp<BR>Content-Length: 364</FONT></DIV>
<DIV>&nbsp;</DIV>
<DIV><FONT face=Arial size=2>v=0<BR>o=root 2442 2442 IN IP4 
192.168.4.39<BR>s=session<BR>c=IN IP4 192.168.4.39<BR>t=0 0<BR>m=audio 30016 
RTP/AVP 8 0 97 3 2 110<BR>a=rtpmap:8 PCMA/8000<BR>a=rtpmap:0 
PCMU/8000<BR>a=rtpmap:97 iLBC/8000<BR>a=rtpmap:3 GSM/8000<BR>a=rtpmap:2 
G726-32/8000<BR>a=rtpmap:110 speex/8000<BR>a=silenceSupp:off - - - -<BR>m=video 
30000 RTP/AVP 34 31<BR>a=rtpmap:34 H263/90000<BR>a=rtpmap:31 
H261/90000</FONT></DIV>
<DIV>&nbsp;</DIV>
<DIV><FONT face=Arial size=2>&nbsp;9(2890) DEBUG:destroy_avp_list: destroing 
list (nil)<BR>&nbsp;9(2890) receive_msg: cleaning up<BR>27(2908) tcp_main_loop: 
read response= f51740e0, 2 from 9 (2890)<BR>27(2908) tcpconn_add: hashes: 772, 
1<BR>27(2908) tcp_main_loop: data available on 0xf51740e0 [h:772] 41<BR>27(2908) 
send2child: to tcp child 0 19(2900), 0xf51740e0<BR>19(2900) received n=4 
con=0xf51740e0, fd=26<BR>19(2900) tcp_read_req: content-length= 0<BR>19(2900) 
SIP Reply&nbsp; (status):<BR>19(2900)&nbsp; version: 
&lt;SIP/2.0&gt;<BR>19(2900)&nbsp; status:&nbsp; &lt;100&gt;<BR>19(2900)&nbsp; 
reason:&nbsp; &lt;Trying&gt;<BR>19(2900) parse_headers: flags=1<BR>19(2900) 
Found param type 232, &lt;branch&gt; = &lt;0&gt;; state=6<BR>19(2900) Found 
param type 237, &lt;ms-received-port&gt; = &lt;42320&gt;; state=6<BR>19(2900) 
Found param type 237, &lt;ms-received-cid&gt; = &lt;2200&gt;; 
state=16<BR>19(2900) end of header reached, state=5<BR>19(2900) parse_headers: 
Via found, flags=1<BR>19(2900) parse_headers: this is the first via<BR>19(2900) 
After parse_msg...<BR>19(2900) forward_reply: found module tm, passing reply to 
it<BR>19(2900) DEBUG: t_check: msg id=1 global id=0 T 
start=0xffffffff<BR>19(2900) parse_headers: flags=17<BR>19(2900) Found param 
type 232, &lt;branch&gt; = &lt;z9hG4bK61c24316&gt;; state=16<BR>19(2900) end of 
header reached, state=5<BR>19(2900) parse_headers: Via found, 
flags=17<BR>19(2900) parse_headers: this is the second via<BR>19(2900) end of 
header reached, state=9<BR>19(2900) DEBUG: get_hdr_field: &lt;To&gt; [28]; 
uri=[sip:chriz@karlshorst.net]<BR>19(2900) DEBUG: to body 
[&lt;sip:chriz@karlshorst.net&gt;<BR>]<BR>19(2900) get_hdr_field: cseq 
&lt;CSeq&gt;: &lt;102&gt; &lt;INVITE&gt;<BR>19(2900) parse_headers: 
flags=4<BR>19(2900) DEBUG: t_reply_matching: failure to match a 
transaction<BR>19(2900) DEBUG: t_check: msg id=1 global id=1 T 
end=(nil)<BR>19(2900) parse_headers: flags=2<BR>19(2900)&nbsp; old size: 357, 
new size: 273<BR>19(2900) build_res_from_sip_res: copied size: orig:104, new: 
20, rest: 253 msg=<BR>SIP/2.0 100 Trying<BR>Via: SIP/2.0/UDP 
192.168.4.39:5082;branch=z9hG4bK61c24316<BR>From: "10" 
&lt;sip:10@fedora.karlshorst.net&gt;;tag=as47998c2b<BR>To: 
&lt;sip:chriz@karlshorst.net&gt;<BR>Call-ID: <A 
href="mailto:3f5512e931c367c566ee7d3420453098@fedora.karlshorst.net">3f5512e931c367c566ee7d3420453098@fedora.karlshorst.net</A><BR>CSeq: 
102 INVITE<BR>Content-Length: 0</FONT></DIV>
<DIV>&nbsp;</DIV><FONT face=Arial size=2>
<DIV><BR>19(2900) update_sock_struct_from_via: using via host<BR>19(2900) 
update_sock_struct_from_via: trying SRV lookup<BR>19(2900)&nbsp; reply forwarded 
to 192.168.4.39:5082<BR>19(2900) DEBUG:destroy_avp_list: destroing list 
(nil)<BR>19(2900) receive_msg: cleaning up<BR>19(2900) tcp_read_req: 
content-length= 0<BR>19(2900) SIP Reply&nbsp; (status):<BR>19(2900)&nbsp; 
version: &lt;SIP/2.0&gt;<BR>19(2900)&nbsp; status:&nbsp; 
&lt;180&gt;<BR>19(2900)&nbsp; reason:&nbsp; &lt;Ringing&gt;<BR>19(2900) 
parse_headers: flags=1<BR>19(2900) Found param type 232, &lt;branch&gt; = 
&lt;0&gt;; state=6<BR>19(2900) Found param type 237, &lt;ms-received-port&gt; = 
&lt;42320&gt;; state=6<BR>19(2900) Found param type 237, &lt;ms-received-cid&gt; 
= &lt;2200&gt;; state=16<BR>19(2900) end of header reached, state=5<BR>19(2900) 
parse_headers: Via found, flags=1<BR>19(2900) parse_headers: this is the first 
via<BR>19(2900) After parse_msg...<BR>19(2900) forward_reply: found module tm, 
passing reply to it<BR>19(2900) DEBUG: t_check: msg id=2 global id=1 T 
start=(nil)<BR>19(2900) parse_headers: flags=17<BR>19(2900) Found param type 
232, &lt;branch&gt; = &lt;z9hG4bK61c24316&gt;; state=16<BR>19(2900) end of 
header reached, state=5<BR>19(2900) parse_headers: Via found, 
flags=17<BR>19(2900) parse_headers: this is the second via<BR>19(2900) DEBUG: 
add_param: epid=da7682c206<BR>19(2900) DEBUG: add_param: 
tag=887adab7a6634995952dcff119280ef8<BR>19(2900) end of header reached, 
state=29<BR>19(2900) DEBUG: get_hdr_field: &lt;To&gt; [81]; 
uri=[sip:chriz@karlshorst.net]<BR>19(2900) DEBUG: to body 
[&lt;sip:chriz@karlshorst.net&gt;]<BR>19(2900) get_hdr_field: cseq &lt;CSeq&gt;: 
&lt;102&gt; &lt;INVITE&gt;<BR>19(2900) parse_headers: flags=4<BR>19(2900) DEBUG: 
t_reply_matching: failure to match a transaction<BR>19(2900) DEBUG: t_check: msg 
id=2 global id=2 T end=(nil)<BR>19(2900) parse_headers: 
flags=2<BR>19(2900)&nbsp; old size: 576, new size: 492<BR>19(2900) 
build_res_from_sip_res: copied size: orig:105, new: 21, rest: 471 
msg=<BR>SIP/2.0 180 Ringing<BR>Via: SIP/2.0/UDP 
192.168.4.39:5082;branch=z9hG4bK61c24316<BR>From: "10" 
&lt;sip:10@fedora.karlshorst.net&gt;;tag=as47998c2b<BR>To: 
&lt;sip:chriz@karlshorst.net&gt;;epid=da7682c206;tag=887adab7a6634995952dcff119280ef8<BR>Call-ID: 
<A 
href="mailto:3f5512e931c367c566ee7d3420453098@fedora.karlshorst.net">3f5512e931c367c566ee7d3420453098@fedora.karlshorst.net</A><BR>CSeq: 
102 INVITE<BR>Record-Route: 
&lt;sip:chriz@192.168.4.39;transport=tcp;r2=on;ftag=as47998c2b;lr&gt;<BR>Record-Route: 
&lt;sip:chriz@192.168.4.39;r2=on;ftag=as47998c2b;lr&gt;<BR>User-Agent: 
RTC/1.3<BR>Content-Length: 0</DIV>
<DIV>&nbsp;</DIV>
<DIV><BR>19(2900) update_sock_struct_from_via: using via host<BR>19(2900) 
update_sock_struct_from_via: trying SRV lookup<BR>19(2900)&nbsp; reply forwarded 
to 192.168.4.39:5082<BR>19(2900) DEBUG:destroy_avp_list: destroing list 
(nil)<BR>19(2900) receive_msg: cleaning up<BR>19(2900) tcp_read_req: 
content-length= 257<BR>19(2900) SIP Reply&nbsp; (status):<BR>19(2900)&nbsp; 
version: &lt;SIP/2.0&gt;<BR>19(2900)&nbsp; status:&nbsp; 
&lt;200&gt;<BR>19(2900)&nbsp; reason:&nbsp; &lt;OK&gt;<BR>19(2900) 
parse_headers: flags=1<BR>19(2900) Found param type 232, &lt;branch&gt; = 
&lt;0&gt;; state=6<BR>19(2900) Found param type 237, &lt;ms-received-port&gt; = 
&lt;42320&gt;; state=6<BR>19(2900) Found param type 237, &lt;ms-received-cid&gt; 
= &lt;2200&gt;; state=16<BR>19(2900) end of header reached, state=5<BR>19(2900) 
parse_headers: Via found, flags=1<BR>19(2900) parse_headers: this is the first 
via<BR>19(2900) After parse_msg...<BR>19(2900) forward_reply: found module tm, 
passing reply to it<BR>19(2900) DEBUG: t_check: msg id=3 global id=2 T 
start=(nil)<BR>19(2900) parse_headers: flags=17<BR>19(2900) Found param type 
232, &lt;branch&gt; = &lt;z9hG4bK61c24316&gt;; state=16<BR>19(2900) end of 
header reached, state=5<BR>19(2900) parse_headers: Via found, 
flags=17<BR>19(2900) parse_headers: this is the second via<BR>19(2900) DEBUG: 
add_param: epid=da7682c206<BR>19(2900) DEBUG: add_param: 
tag=887adab7a6634995952dcff119280ef8<BR>19(2900) end of header reached, 
state=29<BR>19(2900) DEBUG: get_hdr_field: &lt;To&gt; [81]; 
uri=[sip:chriz@karlshorst.net]<BR>19(2900) DEBUG: to body 
[&lt;sip:chriz@karlshorst.net&gt;]<BR>19(2900) get_hdr_field: cseq &lt;CSeq&gt;: 
&lt;102&gt; &lt;INVITE&gt;<BR>19(2900) parse_headers: flags=4<BR>19(2900) DEBUG: 
t_reply_matching: failure to match a transaction<BR>19(2900) DEBUG: t_check: msg 
id=3 global id=3 T end=(nil)<BR>19(2900) parse_headers: 
flags=2<BR>19(2900)&nbsp; old size: 1045, new size: 961<BR>19(2900) 
build_res_from_sip_res: copied size: orig:196, new: 112, rest: 849 
msg=<BR>SIP/2.0 200 OK<BR>Contact: 
&lt;sip:chriz@karlshorst.net:3900;maddr=192.168.4.35;transport=tls;ms-received-cid=1700&gt;<BR>Via: 
SIP/2.0/UDP 192.168.4.39:5082;branch=z9hG4bK61c24316<BR>From: "10" 
&lt;sip:10@fedora.karlshorst.net&gt;;tag=as47998c2b<BR>To: 
&lt;sip:chriz@karlshorst.net&gt;;epid=da7682c206;tag=887adab7a6634995952dcff119280ef8<BR>Call-ID: 
<A 
href="mailto:3f5512e931c367c566ee7d3420453098@fedora.karlshorst.net">3f5512e931c367c566ee7d3420453098@fedora.karlshorst.net</A><BR>CSeq: 
102 INVITE<BR>Record-Route: 
&lt;sip:KHPOOL.karlshorst.net;transport=tcp;ms-fe=delta6.karlshorst.net;lr&gt;<BR>Record-Route: 
&lt;sip:chriz@192.168.4.39;transport=tcp;r2=on;ftag=as47998c2b;lr&gt;<BR>Record-Route: 
&lt;sip:chriz@192.168.4.39;r2=on;ftag=as47998c2b;lr&gt;<BR>User-Agent: 
RTC/1.3<BR>Content-Type: application/sdp<BR>Content-Length: 257</DIV>
<DIV>&nbsp;</DIV>
<DIV>v=0<BR>o=- 0 0 IN IP4 192.168.4.35<BR>s=session<BR>c=IN IP4 
192.168.4.35<BR>b=CT:1000<BR>t=0 0<BR>m=audio 29154 RTP/AVP 8 0 3<BR>a=rtpmap:8 
PCMA/8000<BR>a=rtpmap:0 PCMU/8000<BR>a=rtpmap:3 GSM/8000<BR>m=video 64202 
RTP/AVP 34 31<BR>a=rtpmap:34 H263/90000<BR>a=rtpmap:31 H261/90000</DIV>
<DIV>&nbsp;</DIV>
<DIV>19(2900) update_sock_struct_from_via: using via host<BR>19(2900) 
update_sock_struct_from_via: trying SRV lookup<BR>19(2900)&nbsp; reply forwarded 
to 192.168.4.39:5082<BR>19(2900) DEBUG:destroy_avp_list: destroing list 
(nil)<BR>19(2900) receive_msg: cleaning up<BR>13(2894) SIP 
Request:<BR>13(2894)&nbsp; method:&nbsp; &lt;ACK&gt;<BR>13(2894)&nbsp; 
uri:&nbsp;&nbsp;&nbsp;&nbsp; &lt;sip:chriz@karlshorst.net&gt;<BR>13(2894)&nbsp; 
version: &lt;SIP/2.0&gt;<BR>13(2894) parse_headers: flags=1<BR>13(2894) Found 
param type 232, &lt;branch&gt; = &lt;z9hG4bK62d67fa9&gt;; state=16<BR>13(2894) 
end of header reached, state=5<BR>13(2894) parse_headers: Via found, 
flags=1<BR>13(2894) parse_headers: this is the first via<BR>13(2894) After 
parse_msg...<BR>13(2894) preparing to run routing scripts...<BR>13(2894) DEBUG : 
sl_filter_ACK: to late to be a local ACK!<BR>13(2894) DEBUG : is_maxfwd_present: 
searching for max_forwards header<BR>13(2894) parse_headers: 
flags=128<BR>13(2894) DEBUG: add_param: 
tag=887adab7a6634995952dcff119280ef8<BR>13(2894) end of header reached, 
state=29<BR>13(2894) DEBUG: get_hdr_field: &lt;To&gt; [65]; 
uri=[sip:chriz@karlshorst.net]<BR>13(2894) DEBUG: to body 
[&lt;sip:chriz@karlshorst.net&gt;]<BR>13(2894) get_hdr_field: cseq &lt;CSeq&gt;: 
&lt;102&gt; &lt;ACK&gt;<BR>13(2894) DEBUG: get_hdr_body : 
content_length=0<BR>13(2894) found end of header<BR>13(2894) DEBUG: 
is_maxfwd_present: max_forwards header not found!<BR>13(2894) DEBUG: add_param: 
tag=as47998c2b<BR>13(2894) end of header reached, state=29<BR>13(2894) 
parse_headers: flags=256<BR>13(2894) check_self - checking if host==us: 14==9 
&amp;&amp;&nbsp; [karlshorst.net] == [127.0.0.1]<BR>13(2894) check_self - 
checking if port 5060 matches port 5060<BR>13(2894) check_self - checking if 
host==us: 14==12 &amp;&amp;&nbsp; [karlshorst.net] == [192.168.4.39]<BR>13(2894) 
check_self - checking if port 5060 matches port 5060<BR>13(2894) check_self - 
checking if host==us: 12==9 &amp;&amp;&nbsp; [192.168.4.39] == 
[127.0.0.1]<BR>13(2894) check_self - checking if port 5060 matches port 
5060<BR>13(2894) check_self - checking if host==us: 12==12 &amp;&amp;&nbsp; 
[192.168.4.39] == [192.168.4.39]<BR>13(2894) check_self - checking if port 5060 
matches port 5060<BR>13(2894) ras(): Next hop: 
'sip:KHPOOL.karlshorst.net;transport=tcp;ms-fe=delta6.karlshorst.net;lr' is 
loose router<BR>13(2894) parse_headers: flags=-1<BR>13(2894) ras(): The last 
route URI: 
'sip:chriz@karlshorst.net:3900;maddr=192.168.4.35;transport=tls;ms-received-cid=1700'<BR>13(2894) 
DEBUG: t_addifnew: msg id=1 , global msg id=0 , T on 
entrance=0xffffffff<BR>13(2894) parse_headers: flags=-1<BR>13(2894) 
parse_headers: flags=60<BR>13(2894) t_lookup_request: start searching: 
hash=8792, isACK=1<BR>13(2894) DEBUG: RFC3261 transaction matching 
failed<BR>13(2894) DEBUG: t_lookup_request: no transaction found<BR>13(2894) 
SER: forwarding ACK&nbsp; statelessly<BR>13(2894) DEBUG: mk_proxy: doing DNS 
lookup...<BR>13(2894) sip_resolvehost: SRV(_sip._tcp.KHPOOL.karlshorst.net) = 
delta6.karlshorst.net:5060<BR>13(2894) parse_headers: flags=2048<BR>13(2894) 
check_via_address(192.168.4.39, 192.168.4.39, 0)<BR>13(2894) Sending:<BR>ACK 
sip:chriz@karlshorst.net:3900;maddr=192.168.4.35;transport=tls;ms-received-cid=1700 
SIP/2.0<BR>Max-Forwards: 10<BR>Record-Route: 
&lt;sip:chriz@192.168.4.39;transport=tcp;r2=on;ftag=as47998c2b;lr&gt;<BR>Record-Route: 
&lt;sip:chriz@192.168.4.39;r2=on;ftag=as47998c2b;lr&gt;<BR>Via: SIP/2.0/TCP 
192.168.4.39;branch=0<BR>Via: SIP/2.0/UDP 
192.168.4.39:5082;branch=z9hG4bK62d67fa9<BR>Route: 
&lt;sip:KHPOOL.karlshorst.net;transport=tcp;ms-fe=delta6.karlshorst.net;lr&gt;<BR>From: 
"10" &lt;sip:10@fedora.karlshorst.net&gt;;tag=as47998c2b<BR>To: 
&lt;sip:chriz@karlshorst.net&gt;;tag=887adab7a6634995952dcff119280ef8<BR>Contact: 
&lt;sip:10@192.168.4.39:5082&gt;<BR>Call-ID: <A 
href="mailto:3f5512e931c367c566ee7d3420453098@fedora.karlshorst.net">3f5512e931c367c566ee7d3420453098@fedora.karlshorst.net</A><BR>CSeq: 
102 ACK<BR>User-Agent: Babble/0.6.10<BR>Content-Length: 0</DIV>
<DIV>&nbsp;</DIV>
<DIV>.<BR>13(2894) orig. len=620, new_len=731, proto=2<BR>13(2894) tcp_send: tcp 
connection found (0xf51740e0), acquiring fd<BR>13(2894) tcp_send, c= 0xf51740e0, 
n=8<BR>27(2908) tcp_main_loop: read response= f51740e0, 1 from 13 
(2894)<BR>13(2894) tcp_send: after receive_fd: c= 0xf51740e0 n=4 
fd=19<BR>13(2894) tcp_send: sending...<BR>13(2894) tcp_send: after write: c= 
0xf51740e0 n=731 fd=19<BR>13(2894) tcp_send: buf=<BR>ACK 
sip:chriz@karlshorst.net:3900;maddr=192.168.4.35;transport=tls;ms-received-cid=1700 
SIP/2.0<BR>Max-Forwards: 10<BR>Record-Route: 
&lt;sip:chriz@192.168.4.39;transport=tcp;r2=on;ftag=as47998c2b;lr&gt;<BR>Record-Route: 
&lt;sip:chriz@192.168.4.39;r2=on;ftag=as47998c2b;lr&gt;<BR>Via: SIP/2.0/TCP 
192.168.4.39;branch=0<BR>Via: SIP/2.0/UDP 
192.168.4.39:5082;branch=z9hG4bK62d67fa9<BR>Route: 
&lt;sip:KHPOOL.karlshorst.net;transport=tcp;ms-fe=delta6.karlshorst.net;lr&gt;<BR>From: 
"10" &lt;sip:10@fedora.karlshorst.net&gt;;tag=as47998c2b<BR>To: 
&lt;sip:chriz@karlshorst.net&gt;;tag=887adab7a6634995952dcff119280ef8<BR>Contact: 
&lt;sip:10@192.168.4.39:5082&gt;<BR>Call-ID: <A 
href="mailto:3f5512e931c367c566ee7d3420453098@fedora.karlshorst.net">3f5512e931c367c566ee7d3420453098@fedora.karlshorst.net</A><BR>CSeq: 
102 ACK<BR>User-Agent: Babble/0.6.10<BR>Content-Length: 
0<BR></FONT></DIV></BODY></HTML>