The scenario is 14087184373 calling DID which terminates at exten 1108, which has set Call Forward to 14084935591 .. Here is the relevant log ============================================== 2014-02-24 09:15:35.963293 [DEBUG] switch_core_state_machine.c:325 (sofia/sipinterface_4/sip:1108@192.168.99.8:5060) Running State Change CS_CONSUME_MEDIA 2014-02-24 09:15:35.963293 [DEBUG] switch_core_state_machine.c:383 (sofia/sipinterface_4/sip:1108@192.168.99.8:5060) State CONSUME_MEDIA 2014-02-24 09:15:35.963293 [DEBUG] switch_core_state_machine.c:383 (sofia/sipinterface_4/sip:1108@192.168.99.8:5060) State CONSUME_MEDIA going to sleep 2014-02-24 09:15:36.257932 [DEBUG] sofia.c:4366 Redirect: Transfering to 14084935591 XML redirected 2014-02-24 09:15:36.257932 [DEBUG] switch_ivr.c:1600 (sofia/sipinterface_5/+14087184373@65.98.234.222:5060) State Change CS_EXECUTE -> CS_ROUTING 2014-02-24 09:15:36.257932 [DEBUG] switch_core_session.c:1116 Send signal sofia/sipinterface_5/+14087184373@65.98.234.222:5060 [BREAK] 2014-02-24 09:15:36.257932 [DEBUG] switch_core_session.c:709 Send signal sofia/sipinterface_5/+14087184373@65.98.234.222:5060 [BREAK] 2014-02-24 09:15:36.257932 [NOTICE] switch_ivr.c:1606 Transfer sofia/sipinterface_5/+14087184373@65.98.234.222:5060 to XML[14084935591@redirected] 2014-02-24 09:15:36.257932 [DEBUG] switch_channel.c:2563 (sofia/sipinterface_4/sip:1108@192.168.99.8:5060) Callstate Change RINGING -> HANGUP 2014-02-24 09:15:36.257932 [NOTICE] sofia.c:4369 Hangup sofia/sipinterface_4/sip:1108@192.168.99.8:5060 [CS_CONSUME_MEDIA] [REDIRECTION_TO_NEW_DESTINATION] 2014-02-24 09:15:36.257932 [DEBUG] switch_channel.c:2579 Send signal sofia/sipinterface_4/sip:1108@192.168.99.8:5060 [KILL] 2014-02-24 09:15:36.257932 [DEBUG] switch_core_session.c:1116 Send signal sofia/sipinterface_4/sip:1108@192.168.99.8:5060 [BREAK] 2014-02-24 09:15:36.257932 [DEBUG] switch_ivr_originate.c:3293 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL] 2014-02-24 09:15:36.257932 [ERR] switch_ivr_originate.c:2447 Cannot create outgoing channel of type [user] cause: [ORIGINATOR_CANCEL] 2014-02-24 09:15:36.257932 [DEBUG] switch_ivr_originate.c:3299 Originate Resulted in Error Cause: 487 [ORIGINATOR_CANCEL] 2014-02-24 09:15:36.257932 [INFO] mod_dptools.c:2647 Originate Failed. Cause: ORIGINATOR_CANCEL 2014-02-24 09:15:36.257932 [DEBUG] switch_core_state_machine.c:371 (sofia/sipinterface_5/+14087184373@65.98.234.222:5060) State EXECUTE going to sleep 2014-02-24 09:15:36.257932 [DEBUG] switch_core_state_machine.c:325 (sofia/sipinterface_5/+14087184373@65.98.234.222:5060) Running State Change CS_ROUTING 2014-02-24 09:15:36.257932 [DEBUG] switch_core_state_machine.c:364 (sofia/sipinterface_5/+14087184373@65.98.234.222:5060) State ROUTING 2014-02-24 09:15:36.257932 [DEBUG] mod_sofia.c:147 sofia/sipinterface_5/+14087184373@65.98.234.222:5060 SOFIA ROUTING 2014-02-24 09:15:36.257932 [DEBUG] switch_core_state_machine.c:77 sofia/sipinterface_5/+14087184373@65.98.234.222:5060 Standard ROUTING 2014-02-24 09:15:36.257932 [INFO] mod_dialplan_xml.c:331 Processing +14087184373 <+14087184373>->14084935591 in context redirected Dialplan: sofia/sipinterface_5/+14087184373@65.98.234.222:5060 parsing [redirected->redirected] continue=false Dialplan: sofia/sipinterface_5/+14087184373@65.98.234.222:5060 Regex (PASS) [redirected] destination_number(14084935591) =~ /^(1[2-9][0-8][0-9][2-9][0-9]{6})$/ break=never Dialplan: sofia/sipinterface_5/+14087184373@65.98.234.222:5060 Action set(sip_redirect_profile=sipinterface_4) Dialplan: sofia/sipinterface_5/+14087184373@65.98.234.222:5060 Action bridge(sofia/internal/${sip_redirect_contact_0}@127.0.0.1:5062) 2014-02-24 09:15:36.259255 [DEBUG] switch_core_state_machine.c:119 (sofia/sipinterface_5/+14087184373@65.98.234.222:5060) State Change CS_ROUTING -> CS_EXECUTE 2014-02-24 09:15:36.259255 [DEBUG] switch_core_session.c:1116 Send signal sofia/sipinterface_5/+14087184373@65.98.234.222:5060 [BREAK] 2014-02-24 09:15:36.259255 [DEBUG] switch_core_state_machine.c:364 (sofia/sipinterface_5/+14087184373@65.98.234.222:5060) State ROUTING going to sleep 2014-02-24 09:15:36.259255 [DEBUG] switch_core_state_machine.c:325 (sofia/sipinterface_5/+14087184373@65.98.234.222:5060) Running State Change CS_EXECUTE 2014-02-24 09:15:36.259255 [DEBUG] switch_core_state_machine.c:371 (sofia/sipinterface_5/+14087184373@65.98.234.222:5060) State EXECUTE 2014-02-24 09:15:36.259255 [DEBUG] mod_sofia.c:240 sofia/sipinterface_5/+14087184373@65.98.234.222:5060 SOFIA EXECUTE 2014-02-24 09:15:36.259255 [DEBUG] switch_core_state_machine.c:157 sofia/sipinterface_5/+14087184373@65.98.234.222:5060 Standard EXECUTE 2014-02-24 09:15:36.259255 [DEBUG] mod_dptools.c:1060 sofia/sipinterface_5/+14087184373@65.98.234.222:5060 SET [sip_redirect_profile]=[sipinterface_4] EXECUTE sofia/sipinterface_5/+14087184373@65.98.234.222:5060 bridge(sofia/internal/"14084935591" <sip:14084935591@orion.switch1.telrouter.com>@127.0.0.1:5062) 2014-02-24 09:15:36.259255 [DEBUG] switch_channel.c:918 sofia/sipinterface_5/+14087184373@65.98.234.222:5060 EXPORTING[export_vars] [sip_callee_id_name]=[1108] to event 2014-02-24 09:15:36.259255 [DEBUG] switch_channel.c:918 sofia/sipinterface_5/+14087184373@65.98.234.222:5060 EXPORTING[export_vars] [sip_callee_id_number]=[14087973449] to event 2014-02-24 09:15:36.259255 [DEBUG] switch_ivr_originate.c:1873 Parsing global variables 2014-02-24 09:15:36.259255 [ERR] mod_sofia.c:4167 Invalid Profile 2014-02-24 09:15:36.259255 [NOTICE] mod_sofia.c:4402 Close Channel N/A [CS_NEW] 2014-02-24 09:15:36.259255 [DEBUG] switch_core_state_machine.c:457 () Running State Change CS_DESTROY 2014-02-24 09:15:36.259255 [DEBUG] switch_core_state_machine.c:467 (N/A) State DESTROY 2014-02-24 09:15:36.259255 [DEBUG] mod_sofia.c:362 N/A SOFIA DESTROY 2014-02-24 09:15:36.259255 [DEBUG] switch_core_state_machine.c:467 (N/A) State DESTROY going to sleep 2014-02-24 09:15:36.259255 [ERR] switch_ivr_originate.c:2447 Cannot create outgoing channel of type [sofia] cause: [DESTINATION_OUT_OF_ORDER] 2014-02-24 09:15:36.259255 [DEBUG] switch_ivr_originate.c:3299 Originate Resulted in Error Cause: 27 [DESTINATION_OUT_OF_ORDER] 2014-02-24 09:15:36.259255 [INFO] mod_dptools.c:2647 Originate Failed. Cause: DESTINATION_OUT_OF_ORDER 2014-02-24 09:15:36.259255 [DEBUG] switch_channel.c:2563 (sofia/sipinterface_5/+14087184373@65.98.234.222:5060) Callstate Change RINGING -> HANGUP 2014-02-24 09:15:36.259255 [NOTICE] mod_dptools.c:2761 Hangup sofia/sipinterface_5/+14087184373@65.98.234.222:5060 [CS_EXECUTE] [DESTINATION_OUT_OF_ORDER] 2014-02-24 09:15:36.261841 [DEBUG] switch_channel.c:2579 Send signal sofia/sipinterface_5/+14087184373@65.98.234.222:5060 [KILL] 2014-02-24 09:15:36.261841 [DEBUG] switch_core_session.c:1116 Send signal sofia/sipinterface_5/+14087184373@65.98.234.222:5060 [BREAK] 2014-02-24 09:15:36.261841 [DEBUG] switch_core_session.c:2060 sofia/sipinterface_5/+14087184373@65.98.234.222:5060 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already) ========================================== sipinterface_4 is where all authentication happens ie for extensions .. sipinterface_5 is reserved for all trunk accounts which do not require any authentication. The error shows that "Invalid Profile" .. I Regards, Akhil
Hello everyone,
Looks like I have a strange problem at hand.
A SIP user/ extension has forwarded his phone to his mobile number.
1. When another user( ie extension) calls the SIP user, the call is forwarded to forwarded number after getting 302 redirect.
2. However, if I call from PSTN into the SIP user, the call hangs up after getting the 302 message.
Not sure whats going on. I have the <param name="manual-redirect" value="true"/> in the SIP profile for the extension. NB: I have 2 profiles, one for extensions and one for SIP trunk. Just wanted to separate the ports. Nothing else. But the SIP profile for trunk does not have the manual-redirect set to true.
Regards, Akhil