Please put this into pastebin.freeswitch.org using FreeSWITCH Log as the syntax highlighting. Then reply to this thread with the pastebin URL.

-MC


On Mon, Jul 1, 2013 at 5:40 PM, Lloyd Aloysius <lloyd.aloysius@gmail.com> wrote:
fs_cli log


2013-07-01 20:37:32.446979 [INFO] mod_dialplan_xml.c:558 Processing Barbara Ladner <barbara>->4164790606 in context alcan.mydomain.ca
Dialplan: sofia/sipinterface_1/barbara@alcan.mydomain.ca parsing [alcan.mydomain.ca->outbound_dialplan.] continue=false
Dialplan: sofia/sipinterface_1/barbara@alcan.mydomain.ca Regex (PASS) [outbound_dialplan.] destination_number(4164790606) =~ /^(4164790606)$/ break=on-false
Dialplan: sofia/sipinterface_1/barbara@alcan.mydomain.ca Action lua(/usr/local/hostedsip/luascripts/outbound_dialplan.lua)
2013-07-01 20:37:32.457029 [DEBUG] switch_core_state_machine.c:167 (sofia/sipinterface_1/barbara@alcan.mydomain.ca) State Change CS_ROUTING -> CS_EXECUTE
2013-07-01 20:37:32.457029 [DEBUG] switch_core_session.c:1341 Send signal sofia/sipinterface_1/barbara@alcan.mydomain.ca [BREAK]
2013-07-01 20:37:32.457029 [DEBUG] switch_core_state_machine.c:471 (sofia/sipinterface_1/barbara@alcan.mydomain.ca) State ROUTING going to sleep
2013-07-01 20:37:32.457029 [DEBUG] switch_core_state_machine.c:416 (sofia/sipinterface_1/barbara@alcan.mydomain.ca) Running State Change CS_EXECUTE
2013-07-01 20:37:32.457029 [DEBUG] switch_core_state_machine.c:478 (sofia/sipinterface_1/barbara@alcan.mydomain.ca) State EXECUTE
2013-07-01 20:37:32.457029 [DEBUG] mod_sofia.c:230 sofia/sipinterface_1/barbara@alcan.mydomain.ca SOFIA EXECUTE
2013-07-01 20:37:32.457029 [DEBUG] switch_core_state_machine.c:209 sofia/sipinterface_1/barbara@alcan.mydomain.ca Standard EXECUTE
EXECUTE sofia/sipinterface_1/barbara@alcan.mydomain.ca lua(/usr/local/hostedsip/luascripts/outbound_dialplan.lua)
2013-07-01 20:37:32.468008 [INFO] switch_cpp.cpp:651 Sending early media
2013-07-01 20:37:32.468008 [DEBUG] switch_core_media.c:3982 AUDIO RTP [sofia/sipinterface_1/barbara@alcan.mydomain.ca] A.B.C.D port 24402 -> 192.168.240.105 port 3000 codec: 0 ms: 20
2013-07-01 20:37:32.468008 [DEBUG] switch_rtp.c:2767 Starting timer [soft] 160 bytes per 20ms
2013-07-01 20:37:32.468008 [DEBUG] switch_core_media.c:4313 Set 2833 dtmf send payload to 101
2013-07-01 20:37:32.468008 [DEBUG] switch_core_media.c:4319 Set 2833 dtmf receive payload to 101
2013-07-01 20:37:32.468008 [DEBUG] mod_sofia.c:2105 Ring SDP:
v=0
o=FreeSWITCH 1372701050 1372701051 IN IP4 A.B.C.D
s=FreeSWITCH
c=IN IP4 A.B.C.D
t=0 0
m=audio 24402 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv

2013-07-01 20:37:32.468008 [NOTICE] mod_sofia.c:2108 Pre-Answer sofia/sipinterface_1/barbara@alcan.mydomain.ca!
2013-07-01 20:37:32.468008 [DEBUG] switch_channel.c:3316 (sofia/sipinterface_1/barbara@alcan.mydomain.ca) Callstate Change RINGING -> EARLY
2013-07-01 20:37:32.468008 [DEBUG] switch_core_session.c:861 Send signal sofia/sipinterface_1/barbara@alcan.mydomain.ca [BREAK]
2013-07-01 20:37:32.468008 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/barbara@alcan.mydomain.ca [BREAK]
2013-07-01 20:37:32.476978 [DEBUG] sofia.c:5764 Channel sofia/sipinterface_1/barbara@alcan.mydomain.ca entering state [early][183]
2013-07-01 20:37:32.476978 [DEBUG] mod_sofia.c:822 Local SDP sofia/sipinterface_1/barbara@alcan.mydomain.ca:
v=0
o=FreeSWITCH 1372701050 1372701052 IN IP4 A.B.C.D
s=FreeSWITCH
c=IN IP4 A.B.C.D
t=0 0
m=audio 24402 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv

2013-07-01 20:37:32.476978 [DEBUG] switch_core_session.c:861 Send signal sofia/sipinterface_1/barbara@alcan.mydomain.ca [BREAK]
2013-07-01 20:37:32.476978 [NOTICE] switch_cpp.cpp:633 Channel [sofia/sipinterface_1/barbara@alcan.mydomain.ca] has been answered
2013-07-01 20:37:32.476978 [DEBUG] switch_channel.c:3595 (sofia/sipinterface_1/barbara@alcan.mydomain.ca) Callstate Change EARLY -> ACTIVE
2013-07-01 20:37:32.476978 [INFO] switch_cpp.cpp:1287 [outbound_dialplan] domain_name: alcan.mydomain.ca
2013-07-01 20:37:32.476978 [INFO] switch_cpp.cpp:1287 [outbound_dialplan] context: alcan.mydomain.ca
2013-07-01 20:37:32.476978 [INFO] switch_cpp.cpp:1287 [outbound_dialplan] destination number: 4164790606
2013-07-01 20:37:32.476978 [INFO] switch_cpp.cpp:1287 [outbound_dialplan] sip_from_uri: barbara@alcan.mydomain.ca
2013-07-01 20:37:32.476978 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/barbara@alcan.mydomain.ca [BREAK]
2013-07-01 20:37:32.476978 [DEBUG] freeswitch_lua.cpp:352 DBH handle 0x7fdcb8197170 Connected.
EXECUTE sofia/sipinterface_1/barbara@alcan.mydomain.ca export(nolocal:domain_name=alcan.mydomain.ca)
2013-07-01 20:37:32.476978 [DEBUG] sofia.c:5764 Channel sofia/sipinterface_1/barbara@alcan.mydomain.ca entering state [completed][200]
2013-07-01 20:37:32.476978 [DEBUG] switch_channel.c:1222 EXPORT (export_vars) (REMOTE ONLY) [domain_name]=[alcan.mydomain.ca]
EXECUTE sofia/sipinterface_1/barbara@alcan.mydomain.ca export(nolocal:sip_from_uri=barbara@alcan.mydomain.ca)
2013-07-01 20:37:32.476978 [DEBUG] switch_channel.c:1222 EXPORT (export_vars) (REMOTE ONLY) [sip_from_uri]=[barbara@alcan.mydomain.ca]
EXECUTE sofia/sipinterface_1/barbara@alcan.mydomain.ca export(nolocal:execute_on_answer=lua /usr/local/hostedsip/luascripts/call_recording.lua)
2013-07-01 20:37:32.476978 [DEBUG] switch_channel.c:1222 EXPORT (export_vars) (REMOTE ONLY) [execute_on_answer]=[lua /usr/local/hostedsip/luascripts/call_recording.lua]
2013-07-01 20:37:32.476978 [INFO] switch_cpp.cpp:1287 [outbound_dialplan] begin bridge the destianation number
2013-07-01 20:37:32.476978 [INFO] switch_cpp.cpp:1287 [outbound_dialplan] user_query: select pstn_callerid,caller_id_name,caller_id_number,block_caller_id_status from user where sip_address='barbara@alcan.mydomain.ca'
2013-07-01 20:37:32.486975 [INFO] switch_cpp.cpp:1287 [outbound_dialplan] outbound call originate from a USER
2013-07-01 20:37:32.486975 [INFO] switch_cpp.cpp:1287 [outbound_dialplan] pstn_callerid: USE_PHONE_SETTINGS
2013-07-01 20:37:32.486975 [INFO] switch_cpp.cpp:1287 [outbound_dialplan] caller_id_name:
2013-07-01 20:37:32.486975 [INFO] switch_cpp.cpp:1287 [outbound_dialplan] caller_id_number:
2013-07-01 20:37:32.486975 [INFO] switch_cpp.cpp:1287 [outbound_dialplan] block_caller_id_status: false
2013-07-01 20:37:32.486975 [INFO] switch_cpp.cpp:1287 [outbound_dialplan] local_stream_conf_id1
2013-07-01 20:37:32.486975 [INFO] switch_cpp.cpp:1287 [outbound_dialplan] hold_music: local_stream://default
EXECUTE sofia/sipinterface_1/barbara@alcan.mydomain.ca set(hold_music=local_stream://default)
2013-07-01 20:37:32.486975 [DEBUG] mod_dptools.c:1373 sofia/sipinterface_1/barbara@alcan.mydomain.ca SET [hold_music]=[local_stream://default]
2013-07-01 20:37:32.486975 [INFO] switch_cpp.cpp:1287 [outbound_dialplan] customer_query : select caller_id_name,caller_id_number from customer where domain='alcan.mydomain.ca'
2013-07-01 20:37:32.486975 [INFO] switch_cpp.cpp:1287 [outbound_dialplan] caller_id_name: Alcan Cable
2013-07-01 20:37:32.486975 [INFO] switch_cpp.cpp:1287 [outbound_dialplan] caller_id_number: 9052066900
2013-07-01 20:37:32.486975 [INFO] switch_cpp.cpp:1287 [outbound_dialplan] outbound_caller_id_name & outbound_caller_id_number
2013-07-01 20:37:32.486975 [INFO] switch_cpp.cpp:1287 [outbound_dialplan] outbound_caller_id_name: Alcan Cable
2013-07-01 20:37:32.486975 [INFO] switch_cpp.cpp:1287 [outbound_dialplan] outbound_caller_id_number: 9052066900
EXECUTE sofia/sipinterface_1/barbara@alcan.mydomain.ca set(effective_caller_id_name=Alcan Cable)
2013-07-01 20:37:32.486975 [DEBUG] mod_dptools.c:1373 sofia/sipinterface_1/barbara@alcan.mydomain.ca SET [effective_caller_id_name]=[Alcan Cable]
EXECUTE sofia/sipinterface_1/barbara@alcan.mydomain.ca set(effective_caller_id_number=9052066900)
2013-07-01 20:37:32.486975 [DEBUG] mod_dptools.c:1373 sofia/sipinterface_1/barbara@alcan.mydomain.ca SET [effective_caller_id_number]=[9052066900]
2013-07-01 20:37:32.486975 [INFO] switch_cpp.cpp:1287 [gateway_routing.lua] domain_name: alcan.mydomain.ca
2013-07-01 20:37:32.486975 [INFO] switch_cpp.cpp:1287 [gateway_routing.lua] context: alcan.mydomain.ca
2013-07-01 20:37:32.486975 [INFO] switch_cpp.cpp:1287 [gateway_routing.lua] Outbound Maximum Calls Reached: db alcan.mydomain.ca call_count 5 outbound.max.calls@alcan.mydomain.ca XML alcan.mydomain.ca
2013-07-01 20:37:32.486975 [INFO] switch_limit.c:126 incr called: alcan.mydomain.ca_call_count max:5, interval:0
2013-07-01 20:37:32.486975 [INFO] mod_db.c:193 Usage for alcan.mydomain.ca_call_count is now 1/5
2013-07-01 20:37:32.536989 [INFO] switch_cpp.cpp:1287 [gateway_routing.lua] destination_number: 141
2013-07-01 20:37:32.536989 [INFO] switch_cpp.cpp:1287 [gateway_routing.lua] gateway_1: utel
2013-07-01 20:37:32.536989 [INFO] switch_cpp.cpp:1287 [gateway_routing.lua] gateway_2: voipms
2013-07-01 20:37:32.536989 [INFO] switch_cpp.cpp:1287 [gateway_routing.lua] gateway_3: flowroute
2013-07-01 20:37:32.536989 [INFO] switch_cpp.cpp:1287 [gateway_routing.lua] destination_number: 14164790606
2013-07-01 20:37:32.536989 [INFO] switch_cpp.cpp:1287 [gateway_routing.lua] progress_timeout: 10
2013-07-01 20:37:32.536989 [INFO] switch_cpp.cpp:1287 [gateway_routing.lua] gateway1: utel
2013-07-01 20:37:32.536989 [INFO] switch_cpp.cpp:1287 [gateway_routing.lua] gateway2: voipms
2013-07-01 20:37:32.536989 [INFO] switch_cpp.cpp:1287 [gateway_routing.lua] gateway3: flowroute
EXECUTE sofia/sipinterface_1/barbara@alcan.mydomain.ca set(hangup_after_bridge=true)
2013-07-01 20:37:32.536989 [DEBUG] mod_dptools.c:1373 sofia/sipinterface_1/barbara@alcan.mydomain.ca SET [hangup_after_bridge]=[true]
EXECUTE sofia/sipinterface_1/barbara@alcan.mydomain.ca set(continue_on_fail=true)
2013-07-01 20:37:32.536989 [DEBUG] mod_dptools.c:1373 sofia/sipinterface_1/barbara@alcan.mydomain.ca SET [continue_on_fail]=[true]
EXECUTE sofia/sipinterface_1/barbara@alcan.mydomain.ca set(pstn_direction=PSTN_OUTBOUND)
2013-07-01 20:37:32.536989 [DEBUG] mod_dptools.c:1373 sofia/sipinterface_1/barbara@alcan.mydomain.ca SET [pstn_direction]=[PSTN_OUTBOUND]
EXECUTE sofia/sipinterface_1/barbara@alcan.mydomain.ca export(pstn_direction=PSTN_OUTBOUND)
2013-07-01 20:37:32.536989 [DEBUG] switch_channel.c:1222 EXPORT (export_vars) [pstn_direction]=[PSTN_OUTBOUND]
EXECUTE sofia/sipinterface_1/barbara@alcan.mydomain.ca export(nolocal:route_destination_number=14164790606)
2013-07-01 20:37:32.536989 [DEBUG] switch_channel.c:1222 EXPORT (export_vars) (REMOTE ONLY) [route_destination_number]=[14164790606]
EXECUTE sofia/sipinterface_1/barbara@alcan.mydomain.ca export(nolocal:route_prefix=1416)
2013-07-01 20:37:32.536989 [DEBUG] switch_channel.c:1222 EXPORT (export_vars) (REMOTE ONLY) [route_prefix]=[1416]
EXECUTE sofia/sipinterface_1/barbara@alcan.mydomain.ca set(progress_timeout=10)
2013-07-01 20:37:32.536989 [DEBUG] mod_dptools.c:1373 sofia/sipinterface_1/barbara@alcan.mydomain.ca SET [progress_timeout]=[10]
EXECUTE sofia/sipinterface_1/barbara@alcan.mydomain.ca bridge_export(nolocal:gateway=utel)
2013-07-01 20:37:32.536989 [DEBUG] switch_channel.c:1222 EXPORT (bridge_export_vars) (REMOTE ONLY) [gateway]=[utel]
EXECUTE sofia/sipinterface_1/barbara@alcan.mydomain.ca bridge({sip_cid_type=none}sofia/gateway/utel/14164790606)
2013-07-01 20:37:32.536989 [DEBUG] switch_channel.c:1176 sofia/sipinterface_1/barbara@alcan.mydomain.ca EXPORTING[export_vars] [domain_name]=[alcan.mydomain.ca] to event
2013-07-01 20:37:32.536989 [DEBUG] switch_channel.c:1176 sofia/sipinterface_1/barbara@alcan.mydomain.ca EXPORTING[export_vars] [sip_from_uri]=[barbara@alcan.mydomain.ca] to event
2013-07-01 20:37:32.536989 [DEBUG] switch_channel.c:1176 sofia/sipinterface_1/barbara@alcan.mydomain.ca EXPORTING[export_vars] [execute_on_answer]=[lua /usr/local/hostedsip/luascripts/call_recording.lua] to event
2013-07-01 20:37:32.536989 [DEBUG] switch_channel.c:1176 sofia/sipinterface_1/barbara@alcan.mydomain.ca EXPORTING[export_vars] [pstn_direction]=[PSTN_OUTBOUND] to event
2013-07-01 20:37:32.536989 [DEBUG] switch_channel.c:1176 sofia/sipinterface_1/barbara@alcan.mydomain.ca EXPORTING[export_vars] [route_destination_number]=[14164790606] to event
2013-07-01 20:37:32.536989 [DEBUG] switch_channel.c:1176 sofia/sipinterface_1/barbara@alcan.mydomain.ca EXPORTING[export_vars] [route_prefix]=[1416] to event
2013-07-01 20:37:32.536989 [DEBUG] switch_ivr_originate.c:2050 Parsing global variables
2013-07-01 20:37:32.536989 [DEBUG] switch_event.c:1617 Parsing variable [sip_cid_type]=[none]
2013-07-01 20:37:32.536989 [NOTICE] switch_channel.c:1030 New Channel sofia/sipinterface_2/14164790606 [9584d698-e2af-11e2-bd35-8118757a60c5]
2013-07-01 20:37:32.536989 [DEBUG] mod_sofia.c:4420 (sofia/sipinterface_2/14164790606) State Change CS_NEW -> CS_INIT
2013-07-01 20:37:32.536989 [DEBUG] switch_core_session.c:1341 Send signal sofia/sipinterface_2/14164790606 [BREAK]
2013-07-01 20:37:32.536989 [DEBUG] switch_core_state_machine.c:416 (sofia/sipinterface_2/14164790606) Running State Change CS_INIT
2013-07-01 20:37:32.536989 [DEBUG] switch_core_state_machine.c:455 (sofia/sipinterface_2/14164790606) State INIT
2013-07-01 20:37:32.536989 [DEBUG] mod_sofia.c:87 sofia/sipinterface_2/14164790606 SOFIA INIT
2013-07-01 20:37:32.536989 [DEBUG] sofia_glue.c:1220 Local SDP:
v=0
o=FreeSWITCH 1372703258 1372703259 IN IP4 A.B.C.D
s=FreeSWITCH
c=IN IP4 A.B.C.D
t=0 0
m=audio 22194 RTP/AVP 0 8 3 101 13
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv

2013-07-01 20:37:32.536989 [DEBUG] mod_sofia.c:114 (sofia/sipinterface_2/14164790606) State Change CS_INIT -> CS_ROUTING
2013-07-01 20:37:32.536989 [DEBUG] switch_core_session.c:1341 Send signal sofia/sipinterface_2/14164790606 [BREAK]
2013-07-01 20:37:32.536989 [DEBUG] switch_core_state_machine.c:455 (sofia/sipinterface_2/14164790606) State INIT going to sleep
2013-07-01 20:37:32.536989 [DEBUG] switch_core_state_machine.c:416 (sofia/sipinterface_2/14164790606) Running State Change CS_ROUTING
2013-07-01 20:37:32.536989 [DEBUG] switch_core_state_machine.c:471 (sofia/sipinterface_2/14164790606) State ROUTING
2013-07-01 20:37:32.536989 [DEBUG] mod_sofia.c:137 sofia/sipinterface_2/14164790606 SOFIA ROUTING
2013-07-01 20:37:32.536989 [DEBUG] switch_ivr_originate.c:67 (sofia/sipinterface_2/14164790606) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2013-07-01 20:37:32.536989 [DEBUG] switch_core_session.c:1341 Send signal sofia/sipinterface_2/14164790606 [BREAK]
2013-07-01 20:37:32.536989 [DEBUG] switch_core_state_machine.c:471 (sofia/sipinterface_2/14164790606) State ROUTING going to sleep
2013-07-01 20:37:32.536989 [DEBUG] switch_core_state_machine.c:416 (sofia/sipinterface_2/14164790606) Running State Change CS_CONSUME_MEDIA
2013-07-01 20:37:32.536989 [DEBUG] switch_core_state_machine.c:490 (sofia/sipinterface_2/14164790606) State CONSUME_MEDIA
2013-07-01 20:37:32.536989 [DEBUG] switch_core_state_machine.c:490 (sofia/sipinterface_2/14164790606) State CONSUME_MEDIA going to sleep
2013-07-01 20:37:32.536989 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_2/14164790606 [BREAK]
2013-07-01 20:37:32.536989 [DEBUG] sofia.c:5764 Channel sofia/sipinterface_2/14164790606 entering state [calling][0]
2013-07-01 20:37:32.566973 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_2/14164790606 [BREAK]
2013-07-01 20:37:32.566973 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_2/14164790606 [BREAK]
2013-07-01 20:37:32.566973 [DEBUG] sofia.c:5764 Channel sofia/sipinterface_2/14164790606 entering state [calling][0]
2013-07-01 20:37:32.846981 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/barbara@alcan.mydomain.ca [BREAK]
2013-07-01 20:37:32.857157 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/barbara@alcan.mydomain.ca [BREAK]
2013-07-01 20:37:32.857157 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_1/barbara@alcan.mydomain.ca [BREAK]
2013-07-01 20:37:32.857157 [DEBUG] sofia.c:5764 Channel sofia/sipinterface_1/barbara@alcan.mydomain.ca entering state [ready][200]
2013-07-01 20:37:33.136982 [INFO] switch_rtp.c:4749 Auto Changing port from 192.168.240.105:3000 to 99.247.64.220:34605
2013-07-01 20:37:39.266976 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_2/14164790606 [BREAK]
2013-07-01 20:37:39.266976 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_2/14164790606 [BREAK]
2013-07-01 20:37:39.266976 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_2/14164790606 [BREAK]
2013-07-01 20:37:39.266976 [DEBUG] switch_core_session.c:1006 Send signal sofia/sipinterface_2/14164790606 [BREAK]
2013-07-01 20:37:39.266976 [DEBUG] sofia.c:5764 Channel sofia/sipinterface_2/14164790606 entering state [proceeding][180]
2013-07-01 20:37:39.266976 [NOTICE] sofia.c:5854 Ring-Ready sofia/sipinterface_2/14164790606!
2013-07-01 20:37:39.266976 [DEBUG] switch_channel.c:3180 (sofia/sipinterface_2/14164790606) Callstate Change DOWN -> RINGING



On Mon, Jul 1, 2013 at 8:18 PM, Avi Marcus <avi@avimarcus.net> wrote:
... but it's not in the siptrace at all...

Can we get more lines of the fs_cli log? From the setting of CID to the actual log?

-Avi

On Tue, Jul 2, 2013 at 3:10 AM, Moishe Grunstein <max@nysolutions.com> wrote:

What type of caller ID format is your ITSP expecting? Who is the ITSP?

http://wiki.freeswitch.org/wiki/Channel_Variables#Caller_ID_Related

 

 

 

Thanks,

 

Moishe Grunstein

Tornado Computer Systems, Inc.

212.400.7650 888.IPPBX.US
Service Request Email: support@nysolutions.com

Polycom Certified VAR
Microsoft Small Business Specialist, Cisco SMB Select Certified

cid:image001.jpg@01C72F94.9EE45D60

Computer Networking * Managed Services * IP Video Surveillance * Network Assessments * Web Solutions * Voice over IP * Disaster Recovery * Network Security * Site Surveys * CMS

 

From: freeswitch-users-bounces@lists.freeswitch.org [mailto:freeswitch-users-bounces@lists.freeswitch.org] On Behalf Of Lloyd Aloysius
Sent: Monday, July 01, 2013 7:39 PM
To: FreeSWITCH Users Help
Subject: spam>spam>[Freeswitch-users] effective_caller_id_name &effective_caller_id_number - not working

 

Hi All,

 

When sending calls out from gateway the caller id name and number not working. Please find the freeswitch cli log and sip invite trace. Any help is appreciated.

 

freeswitch cli

 

EXECUTE sofia/sipinterface_1/barbara@alcan.mydomain.ca set(effective_caller_id_name=Alcan Cable)

2013-07-01 19:23:21.676990 [DEBUG] mod_dptools.c:1373 sofia/sipinterface_1/barbara@alcan.mydomain.ca SET [effective_caller_id_name]=[Alcan Cable]

EXECUTE sofia/sipinterface_1/barbara@alcan.mydomain.ca set(effective_caller_id_number=9052066900)

2013-07-01 19:23:21.676990 [DEBUG] mod_dptools.c:1373 sofia/sipinterface_1/barbara@alcan.mydomain.ca SET [effective_caller_id_number]=[9052066900]

 

SIP Trace

 

 

 

Via: SIP/2.0/UDP 192.168.240.105:5060;branch=z9hG4bK17bfd0ad4

 

Max-Forwards: 70

 

Content-Length: 285

 

 

From: Barbara Ladner <sip:barbara@alcan.mydomain.ca>;tag=02f4abe9bef3a7f

 

 

CSeq: 1894816474 INVITE

 

Supported: timer

 

Allow-Events: talk,hold,conference

 

Allow:NOTIFY,REFER,OPTIONS,INVITE,ACK,CANCEL,BYE,INFO

 

Content-Type: application/sdp

 

 

Supported: replaces

 

User-Agent: Aastra 9133i/1.4.3.1001 Brcm Callctrl/1.5.1.0 MxSF/v3.2.8.45

 

 

 

v=0

 

o=MxSIP 0 575681134 IN IP4 192.168.240.105

 

s=SIP Call

 

c=IN IP4 192.168.240.105

 

t=0 0

 

m=audio 3000 RTP/AVP 0 8 18 101

 

a=rtpmap:0 PCMU/8000

 

a=rtpmap:8 PCMA/8000

 

a=rtpmap:18 G729/8000

 

a=rtpmap:101 telephone-event/8000

 

a=fmtp:101 0-15

 

a=ptime:20

 

a=silenceSupp:off - - - -

 

 

SIP/2.0 100 Trying

 

Via: SIP/2.0/UDP 192.168.240.105:5060;branch=z9hG4bK17bfd0ad4;received=99.247.64.220;rport=16511

 

From: Barbara Ladner <sip:barbara@alcan.mydomain.ca>;tag=02f4abe9bef3a7f

 

 

 

CSeq: 1894816474 INVITE

 

User-Agent: FreeSWITCH-mod_sofia/1.5.3b+git~20130628T160527Z~a52a604fbb

 

Content-Length: 0

 

 

Thanks

Lloyd


_________________________________________________________________________
Professional FreeSWITCH Consulting Services:
consulting@freeswitch.org
http://www.freeswitchsolutions.com

FreeSWITCH-powered IP PBX: The CudaTel Communication Server
http://www.cudatel.com

Official FreeSWITCH Sites
http://www.freeswitch.org
http://wiki.freeswitch.org
http://www.cluecon.com

FreeSWITCH-users mailing list
FreeSWITCH-users@lists.freeswitch.org
http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
http://www.freeswitch.org



_________________________________________________________________________
Professional FreeSWITCH Consulting Services:
consulting@freeswitch.org
http://www.freeswitchsolutions.com

FreeSWITCH-powered IP PBX: The CudaTel Communication Server
http://www.cudatel.com

Official FreeSWITCH Sites
http://www.freeswitch.org
http://wiki.freeswitch.org
http://www.cluecon.com

FreeSWITCH-users mailing list
FreeSWITCH-users@lists.freeswitch.org
http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
http://www.freeswitch.org



_________________________________________________________________________
Professional FreeSWITCH Consulting Services:
consulting@freeswitch.org
http://www.freeswitchsolutions.com

FreeSWITCH-powered IP PBX: The CudaTel Communication Server
http://www.cudatel.com

Official FreeSWITCH Sites
http://www.freeswitch.org
http://wiki.freeswitch.org
http://www.cluecon.com

FreeSWITCH-users mailing list
FreeSWITCH-users@lists.freeswitch.org
http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
http://www.freeswitch.org




--
Michael S Collins
Twitter: @mercutioviz
http://www.FreeSWITCH.org
http://www.ClueCon.com
http://www.OSTAG.org