Problem with g711 to g729 transcode using sip & 2811 dspfarm

[bobl12345]

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 101@server  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

[bobl12345]

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]

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]

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]

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:

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]

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

[David Smith]

Yup, I did...thanks Bob.

[bobl12345]

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]

Adding log file...

Received:
INVITE sip:101@192.168.0.3 SIP/2.0
Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest0
From: <100>;tag=2296c25ftest0
To: <101>
Call-ID: test-192.168.0.3:9128-19128
CSeq: 1 INVITE
Contact: <100>
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: <100>;tag=2296c25ftest0
To: <101>
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:101@192.168.0.3:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.0.20:5060;branch=z9hG4bK45D32
Remote-Party-ID: <100>;party=calling;screen=no;privacy=off
From: <100>;tag=1C91D80-D88
To: <101>
Date: Sat, 28 Aug 2010 00:03:34 GMT
Call-ID: 88A86012-B16E11DF-80DDA52D-4E45C415@192.168.0.20
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: <100>
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: <100>;tag=1C91D80-D88
To: <101>;tag=3de9ebe2test1
Call-ID: 88A86012-B16E11DF-80DDA52D-4E45C415@192.168.0.20
CSeq: 101 INVITE
Contact: <100>
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:100@192.168.0.3:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.0.20:5060;branch=z9hG4bK4611A3
From: <100>;tag=1C91D80-D88
To: <101>;tag=3de9ebe2test1
Date: Sat, 28 Aug 2010 00:03:34 GMT
Call-ID: 88A86012-B16E11DF-80DDA52D-4E45C415@192.168.0.20
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: <100>;tag=2296c25ftest0
To: <101>;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: <101>;party=called;screen=no;privacy=off
Contact: <100>
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:101@192.168.0.3 SIP/2.0
Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest1
From: <100>;tag=2296c25ftest0
To: <101>;tag=1C91D98-1796
Call-ID: test-192.168.0.3:9128-19128
CSeq: 1 ACK
Contact: <100>
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:101@192.168.0.3 SIP/2.0
Via: SIP/2.0/UDP 192.168.0.3;branch=z9hG4bKtest2
From: <100>;tag=2296c25ftest0
To: <101>;tag=1C91D98-1796
Call-ID: test-192.168.0.3:9128-19128
CSeq: 2 BYE
Contact: <100>
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: <100>;tag=2296c25ftest0
To: <101>;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:100@192.168.0.3:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.0.20:5060;branch=z9hG4bK4716D9
From: <100>;tag=1C91D80-D88
To: <101>;tag=3de9ebe2test1
Date: Sat, 28 Aug 2010 00:03:34 GMT
Call-ID: 88A86012-B16E11DF-80DDA52D-4E45C415@192.168.0.20
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: <100>;tag=1C91D80-D88
To: <101>;tag=3de9ebe2test1
Call-ID: 88A86012-B16E11DF-80DDA52D-4E45C415@192.168.0.20
CSeq: 102 BYE
Contact: <100>
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]

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]

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

[Steven Holl]

You're matching inbound dial-peer 0, instead of 101 like you intend to.

Configure:

dial-peer voice 101 voip
incoming called-number 101

Then read and understand this link:

http://www.cisco.com/en/US/tech/tk652/tk90/technologies_tech_note09186a008010fed1.shtml

-Steve