Problem with g711 to g729 transcode using sip & 2811 dspfarm

Unanswered Question
Aug 25th, 2010

Hello-

I would like to connect a generic g711 SIP endpoint to a generic g729r8 or g729br8 endpoint using transcoder on 2811 dspfarm.

I have multiple PVDM2-64s installed on 2811.

The 2811 is registered to a CME on a different router.

My dial-peers are targeted at a generic non-cisco sip server.

Everything works fine as long as its g711 to g711, or g729 to g729 but I can't seem to force g711 to g729.

If I set dial-peer 100 codec to g729  and dial-peer 101 codec to g711

I send a sip INVITE to [email protected]  with G729

The 2811 sends back unsupported, 501 not implemented Q.850 cause code 65.

I suspect the problem is with dial-peer setup and codec preferences/classes or I need to point my session target at CME?

Thanks very much for helping!

Here is my 2811 config.

#show sdspfarm units

mtp-1 Device: TCP socket:[-1]  UNREGISTERED
actual_stream:0 max_stream 0 IP:0.0.0.0  0  Unknown 0 keepalive 0

max-mtps:4, max-streams:16, alloc-streams:0, act-streams:0

# running config snip

sccp local FastEthernet0/0
sccp ccm xxxxx identifier 1 version 5.0.
sccp
!
sccp ccm group 1
bind interface FastEthernet0/0
associate ccm 1 priority 1
associate profile 1 register 123456
keepalive retries 5
switchover method immediate
switchback method immediate
switchback interval 5
!
dspfarm profile 1 transcode
codec g711ulaw
codec g711alaw
codec g729ar8
codec g729abr8
codec g729r8
maximum sessions 5
associate application SCCP
!
!
!
dial-peer voice 100 voip
service session
session protocol sipv2
session target ipv4:192.168.0.3
incoming called-number 100
!
dial-peer voice 101 voip
destination-pattern 101
session protocol sipv2
session target ipv4:192.168.0.3
codec g711alaw
!
!
gateway
timer receive-rtp 1200
!
sip-ua
!
!
!

Dspfarm Profile Configuration

Profile ID = 1, Service = TRANSCODING, Resource ID = 1
Profile Description :
Profile Admin State : UP
Profile Operation State : ACTIVE
Application : SCCP   Status : ASSOCIATED
Resource Provider : FLEX_DSPRM   Status : UP
Number of Resource Configured : 5
Number of Resource Available : 5
Codec Configuration
Codec : g711ulaw, Maximum Packetization Period : 30
Codec : g711alaw, Maximum Packetization Period : 30
Codec : g729ar8, Maximum Packetization Period : 60
Codec : g729abr8, Maximum Packetization Period : 60
Codec : g729r8, Maximum Packetization Period : 60


SLOT DSP VERSION  STATUS CHNL USE   TYPE   RSC_ID BRIDGE_ID PKTS_TXED PKTS_RXED

1    3   25.0.256 UP     N/A  FREE  xcode  1      -         -         -
1    3   25.0.256 UP     N/A  FREE  xcode  1      -         -         -
1    3   25.0.256 UP     N/A  FREE  xcode  1      -         -         -
1    3   25.0.256 UP     N/A  FREE  xcode  1      -         -         -
1    3   25.0.256 UP     N/A  FREE  xcode  1      -         -         -

Total number of DSPFARM DSP channel(s) 5

#show sccp all
SCCP Admin State: UP
Gateway IP Address: xxxxxxx, Port Number: 2000
IP Precedence: 5
User Masked Codec list: None
Call Manager: xxxxxxxx, Port Number: 2000
                Priority: N/A, Version: 5.0.1, Identifier: 1

Transcoding Oper State: ACTIVE - Cause Code: NONE
Active Call Manager: xxxxxxx, Port Number: 2000
TCP Link Status: CONNECTED, Profile Identifier: 1
Reported Max Streams: 10, Reported Max OOS Streams: 0
Supported Codec: g711ulaw, Maximum Packetization Period: 30
Supported Codec: g711alaw, Maximum Packetization Period: 30
Supported Codec: g729ar8, Maximum Packetization Period: 60
Supported Codec: g729abr8, Maximum Packetization Period: 60
Supported Codec: g729r8, Maximum Packetization Period: 60
Supported Codec: rfc2833 dtmf, Maximum Packetization Period: 30
Supported Codec: rfc2833 pass-thru, Maximum Packetization Period: 30
Supported Codec: inband-dtmf to rfc2833 conversion, Maximum Packetization Period: 30


SCCP Application Service(s) Statistics:

Profile Identifier: 1, Service Type: Transcoding
TCP packets rx 165, tx 167
Unsupported pkts rx 0, Unrecognized pkts rx 0
Register tx 1, successful 1, rejected 0, failed 0
KeepAlive tx 162, successful 162, failed 0
OpenReceiveChannel rx 0, successful 0, failed 0
CloseReceiveChannel rx 0, successful 0, failed 0
StartMediaTransmission rx 0, successful 0, failed 0
StopMediaTransmission rx 0, successful 0, failed 0
PortReq rx 0
PortRes tx 0, successful 0, failed 0
PortClose rx 0
QosListen rx 0
QosPath rx 0
QosTeardown rx 0, send 0, recv 0, sendrecv 0
QosResvNotify tx 0, send 0, recv 0, sendrecv 0
QosErrorNotify tx 0, send 0, recv 0, sendrecv 0
   err0 0, err1 0, err2 0, err3 0, err4 0, err5 0,
   err6 0, err7 0, err8 0, err9 0, err10 0, err11 0,
   err12 0
QosModify rx 0, send 0, recv 0, sendrecv 0
UpdateDscp rx 0
Reset rx 0, successful 0, failed 0
MediaStreamingFailure rx 0
MediaStreamingFailure tx 0
Switchover 0, Switchback 0

CCM Group Identifier: 1
Description: None
Binded Interface: FastEthernet0/0, IP Address: xxxxxxxxxxxxx
Associated CCM Id: 1, Priority in this CCM Group: 1
Associated Profile: 1, Registration Name: 123456
Registration Retries: 3, Registration Timeout: 10 sec
Keepalive Retries: 5, Keepalive Timeout: 30 sec
CCM Connect Retries: 3, CCM Connect Interval: 10 sec
Switchover Method: IMMEDIATE, Switchback Method: IMMEDIATE
Switchback Interval: 5 sec, Switchback Timeout: 0 sec
Signaling DSCP value: cs3, Audio DSCP value: ef


Total number of active session(s) 0, and connection(s) 0


Total number of active session(s) 0, and connection(s) 0


Total number of active session(s) 0, connection(s) 0, and callegs 0

SCCP Application Service(s) Statistics Summary:
Total Conferencing Sessions: 0, Connections: 0
Total Transcoding Sessions: 0, Connections: 0
Total MTP Sessions: 0, Connections: 0
Total ALG-Phone Sessions: 0, Connections: 0
Total BRI-Phone Sessions: 0, Connections: 0
Total SCCP Sessions: 0, Connections: 0


Total active sessions 0, connections 0, rsvp sessions 0

I have this problem too.
0 votes
  • 1
  • 2
  • 3
  • 4
  • 5
Overall Rating: 5 (1 ratings)
Loading.
David Smith Wed, 08/25/2010 - 19:22

Hey Bob,

I'm a little confused.

What do you mean by you have the 2811 registered on a remote CME?

To what router is the transcoder registered to?  Is it locally registered on the 2811 using "telephony-service" locally?  Or is it registered to the far end CME router, using the remote DSP resources?

Could you please clarify a little?

Also, is the call coming in on a dial-peer on the 2811 and going out over another outbound dial-peer on the 2811?

From the gateway that the call is traversing, ie: coming in on an inbound dial-peer and going out on an outbound dial-peer, please recreate the problem and send:

conf t

no logging console

logging buffered 10000000 deb

service sequence

exit

debug voip ccapi inout

debug ccsip message

sho run

sho version

Thank you very much, -Dave

bobl12345 Thu, 08/26/2010 - 07:53

Dave-

Thanks so much for your reply. Here is my set-up.

                  

                        +-----+

                        | CME |

                        +-----+           

                           |

                           |

+-----+               +----------+                +-----+

| 100 |<--- g729 ---> |   2811   |<--- g711  ---> | 101 |

+-----+     sip       |  PVDM-64 |      sip       +-----+

[email protected] +----------+                [email protected]

                          |

                          |

                        +--------+

                        |sip srv | session target 192.168.0.3

                        +--------+ (also hosts the two soft phones 100 @ 101)

The endpoints are generic SIP “soft” phones hosted on 192.168.0.3. This machine also hosts a generic SIP server which is set up to be the session “target” for the 100 @ 101 dial-peers.

I followed the instructions in the Cicso Unified manager Express System Admin Guide – configuring Transcoder Resources.

http://www.cisco.com/en/US/docs/voice_ip_comm/cucme/admin/configuration/guide/cmetrnsc.html#wp1010333

If there is a way to do this without involving CME I would be delighted.  I want the transcoding on the 2811 box. The CME seems to be sort of a fifth wheel in the setup.  All calls ingress and egress on 2811.

-Bob

Syslog logging: enabled (11 messages dropped, 1 messages rate-limited,

                0 flushes, 0 overruns, xml disabled, filtering disabled)

No Active Message Discriminator.

No Inactive Message Discriminator.

    Console logging: disabled

    Monitor logging: level debugging, 0 messages logged, xml disabled,

                     filtering disabled

    Buffer logging:  level debugging, 139 messages logged, xml disabled,

                     filtering disabled

    Logging Exception size (4096 bytes)

    Count and timestamp logging messages: disabled

    Persistent logging: disabled

    Trap logging: level informational, 58 message lines logged

Log Buffer (10000000 bytes):

000094: *Aug 26 14:18:03.931: %SYS-5-CONFIG_I: Configured from console by vty0 (xxx.xxx.21.96)

000095: *Aug 26 14:21:00.583: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Received:

INVITE sip:[email protected] SIP/2.0

Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest0

From: ;tag=04390a25test0

To:

Call-ID: test-192.168.0.3:1234

CSeq: 1 INVITE

Contact:

User-Agent: Abcd

Allow: INVITE

Allow: ACK

Allow: CANCEL

Allow: BYE

Allow: INFO

Max-Forwards: 70

Content-Type: application/sdp

Content-Length: 179

v=0

o=test 19128 14203282290 IN IP4 192.168.0.3

s=test session

c=IN IP4 192.168.0.3

t=0 0

m=audio 19128 RTP/AVP 18

a=rtpmap:18 G729/8000

a=fmtp:18 annexb=no

a=ptime:20

000096: *Aug 26 14:21:00.587: //27/xxxxxxxxxxxx/CCAPI/cc_api_caps_ind:

   Call Entry Is Not Found

000097: *Aug 26 14:21:00.591: //-1/FC492B81804C/CCAPI/cc_api_display_ie_subfields:

   cc_api_call_setup_ind_common:

   cisco-username=100

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

   cisco-ani=100

   cisco-anitype=0

   cisco-aniplan=0

   cisco-anipi=0

   cisco-anisi=0

   dest=101

   cisco-desttype=0

   cisco-destplan=0

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   cisco-rdntype=0

   cisco-rdnplan=0

   cisco-rdnpi=-1

   cisco-rdnsi=-1

   cisco-redirectreason=-1   fwd_final_type =0

   final_redirectNumber =

   hunt_group_timeout =0

000098: *Aug 26 14:21:00.591: //-1/FC492B81804C/CCAPI/cc_api_call_setup_ind_common:

   Interface=0x462C5D00, Call Info(

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

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

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

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

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

000099: *Aug 26 14:21:00.591: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

000100: *Aug 26 14:21:00.591: :cc_get_feature_vsa malloc success

000101: *Aug 26 14:21:00.591: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

000102: *Aug 26 14:21:00.591:  cc_get_feature_vsa count is 1

000103: *Aug 26 14:21:00.591: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

000104: *Aug 26 14:21:00.591: :FEATURE_VSA attributes are: feature_name:0,feature_time:1182534488,feature_id:27

000105: *Aug 26 14:21:00.591: //27/FC492B81804C/CCAPI/cc_api_call_setup_ind_common:

   Set Up Event Sent;

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

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

000106: *Aug 26 14:21:00.595: //27/FC492B81804C/CCAPI/cc_process_call_setup_ind:

   Event=0x467CF978

000107: *Aug 26 14:21:00.599: //27/FC492B81804C/CCAPI/ccCallSetContext:

   Context=0x478BD7F0

000108: *Aug 26 14:21:00.599: //27/FC492B81804C/CCAPI/cc_process_call_setup_ind:

   >>>>CCAPI handed cid 27 with tag 0 to app "_ManagedAppProcess_Default"

000109: *Aug 26 14:21:00.599: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Sent:

SIP/2.0 100 Trying

Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest0

From: ;tag=04390a25test0

To:

Date: Thu, 26 Aug 2010 14:21:00 GMT

Call-ID: test-192.168.0.3:1234

Server: Cisco-SIPGateway/IOS-12.x

CSeq: 1 INVITE

Allow-Events: telephone-event

Content-Length: 0

000110: *Aug 26 14:21:00.603: //27/FC492B81804C/CCAPI/ccCallProceeding:

   Progress Indication=NULL(0)

000111: *Aug 26 14:21:00.603: //27/FC492B81804C/CCAPI/ccCallSetupRequest:

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

   Outgoing Dial-peer=101, Params=0x478BC9C8, Progress Indication=NULL(0)

000112: *Aug 26 14:21:00.603: //27/FC492B81804C/CCAPI/ccCheckClipClir:

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

000113: *Aug 26 14:21:00.603: //27/FC492B81804C/CCAPI/ccCheckClipClir:

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

000114: *Aug 26 14:21:00.603: //27/FC492B81804C/CCAPI/ccCallSetupRequest:

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

000115: *Aug 26 14:21:00.603: //27/FC492B81804C/CCAPI/ccCallSetupRequest:

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

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

   Redirect Number=, Display Info=

   Account Number=100, Final Destination Flag=TRUE,

   Guid=FC492B81-B053-11DF-804C-90A0E9FADC8A, Outgoing Dial-peer=101

000116: *Aug 26 14:21:00.603: //27/FC492B81804C/CCAPI/cc_api_display_ie_subfields:

   ccCallSetupRequest:

   cisco-username=100

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

   cisco-ani=100

   cisco-anitype=0

   cisco-aniplan=0

   cisco-anipi=0

   cisco-anisi=0

   dest=101

   cisco-desttype=0

   cisco-destplan=0

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   cisco-rdntype=0

   cisco-rdnplan=0

   cisco-rdnpi=-1

   cisco-rdnsi=-1

   cisco-redirectreason=-1   fwd_final_type =0

   final_redirectNumber =

   hunt_group_timeout =0

000117: *Aug 26 14:21:00.607: //27/FC492B81804C/CCAPI/ccIFCallSetupRequestPrivate:

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

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

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

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

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

000118: *Aug 26 14:21:00.607: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

000119: *Aug 26 14:21:00.607: :cc_get_feature_vsa malloc success

000120: *Aug 26 14:21:00.607: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

000121: *Aug 26 14:21:00.607:  cc_get_feature_vsa count is 2

000122: *Aug 26 14:21:00.607: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

000123: *Aug 26 14:21:00.607: :FEATURE_VSA attributes are: feature_name:0,feature_time:1182534272,feature_id:28

000124: *Aug 26 14:21:00.607: //28/FC492B81804C/CCAPI/ccIFCallSetupRequestPrivate:

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

000125: *Aug 26 14:21:00.607: //28/FC492B81804C/CCAPI/ccCallSetContext:

   Context=0x478BC978

000126: *Aug 26 14:21:00.607: //27/FC492B81804C/CCAPI/ccSaveDialpeerTag:

   Outgoing Dial-peer=101

000127: *Aug 26 14:21:00.607: //28/FC492B81804C/CCAPI/cc_api_call_disconnected:

   Cause Value=65, Interface=0x462C5D00, Call Id=28

000128: *Aug 26 14:21:00.607: //28/FC492B81804C/CCAPI/cc_api_call_disconnected:

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

000129: *Aug 26 14:21:00.611: //28/FC492B81804C/CCAPI/cc_api_call_disconnected:

   Cause Value=47, Interface=0x462C5D00, Call Id=28

000130: *Aug 26 14:21:00.611: //28/FC492B81804C/CCAPI/cc_api_call_disconnected:

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

000131: *Aug 26 14:21:00.611: //27/xxxxxxxxxxxx/CCAPI/ccCallReleaseResources:

   release reserved xcoding resource.

000132: *Aug 26 14:21:00.611: //28/FC492B81804C/CCAPI/ccCallSetAAA_Accounting:

   Accounting=0, Call Id=28

000133: *Aug 26 14:21:00.611: //28/FC492B81804C/CCAPI/ccCallDisconnect:

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

000134: *Aug 26 14:21:00.611: //28/FC492B81804C/CCAPI/ccCallDisconnect:

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

000135: *Aug 26 14:21:00.611: //28/FC492B81804C/CCAPI/cc_api_call_disconnect_done:

   Disposition=-11, Interface=0x462C5D00, Tag=0x0, Call Id=28,

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

000136: *Aug 26 14:21:00.611: //28/FC492B81804C/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

000137: *Aug 26 14:21:00.611: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

000138: *Aug 26 14:21:00.611: :cc_free_feature_vsa freeing 467C0A78

000139: *Aug 26 14:21:00.611: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

000140: *Aug 26 14:21:00.611:  vsacount in free is 1

000141: *Aug 26 14:21:00.615: //27/FC492B81804C/CCAPI/ccCallDisconnect:

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

000142: *Aug 26 14:21:00.615: //27/FC492B81804C/CCAPI/ccCallDisconnect:

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

000143: *Aug 26 14:21:00.619: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Sent:

SIP/2.0 501 Not Implemented

Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest0

From: ;tag=04390a25test0

To: ;tag=7935888-E67

Date: Thu, 26 Aug 2010 14:21:00 GMT

Call-ID: test-192.168.0.3:1234

Server: Cisco-SIPGateway/IOS-12.x

CSeq: 1 INVITE

Allow-Events: telephone-event

Reason: Q.850;cause=65

Content-Length: 0

000144: *Aug 26 14:21:01.119: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Sent:

SIP/2.0 501 Not Implemented

Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest0

From: ;tag=04390a25test0

To: ;tag=7935888-E67

Date: Thu, 26 Aug 2010 14:21:00 GMT

Call-ID: test-192.168.0.3:1234

Server: Cisco-SIPGateway/IOS-12.x

CSeq: 1 INVITE

Allow-Events: telephone-event

Reason: Q.850;cause=65

Content-Length: 0

000145: *Aug 26 14:21:02.119: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Sent:

SIP/2.0 501 Not Implemented

Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest0

From: ;tag=04390a25test0

To: ;tag=7935888-E67

Date: Thu, 26 Aug 2010 14:21:00 GMT

Call-ID: test-192.168.0.3:1234

Server: Cisco-SIPGateway/IOS-12.x

CSeq: 1 INVITE

Allow-Events: telephone-event

Reason: Q.850;cause=65

Content-Length: 0

000146: *Aug 26 14:21:04.119: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Sent:

SIP/2.0 501 Not Implemented

Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest0

From: ;tag=04390a25test0

To: ;tag=7935888-E67

Date: Thu, 26 Aug 2010 14:21:00 GMT

Call-ID: test-192.168.0.3:1234

Server: Cisco-SIPGateway/IOS-12.x

CSeq: 1 INVITE

Allow-Events: telephone-event

Reason: Q.850;cause=65

Content-Length: 0

000147: *Aug 26 14:21:08.119: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Sent:

SIP/2.0 501 Not Implemented

Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest0

From: ;tag=04390a25test0

To: ;tag=7935888-E67

Date: Thu, 26 Aug 2010 14:21:00 GMT

Call-ID: test-192.168.0.3:1234

Server: Cisco-SIPGateway/IOS-12.x

CSeq: 1 INVITE

Allow-Events: telephone-event

Reason: Q.850;cause=65

Content-Length: 0

000148: *Aug 26 14:21:12.119: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Sent:

SIP/2.0 501 Not Implemented

Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest0

From: ;tag=04390a25test0

To: ;tag=7935888-E67

Date: Thu, 26 Aug 2010 14:21:00 GMT

Call-ID: test-192.168.0.3:1234

Server: Cisco-SIPGateway/IOS-12.x

CSeq: 1 INVITE

Allow-Events: telephone-event

Reason: Q.850;cause=65

Content-Length: 0

000149: *Aug 26 14:21:16.119: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Sent:

SIP/2.0 501 Not Implemented

Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest0

From: ;tag=04390a25test0

To: ;tag=7935888-E67

Date: Thu, 26 Aug 2010 14:21:00 GMT

Call-ID: test-192.168.0.3:1234

Server: Cisco-SIPGateway/IOS-12.x

CSeq: 1 INVITE

Allow-Events: telephone-event

Reason: Q.850;cause=65

Content-Length: 0

000150: *Aug 26 14:21:20.119: //27/FC492B81804C/CCAPI/cc_api_call_disconnect_done:

   Disposition=-11, Interface=0x462C5D00, Tag=0x0, Call Id=27,

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

000151: *Aug 26 14:21:20.119: //27/FC492B81804C/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

000152: *Aug 26 14:21:20.119: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

000153: *Aug 26 14:21:20.119: :cc_free_feature_vsa freeing 467C0B50

000154: *Aug 26 14:21:20.119: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

000155: *Aug 26 14:21:20.119:  vsacount in free is 0

000156: *Aug 26 14:24:20.123: //-1/xxxxxxxxxxxx/CCAPI/ccAppShutdownMode:

   ccAppShutdownMode: remove it from the queue

Building configuration...

Current configuration : 3162 bytes

!

version 12.4

service timestamps debug datetime msec

service timestamps log datetime msec

no service password-encryption

service sequence-numbers

!

hostname xxxxxx103

!

boot-start-marker

boot system flash c2800nm-ipvoicek9-mz.124-15.T5.bin

boot system flash c2800nm-ipvoice-mz

boot-end-marker

!

card type e1 1 1

logging buffered 10000000

no logging console

enable secret 5 $1$40e6$6DTSj.6Ls/N1FRIHK/9N00

!

no aaa new-model

network-clock-participate slot 1

dot11 syslog

!

!

ip cef

!

!

no ip domain lookup

multilink bundle-name authenticated

!

isdn switch-type primary-ni

!

voice-card 0

no dspfarm

!

voice-card 1

dspfarm

dsp services dspfarm

!

!

voice call carrier capacity active

voice dsp crash-dump file-limit 4

voice dsp crash-dump destination flash:DSPcrash.log

!

voice service pots

!

voice service voip

allow-connections sip to sip

sip

  no call service stop

!

!

voice class codec 1

codec preference 1 g729r8

!

!

!

!

!

!

!

!

!

!

!

voice hpi capture buffer 10000000

!

!

!

!

!

archive

log config

  hidekeys

!

!

controller E1 1/0

framing NO-CRC4

clock source internal

ds0-group 1 timeslots 7 type e&m-immediate-start dtmf dnis

description Cabled to GL Card #5 for subjective test.

!

controller E1 1/1

shutdown

!

!

!

!

!

interface FastEthernet0/0

description LVCC Voice LAN

ip address xxxxxxxxx202.233 255.255.254.0

duplex auto

speed auto

!

interface FastEthernet0/1

ip address 192.168.0.20 255.255.255.0

duplex auto

speed auto

!

ip default-gateway xxxxxxxxx202.1

ip forward-protocol nd

ip route 0.0.0.0 0.0.0.0 xxxxxxxxx202.1

!

!

ip http server

no ip http secure-server

!

!

!

!

control-plane

!

!

!

voice-port 1/0:1

!

!

!

sccp local FastEthernet0/0

sccp ccm xxxxxxxxx202.238 identifier 1 version 5.0.1

sccp

!

sccp ccm group 1

bind interface FastEthernet0/0

associate ccm 1 priority 1

associate profile 1 register 123456

keepalive retries 5

switchover method immediate

switchback method immediate

switchback interval 5

!

dspfarm profile 1 transcode

codec g711ulaw

codec g711alaw

codec g729ar8

codec g729abr8

codec g729r8

maximum sessions 5

associate application SCCP

!

!

dial-peer voice 2001 pots

destination-pattern 2001

!

dial-peer voice 5010 voip

destination-pattern 5010

no modem passthrough

session target ipv4:xxxxxxxxx202.231

dtmf-relay rtp-nte

playout-delay nominal 30

playout-delay minimum low

playout-delay mode fixed

codec g711alaw bytes 80

no vad

!

dial-peer voice 4722 pots

destination-pattern xxxxxx7334722

port 1/0:1

!

dial-peer voice 2003 pots

destination-pattern 2003

!

dial-peer voice 100 voip

service session

session protocol sipv2

session target ipv4:192.168.0.3

incoming called-number 100

!

dial-peer voice 101 voip

destination-pattern 101

session protocol sipv2

session target ipv4:192.168.0.3

codec g711alaw

!

!

gateway

timer receive-rtp 1200

!

sip-ua

!

!

telephony-service

sdspfarm units 4

sdspfarm transcode sessions 8

max-conferences 8 gain -6

transfer-system full-consult

!

!

line con 0

exec-timeout 0 0

privilege level 15

password cisco

line aux 0

password nvs

line vty 0 4

exec-timeout 0 0

privilege level 15

password cisco

no login

!

scheduler allocate 20000 1000

!

end

Cisco IOS Software, 2800 Software (C2800NM-IPVOICEK9-M), Version 12.4(15)T5, RELEASE SOFTWARE (fc4)

Technical Support: http://www.cisco.com/techsupport

Copyright (c) 1986-2008 by Cisco Systems, Inc.

Compiled Wed 30-Apr-08 14:17 by prod_rel_team

ROM: System Bootstrap, Version 12.4(13r)T, RELEASE SOFTWARE (fc1)

xxxxxx103 uptime is 1 day, 11 hours, 45 minutes

System returned to ROM by reload at 03:00:53 UTC Wed Aug 25 2010

System image file is "flash:c2800nm-ipvoicek9-mz.124-15.T5.bin"

This product contains cryptographic features and is subject to United

States and local country laws governing import, export, transfer and

use. Delivery of Cisco cryptographic products does not imply

third-party authority to import, export, distribute or use encryption.

Importers, exporters, distributors and users are responsible for

compliance with U.S. and local country laws. By using this product you

agree to comply with applicable laws and regulations. If you are unable

to comply with U.S. and local laws, return this product immediately.

A summary of U.S. laws governing Cisco cryptographic products may be found at:

http://www.cisco.com/wwl/export/crypto/tool/stqrg.html

If you require further assistance please contact us by sending email to

[email protected].

Cisco 2811 (revision 53.51) with 247808K/14336K bytes of memory.

Processor board ID FTX1202A2M7

2 FastEthernet interfaces

2 Channelized E1/PRI ports

DRAM configuration is 64 bits wide with parity enabled.

239K bytes of non-volatile configuration memory.

62720K bytes of ATA CompactFlash (Read/Write)

Configuration register is 0x2102

bobl12345 Thu, 08/26/2010 - 08:05

I corrected the above drawing to show correct g711/g729 endpoints in the setup.

                  

                        +-----+

                        | CME |

                        +-----+           

                           |

                           |

+-----+               +----------+                +-----+

| 100 |<--- g729 ---> |   2811   |<--- g711  ---> | 101 |

+-----+     sip       |  PVDM-64 |      sip       +-----+

[email protected] +----------+                [email protected]

                          |

                          |

                     +--------+

                     |sip srv | session target 192.168.0.3

                     +--------+ (also hosts the two soft phones 100 @ 101)

David Smith Thu, 08/26/2010 - 08:29

Hey Bob,

OK, thanks, here's what I see:

First off, you're not matching an incoming dial-peer, it's using dial-peer 0...which is the default IOS dial-peer.  This will break transcoding.

Called Number=101(TON=Unknown, NPI=Unknown),
Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,
Incoming Dial-peer=0, Progress Indication=NULL(0), Calling IE

Here are your corrected dial-peer configs:

dial-peer voice 100 voip
description ***To ext. 100***
no service session <------Remove this configuration, never want to use "service session".
destination-pattern 100
session protocol sipv2
session target ipv4:192.168.0.3
incoming called-number 101
codec g729r8
no vad

!

dial-peer voice 101 voip

description ***To ext. 101***

destination-pattern 101

incoming called-number 100

session protocol sipv2

session target ipv4:192.168.0.3

codec g711alaw

no vad

I'm assuming in this test bed 100 and 101 are your only extensions right now...so 100 is calling 101, and 101 is calling 100.

What the above config will do is ensure that everytime 100 calls 101, that incoming leg uses g729...then the outbound leg to 101 uses g711alaw.  Calls from 101 to 100 will use g711alaw on the inbound leg and g729 on the outbound leg to 100.  This will invoke a transcoder.  You need to traverse two dial-peers using dissimilar codecs in order to invoke your transcoder.  The above config should work.

Second, you're missing the "sdspfarm tag" command under telephony-service...for the transcoder.  Please add the below config:

conf t

telephony-service
sdspfarm tag 1 123456

exit

no sccp

sccp

exit

After adding the "sdspfarm tag" config,  just bounce SCCP to make sure everything regsiters correctly.

Let me know if that works.

bobl12345 Thu, 08/26/2010 - 09:56

Dave-

Thanks very much for your help.

====

I'm assuming in this test bed 100 and 101 are your only extensions right now...so 100 is calling 101, and 101 is calling 100.

What the above config will do is ensure that everytime 100 calls 101, that incoming leg uses g729...then the outbound leg to 101 uses g711alaw.  Calls from 101 to 100 will use g711alaw on the inbound leg and g729 on the outbound leg to 100.  This will invoke a transcoder.  You need to traverse two dial-peers using dissimilar codecs in order to invoke your transcoder.  The above config should work.

======

You are correct regarding call flow.

Thanks for the pointer on the dial-peer 0.

Still getting 501 not implemented per below...

-Bob

#show sdspfarm units
mtp-1 Device:123456 TCP socket:[-1]  UNREGISTERED
actual_stream:0 max_stream 0 IP:0.0.0.0  0  Unknown 0 keepalive 0

max-mtps:4, max-streams:16, alloc-streams:0, act-streams:0

Current configuration : 3301 bytes!

version 12.4

service timestamps debug datetime msec

service timestamps log datetime msec

no service password-encryption

service sequence-numbers

!

hostname xxxxxxx103

!

boot-start-marker

boot system flash c2800nm-ipvoicek9-mz.124-15.T5.bin

boot system flash c2800nm-ipvoice-mz

boot-end-marker

!

card type e1 1 1

logging buffered 10000000

no logging console

enable secret 5 $1$40e6$6DTSj.6Ls/N1FRIHK/9N00

!

no aaa new-model

network-clock-participate slot 1

dot11 syslog

!

!

ip cef

!

!

no ip domain lookup

multilink bundle-name authenticated

!

isdn switch-type primary-ni

!

voice-card 0

no dspfarm

!

voice-card 1

dspfarm

dsp services dspfarm

!

!

voice call carrier capacity active

voice dsp crash-dump file-limit 4

voice dsp crash-dump destination flash:DSPcrash.log

!

voice service pots

!

voice service voip

allow-connections sip to sip

sip

  no call service stop

!

!

voice class codec 1

codec preference 1 g729r8

!

!

!

!

!

!

!

!

!

!

!

voice hpi capture buffer 10000000

!

!

!

!

!

archive

log config

  hidekeys

!

!

controller E1 1/0

framing NO-CRC4

clock source internal

ds0-group 1 timeslots 7 type e&m-immediate-start dtmf dnis

description Cabled to GL Card #5 for subjective test.

!

controller E1 1/1

shutdown

!

!

!

!

!

interface FastEthernet0/0

description LVCC Voice LAN

ip address xxxxxxxxx.202.233 255.255.254.0

duplex auto

speed auto

!

interface FastEthernet0/1

ip address 192.168.0.20 255.255.255.0

duplex auto

speed auto

!

ip default-gateway xxxxxxxxx.202.1

ip forward-protocol nd

ip route 0.0.0.0 0.0.0.0 xxxxxxxxx.202.1

!

!

ip http server

no ip http secure-server

!

!

!

!

control-plane

!

!

!

voice-port 1/0:1

!

!

!

sccp local FastEthernet0/0

sccp ccm xxxxxxxxx.202.238 identifier 1 version 5.0.1

sccp

!

sccp ccm group 1

bind interface FastEthernet0/0

associate ccm 1 priority 1

associate profile 1 register 123456

keepalive retries 5

switchover method immediate

switchback method immediate

switchback interval 5

!

dspfarm profile 1 transcode

codec g711ulaw

codec g711alaw

codec g729ar8

codec g729abr8

codec g729r8

maximum sessions 5

associate application SCCP

!

!

dial-peer voice 2001 pots

destination-pattern 2001

!

dial-peer voice 5010 voip

destination-pattern 5010

no modem passthrough

session target ipv4:xxxxxxxxx.202.231

dtmf-relay rtp-nte

playout-delay nominal 30

playout-delay minimum low

playout-delay mode fixed

codec g711alaw bytes 80

no vad

!

dial-peer voice 4722 pots

destination-pattern xxxxxxxxx7334722

port 1/0:1

!

dial-peer voice 2003 pots

destination-pattern 2003

!

dial-peer voice 100 voip

description ***To Ext 100***

destination-pattern 100

session protocol sipv2

session target ipv4:192.168.0.3

incoming called-number 101

no vad

!

dial-peer voice 101 voip

description **** To ext 101*****

destination-pattern 101

session protocol sipv2

session target ipv4:192.168.0.3

incoming called-number 100

codec g711alaw

no vad

!

!

gateway

timer receive-rtp 1200

!

sip-ua

!

!

telephony-service

sdspfarm units 4

sdspfarm transcode sessions 8

sdspfarm tag 1 123456

max-conferences 8 gain -6

transfer-system full-consult

!

!

line con 0

exec-timeout 0 0

privilege level 15

password cisco

line aux 0

password nvs

line vty 0 4

exec-timeout 0 0

privilege level 15

password cisco

no login

!

scheduler allocate 20000 1000

!

End

000283: *Aug 26 16:16:31.098: //31/138CF5268056/CCAPI/cc_api_call_disconnect_done:

   Disposition=-11, Interface=0x462C5D00, Tag=0x0, Call Id=31,

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

000284: *Aug 26 16:16:31.098: //31/138CF5268056/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

000285: *Aug 26 16:16:31.098: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

000286: *Aug 26 16:16:31.098: :cc_free_feature_vsa freeing 467C0B50

000287: *Aug 26 16:16:31.098: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

000288: *Aug 26 16:16:31.098:  vsacount in free is 0

000289: *Aug 26 16:19:31.102: //-1/xxxxxxxxxxxx/CCAPI/ccAppShutdownMode:

   ccAppShutdownMode: remove it from the queue

000290: *Aug 26 16:25:01.694: %SYS-5-CONFIG_I: Configured from console by vty0 (xxxxxxxxx.21.96)

000291: *Aug 26 16:26:02.738: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Received:

INVITE sip:[email protected] SIP/2.0

Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest0

From: ;tag=4c3cec81test0

To:

Call-ID: test-192.168.0.3:abcd

CSeq: 1 INVITE

Contact:

User-Agent: XXXXXX

Allow: INVITE

Allow: ACK

Allow: CANCEL

Allow: BYE

Allow: INFO

Max-Forwards: 70

Content-Type: application/sdp

Content-Length: 178

v=0

o=test 19128 1167143870 IN IP4 192.168.0.3

s=test session

c=IN IP4 192.168.0.3

t=0 0

m=audio 19128 RTP/AVP 18

a=rtpmap:18 G729/8000

a=fmtp:18 annexb=no

a=ptime:20

000292: *Aug 26 16:26:02.746: //33/xxxxxxxxxxxx/CCAPI/cc_api_caps_ind:

   Call Entry Is Not Found

000293: *Aug 26 16:26:02.746: //-1/73EBDC0F805B/CCAPI/cc_api_display_ie_subfields:

   cc_api_call_setup_ind_common:

   cisco-username=100

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

   cisco-ani=100

   cisco-anitype=0

   cisco-aniplan=0

   cisco-anipi=0

   cisco-anisi=0

   dest=101

   cisco-desttype=0

   cisco-destplan=0

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   cisco-rdntype=0

   cisco-rdnplan=0

   cisco-rdnpi=-1

   cisco-rdnsi=-1

   cisco-redirectreason=-1   fwd_final_type =0

   final_redirectNumber =

   hunt_group_timeout =0

000294: *Aug 26 16:26:02.746: //-1/73EBDC0F805B/CCAPI/cc_api_call_setup_ind_common:

   Interface=0x462C5D00, Call Info(

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

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

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

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

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

000295: *Aug 26 16:26:02.746: //-1/73EBDC0F805B/CCAPI/ccCheckClipClir:

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

000296: *Aug 26 16:26:02.746: //-1/73EBDC0F805B/CCAPI/ccCheckClipClir:

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

000297: *Aug 26 16:26:02.746: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

000298: *Aug 26 16:26:02.746: :cc_get_feature_vsa malloc success

000299: *Aug 26 16:26:02.746: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

000300: *Aug 26 16:26:02.746:  cc_get_feature_vsa count is 1

000301: *Aug 26 16:26:02.746: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

000302: *Aug 26 16:26:02.750: :FEATURE_VSA attributes are: feature_name:0,feature_time:1182534488,feature_id:33

000303: *Aug 26 16:26:02.750: //33/73EBDC0F805B/CCAPI/cc_api_call_setup_ind_common:

   Set Up Event Sent;

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

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

000304: *Aug 26 16:26:02.750: //33/73EBDC0F805B/CCAPI/cc_process_call_setup_ind:

   Event=0x467CF978

000305: *Aug 26 16:26:02.754: //33/73EBDC0F805B/CCAPI/ccCallSetContext:

   Context=0x478C2EC0

000306: *Aug 26 16:26:02.754: //33/73EBDC0F805B/CCAPI/cc_process_call_setup_ind:

   >>>>CCAPI handed cid 33 with tag 100 to app "_ManagedAppProcess_Default"

000307: *Aug 26 16:26:02.758: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Sent:

SIP/2.0 100 Trying

Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest0

From: ;tag=4c3cec81test0

To:

Date: Thu, 26 Aug 2010 16:26:02 GMT

Call-ID: test-192.168.0.3:abcd

Server: Cisco-SIPGateway/IOS-12.x

CSeq: 1 INVITE

Allow-Events: telephone-event

Content-Length: 0

000308: *Aug 26 16:26:02.758: //33/73EBDC0F805B/CCAPI/ccCallProceeding:

   Progress Indication=NULL(0)

000309: *Aug 26 16:26:02.758: //33/73EBDC0F805B/CCAPI/ccCallSetupRequest:

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

   Outgoing Dial-peer=101, Params=0x478C2098, Progress Indication=NULL(0)

000310: *Aug 26 16:26:02.762: //33/73EBDC0F805B/CCAPI/ccCheckClipClir:

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

000311: *Aug 26 16:26:02.762: //33/73EBDC0F805B/CCAPI/ccCheckClipClir:

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

000312: *Aug 26 16:26:02.762: //33/73EBDC0F805B/CCAPI/ccCallSetupRequest:

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

000313: *Aug 26 16:26:02.762: //33/73EBDC0F805B/CCAPI/ccCallSetupRequest:

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

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

   Redirect Number=, Display Info=

   Account Number=100, Final Destination Flag=TRUE,

   Guid=73EBDC0F-B065-11DF-805B-90A0E9FADC8A, Outgoing Dial-peer=101

000314: *Aug 26 16:26:02.762: //33/73EBDC0F805B/CCAPI/cc_api_display_ie_subfields:

   ccCallSetupRequest:

   cisco-username=100

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

   cisco-ani=100

   cisco-anitype=0

   cisco-aniplan=0

   cisco-anipi=0

   cisco-anisi=0

   dest=101

   cisco-desttype=0

   cisco-destplan=0

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   cisco-rdntype=0

   cisco-rdnplan=0

   cisco-rdnpi=-1

   cisco-rdnsi=-1

   cisco-redirectreason=-1   fwd_final_type =0

   final_redirectNumber =

   hunt_group_timeout =0

000315: *Aug 26 16:26:02.762: //33/73EBDC0F805B/CCAPI/ccIFCallSetupRequestPrivate:

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

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

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

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

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

000316: *Aug 26 16:26:02.762: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

000317: *Aug 26 16:26:02.762: :cc_get_feature_vsa malloc success

000318: *Aug 26 16:26:02.762: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

000319: *Aug 26 16:26:02.762: cc_get_feature_vsa count is 2

000320: *Aug 26 16:26:02.762: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

000321: *Aug 26 16:26:02.762: :FEATURE_VSA attributes are: feature_name:0,feature_time:1182534272,feature_id:34

000322: *Aug 26 16:26:02.762: //34/73EBDC0F805B/CCAPI/ccIFCallSetupRequestPrivate:

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

000323: *Aug 26 16:26:02.762: //34/73EBDC0F805B/CCAPI/ccCallSetContext:

   Context=0x478C2048

000324: *Aug 26 16:26:02.762: //33/73EBDC0F805B/CCAPI/ccSaveDialpeerTag:

   Outgoing Dial-peer=101

000325: *Aug 26 16:26:02.766: //34/73EBDC0F805B/CCAPI/cc_api_call_disconnected:

   Cause Value=65, Interface=0x462C5D00, Call Id=34

000326: *Aug 26 16:26:02.766: //34/73EBDC0F805B/CCAPI/cc_api_call_disconnected:

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

000327: *Aug 26 16:26:02.766: //34/73EBDC0F805B/CCAPI/cc_api_call_disconnected:

   Cause Value=47, Interface=0x462C5D00, Call Id=34

000328: *Aug 26 16:26:02.766: //34/73EBDC0F805B/CCAPI/cc_api_call_disconnected:

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

000329: *Aug 26 16:26:02.766: //33/xxxxxxxxxxxx/CCAPI/ccCallReleaseResources:

   release reserved xcoding resource.

000330: *Aug 26 16:26:02.766: //34/73EBDC0F805B/CCAPI/ccCallSetAAA_Accounting:

   Accounting=0, Call Id=34

000331: *Aug 26 16:26:02.766: //34/73EBDC0F805B/CCAPI/ccCallDisconnect:

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

000332: *Aug 26 16:26:02.766: //34/73EBDC0F805B/CCAPI/ccCallDisconnect:

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

000333: *Aug 26 16:26:02.770: //34/73EBDC0F805B/CCAPI/cc_api_call_disconnect_done:

   Disposition=-11, Interface=0x462C5D00, Tag=0x0, Call Id=34,

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

000334: *Aug 26 16:26:02.770: //34/73EBDC0F805B/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

000335: *Aug 26 16:26:02.770: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

000336: *Aug 26 16:26:02.770: :cc_free_feature_vsa freeing 467C0A78

000337: *Aug 26 16:26:02.770: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

000338: *Aug 26 16:26:02.770:  vsacount in free is 1

000339: *Aug 26 16:26:02.774: //33/73EBDC0F805B/CCAPI/ccCallDisconnect:

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

000340: *Aug 26 16:26:02.774: //33/73EBDC0F805B/CCAPI/ccCallDisconnect:

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

000341: *Aug 26 16:26:02.774: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Sent:

SIP/2.0 501 Not Implemented

Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest0

From: ;tag=4c3cec81test0

To: ;tag=805D1D4-1E0D

Date: Thu, 26 Aug 2010 16:26:02 GMT

Call-ID: test-192.168.0.3:abcd

Server: Cisco-SIPGateway/IOS-12.x

CSeq: 1 INVITE

Allow-Events: telephone-event

Reason: Q.850;cause=65

Content-Length: 0

David Smith Thu, 08/26/2010 - 10:44

Where is this IP?  What is this IP that your registering the dspfarm to?

sccp  local FastEthernet0/0

sccp ccm xxxxxxxxx.202.238 identifier  1 version 5.0.1

sccp

Aren't you trying to use the DSP's on this local gateway for transcoding?  This would make the most sense, but I don't see this IP anywhere on this GW.

Also, under telephony-service, I just noticed...it's not active yet, you need to add at least 1 DN and one ephone:

telephony-service

sdspfarm units 4

sdspfarm  transcode sessions 8

sdspfarm tag 1  123456

max-conferences 8 gain -6

transfer-system full-consult

Add:

max-dn 1

max-ephone 1

Thanks, -Dave

bobl12345 Thu, 08/26/2010 - 11:39

(edited to correct typos & IP adresses, codecs below)

Dave-

OK - made the additional config changes and no joy with exact same 501 error per above.  I noticed that the docs say to use the mac address as the sdspfarm tag so I used that in the associated dspfarm profile and and sdspfarm tag below. I imagine it is just a convention but not sure.

My 2811 address is x.202.233.  my CME address is x.202.238.  I don't have CME running on my 2811.  I have been assuming that there is a way to have CME use a specific transcoder on my specific 2811 - do I need to set up ephone on the CME router to make this happen?

Is my understanding correct here (skiping the SIP  callflow)?

CM.238 is CME at x.x.x.238

2811.233 is 2811 at x.x.x.233

1. 100 dials into 2811 inviting 101 using g729

2. 2811.233 sends the 100 dial-peer info to CME.238  saying that it uses only g729

3. 2811.233 sends the 101 dial-peer info to CME.238 saying that it uses only g711

4. CME.238 looks at the two dial-peeers and says - ok, you can do that on dsps located at 2811.233

5 CME.238 sends back the messages needed to set up the g729 to g711 and g711 to g729 transcode channels internal to the 2811.233 (the end user is not aware of this, and SIP just issues a g711 INVITE to 101 endpoint)

6. The media starts flowing...?

My soft phones are just very simple, generic (non-cisco) sip clients.

I really appreciate your help here.  I'm just coming up to speed. Conceptually its a simple configuration. If there is a way to ditch CME.238 and hardwire the transcoding on the 2811.233 between these two endpoints, I'd be all for it :-)

-Bob

!
telephony-service
sdspfarm units 4
sdspfarm transcode sessions 8
sdspfarm tag 1 mtp001e7ae14148
max-ephones 1
max-dn 1
max-conferences 8 gain -6
transfer-system full-consult
!

Dspfarm Profile Configuration

Profile ID = 1, Service = TRANSCODING, Resource ID = 1
Profile Description :
Profile Admin State : UP
Profile Operation State : ACTIVE
Application : SCCP   Status : ASSOCIATED
Resource Provider : FLEX_DSPRM   Status : UP
Number of Resource Configured : 5
Number of Resource Available : 5
Codec Configuration
Codec : g711ulaw, Maximum Packetization Period : 30
Codec : g711alaw, Maximum Packetization Period : 30
Codec : g729ar8, Maximum Packetization Period : 60
Codec : g729abr8, Maximum Packetization Period : 60
Codec : g729r8, Maximum Packetization Period : 60


SLOT DSP VERSION  STATUS CHNL USE   TYPE   RSC_ID BRIDGE_ID PKTS_TXED PKTS_RXED

1    3   25.0.256 UP     N/A  FREE  xcode  1      -         -         -
1    3   25.0.256 UP     N/A  FREE  xcode  1      -         -         -
1    3   25.0.256 UP     N/A  FREE  xcode  1      -         -         -
1    3   25.0.256 UP     N/A  FREE  xcode  1      -         -         -
1    3   25.0.256 UP     N/A  FREE  xcode  1      -         -         -

Total number of DSPFARM DSP channel(s) 5

Steven Holl Thu, 08/26/2010 - 11:52

Bob,

Yes, you need you run CME to get the transcoder to register to itself locally.

You don't need to use the MAC address; it is convention that carries over from a requirement on older platforms.  It just needs to match what you specify in the sdspfarm spot under telephony-service.

Is your transcoder registered?  Does 'sh sccp' show it in an ACTIVE state?


If not, in addition to what Dave had you add, I think you need to actually add a bogus DN and ephone, too, like:

ephone-dn 1

number AAAA

ephone 1

mac cccc.cccc.cccc

button 1:1

And then build the config files:

telephony-service

cre cnf

If the issue still occurs, please collect this output:

sh run | s sccp|ccm|telephony|dspfarm|nterface

sh sccp

And then get these debugs for a call failure:

debug ccsip all

debug voip ccapi inout

bobl12345 Thu, 08/26/2010 - 12:03

Thanks, Dave -  Here is my config.  Regarding adding bogus ephone  -  do I do this on the CME router or my 2811 gateway?

-Bob

edited to add:  I thought I would test to see if the 2811.238 actually had a version of CME that I didn't know about as a hail mary, which is why that shows up as a sccp address. There are no dspfarm profiles associated with it, however.

Dspfarm Profile Configuration

Profile ID = 1, Service = TRANSCODING, Resource ID = 1
Profile Description :
Profile Admin State : UP
Profile Operation State : ACTIVE
Application : SCCP   Status : ASSOCIATED
Resource Provider : FLEX_DSPRM   Status : UP
Number of Resource Configured : 5
Number of Resource Available : 5
Codec Configuration
Codec : g711ulaw, Maximum Packetization Period : 30
Codec : g711alaw, Maximum Packetization Period : 30
Codec : g729ar8, Maximum Packetization Period : 60
Codec : g729abr8, Maximum Packetization Period : 60
Codec : g729r8, Maximum Packetization Period : 60

SCCP Admin State: UP
Gateway IP Address: xxxxxxx.202.233, Port Number: 2000
IP Precedence: 5
User Masked Codec list: None
Call Manager: xxxxxxx.202.233, Port Number: 2000
                Priority: N/A, Version: 3.1, Identifier: 2
Call Manager: xxxxxxx.202.238, Port Number: 2000
                Priority: N/A, Version: 5.0.1, Identifier: 1

Transcoding Oper State: ACTIVE - Cause Code: NONE
Active Call Manager: xxxxxxx.202.238, Port Number: 2000
TCP Link Status: CONNECTED, Profile Identifier: 1
Reported Max Streams: 10, Reported Max OOS Streams: 0
Supported Codec: g711ulaw, Maximum Packetization Period: 30
Supported Codec: g711alaw, Maximum Packetization Period: 30
Supported Codec: g729ar8, Maximum Packetization Period: 60
Supported Codec: g729abr8, Maximum Packetization Period: 60
Supported Codec: g729r8, Maximum Packetization Period: 60
Supported Codec: rfc2833 dtmf, Maximum Packetization Period: 30
Supported Codec: rfc2833 pass-thru, Maximum Packetization Period: 30
Supported Codec: inband-dtmf to rfc2833 conversion, Maximum Packetization Period: 30

David Smith Thu, 08/26/2010 - 12:06

Bob,

I don't entirely understand how/why CCME works into this, you have a 2811 which hosts the DSP resources, then you have two SIP softphones registered to the sip server on your pc at the 192.168.0.3.  The call comes in from ext. 100 at 192.168.0.3 destined for 101 at 192.168.0.3.  You don't need CCME here at all.

Your transcoder should be registered locally, not have anything to do with a remote CCME.

You only need telephony-service (which enables CCME function) configured on the 2811 locally...so that you can host an SCCP engine to register the xcoder to.

Do this, all on the 2811:

conf t

no sccp

dspfarm profile 1

shut

no sccp ccm group 1

no sccp ccm xxxxxxxxx.202.238 identifier 1 version 5.0.1  (remove the .238 address)

sccp ccm xxxxxxxxx.202.233 id 1 version 5.0.1 (add the .233 LOCAL address)

sccp ccm  group 1

bind  interface FastEthernet0/0

associate   ccm 1 priority 1

associate  profile 1 register 123456

keepalive   retries 5

switchover  method immediate

switchback  method  immediate

switchback  interval 5

conf t

dspfarm profile 1

no shut

sccp

telephony-service

sdspfarm units 4

sdspfarm  transcode  sessions 8

sdspfarm tag 1  123456

max-conferences 8 gain -6

transfer-system  full-consult

max-dn 1

max-ephone 1

This is abbreviated, but those are the steps you need.  This removes the remote CCME entirely, it's not needed.

This then registers the transcoder locally.

After doing this can you send a new:

sho run

sho sccp all

sho dspfarm profile 1

Thanks, -Dave

David Smith Thu, 08/26/2010 - 12:21

In addition to my above reply, I almost forgot, under telephony-service you need the "ip source-address" config:

telephony-service

max-dn 1

max-ephone  1

ip source-address xxxxxxxxx.202.233 port 2000

sdspfarm units 4

sdspfarm  transcode   sessions 8

sdspfarm tag 1  123456

max-conferences 8 gain -6

transfer-system   full-consult

bobl12345 Thu, 08/26/2010 - 12:56

Dave - We have joy.   Here is a thing of beauty.... :-)

I saw that the docs mentiion the ip source-addr but it only discusses this in context of "unified cisco phones". I had no clue what the implication of that is with my own server/phones.

The callflow below shows both legs of the call.

I am going to try a few more things to see if I can get it to accept g729br8 (i.e. annex b with vad) .  But first I will try to remember how to tftp the config and then burn it into flash.

That's at least one virtual pint i owe you!

For clarity - the spew below is from my sip server.

!

!

INVITE sip:[email protected] SIP/2.0

Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest0

From: ;tag=650e3c94test0

To:

Call-ID: test-192.168.0.3:9128-19128

CSeq: 1 INVITE

Contact:

User-Agent: Zzzzz Zzzzz

Allow: INVITE

Allow: ACK

Allow: CANCEL

Allow: BYE

Allow: INFO

Max-Forwards: 70

Content-Type: application/sdp

Content-Length: 179

v=0

o=test 19128 19478920320 IN IP4 192.168.0.3

s=test session

c=IN IP4 192.168.0.3

t=0 0

m=audio 19128 RTP/AVP 18

a=rtpmap:18 G729/8000

a=fmtp:18 annexb=no

a=ptime:20

!

!

00:00:01.522 DEBUG    sipRecv:166

SIP/2.0 100 Trying

Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest0

From: ;tag=650e3c94test0

To:

Date: Thu, 26 Aug 2010 19:49:47 GMT

Call-ID: test-192.168.0.3:9128-19128

Server: Cisco-SIPGateway/IOS-12.x

CSeq: 1 INVITE

Allow-Events: telephone-event

Content-Length: 0

!

!

00:00:01.540 DEBUG    sipRecv:166

INVITE sip:[email protected]:5060 SIP/2.0

Via: SIP/2.0/UDP 192.168.0.20:5060;branch=z9hG4bK1B16F9

Remote-Party-ID: ;party=calling;screen=no;privacy=off

From: ;tag=8C05B8C-225B

To:

Date: Thu, 26 Aug 2010 19:49:47 GMT

Call-ID: [email protected]

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

Min-SE:  1800

Cisco-Guid: 3935304414-2961248735-2156433568-3925531786

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

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

CSeq: 101 INVITE

Timestamp: 1282852187

Contact:

Expires: 180

Allow-Events: telephone-event

Max-Forwards: 69

Content-Type: application/sdp

Content-Disposition: session;handling=required

Content-Length: 191

v=0

o=CiscoSystemsSIP-GW-UserAgent 2106 4030 IN IP4 192.168.0.20

s=SIP Call

c=IN IP4 192.168.0.20

t=0 0

m=audio 19082 RTP/AVP 8

c=IN IP4 192.168.0.20

a=rtpmap:8 PCMA/8000

a=ptime:20

478920320

!

!

00:00:01.655 DEBUG    sipSend:128

SIP/2.0 200 OK

Via: SIP/2.0/UDP 192.168.0.20:5060;branch=z9hG4bK1B16F9

From: ;tag=8C05B8C-225B

To: ;tag=5879f420test1

Call-ID: [email protected]

CSeq: 101 INVITE

Contact:

Content-Type: application/sdp

Allow: INVITE

Allow: ACK

Allow: CANCEL

Allow: BYE

Allow: INFO

User-Agent: Zzzzz Zzzzz

Content-Length: 177

v=0

o=test 9128 6358968291 IN IP4 192.168.0.3

s=test session

c=IN IP4 192.168.0.3

t=0 0

m=audio 9128 RTP/AVP 8 13

a=rtpmap:8 PCMA/8000

a=rtpmap:13 CN/8000

a=ptime:20

!

!

00:00:01.668 DEBUG    sipRecv:166

ACK sip:[email protected]:5060 SIP/2.0

Via: SIP/2.0/UDP 192.168.0.20:5060;branch=z9hG4bK1C21ED

From: ;tag=8C05B8C-225B

To: ;tag=5879f420test1

Date: Thu, 26 Aug 2010 19:49:47 GMT

Call-ID: [email protected]

Max-Forwards: 70

CSeq: 101 ACK

Allow-Events: telephone-event

Content-Length: 0

!

!

00:00:01.675 DEBUG    sipRecv:166

SIP/2.0 200 OK

Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest0

From: ;tag=650e3c94test0

To: ;tag=8C05C14-5FA

Date: Thu, 26 Aug 2010 19:49:47 GMT

Call-ID: test-192.168.0.3:9128-19128

Server: Cisco-SIPGateway/IOS-12.x

CSeq: 1 INVITE

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

Allow-Events: telephone-event

Remote-Party-ID: ;party=called;screen=no;privacy=off

Contact:

Supported: replaces

Content-Type: application/sdp

Content-Disposition: session;handling=required

Content-Length: 214

v=0

o=CiscoSystemsSIP-GW-UserAgent 7542 9828 IN IP4 192.168.0.20

s=SIP Call

c=IN IP4 192.168.0.20

t=0 0

m=audio 17834 RTP/AVP 18

c=IN IP4 192.168.0.20

a=rtpmap:18 G729/8000

a=fmtp:18 annexb=no

a=ptime:20

!

!

00:00:01.675 DEBUG    sipSend:128

ACK sip:[email protected] SIP/2.0

Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest1

From: ;tag=650e3c94test0

To: ;tag=8C05C14-5FA

Call-ID: test-192.168.0.3:9128-19128

CSeq: 1 ACK

Contact:

User-Agent: Zzzzz Zzzzz

Allow: INVITE

Allow: ACK

Allow: CANCEL

Allow: BYE

Allow: INFO

Max-Forwards: 70

Content-Length: 0

Message was edited by: bobl12345 - edited for clarity

bobl12345 Thu, 08/26/2010 - 12:29

Dave-

My 2811 sccp status isn't happy unless it registers with CME.238.    I don't have a local CME on the 233 machine.  It really seems like if you don't have CME hosted somewhere on your LAN (along with a dsp farm) you are out of luck for transcoding.

-Bob

SCCP Admin State: UP

Gateway IP Address: xxxxxxx.202.233, Port Number: 2000

IP Precedence: 5

User Masked Codec list: None

Call Manager: xxxxxxx.202.233, Port Number: 2000

                Priority: N/A, Version: 5.0.1, Identifier: 1

Transcoding Oper State: ACTIVE_IN_PROGRESS - Cause Code: TCP_CONN_ERROR

Active Call Manager: NONE

TCP Link Status: NOT_CONNECTED, Profile Identifier: 1

Reported Max Streams: 10, Reported Max OOS Streams: 0

Supported Codec: g711ulaw, Maximum Packetization Period: 30

Supported Codec: g711alaw, Maximum Packetization Period: 30

Supported Codec: g729ar8, Maximum Packetization Period: 60

Supported Codec: g729abr8, Maximum Packetization Period: 60

Supported Codec: g729r8, Maximum Packetization Period: 60

Supported Codec: rfc2833 dtmf, Maximum Packetization Period: 30

Supported Codec: rfc2833 pass-thru, Maximum Packetization Period: 30

Supported Codec: inband-dtmf to rfc2833 conversion, Maximum Packetization Period: 30

SCCP Application Service(s) Statistics:

Profile Identifier: 1, Service Type: Transcoding

TCP packets rx 0, tx 0

Unsupported pkts rx 0, Unrecognized pkts rx 0

Register tx 0, successful 0, rejected 0, failed 0

KeepAlive tx 0, successful 0, failed 0

OpenReceiveChannel rx 0, successful 0, failed 0

CloseReceiveChannel rx 0, successful 0, failed 0

StartMediaTransmission rx 0, successful 0, failed 0

StopMediaTransmission rx 0, successful 0, failed 0

PortReq rx 0

PortRes tx 0, successful 0, failed 0

PortClose rx 0

QosListen rx 0

QosPath rx 0

QosTeardown rx 0, send 0, recv 0, sendrecv 0

QosResvNotify tx 0, send 0, recv 0, sendrecv 0

QosErrorNotify tx 0, send 0, recv 0, sendrecv 0

   err0 0, err1 0, err2 0, err3 0, err4 0, err5 0,

   err6 0, err7 0, err8 0, err9 0, err10 0, err11 0,

   err12 0

QosModify rx 0, send 0, recv 0, sendrecv 0

UpdateDscp rx 0

Reset rx 0, successful 0, failed 0

MediaStreamingFailure rx 0

MediaStreamingFailure tx 0

Switchover 0, Switchback 0

CCM Group Identifier: 1

Description: None

Binded Interface: FastEthernet0/0, IP Address: xxxxxxx.202.233

Associated CCM Id: 1, Priority in this CCM Group: 1

Associated Profile: 1, Registration Name: 123456

Registration Retries: 3, Registration Timeout: 10 sec

Keepalive Retries: 5, Keepalive Timeout: 30 sec

CCM Connect Retries: 3, CCM Connect Interval: 10 sec

Switchover Method: IMMEDIATE, Switchback Method: IMMEDIATE

Switchback Interval: 5 sec, Switchback Timeout: 0 sec

Signaling DSCP value: cs3, Audio DSCP value: ef

Total number of active session(s) 0, and connection(s) 0

Total number of active session(s) 0, and connection(s) 0

Total number of active session(s) 0, connection(s) 0, and callegs 0

SCCP Application Service(s) Statistics Summary:

Total Conferencing Sessions: 0, Connections: 0

Total Transcoding Sessions: 0, Connections: 0

Total MTP Sessions: 0, Connections: 0

Total ALG-Phone Sessions: 0, Connections: 0

Total BRI-Phone Sessions: 0, Connections: 0

Total SCCP Sessions: 0, Connections: 0

Total active sessions 0, connections 0, rsvp sessions 0

Dspfarm Profile Configuration

Profile ID = 1, Service = TRANSCODING, Resource ID = 1

Profile Description :

Profile Admin State : UP

Profile Operation State : ACTIVE IN PROGRESS

Application : SCCP   Status : ASSOCIATION IN PROGRESS

Resource Provider : FLEX_DSPRM   Status : UP

Number of Resource Configured : 5

Number of Resource Available : 5

Codec Configuration

Codec : g711ulaw, Maximum Packetization Period : 30

Codec : g711alaw, Maximum Packetization Period : 30

Codec : g729ar8, Maximum Packetization Period : 60

Codec : g729abr8, Maximum Packetization Period : 60

Codec : g729r8, Maximum Packetization Period : 60

SLOT DSP VERSION  STATUS CHNL USE   TYPE   RSC_ID BRIDGE_ID PKTS_TXED PKTS_RXED

1    3   25.0.256 UP     N/A  FREE  xcode  1      -         -         -

1    3   25.0.256 UP     N/A  FREE  xcode  1      -         -         -

1    3   25.0.256 UP     N/A  FREE  xcode  1      -         -         -

1    3   25.0.256 UP     N/A  FREE  xcode  1      -         -         -

1    3   25.0.256 UP     N/A  FREE  xcode  1      -         -         -

Total number of DSPFARM DSP channel(s) 5

David Smith Thu, 08/26/2010 - 13:02

Hey Bob,

When you configure "telephony-service" like you have on the 2811, this is CCME...you are configuring the telephon-service SCCP engine which runs CCME.

From your 2811 send me a new:

sho run

Thanks, -Dave

bobl12345 Thu, 08/26/2010 - 13:10

Dave -

Here is the config from the working model above...

-Bob

Building configuration...

Current configuration : 3457 bytes

!

version 12.4

service timestamps debug datetime msec

service timestamps log datetime msec

no service password-encryption

service sequence-numbers

!

hostname zzzzz103

!

boot-start-marker

boot system flash c2800nm-ipvoicek9-mz.124-15.T5.bin

boot system flash c2800nm-ipvoice-mz

boot-end-marker

!

card type e1 1 1

logging buffered 10000000

no logging console

enable secret 5 $1$40e6$6DTSj.6Ls/N1FRIHK/9N00

!

no aaa new-model

network-clock-participate slot 1

dot11 syslog

!

!

ip cef

!

!

no ip domain lookup

multilink bundle-name authenticated

!

isdn switch-type primary-ni

!

voice-card 0

no dspfarm

!

voice-card 1

dspfarm

dsp services dspfarm

!

!

voice call carrier capacity active

voice dsp crash-dump file-limit 4

voice dsp crash-dump destination flash:DSPcrash.log

!

voice service pots

!

voice service voip

allow-connections sip to sip

sip

  no call service stop

!

!

voice class codec 1

codec preference 1 g729r8

!

!

!

!

!

!

!

!

!

!

!

voice hpi capture buffer 10000000

!

!

!

!

!

archive

log config

  hidekeys

!

!

controller E1 1/0

framing NO-CRC4

clock source internal

ds0-group 1 timeslots 7 type e&m-immediate-start dtmf dnis

description Cabled to GL Card #5 for subjective test.

!

controller E1 1/1

shutdown

!

!

!

!

!

interface FastEthernet0/0

description LVCC Voice LAN

ip address zzzzz.202.233 255.255.254.0

duplex auto

speed auto

!

interface FastEthernet0/1

ip address 192.168.0.20 255.255.255.0

duplex auto

speed auto

!

ip default-gateway zzzzz.202.1

ip forward-protocol nd

ip route 0.0.0.0 0.0.0.0 zzzzz.202.1

!

!

ip http server

no ip http secure-server

!

!

!

!

control-plane

!

!

!

voice-port 1/0:1

!

!

!

sccp local FastEthernet0/0

sccp ccm zzzzz.202.233 identifier 1 version 5.0.1

sccp

!

sccp ccm group 1

bind interface FastEthernet0/0

associate ccm 1 priority 1

associate profile 1 register 123456

keepalive retries 5

switchover method immediate

switchback method immediate

switchback interval 5

!

dspfarm profile 1 transcode

codec g711ulaw

codec g711alaw

codec g729ar8

codec g729abr8

codec g729r8

maximum sessions 5

associate application SCCP

!

!

dial-peer voice 2001 pots

destination-pattern 2001

!

dial-peer voice 5010 voip

destination-pattern 5010

no modem passthrough

session target ipv4:zzzzz.202.231

dtmf-relay rtp-nte

playout-delay nominal 30

playout-delay minimum low

playout-delay mode fixed

codec g711alaw bytes 80

no vad

!

dial-peer voice 4722 pots

destination-pattern zzzzz7334722

port 1/0:1

!

dial-peer voice 2003 pots

destination-pattern 2003

!

dial-peer voice 100 voip

description ***To Ext 100***

destination-pattern 100

session protocol sipv2

session target ipv4:192.168.0.3

incoming called-number 101

no vad

!

dial-peer voice 101 voip

description **** To ext 101*****

destination-pattern 101

session protocol sipv2

session target ipv4:192.168.0.3

incoming called-number 100

codec g711alaw

no vad

!

!

gateway

timer receive-rtp 1200

!

sip-ua

!

!

telephony-service

sdspfarm units 4

sdspfarm transcode sessions 8

sdspfarm tag 1 123456

max-ephones 1

max-dn 1

ip source-address zzzzz.202.233 port 2000

max-conferences 8 gain -6

transfer-system full-consult

!

!

ephone-dn  1

number AAAA

!

!

ephone  1

mac-address CCCC.CCCC.CCCC

button  1:1

!

!

!

line con 0

exec-timeout 0 0

privilege level 15

password cisco

line aux 0

password nvs

line vty 0 4

exec-timeout 0 0

privilege level 15

password cisco

no login

!

scheduler allocate 20000 1000

!

end

David Smith Thu, 08/26/2010 - 13:16

Your config looks good, only one problem I see:

telephony-service

sdspfarm  units 4

sdspfarm transcode sessions 8  <------Change this to 5

sdspfarm  tag 1 123456

max-ephones 1

max-dn  1

ip source-address zzzzz.202.233 port 2000

max-conferences  8 gain -6

transfer-system full-consult

conf t

telephony-service

sdspfarm transcode sessions 5

exit

no sccp

sccp

This should register your profile locally.

You do have DSP's on this 2811 right?

Thanks, -Dave

bobl12345 Thu, 08/26/2010 - 13:29

Dave -

My 2811 has 4 PVDM slots filled, each occupied with PVDM2-64s.  I am going to do some additional testing with real media traffic and I'll report back with results.   Thanks again for sticking with me on this!

-Bob

David Smith Thu, 08/26/2010 - 13:45

NP, but if you get stuck I'd suggest opening a TAC case, that way we can log in and look at everything with you...much easier than going back and
forth.

Your pertinent configs are attached, see below:

/* Style Definitions */ table.MsoNormalTable {mso-style-name:"Table Normal"; mso-tstyle-rowband-size:0; mso-tstyle-colband-size:0; mso-style-noshow:yes; mso-style-priority:99; mso-style-qformat:yes; mso-style-parent:""; mso-padding-alt:0in 5.4pt 0in 5.4pt; mso-para-margin:0in; mso-para-margin-bottom:.0001pt; mso-pagination:widow-orphan; font-size:11.0pt; font-family:"Calibri","sans-serif"; mso-ascii-font-family:Calibri; mso-ascii-theme-font:minor-latin; mso-fareast-font-family:"Times New Roman"; mso-fareast-theme-font:minor-fareast; mso-hansi-font-family:Calibri; mso-hansi-theme-font:minor-latin; mso-bidi-font-family:"Times New Roman"; mso-bidi-theme-font:minor-bidi;}

voice-card 0

dspfarm

dsp services dspfarm

voice-card 1

dspfarm

dsp services dspfarm

sccp local FastEthernet0/0

sccp ccm zzzzz.202.233 identifier 1 version 5.0.1

sccp

sccp ccm group 1

bind interface FastEthernet0/0

associate ccm 1 priority 1

associate profile 1 register 123456

keepalive retries 5

switchover method immediate

switchback method immediate

switchback interval 5

dspfarm profile 1 transcode

codec g711ulaw

codec g711alaw

codec g729ar8

codec g729abr8

codec g729r8

maximum sessions 5

associate application SCCP

telephony-service

sdspfarm  units 4

sdspfarm transcode sessions 5

sdspfarm  tag 1 123456

max-ephones 1

max-dn  1

ip source-address zzzzz.202.233 port 2000

max-conferences  8 gain -6

transfer-system full-consult

If you have your DSP's in the PVDM slots, on the motherboard, then you need to farm them out from "voice-card 0" like in the above config.

Other than that, everything looks fine.

Thanks, -Dave

bobl12345 Thu, 08/26/2010 - 13:55

Thanks, Dave-

Just to confirm, you saw the SIP call flow I posted above showing success?  The thread is sort of fragmented so I want to make sure you saw that.

I am going to run some call tests to make sure the media is OK.

-Bob

bobl12345 Fri, 08/27/2010 - 16:50

Dave-

Many thanks again for the help. I have one small remaining glitch. My media from g711 to g729 is good quality. My media from g729 to g711 results in "comfort noise" out of the 2811 g711 side (see #3 below) . So I have only half the duplex working.

I'm sending in vanilla g729 at 10 msec. No annex b.

Here is what I've done so far to debug-

1. Verified my originating g711, g729 streams and the terminating 2811 g729 streams are all good qualty by using audio packet reference tool.

2.  Captured the g729 packets output from the good leg of the duplex (i.e. the g711 to g729 output from the 2811) and then fed them back into g729 input side of the 2811 just to absolutely remove any rtp/g729 format problem on my end (I prevented hall of mirrors by just running a few seconds and analyzing the g711 data).

3. When I look at (and listen to)  the g711 audio output from the 2811 - it seems like 100% comfort noise, however VAD is off. It is definately not all "zero or idle" and definately not wild data.  Seems to be inserting nothing but legit comfort noise. The noise is in regular g711a packets, rather than special CN pkts.

I'm going to try to add another ephone just in case it nees to see two phantom endpoints.

Config is exactly same as in above posts.  Hoping this rings a bell and its a simple config setting I am missing.

-Bob

Message was edited by: bobl12345  edited to add clarification of comfort noise

bobl12345 Fri, 08/27/2010 - 19:12

Adding log file...

Received:
INVITE sip:[email protected] SIP/2.0
Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest0
From: ;tag=2296c25ftest0
To:
Call-ID: test-192.168.0.3:9128-19128
CSeq: 1 INVITE
Contact:
User-Agent: zzzzz zzzzzzzz
Allow: INVITE
Allow: ACK
Allow: CANCEL
Allow: BYE
Allow: INFO
Max-Forwards: 70
Content-Type: application/sdp
Content-Length: 178

v=0
o=test 19128 6729127220 IN IP4 192.168.0.3
s=test session
c=IN IP4 192.168.0.3
t=0 0
m=audio 19128 RTP/AVP 18
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:10

003396: *Aug 28 00:03:34.141: //116/xxxxxxxxxxxx/CCAPI/cc_api_caps_ind:
   Call Entry Is Not Found
003397: *Aug 28 00:03:34.141: //-1/88A41A6280D8/CCAPI/cc_api_display_ie_subfields:
   cc_api_call_setup_ind_common:
   cisco-username=100
   ----- ccCallInfo IE subfields -----
   cisco-ani=100
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=101
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=FFFFFFFF
   cisco-rdn=
   cisco-rdntype=0
   cisco-rdnplan=0
   cisco-rdnpi=-1
   cisco-rdnsi=-1
   cisco-redirectreason=-1   fwd_final_type =0
   final_redirectNumber =
   hunt_group_timeout =0

003398: *Aug 28 00:03:34.145: //-1/88A41A6280D8/CCAPI/cc_api_call_setup_ind_common:
   Interface=0x45F683C0, Call Info(
   Calling Number=100,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=101(TON=Unknown, NPI=Unknown),
   Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,
   Incoming Dial-peer=100, Progress Indication=NULL(0), Calling IE Present=TRUE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=116
003399: *Aug 28 00:03:34.145: //-1/88A41A6280D8/CCAPI/ccCheckClipClir:
   In: Calling Number=100(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
003400: *Aug 28 00:03:34.145: //-1/88A41A6280D8/CCAPI/ccCheckClipClir:
   Out: Calling Number=100(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
003401: *Aug 28 00:03:34.145: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

003402: *Aug 28 00:03:34.145: :cc_get_feature_vsa malloc success
003403: *Aug 28 00:03:34.145: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

003404: *Aug 28 00:03:34.145:  cc_get_feature_vsa count is 1
003405: *Aug 28 00:03:34.145: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

003406: *Aug 28 00:03:34.145: :FEATURE_VSA attributes are: feature_name:0,feature_time:1175235856,feature_id:116
003407: *Aug 28 00:03:34.145: //116/88A41A6280D8/CCAPI/cc_api_call_setup_ind_common:
   Set Up Event Sent;
   Call Info(Calling Number=100(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=101(TON=Unknown, NPI=Unknown))
003408: *Aug 28 00:03:34.145: //116/88A41A6280D8/CCAPI/cc_process_call_setup_ind:
   Event=0x472E30E8
003409: *Aug 28 00:03:34.153: //116/88A41A6280D8/CCAPI/ccCallSetContext:
   Context=0x482266A8
003410: *Aug 28 00:03:34.153: //116/88A41A6280D8/CCAPI/cc_process_call_setup_ind:
   >>>>CCAPI handed cid 116 with tag 100 to app "_ManagedAppProcess_Default"
003411: *Aug 28 00:03:34.153: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest0
From: ;tag=2296c25ftest0
To:
Date: Sat, 28 Aug 2010 00:03:34 GMT
Call-ID: test-192.168.0.3:9128-19128
Server: Cisco-SIPGateway/IOS-12.x
CSeq: 1 INVITE
Allow-Events: telephone-event
Content-Length: 0

003412: *Aug 28 00:03:34.153: //116/88A41A6280D8/CCAPI/ccCallProceeding:
   Progress Indication=NULL(0)
003413: *Aug 28 00:03:34.157: //116/88A41A6280D8/CCAPI/ccCallSetupRequest:
   Destination=, Calling IE Present=TRUE, Mode=0,
   Outgoing Dial-peer=101, Params=0x48227570, Progress Indication=NULL(0)
003414: *Aug 28 00:03:34.157: //116/88A41A6280D8/CCAPI/ccCheckClipClir:
   In: Calling Number=100(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
003415: *Aug 28 00:03:34.157: //116/88A41A6280D8/CCAPI/ccCheckClipClir:
   Out: Calling Number=100(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
003416: *Aug 28 00:03:34.157: //116/88A41A6280D8/CCAPI/ccCallSetupRequest:
   Destination Pattern=101, Called Number=101, Digit Strip=FALSE
003417: *Aug 28 00:03:34.157: //116/88A41A6280D8/CCAPI/ccCallSetupRequest:
   Calling Number=100(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=101(TON=Unknown, NPI=Unknown),
   Redirect Number=, Display Info=
   Account Number=100, Final Destination Flag=TRUE,
   Guid=88A41A62-B16E-11DF-80D8-A52D4E45C415, Outgoing Dial-peer=101
003418: *Aug 28 00:03:34.157: //116/88A41A6280D8/CCAPI/cc_api_display_ie_subfields:
   ccCallSetupRequest:
   cisco-username=100
   ----- ccCallInfo IE subfields -----
   cisco-ani=100
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=101
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=FFFFFFFF
   cisco-rdn=
   cisco-rdntype=0
   cisco-rdnplan=0
   cisco-rdnpi=-1
   cisco-rdnsi=-1
   cisco-redirectreason=-1   fwd_final_type =0
   final_redirectNumber =
   hunt_group_timeout =0

003419: *Aug 28 00:03:34.157: //116/88A41A6280D8/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x45F683C0, Interface Type=3, Destination=, Mode=0x0,
   Call Params(Calling Number=100,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=101(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=101, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
003420: *Aug 28 00:03:34.157: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

003421: *Aug 28 00:03:34.157: :cc_get_feature_vsa malloc success
003422: *Aug 28 00:03:34.157: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

003423: *Aug 28 00:03:34.157:  cc_get_feature_vsa count is 2
003424: *Aug 28 00:03:34.157: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

003425: *Aug 28 00:03:34.161: :FEATURE_VSA attributes are: feature_name:0,feature_time:1175236720,feature_id:117
003426: *Aug 28 00:03:34.161: //117/88A41A6280D8/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=3, FlowMode=1
003427: *Aug 28 00:03:34.161: //117/88A41A6280D8/CCAPI/ccCallSetContext:
   Context=0x48227520
003428: *Aug 28 00:03:34.161: //116/88A41A6280D8/CCAPI/ccSaveDialpeerTag:
   Outgoing Dial-peer=101
003429: *Aug 28 00:03:34.161: //117/xxxxxxxxxxxx/CCAPI/cc_api_set_xcode_stream:

003430: *Aug 28 00:03:34.161: cc_api_set_xcode_stream Line: 4391
003431: *Aug 28 00:03:34.161: //116/xxxxxxxxxxxx/CCAPI/cc_api_set_xcode_stream:

003432: *Aug 28 00:03:34.161: cc_api_set_xcode_stream Line: 4391
003433: *Aug 28 00:03:34.161: //117/88A41A6280D8/CCAPI/cc_api_event_indication:
   Event=150, Call Id=117
003434: *Aug 28 00:03:34.161: //117/88A41A6280D8/CCAPI/cc_api_event_indication:
   Event Is Sent To Conferenced SPI(s) Directly
003435: *Aug 28 00:03:34.165: //117/88A41A6280D8/CCAPI/cc_api_call_proceeding:
   Interface=0x45F683C0, Progress Indication=NULL(0)
003436: *Aug 28 00:03:34.165: //116/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

003437: *Aug 28 00:03:34.165: cc_api_get_xcode_stream : 4369
003438: *Aug 28 00:03:34.169: //117/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

003439: *Aug 28 00:03:34.169: cc_api_get_xcode_stream : 4369
003440: *Aug 28 00:03:34.169: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
INVITE sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.0.20:5060;branch=z9hG4bK45D32
Remote-Party-ID: ;party=calling;screen=no;privacy=off
From: ;tag=1C91D80-D88
To:
Date: Sat, 28 Aug 2010 00:03:34 GMT
Call-ID: [email protected]
Supported: 100rel,timer,resource-priority,replaces
Min-SE:  1800
Cisco-Guid: 2292456034-2976780767-2161681709-1313195029
User-Agent: Cisco-SIPGateway/IOS-12.x
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
CSeq: 101 INVITE
Timestamp: 1282953814
Contact:
Expires: 180
Allow-Events: telephone-event
Max-Forwards: 69
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 191

v=0
o=CiscoSystemsSIP-GW-UserAgent 8833 5368 IN IP4 192.168.0.20
s=SIP Call
c=IN IP4 192.168.0.20
t=0 0
m=audio 19422 RTP/AVP 8
c=IN IP4 192.168.0.20
a=rtpmap:8 PCMA/8000
a=ptime:20

003441: *Aug 28 00:03:34.173: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.0.20:5060;branch=z9hG4bK45D32
From: ;tag=1C91D80-D88
To: ;tag=3de9ebe2test1
Call-ID: [email protected]
CSeq: 101 INVITE
Contact:
Content-Type: application/sdp
Allow: INVITE
Allow: ACK
Allow: CANCEL
Allow: BYE
Allow: INFO
User-Agent: zzzzz zzzzzzzz
Content-Length: 178

v=0
o=test 9128 20768432111 IN IP4 192.168.0.3
s=test session
c=IN IP4 192.168.0.3
t=0 0
m=audio 9128 RTP/AVP 8 13
a=rtpmap:8 PCMA/8000
a=rtpmap:13 CN/8000
a=ptime:20

003442: *Aug 28 00:03:34.177: //117/88A41A6280D8/CCAPI/cc_api_event_indication:
   Event=141, Call Id=117
003443: *Aug 28 00:03:34.177: //117/88A41A6280D8/CCAPI/cc_api_event_indication:
   Event Is Sent To Conferenced SPI(s) Directly
003444: *Aug 28 00:03:34.177: //117/88A41A6280D8/CCAPI/cc_api_caps_ind:
   Destination Interface=0x0, Destination Call Id=-1, Source Call Id=117,
   Caps(Codec=0x0, Fax Rate=0x2, Vad=0x2,
   Modem=0x0, Codec Bytes=20, Signal Type=2)
003445: *Aug 28 00:03:34.177: //117/88A41A6280D8/CCAPI/cc_api_caps_ind:
   Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms),
   Playout Max=250(ms), Fax Nom=300(ms))
003446: *Aug 28 00:03:34.177: //116/88A41A6280D8/CCAPI/cc_api_caps_ack:
   Destination Interface=0x0, Destination Call Id=117, Source Call Id=116,
   Caps(Codec=g729r8(0x4), Fax Rate=FAX_RATE_VOICE(0x2), Vad=OFF(0x1),
   Modem=OFF(0x0), Codec Bytes=10, Signal Type=2, Seq Num Start=1)
003447: *Aug 28 00:03:34.177: //117/88A41A6280D8/CCAPI/cc_api_call_connected:
   Interface=0x45F683C0, Data Bitmask=0x1, Progress Indication=NULL(0),
   Connection Handle=0
003448: *Aug 28 00:03:34.177: //117/88A41A6280D8/CCAPI/cc_api_call_connected:
   Call Entry(Connected=TRUE, Responsed=TRUE, Retry Count=0)
003449: *Aug 28 00:03:34.181: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
ACK sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.0.20:5060;branch=z9hG4bK4611A3
From: ;tag=1C91D80-D88
To: ;tag=3de9ebe2test1
Date: Sat, 28 Aug 2010 00:03:34 GMT
Call-ID: [email protected]
Max-Forwards: 70
CSeq: 101 ACK
Allow-Events: telephone-event
Content-Length: 0

003450: *Aug 28 00:03:34.181: //116/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   (confID=0x4561D288, callID1=0x74, callID2=0x75, tag=0x0)
003451: *Aug 28 00:03:34.181: //116/88A41A6280D8/CCAPI/ccConferenceCreate:
   Conference Id=0x4561D288, Call Id1=116, Call Id2=117, Tag=0x0
003452: *Aug 28 00:03:34.181: //116/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:

003453: *Aug 28 00:03:34.181: ccConferenceCreate: ret1=0, codecMask1=4, bytes1=10, negot1=1, dtmf1=0
                    ret2=0, codecMask2=2, bytes2=160, negot2=1, dtmf2=0
003454: *Aug 28 00:03:34.181: //116/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

003455: *Aug 28 00:03:34.181: cc_api_get_xcode_stream : 4369
003456: *Aug 28 00:03:34.181: //117/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

003457: *Aug 28 00:03:34.181: cc_api_get_xcode_stream : 4369
003458: *Aug 28 00:03:34.181: //116/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

003459: *Aug 28 00:03:34.181: cc_api_get_xcode_stream : 4369
003460: *Aug 28 00:03:34.181: //116/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

003461: *Aug 28 00:03:34.185: cc_api_get_xcode_stream : 4369
003462: *Aug 28 00:03:34.185: //116/xxxxxxxxxxxx/CCAPI/cc_api_bridge_done:
   Conference Id=0x46, Source Interface=0x45F683C0, Source Call Id=116,
   Destination Call Id=117, Disposition=0x0, Tag=0x0
003463: *Aug 28 00:03:34.185: //117/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

003464: *Aug 28 00:03:34.185: cc_api_get_xcode_stream : 4369
003465: *Aug 28 00:03:34.185: //117/xxxxxxxxxxxx/CCAPI/cc_api_bridge_done:
   Conference Id=0x46, Source Interface=0x45F683C0, Source Call Id=117,
   Destination Call Id=116, Disposition=0x0, Tag=0x0
003466: *Aug 28 00:03:34.185: //116/88A41A6280D8/CCAPI/cc_generic_bridge_done:
   Conference Id=0x46, Source Interface=0x45F683C0, Source Call Id=117,
   Destination Call Id=116, Disposition=0x0, Tag=0x0
003467: *Aug 28 00:03:34.185: //116/88A41A6280D8/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0x46, Destination Call Id=117)
003468: *Aug 28 00:03:34.185: //117/88A41A6280D8/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0x46, Destination Call Id=116)
003469: *Aug 28 00:03:34.185: //116/88A41A6280D8/CCAPI/cc_process_notify_bridge_done:
   Conference Id=0x46, Call Id1=116, Call Id2=117
003470: *Aug 28 00:03:34.185: //116/88A41A6280D8/CCAPI/ccCallConnect:
   Progress Indication=NULL(0), Data Bitmask=0x1
003471: *Aug 28 00:03:34.185: //116/88A41A6280D8/CCAPI/ccCallConnect:
   Call Entry(Connected=TRUE, Responsed=TRUE)
003472: *Aug 28 00:03:34.189: //116/88A41A6280D8/CCAPI/ccCallNotify:
   Data Bitmask=0x7, Call Id=116
003473: *Aug 28 00:03:34.193: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest0
From: ;tag=2296c25ftest0
To: ;tag=1C91D98-1796
Date: Sat, 28 Aug 2010 00:03:34 GMT
Call-ID: test-192.168.0.3:9128-19128
Server: Cisco-SIPGateway/IOS-12.x
CSeq: 1 INVITE
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
Allow-Events: telephone-event
Remote-Party-ID: ;party=called;screen=no;privacy=off
Contact:
Supported: replaces
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 214

v=0
o=CiscoSystemsSIP-GW-UserAgent 2463 2129 IN IP4 192.168.0.20
s=SIP Call
c=IN IP4 192.168.0.20
t=0 0
m=audio 17000 RTP/AVP 18
c=IN IP4 192.168.0.20
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:10

003474: *Aug 28 00:03:34.193: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:[email protected] SIP/2.0
Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest1
From: ;tag=2296c25ftest0
To: ;tag=1C91D98-1796
Call-ID: test-192.168.0.3:9128-19128
CSeq: 1 ACK
Contact:
User-Agent: zzzzz zzzzzzzz
Allow: INVITE
Allow: ACK
Allow: CANCEL
Allow: BYE
Allow: INFO
Max-Forwards: 70
Content-Length: 0

003475: *Aug 28 00:03:34.225: //-1/xxxxxxxxxxxx/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x46633C60, Interface Type=9, Destination=0.0.0.0, Mode=0x0,
   Call Params(Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=, FinalDestinationFlag=FALSE, Outgoing Dial-peer=0, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
003476: *Aug 28 00:03:34.225: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

003477: *Aug 28 00:03:34.225: :cc_get_feature_vsa malloc success
003478: *Aug 28 00:03:34.225: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

003479: *Aug 28 00:03:34.225:  cc_get_feature_vsa count is 3
003480: *Aug 28 00:03:34.229: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

003481: *Aug 28 00:03:34.229: :FEATURE_VSA attributes are: feature_name:0,feature_time:1175236504,feature_id:118
003482: *Aug 28 00:03:34.229: //118/xxxxxxxxxxxx/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=9, FlowMode=1
003483: *Aug 28 00:03:34.229: //118/xxxxxxxxxxxx/CCAPI/ccCallSetContext:
   Context=0x45624770
003484: *Aug 28 00:03:34.229: //-1/xxxxxxxxxxxx/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x464C503C, Interface Type=25, Destination=, Mode=0x0,
   Call Params(Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=, FinalDestinationFlag=FALSE, Outgoing Dial-peer=0, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
003485: *Aug 28 00:03:34.229: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

003486: *Aug 28 00:03:34.229: :cc_get_feature_vsa malloc success
003487: *Aug 28 00:03:34.229: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

003488: *Aug 28 00:03:34.229:  cc_get_feature_vsa count is 4
003489: *Aug 28 00:03:34.229: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

003490: *Aug 28 00:03:34.229: :FEATURE_VSA attributes are: feature_name:0,feature_time:1175236072,feature_id:119
003491: *Aug 28 00:03:34.229: //119/xxxxxxxxxxxx/CCAPI/cc_api_call_connected:
   Interface=0x464C503C, Data Bitmask=0x0, Progress Indication=NULL(0),
   Connection Handle=0
003492: *Aug 28 00:03:34.229: //119/xxxxxxxxxxxx/CCAPI/cc_api_call_connected:
   Call Entry(Connected=TRUE, Responsed=TRUE, Retry Count=0)
003493: *Aug 28 00:03:34.229: //119/xxxxxxxxxxxx/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=25, FlowMode=1
003494: *Aug 28 00:03:34.229: //119/xxxxxxxxxxxx/CCAPI/ccCallSetContext:
   Context=0x45624790
003495: *Aug 28 00:03:34.233: //118/xxxxxxxxxxxx/CCAPI/cc_api_call_connected:
   Interface=0x46633C60, Data Bitmask=0x0, Progress Indication=NULL(0),
   Connection Handle=0
003496: *Aug 28 00:03:34.233: //118/xxxxxxxxxxxx/CCAPI/cc_api_call_connected:
   Call Entry(Connected=TRUE, Responsed=TRUE, Retry Count=0)
003497: *Aug 28 00:03:34.233: //119/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   (confID=0x47E86FC8, callID1=0x77, callID2=0x76, tag=0x0)
003498: *Aug 28 00:03:34.233: //119/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   Conference Id=0x47E86FC8, Call Id1=119, Call Id2=118, Tag=0x0
003499: *Aug 28 00:03:34.233: //119/xxxxxxxxxxxx/CCAPI/cc_api_bridge_done:
   Conference Id=0x47, Source Interface=0x464C503C, Source Call Id=119,
   Destination Call Id=118, Disposition=0x0, Tag=0x0
003500: *Aug 28 00:03:34.233: //118/xxxxxxxxxxxx/CCAPI/cc_api_bridge_done:
   Conference Id=0x47, Source Interface=0x46633C60, Source Call Id=118,
   Destination Call Id=119, Disposition=0x0, Tag=0x0
003501: *Aug 28 00:03:34.233: //119/xxxxxxxxxxxx/CCAPI/cc_generic_bridge_done:
   Conference Id=0x47, Source Interface=0x46633C60, Source Call Id=118,
   Destination Call Id=119, Disposition=0x0, Tag=0x0
003502: *Aug 28 00:03:34.233: //119/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0x47, Destination Call Id=118)
003503: *Aug 28 00:03:34.233: //118/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0x47, Destination Call Id=119)
003504: *Aug 28 00:03:34.233: //118/xxxxxxxxxxxx/CCAPI/ccCallModify:
   Nominator=0x0, Params=0x47E86BC0, Call Id=118
003505: *Aug 28 00:03:34.237: //119/xxxxxxxxxxxx/CCAPI/cc_process_notify_bridge_done:
   Conference Id=0x47, Call Id1=119, Call Id2=118
003506: *Aug 28 00:03:34.237: //118/xxxxxxxxxxxx/CCAPI/cc_api_call_modify_done:
   Result=0, Interface=0x46633C60, Call Id=118
003507: *Aug 28 00:03:34.241: //-1/xxxxxxxxxxxx/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x46633C60, Interface Type=9, Destination=0.0.0.0, Mode=0x0,
   Call Params(Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=, FinalDestinationFlag=FALSE, Outgoing Dial-peer=0, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
003508: *Aug 28 00:03:34.241: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

003509: *Aug 28 00:03:34.241: :cc_get_feature_vsa malloc success
003510: *Aug 28 00:03:34.241: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

003511: *Aug 28 00:03:34.241:  cc_get_feature_vsa count is 5
003512: *Aug 28 00:03:34.241: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

003513: *Aug 28 00:03:34.241: :FEATURE_VSA attributes are: feature_name:0,feature_time:1175236288,feature_id:120
003514: *Aug 28 00:03:34.241: //120/xxxxxxxxxxxx/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=9, FlowMode=1
003515: *Aug 28 00:03:34.241: //120/xxxxxxxxxxxx/CCAPI/ccCallSetContext:
   Context=0x456247B0
003516: *Aug 28 00:03:34.245: //120/xxxxxxxxxxxx/CCAPI/cc_api_call_connected:
   Interface=0x46633C60, Data Bitmask=0x0, Progress Indication=NULL(0),
   Connection Handle=0
003517: *Aug 28 00:03:34.245: //120/xxxxxxxxxxxx/CCAPI/cc_api_call_connected:
   Call Entry(Connected=TRUE, Responsed=TRUE, Retry Count=0)
003518: *Aug 28 00:03:34.245: //118/xxxxxxxxxxxx/CCAPI/ccCallModifyExtended:
   Nominator=0x47E87008, Params=0x47E86FE8, Call Id=118
003519: *Aug 28 00:03:34.245: //119/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   (confID=0x47E86FC8, callID1=0x77, callID2=0x78, tag=0x0)
003520: *Aug 28 00:03:34.245: //119/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   Conference Id=0x47E86FC8, Call Id1=119, Call Id2=120, Tag=0x0
003521: *Aug 28 00:03:34.245: //120/xxxxxxxxxxxx/CCAPI/cc_api_bridge_done:
   Conference Id=0x48, Source Interface=0x46633C60, Source Call Id=120,
   Destination Call Id=119, Disposition=0x0, Tag=0x0
003522: *Aug 28 00:03:34.245: //119/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0x48, Destination Call Id=118)
003523: *Aug 28 00:03:34.245: //120/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0x48, Destination Call Id=119)
003524: *Aug 28 00:03:34.245: //119/xxxxxxxxxxxx/CCAPI/cc_api_bridge_done:
   Conference Id=0x48, Source Interface=0x464C503C, Source Call Id=119,
   Destination Call Id=120, Disposition=0x0, Tag=0x0
003525: *Aug 28 00:03:34.249: //119/xxxxxxxxxxxx/CCAPI/cc_generic_bridge_done:
   Conference Id=0x48, Source Interface=0x464C503C, Source Call Id=119,
   Destination Call Id=120, Disposition=0x0, Tag=0x0
003526: *Aug 28 00:03:34.249: //119/xxxxxxxxxxxx/CCAPI/cc_process_notify_bridge_done:
   Conference Id=0x48, Call Id1=119, Call Id2=120
003527: *Aug 28 00:03:34.249: //118/xxxxxxxxxxxx/CCAPI/ccCallModify:
   Nominator=0x18E00, Params=0x47E873B8, Call Id=118
003528: *Aug 28 00:03:34.249: //118/xxxxxxxxxxxx/CCAPI/cc_api_call_modify_done:
   Result=0, Interface=0x46633C60, Call Id=118
003529: *Aug 28 00:03:34.253: //120/xxxxxxxxxxxx/CCAPI/ccCallModify:
   Nominator=0x0, Params=0x47E86BC0, Call Id=120
003530: *Aug 28 00:03:34.253: //118/xxxxxxxxxxxx/CCAPI/ccCallModifyExtended:
   Nominator=0x47E87008, Params=0x47E86FE8, Call Id=118
003531: *Aug 28 00:03:34.253: //120/xxxxxxxxxxxx/CCAPI/cc_api_call_modify_done:
   Result=0, Interface=0x46633C60, Call Id=120
003532: *Aug 28 00:03:34.257: //120/xxxxxxxxxxxx/CCAPI/ccCallModifyExtended:
   Nominator=0x47E87008, Params=0x47E86FE8, Call Id=120
003533: *Aug 28 00:03:34.257: //120/xxxxxxxxxxxx/CCAPI/ccCallModify:
   Nominator=0x18E00, Params=0x47E873B8, Call Id=120
003534: *Aug 28 00:03:34.261: //120/xxxxxxxxxxxx/CCAPI/cc_api_call_modify_done:
   Result=0, Interface=0x46633C60, Call Id=120
003535: *Aug 28 00:03:34.261: //120/xxxxxxxxxxxx/CCAPI/ccCallModifyExtended:
   Nominator=0x47E87008, Params=0x47E86FE8, Call Id=120
003536: *Aug 28 00:04:37.449: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
BYE sip:[email protected] SIP/2.0
Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest2
From: ;tag=2296c25ftest0
To: ;tag=1C91D98-1796
Call-ID: test-192.168.0.3:9128-19128
CSeq: 2 BYE
Contact:
User-Agent: zzzzz zzzzzzzz
Allow: INVITE
Allow: ACK
Allow: CANCEL
Allow: BYE
Allow: INFO
Max-Forwards: 70
Content-Length: 0

003537: *Aug 28 00:04:37.449: //117/88A41A6280D8/CCAPI/ccGenerateToneInfo:
   Stop Tone On Digit=FALSE, Tone=Null,
   Tone Direction=Sum Network, Params=0x0, Call Id=117
003538: *Aug 28 00:04:37.449: //116/88A41A6280D8/CCAPI/cc_api_call_disconnected:
   Cause Value=16, Interface=0x45F683C0, Call Id=116
003539: *Aug 28 00:04:37.449: //116/88A41A6280D8/CCAPI/cc_api_call_disconnected:
   Call Entry(Responsed=TRUE, Cause Value=16, Retry Count=0)
003540: *Aug 28 00:04:37.453: //116/88A41A6280D8/CCAPI/ccConferenceDestroy:
   Conference Id=0x46, Tag=0x0
003541: *Aug 28 00:04:37.453: //116/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0x46, Source Interface=0x45F683C0, Source Call Id=116,
   Destination Call Id=117, Disposition=0x0, Tag=0x0
003542: *Aug 28 00:04:37.453: //117/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0x46, Source Interface=0x45F683C0, Source Call Id=117,
   Destination Call Id=116, Disposition=0x0, Tag=0x0
003543: *Aug 28 00:04:37.453: //116/88A41A6280D8/CCAPI/cc_generic_bridge_done:
   Conference Id=0x46, Source Interface=0x45F683C0, Source Call Id=117,
   Destination Call Id=116, Disposition=0x0, Tag=0x0
003544: *Aug 28 00:04:37.453: //116/88A41A6280D8/CCAPI/ccCallDisconnect:
   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)
003545: *Aug 28 00:04:37.453: //116/88A41A6280D8/CCAPI/ccCallDisconnect:
   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
003546: *Aug 28 00:04:37.453: //117/88A41A6280D8/CCAPI/ccCallDisconnect:
   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
003547: *Aug 28 00:04:37.453: //117/88A41A6280D8/CCAPI/ccCallDisconnect:
   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
003548: *Aug 28 00:04:37.457: //116/88A41A6280D8/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x45F683C0, Tag=0x0, Call Id=116,
   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
003549: *Aug 28 00:04:37.457: //116/88A41A6280D8/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
003550: *Aug 28 00:04:37.457: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

003551: *Aug 28 00:04:37.457: :cc_free_feature_vsa freeing 460CAD08
003552: *Aug 28 00:04:37.457: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

003553: *Aug 28 00:04:37.457:  vsacount in free is 4
003554: *Aug 28 00:04:37.461: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest2
From: ;tag=2296c25ftest0
To: ;tag=1C91D98-1796
Date: Sat, 28 Aug 2010 00:04:37 GMT
Call-ID: test-192.168.0.3:9128-19128
Server: Cisco-SIPGateway/IOS-12.x
CSeq: 2 BYE
Reason: Q.850;cause=16
Content-Length: 0

003555: *Aug 28 00:04:37.461: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
BYE sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.0.20:5060;branch=z9hG4bK4716D9
From: ;tag=1C91D80-D88
To: ;tag=3de9ebe2test1
Date: Sat, 28 Aug 2010 00:03:34 GMT
Call-ID: [email protected]
User-Agent: Cisco-SIPGateway/IOS-12.x
Max-Forwards: 70
Timestamp: 1282953877
CSeq: 102 BYE
Reason: Q.850;cause=16
Content-Length: 0

003556: *Aug 28 00:04:37.465: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.0.20:5060;branch=z9hG4bK4716D9
From: ;tag=1C91D80-D88
To: ;tag=3de9ebe2test1
Call-ID: [email protected]
CSeq: 102 BYE
Contact:
Content-Type: application/sdp
Allow: INVITE
Allow: ACK
Allow: CANCEL
Allow: BYE
Allow: INFO
User-Agent: zzzzz zzzzzzzz
Content-Length: 0

003557: *Aug 28 00:04:37.469: //117/88A41A6280D8/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x45F683C0, Tag=0x0, Call Id=117,
   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
003558: *Aug 28 00:04:37.469: //117/88A41A6280D8/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
003559: *Aug 28 00:04:37.469: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

003560: *Aug 28 00:04:37.469: :cc_free_feature_vsa freeing 460CB068
003561: *Aug 28 00:04:37.469: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

003562: *Aug 28 00:04:37.469:  vsacount in free is 3
003563: *Aug 28 00:04:37.729: //120/xxxxxxxxxxxx/CCAPI/ccCallModify:
   Nominator=0x800, Params=0x47E87418, Call Id=120
003564: *Aug 28 00:04:37.729: //120/xxxxxxxxxxxx/CCAPI/cc_api_call_modify_done:
   Result=0, Interface=0x46633C60, Call Id=120
003565: *Aug 28 00:04:37.729: //120/xxxxxxxxxxxx/CCAPI/ccCallModifyExtended:
   Nominator=0x47E87008, Params=0x47E86FE8, Call Id=120
003566: *Aug 28 00:04:37.729: //119/xxxxxxxxxxxx/CCAPI/ccConferenceDestroy:
   Conference Id=0x48, Tag=0x0
003567: *Aug 28 00:04:37.729: //119/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0x48, Source Interface=0x464C503C, Source Call Id=119,
   Destination Call Id=120, Disposition=0x0, Tag=0x0
003568: *Aug 28 00:04:37.733: //120/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0x48, Source Interface=0x46633C60, Source Call Id=120,
   Destination Call Id=119, Disposition=0x0, Tag=0x0
003569: *Aug 28 00:04:37.733: //119/xxxxxxxxxxxx/CCAPI/cc_generic_bridge_done:
   Conference Id=0x48, Source Interface=0x46633C60, Source Call Id=120,
   Destination Call Id=119, Disposition=0x0, Tag=0x0
003570: *Aug 28 00:04:37.733: //120/xxxxxxxxxxxx/CCAPI/ccCallDisconnect:
   Cause Value=0, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
003571: *Aug 28 00:04:37.733: //120/xxxxxxxxxxxx/CCAPI/ccCallDisconnect:
   Cause Value=0, Call Entry(Responsed=TRUE, Cause Value=0)
003572: *Aug 28 00:04:37.733: //120/xxxxxxxxxxxx/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x46633C60, Tag=0x0, Call Id=120,
   Call Entry(Disconnect Cause=0, Voice Class Cause Code=0, Retry Count=0)
003573: *Aug 28 00:04:37.733: //120/xxxxxxxxxxxx/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
003574: *Aug 28 00:04:37.733: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

003575: *Aug 28 00:04:37.733: :cc_free_feature_vsa freeing 460CAEB8
003576: *Aug 28 00:04:37.733: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

003577: *Aug 28 00:04:37.733:  vsacount in free is 2
003578: *Aug 28 00:04:37.737: //118/xxxxxxxxxxxx/CCAPI/ccCallModify:
   Nominator=0x800, Params=0x47E87418, Call Id=118
003579: *Aug 28 00:04:37.737: //118/xxxxxxxxxxxx/CCAPI/cc_api_call_modify_done:
   Result=0, Interface=0x46633C60, Call Id=118
003580: *Aug 28 00:04:37.741: //118/xxxxxxxxxxxx/CCAPI/ccCallModifyExtended:
   Nominator=0x47E87008, Params=0x47E86FE8, Call Id=118
003581: *Aug 28 00:04:37.741: //119/xxxxxxxxxxxx/CCAPI/ccConferenceDestroy:
   Conference Id=0x47, Tag=0x0
003582: *Aug 28 00:04:37.741: //119/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0x47, Source Interface=0x464C503C, Source Call Id=119,
   Destination Call Id=118, Disposition=0x0, Tag=0x0
003583: *Aug 28 00:04:37.741: //118/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0x47, Source Interface=0x46633C60, Source Call Id=118,
   Destination Call Id=119, Disposition=0x0, Tag=0x0
003584: *Aug 28 00:04:37.741: //119/xxxxxxxxxxxx/CCAPI/cc_generic_bridge_done:
   Conference Id=0x47, Source Interface=0x46633C60, Source Call Id=118,
   Destination Call Id=119, Disposition=0x0, Tag=0x0
003585: *Aug 28 00:04:37.741: //118/xxxxxxxxxxxx/CCAPI/ccCallDisconnect:
   Cause Value=0, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
003586: *Aug 28 00:04:37.741: //118/xxxxxxxxxxxx/CCAPI/ccCallDisconnect:
   Cause Value=0, Call Entry(Responsed=TRUE, Cause Value=0)
003587: *Aug 28 00:04:37.745: //118/xxxxxxxxxxxx/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x46633C60, Tag=0x0, Call Id=118,
   Call Entry(Disconnect Cause=0, Voice Class Cause Code=0, Retry Count=0)
003588: *Aug 28 00:04:37.745: //118/xxxxxxxxxxxx/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
003589: *Aug 28 00:04:37.745: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

003590: *Aug 28 00:04:37.745: :cc_free_feature_vsa freeing 460CAF90
003591: *Aug 28 00:04:37.745: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

003592: *Aug 28 00:04:37.745:  vsacount in free is 1
003593: *Aug 28 00:04:37.745: //119/xxxxxxxxxxxx/CCAPI/ccCallDisconnect:
   Cause Value=0, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
003594: *Aug 28 00:04:37.745: //119/xxxxxxxxxxxx/CCAPI/ccCallDisconnect:
   Cause Value=0, Call Entry(Responsed=TRUE, Cause Value=0)
003595: *Aug 28 00:04:37.745: //119/xxxxxxxxxxxx/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x464C503C, Tag=0x0, Call Id=119,
   Call Entry(Disconnect Cause=0, Voice Class Cause Code=0, Retry Count=0)
003596: *Aug 28 00:04:37.749: //119/xxxxxxxxxxxx/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
003597: *Aug 28 00:04:37.749: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

003598: *Aug 28 00:04:37.749: :cc_free_feature_vsa freeing 460CADE0
003599: *Aug 28 00:04:37.749: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

003600: *Aug 28 00:04:37.749:  vsacount in free is 0
003601: *Aug 28 00:07:37.473: //-1/xxxxxxxxxxxx/CCAPI/ccAppShutdownMode:
   ccAppShutdownMode: remove it from the queue

bobl12345 Sat, 08/28/2010 - 11:22

Dave -

Please ignore problem with half-duplex, one of the TX port numbers was wrong on my end. I missed that looking at the wireshark trace. Apologies.

One thing I am wondering about is this command....

network-clock-participate slot 1

Can you summarize the meaning? Looking at the docs, I'm not quite sure of the implication. I know that I could not activate one of the dsp farms without setting it b ut not sure of the meaning.

-Bob

David Smith Tue, 08/31/2010 - 11:07

Hey Bob,

Sorry, I wasn't around the past few days.

network-clock-participate slot 1

This sets the T1/E1 etc... ports in slot 1 to participate in the TDM backplane clocking domain.

http://www.cisco.com/en/US/partner/docs/ios/12_3/vvf_r/vrg_n1_ps1839_TSD_Products_Command_Reference_Chapter.html#wp1001437

The command:

network-clock-select 1 T1 XXX

This tells the backplane which clock source to reference and propogate to the backplane.

-Dave

Actions

This Discussion

Related Content