Solved: Incoming calls not reaching CUCM from SIP trunk

Ahsan Hashmi · ‎05-02-2013

I need your help again.

I am having trouble with landing calls to CUCM i believe.

Outbound calls are perfectly fine. But when i call inbound, call is answered and say " the account is already in use " i believe the calls returns to the service provider.

I have pasted my config and voice ccapi inout logs.

Thanks in advance.

! NVRAM config last updated at 11:27:07 UTC Sun Apr 28 2013 by admin

version 15.1

service timestamps debug datetime msec

service timestamps log datetime msec

no service password-encryption

!

hostname vg

!

boot-start-marker

boot-end-marker

!

card type e1 0 1

card type e1 0 3

logging buffered 51200 warnings

enable secret 4 tnhtc92DXBhelxjYk8LWJrPV36S2i4ntXrpb4RFmfqY

!

no aaa new-model

network-clock-participate wic 1

network-clock-participate wic 3

!

no ipv6 cef

ip source-route

ip cef

!

ip name-server 109.224.14.2

ip name-server 8.8.4.4

multilink bundle-name authenticated

!

isdn switch-type primary-net5

!

crypto pki token default removal timeout 0

!

crypto pki trustpoint TP-self-signed-2352337280

enrollment selfsigned

subject-name cn=IOS-Self-Signed-Certificate-2352337280

revocation-check none

rsakeypair TP-self-signed-2352337280

!

crypto pki certificate chain TP-self-signed-2352337280

certificate self-signed 01

3082022B 30820194 A0030201 02020101 300D0609 2A864886 F70D0101 05050030

31312F30 2D060355 04031326 494F532D 53656C66 2D536967 6E65642D 43657274

69666963 6174652D 32333532 33333732 3830301E 170D3132 30393231 30383136

35395A17 0D323030 31303130 30303030 305A3031 312F302D 06035504 03132649

4F532D53 656C662D 5369676E 65642D43 65727469 66696361 74652D32 33353233

33373238 3030819F 300D0609 2A864886 F70D0101 01050003 818D0030 81890281

8100C099 B93F12CD 4EFA651A A05BE975 53555405 99E120BF 7D6170A0 69A8DB8A

08829258 E8B28DCB 697DDDE9 949CE9AB FAF0757B 4491CFF7 09845D33 C0B7CC30

8075CBA3 E9220155 B7C380B1 D5C00594 748B4738 21D1A314 C6B7FEA4 94F6049C

F2B31AF1 C900C772 40F17730 F3AE3FEF 313C9865 C755564A 15160745 076F6EB8

C2330203 010001A3 53305130 0F060355 1D130101 FF040530 030101FF 301F0603

551D2304 18301680 143CAEF9 ED4CF574 58F5DBE3 96FF4ECC 526A58A1 4D301D06

03551D0E 04160414 3CAEF9ED 4CF57458 F5DBE396 FF4ECC52 6A58A14D 300D0609

2A864886 F70D0101 05050003 81810074 90753884 B9A99263 CE4F9901 6B8E7B58

82662C80 3041198B 9F3C0F4F 3382E81C FBA6AC64 8F0ABE88 3F355461 86296B52

44CDA1FB 74093D48 1746B528 EA584D22 D9F42C77 1B6FAB15 58A0FBDA FCB4D112

AB1E14C6 564A91DE D6B3BF0E FEDFF548 397317C9 8A28BF06 ADD772AC C0D1B810

E817DF5F A0925C97 56FDA2BD 4D48FC

quit

voice-card 0

dspfarm

!

voice service voip

mode border-element

allow-connections h323 to h323

allow-connections h323 to sip

allow-connections sip to h323

allow-connections sip to sip

no supplementary-service sip handle-replaces

fax protocol t38 version 0 ls-redundancy 0 hs-redundancy 0 fallback none

sip

!

voice class codec 1

codec preference 1 g711ulaw

codec preference 2 g711alaw

codec preference 3 g729br8

codec preference 4 g729r8

!

voice translation-rule 10

rule 1 /141458*848374/ /55555/

rule 2 /(+442920003853\)/ /55555/

rule 3 /00442920003853/ /55555/

rule 4 /.*/ /55555/

!

voice translation-rule 11

rule 1 /.*/ /50106/

!

voice translation-profile SIP

translate called 10

!

voice translation-profile test

translate called 11

translate redirect-called 50106

!

license udi pid C3900-SPE150/K9 sn FOC1634B5S5

hw-module pvdm 0/0

!

hw-module pvdm 0/1

!

hw-module sm 3

!

hw-module sm 4

!

redundancy

!

controller E1 0/1/0

framing NO-CRC4

pri-group timeslots 1-31

!

controller E1 0/1/1

!

controller E1 0/3/0

!

controller E1 0/3/1

!

interface Embedded-Service-Engine0/0

no ip address

shutdown

!

interface GigabitEthernet0/0

description $ETH-LAN$$ETH-SW-LAUNCH$$INTF-INFO-GE 0/0$

ip address 172.16.4.2 255.255.254.0

duplex auto

speed auto

!

interface GigabitEthernet0/1

ip address 109.224.23.36 255.255.255.248

duplex auto

speed auto

!

interface GigabitEthernet0/2

no ip address

shutdown

duplex auto

speed auto

!

interface Serial0/1/0:15

no ip address

encapsulation hdlc

isdn switch-type primary-net5

isdn incoming-voice voice

isdn bchan-number-order ascending

no cdp enable

!

ip forward-protocol nd

!

ip http server

ip http authentication local

ip http secure-server

ip http timeout-policy idle 60 life 86400 requests 10000

!

ip route 0.0.0.0 0.0.0.0 109.224.23.33

ip route 66.152.187.165 255.255.255.255 109.224.23.33

ip route 172.16.0.0 255.255.0.0 172.16.4.1

!

nls resp-timeout 1

cpd cr-id 1

!

control-plane

!

call threshold global cpu-avg low 68 high 75

call threshold global total-mem low 75 high 85

!

voice-port 0/0/0

!

voice-port 0/0/1

!

voice-port 0/0/2

!

voice-port 0/0/3

!

voice-port 0/1/0:15

cptone AE

bearer-cap Speech

!

voice-port 0/2/0

!

voice-port 0/2/1

!

voice-port 0/2/2

!

voice-port 0/2/3

!

voice-port 3/0/0

!

voice-port 3/0/1

!

voice-port 3/0/2

!

voice-port 3/0/3

!

voice-port 3/0/4

!

voice-port 3/0/5

!

voice-port 3/0/6

!

voice-port 3/0/7

!

voice-port 4/0/0

!

voice-port 4/0/1

!

voice-port 4/0/2

!

voice-port 4/0/3

!

voice-port 4/0/4

!

voice-port 4/0/5

!

voice-port 4/0/6

!

voice-port 4/0/7

!

no ccm-manager fax protocol cisco

!

mgcp call-agent callmanger 2427 service-type mgcp version 0.1

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 profile default

!

dial-peer voice 2 voip

description *** Outbound Calls ***

destination-pattern .T

session protocol sipv2

session target ipv4:66.152.187.165:5060

voice-class codec 1

dtmf-relay rtp-nte

no vad

!

dial-peer voice 3 voip

description *** Extensions ***

destination-pattern 50106

session protocol sipv2

session target ipv4:172.16.4.10:5060

voice-class codec 1

dtmf-relay rtp-nte

no vad

!

dial-peer voice 100 voip

description *** Incoming Dial-Peer from cucm ***

session protocol sipv2

session target sip-server

incoming called-number .

voice-class codec 1

dtmf-relay rtp-nte

no vad

!

dial-peer voice 101 voip

description *** Incoming Dial-Peer ***

translation-profile incoming test

session protocol sipv2

session target sip-server

incoming called-number 141458*848374

voice-class codec 1

dtmf-relay rtp-nte

no vad

!

gateway

timer receive-rtp 1200

!

sip-ua

credentials username 141458*848374 password 7 040259xxxx realm 66.152.187.165

authentication username 141458*848374 password 7 10175Bxxxx

registrar dns:sip1.catiphone.com expires 3600

sip-server dns:sip1.catiphone.com

!

gatekeeper

shutdown

!

telephony-service

max-conferences 8 gain -6

transfer-system full-consult

!

banner exec ^C

--------------------- Debug voice CCAPI INOUT ------------------------------------------------

May 2 12:21:18.104: //-1/A004F23983FF/CCAPI/cc_api_display_ie_subfields:

cc_api_call_setup_ind_common:

cisco-username=001111

----- ccCallInfo IE subfields -----

cisco-ani=001111

cisco-anitype=0

cisco-aniplan=0

cisco-anipi=0

cisco-anisi=0

dest=141458*848374

cisco-desttype=0

cisco-destplan=0

cisco-rdie=74

cisco-rdn=+442920003853

cisco-rdntype=0

cisco-rdnplan=0

cisco-rdnpi=0

cisco-rdnsi=0

cisco-redirectreason=15 fwd_final_type =0

final_redirectNumber =

hunt_group_timeout =0

May 2 12:21:18.104: //-1/A004F23983FF/CCAPI/cc_api_call_setup_ind_common:

Interface=0x13652174, Call Info(

Calling Number=001111,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

Called Number=141458*848374(TON=Unknown, NPI=Unknown),

Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,

Incoming Dial-peer=101, Progress Indication=NULL(0), Calling IE Present=TRUE,

Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=20013

May 2 12:21:18.104: //-1/A004F23983FF/CCAPI/ccCheckClipClir:

In: Calling Number=001111(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

May 2 12:21:18.104: //-1/A004F23983FF/CCAPI/ccCheckClipClir:

Out: Calling Number=001111(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

May 2 12:21:18.104: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

May 2 12:21:18.104: :cc_get_feature_vsa malloc success

May 2 12:21:18.104: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

May 2 12:21:18.104: cc_get_feature_vsa count is 1

May 2 12:21:18.104: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

May 2 12:21:18.104: :FEATURE_VSA attributes are: feature_name:0,feature_time:337841208,feature_id:1591

May 2 12:21:18.104: //20013/A004F23983FF/CCAPI/cc_api_call_setup_ind_common:

Set Up Event Sent;

Call Info(Calling Number=001111(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

Called Number=141458*848374(TON=Unknown, NPI=Unknown))

May 2 12:21:18.108: //20013/A004F23983FF/CCAPI/cc_process_call_setup_ind:

Event=0x13B92FF8

May 2 12:21:18.108: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:

Try with the demoted called number 141458*848374

May 2 12:21:18.108: //20013/A004F23983FF/CCAPI/ccCallSetContext:

Context=0x12F25918

May 2 12:21:18.108: //20013/A004F23983FF/CCAPI/cc_process_call_setup_ind:

>>>>CCAPI handed cid 20013 with tag 101 to app "_ManagedAppProcess_Default"

May 2 12:21:18.108: //20013/A004F23983FF/CCAPI/ccCallProceeding:

Progress Indication=NULL(0)

May 2 12:21:18.108: //20013/A004F23983FF/CCAPI/ccCallSetupRequest:

Destination=, Calling IE Present=TRUE, Mode=0,

Outgoing Dial-peer=3, Params=0x12F2AC68, Progress Indication=NULL(0)

May 2 12:21:18.108: //20013/A004F23983FF/CCAPI/ccCheckClipClir:

In: Calling Number=001111(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

May 2 12:21:18.108: //20013/A004F23983FF/CCAPI/ccCheckClipClir:

Out: Calling Number=001111(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

May 2 12:21:18.108: //20013/A004F23983FF/CCAPI/ccCallSetupRequest:

Destination Pattern=50106, Called Number=50106, Digit Strip=FALSE

May 2 12:21:18.108: //20013/A004F23983FF/CCAPI/ccCallSetupRequest:

Calling Number=001111(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

Called Number=50106(TON=Unknown, NPI=Unknown),

Redirect Number=+442920003853, Display Info=001111

Account Number=001111, Final Destination Flag=TRUE,

Guid=A004F239-B259-11E2-83FF-C8537EAB7692, Outgoing Dial-peer=3

May 2 12:21:18.108: //20013/A004F23983FF/CCAPI/cc_api_display_ie_subfields:

ccCallSetupRequest:

cisco-username=001111

----- ccCallInfo IE subfields -----

cisco-ani=001111

cisco-anitype=0

cisco-aniplan=0

cisco-anipi=0

cisco-anisi=0

dest=50106

cisco-desttype=0

cisco-destplan=0

cisco-rdie=74

cisco-rdn=+442920003853

cisco-rdntype=0

cisco-rdnplan=0

cisco-rdnpi=0

cisco-rdnsi=0

cisco-redirectreason=15 fwd_final_type =0

final_redirectNumber =

hunt_group_timeout =0

May 2 12:21:18.108: //20013/A004F23983FF/CCAPI/ccIFCallSetupRequestPrivate:

Interface=0x13652174, Interface Type=3, Destination=, Mode=0x0,

Call Params(Calling Number=001111,(Calling Name=001111)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

Called Number=50106(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,

Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=3, Call Count On=FALSE,

Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)

May 2 12:21:18.108: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

May 2 12:21:18.108: :cc_get_feature_vsa malloc success

May 2 12:21:18.108: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

May 2 12:21:18.108: cc_get_feature_vsa count is 2

May 2 12:21:18.108: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

May 2 12:21:18.108: :FEATURE_VSA attributes are: feature_name:0,feature_time:337841880,feature_id:1592

May 2 12:21:18.108: //20014/A004F23983FF/CCAPI/ccIFCallSetupRequestPrivate:

SPI Call Setup Request Is Success; Interface Type=3, FlowMode=1

May 2 12:21:18.108: //20014/A004F23983FF/CCAPI/ccCallSetContext:

Context=0x12F2AC18

May 2 12:21:18.108: //20013/A004F23983FF/CCAPI/ccSaveDialpeerTag:

Outgoing Dial-peer=3

May 2 12:21:18.108: //20014/A004F23983FF/CCAPI/cc_api_call_proceeding:

Interface=0x13652174, Progress Indication=NULL(0)

May 2 12:21:18.112: //20014/A004F23983FF/CCAPI/cc_api_call_disconnected:

Cause Value=63, Interface=0x13652174, Call Id=20014

May 2 12:21:18.112: //20014/A004F23983FF/CCAPI/cc_api_call_disconnected:

Call Entry(Responsed=TRUE, Cause Value=63, Retry Count=0)

May 2 12:21:18.112: //20013/A004F23983FF/CCAPI/ccCallReleaseResources:

release reserved xcoding resource.

May 2 12:21:18.112: //20014/A004F23983FF/CCAPI/ccCallSetAAA_Accounting:

Accounting=1, Call Id=20014

May 2 12:21:18.112: //20014/A004F23983FF/CCAPI/ccCallDisconnect:

Cause Value=63, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=63)

May 2 12:21:18.112: //20014/A004F23983FF/CCAPI/ccCallDisconnect:

Cause Value=63, Call Entry(Responsed=TRUE, Cause Value=63)

May 2 12:21:18.112: //20014/A004F23983FF/CCAPI/cc_api_call_disconnect_done:

Disposition=0, Interface=0x13652174, Tag=0x0, Call Id=20014,

Call Entry(Disconnect Cause=63, Voice Class Cause Code=0, Retry Count=0)

May 2 12:21:18.112: //20014/A004F23983FF/CCAPI/cc_api_call_disconnect_done:

Call Disconnect Event Sent

May 2 12:21:18.112: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

May 2 12:21:18.112: :cc_free_feature_vsa freeing 14230ED0

May 2 12:21:18.112: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

May 2 12:21:18.112: vsacount in free is 1

May 2 12:21:18.112: //20013/A004F23983FF/CCAPI/ccCallSetupRequest:

Destination=, Calling IE Present=TRUE, Mode=0,

Outgoing Dial-peer=2, Params=0x16ED8A60, Progress Indication=NULL(0)

May 2 12:21:18.112: //20013/A004F23983FF/CCAPI/ccCheckClipClir:

In: Calling Number=001111(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

May 2 12:21:18.112: //20013/A004F23983FF/CCAPI/ccCheckClipClir:

Out: Calling Number=001111(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

May 2 12:21:18.112: //20013/A004F23983FF/CCAPI/ccCallSetupRequest:

Destination Pattern=.T, Called Number=50106, Digit Strip=FALSE

May 2 12:21:18.112: //20013/A004F23983FF/CCAPI/ccCallSetupRequest:

Calling Number=001111(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

Called Number=50106(TON=Unknown, NPI=Unknown),

Redirect Number=+442920003853, Display Info=001111

Account Number=001111, Final Destination Flag=TRUE,

Guid=A004F239-B259-11E2-83FF-C8537EAB7692, Outgoing Dial-peer=2

May 2 12:21:18.112: //20013/A004F23983FF/CCAPI/cc_api_display_ie_subfields:

ccCallSetupRequest:

cisco-username=001111

----- ccCallInfo IE subfields -----

cisco-ani=001111

cisco-anitype=0

cisco-aniplan=0

cisco-anipi=0

cisco-anisi=0

dest=50106

cisco-desttype=0

cisco-destplan=0

cisco-rdie=74

cisco-rdn=+442920003853

cisco-rdntype=0

cisco-rdnplan=0

cisco-rdnpi=0

cisco-rdnsi=0

cisco-redirectreason=15 fwd_final_type =0

final_redirectNumber =

hunt_group_timeout =0

May 2 12:21:18.112: //20013/A004F23983FF/CCAPI/ccIFCallSetupRequestPrivate:

Interface=0x13652174, Interface Type=3, Destination=, Mode=0x0,

Call Params(Calling Number=001111,(Calling Name=001111)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

Called Number=50106(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,

Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=2, Call Count On=FALSE,

Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)

May 2 12:21:18.112: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

May 2 12:21:18.112: :cc_get_feature_vsa malloc success

May 2 12:21:18.112: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

vg(cfg-translation-profile)#

May 2 12:21:18.112: cc_get_feature_vsa count is 2

May 2 12:21:18.112: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

May 2 12:21:18.112: :FEATURE_VSA attributes are: feature_name:0,feature_time:337841880,feature_id:1593

May 2 12:21:18.112: //20015/A004F23983FF/CCAPI/ccIFCallSetupRequestPrivate:

SPI Call Setup Request Is Success; Interface Type=3, FlowMode=1

May 2 12:21:18.112: //20015/A004F23983FF/CCAPI/ccCallSetContext:

Context=0x16ED8A10

May 2 12:21:18.112: //20013/A004F23983FF/CCAPI/ccSaveDialpeerTag:

Outgoing Dial-peer=2

May 2 12:21:18.112: //20015/A004F23983FF/CCAPI/cc_api_call_proceeding:

Interface=0x13652174, Progress Indication=NULL(0)

May 2 12:21:18.848: //20015/A004F23983FF/CCAPI/cc_api_caps_ind:

Destination Interface=0x0, Destination Call Id=-1, Source Call Id=20015,

Caps(Codec=0x4, Fax Rate=0x2, Vad=0x2,

Modem=0x0, Codec Bytes=20, Signal Type=2)

May 2 12:21:18.848: //20015/A004F23983FF/CCAPI/cc_api_caps_ind:

Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms),

Playout Max=1000(ms), Fax Nom=300(ms))

May 2 12:21:18.848: //20013/A004F23983FF/CCAPI/cc_api_caps_ack:

Destination Interface=0x0, Destination Call Id=-1, Source Call Id=20013,

Caps(Codec=g729r8(0x4), Fax Rate=FAX_RATE_VOICE(0x2), Vad=OFF(0x1),

Modem=OFF(0x0), Codec Bytes=20, Signal Type=2, Seq Num Start=1)

May 2 12:21:18.848: //20013/A004F23983FF/CCAPI/cc_api_caps_ack:

Destination Interface=0x0, Destination Call Id=-1, Source Call Id=20013,

Caps(Codec=g729r8(0x4), Fax Rate=FAX_RATE_VOICE(0x2), Vad=OFF(0x1),

Modem=OFF(0x0), Codec Bytes=20, Signal Type=2, Seq Num Start=1)

May 2 12:21:18.848: //20015/A004F23983FF/CCAPI/cc_api_event_indication:

Event=171, Call Id=20015

May 2 12:21:18.848: //20015/A004F23983FF/CCAPI/cc_api_event_indication:

Event Is Sent To Conferenced SPI(s) Directly

May 2 12:21:18.848: //20015/A004F23983FF/CCAPI/cc_api_event_indication:

Event=98, Call Id=20015

May 2 12:21:18.848: //20015/A004F23983FF/CCAPI/cc_api_event_indication:

Event Is Sent To Conferenced SPI(s) Directly

May 2 12:21:18.848: //20015/A004F23983FF/CCAPI/cc_api_call_cut_progress:

Interface=0x13652174, Progress Indication=INBAND(8), Signal Indication=SIGNAL RINGBACK(1),

Cause Value=0

May 2 12:21:18.848: //20015/A004F23983FF/CCAPI/cc_api_call_cut_progress:

Call Entry(Responsed=TRUE)

May 2 12:21:18.848: //20013/A004F23983FF/CCAPI/ccCallCutProgress:

Progress Indication=INBAND(8), Signal Indication=SIGNAL RINGBACK(1), Cause Value=0

Voice Call Send Alert=FALSE, Call Entry(Alert Sent=FALSE)

May 2 12:21:18.848: //20013/A004F23983FF/CCAPI/ccCallCutProgress:

Call Entry(Responsed=TRUE)

May 2 12:21:18.848: //20013/A004F23983FF/CCAPI/ccConferenceCreate:

(confID=0x12C6420C, callID1=0x4E2D, gcid=A004F239-B25911E2-8402C853-7EAB7692, tag=0x0)

May 2 12:21:18.848: //20015/A004F23983FF/CCAPI/ccConferenceCreate:

(confID=0x12C6420C, callID2=0x4E2F, gcid=A004F239-B25911E2-8402C853-7EAB7692, tag=0x0)

May 2 12:21:18.848: //20013/A004F23983FF/CCAPI/ccConferenceCreate:

Conference Id=0x12C6420C, Call Id1=20013, Call Id2=20015, Tag=0x0

May 2 12:21:18.848: //20013/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

May 2 12:21:18.848: cc_api_get_xcode_stream : 4702

May 2 12:21:18.848: //20015/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

May 2 12:21:18.848: cc_api_get_xcode_stream : 4702

May 2 12:21:18.848: //20013/A004F23983FF/CCAPI/ccConferenceCreate:

May 2 12:21:18.848: ccConferenceCreate: ret1=0, codecMask1=4, bytes1=20, negot1=1, dtmf1=6

ret2=0, codecMask2=4, bytes2=20, negot2=1, dtmf2=6,

tx_dynamic_pt1=18, rx_dynamic_pt1=18, codec_mode1=0, params_bitmap1 =0

tx_dynamic_pt2=18, rx_dynamic_pt2=18, codec_mode2=0, params_bitmap2 =0

May 2 12:21:18.848: //20013/A004F23983FF/CCAPI/ccConferenceCreate:

delay media to slow start case, codec negotation is not done

May 2 12:21:18.848: //20013/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

May 2 12:21:18.848: cc_api_get_xcode_stream : 4702

May 2 12:21:18.848: //20013/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

May 2 12:21:18.848: cc_api_get_xcode_stream : 4702

May 2 12:21:18.848: //20013/A004F23983FF/CCAPI/cc_api_bridge_done:

Conference Id=0xEB, Source Interface=0x13652174, Source Call Id=20013,

Destination Call Id=20015, Disposition=0x0, Tag=0x0

May 2 12:21:18.848: //20015/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

May 2 12:21:18.848: cc_api_get_xcode_stream : 4702

May 2 12:21:18.848: //20015/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

May 2 12:21:18.848: cc_api_get_xcode_stream : 4702

May 2 12:21:18.848: //20015/A004F23983FF/CCAPI/cc_api_bridge_done:

Conference Id=0xEB, Source Interface=0x13652174, Source Call Id=20015,

Destination Call Id=20013, Disposition=0x0, Tag=0x0

May 2 12:21:18.848: //20013/A004F23983FF/CCAPI/cc_generic_bridge_done:

Conference Id=0xEB, Source Interface=0x13652174, Source Call Id=20015,

Destination Call Id=20013, Disposition=0x0, Tag=0x0

May 2 12:21:18.848: //20013/A004F23983FF/CCAPI/ccConferenceCreate:

Call Entry(Conference Id=0xEB, Destination Call Id=20015)

May 2 12:21:18.848: //20015/A004F23983FF/CCAPI/ccConferenceCreate:

Call Entry(Conference Id=0xEB, Destination Call Id=20013)

vg(cfg-translation-profile)#

May 2 12:21:18.848: //20013/A004F23983FF/CCAPI/cc_process_notify_bridge_done:

Conference Id=0xEB, Call Id1=20013, Call Id2=20015

vg(cfg-translation-profile)#

May 2 12:21:21.616: //20015/A004F23983FF/CCAPI/cc_api_call_disconnected:

Cause Value=21, Interface=0x13652174, Call Id=20015

May 2 12:21:21.616: //20015/A004F23983FF/CCAPI/cc_api_call_disconnected:

Call Entry(Responsed=TRUE, Cause Value=21, Retry Count=0)

May 2 12:21:21.616: //20013/A004F23983FF/CCAPI/ccCallReleaseResources:

release reserved xcoding resource.

May 2 12:21:21.616: //20015/A004F23983FF/CCAPI/ccCallSetAAA_Accounting:

Accounting=0, Call Id=20015

May 2 12:21:21.616: //20013/A004F23983FF/CCAPI/ccConferenceDestroy:

Conference Id=0xEB, Tag=0x0

May 2 12:21:21.616: //20013/A004F23983FF/CCAPI/cc_api_bridge_drop_done:

Conference Id=0xEB, Source Interface=0x13652174, Source Call Id=20013,

Destination Call Id=20015, Disposition=0x0, Tag=0x0

May 2 12:21:21.616: //20015/A004F23983FF/CCAPI/cc_api_bridge_drop_done:

Conference Id=0xEB, Source Interface=0x13652174, Source Call Id=20015,

Destination Call Id=20013, Disposition=0x0, Tag=0x0

May 2 12:21:21.616: //20013/A004F23983FF/CCAPI/cc_generic_bridge_done:

Conference Id=0xEB, Source Interface=0x13652174, Source Call Id=20015,

Destination Call Id=20013, Disposition=0x0, Tag=0x0

May 2 12:21:21.616: //20015/A004F23983FF/CCAPI/ccCallDisconnect:

Cause Value=21, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=21)

May 2 12:21:21.616: //20015/A004F23983FF/CCAPI/ccCallDisconnect:

Cause Value=21, Call Entry(Responsed=TRUE, Cause Value=21)

May 2 12:21:21.616: //20015/A004F23983FF/CCAPI/cc_api_call_disconnect_done:

Disposition=0, Interface=0x13652174, Tag=0x0, Call Id=20015,

Call Entry(Disconnect Cause=21, Voice Class Cause Code=0, Retry Count=0)

May 2 12:21:21.616: //20015/A004F23983FF/CCAPI/cc_api_call_disconnect_done:

Call Disconnect Event Sent

May 2 12:21:21.616: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

May 2 12:21:21.616: :cc_free_feature_vsa freeing 14230ED0

May 2 12:21:21.616: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

May 2 12:21:21.616: vsacount in free is 1

May 2 12:21:21.616: //20013/A004F23983FF/CCAPI/ccCallDisconnect:

Cause Value=21, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)

May 2 12:21:21.616: //20013/A004F23983FF/CCAPI/ccCallDisconnect:

Cause Value=21, Call Entry(Responsed=TRUE, Cause Value=21)

May 2 12:21:21.880: //20013/A004F23983FF/CCAPI/cc_api_call_disconnect_done:

Disposition=0, Interface=0x13652174, Tag=0x0, Call Id=20013,

Call Entry(Disconnect Cause=21, Voice Class Cause Code=0, Retry Count=0)

May 2 12:21:21.880: //20013/A004F23983FF/CCAPI/cc_api_call_disconnect_done:

Call Disconnect Event Sent

vg(cfg-translation-profile)#

May 2 12:21:21.880: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

May 2 12:21:21.880: :cc_free_feature_vsa freeing 14230C30

May 2 12:21:21.880: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

May 2 12:21:21.880: vsacount in free is 0

vg(cfg-translation-profile)#

Ayodeji Okanlawon · ‎05-03-2013

Ahsan,

CUCM is sending this error to the CUBE...

"Warning: 399 callmanger "Unable to find a device handler for the request received on port 62116 from 172.16.4.2"

Usually when you get that error it is indicative of three things..

1. Wrong Ip address configured on the sip trunk. is 172.16.4.2 the ip address on the sip trunk?

2. The CUCM server your dial-peer points to is not in the CUCM group of the sip trunk (and you dont have "route on all active nodes" checked (if your version supports it)----

3. Incorrect bind config.....

Please check the first two points above...The 3rd point doesnt seem to be an issue because I can see the CUBE sending call out the local interface to CUCM

Please rate all useful posts

"opportunity is a haughty goddess who waste no time with those who are unprepared"

Please rate all useful posts

View solution in original post

Ayodeji Okanlawon · ‎05-03-2013

Ahsan,

Please reset the sip trunk..Then test again and send debug ccsip messages.

Please rate all useful posts

"opportunity is a haughty goddess who waste no time with those who are unprepared"

Please rate all useful posts

View solution in original post

Ayodeji Okanlawon · ‎05-02-2013

From the logs the call initially was sent out via dial-peer 3 to 172.16.4.10 and that failed..Then the gateway sent the call to dial-peer 2..which is your service provider...

Please do another test call and send

debug ccsip messages

debug voip ccapi inout

Please rate all useful posts

"opportunity is a haughty goddess who waste no time with those who are unprepared"

Please rate all useful posts

Ahsan Hashmi · ‎05-03-2013

--------------------Debug voip ccapi inout----------------------------

cc_api_call_setup_ind_common:

cisco-username=001111

----- ccCallInfo IE subfields -----

cisco-ani=001111

cisco-anitype=0

cisco-aniplan=0

cisco-anipi=0

cisco-anisi=0

dest=141458*848374

cisco-desttype=0

cisco-destplan=0

cisco-rdie=74

cisco-rdn=+442920003853

cisco-rdntype=0

cisco-rdnplan=0

cisco-rdnpi=0

cisco-rdnsi=0

cisco-redirectreason=15 fwd_final_type =0

final_redirectNumber =

hunt_group_timeout =0

May 3 12:10:10.090: //-1/3C43DCA88CAA/CCAPI/cc_api_call_setup_ind_common:

Interface=0x13652174, Call Info(

Calling Number=001111,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

Called Number=141458*848374(TON=Unknown, NPI=Unknown),

Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,

Incoming Dial-peer=101, Progress Indication=NULL(0), Calling IE Present=TRUE,

Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=21678

May 3 12:10:10.090: //-1/3C43DCA88CAA/CCAPI/ccCheckClipClir:

In: Calling Number=001111(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

May 3 12:10:10.090: //-1/3C43DCA88CAA/CCAPI/ccCheckClipClir:

Out: Calling Number=001111(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

May 3 12:10:10.090: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

May 3 12:10:10.090: :cc_get_feature_vsa malloc success

May 3 12:10:10.090: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

May 3 12:10:10.090: cc_get_feature_vsa count is 1

May 3 12:10:10.090: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

May 3 12:10:10.090: :FEATURE_VSA attributes are: feature_name:0,feature_time:337842104,feature_id:1803

May 3 12:10:10.090: //21678/3C43DCA88CAA/CCAPI/cc_api_call_setup_ind_common:

Set Up Event Sent;

Call Info(Calling Number=001111(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

Called Number=141458*848374(TON=Unknown, NPI=Unknown))

May 3 12:10:10.090: //21678/3C43DCA88CAA/CCAPI/cc_process_call_setup_ind:

Event=0x13B92FF8

May 3 12:10:10.090: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:

Try with the demoted called number 141458*848374

May 3 12:10:10.090: //21678/3C43DCA88CAA/CCAPI/ccCallSetContext:

Context=0x16DCD110

May 3 12:10:10.090: //21678/3C43DCA88CAA/CCAPI/cc_process_call_setup_ind:

>>>>CCAPI handed cid 21678 with tag 101 to app "_ManagedAppProcess_Default"

May 3 12:10:10.090: //21678/3C43DCA88CAA/CCAPI/ccCallProceeding:

Progress Indication=NULL(0)

May 3 12:10:10.090: //21678/3C43DCA88CAA/CCAPI/ccCallSetupRequest:

Destination=, Calling IE Present=TRUE, Mode=0,

Outgoing Dial-peer=3, Params=0x16DD0FA0, Progress Indication=NULL(0)

May 3 12:10:10.090: //21678/3C43DCA88CAA/CCAPI/ccCheckClipClir:

In: Calling Number=001111(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

May 3 12:10:10.090: //21678/3C43DCA88CAA/CCAPI/ccCheckClipClir:

Out: Calling Number=001111(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

May 3 12:10:10.094: //21678/3C43DCA88CAA/CCAPI/ccCallSetupRequest:

Destination Pattern=50106, Called Number=50106, Digit Strip=FALSE

May 3 12:10:10.094: //21678/3C43DCA88CAA/CCAPI/ccCallSetupRequest:

Calling Number=001111(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

Called Number=50106(TON=Unknown, NPI=Unknown),

Redirect Number=+442920003853, Display Info=001111

Account Number=001111, Final Destination Flag=TRUE,

Guid=3C43DCA8-B321-11E2-8CAA-C8537EAB7692, Outgoing Dial-peer=3

May 3 12:10:10.094: //21678/3C43DCA88CAA/CCAPI/cc_api_display_ie_subfields:

ccCallSetupRequest:

cisco-username=001111

----- ccCallInfo IE subfields -----

cisco-ani=001111

cisco-anitype=0

cisco-aniplan=0

cisco-anipi=0

cisco-anisi=0

dest=50106

cisco-desttype=0

cisco-destplan=0

cisco-rdie=74

cisco-rdn=+442920003853

cisco-rdntype=0

cisco-rdnplan=0

cisco-rdnpi=0

cisco-rdnsi=0

cisco-redirectreason=15 fwd_final_type =0

final_redirectNumber =

hunt_group_timeout =0

May 3 12:10:10.094: //21678/3C43DCA88CAA/CCAPI/ccIFCallSetupRequestPrivate:

Interface=0x13652174, Interface Type=3, Destination=, Mode=0x0,

Call Params(Calling Number=001111,(Calling Name=001111)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

Called Number=50106(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,

Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=3, Call Count On=FALSE,

Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)

May 3 12:10:10.094: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

May 3 12:10:10.094: :cc_get_feature_vsa malloc success

May 3 12:10:10.094: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

May 3 12:10:10.094: cc_get_feature_vsa count is 2

May 3 12:10:10.094: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

May 3 12:10:10.094: :FEATURE_VSA attributes are: feature_name:0,feature_time:337841880,feature_id:1804

May 3 12:10:10.094: //21679/3C43DCA88CAA/CCAPI/ccIFCallSetupRequestPrivate:

SPI Call Setup Request Is Success; Interface Type=3, FlowMode=1

May 3 12:10:10.094: //21679/3C43DCA88CAA/CCAPI/ccCallSetContext:

Context=0x16DD0F50

May 3 12:10:10.094: //21678/3C43DCA88CAA/CCAPI/ccSaveDialpeerTag:

Outgoing Dial-peer=3

May 3 12:10:10.094: //21679/3C43DCA88CAA/CCAPI/cc_api_call_proceeding:

Interface=0x13652174, Progress Indication=NULL(0)

May 3 12:10:10.098: //21679/3C43DCA88CAA/CCAPI/cc_api_call_disconnected:

Cause Value=63, Interface=0x13652174, Call Id=21679

May 3 12:10:10.098: //21679/3C43DCA88CAA/CCAPI/cc_api_call_disconnected:

Call Entry(Responsed=TRUE, Cause Value=63, Retry Count=0)

May 3 12:10:10.098: //21678/3C43DCA88CAA/CCAPI/ccCallReleaseResources:

release reserved xcoding resource.

May 3 12:10:10.098: //21679/3C43DCA88CAA/CCAPI/ccCallSetAAA_Accounting:

Accounting=1, Call Id=21679

May 3 12:10:10.098: //21679/3C43DCA88CAA/CCAPI/ccCallDisconnect:

Cause Value=63, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=63)

May 3 12:10:10.098: //21679/3C43DCA88CAA/CCAPI/ccCallDisconnect:

Cause Value=63, Call Entry(Responsed=TRUE, Cause Value=63)

May 3 12:10:10.098: //21679/3C43DCA88CAA/CCAPI/cc_api_call_disconnect_done:

Disposition=0, Interface=0x13652174, Tag=0x0, Call Id=21679,

Call Entry(Disconnect Cause=63, Voice Class Cause Code=0, Retry Count=0)

May 3 12:10:10.098: //21679/3C43DCA88CAA/CCAPI/cc_api_call_disconnect_done:

Call Disconnect Event Sent

May 3 12:10:10.098: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

May 3 12:10:10.098: :cc_free_feature_vsa freeing 14230ED0

May 3 12:10:10.098: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

May 3 12:10:10.098: vsacount in free is 1

May 3 12:10:10.098: //21678/3C43DCA88CAA/CCAPI/ccCallSetupRequest:

Destination=, Calling IE Present=TRUE, Mode=0,

Outgoing Dial-peer=2, Params=0x16DCE620, Progress Indication=NULL(0)

May 3 12:10:10.098: //21678/3C43DCA88CAA/CCAPI/ccCheckClipClir:

In: Calling Number=001111(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

May 3 12:10:10.098: //21678/3C43DCA88CAA/CCAPI/ccCheckClipClir:

Out: Calling Number=001111(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

May 3 12:10:10.098: //21678/3C43DCA88CAA/CCAPI/ccCallSetupRequest:

Destination Pattern=.T, Called Number=50106, Digit Strip=FALSE

May 3 12:10:10.098: //21678/3C43DCA88CAA/CCAPI/ccCallSetupRequest:

Calling Number=001111(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

Called Number=50106(TON=Unknown, NPI=Unknown),

Redirect Number=+442920003853, Display Info=001111

Account Number=001111, Final Destination Flag=TRUE,

Guid=3C43DCA8-B321-11E2-8CAA-C8537EAB7692, Outgoing Dial-peer=2

May 3 12:10:10.098: //21678/3C43DCA88CAA/CCAPI/cc_api_display_ie_subfields:

ccCallSetupRequest:

cisco-username=001111

----- ccCallInfo IE subfields -----

cisco-ani=001111

cisco-anitype=0

cisco-aniplan=0

cisco-anipi=0

cisco-anisi=0

dest=50106

cisco-desttype=0

cisco-destplan=0

cisco-rdie=74

cisco-rdn=+442920003853

cisco-rdntype=0

cisco-rdnplan=0

cisco-rdnpi=0

cisco-rdnsi=0

cisco-redirectreason=15 fwd_final_type =0

final_redirectNumber =

hunt_group_timeout =0

May 3 12:10:10.098: //21678/3C43DCA88CAA/CCAPI/ccIFCallSetupRequestPrivate:

Interface=0x13652174, Interface Type=3, Destination=, Mode=0x0,

Call Params(Calling Number=001111,(Calling Name=001111)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

Called Number=50106(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,

Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=2, Call Count On=FALSE,

Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)

May 3 12:10:10.098: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

May 3 12:10:10.098: :cc_get_feature_vsa malloc success

May 3 12:10:10.098: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

vg#

May 3 12:10:10.098: cc_get_feature_vsa count is 2

May 3 12:10:10.098: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

May 3 12:10:10.098: :FEATURE_VSA attributes are: feature_name:0,feature_time:337841880,feature_id:1805

May 3 12:10:10.098: //21680/3C43DCA88CAA/CCAPI/ccIFCallSetupRequestPrivate:

SPI Call Setup Request Is Success; Interface Type=3, FlowMode=1

May 3 12:10:10.098: //21680/3C43DCA88CAA/CCAPI/ccCallSetContext:

Context=0x16DCE5D0

May 3 12:10:10.098: //21678/3C43DCA88CAA/CCAPI/ccSaveDialpeerTag:

Outgoing Dial-peer=2

May 3 12:10:10.098: //21680/3C43DCA88CAA/CCAPI/cc_api_call_proceeding:

Interface=0x13652174, Progress Indication=NULL(0)

May 3 12:10:10.810: //21680/3C43DCA88CAA/CCAPI/cc_api_caps_ind:

Destination Interface=0x0, Destination Call Id=-1, Source Call Id=21680,

Caps(Codec=0x4, Fax Rate=0x2, Vad=0x2,

Modem=0x0, Codec Bytes=20, Signal Type=2)

May 3 12:10:10.810: //21680/3C43DCA88CAA/CCAPI/cc_api_caps_ind:

Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms),

Playout Max=1000(ms), Fax Nom=300(ms))

May 3 12:10:10.810: //21678/3C43DCA88CAA/CCAPI/cc_api_caps_ack:

Destination Interface=0x0, Destination Call Id=-1, Source Call Id=21678,

Caps(Codec=g729r8(0x4), Fax Rate=FAX_RATE_VOICE(0x2), Vad=OFF(0x1),

Modem=OFF(0x0), Codec Bytes=20, Signal Type=2, Seq Num Start=1)

May 3 12:10:10.810: //21678/3C43DCA88CAA/CCAPI/cc_api_caps_ack:

Destination Interface=0x0, Destination Call Id=-1, Source Call Id=21678,

Caps(Codec=g729r8(0x4), Fax Rate=FAX_RATE_VOICE(0x2), Vad=OFF(0x1),

Modem=OFF(0x0), Codec Bytes=20, Signal Type=2, Seq Num Start=1)

May 3 12:10:10.810: //21680/3C43DCA88CAA/CCAPI/cc_api_event_indication:

Event=171, Call Id=21680

May 3 12:10:10.810: //21680/3C43DCA88CAA/CCAPI/cc_api_event_indication:

Event Is Sent To Conferenced SPI(s) Directly

May 3 12:10:10.810: //21680/3C43DCA88CAA/CCAPI/cc_api_event_indication:

Event=98, Call Id=21680

May 3 12:10:10.810: //21680/3C43DCA88CAA/CCAPI/cc_api_event_indication:

Event Is Sent To Conferenced SPI(s) Directly

May 3 12:10:10.810: //21680/3C43DCA88CAA/CCAPI/cc_api_call_cut_progress:

Interface=0x13652174, Progress Indication=INBAND(8), Signal Indication=SIGNAL RINGBACK(1),

Cause Value=0

May 3 12:10:10.810: //21680/3C43DCA88CAA/CCAPI/cc_api_call_cut_progress:

Call Entry(Responsed=TRUE)

May 3 12:10:10.810: //21678/3C43DCA88CAA/CCAPI/ccCallCutProgress:

Progress Indication=INBAND(8), Signal Indication=SIGNAL RINGBACK(1), Cause Value=0

Voice Call Send Alert=FALSE, Call Entry(Alert Sent=FALSE)

May 3 12:10:10.810: //21678/3C43DCA88CAA/CCAPI/ccCallCutProgress:

Call Entry(Responsed=TRUE)

May 3 12:10:10.810: //21678/3C43DCA88CAA/CCAPI/ccConferenceCreate:

(confID=0x12C63EAC, callID1=0x54AE, gcid=3C43DCA8-B32111E2-8CADC853-7EAB7692, tag=0x0)

May 3 12:10:10.810: //21680/3C43DCA88CAA/CCAPI/ccConferenceCreate:

(confID=0x12C63EAC, callID2=0x54B0, gcid=3C43DCA8-B32111E2-8CADC853-7EAB7692, tag=0x0)

May 3 12:10:10.810: //21678/3C43DCA88CAA/CCAPI/ccConferenceCreate:

Conference Id=0x12C63EAC, Call Id1=21678, Call Id2=21680, Tag=0x0

May 3 12:10:10.810: //21678/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

May 3 12:10:10.810: cc_api_get_xcode_stream : 4702

May 3 12:10:10.810: //21680/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

May 3 12:10:10.810: cc_api_get_xcode_stream : 4702

May 3 12:10:10.810: //21678/3C43DCA88CAA/CCAPI/ccConferenceCreate:

May 3 12:10:10.810: ccConferenceCreate: ret1=0, codecMask1=4, bytes1=20, negot1=1, dtmf1=6

ret2=0, codecMask2=4, bytes2=20, negot2=1, dtmf2=6,

tx_dynamic_pt1=18, rx_dynamic_pt1=18, codec_mode1=0, params_bitmap1 =0

tx_dynamic_pt2=18, rx_dynamic_pt2=18, codec_mode2=0, params_bitmap2 =0

May 3 12:10:10.810: //21678/3C43DCA88CAA/CCAPI/ccConferenceCreate:

delay media to slow start case, codec negotation is not done

May 3 12:10:10.810: //21678/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

May 3 12:10:10.810: cc_api_get_xcode_stream : 4702

May 3 12:10:10.810: //21678/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

May 3 12:10:10.814: cc_api_get_xcode_stream : 4702

May 3 12:10:10.814: //21678/3C43DCA88CAA/CCAPI/cc_api_bridge_done:

Conference Id=0x12C, Source Interface=0x13652174, Source Call Id=21678,

Destination Call Id=21680, Disposition=0x0, Tag=0x0

May 3 12:10:10.814: //21680/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

May 3 12:10:10.814: cc_api_get_xcode_stream : 4702

May 3 12:10:10.814: //21680/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

May 3 12:10:10.814: cc_api_get_xcode_stream : 4702

May 3 12:10:10.814: //21680/3C43DCA88CAA/CCAPI/cc_api_bridge_done:

Conference Id=0x12C, Source Interface=0x13652174, Source Call Id=21680,

Destination Call Id=21678, Disposition=0x0, Tag=0x0

May 3 12:10:10.814: //21678/3C43DCA88CAA/CCAPI/cc_generic_bridge_done:

Conference Id=0x12C, Source Interface=0x13652174, Source Call Id=21680,

Destination Call Id=21678, Disposition=0x0, Tag=0x0

May 3 12:10:10.814: //21678/3C43DCA88CAA/CCAPI/ccConferenceCreate:

Call Entry(Conference Id=0x12C, Destination Call Id=21680)

May 3 12:10:10.814: //21680/3C43DCA88CAA/CCAPI/ccConferenceCreate:

Call Entry(Conference Id=0x12C, Destination Call Id=21678)

vg#

May 3 12:10:10.814: //21678/3C43DCA88CAA/CCAPI/cc_process_notify_bridge_done:

Conference Id=0x12C, Call Id1=21678, Call Id2=21680

vg#

May 3 12:10:13.582: //21680/3C43DCA88CAA/CCAPI/cc_api_call_disconnected:

Cause Value=21, Interface=0x13652174, Call Id=21680

May 3 12:10:13.582: //21680/3C43DCA88CAA/CCAPI/cc_api_call_disconnected:

Call Entry(Responsed=TRUE, Cause Value=21, Retry Count=0)

May 3 12:10:13.582: //21678/3C43DCA88CAA/CCAPI/ccCallReleaseResources:

release reserved xcoding resource.

May 3 12:10:13.582: //21680/3C43DCA88CAA/CCAPI/ccCallSetAAA_Accounting:

Accounting=0, Call Id=21680

May 3 12:10:13.582: //21678/3C43DCA88CAA/CCAPI/ccConferenceDestroy:

Conference Id=0x12C, Tag=0x0

May 3 12:10:13.582: //21678/3C43DCA88CAA/CCAPI/cc_api_bridge_drop_done:

Conference Id=0x12C, Source Interface=0x13652174, Source Call Id=21678,

Destination Call Id=21680, Disposition=0x0, Tag=0x0

May 3 12:10:13.582: //21680/3C43DCA88CAA/CCAPI/cc_api_bridge_drop_done:

Conference Id=0x12C, Source Interface=0x13652174, Source Call Id=21680,

Destination Call Id=21678, Disposition=0x0, Tag=0x0

May 3 12:10:13.582: //21678/3C43DCA88CAA/CCAPI/cc_generic_bridge_done:

Conference Id=0x12C, Source Interface=0x13652174, Source Call Id=21680,

Destination Call Id=21678, Disposition=0x0, Tag=0x0

May 3 12:10:13.582: //21680/3C43DCA88CAA/CCAPI/ccCallDisconnect:

Cause Value=21, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=21)

May 3 12:10:13.582: //21680/3C43DCA88CAA/CCAPI/ccCallDisconnect:

Cause Value=21, Call Entry(Responsed=TRUE, Cause Value=21)

May 3 12:10:13.582: //21680/3C43DCA88CAA/CCAPI/cc_api_call_disconnect_done:

Disposition=0, Interface=0x13652174, Tag=0x0, Call Id=21680,

Call Entry(Disconnect Cause=21, Voice Class Cause Code=0, Retry Count=0)

May 3 12:10:13.582: //21680/3C43DCA88CAA/CCAPI/cc_api_call_disconnect_done:

Call Disconnect Event Sent

May 3 12:10:13.582: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

May 3 12:10:13.582: :cc_free_feature_vsa freeing 14230ED0

vg#

May 3 12:10:13.582: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

May 3 12:10:13.582: vsacount in free is 1

May 3 12:10:13.586: //21678/3C43DCA88CAA/CCAPI/ccCallDisconnect:

Cause Value=21, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)

May 3 12:10:13.586: //21678/3C43DCA88CAA/CCAPI/ccCallDisconnect:

Cause Value=21, Call Entry(Responsed=TRUE, Cause Value=21)

May 3 12:10:13.858: //21678/3C43DCA88CAA/CCAPI/cc_api_call_disconnect_done:

Disposition=0, Interface=0x13652174, Tag=0x0, Call Id=21678,

Call Entry(Disconnect Cause=21, Voice Class Cause Code=0, Retry Count=0)

vg#

May 3 12:10:13.858: //21678/3C43DCA88CAA/CCAPI/cc_api_call_disconnect_done:

Call Disconnect Event Sent

May 3 12:10:13.858: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

May 3 12:10:13.858: :cc_free_feature_vsa freeing 14230FB0

May 3 12:10:13.858: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

May 3 12:10:13.858: vsacount in free is 0

vg#

Ahsan Hashmi · ‎05-03-2013

------------------------------------debug ccsip message-----------------------------

Received:

OPTIONS sip:141458*848374@109.224.23.36:5060 SIP/2.0

Via: SIP/2.0/UDP 66.152.187.165:5060;branch=z9hG4bK7bdb1b2f;rport

Max-Forwards: 70

From: "asterisk" ;tag=as4001b234

To: <141458>

Contact:

Call-ID: 28b21da323a11cec46e148707b1090b9@66.152.187.165:5060

CSeq: 102 OPTIONS

User-Agent: Asterisk PBX 1.8.2.3

Date: Fri, 03 May 2013 12:17:42 GMT

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH

Supported: replaces, timer

Content-Length: 0

May 3 12:13:37.434: //21684/B7D96DFB8CB6/SIP/Msg/ccsipDisplayMsg:

Sent:

SIP/2.0 200 OK

Via: SIP/2.0/UDP 66.152.187.165:5060;branch=z9hG4bK7bdb1b2f;rport

From: "asterisk" ;tag=as4001b234

To: <141458>;tag=768DF818-173B

Date: Fri, 03 May 2013 12:13:37 GMT

Call-ID: 28b21da323a11cec46e148707b1090b9@66.152.187.165:5060

Server: Cisco-SIPGateway/IOS-12.x

CSeq: 102 OPTIONS

Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER

Allow-Events: telephone-event

Accept: application/

vg#sdp

Supported: 100rel,timer,resource-priority,replaces,sdp-anat

Content-Type: application/sdp

Content-Length: 454

v=0

o=CiscoSystemsSIP-GW-UserAgent 7911 2236 IN IP4 109.224.23.36

s=SIP Call

c=IN IP4 109.224.23.36

t=0 0

m=audio 0 RTP/AVP 18 0 8 9 4 2 15

c=IN IP4 109.224.23.36

m=image 0 udptl t38

c=IN IP4 109.224.23.36

a=T38FaxVersion:0

a=T38MaxBitRate:9600

a=T38FaxFillBitRemoval:0

a=T38FaxTranscodingMMR:0

a=T38FaxTranscodingJBIG:0

a=T38FaxRateManagement:transferredTCF

a=T38FaxMaxBuffer:200

a=T38FaxMaxDatagram:320

a=T38FaxUdpEC:t38UDPRedundancy

May 3 12:13:38.886: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Received:

INVITE sip:141458*848374@109.224.23.36:5060 SIP/2.0

Via: SIP/2.0/UDP 66.152.187.165:5060;branch=z9hG4bK558f9fe5;rport

Max-Forwards: 70

From: "001111" <001111>;tag=as0012aad8

To: <141458>

Contact: <001111>

Call-ID: 6c29f1d346789f71336771012ee5b766@66.152.187.165:5060

CSeq: 102 INVITE

User-Agent: Asterisk PBX 1.8.2.3

Date: Fri, 03 May 2013 12:17:43 GMT

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH

Supported: replaces, timer

Remote-Party-ID: "001111" <001111>;party=calling;privacy=off;screen=no

Diversion: <>;reason=unconditional

Content-Type: application/sdp

Content-Length: 336

v=0

o=root 1349148258 1349148258 IN IP4 66.152.187.165

s=Asterisk PBX 1.8.2.3

c=IN IP4 66.152.187.165

t=0 0

m=audio 18334 RTP/AVP 18 4 110 101

a=rtpmap:18 G729/8000

a=fmtp:18 annexb=no

a=rtpmap:4 G723/8000

a=fmtp:4 annexa=no

a=rtpmap:110 speex/8000

a=rtpmap:101 telephone-event/8000

a=fmtp:101 0-16

a=ptime:20

a=sendrecv

May 3 12:13:38.890: //21685/B8B798688CB7/SIP/Msg/ccsipDisplayMsg:

Sent:

SIP/2.0 100 Trying

Via: SIP/2.0/UDP 66.152.187.165:5060;branch=z9hG4bK558f9fe5;rport

From: "001111" <001111>;tag=as0012aad8

To: <141458>

Date: Fri, 03 May 2013 12:13:38 GMT

Call-ID: 6c29f1d346789f71336771012ee5b766@66.152.187.165:5060

CSeq: 102 INVITE

Allow-Events: telephone-event

Server: Cisco-SIPGateway/IOS-12.x

Content-Length: 0

May 3 12:13:38.890: //21686/B8B798688CB7/SIP/Msg/ccsipDisplayMsg:

Sent:

INVITE sip:50106@172.16.4.10:5060 SIP/2.0

Via: SIP/2.0/UDP 172.16.4.2:5060;branch=z9hG4bK387A1E42

Remote-Party-ID: "001111" <001111>;party=calling;screen=no;privacy=off

From: "001111" <>001111@sip1.catiphone.com>;tag=768DFDCC-18DD

To: <50106>

Date: Fri, 03 May 2013 12:13:38 GMT

Call-ID: B8B83490-B32111E2-8CBDC853-7EAB7692@172.16.4.2

Supported: 100rel,timer,resource-priority,replaces,sdp-anat

Min-SE: 1800

Cisco-Guid: 3099039848-3005288930-2360854611-2125166226

User-Agent: Cisco-SIPGateway/IOS-12.x

Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER

CSeq: 101 INVITE

Timestamp: 1367583218

Contact: <001111>

Expires: 180

Allow-Events: telephone-event

Max-Forwards: 69

Diversion: <>;reason=unconditional

Content-Type: application/sdp

Content-Disposition: session;handling=required

Content-Length: 250

v=0

o=CiscoSystemsSIP-GW-UserAgent 44 2563 IN IP4 172.16.4.2

s=SIP Call

c=IN IP4 172.16.4.2

t=0 0

m=audio 31872 RTP/AVP 18 101

c=IN IP4 172.16.4.2

a=rtpmap:18 G729/8000

a=fmtp:18 annexb=no

a=rtpmap:101 telephone-event/8000

a=fmtp:101 0-16

May 3 12:13:38.890: //21686/B8B798688CB7/SIP/Msg/ccsipDisplayMsg:

Received:

SIP/2.0 100 Trying

Via: SIP/2.0/UDP 172.16.4.2:5060;branch=z9hG4bK387A1E42

From: "001111" <>001111@sip1.catiphone.com>;tag=768DFDCC-18DD

To: <50106>

Date: Fri, 03 May 2013 15:16:44 GMT

Call-ID: B8B83490-B32111E2-8CBDC853-7EAB7692@172.16.4.2

CSeq: 101 INVITE

Allow-Events: presence

Content-Length: 0

May 3 12:13:38.890: //21686/B8B798688CB7/SIP/Msg/ccsipDisplayMsg:

Received:

SIP/2.0 503 Service Unavailable

Via: SIP/2.0/UDP 172.16.4.2:5060;branch=z9hG4bK387A1E42

From: "001111" <>001111@sip1.catiphone.com>;tag=768DFDCC-18DD

To: <50106>;tag=751244418

Date: Fri, 03 May 2013 15:16:44 GMT

Call-ID: B8B83490-B32111E2-8CBDC853-7EAB7692@172.16.4.2

CSeq: 101 INVITE

Allow-Events: presence

Warning: 399 callmanger "Unable to find a device handler for the request received on port 62116 from 172.16.4.2"

Content-Length: 0

May 3 12:13:38.894: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Sent:

ACK sip:50106@172.16.4.10:5060 SIP/2.0

Via: SIP/2.0/UDP 172.16.4.2:5060;branch=z9hG4bK387A1E42

From: "001111" <>001111@sip1.catiphone.com>;tag=768DFDCC-18DD

To: <50106>;tag=751244418

Date: Fri, 03 May 2013 12:13:38 GMT

Call-ID: B8B83490-B32111E2-8CBDC853-7EAB7692@172.16.4.2

Max-Forwards: 70

CSeq: 101 ACK

Allow-Events: telephone-event

Content-Length: 0

May 3 12:13:38.894: //21687/B8B798688CB7/SIP/Msg/ccsipDisplayMsg:

Sent:

INVITE sip:50106@66.152.187.165:5060 SIP/2.0

Via: SIP/2.0/UDP 109.224.23.36:5060;branch=z9hG4bK387B17D0

Remote-Party-ID: "001111" <001111>;party=calling;screen=no;privacy=off

From: "001111" <>001111@sip1.catiphone.com>;tag=768DFDD0-8EA

To: <50106>

Date: Fri, 03 May 2013 12:13:38 GMT

Call-ID: B8B8D0B8-B32111E2-8CBFC853-7EAB7692@109.224.23.36

Supported: 100rel,timer,resource-priority,replaces,sdp-anat

Min-SE: 1800

Cisco-Guid: 3099039848-3005288930-2360854611-2125166226

User-Agent: Cisco-SIPGateway/IOS-12.x

Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER

CSeq: 101 INVITE

Timestamp: 1367583218

Contact: <001111>

Expires: 180

Allow-Events: telephone-event

Max-Forwards: 69

Diversion: <>;reason=unconditional

Content-Type: application/sdp

Content-Disposition: session;handling=required

Content-Length: 260

v=0

o=CiscoSystemsSIP-GW-UserAgent 284 5727 IN

vg# IP4 109.224.23.36

s=SIP Call

c=IN IP4 109.224.23.36

t=0 0

m=audio 25410 RTP/AVP 18 101

c=IN IP4 109.224.23.36

a=rtpmap:18 G729/8000

a=fmtp:18 annexb=no

a=rtpmap:101 telephone-event/8000

a=fmtp:101 0-16

May 3 12:13:39.174: //21687/B8B798688CB7/SIP/Msg/ccsipDisplayMsg:

Received:

SIP/2.0 401 Unauthorized

Via: SIP/2.0/UDP 109.224.23.36:5060;branch=z9hG4bK387B17D0;received=109.224.23.36;rport=63152

From: "001111" <>001111@sip1.catiphone.com>;tag=768DFDD0-8EA

To: <50106>;tag=as165742d9

Call-ID: B8B8D0B8-B32111E2-8CBFC853-7EAB7692@109.224.23.36

CSeq: 101 INVITE

Server: Asterisk PBX 1.8.2.3

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH

Supported: replaces, timer

WWW-Authenticate: Digest algorithm=MD5, realm="Catiphone", nonce="540a6b3e"

Content-Length: 0

May 3 12:13:39.174: //21687/B8B798688CB7/SIP/Msg/ccsipDisplayMsg:

Sent:

ACK sip:50106@66.152.187.165:5060 SIP/2.0

Via: SIP/2.0/UDP 109.224.23.36:5060;branch=z9hG4bK387B17D0

From: "001111" <>001111@sip1.catiphone.com>;tag=768DFDD0-8EA

To: <50106>;tag=as165742d9

Date: Fri, 03 May 2013 12:13:38 GMT

Call-ID: B8B8D0B8-B32111E2-8CBFC853-7EAB7692@109.224.23.36

Max-Forwards: 70

CSeq: 101 ACK

Allow-Events: telephone-event

Content-Length: 0

May 3 12:13:39.174: //21687/B8B798688CB7/SIP/Msg/ccsipDisplayMsg:

Sent:

INVITE sip:50106@66.152.187.165:5060 SIP/2.0

Via: SIP/2.0/UDP 109.224.23.36:5060;branch=z9hG4bK387C2391

Remote-Party-ID: "001111" <001111>;party=calling;screen=no;privacy=off

From: "001111" <>001111@sip1.catiphone.com>;tag=768DFDD0-8EA

To: <50106>

Date: Fri, 03 May 2013 12:13:39 GMT

Call-ID: B8B8D0B8-B32111E2-8CBFC853-7EAB7692@109.224.23.36

Supported: 100rel,timer,resource-priority,replaces,sdp-anat

Min-SE: 1800

Cisco-Guid: 3099039848-3005288930-2360854611-2125166226

User-Agent: Cisco-SIPGateway/IOS-12.x

Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER

CSeq: 102 INVITE

Timestamp: 1367583219

Contact: <001111>

Expires: 180

Allow-Events: telephone-event

Authorization: Digest username="141458*848374",realm="Catiphone",uri="sip:50106@66.152.187.165:5060",response="e4b1d2e3215ed8f4b5c9033d36abd2d1",nonce="540a6b3e",algorithm=MD5

Max-Forwards: 69

Diversion: <>;reason=unconditional

Content-Type: application/sdp

Content-Disposition: session;handling=required

Content-Length: 260

v=0

o=CiscoSystemsSIP-GW-UserAgent 284 5727 IN IP4 109.224.23.36

s=SIP Call

c=IN IP4 109.224.23.36

t=0 0

m=audio 25410 RTP/AVP 18 101

c=IN IP4 109.224.23.36

a=rtpmap:18 G729/8000

a=fmtp:18 annexb=no

a=rtpmap:101 telephone-event/8000

a=fmtp:101 0-16

May 3 12:13:39.450: //21687/B8B798688CB7/SIP/Msg/ccsipDisplayMsg:

Received:

SIP/2.0 100 Trying

Via: SIP/2.0/UDP 109.224.23.36:5060;branch=z9hG4bK387C2391;received=109.224.23.36;rport=63152

From: "001111" <>001111@sip1.catiphone.com>;tag=768DFDD0-8EA

To: <50106>

Call-ID: B8B8D0B8-B32111E2-8CBFC853-7EAB7692@109.224.23.36

CSeq: 102 INVITE

Server: Asterisk PBX 1.8.2.3

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH

Supported: replaces, timer

Contact: <50106>

Content-Length: 0

May 3 12:13:39.618: //21687/B8B798688CB7/SIP/Msg/ccsipDisplayMsg:

Received:

SIP/2.0 183 Session Progress

Via: SIP/2.0/UDP 109.224.23.36:5060;branch=z9hG4bK387C2391;received=109.224.23.36;rport=63152

From: "001111" <>001111@sip1.catiphone.com>;tag=768DFDD0-8EA

To: <50106>;tag=as21064581

Call-ID: B8B8D0B8-B32111E2-8CBFC853-7EAB7692@109.224.23.36

CSeq: 102 INVITE

Server: Asterisk PBX 1.8.2.3

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH

Supported: replaces, timer

Contact: <50106>

Content-Type: application/sdp

Content-Length: 261

v=0

o=root 804648090 804648090 IN IP4 66.152.187.165

s=Asterisk PBX 1.8.2.3

c=IN IP4 66.152.187.165

t=0 0

m=audio 13450 RTP/AVP 18 101

a=rtpmap:18 G729/8000

a=fmtp:18 annexb=no

a=rtpmap:101 telephone-event/8000

a=fmtp:101 0-16

a=ptime:20

a=sendrecv

May 3 12:13:39.622: //21685/B8B798688CB7/SIP/Msg/ccsipDisplayMsg:

Sent:

SIP/2.0 183 Session Progress

Via: SIP/2.0/UDP 66.152.187.165:5060;branch=z9hG4bK558f9fe5;rport

From: "001111" <001111>;tag=as0012aad8

To: <141458>;tag=768E00A8-5CF

Date: Fri, 03 May 2013 12:13:38 GMT

Call-ID: 6c29f1d346789f71336771012ee5b766@66.152.187.165:5060

CSeq: 102 INVITE

Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER

Allow-Events: telephone-event

Remote-Party-ID: <50106>;part

vg#y=called;screen=no;privacy=off

Contact: <141458>

Supported: sdp-anat

Server: Cisco-SIPGateway/IOS-12.x

Content-Type: application/sdp

Content-Disposition: session;handling=required

Content-Length: 273

v=0

o=CiscoSystemsSIP-GW-UserAgent 5249 6474 IN IP4 109.224.23.36

s=SIP Call

c=IN IP4 109.224.23.36

t=0 0

m=audio 22558 RTP/AVP 18 101

c=IN IP4 109.224.23.36

a=rtpmap:18 G729/8000

a=fmtp:18 annexb=no

a=rtpmap:101 telephone-event/8000

a=fmtp:101 0-16

a=ptime:20

vg#

May 3 12:13:42.386: //21687/B8B798688CB7/SIP/Msg/ccsipDisplayMsg:

Received:

SIP/2.0 603 Declined

Via: SIP/2.0/UDP 109.224.23.36:5060;branch=z9hG4bK387C2391;received=109.224.23.36;rport=63152

From: "001111" <>001111@sip1.catiphone.com>;tag=768DFDD0-8EA

To: <50106>;tag=as21064581

Call-ID: B8B8D0B8-B32111E2-8CBFC853-7EAB7692@109.224.23.36

CSeq: 102 INVITE

Server: Asterisk PBX 1.8.2.3

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH

Supported: replaces, timer

Content-Length: 0

May 3 12:13:42.386: //21687/B8B798688CB7/SIP/Msg/ccsipDisplayMsg:

Sent:

ACK sip:50106@66.152.187.165:5060 SIP/2.0

Via: SIP/2.0/UDP 109.224.23.36:5060;branch=z9hG4bK387C2391

From: "001111" <>001111@sip1.catiphone.com>;tag=768DFDD0-8EA

To: <50106>;tag=as21064581

Date: Fri, 03 May 2013 12:13:39 GMT

Call-ID: B8B8D0B8-B32111E2-8CBFC853-7EAB7692@109.224.23.36

Max-Forwards: 70

CSeq: 102 ACK

Allow-Events: telephone-event

Content-Length: 0

May 3 12:13:42.386: //21685/B8B798688CB7/SIP/Msg/ccsipDisplayMsg:

Sent:

SIP/2.0 403 Forbidden

Via: SIP/2.0/UDP 66.152.187.165:5060;branch=z9hG4bK558f9fe5;rport

From: "001111" <001111>;tag=as0012aad8

To: <141458>;tag=768E00A8-5CF

Date: Fri, 03 May 2013 12:13:38 GMT

Call-ID: 6c29f1d346789f71336771012ee5b766@66.152.187.165:5060

CSeq: 102 INVITE

Allow-Events: telephone-event

Server: Cisco-SIPGateway/IOS-12.x

Reason: Q.850;cause=21

Content-Length: 0

May 3 12:13:42.654: //21687/B8B798688CB7/SIP/Msg/ccsipDisplayMsg:

Received:

SIP/2.0 603 Declined

Via: SIP/2.0/UDP 109.224.23.36:5060;branch=z9hG4bK387C2391;received=109.224.23.36;rport=63152

From: "001111" <>001111@sip1.catiphone.com>;tag=768DFDD0-8EA

To: <50106>;tag=as21064581

Call-ID: B8B8D0B8-B32111E2-8CBFC853-7EAB7692@109.224.23.36

CSeq: 102 INVITE

Server: Asterisk PBX 1.8.2.3

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH

Supported: replaces, timer

Content-Length: 0

May 3 12:13:42.654: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Sent:

ACK sip:50106@66.152.187.165:5060 SIP/2.0

Via: SIP/2.0/UDP 109.224.23.36:5060;branch=z9hG4bK387C2391

From: "001111" <>001111@sip1.catiphone.com>;tag=768DFDD0-8EA

To: <50106>;tag=as21064581

Date: Fri, 03 May 2013 12:13:39 GMT

Call-ID: B8B8D0B8-B32111E2-8CBFC853-7EAB7692@109.224.23.36

Max-Forwards: 70

CSeq: 102 ACK

Allow-Events: telephone-event

Reason: Q.850;cause=21

Content-Length: 0

May 3 12:13:42.662: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Received:

vg#ACK sip:141458*848374@109.224.23.36:5060 SIP/2.0

Via: SIP/2.0/UDP 66.152.187.165:5060;branch=z9hG4bK558f9fe5;rport

Max-Forwards: 70

From: "001111" <001111>;tag=as0012aad8

To: <141458>;tag=768E00A8-5CF

Contact: <001111>

Call-ID: 6c29f1d346789f71336771012ee5b766@66.152.187.165:5060

CSeq: 102 ACK

User-Agent: Asterisk PBX 1.8.2.3

Content-Length: 0

vg#

Ahsan Hashmi · ‎05-03-2013

I have pasted my sip trunk config also for your reference.

Carlo Poggiarelli · ‎05-03-2013

Hi.

Make sure to configure inbound calling search space in your sip trunk configuration page on cucm.

In your actual config is "NONE

HTH

Regards

Carlo

Please rate all helpful posts

"The more you help the more you learn"

Please rate all helpful posts "The more you help the more you learn"

Ayodeji Okanlawon · ‎05-03-2013

Ahsan,

CUCM is sending this error to the CUBE...

"Warning: 399 callmanger "Unable to find a device handler for the request received on port 62116 from 172.16.4.2"

Usually when you get that error it is indicative of three things..

1. Wrong Ip address configured on the sip trunk. is 172.16.4.2 the ip address on the sip trunk?

2. The CUCM server your dial-peer points to is not in the CUCM group of the sip trunk (and you dont have "route on all active nodes" checked (if your version supports it)----

3. Incorrect bind config.....

Please check the first two points above...The 3rd point doesnt seem to be an issue because I can see the CUBE sending call out the local interface to CUCM

Please rate all useful posts

"opportunity is a haughty goddess who waste no time with those who are unprepared"

Please rate all useful posts

Ahsan Hashmi · ‎05-03-2013

172.16.4.2 is the LAN IP address of my voice gateway.

109.224.23.36 is the IP facing ITSP

1) if you see the above screen shots i pasted. SIP trunk desetination was 109.224.23.36 before now i changed it to 172.16.4.2.. outboud calls are going fine. incoming is still the same.

2) i have checked the " route on all active nodes " under SIP trunk.

"The CUCM server your dial-peer points to is not in the CUCM group of the sip trunk " by this do u mean the device pool ? because the sip trunk configuration has only device pool config which i have done..

Ayodeji Okanlawon · ‎05-03-2013

Ahsan,

Please reset the sip trunk..Then test again and send debug ccsip messages.

Please rate all useful posts

"opportunity is a haughty goddess who waste no time with those who are unprepared"

Please rate all useful posts

Ahsan Hashmi · ‎05-03-2013

HI...

It worked.. after i reseted the sip trunk. the call is comming into the extension now..

Thanks alot.

Ayodeji Okanlawon · ‎05-03-2013

Thats good. Dont forget to mark the thread as answered and to rate all useful posts..

Please rate all useful posts

"opportunity is a haughty goddess who waste no time with those who are unprepared"

Please rate all useful posts