NOT be able to make a call

425 views
Skip to first unread message

channdy keo

unread,
Jan 6, 2013, 1:44:37 AM1/6/13
to as...@googlegroups.com
Dear Admin,

I am new to ASTPP. I have completed installation of ASTPP and I also followed "What to do next?" on http://wiki.astpp.org/index.php?title=Installation_Guide .  I am not be able to make a call. Could you please help? please also check log below.

Pricelist
   Providers
   Trunks
   Termination Rates
   Origination Rates
   Customer Accounts
   etc
/usr/local/freeswitch/conf/sip_profiles/external/astpp.xml
For example: <include> <gateway name="YOUR GATEWAY NAME"> <param name="username" value="TRUNK USERNAME"/> <param name="password" value="TRUNK PASSWORD"/> <param name="caller-id-in-from" value="true"/> <param name="realm" value="XXX.XXX.XXX.XXX"/> <param name="proxy" value="XXX.XXX.XXX.XXX"/> <param name="register" value="true"/> </gateway> </include>



2013-01-06 20:32:09.508957 [NOTICE] switch_channel.c:968 New Channel sofia/internal/0986101...@192.168.0.51 [788df6d0-5805-11e2-896d-f1b8a8ddaeb8]
2013-01-06 20:32:09.508957 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/0986101...@192.168.0.51 [BREAK]
2013-01-06 20:32:09.508957 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/0986101...@192.168.0.51 [BREAK]
2013-01-06 20:32:09.530300 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/0986101...@192.168.0.51) Running State Change CS_NEW
2013-01-06 20:32:09.530300 [DEBUG] switch_core_state_machine.c:433 (sofia/internal/0986101...@192.168.0.51) State NEW
2013-01-06 20:32:09.549130 [DEBUG] sofia.c:7731 IP 192.168.0.87 Rejected by acl "domains". Falling back to Digest auth.
2013-01-06 20:32:09.549130 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/0986101...@192.168.0.51 [BREAK]
2013-01-06 20:32:09.549130 [DEBUG] sofia.c:1750 detaching session 788df6d0-5805-11e2-896d-f1b8a8ddaeb8
2013-01-06 20:32:09.709311 [DEBUG] sofia.c:1842 Re-attaching to session 788df6d0-5805-11e2-896d-f1b8a8ddaeb8
2013-01-06 20:32:09.709311 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/0986101...@192.168.0.51 [BREAK]
2013-01-06 20:32:09.709311 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/0986101...@192.168.0.51 [BREAK]
2013-01-06 20:32:09.709311 [DEBUG] sofia.c:7731 IP 192.168.0.87 Rejected by acl "domains". Falling back to Digest auth.
2013-01-06 20:32:10.112865 [DEBUG] sofia.c:5599 Channel sofia/internal/0986101...@192.168.0.51 entering state [received][100]
2013-01-06 20:32:10.112865 [DEBUG] sofia.c:5610 Remote SDP:
v=0
o=CMI-SIPUA 15024 0 IN IP4 192.168.0.87
s=SIP CALL
c=IN IP4 192.168.0.87
t=0 0
m=audio 20000 RTP/AVP 18 101
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=rtcp:20001

2013-01-06 20:32:10.112865 [DEBUG] sofia.c:5807 (sofia/internal/0986101...@192.168.0.51) State Change CS_NEW -> CS_INIT
2013-01-06 20:32:10.112865 [DEBUG] switch_core_session.c:1291 Send signal sofia/internal/0986101...@192.168.0.51 [BREAK]
2013-01-06 20:32:10.112865 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/0986101...@192.168.0.51) Running State Change CS_INIT
2013-01-06 20:32:10.112865 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/0986101...@192.168.0.51) State INIT
2013-01-06 20:32:10.112865 [DEBUG] mod_sofia.c:86 sofia/internal/0986101...@192.168.0.51 SOFIA INIT
2013-01-06 20:32:10.112865 [DEBUG] mod_sofia.c:126 (sofia/internal/0986101...@192.168.0.51) State Change CS_INIT -> CS_ROUTING
2013-01-06 20:32:10.112865 [DEBUG] switch_core_session.c:1291 Send signal sofia/internal/0986101...@192.168.0.51 [BREAK]
2013-01-06 20:32:10.112865 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/0986101...@192.168.0.51) State INIT going to sleep
2013-01-06 20:32:10.112865 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/0986101...@192.168.0.51) Running State Change CS_ROUTING
2013-01-06 20:32:10.112865 [DEBUG] switch_channel.c:2003 (sofia/internal/0986101...@192.168.0.51) Callstate Change DOWN -> RINGING
2013-01-06 20:32:10.112865 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/0986101...@192.168.0.51) State ROUTING
2013-01-06 20:32:10.112865 [DEBUG] mod_sofia.c:149 sofia/internal/0986101...@192.168.0.51 SOFIA ROUTING
2013-01-06 20:32:10.112865 [DEBUG] switch_core_state_machine.c:117 sofia/internal/0986101...@192.168.0.51 Standard ROUTING
2013-01-06 20:32:10.112865 [INFO] mod_dialplan_xml.c:557 Processing 09861010610344 <09861010610344>->1185589610106 in context default
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->unloop] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->tod_example] continue=true
Dialplan: sofia/internal/0986101...@192.168.0.51 Date/TimeMatch (FAIL) [tod_example] break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->holiday_example] continue=true
Dialplan: sofia/internal/0986101...@192.168.0.51 Date/TimeMatch (FAIL) [holiday_example] break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->global-intercept] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [global-intercept] destination_number(1185589610106) =~ /^886$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->group-intercept] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [group-intercept] destination_number(1185589610106) =~ /^\*8$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->intercept-ext] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [intercept-ext] destination_number(1185589610106) =~ /^\*\*(\d+)$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->redial] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [redial] destination_number(1185589610106) =~ /^(redial|870)$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->global] continue=true
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [global] ${sip_has_crypto}() =~ /^(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)$/ break=never
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (PASS) [global] ${endpoint_disposition}(DELAYED NEGOTIATION) =~ /^(DELAYED NEGOTIATION)/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [global] ${switch_r_sdp}(v=0
o=CMI-SIPUA 15024 0 IN IP4 192.168.0.87
s=SIP CALL
c=IN IP4 192.168.0.87
t=0 0
m=audio 20000 RTP/AVP 18 101
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=rtcp:20001
) =~ /(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)/ break=never
Dialplan: sofia/internal/0986101...@192.168.0.51 Absolute Condition [global]
Dialplan: sofia/internal/0986101...@192.168.0.51 Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid}) 
Dialplan: sofia/internal/0986101...@192.168.0.51 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number}) 
Dialplan: sofia/internal/0986101...@192.168.0.51 Action hash(insert/${domain_name}-last_dial/global/${uuid}) 
Dialplan: sofia/internal/0986101...@192.168.0.51 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) 
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->snom-demo-2] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [snom-demo-2] destination_number(1185589610106) =~ /^9001$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->snom-demo-1] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [snom-demo-1] destination_number(1185589610106) =~ /^9000$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->eavesdrop] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [eavesdrop] destination_number(1185589610106) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->eavesdrop] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [eavesdrop] destination_number(1185589610106) =~ /^779$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->call_return] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [call_return] destination_number(1185589610106) =~ /^\*69$|^869$|^lcr$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->del-group] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [del-group] destination_number(1185589610106) =~ /^80(\d{2})$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->add-group] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [add-group] destination_number(1185589610106) =~ /^81(\d{2})$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->call-group-simo] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [call-group-simo] destination_number(1185589610106) =~ /^82(\d{2})$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->call-group-order] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [call-group-order] destination_number(1185589610106) =~ /^83(\d{2})$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->extension-intercom] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [extension-intercom] destination_number(1185589610106) =~ /^8(10[01][0-9])$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->Local_Extension] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [Local_Extension] destination_number(1185589610106) =~ /^(10[01][0-9])$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->Local_Extension_Skinny] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [Local_Extension_Skinny] destination_number(1185589610106) =~ /^(11[01][0-9])$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->group_dial_sales] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [group_dial_sales] destination_number(1185589610106) =~ /^2000$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->group_dial_support] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [group_dial_support] destination_number(1185589610106) =~ /^2001$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->group_dial_billing] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [group_dial_billing] destination_number(1185589610106) =~ /^2002$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->operator] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [operator] destination_number(1185589610106) =~ /^(operator|0)$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->vmain] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [vmain] destination_number(1185589610106) =~ /^vmain$|^4000$|^\*98$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->sip_uri] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [sip_uri] destination_number(1185589610106) =~ /^sip:(.*)$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->nb_conferences] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [nb_conferences] destination_number(1185589610106) =~ /^(30\d{2})$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->wb_conferences] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [wb_conferences] destination_number(1185589610106) =~ /^(31\d{2})$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->uwb_conferences] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [uwb_conferences] destination_number(1185589610106) =~ /^(32\d{2})$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->cdquality_conferences] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [cdquality_conferences] destination_number(1185589610106) =~ /^(33\d{2})$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->freeswitch_public_conf_via_sip] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [freeswitch_public_conf_via_sip] destination_number(1185589610106) =~ /^9(888|8888|1616|3232)$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->mad_boss_intercom] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [mad_boss_intercom] destination_number(1185589610106) =~ /^0911$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->mad_boss_intercom] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [mad_boss_intercom] destination_number(1185589610106) =~ /^0912$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->mad_boss] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [mad_boss] destination_number(1185589610106) =~ /^0913$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->ivr_demo] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [ivr_demo] destination_number(1185589610106) =~ /^5000$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->dynamic_conference] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [dynamic_conference] destination_number(1185589610106) =~ /^5001$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->rtp_multicast_page] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [rtp_multicast_page] destination_number(1185589610106) =~ /^pagegroup$|^7243$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->park] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [park] destination_number(1185589610106) =~ /^5900$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->unpark] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [unpark] destination_number(1185589610106) =~ /^5901$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->valet_park] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [valet_park] destination_number(1185589610106) =~ /^(6000)$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->valet_park] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [valet_park] destination_number(1185589610106) =~ /^(60\d[1-9])$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->park] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (PASS) [park] source(mod_sofia) =~ /mod_sofia/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [park] destination_number(1185589610106) =~ /park\+(\d+)/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->unpark] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (PASS) [unpark] source(mod_sofia) =~ /mod_sofia/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [unpark] destination_number(1185589610106) =~ /^parking$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->park] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (PASS) [park] source(mod_sofia) =~ /mod_sofia/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [park] destination_number(1185589610106) =~ /callpark/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->unpark] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (PASS) [unpark] source(mod_sofia) =~ /mod_sofia/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [unpark] destination_number(1185589610106) =~ /pickup/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->wait] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [wait] destination_number(1185589610106) =~ /^wait$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->fax_receive] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [fax_receive] destination_number(1185589610106) =~ /^9178$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->fax_transmit] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [fax_transmit] destination_number(1185589610106) =~ /^9179$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->ringback_180] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [ringback_180] destination_number(1185589610106) =~ /^9180$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->ringback_183_uk_ring] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [ringback_183_uk_ring] destination_number(1185589610106) =~ /^9181$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->ringback_183_music_ring] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [ringback_183_music_ring] destination_number(1185589610106) =~ /^9182$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->ringback_post_answer_uk_ring] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [ringback_post_answer_uk_ring] destination_number(1185589610106) =~ /^9183$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->ringback_post_answer_music] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [ringback_post_answer_music] destination_number(1185589610106) =~ /^9184$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->ClueCon] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [ClueCon] destination_number(1185589610106) =~ /^9191$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->show_info] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [show_info] destination_number(1185589610106) =~ /^9192$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->video_record] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [video_record] destination_number(1185589610106) =~ /^9193$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->video_playback] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [video_playback] destination_number(1185589610106) =~ /^9194$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->delay_echo] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [delay_echo] destination_number(1185589610106) =~ /^9195$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->echo] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [echo] destination_number(1185589610106) =~ /^9196$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->milliwatt] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [milliwatt] destination_number(1185589610106) =~ /^9197$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->tone_stream] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [tone_stream] destination_number(1185589610106) =~ /^9198$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->zrtp_enrollement] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [zrtp_enrollement] destination_number(1185589610106) =~ /^9787$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->hold_music] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [hold_music] destination_number(1185589610106) =~ /^9664$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->laugh break] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [laugh break] destination_number(1185589610106) =~ /^9386$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->101] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [101] destination_number(1185589610106) =~ /^101$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->pizza_demo] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [pizza_demo] destination_number(1185589610106) =~ /^(pizza|74992)$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->local.example.com] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [local.example.com] ${toll_allow}() =~ /local/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->domestic.example.com] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [domestic.example.com] ${toll_allow}() =~ /domestic/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->international.example.com] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [international.example.com] ${toll_allow}() =~ /international/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->Talking Clock Time] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [Talking Clock Time] destination_number(1185589610106) =~ /^9170$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->Talking Clock Date] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [Talking Clock Date] destination_number(1185589610106) =~ /^9171$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->Talking Clock Date and Time] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [Talking Clock Date and Time] destination_number(1185589610106) =~ /^9172$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->astpp_callingcards] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL) [astpp_callingcards] destination_number(1185589610106) =~ /^8008018888$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 parsing [default->enum] continue=false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (PASS) [enum] ${module_exists(mod_enum)}(true) =~ /true/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (PASS) [enum] destination_number(1185589610106) =~ /^(.*)$/ break=on-false
Dialplan: sofia/internal/0986101...@192.168.0.51 Action transfer(1185589610106 enum) 
2013-01-06 20:32:10.589620 [DEBUG] switch_core_state_machine.c:167 (sofia/internal/0986101...@192.168.0.51) State Change CS_ROUTING -> CS_EXECUTE
2013-01-06 20:32:10.589620 [DEBUG] switch_core_session.c:1291 Send signal sofia/internal/0986101...@192.168.0.51 [BREAK]
2013-01-06 20:32:10.589620 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/0986101...@192.168.0.51) State ROUTING going to sleep
2013-01-06 20:32:10.589620 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/0986101...@192.168.0.51) Running State Change CS_EXECUTE
2013-01-06 20:32:10.589620 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/0986101...@192.168.0.51) State EXECUTE
2013-01-06 20:32:10.589620 [DEBUG] mod_sofia.c:242 sofia/internal/0986101...@192.168.0.51 SOFIA EXECUTE
2013-01-06 20:32:10.589620 [DEBUG] switch_core_state_machine.c:209 sofia/internal/0986101...@192.168.0.51 Standard EXECUTE
EXECUTE sofia/internal/0986101...@192.168.0.51 hash(insert/192.168.0.51-spymap/09861010610344/788df6d0-5805-11e2-896d-f1b8a8ddaeb8)
EXECUTE sofia/internal/0986101...@192.168.0.51 hash(insert/192.168.0.51-last_dial/09861010610344/1185589610106)
EXECUTE sofia/internal/0986101...@192.168.0.51 hash(insert/192.168.0.51-last_dial/global/788df6d0-5805-11e2-896d-f1b8a8ddaeb8)
EXECUTE sofia/internal/0986101...@192.168.0.51 export(RFC2822_DATE=Sun, 06 Jan 2013 20:32:10 +0700)
2013-01-06 20:32:10.614756 [DEBUG] switch_channel.c:1135 EXPORT (export_vars) [RFC2822_DATE]=[Sun, 06 Jan 2013 20:32:10 +0700]
EXECUTE sofia/internal/0986101...@192.168.0.51 transfer(1185589610106 enum)
2013-01-06 20:32:10.614756 [DEBUG] switch_ivr.c:1794 (sofia/internal/0986101...@192.168.0.51) State Change CS_EXECUTE -> CS_ROUTING
2013-01-06 20:32:10.614756 [DEBUG] switch_core_session.c:1291 Send signal sofia/internal/0986101...@192.168.0.51 [BREAK]
2013-01-06 20:32:10.614756 [DEBUG] switch_core_session.c:830 Send signal sofia/internal/0986101...@192.168.0.51 [BREAK]
2013-01-06 20:32:10.614756 [NOTICE] switch_ivr.c:1801 Transfer sofia/internal/0986101...@192.168.0.51 to enum[1185589610106@default]
2013-01-06 20:32:10.614756 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/0986101...@192.168.0.51) State EXECUTE going to sleep
2013-01-06 20:32:10.614756 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/0986101...@192.168.0.51) Running State Change CS_ROUTING
2013-01-06 20:32:10.614756 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/0986101...@192.168.0.51) State ROUTING
2013-01-06 20:32:10.614756 [DEBUG] mod_sofia.c:149 sofia/internal/0986101...@192.168.0.51 SOFIA ROUTING
2013-01-06 20:32:10.614756 [DEBUG] switch_core_state_machine.c:117 sofia/internal/0986101...@192.168.0.51 Standard ROUTING
2013-01-06 20:32:10.614756 [DEBUG] mod_enum.c:638 ENUM Lookup on 1185589610106
2013-01-06 20:32:10.614756 [DEBUG] mod_enum.c:490 No Nameservers specified, using host default
2013-01-06 20:32:11.006067 [DEBUG] switch_core_state_machine.c:167 (sofia/internal/0986101...@192.168.0.51) State Change CS_ROUTING -> CS_EXECUTE
2013-01-06 20:32:11.006067 [DEBUG] switch_core_session.c:1291 Send signal sofia/internal/0986101...@192.168.0.51 [BREAK]
2013-01-06 20:32:11.006067 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/0986101...@192.168.0.51) State ROUTING going to sleep
2013-01-06 20:32:11.006067 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/0986101...@192.168.0.51) Running State Change CS_EXECUTE
2013-01-06 20:32:11.006067 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/0986101...@192.168.0.51) State EXECUTE
2013-01-06 20:32:11.006067 [DEBUG] mod_sofia.c:242 sofia/internal/0986101...@192.168.0.51 SOFIA EXECUTE
2013-01-06 20:32:11.006067 [DEBUG] switch_core_state_machine.c:209 sofia/internal/0986101...@192.168.0.51 Standard EXECUTE
2013-01-06 20:32:11.006067 [NOTICE] switch_core_state_machine.c:262 sofia/internal/0986101...@192.168.0.51 has executed the last dialplan instruction, hanging up.
2013-01-06 20:32:11.006067 [DEBUG] switch_channel.c:2994 (sofia/internal/0986101...@192.168.0.51) Callstate Change RINGING -> HANGUP
2013-01-06 20:32:11.006067 [NOTICE] switch_core_state_machine.c:264 Hangup sofia/internal/0986101...@192.168.0.51 [CS_EXECUTE] [NORMAL_CLEARING]
2013-01-06 20:32:11.006067 [DEBUG] switch_channel.c:3017 Send signal sofia/internal/0986101...@192.168.0.51 [KILL]
2013-01-06 20:32:11.006067 [DEBUG] switch_core_session.c:1291 Send signal sofia/internal/0986101...@192.168.0.51 [BREAK]
2013-01-06 20:32:11.006067 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/0986101...@192.168.0.51) State EXECUTE going to sleep
2013-01-06 20:32:11.006067 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/0986101...@192.168.0.51) Running State Change CS_HANGUP
2013-01-06 20:32:11.006067 [DEBUG] switch_core_state_machine.c:667 (sofia/internal/0986101...@192.168.0.51) State HANGUP
2013-01-06 20:32:11.006067 [DEBUG] mod_sofia.c:503 Channel sofia/internal/0986101...@192.168.0.51 hanging up, cause: NORMAL_CLEARING
2013-01-06 20:32:11.031071 [DEBUG] mod_sofia.c:633 Responding to INVITE with: 480
2013-01-06 20:32:11.031071 [DEBUG] switch_core_state_machine.c:48 sofia/internal/0986101...@192.168.0.51 Standard HANGUP, cause: NORMAL_CLEARING
2013-01-06 20:32:11.031071 [DEBUG] switch_core_state_machine.c:667 (sofia/internal/0986101...@192.168.0.51) State HANGUP going to sleep
2013-01-06 20:32:11.031071 [DEBUG] switch_core_state_machine.c:446 (sofia/internal/0986101...@192.168.0.51) State Change CS_HANGUP -> CS_REPORTING
2013-01-06 20:32:11.031071 [DEBUG] switch_core_session.c:1291 Send signal sofia/internal/0986101...@192.168.0.51 [BREAK]
2013-01-06 20:32:11.031071 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/0986101...@192.168.0.51) Running State Change CS_REPORTING
2013-01-06 20:32:11.031071 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/0986101...@192.168.0.51) State REPORTING
2013-01-06 20:32:28.428387 [DEBUG] switch_core_state_machine.c:92 sofia/internal/0986101...@192.168.0.51 Standard REPORTING, cause: NORMAL_CLEARING
2013-01-06 20:32:28.468574 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/0986101...@192.168.0.51) State REPORTING going to sleep
2013-01-06 20:32:28.508545 [DEBUG] switch_core_state_machine.c:440 (sofia/internal/0986101...@192.168.0.51) State Change CS_REPORTING -> CS_DESTROY
2013-01-06 20:32:28.529040 [DEBUG] switch_core_session.c:1291 Send signal sofia/internal/0986101...@192.168.0.51 [BREAK]
2013-01-06 20:32:28.529040 [DEBUG] switch_core_session.c:1499 Session 10 (sofia/internal/0986101...@192.168.0.51) Locked, Waiting on external entities
2013-01-06 20:32:28.529040 [NOTICE] switch_core_session.c:1517 Session 10 (sofia/internal/0986101...@192.168.0.51) Ended
2013-01-06 20:32:28.548581 [DEBUG] switch_core_state_machine.c:556 (sofia/internal/0986101...@192.168.0.51) Callstate Change HANGUP -> DOWN
2013-01-06 20:32:28.548581 [DEBUG] switch_core_state_machine.c:559 (sofia/internal/0986101...@192.168.0.51) Running State Change CS_DESTROY
2013-01-06 20:32:28.548581 [DEBUG] switch_core_state_machine.c:569 (sofia/internal/0986101...@192.168.0.51) State DESTROY
2013-01-06 20:32:28.569365 [DEBUG] mod_sofia.c:396 sofia/internal/0986101...@192.168.0.51 SOFIA DESTROY
2013-01-06 20:32:28.628688 [DEBUG] switch_core_state_machine.c:99 sofia/internal/0986101...@192.168.0.51 Standard DESTROY
2013-01-06 20:32:28.628688 [DEBUG] switch_core_state_machine.c:569 (sofia/internal/0986101...@192.168.0.51) State DESTROY going to sleep


Thanks,
Chandy

Samir Doshi

unread,
Jan 7, 2013, 3:08:56 AM1/7/13
to as...@googlegroups.com
Hi,

Please enable debug log on from system configuration and make calls.
While making calls, please check http error log
/var/log/httpd/error_log.

You should get some error from there. If not please send us that error
log. We will check it out.

---
Thanks,
Samir Doshi

On 2013-01-06 12:14 PM, channdy keo wrote:
> Dear Admin,
>
> I am new to ASTPP. I have completed installation of ASTPP and I also
> followed "What to do next?" on
> http://wiki.astpp.org/index.php?title=Installation_Guide [1] . I am
> not be able to make a call. Could you please help? please also check
> log below.
>
> Pricelist
> Providers
> Trunks
> Termination Rates
> Origination Rates
> Customer Accounts
> etc
>
> /usr/local/freeswitch/conf/sip_profiles/external/astpp.xml
>
> FOR EXAMPLE:
> [group-intercept] destination_number(1185589610106) =~ /^*8$/
> break=on-false
> Dialplan: sofia/internal/0986101...@192.168.0.51 parsing
> [default->intercept-ext] continue=false
> Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL)
> [intercept-ext] destination_number(1185589610106) =~ /^**(d+)$/
> /^88(d{4})$|^*0(.*)$/
> break=on-false
> Dialplan: sofia/internal/0986101...@192.168.0.51 parsing
> [default->eavesdrop] continue=false
> Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL)
> [eavesdrop] destination_number(1185589610106) =~ /^779$/
> break=on-false
> Dialplan: sofia/internal/0986101...@192.168.0.51 parsing
> [default->call_return] continue=false
> Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL)
> [call_return] destination_number(1185589610106) =~
> /^*69$|^869$|^lcr$/
> break=on-false
> Dialplan: sofia/internal/0986101...@192.168.0.51 parsing
> [default->del-group] continue=false
> Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL)
> [del-group] destination_number(1185589610106) =~ /^80(d{2})$/
> break=on-false
> Dialplan: sofia/internal/0986101...@192.168.0.51 parsing
> [default->add-group] continue=false
> Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL)
> [add-group] destination_number(1185589610106) =~ /^81(d{2})$/
> break=on-false
> Dialplan: sofia/internal/0986101...@192.168.0.51 parsing
> [default->call-group-simo] continue=false
> Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL)
> [call-group-simo] destination_number(1185589610106) =~ /^82(d{2})$/
> break=on-false
> Dialplan: sofia/internal/0986101...@192.168.0.51 parsing
> [default->call-group-order] continue=false
> Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL)
> [call-group-order] destination_number(1185589610106) =~ /^83(d{2})$/
> [vmain] destination_number(1185589610106) =~ /^vmain$|^4000$|^*98$/
> break=on-false
> Dialplan: sofia/internal/0986101...@192.168.0.51 parsing
> [default->sip_uri] continue=false
> Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL)
> [sip_uri] destination_number(1185589610106) =~ /^sip:(.*)$/
> break=on-false
> Dialplan: sofia/internal/0986101...@192.168.0.51 parsing
> [default->nb_conferences] continue=false
> Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL)
> [nb_conferences] destination_number(1185589610106) =~ /^(30d{2})$/
> break=on-false
> Dialplan: sofia/internal/0986101...@192.168.0.51 parsing
> [default->wb_conferences] continue=false
> Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL)
> [wb_conferences] destination_number(1185589610106) =~ /^(31d{2})$/
> break=on-false
> Dialplan: sofia/internal/0986101...@192.168.0.51 parsing
> [default->uwb_conferences] continue=false
> Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL)
> [uwb_conferences] destination_number(1185589610106) =~ /^(32d{2})$/
> break=on-false
> Dialplan: sofia/internal/0986101...@192.168.0.51 parsing
> [default->cdquality_conferences] continue=false
> Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL)
> [cdquality_conferences] destination_number(1185589610106) =~
> /^(33d{2})$/ break=on-false
> [valet_park] destination_number(1185589610106) =~ /^(60d[1-9])$/
> break=on-false
> Dialplan: sofia/internal/0986101...@192.168.0.51 parsing
> [default->park] continue=false
> Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (PASS)
> [park] source(mod_sofia) =~ /mod_sofia/ break=on-false
> Dialplan: sofia/internal/0986101...@192.168.0.51 Regex (FAIL)
> [park] destination_number(1185589610106) =~ /park+(d+)/
> 2013-01-06 20:32:10.614756 [DEBUG] MOD_ENUM.C:638 ENUM LOOKUP ON
> 1185589610106
> 2013-01-06 20:32:10.614756 [DEBUG] MOD_ENUM.C:490 NO NAMESERVERS
> SPECIFIED, USING HOST DEFAULT
> Links:
> ------
> [1] http://wiki.astpp.org/index.php?title=Installation_Guide

channdy keo

unread,
Jan 7, 2013, 8:45:37 PM1/7/13
to as...@googlegroups.com, sa...@astpp.org
Dear Samir Doshi,

Here is the error log, please help me to find out the problem.


Thanks very much!
Chandy

[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-Caller-ID-Number 09861010610344
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-Network-Addr 192.168.0.121
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-ANI 09861010610344
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-Destination-Number 1185589610106
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-Unique-ID 08f29748-596f-11e2-aa1d-232b38ec329a
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-Source mod_sofia
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-Context default
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-Channel-Name sofia/internal/0986101...@192.168.0.51
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-Profile-Index 1
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-Profile-Created-Time 1357634420490441
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-Channel-Created-Time 1357634420490441
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-Channel-Answered-Time 0
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-Channel-Progress-Time 0
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-Channel-Progress-Media-Time 0
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-Channel-Hangup-Time 0
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-Channel-Transfer-Time 0
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-Channel-Resurrect-Time 0
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-Channel-Bridged-Time 0
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-Channel-Last-Hold 0
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-Channel-Hold-Accum 0
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-Screen-Bit true
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-Privacy-Hide-Name false
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Caller-Privacy-Hide-Number false
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_direction inbound
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_uuid 08f29748-596f-11e2-aa1d-232b38ec329a
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_session_id 2
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_from_user 09861010610344
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_from_uri 0986101...@192.168.0.51
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_from_host 192.168.0.51
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_channel_name sofia/internal/0986101...@192.168.0.51
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_call_id NjliMTc4ZjVjYjIwYzk4YWIyZDdlMTUwZTA2Y2E1Yjk.
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_local_network_addr 192.168.0.51
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_network_ip 192.168.0.121
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_network_port 35820
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_received_ip 192.168.0.121
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_received_port 35820
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_via_protocol udp
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_authorized true
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_number_alias 09861010610344
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_auth_username 09861010610344
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_auth_realm 192.168.0.51
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_number_alias 09861010610344
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_user_name 09861010610344
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_domain_name 192.168.0.51
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_accountcode 098610106
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_user_context default
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_from_user_stripped 09861010610344
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_from_tag 31377814
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sofia_profile_name internal
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_recovery_profile_name internal
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_full_via SIP/2.0/UDP 192.168.0.121:35820;branch=z9hG4bK-d8754z-197fc94d9e0cc53f-1---d8754z-;rport=35820
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_from_display 09861010610344
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_full_from "09861010610344" <sip:0986101...@192.168.0.51>;tag=31377814
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_to_display 1185589610106
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_full_to "1185589610106" <sip:118558...@192.168.0.51>
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_req_user 1185589610106
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_req_uri 118558...@192.168.0.51
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_req_host 192.168.0.51
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_to_user 1185589610106
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_to_uri 118558...@192.168.0.51
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_to_host 192.168.0.51
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_contact_user 09861010610344
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_contact_port 35820
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_contact_uri 0986101...@192.168.0.121:35820
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_contact_host 192.168.0.121
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_user_agent eyeBeam release 1102q stamp 51814
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_via_host 192.168.0.121
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_via_port 35820
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_sip_via_rport 35820
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_max_forwards 70
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_presence_id 0986101...@192.168.0.51
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_switch_r_sdp v=0\r
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] o=- 2 2 IN IP4 192.168.0.121\r
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] s=CounterPath eyeBeam 1.5\r
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] c=IN IP4 192.168.0.121\r
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] t=0 0\r
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] m=audio 51142 RTP/AVP 107 0 8 18 101\r
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] a=rtpmap:107 BV32/16000\r
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] a=rtpmap:18 G729/8000\r
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] a=fmtp:18 annexb=yes\r
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] a=rtpmap:101 telephone-event/8000\r
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] a=fmtp:101 0-15\r
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] a=alt:1 1 : y1YXOuAg H+pIOXEM 192.168.0.121 51142\r
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] 
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_ep_codec_string PCMU@8000h@20i@64000b,PCMA@8000h@20i@64000b
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_endpoint_disposition DELAYED NEGOTIATION
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] variable_call_uuid 08f29748-596f-11e2-aa1d-232b38ec329a
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Direction inbound
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Username 09861010610344
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Dialplan XML
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Caller-ID-Name 09861010610344
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Caller-ID-Number 09861010610344
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Network-Addr 192.168.0.121
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-ANI 09861010610344
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Destination-Number 1185589610106
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Unique-ID 08f29748-596f-11e2-aa1d-232b38ec329a
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Source mod_sofia
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Context default
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Channel-Name sofia/internal/0986101...@192.168.0.51
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Profile-Index 1
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Profile-Created-Time 1357634420490441
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Channel-Created-Time 1357634420490441
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Channel-Answered-Time 0
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Channel-Progress-Time 0
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Channel-Progress-Media-Time 0
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Channel-Hangup-Time 0
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Channel-Transfer-Time 0
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Channel-Resurrect-Time 0
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Channel-Bridged-Time 0
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Channel-Last-Hold 0
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Channel-Hold-Accum 0
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Screen-Bit true
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Privacy-Hide-Name false
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Hunt-Privacy-Hide-Number false
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Destination = 1185589610106
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] 098610106, 1185589610106
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] FINDING LIMIT FOR: 098610106
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] SELECT * FROM pricelists WHERE name = 'test'
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Pricelist: test 
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] SELECT * FROM routes WHERE '1185589610106' RLIKE pattern AND status = 1 AND pricelist = 'test' ORDER BY LENGTH(pattern) DESC LIMIT 1
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] pattern: ^11.*
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Route: Ezecomt Outbound Cost: 0.02000 Pricelist: test Pattern: ^11.*
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Found pattern: ^11.*
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Account Balance: -50.448229
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Credit Limit: 0
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Credit: 50.448229
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Pricelist: test 
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] SELECT * FROM routes WHERE '1185589610106' RLIKE pattern AND status = 1 AND pricelist = 'test' ORDER BY LENGTH(pattern) DESC LIMIT 1
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] pattern: ^11.*
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Route: Ezecomt Outbound Cost: 0.02000 Pricelist: test Pattern: ^11.*
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Cost: 0.02000
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Pricelist: test
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] CALLSTATUS: 1 MAX_LENGTH: 504.48229
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] PRINTING LIST OF RESELLERS FOR THIS ACCOUNT
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Looking for Route
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Pricelist: test 
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] SELECT * FROM routes WHERE '1185589610106' RLIKE pattern AND status = 1 AND pricelist = 'test' ORDER BY LENGTH(pattern) DESC LIMIT 1
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] pattern: ^11.*
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Route: Ezecomt Outbound Cost: 0.02000 Pricelist: test Pattern: ^11.*
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] WE DID NOT RECEIVE A LIST OF RESELLERS TO CHECK AGAINST.
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] Content-Type: text/plain; charset=ISO-8859-1\r
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] \r
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] <?xml version="1.0" encoding="UTF-8" standalone="no"?>
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] <document type="freeswitch/xml">
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] <section name="dialplan" description="ASTPP Dynamic Routing">
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] <context name="default">
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] <extension name="1185589610106">
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] <condition field="destination_number" expression="1185589610106">
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] <action application="set" data="effective_destination_number=1185589610106"/>
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] <action application="sched_hangup" data="+86400"/>
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] <action application="set" data="accountcode=098610106"/>
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] </condition>
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] </extension>
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] </context>
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] </section>
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] </document>
[Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] 
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] Connected to Freeswitch(TM) Database!
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] DBI:mysql:database=fscdr;host=127.0.0.1
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] Connected to CDR Database!
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] cdr <?xml version="1.0"?>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] <cdr core-uuid="45210e26-5969-11e2-a9e7-232b38ec329a">
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]   <channel_data>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <state>CS_REPORTING</state>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <direction>inbound</direction>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <state_number>11</state_number>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <flags>0=1;37=1;39=1;72=1</flags>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <caps>1=1;2=1;3=1;4=1;5=1;6=1</caps>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]   </channel_data>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]   <variables>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <direction>inbound</direction>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <uuid>08f29748-596f-11e2-aa1d-232b38ec329a</uuid>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <session_id>2</session_id>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_from_user>09861010610344</sip_from_user>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_from_uri>09861010610344%40192.168.0.51</sip_from_uri>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_from_host>192.168.0.51</sip_from_host>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <channel_name>sofia/internal/09861010610344%40192.168.0.51</channel_name>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_call_id>NjliMTc4ZjVjYjIwYzk4YWIyZDdlMTUwZTA2Y2E1Yjk.</sip_call_id>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_local_network_addr>192.168.0.51</sip_local_network_addr>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_network_ip>192.168.0.121</sip_network_ip>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_network_port>35820</sip_network_port>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_received_ip>192.168.0.121</sip_received_ip>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_received_port>35820</sip_received_port>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_via_protocol>udp</sip_via_protocol>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_authorized>true</sip_authorized>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_number_alias>09861010610344</sip_number_alias>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_auth_username>09861010610344</sip_auth_username>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_auth_realm>192.168.0.51</sip_auth_realm>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <number_alias>09861010610344</number_alias>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <user_name>09861010610344</user_name>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <domain_name>192.168.0.51</domain_name>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <user_context>default</user_context>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_from_user_stripped>09861010610344</sip_from_user_stripped>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_from_tag>31377814</sip_from_tag>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sofia_profile_name>internal</sofia_profile_name>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <recovery_profile_name>internal</recovery_profile_name>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_full_via>SIP/2.0/UDP%20192.168.0.121%3A35820%3Bbranch%3Dz9hG4bK-d8754z-197fc94d9e0cc53f-1---d8754z-%3Brport%3D35820</sip_full_via>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_from_display>09861010610344</sip_from_display>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_full_from>%2209861010610344%22%20%3Csip%3A09861010610344%40192.168.0.51%3E%3Btag%3D31377814</sip_full_from>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_to_display>1185589610106</sip_to_display>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_full_to>%221185589610106%22%20%3Csip%3A1185589610106%40192.168.0.51%3E</sip_full_to>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_req_user>1185589610106</sip_req_user>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_req_uri>1185589610106%40192.168.0.51</sip_req_uri>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_req_host>192.168.0.51</sip_req_host>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_to_user>1185589610106</sip_to_user>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_to_uri>1185589610106%40192.168.0.51</sip_to_uri>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_to_host>192.168.0.51</sip_to_host>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_contact_user>09861010610344</sip_contact_user>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_contact_port>35820</sip_contact_port>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_contact_uri>09861010610344%40192.168.0.121%3A35820</sip_contact_uri>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_contact_host>192.168.0.121</sip_contact_host>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_user_agent>eyeBeam%20release%201102q%20stamp%2051814</sip_user_agent>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_via_host>192.168.0.121</sip_via_host>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_via_port>35820</sip_via_port>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_via_rport>35820</sip_via_rport>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <max_forwards>70</max_forwards>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <presence_id>09861010610344%40192.168.0.51</presence_id>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <switch_r_sdp>v%3D0%0D%0Ao%3D-%202%202%20IN%20IP4%20192.168.0.121%0D%0As%3DCounterPath%20eyeBeam%201.5%0D%0Ac%3DIN%20IP4%20192.168.0.121%0D%0At%3D0%200%0D%0Am%3Daudio%2051142%20RTP/AVP%20107%200%208%2018%20101%0D%0Aa%3Drtpmap%3A107%20BV32/16000%0D%0Aa%3Drtpmap%3A18%20G729/8000%0D%0Aa%3Dfmtp%3A18%20annexb%3Dyes%0D%0Aa%3Drtpmap%3A101%20telephone-event/8000%0D%0Aa%3Dfmtp%3A101%200-15%0D%0Aa%3Dalt%3A1%201%20%3A%20y1YXOuAg%20H%2BpIOXEM%20192.168.0.121%2051142%0D%0A</switch_r_sdp>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <ep_codec_string>PCMU%408000h%4020i%4064000b,PCMA%408000h%4020i%4064000b</ep_codec_string>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <endpoint_disposition>DELAYED%20NEGOTIATION</endpoint_disposition>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <call_uuid>08f29748-596f-11e2-aa1d-232b38ec329a</call_uuid>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <effective_destination_number>1185589610106</effective_destination_number>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <current_application_data>accountcode%3D098610106</current_application_data>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <current_application>set</current_application>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <accountcode>098610106</accountcode>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <hangup_cause>NORMAL_CLEARING</hangup_cause>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <hangup_cause_q850>16</hangup_cause_q850>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <digits_dialed>none</digits_dialed>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <start_stamp>2013-01-08%2015%3A
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] 40%3A20</start_stamp>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <profile_start_stamp>2013-01-08%2015%3A40%3A20</profile_start_stamp>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <end_stamp>2013-01-08%2015%3A40%3A20</end_stamp>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <start_epoch>1357634420</start_epoch>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <start_uepoch>1357634420490441</start_uepoch>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <profile_start_epoch>1357634420</profile_start_epoch>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <profile_start_uepoch>1357634420490441</profile_start_uepoch>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <answer_epoch>0</answer_epoch>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <answer_uepoch>0</answer_uepoch>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <bridge_epoch>0</bridge_epoch>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <bridge_uepoch>0</bridge_uepoch>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <last_hold_epoch>0</last_hold_epoch>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <last_hold_uepoch>0</last_hold_uepoch>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <hold_accum_seconds>0</hold_accum_seconds>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <hold_accum_usec>0</hold_accum_usec>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <hold_accum_ms>0</hold_accum_ms>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <resurrect_epoch>0</resurrect_epoch>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <resurrect_uepoch>0</resurrect_uepoch>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <progress_epoch>0</progress_epoch>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <progress_uepoch>0</progress_uepoch>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <progress_media_epoch>0</progress_media_epoch>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <progress_media_uepoch>0</progress_media_uepoch>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <end_epoch>1357634420</end_epoch>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <end_uepoch>1357634420915967</end_uepoch>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <last_app>set</last_app>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <last_arg>accountcode%3D098610106</last_arg>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <caller_id>%2209861010610344%22%20%3C09861010610344%3E</caller_id>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <duration>0</duration>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <billsec>0</billsec>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <progresssec>0</progresssec>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <answersec>0</answersec>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <waitsec>0</waitsec>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <progress_mediasec>0</progress_mediasec>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <flow_billsec>0</flow_billsec>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <mduration>425</mduration>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <billmsec>0</billmsec>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <progressmsec>0</progressmsec>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <answermsec>0</answermsec>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <waitmsec>0</waitmsec>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <progress_mediamsec>0</progress_mediamsec>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <flow_billmsec>0</flow_billmsec>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <uduration>425526</uduration>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <billusec>0</billusec>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <progressusec>0</progressusec>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <answerusec>0</answerusec>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <waitusec>0</waitusec>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <progress_mediausec>0</progress_mediausec>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <flow_billusec>0</flow_billusec>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <sip_hangup_disposition>send_refuse</sip_hangup_disposition>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]   </variables>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]   <app_log>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <application app_name="set" app_data="effective_destination_number=1185589610106" app_stamp="1357634420919587"></application>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <application app_name="sched_hangup" app_data="+86400" app_stamp="1357634420919896"></application>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <application app_name="set" app_data="accountcode=098610106" app_stamp="1357634420920185"></application>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]   </app_log>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]   <callflow dialplan="XML" unique-id="0930c75c-596f-11e2-aa20-232b38ec329a" profile_index="1">
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <extension name="1185589610106" number="1185589610106">
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <application app_name="set" app_data="effective_destination_number=1185589610106"></application>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <application app_name="sched_hangup" app_data="+86400"></application>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <application app_name="set" app_data="accountcode=098610106"></application>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     </extension>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <caller_profile>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <username>09861010610344</username>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <dialplan>XML</dialplan>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <caller_id_name>09861010610344</caller_id_name>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <caller_id_number>09861010610344</caller_id_number>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <callee_id_name></callee_id_name>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <callee_id_number></callee_id_number>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <ani>09861010610344</ani>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <aniii></aniii>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <network_addr>192.168.0.121</network_addr>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <rdnis></rdnis>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <destination_number>1185589610106</destination_number>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <uuid>08f29748-596f-11e2-aa1d-232b38ec329a</uuid>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <source>mod_sofia</source>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <context>default</context>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <chan_name>sofia/internal/0986101...@192.168.0.51</chan_name>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     </caller_profile>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     <times>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <created_time>1357634420490441</created_time>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <profile_created_time>1357634420490441</profile_created_time>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <progress_time>0</progress_time>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <progress_media_time>0</progress_media_time>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <answered_time>0</answered_time>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <bridged_time>0</bridged_time>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <last_hold_time>0</last_hold_time>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <hold_accum_time>0</hold_accum_time>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <hangup_time>1357634420915967</hangup_time>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <resurrect_time>0</resurrect_time>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]       <transfer_time>0</transfer_time>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     </times>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]   </callflow>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] </cdr>
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] 
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] Call hangup and CDR Generating
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] $VAR1 = {
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]           'channel_data' => {
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                             'direction' => 'inbound',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                             'state_number' => '11',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                             'flags' => '0=1;37=1;39=1;72=1',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                             'caps' => '1=1;2=1;3=1;4=1;5=1;6=1',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                             'state' => 'CS_REPORTING'
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                           },
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]           'variables' => {
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'last_hold_uepoch' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'profile_start_stamp' => '2013-01-08%2015%3A40%3A20',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_network_port' => '35820',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'start_epoch' => '1357634420',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'number_alias' => '09861010610344',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_to_display' => '1185589610106',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'mduration' => '425',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_full_from' => '%2209861010610344%22%20%3Csip%3A09861010610344%40192.168.0.51%3E%3Btag%3D31377814',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_local_network_addr' => '192.168.0.51',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_contact_host' => '192.168.0.121',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_to_user' => '1185589610106',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'last_hold_epoch' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_via_port' => '35820',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'answer_uepoch' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_contact_port' => '35820',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_to_host' => '192.168.0.51',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'hangup_cause_q850' => '16',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'user_context' => 'default',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'progress_uepoch' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'waitmsec' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'progress_mediasec' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'answermsec' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'progress_media_epoch' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'progress_epoch' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'profile_start_epoch' => '1357634420',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'resurrect_uepoch' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_full_to' => '%221185589610106%22%20%3Csip%3A1185589610106%40192.168.0.51%3E',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'uduration' => '425526',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'recovery_profile_name' => 'internal',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'billsec' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_from_host' => '192.168.0.51',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'bridge_epoch' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'progress_mediausec' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'session_id' => '2',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'bridge_uepoch' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_from_user_stripped' => '09861010610344',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'waitsec' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'end_uepoch' => '1357634420915967',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'start_stamp' => '2013-01-08%2015%3A40%3A20',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'call_uuid' => '08f29748-596f-11e2-aa1d-232b38ec329a',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sofia_profile_name' => 'internal',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'direction' => 'inbound',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_from_display' => '09861010610344',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'progressusec' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_number_alias' => '09861010610344',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_received_ip' => '192.168.0.121',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'end_stamp' => '2013-01-08%2015%3A40%3A20',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'answersec' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'current_application' => 'set',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'end_epoch' => '1357634420',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'max_forwards' => '70',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'hold_accum_ms' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'switch_r_sdp' => 'v%3D0%0D%0Ao%3D-%202%202%20IN%20IP4%20192.168.0.121%0D%0As%3DCounterPath%20eyeBeam%201.5%0D%0Ac%3DIN%20IP4%20192.168.0.121%0D%0At%3D0%200%0D%0Am%3Daudio%2051142%20RTP/AVP%20107%200%208%2018%20101%0D%0Aa%3Drtpmap%3A107%20BV32/16000%0D%0Aa%3Drtpmap%3A18%20G729/8000%0D%0Aa%3Dfmtp%3A18%20annexb%3Dyes%0D%0Aa%3Drtpmap%3A101%20telephone-event/8000%0D%0Aa%3Dfmtp%3A101%200-15%0D%0Aa%3Dalt%3A1%201%20%3A%20y1YXOuAg%20H%2BpIOXEM%20192.168.0.121%2051142%0D%0A',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_from_user' => '09861010610344',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_via_host' => '192.168.0.121',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'progress_mediamsec' =
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] > '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'progressmsec' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'flow_billsec' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'uuid' => '08f29748-596f-11e2-aa1d-232b38ec329a',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_network_ip' => '192.168.0.121',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'digits_dialed' => 'none',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'progress_media_uepoch' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'resurrect_epoch' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_via_rport' => '35820',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'presence_id' => '09861010610344%40192.168.0.51',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_hangup_disposition' => 'send_refuse',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_authorized' => 'true',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_req_uri' => '1185589610106%40192.168.0.51',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'channel_name' => 'sofia/internal/09861010610344%40192.168.0.51',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'duration' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'answer_epoch' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_req_host' => '192.168.0.51',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'user_name' => '09861010610344',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_full_via' => 'SIP/2.0/UDP%20192.168.0.121%3A35820%3Bbranch%3Dz9hG4bK-d8754z-197fc94d9e0cc53f-1---d8754z-%3Brport%3D35820',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'endpoint_disposition' => 'DELAYED%20NEGOTIATION',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_received_port' => '35820',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'answerusec' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'waitusec' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_req_user' => '1185589610106',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'billmsec' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'billusec' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'current_application_data' => 'accountcode%3D098610106',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'accountcode' => '098610106',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_contact_uri' => '09861010610344%40192.168.0.121%3A35820',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'hold_accum_seconds' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'last_arg' => 'accountcode%3D098610106',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'profile_start_uepoch' => '1357634420490441',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'flow_billusec' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_user_agent' => 'eyeBeam%20release%201102q%20stamp%2051814',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_to_uri' => '1185589610106%40192.168.0.51',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'ep_codec_string' => 'PCMU%408000h%4020i%4064000b,PCMA%408000h%4020i%4064000b',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_contact_user' => '09861010610344',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'progresssec' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_from_tag' => '31377814',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_auth_username' => '09861010610344',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_from_uri' => '09861010610344%40192.168.0.51',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'caller_id' => '%2209861010610344%22%20%3C09861010610344%3E',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'domain_name' => '192.168.0.51',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'start_uepoch' => '1357634420490441',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_auth_realm' => '192.168.0.51',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'last_app' => 'set',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'hangup_cause' => 'NORMAL_CLEARING',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'flow_billmsec' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_call_id' => 'NjliMTc4ZjVjYjIwYzk4YWIyZDdlMTUwZTA2Y2E1Yjk.',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'sip_via_protocol' => 'udp',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'hold_accum_usec' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                          'effective_destination_number' => '1185589610106'
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                        },
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]           'callflow' => {
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                         'extension' => {
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                        'number' => '1185589610106',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                        'application' => [
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                                         {
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                                           'app_name' => 'set',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                                           'app_data' => 'effective_destination_number=1185589610106'
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                                         },
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                                         {
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                                           'app_name' => 'sched_hangup',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                                           'app_data' => '+86400'
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                                     
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]     },
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                                         {
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                                           'app_name' => 'set',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                                           'app_data' => 'accountcode=098610106'
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                                         }
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                                       ],
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                        'name' => '1185589610106'
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                      },
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                         'dialplan' => 'XML',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                         'profile_index' => '1',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                         'caller_profile' => {
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                             'source' => 'mod_sofia',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                             'callee_id_name' => {},
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                             'caller_id_name' => '09861010610344',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                             'caller_id_number' => '09861010610344',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                             'aniii' => {},
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                             'uuid' => '08f29748-596f-11e2-aa1d-232b38ec329a',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                             'callee_id_number' => {},
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                             'username' => '09861010610344',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                             'network_addr' => '192.168.0.121',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                             'ani' => '09861010610344',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                             'dialplan' => 'XML',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                             'context' => 'default',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                             'destination_number' => '1185589610106',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                             'rdnis' => {},
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                             'chan_name' => 'sofia/internal/0986101...@192.168.0.51'
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                           },
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                         'times' => {
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                    'answered_time' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                    'hangup_time' => '1357634420915967',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                    'created_time' => '1357634420490441',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                    'progress_media_time' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                    'progress_time' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                    'last_hold_time' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                    'transfer_time' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                    'resurrect_time' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                    'profile_created_time' => '1357634420490441',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                    'bridged_time' => '0',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                    'hold_accum_time' => '0'
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                  },
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                         'unique-id' => '0930c75c-596f-11e2-aa20-232b38ec329a'
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                       },
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]           'app_log' => {
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                        'application' => [
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                         {
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                           'app_name' => 'set',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                           'app_stamp' => '1357634420919587',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                           'app_data' => 'effective_destination_number=1185589610106'
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                         },
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                         {
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                           'app_name' => 'sched_hangup',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                           'app_stamp' => '1357634420919896',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                           'app_data' => '+86400'
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                         },
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                         {
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                           'app_name' => 'set',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                           'app_stamp' => '1357634420920185',
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                           'app_data' => 'accountcode=098610106'
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                         }
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                                       ]
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]                      },
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]           'core-uuid' => '45210e26-5969-11e2-a9e7-232b38ec329a'
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1]         };
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] 
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] INSERT INTO fscdr(accountcode,src,dst,dcontext,clid,channel,dstchannel,lastapp,lastdata,calldate,answerdate,enddate,duration,billsec,disposition,amaflags,uniqueid,originator,userfield,read_codec,write_codec,cost,vendor,provider,trunk,outbound_route,progressmsec,answermsec,progress_mediamsec) VALUES ('098610106','09861010610344','1185589610106','default','"09861010610344" <09861010610344>','sofia/internal/0986101...@192.168.0.51','','set','accountcode=098610106','2013-01-08 15:40:20','','2013-01-08 15:40:20','0','0','NORMAL_CLEARING','','08f29748-596f-11e2-aa1d-232b38ec329a','','','','','none','none','','','','0','0','0')
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] Processing Uniqueid: 08f29748-596f-11e2-aa1d-232b38ec329a
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] UPDATE fscdr SET vendor = '0' WHERE uniqueid = '08f29748-596f-11e2-aa1d-232b38ec329a' AND dst = '1185589610106' LIMIT 1
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] 
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] ----------------------
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] CDR Written - No Billable Seconds
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] uniqueid 08f29748-596f-11e2-aa1d-232b38ec329a, cardno 098610106, phoneno 1185589610106
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] disposition NORMAL_CLEARING
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] ----------------------
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] Vendor Rating Starting/n
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] Vendor Rating Uniqueid: 08f29748-596f-11e2-aa1d-232b38ec329a
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] SELECT * FROM fscdr WHERE uniqueid = '08f29748-596f-11e2-aa1d-232b38ec329a'
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] SELECT * FROM outbound_routes WHERE id = ''
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] UPDATE fscdr SET vendor = 'error' WHERE uniqueid = '08f29748-596f-11e2-aa1d-232b38ec329a' AND dst = '1185589610106' LIMIT 1
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] VENDOR CHARGES: 1
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] Vendor Rating Uniqueid: 08f29748-596f-11e2-aa1d-232b38ec329a
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] SELECT * FROM fscdr WHERE uniqueid = '08f29748-596f-11e2-aa1d-232b38ec329a'
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] SELECT * FROM outbound_routes WHERE id = ''
[Tue Jan 08 15:40:21 2013] [error] [client 127.0.0.1] UPDATE fscdr SET vendor = 'error' WHERE uniqueid = '08f29748-596f-11e2-aa1d-232b38ec329a' AND dst = '1185589610106' LIMIT 1

Samir Doshi

unread,
Jan 8, 2013, 7:34:49 AM1/8/13
to channdy keo, as...@googlegroups.com
It looks like you haven't configured trunks and termination rates
properly. I see in log, call is getting termination rates but somehow
not able to get trunk information. Please check in trunk and termination
rates configuration again.

---
Thanks,
Samir Doshi
> variable_switch_r_sdp v=0r
> [Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] o=- 2 2 IN IP4
> 192.168.0.121r
> [Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] s=CounterPath
> eyeBeam 1.5r
> [Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] c=IN IP4
> 192.168.0.121r
> [Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] t=0 0r
> [Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] m=audio 51142
> RTP/AVP 107 0 8 18 101r
> [Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] a=rtpmap:107
> BV32/16000r
> [Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] a=rtpmap:18
> G729/8000r
> [Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] a=fmtp:18
> annexb=yesr
> [Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] a=rtpmap:101
> telephone-event/8000r
> [Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] a=fmtp:101
> 0-15r
> [Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1] a=alt:1 1 :
> y1YXOuAg H+pIOXEM 192.168.0.121 51142r
> text/plain; charset=ISO-8859-1r

channdy keo

unread,
Jan 8, 2013, 8:48:40 PM1/8/13
to as...@googlegroups.com, channdy keo, sa...@astpp.org
Dear Samir,

Thanks very much for your reply. I have configured trunks and termination rate and i think it should be properly configured now. I got "Call Rejected" error in log file. I cannot figure out whether ASTPP or my outbound partner rejected the call? Please help me to analyse the log below: Does ASTPP or outbound partner rejected the calls?

[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Connected to Freeswitch(TM) Database!
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] DBI:mysql:database=fscdr;host=127.0.0.1
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Connected to CDR Database!
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] hostname astpp-vm
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] section directory
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] tag_name domain
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] key_name name
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] key_value 192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Event-Name REQUEST_PARAMS
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Core-UUID 5fdff5b2-5a34-11e2-8537-c99be87bf994
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] FreeSWITCH-Hostname astpp-vm
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] FreeSWITCH-Switchname astpp-vm
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] FreeSWITCH-IPv4 192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] FreeSWITCH-IPv6 ::1
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Event-Date-Local 2013-01-09 15:35:49
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Event-Date-GMT Wed, 09 Jan 2013 08:35:49 GMT
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Event-Date-Timestamp 1357720549880879
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Event-Calling-File sofia_reg.c
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Event-Calling-Function sofia_reg_parse_auth
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Event-Calling-Line-Number 2412
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Event-Sequence 758
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] action sip_auth
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] sip_profile internal
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] sip_user_agent CM5K-PHONE  (908260)
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] sip_auth_username 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] sip_auth_realm 192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] sip_auth_nonce 92324972-5a37-11e2-857c-c99be87bf994
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] sip_auth_uri sip:85589...@192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] sip_contact_user 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] sip_contact_host 192.168.0.87
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] sip_to_user 85589610106
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] sip_to_host 192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] sip_from_user 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] sip_from_host 192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] sip_request_user 85589610106
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] sip_request_host 192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] sip_auth_qop auth
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] sip_auth_cnonce 48d9a6
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] sip_auth_nc 00000001
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] sip_auth_response 4a5d51a0c1c21883240530b93242ef0f
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] sip_auth_method INVITE
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] key id
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] user 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] domain 192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] ip 192.168.0.87
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] COUNT: 1
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] SELECT * FROM ip_map WHERE ip = '192.168.0.87' AND prefix IN (NULL,'') OR ip = '192.168.0.87' ORDER BY LENGTH(prefix) DESC
 LIMIT 1
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] COUNT: 
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] TOTAL USERS: 1 
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] User Count: 1
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Content-Type: text/plain; charset=ISO-8859-1\r
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] \r
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <?xml version="1.0"?>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <document type="freeswitch/xml">
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <section name="directory" description="User Directory">
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <domain name="192.168.0.51"><user id="09861010610344" mailbox="">
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <params>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <param name="vm-password" value="098610106"/>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <param name="password" value="098610106"/>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] </params>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <variables>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <variable name="accountcode" value="098610106"/>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <variable name="user_context" value="default"/>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] </variables>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] </user>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] </domain>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] </section>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] </document>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] 
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Connected to Freeswitch(TM) Database!
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] DBI:mysql:database=fscdr;host=127.0.0.1
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Connected to CDR Database!
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] hostname astpp-vm
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] section dialplan
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] tag_name 
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] key_name 
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] key_value 
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Event-Name REQUEST_PARAMS
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Core-UUID 5fdff5b2-5a34-11e2-8537-c99be87bf994
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] FreeSWITCH-Hostname astpp-vm
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] FreeSWITCH-Switchname astpp-vm
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] FreeSWITCH-IPv4 192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] FreeSWITCH-IPv6 ::1
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Event-Date-Local 2013-01-09 15:35:50
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Event-Date-GMT Wed, 09 Jan 2013 08:35:50 GMT
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Event-Date-Timestamp 1357720550200713
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Event-Calling-File mod_dialplan_xml.c
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Event-Calling-Function dialplan_xml_locate
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Event-Calling-Line-Number 528
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Event-Sequence 764
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Channel-State CS_ROUTING
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Channel-Call-State RINGING
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Channel-State-Number 2
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Channel-Name sofia/internal/0986101...@192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Unique-ID 922f2abc-5a37-11e2-857b-c99be87bf994
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Call-Direction inbound
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Presence-Call-Direction inbound
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Channel-HIT-Dialplan true
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Channel-Presence-ID 0986101...@192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Channel-Call-UUID 922f2abc-5a37-11e2-857b-c99be87bf994
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Answer-State ringing
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Direction inbound
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Username 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Dialplan XML
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Caller-ID-Name 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Caller-ID-Number 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Network-Addr 192.168.0.87
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-ANI 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Destination-Number 85589610106
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Unique-ID 922f2abc-5a37-11e2-857b-c99be87bf994
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Source mod_sofia
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Context default
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Channel-Name sofia/internal/0986101...@192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Profile-Index 1
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Profile-Created-Time 1357720550195953
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Channel-Created-Time 1357720550195953
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Channel-Answered-Time 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Channel-Progress-Time 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Channel-Progress-Media-Time 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Channel-Hangup-Time 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Channel-Transfer-Time 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Channel-Resurrect-Time 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Channel-Bridged-Time 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Channel-Last-Hold 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Channel-Hold-Accum 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Screen-Bit true
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Privacy-Hide-Name false
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Privacy-Hide-Number false
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_direction inbound
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_uuid 922f2abc-5a37-11e2-857b-c99be87bf994
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_session_id 5
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_from_user 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_from_uri 0986101...@192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_from_host 192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_channel_name sofia/internal/0986101...@192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_call_id 68eea9420caa61e0...@192.168.0.87
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_local_network_addr 192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_network_ip 192.168.0.87
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_network_port 5060
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_received_ip 192.168.0.87
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_received_port 5060
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_via_protocol udp
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_authorized true
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_number_alias 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_auth_username 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_auth_realm 192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_number_alias 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_user_name 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_domain_name 192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_accountcode 098610106
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_user_context default
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_from_user_stripped 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_from_tag 5c055e60
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sofia_profile_name internal
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_recovery_profile_name internal
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_full_via SIP/2.0/UDP 192.168.0.87:5060;rport=5060;branch=z9hG4bKbbbc230bfb
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_from_display 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_full_from "09861010610344" <sip:0986101...@192.168.0.51>;tag=5c055e60
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_full_to <sip:85589...@192.168.0.51>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_req_user 85589610106
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_req_uri 85589...@192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_req_host 192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_to_user 85589610106
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_to_uri 85589...@192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_to_host 192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_contact_user 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_contact_port 5060
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_contact_uri 0986101...@192.168.0.87:5060
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_contact_host 192.168.0.87
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_user_agent CM5K-PHONE  (908260)
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_via_host 192.168.0.87
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_via_port 5060
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_via_rport 5060
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_max_forwards 70
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_presence_id 0986101...@192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_switch_r_sdp v=0\r
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] o=CMI-SIPUA 27234 0 IN IP4 192.168.0.87\r
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] s=SIP CALL\r
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] c=IN IP4 192.168.0.87\r
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] t=0 0\r
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] m=audio 20000 RTP/AVP 18 101\r
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] a=fmtp:18 annexb=no\r
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] a=rtpmap:101 telephone-event/8000\r
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] a=fmtp:101 0-15\r
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] a=rtcp:20001\r
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] 
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_ep_codec_string G729@8000h@20i@8000b
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_endpoint_disposition DELAYED NEGOTIATION
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_call_uuid 922f2abc-5a37-11e2-857b-c99be87bf994
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Direction inbound
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Username 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Dialplan XML
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Caller-ID-Name 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Caller-ID-Number 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Network-Addr 192.168.0.87
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-ANI 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Destination-Number 85589610106
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Unique-ID 922f2abc-5a37-11e2-857b-c99be87bf994
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Source mod_sofia
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Context default
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Channel-Name sofia/internal/0986101...@192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Profile-Index 1
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Profile-Created-Time 1357720550195953
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Channel-Created-Time 1357720550195953
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Channel-Answered-Time 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Channel-Progress-Time 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Channel-Progress-Media-Time 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Channel-Hangup-Time 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Channel-Transfer-Time 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Channel-Resurrect-Time 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Channel-Bridged-Time 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Channel-Last-Hold 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Channel-Hold-Accum 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Screen-Bit true
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Privacy-Hide-Name false
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Privacy-Hide-Number false
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Destination = 85589610106
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] 098610106, 85589610106
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] FINDING LIMIT FOR: 098610106
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] SELECT * FROM pricelists WHERE name = 'test'
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Pricelist: test 
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] SELECT * FROM routes WHERE '85589610106' RLIKE pattern AND status = 1 AND pricelist = 'test' ORDER BY LENGTH(pattern) DESC
 LIMIT 1
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] pattern: ^855.*
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Route: Ezecom Outbound Cost: 0.02000 Pricelist: test Pattern: ^855.*
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Found pattern: ^855.*
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Account Balance: -50.448229
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Credit Limit: 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Credit: 50.448229
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Pricelist: test 
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] SELECT * FROM routes WHERE '85589610106' RLIKE pattern AND status = 1 AND pricelist = 'test' ORDER BY LENGTH(pattern) DESC
 LIMIT 1
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] pattern: ^855.*
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Route: Ezecom Outbound Cost: 0.02000 Pricelist: test Pattern: ^855.*
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Cost: 0.02000
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Pricelist: test
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] CALLSTATUS: 1 MAX_LENGTH: 504.48229
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] PRINTING LIST OF RESELLERS FOR THIS ACCOUNT
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Looking for Route
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Pricelist: test 
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] SELECT * FROM routes WHERE '85589610106' RLIKE pattern AND status = 1 AND pricelist = 'test' ORDER BY LENGTH(pattern) DESC
 LIMIT 1
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] pattern: ^855.*
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Route: Ezecom Outbound Cost: 0.02000 Pricelist: test Pattern: ^855.*
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] WE DID NOT RECEIVE A LIST OF RESELLERS TO CHECK AGAINST.
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Ezecom: cost 0.02000\t ^855.*
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Grab: 855
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Replacement: 177855
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Phone Before: 85589610106
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Phone After: 17785589610106
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Content-Type: text/plain; charset=ISO-8859-1\r
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] \r
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <?xml version="1.0" encoding="UTF-8" standalone="no"?>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <document type="freeswitch/xml">
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <section name="dialplan" description="ASTPP Dynamic Routing">
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <context name="default">
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <extension name="85589610106">
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <condition field="destination_number" expression="85589610106">
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <action application="set" data="effective_destination_number=85589610106"/>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <action application="sched_hangup" data="+86400"/>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <action application="set" data="accountcode=098610106"/>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <action application="set" data="hangup_after_bridge=true"/>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <action application="set" data="continue_on_fail=true"/>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <action application="set" data="calltype=STANDARD"/>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <action application="set" data="outbound_route=1"/>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <action application="set" data="trunk=Ezecom"/>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <action application="set" data="provider=1111111"/>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <action application="bridge" data="sofia/gateway/ezecom-out/17785589610106"/>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] </condition>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] </extension>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] </context>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] </section>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] </document>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] 
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Connected to Freeswitch(TM) Database!
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] DBI:mysql:database=fscdr;host=127.0.0.1
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Connected to CDR Database!
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] cdr <?xml version="1.0"?>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] <cdr core-uuid="5fdff5b2-5a34-11e2-8537-c99be87bf994">
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]   <channel_data>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <state>CS_REPORTING</state>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <direction>outbound</direction>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <state_number>11</state_number>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <flags>0=1;2=1;27=1;37=1;39=1;72=1</flags>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <caps>1=1;2=1;3=1;4=1;5=1;6=1</caps>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]   </channel_data>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]   <variables>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <direction>outbound</direction>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <is_outbound>true</is_outbound>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <uuid>92b38898-5a37-11e2-858c-c99be87bf994</uuid>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <session_id>6</session_id>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <sip_gateway_name>ezecom-out</sip_gateway_name>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <sip_profile_name>gateway</sip_profile_name>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <channel_name>sofia/external/17785589610106</channel_name>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <sip_destination_url>sip%3A17785589610106%40119.82.248.16</sip_destination_url>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <absolute_codec_string>G729%408000h%4020i%408000b</absolute_codec_string>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <max_forwards>69</max_forwards>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <originator_codec>G729%408000h%4020i%408000b</originator_codec>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <originator>922f2abc-5a37-11e2-857b-c99be87bf994</originator>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <signal_bond>922f2abc-5a37-11e2-857b-c99be87bf994</signal_bond>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <switch_m_sdp>v%3D0%0D%0Ao%3DCMI-SIPUA%2027234%200%20IN%20IP4%20192.168.0.87%0D%0As%3DSIP%20CALL%0D%0Ac%3DIN%20IP4%201
92.168.0.87%0D%0At%3D0%200%0D%0Am%3Daudio%2020000%20RTP/AVP%2018%20101%0D%0Aa%3Dfmtp%3A18%20annexb%3Dno%0D%0Aa%3Drtpmap%3A101%20telephone-event/8000%0D%0Aa%3Dfmtp%3A101%200-15%
0D%0Aa%3Drtcp%3A20001%0D%0A</switch_m_sdp>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <call_uuid>922f2abc-5a37-11e2-857b-c99be87bf994</call_uuid>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <originate_early_media>true</originate_early_media>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <originating_leg_uuid>922f2abc-5a37-11e2-857b-c99be87bf994</originating_leg_uuid>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <local_media_ip>192.168.0.51</local_media_ip>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <local_media_port>19884</local_media_port>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <advertised_media_ip>192.168.0.51</advertised_media_ip>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <sip_local_sdp_str>v%3D0%0Ao%3DFreeSWITCH%201357700666%201357700667%20IN%20IP4%20192.168.0.51%0As%3DFreeSWITCH%0Ac%3DI
N%20IP4%20192.168.0.51%0At%3D0%200%0Am%3Daudio%2019884%20RTP/AVP%2018%20101%2013%0Aa%3Dfmtp%3A18%20annexb%3Dno%0Aa%3Drtpmap%3A101%20telephone-event/8000%0Aa%3Dfmtp%3A101%200-16
%0Aa%3Dptime%3A20%0Aa%3Dsendrecv%0A</sip_local_sdp_str>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <sip_outgoing_contact_uri>%3Csip%3Agw%2Bezecom-out%40192.168.0.51%3A5080%3Btransport%3Dudp%3Bgw%3Dezecom-out%3E</sip_o
utgoing_contact_uri>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <sip_req_uri>17785589610106%40119.82.248.16</sip_req_uri>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <sip_to_host>119.82.248.16</sip_to_host>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <sip_from_host>192.168.0.51</sip_from_host>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <sofia_profile_name>external</sofia_profile_name>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <recovery_profile_name>external</recovery_profile_name>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <sip_call_id>6a11fed9-d4da-1230-93bd-000c29c2bb32</sip_call_id>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <sip_hangup_disposition>recv_refuse</sip_hangup_disposition>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <sip_local_network_addr>192.168.0.51</sip_local_network_addr>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <sip_reply_host>119.82.248.16</sip_reply_host>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <sip_reply_port>5060</sip_reply_port>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <sip_network_ip>119.82.248.16</sip_network_ip>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <sip_network_port>5060</sip_network_port>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <sip_term_status>403</sip_term_status>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <proto_specific_hangup_cause>sip%3A403</proto_specific_hangup_cause>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <sip_term_cause>21</sip_term_cause>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <hangup_cause>CALL_REJECTED</hangup_cause>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <hangup_cause_q850>21</hangup_cause_q850>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <digits_dialed>none</digits_dialed>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <start_stamp>2013-01-09%2015%3A35%3A50</start_stamp>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <profile_start_stamp>2013-01-09%2015%3A35%3A50</profile_start_stamp>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <end_stamp>2013-01-09%2015%3A35%3A50</end_stamp>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <start_epoch>1357720550</start_epoch>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <start_uepoch>1357720550542875</start_uepoch>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <profile_start_epoch>1357720550</profile_start_epoch>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <profile_start_uepoch>1357720550542875</profile_start_uepoch>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <answer_epoch>0</answer_epoch>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <answer_uepoch>0</answer_uepoch>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <bridge_epoch>0</bridge_epoch>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <bridge_uepoch>0</bridge_uepoch>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <last_hold_epoch>0</last_hold_epoch>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <last_hold_uepoch>0</last_hold_uepoch>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <hold_accum_seconds>0</hold_accum_seconds>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <hold_accum_usec>0</hold_accum_usec>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <hold_accum_ms>0</hold_accum_ms>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <resurrect_epoch>0</resurrect_epoch>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <resurrect_uepoch>0</resurrect_uepoch>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <progress_epoch>0</progress_epoch>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <progress_uepoch>0</progre
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] ss_uepoch>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <progress_media_epoch>0</progress_media_epoch>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <progress_media_uepoch>0</progress_media_uepoch>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <end_epoch>1357720550</end_epoch>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <end_uepoch>1357720550542875</end_uepoch>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <caller_id>%2209861010610344%22%20%3C09861010610344%3E</caller_id>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <duration>0</duration>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <billsec>0</billsec>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <progresssec>0</progresssec>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <answersec>0</answersec>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <waitsec>0</waitsec>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <progress_mediasec>0</progress_mediasec>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <flow_billsec>0</flow_billsec>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <mduration>0</mduration>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <billmsec>0</billmsec>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <progressmsec>0</progressmsec>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <answermsec>0</answermsec>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <waitmsec>0</waitmsec>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <progress_mediamsec>0</progress_mediamsec>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <flow_billmsec>0</flow_billmsec>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <uduration>0</uduration>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <billusec>0</billusec>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <progressusec>0</progressusec>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <answerusec>0</answerusec>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <waitusec>0</waitusec>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <progress_mediausec>0</progress_mediausec>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <flow_billusec>0</flow_billusec>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]   </variables>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]   <callflow dialplan="XML" unique-id="92b38bae-5a37-11e2-858d-c99be87bf994" clone-of="92b386ae-5a37-11e2-858b-c99be87bf994
" profile_index="1">
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <caller_profile>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <username>09861010610344</username>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <dialplan>XML</dialplan>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <caller_id_name>09861010610344</caller_id_name>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <caller_id_number>09861010610344</caller_id_number>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <callee_id_name>Outbound Call</callee_id_name>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <callee_id_number>17785589610106</callee_id_number>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <ani>09861010610344</ani>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <aniii></aniii>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <network_addr>119.82.248.16</network_addr>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <rdnis></rdnis>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <destination_number>17785589610106</destination_number>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <uuid>92b38898-5a37-11e2-858c-c99be87bf994</uuid>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <source>mod_sofia</source>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <context>default</context>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <chan_name>sofia/external/17785589610106</chan_name>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <originator>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]         <originator_caller_profile>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]           <username>09861010610344</username>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]           <dialplan>XML</dialplan>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]           <caller_id_name>09861010610344</caller_id_name>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]           <caller_id_number>09861010610344</caller_id_number>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]           <callee_id_name></callee_id_name>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]           <callee_id_number></callee_id_number>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]           <ani>09861010610344</ani>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]           <aniii></aniii>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]           <network_addr>192.168.0.87</network_addr>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]           <rdnis></rdnis>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]           <destination_number>85589610106</destination_number>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]           <uuid>922f2abc-5a37-11e2-857b-c99be87bf994</uuid>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]           <source>mod_sofia</source>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]           <context>default</context>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]           <chan_name>sofia/internal/0986101...@192.168.0.51</chan_name>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]         </originator_caller_profile>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       </originator>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     </caller_profile>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     <times>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <created_time>1357720550542875</created_time>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <profile_created_time>1357720550542875</profile_created_time>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <progress_time>0</progress_time>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <progress_media_time>0</progress_media_time>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <answered_time>0</answered_time>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <bridged_time>0</bridged_time>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <last_hold_time>0</last_hold_time>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <hold_accum_time>0</hold_accum_time>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <hangup_time>1357720550542875</hangup_time>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <resurrect_time>0</resurrect_time>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]       <transfer_time>0</transfer_time>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]     </times>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]   </callflow>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] </cdr>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] 
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Call hangup and CDR Generating
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] $VAR1 = {
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]           'channel_data' => {
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                             'direction' => 'outbound',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                             'state_number' => '11',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                             'flags' => '0=1;2=1;27=1;37=1;39=1;72=1',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                             'caps' => '1=1;2=1;3=1;4=1;5=1;6=1',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                             'state' => 'CS_REPORTING'
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                           },
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]           'variables' => {
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'absolute_codec_string' => 'G729%408000h%4020i%408000b',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'last_hold_uepoch' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'profile_start_stamp' => '2013-01-09%2015%3A35%3A50',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'sip_network_port' => '5060',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'start_epoch' => '1357720550',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'mduration' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'sip_local_network_addr' => '192.168.0.51',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'sip_profile_name' => 'gateway',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'last_hold_epoch' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'answer_uepoch' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'local_media_port' => '19884',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'sip_to_host' => '119.82.248.16',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'hangup_cause_q850' => '21',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'progress_uepoch' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'sip_destination_url' => 'sip%3A17785589610106%40119.82.248.16',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'waitmsec' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'sip_term_status' => '403',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'progress_mediasec' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'sip_gateway_name' => 'ezecom-out',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'signal_bond' => '922f2abc-5a37-11e2-857b-c99be87bf994',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'answermsec' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'progress_media_epoch' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'is_outbound' => 'true',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'progress_epoch' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'profile_start_epoch' => '1357720550',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'resurrect_uepoch' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'uduration' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'recovery_profile_name' => 'external',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'billsec' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'sip_term_cause' => '21',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'sip_from_host' => '192.168.0.51',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'sip_local_sdp_str' => 'v%3D0%0Ao%3DFreeSWITCH%201357700666%201357700667%20IN%20IP4%20192.168.0.5
1%0As%3DFreeSWITCH%0Ac%3DIN%20IP4%20192.168.0.51%0At%3D0%200%0Am%3Daudio%2019884%20RTP/AVP%2018%20101%2013%0Aa%3Dfmtp%3A18%20annexb%3Dno%0Aa%3Drtpmap%3A101%20telephone-event/80
00%0Aa%3Dfmtp%3A101%200-16%0Aa%3Dptime%3A20%0Aa%3Dsendrecv%0A',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'bridge_epoch' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'progress_mediausec' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'session_id' => '6',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'bridge_uepoch' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'waitsec' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'end_uepoch' => '1357720550542875',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'start_stamp' => '2013-01-09%2015%3A35%3A50',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'call_uuid' => '922f2abc-5a37-11e2-857b-c99be87bf994',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'sofia_profile_name' => 'external',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'direction' => 'outbound',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'progressusec' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'advertised_media_ip' => '192.168.0.51',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'originator_codec' => 'G729%408000h%4020i%408000b',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'sip_outgoing_contact_uri' => '%3Csip%3Agw%2Bezecom-out%40192.168.0.51%3A5080%3Btransport%3Dudp%3
Bgw%3Dezecom-out%3E',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'end_stamp' => '2013-01-09%2015%3A35%3A50',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'answersec' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'end_epoch' => '1357720550',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'switch_m_sdp' => 'v%3D0%0D%0Ao%3DCMI-SIPUA%2027234%200%20IN%20IP4%20192.168.0.87%0D%0As%3DSIP%20
CALL%0D%0Ac%3DIN%20IP4%20192.168.0.87%0D%0At%3D0%200%0D%0Am%3Daudio%2020000%20RTP/AVP%2018%20101%0D%0Aa%3Dfmtp%3A18%20annexb%3Dno%0D%0Aa%3Drtpmap%3A101%20telephone-event/8000%0
D%0Aa%3Dfmtp%3A101%200-15%0D%0Aa%3Drtcp%3A20001%0D%0A',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'max_forwards' => '69',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'hold_accum_ms' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'sip_reply_port' 
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] => '5060',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'progress_mediamsec' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'progressmsec' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'flow_billsec' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'uuid' => '92b38898-5a37-11e2-858c-c99be87bf994',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'originate_early_media' => 'true',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'sip_network_ip' => '119.82.248.16',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'digits_dialed' => 'none',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'proto_specific_hangup_cause' => 'sip%3A403',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'resurrect_epoch' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'progress_media_uepoch' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'sip_hangup_disposition' => 'recv_refuse',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'sip_req_uri' => '17785589610106%40119.82.248.16',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'originator' => '922f2abc-5a37-11e2-857b-c99be87bf994',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'local_media_ip' => '192.168.0.51',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'channel_name' => 'sofia/external/17785589610106',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'duration' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'answer_epoch' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'answerusec' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'waitusec' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'billmsec' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'sip_reply_host' => '119.82.248.16',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'billusec' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'hold_accum_seconds' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'profile_start_uepoch' => '1357720550542875',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'flow_billusec' => '0',
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'progresssec' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'originating_leg_uuid' => '922f2abc-5a37-11e2-857b-c99be87bf994',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'caller_id' => '%2209861010610344%22%20%3C09861010610344%3E',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'start_uepoch' => '1357720550542875',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'hangup_cause' => 'CALL_REJECTED',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'flow_billmsec' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_call_id' => '6a11fed9-d4da-1230-93bd-000c29c2bb32',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'hold_accum_usec' => '0'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                        },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]           'callflow' => {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                         'dialplan' => 'XML',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                         'clone-of' => '92b386ae-5a37-11e2-858b-c99be87bf994',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                         'profile_index' => '1',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                         'caller_profile' => {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'source' => 'mod_sofia',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'callee_id_name' => 'Outbound Call',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'caller_id_name' => '09861010610344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'caller_id_number' => '09861010610344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'originator' => {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                             'originator_caller_profile' => {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                            'source' => 'mod_sofia',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                            'callee_id_name' => {},
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                            'caller_id_name' => '0986101061
0344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                            'caller_id_number' => '09861010
610344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                            'aniii' => {},
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                            'uuid' => '922f2abc-5a37-11e2-8
57b-c99be87bf994',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                            'callee_id_number' => {},
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                            'username' => '09861010610344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                            'network_addr' => '192.168.0.87
',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                            'ani' => '09861010610344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                            'dialplan' => 'XML',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                      
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                       'context' => 'default',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                            'destination_number' => '855896
10106',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                            'rdnis' => {},
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                            'chan_name' => 'sofia/internal/
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                          }
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                           },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'aniii' => {},
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'uuid' => '92b38898-5a37-11e2-858c-c99be87bf994',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'callee_id_number' => '17785589610106',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'username' => '09861010610344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'network_addr' => '119.82.248.16',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'ani' => '09861010610344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'dialplan' => 'XML',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'context' => 'default',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'destination_number' => '17785589610106',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'rdnis' => {},
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'chan_name' => 'sofia/external/17785589610106'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                         'times' => {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                    'answered_time' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                    'hangup_time' => '1357720550542875',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                    'created_time' => '1357720550542875',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                    'progress_media_time' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                    'progress_time' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                    'last_hold_time' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                    'transfer_time' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                    'resurrect_time' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                    'profile_created_time' => '1357720550542875',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                    'bridged_time' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                    'hold_accum_time' => '0'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                  },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                         'unique-id' => '92b38bae-5a37-11e2-858d-c99be87bf994'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                       },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]           'core-uuid' => '5fdff5b2-5a34-11e2-8537-c99be87bf994'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]         };
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] 
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] INSERT INTO fscdr(accountcode,src,dst,dcontext,clid,channel,dstchannel,lastapp,lastdata,calldate,answerdate,enddate,durati
on,billsec,disposition,amaflags,uniqueid,originator,userfield,read_codec,write_codec,cost,vendor,provider,trunk,outbound_route,progressmsec,answermsec,progress_mediamsec) VALUE
S ('','09861010610344','','default','"09861010610344" <09861010610344>','sofia/external/17785589610106','','','','2013-01-09 15:35:50','','2013-01-09 15:35:50','0','0','CALL_RE
JECTED','','92b38898-5a37-11e2-858c-c99be87bf994','922f2abc-5a37-11e2-857b-c99be87bf994','','','','none','none','','','','0','0','0')
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] Processing Uniqueid: 92b38898-5a37-11e2-858c-c99be87bf994
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] ----------------------
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] ERROR - ERROR - ERROR - ERROR - ERROR 
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] NO ACCOUNTCODE IN DATABASE
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] uniqueid: 92b38898-5a37-11e2-858c-c99be87bf994, cardno: , phoneno: 
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] disposition: CALL_REJECTED
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] ----------------------
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] Vendor Rating Starting/n
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] Vendor Rating Uniqueid: 92b38898-5a37-11e2-858c-c99be87bf994
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] SELECT * FROM fscdr WHERE uniqueid = '92b38898-5a37-11e2-858c-c99be87bf994'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] SELECT * FROM outbound_routes WHERE id = ''
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] UPDATE fscdr SET vendor = 'error' WHERE uniqueid = '92b38898-5a37-11e2-858c-c99be87bf994' AND dst = '' LIMIT 1
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] VENDOR CHARGES: 1
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] Vendor Rating Uniqueid: 92b38898-5a37-11e2-858c-c99be87bf994
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] SELECT * FROM fscdr WHERE uniqueid = '92b38898-5a37-11e2-858c-c99be87bf994'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] SELECT * FROM outbound_routes WHERE id = ''
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] UPDATE fscdr SET vendor = 'error' WHERE uniqueid = '92b38898-5a37-11e2-858c-c99be87bf994' AND dst = '' LIMIT 1
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] Connected to Freeswitch(TM) Database!
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] DBI:mysql:database=fscdr;host=127.0.0.1
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] Connected to CDR Database!
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] cdr <?xml version="1.0"?>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] <cdr core-uuid="5fdff5b2-5a34-11e2-8537-c99be87bf994">
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]   <channel_data>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <state>CS_REPORTING</state>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <direction>inbound</direction>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <state_number>11</state_number>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <flags>0=1;37=1;39=1;72=1</flags>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <caps>1=1;2=1;3=1;4=1;5=1;6=1</caps>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]   </channel_data>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]   <variables>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <direction>inbound</direction>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <uuid>922f2abc-5a37-11e2-857b-c99be87bf994</uuid>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <session_id>5</session_id>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_from_user>09861010610344</sip_from_user>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_from_uri>09861010610344%40192.168.0.51</sip_from_uri>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_from_host>192.168.0.51</sip_from_host>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <channel_name>sofia/internal/09861010610344%40192.168.0.51</channel_name>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_call_id>68eea9420caa61e005ffbf9f597d62cc%40192.168.0.87</sip_call_id>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_local_network_addr>192.168.0.51</sip_local_network_addr>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_network_ip>192.168.0.87</sip_network_ip>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_network_port>5060</sip_network_port>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_received_ip>192.168.0.87</sip_received_ip>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_received_port>5060</sip_received_port>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_via_protocol>udp</sip_via_protocol>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_authorized>true</sip_authorized>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_number_alias>09861010610344</sip_number_alias>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_auth_username>09861010610344</sip_auth_username>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_auth_realm>192.168.0.51</sip_auth_realm>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <number_alias>09861010610344</number_alias>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <user_name>09861010610344</user_name>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <domain_name>192.168.0.51</domain_name>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <user_context>default</user_context>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_from_user_stripped>09861010610344</sip_from_user_stripped>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_from_tag>5c055e60</sip_from_tag>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sofia_profile_name>internal</sofia_profile_name>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <recovery_profile_name>internal</recovery_profile_name>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_full_via>SIP/2.0/UDP%20192.168.0.87%3A5060%3Brport%3D5060%3Bbranch%3Dz9hG4bKbbbc230bfb</sip_full_via>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_from_display>09861010610344</sip_from_display>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_full_from>%2209861010610344%22%20%3Csip%3A09861010610344%40192.168.0.51%3E%3Btag%3D5c055e60</sip_full_from>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_full_to>%3Csip%3A85589610106%40192.168.0.51%3E</sip_full_to>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_req_user>85589610106</sip_req_user>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_req_uri>85589610106%40192.168.0.51</sip_req_uri>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_req_host>192.168.0.51</sip_req_host>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_to_user>85589610106</sip_to_user>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_to_uri>85589610106%40192.168.0.51</sip_to_uri>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_to_host>192.168.0.51</sip_to_host>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_contact_user>09861010610344</sip_contact_user>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_contact_port>5060</sip_contact_port>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_contact_uri>09861010610344%40192.168.0.87%3A5060</sip_contact_uri>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_contact_host>192.168.0.87</sip_contact_host>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_user_agent>CM5K-PHONE%20%20(908260)</sip_user_agent>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_via_host>192.168.0.87</sip_via_host>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_via_port>5060</sip_via_port>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_via_rport>5060</sip_via_rport>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <max_forwards>70</max_forwards>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <presence_id>09861010610344%40192.168.0.51</presence_id>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <switch_r_sdp>v%3D0%0D%0Ao%3DCMI-SIPUA%2027234%200%20IN%20IP4%20192.168.0.87%0D%0As%3DSIP%20CALL%0D%0Ac%3DIN%20IP4%201
92.168.0.87%0D%0At%3D0%200%0D%0Am%3Daudio%2020000%20RTP/AVP%2018%20101%0D%0Aa%3Dfmtp%3A18%20annexb%3Dno%0D%0Aa%3Drtpmap%3A101%20telephone-event/8000%0D%0Aa%3Dfmtp%3A101%200-15%
0D%0Aa%3Drtcp%3A20001%0D%0A</switch_r_sdp>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <ep_codec_string>G729%408000h%4020i%408000b</ep_codec_string>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <endpoint_disposition>DELAYED%20NEGOTIATION</endpoint_disposition>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <call_uuid>922f2abc-5a37-11e2-857b-c99be87bf994</call_uuid>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <effective_destination_number>85589610106</effective_destination_number>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <accountcode>098610106</accountcode>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <hangup_after_bridge>true</hangup_after_bridge>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <continue_on_fail>true</continue_on_fail>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <calltype>STANDARD</calltype>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <outbound_route>1</outbound_route>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <trunk>Ezecom</trunk>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <provider>1111111</provider>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <current_application_data>sofia/gateway/ezecom-out/17785589610106</current_application_data>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <current_application>bridge</current_application>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <inherit_codec>true</inherit_codec>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <originate_signal_bond>92b38898-5a37-11e2-858c-c99be87bf994</originate_signal_bond>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <originated_legs>92b38898-5a37-11e2-858c-c99be87bf994%3BOutbound%20Call%3B17785589610106</originated
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] _legs>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_hangup_phrase>Forbidden</sip_hangup_phrase>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <last_bridge_hangup_cause>CALL_REJECTED</last_bridge_hangup_cause>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <last_bridge_proto_specific_hangup_cause>sip%3A403</last_bridge_proto_specific_hangup_cause>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <originate_disposition>CALL_REJECTED</originate_disposition>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <DIALSTATUS>DONTCALL</DIALSTATUS>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <originate_causes>92b38898-5a37-11e2-858c-c99be87bf994%3BCALL_REJECTED</originate_causes>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <hangup_cause>NORMAL_CLEARING</hangup_cause>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <hangup_cause_q850>16</hangup_cause_q850>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <digits_dialed>none</digits_dialed>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <start_stamp>2013-01-09%2015%3A35%3A50</start_stamp>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <profile_start_stamp>2013-01-09%2015%3A35%3A50</profile_start_stamp>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <end_stamp>2013-01-09%2015%3A35%3A50</end_stamp>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <start_epoch>1357720550</start_epoch>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <start_uepoch>1357720550195953</start_uepoch>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <profile_start_epoch>1357720550</profile_start_epoch>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <profile_start_uepoch>1357720550195953</profile_start_uepoch>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <answer_epoch>0</answer_epoch>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <answer_uepoch>0</answer_uepoch>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <bridge_epoch>0</bridge_epoch>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <bridge_uepoch>0</bridge_uepoch>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <last_hold_epoch>0</last_hold_epoch>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <last_hold_uepoch>0</last_hold_uepoch>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <hold_accum_seconds>0</hold_accum_seconds>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <hold_accum_usec>0</hold_accum_usec>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <hold_accum_ms>0</hold_accum_ms>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <resurrect_epoch>0</resurrect_epoch>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <resurrect_uepoch>0</resurrect_uepoch>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <progress_epoch>0</progress_epoch>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <progress_uepoch>0</progress_uepoch>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <progress_media_epoch>0</progress_media_epoch>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <progress_media_uepoch>0</progress_media_uepoch>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <end_epoch>1357720550</end_epoch>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <end_uepoch>1357720550851189</end_uepoch>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <last_app>bridge</last_app>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <last_arg>sofia/gateway/ezecom-out/17785589610106</last_arg>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <caller_id>%2209861010610344%22%20%3C09861010610344%3E</caller_id>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <duration>0</duration>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <billsec>0</billsec>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <progresssec>0</progresssec>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <answersec>0</answersec>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <waitsec>0</waitsec>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <progress_mediasec>0</progress_mediasec>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <flow_billsec>0</flow_billsec>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <mduration>656</mduration>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <billmsec>0</billmsec>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <progressmsec>0</progressmsec>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <answermsec>0</answermsec>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <waitmsec>0</waitmsec>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <progress_mediamsec>0</progress_mediamsec>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <flow_billmsec>0</flow_billmsec>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <uduration>655236</uduration>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <billusec>0</billusec>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <progressusec>0</progressusec>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <answerusec>0</answerusec>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <waitusec>0</waitusec>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <progress_mediausec>0</progress_mediausec>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <flow_billusec>0</flow_billusec>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <sip_hangup_disposition>send_refuse</sip_hangup_disposition>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]   </variables>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]   <app_log>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <application app_name="set" app_data="effective_destination_number=85589610106" app_stamp="1357720550543954"></applica
tion>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <application app_name="sched_hangup" app_data="+86400" app_stamp="1357720550544234"></application>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <application app_name="set" app_data="accountcode=098610106" app_stamp="1357720550544883"></application>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <application app_name="set" app_data="hangup_after_bridge=true" app_stamp="1357720550545206"></application>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <application app_name="set" app_data="continue_on_fail=true" app_stamp="1357720550545564"></application>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <application app_name="set" app_data="calltype=STANDARD" app_stamp="1357720550545876"></application>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <application app_name="set" app_data="outbound_route=1" app_stamp="1357720550546185"></application>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <application app_name="set" app_data="trunk=Ezecom" app_stamp="1357720550546561"></application>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <application app_name="set" app_data="provider=1111111" app_stamp="1357720550546873"></application>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <application app_name="bridge" app_data="sofia/gateway/ezecom-out/17785589610106" app_stamp="1357720550547222"></appli
cation>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]   </app_log>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]   <callflow dialplan="XML" unique-id="927e95b6-5a37-11e2-857e-c99be87bf994" profile_index="1">
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <extension name="85589610106" number="85589610106">
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <application app_name="set" app_data="effective_destination_number=85589610106"></application>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <application app_name="sched_hangup" app_data="+86400"></application>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <application app_name="set" a
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] pp_data="accountcode=098610106"></application>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <application app_name="set" app_data="hangup_after_bridge=true"></application>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <application app_name="set" app_data="continue_on_fail=true"></application>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <application app_name="set" app_data="calltype=STANDARD"></application>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <application app_name="set" app_data="outbound_route=1"></application>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <application app_name="set" app_data="trunk=Ezecom"></application>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <application app_name="set" app_data="provider=1111111"></application>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <application app_name="bridge" app_data="sofia/gateway/ezecom-out/17785589610106"></application>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     </extension>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <caller_profile>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <username>09861010610344</username>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <dialplan>XML</dialplan>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <caller_id_name>09861010610344</caller_id_name>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <caller_id_number>09861010610344</caller_id_number>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <callee_id_name></callee_id_name>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <callee_id_number></callee_id_number>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <ani>09861010610344</ani>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <aniii></aniii>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <network_addr>192.168.0.87</network_addr>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <rdnis></rdnis>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <destination_number>85589610106</destination_number>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <uuid>922f2abc-5a37-11e2-857b-c99be87bf994</uuid>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <source>mod_sofia</source>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <context>default</context>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <chan_name>sofia/internal/0986101...@192.168.0.51</chan_name>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <origination>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]         <origination_caller_profile>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]           <username>09861010610344</username>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]           <dialplan>XML</dialplan>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]           <caller_id_name>09861010610344</caller_id_name>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]           <caller_id_number>09861010610344</caller_id_number>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]           <callee_id_name>Outbound Call</callee_id_name>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]           <callee_id_number>17785589610106</callee_id_number>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]           <ani>09861010610344</ani>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]           <aniii></aniii>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]           <network_addr>192.168.0.87</network_addr>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]           <rdnis></rdnis>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]           <destination_number>17785589610106</destination_number>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]           <uuid>92b38898-5a37-11e2-858c-c99be87bf994</uuid>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]           <source>mod_sofia</source>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]           <context>default</context>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]           <chan_name>sofia/external/17785589610106</chan_name>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]         </origination_caller_profile>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       </origination>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     </caller_profile>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     <times>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <created_time>1357720550195953</created_time>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <profile_created_time>1357720550195953</profile_created_time>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <progress_time>0</progress_time>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <progress_media_time>0</progress_media_time>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <answered_time>0</answered_time>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <bridged_time>0</bridged_time>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <last_hold_time>0</last_hold_time>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <hold_accum_time>0</hold_accum_time>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <hangup_time>1357720550851189</hangup_time>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <resurrect_time>0</resurrect_time>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]       <transfer_time>0</transfer_time>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]     </times>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]   </callflow>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] </cdr>
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] 
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] Call hangup and CDR Generating
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] $VAR1 = {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]           'channel_data' => {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                             'direction' => 'inbound',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                             'state_number' => '11',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                             'flags' => '0=1;37=1;39=1;72=1',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                             'caps' => '1=1;2=1;3=1;4=1;5=1;6=1',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                             'state' => 'CS_REPORTING'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                           },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]           'variables' => {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'provider' => '1111111',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'last_hold_uepoch' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'profile_start_stamp' => '2013-01-09%2015%3A35%3A50',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_network_port' => '5060',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'start_epoch' => '1357720550',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'number_alias' => '09861010610344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'mduration' => '656',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_full_from' => '%2209861010610344%22%20%3Csip%3A09861010610344%40192.168.0.51%3E%3Btag%3D5c05
5e60',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_local_network_addr' => '192.168.0.51',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_contact_host' => '192.168.0.87',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_to_user' => '85589610106',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'last_hold_epoch' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_via_port' => '5060',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'answer_uepoch' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_contact_port' => '5060',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_to_host' => '192.168.0.51',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'hangup_cause_q850' => '16',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'user_context' => 'default',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'progress_uepoch' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'waitmsec' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'progress_mediasec' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'answermsec' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'progress_media_epoch' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'progress_epoch' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'profile_start_epoch' => '1357720550',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'resurrect_uepoch' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'originated_legs' => '92b38898-5a37-11e2-858c-c99be87bf994%3BOutbound%20Call%3B17785589610106',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_full_to' => '%3Csip%3A85589610106%40192.168.0.51%3E',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'uduration' => '655236',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'recovery_profile_name' => 'internal',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'billsec' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_from_host' => '192.168.0.51',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'bridge_epoch' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'progress_mediausec' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'session_id' => '5',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'bridge_uepoch' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_from_user_stripped' => '09861010610344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'waitsec' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'last_bridge_hangup_cause' => 'CALL_REJECTED',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'end_uepoch' => '1357720550851189',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'start_stamp' => '2013-01-09%2015%3A35%3A50',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'call_uuid' => '922f2abc-5a37-11e2-857b-c99be87bf994',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sofia_profile_name' => 'internal',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'inherit_codec' => 'true',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'direction' => 'inbound',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_from_display' => '09861010610344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'progressusec' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_number_alias' => '09861010610344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_received_ip' => '192.168.0.87',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'end_stamp' => '2013-01-09%2015%3A35%3A50',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'answersec' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'current_application' => 'bridge',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'end_epoch' => '1357720550',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'max_forwards' => '70',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'hold_accum_ms' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'switch_r_sdp' => 'v%3D0%0D%0Ao%3DCMI-SIPUA%2027234%200%20IN%20IP4%20192.168.0.87%0D%0As%3DSIP%20
CALL%0D%0Ac%3DIN%20IP4%20192.168.0.87%0D%0At%3D0%200%0D%0Am%3Daudio%2020000%20RTP/AVP%2018%20101%0D%0Aa%3Dfmtp%3A18%20annexb%3Dno%0D%0Aa%3Drtpmap%3A101%20telephone-event/8000%0
D%0Aa%3Dfmtp%3A101%200-15%0D%0Aa%3Drtcp%3A20001%0D%0A',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_hangup_phrase' => 'Forbidden',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_from_user' => '0
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] 9861010610344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_via_host' => '192.168.0.87',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'progress_mediamsec' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'progressmsec' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'flow_billsec' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'uuid' => '922f2abc-5a37-11e2-857b-c99be87bf994',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'digits_dialed' => 'none',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_network_ip' => '192.168.0.87',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'progress_media_uepoch' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'resurrect_epoch' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_via_rport' => '5060',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'presence_id' => '09861010610344%40192.168.0.51',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_hangup_disposition' => 'send_refuse',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_authorized' => 'true',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_req_uri' => '85589610106%40192.168.0.51',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'outbound_route' => '1',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'channel_name' => 'sofia/internal/09861010610344%40192.168.0.51',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'duration' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'answer_epoch' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_req_host' => '192.168.0.51',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'user_name' => '09861010610344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_full_via' => 'SIP/2.0/UDP%20192.168.0.87%3A5060%3Brport%3D5060%3Bbranch%3Dz9hG4bKbbbc230bfb'
,
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'originate_disposition' => 'CALL_REJECTED',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'endpoint_disposition' => 'DELAYED%20NEGOTIATION',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_received_port' => '5060',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'answerusec' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'waitusec' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_req_user' => '85589610106',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'billmsec' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'billusec' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'last_bridge_proto_specific_hangup_cause' => 'sip%3A403',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'current_application_data' => 'sofia/gateway/ezecom-out/17785589610106',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'accountcode' => '098610106',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_contact_uri' => '09861010610344%40192.168.0.87%3A5060',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'hold_accum_seconds' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'last_arg' => 'sofia/gateway/ezecom-out/17785589610106',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'profile_start_uepoch' => '1357720550195953',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'flow_billusec' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_user_agent' => 'CM5K-PHONE%20%20(908260)',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_to_uri' => '85589610106%40192.168.0.51',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'DIALSTATUS' => 'DONTCALL',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'ep_codec_string' => 'G729%408000h%4020i%408000b',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_contact_user' => '09861010610344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'progresssec' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'trunk' => 'Ezecom',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'hangup_after_bridge' => 'true',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_from_tag' => '5c055e60',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_auth_username' => '09861010610344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_from_uri' => '09861010610344%40192.168.0.51',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'originate_causes' => '92b38898-5a37-11e2-858c-c99be87bf994%3BCALL_REJECTED',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'caller_id' => '%2209861010610344%22%20%3C09861010610344%3E',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'start_uepoch' => '1357720550195953',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'domain_name' => '192.168.0.51',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'originate_signal_bond' => '92b38898-5a37-11e2-858c-c99be87bf994',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_auth_realm' => '192.168.0.51',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'last_app' => 'bridge',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'hangup_cause' => 'NORMAL_CLEARING',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'calltype' => 'STANDARD',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'flow_billmsec' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_call_id' => '68eea9420caa61e005ffbf9f597d62cc%40192.168.0.87',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'continue_on_fail' => 'true',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'sip_via_protocol' => 'udp',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'hold_accum_usec' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                          'effective_destination_number' => '85589610106'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                        },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]           'callflow' => {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                         'ex
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] tension' => {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                        'number' => '85589610106',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                        'application' => [
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                         {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                           'app_name' => 'set',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                           'app_data' => 'effective_destination_number=85589610106'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                         },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                         {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                           'app_name' => 'sched_hangup',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                           'app_data' => '+86400'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                         },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                         {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                           'app_name' => 'set',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                           'app_data' => 'accountcode=098610106'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                         },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                         {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                           'app_name' => 'set',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                           'app_data' => 'hangup_after_bridge=true'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                         },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                         {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                           'app_name' => 'set',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                           'app_data' => 'continue_on_fail=true'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                         },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                         {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                           'app_name' => 'set',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                           'app_data' => 'calltype=STANDARD'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                         },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                         {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                           'app_name' => 'set',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                           'app_data' => 'outbound_route=1'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                         },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                         {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                           'app_name' => 'set',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                           'app_data' => 'trunk=Ezecom'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                         },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                         {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                           'app_name' => 'set',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                           'app_data' => 'provider=1111111'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                         },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                         {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                           'app_name' => 'bridge',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                           'app_data' => 'sofia/gateway/ezecom-out/17785589610106'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                         }
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                       ],
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                        'name' => '85589610106'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                      },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                         'dialplan' => 'XML',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                         'profile_index' => '1',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                         'caller_profile' => {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'source' => 'mod_sofia',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'caller_id_name' => '09861010610344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'aniii' => {},
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'origination' => {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                              'origination_caller_profile' => {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                              'source' => 'mod_sofia',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                              'callee_id_name' => 'Outbound
 Call',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                              'caller_id_name' 
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] => '09861010610344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                              'caller_id_number' => '098610
10610344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                              'aniii' => {},
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                              'uuid' => '92b38898-5a37-11e2
-858c-c99be87bf994',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                              'callee_id_number' => '177855
89610106',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                              'username' => '09861010610344
',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                              'network_addr' => '192.168.0.
87',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                              'ani' => '09861010610344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                              'dialplan' => 'XML',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                              'context' => 'default',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                              'destination_number' => '1778
5589610106',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                              'rdnis' => {},
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                              'chan_name' => 'sofia/externa
l/17785589610106'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                                                            }
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                                            },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'uuid' => '922f2abc-5a37-11e2-857b-c99be87bf994',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'callee_id_number' => {},
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'dialplan' => 'XML',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'context' => 'default',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'destination_number' => '85589610106',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'chan_name' => 'sofia/internal/0986101...@192.168.0.51',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'callee_id_name' => {},
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'caller_id_number' => '09861010610344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'username' => '09861010610344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'network_addr' => '192.168.0.87',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'ani' => '09861010610344',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                             'rdnis' => {}
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                         'times' => {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                    'answered_time' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                    'hangup_time' => '1357720550851189',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                    'created_time' => '1357720550195953',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                    'progress_media_time' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                    'progress_time' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                    'last_hold_time' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                    'transfer_time' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                    'resurrect_time' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                    'profile_created_time' => '1357720550195953',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                    'bridged_time' => '0',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                    'hold_accum_time' => '0'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                  },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                         'unique-id' => '927e95b6-5a37-11e2-857e-c99be87bf994'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                       },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]           'app_log' => {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                        'application' => [
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                         {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_name' => 'set',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_stamp' => '1357720550543954',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_data' => 'effective_destination_number=85589610106'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                         },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                         {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_name' => 'sched_hangup',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_stamp' => '1357720
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] 550544234',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_data' => '+86400'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                         },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                         {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_name' => 'set',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_stamp' => '1357720550544883',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_data' => 'accountcode=098610106'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                         },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                         {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_name' => 'set',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_stamp' => '1357720550545206',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_data' => 'hangup_after_bridge=true'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                         },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                         {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_name' => 'set',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_stamp' => '1357720550545564',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_data' => 'continue_on_fail=true'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                         },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                         {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_name' => 'set',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_stamp' => '1357720550545876',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_data' => 'calltype=STANDARD'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                         },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                         {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_name' => 'set',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_stamp' => '1357720550546185',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_data' => 'outbound_route=1'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                         },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                         {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_name' => 'set',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_stamp' => '1357720550546561',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_data' => 'trunk=Ezecom'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                         },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                         {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_name' => 'set',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_stamp' => '1357720550546873',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_data' => 'provider=1111111'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                         },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                         {
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_name' => 'bridge',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_stamp' => '1357720550547222',
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                           'app_data' => 'sofia/gateway/ezecom-out/17785589610106'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                         }
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                                       ]
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]                      },
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]           'core-uuid' => '5fdff5b2-5a34-11e2-8537-c99be87bf994'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]         };
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] 
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] INSERT INTO fscdr(accountcode,src,dst,dcontext,clid,channel,dstchannel,lastapp,lastdata,calldate,answerdate,enddate,durati
on,billsec,disposition,amaflags,uniqueid,originator,userfield,read_codec,write_codec,cost,vendor,provider,trunk,outbound_route,progressmsec,answermsec,progress_mediamsec) VALUE
S ('098610106','09861010610344','85589610106','default','"09861010610344" <09861010610344>','sofia/internal/0986101...@192.168.0.51','','bridge','sofia/gateway/ezecom-out/1
7785589610106','2013-01-09 15:35:50','','2013-01-09 15:35:50','0','0','NORMAL_CLEARING','','922f2abc-5a37-11e2-857b-c99be87bf994','','STANDARD','','','none','none','1111111','E
zecom','1','0','0','0')
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] Processing Uniqueid: 922f2abc-5a37-11e2-857b-c99be87bf994
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] UPDATE fscdr SET vendor = '0' WHERE uniqueid = '922f2abc-5a37-11e2-857b-c99be87bf994' AND dst = '85589610106' LIMIT 1
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] 
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] ----------------------
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] CDR Written - No Billable Seconds
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] uniqueid 922f2abc-5a37-11e2-857b-c99be87bf994, cardno 098610106, phoneno 85589610106
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] disposition NORMAL_CLEARING
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] ----------------------
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] Vendor Rating Starting/n
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] Vendor Rating Uniqueid: 922f2abc-5a37-11e2-857b-c99be87bf994
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] SELECT * FROM fscdr WHERE uniqueid = '922f2abc-5a37-11e2-857b-c99be87bf994'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] SELECT * FROM outbound_routes WHERE id = '1'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] Connect: 0.00000 Cost: 0.02000 Answered: 0 
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]  Inc:  included: 0 
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] NO CHARGE - ANSWEREDTIME = 0
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] INSERT INTO cdrs(uniqueid,cardnum,callerid,callednum,trunk,disposition,billseconds,debit,callstart,status,notes,pricelist,
pattern,calltype,provider) VALUES ('922f2abc-5a37-11e2-857b-c99be87bf994', '1111111', '09861010610344', '85589610106', 'Ezecom', 'NORMAL_CLEARING', '0', '0', '2013-01-09 15:35:
50', '0', 'Ezecom Gateway','N/A','^855.*','STANDARD','1111111')
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] UPDATE fscdr SET vendor = '0.0000' WHERE uniqueid = '922f2abc-5a37-11e2-857b-c99be87bf994' AND dst = '85589610106' LIMIT 1
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] UPDATE cdrs SET cost = '0.0000' WHERE uniqueid = '922f2abc-5a37-11e2-857b-c99be87bf994' AND cost = 0  AND cardnum != '1111
111' AND callednum = '85589610106' LIMIT 1
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] VENDOR CHARGES: 1
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] Vendor Rating Uniqueid: 922f2abc-5a37-11e2-857b-c99be87bf994
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] SELECT * FROM fscdr WHERE uniqueid = '922f2abc-5a37-11e2-857b-c99be87bf994'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] SELECT * FROM outbound_routes WHERE id = '1'
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] Connect: 0.00000 Cost: 0.02000 Answered: 0 
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1]  Inc:  included: 0 
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] NO CHARGE - ANSWEREDTIME = 0
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] INSERT INTO cdrs(uniqueid,cardnum,callerid,callednum,trunk,disposition,billseconds,debit,callstart,status,notes,pricelist,
pattern,calltype,provider) VALUES ('922f2abc-5a37-11e2-857b-c99be87bf994', '1111111', '09861010610344', '85589610106', 'Ezecom', 'NORMAL_CLEARING', '0', '0', '2013-01-09 15:35:
50', '0', 'Ezecom Gateway','N/A','^855.*','STANDARD','1111111')
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] UPDATE fscdr SET vendor = '0.0000' WHERE uniqueid = '922f2abc-5a37-11e2-857b-c99be87bf994' AND dst = '85589610106' LIMIT 1
[Wed Jan 09 15:35:51 2013] [error] [client 127.0.0.1] UPDATE cdrs SET cost = '0.0000' WHERE uniqueid = '922f2abc-5a37-11e2-857b-c99be87bf994' AND cost = 0  AND cardnum != '1111
111' AND callednum = '85589610106' LIMIT 1
[Wed Jan 09 15:36:06 2013] [error] [client 127.0.0.1] Connected to Freeswitch(TM) Database!


Thanks,
Chandy
> <sip:09861...@192.168.0.51>;tag=31377814
> [Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1]
> variable_sip_to_display 1185589610106
> [Tue Jan 08 15:40:20 2013] [error] [client 127.0.0.1]
> variable_sip_full_to "1185589610106" <sip:1185...@192.168.0.51>
> <chan_name>sofia/internal/098610106...@192.168.0.51</chan_name>
> 'sofia/internal/09861010610344@192.168.0.51'
> [Tue Jan 08 15:40:21 2013] [error] [client 12...<br><a href="https://groups.google.com/group/astpp/msg/f161a355ba6ed062?dmode=source&output=gplain&noredirect">Show original</a>

channdy keo

unread,
Jan 9, 2013, 9:17:26 PM1/9/13
to as...@googlegroups.com, channdy keo, sa...@astpp.org
Dear Samir,

Is there any update regarding to this issue?
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Channel-Name sofia/internal/09861010610344@192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Unique-ID 922f2abc-5a37-11e2-857b-c99be87bf994
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Call-Direction inbound
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Presence-Call-Direction inbound
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Channel-HIT-Dialplan true
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Channel-Presence-ID 0986101...@192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Channel-Call-UUID 922f2abc-5a37-11e2-857b-c99be87bf994
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Answer-State ringing
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Direction inbound
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Username 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Dialplan XML
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Caller-ID-Name 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Caller-ID-Number 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Network-Addr 192.168.0.87
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-ANI 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Destination-Number 85589610106
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Unique-ID 922f2abc-5a37-11e2-857b-c99be87bf994
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Source mod_sofia
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Context default
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Channel-Name sofia/internal/09861010610344@192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Profile-Index 1
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Profile-Created-Time 1357720550195953
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Channel-Created-Time 1357720550195953
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Channel-Answered-Time 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Channel-Progress-Time 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Channel-Progress-Media-Time 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Channel-Hangup-Time 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Channel-Transfer-Time 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Channel-Resurrect-Time 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Channel-Bridged-Time 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Channel-Last-Hold 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Channel-Hold-Accum 0
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Screen-Bit true
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Privacy-Hide-Name false
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Caller-Privacy-Hide-Number false
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_direction inbound
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_uuid 922f2abc-5a37-11e2-857b-c99be87bf994
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_session_id 5
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_from_user 09861010610344
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_from_uri 0986101...@192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_from_host 192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_channel_name sofia/internal/09861010610344@192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] variable_sip_call_id 68eea9420caa61e005ffbf9f597d62c...@192.168.0.87
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1] Hunt-Channel-Name sofia/internal/09861010610344@192.168.0.51
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]           <chan_name>sofia/internal/098610106...@192.168.0.51</chan_name>
[Wed Jan 09 15:35:50 2013] [error] [client 127.0.0.1]                          'last_hold_uepoch' =...
Show original
Reply all
Reply to author
Forward
0 new messages