[Freeswitch-users] effective_caller_id_name &effective_caller_id_number - not working
Michael Collins
msc at freeswitch.org
Tue Jul 2 05:58:41 MSD 2013
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.cacall_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.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 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
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20130701/d3003252/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/d3003252/attachment-0001.jpe
Join us at ClueCon 2011 Aug 9-11, 2011
More information about the FreeSWITCH-users
mailing list