- FreeSWITCH-users - FreeSWITCH Mailing Lists

Freeswitch trunk with router vodafone asterisk based
by "Δημήτριος Δ. Κάργας" 03 Apr '19

03 Apr '19

Good morning, I Have this error, Internet ——> Router Vodafone (Asteriskj Based Pstn Voip) 192.168.2.5 ——> FS ( 192.168.2.10 ) ——-> Phone (192.168.2.41) * Freeswitch is behind this router with static internal ip 192.168.2.10 and without internet. After config trunk with this router and add gateway in FS this trunk a have normal inbound/incoming calls and work ok. The error is on outbound call from this trunk, make the call and i don’t have returned audio to phone. After make from phone a call, call starting from router but with out ring back in phone and if answer the call from the other side rtp channel open and send packets to FS but not to Phone. Can help me please? Thanks. Sorry my English is so bad. Log from sip call outbound trace ------------------------------------------------------------------------ INVITE sip:401@192.168.2.10:5060;transport=udp SIP/2.0 Via: SIP/2.0/UDP 192.168.2.41;branch=z9hG4bK169fc7e5a6e1207bd Route: <sip:192.168.2.10:5060;lr;transport=udp> Max-Forwards: 70 From: "7777" <sip:7777@192.168.2.10:5060>;tag=c607ca2663;epid=SC0c351a To: <sip:401@192.168.2.10:5060> Call-ID: 356f4bddc52d1c96 CSeq: 2140941627 INVITE Allow: INVITE, ACK, CANCEL, BYE, REFER, NOTIFY, UPDATE Allow-Events: hold Contact: "7777" <sip:7777@192.168.2.41:5060;transport=udp> Min-SE: 90 Session-Expires: 3600;refresher=uac Supported: replaces, 100rel, timer User-Agent: OpenStage_40_V3 R4.10.0 SIP 160728 X-Siemens-Call-Type: ST-secure, ST-insecure Content-Type: application/sdp Content-Length: 352 v=0 o=OpenStage-Line_0 1646341531 67203184 IN IP4 192.168.2.41 s=SIP Call c=IN IP4 192.168.2.41 t=0 0 m=audio 5010 RTP/AVP 8 0 18 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:18 G729/8000 a=rtpmap:101 telephone-event/8000 a=silenceSupp:off - - - - a=fmtp:18 annexb=no a=fmtp:101 0-15 a=rtcp:5011 IN IP4 192.168.2.41 a=sendrecv ------------------------------------------------------------------------ 2019-04-01 23:19:16.604364 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/7777@192.168.2.10:5060 [1f84cc47-487d-495d-8d1f-a7dd2636fc43] 2019-04-01 23:19:16.604364 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/7777@192.168.2.10:5060) Running State Change CS_NEW (Cur 1 Tot 7) 2019-04-01 23:19:16.604364 [DEBUG] sofia.c:10092 sofia/internal/7777@192.168.2.10:5060 receiving invite from 192.168.2.41:5060 version: 1.8.5 -6-31281a0bf1 64bit 2019-04-01 23:19:16.604364 [DEBUG] sofia.c:7291 Channel sofia/internal/7777@192.168.2.10:5060 entering state [received][100] 2019-04-01 23:19:16.604364 [DEBUG] sofia.c:7301 Remote SDP: v=0 o=OpenStage-Line_0 1646341531 67203184 IN IP4 192.168.2.41 s=SIP Call c=IN IP4 192.168.2.41 t=0 0 m=audio 5010 RTP/AVP 8 0 18 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 a=silenceSupp:off - - - - a=rtcp:5011 IN IP4 192.168.2.41 2019-04-01 23:19:16.604364 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G729:18:8000:20:8000:1] 2019-04-01 23:19:16.604364 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1] 2019-04-01 23:19:16.604364 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1] 2019-04-01 23:19:16.604364 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1] 2019-04-01 23:19:16.604364 [DEBUG] switch_core_media.c:5533 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match 2019-04-01 23:19:16.604364 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[GSM:3:8000:20:13200:1] 2019-04-01 23:19:16.604364 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G729:18:8000:20:8000:1] 2019-04-01 23:19:16.604364 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1] 2019-04-01 23:19:16.604364 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1] 2019-04-01 23:19:16.604364 [DEBUG] switch_core_media.c:5533 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match 2019-04-01 23:19:16.604364 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1] 2019-04-01 23:19:16.604364 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[GSM:3:8000:20:13200:1] 2019-04-01 23:19:16.604364 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [G729:18:8000:20:8000:1]/[G729:18:8000:20:8000:1] 2019-04-01 23:19:16.604364 [DEBUG] switch_core_media.c:5533 Audio Codec Compare [G729:18:8000:20:8000:1] ++++ is saved as a match 2019-04-01 23:19:16.604364 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [G729:18:8000:20:8000:1]/[G722:9:8000:20:64000:1] 2019-04-01 23:19:16.604364 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1] 2019-04-01 23:19:16.604364 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1] 2019-04-01 23:19:16.604364 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [G729:18:8000:20:8000:1]/[GSM:3:8000:20:13200:1] 2019-04-01 23:19:16.604364 [DEBUG] switch_core_media.c:5394 Set telephone-event payload to 101@8000 2019-04-01 23:19:16.604364 [DEBUG] switch_core_media.c:3781 Set Codec sofia/internal/7777@192.168.2.10:5060 PCMA/8000 20 ms 160 samples 64000 bits 1 channels 2019-04-01 23:19:16.604364 [DEBUG] switch_core_codec.c:111 sofia/internal/7777@192.168.2.10:5060 Original read codec set to PCMA:8 2019-04-01 23:19:16.624363 [DEBUG] switch_core_media.c:5737 Set telephone-event payload to 101@8000 2019-04-01 23:19:16.624363 [DEBUG] switch_core_media.c:5795 sofia/internal/7777@192.168.2.10:5060 Set 2833 dtmf send payload to 101 recv payload to 101 2019-04-01 23:19:16.624363 [DEBUG] sofia.c:7716 (sofia/internal/7777@192.168.2.10:5060) State Change CS_NEW -> CS_INIT 2019-04-01 23:19:16.624363 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/7777@192.168.2.10:5060) State NEW 2019-04-01 23:19:16.624363 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/7777@192.168.2.10:5060) Running State Change CS_INIT (Cur 1 Tot 7) 2019-04-01 23:19:16.624363 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/7777@192.168.2.10:5060) State INIT 2019-04-01 23:19:16.624363 [DEBUG] mod_sofia.c:93 sofia/internal/7777@192.168.2.10:5060 SOFIA INIT 2019-04-01 23:19:16.624363 [DEBUG] switch_core_state_machine.c:40 sofia/internal/7777@192.168.2.10:5060 Standard INIT 2019-04-01 23:19:16.624363 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/7777@192.168.2.10:5060) State Change CS_INIT -> CS_ROUTING 2019-04-01 23:19:16.624363 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/7777@192.168.2.10:5060) State INIT going to sleep 2019-04-01 23:19:16.624363 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/7777@192.168.2.10:5060) Running State Change CS_ROUTING (Cur 1 Tot 7) 2019-04-01 23:19:16.624363 [DEBUG] switch_channel.c:2249 (sofia/internal/7777@192.168.2.10:5060) Callstate Change DOWN -> RINGING 2019-04-01 23:19:16.624363 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/7777@192.168.2.10:5060) State ROUTING 2019-04-01 23:19:16.624363 [DEBUG] mod_sofia.c:154 sofia/internal/7777@192.168.2.10:5060 SOFIA ROUTING 2019-04-01 23:19:16.624363 [DEBUG] switch_core_state_machine.c:236 sofia/internal/7777@192.168.2.10:5060 Standard ROUTING 2019-04-01 23:19:16.624363 [INFO] mod_dialplan_xml.c:637 Processing 7777 <7777>->401 in context 192.168.2.10 send 296 bytes to udp/[192.168.2.41]:5060 at 23:19:16.624956: ------------------------------------------------------------------------ SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.2.41;branch=z9hG4bK169fc7e5a6e1207bd;rport=5060 From: "7777" <sip:7777@192.168.2.10:5060>;tag=c607ca2663;epid=SC0c351a To: <sip:401@192.168.2.10:5060> Call-ID: 356f4bddc52d1c96 CSeq: 2140941627 INVITE User-Agent: FreeSWITCH Content-Length: 0 ------------------------------------------------------------------------ Dialplan: sofia/internal/7777@192.168.2.10:5060 parsing [192.168.2.10->user_exists] continue=true Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (PASS) [user_exists] () =~ // break=on-false Dialplan: sofia/internal/7777@192.168.2.10:5060 Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE EXECUTE sofia/internal/7777@192.168.2.10:5060 set(user_exists=false) 2019-04-01 23:19:16.624363 [DEBUG] mod_dptools.c:1598 SET sofia/internal/7777@192.168.2.10:5060 [user_exists]=[false] Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false Dialplan: sofia/internal/7777@192.168.2.10:5060 parsing [192.168.2.10->caller-details] continue=true Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (PASS) [caller-details] ${caller_destination}() =~ /^$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Action set(caller_destination=${destination_number}) INLINE EXECUTE sofia/internal/7777@192.168.2.10:5060 set(caller_destination=401) 2019-04-01 23:19:16.624363 [DEBUG] mod_dptools.c:1598 SET sofia/internal/7777@192.168.2.10:5060 [caller_destination]=[401] Dialplan: sofia/internal/7777@192.168.2.10:5060 Action set(caller_id_name=${caller_id_name}) INLINE EXECUTE sofia/internal/7777@192.168.2.10:5060 set(caller_id_name=7777) 2019-04-01 23:19:16.624363 [DEBUG] mod_dptools.c:1598 SET sofia/internal/7777@192.168.2.10:5060 [caller_id_name]=[7777] Dialplan: sofia/internal/7777@192.168.2.10:5060 Action set(caller_id_number=${caller_id_number}) INLINE EXECUTE sofia/internal/7777@192.168.2.10:5060 set(caller_id_number=7777) 2019-04-01 23:19:16.624363 [DEBUG] mod_dptools.c:1598 SET sofia/internal/7777@192.168.2.10:5060 [caller_id_number]=[7777] Dialplan: sofia/internal/7777@192.168.2.10:5060 parsing [192.168.2.10->variables] continue=true Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (PASS) [variables] () =~ // break=on-false Dialplan: sofia/internal/7777@192.168.2.10:5060 Action export(origination_callee_id_name=${destination_number}) Dialplan: sofia/internal/7777@192.168.2.10:5060 Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) Dialplan: sofia/internal/7777@192.168.2.10:5060 parsing [192.168.2.10->call-direction] continue=true Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [call-direction] ${call_direction}() =~ /^(inbound|outbound|local)$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 ANTI-Action export(call_direction=local) Dialplan: sofia/internal/7777@192.168.2.10:5060 parsing [192.168.2.10->call_block] continue=true Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [call_block] ${call_direction}() =~ /^inbound$/ break=on-false Dialplan: sofia/internal/7777@192.168.2.10:5060 parsing [192.168.2.10->user_record] continue=true Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (PASS) [user_record] () =~ // break=on-false Dialplan: sofia/internal/7777@192.168.2.10:5060 Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE EXECUTE sofia/internal/7777@192.168.2.10:5060 set(from_user_exists=true) 2019-04-01 23:19:16.624363 [DEBUG] mod_dptools.c:1598 SET sofia/internal/7777@192.168.2.10:5060 [from_user_exists]=[true] Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [user_record] ${call_direction}() =~ /^inbound$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [user_record] ${call_direction}() =~ /^outbound$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [user_record] ${call_direction}() =~ /^local$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Action set(from_user_record=${user_data ${sip_from_user}@${sip_from_host} var user_record}) INLINE EXECUTE sofia/internal/7777@192.168.2.10:5060 set(from_user_record=) 2019-04-01 23:19:16.624363 [DEBUG] mod_dptools.c:1598 SET sofia/internal/7777@192.168.2.10:5060 [from_user_record]=[UNDEF] Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [user_record] ${call_direction}() =~ /^inbound$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [user_record] ${call_direction}() =~ /^outbound$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [user_record] ${call_direction}() =~ /^local$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false Dialplan: sofia/internal/7777@192.168.2.10:5060 parsing [192.168.2.10->redial] continue=true Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [redial] destination_number(401) =~ /^(redial|\*870)$/ break=on-true Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (PASS) [redial] () =~ // break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number}) Dialplan: sofia/internal/7777@192.168.2.10:5060 parsing [192.168.2.10->speed_dial] continue=false Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (FAIL) [speed_dial] destination_number(401) =~ /^\*0(.*)$/ break=on-false Dialplan: sofia/internal/7777@192.168.2.10:5060 parsing [192.168.2.10->default_caller_id] continue=true Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (PASS) [default_caller_id] ${emergency_caller_id_number}() =~ /^$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Action set(emergency_caller_id_name=${default_emergency_caller_id_name}) INLINE EXECUTE sofia/internal/7777@192.168.2.10:5060 set(emergency_caller_id_name=) 2019-04-01 23:19:16.624363 [DEBUG] mod_dptools.c:1598 SET sofia/internal/7777@192.168.2.10:5060 [emergency_caller_id_name]=[UNDEF] Dialplan: sofia/internal/7777@192.168.2.10:5060 Action set(emergency_caller_id_number=${default_emergency_caller_id_number}) INLINE EXECUTE sofia/internal/7777@192.168.2.10:5060 set(emergency_caller_id_number=) 2019-04-01 23:19:16.624363 [DEBUG] mod_dptools.c:1598 SET sofia/internal/7777@192.168.2.10:5060 [emergency_caller_id_number]=[UNDEF] Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (PASS) [default_caller_id] ${outbound_caller_id_number}() =~ /^$/ break=never Dialplan: sofia/internal/7777@192.168.2.10:5060 Action set(outbound_caller_id_name=${default_outbound_caller_id_name}) INLINE EXECUTE sofia/internal/7777@192.168.2.10:5060 set(outbound_caller_id_name=) 2019-04-01 23:19:16.624363 [DEBUG] mod_dptools.c:1598 SET sofia/internal/7777@192.168.2.10:5060 [outbound_caller_id_name]=[UNDEF] Dialplan: sofia/internal/7777@192.168.2.10:5060 Action set(outbound_caller_id_number=${default_outbound_caller_id_number}) INLINE EXECUTE sofia/internal/7777@192.168.2.10:5060 set(outbound_caller_id_number=) 2019-04-01 23:19:16.624363 [DEBUG] mod_dptools.c:1598 SET sofia/internal/7777@192.168.2.10:5060 [outbound_caller_id_number]=[UNDEF] Dialplan: sofia/internal/7777@192.168.2.10:5060 parsing [192.168.2.10->fs.d3] continue=false Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (PASS) [fs.d3] ${user_exists}(false) =~ /false/ break=on-false Dialplan: sofia/internal/7777@192.168.2.10:5060 Regex (PASS) [fs.d3] destination_number(401) =~ /^(\d{3})$/ break=on-false Dialplan: sofia/internal/7777@192.168.2.10:5060 Action set(sip_h_X-accountcode=${accountcode}) Dialplan: sofia/internal/7777@192.168.2.10:5060 Action export(call_direction=outbound) Dialplan: sofia/internal/7777@192.168.2.10:5060 Action unset(call_timeout) Dialplan: sofia/internal/7777@192.168.2.10:5060 Action set(hangup_after_bridge=true) Dialplan: sofia/internal/7777@192.168.2.10:5060 Action set(effective_caller_id_name=${outbound_caller_id_name}) Dialplan: sofia/internal/7777@192.168.2.10:5060 Action set(effective_caller_id_number=${outbound_caller_id_number}) Dialplan: sofia/internal/7777@192.168.2.10:5060 Action set(ignore_display_updates=true) Dialplan: sofia/internal/7777@192.168.2.10:5060 Action set(callee_id_number=401) Dialplan: sofia/internal/7777@192.168.2.10:5060 Action set(continue_on_fail=true) Dialplan: sofia/internal/7777@192.168.2.10:5060 Action bridge({rtp_autoflush_during_bridge=false}sofia/gateway/af53c152-0f9c-4166-ad4f-3abf497e9abe/401) 2019-04-01 23:19:16.624363 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/7777@192.168.2.10:5060) State Change CS_ROUTING -> CS_EXECUTE 2019-04-01 23:19:16.624363 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/7777@192.168.2.10:5060) State ROUTING going to sleep 2019-04-01 23:19:16.624363 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/7777@192.168.2.10:5060) Running State Change CS_EXECUTE (Cur 1 Tot 7) 2019-04-01 23:19:16.624363 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/7777@192.168.2.10:5060) State EXECUTE 2019-04-01 23:19:16.624363 [DEBUG] mod_sofia.c:209 sofia/internal/7777@192.168.2.10:5060 SOFIA EXECUTE 2019-04-01 23:19:16.624363 [DEBUG] switch_core_state_machine.c:328 sofia/internal/7777@192.168.2.10:5060 Standard EXECUTE EXECUTE sofia/internal/7777@192.168.2.10:5060 export(origination_callee_id_name=401) 2019-04-01 23:19:16.624363 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [origination_callee_id_name]=[401] EXECUTE sofia/internal/7777@192.168.2.10:5060 set(RFC2822_DATE=Mon, 01 Apr 2019 23:19:16 +0300) 2019-04-01 23:19:16.624363 [DEBUG] mod_dptools.c:1598 SET sofia/internal/7777@192.168.2.10:5060 [RFC2822_DATE]=[Mon, 01 Apr 2019 23:19:16 +0300] EXECUTE sofia/internal/7777@192.168.2.10:5060 export(call_direction=local) 2019-04-01 23:19:16.624363 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [call_direction]=[local] EXECUTE sofia/internal/7777@192.168.2.10:5060 hash(insert/192.168.2.10-last_dial/7777/401) EXECUTE sofia/internal/7777@192.168.2.10:5060 set(sip_h_X-accountcode=) 2019-04-01 23:19:16.624363 [DEBUG] mod_dptools.c:1598 SET sofia/internal/7777@192.168.2.10:5060 [sip_h_X-accountcode]=[UNDEF] EXECUTE sofia/internal/7777@192.168.2.10:5060 export(call_direction=outbound) 2019-04-01 23:19:16.624363 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [call_direction]=[outbound] EXECUTE sofia/internal/7777@192.168.2.10:5060 unset(call_timeout) 2019-04-01 23:19:16.624363 [DEBUG] mod_dptools.c:1743 UNSET [call_timeout] EXECUTE sofia/internal/7777@192.168.2.10:5060 set(hangup_after_bridge=true) 2019-04-01 23:19:16.624363 [DEBUG] mod_dptools.c:1598 SET sofia/internal/7777@192.168.2.10:5060 [hangup_after_bridge]=[true] EXECUTE sofia/internal/7777@192.168.2.10:5060 set(effective_caller_id_name=) 2019-04-01 23:19:16.624363 [DEBUG] mod_dptools.c:1598 SET sofia/internal/7777@192.168.2.10:5060 [effective_caller_id_name]=[UNDEF] EXECUTE sofia/internal/7777@192.168.2.10:5060 set(effective_caller_id_number=) 2019-04-01 23:19:16.624363 [DEBUG] mod_dptools.c:1598 SET sofia/internal/7777@192.168.2.10:5060 [effective_caller_id_number]=[UNDEF] EXECUTE sofia/internal/7777@192.168.2.10:5060 set(ignore_display_updates=true) 2019-04-01 23:19:16.644362 [DEBUG] mod_dptools.c:1598 SET sofia/internal/7777@192.168.2.10:5060 [ignore_display_updates]=[true] EXECUTE sofia/internal/7777@192.168.2.10:5060 set(callee_id_number=401) 2019-04-01 23:19:16.644362 [DEBUG] mod_dptools.c:1598 SET sofia/internal/7777@192.168.2.10:5060 [callee_id_number]=[401] EXECUTE sofia/internal/7777@192.168.2.10:5060 set(continue_on_fail=true) 2019-04-01 23:19:16.644362 [DEBUG] mod_dptools.c:1598 SET sofia/internal/7777@192.168.2.10:5060 [continue_on_fail]=[true] EXECUTE sofia/internal/7777@192.168.2.10:5060 bridge({rtp_autoflush_during_bridge=false}sofia/gateway/af53c152-0f9c-4166-ad4f-3abf497e9abe/401) 2019-04-01 23:19:16.644362 [DEBUG] switch_channel.c:1250 sofia/internal/7777@192.168.2.10:5060 EXPORTING[export_vars] [domain_name]=[192.168.2.10] to event 2019-04-01 23:19:16.644362 [DEBUG] switch_channel.c:1250 sofia/internal/7777@192.168.2.10:5060 EXPORTING[export_vars] [origination_callee_id_name]=[401] to event 2019-04-01 23:19:16.644362 [DEBUG] switch_channel.c:1250 sofia/internal/7777@192.168.2.10:5060 EXPORTING[export_vars] [call_direction]=[outbound] to event 2019-04-01 23:19:16.644362 [DEBUG] switch_channel.c:1250 sofia/internal/7777@192.168.2.10:5060 EXPORTING[export_vars] [call_direction]=[outbound] to event 2019-04-01 23:19:16.644362 [DEBUG] switch_ivr_originate.c:2204 Parsing global variables 2019-04-01 23:19:16.644362 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/401 [46e3d37c-4663-40fd-8a89-fbc58a624fb5] 2019-04-01 23:19:16.644362 [DEBUG] mod_sofia.c:5019 (sofia/internal/401) State Change CS_NEW -> CS_INIT 2019-04-01 23:19:16.644362 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/401) Running State Change CS_INIT (Cur 2 Tot 8) 2019-04-01 23:19:16.644362 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/401) State INIT 2019-04-01 23:19:16.644362 [DEBUG] mod_sofia.c:93 sofia/internal/401 SOFIA INIT 2019-04-01 23:19:16.644362 [DEBUG] sofia_glue.c:1302 sofia/internal/401 sending invite version: 1.8.5 -6-31281a0bf1 64bit Local SDP: v=0 o=FreeSWITCH 1554117544 1554117545 IN IP4 192.168.2.10 s=FreeSWITCH c=IN IP4 192.168.2.10 t=0 0 m=audio 32412 RTP/AVP 8 101 13 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=rtpmap:13 CN/8000 a=ptime:20 a=sendrecv 2019-04-01 23:19:16.644362 [DEBUG] switch_core_state_machine.c:40 sofia/internal/401 Standard INIT 2019-04-01 23:19:16.644362 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/401) State Change CS_INIT -> CS_ROUTING 2019-04-01 23:19:16.644362 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/401) State INIT going to sleep send 1235 bytes to udp/[192.168.2.5]:5060 at 23:19:16.646518: ------------------------------------------------------------------------ INVITE sip:401@192.168.2.5 SIP/2.0 Via: SIP/2.0/UDP 192.168.2.10;rport;branch=z9hG4bKaD01jKXKySvej Max-Forwards: 69 From: "7777" <sip:9999@192.168.2.5>;tag=Fj74StZva720c To: <sip:401@192.168.2.5> Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78 CSeq: 2521186 INVITE Contact: <sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe@192.168.2.10:5060;transport=udp;gw=af53c152-0f9c-4166-ad4f-3abf497e9abe> User-Agent: FreeSWITCH Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, path, replaces Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Content-Type: application/sdp Content-Disposition: session Content-Length: 244 X-Siemens-Call-Type: ST-secure, ST-insecure X-FS-Support: update_display,send_info Remote-Party-ID: "7777" <sip:7777@192.168.2.5>;party=calling;screen=yes;privacy=off v=0 o=FreeSWITCH 1554117544 1554117545 IN IP4 192.168.2.10 s=FreeSWITCH c=IN IP4 192.168.2.10 t=0 0 m=audio 32412 RTP/AVP 8 101 13 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=rtpmap:13 CN/8000 a=ptime:20 ------------------------------------------------------------------------ 2019-04-01 23:19:16.644362 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/401) Running State Change CS_ROUTING (Cur 2 Tot 8) 2019-04-01 23:19:16.644362 [DEBUG] sofia.c:7291 Channel sofia/internal/401 entering state [calling][0] 2019-04-01 23:19:16.644362 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/401) State ROUTING 2019-04-01 23:19:16.644362 [DEBUG] mod_sofia.c:154 sofia/internal/401 SOFIA ROUTING 2019-04-01 23:19:16.644362 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/401) State Change CS_ROUTING -> CS_CONSUME_MEDIA 2019-04-01 23:19:16.644362 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/401) State ROUTING going to sleep 2019-04-01 23:19:16.644362 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/401) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 8) 2019-04-01 23:19:16.644362 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/401) State CONSUME_MEDIA 2019-04-01 23:19:16.644362 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/401) State CONSUME_MEDIA going to sleep recv 552 bytes from udp/[192.168.2.5]:5060 at 23:19:16.649851: ------------------------------------------------------------------------ SIP/2.0 407 Proxy Authentication Required Via: SIP/2.0/UDP 192.168.2.10;branch=z9hG4bKaD01jKXKySvej;received=192.168.2.10;rport=5060 From: "7777" <sip:9999@192.168.2.5>;tag=Fj74StZva720c To: <sip:401@192.168.2.5>;tag=as5f2ac2da Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78 CSeq: 2521186 INVITE User-Agent: fw2016052315-IVV14200.N2UHM Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Proxy-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="4c256898" Content-Length: 0 ------------------------------------------------------------------------ send 300 bytes to udp/[192.168.2.5]:5060 at 23:19:16.649935: ------------------------------------------------------------------------ ACK sip:401@192.168.2.5 SIP/2.0 Via: SIP/2.0/UDP 192.168.2.10;rport;branch=z9hG4bKaD01jKXKySvej Max-Forwards: 69 From: "7777" <sip:9999@192.168.2.5>;tag=Fj74StZva720c To: <sip:401@192.168.2.5>;tag=as5f2ac2da Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78 CSeq: 2521186 ACK Content-Length: 0 ------------------------------------------------------------------------ send 1403 bytes to udp/[192.168.2.5]:5060 at 23:19:16.650070: ------------------------------------------------------------------------ INVITE sip:401@192.168.2.5 SIP/2.0 Via: SIP/2.0/UDP 192.168.2.10;rport;branch=z9hG4bKBpStmeeQU2j1D Max-Forwards: 69 From: "7777" <sip:9999@192.168.2.5>;tag=Fj74StZva720c To: <sip:401@192.168.2.5> Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78 CSeq: 2521187 INVITE Contact: <sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe@192.168.2.10:5060;transport=udp;gw=af53c152-0f9c-4166-ad4f-3abf497e9abe> User-Agent: FreeSWITCH Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, path, replaces Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Proxy-Authorization: Digest username="9999", realm="asterisk", nonce="4c256898", algorithm=MD5, uri="sip:401@192.168.2.5", response="63b6418f049af14ff2d44e17d7d72f34" Content-Type: application/sdp Content-Disposition: session Content-Length: 244 X-Siemens-Call-Type: ST-secure, ST-insecure X-FS-Support: update_display,send_info Remote-Party-ID: "7777" <sip:7777@192.168.2.5>;party=calling;screen=yes;privacy=off v=0 o=FreeSWITCH 1554117544 1554117545 IN IP4 192.168.2.10 s=FreeSWITCH c=IN IP4 192.168.2.10 t=0 0 m=audio 32412 RTP/AVP 8 101 13 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=rtpmap:13 CN/8000 a=ptime:20 ------------------------------------------------------------------------ 2019-04-01 23:19:16.644362 [DEBUG] sofia.c:7291 Channel sofia/internal/401 entering state [calling][0] recv 503 bytes from udp/[192.168.2.5]:5060 at 23:19:16.654639: ------------------------------------------------------------------------ SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.2.10;branch=z9hG4bKBpStmeeQU2j1D;received=192.168.2.10;rport=5060 From: "7777" <sip:9999@192.168.2.5>;tag=Fj74StZva720c To: <sip:401@192.168.2.5> Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78 CSeq: 2521187 INVITE User-Agent: fw2016052315-IVV14200.N2UHM Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Session-Expires: -1;refresher=uac Contact: <sip:401@192.168.2.5> Content-Length: 0 ------------------------------------------------------------------------ recv 535 bytes from udp/[192.168.2.5]:5060 at 23:19:16.678633: ------------------------------------------------------------------------ SIP/2.0 180 Ringing Via: SIP/2.0/UDP 192.168.2.10;branch=z9hG4bKBpStmeeQU2j1D;received=192.168.2.10;rport=5060 From: "7777" <sip:9999@192.168.2.5>;tag=Fj74StZva720c To: <sip:401@192.168.2.5>;tag=as10f04bc3 Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78 CSeq: 2521187 INVITE User-Agent: fw2016052315-IVV14200.N2UHM Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Session-Expires: -1;refresher=uac Contact: <sip:401@192.168.2.5> Require: timer Content-Length: 0 ------------------------------------------------------------------------ send 1403 bytes to udp/[192.168.2.5]:5060 at 23:19:17.650231: ------------------------------------------------------------------------ INVITE sip:401@192.168.2.5 SIP/2.0 Via: SIP/2.0/UDP 192.168.2.10;rport;branch=z9hG4bKBpStmeeQU2j1D Max-Forwards: 69 From: "7777" <sip:9999@192.168.2.5>;tag=Fj74StZva720c To: <sip:401@192.168.2.5> Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78 CSeq: 2521187 INVITE Contact: <sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe@192.168.2.10:5060;transport=udp;gw=af53c152-0f9c-4166-ad4f-3abf497e9abe> User-Agent: FreeSWITCH Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, path, replaces Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Proxy-Authorization: Digest username="9999", realm="asterisk", nonce="4c256898", algorithm=MD5, uri="sip:401@192.168.2.5", response="63b6418f049af14ff2d44e17d7d72f34" Content-Type: application/sdp Content-Disposition: session Content-Length: 244 X-Siemens-Call-Type: ST-secure, ST-insecure X-FS-Support: update_display,send_info Remote-Party-ID: "7777" <sip:7777@192.168.2.5>;party=calling;screen=yes;privacy=off v=0 o=FreeSWITCH 1554117544 1554117545 IN IP4 192.168.2.10 s=FreeSWITCH c=IN IP4 192.168.2.10 t=0 0 m=audio 32412 RTP/AVP 8 101 13 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=rtpmap:13 CN/8000 a=ptime:20 ------------------------------------------------------------------------ recv 503 bytes from udp/[192.168.2.5]:5060 at 23:19:17.652893: ------------------------------------------------------------------------ SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.2.10;branch=z9hG4bKBpStmeeQU2j1D;received=192.168.2.10;rport=5060 From: "7777" <sip:9999@192.168.2.5>;tag=Fj74StZva720c To: <sip:401@192.168.2.5> Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78 CSeq: 2521187 INVITE User-Agent: fw2016052315-IVV14200.N2UHM Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Session-Expires: -1;refresher=uac Contact: <sip:401@192.168.2.5> Content-Length: 0 ------------------------------------------------------------------------ send 1403 bytes to udp/[192.168.2.5]:5060 at 23:19:19.650267: ------------------------------------------------------------------------ INVITE sip:401@192.168.2.5 SIP/2.0 Via: SIP/2.0/UDP 192.168.2.10;rport;branch=z9hG4bKBpStmeeQU2j1D Max-Forwards: 69 From: "7777" <sip:9999@192.168.2.5>;tag=Fj74StZva720c To: <sip:401@192.168.2.5> Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78 CSeq: 2521187 INVITE Contact: <sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe@192.168.2.10:5060;transport=udp;gw=af53c152-0f9c-4166-ad4f-3abf497e9abe> User-Agent: FreeSWITCH Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, path, replaces Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Proxy-Authorization: Digest username="9999", realm="asterisk", nonce="4c256898", algorithm=MD5, uri="sip:401@192.168.2.5", response="63b6418f049af14ff2d44e17d7d72f34" Content-Type: application/sdp Content-Disposition: session Content-Length: 244 X-Siemens-Call-Type: ST-secure, ST-insecure X-FS-Support: update_display,send_info Remote-Party-ID: "7777" <sip:7777@192.168.2.5>;party=calling;screen=yes;privacy=off v=0 o=FreeSWITCH 1554117544 1554117545 IN IP4 192.168.2.10 s=FreeSWITCH c=IN IP4 192.168.2.10 t=0 0 m=audio 32412 RTP/AVP 8 101 13 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=rtpmap:13 CN/8000 a=ptime:20 ------------------------------------------------------------------------ recv 503 bytes from udp/[192.168.2.5]:5060 at 23:19:19.656053: ------------------------------------------------------------------------ SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.2.10;branch=z9hG4bKBpStmeeQU2j1D;received=192.168.2.10;rport=5060 From: "7777" <sip:9999@192.168.2.5>;tag=Fj74StZva720c To: <sip:401@192.168.2.5> Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78 CSeq: 2521187 INVITE User-Agent: fw2016052315-IVV14200.N2UHM Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Session-Expires: -1;refresher=uac Contact: <sip:401@192.168.2.5> Content-Length: 0 ------------------------------------------------------------------------ send 1403 bytes to udp/[192.168.2.5]:5060 at 23:19:23.650317: ------------------------------------------------------------------------ INVITE sip:401@192.168.2.5 SIP/2.0 Via: SIP/2.0/UDP 192.168.2.10;rport;branch=z9hG4bKBpStmeeQU2j1D Max-Forwards: 69 From: "7777" <sip:9999@192.168.2.5>;tag=Fj74StZva720c To: <sip:401@192.168.2.5> Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78 CSeq: 2521187 INVITE Contact: <sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe@192.168.2.10:5060;transport=udp;gw=af53c152-0f9c-4166-ad4f-3abf497e9abe> User-Agent: FreeSWITCH Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, path, replaces Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Proxy-Authorization: Digest username="9999", realm="asterisk", nonce="4c256898", algorithm=MD5, uri="sip:401@192.168.2.5", response="63b6418f049af14ff2d44e17d7d72f34" Content-Type: application/sdp Content-Disposition: session Content-Length: 244 X-Siemens-Call-Type: ST-secure, ST-insecure X-FS-Support: update_display,send_info Remote-Party-ID: "7777" <sip:7777@192.168.2.5>;party=calling;screen=yes;privacy=off v=0 o=FreeSWITCH 1554117544 1554117545 IN IP4 192.168.2.10 s=FreeSWITCH c=IN IP4 192.168.2.10 t=0 0 m=audio 32412 RTP/AVP 8 101 13 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=rtpmap:13 CN/8000 a=ptime:20 ------------------------------------------------------------------------ recv 503 bytes from udp/[192.168.2.5]:5060 at 23:19:23.653116: ------------------------------------------------------------------------ SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.2.10;branch=z9hG4bKBpStmeeQU2j1D;received=192.168.2.10;rport=5060 From: "7777" <sip:9999@192.168.2.5>;tag=Fj74StZva720c To: <sip:401@192.168.2.5> Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78 CSeq: 2521187 INVITE User-Agent: fw2016052315-IVV14200.N2UHM Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Session-Expires: -1;refresher=uac Contact: <sip:401@192.168.2.5> Content-Length: 0 ------------------------------------------------------------------------ recv 745 bytes from udp/[192.168.2.5]:5060 at 23:19:24.548759: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.2.10;branch=z9hG4bKBpStmeeQU2j1D;received=192.168.2.10;rport=5060 From: "7777" <sip:9999@192.168.2.5>;tag=Fj74StZva720c To: <sip:401@192.168.2.5>;tag=as10f04bc3 Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78 CSeq: 2521187 INVITE User-Agent: fw2016052315-IVV14200.N2UHM Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Session-Expires: -1;refresher=uac Contact: <sip:401@192.168.2.5> Require: timer Content-Type: application/sdp Content-Length: 182 v=0 o=root 23324 23324 IN IP4 192.168.2.5 s=session c=IN IP4 192.168.2.5 t=0 0 m=audio 11598 RTP/AVP 8 a=rtpmap:8 PCMA/8000 a=silenceSupp:off - - - - a=ptime:20 a=sendrecv ------------------------------------------------------------------------ recv 745 bytes from udp/[192.168.2.5]:5060 at 23:19:25.549674: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.2.10;branch=z9hG4bKBpStmeeQU2j1D;received=192.168.2.10;rport=5060 From: "7777" <sip:9999@192.168.2.5>;tag=Fj74StZva720c To: <sip:401@192.168.2.5>;tag=as10f04bc3 Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78 CSeq: 2521187 INVITE User-Agent: fw2016052315-IVV14200.N2UHM Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Session-Expires: -1;refresher=uac Contact: <sip:401@192.168.2.5> Require: timer Content-Type: application/sdp Content-Length: 182 v=0 o=root 23324 23324 IN IP4 192.168.2.5 s=session c=IN IP4 192.168.2.5 t=0 0 m=audio 11598 RTP/AVP 8 a=rtpmap:8 PCMA/8000 a=silenceSupp:off - - - - a=ptime:20 a=sendrecv ------------------------------------------------------------------------ recv 745 bytes from udp/[192.168.2.5]:5060 at 23:19:26.550846: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.2.10;branch=z9hG4bKBpStmeeQU2j1D;received=192.168.2.10;rport=5060 From: "7777" <sip:9999@192.168.2.5>;tag=Fj74StZva720c To: <sip:401@192.168.2.5>;tag=as10f04bc3 Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78 CSeq: 2521187 INVITE User-Agent: fw2016052315-IVV14200.N2UHM Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Session-Expires: -1;refresher=uac Contact: <sip:401@192.168.2.5> Require: timer Content-Type: application/sdp Content-Length: 182 v=0 o=root 23324 23324 IN IP4 192.168.2.5 s=session c=IN IP4 192.168.2.5 t=0 0 m=audio 11598 RTP/AVP 8 a=rtpmap:8 PCMA/8000 a=silenceSupp:off - - - - a=ptime:20 a=sendrecv ------------------------------------------------------------------------ recv 745 bytes from udp/[192.168.2.5]:5060 at 23:19:28.550669: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.2.10;branch=z9hG4bKBpStmeeQU2j1D;received=192.168.2.10;rport=5060 From: "7777" <sip:9999@192.168.2.5>;tag=Fj74StZva720c To: <sip:401@192.168.2.5>;tag=as10f04bc3 Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78 CSeq: 2521187 INVITE User-Agent: fw2016052315-IVV14200.N2UHM Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Session-Expires: -1;refresher=uac Contact: <sip:401@192.168.2.5> Require: timer Content-Type: application/sdp Content-Length: 182 v=0 o=root 23324 23324 IN IP4 192.168.2.5 s=session c=IN IP4 192.168.2.5 t=0 0 m=audio 11598 RTP/AVP 8 a=rtpmap:8 PCMA/8000 a=silenceSupp:off - - - - a=ptime:20 a=sendrecv ------------------------------------------------------------------------ recv 432 bytes from udp/[192.168.2.5]:5060 at 23:19:30.442714: ------------------------------------------------------------------------ BYE sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe@192.168.2.10:5060;transport=udp;gw=af53c152-0f9c-4166-ad4f-3abf497e9abe SIP/2.0 Via: SIP/2.0/UDP 192.168.2.5:5060;branch=z9hG4bK2836912f;rport From: <sip:401@192.168.2.5>;tag=as10f04bc3 To: "7777" <sip:9999@192.168.2.5>;tag=Fj74StZva720c Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78 CSeq: 102 BYE User-Agent: fw2016052315-IVV14200.N2UHM Max-Forwards: 70 Content-Length: 0 ------------------------------------------------------------------------ 2019-04-01 23:19:30.424363 [NOTICE] sofia.c:1079 Hangup sofia/internal/401 [CS_CONSUME_MEDIA] [NORMAL_CLEARING] 2019-04-01 23:19:30.424363 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/401) Running State Change CS_HANGUP (Cur 2 Tot 8) send 433 bytes to udp/[192.168.2.5]:5060 at 23:19:30.443518: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.2.5:5060;branch=z9hG4bK2836912f;rport=5060 From: <sip:401@192.168.2.5>;tag=as10f04bc3 To: "7777" <sip:9999@192.168.2.5>;tag=Fj74StZva720c Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78 CSeq: 102 BYE User-Agent: FreeSWITCH Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, path, replaces Content-Length: 0 ------------------------------------------------------------------------ 2019-04-01 23:19:30.424363 [DEBUG] switch_core_state_machine.c:847 (sofia/internal/401) Callstate Change DOWN -> HANGUP 2019-04-01 23:19:30.424363 [DEBUG] switch_core_state_machine.c:849 (sofia/internal/401) State HANGUP 2019-04-01 23:19:30.424363 [DEBUG] mod_sofia.c:449 Channel sofia/internal/401 hanging up, cause: NORMAL_CLEARING 2019-04-01 23:19:30.424363 [DEBUG] switch_core_state_machine.c:60 sofia/internal/401 Standard HANGUP, cause: NORMAL_CLEARING 2019-04-01 23:19:30.424363 [DEBUG] switch_core_state_machine.c:849 (sofia/internal/401) State HANGUP going to sleep 2019-04-01 23:19:30.424363 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/401) State Change CS_HANGUP -> CS_REPORTING 2019-04-01 23:19:30.424363 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/401) Running State Change CS_REPORTING (Cur 2 Tot 8) 2019-04-01 23:19:30.424363 [DEBUG] switch_core_state_machine.c:935 (sofia/internal/401) State REPORTING 2019-04-01 23:19:30.424363 [DEBUG] switch_core_state_machine.c:174 sofia/internal/401 Standard REPORTING, cause: NORMAL_CLEARING 2019-04-01 23:19:30.424363 [DEBUG] switch_core_state_machine.c:935 (sofia/internal/401) State REPORTING going to sleep 2019-04-01 23:19:30.424363 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/401) State Change CS_REPORTING -> CS_DESTROY 2019-04-01 23:19:30.424363 [DEBUG] switch_core_session.c:1715 Session 8 (sofia/internal/401) Locked, Waiting on external entities 2019-04-01 23:19:30.444362 [DEBUG] switch_ivr_originate.c:3941 Originate Resulted in Error Cause: 16 [NORMAL_CLEARING] 2019-04-01 23:19:30.444362 [NOTICE] switch_core_session.c:1733 Session 8 (sofia/internal/401) Ended 2019-04-01 23:19:30.444362 [NOTICE] switch_core_session.c:1737 Close Channel sofia/internal/401 [CS_DESTROY] 2019-04-01 23:19:30.444362 [DEBUG] switch_core_state_machine.c:738 (sofia/internal/401) Running State Change CS_DESTROY (Cur 1 Tot 8) 2019-04-01 23:19:30.444362 [DEBUG] switch_core_state_machine.c:748 (sofia/internal/401) State DESTROY 2019-04-01 23:19:30.444362 [DEBUG] mod_sofia.c:354 sofia/internal/401 SOFIA DESTROY 2019-04-01 23:19:30.444362 [DEBUG] switch_core_state_machine.c:181 sofia/internal/401 Standard DESTROY 2019-04-01 23:19:30.444362 [DEBUG] switch_core_state_machine.c:748 (sofia/internal/401) State DESTROY going to sleep 2019-04-01 23:19:30.444362 [INFO] mod_dptools.c:3518 Originate Failed. Cause: NORMAL_CLEARING 2019-04-01 23:19:30.444362 [NOTICE] switch_core_state_machine.c:385 sofia/internal/7777@192.168.2.10:5060 has executed the last dialplan instruction, hanging up. 2019-04-01 23:19:30.444362 [NOTICE] switch_core_state_machine.c:387 Hangup sofia/internal/7777@192.168.2.10:5060 [CS_EXECUTE] [NORMAL_CLEARING] 2019-04-01 23:19:30.444362 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/7777@192.168.2.10:5060) State EXECUTE going to sleep 2019-04-01 23:19:30.444362 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/7777@192.168.2.10:5060) Running State Change CS_HANGUP (Cur 1 Tot 8) 2019-04-01 23:19:30.444362 [DEBUG] switch_core_state_machine.c:847 (sofia/internal/7777@192.168.2.10:5060) Callstate Change RINGING -> HANGUP 2019-04-01 23:19:30.444362 [DEBUG] switch_core_state_machine.c:849 (sofia/internal/7777@192.168.2.10:5060) State HANGUP 2019-04-01 23:19:30.444362 [DEBUG] mod_sofia.c:443 sofia/internal/7777@192.168.2.10:5060 Overriding SIP cause 480 with 200 from the other leg 2019-04-01 23:19:30.444362 [DEBUG] mod_sofia.c:449 Channel sofia/internal/7777@192.168.2.10:5060 hanging up, cause: NORMAL_CLEARING 2019-04-01 23:19:30.444362 [DEBUG] mod_sofia.c:589 Responding to INVITE with: 200 2019-04-01 23:19:30.444362 [DEBUG] switch_core_state_machine.c:60 sofia/internal/7777@192.168.2.10:5060 Standard HANGUP, cause: NORMAL_CLEARING 2019-04-01 23:19:30.444362 [DEBUG] switch_core_state_machine.c:849 (sofia/internal/7777@192.168.2.10:5060) State HANGUP going to sleep 2019-04-01 23:19:30.444362 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/7777@192.168.2.10:5060) State Change CS_HANGUP -> CS_REPORTING send 946 bytes to udp/[192.168.2.41]:5060 at 23:19:30.460487: ------------------------------------------------------------------------ SIP/2.0 500 No session set by user Via: SIP/2.0/UDP 192.168.2.41;branch=z9hG4bK169fc7e5a6e1207bd;rport=5060 Max-Forwards: 70 From: "7777" <sip:7777@192.168.2.10:5060>;tag=c607ca2663;epid=SC0c351a To: <sip:401@192.168.2.10:5060>;tag=e9DcrZeSDyceH Call-ID: 356f4bddc52d1c96 CSeq: 2140941627 INVITE Contact: <sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe@192.168.2.10:5060;transport=udp;gw=af53c152-0f9c-4166-ad4f-3abf497e9abe> User-Agent: FreeSWITCH Accept: application/sdp Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, path, replaces Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Reason: Q.850;cause=16;text="NORMAL_CLEARING" Content-Length: 0 Remote-Party-ID: "401" <sip:401@192.168.2.10>;party=calling;privacy=off;screen=no ------------------------------------------------------------------------ 2019-04-01 23:19:30.444362 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/7777@192.168.2.10:5060) Running State Change CS_REPORTING (Cur 1 Tot 8) 2019-04-01 23:19:30.444362 [DEBUG] switch_core_state_machine.c:935 (sofia/internal/7777@192.168.2.10:5060) State REPORTING recv 430 bytes from udp/[192.168.2.41]:5060 at 23:19:30.466346: ------------------------------------------------------------------------ ACK sip:401@192.168.2.10:5060;transport=udp SIP/2.0 Via: SIP/2.0/UDP 192.168.2.41;branch=z9hG4bK169fc7e5a6e1207bd Route: <sip:192.168.2.10:5060;lr;transport=udp> Max-Forwards: 70 From: "7777" <sip:7777@192.168.2.10:5060>;tag=c607ca2663;epid=SC0c351a To: <sip:401@192.168.2.10:5060>;tag=e9DcrZeSDyceH Call-ID: 356f4bddc52d1c96 CSeq: 2140941627 ACK User-Agent: OpenStage_40_V3 R4.10.0 SIP 160728 Content-Length: 0 ------------------------------------------------------------------------ 2019-04-01 23:19:30.524364 [DEBUG] switch_core_state_machine.c:174 sofia/internal/7777@192.168.2.10:5060 Standard REPORTING, cause: NORMAL_CLEARING 2019-04-01 23:19:30.524364 [DEBUG] switch_core_state_machine.c:935 (sofia/internal/7777@192.168.2.10:5060) State REPORTING going to sleep 2019-04-01 23:19:30.524364 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/7777@192.168.2.10:5060) State Change CS_REPORTING -> CS_DESTROY 2019-04-01 23:19:30.524364 [DEBUG] switch_core_session.c:1715 Session 7 (sofia/internal/7777@192.168.2.10:5060) Locked, Waiting on external entities 2019-04-01 23:19:30.524364 [NOTICE] switch_core_session.c:1733 Session 7 (sofia/internal/7777@192.168.2.10:5060) Ended 2019-04-01 23:19:30.524364 [NOTICE] switch_core_session.c:1737 Close Channel sofia/internal/7777@192.168.2.10:5060 [CS_DESTROY] 2019-04-01 23:19:30.524364 [DEBUG] switch_core_state_machine.c:738 (sofia/internal/7777@192.168.2.10:5060) Running State Change CS_DESTROY (Cur 0 Tot 8) 2019-04-01 23:19:30.524364 [DEBUG] switch_core_state_machine.c:748 (sofia/internal/7777@192.168.2.10:5060) State DESTROY 2019-04-01 23:19:30.524364 [DEBUG] mod_sofia.c:354 sofia/internal/7777@192.168.2.10:5060 SOFIA DESTROY 2019-04-01 23:19:30.524364 [DEBUG] switch_core_state_machine.c:181 sofia/internal/7777@192.168.2.10:5060 Standard DESTROY 2019-04-01 23:19:30.524364 [DEBUG] switch_core_state_machine.c:748 (sofia/internal/7777@192.168.2.10:5060) State DESTROY going to sleep recv 729 bytes from udp/[192.168.2.5]:5060 at 23:19:31.421113: ------------------------------------------------------------------------ OPTIONS sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe@192.168.2.10:5060;transport=udp;gw=af53c152-0f9c-4166-ad4f-3abf497e9abe.OxygenPBX SIP/2.0 Via: SIP/2.0/UDP 192.168.2.5:5060;branch=z9hG4bK17ff44d5;rport From: "unknown" <sip:unknown@192.168.2.5;user=phone>;tag=as44d33727 To: <sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe@192.168.2.10:5060;transport=udp;gw=af53c152-0f9c-4166-ad4f-3abf497e9abe> Contact: <sip:unknown@192.168.2.5> Call-ID: 766e66790050605e7b4939ee7d1ae247(a)192.168.2.5 CSeq: 102 OPTIONS User-Agent: fw2016052315-IVV14200.N2UHM Max-Forwards: 0 Date: Mon, 01 Apr 2019 20:19:31 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces Content-Length: 0 ------------------------------------------------------------------------ send 882 bytes to udp/[192.168.2.5]:5060 at 23:19:31.421408: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.2.5:5060;branch=z9hG4bK17ff44d5;rport=5060 From: "unknown" <sip:unknown@192.168.2.5;user=phone>;tag=as44d33727 To: <sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe@192.168.2.10:5060;transport=udp;gw=af53c152-0f9c-4166-ad4f-3abf497e9abe>;tag=gU0XUNg07FSKr Call-ID: 766e66790050605e7b4939ee7d1ae247(a)192.168.2.5 CSeq: 102 OPTIONS Contact: <sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe@192.168.2.10:5060;transport=udp;gw=af53c152-0f9c-4166-ad4f-3abf497e9abe> User-Agent: FreeSWITCH Accept: application/sdp Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, path, replaces Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Content-Length: 0 ------------------------------------------------------------------------ send 1403 bytes to udp/[192.168.2.5]:5060 at 23:19:31.649571: ------------------------------------------------------------------------ INVITE sip:401@192.168.2.5 SIP/2.0 Via: SIP/2.0/UDP 192.168.2.10;rport;branch=z9hG4bKBpStmeeQU2j1D Max-Forwards: 69 From: "7777" <sip:9999@192.168.2.5>;tag=Fj74StZva720c To: <sip:401@192.168.2.5> Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78 CSeq: 2521187 INVITE Contact: <sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe@192.168.2.10:5060;transport=udp;gw=af53c152-0f9c-4166-ad4f-3abf497e9abe> User-Agent: FreeSWITCH Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, path, replaces Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Proxy-Authorization: Digest username="9999", realm="asterisk", nonce="4c256898", algorithm=MD5, uri="sip:401@192.168.2.5", response="63b6418f049af14ff2d44e17d7d72f34" Content-Type: application/sdp Content-Disposition: session Content-Length: 244 X-Siemens-Call-Type: ST-secure, ST-insecure X-FS-Support: update_display,send_info Remote-Party-ID: "7777" <sip:7777@192.168.2.5>;party=calling;screen=yes;privacy=off v=0 o=FreeSWITCH 1554117544 1554117545 IN IP4 192.168.2.10 s=FreeSWITCH c=IN IP4 192.168.2.10 t=0 0 m=audio 32412 RTP/AVP 8 101 13 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=rtpmap:13 CN/8000 a=ptime:20 ------------------------------------------------------------------------ recv 507 bytes from udp/[192.168.2.5]:5060 at 23:19:31.652645: ------------------------------------------------------------------------ SIP/2.0 503 Unavailable Via: SIP/2.0/UDP 192.168.2.10;branch=z9hG4bKBpStmeeQU2j1D;received=192.168.2.10;rport=5060 From: "7777" <sip:9999@192.168.2.5>;tag=Fj74StZva720c To: <sip:401@192.168.2.5>;tag=as10f04bc3 Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78 CSeq: 2521187 INVITE User-Agent: fw2016052315-IVV14200.N2UHM Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Session-Expires: -1;refresher=uac Require: timer Content-Length: 0 ------------------------------------------------------------------------ recv 745 bytes from udp/[192.168.2.5]:5060 at 23:19:32.549718: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.2.10;branch=z9hG4bKBpStmeeQU2j1D;received=192.168.2.10;rport=5060 From: "7777" <sip:9999@192.168.2.5>;tag=Fj74StZva720c To: <sip:401@192.168.2.5>;tag=as10f04bc3 Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78 CSeq: 2521187 INVITE User-Agent: fw2016052315-IVV14200.N2UHM Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Session-Expires: -1;refresher=uac Contact: <sip:401@192.168.2.5> Require: timer Content-Type: application/sdp Content-Length: 182 v=0 o=root 23324 23324 IN IP4 192.168.2.5 s=session c=IN IP4 192.168.2.5 t=0 0 m=audio 11598 RTP/AVP 8 a=rtpmap:8 PCMA/8000 a=silenceSupp:off - - - - a=ptime:20 a=sendrecv ------------------------------------------------------------------------ recv 745 bytes from udp/[192.168.2.5]:5060 at 23:19:36.550696: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.2.10;branch=z9hG4bKBpStmeeQU2j1D;received=192.168.2.10;rport=5060 From: "7777" <sip:9999@192.168.2.5>;tag=Fj74StZva720c To: <sip:401@192.168.2.5>;tag=as10f04bc3 Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78 CSeq: 2521187 INVITE User-Agent: fw2016052315-IVV14200.N2UHM Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Session-Expires: -1;refresher=uac Contact: <sip:401@192.168.2.5> Require: timer Content-Type: application/sdp Content-Length: 182 v=0 o=root 23324 23324 IN IP4 192.168.2.5 s=session c=IN IP4 192.168.2.5 t=0 0 m=audio 11598 RTP/AVP 8 a=rtpmap:8 PCMA/8000 a=silenceSupp:off - - - - a=ptime:20 a=sendrecv ———————————————————————————————————— And tcpdump trace 23:25:02.314879 IP6 fe80::dc5a:83fe:4382:a063.52511 > ff02::c.1900: UDP, length 146 23:25:02.350131 IP 192.168.2.10.52081 > oxygen.voip.domain: 12070+ PTR? c.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.2.0.f.f.ip6.arpa. (90) 23:25:02.387056 IP oxygen.voip.domain > 192.168.2.10.52081: 12070 NXDomain 0/1/0 (154) 23:25:02.387158 IP 192.168.2.10.34229 > oxygen.voip.domain: 31187+ PTR? 3.6.0.a.2.8.3.4.e.f.3.8.a.5.c.d.0.0.0.0.0.0.0.0.0.0.0.0.0.8.e.f.ip6.arpa. (90) 23:25:02.424498 IP oxygen.voip.domain > 192.168.2.10.34229: 31187 NXDomain* 0/1/0 (154) 23:25:02.424603 IP 192.168.2.10.39283 > oxygen.voip.domain: 10115+ PTR? 5.2.168.192.in-addr.arpa. (42) 23:25:02.426138 IP oxygen.voip.domain > 192.168.2.10.39283: 10115* 1/0/0 PTR oxygen.voip. (67) 23:25:02.426220 IP 192.168.2.10.33703 > oxygen.voip.domain: 53769+ PTR? 10.2.168.192.in-addr.arpa. (43) 23:25:02.688484 IP 7777.lan.sip > 192.168.2.10.sip: SIP: INVITE sip:401@192.168.2.10:5060;transport=udp SIP/2.0 23:25:02.688546 IP 192.168.2.10.52828 > oxygen.voip.domain: 19632+ PTR? 41.2.168.192.in-addr.arpa. (43) 23:25:02.689888 IP oxygen.voip.domain > 192.168.2.10.52828: 19632* 1/0/0 PTR 7777.lan. (65) 23:25:02.695341 IP 192.168.2.10.sip > 7777.lan.sip: SIP: SIP/2.0 100 Trying 23:25:02.723923 IP 192.168.2.10.sip > oxygen.voip.sip: SIP: INVITE sip:401@192.168.2.5 SIP/2.0 23:25:02.727637 IP oxygen.voip.sip > 192.168.2.10.sip: SIP: SIP/2.0 407 Proxy Authentication Required 23:25:02.727789 IP 192.168.2.10.sip > oxygen.voip.sip: SIP: ACK sip:401@192.168.2.5 SIP/2.0 23:25:02.727946 IP 192.168.2.10.sip > oxygen.voip.sip: SIP: INVITE sip:401@192.168.2.5 SIP/2.0 23:25:02.732641 IP oxygen.voip.sip > 192.168.2.10.sip: SIP: SIP/2.0 100 Trying 23:25:02.756941 IP oxygen.voip.sip > 192.168.2.10.sip: SIP: SIP/2.0 180 Ringing 23:25:03.728747 IP 192.168.2.10.sip > oxygen.voip.sip: SIP: INVITE sip:401@192.168.2.5 SIP/2.0 23:25:03.731200 IP oxygen.voip.sip > 192.168.2.10.sip: SIP: SIP/2.0 100 Trying 23:25:05.728767 IP 192.168.2.10.sip > oxygen.voip.sip: SIP: INVITE sip:401@192.168.2.5 SIP/2.0 23:25:05.731230 IP oxygen.voip.sip > 192.168.2.10.sip: SIP: SIP/2.0 100 Trying 23:25:08.436779 IP oxygen.voip.sip > 192.168.2.10.sip: SIP: SIP/2.0 200 OK 23:25:08.446653 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.446678 IP 192.168.2.10 > oxygen.voip: ICMP 192.168.2.10 udp port 28242 unreachable, length 208 23:25:08.466422 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.466437 IP 192.168.2.10 > oxygen.voip: ICMP 192.168.2.10 udp port 28242 unreachable, length 208 23:25:08.486334 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.486347 IP 192.168.2.10 > oxygen.voip: ICMP 192.168.2.10 udp port 28242 unreachable, length 208 23:25:08.487440 STP 802.1d, Config, Flags [none], bridge-id 8000.00:1d:1c:04:d5:ac.8001, length 43 23:25:08.506432 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.506447 IP 192.168.2.10 > oxygen.voip: ICMP 192.168.2.10 udp port 28242 unreachable, length 208 23:25:08.526267 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.526282 IP 192.168.2.10 > oxygen.voip: ICMP 192.168.2.10 udp port 28242 unreachable, length 208 23:25:08.546424 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.546438 IP 192.168.2.10 > oxygen.voip: ICMP 192.168.2.10 udp port 28242 unreachable, length 208 23:25:08.566329 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.586319 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.606286 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.626212 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.646351 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.666312 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.686319 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.706279 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.726197 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.746407 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.766435 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.786410 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.806302 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.826217 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.846282 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.866301 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.886329 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.906297 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.926239 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.946346 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.966305 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:08.986323 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.006257 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.026221 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.046302 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.066320 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.086294 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.106293 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.126197 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.146430 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.166309 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.186300 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.206286 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.226221 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.248148 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.266316 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.286334 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.306288 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.326226 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.346445 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.366325 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.386362 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.406327 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.426218 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.437838 IP oxygen.voip.sip > 192.168.2.10.sip: SIP: SIP/2.0 200 OK 23:25:09.446354 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.446369 IP 192.168.2.10 > oxygen.voip: ICMP 192.168.2.10 udp port 28242 unreachable, length 208 23:25:09.466410 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.486235 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.506303 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.526276 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.546373 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.566296 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.586274 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.606280 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.626284 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.646287 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.666365 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.686269 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.706309 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.726314 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.728766 IP 192.168.2.10.sip > oxygen.voip.sip: SIP: INVITE sip:401@192.168.2.5 SIP/2.0 23:25:09.731172 IP oxygen.voip.sip > 192.168.2.10.sip: SIP: SIP/2.0 100 Trying 23:25:09.732357 IP oxygen.voip.sip > 192.168.2.10.sip: SIP: SIP/2.0 200 OK 23:25:09.746460 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.766311 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.786286 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.806338 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.826311 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.846239 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.866314 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.886412 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.906337 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.926263 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.946425 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.966306 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:09.986324 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.006330 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.026315 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.046240 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.066301 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.086279 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.106327 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.151813 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.152079 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.166330 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.186327 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.206532 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.226295 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.246244 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.266318 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.286333 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.306284 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.326333 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.347574 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.366315 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.386367 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.406282 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.426324 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.437839 IP oxygen.voip.sip > 192.168.2.10.sip: SIP: SIP/2.0 200 OK 23:25:10.446305 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.446320 IP 192.168.2.10 > oxygen.voip: ICMP 192.168.2.10 udp port 28242 unreachable, length 208 23:25:10.466345 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.486276 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.487434 STP 802.1d, Config, Flags [none], bridge-id 8000.00:1d:1c:04:d5:ac.8001, length 43 23:25:10.506361 IP oxygen.voip.10424 > 192.168.2.10.28242: UDP, length 172 23:25:10.521924 IP oxygen.voip.sip > 192.168.2.10.sip: SIP: BYE sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe@192.168.2.10:5060;transport=udp;gw=af53c152-0f9c-4166-ad4f-3abf497e9abe SIP/2.0 23:25:10.522745 IP 192.168.2.10.sip > oxygen.voip.sip: SIP: SIP/2.0 200 OK 23:25:10.533129 IP 192.168.2.10.sip > 7777.lan.sip: SIP: SIP/2.0 500 No session set by user 23:25:10.540064 IP 7777.lan.sip > 192.168.2.10.sip: SIP: ACK sip:401@192.168.2.10:5060;transport=udp SIP/2.0 23:25:12.316170 IP6 fe80::dc5a:83fe:4382:a063.52511 > ff02::c.1900: UDP, length 146 23:25:12.437875 IP oxygen.voip.sip > 192.168.2.10.sip: SIP: SIP/2.0 200 OK 23:25:12.487408 STP 802.1d, Config, Flags [none], bridge-id 8000.00:1d:1c:04:d5:ac.8001, length 43 23:25:14.487284 STP 802.1d, Config, Flags [none], bridge-id 8000.00:1d:1c:04:d5:ac.8001, length 43 23:25:15.902213 IP 192.168.2.10.ntp > ns4.asda.gr.ntp: NTPv4, Client, length 48 23:25:15.902312 IP 192.168.2.10.34483 > oxygen.voip.domain: 23686+ PTR? 194.164.93.193.in-addr.arpa. (45) 23:25:15.903728 IP oxygen.voip.domain > 192.168.2.10.34483: 23686 1/0/0 PTR ns4.asda.gr. (70) 23:25:15.934167 IP ns4.asda.gr.ntp > 192.168.2.10.ntp: NTPv4, Server, length 48 23:25:16.317586 IP6 fe80::dc5a:83fe:4382:a063.52511 > ff02::c.1900: UDP, length 146

1 0

conference layout in verto
by Vishal Pai 01 Apr '19

01 Apr '19

Hi Eeveryone I have used verto communicator for conference now i need customise the conference layout for participant and moderator. What is the best way to achieve this?. Thank You Vishal

2 3

FS dev communication channel
by Harangozó, László 28 Mar '19

28 Mar '19

What is the "standard" dev communication channel these days? I have read the Community chapter <https://freeswitch.org/confluence/display/FREESWITCH/Community> from the docs but I am still confused. - The freeswitch-dev(a)lists.freeswitch.org list seems inactive (signed up 9 days ago, no traffic since) - The #freeswitch-dev on IRC seems also abandoned as the topic was set more than 4 years ago (whatever that means, I have never used IRC before) - The #freeswitch-dev channel on Slack is active, but I am not sure if this is the primary channel (as searching the history costs money) I have added a couple of features locally and would like to discuss how and what to contribute back. Hari

3 3

Video across loopback
by Dave Singer 27 Mar '19

27 Mar '19

I'm using loopback for connecting calls in some situations but it seems that I can't get video to work when I use a loopback. The SIP captured on both inbound and outbound legs of the call set up the video fine with the 200 OK to the INVITE containing the proper SDP for H264 and the RTP for the video is getting to Freeswitch but not going out from freeswitch. T he logs that seem relevant... mod_loopback.c:158 loopback/<ext>/context-a setup codec G7221/32000/20 then a little further down switch_ivr_originate.c:1273 Raw Codec Activation Success L16@32000hz 1 channel 20ms 0_23453543(a)192.168.88.221 2019-03-20 21:49:28.564575 [DEBUG] switch_core_codec.c:223 sofia/sipinterface_1/<ext2>@<realm> Push codec L16:100 Those are for audio but there are none for video. Is video not supported by loopback? I'm on Freeswitch 1.6.20.1 Thanks Dave

2 1

Chrome M76 requires DTLS 1.2, doesn't work with FS 1.6 on Debian 8
by Thomas Auge 27 Mar '19

27 Mar '19

FYI for those still using FS 1.6 with webRTC clients: Chrome will require DTLS 1.2 starting with M76, which does not appear to work with FS 1.6 on Debian Jessie. Compiling with backported OpenSSL 1.0.2 did not help. https://freeswitch.org/jira/browse/FS-11730 Cheers! Thomas

1 0

Hebrew sounds
by Dmitry Mordovin 27 Mar '19

27 Mar '19

Hi I have install module mod_say_he but can't find Hebrew sounds. Does anyone knows link to download Hebrew sounds? Dmitry

1 0

libsndfile in FreeSWITCH 1.8
by Miroslav Levanic 27 Mar '19

27 Mar '19

Hi I'm comparing source between FreeSWITCH v1.6 and v1.8 and found out that in 1.8 libsndfile project is not present and there is no original source code for this library, just pre-compiled libs and dlls files in libs\libsndfile-1.0.28.1.fda9c8d folder. I'm interesting is there some special reason for that? Regards, Miro

2 1

How to get information of callee when the call is forwarded
by Hailiang Wang 27 Mar '19

27 Mar '19

hi, Folks I have come to a question when dealing with call forwarding: A and B are using Mobile Phones with PSTN. C is another Phone Number but connected with FreeSWTICH Instance which pickups any calls C receives. A calls B, B forwards to C, then FreeSWITCH routes A to an extension, in this extension, I would like to extract the Information of B, like its phone number, etc. I have checked the variables in the channel, but it doesn't contain information of B. Can any one help? Thanks. BTW, one related topic: http://lists.freeswitch.org/pipermail/freeswitch-users/2013-May/096044.html

2 1

stash account email address
by Harangozó, László 26 Mar '19

26 Mar '19

I have created my FS stash account with a typo in the email address. The account settings page tells me that "You cannot edit your display name or email address as they are stored in a read-only user directory.". This is bad for me, since I am not getting the notification mails. Is there a way to change the address? I have just realized this when I saw that my only PR got approved and I started to wonder why I got no notifications. Thanks, Hari

2 2

Does early attended transfer execute application set on the transferred channel?
by mayamatakeshi 23 Mar '19

23 Mar '19

Hi, I am testing early attended transfer scenario (REFER with Replaces before transfer target answers). Scenario is like this: 1) PSTN call arrives 2) dialplan sends call to user1 3) user1 answers the call 4) user1 puts PSTN call on-hold 5) user1 makes call to user2 6) FS executes a dialplan that sets some variables (like user1 DB ID) and executes application bridge to user2 7) before user2 answers user1 requests attended transfer 8) it seems in this case FS executes the 'set' applications from step 6 in the PSTN channel and changes the ownership of the ongoing bridge application to it. Can someone confirm this is indeed what happens? (I checked XML CDR, the variable mentioned by application 'set' is assigned but the app_log doesn't show application 'set' was executed). And if this is indeed the case, is there some way to ask FS to refuse early attended transfer as it is causing wrong CDR to be written (PSTN channel is marked as being a user channel)? I don't want to refuse neither blind transfer nor consultative transfer (transfer after answer). I just need to prevent early attended transfer (or maybe someone has some idea about how to deal with this scenario).

1 0