freeswitchforum.com

2014-04-16 12:16:05.745018 [NOTICE] mod_logfile.c:213 New log started.
2014-04-16 12:16:16.145003 [NOTICE] switch_channel.c:1055 New Channel sofia/trunk177_2/79027614607@10.177.177.204 [17aef6ad00beb7f41dc68f122e908a34@10.177.177.204:5060]
2014-04-16 12:16:16.145003 [DEBUG] switch_core_session.c:1048 Send signal sofia/trunk177_2/79027614607@10.177.177.204 [BREAK]
2014-04-16 12:16:16.145003 [DEBUG] switch_core_session.c:1048 Send signal sofia/trunk177_2/79027614607@10.177.177.204 [BREAK]
2014-04-16 12:16:16.145003 [DEBUG] switch_core_state_machine.c:467 (sofia/trunk177_2/79027614607@10.177.177.204) Running State Change CS_NEW
2014-04-16 12:16:16.145003 [DEBUG] sofia.c:8048 IP 10.177.177.204 Approved by acl "btk[]". Access Granted.
2014-04-16 12:16:16.145003 [DEBUG] sofia.c:5889 Channel sofia/trunk177_2/79027614607@10.177.177.204 entering state [received][100]
2014-04-16 12:16:16.145003 [DEBUG] sofia.c:5899 Remote SDP:
v=0
o=root 1725559670 1725559670 IN IP4 10.177.177.204
s=Asterisk PBX 1.8.8.2
c=IN IP4 10.177.177.204
t=0 0
m=audio 17634 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20

2014-04-16 12:16:16.145003 [DEBUG] sofia.c:6144 (sofia/trunk177_2/79027614607@10.177.177.204) State Change CS_NEW -> CS_INIT
2014-04-16 12:16:16.145003 [DEBUG] switch_core_session.c:1383 Send signal sofia/trunk177_2/79027614607@10.177.177.204 [BREAK]
2014-04-16 12:16:16.145003 [DEBUG] switch_core_state_machine.c:486 (sofia/trunk177_2/79027614607@10.177.177.204) State NEW
2014-04-16 12:16:16.145003 [DEBUG] switch_core_state_machine.c:467 (sofia/trunk177_2/79027614607@10.177.177.204) Running State Change CS_INIT
2014-04-16 12:16:16.145003 [DEBUG] switch_core_state_machine.c:507 (sofia/trunk177_2/79027614607@10.177.177.204) State INIT
2014-04-16 12:16:16.145003 [DEBUG] mod_sofia.c:87 sofia/trunk177_2/79027614607@10.177.177.204 SOFIA INIT
2014-04-16 12:16:16.145003 [DEBUG] switch_core_state_machine.c:40 sofia/trunk177_2/79027614607@10.177.177.204 Standard INIT
2014-04-16 12:16:16.145003 [DEBUG] switch_core_state_machine.c:48 (sofia/trunk177_2/79027614607@10.177.177.204) State Change CS_INIT -> CS_ROUTING
2014-04-16 12:16:16.145003 [DEBUG] switch_core_session.c:1383 Send signal sofia/trunk177_2/79027614607@10.177.177.204 [BREAK]
2014-04-16 12:16:16.145003 [DEBUG] switch_core_state_machine.c:507 (sofia/trunk177_2/79027614607@10.177.177.204) State INIT going to sleep
2014-04-16 12:16:16.145003 [DEBUG] switch_core_state_machine.c:467 (sofia/trunk177_2/79027614607@10.177.177.204) Running State Change CS_ROUTING
2014-04-16 12:16:16.145003 [DEBUG] switch_channel.c:2178 (sofia/trunk177_2/79027614607@10.177.177.204) Callstate Change DOWN -> RINGING
2014-04-16 12:16:16.145003 [DEBUG] switch_core_state_machine.c:523 (sofia/trunk177_2/79027614607@10.177.177.204) State ROUTING
2014-04-16 12:16:16.145003 [DEBUG] mod_sofia.c:123 sofia/trunk177_2/79027614607@10.177.177.204 SOFIA ROUTING
2014-04-16 12:16:16.145003 [DEBUG] switch_core_state_machine.c:164 sofia/trunk177_2/79027614607@10.177.177.204 Standard ROUTING
2014-04-16 12:16:16.145003 [INFO] mod_dialplan_xml.c:558 Processing 79027614607 <79027614607>->728308 in context public
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 parsing [public->unloop] continue=false
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 parsing [public->outside_call] continue=true
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Absolute Condition [outside_call]
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Action set(outside_call=true)
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 parsing [public->call_debug] continue=true
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 parsing [public->728305_to_world] continue=false
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Regex (FAIL) [728305_to_world] caller_id_number(79027614607) =~ /^555555$/ break=on-false
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 parsing [public->728308_to_world] continue=false
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Regex (FAIL) [728308_to_world] caller_id_number(79027614607) =~ /^9998$/ break=on-false
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 parsing [public->gateway2.d3] continue=false
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Regex (FAIL) [gateway2.d3] caller_id_number(79027614607) =~ /^1009$/ break=on-false
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 parsing [public->Inbound_131] continue=false
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Regex (PASS) [Inbound_131] context(public) =~ /public/ break=on-false
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Regex (FAIL) [Inbound_131] destination_number(728308) =~ /^131$/ break=on-false
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 parsing [public->world_to_728305] continue=false
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Regex (PASS) [world_to_728305] context(public) =~ /public/ break=on-false
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Regex (FAIL) [world_to_728305] destination_number(728308) =~ /^728305$/ break=on-false
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 parsing [public->world_to_728308] continue=false
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Regex (PASS) [world_to_728308] context(public) =~ /public/ break=on-false
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Regex (PASS) [world_to_728308] destination_number(728308) =~ /^728308$/ break=on-false
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Action set(recording_follow_transfer=true)
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Action set(media_bug_answer_req=true)
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Action set(RECORD_TITLE=Recording ${destination_number} ${caller_id_number} ${strftime(%Y-%m-%d %H:%M)})
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Action set(RECORD_SOFTWARE=FreeSWITCH)
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Action set(RECORD_ARTIST=FreeSWITCH)
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Action set(RECORD_COMMENT=FreeSWITCH)
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Action set(RECORD_DATE=${strftime(%Y-%m-%d %H:%M)})
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Action set(RECORD_STEREO=true)
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Action record_session(/usr/local/freeswitch/recordings/under_office/${strftime(%Y)}/${strftime(%b)}/${strftime(%d)}/${strftime(%Y%m%d_%H%M%S)}_${caller_id_number}_${destination_number}.mp3)
Dialplan: sofia/trunk177_2/79027614607@10.177.177.204 Action bridge(user/9998@${domain_name})
2014-04-16 12:16:16.145003 [DEBUG] switch_core_state_machine.c:214 (sofia/trunk177_2/79027614607@10.177.177.204) State Change CS_ROUTING -> CS_EXECUTE
2014-04-16 12:16:16.145003 [DEBUG] switch_core_session.c:1383 Send signal sofia/trunk177_2/79027614607@10.177.177.204 [BREAK]
2014-04-16 12:16:16.145003 [DEBUG] switch_core_state_machine.c:523 (sofia/trunk177_2/79027614607@10.177.177.204) State ROUTING going to sleep
2014-04-16 12:16:16.145003 [DEBUG] switch_core_state_machine.c:467 (sofia/trunk177_2/79027614607@10.177.177.204) Running State Change CS_EXECUTE
2014-04-16 12:16:16.145003 [DEBUG] switch_core_state_machine.c:530 (sofia/trunk177_2/79027614607@10.177.177.204) State EXECUTE
2014-04-16 12:16:16.145003 [DEBUG] mod_sofia.c:178 sofia/trunk177_2/79027614607@10.177.177.204 SOFIA EXECUTE
2014-04-16 12:16:16.145003 [DEBUG] switch_core_state_machine.c:256 sofia/trunk177_2/79027614607@10.177.177.204 Standard EXECUTE
EXECUTE sofia/trunk177_2/79027614607@10.177.177.204 set(outside_call=true)
2014-04-16 12:16:16.145003 [DEBUG] mod_dptools.c:1402 sofia/trunk177_2/79027614607@10.177.177.204 SET [outside_call]=[true]
EXECUTE sofia/trunk177_2/79027614607@10.177.177.204 export(RFC2822_DATE=Wed, 16 Apr 2014 12:16:16 +0900)
2014-04-16 12:16:16.145003 [DEBUG] switch_channel.c:1247 EXPORT (export_vars) [RFC2822_DATE]=[Wed, 16 Apr 2014 12:16:16 +0900]
EXECUTE sofia/trunk177_2/79027614607@10.177.177.204 set(recording_follow_transfer=true)
2014-04-16 12:16:16.165025 [DEBUG] mod_dptools.c:1402 sofia/trunk177_2/79027614607@10.177.177.204 SET [recording_follow_transfer]=[true]
EXECUTE sofia/trunk177_2/79027614607@10.177.177.204 set(media_bug_answer_req=true)
2014-04-16 12:16:16.165025 [DEBUG] mod_dptools.c:1402 sofia/trunk177_2/79027614607@10.177.177.204 SET [media_bug_answer_req]=[true]
EXECUTE sofia/trunk177_2/79027614607@10.177.177.204 set(RECORD_TITLE=Recording 728308 79027614607 2014-04-16 12:16)
2014-04-16 12:16:16.165025 [DEBUG] mod_dptools.c:1402 sofia/trunk177_2/79027614607@10.177.177.204 SET [RECORD_TITLE]=[Recording 728308 79027614607 2014-04-16 12:16]
EXECUTE sofia/trunk177_2/79027614607@10.177.177.204 set(RECORD_SOFTWARE=FreeSWITCH)
2014-04-16 12:16:16.165025 [DEBUG] mod_dptools.c:1402 sofia/trunk177_2/79027614607@10.177.177.204 SET [RECORD_SOFTWARE]=[FreeSWITCH]
EXECUTE sofia/trunk177_2/79027614607@10.177.177.204 set(RECORD_ARTIST=FreeSWITCH)
2014-04-16 12:16:16.165025 [DEBUG] mod_dptools.c:1402 sofia/trunk177_2/79027614607@10.177.177.204 SET [RECORD_ARTIST]=[FreeSWITCH]
EXECUTE sofia/trunk177_2/79027614607@10.177.177.204 set(RECORD_COMMENT=FreeSWITCH)
2014-04-16 12:16:16.165025 [DEBUG] mod_dptools.c:1402 sofia/trunk177_2/79027614607@10.177.177.204 SET [RECORD_COMMENT]=[FreeSWITCH]
EXECUTE sofia/trunk177_2/79027614607@10.177.177.204 set(RECORD_DATE=2014-04-16 12:16)
2014-04-16 12:16:16.165025 [DEBUG] mod_dptools.c:1402 sofia/trunk177_2/79027614607@10.177.177.204 SET [RECORD_DATE]=[2014-04-16 12:16]
EXECUTE sofia/trunk177_2/79027614607@10.177.177.204 set(RECORD_STEREO=true)
2014-04-16 12:16:16.165025 [DEBUG] mod_dptools.c:1402 sofia/trunk177_2/79027614607@10.177.177.204 SET [RECORD_STEREO]=[true]
2014-04-16 12:16:16.165025 [DEBUG] switch_core_session.c:2689 Application record_session Requires media! pre_answering channel sofia/trunk177_2/79027614607@10.177.177.204
2014-04-16 12:16:16.165025 [INFO] switch_core_session.c:2691 Sending early media
2014-04-16 12:16:16.165025 [DEBUG] switch_core_media.c:3159 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000]
2014-04-16 12:16:16.165025 [DEBUG] switch_core_media.c:3213 Audio Codec Compare [PCMA:8:8000:20:64000] ++++ is saved as a match
2014-04-16 12:16:16.165025 [DEBUG] switch_core_media.c:3085 Set telephone-event payload to 101
2014-04-16 12:16:16.165025 [DEBUG] switch_core_media.c:2125 Set Codec sofia/trunk177_2/79027614607@10.177.177.204 PCMA/8000 20 ms 160 samples 64000 bits
2014-04-16 12:16:16.165025 [DEBUG] switch_core_codec.c:111 sofia/trunk177_2/79027614607@10.177.177.204 Original read codec set to PCMA:8
2014-04-16 12:16:16.165025 [DEBUG] switch_core_media.c:3391 Set 2833 dtmf send/recv payload to 101
2014-04-16 12:16:16.165025 [INFO] switch_nat.c:590 NAT port mapping disabled
2014-04-16 12:16:16.165025 [DEBUG] switch_core_media.c:4563 AUDIO RTP [sofia/trunk177_2/79027614607@10.177.177.204] 10.177.177.249 port 32262 -> 10.177.177.204 port 17634 codec: 8 ms: 20
2014-04-16 12:16:16.165025 [DEBUG] switch_rtp.c:3047 Starting timer [soft] 160 bytes per 20ms
2014-04-16 12:16:16.165025 [DEBUG] switch_core_media.c:4907 Set 2833 dtmf send payload to 101
2014-04-16 12:16:16.165025 [DEBUG] switch_core_media.c:4913 Set 2833 dtmf receive payload to 101
2014-04-16 12:16:16.165025 [NOTICE] sofia_media.c:92 Pre-Answer sofia/trunk177_2/79027614607@10.177.177.204!
2014-04-16 12:16:16.165025 [DEBUG] switch_channel.c:3404 (sofia/trunk177_2/79027614607@10.177.177.204) Callstate Change RINGING -> EARLY
2014-04-16 12:16:16.165025 [DEBUG] mod_sofia.c:2092 Ring SDP:
v=0
o=FreeSWITCH 1397585914 1397585915 IN IP4 10.177.177.249
s=FreeSWITCH
c=IN IP4 10.177.177.249
t=0 0
m=audio 32262 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv

2014-04-16 12:16:16.165025 [DEBUG] switch_core_session.c:903 Send signal sofia/trunk177_2/79027614607@10.177.177.204 [BREAK]
EXECUTE sofia/trunk177_2/79027614607@10.177.177.204 record_session(/usr/local/freeswitch/recordings/under_office/2014/Apr/16/20140416_121616_79027614607_728308.mp3)
2014-04-16 12:16:16.165025 [DEBUG] switch_core_session.c:1048 Send signal sofia/trunk177_2/79027614607@10.177.177.204 [BREAK]
2014-04-16 12:16:16.165025 [DEBUG] sofia.c:5889 Channel sofia/trunk177_2/79027614607@10.177.177.204 entering state [early][183]
2014-04-16 12:16:16.165025 [INFO] mod_shout.c:324 LAME 3.98.4 32bits (http://www.mp3dev.org/)
2014-04-16 12:16:16.165025 [INFO] mod_shout.c:324 Using polyphase lowpass filter, transition band:  3903 Hz -  4000 Hz
2014-04-16 12:16:16.165025 [DEBUG] switch_core_media_bug.c:532 Attaching BUG to sofia/trunk177_2/79027614607@10.177.177.204
EXECUTE sofia/trunk177_2/79027614607@10.177.177.204 bridge(user/9998@194.143.148.10)
2014-04-16 12:16:16.165025 [DEBUG] switch_channel.c:1201 sofia/trunk177_2/79027614607@10.177.177.204 EXPORTING[export_vars] [RFC2822_DATE]=[Wed, 16 Apr 2014 12:16:16 +0900] to event
2014-04-16 12:16:16.165025 [DEBUG] switch_ivr_originate.c:2071 Parsing global variables
2014-04-16 12:16:16.165025 [DEBUG] switch_channel.c:1201 sofia/trunk177_2/79027614607@10.177.177.204 EXPORTING[export_vars] [RFC2822_DATE]=[Wed, 16 Apr 2014 12:16:16 +0900] to event
2014-04-16 12:16:16.165025 [DEBUG] switch_ivr_originate.c:2071 Parsing global variables
2014-04-16 12:16:16.165025 [NOTICE] switch_channel.c:1055 New Channel sofia/sipinterface_1/sip:9998@10.1.4.154:5060 [78bb992c-c515-11e3-be6e-6934d9634f16]
2014-04-16 12:16:16.165025 [DEBUG] mod_sofia.c:4429 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) State Change CS_NEW -> CS_INIT
2014-04-16 12:16:16.165025 [DEBUG] switch_core_session.c:1383 Send signal sofia/sipinterface_1/sip:9998@10.1.4.154:5060 [BREAK]
2014-04-16 12:16:16.165025 [DEBUG] switch_core_state_machine.c:467 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) Running State Change CS_INIT
2014-04-16 12:16:16.165025 [DEBUG] switch_core_state_machine.c:507 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) State INIT
2014-04-16 12:16:16.165025 [DEBUG] mod_sofia.c:87 sofia/sipinterface_1/sip:9998@10.1.4.154:5060 SOFIA INIT
2014-04-16 12:16:16.165025 [INFO] switch_nat.c:590 NAT port mapping disabled
2014-04-16 12:16:16.165025 [DEBUG] sofia_glue.c:1196 sip:9998@10.1.4.154:5060 Setting proxy route to sofia/sipinterface_1/sip:9998@10.1.4.154:5060
2014-04-16 12:16:16.165025 [DEBUG] sofia_glue.c:1225 Local SDP:
v=0
o=FreeSWITCH 1397600784 1397600785 IN IP4 194.143.148.10
s=FreeSWITCH
c=IN IP4 194.143.148.10
t=0 0
m=audio 17392 RTP/AVP 8 101 13
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv

2014-04-16 12:16:16.165025 [DEBUG] switch_core_state_machine.c:40 sofia/sipinterface_1/sip:9998@10.1.4.154:5060 Standard INIT
2014-04-16 12:16:16.165025 [DEBUG] switch_core_state_machine.c:48 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) State Change CS_INIT -> CS_ROUTING
2014-04-16 12:16:16.165025 [DEBUG] switch_core_session.c:1383 Send signal sofia/sipinterface_1/sip:9998@10.1.4.154:5060 [BREAK]
2014-04-16 12:16:16.165025 [DEBUG] switch_core_state_machine.c:507 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) State INIT going to sleep
2014-04-16 12:16:16.165025 [DEBUG] switch_core_state_machine.c:467 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) Running State Change CS_ROUTING
2014-04-16 12:16:16.165025 [DEBUG] switch_core_session.c:1048 Send signal sofia/sipinterface_1/sip:9998@10.1.4.154:5060 [BREAK]
2014-04-16 12:16:16.165025 [DEBUG] sofia.c:5889 Channel sofia/sipinterface_1/sip:9998@10.1.4.154:5060 entering state [calling][0]
2014-04-16 12:16:16.165025 [DEBUG] switch_core_state_machine.c:523 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) State ROUTING
2014-04-16 12:16:16.165025 [DEBUG] mod_sofia.c:123 sofia/sipinterface_1/sip:9998@10.1.4.154:5060 SOFIA ROUTING
2014-04-16 12:16:16.165025 [DEBUG] switch_ivr_originate.c:67 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2014-04-16 12:16:16.165025 [DEBUG] switch_core_session.c:1383 Send signal sofia/sipinterface_1/sip:9998@10.1.4.154:5060 [BREAK]
2014-04-16 12:16:16.165025 [DEBUG] switch_core_state_machine.c:523 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) State ROUTING going to sleep
2014-04-16 12:16:16.165025 [DEBUG] switch_core_state_machine.c:467 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) Running State Change CS_CONSUME_MEDIA
2014-04-16 12:16:16.165025 [DEBUG] switch_core_state_machine.c:542 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) State CONSUME_MEDIA
2014-04-16 12:16:16.165025 [DEBUG] switch_core_state_machine.c:542 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) State CONSUME_MEDIA going to sleep
2014-04-16 12:16:16.265005 [DEBUG] switch_rtp.c:5169 Correct ip/port confirmed.
2014-04-16 12:16:16.265005 [DEBUG] switch_core_io.c:524 Setting BUG Codec PCMA:8
2014-04-16 12:16:16.565017 [DEBUG] switch_core_session.c:1048 Send signal sofia/sipinterface_1/sip:9998@10.1.4.154:5060 [BREAK]
2014-04-16 12:16:16.565017 [DEBUG] switch_core_session.c:1048 Send signal sofia/sipinterface_1/sip:9998@10.1.4.154:5060 [BREAK]
2014-04-16 12:16:16.565017 [DEBUG] sofia.c:5889 Channel sofia/sipinterface_1/sip:9998@10.1.4.154:5060 entering state [proceeding][180]
2014-04-16 12:16:16.565017 [NOTICE] sofia.c:5979 Ring-Ready sofia/sipinterface_1/sip:9998@10.1.4.154:5060!
2014-04-16 12:16:16.565017 [DEBUG] switch_channel.c:3266 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) Callstate Change DOWN -> RINGING
2014-04-16 12:16:28.585005 [DEBUG] switch_core_session.c:1048 Send signal sofia/trunk177_2/79027614607@10.177.177.204 [BREAK]
2014-04-16 12:16:28.585005 [DEBUG] switch_core_session.c:1048 Send signal sofia/trunk177_2/79027614607@10.177.177.204 [BREAK]
2014-04-16 12:16:28.585005 [DEBUG] switch_core_session.c:1048 Send signal sofia/trunk177_2/79027614607@10.177.177.204 [BREAK]
2014-04-16 12:16:28.605013 [DEBUG] sofia.c:5889 Channel sofia/trunk177_2/79027614607@10.177.177.204 entering state [terminated][487]
2014-04-16 12:16:28.605013 [NOTICE] sofia.c:6730 Hangup sofia/trunk177_2/79027614607@10.177.177.204 [CS_EXECUTE] [ORIGINATOR_CANCEL]
2014-04-16 12:16:28.605013 [DEBUG] switch_channel.c:3211 Send signal sofia/trunk177_2/79027614607@10.177.177.204 [KILL]
2014-04-16 12:16:28.605013 [DEBUG] switch_core_session.c:1383 Send signal sofia/trunk177_2/79027614607@10.177.177.204 [BREAK]
2014-04-16 12:16:28.605013 [NOTICE] switch_ivr_originate.c:3449 Hangup sofia/sipinterface_1/sip:9998@10.1.4.154:5060 [CS_CONSUME_MEDIA] [ORIGINATOR_CANCEL]
2014-04-16 12:16:28.605013 [DEBUG] switch_channel.c:3211 Send signal sofia/sipinterface_1/sip:9998@10.1.4.154:5060 [KILL]
2014-04-16 12:16:28.605013 [DEBUG] switch_core_session.c:1383 Send signal sofia/sipinterface_1/sip:9998@10.1.4.154:5060 [BREAK]
2014-04-16 12:16:28.605013 [DEBUG] switch_ivr_originate.c:3666 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL]
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:467 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) Running State Change CS_HANGUP
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:731 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) State HANGUP
2014-04-16 12:16:28.605013 [DEBUG] mod_sofia.c:407 sofia/sipinterface_1/sip:9998@10.1.4.154:5060 Overriding SIP cause 487 with 487 from the other leg
2014-04-16 12:16:28.605013 [DEBUG] mod_sofia.c:413 Channel sofia/sipinterface_1/sip:9998@10.1.4.154:5060 hanging up, cause: ORIGINATOR_CANCEL
2014-04-16 12:16:28.605013 [NOTICE] switch_ivr_originate.c:2700 Cannot create outgoing channel of type [user] cause: [ORIGINATOR_CANCEL]
2014-04-16 12:16:28.605013 [DEBUG] switch_ivr_originate.c:3678 Originate Resulted in Error Cause: 487 [ORIGINATOR_CANCEL]
2014-04-16 12:16:28.605013 [DEBUG] mod_sofia.c:475 Sending CANCEL to sofia/sipinterface_1/sip:9998@10.1.4.154:5060
2014-04-16 12:16:28.605013 [INFO] mod_dptools.c:3201 Originate Failed.  Cause: ORIGINATOR_CANCEL
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:58 sofia/sipinterface_1/sip:9998@10.1.4.154:5060 Standard HANGUP, cause: ORIGINATOR_CANCEL
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:731 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) State HANGUP going to sleep
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:744 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) Callstate Change RINGING -> HANGUP
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:499 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) State Change CS_HANGUP -> CS_REPORTING
2014-04-16 12:16:28.605013 [DEBUG] switch_core_session.c:1383 Send signal sofia/sipinterface_1/sip:9998@10.1.4.154:5060 [BREAK]
2014-04-16 12:16:28.605013 [DEBUG] switch_core_session.c:2852 sofia/trunk177_2/79027614607@10.177.177.204 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:530 (sofia/trunk177_2/79027614607@10.177.177.204) State EXECUTE going to sleep
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:467 (sofia/trunk177_2/79027614607@10.177.177.204) Running State Change CS_HANGUP
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:467 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) Running State Change CS_REPORTING
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:816 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) State REPORTING
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:102 sofia/sipinterface_1/sip:9998@10.1.4.154:5060 Standard REPORTING, cause: ORIGINATOR_CANCEL
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:816 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) State REPORTING going to sleep
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:493 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) State Change CS_REPORTING -> CS_DESTROY
2014-04-16 12:16:28.605013 [DEBUG] switch_core_session.c:1383 Send signal sofia/sipinterface_1/sip:9998@10.1.4.154:5060 [BREAK]
2014-04-16 12:16:28.605013 [DEBUG] switch_core_session.c:1591 Session 18765 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) Locked, Waiting on external entities
2014-04-16 12:16:28.605013 [NOTICE] switch_core_session.c:1609 Session 18765 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) Ended
2014-04-16 12:16:28.605013 [NOTICE] switch_core_session.c:1613 Close Channel sofia/sipinterface_1/sip:9998@10.1.4.154:5060 [CS_DESTROY]
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:618 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) Callstate Change HANGUP -> DOWN
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:621 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) Running State Change CS_DESTROY
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:631 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) State DESTROY
2014-04-16 12:16:28.605013 [DEBUG] mod_sofia.c:323 sofia/sipinterface_1/sip:9998@10.1.4.154:5060 SOFIA DESTROY
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:109 sofia/sipinterface_1/sip:9998@10.1.4.154:5060 Standard DESTROY
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:631 (sofia/sipinterface_1/sip:9998@10.1.4.154:5060) State DESTROY going to sleep
2014-04-16 12:16:28.605013 [DEBUG] switch_ivr_async.c:1175 Stop recording file /usr/local/freeswitch/recordings/under_office/2014/Apr/16/20140416_121616_79027614607_728308.mp3
2014-04-16 12:16:28.605013 [DEBUG] switch_core_media_bug.c:780 Removing BUG from sofia/trunk177_2/79027614607@10.177.177.204
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:731 (sofia/trunk177_2/79027614607@10.177.177.204) State HANGUP
2014-04-16 12:16:28.605013 [DEBUG] mod_sofia.c:413 Channel sofia/trunk177_2/79027614607@10.177.177.204 hanging up, cause: ORIGINATOR_CANCEL
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:58 sofia/trunk177_2/79027614607@10.177.177.204 Standard HANGUP, cause: ORIGINATOR_CANCEL
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:731 (sofia/trunk177_2/79027614607@10.177.177.204) State HANGUP going to sleep
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:744 (sofia/trunk177_2/79027614607@10.177.177.204) Callstate Change EARLY -> HANGUP
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:499 (sofia/trunk177_2/79027614607@10.177.177.204) State Change CS_HANGUP -> CS_REPORTING
2014-04-16 12:16:28.605013 [DEBUG] switch_core_session.c:1383 Send signal sofia/trunk177_2/79027614607@10.177.177.204 [BREAK]
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:467 (sofia/trunk177_2/79027614607@10.177.177.204) Running State Change CS_REPORTING
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:816 (sofia/trunk177_2/79027614607@10.177.177.204) State REPORTING
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:102 sofia/trunk177_2/79027614607@10.177.177.204 Standard REPORTING, cause: ORIGINATOR_CANCEL
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:816 (sofia/trunk177_2/79027614607@10.177.177.204) State REPORTING going to sleep
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:493 (sofia/trunk177_2/79027614607@10.177.177.204) State Change CS_REPORTING -> CS_DESTROY
2014-04-16 12:16:28.605013 [DEBUG] switch_core_session.c:1383 Send signal sofia/trunk177_2/79027614607@10.177.177.204 [BREAK]
2014-04-16 12:16:28.605013 [DEBUG] switch_core_session.c:1591 Session 18764 (sofia/trunk177_2/79027614607@10.177.177.204) Locked, Waiting on external entities
2014-04-16 12:16:28.605013 [NOTICE] switch_core_session.c:1609 Session 18764 (sofia/trunk177_2/79027614607@10.177.177.204) Ended
2014-04-16 12:16:28.605013 [NOTICE] switch_core_session.c:1613 Close Channel sofia/trunk177_2/79027614607@10.177.177.204 [CS_DESTROY]
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:618 (sofia/trunk177_2/79027614607@10.177.177.204) Callstate Change HANGUP -> DOWN
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:621 (sofia/trunk177_2/79027614607@10.177.177.204) Running State Change CS_DESTROY
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:631 (sofia/trunk177_2/79027614607@10.177.177.204) State DESTROY
2014-04-16 12:16:28.605013 [DEBUG] mod_sofia.c:323 sofia/trunk177_2/79027614607@10.177.177.204 SOFIA DESTROY
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:109 sofia/trunk177_2/79027614607@10.177.177.204 Standard DESTROY
2014-04-16 12:16:28.605013 [DEBUG] switch_core_state_machine.c:631 (sofia/trunk177_2/79027614607@10.177.177.204) State DESTROY going to sleep

\D4ò\A1\00\00\00\00\00\00\00\00\00\00\FF\FF\00\00
\00\00\00\BD\E9MS\DF.\00\00\00\00\00\00\C0\93.\8B\D4\CAm
D`\00E\88
\F5\00\00@\00?\D4:

\9B\94
\C4\C4
\E1\8D~REGISTER sip:194.143.148.10 SIP/2.0
Via: SIP/2.0/UDP 10.1.4.155:5060;branch=z9hG4bK459b112834b3b30de4b35f15e9b2148;rport
From: "Lenka" <sip:1009@194.143.148.10>;tag=3972260303
To: "Lenka" <sip:1009@194.143.148.10>
Call-ID: 3113540487@10_1_4_155
CSeq: 6457 REGISTER
Contact: <sip:1009@10.1.4.155:5060>
Max-Forwards: 70
User-Agent: DX800A/41.096.00.000.000
Expires: 180
Allow: INVITE, ACK, CANCEL, BYE, OPTIONS, INFO, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0

\BD\E9MS#3\00\8B\00\00\8B\00\00|/\80,na\00\C0\93.\8B\00E\00}\87\A6\00\00@\8B\94\94


\9B\C4\C4ig\B0SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 10.1.4.155:5060;branch=z9hG4bK459b112834b3b30de4b35f15e9b2148;rport=5060
From: "Lenka" <sip:1009@194.143.148.10>;tag=3972260303
To: "Lenka" <sip:1009@194.143.148.10>;tag=B5XSKcvc2ZrpF
Call-ID: 3113540487@10_1_4_155
CSeq: 6457 REGISTER
User-Agent: The 2600hz Project
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: precondition, path, replaces
WWW-Authenticate: Digest realm="194.143.148.10", nonce="2a12c310-c50e-11e3-bab0-6934d9634f16", algorithm=MD5, qop="auth"
Content-Length: 0

\BD\E9MS\F9\85\00   \00\00   \00\00\00\C0\93.\8B\D4\CAm
D`\00E\88\FB\00\00@\00?\D34

\9B\94
\C4\C4\E7\C6\C1REGISTER sip:194.143.148.10 SIP/2.0
Via: SIP/2.0/UDP 10.1.4.155:5060;branch=z9hG4bK38bc329c3de1450548fd15cdd1c04be9;rport
From: "Lenka" <sip:1009@194.143.148.10>;tag=3972260303
To: "Lenka" <sip:1009@194.143.148.10>
Call-ID: 3113540487@10_1_4_155
CSeq: 6458 REGISTER
Contact: <sip:1009@10.1.4.155:5060>
Authorization: Digest username="1009", realm="194.143.148.10", qop=auth, algorithm=MD5, uri="sip:194.143.148.10", nonce="2a12c310-c50e-11e3-bab0-6934d9634f16", nc=00000001, cnonce="f61e21227f37157640c9b02cb9c49b51", response="83f2dba30e8121d2986fff8d0ae93f3b"
Max-Forwards: 70
User-Agent: DX800A/41.096.00.000.000
Expires: 180
Allow: INVITE, ACK, CANCEL, BYE, OPTIONS, INFO, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0

\BD\E9MSӎ\00^\00\00^\00\00|/\80,na\00\C0\93.\8B\00E\00P\87\A7\00\00@\8B\C0\94


\9B\C4\C4<g\83SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.1.4.155:5060;branch=z9hG4bK38bc329c3de1450548fd15cdd1c04be9;rport=5060
From: "Lenka" <sip:1009@194.143.148.10>;tag=3972260303
To: "Lenka" <sip:1009@194.143.148.10>;tag=ceQjN7cgZ8e9a
Call-ID: 3113540487@10_1_4_155
CSeq: 6458 REGISTER
Contact: <sip:1009@10.1.4.155:5060>;expires=180
Date: Wed, 16 Apr 2014 02:23:57 GMT
User-Agent: The 2600hz Project
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: precondition, path, replaces
Content-Length: 0

\BD\E9MS\DF\DF\00\C7\00\00\C7\00\00|/\80,na\00\C0\93.\8B\00E\00\B9\87\A8\00\00@\8AV\94


\9B\C4\C4\A5h\ECNOTIFY sip:1009@10.1.4.155:5060 SIP/2.0
Via: SIP/2.0/UDP 194.143.148.10;rport;branch=z9hG4bKQKN1QX6er0DDK
Route: <sip:1009@10.1.4.155:5060>
Max-Forwards: 70
From: <sip:1009@194.143.148.10>;tag=DQgBQ2XKvH5Up
To: <sip:1009@194.143.148.10>
Call-ID: 0177d63b-3fb1-1232-558f-001cf091cf56
CSeq: 58471454 NOTIFY
Contact: <sip:mod_sofia@194.143.148.10:5060>
User-Agent: The 2600hz Project
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: precondition, path, replaces
Event: message-summary
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Subscription-State: terminated;reason=noresource
Content-Type: application/simple-message-summary
Content-Length: 66

Messages-Waiting: no
Message-Account: sip:1009@194.143.148.10

\BD\E9MS\D0\E3\00<\00\00\00<\00\00\00\00\C0\93.\8B\D4\CAm
D`\00E\88\00 \00\00@\00?\D6

\9B\94
\C4\C4\00Y

\00\00\00\00\00\00\00\00\00\00\00\00\00\00\BD\E9MS\D6#\00A
\00\00A
\00\00\00\C0\93.\8B\D4\CAm
D`\00E\88
3\00\00@\00?\D4\FC

\9B\94
\C4\C4
\ABSIP/2.0 200 OK
Via: SIP/2.0/UDP 194.143.148.10;rport=5060;branch=z9hG4bKQKN1QX6er0DDK
From: <sip:1009@194.143.148.10>;tag=DQgBQ2XKvH5Up
To: <sip:1009@194.143.148.10>;tag=EPfCP3YJwI4Tq
Call-ID: 0177d63b-3fb1-1232-558f-001cf091cf56
CSeq: 58471454 NOTIFY
Content-Length: 0

\C0\E9MS\F1
\00*\00\00*\00\00|/\80,na\00\C0\93.\8B\00E\00\87\A9\00\00@\8A\F2\94


\9B\C4\C4hOOPTIONS sip:1009@10.1.4.155:5060 SIP/2.0
Via: SIP/2.0/UDP 194.143.148.10;rport;branch=z9hG4bKrvetSrQjN93Ze
Route: <sip:1009@10.1.4.155:5060>
Max-Forwards: 70
From: <sip:mod_sofia@194.143.148.10:5060>;tag=e093rXeQStUej
To: <sip:1009@194.143.148.10>
Call-ID: 2b77851a-c50e-11e3-bab3-6934d9634f16_3113540487@10_1_4_155
CSeq: 57567052 OPTIONS
Contact: <sip:mod_sofia@194.143.148.10:5060>
User-Agent: The 2600hz Project
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: precondition, 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

\C0\E9MS\D7
\00*\00\00*\00\00|/\80e\97X\00\C0\93.\8B\00E\00'\CE\00\00@\EA\CE\94


\9A\C4\C4hNOPTIONS sip:9998@10.1.4.154:5060 SIP/2.0
Via: SIP/2.0/UDP 194.143.148.10;rport;branch=z9hG4bKS57jUK8Njjtja
Route: <sip:9998@10.1.4.154:5060>
Max-Forwards: 70
From: <sip:mod_sofia@194.143.148.10:5060>;tag=F92vtrZtp3H1D
To: <sip:9998@194.143.148.10>
Call-ID: 2b7788e4-c50e-11e3-bab4-6934d9634f16_1975010744@10_1_4_154
CSeq: 57567053 OPTIONS
Contact: <sip:mod_sofia@194.143.148.10:5060>
User-Agent: The 2600hz Project
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: precondition, 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

\C0\E9MSQ_
\00T\00\00T\00\00\00\C0\93.\8B\D4\CAm
D`\00E\88F\00\00@\00?\D3\E9

\9B\94
\C4\C42\A8\AFSIP/2.0 200 OK
Via: SIP/2.0/UDP 194.143.148.10;rport=5060;branch=z9hG4bKrvetSrQjN93Ze
From: <sip:mod_sofia@194.143.148.10:5060>;tag=e093rXeQStUej
To: <sip:1009@194.143.148.10>;tag=d182sYdPRuTdk
Call-ID: 2b77851a-c50e-11e3-bab3-6934d9634f16_3113540487@10_1_4_155
CSeq: 57567052 OPTIONS
Supported: replaces
Allow: INVITE, ACK, CANCEL, BYE, OPTIONS, INFO, REFER, SUBSCRIBE, NOTIFY
Accept: application/sdp,application/dtmf-relay,application/simple-message-summary,message/sipfrag
Accept-Encoding: identity
Accept-Language: en
Content-Length: 0

\C0\E9MS\B4t
\00{\00\00{\00\00\00\C0\93.\8B\D4\CAm
D`\00E\88m\EF\8F\00\00\E43

\9A\94
\C4\C4Y*=SIP/2.0 200 OK
Via: SIP/2.0/UDP 194.143.148.10;rport=5060;branch=z9hG4bKS57jUK8Njjtja
From: <sip:mod_sofia@194.143.148.10:5060>;tag=F92vtrZtp3H1D
To: <sip:9998@194.143.148.10>;tag=G83wusZuq2I0E
Call-ID: 2b7788e4-c50e-11e3-bab4-6934d9634f16_1975010744@10_1_4_154
CSeq: 57567053 OPTIONS
Supported: replaces
User-Agent: A510 IP/42.076.00.000.000
Allow: INVITE, ACK, CANCEL, BYE, OPTIONS, INFO, REFER, SUBSCRIBE, NOTIFY
Accept: application/sdp,application/dtmf-relay,application/simple-message-summary,message/sipfrag
Accept-Encoding: identity
Accept-Language: en
Content-Length: 0

\C3\E9MS\C1\F4
\00\AA\00\00\AA\00\00\00\C0\93.\8B\90\E2\BA\E2p\00E\00\9C\87g\00\00<v\B0]\BD\C9\E2\94
\C4\C4\88\F0/REGISTER sip:194.143.148.10 SIP/2.0
Via: SIP/2.0/UDP 93.189.201.226:5060;branch=z9hG4bK2a7f7901
Max-Forwards: 70
From: <sip:555555@194.143.148.10>;tag=as3707aa9d
To: <sip:555555@194.143.148.10>
Call-ID: 62696a01795f458969ff61853c2af519@0.8.122.35
CSeq: 2524 REGISTER
User-Agent: Asterisk PBX 1.8.10.1~dfsg-1ubuntu1
Authorization: Digest username="555555", realm="194.143.148.10", algorithm=MD5, uri="sip:194.143.148.10", nonce="3413358e-c437-11e3-a6e0-6934d9634f16", response="08477e7b1929cc19aff290e6c5e21ded", qop=auth, cnonce="3758562f", nc=00000370
Expires: 120
Contact: <sip:555555@93.189.201.226:5060>
Content-Length: 0

\C3\E9MS\C3\00O\00\00O\00\00\00!\91\B1p\00\00\C0\93.\8B\00E\00A\FB\C0\00\00@\FE\B1\94
]\BD\C9\E2\C4\C4-\80xSIP/2.0 200 OK
Via: SIP/2.0/UDP 93.189.201.226:5060;branch=z9hG4bK2a7f7901
From: <sip:555555@194.143.148.10>;tag=as3707aa9d
To: <sip:555555@194.143.148.10>;tag=gjvNvKgyKc8KS
Call-ID: 62696a01795f458969ff61853c2af519@0.8.122.35
CSeq: 2524 REGISTER
Contact: <sip:555555@93.189.201.226:5060>;expires=120
Date: Wed, 16 Apr 2014 02:24:03 GMT
User-Agent: The 2600hz Project
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: precondition, path, replaces
Content-Length: 0

\CA\E9MS \00q\00\00q\00\00\00\C0\93.\8B\00
a\AE\8DU\00E\00c؊\00\00\80B\C7

\EF

H\C4\D8O>\B6OPTIONS sip:gw+gateway1@10.1.4.72:5080;transport=udp;gw=gateway1 SIP/2.0
Via: SIP/2.0/UDP 10.1.4.239:5060;branch=z9hG4bK28e1b8ad;rport
Max-Forwards: 70
From: "Unknown" <sip:Unknown@10.1.4.239>;tag=as661b407b
To: <sip:gw+gateway1@10.1.4.72:5080;transport=udp;gw=gateway1>
Contact: <sip:Unknown@10.1.4.239>
Call-ID: 5e9a95ee4c2a1af12e7ce6f022c26541@10.1.4.239
CSeq: 102 OPTIONS
User-Agent: Cisco-SIPGateway/IOS-12.x
Date: Wed, 16 Apr 2014 02:21:48 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces, timer
Content-Length: 0

\CA\E9MS="\00\CB\00\00\CB\00\00\00
a\AE\8DU\00\C0\93.\8B\00E\00\BD
\00\00@O\EB

H

\EF\D8\C4\A9\F3SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.1.4.239:5060;branch=z9hG4bK28e1b8ad;rport=5060
From: "Unknown" <sip:Unknown@10.1.4.239>;tag=as661b407b
To: <sip:gw+gateway1@10.1.4.72:5080;transport=udp;gw=gateway1>;tag=42De39mK2HaXK
Call-ID: 5e9a95ee4c2a1af12e7ce6f022c26541@10.1.4.239
CSeq: 102 OPTIONS
Contact: <sip:gw+gateway1@10.1.4.72:5080;transport=udp;gw=gateway1>
User-Agent: FreeSWITCH-mod_sofia/1.5.8b+git~20131215T034450Z~0292a04c7c~32bit
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: timer, precondition, path, replaces
Allow-Events: talk, hold, conference, refer
Content-Length: 0

\CD\E9MS؝\00S\00\00S\00\00\00\C0\93.\8B\90\E2\BA\E2p\00E\00E\87h\00\00<w]\BD\C9\E2\94
\C4\C41C6OPTIONS sip:194.143.148.10 SIP/2.0
Via: SIP/2.0/UDP 93.189.201.226:5060;branch=z9hG4bK4b305de0;rport
Max-Forwards: 70
From: "asterisk" <sip:555555@93.189.201.226:5060>;tag=as393ba86a
To: <sip:194.143.148.10>
Contact: <sip:555555@93.189.201.226:5060>
Call-ID: 5636a6ed7ea398cc594fd1ad281be89c@192.168.1.9:5060
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX 1.8.10.1~dfsg-1ubuntu1
Date: Wed, 16 Apr 2014 02:24:13 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

\CD\E9MS\A6\9F\00\EE\00\00\EE\00\00\00!\91\B1p\00\00\C0\93.\8B\00E\00\E0\FB\C1\00\00@\FE\94
]\BD\C9\E2\C4\C4́SIP/2.0 200 OK
Via: SIP/2.0/UDP 93.189.201.226:5060;branch=z9hG4bK4b305de0;rport=5060
From: "asterisk" <sip:555555@93.189.201.226:5060>;tag=as393ba86a
To: <sip:194.143.148.10>;tag=HUNeye11gNy6m
Call-ID: 5636a6ed7ea398cc594fd1ad281be89c@192.168.1.9:5060
CSeq: 102 OPTIONS
Contact: <sip:194.143.148.10>
User-Agent: The 2600hz Project
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: precondition, 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

\D4\E9MS:x
\00<\00\00\00<\00\00\00\00\C0\93.\8B\D4\CAm
D`\00E\88\00 \00\00@\00?\D6

\9B\94
\C4\C4\00Y

\00\00\00\00\00\00\00\00\00\00\00\00\00\00\D4\E9MS-\8B
\00<\00\00\00<\00\00\00\00\C0\93.\8B\D4\CAm
D`\00E\88\00 \EF\90\00\00\E6

\9A\94
\C4\C4\00Y

\00\00\00\00\00\00\00\00\00\00\00\00\00\00\DA\E9MS\915\00o\00\00o\00\00\00\C0\93.\8B\00ˣ>\81\00\00\B1\00E`]\8CW\00\00@q\B1
\B1\B1\CC
\B1\B1\F9\C4\C4I\DCINVITE sip:728308@10.177.177.249 SIP/2.0
Via: SIP/2.0/UDP 10.177.177.204:5060;branch=z9hG4bK53707057;rport
Max-Forwards: 70
From: "79027614607" <sip:79027614607@10.177.177.204>;tag=as131f5962
To: <sip:728308@10.177.177.249>
Contact: <sip:79027614607@10.177.177.204:5060>
Call-ID: 48b23714032b3e1a78f2540539a6a9bd@10.177.177.204:5060
CSeq: 102 INVITE
User-Agent: FPBX-2.9.0(1.8.8.2)
Date: Wed, 16 Apr 2014 02:23:09 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Type: application/sdp
Content-Length: 240

v=0
o=root 1009434461 1009434461 IN IP4 10.177.177.204
s=Asterisk PBX 1.8.8.2
c=IN IP4 10.177.177.204
t=0 0
m=audio 18196 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv
\DA\E9MS\E97\00v
\00\00v
\00\00\00ˣ>\00\C0\93.\8B\81\00\00\B1\00E\00
d\E6\00\00@\F7{
\B1\B1\F9
\B1\B1\CC\C4\C4
Pz\89SIP/2.0 100 Trying
Via: SIP/2.0/UDP 10.177.177.204:5060;branch=z9hG4bK53707057;rport=5060
From: "79027614607" <sip:79027614607@10.177.177.204>;tag=as131f5962
To: <sip:728308@10.177.177.249>
Call-ID: 48b23714032b3e1a78f2540539a6a9bd@10.177.177.204:5060
CSeq: 102 INVITE
User-Agent: The 2600hz Project
Content-Length: 0

\DA\E9MSWh\00\A0\00\00\A0\00\00\00ˣ>\00\C0\93.\8B\81\00\00\B1\00E\00\8E\E7\00\00@\F4P
\B1\B1\F9
\B1\B1\CC\C4\C4z}\B3SIP/2.0 183 Session Progress
Via: SIP/2.0/UDP 10.177.177.204:5060;branch=z9hG4bK53707057;rport=5060
From: "79027614607" <sip:79027614607@10.177.177.204>;tag=as131f5962
To: <sip:728308@10.177.177.249>;tag=gmUvXcXD4m2cc
Call-ID: 48b23714032b3e1a78f2540539a6a9bd@10.177.177.204:5060
CSeq: 102 INVITE
Contact: <sip:728308@10.177.177.249:5060;transport=udp>
User-Agent: The 2600hz Project
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: precondition, 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: 224
Remote-Party-ID: "728308" <sip:728308@10.177.177.249>;party=calling;privacy=off;screen=no

v=0
o=FreeSWITCH 1397582766 1397582767 IN IP4 10.177.177.249
s=FreeSWITCH
c=IN IP4 10.177.177.249
t=0 0
m=audio 32300 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
\DA\E9MS\85\00\B8\00\00\B8\00\00|/\80e\97X\00\C0\93.\8B\00E\00\AA'\CF\00\00@\E9?\94


\9A\C4\C4\96i\DCINVITE sip:9998@10.1.4.154:5060 SIP/2.0
Via: SIP/2.0/UDP 194.143.148.10;rport;branch=z9hG4bKte1BXeSSFUg5N
Route: <sip:9998@10.1.4.154:5060>
Max-Forwards: 69
From: "79027614607" <sip:79027614607@194.143.148.10>;tag=j4e7Z9H5DymSg
To: <sip:9998@10.1.4.154:5060>
Call-ID: 3b40f580-c50e-11e3-bac8-6934d9634f16
CSeq: 58471469 INVITE
Contact: <sip:mod_sofia@194.143.148.10:5060>
User-Agent: The 2600hz Project
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: precondition, 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: 205
X-FS-Support: update_display,send_info
Remote-Party-ID: "79027614607" <sip:79027614607@194.143.148.10>;party=calling;screen=yes;privacy=off

v=0
o=FreeSWITCH 1397596294 1397596295 IN IP4 194.143.148.10
s=FreeSWITCH
c=IN IP4 194.143.148.10
t=0 0
m=audio 18772 RTP/AVP 8 101 13
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
\DA\E9MS.<   \00\A4
\00\00\A4
\00\00\00\C0\93.\8B\D4\CAm
D`\00E\88
\96\EF\91\00\00\E5

\9A\94
\C4\C4
\82aSIP/2.0 100 Trying
Via: SIP/2.0/UDP 194.143.148.10;rport=5060;branch=z9hG4bKte1BXeSSFUg5N
From: "79027614607" <sip:79027614607@194.143.148.10>;tag=j4e7Z9H5DymSg
To: <sip:9998@10.1.4.154:5060>;tag=2689606658
Call-ID: 3b40f580-c50e-11e3-bac8-6934d9634f16
CSeq: 58471469 INVITE
Contact: <sip:9998@10.1.4.154:5060>
User-Agent: A510 IP/42.076.00.000.000
Content-Length: 0

\DA\E9MS\8Dz\00<\00\00\00<\00\00\00\00\C0\93.\8B\D4\CAm
D`\00E\88\00 \EF\92\00\00\E6}

\9A\94
\C4\C4\00Y

\00\00\00\00\00\00\00\00\00\00\00\00\00\00\DA\E9MS\81\00\D7
\00\00\D7
\00\00\00\C0\93.\8B\D4\CAm
D`\00E\88
\C9\EF\93\00\00\E4\D3

\9A\94
\C4\C4
\B5\CDSIP/2.0 180 Ringing
Via: SIP/2.0/UDP 194.143.148.10;rport=5060;branch=z9hG4bKte1BXeSSFUg5N
From: "79027614607" <sip:79027614607@194.143.148.10>;tag=j4e7Z9H5DymSg
To: <sip:9998@10.1.4.154:5060>;tag=2689606658
Call-ID: 3b40f580-c50e-11e3-bac8-6934d9634f16
CSeq: 58471469 INVITE
Contact: <sip:9998@10.1.4.154:5060>
Allow-Events: message-summary, refer, ua-profile
User-Agent: A510 IP/42.076.00.000.000
Content-Length: 0

\DE\E9MS
\00*\00\00*\00\00|/\80,na\00\C0\93.\8B\00E\00\87\AA\00\00@\8A\F1\94


\9B\C4\C4hOOPTIONS sip:1009@10.1.4.155:5060 SIP/2.0
Via: SIP/2.0/UDP 194.143.148.10;rport;branch=z9hG4bKUQt4y99vc46QH
Route: <sip:1009@10.1.4.155:5060>
Max-Forwards: 70
From: <sip:mod_sofia@194.143.148.10:5060>;tag=KD8Z1428a7acc
To: <sip:1009@194.143.148.10>
Call-ID: 3d59649c-c50e-11e3-bacc-6934d9634f16_3113540487@10_1_4_155
CSeq: 57567054 OPTIONS
Contact: <sip:mod_sofia@194.143.148.10:5060>
User-Agent: The 2600hz Project
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: precondition, 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

\DE\E9MS\FE
\00*\00\00*\00\00|/\80e\97X\00\C0\93.\8B\00E\00'\D0\00\00@\EA\CC\94


\9A\C4\C4hNOPTIONS sip:9998@10.1.4.154:5060 SIP/2.0
Via: SIP/2.0/UDP 194.143.148.10;rport;branch=z9hG4bKv0KX04t09cXaD
Route: <sip:9998@10.1.4.154:5060>
Max-Forwards: 70
From: <sip:mod_sofia@194.143.148.10:5060>;tag=mp1r3ZKc8F1yQ
To: <sip:9998@194.143.148.10>
Call-ID: 3d596924-c50e-11e3-bacd-6934d9634f16_1975010744@10_1_4_154
CSeq: 57567055 OPTIONS
Contact: <sip:mod_sofia@194.143.148.10:5060>
User-Agent: The 2600hz Project
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: precondition, 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

\DE\E9MSfa
\00T\00\00T\00\00\00\C0\93.\8B\D4\CAm
D`\00E\88F\00\00@\00?\D3\E9

\9B\94
\C4\C42\FC=SIP/2.0 200 OK
Via: SIP/2.0/UDP 194.143.148.10;rport=5060;branch=z9hG4bKUQt4y99vc46QH
From: <sip:mod_sofia@194.143.148.10:5060>;tag=KD8Z1428a7acc
To: <sip:1009@194.143.148.10>;tag=JE9[0539`6`bb
Call-ID: 3d59649c-c50e-11e3-bacc-6934d9634f16_3113540487@10_1_4_155
CSeq: 57567054 OPTIONS
Supported: replaces
Allow: INVITE, ACK, CANCEL, BYE, OPTIONS, INFO, REFER, SUBSCRIBE, NOTIFY
Accept: application/sdp,application/dtmf-relay,application/simple-message-summary,message/sipfrag
Accept-Encoding: identity
Accept-Language: en
Content-Length: 0

\DE\E9MSls
\00~
\00\00~
\00\00\00\C0\93.\8B\D4\CAm
D`\00E\88
p\EF\94\00\00\E5+

\9A\94
\C4\C4
\a\D1SIP/2.0 486 Busy Here
Via: SIP/2.0/UDP 194.143.148.10;rport=5060;branch=z9hG4bKv0KX04t09cXaD
From: <sip:mod_sofia@194.143.148.10:5060>;tag=mp1r3ZKc8F1yQ
To: <sip:9998@194.143.148.10>
Call-ID: 3d596924-c50e-11e3-bacd-6934d9634f16_1975010744@10_1_4_154
CSeq: 57567055 OPTIONS
User-Agent: A510 IP/42.076.00.000.000
Content-Length: 0