Problem with FXO H323 GW and extension

[alejandrortiz]

I have configured a gateway 881 with FXO port. When the call comes the ephone rings for a moment, but inmediatly, the ring stops, and then the behavior is repeated. When i get a debug I found this:

*Sep 22 20:08:50.601: //-1/366B47CB83F5/CCAPI/cc_api_display_ie_subfields:
cc_api_call_setup_ind_common:
cisco-username=
----- ccCallInfo IE subfields -----
cisco-ani=
cisco-anitype=0
cisco-aniplan=0
cisco-anipi=0
cisco-anisi=0
dest=7301
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

*Sep 22 20:08:50.601: //-1/366B47CB83F5/CCAPI/cc_api_call_setup_ind_common:
Interface=0x8B5FF25C, Call Info(
Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=7301(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=FALSE,
Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=-1
*Sep 22 20:08:50.601: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Sep 22 20:08:50.601: :cc_get_feature_vsa malloc success
*Sep 22 20:08:50.601: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Sep 22 20:08:50.601: cc_get_feature_vsa count is 1
*Sep 22 20:08:50.601: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Sep 22 20:08:50.601: :FEATURE_VSA attributes are: feature_name:0,feature_time:2352255104,feature_id:405
*Sep 22 20:08:50.601: //405/366B47CB83F5/CCAPI/cc_api_call_setup_ind_common:
Set Up Event Sent;
Call Info(Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=7301(TON=Unknown, NPI=Unknown))
*Sep 22 20:08:50.601: //405/366B47CB83F5/CCAPI/cc_process_call_setup_ind:
Event=0x8B592130
*Sep 22 20:08:50.601: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
Try with the demoted called number 7301
*Sep 22 20:08:50.601: //405/366B47CB83F5/CCAPI/ccCallSetContext:
Context=0x88BBCB14
*Sep 22 20:08:50.605: //405/366B47CB83F5/CCAPI/cc_process_call_setup_ind:
>>>>CCAPI handed cid 405 with tag 0 to app "_ManagedAppProcess_Default"
*Sep 22 20:08:50.605: //405/366B47CB83F5/CCAPI/ccCallProceeding:
Progress Indication=NULL(0)
*Sep 22 20:08:50.605: //405/366B47CB83F5/CCAPI/ccCallSetupRequest:
Destination=, Calling IE Present=FALSE, Mode=0,
Outgoing Dial-peer=7000, Params=0x88BBE10C, Progress Indication=ORIGINATING SIDE IS NON ISDN(3)
*Sep 22 20:08:50.605: //405/366B47CB83F5/CCAPI/ccCheckClipClir:
In: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Sep 22 20:08:50.605: //405/366B47CB83F5/CCAPI/ccCheckClipClir:
Out: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Sep 22 20:08:50.605: //405/366B47CB83F5/CCAPI/ccCallSetupRequest:
Destination Pattern=7...$, Called Number=7301, Digit Strip=FALSE
*Sep 22 20:08:50.605: //405/366B47CB83F5/CCAPI/ccCallSetupRequest:
Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=7301(TON=Unknown, NPI=Unknown),
Redirect Number=, Display Info=
Account Number=, Final Destination Flag=TRUE,
Guid=366B47CB-8037-11E6-83F5-83B65075D545, Outgoing Dial-peer=7000
*Sep 22 20:08:50.605: //405/366B47CB83F5/CCAPI/cc_api_display_ie_subfields:
ccCallSetupRequest:
cisco-username=
----- ccCallInfo IE subfields -----
cisco-ani=
cisco-anitype=0
cisco-aniplan=0
cisco-anipi=0
cisco-anisi=0
dest=7301
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

*Sep 22 20:08:50.605: //405/366B47CB83F5/CCAPI/ccIFCallSetupRequestPrivate:
Interface=0x8AC020AC, Interface Type=1, Destination=, Mode=0x0,
Call Params(Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=7301(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
Subscriber Type Str=RegularLine, FinalDestinationFlag=TRUE, Outgoing Dial-peer=7000, Call Count On=FALSE,
Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
*Sep 22 20:08:50.609: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Sep 22 20:08:50.609: :cc_get_feature_vsa malloc success
*Sep 22 20:08:50.609: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Sep 22 20:08:50.609: cc_get_feature_vsa count is 2
*Sep 22 20:08:50.609: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Sep 22 20:08:50.609: :FEATURE_VSA attributes are: feature_name:0,feature_time:2352254880,feature_id:406
*Sep 22 20:08:50.609: //406/366B47CB83F5/CCAPI/ccIFCallSetupRequestPrivate:
SPI Call Setup Request Is Success; Interface Type=1, FlowMode=1
*Sep 22 20:08:50.609: //406/366B47CB83F5/CCAPI/ccCallSetContext:
Context=0x88BBE0BC
*Sep 22 20:08:50.609: //405/366B47CB83F5/CCAPI/ccSaveDialpeerTag:
Outgoing Dial-peer=7000
*Sep 22 20:08:50.609: //406/366B47CB83F5/CCAPI/ccGetMediaClassTag:
media class tag 0
*Sep 22 20:08:50.609: //406/366B47CB83F5/CCAPI/ccSetMediaclassIp2ipTags:
media class tags set: NR 0, ASP 0
*Sep 22 20:08:50.609: //405/366B47CB83F5/CCAPI/ccGetMediaClassTag:
no peer tag found, use the default media class tag
*Sep 22 20:08:50.609: //405/366B47CB83F5/CCAPI/ccSetMediaclassIp2ipTags:
media class tags set: NR 0, ASP 0
*Sep 22 20:08:50.609: //406/366B47CB83F5/CCAPI/ccGet_xc_nr_asp_info:
media class tags: NR 0, ASP 0
*Sep 22 20:08:50.609: //405/366B47CB83F5/CCAPI/ccGet_xc_nr_asp_info:
media class tags: NR 0, ASP 0
*Sep 22 20:08:50.677: //406/366B47CB83F5/CCAPI/cc_api_set_called_ccm_detected:
CallInfo(called ccm detected=TRUE ccmVersion 3)
*Sep 22 20:08:50.677: //406/366B47CB83F5/CCAPI/cc_api_call_proceeding:
Interface=0x8AC020AC, Progress Indication=NULL(0)
*Sep 22 20:08:50.793: //406/366B47CB83F5/CCAPI/cc_api_set_called_ccm_detected:
CallInfo(called ccm detected=TRUE ccmVersion 3)
*Sep 22 20:08:50.793: //406/366B47CB83F5/CCAPI/cc_api_set_delay_xport:
CallInfo(delay xport=TRUE)
*Sep 22 20:08:50.793: //406/366B47CB83F5/CCAPI/cc_api_call_alert:
Interface=0x8AC020AC, Progress Indication=NULL(0), Signal Indication=SIGNAL RINGBACK(1)
*Sep 22 20:08:50.793: //406/366B47CB83F5/CCAPI/cc_api_call_alert:
Call Entry(Retry Count=0, Responsed=TRUE)
*Sep 22 20:08:50.797: //405/366B47CB83F5/CCAPI/ccCallAlert:
Progress Indication=NULL(0), Signal Indication=SIGNAL RINGBACK(1)
*Sep 22 20:08:50.797: //405/366B47CB83F5/CCAPI/ccCallAlert:
Call Entry(Responsed=TRUE, Alert Sent=TRUE)
*Sep 22 20:08:50.797: //406/366B47CB83F5/CCAPI/cc_api_set_called_ccm_detected:
CallInfo(called ccm detected=TRUE ccmVersion 3)
*Sep 22 20:08:50.797: //406/366B47CB83F5/CCAPI/cc_api_call_notify:
Data Bitmask=0x5, Interface=0x8AC020AC, Call Id=406
*Sep 22 20:08:50.797: //406/366B47CB83F5/CCAPI/cc_api_get_ssCTreRoutingNotSupported:
CallInfo(ssCTreRoutingNotSupported=FALSE)
*Sep 22 20:08:50.797: //406/366B47CB83F5/CCAPI/cc_api_get_ccm_detected:
CallInfo(ccm detected=TRUE)
*Sep 22 20:08:50.797: //405/366B47CB83F5/CCAPI/ccCallNotify:
Data Bitmask=0x5, Call Id=405
*Sep 22 20:08:51.205: //405/366B47CB83F5/CCAPI/cc_api_call_disconnected:
Cause Value=16, Interface=0x8B5FF25C, Call Id=405
*Sep 22 20:08:51.205: //405/366B47CB83F5/CCAPI/cc_api_call_disconnected:
Call Entry(Responsed=TRUE, Cause Value=16, Retry Count=0)
*Sep 22 20:08:51.205: //405/366B47CB83F5/CCAPI/ccGenerateToneInfo:
Stop Tone On Digit=FALSE, Tone=Null,
Tone Direction=Network, Params=0x0, Call Id=405
*Sep 22 20:08:51.205: //406/366B47CB83F5/CCAPI/ccCallDisconnect:
Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
*Sep 22 20:08:51.205: //406/366B47CB83F5/CCAPI/ccCallDisconnect:
Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
*Sep 22 20:08:51.205: //406/366B47CB83F5/CCAPI/cc_api_get_transfer_info:
Transfer Number=NULL
*Sep 22 20:08:51.205: //405/366B47CB83F5/CCAPI/ccCallDisconnect:
Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)
*Sep 22 20:08:51.205: //405/366B47CB83F5/CCAPI/ccCallDisconnect:
Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
*Sep 22 20:08:51.205: //405/366B47CB83F5/CCAPI/cc_api_get_transfer_info:
Transfer Number=NULL
*Sep 22 20:08:51.209: //406/366B47CB83F5/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x8AC020AC, Tag=0x0, Call Id=406,
Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
*Sep 22 20:08:51.209: //406/366B47CB83F5/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
*Sep 22 20:08:51.209: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Sep 22 20:08:51.209: :cc_free_feature_vsa freeing 8C348F98
*Sep 22 20:08:51.209: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Sep 22 20:08:51.209: vsacount in free is 1
*Sep 22 20:08:51.209: //405/366B47CB83F5/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x8B5FF25C, Tag=0x0, Call Id=405,
Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
*Sep 22 20:08:51.209: //405/366B47CB83F5/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
*Sep 22 20:08:51.209: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Sep 22 20:08:51.209: :cc_free_feature_vsa freeing 8C349078
*Sep 22 20:08:51.209: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Sep 22 20:08:51.209: vsacount in free is 0
*Sep 22 20:09:00.613: //-1/3C639A0483FA/CCAPI/cc_api_display_ie_subfields:
cc_api_call_setup_ind_common:
cisco-username=
----- ccCallInfo IE subfields -----
cisco-ani=
cisco-anitype=0
cisco-aniplan=0
cisco-anipi=0
cisco-anisi=0
dest=7301
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

*Sep 22 20:09:00.617: //-1/3C639A0483FA/CCAPI/cc_api_call_setup_ind_common:
Interface=0x8B5FF25C, Call Info(
Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=7301(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=FALSE,
Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=-1
*Sep 22 20:09:00.617: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Sep 22 20:09:00.617: :cc_get_feature_vsa malloc success
*Sep 22 20:09:00.617: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Sep 22 20:09:00.617: cc_get_feature_vsa count is 1
*Sep 22 20:09:00.617: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Sep 22 20:09:00.617: :FEATURE_VSA attributes are: feature_name:0,feature_time:2352255104,feature_id:407
*Sep 22 20:09:00.617: //407/3C639A0483FA/CCAPI/cc_api_call_setup_ind_common:
Set Up Event Sent;
Call Info(Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=7301(TON=Unknown, NPI=Unknown))
*Sep 22 20:09:00.617: //407/3C639A0483FA/CCAPI/cc_process_call_setup_ind:
Event=0x8B592130
*Sep 22 20:09:00.617: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
Try with the demoted called number 7301
*Sep 22 20:09:00.617: //407/3C639A0483FA/CCAPI/ccCallSetContext:
Context=0x88BBF664
*Sep 22 20:09:00.617: //407/3C639A0483FA/CCAPI/cc_process_call_setup_ind:
>>>>CCAPI handed cid 407 with tag 0 to app "_ManagedAppProcess_Default"
*Sep 22 20:09:00.617: //407/3C639A0483FA/CCAPI/ccCallProceeding:
Progress Indication=NULL(0)
*Sep 22 20:09:00.621: //407/3C639A0483FA/CCAPI/ccCallSetupRequest:
Destination=, Calling IE Present=FALSE, Mode=0,
Outgoing Dial-peer=7000, Params=0x88BC0C5C, Progress Indication=ORIGINATING SIDE IS NON ISDN(3)
*Sep 22 20:09:00.621: //407/3C639A0483FA/CCAPI/ccCheckClipClir:
In: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Sep 22 20:09:00.621: //407/3C639A0483FA/CCAPI/ccCheckClipClir:
Out: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Sep 22 20:09:00.621: //407/3C639A0483FA/CCAPI/ccCallSetupRequest:
Destination Pattern=7...$, Called Number=7301, Digit Strip=FALSE
*Sep 22 20:09:00.621: //407/3C639A0483FA/CCAPI/ccCallSetupRequest:
Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=7301(TON=Unknown, NPI=Unknown),
Redirect Number=, Display Info=
Account Number=, Final Destination Flag=TRUE,
Guid=3C639A04-8037-11E6-83FA-83B65075D545, Outgoing Dial-peer=7000
*Sep 22 20:09:00.621: //407/3C639A0483FA/CCAPI/cc_api_display_ie_subfields:
ccCallSetupRequest:
cisco-username=
----- ccCallInfo IE subfields -----
cisco-ani=
cisco-anitype=0
cisco-aniplan=0
cisco-anipi=0
cisco-anisi=0
dest=7301
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

*Sep 22 20:09:00.621: //407/3C639A0483FA/CCAPI/ccIFCallSetupRequestPrivate:
Interface=0x8AC020AC, Interface Type=1, Destination=, Mode=0x0,
Call Params(Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=7301(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
Subscriber Type Str=RegularLine, FinalDestinationFlag=TRUE, Outgoing Dial-peer=7000, Call Count On=FALSE,
Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
*Sep 22 20:09:00.621: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Sep 22 20:09:00.621: :cc_get_feature_vsa malloc success
*Sep 22 20:09:00.621: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Sep 22 20:09:00.621: cc_get_feature_vsa count is 2
*Sep 22 20:09:00.621: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Sep 22 20:09:00.621: :FEATURE_VSA attributes are: feature_name:0,feature_time:2352254880,feature_id:408
*Sep 22 20:09:00.621: //408/3C639A0483FA/CCAPI/ccIFCallSetupRequestPrivate:
SPI Call Setup Request Is Success; Interface Type=1, FlowMode=1
*Sep 22 20:09:00.621: //408/3C639A0483FA/CCAPI/ccCallSetContext:
Context=0x88BC0C0C
*Sep 22 20:09:00.621: //407/3C639A0483FA/CCAPI/ccSaveDialpeerTag:
Outgoing Dial-peer=7000
*Sep 22 20:09:00.621: //408/3C639A0483FA/CCAPI/ccGetMediaClassTag:
media class tag 0
*Sep 22 20:09:00.625: //408/3C639A0483FA/CCAPI/ccSetMediaclassIp2ipTags:
media class tags set: NR 0, ASP 0
*Sep 22 20:09:00.625: //407/3C639A0483FA/CCAPI/ccGetMediaClassTag:
no peer tag found, use the default media class tag
*Sep 22 20:09:00.625: //407/3C639A0483FA/CCAPI/ccSetMediaclassIp2ipTags:
media class tags set: NR 0, ASP 0
*Sep 22 20:09:00.625: //408/3C639A0483FA/CCAPI/ccGet_xc_nr_asp_info:
media class tags: NR 0, ASP 0
*Sep 22 20:09:00.625: //407/3C639A0483FA/CCAPI/ccGet_xc_nr_asp_info:
media class tags: NR 0, ASP 0
*Sep 22 20:09:00.697: //408/3C639A0483FA/CCAPI/cc_api_set_called_ccm_detected:
CallInfo(called ccm detected=TRUE ccmVersion 3)
*Sep 22 20:09:00.697: //408/3C639A0483FA/CCAPI/cc_api_call_proceeding:
Interface=0x8AC020AC, Progress Indication=NULL(0)
*Sep 22 20:09:01.221: //407/3C639A0483FA/CCAPI/cc_api_call_disconnected:
Cause Value=16, Interface=0x8B5FF25C, Call Id=407
*Sep 22 20:09:01.221: //407/3C639A0483FA/CCAPI/cc_api_call_disconnected:
Call Entry(Responsed=FALSE, Cause Value=16, Retry Count=0)
*Sep 22 20:09:01.221: //408/3C639A0483FA/CCAPI/ccCallDisconnect:
Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
*Sep 22 20:09:01.221: //408/3C639A0483FA/CCAPI/ccCallDisconnect:
Cause Value=16, Call Entry(Responsed=FALSE, Cause Value=16)
*Sep 22 20:09:01.221: //408/3C639A0483FA/CCAPI/cc_api_get_transfer_info:
Transfer Number=NULL
*Sep 22 20:09:01.221: //407/3C639A0483FA/CCAPI/ccCallDisconnect:
Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)
*Sep 22 20:09:01.221: //407/3C639A0483FA/CCAPI/ccCallDisconnect:
Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
*Sep 22 20:09:01.221: //407/3C639A0483FA/CCAPI/cc_api_get_transfer_info:
Transfer Number=NULL
*Sep 22 20:09:01.225: //408/3C639A0483FA/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x8AC020AC, Tag=0x0, Call Id=408,
Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
*Sep 22 20:09:01.225: //408/3C639A0483FA/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
*Sep 22 20:09:01.225: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Sep 22 20:09:01.225: :cc_free_feature_vsa freeing 8C348F98
*Sep 22 20:09:01.225: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Sep 22 20:09:01.225: vsacount in free is 1
*Sep 22 20:09:01.229: //407/3C639A0483FA/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x8B5FF25C, Tag=0x0, Call Id=407,
Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
*Sep 22 20:09:01.229: //407/3C639A0483FA/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
*Sep 22 20:09:01.229: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Sep 22 20:09:01.229: :cc_free_feature_vsa freeing 8C349078
*Sep 22 20:09:01.229: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Sep 22 20:09:01.229: vsacount in free is 0

I think that when the phone rings, the dial-peer is correct, but when the message ORIGINATING SIDE IS NON ISDN appears the call fails.

The sh run is:

GW_GARAU#sh run
Building configuration...

Current configuration : 4606 bytes
!
! Last configuration change at 20:52:13 UTC Thu Sep 22 2016 by diadmin
!
version 15.4
no service pad
service timestamps debug datetime msec
service timestamps log datetime msec
no service password-encryption
!
hostname GW_GARAU
!
boot-start-marker
boot-end-marker
!
!
enable password D1as316
!
no aaa new-model
network-clock-participate wic 0
!
!
!
!
!
!
!
!
!
!
ip domain name policia.gov.co
ip cef
no ipv6 cef
!
!
!
!
!
multilink bundle-name authenticated
!
!
!
voice service voip
mode border-element license capacity 50
allow-connections h323 to h323
allow-connections h323 to sip
allow-connections sip to h323
allow-connections sip to sip
no supplementary-service h225-notify cid-update
fax protocol t38 version 0 ls-redundancy 0 hs-redundancy 0 fallback none
sip
bind control source-interface Vlan400
bind media source-interface Vlan400
!
!
!
!
!
voice register global
mode esrst
system message Sistema de Respaldo Activo
max-dn 2
max-pool 2
!
voice register pool 1
id network 172.26.34.0 mask 255.255.255.0
!
!
!
voice-card 0
!
license udi pid C881-V-K9 sn FJC2027L15Y
!
!
username diadmin privilege 15 password 0 D1as316
!
!
!
!
!
ip ssh version 2
!
!
!
!
!
!
!
!
!
!
!
interface BRI1
no ip address
!
interface BRI2
no ip address
!
interface FastEthernet0
switchport access vlan 400
no ip address
!
interface FastEthernet1
no ip address
!
interface FastEthernet2
no ip address
!
interface FastEthernet3
switchport mode trunk
no ip address
!
interface FastEthernet4
ip address 10.0.0.1 255.255.255.252
duplex auto
speed auto
!
interface Vlan1
no ip address
!
interface Vlan400
ip address 172.26.34.214 255.255.255.0
h323-gateway voip interface
h323-gateway voip bind srcaddr 172.26.34.214
!
ip default-gateway 172.26.34.241
ip forward-protocol nd
no ip http server
no ip http secure-server
!
!
ip route 0.0.0.0 0.0.0.0 172.26.34.241
!
!
!
control-plane
!
!
voice-port 1
!
voice-port 2
!
voice-port 3
!
voice-port 4
!
voice-port 5
!
voice-port 6
!
voice-port 7
connection plar 7301
!
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 ccm 172.26.192.225 identifier 1 version 7.0
!
sccp ccm group 1
associate ccm 1 priority 1
associate profile 2 register XCNFR_GARAU
associate profile 1 register XCODE_GARAU
!
ccm-manager music-on-hold
!
!
dspfarm profile 1 transcode
associate application SCCP
shutdown
!
dspfarm profile 2 conference
associate application SCCP
shutdown
!
dial-peer voice 9000 pots
description Llamadas desde PSTN
incoming called-number .
direct-inward-dial
!
dial-peer voice 1000 voip
description Ext_Bog_Cund
destination-pattern 1...$
session target ipv4:172.26.192.225
dtmf-relay h245-alphanumeric rtp-nte
codec g711ulaw
no vad
!
dial-peer voice 2000 voip
description Ext_Sur_Occidente
destination-pattern 2...$
session target ipv4:172.26.192.225
dtmf-relay h245-alphanumeric rtp-nte
codec g711ulaw
no vad
!
dial-peer voice 4000 voip
description Ext_Nor_Occidente
destination-pattern 4...$
session target ipv4:172.26.192.225
dtmf-relay h245-alphanumeric rtp-nte
codec g711ulaw
no vad
!
dial-peer voice 5000 voip
description Ext_Sur_Occidente
destination-pattern 5...$
session target ipv4:172.26.192.225
dtmf-relay h245-alphanumeric rtp-nte
codec g711ulaw
no vad
!
dial-peer voice 6000 voip
description Ext_Eje_Cafetero
destination-pattern 6...$
session target ipv4:172.26.192.225
dtmf-relay h245-alphanumeric rtp-nte
codec g711ulaw
no vad
!
dial-peer voice 7000 voip
description Ext_Nor_Oriente
destination-pattern 7...$
session target ipv4:172.26.192.225
dtmf-relay h245-alphanumeric rtp-nte
codec g711ulaw
no vad
!
dial-peer voice 8000 voip
description Ext_Sur
destination-pattern 8...$
session target ipv4:172.26.192.225
dtmf-relay h245-alphanumeric rtp-nte
codec g711ulaw
no vad
!
dial-peer voice 41000 voip
description Ext_GAMEV
destination-pattern 41..$
session target ipv4:172.26.192.225
dtmf-relay h245-alphanumeric rtp-nte
codec g711ulaw
no vad
!
!
!
call-manager-fallback
secondary-dialtone 9
max-conferences 1 gain -6
transfer-system full-consult
limit-dn 7911 4
timeouts ringing 30
ip source-address 172.26.34.214 port 2000 strict-match
max-ephones 5
max-dn 6 dual-line
system message primary Sistema de Respaldo Activo
transfer-pattern 9T
keepalive 20
no huntstop
call-forward pattern .T
time-zone 17
date-format dd-mm-yy
!
!
line con 0
no modem enable
line aux 0
line vty 0 4
login local
transport input all
!
!
end

GW_GARAU#

Can someboday tell me why is happening that?

[Mohammed al Baqari]

I am bit confused. You said that ephone is ringing. Do you mean that your phones are in SRST mode. Based on the debugs the calls is matching dialpeer 7000 and signaling another system (probably CUCM).

Can you add more clarity on the topology.

[Aseem Anand]

Hi,

As per the running configuration it is sending the call to 72.26.192.225. Is this the IP address of a CUCM or a CME? If its a CUCM server then can you check the region settings between the gateway and the IP phone on CUCM to make sure its G711 and not G729 as it could be a Xcoder issue on CUCM?

Aseem Anand