Missing alerting

[asarkany]

Hi,

We have a migration scenario at customer side.

A Alcatel PBX connected via 2600er voice gateway and Cisco Callmanager.

The PSTN still terminates to the Alcatel and via PRI-trunk the 2600er is connected.

Inbound calls have the problem that there is sometimes alerting missing.

e.g. if there is no sending complete

1) Call via GSM Mobile into this scenario to a extension --> alerting

2) call via PBX into this scenario to a extension --> no alerting

any ideas what is going wrong?

thanks in advance

August

[thusain]

Could you ppost your config and also debug isdn q931 and debug voip ccapi inout of the call that has no alerting.

Regards,

Taimoor

[asarkany]

Hi,

thanks for your answer:

1) debug isdn q931:

weitzer-weiz#

Jun 11 19:59:39.460 MET: ISDN Se1/0:15: RX <- SETUP pd = 8 callref = 0x0276

Jun 11 19:59:39.464 MET: Bearer Capability i = 0x8090A3

Jun 11 19:59:39.464 MET: Channel ID i = 0xA9839C

Jun 11 19:59:39.464 MET: Calling Party Number i = 0x0181, '3169080800', Plan:ISDN, Type:Unknown

Jun 11 19:59:39.468 MET: Called Party Number i = 0xA1, '499', Plan:ISDN, Type:National

Jun 11 19:59:39.468 MET: High Layer Compat i = 0x9181

Jun 11 19:59:39.476 MET: ISDN Se1/0:15: TX -> SETUP_ACK pd = 8 callref = 0x8276

Jun 11 19:59:39.480 MET: Channel ID i = 0xA9839C

weitzer-weiz#

Jun 11 19:59:44.620 MET: ISDN Se1/0:15: TX -> CALL_PROC pd = 8 callref = 0x8276

Jun 11 19:59:44.668 MET: ISDN Se1/0:15: TX -> PROGRESS pd = 8 callref = 0x8276

Jun 11 19:59:44.668 MET: Progress Ind i = 0x8188 - In-band info or appropriate now available

weitzer-weiz#

Jun 11 19:59:52.420 MET: ISDN Se1/0:15: TX -> CONNECT pd = 8 callref = 0x8276

Jun 11 19:59:52.488 MET: ISDN Se1/0:15: RX <- CONNECT_ACK pd = 8 callref = 0x0276

Jun 11 19:59:52.488 MET: Channel ID i = 0xA9839C

Jun 11 19:59:52.492 MET: ISDN Se1/0:15: CALL_PROGRESS: CALL_CONNECTED call id 0x359, bchan 27, dsl 0

weitzer-weiz#

Jun 11 19:59:56.428 MET: ISDN Se1/0:15: RX <- DISCONNECT pd = 8 callref = 0x0276

Jun 11 19:59:56.428 MET: Cause i = 0x8190 - Normal call clearing

Jun 11 19:59:56.432 MET: Progress Ind i = 0x8288 - In-band info or appropriate now available

Jun 11 19:59:56.460 MET: ISDN Se1/0:15: TX -> RELEASE pd = 8 callref = 0x8276

Jun 11 19:59:56.512 MET: ISDN Se1/0:15: RX <- RELEASE_COMP pd = 8 callref = 0x0276

Jun 11 19:59:56.512 MET: Cause i = 0x8190 - Normal call clearing

weitzer-weiz#

2) config voice gateway:

version 12.2

!

!

no ip domain-lookup

!

frame-relay switching

isdn switch-type primary-net5

!

!

voice service voip

!

voice class codec 1

codec preference 1 g711alaw

!

!

!

!

!

!

fax interface-type fax-mail

mta receive maximum-recipients 0

!

controller E1 1/0

pri-group timeslots 1-31

description E1 zu Alcatel Port:VT5-30(PRA2)

!

translation-rule 1

Rule 0 ^0% 1

!

interface Serial1/0:15

description signalling to ALCATEL

no ip address

no logging event link-status

no snmp trap link-status

isdn switch-type primary-net5

isdn overlap-receiving T302 5000

isdn incoming-voice voice

isdn T309-enable

isdn T203 30000

isdn T310 60000

isdn send-alerting

isdn sending-complete

no cdp enable

!

!

call rsvp-sync

!

voice-port 1/0:15

echo-cancel coverage 32

cptone AT

timeouts wait-release infinity

!

!

mgcp profile default

!

dial-peer cor custom

!

!

!

dial-peer voice 1 pots

description ALL OUTGOING CALLS

preference 5

destination-pattern 0T

progress_ind setup enable 3

progress_ind alert enable 8

progress_ind progress enable 8

translate-outgoing called 1

fax rate disable

no digit-strip

direct-inward-dial

port 1/0:15

forward-digits all

!

dial-peer voice 5 voip

huntstop

destination-pattern .T

progress_ind setup enable 3

progress_ind alert enable 8

progress_ind progress enable 8

voice-class codec 1

session target ipv4:172.26.1.1

fax rate disable

no vad

!

dial-peer voice 2 pots

description INTERNAL CALLS

preference 5

destination-pattern .T

progress_ind setup enable 3

progress_ind alert enable 8

progress_ind progress enable 8

fax rate disable

no digit-strip

direct-inward-dial

port 1/0:15

forward-digits all

!

thanks for help

August

[asarkany]

Jun 11 20:01:18.609 MET: cc_api_call_setup_ind (vdbPtr=0x82D489D8, callInfo={called=499,called_oct3=0xA1,calling=3169080800,calling_oct3=0x1,calling_oct3a=0x81,calling_xlated=false,subscriber_type_str=RegularLine,fdest=1,peer_tag=2, prog_ind=0,callingIE_present 1},callID=0x83008CA8)

Jun 11 20:01:18.613 MET: cc_api_call_setup_ind type 13 , prot 0

Jun 11 20:01:18.613 MET: cc_insert_call_entry: Increment call volume counter

Jun 11 20:01:18.613 MET: cc_insert_call_entry: current call volume: 2

Jun 11 20:01:18.613 MET: cc_insert_call_entry: entry's incoming TRUE. is_incoming is TRUE

Jun 11 20:01:18.613 MET: cc_incr_if_call_volume: not the VoIP or MMoIP

Jun 11 20:01:18.617 MET: cc_process_call_setup_ind (event=0x82CE1618)

Jun 11 20:01:18.617 MET: >>>>CCAPI handed cid 5007 with tag 2 to app "DEFAULT"

Jun 11 20:01:18.617 MET: sess_appl: ev(24=CC_EV_CALL_SETUP_IND), cid(5007), disp(0)

Jun 11 20:01:18.617 MET: sess_appl: ev(SSA_EV_CALL_SETUP_IND), cid(5007), disp(0)

Jun 11 20:01:18.617 MET: ssaCallSetupInd

Jun 11 20:01:18.617 MET: ccCallSetContext (callID=0x138F, context=0x82FB0408)

Jun 11 20:01:18.617 MET: ssaCallSetupInd cid(5007), st(SSA_CS_MAPPING),oldst(0), ev(24)ev->e.evCallSetupInd.nCallInfo.finalDestFlag = 1

Jun 11 20:01:18.617 MET: ssaCallSetupInd finalDest cllng(3169080800), clled(499)

Jun 11 20:01:18.621 MET: ssaCallSetupInd cid(5007), st(SSA_CS_CALL_SETTING),oldst(0), ev(24)dpMatchPeersMoreArg result= 0

Jun 11 20:01:18.621 MET: ssaSetupPeer cid(5007) peer list: tag(5) called number (499) tag(2) called number (499)

Jun 11 20:01:18.621 MET: ssaSetupPeer cid(5007), destPat(499), matched(0), prefix(), peer(82ED5388), peer->encapType (2)

Jun 11 20:01:18.621 MET: ccCallSetupRequest (Inbound call = 0x138F, outbound peer =5, dest=, params=0x82CED068 mode=0, *callID=0x82CED498, prog_ind = 3) callingIE_present 1

Jun 11 20:01:18.621 MET: ccCallSetupRequest numbering_type 0xA1

Jun 11 20:01:18.621 MET: ccCallSetupRequest encapType 2 clid_restrict_disable 1 null_orig_clg 0 clid_transparent 0 callingNumber 3169080800

Jun 11 20:01:18.621 MET: dest pattern .T, called 499, digit_strip 0

Jun 11 20:01:18.621 MET: callingNumber=3169080800, calledNumber=499, redirectNumber= display_info= calling_oct3a=81

Jun 11 20:01:18.625 MET: accountNumber=, finalDestFlag=1,

guid=8930.290e.9b6d.11d7.8ccc.8084.caf6.552e

Jun 11 20:01:18.625 MET: peer_tag=5

Jun 11 20:01:18.625 MET: ccIFCallSetupRequestPrivate: (vdbPtr=0x82979108, dest=, callParams={called=499,called_oct3=0xA1, calling=3169080800,calling_oct3=0x1, calling_xlated=false, subscriber_type_str=RegularLine, fdest=1, voice_peer_tag=5},mode=0x0) vdbPtr type = 1

Jun 11 20:01:18.625 MET: ccIFCallSetupRequestPrivate: (vdbPtr=0x82979108, dest=, callParams={called=499, called_oct3 0xA1, calling=3169080800,calling_oct3 0x1, calling_xlated=false, fdest=1, voice_peer_tag=5}, mode=0x0, xltrc=-5)

Jun 11 20:01:18.625 MET: cc_insert_call_entry: not incoming entry

Jun 11 20:01:18.625 MET: cc_insert_call_entry: entry's incoming FALSE. is_incoming is FALSE

Jun 11 20:01:18.625 MET: ccSaveDialpeerTag (callID=0x138F, dialpeer_tag=0x5)

Jun 11 20:01:18.625 MET: ccCallSetContext (callID=0x1390, context=0x82FA2A98)

Jun 11 20:01:18.629 MET: ccCallReportDigits (callID=0x138F, enable=0x0)

Jun 11 20:01:18.629 MET: cc_api_call_report_digits_done (vdbPtr=0x82D489D8, callID=0x138F, disp=0)

Jun 11 20:01:18.629 MET: sess_appl: ev(52=CC_EV_CALL_REPORT_DIGITS_DONE), cid(5007), disp(0)

Jun 11 20:01:18.629 MET: cid(5007)st(SSA_CS_CALL_SETTING)ev(SSA_EV_CALL_REPORT_DIGITS_DONE)

oldst(SSA_CS_MAPPING)cfid(-1)csize(0)in(1)fDest(1)

Jun 11 20:01:18.629 MET: -cid2(5008)st2(SSA_CS_CALL_SETTING)oldst2(SSA_CS_MAPPING)

Jun 11 20:01:18.629 MET: ssaReportDigitsDone cid(5007) peer list: tag(2) called number (499)

Jun 11 20:01:18.629 MET: ssaReportDigitsDone callid=5007 Reporting disabled.

Jun 11 20:01:18.629 MET: cc_api_supported_data data_mode=0x10002

Jun 11 20:01:18.633 MET: cc_incr_if_call_volume: remote IP is 172.26.1.1

Jun 11 20:01:18.633 MET: cc_incr_if_call_volume: hwidb is FastEthernet0/0

Jun 11 20:01:18.633 MET: cc_incr_if_call_volume: added for entry: 2, voip: 2, mmoip: 0

Jun 11 20:01:18.637 MET: ccTDUtilGetInstanceCount: For tagID[1] of callID[5008]

Jun 11 20:01:18.637 MET: ccTDPvtProfileTableObjectAccessManager: No profileTable set for callID[5008]

Jun 11 20:01:18.641 MET: ccTDUtilGetInstanceCount: For tagID[2] of callID[5008]

Jun 11 20:01:18.641 MET: ccTDPvtProfileTableObjectAccessManager: No profileTable set for callID[5008]

Jun 11 20:01:18.769 MET: cc_api_call_proceeding(vdbPtr=0x82979108, callID=0x1390,

prog_ind=0x0, rawmsgPtr=0x0)

Jun 11 20:01:18.769 MET: sess_appl: ev(21=CC_EV_CALL_PROCEEDING), cid(5008), disp(0)

Jun 11 20:01:18.769 MET: cid(5008)st(SSA_CS_CALL_SETTING)ev(SSA_EV_CALL_PROCEEDING)

oldst(SSA_CS_MAPPING)cfid(-1)csize(0)in(0)fDest(0)

Jun 11 20:01:18.773 MET: -cid2(5007)st2(SSA_CS_CALL_SETTING)oldst2(SSA_CS_CALL_SETTING)

Jun 11 20:01:18.773 MET: ssaCallProc

Jun 11 20:01:18.773 MET: ccGetDialpeerTag (callID=0x138F)

Jun 11 20:01:18.773 MET: ccCallProceeding (callID=0x138F, prog_ind=0x0)

Jun 11 20:01:18.773 MET: ssaIgnore cid(5008), st(SSA_CS_CALL_SETTING),oldst(1), ev(21)

Jun 11 20:01:18.821 MET: cc_api_call_cut_progress(vdbPtr=0x82979108, callID=0x1390, prog_ind=0x8, sig_ind=0x1)

Jun 11 20:01:18.821 MET: sess_appl: ev(22=CC_EV_CALL_PROGRESS), cid(5008), disp(0)

Jun 11 20:01:18.825 MET: cid(5008)st(SSA_CS_CALL_SETTING)ev(SSA_EV_CALL_PROGRESS)

oldst(SSA_CS_CALL_SETTING)cfid(-1)csize(0)in(0)fDest(0)

Jun 11 20:01:18.825 MET: -cid2(5007)st2(SSA_CS_CALL_SETTING)oldst2(SSA_CS_CALL_SETTING)

Jun 11 20:01:18.825 MET: ssaCutProgress

Jun 11 20:01:18.825 MET: ccGetDialpeerTag (callID=0x138F)

Jun 11 20:01:18.825 MET: ccCallCutProgress (callID=0x138F, prog_ind=0x8, sig_ind=0x1)

Jun 11 20:01:18.825 MET: ccConferenceCreate (confID=0x82CED514, callID1=0x138F, callID2=0x1390, tag=0x0)

Jun 11 20:01:18.825 MET: cc_api_bridge_done (confID=0x8D1, srcIF=0x82979108, srcCallID=0x1390, dstCallID=0x138F, disposition=0, tag=0x0)

Jun 11 20:01:18.829 MET: cc_api_bridge_done (confID=0x8D1, srcIF=0x82D489D8, srcCallID=0x138F, dstCallID=0x1390, disposition=0, tag=0x0)

Jun 11 20:01:18.829 MET: cc_api_caps_ind (dstVdbPtr=0x82979108, dstCallId=0x1390, srcCallId=0x138F,

caps={codec=0x2887F, fax_rate=0xBF, vad=0x3, modem=0x2

codec_bytes=0, signal_type=3})

Jun 11 20:01:18.829 MET: cc_api_caps_ind (Playout: mode 0, initial 60,min 40, max 300)

Jun 11 20:01:18.829 MET: sess_appl: ev(29=CC_EV_CONF_CREATE_DONE), cid(5007), disp(0)

Jun 11 20:01:18.833 MET: cid(5007)st(SSA_CS_CONFERENCING_PROGRESS)ev(SSA_EV_CONF_CREATE_DONE)

oldst(SSA_CS_CALL_SETTING)cfid(2257)csize(0)in(1)fDest(1)

Jun 11 20:01:18.833 MET: -cid2(5008)st2(SSA_CS_CONFERENCING_PROGRESS)oldst2(SSA_CS_CALL_SETTING)

Jun 11 20:01:18.833 MET: ssaConfCreateDoneAlert

Jun 11 20:01:18.833 MET: cc_process_notify_bridge_done (event=0x82CE1BE8)

Jun 11 20:01:18.921 MET: cc_api_caps_ind (dstVdbPtr=0x82D489D8, dstCallId=0x138F, srcCallId=0x1390,

caps={codec=0x2, fax_rate=0x1, vad=0x1, modem=0x0

codec_bytes=160, signal_type=2})

Jun 11 20:01:18.921 MET: cc_api_caps_ind (Playout: mode 0, initial 60,min 40, max 300)

Jun 11 20:01:18.921 MET: cc_api_caps_ack (dstVdbPtr=0x82D489D8, dstCallId=0x138F, srcCallId=0x1390,

caps={codec=0x2, fax_rate=0x1, vad=0x1, modem=0x0

codec_bytes=160, signal_type=2, seq_num_start=1663})

Jun 11 20:01:18.925 MET: cc_api_caps_ack (dstVdbPtr=0x82979108, dstCallId=0x1390, srcCallId=0x138F,

caps={codec=0x2, fax_rate=0x1, vad=0x1, modem=0x0

codec_bytes=160, signal_type=2, seq_num_start=1663})

Jun 11 20:01:18.925 MET: cc_api_voice_mode_event , callID=0x138F

Jun 11 20:01:18.925 MET: Call Pointer =82FB0408

Jun 11 20:01:18.929 MET: sess_appl: ev(50=CC_EV_VOICE_MODE_DONE), cid(5007), disp(0)

Jun 11 20:01:18.929 MET: cid(5007)st(SSA_CS_CONFERENCED_ALERT)ev(SSA_EV_VOICE_MODE_DONE)

oldst(SSA_CS_CONFERENCING_PROGRESS)cfid(2257)csize(0)in(1)fDest(1)

Jun 11 20:01:18.929 MET: -cid2(5008)st2(SSA_CS_CONFERENCED_ALERT)oldst2(SSA_CS_CALL_SETTING)

Jun 11 20:01:18.929 MET: ssaIgnore cid(5007), st(SSA_CS_CONFERENCED_ALERT),oldst(4), ev(50)

Jun 11 20:01:18.937 MET: cc_api_caps_ind (dstVdbPtr=0x82D489D8, dstCallId=0x138F, srcCallId=0x1390,

caps={codec=0x2, fax_rate=0x1, vad=0x1, modem=0x0

codec_bytes=160, signal_type=2})

Jun 11 20:01:18.937 MET: cc_api_caps_ind (Playout: mode 0, initial 60,min 40, max 300)

Jun 11 20:01:18.937 MET: cc_api_caps_ack (dstVdbPtr=0x82D489D8, dstCallId=0x138F, srcCallId=0x1390,

caps={codec=0x2, fax_rate=0x1, vad=0x1, modem=0x0

codec_bytes=160, signal_type=2, seq_num_start=1663})

Jun 11 20:01:18.941 MET: cc_api_caps_ack (dstVdbPtr=0x82979108, dstCallId=0x1390, srcCallId=0x138F,

caps={codec=0x2, fax_rate=0x1, vad=0x1, modem=0x0

codec_bytes=160, signal_type=2, seq_num_start=1663})

Jun 11 20:01:18.941 MET: cc_api_voice_mode_event , callID=0x138F

Jun 11 20:01:18.941 MET: Call Pointer =82FB0408

Jun 11 20:01:18.941 MET: sess_appl: ev(50=CC_EV_VOICE_MODE_DONE), cid(5007), disp(0)

Jun 11 20:01:18.945 MET: cid(5007)st(SSA_CS_CONFERENCED_ALERT)ev(SSA_EV_VOICE_MODE_DONE)

oldst(SSA_CS_CONFERENCED_ALERT)cfid(2257)csize(0)in(1)fDest(1)

Jun 11 20:01:18.945 MET: -cid2(5008)st2(SSA_CS_CONFERENCED_ALERT)oldst2(SSA_CS_CALL_SETTING)

weitzer-weiz#

Jun 11 20:01:18.945 MET: ssaIgnore cid(5007), st(SSA_CS_CONFERENCED_ALERT),oldst(4), ev(50)

weitzer-weiz#

Jun 11 20:01:26.557 MET: cc_api_call_connected(vdbPtr=0x82979108, callID=0x1390), prog_ind = 0cc_api_call_connected: setting callEntry->connected to TRUE

Jun 11 20:01:26.557 MET: sess_appl: ev(8=CC_EV_CALL_CONNECTED), cid(5008), disp(0)

Jun 11 20:01:26.557 MET: cid(5008)st(SSA_CS_CONFERENCED_ALERT)ev(SSA_EV_CALL_CONNECTED)

oldst(SSA_CS_CALL_SETTING)cfid(2257)csize(0)in(0)fDest(0)

[allan.wells]

voice call send-alert

To enable the terminating gateway to send an alert message instead of a progress message after it receives a call setup message, use the voice call send-alert command in global configuration mode. To restore the default behavior, use the no form of this command.

voice call send-alert

no voice call send-alert

[asarkany]

Thanks.

Most of the alerting troubles are solved now.

The only still existing one is the direction

Alcatel (PBX) user --> IP phone

Is there another failure in the config?

thanks in advance

August / NTS