09-06-2021 10:01 AM
Hi Team,
I am trying to connect my CUCM IPBX to PSTN using FXO ports (SM-X-8FX-12FO module) but I have cannot make a call out.
This is the debug of a call ouside:
*Sep 6 15:20:04.151: //-1/A85D13800000/CCAPI/cc_api_display_ie_subfields:
cc_api_call_setup_ind_common:
cisco-username=1101
----- ccCallInfo IE subfields -----
cisco-ani=1101
cisco-anitype=0
cisco-aniplan=0
cisco-anipi=0
cisco-anisi=1
dest=079347783
cisco-desttype=0
cisco-destplan=0
cisco-rdie=FFFFFFFFFFFFFFFF
cisco-rdn=
cisco-rdntype=0
cisco-rdnplan=0
cisco-rdnpi=-1
cisco-rdnsi=-1
cisco-redirectreason=-1 fwd_final_type =0
final_redirectNumber =
hunt_group_timeout =0
*Sep 6 15:20:04.153: //-1/A85D13800000/CCAPI/cc_api_call_setup_ind_common:
Interface=0x7FBFF012F8B0, Call Info(
Calling Number=1101,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),
Called Number=079347783(TON=Unknown, NPI=Unknown),
Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=T RUE,
Incoming Dial-peer=4005, Progress Indication=NULL(0), Calling IE Present=TRUE ,
Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALS E), Call Id=29
*Sep 6 15:20:04.153: //-1/A85D13800000/CCAPI/ccCheckClipClir:
In: Calling Number=1101(TON=Unknown, NPI=Unknown, Screening=User, Passed, Pre sentation=Allowed)
*Sep 6 15:20:04.153: //-1/A85D13800000/CCAPI/ccCheckClipClir:
Out: Calling Number=1101(TON=Unknown, NPI=Unknown, Screening=User, Passed, Pr esentation=Allowed)
*Sep 6 15:20:04.153: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
*Sep 6 15:20:04.153: :cc_get_feature_vsa malloc success
*Sep 6 15:20:04.153: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
*Sep 6 15:20:04.154: cc_get_feature_vsa count is 1
*Sep 6 15:20:04.154: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
*Sep 6 15:20:04.154: :FEATURE_VSA attributes are: feature_name:0,feature_time:1 40462362646860,feature_id:29
*Sep 6 15:20:04.154: //29/A85D13800000/CCAPI/cc_api_call_setup_ind_common:
Set Up Event Sent;
Call Info(Calling Number=1101(TON=Unknown, NPI=Unknown, Screening=User, Passe d, Presentation=Allowed),
Called Number=079347783(TON=Unknown, NPI=Unknown))
*Sep 6 15:20:04.154: //29/A85D13800000/CCAPI/cc_process_call_setup_ind:
Event=0x7FBFF13CD208
*Sep 6 15:20:04.155: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
Try with the demoted called number 079347783
*Sep 6 15:20:04.155: //29/A85D13800000/CCAPI/ccCallSetContext:
Context=0x7FBFF9BC3160
*Sep 6 15:20:04.156: //29/A85D13800000/CCAPI/cc_process_call_setup_ind:
>>>>CCAPI handed cid 29 with tag 4005 to app "_ManagedAppProcess_Default"
*Sep 6 15:20:04.156: //29/A85D13800000/CCAPI/ccCallProceeding:
Progress Indication=NULL(0)
*Sep 6 15:20:04.157: //29/A85D13800000/CCAPI/ccCallSetupRequest:
Destination=, Calling IE Present=TRUE, Mode=0,
Outgoing Dial-peer=4002, Params=0x7FBFF9BC1AD0, Progress Indication=NULL(0)
*Sep 6 15:20:04.157: //29/A85D13800000/CCAPI/ccCheckClipClir:
In: Calling Number=1101(TON=Unknown, NPI=Unknown, Screening=User, Passed, Pre sentation=Allowed)
*Sep 6 15:20:04.157: //29/A85D13800000/CCAPI/ccCheckClipClir:
Out: Calling Number=1101(TON=Unknown, NPI=Unknown, Screening=User, Passed, Pr esentation=Allowed)
*Sep 6 15:20:04.157: //29/A85D13800000/CCAPI/ccCallSetupRequest:
Destination Pattern=0........, Called Number=079347783, Digit Strip=TRUE
*Sep 6 15:20:04.157: //29/A85D13800000/CCAPI/ccCallSetupRequest:
Calling Number=1101(TON=Unknown, NPI=Unknown, Screening=User, Passed, Present ation=Allowed),
Called Number=079347783(TON=Unknown, NPI=Unknown),
Redirect Number=, Display Info=
Account Number=1101, Final Destination Flag=TRUE,
Guid=A85D1380-0001-0000-0000-000647029D0A, Outgoing Dial-peer=4002
*Sep 6 15:20:04.158: //29/A85D13800000/CCAPI/cc_api_display_ie_subfields:
ccCallSetupRequest:
cisco-username=1101
----- ccCallInfo IE subfields -----
cisco-ani=1101
cisco-anitype=0
cisco-aniplan=0
cisco-anipi=0
cisco-anisi=1
dest=079347783
cisco-desttype=0
cisco-destplan=0
cisco-rdie=FFFFFFFFFFFFFFFF
cisco-rdn=
cisco-rdntype=0
cisco-rdnplan=0
cisco-rdnpi=-1
cisco-rdnsi=-1
cisco-redirectreason=-1 fwd_final_type =0
final_redirectNumber =
hunt_group_timeout =0
*Sep 6 15:20:04.159: //29/A85D13800000/CCAPI/ccIFCallSetupRequestPrivate:
Interface=0x7FBFF4A1AC58, Interface Type=6, Destination=, Mode=0x0,
Call Params(Calling Number=1101,(Calling Name=)(TON=Unknown, NPI=Unknown, Scr eening=User, Passed, Presentation=Allowed),
Called Number=079347783(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=40 02, Call Count On=FALSE,
Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Appl ication Call Id=)
*Sep 6 15:20:04.159: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
*Sep 6 15:20:04.159: :cc_get_feature_vsa malloc success
*Sep 6 15:20:04.160: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
*Sep 6 15:20:04.160: cc_get_feature_vsa count is 2
*Sep 6 15:20:04.160: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
*Sep 6 15:20:04.160: :FEATURE_VSA attributes are: feature_name:0,feature_time:1 40462362646636,feature_id:30
*Sep 6 15:20:04.160: //30/A85D13800000/CCAPI/ccIFCallSetupRequestPrivate:
SPI Call Setup Request Is Success; Interface Type=6, FlowMode=1
*Sep 6 15:20:04.160: //30/A85D13800000/CCAPI/ccCallSetContext:
Context=0x7FBFF9BC1A50
*Sep 6 15:20:04.160: //29/A85D13800000/CCAPI/ccSaveDialpeerTag:
Outgoing Dial-peer=4002
*Sep 6 15:20:04.162: //30/A85D13800000/CCAPI/cc_api_call_proceeding:
Interface=0x7FBFF4A1AC58, Progress Indication=NULL(0)
*Sep 6 15:20:05.424: //30/A85D13800000/CCAPI/cc_api_call_disconnected:
Cause Value=34, Interface=0x7FBFF4A1AC58, Call Id=30
*Sep 6 15:20:05.425: //30/A85D13800000/CCAPI/cc_api_call_disconnected:
Call Entry(Responsed=TRUE, Cause Value=34, Retry Count=0)
*Sep 6 15:20:05.425: //29/A85D13800000/CCAPI/ccCallReleaseResources:
release reserved xcoding resource.
*Sep 6 15:20:05.425: //30/A85D13800000/CCAPI/ccCallSetAAA_Accounting:
Accounting=0, Call Id=30
*Sep 6 15:20:05.425: //30/A85D13800000/CCAPI/ccCallDisconnect:
Cause Value=34, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect C ause=34)
*Sep 6 15:20:05.425: //30/A85D13800000/CCAPI/ccCallDisconnect:
Cause Value=34, Call Entry(Responsed=TRUE, Cause Value=34)
*Sep 6 15:20:05.431: //30/A85D13800000/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x7FBFF4A1AC58, Tag=0x0, Call Id=30,
Call Entry(Disconnect Cause=34, Voice Class Cause Code=0, Retry Count=0)
*Sep 6 15:20:05.432: //30/A85D13800000/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
*Sep 6 15:20:05.432: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
*Sep 6 15:20:05.432: :cc_free_feature_vsa freeing 7FBFF13AD860
*Sep 6 15:20:05.432: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
*Sep 6 15:20:05.432: vsacount in free is 1
*Sep 6 15:20:05.432: //29/A85D13800000/CCAPI/ccCallDisconnect:
Cause Value=34, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect C ause=0)
*Sep 6 15:20:05.433: //29/A85D13800000/CCAPI/ccCallDisconnect:
Cause Value=34, Call Entry(Responsed=TRUE, Cause Value=34)
*Sep 6 15:20:05.436: //29/A85D13800000/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x7FBFF012F8B0, Tag=0x0, Call Id=29,
Call Entry(Disconnect Cause=34, Voice Class Cause Code=0, Retry Count=0)
*Sep 6 15:20:05.436: //29/A85D13800000/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
*Sep 6 15:20:05.437: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
*Sep 6 15:20:05.437: :cc_free_feature_vsa freeing 7FBFF13AD940
*Sep 6 15:20:05.437: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
*Sep 6 15:20:05.437: vsacount in free is 0
*Sep 6 15:23:05.437: //-1/xxxxxxxxxxxx/CCAPI/ccAppShutdownMode:
remove it from the queue
Any support on this??
09-06-2021 10:39 PM
According to your logs the call is disconnected with Cause Value=34 and this means no circuit/channel available. Can you please share the configuration of your voice gateway and for the call pertaining configuration from CM so we can verify your setup?
09-08-2021 01:09 AM
Hi Roger,
This is my ISR conf :
voice service voip
ip address trusted list
ipv4 10.157.2.71
mode border-element license capacity 200
allow-connections h323 to h323
allow-connections h323 to sip
allow-connections sip to h323
allow-connections sip to sip
fax protocol t38 version 0 ls-redundancy 0 hs-redundancy 0 fallback none
sip
early-offer forced
midcall-signaling passthru
g729 annexb-all
!
voice class codec 3
codec preference 1 g729r8
codec preference 2 g711ulaw
codec preference 3 g711alaw
!
!
!
!
!
!
!
!
!
!
!
voice-card 0/1
no watchdog
!
voice-card 0/4
no watchdog
!
voice-card 1/0
no watchdog
!
ip default-gateway 10.157.2.1
ip forward-protocol nd
ip http server
ip http authentication local
ip http secure-server
ip tftp source-interface Loopback0
!
ip ssh time-out 60
ip ssh authentication-retries 2
!
!
!
!
!
!
!
control-plane
!
!
voice-port 1/0/0
signal groundStart
!
voice-port 1/0/1
!
voice-port 1/0/2
!
voice-port 1/0/3
!
voice-port 1/0/4
!
voice-port 1/0/5
!
voice-port 1/0/6
!
voice-port 1/0/7
!
voice-port 1/0/8
!
voice-port 1/0/9
!
voice-port 1/0/10
!
voice-port 1/0/11
!
voice-port 1/0/12
!
voice-port 1/0/13
!
voice-port 1/0/14
!
voice-port 1/0/15
!
voice-port 1/0/16
!
voice-port 1/0/17
!
voice-port 1/0/18
!
voice-port 1/0/19
supervisory disconnect dualtone mid-call
timing hookflash-out 50
timing guard-out 1000
connection plar 1101
!
mgcp
mgcp call-agent 10.157.2.71 2427 service-type mgcp version 0.1
mgcp dtmf-relay voip codec all mode out-of-band
mgcp rtp unreachable timeout 1000 action notify
mgcp modem passthrough voip mode nse
mgcp package-capability rtp-package
mgcp package-capability sst-package
mgcp package-capability pre-package
no mgcp package-capability res-package
no mgcp timer receive-rtcp
mgcp sdp simple
mgcp fax t38 inhibit
mgcp bind control source-interface GigabitEthernet0/0/0
mgcp bind media source-interface GigabitEthernet0/0/0
mgcp behavior rsip-range tgcp-only
mgcp behavior comedia-role none
mgcp behavior comedia-check-media-src disable
mgcp behavior comedia-sdp-force disable
!
mgcp profile default
!
!
ccm-manager music-on-hold
!
ccm-manager mgcp
no ccm-manager fax protocol cisco
ccm-manager config server 10.157.2.71
ccm-manager config
!
dial-peer voice 999100 pots
service mgcpapp
port 1/0/0
!
dial-peer voice 1 pots
service mgcpapp
port 1/0/0
!
dial-peer voice 20 pots
service mgcpapp
port 1/0/19
!
dial-peer voice 9991019 pots
service mgcpapp
port 1/0/19
!
dial-peer voice 5000 voip
destination-pattern 10001
session target ipv4:10.157.2.71
dtmf-relay h245-alphanumeric
!
dial-peer voice 4001 pots
description ONATEL
destination-pattern 2.......
port 1/0/19
forward-digits 8
!
dial-peer voice 4002 pots
description MOBILE
destination-pattern 0........
port 1/0/19
forward-digits 9
!
dial-peer voice 4005 voip
description ENTRANT
destination-pattern 1101
session target ipv4:10.157.2.71
no vad
!
!
!
line con 0
transport input none
stopbits 1
line aux 0
stopbits 1
line vty 0 4
password WV@Voice@2021
transport input ssh
!
!
!
!
!
!
end
09-07-2021 06:45 AM
In addition to the config, please also provide the output of "debug vpim signal", which will tell us more about what is going on with the FXO port itself.
Maren
09-08-2021 03:07 AM
Hi @Maren Mahoney ,
here is debug vpm
*Sep 8 10:12:06.513: htsp_timer_stop3 htsp_setup_req
*Sep 8 10:12:06.514: Orig called num:079347783
*Sep 8 10:12:06.514: htsp_process_event: [1/0/19, FXOLS_ONHOOK, E_HTSP_SETUP_REQ]fxols_onhook_setup
*Sep 8 10:12:06.514: [1/0/19] sm_set_sig_state: state=0xC, timestamp=0
*Sep 8 10:12:06.514: [1/0/19] set signal state = 0xC timestamp = 0
*Sep 8 10:12:06.514: dsp_set_sig_state: [1/0/19] packet_len=12 channel_id=147 packet_id=39 state=0xC timestamp=0x0
*Sep 8 10:12:06.515: TGRM: reg_invoke_tgrm_call_update(1, 0, 19, 65535, 1, TGRM_CALL_BUSY, TGRM_CALL_VOICE, TGRM_DIRECTION_OUT)
*Sep 8 10:12:06.515: htsp_timer - 1300 msec
*Sep 8 10:12:06.781: htsp_dsp_message: SEND_SIG_STATUS: state=0xC timestamp=57943 systime=40907552
*Sep 8 10:12:06.781: htsp_process_event: [1/0/19, FXOLS_WAIT_DIAL_TONE, E_DSP_SIG_1100]fxols_power_denial_detected
*Sep 8 10:12:06.781: htsp_timer2 - 1000 msec
*Sep 8 10:12:06.782: htsp_timer_stop
*Sep 8 10:12:07.782: htsp_process_event: [1/0/19, FXOLS_WAIT_DIAL_TONE, E_HTSP_EVENT_TIMER2]fxols_power_den_disc
*Sep 8 10:12:07.782: htsp_timer_stop
*Sep 8 10:12:07.782: htsp_timer_stop2
*Sep 8 10:12:07.782: [1/0/19] sm_set_sig_state: state=0x4, timestamp=0
*Sep 8 10:12:07.782: [1/0/19] set signal state = 0x4 timestamp = 0
*Sep 8 10:12:07.782: dsp_set_sig_state: [1/0/19] packet_len=12 channel_id=147 packet_id=39 state=0x4 timestamp=0x0
*Sep 8 10:12:07.783: mars_flex_dsprm_current_codec_comp:DSP:0 FLEX Complexity Codec htsp_release_req: cause 34, no_onhook 0
*Sep 8 10:12:07.784: htsp_process_event: [1/0/19, FXOLS_ONHOOK, E_HTSP_RELEASE_REQ]fxols_onhook_release
*Sep 8 10:12:07.784: TGRM: reg_invoke_tgrm_call_update(1, 0, 19, 65535, 1, TGRM_CALL_IDLE, TGRM_CALL_VOICE, TGRM_DIRECTION_OUT)
*Sep 8 10:12:07.786: flex_dsprm_close_cleanup
Discover and save your favorite ideas. Come back to expert answers, step-by-step guides, recent topics, and more.
New here? Get started with these tips. How to use Community New member guide