[Freeswitch-users] effective_caller_id_name &effective_caller_id_number - not working
Lloyd Aloysius
lloyd.aloysius at gmail.com
Tue Jul 2 06:18:38 MSD 2013
Please have a look into the freeswitch log below.
http://pastebin.freeswitch.org/21140
Thanks
Lloyd
*
*
* <http://www.sunteltech.ca/blog/>*
On Mon, Jul 1, 2013 at 9:58 PM, Michael Collins <msc at freeswitch.org> wrote:
> 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 at 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 at alcan.mydomain.ca parsing
>> [alcan.mydomain.ca->outbound_dialplan.] continue=false
>> Dialplan: sofia/sipinterface_1/barbara at alcan.mydomain.ca Regex (PASS)
>> [outbound_dialplan.] destination_number(4164790606) =~ /^(4164790606)$/
>> break=on-false
>> Dialplan: sofia/sipinterface_1/barbara at 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 at 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 at alcan.mydomain.ca [BREAK]
>> 2013-07-01 20:37:32.457029 [DEBUG] switch_core_state_machine.c:471
>> (sofia/sipinterface_1/barbara at 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 at 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 at alcan.mydomain.ca) State EXECUTE
>> 2013-07-01 20:37:32.457029 [DEBUG] mod_sofia.c:230 sofia/sipinterface_1/
>> barbara at alcan.mydomain.ca SOFIA EXECUTE
>> 2013-07-01 20:37:32.457029 [DEBUG] switch_core_state_machine.c:209
>> sofia/sipinterface_1/barbara at alcan.mydomain.ca Standard EXECUTE
>> EXECUTE sofia/sipinterface_1/barbara at alcan.mydomain.calua(/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 at 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 at alcan.mydomain.ca!
>> 2013-07-01 20:37:32.468008 [DEBUG] switch_channel.c:3316
>> (sofia/sipinterface_1/barbara at 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 at alcan.mydomain.ca [BREAK]
>> 2013-07-01 20:37:32.468008 [DEBUG] switch_core_session.c:1006 Send signal
>> sofia/sipinterface_1/barbara at alcan.mydomain.ca [BREAK]
>> 2013-07-01 20:37:32.476978 [DEBUG] sofia.c:5764 Channel
>> sofia/sipinterface_1/barbara at 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 at 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 at alcan.mydomain.ca [BREAK]
>> 2013-07-01 20:37:32.476978 [NOTICE] switch_cpp.cpp:633 Channel
>> [sofia/sipinterface_1/barbara at alcan.mydomain.ca] has been answered
>> 2013-07-01 20:37:32.476978 [DEBUG] switch_channel.c:3595
>> (sofia/sipinterface_1/barbara at 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 at alcan.mydomain.ca
>> 2013-07-01 20:37:32.476978 [DEBUG] switch_core_session.c:1006 Send signal
>> sofia/sipinterface_1/barbara at 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 at alcan.mydomain.caexport(nolocal:domain_name=
>> alcan.mydomain.ca)
>> 2013-07-01 20:37:32.476978 [DEBUG] sofia.c:5764 Channel
>> sofia/sipinterface_1/barbara at 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 at alcan.mydomain.caexport(nolocal:sip_from_uri=
>> barbara at alcan.mydomain.ca)
>> 2013-07-01 20:37:32.476978 [DEBUG] switch_channel.c:1222 EXPORT
>> (export_vars) (REMOTE ONLY) [sip_from_uri]=[barbara at alcan.mydomain.ca]
>> EXECUTE sofia/sipinterface_1/barbara at alcan.mydomain.caexport(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 at 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 at alcan.mydomain.caset(hold_music=local_stream://default)
>> 2013-07-01 20:37:32.486975 [DEBUG] mod_dptools.c:1373
>> sofia/sipinterface_1/barbara at 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 at alcan.mydomain.caset(effective_caller_id_name=Alcan Cable)
>> 2013-07-01 20:37:32.486975 [DEBUG] mod_dptools.c:1373
>> sofia/sipinterface_1/barbara at alcan.mydomain.ca SET
>> [effective_caller_id_name]=[Alcan Cable]
>> EXECUTE sofia/sipinterface_1/barbara at alcan.mydomain.caset(effective_caller_id_number=
>> 9052066900)
>> 2013-07-01 20:37:32.486975 [DEBUG] mod_dptools.c:1373
>> sofia/sipinterface_1/barbara at 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 at alcan.mydomain.ca XML
>> alcan.mydomain.ca
>> EXECUTE sofia/sipinterface_1/barbara at alcan.mydomain.ca limit(db
>> alcan.mydomain.ca call_count 5 outbound.max.calls at 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 at alcan.mydomain.caset(hangup_after_bridge=true)
>> 2013-07-01 20:37:32.536989 [DEBUG] mod_dptools.c:1373
>> sofia/sipinterface_1/barbara at alcan.mydomain.ca SET
>> [hangup_after_bridge]=[true]
>> EXECUTE sofia/sipinterface_1/barbara at alcan.mydomain.caset(continue_on_fail=true)
>> 2013-07-01 20:37:32.536989 [DEBUG] mod_dptools.c:1373
>> sofia/sipinterface_1/barbara at alcan.mydomain.ca SET
>> [continue_on_fail]=[true]
>> EXECUTE sofia/sipinterface_1/barbara at alcan.mydomain.caset(pstn_direction=PSTN_OUTBOUND)
>> 2013-07-01 20:37:32.536989 [DEBUG] mod_dptools.c:1373
>> sofia/sipinterface_1/barbara at alcan.mydomain.ca SET
>> [pstn_direction]=[PSTN_OUTBOUND]
>> EXECUTE sofia/sipinterface_1/barbara at alcan.mydomain.caexport(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 at alcan.mydomain.caexport(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 at alcan.mydomain.caexport(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 at alcan.mydomain.caset(progress_timeout=10)
>> 2013-07-01 20:37:32.536989 [DEBUG] mod_dptools.c:1373
>> sofia/sipinterface_1/barbara at alcan.mydomain.ca SET
>> [progress_timeout]=[10]
>> EXECUTE sofia/sipinterface_1/barbara at alcan.mydomain.cabridge_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 at alcan.mydomain.cabridge({sip_cid_type=none}sofia/gateway/utel/
>> 14164790606)
>> 2013-07-01 20:37:32.536989 [DEBUG] switch_channel.c:1176
>> sofia/sipinterface_1/barbara at 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 at alcan.mydomain.ca EXPORTING[export_vars]
>> [sip_from_uri]=[barbara at alcan.mydomain.ca] to event
>> 2013-07-01 20:37:32.536989 [DEBUG] switch_channel.c:1176
>> sofia/sipinterface_1/barbara at 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 at 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 at 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 at 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 at alcan.mydomain.ca [BREAK]
>> 2013-07-01 20:37:32.857157 [DEBUG] switch_core_session.c:1006 Send signal
>> sofia/sipinterface_1/barbara at alcan.mydomain.ca [BREAK]
>> 2013-07-01 20:37:32.857157 [DEBUG] switch_core_session.c:1006 Send signal
>> sofia/sipinterface_1/barbara at alcan.mydomain.ca [BREAK]
>> 2013-07-01 20:37:32.857157 [DEBUG] sofia.c:5764 Channel
>> sofia/sipinterface_1/barbara at 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 at 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 at 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 at nysolutions.com *****
>>>>
>>>> Polycom Certified VAR
>>>> Microsoft Small Business Specialist, Cisco SMB Select Certified****
>>>>
>>>> [image: cid:image001.jpg at 01C72F94.9EE45D60]<http://www.nysolutions.com/>
>>>> ****
>>>>
>>>> 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 at lists.freeswitch.org [mailto:
>>>> freeswitch-users-bounces at 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 at alcan.mydomain.caset(effective_caller_id_name=Alcan Cable)
>>>> ****
>>>>
>>>> 2013-07-01 19:23:21.676990 [DEBUG] mod_dptools.c:1373
>>>> sofia/sipinterface_1/barbara at alcan.mydomain.ca SET
>>>> [effective_caller_id_name]=[Alcan Cable]****
>>>>
>>>> EXECUTE sofia/sipinterface_1/barbara at alcan.mydomain.caset(effective_caller_id_number=
>>>> 9052066900)****
>>>>
>>>> 2013-07-01 19:23:21.676990 [DEBUG] mod_dptools.c:1373
>>>> sofia/sipinterface_1/barbara at alcan.mydomain.ca SET
>>>> [effective_caller_id_number]=[9052066900]****
>>>>
>>>> ** **
>>>>
>>>> *SIP Trace*****
>>>>
>>>> ** **
>>>>
>>>> ** **
>>>>
>>>> INVITE sip:4164750401 at alcan.mydomain.ca SIP/2.0****
>>>>
>>>> ** **
>>>>
>>>> Via: SIP/2.0/UDP 192.168.240.105:5060;branch=z9hG4bK17bfd0ad4****
>>>>
>>>> ** **
>>>>
>>>> Max-Forwards: 70****
>>>>
>>>> ** **
>>>>
>>>> Content-Length: 285****
>>>>
>>>> ** **
>>>>
>>>> To: 4164750401 <sip:4164750401 at alcan.mydomain.ca>****
>>>>
>>>> ** **
>>>>
>>>> From: Barbara Ladner <sip:barbara at alcan.mydomain.ca
>>>> >;tag=02f4abe9bef3a7f****
>>>>
>>>> ** **
>>>>
>>>> Call-ID: 43016333178f7b0882c3767aab886c1d at 192.168.240.105****
>>>>
>>>> ** **
>>>>
>>>> CSeq: 1894816474 INVITE****
>>>>
>>>> ** **
>>>>
>>>> Supported: timer****
>>>>
>>>> ** **
>>>>
>>>> Allow-Events: talk,hold,conference****
>>>>
>>>> ** **
>>>>
>>>> Allow:NOTIFY,REFER,OPTIONS,INVITE,ACK,CANCEL,BYE,INFO****
>>>>
>>>> ** **
>>>>
>>>> Content-Type: application/sdp****
>>>>
>>>> ** **
>>>>
>>>> Contact: Barbara Ladner <sip:barbara at 192.168.240.105:5060;transport=udp
>>>> >****
>>>>
>>>> ** **
>>>>
>>>> Supported: replaces****
>>>>
>>>> ** **
>>>>
>>>> User-Agent: Aastra 9133i/1.4.3.1001 Brcm Callctrl/1.5.1.0MxSF/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 at alcan.mydomain.ca
>>>> >;tag=02f4abe9bef3a7f****
>>>>
>>>> ** **
>>>>
>>>> To: 4164750401 <sip:4164750401 at alcan.mydomain.ca>****
>>>>
>>>> ** **
>>>>
>>>> Call-ID: 43016333178f7b0882c3767aab886c1d at 192.168.240.105****
>>>>
>>>> ** **
>>>>
>>>> CSeq: 1894816474 INVITE****
>>>>
>>>> ** **
>>>>
>>>> User-Agent: FreeSWITCH-mod_sofia/1.5.3b+git~20130628T160527Z~a52a604fbb
>>>> ****
>>>>
>>>> ** **
>>>>
>>>> Content-Length: 0****
>>>>
>>>> ** **
>>>>
>>>> ** **
>>>>
>>>> Thanks****
>>>>
>>>> Lloyd****
>>>>
>>>>
>>>> _________________________________________________________________________
>>>> Professional FreeSWITCH Consulting Services:
>>>> consulting at freeswitch.org
>>>> http://www.freeswitchsolutions.com
>>>>
>>>>
>>>>
>>>>
>>>> Official FreeSWITCH Sites
>>>> http://www.freeswitch.org
>>>> http://wiki.freeswitch.org
>>>> http://www.cluecon.com
>>>>
>>>> FreeSWITCH-users mailing list
>>>> FreeSWITCH-users at 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 at freeswitch.org
>>> http://www.freeswitchsolutions.com
>>>
>>>
>>>
>>>
>>> Official FreeSWITCH Sites
>>> http://www.freeswitch.org
>>> http://wiki.freeswitch.org
>>> http://www.cluecon.com
>>>
>>> FreeSWITCH-users mailing list
>>> FreeSWITCH-users at 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 at freeswitch.org
>> http://www.freeswitchsolutions.com
>>
>>
>>
>>
>> Official FreeSWITCH Sites
>> http://www.freeswitch.org
>> http://wiki.freeswitch.org
>> http://www.cluecon.com
>>
>> FreeSWITCH-users mailing list
>> FreeSWITCH-users at 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
>
>
> _________________________________________________________________________
> Professional FreeSWITCH Consulting Services:
> consulting at freeswitch.org
> http://www.freeswitchsolutions.com
>
>
>
>
> Official FreeSWITCH Sites
> http://www.freeswitch.org
> http://wiki.freeswitch.org
> http://www.cluecon.com
>
> FreeSWITCH-users mailing list
> FreeSWITCH-users at lists.freeswitch.org
> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
> http://www.freeswitch.org
>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20130701/5c47021f/attachment-0001.html
-------------- next part --------------
A non-text attachment was scrubbed...
Name: not available
Type: image/jpeg
Size: 2424 bytes
Desc: not available
Url : http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20130701/5c47021f/attachment-0001.jpe
Join us at ClueCon 2011 Aug 9-11, 2011
More information about the FreeSWITCH-users
mailing list