[Freeswitch-users] Freeswitch trunk with router vodafone asterisk based
"Δημήτριος Δ. Κάργας"
d.kargas at teiwm.gr
Wed Apr 3 06:45:57 UTC 2019
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 at 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 at 192.168.2.10:5060>;tag=c607ca2663;epid=SC0c351a
To: <sip:401 at 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 at 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 at 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 at 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 at 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 at 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 at 8000
2019-04-01 23:19:16.604364 [DEBUG] switch_core_media.c:3781 Set Codec sofia/internal/7777 at 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 at 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 at 8000
2019-04-01 23:19:16.624363 [DEBUG] switch_core_media.c:5795 sofia/internal/7777 at 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 at 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 at 192.168.2.10:5060) State NEW
2019-04-01 23:19:16.624363 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/7777 at 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 at 192.168.2.10:5060) State INIT
2019-04-01 23:19:16.624363 [DEBUG] mod_sofia.c:93 sofia/internal/7777 at 192.168.2.10:5060 SOFIA INIT
2019-04-01 23:19:16.624363 [DEBUG] switch_core_state_machine.c:40 sofia/internal/7777 at 192.168.2.10:5060 Standard INIT
2019-04-01 23:19:16.624363 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/7777 at 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 at 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 at 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 at 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 at 192.168.2.10:5060) State ROUTING
2019-04-01 23:19:16.624363 [DEBUG] mod_sofia.c:154 sofia/internal/7777 at 192.168.2.10:5060 SOFIA ROUTING
2019-04-01 23:19:16.624363 [DEBUG] switch_core_state_machine.c:236 sofia/internal/7777 at 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 at 192.168.2.10:5060>;tag=c607ca2663;epid=SC0c351a
To: <sip:401 at 192.168.2.10:5060>
Call-ID: 356f4bddc52d1c96
CSeq: 2140941627 INVITE
User-Agent: FreeSWITCH
Content-Length: 0
------------------------------------------------------------------------
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 parsing [192.168.2.10->user_exists] continue=true
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (PASS) [user_exists] () =~ // break=on-false
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
EXECUTE sofia/internal/7777 at 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 at 192.168.2.10:5060 [user_exists]=[false]
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 parsing [192.168.2.10->caller-details] continue=true
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (PASS) [caller-details] ${caller_destination}() =~ /^$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Action set(caller_destination=${destination_number}) INLINE
EXECUTE sofia/internal/7777 at 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 at 192.168.2.10:5060 [caller_destination]=[401]
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Action set(caller_id_name=${caller_id_name}) INLINE
EXECUTE sofia/internal/7777 at 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 at 192.168.2.10:5060 [caller_id_name]=[7777]
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Action set(caller_id_number=${caller_id_number}) INLINE
EXECUTE sofia/internal/7777 at 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 at 192.168.2.10:5060 [caller_id_number]=[7777]
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 parsing [192.168.2.10->variables] continue=true
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (PASS) [variables] () =~ // break=on-false
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Action export(origination_callee_id_name=${destination_number})
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 parsing [192.168.2.10->call-direction] continue=true
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [call-direction] ${call_direction}() =~ /^(inbound|outbound|local)$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 ANTI-Action export(call_direction=local)
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 parsing [192.168.2.10->call_block] continue=true
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [call_block] ${call_direction}() =~ /^inbound$/ break=on-false
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 parsing [192.168.2.10->user_record] continue=true
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (PASS) [user_record] () =~ // break=on-false
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
EXECUTE sofia/internal/7777 at 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 at 192.168.2.10:5060 [from_user_exists]=[true]
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [user_record] ${call_direction}() =~ /^inbound$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [user_record] ${call_direction}() =~ /^outbound$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [user_record] ${call_direction}() =~ /^local$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
Dialplan: sofia/internal/7777 at 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 at 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 at 192.168.2.10:5060 [from_user_record]=[UNDEF]
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [user_record] ${call_direction}() =~ /^inbound$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [user_record] ${call_direction}() =~ /^outbound$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [user_record] ${call_direction}() =~ /^local$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 parsing [192.168.2.10->redial] continue=true
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [redial] destination_number(401) =~ /^(redial|\*870)$/ break=on-true
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (PASS) [redial] () =~ // break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 parsing [192.168.2.10->speed_dial] continue=false
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (FAIL) [speed_dial] destination_number(401) =~ /^\*0(.*)$/ break=on-false
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 parsing [192.168.2.10->default_caller_id] continue=true
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (PASS) [default_caller_id] ${emergency_caller_id_number}() =~ /^$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Action set(emergency_caller_id_name=${default_emergency_caller_id_name}) INLINE
EXECUTE sofia/internal/7777 at 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 at 192.168.2.10:5060 [emergency_caller_id_name]=[UNDEF]
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Action set(emergency_caller_id_number=${default_emergency_caller_id_number}) INLINE
EXECUTE sofia/internal/7777 at 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 at 192.168.2.10:5060 [emergency_caller_id_number]=[UNDEF]
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (PASS) [default_caller_id] ${outbound_caller_id_number}() =~ /^$/ break=never
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Action set(outbound_caller_id_name=${default_outbound_caller_id_name}) INLINE
EXECUTE sofia/internal/7777 at 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 at 192.168.2.10:5060 [outbound_caller_id_name]=[UNDEF]
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Action set(outbound_caller_id_number=${default_outbound_caller_id_number}) INLINE
EXECUTE sofia/internal/7777 at 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 at 192.168.2.10:5060 [outbound_caller_id_number]=[UNDEF]
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 parsing [192.168.2.10->fs.d3] continue=false
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (PASS) [fs.d3] ${user_exists}(false) =~ /false/ break=on-false
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Regex (PASS) [fs.d3] destination_number(401) =~ /^(\d{3})$/ break=on-false
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Action set(sip_h_X-accountcode=${accountcode})
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Action export(call_direction=outbound)
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Action unset(call_timeout)
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Action set(hangup_after_bridge=true)
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Action set(effective_caller_id_name=${outbound_caller_id_name})
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Action set(effective_caller_id_number=${outbound_caller_id_number})
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Action set(ignore_display_updates=true)
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Action set(callee_id_number=401)
Dialplan: sofia/internal/7777 at 192.168.2.10:5060 Action set(continue_on_fail=true)
Dialplan: sofia/internal/7777 at 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 at 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 at 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 at 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 at 192.168.2.10:5060) State EXECUTE
2019-04-01 23:19:16.624363 [DEBUG] mod_sofia.c:209 sofia/internal/7777 at 192.168.2.10:5060 SOFIA EXECUTE
2019-04-01 23:19:16.624363 [DEBUG] switch_core_state_machine.c:328 sofia/internal/7777 at 192.168.2.10:5060 Standard EXECUTE
EXECUTE sofia/internal/7777 at 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 at 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 at 192.168.2.10:5060 [RFC2822_DATE]=[Mon, 01 Apr 2019 23:19:16 +0300]
EXECUTE sofia/internal/7777 at 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 at 192.168.2.10:5060 hash(insert/192.168.2.10-last_dial/7777/401)
EXECUTE sofia/internal/7777 at 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 at 192.168.2.10:5060 [sip_h_X-accountcode]=[UNDEF]
EXECUTE sofia/internal/7777 at 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 at 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 at 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 at 192.168.2.10:5060 [hangup_after_bridge]=[true]
EXECUTE sofia/internal/7777 at 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 at 192.168.2.10:5060 [effective_caller_id_name]=[UNDEF]
EXECUTE sofia/internal/7777 at 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 at 192.168.2.10:5060 [effective_caller_id_number]=[UNDEF]
EXECUTE sofia/internal/7777 at 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 at 192.168.2.10:5060 [ignore_display_updates]=[true]
EXECUTE sofia/internal/7777 at 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 at 192.168.2.10:5060 [callee_id_number]=[401]
EXECUTE sofia/internal/7777 at 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 at 192.168.2.10:5060 [continue_on_fail]=[true]
EXECUTE sofia/internal/7777 at 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 at 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 at 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 at 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 at 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 at 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 at 192.168.2.5>;tag=Fj74StZva720c
To: <sip:401 at 192.168.2.5>
Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78
CSeq: 2521186 INVITE
Contact: <sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe at 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 at 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 at 192.168.2.5>;tag=Fj74StZva720c
To: <sip:401 at 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 at 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 at 192.168.2.5>;tag=Fj74StZva720c
To: <sip:401 at 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 at 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 at 192.168.2.5>;tag=Fj74StZva720c
To: <sip:401 at 192.168.2.5>
Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78
CSeq: 2521187 INVITE
Contact: <sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe at 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 at 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 at 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 at 192.168.2.5>;tag=Fj74StZva720c
To: <sip:401 at 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 at 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 at 192.168.2.5>;tag=Fj74StZva720c
To: <sip:401 at 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 at 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 at 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 at 192.168.2.5>;tag=Fj74StZva720c
To: <sip:401 at 192.168.2.5>
Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78
CSeq: 2521187 INVITE
Contact: <sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe at 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 at 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 at 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 at 192.168.2.5>;tag=Fj74StZva720c
To: <sip:401 at 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 at 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 at 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 at 192.168.2.5>;tag=Fj74StZva720c
To: <sip:401 at 192.168.2.5>
Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78
CSeq: 2521187 INVITE
Contact: <sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe at 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 at 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 at 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 at 192.168.2.5>;tag=Fj74StZva720c
To: <sip:401 at 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 at 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 at 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 at 192.168.2.5>;tag=Fj74StZva720c
To: <sip:401 at 192.168.2.5>
Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78
CSeq: 2521187 INVITE
Contact: <sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe at 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 at 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 at 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 at 192.168.2.5>;tag=Fj74StZva720c
To: <sip:401 at 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 at 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 at 192.168.2.5>;tag=Fj74StZva720c
To: <sip:401 at 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 at 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 at 192.168.2.5>;tag=Fj74StZva720c
To: <sip:401 at 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 at 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 at 192.168.2.5>;tag=Fj74StZva720c
To: <sip:401 at 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 at 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 at 192.168.2.5>;tag=Fj74StZva720c
To: <sip:401 at 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 at 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 at 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 at 192.168.2.5>;tag=as10f04bc3
To: "7777" <sip:9999 at 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 at 192.168.2.5>;tag=as10f04bc3
To: "7777" <sip:9999 at 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 at 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 at 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 at 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 at 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 at 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 at 192.168.2.10:5060) State HANGUP
2019-04-01 23:19:30.444362 [DEBUG] mod_sofia.c:443 sofia/internal/7777 at 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 at 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 at 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 at 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 at 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 at 192.168.2.10:5060>;tag=c607ca2663;epid=SC0c351a
To: <sip:401 at 192.168.2.10:5060>;tag=e9DcrZeSDyceH
Call-ID: 356f4bddc52d1c96
CSeq: 2140941627 INVITE
Contact: <sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe at 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 at 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 at 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 at 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 at 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 at 192.168.2.10:5060>;tag=c607ca2663;epid=SC0c351a
To: <sip:401 at 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 at 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 at 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 at 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 at 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 at 192.168.2.10:5060) Ended
2019-04-01 23:19:30.524364 [NOTICE] switch_core_session.c:1737 Close Channel sofia/internal/7777 at 192.168.2.10:5060 [CS_DESTROY]
2019-04-01 23:19:30.524364 [DEBUG] switch_core_state_machine.c:738 (sofia/internal/7777 at 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 at 192.168.2.10:5060) State DESTROY
2019-04-01 23:19:30.524364 [DEBUG] mod_sofia.c:354 sofia/internal/7777 at 192.168.2.10:5060 SOFIA DESTROY
2019-04-01 23:19:30.524364 [DEBUG] switch_core_state_machine.c:181 sofia/internal/7777 at 192.168.2.10:5060 Standard DESTROY
2019-04-01 23:19:30.524364 [DEBUG] switch_core_state_machine.c:748 (sofia/internal/7777 at 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 at 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 at 192.168.2.5;user=phone>;tag=as44d33727
To: <sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe at 192.168.2.10:5060;transport=udp;gw=af53c152-0f9c-4166-ad4f-3abf497e9abe>
Contact: <sip:unknown at 192.168.2.5>
Call-ID: 766e66790050605e7b4939ee7d1ae247 at 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 at 192.168.2.5;user=phone>;tag=as44d33727
To: <sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe at 192.168.2.10:5060;transport=udp;gw=af53c152-0f9c-4166-ad4f-3abf497e9abe>;tag=gU0XUNg07FSKr
Call-ID: 766e66790050605e7b4939ee7d1ae247 at 192.168.2.5
CSeq: 102 OPTIONS
Contact: <sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe at 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 at 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 at 192.168.2.5>;tag=Fj74StZva720c
To: <sip:401 at 192.168.2.5>
Call-ID: 43cf1dd4-cf5e-1237-7b9b-0025b328ba78
CSeq: 2521187 INVITE
Contact: <sip:gw+af53c152-0f9c-4166-ad4f-3abf497e9abe at 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 at 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 at 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 at 192.168.2.5>;tag=Fj74StZva720c
To: <sip:401 at 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 at 192.168.2.5>;tag=Fj74StZva720c
To: <sip:401 at 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 at 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 at 192.168.2.5>;tag=Fj74StZva720c
To: <sip:401 at 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 at 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 at 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 at 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 at 192.168.2.5 SIP/2.0
23:25:02.727946 IP 192.168.2.10.sip > oxygen.voip.sip: SIP: INVITE sip:401 at 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 at 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 at 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 at 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 at 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 at 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
More information about the FreeSWITCH-users
mailing list