Hi All,

I am testing the FS behavior receiving the SIP UPDATE message in a SIP to SIP call in early media state

for media modification.

FS does not negotiate end to end the UPDATE/SDP offer but answer 200 OK locally with the SDP answer.

In addition It seems that UPDATE doesn’t have any impact on media handling.

These are two examples:

-          UPDATE with codec modification: result –> 200OK with SDP answer without audio codec

-          UPDATE with IP address modification -> 200 OK SDP answer

Do you know if FS support UPDATE for media modification?

Below the full log.

Thanks

Alessandro

UPDATE with codec modification

freeswitch@internal> recv 818 bytes from udp/[138.132.110.64]:5065 at 08:10:45.038063:
   ------------------------------------------------------------------------
   INVITE sip:1001@138.132.105.40 SIP/2.0
   Via: SIP/2.0/UDP 138.132.110.64:5065;branch=z9hG4bKxTP2KbyJab0564
   To: "1001" <sip:1001@138.132.105.40>
   From: "1000" <sip:1000@138.132.105.40>;tag=3bad0564
   Call-ID: 05646d49df5d85548e08b348fa46b455@138.132.110.64
   CSeq: 1 INVITE
   Max-Forwards: 70
   Contact: "1000" <sip:1000@138.132.110.64:5065>
   User-Agent: SIP TP2000 Emu (Build: 240464)
   Allow: INVITE, ACK, PRACK, CANCEL, BYE, OPTIONS, MESSAGE, NOTIFY, UPDATE, REGISTER, INFO, REFER, SUBSCRIBE
   Supported: 100rel
   Content-Type: application/sdp
   Content-Length: 255

   v=0
   o=TI-WLAN-PHONE 0 0 IN IP4 138.132.110.64
   s=TI-WLAN-CALL
   c=IN IP4 138.132.110.64
   t=0 0
   m=audio 10136 RTP/AVP 8 18 101 102
   a=rtpmap:8 PCMA/8000
   a=rtpmap:18 G729/8000
   a=rtpmap:102 G.729a/8000
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-15
   ------------------------------------------------------------------------
send 331 bytes to udp/[138.132.110.64]:5065 at 08:10:45.047354:
   ------------------------------------------------------------------------
   SIP/2.0 100 Trying
   Via: SIP/2.0/UDP 138.132.110.64:5065;branch=z9hG4bKxTP2KbyJab0564
   From: "1000" <sip:1000@138.132.105.40>;tag=3bad0564
   To: "1001" <sip:1001@138.132.105.40>
   Call-ID: 05646d49df5d85548e08b348fa46b455@138.132.110.64
   CSeq: 1 INVITE
   User-Agent: Italtel-WeGate/HW_V1.0.0/FW_V1.0.0/SW_V1.0.0
   Content-Length: 0

   ------------------------------------------------------------------------
1970-01-06 08:10:45.041214 [NOTICE] switch_channel.c:920 New Channel sofia/external/1000@138.132.105.40 [6837d3fd-27eb-4832-9835-6cf7074dc859]
1970-01-06 08:10:45.060669 [DEBUG] switch_core_state_machine.c:362 (sofia/external/1000@138.132.105.40) Running State Change CS_NEW
1970-01-06 08:10:45.060669 [DEBUG] switch_core_state_machine.c:380 (sofia/external/1000@138.132.105.40) State NEW
1970-01-06 08:10:45.060669 [DEBUG] sofia.c:5390 Channel sofia/external/1000@138.132.105.40 entering state [received][100]
1970-01-06 08:10:45.060669 [DEBUG] sofia.c:5401 Remote SDP:
v=0
o=TI-WLAN-PHONE 0 0 IN IP4 138.132.110.64
s=TI-WLAN-CALL
c=IN IP4 138.132.110.64
t=0 0
m=audio 10136 RTP/AVP 8 18 101 102
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=rtpmap:102 G.729a/8000

1970-01-06 08:10:45.060669 [DEBUG] sofia.c:5594 (sofia/external/1000@138.132.105.40) State Change CS_NEW -> CS_INIT
1970-01-06 08:10:45.060669 [DEBUG] switch_core_session.c:1177 Send signal sofia/external/1000@138.132.105.40 [BREAK]
1970-01-06 08:10:45.060669 [DEBUG] switch_core_state_machine.c:362 (sofia/external/1000@138.132.105.40) Running State Change CS_INIT
1970-01-06 08:10:45.060669 [DEBUG] switch_core_state_machine.c:401 (sofia/external/1000@138.132.105.40) State INIT
1970-01-06 08:10:45.060669 [DEBUG] mod_sofia.c:85 sofia/external/1000@138.132.105.40 SOFIA INIT
1970-01-06 08:10:45.060669 [DEBUG] mod_sofia.c:125 (sofia/external/1000@138.132.105.40) State Change CS_INIT -> CS_ROUTING
1970-01-06 08:10:45.060669 [DEBUG] switch_core_session.c:1177 Send signal sofia/external/1000@138.132.105.40 [BREAK]
1970-01-06 08:10:45.060669 [DEBUG] switch_core_state_machine.c:401 (sofia/external/1000@138.132.105.40) State INIT going to sleep
1970-01-06 08:10:45.060669 [DEBUG] switch_core_state_machine.c:362 (sofia/external/1000@138.132.105.40) Running State Change CS_ROUTING
1970-01-06 08:10:45.060669 [DEBUG] switch_channel.c:1871 (sofia/external/1000@138.132.105.40) Callstate Change DOWN -> RINGING
1970-01-06 08:10:45.060669 [DEBUG] switch_core_state_machine.c:410 (sofia/external/1000@138.132.105.40) State ROUTING
1970-01-06 08:10:45.060669 [DEBUG] mod_sofia.c:148 sofia/external/1000@138.132.105.40 SOFIA ROUTING
1970-01-06 08:10:45.060669 [DEBUG] switch_core_state_machine.c:104 sofia/external/1000@138.132.105.40 Standard ROUTING
1970-01-06 08:10:45.060669 [INFO] mod_dialplan_xml.c:481 Processing 1000 <1000>->1001 in context public
Dialplan: sofia/external/1000@138.132.105.40 parsing [public->dial_from_gateway1] continue=false
Dialplan: sofia/external/1000@138.132.105.40 Regex (FAIL) [dial_from_gateway1] destination_number(1001) =~ /1000/ break=on-false
Dialplan: sofia/external/1000@138.132.105.40 parsing [public->dial_from_gateway1] continue=false
Dialplan: sofia/external/1000@138.132.105.40 Regex (PASS) [dial_from_gateway1] destination_number(1001) =~ /1001/ break=on-false
Dialplan: sofia/external/1000@138.132.105.40 Action set(call_timeout=400)
Dialplan: sofia/external/1000@138.132.105.40 Action set(inherit_codec=true)
Dialplan: sofia/external/1000@138.132.105.40 Action bridge(sofia/external/1001@138.132.110.64:5070)
1970-01-06 08:10:45.101525 [DEBUG] switch_core_state_machine.c:154 (sofia/external/1000@138.132.105.40) State Change CS_ROUTING -> CS_EXECUTE
1970-01-06 08:10:45.101525 [DEBUG] switch_core_session.c:1177 Send signal sofia/external/1000@138.132.105.40 [BREAK]
1970-01-06 08:10:45.101525 [DEBUG] switch_core_state_machine.c:410 (sofia/external/1000@138.132.105.40) State ROUTING going to sleep
1970-01-06 08:10:45.101525 [DEBUG] switch_core_state_machine.c:362 (sofia/external/1000@138.132.105.40) Running State Change CS_EXECUTE
1970-01-06 08:10:45.101525 [DEBUG] switch_core_state_machine.c:417 (sofia/external/1000@138.132.105.40) State EXECUTE
1970-01-06 08:10:45.101525 [DEBUG] mod_sofia.c:241 sofia/external/1000@138.132.105.40 SOFIA EXECUTE
1970-01-06 08:10:45.101525 [DEBUG] switch_core_state_machine.c:192 sofia/external/1000@138.132.105.40 Standard EXECUTE
EXECUTE sofia/external/1000@138.132.105.40 set(call_timeout=400)
1970-01-06 08:10:45.101525 [DEBUG] mod_dptools.c:1263 sofia/external/1000@138.132.105.40 SET [call_timeout]=[400]
EXECUTE sofia/external/1000@138.132.105.40 set(inherit_codec=true)
1970-01-06 08:10:45.101525 [DEBUG] mod_dptools.c:1263 sofia/external/1000@138.132.105.40 SET [inherit_codec]=[true]
EXECUTE sofia/external/1000@138.132.105.40 bridge(sofia/external/1001@138.132.110.64:5070)
1970-01-06 08:10:45.101525 [DEBUG] switch_ivr_originate.c:1884 Parsing global variables
1970-01-06 08:10:45.101525 [NOTICE] switch_channel.c:920 New Channel sofia/external/1001@138.132.110.64:5070 [478e7aac-980d-43b5-834a-4f9e38102547]
1970-01-06 08:10:45.101525 [DEBUG] mod_sofia.c:4539 (sofia/external/1001@138.132.110.64:5070) State Change CS_NEW -> CS_INIT
1970-01-06 08:10:45.101525 [DEBUG] switch_core_session.c:1177 Send signal sofia/external/1001@138.132.110.64:5070 [BREAK]
1970-01-06 08:10:45.101525 [DEBUG] switch_core_state_machine.c:362 (sofia/external/1001@138.132.110.64:5070) Running State Change CS_INIT
1970-01-06 08:10:45.101525 [DEBUG] switch_core_state_machine.c:401 (sofia/external/1001@138.132.110.64:5070) State INIT
1970-01-06 08:10:45.101525 [DEBUG] mod_sofia.c:85 sofia/external/1001@138.132.110.64:5070 SOFIA INIT
1970-01-06 08:10:45.141164 [DEBUG] mod_sofia.c:125 (sofia/external/1001@138.132.110.64:5070) State Change CS_INIT -> CS_ROUTING
1970-01-06 08:10:45.141164 [DEBUG] switch_core_session.c:1177 Send signal sofia/external/1001@138.132.110.64:5070 [BREAK]
1970-01-06 08:10:45.141164 [DEBUG] switch_core_state_machine.c:401 (sofia/external/1001@138.132.110.64:5070) State INIT going to sleep
1970-01-06 08:10:45.141164 [DEBUG] switch_core_state_machine.c:362 (sofia/external/1001@138.132.110.64:5070) Running State Change CS_ROUTING
1970-01-06 08:10:45.141164 [DEBUG] switch_channel.c:1871 (sofia/external/1001@138.132.110.64:5070) Callstate Change DOWN -> RINGING
send 1033 bytes to udp/[138.132.110.64]:5070 at 08:10:45.152568:
   ------------------------------------------------------------------------
   INVITE sip:1001@138.132.110.64:5070 SIP/2.0
   Via: SIP/2.0/UDP 138.132.105.40;rport;branch=z9hG4bK5FS2tNSXeU48a
   Max-Forwards: 69
   From: "1000" <sip:1000@138.132.105.40>;tag=gX2j9p6vFN8BN
   To: <sip:1001@138.132.110.64:5070>
   Call-ID: 4d9c002d-9ca7-1200-1ca0-0020da862374
   CSeq: 30983298 INVITE
   Contact: <sip:mod_sofia@138.132.105.40:5060>
   User-Agent: Italtel-WeGate/HW_V1.0.0/FW_V1.0.0/SW_V1.0.0
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, PRACK, NOTIFY
   Supported: 100rel, precondition, path, replaces
   Allow-Events: talk, hold, refer
   Content-Type: application/sdp
   Content-Disposition: session
   Content-Length: 254
   X-FS-Support: update_display
   Remote-Party-ID: "1000" <sip:1000@138.132.105.40>;party=calling;screen=yes;privacy=off

   v=0
   o=FreeSWITCH 436277 436278 IN IP4 138.132.105.40
   s=FreeSWITCH
   c=IN IP4 138.132.105.40
   t=0 0
   m=audio 25168 RTP/AVP 8 18 98 101 13
   a=rtpmap:98 AMR-WB/16000
   a=fmtp:98 octet-align=0
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-16
   a=ptime:20
   ------------------------------------------------------------------------
1970-01-06 08:10:45.141164 [DEBUG] switch_core_session.c:872 Send signal sofia/external/1001@138.132.110.64:5070 [BREAK]
1970-01-06 08:10:45.141164 [DEBUG] switch_core_state_machine.c:410 (sofia/external/1001@138.132.110.64:5070) State ROUTING
1970-01-06 08:10:45.141164 [DEBUG] mod_sofia.c:148 sofia/external/1001@138.132.110.64:5070 SOFIA ROUTING
1970-01-06 08:10:45.141164 [DEBUG] switch_ivr_originate.c:66 (sofia/external/1001@138.132.110.64:5070) State Change CS_ROUTING -> CS_CONSUME_MEDIA
1970-01-06 08:10:45.141164 [DEBUG] switch_core_session.c:1177 Send signal sofia/external/1001@138.132.110.64:5070 [BREAK]
1970-01-06 08:10:45.141164 [DEBUG] switch_core_state_machine.c:410 (sofia/external/1001@138.132.110.64:5070) State ROUTING going to sleep
1970-01-06 08:10:45.141164 [DEBUG] switch_core_state_machine.c:362 (sofia/external/1001@138.132.110.64:5070) Running State Change CS_CONSUME_MEDIA
1970-01-06 08:10:45.141164 [DEBUG] switch_core_state_machine.c:429 (sofia/external/1001@138.132.110.64:5070) State CONSUME_MEDIA
1970-01-06 08:10:45.141164 [DEBUG] switch_core_state_machine.c:429 (sofia/external/1001@138.132.110.64:5070) State CONSUME_MEDIA going to sleep
1970-01-06 08:10:45.141164 [DEBUG] sofia.c:5390 Channel sofia/external/1001@138.132.110.64:5070 entering state [calling][0]
recv 299 bytes from udp/[138.132.110.64]:5070 at 08:10:45.281081:
   ------------------------------------------------------------------------
   SIP/2.0 100 Trying
   Via: SIP/2.0/UDP 138.132.105.40;rport;branch=z9hG4bK5FS2tNSXeU48a
   To: <sip:1001@138.132.110.64:5070>
   From: "1000" <sip:1000@138.132.105.40>;tag=gX2j9p6vFN8BN
   Call-ID: 4d9c002d-9ca7-1200-1ca0-0020da862374
   CSeq: 30983298 INVITE
   User Agent: TP2000 By JAB
   Content-Length: 0

   ------------------------------------------------------------------------
recv 682 bytes from udp/[138.132.110.64]:5070 at 08:10:45.285542:
   ------------------------------------------------------------------------
   SIP/2.0 183 Session Progress
   Via: SIP/2.0/UDP 138.132.105.40;rport;branch=z9hG4bK5FS2tNSXeU48a
   To: <sip:1001@138.132.110.64:5070>;tag=beef4243
   From: "1000" <sip:1000@138.132.105.40>;tag=gX2j9p6vFN8BN
   Call-ID: 4d9c002d-9ca7-1200-1ca0-0020da862374
   CSeq: 30983298 INVITE
   Contact: <sip:1001@138.132.110.64:5070>
   Allow: INVITE, ACK, PRACK, CANCEL, BYE, OPTIONS, MESSAGE, NOTIFY, UPDATE, REGISTER, INFO, REFER, SUBSCRIBE
   Require: 100rel
   RSeq: 84
   Content-Type: application/sdp
   Content-Length: 178

   v=0
   o=TI-WLAN-PHONE 0 1 IN IP4 138.132.110.64
   s=TI-WLAN-CALL
   c=IN IP4 138.132.110.64
   t=0 0
   m=audio 10136 RTP/AVP 18 101
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-15
   ------------------------------------------------------------------------
send 602 bytes to udp/[138.132.110.64]:5070 at 08:10:45.288805:
   ------------------------------------------------------------------------
   PRACK sip:1001@138.132.110.64:5070 SIP/2.0
   Via: SIP/2.0/UDP 138.132.105.40;rport;branch=z9hG4bKyNFXv3H4a4XBD
   Max-Forwards: 70
   From: "1000" <sip:1000@138.132.105.40>;tag=gX2j9p6vFN8BN
   To: <sip:1001@138.132.110.64:5070>;tag=beef4243
   Call-ID: 4d9c002d-9ca7-1200-1ca0-0020da862374
   CSeq: 30983299 PRACK
   Contact: <sip:mod_sofia@138.132.105.40:5060>
   RAck: 84 30983298 INVITE
   User-Agent: Italtel-WeGate/HW_V1.0.0/FW_V1.0.0/SW_V1.0.0
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, PRACK, NOTIFY
   Supported: 100rel, precondition, path, replaces
   Content-Length: 0

   ------------------------------------------------------------------------
1970-01-06 08:10:45.281994 [DEBUG] switch_core_session.c:872 Send signal sofia/external/1001@138.132.110.64:5070 [BREAK]
1970-01-06 08:10:45.281994 [DEBUG] switch_core_session.c:872 Send signal sofia/external/1001@138.132.110.64:5070 [BREAK]
1970-01-06 08:10:45.281994 [DEBUG] sofia.c:5390 Channel sofia/external/1001@138.132.110.64:5070 entering state [proceeding][183]
1970-01-06 08:10:45.281994 [DEBUG] sofia.c:5401 Remote SDP:
v=0
o=TI-WLAN-PHONE 0 1 IN IP4 138.132.110.64
s=TI-WLAN-CALL
c=IN IP4 138.132.110.64
t=0 0
m=audio 10136 RTP/AVP 18 101
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

1970-01-06 08:10:45.281994 [DEBUG] sofia.c:5516

[GIO] sofia_handle_sip_i_state() :

1970-01-06 08:10:45.281994 [DEBUG] sofia_glue.c:3904

[GIO] sofia_glue_tech_media() :

1970-01-06 08:10:45.281994 [DEBUG] sofia_glue.c:4304

[GIO] sofia_glue_negotiate_sdp() :

1970-01-06 08:10:45.281994 [DEBUG] sofia_glue.c:4768 Audio Codec Compare [G729:18:8000:20:8000]/[PCMA:8:8000:20:64000]
1970-01-06 08:10:45.281994 [DEBUG] sofia_glue.c:4768 Audio Codec Compare [G729:18:8000:20:8000]/[G729:18:8000:20:8000]
1970-01-06 08:10:45.281994 [DEBUG] sofia_glue.c:2887 Set Codec sofia/external/1001@138.132.110.64:5070 G729/8000 20 ms 160 samples 8000 bits
1970-01-06 08:10:45.300933 [DEBUG] sofia_glue.c:4882 Set 2833 dtmf send payload to 101
1970-01-06 08:10:45.300933 [DEBUG] sofia_glue.c:3139 AUDIO RTP [sofia/external/1001@138.132.110.64:5070] 138.132.105.40 port 25168 -> 138.132.110.64 port 10136 codec: 18 ms: 20
1970-01-06 08:10:45.300933 [DEBUG] switch_rtp.c:1642 Starting timer [soft] 160 bytes per 20ms
1970-01-06 08:10:45.300933 [DEBUG] sofia_glue.c:3403 Set 2833 dtmf send payload to 101
1970-01-06 08:10:45.300933 [DEBUG] sofia_glue.c:3409 Set 2833 dtmf receive payload to 101
1970-01-06 08:10:45.300933 [NOTICE] sofia_glue.c:3915 Pre-Answer sofia/external/1001@138.132.110.64:5070!
1970-01-06 08:10:45.300933 [DEBUG] switch_channel.c:2917 (sofia/external/1001@138.132.110.64:5070) Callstate Change RINGING -> EARLY
1970-01-06 08:10:45.340087 [DEBUG] switch_ivr_originate.c:405 Setting codec string on sofia/external/1000@138.132.105.40 to G729@8000h@20i
1970-01-06 08:10:45.340087 [INFO] switch_ivr_originate.c:3215 Sending early media
1970-01-06 08:10:45.340087 [DEBUG] sofia_glue.c:3904

[GIO] sofia_glue_tech_media() :

1970-01-06 08:10:45.340087 [DEBUG] sofia_glue.c:4304

[GIO] sofia_glue_negotiate_sdp() :

1970-01-06 08:10:45.340087 [DEBUG] sofia_glue.c:4768 Audio Codec Compare [PCMA:8:8000:20:64000]/[G729:18:8000:20:8000]
1970-01-06 08:10:45.340087 [DEBUG] sofia_glue.c:4768 Audio Codec Compare [G729:18:8000:20:8000]/[G729:18:8000:20:8000]
1970-01-06 08:10:45.340087 [DEBUG] sofia_glue.c:2887 Set Codec sofia/external/1000@138.132.105.40 G729/8000 20 ms 160 samples 8000 bits
1970-01-06 08:10:45.340087 [DEBUG] sofia_glue.c:4889 Set 2833 dtmf send/recv payload to 101
1970-01-06 08:10:45.340087 [DEBUG] sofia_glue.c:3139 AUDIO RTP [sofia/external/1000@138.132.105.40] 138.132.105.40 port 18270 -> 138.132.110.64 port 10136 codec: 18 ms: 20
1970-01-06 08:10:45.340087 [DEBUG] switch_rtp.c:1642 Starting timer [soft] 160 bytes per 20ms
1970-01-06 08:10:45.360383 [DEBUG] sofia_glue.c:3403 Set 2833 dtmf send payload to 101
1970-01-06 08:10:45.360383 [DEBUG] sofia_glue.c:3409 Set 2833 dtmf receive payload to 101
1970-01-06 08:10:45.360383 [NOTICE] sofia_glue.c:3915 Pre-Answer sofia/external/1000@138.132.105.40!
1970-01-06 08:10:45.360383 [DEBUG] switch_channel.c:2917 (sofia/external/1000@138.132.105.40) Callstate Change RINGING -> EARLY
1970-01-06 08:10:45.420089 [DEBUG] switch_channel.c:2959 Send signal sofia/external/1000@138.132.105.40 [BREAK]
1970-01-06 08:10:45.420089 [DEBUG] mod_sofia.c:2500 Ring SDP:
v=0
o=FreeSWITCH 0000443175 0000443176 IN IP4 138.132.105.40
s=FreeSWITCH
c=IN IP4 138.132.105.40
t=0 0
m=audio 18270 RTP/AVP 18 101
a=rtpmap:18 G729/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv

send 1048 bytes to udp/[138.132.110.64]:5065 at 08:10:45.428139:
   ------------------------------------------------------------------------
   SIP/2.0 183 Session Progress
   Via: SIP/2.0/UDP 138.132.110.64:5065;branch=z9hG4bKxTP2KbyJab0564
   From: "1000" <sip:1000@138.132.105.40>;tag=3bad0564
   To: "1001" <sip:1001@138.132.105.40>;tag=QQcp78HpKcF9j
   Call-ID: 05646d49df5d85548e08b348fa46b455@138.132.110.64
   CSeq: 1 INVITE
   Contact: <sip:1001@138.132.105.40:5060;transport=udp>
   RSeq: 1101569577
   User-Agent: Italtel-WeGate/HW_V1.0.0/FW_V1.0.0/SW_V1.0.0
   Accept: application/sdp
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, PRACK, NOTIFY
   Require: 100rel
   Supported: 100rel, precondition, path, replaces
   Allow-Events: talk, hold, refer
   Content-Type: application/sdp
   Content-Disposition: session
   Content-Length: 245
   Remote-Party-ID: "1001" <sip:1001@138.132.105.40>;party=calling;privacy=off;screen=no

   v=0
   o=FreeSWITCH 443175 443176 IN IP4 138.132.105.40
   s=FreeSWITCH
   c=IN IP4 138.132.105.40
   t=0 0
   m=audio 18270 RTP/AVP 18 101
   a=rtpmap:18 G729/8000
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-16
   a=silenceSupp:off - - - -
   a=ptime:20
   ------------------------------------------------------------------------
1970-01-06 08:10:45.420089 [DEBUG] switch_core_session.c:872 Send signal sofia/external/1000@138.132.105.40 [BREAK]
recv 367 bytes from udp/[138.132.110.64]:5065 at 08:10:45.436792:
   ------------------------------------------------------------------------
   PRACK sip:1001@138.132.105.40:5060;transport=udp SIP/2.0
   Via: SIP/2.0/UDP 138.132.110.64:5065;branch=z9hG4bKe27d3961
   To: "1001" <sip:1001@138.132.105.40>;tag=QQcp78HpKcF9j
   From: "1000" <sip:1000@138.132.105.40>;tag=3bad0564
   Call-ID: 05646d49df5d85548e08b348fa46b455@138.132.110.64
   CSeq: 2 PRACK
   Max-Forwards: 70
   RAck: 1101569577 1 INVITE
   Content-Length: 0

   ------------------------------------------------------------------------
send 564 bytes to udp/[138.132.110.64]:5065 at 08:10:45.438378:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP 138.132.110.64:5065;branch=z9hG4bKe27d3961
   From: "1000" <sip:1000@138.132.105.40>;tag=3bad0564
   To: "1001" <sip:1001@138.132.105.40>;tag=QQcp78HpKcF9j
   Call-ID: 05646d49df5d85548e08b348fa46b455@138.132.110.64
   CSeq: 2 PRACK
   Contact: <sip:1001@138.132.105.40:5060;transport=udp>
   User-Agent: Italtel-WeGate/HW_V1.0.0/FW_V1.0.0/SW_V1.0.0
   Accept: application/sdp
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, PRACK, NOTIFY
   Supported: 100rel, precondition, path, replaces
   Content-Length: 0

   ------------------------------------------------------------------------
1970-01-06 08:10:45.420089 [DEBUG] switch_core_session.c:872 Send signal sofia/external/1000@138.132.105.40 [BREAK]
recv 339 bytes from udp/[138.132.110.64]:5070 at 08:10:45.440556:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Call-ID: 4d9c002d-9ca7-1200-1ca0-0020da862374
   Via: SIP/2.0/UDP 138.132.105.40;rport;branch=z9hG4bKyNFXv3H4a4XBD
   To: <sip:1001@138.132.110.64:5070>;tag=beef4243
   From: "1000" <sip:1000@138.132.105.40>;tag=gX2j9p6vFN8BN
   CSeq: 30983299 PRACK
   Contact: <sip:1001@138.132.110.64:5070>
   Max-Forwards: 70
   Content-Length: 0

   ------------------------------------------------------------------------
1970-01-06 08:10:45.442044 [DEBUG] switch_core_session.c:872 Send signal sofia/external/1001@138.132.110.64:5070 [BREAK]
1970-01-06 08:10:45.442044 [DEBUG] sofia.c:5383 Channel sofia/external/1000@138.132.105.40 skipping state [early][183]
1970-01-06 08:10:45.442044 [DEBUG] switch_core_session.c:726 Send signal sofia/external/1000@138.132.105.40 [BREAK]
1970-01-06 08:10:45.442044 [DEBUG] switch_ivr_originate.c:3269 Originate Resulted in Success: [sofia/external/1001@138.132.110.64:5070]
1970-01-06 08:10:45.442044 [DEBUG] switch_core_session.c:726 Send signal sofia/external/1001@138.132.110.64:5070 [BREAK]
1970-01-06 08:10:45.442044 [DEBUG] switch_core_session.c:726 Send signal sofia/external/1000@138.132.105.40 [BREAK]
1970-01-06 08:10:45.442044 [DEBUG] switch_ivr_bridge.c:1270 (sofia/external/1001@138.132.110.64:5070) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
1970-01-06 08:10:45.442044 [DEBUG] switch_core_session.c:1177 Send signal sofia/external/1001@138.132.110.64:5070 [BREAK]
1970-01-06 08:10:45.442044 [DEBUG] switch_core_state_machine.c:362 (sofia/external/1001@138.132.110.64:5070) Running State Change CS_EXCHANGE_MEDIA
1970-01-06 08:10:45.442044 [DEBUG] switch_core_state_machine.c:420 (sofia/external/1001@138.132.110.64:5070) State EXCHANGE_MEDIA
1970-01-06 08:10:45.442044 [DEBUG] mod_sofia.c:574 SOFIA EXCHANGE_MEDIA
recv 593 bytes from udp/[138.132.110.64]:5065 at 08:10:46.445851:
   ------------------------------------------------------------------------
   UPDATE sip:1001@138.132.105.40:5060;transport=udp SIP/2.0
   Via: SIP/2.0/UDP 138.132.110.64:5065;branch=z9hG4bKe27d3597
   To: "1001" <sip:1001@138.132.105.40>;tag=QQcp78HpKcF9j
   From: "1000" <sip:1000@138.132.105.40>;tag=3bad0564
   Call-ID: 05646d49df5d85548e08b348fa46b455@138.132.110.64
   CSeq: 3 UPDATE
   Max-Forwards: 70
   Contact: <sip:1000@138.132.110.64:5065>
   Content-Type: application/sdp
   Content-Length: 177

   v=0
   o=TI-WLAN-PHONE 0 2 IN IP4 138.132.110.64
   s=TI-WLAN-CALL
   c=IN IP4 138.132.110.64
   t=0 0
   m=audio 10136 RTP/AVP 8 101
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-15
   ------------------------------------------------------------------------
send 847 bytes to udp/[138.132.110.64]:5065 at 08:10:46.448561:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP 138.132.110.64:5065;branch=z9hG4bKe27d3597
   From: "1000" <sip:1000@138.132.105.40>;tag=3bad0564
   To: "1001" <sip:1001@138.132.105.40>;tag=QQcp78HpKcF9j
   Call-ID: 05646d49df5d85548e08b348fa46b455@138.132.110.64
   CSeq: 3 UPDATE
   Contact: <sip:1001@138.132.105.40:5060;transport=udp>
   User-Agent: Italtel-WeGate/HW_V1.0.0/FW_V1.0.0/SW_V1.0.0
   Accept: application/sdp
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, PRACK, NOTIFY
   Supported: 100rel, precondition, path, replaces
   Content-Type: application/sdp
   Content-Disposition: session
   Content-Length: 219

   v=0
   o=FreeSWITCH 443175 443177 IN IP4 138.132.105.40
   s=FreeSWITCH
   c=IN IP4 138.132.105.40
   t=0 0
   m=audio 18270 RTP/AVP 101
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-16
   a=silenceSupp:off - - - -
   a=ptime:20
   ------------------------------------------------------------------------
1970-01-06 08:10:46.440055 [DEBUG] switch_core_session.c:872 Send signal sofia/external/1000@138.132.105.40 [BREAK]
1970-01-06 08:10:46.460090 [DEBUG] switch_core_session.c:872 Send signal sofia/external/1000@138.132.105.40 [BREAK]
1970-01-06 08:10:46.480073 [DEBUG] sofia.c:5390 Channel sofia/external/1000@138.132.105.40 entering state [early][200]
1970-01-06 08:10:46.480073 [DEBUG] sofia.c:5401 Remote SDP:
v=0
o=TI-WLAN-PHONE 0 2 IN IP4 138.132.110.64
s=TI-WLAN-CALL
c=IN IP4 138.132.110.64
t=0 0
m=audio 10136 RTP/AVP 8 101
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

UPDATE with IP address modification

freeswitch@internal> recv 818 bytes from udp/[138.132.110.64]:5065 at 08:19:06.920845:
   ------------------------------------------------------------------------
   INVITE sip:1001@138.132.105.40 SIP/2.0
   Via: SIP/2.0/UDP 138.132.110.64:5065;branch=z9hG4bKxTP2KbyJab6373
   To: "1001" <sip:1001@138.132.105.40>
   From: "1000" <sip:1000@138.132.105.40>;tag=3bad6373
   Call-ID: 63736d49df5d85548e08b348fa46b455@138.132.110.64
   CSeq: 1 INVITE
   Max-Forwards: 70
   Contact: "1000" <sip:1000@138.132.110.64:5065>
   User-Agent: SIP TP2000 Emu (Build: 240464)
   Allow: INVITE, ACK, PRACK, CANCEL, BYE, OPTIONS, MESSAGE, NOTIFY, UPDATE, REGISTER, INFO, REFER, SUBSCRIBE
   Supported: 100rel
   Content-Type: application/sdp
   Content-Length: 255

   v=0
   o=TI-WLAN-PHONE 0 0 IN IP4 138.132.110.64
   s=TI-WLAN-CALL
   c=IN IP4 138.132.110.64
   t=0 0
   m=audio 10136 RTP/AVP 8 18 101 102
   a=rtpmap:8 PCMA/8000
   a=rtpmap:18 G729/8000
   a=rtpmap:102 G.729a/8000
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-15
   ------------------------------------------------------------------------
send 331 bytes to udp/[138.132.110.64]:5065 at 08:19:06.923992:
   ------------------------------------------------------------------------
   SIP/2.0 100 Trying
   Via: SIP/2.0/UDP 138.132.110.64:5065;branch=z9hG4bKxTP2KbyJab6373
   From: "1000" <sip:1000@138.132.105.40>;tag=3bad6373
   To: "1001" <sip:1001@138.132.105.40>
   Call-ID: 63736d49df5d85548e08b348fa46b455@138.132.110.64
   CSeq: 1 INVITE
   User-Agent: Italtel-WeGate/HW_V1.0.0/FW_V1.0.0/SW_V1.0.0
   Content-Length: 0

   ------------------------------------------------------------------------
1970-01-06 08:19:06.920625 [NOTICE] switch_channel.c:920 New Channel sofia/external/1000@138.132.105.40 [bb52cd26-2d20-4d0c-ad8a-b2efedd16f6c]
1970-01-06 08:19:06.920625 [DEBUG] switch_core_state_machine.c:362 (sofia/external/1000@138.132.105.40) Running State Change CS_NEW
1970-01-06 08:19:06.920625 [DEBUG] switch_core_state_machine.c:380 (sofia/external/1000@138.132.105.40) State NEW
1970-01-06 08:19:06.920625 [DEBUG] sofia.c:5390 Channel sofia/external/1000@138.132.105.40 entering state [received][100]
1970-01-06 08:19:06.920625 [DEBUG] sofia.c:5401 Remote SDP:
v=0
o=TI-WLAN-PHONE 0 0 IN IP4 138.132.110.64
s=TI-WLAN-CALL
c=IN IP4 138.132.110.64
t=0 0
m=audio 10136 RTP/AVP 8 18 101 102
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=rtpmap:102 G.729a/8000

1970-01-06 08:19:06.920625 [DEBUG] sofia.c:5594 (sofia/external/1000@138.132.105.40) State Change CS_NEW -> CS_INIT
1970-01-06 08:19:06.920625 [DEBUG] switch_core_session.c:1177 Send signal sofia/external/1000@138.132.105.40 [BREAK]
1970-01-06 08:19:06.920625 [DEBUG] switch_core_state_machine.c:362 (sofia/external/1000@138.132.105.40) Running State Change CS_INIT
1970-01-06 08:19:06.920625 [DEBUG] switch_core_state_machine.c:401 (sofia/external/1000@138.132.105.40) State INIT
1970-01-06 08:19:06.920625 [DEBUG] mod_sofia.c:85 sofia/external/1000@138.132.105.40 SOFIA INIT
1970-01-06 08:19:06.920625 [DEBUG] mod_sofia.c:125 (sofia/external/1000@138.132.105.40) State Change CS_INIT -> CS_ROUTING
1970-01-06 08:19:06.920625 [DEBUG] switch_core_session.c:1177 Send signal sofia/external/1000@138.132.105.40 [BREAK]
1970-01-06 08:19:06.920625 [DEBUG] switch_core_state_machine.c:401 (sofia/external/1000@138.132.105.40) State INIT going to sleep
1970-01-06 08:19:06.920625 [DEBUG] switch_core_state_machine.c:362 (sofia/external/1000@138.132.105.40) Running State Change CS_ROUTING
1970-01-06 08:19:06.920625 [DEBUG] switch_channel.c:1871 (sofia/external/1000@138.132.105.40) Callstate Change DOWN -> RINGING
1970-01-06 08:19:06.920625 [DEBUG] switch_core_state_machine.c:410 (sofia/external/1000@138.132.105.40) State ROUTING
1970-01-06 08:19:06.920625 [DEBUG] mod_sofia.c:148 sofia/external/1000@138.132.105.40 SOFIA ROUTING
1970-01-06 08:19:06.920625 [DEBUG] switch_core_state_machine.c:104 sofia/external/1000@138.132.105.40 Standard ROUTING
1970-01-06 08:19:06.920625 [INFO] mod_dialplan_xml.c:481 Processing 1000 <1000>->1001 in context public
Dialplan: sofia/external/1000@138.132.105.40 parsing [public->dial_from_gateway1] continue=false
Dialplan: sofia/external/1000@138.132.105.40 Regex (FAIL) [dial_from_gateway1] destination_number(1001) =~ /1000/ break=on-false
Dialplan: sofia/external/1000@138.132.105.40 parsing [public->dial_from_gateway1] continue=false
Dialplan: sofia/external/1000@138.132.105.40 Regex (PASS) [dial_from_gateway1] destination_number(1001) =~ /1001/ break=on-false
Dialplan: sofia/external/1000@138.132.105.40 Action set(call_timeout=400)
Dialplan: sofia/external/1000@138.132.105.40 Action set(inherit_codec=true)
Dialplan: sofia/external/1000@138.132.105.40 Action bridge(sofia/external/1001@138.132.110.64:5070)
1970-01-06 08:19:06.980093 [DEBUG] switch_core_state_machine.c:154 (sofia/external/1000@138.132.105.40) State Change CS_ROUTING -> CS_EXECUTE
1970-01-06 08:19:06.980093 [DEBUG] switch_core_session.c:1177 Send signal sofia/external/1000@138.132.105.40 [BREAK]
1970-01-06 08:19:06.980093 [DEBUG] switch_core_state_machine.c:410 (sofia/external/1000@138.132.105.40) State ROUTING going to sleep
1970-01-06 08:19:06.980093 [DEBUG] switch_core_state_machine.c:362 (sofia/external/1000@138.132.105.40) Running State Change CS_EXECUTE
1970-01-06 08:19:06.980093 [DEBUG] switch_core_state_machine.c:417 (sofia/external/1000@138.132.105.40) State EXECUTE
1970-01-06 08:19:06.980093 [DEBUG] mod_sofia.c:241 sofia/external/1000@138.132.105.40 SOFIA EXECUTE
1970-01-06 08:19:06.980093 [DEBUG] switch_core_state_machine.c:192 sofia/external/1000@138.132.105.40 Standard EXECUTE
EXECUTE sofia/external/1000@138.132.105.40 set(call_timeout=400)
1970-01-06 08:19:06.980093 [DEBUG] mod_dptools.c:1263 sofia/external/1000@138.132.105.40 SET [call_timeout]=[400]
EXECUTE sofia/external/1000@138.132.105.40 set(inherit_codec=true)
1970-01-06 08:19:06.980093 [DEBUG] mod_dptools.c:1263 sofia/external/1000@138.132.105.40 SET [inherit_codec]=[true]
EXECUTE sofia/external/1000@138.132.105.40 bridge(sofia/external/1001@138.132.110.64:5070)
1970-01-06 08:19:07.000205 [DEBUG] switch_ivr_originate.c:1884 Parsing global variables
1970-01-06 08:19:07.000205 [NOTICE] switch_channel.c:920 New Channel sofia/external/1001@138.132.110.64:5070 [20710684-bb47-4d82-94ec-aca7960bdf05]
1970-01-06 08:19:07.000205 [DEBUG] mod_sofia.c:4539 (sofia/external/1001@138.132.110.64:5070) State Change CS_NEW -> CS_INIT
1970-01-06 08:19:07.000205 [DEBUG] switch_core_session.c:1177 Send signal sofia/external/1001@138.132.110.64:5070 [BREAK]
1970-01-06 08:19:07.020085 [DEBUG] switch_core_state_machine.c:362 (sofia/external/1001@138.132.110.64:5070) Running State Change CS_INIT
1970-01-06 08:19:07.020085 [DEBUG] switch_core_state_machine.c:401 (sofia/external/1001@138.132.110.64:5070) State INIT
1970-01-06 08:19:07.020085 [DEBUG] mod_sofia.c:85 sofia/external/1001@138.132.110.64:5070 SOFIA INIT
1970-01-06 08:19:07.041130 [DEBUG] mod_sofia.c:125 (sofia/external/1001@138.132.110.64:5070) State Change CS_INIT -> CS_ROUTING
1970-01-06 08:19:07.041130 [DEBUG] switch_core_session.c:1177 Send signal sofia/external/1001@138.132.110.64:5070 [BREAK]
1970-01-06 08:19:07.041130 [DEBUG] switch_core_state_machine.c:401 (sofia/external/1001@138.132.110.64:5070) State INIT going to sleep
1970-01-06 08:19:07.041130 [DEBUG] switch_core_state_machine.c:362 (sofia/external/1001@138.132.110.64:5070) Running State Change CS_ROUTING
1970-01-06 08:19:07.041130 [DEBUG] switch_channel.c:1871 (sofia/external/1001@138.132.110.64:5070) Callstate Change DOWN -> RINGING
1970-01-06 08:19:07.041130 [DEBUG] switch_core_state_machine.c:410 (sofia/external/1001@138.132.110.64:5070) State ROUTING
1970-01-06 08:19:07.041130 [DEBUG] mod_sofia.c:148 sofia/external/1001@138.132.110.64:5070 SOFIA ROUTING
1970-01-06 08:19:07.041130 [DEBUG] switch_ivr_originate.c:66 (sofia/external/1001@138.132.110.64:5070) State Change CS_ROUTING -> CS_CONSUME_MEDIA
1970-01-06 08:19:07.041130 [DEBUG] switch_core_session.c:1177 Send signal sofia/external/1001@138.132.110.64:5070 [BREAK]
1970-01-06 08:19:07.041130 [DEBUG] switch_core_state_machine.c:410 (sofia/external/1001@138.132.110.64:5070) State ROUTING going to sleep
1970-01-06 08:19:07.041130 [DEBUG] switch_core_state_machine.c:362 (sofia/external/1001@138.132.110.64:5070) Running State Change CS_CONSUME_MEDIA
1970-01-06 08:19:07.041130 [DEBUG] switch_core_state_machine.c:429 (sofia/external/1001@138.132.110.64:5070) State CONSUME_MEDIA
1970-01-06 08:19:07.041130 [DEBUG] switch_core_state_machine.c:429 (sofia/external/1001@138.132.110.64:5070) State CONSUME_MEDIA going to sleep
send 1033 bytes to udp/[138.132.110.64]:5070 at 08:19:07.061497:
   ------------------------------------------------------------------------
   INVITE sip:1001@138.132.110.64:5070 SIP/2.0
   Via: SIP/2.0/UDP 138.132.105.40;rport;branch=z9hG4bKXty0Na85rgvNQ
   Max-Forwards: 69
   From: "1000" <sip:1000@138.132.105.40>;tag=1Xy95SNcpKSSK
   To: <sip:1001@138.132.110.64:5070>
   Call-ID: 78c3e14f-9ca8-1200-1ca0-0020da862374
   CSeq: 30983549 INVITE
   Contact: <sip:mod_sofia@138.132.105.40:5060>
   User-Agent: Italtel-WeGate/HW_V1.0.0/FW_V1.0.0/SW_V1.0.0
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, PRACK, NOTIFY
   Supported: 100rel, precondition, path, replaces
   Allow-Events: talk, hold, refer
   Content-Type: application/sdp
   Content-Disposition: session
   Content-Length: 254
   X-FS-Support: update_display
   Remote-Party-ID: "1000" <sip:1000@138.132.105.40>;party=calling;screen=yes;privacy=off

   v=0
   o=FreeSWITCH 441041 441042 IN IP4 138.132.105.40
   s=FreeSWITCH
   c=IN IP4 138.132.105.40
   t=0 0
   m=audio 20906 RTP/AVP 8 18 98 101 13
   a=rtpmap:98 AMR-WB/16000
   a=fmtp:98 octet-align=0
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-16
   a=ptime:20
   ------------------------------------------------------------------------
1970-01-06 08:19:07.080086 [DEBUG] switch_core_session.c:872 Send signal sofia/external/1001@138.132.110.64:5070 [BREAK]
1970-01-06 08:19:07.080086 [DEBUG] sofia.c:5390 Channel sofia/external/1001@138.132.110.64:5070 entering state [calling][0]
recv 299 bytes from udp/[138.132.110.64]:5070 at 08:19:07.292884:
   ------------------------------------------------------------------------
   SIP/2.0 100 Trying
   Via: SIP/2.0/UDP 138.132.105.40;rport;branch=z9hG4bKXty0Na85rgvNQ
   To: <sip:1001@138.132.110.64:5070>
   From: "1000" <sip:1000@138.132.105.40>;tag=1Xy95SNcpKSSK
   Call-ID: 78c3e14f-9ca8-1200-1ca0-0020da862374
   CSeq: 30983549 INVITE
   User Agent: TP2000 By JAB
   Content-Length: 0

   ------------------------------------------------------------------------
recv 682 bytes from udp/[138.132.110.64]:5070 at 08:19:07.307137:
   ------------------------------------------------------------------------
   SIP/2.0 183 Session Progress
   Via: SIP/2.0/UDP 138.132.105.40;rport;branch=z9hG4bKXty0Na85rgvNQ
   To: <sip:1001@138.132.110.64:5070>;tag=beef9284
   From: "1000" <sip:1000@138.132.105.40>;tag=1Xy95SNcpKSSK
   Call-ID: 78c3e14f-9ca8-1200-1ca0-0020da862374
   CSeq: 30983549 INVITE
   Contact: <sip:1001@138.132.110.64:5070>
   Allow: INVITE, ACK, PRACK, CANCEL, BYE, OPTIONS, MESSAGE, NOTIFY, UPDATE, REGISTER, INFO, REFER, SUBSCRIBE
   Require: 100rel
   RSeq: 18
   Content-Type: application/sdp
   Content-Length: 178

   v=0
   o=TI-WLAN-PHONE 0 1 IN IP4 138.132.110.64
   s=TI-WLAN-CALL
   c=IN IP4 138.132.110.64
   t=0 0
   m=audio 10136 RTP/AVP 18 101
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-15
   ------------------------------------------------------------------------
1970-01-06 08:19:07.300076 [DEBUG] switch_core_session.c:872 Send signal sofia/external/1001@138.132.110.64:5070 [BREAK]
send 602 bytes to udp/[138.132.110.64]:5070 at 08:19:07.323009:
   ------------------------------------------------------------------------
   PRACK sip:1001@138.132.110.64:5070 SIP/2.0
   Via: SIP/2.0/UDP 138.132.105.40;rport;branch=z9hG4bKp8mU7r0cNSNpS
   Max-Forwards: 70
   From: "1000" <sip:1000@138.132.105.40>;tag=1Xy95SNcpKSSK
   To: <sip:1001@138.132.110.64:5070>;tag=beef9284
   Call-ID: 78c3e14f-9ca8-1200-1ca0-0020da862374
   CSeq: 30983550 PRACK
   Contact: <sip:mod_sofia@138.132.105.40:5060>
   RAck: 18 30983549 INVITE
   User-Agent: Italtel-WeGate/HW_V1.0.0/FW_V1.0.0/SW_V1.0.0
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, PRACK, NOTIFY
   Supported: 100rel, precondition, path, replaces
   Content-Length: 0

   ------------------------------------------------------------------------
1970-01-06 08:19:07.321123 [DEBUG] switch_core_session.c:872 Send signal sofia/external/1001@138.132.110.64:5070 [BREAK]
1970-01-06 08:19:07.321123 [DEBUG] sofia.c:5390 Channel sofia/external/1001@138.132.110.64:5070 entering state [proceeding][183]
1970-01-06 08:19:07.321123 [DEBUG] sofia.c:5401 Remote SDP:
v=0
o=TI-WLAN-PHONE 0 1 IN IP4 138.132.110.64
s=TI-WLAN-CALL
c=IN IP4 138.132.110.64
t=0 0
m=audio 10136 RTP/AVP 18 101
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

1970-01-06 08:19:07.321123 [DEBUG] sofia.c:5516

[GIO] sofia_handle_sip_i_state() :

1970-01-06 08:19:07.321123 [DEBUG] sofia_glue.c:3904

[GIO] sofia_glue_tech_media() :

1970-01-06 08:19:07.321123 [DEBUG] sofia_glue.c:4304

[GIO] sofia_glue_negotiate_sdp() :

1970-01-06 08:19:07.321123 [DEBUG] sofia_glue.c:4768 Audio Codec Compare [G729:18:8000:20:8000]/[PCMA:8:8000:20:64000]
1970-01-06 08:19:07.321123 [DEBUG] sofia_glue.c:4768 Audio Codec Compare [G729:18:8000:20:8000]/[G729:18:8000:20:8000]
1970-01-06 08:19:07.321123 [DEBUG] sofia_glue.c:2887 Set Codec sofia/external/1001@138.132.110.64:5070 G729/8000 20 ms 160 samples 8000 bits
1970-01-06 08:19:07.321123 [DEBUG] sofia_glue.c:4882 Set 2833 dtmf send payload to 101
1970-01-06 08:19:07.321123 [DEBUG] sofia_glue.c:3139 AUDIO RTP [sofia/external/1001@138.132.110.64:5070] 138.132.105.40 port 20906 -> 138.132.110.64 port 10136 codec: 18 ms: 20
1970-01-06 08:19:07.321123 [DEBUG] switch_rtp.c:1642 Starting timer [soft] 160 bytes per 20ms
1970-01-06 08:19:07.321123 [DEBUG] sofia_glue.c:3403 Set 2833 dtmf send payload to 101
1970-01-06 08:19:07.321123 [DEBUG] sofia_glue.c:3409 Set 2833 dtmf receive payload to 101
1970-01-06 08:19:07.321123 [NOTICE] sofia_glue.c:3915 Pre-Answer sofia/external/1001@138.132.110.64:5070!
1970-01-06 08:19:07.321123 [DEBUG] switch_channel.c:2917 (sofia/external/1001@138.132.110.64:5070) Callstate Change RINGING -> EARLY
1970-01-06 08:19:07.321123 [DEBUG] switch_ivr_originate.c:405 Setting codec string on sofia/external/1000@138.132.105.40 to G729@8000h@20i
1970-01-06 08:19:07.321123 [INFO] switch_ivr_originate.c:3215 Sending early media
1970-01-06 08:19:07.321123 [DEBUG] sofia_glue.c:3904

[GIO] sofia_glue_tech_media() :

1970-01-06 08:19:07.321123 [DEBUG] sofia_glue.c:4304

[GIO] sofia_glue_negotiate_sdp() :

1970-01-06 08:19:07.321123 [DEBUG] sofia_glue.c:4768 Audio Codec Compare [PCMA:8:8000:20:64000]/[G729:18:8000:20:8000]
1970-01-06 08:19:07.321123 [DEBUG] sofia_glue.c:4768 Audio Codec Compare [G729:18:8000:20:8000]/[G729:18:8000:20:8000]
1970-01-06 08:19:07.321123 [DEBUG] sofia_glue.c:2887 Set Codec sofia/external/1000@138.132.105.40 G729/8000 20 ms 160 samples 8000 bits
1970-01-06 08:19:07.321123 [DEBUG] sofia_glue.c:4889 Set 2833 dtmf send/recv payload to 101
1970-01-06 08:19:07.321123 [DEBUG] sofia_glue.c:3139 AUDIO RTP [sofia/external/1000@138.132.105.40] 138.132.105.40 port 21634 -> 138.132.110.64 port 10136 codec: 18 ms: 20
1970-01-06 08:19:07.321123 [DEBUG] switch_rtp.c:1642 Starting timer [soft] 160 bytes per 20ms
1970-01-06 08:19:07.367755 [DEBUG] sofia_glue.c:3403 Set 2833 dtmf send payload to 101
1970-01-06 08:19:07.367755 [DEBUG] sofia_glue.c:3409 Set 2833 dtmf receive payload to 101
1970-01-06 08:19:07.367755 [NOTICE] sofia_glue.c:3915 Pre-Answer sofia/external/1000@138.132.105.40!
1970-01-06 08:19:07.367755 [DEBUG] switch_channel.c:2917 (sofia/external/1000@138.132.105.40) Callstate Change RINGING -> EARLY
1970-01-06 08:19:07.380617 [DEBUG] mod_sofia.c:2500 Ring SDP:
v=0
o=FreeSWITCH 0000440313 0000440314 IN IP4 138.132.105.40
s=FreeSWITCH
c=IN IP4 138.132.105.40
t=0 0
m=audio 21634 RTP/AVP 18 101
a=rtpmap:18 G729/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv

send 1048 bytes to udp/[138.132.110.64]:5065 at 08:19:07.424043:
   ------------------------------------------------------------------------
   SIP/2.0 183 Session Progress
   Via: SIP/2.0/UDP 138.132.110.64:5065;branch=z9hG4bKxTP2KbyJab6373
   From: "1000" <sip:1000@138.132.105.40>;tag=3bad6373
   To: "1001" <sip:1001@138.132.105.40>;tag=8Q8emBX5ta0pH
   Call-ID: 63736d49df5d85548e08b348fa46b455@138.132.110.64
   CSeq: 1 INVITE
   Contact: <sip:1001@138.132.105.40:5060;transport=udp>
   RSeq: 1262621007
   User-Agent: Italtel-WeGate/HW_V1.0.0/FW_V1.0.0/SW_V1.0.0
   Accept: application/sdp
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, PRACK, NOTIFY
   Require: 100rel
   Supported: 100rel, precondition, path, replaces
   Allow-Events: talk, hold, refer
   Content-Type: application/sdp
   Content-Disposition: session
   Content-Length: 245
   Remote-Party-ID: "1001" <sip:1001@138.132.105.40>;party=calling;privacy=off;screen=no

   v=0
   o=FreeSWITCH 440313 440314 IN IP4 138.132.105.40
   s=FreeSWITCH
   c=IN IP4 138.132.105.40
   t=0 0
   m=audio 21634 RTP/AVP 18 101
   a=rtpmap:18 G729/8000
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-16
   a=silenceSupp:off - - - -
   a=ptime:20
   ------------------------------------------------------------------------
1970-01-06 08:19:07.420102 [DEBUG] switch_core_session.c:872 Send signal sofia/external/1000@138.132.105.40 [BREAK]
recv 367 bytes from udp/[138.132.110.64]:5065 at 08:19:07.430920:
   ------------------------------------------------------------------------
   PRACK sip:1001@138.132.105.40:5060;transport=udp SIP/2.0
   Via: SIP/2.0/UDP 138.132.110.64:5065;branch=z9hG4bKe27d4510
   To: "1001" <sip:1001@138.132.105.40>;tag=8Q8emBX5ta0pH
   From: "1000" <sip:1000@138.132.105.40>;tag=3bad6373
   Call-ID: 63736d49df5d85548e08b348fa46b455@138.132.110.64
   CSeq: 2 PRACK
   Max-Forwards: 70
   RAck: 1262621007 1 INVITE
   Content-Length: 0

   ------------------------------------------------------------------------
send 564 bytes to udp/[138.132.110.64]:5065 at 08:19:07.432407:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP 138.132.110.64:5065;branch=z9hG4bKe27d4510
   From: "1000" <sip:1000@138.132.105.40>;tag=3bad6373
   To: "1001" <sip:1001@138.132.105.40>;tag=8Q8emBX5ta0pH
   Call-ID: 63736d49df5d85548e08b348fa46b455@138.132.110.64
   CSeq: 2 PRACK
   Contact: <sip:1001@138.132.105.40:5060;transport=udp>
   User-Agent: Italtel-WeGate/HW_V1.0.0/FW_V1.0.0/SW_V1.0.0
   Accept: application/sdp
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, PRACK, NOTIFY
   Supported: 100rel, precondition, path, replaces
   Content-Length: 0

   ------------------------------------------------------------------------
1970-01-06 08:19:07.420102 [DEBUG] switch_core_session.c:872 Send signal sofia/external/1000@138.132.105.40 [BREAK]
recv 339 bytes from udp/[138.132.110.64]:5070 at 08:19:07.434919:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Call-ID: 78c3e14f-9ca8-1200-1ca0-0020da862374
   Via: SIP/2.0/UDP 138.132.105.40;rport;branch=z9hG4bKp8mU7r0cNSNpS
   To: <sip:1001@138.132.110.64:5070>;tag=beef9284
   From: "1000" <sip:1000@138.132.105.40>;tag=1Xy95SNcpKSSK
   CSeq: 30983550 PRACK
   Contact: <sip:1001@138.132.110.64:5070>
   Max-Forwards: 70
   Content-Length: 0

   ------------------------------------------------------------------------
1970-01-06 08:19:07.420102 [DEBUG] switch_core_session.c:872 Send signal sofia/external/1001@138.132.110.64:5070 [BREAK]
1970-01-06 08:19:07.420102 [DEBUG] switch_channel.c:2959 Send signal sofia/external/1000@138.132.105.40 [BREAK]
1970-01-06 08:19:07.420102 [DEBUG] sofia.c:5383 Channel sofia/external/1000@138.132.105.40 skipping state [early][183]
1970-01-06 08:19:07.420102 [DEBUG] switch_core_session.c:726 Send signal sofia/external/1000@138.132.105.40 [BREAK]
1970-01-06 08:19:07.420102 [DEBUG] switch_ivr_originate.c:3269 Originate Resulted in Success: [sofia/external/1001@138.132.110.64:5070]
1970-01-06 08:19:07.440084 [DEBUG] switch_core_session.c:726 Send signal sofia/external/1001@138.132.110.64:5070 [BREAK]
1970-01-06 08:19:07.440084 [DEBUG] switch_core_session.c:726 Send signal sofia/external/1000@138.132.105.40 [BREAK]
1970-01-06 08:19:07.440084 [DEBUG] switch_ivr_bridge.c:1270 (sofia/external/1001@138.132.110.64:5070) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
1970-01-06 08:19:07.440084 [DEBUG] switch_core_session.c:1177 Send signal sofia/external/1001@138.132.110.64:5070 [BREAK]
1970-01-06 08:19:07.440084 [DEBUG] switch_core_state_machine.c:362 (sofia/external/1001@138.132.110.64:5070) Running State Change CS_EXCHANGE_MEDIA
1970-01-06 08:19:07.440084 [DEBUG] switch_core_state_machine.c:420 (sofia/external/1001@138.132.110.64:5070) State EXCHANGE_MEDIA
1970-01-06 08:19:07.440084 [DEBUG] mod_sofia.c:574 SOFIA EXCHANGE_MEDIA
recv 587 bytes from udp/[138.132.110.64]:5065 at 08:19:08.449739:
   ------------------------------------------------------------------------
   UPDATE sip:1001@138.132.105.40:5060;transport=udp SIP/2.0
   Via: SIP/2.0/UDP 138.132.110.64:5065;branch=z9hG4bKe27d7918
   To: "1001" <sip:1001@138.132.105.40>;tag=8Q8emBX5ta0pH
   From: "1000" <sip:1000@138.132.105.40>;tag=3bad6373
   Call-ID: 63736d49df5d85548e08b348fa46b455@138.132.110.64
   CSeq: 3 UPDATE
   Max-Forwards: 70
   Contact: <sip:1000@138.132.110.64:5065>
   Content-Type: application/sdp
   Content-Length: 171

   v=0
   o=TI-WLAN-PHONE 0 2 IN IP4 138.132.110.64
   s=TI-WLAN-CALL
   c=IN IP4 0.0.0.0
   t=0 0
   m=audio 10136 RTP/AVP 18 101
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-15
   ------------------------------------------------------------------------
send 885 bytes to udp/[138.132.110.64]:5065 at 08:19:08.465202:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP 138.132.110.64:5065;branch=z9hG4bKe27d7918
   From: "1000" <sip:1000@138.132.105.40>;tag=3bad6373
   To: "1001" <sip:1001@138.132.105.40>;tag=8Q8emBX5ta0pH
   Call-ID: 63736d49df5d85548e08b348fa46b455@138.132.110.64
   CSeq: 3 UPDATE
   Contact: <sip:1001@138.132.105.40:5060;transport=udp>
   User-Agent: Italtel-WeGate/HW_V1.0.0/FW_V1.0.0/SW_V1.0.0
   Accept: application/sdp
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, PRACK, NOTIFY
   Supported: 100rel, precondition, path, replaces
   Content-Type: application/sdp
   Content-Disposition: session
   Content-Length: 257

   v=0
   o=FreeSWITCH 440313 440315 IN IP4 138.132.105.40
   s=FreeSWITCH
   c=IN IP4 138.132.105.40
   t=0 0
   m=audio 21634 RTP/AVP 18 101
   a=rtpmap:18 G729/8000
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-16
   a=recvonly
   a=silenceSupp:off - - - -
   a=ptime:20
   ------------------------------------------------------------------------
1970-01-06 08:19:08.460083 [DEBUG] switch_core_session.c:872 Send signal sofia/external/1000@138.132.105.40 [BREAK]
1970-01-06 08:19:08.460083 [DEBUG] switch_core_session.c:872 Send signal sofia/external/1000@138.132.105.40 [BREAK]
1970-01-06 08:19:08.480076 [DEBUG] sofia.c:5390 Channel sofia/external/1000@138.132.105.40 entering state [early][200]
1970-01-06 08:19:08.480076 [DEBUG] sofia.c:5401 Remote SDP:
v=0
o=TI-WLAN-PHONE 0 2 IN IP4 138.132.110.64
s=TI-WLAN-CALL
c=IN IP4 0.0.0.0
t=0 0
m=audio 10136 RTP/AVP 18 101
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendonly