<!DOCTYPE HTML PUBLIC "-//W3C//DTD HTML 4.0 TRANSITIONAL//EN">
<HTML>
<HEAD>
<META HTTP-EQUIV="Content-Type" CONTENT="text/html; CHARSET=UTF-8">
<META NAME="GENERATOR" CONTENT="GtkHTML/3.26.0">
</HEAD>
<BODY>
Hi,<BR>
<BR>
Hope someone knows how I am able to get around this one. Here goes...<BR>
<BR>
Did an upgrade to trunk (from a July vintage build) last week and noticed calls out to a provider were now failing after about 30 seconds or so - post answer. Tried latest (15183) - same thing.<BR>
<BR>
Analysing, I see that I have multiple UPDATE messages now being sent to the provider, but no response being sent back to FS. So FS times out and eventually kills the call.<BR>
Interestingly, it only drops the A-leg; the B-leg remains up till the B party hangs up.<BR>
<BR>
I cant recall seeing these UPDATE messages before...<BR>
<BR>
The intent of the UPDATE seems to be to send the callee name & number to the B-leg.<BR>
<BR>
If its the provider's sip stack that's broken w.r.t. handling UPDATE - is there any way to get around it by doing something in my config to ensure these UPDATE's are not 'triggered' ?<BR>
<BR>
<BR>
Some traces below. <BR>
<BR>
<BR>
Any suggestions welcomed...<BR>
<BR>
Best Regards<BR>
<BR>
Keith<BR>
Pretoria, South Africa.<BR>
<BR>
--------------------------------------------------------------------------------------------------------------------------------------------------<BR>
<BR>
<BR>
<TT>send 1048 bytes to udp/[196.10.11.12]:5060 at 13:24:04.249269:</TT><BR>
<TT> ------------------------------------------------------------------------</TT><BR>
<TT> INVITE sip:27835551111@196.10.11.12 SIP/2.0</TT><BR>
<TT> Via: SIP/2.0/UDP 10.17.10.10;rport;branch=z9hG4bKyQepDXQ5H8g5m</TT><BR>
<TT> Max-Forwards: 67</TT><BR>
<TT> From: "Keith PhoneADSL" <<A HREF="sip:878050000@10.17.10.10">sip:878050000@10.17.10.10</A>>;tag=Upa3NvXpBB1eF</TT><BR>
<TT> To: <<A HREF="sip:27835551111@196.10.11.12">sip:27835551111@196.10.11.12</A>></TT><BR>
<TT> Call-ID: d821359d-38e7-122d-a38e-002264cc9b93</TT><BR>
<TT> CSeq: 121947386 INVITE</TT><BR>
<TT> Contact: <<A HREF="sip:gw+vprov@10.17.10.10:5060">sip:gw+vprov@10.17.10.10:5060</A>;transport=udp;gw=vprov></TT><BR>
<TT> User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-15183M</TT><BR>
<TT> Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, REGISTER, REFER, UPDATE, NOTIFY</TT><BR>
<TT> Supported: timer, precondition, path, replaces</TT><BR>
<TT> Allow-Events: talk, refer</TT><BR>
<TT> Content-Type: application/sdp</TT><BR>
<TT> Content-Disposition: session</TT><BR>
<TT> Content-Length: 247</TT><BR>
<TT> X-Actually-Support: UPDATE</TT><BR>
<TT> Remote-Party-ID: "Keith PhoneADSL" <<A HREF="sip:878050000@10.17.10.10">sip:878050000@10.17.10.10</A>>;party=calling;screen=yes;privacy=off</TT><BR>
<TT> </TT><BR>
<TT> v=0</TT><BR>
<TT> o=FreeSWITCH 1256118582 1256118583 IN IP4 10.17.10.10</TT><BR>
<TT> s=FreeSWITCH</TT><BR>
<TT> c=IN IP4 10.17.10.10</TT><BR>
<TT> t=0 0</TT><BR>
<TT> m=audio 12862 RTP/AVP 18 101</TT><BR>
<TT> a=rtpmap:18 G729/8000</TT><BR>
<TT> a=rtpmap:101 telephone-event/8000</TT><BR>
<TT> a=fmtp:101 0-16</TT><BR>
<TT> a=silenceSupp:off - - - -</TT><BR>
<TT> a=ptime:20</TT><BR>
<TT> ------------------------------------------------------------------------</TT><BR>
<TT>2009-10-21 15:24:04.248448 [DEBUG] sofia.c:3493 Channel sofia/vvrf/27835551111 entering state [calling][0]</TT><BR>
<TT>recv 601 bytes from udp/[196.10.11.12]:5060 at 13:24:04.307690:</TT><BR>
<TT> ------------------------------------------------------------------------</TT><BR>
<TT> SIP/2.0 100 Trying</TT><BR>
<TT> Via: SIP/2.0/UDP 10.17.10.10;rport;branch=z9hG4bKyQepDXQ5H8g5m</TT><BR>
<TT> From: "Keith PhoneADSL" <<A HREF="sip:878050000@10.17.10.10">sip:878050000@10.17.10.10</A>>;tag=Upa3NvXpBB1eF</TT><BR>
<TT> To: <<A HREF="sip:27835551111@196.10.11.12">sip:27835551111@196.10.11.12</A>>;tag=GR52RWG346-34</TT><BR>
<TT> Call-ID: d821359d-38e7-122d-a38e-002264cc9b93</TT><BR>
<TT> CSeq: 121947386 INVITE</TT><BR>
<TT> Contact: "vprov C5CM" <<A HREF="sip:196.10.11.12:5060">sip:196.10.11.12:5060</A>></TT><BR>
<TT> User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-15183M</TT><BR>
<TT> Allow-Events: talk</TT><BR>
<TT> Allow-Events: refer</TT><BR>
<TT> Content-Disposition: session</TT><BR>
<TT> X-Actually-Support: UPDATE</TT><BR>
<TT> Remote-Party-ID: "Keith PhoneADSL" <<A HREF="sip:878050000@10.17.10.10">sip:878050000@10.17.10.10</A>>;party=calling;screen=yes;privacy=off</TT><BR>
<TT> Content-Length: 0</TT><BR>
<TT> </TT><BR>
<TT> ------------------------------------------------------------------------</TT><BR>
<TT>recv 879 bytes from udp/[196.10.11.12]:5060 at 13:24:08.508162:</TT><BR>
<TT> ------------------------------------------------------------------------</TT><BR>
<TT> SIP/2.0 183 Session Progress</TT><BR>
<TT> Via: SIP/2.0/UDP 10.17.10.10;rport;branch=z9hG4bKyQepDXQ5H8g5m</TT><BR>
<TT> From: "Keith PhoneADSL" <<A HREF="sip:878050000@10.17.10.10">sip:878050000@10.17.10.10</A>>;tag=Upa3NvXpBB1eF</TT><BR>
<TT> To: <<A HREF="sip:27835551111@196.10.11.12">sip:27835551111@196.10.11.12</A>>;tag=GR52RWG346-34</TT><BR>
<TT> Call-ID: d821359d-38e7-122d-a38e-002264cc9b93</TT><BR>
<TT> CSeq: 121947386 INVITE</TT><BR>
<TT> Contact: "vprov C5CM" <<A HREF="sip:196.10.11.12:5060">sip:196.10.11.12:5060</A>></TT><BR>
<TT> User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-15183M</TT><BR>
<TT> Allow-Events: talk</TT><BR>
<TT> Allow-Events: refer</TT><BR>
<TT> Content-Disposition: session</TT><BR>
<TT> X-Actually-Support: UPDATE</TT><BR>
<TT> Remote-Party-ID: "Keith PhoneADSL" <<A HREF="sip:878050000@10.17.10.10">sip:878050000@10.17.10.10</A>>;party=calling;screen=yes;privacy=off</TT><BR>
<TT> Content-Type: application/sdp</TT><BR>
<TT> Content-Length: 233</TT><BR>
<TT> </TT><BR>
<TT> v=0</TT><BR>
<TT> o=Clarent 152602 152603 IN IP4 196.10.11.15</TT><BR>
<TT> s=Clarent C5CM</TT><BR>
<TT> c=IN IP4 196.10.11.15</TT><BR>
<TT> t=0 0</TT><BR>
<TT> m=audio 5230 RTP/AVP 18 101</TT><BR>
<TT> a=rtpmap:18 G729/8000</TT><BR>
<TT> a=ptime:20</TT><BR>
<TT> a=fmtp:18 annexb=no</TT><BR>
<TT> a=rtpmap:101 telephone-event/8000</TT><BR>
<TT> a=fmtp:101 0-15</TT><BR>
<TT> ------------------------------------------------------------------------</TT><BR>
<TT>2009-10-21 15:24:08.507506 [DEBUG] sofia.c:3493 Channel sofia/vvrf/27835551111 entering state [proceeding][183]</TT><BR>
<TT>2009-10-21 15:24:08.507506 [DEBUG] sofia.c:3500 Remote SDP:</TT><BR>
<TT>v=0</TT><BR>
<TT>o=Clarent 152602 152603 IN IP4 196.10.11.15</TT><BR>
<TT>s=Clarent C5CM</TT><BR>
<TT>c=IN IP4 196.10.11.15</TT><BR>
<TT>t=0 0</TT><BR>
<TT>m=audio 5230 RTP/AVP 18 101</TT><BR>
<TT>a=rtpmap:18 G729/8000</TT><BR>
<TT>a=fmtp:18 annexb=no</TT><BR>
<TT>a=rtpmap:101 telephone-event/8000</TT><BR>
<TT>a=fmtp:101 0-15</TT><BR>
<TT>a=ptime:20</TT><BR>
<BR>
<TT>2009-10-21 15:24:08.507506 [DEBUG] sofia_glue.c:3144 Audio Codec Compare [G729:18:8000:20]/[G729:18:8000:20]</TT><BR>
<TT>2009-10-21 15:24:08.508561 [DEBUG] sofia_glue.c:2102 Set Codec sofia/vvrf/27835551111 G729/8000 20 ms 160 samples</TT><BR>
<TT>2009-10-21 15:24:08.508561 [DEBUG] sofia_glue.c:3104 Set 2833 dtmf payload to 101</TT><BR>
<TT>2009-10-21 15:24:08.508561 [DEBUG] sofia_glue.c:2336 AUDIO RTP [sofia/vvrf/27835551111] 10.17.10.10 port 12862 -> 196.10.11.15 port 5230 codec: 18 ms: 20</TT><BR>
<TT>2009-10-21 15:24:08.508561 [DEBUG] switch_rtp.c:1155 Starting timer [soft] 160 bytes per 20ms</TT><BR>
<TT>2009-10-21 15:24:08.509616 [NOTICE] sofia_glue.c:2771 Pre-Answer sofia/vvrf/27835551111!</TT><BR>
<TT>2009-10-21 15:24:08.509616 [DEBUG] switch_channel.c:1992 Send signal sofia/inetticky/27878050000@196.222.3.4 [BREAK]</TT><BR>
<TT>2009-10-21 15:24:08.510671 [DEBUG] switch_ivr_originate.c:615 Setting codec string on sofia/inetticky/27878050000@196.222.3.4 to <A HREF="mailto:G729@8000h">G729@8000h</A>@20i</TT><BR>
<TT>2009-10-21 15:24:08.510671 [DEBUG] switch_ivr_originate.c:2326 sofia/inetticky/27878050000@196.222.3.4 receive message [PROGRESS]</TT><BR>
<TT>2009-10-21 15:24:08.510671 [INFO] switch_ivr_originate.c:2326 Sending early media</TT><BR>
<TT>2009-10-21 15:24:08.510671 [DEBUG] sofia_glue.c:3144 Audio Codec Compare [G729:18:8000:0]/[G729:18:8000:20]</TT><BR>
<TT>2009-10-21 15:24:08.510671 [DEBUG] sofia_glue.c:2102 Set Codec sofia/inetticky/27878050000@196.222.3.4 G729/8000 20 ms 160 samples</TT><BR>
<TT>2009-10-21 15:24:08.510671 [DEBUG] sofia_glue.c:3104 Set 2833 dtmf payload to 101</TT><BR>
<TT>2009-10-21 15:24:08.510671 [DEBUG] sofia_glue.c:2336 AUDIO RTP [sofia/inetticky/27878050000@196.222.3.4] 196.222.3.4 port 16840 -> 41.242.6.167 port 62936 codec: 18 ms: 20</TT><BR>
<TT>2009-10-21 15:24:08.510671 [DEBUG] switch_rtp.c:1155 Starting timer [soft] 160 bytes per 20ms</TT><BR>
<TT>2009-10-21 15:24:08.511769 [NOTICE] sofia_glue.c:2771 Pre-Answer sofia/inetticky/<A HREF="mailto:27878050000@196.222.3.4">27878050000@196.222.3.4</A>!</TT><BR>
<TT>2009-10-21 15:24:08.511769 [INFO] mod_sofia.c:1582 Ring SDP:</TT><BR>
<TT>v=0</TT><BR>
<TT>o=FreeSWITCH 1256114608 1256114609 IN IP4 196.222.3.4</TT><BR>
<TT>s=FreeSWITCH</TT><BR>
<TT>c=IN IP4 196.222.3.4</TT><BR>
<TT>t=0 0</TT><BR>
<TT>m=audio 16840 RTP/AVP 18 101</TT><BR>
<TT>a=rtpmap:18 G729/8000</TT><BR>
<TT>a=rtpmap:101 telephone-event/8000</TT><BR>
<TT>a=fmtp:101 0-16</TT><BR>
<TT>a=silenceSupp:off - - - -</TT><BR>
<TT>a=ptime:20</TT><BR>
<TT>a=sendrecv</TT><BR>
<BR>
<TT>2009-10-21 15:24:08.511769 [DEBUG] switch_core_session.c:712 Send signal sofia/vvrf/27835551111 [BREAK]</TT><BR>
<TT>2009-10-21 15:24:08.511769 [DEBUG] switch_core_session.c:653 Send signal sofia/inetticky/27878050000@196.222.3.4 [BREAK]</TT><BR>
<TT>2009-10-21 15:24:08.511769 [DEBUG] sofia.c:407 sofia/vvrf/27835551111 receive message [DISPLAY]</TT><BR>
<TT>2009-10-21 15:24:08.511769 [DEBUG] switch_ivr_originate.c:2368 Originate Resulted in Success: [sofia/vvrf/27835551111]</TT><BR>
<TT>2009-10-21 15:24:08.511769 [DEBUG] switch_channel.c:182 sofia/vvrf/27835551111 receive message [AUDIO_SYNC]</TT><BR>
<TT>2009-10-21 15:24:08.511769 [DEBUG] switch_channel.c:182 sofia/inetticky/27878050000@196.222.3.4 receive message [AUDIO_SYNC]</TT><BR>
<TT>2009-10-21 15:24:08.512832 [DEBUG] switch_ivr_bridge.c:975 sofia/vvrf/27835551111 receive message [BRIDGE]</TT><BR>
<TT>2009-10-21 15:24:08.512832 [DEBUG] switch_core_session.c:653 Send signal sofia/vvrf/27835551111 [BREAK]</TT><BR>
<TT>2009-10-21 15:24:08.512832 [DEBUG] switch_ivr_bridge.c:982 sofia/inetticky/27878050000@196.222.3.4 receive message [BRIDGE]</TT><BR>
<TT>send 973 bytes to udp/[41.242.6.167]:62928 at 13:24:08.512974:</TT><BR>
<TT> ------------------------------------------------------------------------</TT><BR>
<TT> SIP/2.0 183 Session Progress</TT><BR>
<TT> Via: SIP/2.0/UDP 41.242.6.167:56675;branch=z9hG4bK2234c0462cdad03fc318bd6c7438282;rport=629282009-10-21 15:24:08.512832 [DEBUG] switch_core_session.c:653 Send signal sofia/inetticky/27878050000@196.222.3.4 [BREAK]</TT><BR>
<TT>2009-10-21 15:24:08.512832 [DEBUG] switch_ivr_bridge.c:1026 (sofia/vvrf/27835551111) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA</TT><BR>
<TT>2009-10-21 15:24:08.512832 [DEBUG] switch_core_session.c:985 Send signal sofia/vvrf/27835551111 [BREAK]</TT><BR>
<TT>2009-10-21 15:24:08.512832 [DEBUG] switch_core_state_machine.c:306 (sofia/vvrf/27835551111) Running State Change CS_EXCHANGE_MEDIA</TT><BR>
<TT>2009-10-21 15:24:08.512832 [DEBUG] switch_core_state_machine.c:343 (sofia/vvrf/27835551111) State EXCHANGE_MEDIA</TT><BR>
<TT>2009-10-21 15:24:08.512832 [DEBUG] mod_sofia.c:436 SOFIA LOOPBACK</TT><BR>
<BR>
<TT> From: "Keith PhoneADSL" <<A HREF="sip:27878050000@196.222.3.4">sip:27878050000@196.222.3.4</A>>;tag=3283506127</TT><BR>
<TT> To: <<A HREF="sip:0835551111@196.222.3.4">sip:0835551111@196.222.3.4</A>>;user=phone;tag=g2DFFpS0QN4cc</TT><BR>
<TT> Call-ID: <A HREF="mailto:4252084844@192_168_1_65">4252084844@192_168_1_65</A></TT><BR>
<TT> CSeq: 3 INVITE</TT><BR>
<TT> Contact: <<A HREF="sip:0835551111@196.222.3.4:5060">sip:0835551111@196.222.3.4:5060</A>;transport=udp></TT><BR>
<TT> User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-15183M</TT><BR>
<TT> Accept: application/sdp</TT><BR>
<TT> Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, REGISTER, REFER, UPDATE, NOTIFY</TT><BR>
<TT> Supported: timer, precondition, path, replaces</TT><BR>
<TT> Allow-Events: talk, refer</TT><BR>
<TT> Content-Type: application/sdp</TT><BR>
<TT> Content-Disposition: session</TT><BR>
<TT> Content-Length: 249</TT><BR>
<TT> X-Actually-Support: UPDATE</TT><BR>
<TT> </TT><BR>
<TT> v=0</TT><BR>
<TT> o=FreeSWITCH 1256114608 1256114609 IN IP4 196.222.3.4</TT><BR>
<TT> s=FreeSWITCH</TT><BR>
<TT> c=IN IP4 196.222.3.4</TT><BR>
<TT> t=0 0</TT><BR>
<TT> m=audio 16840 RTP/AVP 18 101</TT><BR>
<TT> a=rtpmap:18 G729/8000</TT><BR>
<TT> a=rtpmap:101 telephone-event/8000</TT><BR>
<TT> a=fmtp:101 0-16</TT><BR>
<TT> a=silenceSupp:off - - - -</TT><BR>
<TT> a=ptime:20</TT><BR>
<TT> ------------------------------------------------------------------------</TT><BR>
<TT>2009-10-21 15:24:08.512832 [DEBUG] sofia.c:3493 Channel sofia/inetticky/27878050000@196.222.3.4 entering state [early][183]</TT><BR>
<TT>recv 928 bytes from udp/[196.10.11.12]:5060 at 13:24:14.188781:</TT><BR>
<TT> ------------------------------------------------------------------------</TT><BR>
<TT> SIP/2.0 200 OK</TT><BR>
<TT> Via: SIP/2.0/UDP 10.17.10.10;rport;branch=z9hG4bKyQepDXQ5H8g5m</TT><BR>
<TT> From: "Keith PhoneADSL" <<A HREF="sip:878050000@10.17.10.10">sip:878050000@10.17.10.10</A>>;tag=Upa3NvXpBB1eF</TT><BR>
<TT> To: <<A HREF="sip:27835551111@196.10.11.12">sip:27835551111@196.10.11.12</A>>;tag=GR52RWG346-34</TT><BR>
<TT> Call-ID: d821359d-38e7-122d-a38e-002264cc9b93</TT><BR>
<TT> CSeq: 121947386 INVITE</TT><BR>
<TT> Contact: "vprov C5CM" <<A HREF="sip:196.10.11.12:5060">sip:196.10.11.12:5060</A>></TT><BR>
<TT> User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-15183M</TT><BR>
<TT> Allow-Events: talk</TT><BR>
<TT> Allow-Events: refer</TT><BR>
<TT> Content-Disposition: session</TT><BR>
<TT> X-Actually-Support: UPDATE</TT><BR>
<TT> Remote-Party-ID: "Keith PhoneADSL" <<A HREF="sip:878050000@10.17.10.10">sip:878050000@10.17.10.10</A>>;party=calling;screen=yes;privacy=off</TT><BR>
<TT> Allow: ACK, NOTIFY, OPTIONS, REFER, INFO, BYE, CANCEL, INVITE</TT><BR>
<TT> Content-Type: application/sdp</TT><BR>
<TT> Content-Length: 233</TT><BR>
<TT> </TT><BR>
<TT> v=0</TT><BR>
<TT> o=Clarent 153288 153288 IN IP4 196.10.11.15</TT><BR>
<TT> s=Clarent C5CM</TT><BR>
<TT> c=IN IP4 196.10.11.15</TT><BR>
<TT> t=0 0</TT><BR>
<TT> m=audio 5230 RTP/AVP 18 101</TT><BR>
<TT> a=rtpmap:18 G729/8000</TT><BR>
<TT> a=ptime:20</TT><BR>
<TT> a=fmtp:18 annexb=no</TT><BR>
<TT> a=rtpmap:101 telephone-event/8000</TT><BR>
<TT> a=fmtp:101 0-15</TT><BR>
<TT> ------------------------------------------------------------------------</TT><BR>
<TT>send 396 bytes to udp/[196.10.11.12]:5060 at 13:24:14.189032:</TT><BR>
<TT> ------------------------------------------------------------------------</TT><BR>
<TT> ACK sip:196.10.11.12:5060 SIP/2.0</TT><BR>
<TT> Via: SIP/2.0/UDP 10.17.10.10;rport;branch=z9hG4bKZ07eFr88eH7Qg</TT><BR>
<TT> Max-Forwards: 70</TT><BR>
<TT> From: "Keith PhoneADSL" <<A HREF="sip:878050000@10.17.10.10">sip:878050000@10.17.10.10</A>>;tag=Upa3NvXpBB1eF</TT><BR>
<TT> To: <<A HREF="sip:27835551111@196.10.11.12">sip:27835551111@196.10.11.12</A>>;tag=GR52RWG346-34</TT><BR>
<TT> Call-ID: d821359d-38e7-122d-a38e-002264cc9b93</TT><BR>
<TT> CSeq: 121947386 ACK</TT><BR>
<TT> Contact: <<A HREF="sip:gw+vprov@10.17.10.10:5060">sip:gw+vprov@10.17.10.10:5060</A>;transport=udp;gw=vprov></TT><BR>
<TT> Content-Length: 0</TT><BR>
<TT> </TT><BR>
<TT> ------------------------------------------------------------------------</TT><BR>
<TT>2009-10-21 15:24:14.188910 [DEBUG] sofia.c:3493 Channel sofia/vvrf/27835551111 entering state [ready][200]</TT><BR>
<TT>2009-10-21 15:24:14.188910 [DEBUG] switch_channel.c:2105 Send signal sofia/inetticky/27878050000@196.222.3.4 [BREAK]</TT><BR>
<TT>2009-10-21 15:24:14.188910 [NOTICE] sofia.c:3928 Channel [sofia/vvrf/27835551111] has been answered</TT><BR>
<TT>2009-10-21 15:24:14.188910 [DEBUG] switch_channel.c:182 sofia/vvrf/27835551111 receive message [AUDIO_SYNC]</TT><BR>
<TT>2009-10-21 15:24:14.204823 [DEBUG] switch_ivr_bridge.c:378 sofia/inetticky/27878050000@196.222.3.4 receive message [ANSWER]</TT><BR>
<TT>2009-10-21 15:24:14.204823 [DEBUG] mod_sofia.c:543 Local SDP sofia/inetticky/<A HREF="mailto:27878050000@196.222.3.4">27878050000@196.222.3.4</A>:</TT><BR>
<TT>v=0</TT><BR>
<TT>o=FreeSWITCH 1256114608 1256114610 IN IP4 196.222.3.4</TT><BR>
<TT>s=FreeSWITCH</TT><BR>
<TT>c=IN IP4 196.222.3.4</TT><BR>
<TT>t=0 0</TT><BR>
<TT>m=audio 16840 RTP/AVP 18 101</TT><BR>
<TT>a=rtpmap:18 G729/8000</TT><BR>
<TT>a=rtpmap:101 telephone-event/8000</TT><BR>
<TT>a=fmtp:101 0-16</TT><BR>
<TT>a=silenceSupp:off - - - -</TT><BR>
<TT>a=ptime:20</TT><BR>
<TT>a=sendrecv</TT><BR>
<BR>
<TT>2009-10-21 15:24:14.204823 [DEBUG] switch_core_session.c:712 Send signal sofia/vvrf/27835551111 [BREAK]</TT><BR>
<TT>2009-10-21 15:24:14.204823 [DEBUG] switch_core_session.c:653 Send signal sofia/inetticky/27878050000@196.222.3.4 [BREAK]</TT><BR>
<TT>2009-10-21 15:24:14.204823 [NOTICE] switch_ivr_bridge.c:378 Channel [sofia/inetticky/27878050000@196.222.3.4] has been answered</TT><BR>
<TT>2009-10-21 15:24:14.204823 [DEBUG] switch_channel.c:182 sofia/inetticky/27878050000@196.222.3.4 receive message [AUDIO_SYNC]</TT><BR>
<TT>send 983 bytes to udp/[41.242.6.167]:62928 at 13:24:14.205173:</TT><BR>
<TT> ------------------------------------------------------------------------</TT><BR>
<TT> SIP/2.0 200 OK</TT><BR>
<TT> Via: SIP/2.0/UDP 41.242.6.167:56675;branch=z9hG4bK2234c0462cdad03fc318bd6c7438282;rport=62928</TT><BR>
<TT> From: "Keith PhoneADSL" <<A HREF="sip:27878050000@196.222.3.4">sip:27878050000@196.222.3.4</A>>;tag=3283506127</TT><BR>
<TT> To: <<A HREF="sip:0835551111@196.222.3.4">sip:0835551111@196.222.3.4</A>>;user=phone;tag=g2DFFpS0QN4cc</TT><BR>
<TT> Call-ID: <A HREF="mailto:4252084844@192_168_1_65">4252084844@192_168_1_65</A></TT><BR>
<TT> CSeq: 3 INVITE</TT><BR>
<TT> Contact: <<A HREF="sip:0835551111@196.222.3.4:5060">sip:0835551111@196.222.3.4:5060</A>;transport=udp></TT><BR>
<TT> User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-15183M</TT><BR>
<TT> Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, REGISTER, REFER, UPDATE, NOTIFY</TT><BR>
<TT> Supported: timer, precondition, path, replaces</TT><BR>
<TT> Allow-Events: talk, refer</TT><BR>
<TT> Session-Expires: 120;refresher=uas</TT><BR>
<TT> Min-SE: 120</TT><BR>
<TT> Content-Type: application/sdp</TT><BR>
<TT> Content-Disposition: session</TT><BR>
<TT> Content-Length: 249</TT><BR>
<TT> X-Actually-Support: UPDATE</TT><BR>
<TT> </TT><BR>
<TT> v=0</TT><BR>
<TT> o=FreeSWITCH 1256114608 1256114609 IN IP4 196.222.3.4</TT><BR>
<TT> s=FreeSWITCH</TT><BR>
<TT> c=IN IP4 196.222.3.4</TT><BR>
<TT> t=0 0</TT><BR>
<TT> m=audio 16840 RTP/AVP 18 101</TT><BR>
<TT> a=rtpmap:18 G729/8000</TT><BR>
<TT> a=rtpmap:101 telephone-event/8000</TT><BR>
<TT> a=fmtp:101 0-16</TT><BR>
<TT> a=silenceSupp:off - - - -</TT><BR>
<TT> a=ptime:20</TT><BR>
<TT> ------------------------------------------------------------------------</TT><BR>
<TT>2009-10-21 15:24:14.204823 [DEBUG] sofia.c:3493 Channel sofia/inetticky/27878050000@196.222.3.4 entering state [completed][200]</TT><BR>
<TT>2009-10-21 15:24:14.224959 [DEBUG] sofia.c:407 sofia/vvrf/27835551111 receive message [DISPLAY]</TT><BR>
<TT>send 947 bytes to udp/[196.10.11.12]:5060 at 13:24:14.225162:</TT><BR>
<TT> ------------------------------------------------------------------------</TT><BR>
<TT> UPDATE sip:196.10.11.12:5060 SIP/2.0</TT><BR>
<TT> Via: SIP/2.0/UDP 10.17.10.10;rport;branch=z9hG4bK0907gKScctXac</TT><BR>
<TT> Max-Forwards: 70</TT><BR>
<TT> From: "Keith PhoneADSL" <<A HREF="sip:878050000@10.17.10.10">sip:878050000@10.17.10.10</A>>;tag=Upa3NvXpBB1eF</TT><BR>
<TT> To: <<A HREF="sip:27835551111@196.10.11.12">sip:27835551111@196.10.11.12</A>>;tag=GR52RWG346-34</TT><BR>
<TT> Call-ID: d821359d-38e7-122d-a38e-002264cc9b93</TT><BR>
<TT> CSeq: 121947387 UPDATE</TT><BR>
<TT> Contact: <<A HREF="sip:gw+vprov@10.17.10.10:5060">sip:gw+vprov@10.17.10.10:5060</A>;transport=udp;gw=vprov></TT><BR>
<TT> User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-15183M</TT><BR>
<TT> Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, REGISTER, REFER, UPDATE, NOTIFY</TT><BR>
<TT> Supported: timer, precondition, path, replaces</TT><BR>
<TT> Content-Type: application/sdp</TT><BR>
<TT> Content-Disposition: session</TT><BR>
<TT> Content-Length: 247</TT><BR>
<TT> P-Asserted-Identity: "unknown" <27835551111></TT><BR>
<TT> </TT><BR>
<TT> v=0</TT><BR>
<TT> o=FreeSWITCH 1256118582 1256118583 IN IP4 10.17.10.10</TT><BR>
<TT> s=FreeSWITCH</TT><BR>
<TT> c=IN IP4 10.17.10.10</TT><BR>
<TT> t=0 0</TT><BR>
<TT> m=audio 12862 RTP/AVP 18 101</TT><BR>
<TT> a=rtpmap:18 G729/8000</TT><BR>
<TT> a=rtpmap:101 telephone-event/8000</TT><BR>
<TT> a=fmtp:101 0-16</TT><BR>
<TT> a=silenceSupp:off - - - -</TT><BR>
<TT> a=ptime:20</TT><BR>
<TT> ------------------------------------------------------------------------</TT><BR>
<TT>2009-10-21 15:24:14.224959 [DEBUG] sofia.c:3493 Channel sofia/vvrf/27835551111 entering state [calling][0]</TT><BR>
<TT>recv 733 bytes from udp/[41.242.6.167]:62928 at 13:24:14.533488:</TT><BR>
<TT> ------------------------------------------------------------------------</TT><BR>
<TT> ACK sip:0835551111@196.222.3.4:5060;transport=udp SIP/2.0</TT><BR>
<TT> Via: SIP/2.0/UDP 41.242.6.167:56675;branch=z9hG4bKd2c91e1afbf0880332fbeba5fc9c04a6;rport</TT><BR>
<TT> From: "Keith PhoneADSL" <<A HREF="sip:27878050000@196.222.3.4">sip:27878050000@196.222.3.4</A>>;tag=3283506127</TT><BR>
<TT> To: <<A HREF="sip:0835551111@196.222.3.4">sip:0835551111@196.222.3.4</A>>;user=phone;tag=g2DFFpS0QN4cc</TT><BR>
<TT> Call-ID: <A HREF="mailto:4252084844@192_168_1_65">4252084844@192_168_1_65</A></TT><BR>
<TT> CSeq: 3 ACK</TT><BR>
<TT> Contact: <<A HREF="sip:27878050000@41.242.6.167:56675">sip:27878050000@41.242.6.167:56675</A>></TT><BR>
<TT> Proxy-Authorization: Digest username="27878050000", realm="196.222.3.4", qop=auth, algorithm=MD5, uri="sip:0835551111@196.222.3.4", nonce="0092f192-be45-11de-a2c1-a70e5037c20e", nc=00000001, cnonce="ab2d49987adb74997fc6b236fc16d23", response="445ae74c1f910e45d9aa1043402b4dbb"</TT><BR>
<TT> Max-Forwards: 70</TT><BR>
<TT> User-Agent: C455 IP021910000000</TT><BR>
<TT> Content-Length: 0</TT><BR>
<TT> </TT><BR>
<TT> ------------------------------------------------------------------------</TT><BR>
<TT>2009-10-21 15:24:14.533538 [DEBUG] sofia.c:3493 Channel sofia/inetticky/27878050000@196.222.3.4 entering state [ready][200]</TT><BR>
<TT>2009-10-21 15:24:14.545161 [DEBUG] switch_core_session.c:712 Send signal sofia/vvrf/27835551111 [BREAK]</TT><BR>
<TT>2009-10-21 15:24:14.545161 [DEBUG] switch_core_session.c:712 Send signal sofia/inetticky/27878050000@196.222.3.4 [BREAK]</TT><BR>
<TT>2009-10-21 15:24:14.565231 [DEBUG] switch_ivr_bridge.c:122 sofia/vvrf/27835551111 receive message [DISPLAY]</TT><BR>
<TT>2009-10-21 15:24:14.565231 [DEBUG] switch_ivr_bridge.c:122 sofia/inetticky/27878050000@196.222.3.4 receive message [DISPLAY]</TT><BR>
<TT>send 947 bytes to udp/[196.10.11.12]:5060 at 13:24:14.727678:</TT><BR>
<TT> ------------------------------------------------------------------------</TT><BR>
<TT> UPDATE sip:196.10.11.12:5060 SIP/2.0</TT><BR>
<TT> Via: SIP/2.0/UDP 10.17.10.10;rport;branch=z9hG4bK0907gKScctXac</TT><BR>
<TT> Max-Forwards: 70</TT><BR>
<TT> From: "Keith PhoneADSL" <<A HREF="sip:878050000@10.17.10.10">sip:878050000@10.17.10.10</A>>;tag=Upa3NvXpBB1eF</TT><BR>
<TT> To: <<A HREF="sip:27835551111@196.10.11.12">sip:27835551111@196.10.11.12</A>>;tag=GR52RWG346-34</TT><BR>
<TT> Call-ID: d821359d-38e7-122d-a38e-002264cc9b93</TT><BR>
<TT> CSeq: 121947387 UPDATE</TT><BR>
<TT> Contact: <<A HREF="sip:gw+vprov@10.17.10.10:5060">sip:gw+vprov@10.17.10.10:5060</A>;transport=udp;gw=vprov></TT><BR>
<TT> User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-15183M</TT><BR>
<TT> Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, REGISTER, REFER, UPDATE, NOTIFY</TT><BR>
<TT> Supported: timer, precondition, path, replaces</TT><BR>
<TT> Content-Type: application/sdp</TT><BR>
<TT> Content-Disposition: session</TT><BR>
<TT> Content-Length: 247</TT><BR>
<TT> P-Asserted-Identity: "unknown" <27835551111></TT><BR>
<TT> </TT><BR>
<TT> v=0</TT><BR>
<TT> o=FreeSWITCH 1256118582 1256118583 IN IP4 10.17.10.10</TT><BR>
<TT> s=FreeSWITCH</TT><BR>
<TT> c=IN IP4 10.17.10.10</TT><BR>
<TT> t=0 0</TT><BR>
<TT> m=audio 12862 RTP/AVP 18 101</TT><BR>
<TT> a=rtpmap:18 G729/8000</TT><BR>
<TT> a=rtpmap:101 telephone-event/8000</TT><BR>
<TT> a=fmtp:101 0-16</TT><BR>
<TT> a=silenceSupp:off - - - -</TT><BR>
<TT> a=ptime:20</TT><BR>
<TT> ------------------------------------------------------------------------</TT><BR>
<TT>send 947 bytes to udp/[196.10.11.12]:5060 at 13:24:15.728255:</TT><BR>
<TT> ------------------------------------------------------------------------</TT><BR>
<TT> UPDATE sip:196.10.11.12:5060 SIP/2.0</TT><BR>
<TT> Via: SIP/2.0/UDP 10.17.10.10;rport;branch=z9hG4bK0907gKScctXac</TT><BR>
<TT> Max-Forwards: 70</TT><BR>
<TT> From: "Keith PhoneADSL" <<A HREF="sip:878050000@10.17.10.10">sip:878050000@10.17.10.10</A>>;tag=Upa3NvXpBB1eF</TT><BR>
<TT> To: <<A HREF="sip:27835551111@196.10.11.12">sip:27835551111@196.10.11.12</A>>;tag=GR52RWG346-34</TT><BR>
<TT> Call-ID: d821359d-38e7-122d-a38e-002264cc9b93</TT><BR>
<TT> CSeq: 121947387 UPDATE</TT><BR>
<TT> Contact: <<A HREF="sip:gw+vprov@10.17.10.10:5060">sip:gw+vprov@10.17.10.10:5060</A>;transport=udp;gw=vprov></TT><BR>
<TT> User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-15183M</TT><BR>
<TT> Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, REGISTER, REFER, UPDATE, NOTIFY</TT><BR>
<TT> Supported: timer, precondition, path, replaces</TT><BR>
<TT> Content-Type: application/sdp</TT><BR>
<TT> Content-Disposition: session</TT><BR>
<TT> Content-Length: 247</TT><BR>
<TT> P-Asserted-Identity: "unknown" <27835551111></TT><BR>
<TT> </TT><BR>
<TT> v=0</TT><BR>
<TT> o=FreeSWITCH 1256118582 1256118583 IN IP4 10.17.10.10</TT><BR>
<TT> s=FreeSWITCH</TT><BR>
<TT> c=IN IP4 10.17.10.10</TT><BR>
<TT> t=0 0</TT><BR>
<TT> m=audio 12862 RTP/AVP 18 101</TT><BR>
<TT> a=rtpmap:18 G729/8000</TT><BR>
<TT> a=rtpmap:101 telephone-event/8000</TT><BR>
<TT> a=fmtp:101 0-16</TT><BR>
<TT> a=silenceSupp:off - - - -</TT><BR>
<TT> a=ptime:20</TT><BR>
<BR>
[Many more copies of the UPDATE's continue ... then ]<BR>
<BR>
2009-10-21 15:24:46.228024 [DEBUG] sofia.c:3493 Channel sofia/vvrf/27835551111 entering state [terminated][408]<BR>
2009-10-21 15:24:46.228024 [NOTICE] sofia.c:4039 Hangup sofia/vvrf/27835551111 [CS_EXCHANGE_MEDIA] [RECOVERY_ON_TIMER_EXPIRE]<BR>
2009-10-21 15:24:46.228024 [DEBUG] switch_channel.c:1896 Send signal sofia/vvrf/27835551111 [KILL] <BR>
<BR>
</BODY>
</HTML>