Re: Help with CME

smutnpj10 · ‎12-09-2017

I'm new to VOIP and I'm building a test lab at home. I currently have a 2901 with an FXO port connection to the PSTN. I also have a VG202 connected with an analog phone connected to the FXS port. My issue is I can't get any incoming calls to either the analog phone or the VOIP phones. I also cannot dial out of the analog phone. I'm able to dial out of the VOIP phones. Here's a snapshot of my configs. Thanks for help in advance.

2901:

stcapp ccm-group 1
stcapp
!
stcapp feature access-code
!
stcapp feature speed-dial
!

voice-card 0
!
voice service voip
allow-connections h323 to h323
allow-connections h323 to sip
allow-connections sip to sip
fax protocol t38 version 0 ls-redundancy 0 hs-redundancy 0 fallback none
sip
!voice moh-group 1
!
hw-module pvdm 0/0
!
!
!
archive
log config
logging enable

!
!
interface Loopback0
ip address 172.30.11.36 255.255.255.255
!
interface Embedded-Service-Engine0/0
no ip address
shutdown
!
interface GigabitEthernet0/0
description WAN INTERNET
ip address dhcp
no ip redirects
no ip proxy-arp
ip nat outside
ip virtual-reassembly in
duplex auto
speed auto
no cdp tlv app
!
interface GigabitEthernet0/1
shutdown
!
interface GigabitEthernet0/0/0
description The LAN
ip address 192.168.255.1 255.255.255.252
ip nat inside
no ip virtual-reassembly in
duplex auto
speed auto
no mop enabled
!
ipv6 ioam timestamp
!
voice-port 0/1/0
description POTS line from Carrier
caller-id enable
!
voice-port 0/1/1
!
!
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
!
sccp local GigabitEthernet0/0/0
sccp ccm 192.168.99.6 identifier 1 priority 1 version 7.0
sccp
!
sccp ccm group 1
associate ccm 1 priority 1
keepalive retries 5
switchover method immediate
switchback method immediate
switchback interval 5
!
!
dial-peer voice 10 pots
incoming called-number .
!
!
sip-ua
!
!
!
gatekeeper
shutdown
!
!
telephony-service
moh-file-buffer 2000
max-ephones 20
max-dn 60
ip source-address 192.168.255.1 port 2000
auto assign 105 to 110
cnf-file location flash:
cnf-file perphone
load 7916-12 B016-1-0-4-2
load 7921 sip78xx.12-0-1-11
load 7962 SCCP42.9-4-2SR3-1S
load 7965 SCCP45.9-4-2SR3-1S
load 8945 SCCP894x.9-4-2SR3-1
time-zone 12
max-conferences 8 gain -6
transfer-system full-consult
create cnf-files version-stamp Jan 01 2002 00:00:00
!
!
ephone-dn 1 dual-line
number 100
description XXX x100
hold-alert 30 originator
!
!
ephone-dn 2
number 101
description x101
hold-alert 30 originator
!
!
ephone-dn 3
number 102
description x102
!
!
ephone-dn 4
number 103
description X103
!
!
!
!
ephone-dn 30 dual-line
description Analog Line
number 200 secondary xxxxxxxxxx (PSTN)
!
!
!
!
!
ephone 10
device-security-mode none
mac-address 8141.80E1.9000
max-calls-per-button 2
type anl
button 1:30

VG202

stcapp ccm-group 1
stcapp
!
stcapp feature access-code
!
stcapp feature speed-dial
!
!
!
stcapp supplementary-services
port 0/0
fallback-dn 200
port 0/1
fallback-dn 200
!
!
!
!
!
voice service voip
no supplementary-service sip handle-replaces
modem passthrough nse codec g711ulaw
!
!
!
!
!
voice-card 0
!
!
!
interface FastEthernet0/0
shutdown
!
interface FastEthernet0/1
ip address 192.168.99.6 255.255.255.192
duplex auto
speed auto
!
!
voice-port 0/0
timeouts ringing infinity
description Analog
station-id number 200
caller-id enable
!
voice-port 0/1
timeouts ringing infinity
caller-id enable
!
!
!
mgcp profile default
!
sccp local FastEthernet0/1
sccp ccm 192.168.255.1 identifier 1 version 7.0
sccp
!
sccp ccm group 1
associate ccm 1 priority 1
!
dial-peer voice 2 pots
service stcapp
port 0/0
!
dial-peer voice 1000 pots
service stcapp
port 0/1
!

MOHIT SINGH · ‎12-10-2017

Hi,

Can you remove the command "stcapp feature access-code" from the VG202 and test? Also for a test call provide below logs from VG202

debug vpm signal

debug voip ccapi inout

smutnpj10 · ‎12-10-2017

Thanks for the reply. I took out the stcapp feature access-code. Ran the debug on the VG202. Didn't see any output of the debug on the VG202 for an incoming call so I figured it wasn't reaching. So I ran the debug on the gateway and here's the output:

Dec 10 14:59:21.305: htsp_dsp_message: SEND_SIG_STATUS: state=0x0 timestamp=33424 systime=595221
Dec 10 14:59:21.305: htsp_process_event: [0/1/0, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing
Dec 10 14:59:21.305: htsp_timer - 125 msec
Dec 10 14:59:21.433: htsp_process_event: [0/1/0, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait_ring_min_timer
Dec 10 14:59:21.433: htsp_timer - 10000 msec
Dec 10 14:59:21.433: htsp_timer3 - 5600 msec
Dec 10 14:59:21.433: [0/1/0] htsp_start_caller_id_rx:Mode BELLCORE. Alerting 0x1
Dec 10 14:59:21.433: htsp_start_caller_id_rx create dsp_stream_manager
Dec 10 14:59:21.433: [0/1/0] htsp_dsm_create_success returns 1
Dec 10 14:59:23.377: htsp_dsp_message: SEND_SIG_STATUS: state=0x4 timestamp=35493 systime=595428
Dec 10 14:59:23.377: htsp_process_event: [0/1/0, FXOLS_RINGING, E_DSP_SIG_0100]
Dec 10 14:59:23.377: fxols_ringing_not
Dec 10 14:59:23.377: htsp_timer_stop
Dec 10 14:59:23.377: htsp_timer - 10000 msec
Dec 10 14:59:24.501: [0/1/0] htsp_dsm_feature_notify_cb returns 2 id=DSM_FEATURE_SM_CALLERID_RX
Dec 10 14:59:24.501: htsp_process_event: [0/1/0, FXOLS_RINGING, E_HTSP_CALLERID_RX_DONE]
Dec 10 14:59:24.501: fxols_callerid_done: stop caller ID
Dec 10 14:59:24.501: [0/1/0] htsp_stop_caller_id_rx. message length 46
Dec 10 14:59:24.501: htsp_timer_stop3
Dec 10 14:59:24.501: htsp_timer3 - 20 msec
Dec 10 14:59:24.505: [0/1/0] htsp_dsm_close_done
Dec 10 14:59:24.521: htsp_process_event: [0/1/0, FXOLS_STOP_CALLERID_DELAY, E_HTSP_EVENT_TIMER3]
Dec 10 14:59:24.521: htsp_timer_stop
Dec 10 14:59:24.525: htsp_timer_stop3 htsp_setup_ind
Dec 10 14:59:24.525: [0/1/0] get_fxo_caller_id:Caller ID received. Message type=128 length=42 checksum=87
Dec 10 14:59:24.525: [0/1/0] Caller ID String 80 27 01 08 31 32 31 30 30 39 35 39 02 0A 37 32 34 38 38 32 35 31 30 38 07 0F 41 52 43 4F 4E 49 43 20 20 20 20 20 20 20 20 87
Dec 10 14:59:24.525: [0/1/0] get_fxo_caller_id calling num=7xx4x2xx08 calling name=ARCONIC         calling time=12/10 09:59
Dec 10 14:59:24.525: fxols_callerid_done: call being answered
Dec 10 14:59:24.529: //-1/8B97294B801B/CCAPI/cc_api_display_ie_subfields:
   cc_api_call_setup_ind_common:
   cisco-username=
   ----- ccCallInfo IE subfields -----
   cisco-ani=7248825108
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=FFFFFFFF
   cisco-rdn=
   cisco-rdntype=0
   cisco-rdnplan=0
   cisco-rdnpi=0
   cisco-rdnsi=0
   cisco-redirectreason=0   fwd_final_type =0
   final_redirectNumber =
   hunt_group_timeout =0

Dec 10 14:59:24.529: //-1/8B97294B801B/CCAPI/cc_api_call_setup_ind_common:
   Interface=0x23704FA0, Call Info(
   Calling Number=7xx4x2xx08,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=(TON=Unknown, NPI=Unknown),
   Calling Translated=FALSE, Subscriber Type Str=RegularLine, FinalDestinationFlag=TRUE,
   Incoming Dial-peer=0, Progress Indication=ORIGINATING SIDE IS NON ISDN(3), Calling IE Present=TRUE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=-1
Dec 10 14:59:24.529: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec 10 14:59:24.529: :cc_get_feature_vsa malloc success
Dec 10 14:59:24.529: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec 10 14:59:24.529: cc_get_feature_vsa count is 1
Dec 10 14:59:24.529: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec 10 14:59:24.529: :FEATURE_VSA attributes are: feature_name:0,feature_time:640462032,feature_id:8
Dec 10 14:59:24.529: //8/8B97294B801B/CCAPI/cc_api_call_setup_ind_common:
   Set Up Event Sent;
   Call Info(Calling Number=7xx4x2xx08(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=(TON=Unknown, NPI=Unknown))
Dec 10 14:59:24.529: //8/8B97294B801B/CCAPI/cc_process_call_setup_ind:
   Event=0x231FC9C0
Dec 10 14:59:24.529: htsp_process_event: [0/1/0, FXOLS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]
Dec 10 14:59:24.529: fxols_wait_setup_ack:
Dec 10 14:59:24.529: [0/1/0] set signal state = 0xC timestamp = 0fxols_check_auto_call
Dec 10 14:59:24.529: //8/8B97294B801B/CCAPI/ccCallSetContext:
   Context=0x21009838
Dec 10 14:59:24.529: //8/8B97294B801B/CCAPI/cc_process_call_setup_ind:
   >>>>CCAPI handed cid 8 with tag 0 to app "_ManagedAppProcess_Default"
Dec 10 14:59:24.529: //8/8B97294B801B/CCAPI/ccCallProceeding:
   Progress Indication=NULL(0)
Dec 10 14:59:24.529: htsp_process_event: [0/1/0, FXOLS_PROCEEDING, E_HTSP_PROCEEDING]fxols_offhook_proc
Dec 10 14:59:24.529: htsp_timer - 120000 msec
Dec 10 14:59:24.533: //8/8B97294B801B/CCAPI/ccCallDisconnect:
   Cause Value=28, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
Dec 10 14:59:24.533: //8/8B97294B801B/CCAPI/ccCallDisconnect:
   Cause Value=28, Call Entry(Responsed=TRUE, Cause Value=28)
Dec 10 14:59:24.533: //8/8B97294B801B/CCAPI/cc_api_get_transfer_info:
   Transfer Number=NULL
Dec 10 14:59:24.533: htsp_pre_connect_disconnect, cdb = 270C8EF8 cause = 1C

Dec 10 14:59:24.533: htsp_process_event: [0/1/0, FXOLS_PROCEEDING, E_HTSP_PRE_CONN_DISC]
Dec 10 14:59:24.805: htsp_dsp_message: SEND_SIG_STATUS: state=0x6 timestamp=36922 systime=595571
Dec 10 14:59:24.805: htsp_process_event: [0/1/0, FXOLS_OFFHOOK, E_DSP_SIG_0110]
Dec 10 14:59:24.805: htsp_timer_stop2 fxols_offhook_rvs_battery
Dec 10 14:59:50.509: htsp_dsp_message: SEND_SIG_STATUS: state=0xC timestamp=62627 systime=598141
Dec 10 14:59:50.509: htsp_process_event: [0/1/0, FXOLS_CONNECT, E_DSP_SIG_1100]fxols_offhook_disc
Dec 10 14:59:50.509: htsp_timer2 - 350 msec
Dec 10 14:59:50.861: htsp_process_event: [0/1/0, FXOLS_CONNECT, E_HTSP_EVENT_TIMER2]fxols_disc_confirm
Dec 10 14:59:50.861: htsp_timer_stop
Dec 10 14:59:50.861: htsp_timer_stop2
Dec 10 14:59:50.861: htsp_timer_stop3
Dec 10 14:59:50.861: htsp_process_event: [0/1/0, FXOLS_REMOTE_RELEASE, E_HTSP_RELEASE_REQ]fxols_offhook_release
Dec 10 14:59:50.861: htsp_timer_stop
Dec 10 14:59:50.861: htsp_timer_stop2
Dec 10 14:59:50.861: htsp_timer_stop3
Dec 10 14:59:50.861: [0/1/0] set signal state = 0x4 timestamp = 0
Dec 10 14:59:50.861: htsp_timer - 2000 msec
Dec 10 14:59:50.865: //8/8B97294B801B/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x23704FA0, Tag=0x0, Call Id=8,
   Call Entry(Disconnect Cause=28, Voice Class Cause Code=0, Retry Count=0)
Dec 10 14:59:50.865: //8/8B97294B801B/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
Dec 10 14:59:50.865: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec 10 14:59:50.865: :cc_free_feature_vsa freeing 262CACC8
Dec 10 14:59:50.865: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec 10 14:59:50.865: vsacount in free is 0
Dec 10 14:59:51.529: htsp_dsp_message: SEND_SIG_STATUS: state=0x6 timestamp=63644 systime=598243
Dec 10 14:59:51.529: htsp_process_event: [0/1/0, FXOLS_GUARD_OUT, E_DSP_SIG_0110]
Dec 10 14:59:52.861: htsp_process_event: [0/1/0, FXOLS_GUARD_OUT, E_HTSP_EVENT_TIMER]fxols_guard_out_timeout
Dec 10 14:59:52.861: htsp_dsp_message: RESP_SIG_STATUS: state=0x4 timestamp=0 systime=598376
Dec 10 14:59:52.861: htsp_process_event: [0/1/0, FXOLS_ONHOOK, E_DSP_SIG_0100]
Dec 10 15:02:50.867: //-1/xxxxxxxxxxxx/CCAPI/ccAppShutdownMode:
remove it from the queue

smutnpj10 · ‎12-10-2017

I was able to figure it out. Needed to edit the dial-peer and add the voice translation rule. Thanks for your help.