cancel
Showing results for 
Search instead for 
Did you mean: 
cancel
Announcements
Walkthrough Wednesdays
2425
Views
0
Helpful
40
Replies
Jakub Stroinski
Enthusiast

Call forwarding to external number SIP SRST no sound

Below is the current config

Call comes in, goes to 2000 (auto-attendant UCCX trigger in CUCM)

When CUCM is down, 2000 doesnt exti, calls go to 2339 and if no answer to 2340 under SRST mode

All of this works

Now, if I replace 2340 with a mobile number i.e. 95145551234, the mobile phone rings, but when answered, there is no sound (either direction) and the call is disconnected after 60 seconds.

Ideas gentlemen?


boot system flash:c2800nm-adventerprisek9-mz.151-4.M10.bin

ip dhcp excluded-address 172.16.16.1 172.16.16.20

ip dhcp pool voice
 import all
 network 172.16.16.0 255.255.255.0
 default-router 172.16.16.1
 option 150 ip 172.16.16.4
 dns-server 10.10.0.5
 lease 0 2

voice service voip
 ip address trusted list
  ipv4 72.55.168.18
  ipv4 172.10.10.0 255.255.255.0
  ipv4 172.16.16.0 255.255.255.0
 ip address trusted call-block cause not-in-cug
 gcid
 clid substitute name
 allow-connections h323 to sip
 allow-connections sip to h323
 allow-connections sip to sip
 no supplementary-service sip moved-temporarily
 no supplementary-service sip refer
 sip
  e911
  registrar server expires max 600 min 60
  transport switch udp tcp
  asserted-id ppi
  midcall-signaling passthru
  no call service stop
!
voice class sip-profiles 1
 request INVITE sip-header From modify "From: (.*<)(.*>)" "From: \"Cisco Lab\" <\2"
!
!
voice register global
 timeouts interdigit 5
 system message SRST active
 max-dn 20
 max-pool 20
!
voice register pool  1
 translation-profile outgoing SRST
 id network 172.16.16.0 mask 255.255.255.0
 alias 1 2000 to 2339
 dtmf-relay rtp-nte cisco-rtp
 call-forward b2bua noan 2340 timeout 15
 codec g711ulaw
!
!
!
voice translation-rule 1
 rule 1 /.*/ /2000/
!
voice translation-rule 2
 rule 1 /.*/ /5143605555/
!
voice translation-rule 3
 rule 1 /^9\(.*\)/ /\1/
!
voice translation-rule 4
 rule 1 /2000/ /2339/
!
!
voice translation-profile INCOMING
 translate called 1
!
voice translation-profile OUTGOING
 translate calling 2
 translate called 3
!
voice translation-profile SRST
 translate called 4

!
license udi pid CISCO2811 sn FTX1126AXXX

!
interface FastEthernet0/0
 description DHCPVoIP
 ip address 172.16.16.2 255.255.255.0
 duplex auto
 speed auto
!
interface FastEthernet0/1
 no ip address
 shutdown
 duplex auto
 speed auto
!
ip forward-protocol nd
no ip http server
no ip http secure-server
!
!
ip route 0.0.0.0 0.0.0.0 172.16.16.1
!
access-list 23 permit 172.16.16.0 0.0.0.255
access-list 23 permit 172.10.10.0 0.0.0.255
access-list 23 permit 10.10.0.0 0.0.0.255


dial-peer voice 1 voip
 translation-profile incoming INCOMING
 session protocol sipv2
 session target ipv4:172.16.16.4
 incoming called-number 12345678
 dtmf-relay cisco-rtp rtp-nte
 codec g711ulaw
 no vad
!
dial-peer voice 3 voip
 translation-profile outgoing OUTGOING
 destination-pattern 9[2-9]..[2-9]......
 session protocol sipv2
 session target ipv4:72.55.168.18
 no voice-class sip early-offer forced
 voice-class sip profiles 1
 dtmf-relay rtp-nte cisco-rtp sip-kpml sip-notify
 codec g711ulaw
 no vad
!
dial-peer voice 4 voip
 destination-pattern 2...
 session protocol sipv2
 session target ipv4:172.16.16.4
 dtmf-relay cisco-rtp rtp-nte
 codec g711ulaw
 no vad
!
!
sip-ua
 credentials username 12345678 password 7 XXXXX realm montreal3.voip.ms
 authentication username 12345678 password 7 XXXXX realm montreal3.voip.ms
 registrar 1 dns:montreal3.voip.ms expires 300
 registrar 2 ipv4:172.16.16.2 expires 3600
!
!
!
call-manager-fallback
 max-conferences 8 gain -6
 transfer-system full-consult
 ip source-address 172.16.16.2 port 2000
 max-ephones 1
 max-dn 1 octo-line
 alias 1 2000 to 2339

40 REPLIES 40
Manish Gogna
Cisco Employee

Hi Jakub,

If the normal calls to this mobile phone are working fine then this is most likely a signaling issue. You may collect the "debug ccsip messages" and post here to see if signaling is okay.

Manish

- Do rate helpful posts -

Calling from 5147221234

Calling 5143601234

Forward to 5145551234

My SIP ID is 12345678

My router is 172.16.16.2 and my CUCM is 172.16.16.4

sh logging
Syslog logging: enabled (5 messages dropped, 3 messages rate-limited, 2083 flushes, 0 overruns, xml disabled, filtering disabled)

No Active Message Discriminator.



No Inactive Message Discriminator.


    Console logging: level debugging, 9867 messages logged, xml disabled,
                     filtering disabled
    Monitor logging: level debugging, 0 messages logged, xml disabled,
                     filtering disabled
    Buffer logging:  level debugging, 7359 messages logged, xml disabled,
                    filtering disabled
    Exception Logging: size (4096 bytes)
    Count and timestamp logging messages: disabled
    Persistent logging: disabled

No active filter modules.

    Trap logging: level informational, 97 message lines logged
        Logging Source-Interface:       VRF Name:

Log Buffer (4096 bytes):
: <sip:12345678@172.16.16.2:5060>
Expires:  3600
Supported: path
Content-Length: 0


Dec  2 13:16:17.532: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK8824E2E
From: <sip:12345678@172.16.16.2>;tag=8AB27F48-F90
To: <sip:12345678@172.16.16.2>
Date: Wed, 02 Dec 2015 13:16:17 GMT
Call-ID: 50DA5F6C-830511E5-8040BE77-FFDD325D
Server: Cisco-SIPGateway/IOS-12.x
Timestamp: 1449062177
CSeq: 12923 REGISTER
Content-Length: 0


Dec  2 13:16:17.536: //84314/B494FA01B9E6/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 404 Not Found
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK8824E2E
From: <sip:12345678@172.16.16.2>;tag=8AB27F48-F90
To: <sip:12345678@172.16.16.2>;tag=8AB27F50-D43
Date: Wed, 02 Dec 2015 13:16:17 GMT
Call-ID: 50DA5F6C-830511E5-8040BE77-FFDD325D
Server: Cisco-SIPGateway/IOS-12.x
Timestamp: 1449062177
CSeq: 12923 REGISTER
Content-Length: 0


Dec  2 13:16:17.540: //84313/000000000000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK8824E2E
From: <sip:12345678@172.16.16.2>;tag=8AB27F48-F90
To: <sip:12345678@172.16.16.2>
Date: Wed, 02 Dec 2015 13:16:17 GMT
Call-ID: 50DA5F6C-830511E5-8040BE77-FFDD325D
Server: Cisco-SIPGateway/IOS-12.x
Timestamp: 1449062177
CSeq: 12923 REGISTER
Content-Length: 0


Dec  2 13:16:17.540: //84313/000000000000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 404 Not Found
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK8824E2E
From: <sip:12345678@172.16.16.2>;tag=8AB27F48-F90
To: <sip:12345678@172.16.16.2>;tag=8AB27F50-D43
Date: Wed, 02 Dec 2015 13:16:17 GMT
Call-ID: 50DA5F6C-830511E5-8040BE77-FFDD325D
Server: Cisco-SIPGateway/IOS-12.x
Timestamp: 1449062177
CSeq: 12923 REGISTER
Content-Length: 0


Dec  2 13:17:11.016: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
BYE sip:5143601655@172.16.16.2:5060 SIP/2.0
Via: SIP/2.0/UDP 72.55.168.18:5060;branch=z9hG4bK3e87b574;rport
Max-Forwards: 70
From: <sip:5145551234@72.55.168.18>;tag=as3d955f19
To: "Cisco Lab" <sip:5143601655@172.16.16.2>;tag=8AB23F00-1211
Call-ID: AAC4BF35-982D11E5-B9E5BE77-FFDD325D@172.16.16.2
CSeq: 102 BYE
User-Agent: voip.ms
Proxy-Authorization: Digest username="12345678", realm="montreal3.voip.ms", algorithm=MD5, uri="sip:72.55.168.18", nonce="4b15adc2", response="89bf684c673076c7dc6815be99a9ec08"
X-Asterisk-HangupCause: Normal Clearing
X-Asterisk-HangupCauseCode: 16
Content-Length: 0


Dec  2 13:17:11.024: //84310/A1BADF28B9DA/SIP/Msg/ccsipDisplayMsg:
Sent:
BYE sip:5147221234@72.55.168.18:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK88251B92
From: <sip:12345678@172.16.16.2:5060>;tag=8AB2044C-199C
To: "CALLER ID" <sip:5147221234@72.55.168.18>;tag=as18d2034c
Date: Wed, 02 Dec 2015 13:16:10 GMT
Call-ID: 22cd2cc349a3586e16ac904a30f1f5c1@72.55.168.18:5060
User-Agent: Cisco-SIPGateway/IOS-12.x
Max-Forwards: 70
Timestamp: 1449062231
CSeq: 101 BYE
Reason: Q.850;cause=16
P-RTP-Stat: PS=0,OS=0,PR=0,OR=0,PL=0,JI=0,LA=0,DU=60
Content-Length: 0


Dec  2 13:17:11.028: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 72.55.168.18:5060;branch=z9hG4bK3e87b574;rport
From: <sip:5145551234@72.55.168.18>;tag=as3d955f19
To: "CALLER ID" <sip:5143601655@172.16.16.2>;tag=8AB23F00-1211
Date: Wed, 02 Dec 2015 13:17:11 GMT
Call-ID: AAC4BF35-982D11E5-B9E5BE77-FFDD325D@172.16.16.2
Server: Cisco-SIPGateway/IOS-12.x
CSeq: 102 BYE
Reason: Q.850;cause=16
P-RTP-Stat: PS=0,OS=0,PR=0,OR=0,PL=0,JI=0,LA=0,DU=60
Content-Length: 0


Dec  2 13:17:11.044: //84310/A1BADF28B9DA/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK88251B92;received=66.11.41.90;rport=58930
From: <sip:12345678@172.16.16.2:5060>;tag=8AB2044C-199C
To: "CALLER ID" <sip:5147221234@72.55.168.18>;tag=as18d2034c
Call-ID: 22cd2cc349a3586e16ac904a30f1f5c1@72.55.168.18:5060
CSeq: 101 BYE
Server: voip.ms
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0



Your debug has nothing that we could use for analysis.

From the symptom, this looks like a signalling issue. Probably there is no answer to a RE-INVITE, or your ISP does not like one of the messages due to which it does not reply leading to a 60 second time out.

Can you take the debug Manish requested for a test call and attach the file here?

~Avinash

That was the debug that Manish asked for. I'll run another one


LabDOMAIN1#un all
All possible debugging has been turned off
LabDOMAIN1#clear logging
Clear logging buffer [confirm]
LabDOMAIN1#debug ccsip messages
SIP Call messages tracing is enabled
LabDOMAIN1#sh logging
Syslog logging: enabled (5 messages dropped, 3 messages rate-limited, 2116 flushes, 0 overruns, xml disabled, filtering disabled)

No Active Message Discriminator.



No Inactive Message Discriminator.


    Console logging: level debugging, 71482 messages logged, xml disabled,
                     filtering disabled
    Monitor logging: level debugging, 0 messages logged, xml disabled,
                     filtering disabled
    Buffer logging:  level debugging, 68918 messages logged, xml disabled,
                    filtering disabled
    Exception Logging: size (4096 bytes)
    Count and timestamp logging messages: disabled
    Persistent logging: disabled

No active filter modules.

    Trap logging: level informational, 97 message lines logged
        Logging Source-Interface:       VRF Name:

Log Buffer (4096 bytes):
h: 0


Dec  4 21:46:31.176: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
REGISTER sip:montreal3.voip.ms:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK940823C2
From: <sip:12345678@montreal3.voip.ms>;tag=96D24F0C-D03
To: <sip:12345678@montreal3.voip.ms>
Date: Fri, 04 Dec 2015 21:46:31 GMT
Call-ID: E0E652EE-830311E5-8002BE77-FFDD325D
User-Agent: Cisco-SIPGateway/IOS-12.x
Max-Forwards: 70
Timestamp: 1449265591
CSeq: 20834 REGISTER
Contact: <sip:12345678@172.16.16.2:5060>
Expires: 300
Authorization: Digest username="12345678",realm="montreal3.voip.ms",uri="sip:montreal3.voip.ms:5060",response="7df5e15dca308807d7be3e3b99fb3532",nonce="14502de4",algorithm=MD5
Content-Length: 0


Dec  4 21:46:31.184: //93729/000000000000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK940823C2;received=66.11.41.90;rport=58930
From: <sip:12345678@montreal3.voip.ms>;tag=96D24F0C-D03
To: <sip:12345678@montreal3.voip.ms>;tag=as34fdccb7
Call-ID: E0E652EE-830311E5-8002BE77-FFDD325D
CSeq: 20834 REGISTER
Server: voip.ms
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Expires: 300
Contact: <sip:12345678@172.16.16.2:5060>;expires=300
Date: Fri, 04 Dec 2015 21:46:31 GMT
Content-Length: 0


Dec  4 21:46:42.740: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
REGISTER sip:172.16.16.2:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK94091C09
From: <sip:12345678@172.16.16.2>;tag=96D27C44-22B3
To: <sip:12345678@172.16.16.2>
Date: Fri, 04 Dec 2015 21:46:42 GMT
Call-ID: 50DA5F6C-830511E5-8040BE77-FFDD325D
User-Agent: Cisco-SIPGateway/IOS-12.x
Max-Forwards: 70
Timestamp: 1449265602
CSeq: 14053 REGISTER
Contact: <sip:12345678@172.16.16.2:5060>
Expires:  3600
Supported: path
Content-Length: 0


Dec  4 21:46:42.744: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
REGISTER sip:172.16.16.2:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK94091C09
From: <sip:12345678@172.16.16.2>;tag=96D27C44-22B3
To: <sip:12345678@172.16.16.2>
Date: Fri, 04 Dec 2015 21:46:42 GMT
Call-ID: 50DA5F6C-830511E5-8040BE77-FFDD325D
User-Agent: Cisco-SIPGateway/IOS-12.x
Max-Forwards: 70
Timestamp: 1449265602
CSeq: 14053 REGISTER
Contact: <sip:12345678@172.16.16.2:5060>
Expires:  3600
Supported: path
Content-Length: 0


Dec  4 21:46:42.752: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK94091C09
From: <sip:12345678@172.16.16.2>;tag=96D27C44-22B3
To: <sip:12345678@172.16.16.2>
Date: Fri, 04 Dec 2015 21:46:42 GMT
Call-ID: 50DA5F6C-830511E5-8040BE77-FFDD325D
Server: Cisco-SIPGateway/IOS-12.x
Timestamp: 1449265602
CSeq: 14053 REGISTER
Content-Length: 0


Dec  4 21:46:42.756: //93731/5775B54A92FA/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 404 Not Found
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK94091C09
From: <sip:12345678@172.16.16.2>;tag=96D27C44-22B3
To: <sip:12345678@172.16.16.2>;tag=96D27C4C-1E0C
Date: Fri, 04 Dec 2015 21:46:42 GMT
Call-ID: 50DA5F6C-830511E5-8040BE77-FFDD325D
Server: Cisco-SIPGateway/IOS-12.x
Timestamp: 1449265602
CSeq: 14053 REGISTER
Content-Length: 0


Dec  4 21:46:42.756: //93730/000000000000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK94091C09
From: <sip:12345678@172.16.16.2>;tag=96D27C44-22B3
To: <sip:12345678@172.16.16.2>
Date: Fri, 04 Dec 2015 21:46:42 GMT
Call-ID: 50DA5F6C-830511E5-8040BE77-FFDD325D
Server: Cisco-SIPGateway/IOS-12.x
Timestamp: 1449265602
CSeq: 14053 REGISTER
Content-Length: 0


Dec  4 21:46:42.760: //93730/000000000000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 404 Not Found
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK94091C09
From: <sip:12345678@172.16.16.2>;tag=96D27C44-22B3
To: <sip:12345678@172.16.16.2>;tag=96D27C4C-1E0C
Date: Fri, 04 Dec 2015 21:46:42 GMT
Call-ID: 50DA5F6C-830511E5-8040BE77-FFDD325D
Server: Cisco-SIPGateway/IOS-12.x
Timestamp: 1449265602
CSeq: 14053 REGISTER
Content-Length: 0


LabDOMAIN1#

just run like below

# config mode

# no logg console

# no logg monitor

# logging buffered 30000000

# exit

# debug ccsip message

# debug voice ccapi inout

Br, Nadeem Please rate all useful post.


LabDOMAIN1#conf t
Enter configuration commands, one per line.  End with CNTL/Z.
LabDOMAIN1(config)#no log console
% Ambiguous command:  "no log console"
LabDOMAIN1(config)#no logg console
LabDOMAIN1(config)#no logg monitor
LabDOMAIN1(config)#logging buffered 30000000
LabDOMAIN1(config)#exit
LabDOMAIN1#debug ccsip message
SIP Call messages tracing is enabled
LabDOMAIN1#debug voice ccapi inout
voip ccapi inout debugging is on
LabDOMAIN1#show logging
Syslog logging: enabled (5 messages dropped, 3 messages rate-limited, 2119 flushes, 0 overruns, xml disabled, filtering disabled)

No Active Message Discriminator.



No Inactive Message Discriminator.


    Console logging: disabled
    Monitor logging: disabled
    Buffer logging:  level debugging, 426 messages logged, xml disabled,
                    filtering disabled
    Exception Logging: size (4096 bytes)
    Count and timestamp logging messages: disabled
    Persistent logging: disabled

No active filter modules.

    Trap logging: level informational, 98 message lines logged
        Logging Source-Interface:       VRF Name:

Log Buffer (30000000 bytes):

Dec  4 23:23:49.611: %SYS-5-CONFIG_I: Configured from console by voipDOMAIN on vty0 (172.16.16.1)
Dec  4 23:25:26.224: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
INVITE sip:12345678@172.16.16.2:5060 SIP/2.0
Via: SIP/2.0/UDP 72.55.168.18:5060;branch=z9hG4bK519ffbaf;rport
Max-Forwards: 70
From: "DOMAIN" <sip:5147221234@72.55.168.18>;tag=as2eaf8249
To: <sip:12345678@172.16.16.2:5060>
Contact: <sip:5147221234@72.55.168.18:5060>
Call-ID: 0ecac0404157151e3069efe27fac68bd@72.55.168.18:5060
CSeq: 102 INVITE
User-Agent: voip.ms
Date: Fri, 04 Dec 2015 23:25:26 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Remote-Party-ID: "DOMAIN" <sip:5147221234@72.55.168.18>;party=calling;privacy=off;screen=no
Content-Type: application/sdp
Content-Length: 268

v=0
o=root 584936720 584936720 IN IP4 72.55.168.18
s=voip.ms
c=IN IP4 72.55.168.18
t=0 0
m=audio 12540 RTP/AVP 0 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv

Dec  4 23:25:26.236: //-1/2220FA8F93C7/CCAPI/cc_api_display_ie_subfields:
   cc_api_call_setup_ind_common:
   cisco-username=5147221234
   ----- ccCallInfo IE subfields -----
   cisco-ani=5147221234
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=12345678
   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

Dec  4 23:25:26.236: //-1/2220FA8F93C7/CCAPI/cc_api_call_setup_ind_common:
   Interface=0x49C67A38, Call Info(
   Calling Number=5147221234,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=12345678(TON=Unknown, NPI=Unknown),
   Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,
   Incoming Dial-peer=1, Progress Indication=NULL(0), Calling IE Present=TRUE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=94011
Dec  4 23:25:26.240: //-1/2220FA8F93C7/CCAPI/ccCheckClipClir:
   In: Calling Number=5147221234(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Dec  4 23:25:26.240: //-1/2220FA8F93C7/CCAPI/ccCheckClipClir:
   Out: Calling Number=5147221234(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Dec  4 23:25:26.240: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:26.240: :cc_get_feature_vsa malloc success
Dec  4 23:25:26.240: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:26.240:  cc_get_feature_vsa count is 1
Dec  4 23:25:26.240: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:26.240: :FEATURE_VSA attributes are: feature_name:0,feature_time:1223981768,feature_id:503
Dec  4 23:25:26.240: //94011/2220FA8F93C7/CCAPI/cc_api_call_setup_ind_common:
   Set Up Event Sent;
   Call Info(Calling Number=5147221234(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=12345678(TON=Unknown, NPI=Unknown))
Dec  4 23:25:26.244: //94011/2220FA8F93C7/CCAPI/cc_process_call_setup_ind:
   Event=0x4B12D548
Dec  4 23:25:26.244: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
   Try with the demoted called number 12345678
Dec  4 23:25:26.248: //94011/2220FA8F93C7/CCAPI/ccCallSetContext:
   Context=0x48F52FBC
Dec  4 23:25:26.248: //94011/2220FA8F93C7/CCAPI/cc_process_call_setup_ind:
   >>>>CCAPI handed cid 94011 with tag 1 to app "_ManagedAppProcess_Default"
Dec  4 23:25:26.248: //94011/2220FA8F93C7/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 72.55.168.18:5060;branch=z9hG4bK519ffbaf;rport
From: "DOMAIN" <sip:5147221234@72.55.168.18>;tag=as2eaf8249
To: <sip:12345678@172.16.16.2:5060>
Date: Fri, 04 Dec 2015 23:25:26 GMT
Call-ID: 0ecac0404157151e3069efe27fac68bd@72.55.168.18:5060
CSeq: 102 INVITE
Allow-Events: telephone-event
Server: Cisco-SIPGateway/IOS-12.x
Content-Length: 0


Dec  4 23:25:26.252: //94011/2220FA8F93C7/CCAPI/ccCallProceeding:
   Progress Indication=NULL(0)
Dec  4 23:25:26.256: //94011/2220FA8F93C7/CCAPI/ccCallSetupRequest:
   Destination=, Calling IE Present=TRUE, Mode=0,
   Outgoing Dial-peer=40006, Params=0x48F5598C, Progress Indication=NULL(0)
Dec  4 23:25:26.256: //94011/2220FA8F93C7/CCAPI/ccCheckClipClir:
   In: Calling Number=5147221234(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Dec  4 23:25:26.256: //94011/2220FA8F93C7/CCAPI/ccCheckClipClir:
   Out: Calling Number=5147221234(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Dec  4 23:25:26.256: //94011/2220FA8F93C7/CCAPI/ccCallSetupRequest:
   Destination Pattern=2000, Called Number=2339, Digit Strip=FALSE
Dec  4 23:25:26.256: //94011/2220FA8F93C7/CCAPI/ccCallSetupRequest:
   Calling Number=5147221234(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=2339(TON=Unknown, NPI=Unknown),
   Redirect Number=, Display Info=DOMAIN
   Account Number=5147221234, Final Destination Flag=TRUE,
   Guid=2220FA8F-9A15-11E5-93C7-BE77FFDD325D, Outgoing Dial-peer=40006
Dec  4 23:25:26.256: //94011/2220FA8F93C7/CCAPI/cc_api_display_ie_subfields:
   ccCallSetupRequest:
   cisco-username=5147221234
   ----- ccCallInfo IE subfields -----
   cisco-ani=5147221234
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=2339
   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

Dec  4 23:25:26.260: //94011/2220FA8F93C7/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x49C67A38, Interface Type=3, Destination=, Mode=0x0,
   Call Params(Calling Number=5147221234,(Calling Name=DOMAIN)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=2339(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=40006, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
Dec  4 23:25:26.260: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:26.260: :cc_get_feature_vsa malloc success
Dec  4 23:25:26.260: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:26.260:  cc_get_feature_vsa count is 2
Dec  4 23:25:26.260: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:26.260: :FEATURE_VSA attributes are: feature_name:0,feature_time:1223981544,feature_id:504
Dec  4 23:25:26.260: //94012/2220FA8F93C7/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=3, FlowMode=1
Dec  4 23:25:26.260: //94012/2220FA8F93C7/CCAPI/ccCallSetContext:
   Context=0x48F5593C
Dec  4 23:25:26.260: //94011/2220FA8F93C7/CCAPI/ccSaveDialpeerTag:
   Outgoing Dial-peer=40006
Dec  4 23:25:26.268: //94012/2220FA8F93C7/CCAPI/cc_api_call_proceeding:
   Interface=0x49C67A38, Progress Indication=NULL(0)
Dec  4 23:25:26.272: //94012/2220FA8F93C7/SIP/Msg/ccsipDisplayMsg:
Sent:
INVITE sip:2339@172.16.16.23:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK946D6C3
From: "DOMAIN" <sip:5147221234@172.16.16.2>;tag=972CDED0-600
To: <sip:2339@172.16.16.23>
Date: Fri, 04 Dec 2015 23:25:26 GMT
Call-ID: 2227B178-9A1511E5-93CDBE77-FFDD325D@172.16.16.2
Supported: 100rel,timer,resource-priority,replaces
Min-SE:  1800
Cisco-Guid: 0572586639-2585072101-2479341175-4292686429
User-Agent: Cisco-SIPGateway/IOS-12.x
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
CSeq: 101 INVITE
Timestamp: 1449271526
Contact: <sip:5147221234@172.16.16.2:5060>
Expires: 180
Allow-Events: telephone-event
Max-Forwards: 69
Cisco-Gcid: 22223378-9A15-11E5-93CA-BE77FFDD325D
P-Preferred-Identity: "DOMAIN" <sip:5147221234@172.16.16.2>
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 325

v=0
o=CiscoSystemsSIP-GW-UserAgent 5699 9646 IN IP4 172.16.16.2
s=SIP Call
c=IN IP4 172.16.16.2
t=0 0
m=audio 18560 RTP/AVP 0 101 121 19
c=IN IP4 172.16.16.2
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:121 frf-dialed-digit/8000
a=fmtp:121 0-15
a=rtpmap:19 CN/8000
a=ptime:20

Dec  4 23:25:26.288: //94012/2220FA8F93C7/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK946D6C3
From: "DOMAIN" <sip:5147221234@172.16.16.2>;tag=972CDED0-600
To: <sip:2339@172.16.16.23>
Call-ID: 2227B178-9A1511E5-93CDBE77-FFDD325D@172.16.16.2
Date: Fri, 04 Dec 2015 23:25:26 GMT
CSeq: 101 INVITE
Server: Cisco-CP7975G/9.4.2
Contact: <sip:60037a2b-e0b4-7c3f-dd9f-4eca6b99ccd4@172.16.16.23:5060;transport=udp>
Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER,REGISTER,UPDATE,SUBSCRIBE,INFO
Supported: replaces,join,sdp-anat,norefersub,resource-priority,X-cisco-srtp-fallback,X-cisco-xsi-8.5.1
Allow-Events: kpml,dialog
Content-Length: 0


Dec  4 23:25:26.360: //94012/2220FA8F93C7/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK946D6C3
From: "DOMAIN" <sip:5147221234@172.16.16.2>;tag=972CDED0-600
To: <sip:2339@172.16.16.23>;tag=44e4d945122b007f9388ef35-2b5ea32f

Call-ID: 2227B178-9A1511E5-93CDBE77-FFDD325D@172.16.16.2
Date: Fri, 04 Dec 2015 23:25:26 GMT
CSeq: 101 INVITE
Server: Cisco-CP7975G/9.4.2
Contact: <sip:60037a2b-e0b4-7c3f-dd9f-4eca6b99ccd4@172.16.16.23:5060;transport=udp>
Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER,REGISTER,UPDATE,SUBSCRIBE,INFO
Remote-Party-ID: "Jakub Stroinski" <sip:2339@172.16.16.2>;party=called;id-type=subscriber;privacy=off;screen=yes

Supported: replaces,join,sdp-anat,norefersub,resource-priority,X-cisco-srtp-fallback,X-cisco-xsi-8.5.1
Allow-Events: kpml,dialog
Content-Length: 0


Dec  4 23:25:26.360: //94012/2220FA8F93C7/CCAPI/cc_api_call_alert:
   Interface=0x49C67A38, Progress Indication=NULL(0), Signal Indication=SIGNAL RINGBACK(1)
Dec  4 23:25:26.360: //94012/2220FA8F93C7/CCAPI/cc_api_call_alert:
   Call Entry(Retry Count=0, Responsed=TRUE)
Dec  4 23:25:26.364: //94011/2220FA8F93C7/CCAPI/ccCallAlert:
   Progress Indication=NULL(0), Signal Indication=SIGNAL RINGBACK(1)
Dec  4 23:25:26.364: //94011/2220FA8F93C7/CCAPI/ccCallAlert:
   Call Entry(Responsed=TRUE, Alert Sent=TRUE)
Dec  4 23:25:26.368: //94011/2220FA8F93C7/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 72.55.168.18:5060;branch=z9hG4bK519ffbaf;rport
From: "DOMAIN" <sip:5147221234@72.55.168.18>;tag=as2eaf8249
To: <sip:12345678@172.16.16.2:5060>;tag=972CDF30-17AC
Date: Fri, 04 Dec 2015 23:25:26 GMT

Call-ID: 0ecac0404157151e3069efe27fac68bd@72.55.168.18:5060
CSeq: 102 INVITE
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
Allow-Events: telephone-event
Remote-Party-ID: "Jakub Stroinski" <sip:2339@172.16.16.2>;party=called;screen=yes;privacy=off
Contact: <sip:12345678@172.16.16.2:5060>
Server: Cisco-SIPGateway/IOS-12.x
Content-Length: 0


Dec  4 23:25:41.364: //-1/xxxxxxxxxxxx/CCAPI/ccUpdateRedirectingNumber:
   type=6 redirecting_number=2339
Dec  4 23:25:41.364: //-1/xxxxxxxxxxxx/CCAPI/ccUpdateRedirectNumber:
   type=6  Original Called Number=2339, Called Number=2339, Calling Number=5147221234, Calling DN=-1 Calling Id=94011,
   Redirect Number=95148121234, Redirect Reason=2
Dec  4 23:25:41.364: //-1/xxxxxxxxxxxx/CCAPI/ccUpdateRedirectingNumber:
   type=6 redirecting_number=2339
Dec  4 23:25:41.364: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:41.364: :cc_get_feature_vsa malloc success
Dec  4 23:25:41.364: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:41.364:  cc_get_feature_vsa count is 3
Dec  4 23:25:41.364: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:41.364: :FEATURE_VSA attributes are: feature_name:0,feature_time:1223982440,feature_id:505
Dec  4 23:25:41.364: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Dec  4 23:25:41.364:  feature_vsa is 48F47AC0,featname is 0
Dec  4 23:25:41.364: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:41.364: :cc_get_feature_vsa malloc success
Dec  4 23:25:41.364: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:41.364:  cc_get_feature_vsa count is 4
Dec  4 23:25:41.364: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:41.364: :FEATURE_VSA attributes are: feature_name:0,feature_time:1223978632,feature_id:506
Dec  4 23:25:41.364: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Dec  4 23:25:41.364: : Generating new featurevsa,inserting it
Dec  4 23:25:41.364: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Dec  4 23:25:41.364:  feature call forward featname is 3
Dec  4 23:25:41.368: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Dec  4 23:25:41.368:  feature_vsa is 48F479E0,featname is 0
Dec  4 23:25:41.368: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:41.368: :cc_get_feature_vsa malloc success
Dec  4 23:25:41.368: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:41.368:  cc_get_feature_vsa count is 5
Dec  4 23:25:41.368: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:41.368: :FEATURE_VSA attributes are: feature_name:0,feature_time:1223980424,feature_id:507
Dec  4 23:25:41.368: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Dec  4 23:25:41.368: : Generating new featurevsa,inserting it
Dec  4 23:25:41.368: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Dec  4 23:25:41.368:  feature call forward featname is 3
Dec  4 23:25:41.368: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  4 23:25:41.368: :cc_free_feature_vsa freeing 48F47D60
Dec  4 23:25:41.368: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  4 23:25:41.368:  vsacount in free is 4
Dec  4 23:25:41.368: //94012/2220FA8F93C7/CCAPI/ccCallDisconnect:
   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
Dec  4 23:25:41.368: //94012/2220FA8F93C7/CCAPI/ccCallDisconnect:
   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
Dec  4 23:25:41.372: //94012/2220FA8F93C7/SIP/Msg/ccsipDisplayMsg:
Sent:
CANCEL sip:2339@172.16.16.23:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK946D6C3
From: "DOMAIN" <sip:5147221234@172.16.16.2>;tag=972CDED0-600
To: <sip:2339@172.16.16.23>
Date: Fri, 04 Dec 2015 23:25:26 GMT
Call-ID: 2227B178-9A1511E5-93CDBE77-FFDD325D@172.16.16.2
CSeq: 101 CANCEL
Max-Forwards: 70
Timestamp: 1449271541
Reason: Q.850;cause=16

Content-Length: 0


Dec  4 23:25:41.384: //94012/2220FA8F93C7/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK946D6C3
From: "DOMAIN" <sip:5147221234@172.16.16.2>;tag=972CDED0-600
To: <sip:2339@172.16.16.23>;tag=44e4d945122b007f9388ef35-2b5ea32f
Call-ID: 2227B178-9A1511E5-93CDBE77-FFDD325D@172.16.16.2
Date: Fri, 04 Dec 2015 23:25:41 GMT
CSeq: 101 CANCEL
Server: Cisco-CP7975G/9.4.2
Content-Length: 0


Dec  4 23:25:41.384: //94012/2220FA8F93C7/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x49C67A38, Tag=0x0, Call Id=94012,
   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
Dec  4 23:25:41.388: //94012/2220FA8F93C7/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
Dec  4 23:25:41.388: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  4 23:25:41.388: :cc_free_feature_vsa freeing 48F47580
Dec  4 23:25:41.388: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  4 23:25:41.388:  vsacount in free is 3
Dec  4 23:25:41.388: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  4 23:25:41.388:  vsacount in free is 2
Dec  4 23:25:41.388: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:41.388: :cc_get_feature_vsa malloc success
Dec  4 23:25:41.388: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:41.388:  cc_get_feature_vsa count is 3
Dec  4 23:25:41.388: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:41.388: :FEATURE_VSA attributes are: feature_name:0,feature_time:1223981544,feature_id:508
Dec  4 23:25:41.392: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Dec  4 23:25:41.392:  feature call forward featname is 3
Dec  4 23:25:41.392: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  4 23:25:41.392: :cc_free_feature_vsa freeing 48F479E0
Dec  4 23:25:41.392: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  4 23:25:41.392:  vsacount in free is 2
Dec  4 23:25:41.396: //94011/2220FA8F93C7/CCAPI/ccCallSetupRequest:
   Destination=, Calling IE Present=TRUE, Mode=0,
   Outgoing Dial-peer=3, Params=0x48F51B4C, Progress Indication=NULL(0)
Dec  4 23:25:41.396: //94011/2220FA8F93C7/CCAPI/ccCheckClipClir:
   In: Calling Number=5143601234(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Dec  4 23:25:41.396: //94011/2220FA8F93C7/CCAPI/ccCheckClipClir:
   Out: Calling Number=5143601234(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Dec  4 23:25:41.396: //94011/2220FA8F93C7/CCAPI/ccCallSetupRequest:
   Destination Pattern=9[2-9]..[2-9]......, Called Number=5148121234, Digit Strip=FALSE
Dec  4 23:25:41.396: //94011/2220FA8F93C7/CCAPI/ccCallSetupRequest:
   Calling Number=5143601234(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=5148121234(TON=Unknown, NPI=Unknown),
   Redirect Number=2339, Display Info=DOMAIN
   Account Number=5147221234, Final Destination Flag=TRUE,
   Guid=2B2B74C0-9A15-11E5-93CE-BE77FFDD325D, Outgoing Dial-peer=3
Dec  4 23:25:41.396: //94011/2220FA8F93C7/CCAPI/cc_api_display_ie_subfields:
   ccCallSetupRequest:
   cisco-username=5147221234
   ----- ccCallInfo IE subfields -----
   cisco-ani=5143601234
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=5148121234
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=73
   cisco-rdn=2339
   cisco-rdntype=0
   cisco-rdnplan=0
   cisco-rdnpi=0
   cisco-rdnsi=0
   cisco-redirectreason=2   fwd_final_type =0
   final_redirectNumber =
   hunt_group_timeout =0

Dec  4 23:25:41.396: //94011/2220FA8F93C7/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x49C67A38, Interface Type=3, Destination=, Mode=0x0,
   Call Params(Calling Number=5143601234,(Calling Name=DOMAIN)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=5148121234(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=3, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
Dec  4 23:25:41.396: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:41.400: :cc_get_feature_vsa malloc success
Dec  4 23:25:41.400: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:41.400:  cc_get_feature_vsa count is 3
Dec  4 23:25:41.400: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:41.400: :FEATURE_VSA attributes are: feature_name:0,feature_time:1223981544,feature_id:509
Dec  4 23:25:41.400: //94013/2220FA8F93C7/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=3, FlowMode=1
Dec  4 23:25:41.400: //94013/2220FA8F93C7/CCAPI/ccCallSetContext:
   Context=0x48F51AFC
Dec  4 23:25:41.400: //94011/2220FA8F93C7/CCAPI/ccSaveDialpeerTag:
   Outgoing Dial-peer=3
Dec  4 23:25:41.400: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Dec  4 23:25:41.400:  feature call forward featname is 3
Dec  4 23:25:41.400: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Dec  4 23:25:41.400:  feature_vsa is 48F479E0,featname is 0
Dec  4 23:25:41.400: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:41.400: :cc_get_feature_vsa malloc success
Dec  4 23:25:41.400: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:41.400:  cc_get_feature_vsa count is 4
Dec  4 23:25:41.404: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  4 23:25:41.404: :FEATURE_VSA attributes are: feature_name:0,feature_time:1223980424,feature_id:510
Dec  4 23:25:41.404: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Dec  4 23:25:41.404: : Generating new featurevsa,inserting it
Dec  4 23:25:41.404: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Dec  4 23:25:41.404:  feature call forward featname is 3
Dec  4 23:25:41.408: //94013/2220FA8F93C7/CCAPI/cc_api_call_proceeding:
   Interface=0x49C67A38, Progress Indication=NULL(0)
Dec  4 23:25:41.416: //94013/2B2B74C093CE/SIP/Msg/ccsipDisplayMsg:
Sent:
INVITE sip:5148121234@72.55.168.18:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK946E1A7C
From: "Cisco Lab" <sip:5143601234@172.16.16.2>;tag=972D19F8-1D03
To: <sip:5148121234@72.55.168.18>
Date: Fri, 04 Dec 2015 23:25:41 GMT
Call-ID: 2B2DE55F-9A1511E5-93D2BE77-FFDD325D@172.16.16.2
Supported: 100rel,timer,resource-priority,replaces,sdp-anat
Min-SE:  1800
Cisco-Guid: 0724268224-2585072101-2479799927-4292686429
User-Agent: Cisco-SIPGateway/IOS-12.x
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
CSeq: 101 INVITE
Timestamp: 1449271541
Contact: <sip:5143601234@172.16.16.2:5060>
Call-Info: <sip:172.16.16.2:5060>;method="NOTIFY;Event=telephone-event;Duration=2000"
Diversion: <sip:2339@172.16.16.2>;privacy=off;reason=no-answer;counter=1;screen=no

Expires: 180
Allow-Events: kpml, telephone-event
Max-Forwards: 69
Cisco-Gcid: 22223378-9A15-11E5-93CA-BE77FFDD325D
P-Preferred-Identity: "DOMAIN" <sip:5143601234@172.16.16.2>
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 301

v=0
o=CiscoSystemsSIP-GW-UserAgent 8473 1772 IN IP4 172.16.16.2
s=SIP Call
c=IN IP4 172.16.16.2
t=0 0
m=audio 16902 RTP/AVP 0 101 121
c=IN IP4 172.16.16.2
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:121 frf-dialed-digit/8000
a=fmtp:121 0-15
a=ptime:20


Dec  4 23:25:41.420: //94012/2220FA8F93C7/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 487 Request Cancelled
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK946D6C3
From: "DOMAIN" <sip:5147221234@172.16.16.2>;tag=972CDED0-600
To: <sip:2339@172.16.16.23>;tag=44e4d945122b007f9388ef35-2b5ea32f
Call-ID: 2227B178-9A1511E5-93CDBE77-FFDD325D@172.16.16.2
Date: Fri, 04 Dec 2015 23:25:41 GMT
CSeq: 101 INVITE
Server: Cisco-CP7975G/9.4.2
Contact: <sip:60037a2b-e0b4-7c3f-dd9f-4eca6b99ccd4@172.16.16.23:5060;transport=udp>
Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER,REGISTER,UPDATE,SUBSCRIBE,INFO
Remote-Party-ID: "Jakub Stroinski" <sip:2339@172.16.16.2>;party=called;id-type=subscriber;privacy=off;screen=yes
Allow-Events: kpml,dialog
Content-Length: 0


Dec  4 23:25:41.424: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
ACK sip:2339@172.16.16.23:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK946D6C3
From: "DOMAIN" <sip:5147221234@172.16.16.2>;tag=972CDED0-600
To: <sip:2339@172.16.16.23>;tag=44e4d945122b007f9388ef35-2b5ea32f
Date: Fri, 04 Dec 2015 23:25:26 GMT
Call-ID: 2227B178-9A1511E5-93CDBE77-FFDD325D@172.16.16.2
Max-Forwards: 70
CSeq: 101 ACK
Allow-Events: telephone-event
Content-Length: 0


Dec  4 23:25:41.428: //94013/2B2B74C093CE/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK946E1A7C;received=66.11.41.90;rport=58930
From: "Cisco Lab" <sip:5143601234@172.16.16.2>;tag=972D19F8-1D03
To: <sip:5148121234@72.55.168.18>;tag=as0b201840
Call-ID: 2B2DE55F-9A1511E5-93D2BE77-FFDD325D@172.16.16.2
CSeq: 101 INVITE
Server: voip.ms
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH

Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="montreal3.voip.ms", nonce="35e998a7"
Content-Length: 0


Dec  4 23:25:41.432: //94013/2B2B74C093CE/SIP/Msg/ccsipDisplayMsg:
Sent:
ACK sip:5148121234@72.55.168.18:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK946E1A7C
From: "DOMAIN" <sip:5143601234@172.16.16.2>;tag=972D19F8-1D03
To: <sip:5148121234@72.55.168.18>;tag=as0b201840
Date: Fri, 04 Dec 2015 23:25:41 GMT
Call-ID: 2B2DE55F-9A1511E5-93D2BE77-FFDD325D@172.16.16.2
Max-Forwards: 70
CSeq: 101 ACK
Allow-Events: kpml, telephone-event
Content-Length: 0


Dec  4 23:25:41.436: //94013/2B2B74C093CE/SIP/Msg/ccsipDisplayMsg:
Sent:
INVITE sip:5148121234@72.55.168.18:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK946F255D
From: "Cisco Lab" <sip:5143601234@172.16.16.2>;tag=972D19F8-1D03
To: <sip:5148121234@72.55.168.18>
Date: Fri, 04 Dec 2015 23:25:41 GMT
Call-ID: 2B2DE55F-9A1511E5-93D2BE77-FFDD325D@172.16.16.2
Supported: 100rel,timer,resource-priority,replaces,sdp-anat
Min-SE:  1800
Cisco-Guid: 0724268224-2585072101-2479799927-4292686429
User-Agent: Cisco-SIPGateway/IOS-12.x
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
CSeq: 102 INVITE
Timestamp: 1449271541
Contact: <sip:5143601234@172.16.16.2:5060>
Call-Info: <sip:172.16.16.2:5060>;method="NOTIFY;Event=telephone-event;Duration=2000"
Diversion: <sip:2339@172.16.16.2>;privacy=off;reason=no-answer;counter=1;screen=no
Expires: 180
Allow-Events: kpml, telephone-event
Authorization: Digest username="12345678",realm="montreal3.voip.ms",uri="sip:5148121234@72.55.168.18:5060",response="be0496564373569f1e8b3331ddf27a98",nonce="35e998a7",algorithm=MD5

Max-Forwards: 69
Cisco-Gcid: 22223378-9A15-11E5-93CA-BE77FFDD325D
P-Preferred-Identity: "DOMAIN" <sip:5143601234@172.16.16.2>
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 301

v=0
o=CiscoSystemsSIP-GW-UserAgent 8473 1772 IN IP4 172.16.16.2
s=SIP Call
c=IN IP4 172.16.16.2
t=0 0
m=audio 16902 RTP/AVP 0 101 121
c=IN IP4 172.16.16.2
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:121 frf-dialed-digit/8000
a=fmtp:121 0-15
a=ptime:20

Dec  4 23:25:41.444: //94013/2B2B74C093CE/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK946F255D;received=66.11.41.90;rport=58930
From: "Cisco Lab" <sip:5143601234@172.16.16.2>;tag=972D19F8-1D03
To: <sip:5148121234@72.55.168.18>
Call-ID: 2B2DE55F-9A1511E5-93D2BE77-FFDD325D@172.16.16.2
CSeq: 102 INVITE
Server: voip.ms
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Session-Expires: 1800;refresher=uas
Contact: <sip:5148121234@72.55.168.18:5060>
Content-Length: 0


Dec  4 23:25:43.620: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
REGISTER sip:172.16.16.2:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9470E7B
From: <sip:12345678@172.16.16.2>;tag=972D2294-1783
To: <sip:12345678@172.16.16.2>

Date: Fri, 04 Dec 2015 23:25:43 GMT
Call-ID: 50DA5F6C-830511E5-8040BE77-FFDD325D
User-Agent: Cisco-SIPGateway/IOS-12.x
Max-Forwards: 70
Timestamp: 1449271543
CSeq: 14086 REGISTER
Contact: <sip:12345678@172.16.16.2:5060>
Expires:  3600
Supported: path
Content-Length: 0


Dec  4 23:25:43.624: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
REGISTER sip:172.16.16.2:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9470E7B
From: <sip:12345678@172.16.16.2>;tag=972D2294-1783
To: <sip:12345678@172.16.16.2>
Date: Fri, 04 Dec 2015 23:25:43 GMT
Call-ID: 50DA5F6C-830511E5-8040BE77-FFDD325D
User-Agent: Cisco-SIPGateway/IOS-12.x
Max-Forwards: 70

Timestamp: 1449271543
CSeq: 14086 REGISTER
Contact: <sip:12345678@172.16.16.2:5060>
Expires:  3600
Supported: path
Content-Length: 0


Dec  4 23:25:43.632: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9470E7B
From: <sip:12345678@172.16.16.2>;tag=972D2294-1783
To: <sip:12345678@172.16.16.2>
Date: Fri, 04 Dec 2015 23:25:43 GMT
Call-ID: 50DA5F6C-830511E5-8040BE77-FFDD325D
Server: Cisco-SIPGateway/IOS-12.x
Timestamp: 1449271543
CSeq: 14086 REGISTER
Content-Length: 0


Dec  4 23:25:43.632: //94015/2C8008C393D3/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 404 Not Found
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9470E7B
From: <sip:12345678@172.16.16.2>;tag=972D2294-1783
To: <sip:12345678@172.16.16.2>;tag=972D22A0-13D6
Date: Fri, 04 Dec 2015 23:25:43 GMT
Call-ID: 50DA5F6C-830511E5-8040BE77-FFDD325D
Server: Cisco-SIPGateway/IOS-12.x
Timestamp: 1449271543
CSeq: 14086 REGISTER
Content-Length: 0


Dec  4 23:25:43.636: //94014/000000000000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9470E7B
From: <sip:12345678@172.16.16.2>;tag=972D2294-1783
To: <sip:12345678@172.16.16.2>
Date: Fri, 04 Dec 2015 23:25:43 GMT
Call-ID: 50DA5F6C-830511E5-8040BE77-FFDD325D
Server: Cisco-SIPGateway/IOS-12.x

Timestamp: 1449271543
CSeq: 14086 REGISTER
Content-Length: 0


Dec  4 23:25:43.640: //94014/000000000000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 404 Not Found
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9470E7B
From: <sip:12345678@172.16.16.2>;tag=972D2294-1783
To: <sip:12345678@172.16.16.2>;tag=972D22A0-13D6
Date: Fri, 04 Dec 2015 23:25:43 GMT
Call-ID: 50DA5F6C-830511E5-8040BE77-FFDD325D
Server: Cisco-SIPGateway/IOS-12.x
Timestamp: 1449271543
CSeq: 14086 REGISTER
Content-Length: 0


Dec  4 23:25:51.492: //94013/2B2B74C093CE/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 200 OK

Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK946F255D;received=66.11.41.90;rport=58930
From: "Cisco Lab" <sip:5143601234@172.16.16.2>;tag=972D19F8-1D03
To: <sip:5148121234@72.55.168.18>;tag=as51f98a9d
Call-ID: 2B2DE55F-9A1511E5-93D2BE77-FFDD325D@172.16.16.2
CSeq: 102 INVITE
Server: voip.ms
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Session-Expires: 1800;refresher=uas
Contact: <sip:5148121234@72.55.168.18:5060>
Content-Type: application/sdp
Require: timer
Content-Length: 221

v=0
o=root 238145809 238145809 IN IP4 72.55.168.18
s=voip.ms
c=IN IP4 72.55.168.18
t=0 0
m=audio 18296 RTP/AVP 0 101

a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv

Dec  4 23:25:51.500: //94013/2220FA8F93C7/CCAPI/cc_api_caps_ind:
   Destination Interface=0x0, Destination Call Id=-1, Source Call Id=94013,
   Caps(Codec=0x1, Fax Rate=0x2, Vad=0x2,
   Modem=0x0, Codec Bytes=20, Signal Type=2)
Dec  4 23:25:51.500: //94013/2220FA8F93C7/CCAPI/cc_api_caps_ind:
   Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms),
   Playout Max=1000(ms), Fax Nom=300(ms))
Dec  4 23:25:51.500: //94011/2220FA8F93C7/CCAPI/cc_api_caps_ack:
   Destination Interface=0x0, Destination Call Id=94013, Source Call Id=94011,
   Caps(Codec=g711ulaw(0x1), Fax Rate=FAX_RATE_VOICE(0x2), Vad=OFF(0x1),
   Modem=OFF(0x0), Codec Bytes=160, Signal Type=2, Seq Num Start=1)
Dec  4 23:25:51.500: //94011/2220FA8F93C7/CCAPI/cc_api_caps_ack:
   Destination Interface=0x0, Destination Call Id=94013, Source Call Id=94011,
   Caps(Codec=g711ulaw(0x1), Fax Rate=FAX_RATE_VOICE(0x2), Vad=OFF(0x1),
   Modem=OFF(0x0), Codec Bytes=160, Signal Type=2, Seq Num Start=1)
Dec  4 23:25:51.500: //94013/2220FA8F93C7/CCAPI/cc_api_event_indication:
   Event=171, Call Id=94013
Dec  4 23:25:51.500: //94013/2220FA8F93C7/CCAPI/cc_api_event_indication:
   Event Is Sent To Conferenced SPI(s) Directly
Dec  4 23:25:51.500: //94013/2220FA8F93C7/CCAPI/cc_api_call_connected:
   Interface=0x49C67A38, Data Bitmask=0x1, Progress Indication=NULL(0),
   Connection Handle=0
Dec  4 23:25:51.500: //94013/2220FA8F93C7/CCAPI/cc_api_call_connected:
   Call Entry(Connected=TRUE, Responsed=TRUE, Retry Count=0)
Dec  4 23:25:51.508: //94011/2220FA8F93C7/CCAPI/ccConferenceCreate:
   (confID=0x48F861AC, callID1=0x16F3B, gcid=22223378-9A1511E5-93CABE77-FFDD325D, tag=0x0)
Dec  4 23:25:51.508: //94013/2220FA8F93C7/CCAPI/ccConferenceCreate:
   (confID=0x48F861AC, callID2=0x16F3D, gcid=22223378-9A1511E5-93CABE77-FFDD325D, tag=0x0)
Dec  4 23:25:51.508: //94011/2220FA8F93C7/CCAPI/ccConferenceCreate:
   Conference Id=0x48F861AC, Call Id1=94011, Call Id2=94013, Tag=0x0
Dec  4 23:25:51.508: //94011/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  4 23:25:51.508: cc_api_get_xcode_stream : 4702
Dec  4 23:25:51.508: //94013/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  4 23:25:51.508: cc_api_get_xcode_stream : 4702
Dec  4 23:25:51.508: //94011/2220FA8F93C7/CCAPI/ccConferenceCreate:

Dec  4 23:25:51.508: ccConferenceCreate: ret1=0, codecMask1=1, bytes1=160, negot1=1, dtmf1=6
                    ret2=0, codecMask2=1, bytes2=160, negot2=1, dtmf2=6,
                    tx_dynamic_pt1=0, rx_dynamic_pt1=0, codec_mode1=0, params_bitmap1 =0
                    tx_dynamic_pt2=0, rx_dynamic_pt2=0, codec_mode2=0, params_bitmap2 =0
Dec  4 23:25:51.508: //94011/2220FA8F93C7/CCAPI/ccConferenceCreate:
   delay media to slow start case, codec negotation is not done
Dec  4 23:25:51.508: //94011/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  4 23:25:51.508: cc_api_get_xcode_stream : 4702
Dec  4 23:25:51.508: //94011/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  4 23:25:51.508: cc_api_get_xcode_stream : 4702
Dec  4 23:25:51.512: //94011/2220FA8F93C7/CCAPI/cc_api_bridge_done:
   Conference Id=0x65, Source Interface=0x49C67A38, Source Call Id=94011,
   Destination Call Id=94013, Disposition=0x0, Tag=0x0
Dec  4 23:25:51.512: //94013/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  4 23:25:51.512: cc_api_get_xcode_stream : 4702
Dec  4 23:25:51.512: //94013/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  4 23:25:51.512: cc_api_get_xcode_stream : 4702
Dec  4 23:25:51.512: //94013/2220FA8F93C7/CCAPI/cc_api_bridge_done:
   Conference Id=0x65, Source Interface=0x49C67A38, Source Call Id=94013,
   Destination Call Id=94011, Disposition=0x0, Tag=0x0
Dec  4 23:25:51.512: //94011/2220FA8F93C7/CCAPI/cc_generic_bridge_done:
   Conference Id=0x65, Source Interface=0x49C67A38, Source Call Id=94013,
   Destination Call Id=94011, Disposition=0x0, Tag=0x0
Dec  4 23:25:51.512: //94011/2220FA8F93C7/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0x65, Destination Call Id=94013)
Dec  4 23:25:51.512: //94013/2220FA8F93C7/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0x65, Destination Call Id=94011)
Dec  4 23:25:51.512: //94011/2220FA8F93C7/CCAPI/cc_process_notify_bridge_done:
   Conference Id=0x65, Call Id1=94011, Call Id2=94013
Dec  4 23:25:51.516: //94013/2B2B74C093CE/SIP/Msg/ccsipDisplayMsg:
Sent:
ACK sip:5148121234@72.55.168.18:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK94717D5
From: "DOMAIN" <sip:5143601234@172.16.16.2>;tag=972D19F8-1D03
To: <sip:5148121234@72.55.168.18>;tag=as51f98a9d
Date: Fri, 04 Dec 2015 23:25:41 GMT
Call-ID: 2B2DE55F-9A1511E5-93D2BE77-FFDD325D@172.16.16.2
Max-Forwards: 70

CSeq: 102 ACK
Authorization: Digest username="12345678",realm="montreal3.voip.ms",uri="sip:5148121234@72.55.168.18:5060",response="be0496564373569f1e8b3331ddf27a98",nonce="35e998a7",algorithm=MD5
Allow-Events: kpml, telephone-event
Content-Length: 0


Dec  4 23:25:51.516: //94011/2220FA8F93C7/CCAPI/ccCallConnect:
   Progress Indication=NULL(0), Data Bitmask=0x1
Dec  4 23:25:51.516: //94011/2220FA8F93C7/CCAPI/ccCallConnect:
   Call Entry(Connected=TRUE, Responsed=TRUE)
Dec  4 23:25:51.524: //94011/2220FA8F93C7/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 72.55.168.18:5060;branch=z9hG4bK519ffbaf;rport
From: "DOMAIN" <sip:5147221234@72.55.168.18>;tag=as2eaf8249
To: <sip:12345678@172.16.16.2:5060>;tag=972CDF30-17AC
Date: Fri, 04 Dec 2015 23:25:26 GMT
Call-ID: 0ecac0404157151e3069efe27fac68bd@72.55.168.18:5060
CSeq: 102 INVITE
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER

Allow-Events: telephone-event
Remote-Party-ID: <sip:5148121234@172.16.16.2>;party=called;screen=no;privacy=off
Contact: <sip:12345678@172.16.16.2:5060>
Supported: replaces
Supported: sdp-anat
Server: Cisco-SIPGateway/IOS-12.x
Cisco-Gcid: 22223378-9A15-11E5-93CA-BE77FFDD325D
Session-Expires:  1800;refresher=uas
Require: timer
Supported: timer
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 244

v=0
o=CiscoSystemsSIP-GW-UserAgent 6275 7837 IN IP4 172.16.16.2
s=SIP Call
c=IN IP4 172.16.16.2
t=0 0
m=audio 18614 RTP/AVP 0 101
c=IN IP4 172.16.16.2
a=rtpmap:0 PCMU/8000

a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20

Dec  4 23:25:51.532: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:12345678@172.16.16.2:5060 SIP/2.0
Via: SIP/2.0/UDP 72.55.168.18:5060;branch=z9hG4bK4b8e27d0;rport
Max-Forwards: 70
From: "DOMAIN" <sip:5147221234@72.55.168.18>;tag=as2eaf8249
To: <sip:12345678@172.16.16.2:5060>;tag=972CDF30-17AC
Contact: <sip:5147221234@72.55.168.18:5060>
Call-ID: 0ecac0404157151e3069efe27fac68bd@72.55.168.18:5060
CSeq: 102 ACK
User-Agent: voip.ms
Content-Length: 0


Dec  4 23:26:52.009: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
BYE sip:12345678@172.16.16.2:5060 SIP/2.0
Via: SIP/2.0/UDP 72.55.168.18:5060;branch=z9hG4bK74c5716e;rport

Max-Forwards: 70
From: "DOMAIN" <sip:5147221234@72.55.168.18>;tag=as2eaf8249
To: <sip:12345678@172.16.16.2:5060>;tag=972CDF30-17AC
Call-ID: 0ecac0404157151e3069efe27fac68bd@72.55.168.18:5060
CSeq: 103 BYE
User-Agent: voip.ms
X-Asterisk-HangupCause: Normal Clearing
X-Asterisk-HangupCauseCode: 16
Content-Length: 0


Dec  4 23:26:52.013: //94013/2220FA8F93C7/CCAPI/ccGenerateToneInfo:
   Stop Tone On Digit=FALSE, Tone=Null,
   Tone Direction=Sum Network, Params=0x0, Call Id=94013
Dec  4 23:26:52.013: //94011/2220FA8F93C7/CCAPI/cc_api_call_disconnected:
   Cause Value=16, Interface=0x49C67A38, Call Id=94011
Dec  4 23:26:52.013: //94011/2220FA8F93C7/CCAPI/cc_api_call_disconnected:
   Call Entry(Responsed=TRUE, Cause Value=16, Retry Count=0)
Dec  4 23:26:52.013: //94011/2220FA8F93C7/CCAPI/ccConferenceDestroy:
   Conference Id=0x65, Tag=0x0
Dec  4 23:26:52.013: //94011/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  4 23:26:52.013: cc_api_get_xcode_stream : 4702
Dec  4 23:26:52.013: //94013/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  4 23:26:52.017: cc_api_get_xcode_stream : 4702
Dec  4 23:26:52.017: //94011/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  4 23:26:52.017: cc_api_get_xcode_stream : 4702
Dec  4 23:26:52.017: //94011/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  4 23:26:52.017: cc_api_get_xcode_stream : 4702
Dec  4 23:26:52.017: //94011/2220FA8F93C7/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0x65, Source Interface=0x49C67A38, Source Call Id=94011,
   Destination Call Id=94013, Disposition=0x0, Tag=0x0
Dec  4 23:26:52.017: //94013/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  4 23:26:52.017: cc_api_get_xcode_stream : 4702
Dec  4 23:26:52.017: //94011/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  4 23:26:52.017: cc_api_get_xcode_stream : 4702
Dec  4 23:26:52.017: //94013/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  4 23:26:52.017: cc_api_get_xcode_stream : 4702
Dec  4 23:26:52.017: //94013/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  4 23:26:52.017: cc_api_get_xcode_stream : 4702
Dec  4 23:26:52.017: //94013/2220FA8F93C7/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0x65, Source Interface=0x49C67A38, Source Call Id=94013,
   Destination Call Id=94011, Disposition=0x0, Tag=0x0
Dec  4 23:26:52.017: //94011/2220FA8F93C7/CCAPI/cc_generic_bridge_done:
   Conference Id=0x65, Source Interface=0x49C67A38, Source Call Id=94013,
   Destination Call Id=94011, Disposition=0x0, Tag=0x0
Dec  4 23:26:52.021: //94011/2220FA8F93C7/CCAPI/ccCallDisconnect:
   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)
Dec  4 23:26:52.021: //94011/2220FA8F93C7/CCAPI/ccCallDisconnect:
   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
Dec  4 23:26:52.021: //94013/2220FA8F93C7/CCAPI/ccCallDisconnect:
   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
Dec  4 23:26:52.021: //94013/2220FA8F93C7/CCAPI/ccCallDisconnect:
   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
Dec  4 23:26:52.021: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
BYE sip:5143601234@172.16.16.2:5060 SIP/2.0
Via: SIP/2.0/UDP 72.55.168.18:5060;branch=z9hG4bK0d49e353;rport
Max-Forwards: 70

From: <sip:5148121234@72.55.168.18>;tag=as51f98a9d
To: "Cisco Lab" <sip:5143601234@172.16.16.2>;tag=972D19F8-1D03
Call-ID: 2B2DE55F-9A1511E5-93D2BE77-FFDD325D@172.16.16.2
CSeq: 102 BYE
User-Agent: voip.ms
Proxy-Authorization: Digest username="12345678", realm="montreal3.voip.ms", algorithm=MD5, uri="sip:72.55.168.18", nonce="35e998a7", response="4a855e4ff4636e7596b92a1337259809"
X-Asterisk-HangupCause: Normal Clearing
X-Asterisk-HangupCauseCode: 16
Content-Length: 0


Dec  4 23:26:52.025: //94013/2220FA8F93C7/CCAPI/cc_api_call_disconnected:
   Cause Value=16, Interface=0x49C67A38, Call Id=94013
Dec  4 23:26:52.025: //94013/2220FA8F93C7/CCAPI/cc_api_call_disconnected:
   Call Entry(Responsed=TRUE, Cause Value=16, Retry Count=0)
Dec  4 23:26:52.029: //94011/2220FA8F93C7/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x49C67A38, Tag=0x0, Call Id=94011,
   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
Dec  4 23:26:52.029: //94011/2220FA8F93C7/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
Dec  4 23:26:52.029: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  4 23:26:52.029: :cc_free_feature_vsa freeing 48F46E80
Dec  4 23:26:52.029: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  4 23:26:52.029:  vsacount in free is 3
Dec  4 23:26:52.029: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  4 23:26:52.029:  vsacount in free is 2
Dec  4 23:26:52.033: //94013/2220FA8F93C7/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x49C67A38, Tag=0x0, Call Id=94013,
   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
Dec  4 23:26:52.033: //94013/2220FA8F93C7/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
Dec  4 23:26:52.033: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  4 23:26:52.033: :cc_free_feature_vsa freeing 48F47580
Dec  4 23:26:52.033: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  4 23:26:52.033:  vsacount in free is 1
Dec  4 23:26:52.033: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  4 23:26:52.033:  vsacount in free is 0
Dec  4 23:26:52.037: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 72.55.168.18:5060;branch=z9hG4bK74c5716e;rport
From: "DOMAIN" <sip:5147221234@72.55.168.18>;tag=as2eaf8249
To: <sip:12345678@172.16.16.2:5060>;tag=972CDF30-17AC
Date: Fri, 04 Dec 2015 23:26:52 GMT
Call-ID: 0ecac0404157151e3069efe27fac68bd@72.55.168.18:5060
Server: Cisco-SIPGateway/IOS-12.x
CSeq: 103 BYE
Reason: Q.850;cause=16
P-RTP-Stat: PS=0,OS=0,PR=0,OR=0,PL=0,JI=0,LA=0,DU=60
Content-Length: 0


Dec  4 23:26:52.037: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 72.55.168.18:5060;branch=z9hG4bK0d49e353;rport
From: <sip:5148121234@72.55.168.18>;tag=as51f98a9d
To: "DOMAIN" <sip:5143601234@172.16.16.2>;tag=972D19F8-1D03
Date: Fri, 04 Dec 2015 23:26:52 GMT
Call-ID: 2B2DE55F-9A1511E5-93D2BE77-FFDD325D@172.16.16.2

Server: Cisco-SIPGateway/IOS-12.x
CSeq: 102 BYE
Reason: Q.850;cause=16
P-RTP-Stat: PS=0,OS=0,PR=0,OR=0,PL=0,JI=0,LA=0,DU=60
Content-Length: 0


LabDOMAIN1#

Your issue is most likely due to diversion header. From your INVITE we can see the diversion header

Diversion: <sip:2339@172.16.16.2>;privacy=off;reason=no-answer;counter=1;screen=no

As you can see the number presented in the diverison header (this is what your ITSP will use to authorize the call) doesnt seem to be a valid DDI. You will need to modify this to a valid DDI before your call can be accepted by your ITSP.

Please try the ff sip profile..

voice class sip-profile 5

request INVITE sip-header Diversion modify "<sip:2399@(.*)>" "<sip:XXXXX@\1>"

where XXXX=valid DDI

Please rate all useful posts

Hi Ayodeji

I tried the sip profile and the call behaves the same way. No sound, disconnects after 60 seconds

You need to apply it to the dial peer facing your itsp. 

Dial-peer voice XX voip

Voice-class sip-profiles 5

Please rate all useful posts

I had added it to the voice class sip profile 1 as an additional line. It is already associated with the outbound dial peer to ITSP...

Please send details debug ccsip messages and include calling and called number 

Please rate all useful posts

Here it is

This is the new sip-profile

voice class sip-profiles 1
 request INVITE sip-header From modify "From: (.*<)(.*>)" "From: \"Cisco Lab\" <\2"
 request INVITE sip-header Diversion modify "<sip:2339@(.*)>" "<sip:5143601234@\1>"

Debug

Calling: 5147221234
Called: 5143601234
Redirect: 5148121234




LabDOMAIN1#debug ccsip messages
SIP Call messages tracing is enabled
LabDOMAIN1#debug ccapi inout
                    ^
% Invalid input detected at '^' marker.

LabDOMAIN1#debug voice ccapi inout
voip ccapi inout debugging is on
LabDOMAIN1#sh logging
Syslog logging: enabled (5 messages dropped, 3 messages rate-limited, 2119 flushes, 0 overruns, xml disabled, filtering disabled)

No Active Message Discriminator.



No Inactive Message Discriminator.


    Console logging: disabled
    Monitor logging: disabled
    Buffer logging:  level debugging, 3884 messages logged, xml disabled,
                    filtering disabled
    Exception Logging: size (4096 bytes)
    Count and timestamp logging messages: disabled
    Persistent logging: disabled

No active filter modules.

    Trap logging: level informational, 103 message lines logged
        Logging Source-Interface:       VRF Name:

Log Buffer (30000000 bytes):

Dec  5 14:33:24.843: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
REGISTER sip:montreal3.voip.ms:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9780153
From: <sip:12345678@montreal3.voip.ms>;tag=9A6C2364-5DF
To: <sip:12345678@montreal3.voip.ms>
Date: Sat, 05 Dec 2015 14:33:24 GMT
Call-ID: E0E652EE-830311E5-8002BE77-FFDD325D
User-Agent: Cisco-SIPGateway/IOS-12.x
Max-Forwards: 70
Timestamp: 1449326004
CSeq: 21331 REGISTER
Contact: <sip:12345678@172.16.16.2:5060>
Expires:  300
Supported: path
Content-Length: 0


Dec  5 14:33:24.851: //96516/000000000000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9780153;received=66.11.41.90;rport=58930
From: <sip:12345678@montreal3.voip.ms>;tag=9A6C2364-5DF
To: <sip:12345678@montreal3.voip.ms>;tag=as18a3280b
Call-ID: E0E652EE-830311E5-8002BE77-FFDD325D
CSeq: 21331 REGISTER
Server: voip.ms
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="montreal3.voip.ms", nonce="2457a335"
Content-Length: 0


Dec  5 14:33:24.855: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
REGISTER sip:montreal3.voip.ms:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK978125FF
From: <sip:12345678@montreal3.voip.ms>;tag=9A6C2364-5DF
To: <sip:12345678@montreal3.voip.ms>
Date: Sat, 05 Dec 2015 14:33:24 GMT

Call-ID: E0E652EE-830311E5-8002BE77-FFDD325D
User-Agent: Cisco-SIPGateway/IOS-12.x
Max-Forwards: 70
Timestamp: 1449326004
CSeq: 21332 REGISTER
Contact: <sip:12345678@172.16.16.2:5060>
Expires: 300
Authorization: Digest username="12345678",realm="montreal3.voip.ms",uri="sip:montreal3.voip.ms:5060",response="55f8d1dd7de4484b2301fe057d1bb4f5",nonce="2457a335",algorithm=MD5
Content-Length: 0


Dec  5 14:33:24.859: //96516/000000000000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK978125FF;received=66.11.41.90;rport=58930
From: <sip:12345678@montreal3.voip.ms>;tag=9A6C2364-5DF
To: <sip:12345678@montreal3.voip.ms>;tag=as18a3280b
Call-ID: E0E652EE-830311E5-8002BE77-FFDD325D
CSeq: 21332 REGISTER

Server: voip.ms
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Expires: 300
Contact: <sip:12345678@172.16.16.2:5060>;expires=300
Date: Sat, 05 Dec 2015 14:33:24 GMT
Content-Length: 0


Dec  5 14:33:28.715: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
INVITE sip:12345678@172.16.16.2:5060 SIP/2.0
Via: SIP/2.0/UDP 72.55.168.18:5060;branch=z9hG4bK4ef6c761;rport
Max-Forwards: 70
From: "Jakub Stroinski" <sip:5147221234@72.55.168.18>;tag=as3b4c747d
To: <sip:12345678@172.16.16.2:5060>
Contact: <sip:5147221234@72.55.168.18:5060>
Call-ID: 15e266a0629829ee1b1e5ffb792bd417@72.55.168.18:5060
CSeq: 102 INVITE
User-Agent: voip.ms
Date: Sat, 05 Dec 2015 14:33:21 GMT

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Remote-Party-ID: "Jakub Stroinski" <sip:5147221234@72.55.168.18>;party=calling;privacy=off;screen=no
Content-Type: application/sdp
Content-Length: 268

v=0
o=root 135196842 135196842 IN IP4 72.55.168.18
s=voip.ms
c=IN IP4 72.55.168.18
t=0 0
m=audio 11208 RTP/AVP 0 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv

Dec  5 14:33:28.727: //-1/FC3A05359A7F/CCAPI/cc_api_display_ie_subfields:
   cc_api_call_setup_ind_common:
   cisco-username=5147221234
   ----- ccCallInfo IE subfields -----
   cisco-ani=5147221234
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=12345678
   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

Dec  5 14:33:28.731: //-1/FC3A05359A7F/CCAPI/cc_api_call_setup_ind_common:
   Interface=0x49C67A38, Call Info(
   Calling Number=5147221234,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=12345678(TON=Unknown, NPI=Unknown),
   Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,
   Incoming Dial-peer=1, Progress Indication=NULL(0), Calling IE Present=TRUE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=96517
Dec  5 14:33:28.731: //-1/FC3A05359A7F/CCAPI/ccCheckClipClir:
   In: Calling Number=5147221234(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Dec  5 14:33:28.731: //-1/FC3A05359A7F/CCAPI/ccCheckClipClir:
   Out: Calling Number=5147221234(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Dec  5 14:33:28.731: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:28.731: :cc_get_feature_vsa malloc success
Dec  5 14:33:28.731: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:28.731:  cc_get_feature_vsa count is 1
Dec  5 14:33:28.731: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:28.731: :FEATURE_VSA attributes are: feature_name:0,feature_time:1223981768,feature_id:539
Dec  5 14:33:28.731: //96517/FC3A05359A7F/CCAPI/cc_api_call_setup_ind_common:
   Set Up Event Sent;
   Call Info(Calling Number=5147221234(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=12345678(TON=Unknown, NPI=Unknown))
Dec  5 14:33:28.735: //96517/FC3A05359A7F/CCAPI/cc_process_call_setup_ind:
   Event=0x4B12EB38
Dec  5 14:33:28.735: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
   Try with the demoted called number 12345678
Dec  5 14:33:28.739: //96517/FC3A05359A7F/CCAPI/ccCallSetContext:
   Context=0x48F5977C
Dec  5 14:33:28.739: //96517/FC3A05359A7F/CCAPI/cc_process_call_setup_ind:
   >>>>CCAPI handed cid 96517 with tag 1 to app "_ManagedAppProcess_Default"
Dec  5 14:33:28.743: //96517/FC3A05359A7F/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 72.55.168.18:5060;branch=z9hG4bK4ef6c761;rport
From: "Jakub Stroinski" <sip:5147221234@72.55.168.18>;tag=as3b4c747d
To: <sip:12345678@172.16.16.2:5060>
Date: Sat, 05 Dec 2015 14:33:28 GMT
Call-ID: 15e266a0629829ee1b1e5ffb792bd417@72.55.168.18:5060

CSeq: 102 INVITE
Allow-Events: telephone-event
Server: Cisco-SIPGateway/IOS-12.x
Content-Length: 0


Dec  5 14:33:28.743: //96517/FC3A05359A7F/CCAPI/ccCallProceeding:
   Progress Indication=NULL(0)
Dec  5 14:33:28.747: //96517/FC3A05359A7F/CCAPI/ccCallSetupRequest:
   Destination=, Calling IE Present=TRUE, Mode=0,
   Outgoing Dial-peer=40004, Params=0x48F4F1CC, Progress Indication=NULL(0)
Dec  5 14:33:28.747: //96517/FC3A05359A7F/CCAPI/ccCheckClipClir:
   In: Calling Number=5147221234(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Dec  5 14:33:28.747: //96517/FC3A05359A7F/CCAPI/ccCheckClipClir:
   Out: Calling Number=5147221234(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Dec  5 14:33:28.747: //96517/FC3A05359A7F/CCAPI/ccCallSetupRequest:
   Destination Pattern=2000, Called Number=2339, Digit Strip=FALSE
Dec  5 14:33:28.747: //96517/FC3A05359A7F/CCAPI/ccCallSetupRequest:
   Calling Number=5147221234(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=2339(TON=Unknown, NPI=Unknown),
   Redirect Number=, Display Info=Jakub Stroinski
   Account Number=5147221234, Final Destination Flag=TRUE,
   Guid=FC3A0535-9A93-11E5-9A7F-BE77FFDD325D, Outgoing Dial-peer=40004
Dec  5 14:33:28.751: //96517/FC3A05359A7F/CCAPI/cc_api_display_ie_subfields:
   ccCallSetupRequest:
   cisco-username=5147221234
   ----- ccCallInfo IE subfields -----
   cisco-ani=5147221234
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=2339
   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

Dec  5 14:33:28.751: //96517/FC3A05359A7F/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x49C67A38, Interface Type=3, Destination=, Mode=0x0,
   Call Params(Calling Number=5147221234,(Calling Name=Jakub Stroinski)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=2339(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=40004, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
Dec  5 14:33:28.751: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:28.751: :cc_get_feature_vsa malloc success
Dec  5 14:33:28.751: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:28.751:  cc_get_feature_vsa count is 2
Dec  5 14:33:28.751: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:28.751: :FEATURE_VSA attributes are: feature_name:0,feature_time:1223980424,feature_id:540
Dec  5 14:33:28.755: //96518/FC3A05359A7F/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=3, FlowMode=1
Dec  5 14:33:28.755: //96518/FC3A05359A7F/CCAPI/ccCallSetContext:
   Context=0x48F4F17C
Dec  5 14:33:28.755: //96517/FC3A05359A7F/CCAPI/ccSaveDialpeerTag:
   Outgoing Dial-peer=40004
Dec  5 14:33:28.759: //96518/FC3A05359A7F/CCAPI/cc_api_call_proceeding:
   Interface=0x49C67A38, Progress Indication=NULL(0)
Dec  5 14:33:28.767: //96518/FC3A05359A7F/SIP/Msg/ccsipDisplayMsg:
Sent:
INVITE sip:2339@172.16.16.23:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9782211
From: "Jakub Stroinski" <sip:5147221234@172.16.16.2>;tag=9A6C32B4-1AC6
To: <sip:2339@172.16.16.23>
Date: Sat, 05 Dec 2015 14:33:28 GMT
Call-ID: FC401FF6-9A9311E5-9A85BE77-FFDD325D@172.16.16.2
Supported: 100rel,timer,resource-priority,replaces
Min-SE:  1800
Cisco-Guid: 4231660853-2593329637-2592063095-4292686429
User-Agent: Cisco-SIPGateway/IOS-12.x
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
CSeq: 101 INVITE
Timestamp: 1449326008

Contact: <sip:5147221234@172.16.16.2:5060>
Expires: 180
Allow-Events: telephone-event
Max-Forwards: 69
Cisco-Gcid: FC3AA15D-9A93-11E5-9A82-BE77FFDD325D
P-Preferred-Identity: "Jakub Stroinski" <sip:5147221234@172.16.16.2>
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 323

v=0
o=CiscoSystemsSIP-GW-UserAgent 48 7035 IN IP4 172.16.16.2
s=SIP Call
c=IN IP4 172.16.16.2
t=0 0
m=audio 19248 RTP/AVP 0 101 121 19
c=IN IP4 172.16.16.2
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:121 frf-dialed-digit/8000
a=fmtp:121 0-15

a=rtpmap:19 CN/8000
a=ptime:20

Dec  5 14:33:28.779: //96518/FC3A05359A7F/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9782211
From: "Jakub Stroinski" <sip:5147221234@172.16.16.2>;tag=9A6C32B4-1AC6
To: <sip:2339@172.16.16.23>
Call-ID: FC401FF6-9A9311E5-9A85BE77-FFDD325D@172.16.16.2
Date: Sat, 05 Dec 2015 14:33:28 GMT
CSeq: 101 INVITE
Server: Cisco-CP7975G/9.4.2
Contact: <sip:60037a2b-e0b4-7c3f-dd9f-4eca6b99ccd4@172.16.16.23:5060;transport=udp>
Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER,REGISTER,UPDATE,SUBSCRIBE,INFO
Supported: replaces,join,sdp-anat,norefersub,resource-priority,X-cisco-srtp-fallback,X-cisco-xsi-8.5.1
Allow-Events: kpml,dialog
Content-Length: 0


Dec  5 14:33:28.871: //96518/FC3A05359A7F/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9782211
From: "Jakub Stroinski" <sip:5147221234@172.16.16.2>;tag=9A6C32B4-1AC6
To: <sip:2339@172.16.16.23>;tag=44e4d945122b02657b2123d8-a1ad0a21
Call-ID: FC401FF6-9A9311E5-9A85BE77-FFDD325D@172.16.16.2
Date: Sat, 05 Dec 2015 14:33:28 GMT
CSeq: 101 INVITE
Server: Cisco-CP7975G/9.4.2
Contact: <sip:60037a2b-e0b4-7c3f-dd9f-4eca6b99ccd4@172.16.16.23:5060;transport=udp>
Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER,REGISTER,UPDATE,SUBSCRIBE,INFO
Remote-Party-ID: "Jakub Stroinski" <sip:2339@172.16.16.2>;party=called;id-type=subscriber;privacy=off;screen=yes
Supported: replaces,join,sdp-anat,norefersub,resource-priority,X-cisco-srtp-fallback,X-cisco-xsi-8.5.1
Allow-Events: kpml,dialog
Content-Length: 0


Dec  5 14:33:28.871: //96518/FC3A05359A7F/CCAPI/cc_api_call_alert:
   Interface=0x49C67A38, Progress Indication=NULL(0), Signal Indication=SIGNAL RINGBACK(1)
Dec  5 14:33:28.871: //96518/FC3A05359A7F/CCAPI/cc_api_call_alert:
   Call Entry(Retry Count=0, Responsed=TRUE)
Dec  5 14:33:28.871: //96517/FC3A05359A7F/CCAPI/ccCallAlert:
   Progress Indication=NULL(0), Signal Indication=SIGNAL RINGBACK(1)
Dec  5 14:33:28.875: //96517/FC3A05359A7F/CCAPI/ccCallAlert:
   Call Entry(Responsed=TRUE, Alert Sent=TRUE)
Dec  5 14:33:28.875: //96517/FC3A05359A7F/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 72.55.168.18:5060;branch=z9hG4bK4ef6c761;rport
From: "Jakub Stroinski" <sip:5147221234@72.55.168.18>;tag=as3b4c747d
To: <sip:12345678@172.16.16.2:5060>;tag=9A6C3324-498
Date: Sat, 05 Dec 2015 14:33:28 GMT
Call-ID: 15e266a0629829ee1b1e5ffb792bd417@72.55.168.18:5060
CSeq: 102 INVITE
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
Allow-Events: telephone-event
Remote-Party-ID: "Jakub Stroinski" <sip:2339@172.16.16.2>;party=called;screen=yes;privacy=off
Contact: <sip:12345678@172.16.16.2:5060>
Server: Cisco-SIPGateway/IOS-12.x
Content-Length: 0



Dec  5 14:33:43.872: //-1/xxxxxxxxxxxx/CCAPI/ccUpdateRedirectingNumber:
   type=6 redirecting_number=2339
Dec  5 14:33:43.872: //-1/xxxxxxxxxxxx/CCAPI/ccUpdateRedirectNumber:
   type=6  Original Called Number=2339, Called Number=2339, Calling Number=5147221234, Calling DN=-1 Calling Id=96517,
   Redirect Number=95148121234, Redirect Reason=2
Dec  5 14:33:43.872: //-1/xxxxxxxxxxxx/CCAPI/ccUpdateRedirectingNumber:
   type=6 redirecting_number=2339
Dec  5 14:33:43.872: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:43.872: :cc_get_feature_vsa malloc success
Dec  5 14:33:43.872: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:43.872:  cc_get_feature_vsa count is 3
Dec  5 14:33:43.872: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:43.872: :FEATURE_VSA attributes are: feature_name:0,feature_time:1223982440,feature_id:541
Dec  5 14:33:43.872: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Dec  5 14:33:43.872:  feature_vsa is 48F47AC0,featname is 0
Dec  5 14:33:43.872: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:43.872: :cc_get_feature_vsa malloc success
Dec  5 14:33:43.872: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:43.872:  cc_get_feature_vsa count is 4
Dec  5 14:33:43.872: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:43.872: :FEATURE_VSA attributes are: feature_name:0,feature_time:1223978632,feature_id:542
Dec  5 14:33:43.872: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Dec  5 14:33:43.872: : Generating new featurevsa,inserting it
Dec  5 14:33:43.872: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Dec  5 14:33:43.872:  feature call forward featname is 3
Dec  5 14:33:43.876: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Dec  5 14:33:43.876:  feature_vsa is 48F47580,featname is 0
Dec  5 14:33:43.876: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:43.876: :cc_get_feature_vsa malloc success
Dec  5 14:33:43.876: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:43.876:  cc_get_feature_vsa count is 5
Dec  5 14:33:43.876: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:43.876: :FEATURE_VSA attributes are: feature_name:0,feature_time:1223981544,feature_id:543
Dec  5 14:33:43.876: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Dec  5 14:33:43.876: : Generating new featurevsa,inserting it
Dec  5 14:33:43.876: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Dec  5 14:33:43.876:  feature call forward featname is 3
Dec  5 14:33:43.876: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  5 14:33:43.876: :cc_free_feature_vsa freeing 48F47D60
Dec  5 14:33:43.876: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  5 14:33:43.876:  vsacount in free is 4
Dec  5 14:33:43.876: //96518/FC3A05359A7F/CCAPI/ccCallDisconnect:
   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
Dec  5 14:33:43.876: //96518/FC3A05359A7F/CCAPI/ccCallDisconnect:
   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
Dec  5 14:33:43.880: //96518/FC3A05359A7F/SIP/Msg/ccsipDisplayMsg:
Sent:
CANCEL sip:2339@172.16.16.23:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9782211
From: "Jakub Stroinski" <sip:5147221234@172.16.16.2>;tag=9A6C32B4-1AC6
To: <sip:2339@172.16.16.23>
Date: Sat, 05 Dec 2015 14:33:28 GMT
Call-ID: FC401FF6-9A9311E5-9A85BE77-FFDD325D@172.16.16.2
CSeq: 101 CANCEL
Max-Forwards: 70
Timestamp: 1449326023
Reason: Q.850;cause=16
Content-Length: 0


Dec  5 14:33:43.892: //96518/FC3A05359A7F/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9782211
From: "Jakub Stroinski" <sip:5147221234@172.16.16.2>;tag=9A6C32B4-1AC6
To: <sip:2339@172.16.16.23>;tag=44e4d945122b02657b2123d8-a1ad0a21
Call-ID: FC401FF6-9A9311E5-9A85BE77-FFDD325D@172.16.16.2

Date: Sat, 05 Dec 2015 14:33:43 GMT
CSeq: 101 CANCEL
Server: Cisco-CP7975G/9.4.2
Content-Length: 0


Dec  5 14:33:43.892: //96518/FC3A05359A7F/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x49C67A38, Tag=0x0, Call Id=96518,
   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
Dec  5 14:33:43.892: //96518/FC3A05359A7F/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
Dec  5 14:33:43.892: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  5 14:33:43.896: :cc_free_feature_vsa freeing 48F479E0
Dec  5 14:33:43.896: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  5 14:33:43.896:  vsacount in free is 3
Dec  5 14:33:43.896: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  5 14:33:43.896:  vsacount in free is 2
Dec  5 14:33:43.896: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:43.896: :cc_get_feature_vsa malloc success
Dec  5 14:33:43.896: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:43.896:  cc_get_feature_vsa count is 3
Dec  5 14:33:43.896: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:43.896: :FEATURE_VSA attributes are: feature_name:0,feature_time:1223980424,feature_id:544
Dec  5 14:33:43.896: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Dec  5 14:33:43.896:  feature call forward featname is 3
Dec  5 14:33:43.896: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  5 14:33:43.900: :cc_free_feature_vsa freeing 48F47580
Dec  5 14:33:43.900: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  5 14:33:43.900:  vsacount in free is 2
Dec  5 14:33:43.904: //96517/FC3A05359A7F/CCAPI/ccCallSetupRequest:
   Destination=, Calling IE Present=TRUE, Mode=0,
   Outgoing Dial-peer=3, Params=0x48F544CC, Progress Indication=NULL(0)
Dec  5 14:33:43.904: //96517/FC3A05359A7F/CCAPI/ccCheckClipClir:
   In: Calling Number=5143601234(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Dec  5 14:33:43.904: //96517/FC3A05359A7F/CCAPI/ccCheckClipClir:
   Out: Calling Number=5143601234(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Dec  5 14:33:43.904: //96517/FC3A05359A7F/CCAPI/ccCallSetupRequest:
   Destination Pattern=9[2-9]..[2-9]......, Called Number=5148121234, Digit Strip=FALSE
Dec  5 14:33:43.904: //96517/FC3A05359A7F/CCAPI/ccCallSetupRequest:
   Calling Number=5143601234(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=5148121234(TON=Unknown, NPI=Unknown),
   Redirect Number=2339, Display Info=Jakub Stroinski
   Account Number=5147221234, Final Destination Flag=TRUE,
   Guid=05465476-9A94-11E5-9A86-BE77FFDD325D, Outgoing Dial-peer=3
Dec  5 14:33:43.904: //96517/FC3A05359A7F/CCAPI/cc_api_display_ie_subfields:
   ccCallSetupRequest:
   cisco-username=5147221234
   ----- ccCallInfo IE subfields -----
   cisco-ani=5143601234
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=5148121234
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=73
   cisco-rdn=2339
   cisco-rdntype=0
   cisco-rdnplan=0
   cisco-rdnpi=0
   cisco-rdnsi=0
   cisco-redirectreason=2   fwd_final_type =0
   final_redirectNumber =
   hunt_group_timeout =0

Dec  5 14:33:43.904: //96517/FC3A05359A7F/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x49C67A38, Interface Type=3, Destination=, Mode=0x0,
   Call Params(Calling Number=5143601234,(Calling Name=Jakub Stroinski)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=5148121234(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=3, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
Dec  5 14:33:43.904: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:43.904: :cc_get_feature_vsa malloc success
Dec  5 14:33:43.904: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:43.904:  cc_get_feature_vsa count is 3
Dec  5 14:33:43.908: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:43.908: :FEATURE_VSA attributes are: feature_name:0,feature_time:1223980424,feature_id:545
Dec  5 14:33:43.908: //96519/FC3A05359A7F/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=3, FlowMode=1
Dec  5 14:33:43.908: //96519/FC3A05359A7F/CCAPI/ccCallSetContext:
   Context=0x48F5447C
Dec  5 14:33:43.908: //96517/FC3A05359A7F/CCAPI/ccSaveDialpeerTag:
   Outgoing Dial-peer=3
Dec  5 14:33:43.908: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Dec  5 14:33:43.908:  feature call forward featname is 3
Dec  5 14:33:43.908: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Dec  5 14:33:43.908:  feature_vsa is 48F47580,featname is 0
Dec  5 14:33:43.908: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:43.908: :cc_get_feature_vsa malloc success
Dec  5 14:33:43.908: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:43.908:  cc_get_feature_vsa count is 4
Dec  5 14:33:43.908: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Dec  5 14:33:43.908: :FEATURE_VSA attributes are: feature_name:0,feature_time:1223981544,feature_id:546
Dec  5 14:33:43.908: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Dec  5 14:33:43.908: : Generating new featurevsa,inserting it
Dec  5 14:33:43.912: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Dec  5 14:33:43.912:  feature call forward featname is 3
Dec  5 14:33:43.916: //96519/FC3A05359A7F/CCAPI/cc_api_call_proceeding:
   Interface=0x49C67A38, Progress Indication=NULL(0)
Dec  5 14:33:43.924: //96519/054654769A86/SIP/Msg/ccsipDisplayMsg:
Sent:
INVITE sip:5148121234@72.55.168.18:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9783DC0
From: "Cisco Lab" <sip:5143601234@172.16.16.2>;tag=9A6C6DE8-1925
To: <sip:5148121234@72.55.168.18>
Date: Sat, 05 Dec 2015 14:33:43 GMT
Call-ID: 548C516-9A9411E5-9A8ABE77-FFDD325D@172.16.16.2

Supported: 100rel,timer,resource-priority,replaces,sdp-anat
Min-SE:  1800
Cisco-Guid: 0088495222-2593395173-2592521847-4292686429
User-Agent: Cisco-SIPGateway/IOS-12.x
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
CSeq: 101 INVITE
Timestamp: 1449326023
Contact: <sip:5143601234@172.16.16.2:5060>
Call-Info: <sip:172.16.16.2:5060>;method="NOTIFY;Event=telephone-event;Duration=2000"
Diversion: <sip:5143601234@172.16.16.2>;privacy=off;reason=no-answer;counter=1;screen=no
Expires: 180
Allow-Events: kpml, telephone-event
Max-Forwards: 69
Cisco-Gcid: FC3AA15D-9A93-11E5-9A82-BE77FFDD325D
P-Preferred-Identity: "Jakub Stroinski" <sip:5143601234@172.16.16.2>
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 300


v=0
o=CiscoSystemsSIP-GW-UserAgent 4462 550 IN IP4 172.16.16.2
s=SIP Call
c=IN IP4 172.16.16.2
t=0 0
m=audio 17254 RTP/AVP 0 101 121
c=IN IP4 172.16.16.2
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:121 frf-dialed-digit/8000
a=fmtp:121 0-15
a=ptime:20

Dec  5 14:33:43.928: //96518/FC3A05359A7F/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 487 Request Cancelled
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9782211
From: "Jakub Stroinski" <sip:5147221234@172.16.16.2>;tag=9A6C32B4-1AC6
To: <sip:2339@172.16.16.23>;tag=44e4d945122b02657b2123d8-a1ad0a21
Call-ID: FC401FF6-9A9311E5-9A85BE77-FFDD325D@172.16.16.2
Date: Sat, 05 Dec 2015 14:33:43 GMT

CSeq: 101 INVITE
Server: Cisco-CP7975G/9.4.2
Contact: <sip:60037a2b-e0b4-7c3f-dd9f-4eca6b99ccd4@172.16.16.23:5060;transport=udp>
Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER,REGISTER,UPDATE,SUBSCRIBE,INFO
Remote-Party-ID: "Jakub Stroinski" <sip:2339@172.16.16.2>;party=called;id-type=subscriber;privacy=off;screen=yes
Allow-Events: kpml,dialog
Content-Length: 0


Dec  5 14:33:43.932: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
ACK sip:2339@172.16.16.23:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9782211
From: "Jakub Stroinski" <sip:5147221234@172.16.16.2>;tag=9A6C32B4-1AC6
To: <sip:2339@172.16.16.23>;tag=44e4d945122b02657b2123d8-a1ad0a21
Date: Sat, 05 Dec 2015 14:33:28 GMT
Call-ID: FC401FF6-9A9311E5-9A85BE77-FFDD325D@172.16.16.2
Max-Forwards: 70
CSeq: 101 ACK
Allow-Events: telephone-event

Content-Length: 0


Dec  5 14:33:43.936: //96519/054654769A86/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9783DC0;received=66.11.41.90;rport=58930
From: "Cisco Lab" <sip:5143601234@172.16.16.2>;tag=9A6C6DE8-1925
To: <sip:5148121234@72.55.168.18>;tag=as7df4eab0
Call-ID: 548C516-9A9411E5-9A8ABE77-FFDD325D@172.16.16.2
CSeq: 101 INVITE
Server: voip.ms
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="montreal3.voip.ms", nonce="31ddbd60"
Content-Length: 0


Dec  5 14:33:43.944: //96519/054654769A86/SIP/Msg/ccsipDisplayMsg:
Sent:
ACK sip:5148121234@72.55.168.18:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9783DC0
From: "Jakub Stroinski" <sip:5143601234@172.16.16.2>;tag=9A6C6DE8-1925
To: <sip:5148121234@72.55.168.18>;tag=as7df4eab0
Date: Sat, 05 Dec 2015 14:33:43 GMT
Call-ID: 548C516-9A9411E5-9A8ABE77-FFDD325D@172.16.16.2
Max-Forwards: 70
CSeq: 101 ACK
Allow-Events: kpml, telephone-event
Content-Length: 0


Dec  5 14:33:43.944: //96519/054654769A86/SIP/Msg/ccsipDisplayMsg:
Sent:
INVITE sip:5148121234@72.55.168.18:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK97841949
From: "Cisco Lab" <sip:5143601234@172.16.16.2>;tag=9A6C6DE8-1925
To: <sip:5148121234@72.55.168.18>
Date: Sat, 05 Dec 2015 14:33:43 GMT
Call-ID: 548C516-9A9411E5-9A8ABE77-FFDD325D@172.16.16.2
Supported: 100rel,timer,resource-priority,replaces,sdp-anat
Min-SE:  1800

Cisco-Guid: 0088495222-2593395173-2592521847-4292686429
User-Agent: Cisco-SIPGateway/IOS-12.x
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
CSeq: 102 INVITE
Timestamp: 1449326023
Contact: <sip:5143601234@172.16.16.2:5060>
Call-Info: <sip:172.16.16.2:5060>;method="NOTIFY;Event=telephone-event;Duration=2000"
Diversion: <sip:5143601234@172.16.16.2>;privacy=off;reason=no-answer;counter=1;screen=no
Expires: 180
Allow-Events: kpml, telephone-event
Authorization: Digest username="12345678",realm="montreal3.voip.ms",uri="sip:5148121234@72.55.168.18:5060",response="e6967cdfffc76c9bf3a966b35649e1a2",nonce="31ddbd60",algorithm=MD5
Max-Forwards: 69
Cisco-Gcid: FC3AA15D-9A93-11E5-9A82-BE77FFDD325D
P-Preferred-Identity: "Jakub Stroinski" <sip:5143601234@172.16.16.2>
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 300


v=0
o=CiscoSystemsSIP-GW-UserAgent 4462 550 IN IP4 172.16.16.2
s=SIP Call
c=IN IP4 172.16.16.2
t=0 0
m=audio 17254 RTP/AVP 0 101 121
c=IN IP4 172.16.16.2
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:121 frf-dialed-digit/8000
a=fmtp:121 0-15
a=ptime:20

Dec  5 14:33:43.952: //96519/054654769A86/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK97841949;received=66.11.41.90;rport=58930
From: "Cisco Lab" <sip:5143601234@172.16.16.2>;tag=9A6C6DE8-1925
To: <sip:5148121234@72.55.168.18>

Call-ID: 548C516-9A9411E5-9A8ABE77-FFDD325D@172.16.16.2
CSeq: 102 INVITE
Server: voip.ms
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Session-Expires: 1800;refresher=uas
Contact: <sip:5148121234@72.55.168.18:5060>
Content-Length: 0


Dec  5 14:33:44.936: //96519/054654769A86/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 183 Session Progress
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK97841949;received=66.11.41.90;rport=58930
From: "Cisco Lab" <sip:5143601234@172.16.16.2>;tag=9A6C6DE8-1925
To: <sip:5148121234@72.55.168.18>;tag=as6ef74c21
Call-ID: 548C516-9A9411E5-9A8ABE77-FFDD325D@172.16.16.2
CSeq: 102 INVITE
Server: voip.ms
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH

Supported: replaces, timer
Session-Expires: 1800;refresher=uas
Contact: <sip:5148121234@72.55.168.18:5060>
Content-Type: application/sdp
Require: timer
Content-Length: 221

v=0
o=root 164402832 164402832 IN IP4 72.55.168.18
s=voip.ms
c=IN IP4 72.55.168.18
t=0 0
m=audio 14754 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv

Dec  5 14:33:44.940: //96519/FC3A05359A7F/CCAPI/cc_api_caps_ind:
   Destination Interface=0x0, Destination Call Id=-1, Source Call Id=96519,
   Caps(Codec=0x1, Fax Rate=0x2, Vad=0x2,
   Modem=0x0, Codec Bytes=20, Signal Type=2)
Dec  5 14:33:44.940: //96519/FC3A05359A7F/CCAPI/cc_api_caps_ind:
   Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms),
   Playout Max=1000(ms), Fax Nom=300(ms))
Dec  5 14:33:44.940: //96517/FC3A05359A7F/CCAPI/cc_api_caps_ack:
   Destination Interface=0x0, Destination Call Id=-1, Source Call Id=96517,
   Caps(Codec=g711ulaw(0x1), Fax Rate=FAX_RATE_VOICE(0x2), Vad=OFF(0x1),
   Modem=OFF(0x0), Codec Bytes=160, Signal Type=2, Seq Num Start=1)
Dec  5 14:33:44.944: //96517/FC3A05359A7F/CCAPI/cc_api_caps_ack:
   Destination Interface=0x0, Destination Call Id=-1, Source Call Id=96517,
   Caps(Codec=g711ulaw(0x1), Fax Rate=FAX_RATE_VOICE(0x2), Vad=OFF(0x1),
   Modem=OFF(0x0), Codec Bytes=160, Signal Type=2, Seq Num Start=1)
Dec  5 14:33:44.944: //96519/FC3A05359A7F/CCAPI/cc_api_event_indication:
   Event=171, Call Id=96519
Dec  5 14:33:44.944: //96519/FC3A05359A7F/CCAPI/cc_api_event_indication:
   Event Is Sent To Conferenced SPI(s) Directly
Dec  5 14:33:44.944: //96519/FC3A05359A7F/CCAPI/cc_api_event_indication:
   Event=98, Call Id=96519
Dec  5 14:33:44.944: //96519/FC3A05359A7F/CCAPI/cc_api_event_indication:
   Event Is Sent To Conferenced SPI(s) Directly
Dec  5 14:33:44.944: //96519/FC3A05359A7F/CCAPI/cc_api_call_cut_progress:
   Interface=0x49C67A38, Progress Indication=INBAND(8), Signal Indication=SIGNAL RINGBACK(1),
   Cause Value=0
Dec  5 14:33:44.944: //96519/FC3A05359A7F/CCAPI/cc_api_call_cut_progress:
   Call Entry(Responsed=TRUE)
Dec  5 14:33:44.948: //96517/FC3A05359A7F/CCAPI/ccCallCutProgress:
   Progress Indication=INBAND(8), Signal Indication=SIGNAL RINGBACK(1), Cause Value=0
   Voice Call Send Alert=FALSE, Call Entry(Alert Sent=TRUE)
Dec  5 14:33:44.948: //96517/FC3A05359A7F/CCAPI/ccCallCutProgress:
   Call Entry(Responsed=TRUE)
Dec  5 14:33:44.948: //96517/FC3A05359A7F/CCAPI/ccConferenceCreate:
   (confID=0x48F8635C, callID1=0x17905, gcid=FC3AA15D-9A9311E5-9A82BE77-FFDD325D, tag=0x0)
Dec  5 14:33:44.948: //96519/FC3A05359A7F/CCAPI/ccConferenceCreate:
   (confID=0x48F8635C, callID2=0x17907, gcid=FC3AA15D-9A9311E5-9A82BE77-FFDD325D, tag=0x0)
Dec  5 14:33:44.948: //96517/FC3A05359A7F/CCAPI/ccConferenceCreate:
   Conference Id=0x48F8635C, Call Id1=96517, Call Id2=96519, Tag=0x0
Dec  5 14:33:44.948: //96517/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  5 14:33:44.948: cc_api_get_xcode_stream : 4702
Dec  5 14:33:44.948: //96519/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  5 14:33:44.948: cc_api_get_xcode_stream : 4702
Dec  5 14:33:44.948: //96517/FC3A05359A7F/CCAPI/ccConferenceCreate:

Dec  5 14:33:44.948: ccConferenceCreate: ret1=0, codecMask1=1, bytes1=160, negot1=1, dtmf1=6
                    ret2=0, codecMask2=1, bytes2=160, negot2=1, dtmf2=6,
                    tx_dynamic_pt1=0, rx_dynamic_pt1=0, codec_mode1=0, params_bitmap1 =0
                    tx_dynamic_pt2=0, rx_dynamic_pt2=0, codec_mode2=0, params_bitmap2 =0
Dec  5 14:33:44.948: //96517/FC3A05359A7F/CCAPI/ccConferenceCreate:
   delay media to slow start case, codec negotation is not done
Dec  5 14:33:44.952: //96517/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  5 14:33:44.952: cc_api_get_xcode_stream : 4702
Dec  5 14:33:44.952: //96517/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  5 14:33:44.952: cc_api_get_xcode_stream : 4702
Dec  5 14:33:44.952: //96517/FC3A05359A7F/CCAPI/cc_api_bridge_done:
   Conference Id=0x6B, Source Interface=0x49C67A38, Source Call Id=96517,
   Destination Call Id=96519, Disposition=0x0, Tag=0x0
Dec  5 14:33:44.952: //96519/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  5 14:33:44.952: cc_api_get_xcode_stream : 4702
Dec  5 14:33:44.952: //96519/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  5 14:33:44.952: cc_api_get_xcode_stream : 4702
Dec  5 14:33:44.952: //96519/FC3A05359A7F/CCAPI/cc_api_bridge_done:
   Conference Id=0x6B, Source Interface=0x49C67A38, Source Call Id=96519,
   Destination Call Id=96517, Disposition=0x0, Tag=0x0
Dec  5 14:33:44.956: //96517/FC3A05359A7F/CCAPI/cc_generic_bridge_done:
   Conference Id=0x6B, Source Interface=0x49C67A38, Source Call Id=96519,
   Destination Call Id=96517, Disposition=0x0, Tag=0x0
Dec  5 14:33:44.956: //96517/FC3A05359A7F/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0x6B, Destination Call Id=96519)
Dec  5 14:33:44.956: //96519/FC3A05359A7F/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0x6B, Destination Call Id=96517)
Dec  5 14:33:44.956: //96517/FC3A05359A7F/CCAPI/cc_process_notify_bridge_done:
   Conference Id=0x6B, Call Id1=96517, Call Id2=96519
Dec  5 14:33:44.960: //96517/FC3A05359A7F/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 183 Session Progress
Via: SIP/2.0/UDP 72.55.168.18:5060;branch=z9hG4bK4ef6c761;rport
From: "Jakub Stroinski" <sip:5147221234@72.55.168.18>;tag=as3b4c747d
To: <sip:12345678@172.16.16.2:5060>;tag=9A6C3324-498
Date: Sat, 05 Dec 2015 14:33:28 GMT
Call-ID: 15e266a0629829ee1b1e5ffb792bd417@72.55.168.18:5060

CSeq: 102 INVITE
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
Allow-Events: telephone-event
Remote-Party-ID: <sip:5148121234@172.16.16.2>;party=called;screen=no;privacy=off
Contact: <sip:12345678@172.16.16.2:5060>
Supported: sdp-anat
Server: Cisco-SIPGateway/IOS-12.x
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 244

v=0
o=CiscoSystemsSIP-GW-UserAgent 1971 8444 IN IP4 172.16.16.2
s=SIP Call
c=IN IP4 172.16.16.2
t=0 0
m=audio 18400 RTP/AVP 0 101
c=IN IP4 172.16.16.2
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16

a=ptime:20

Dec  5 14:33:54.112: //96519/054654769A86/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK97841949;received=66.11.41.90;rport=58930
From: "Cisco Lab" <sip:5143601234@172.16.16.2>;tag=9A6C6DE8-1925
To: <sip:5148121234@72.55.168.18>;tag=as6ef74c21
Call-ID: 548C516-9A9411E5-9A8ABE77-FFDD325D@172.16.16.2
CSeq: 102 INVITE
Server: voip.ms
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Session-Expires: 1800;refresher=uas
Contact: <sip:5148121234@72.55.168.18:5060>
Content-Type: application/sdp
Require: timer
Content-Length: 221

v=0

o=root 164402832 164402833 IN IP4 72.55.168.18
s=voip.ms
c=IN IP4 72.55.168.18
t=0 0
m=audio 14754 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv

Dec  5 14:33:54.116: //96519/FC3A05359A7F/CCAPI/cc_api_call_connected:
   Interface=0x49C67A38, Data Bitmask=0x1, Progress Indication=NULL(0),
   Connection Handle=0
Dec  5 14:33:54.116: //96519/FC3A05359A7F/CCAPI/cc_api_call_connected:
   Call Entry(Connected=TRUE, Responsed=TRUE, Retry Count=0)
Dec  5 14:33:54.120: //96517/FC3A05359A7F/CCAPI/ccCallConnect:
   Progress Indication=NULL(0), Data Bitmask=0x1
Dec  5 14:33:54.120: //96517/FC3A05359A7F/CCAPI/ccCallConnect:
   Call Entry(Connected=TRUE, Responsed=TRUE)
Dec  5 14:33:54.124: //96519/054654769A86/SIP/Msg/ccsipDisplayMsg:
Sent:
ACK sip:5148121234@72.55.168.18:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9785126E
From: "Jakub Stroinski" <sip:5143601234@172.16.16.2>;tag=9A6C6DE8-1925
To: <sip:5148121234@72.55.168.18>;tag=as6ef74c21
Date: Sat, 05 Dec 2015 14:33:43 GMT
Call-ID: 548C516-9A9411E5-9A8ABE77-FFDD325D@172.16.16.2
Max-Forwards: 70
CSeq: 102 ACK
Authorization: Digest username="12345678",realm="montreal3.voip.ms",uri="sip:5148121234@72.55.168.18:5060",response="e6967cdfffc76c9bf3a966b35649e1a2",nonce="31ddbd60",algorithm=MD5
Allow-Events: kpml, telephone-event
Content-Length: 0


Dec  5 14:33:54.128: //96517/FC3A05359A7F/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 72.55.168.18:5060;branch=z9hG4bK4ef6c761;rport
From: "Jakub Stroinski" <sip:5147221234@72.55.168.18>;tag=as3b4c747d
To: <sip:12345678@172.16.16.2:5060>;tag=9A6C3324-498
Date: Sat, 05 Dec 2015 14:33:28 GMT
Call-ID: 15e266a0629829ee1b1e5ffb792bd417@72.55.168.18:5060

CSeq: 102 INVITE
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
Allow-Events: telephone-event
Remote-Party-ID: <sip:5148121234@172.16.16.2>;party=called;screen=no;privacy=off
Contact: <sip:12345678@172.16.16.2:5060>
Supported: replaces
Supported: sdp-anat
Server: Cisco-SIPGateway/IOS-12.x
Cisco-Gcid: FC3AA15D-9A93-11E5-9A82-BE77FFDD325D
Session-Expires:  1800;refresher=uas
Require: timer
Supported: timer
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 244

v=0
o=CiscoSystemsSIP-GW-UserAgent 1971 8444 IN IP4 172.16.16.2
s=SIP Call
c=IN IP4 172.16.16.2
t=0 0

m=audio 18400 RTP/AVP 0 101
c=IN IP4 172.16.16.2
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20

Dec  5 14:33:54.136: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:12345678@172.16.16.2:5060 SIP/2.0
Via: SIP/2.0/UDP 72.55.168.18:5060;branch=z9hG4bK0c76d014;rport
Max-Forwards: 70
From: "Jakub Stroinski" <sip:5147221234@72.55.168.18>;tag=as3b4c747d
To: <sip:12345678@172.16.16.2:5060>;tag=9A6C3324-498
Contact: <sip:5147221234@72.55.168.18:5060>
Call-ID: 15e266a0629829ee1b1e5ffb792bd417@72.55.168.18:5060
CSeq: 102 ACK
User-Agent: voip.ms
Content-Length: 0


Dec  5 14:34:50.296: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
REGISTER sip:172.16.16.2:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9786492
From: <sip:12345678@172.16.16.2>;tag=9A6D7130-D02
To: <sip:12345678@172.16.16.2>
Date: Sat, 05 Dec 2015 14:34:50 GMT
Call-ID: 50DA5F6C-830511E5-8040BE77-FFDD325D
User-Agent: Cisco-SIPGateway/IOS-12.x
Max-Forwards: 70
Timestamp: 1449326090
CSeq: 14389 REGISTER
Contact: <sip:12345678@172.16.16.2:5060>
Expires:  3600
Supported: path
Content-Length: 0


Dec  5 14:34:50.300: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
REGISTER sip:172.16.16.2:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9786492
From: <sip:12345678@172.16.16.2>;tag=9A6D7130-D02
To: <sip:12345678@172.16.16.2>

Date: Sat, 05 Dec 2015 14:34:50 GMT
Call-ID: 50DA5F6C-830511E5-8040BE77-FFDD325D
User-Agent: Cisco-SIPGateway/IOS-12.x
Max-Forwards: 70
Timestamp: 1449326090
CSeq: 14389 REGISTER
Contact: <sip:12345678@172.16.16.2:5060>
Expires:  3600
Supported: path
Content-Length: 0


Dec  5 14:34:50.308: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9786492
From: <sip:12345678@172.16.16.2>;tag=9A6D7130-D02
To: <sip:12345678@172.16.16.2>
Date: Sat, 05 Dec 2015 14:34:50 GMT
Call-ID: 50DA5F6C-830511E5-8040BE77-FFDD325D
Server: Cisco-SIPGateway/IOS-12.x
Timestamp: 1449326090

CSeq: 14389 REGISTER
Content-Length: 0


Dec  5 14:34:50.312: //96521/2CDAE5649A8B/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 404 Not Found
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9786492
From: <sip:12345678@172.16.16.2>;tag=9A6D7130-D02
To: <sip:12345678@172.16.16.2>;tag=9A6D7138-1200
Date: Sat, 05 Dec 2015 14:34:50 GMT
Call-ID: 50DA5F6C-830511E5-8040BE77-FFDD325D
Server: Cisco-SIPGateway/IOS-12.x
Timestamp: 1449326090
CSeq: 14389 REGISTER
Content-Length: 0


Dec  5 14:34:50.316: //96520/000000000000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9786492

From: <sip:12345678@172.16.16.2>;tag=9A6D7130-D02
To: <sip:12345678@172.16.16.2>
Date: Sat, 05 Dec 2015 14:34:50 GMT
Call-ID: 50DA5F6C-830511E5-8040BE77-FFDD325D
Server: Cisco-SIPGateway/IOS-12.x
Timestamp: 1449326090
CSeq: 14389 REGISTER
Content-Length: 0


Dec  5 14:34:50.316: //96520/000000000000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 404 Not Found
Via: SIP/2.0/UDP 172.16.16.2:5060;branch=z9hG4bK9786492
From: <sip:12345678@172.16.16.2>;tag=9A6D7130-D02
To: <sip:12345678@172.16.16.2>;tag=9A6D7138-1200
Date: Sat, 05 Dec 2015 14:34:50 GMT
Call-ID: 50DA5F6C-830511E5-8040BE77-FFDD325D
Server: Cisco-SIPGateway/IOS-12.x
Timestamp: 1449326090
CSeq: 14389 REGISTER
Content-Length: 0



Dec  5 14:34:55.024: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
BYE sip:12345678@172.16.16.2:5060 SIP/2.0
Via: SIP/2.0/UDP 72.55.168.18:5060;branch=z9hG4bK3bdef789;rport
Max-Forwards: 70
From: "Jakub Stroinski" <sip:5147221234@72.55.168.18>;tag=as3b4c747d
To: <sip:12345678@172.16.16.2:5060>;tag=9A6C3324-498
Call-ID: 15e266a0629829ee1b1e5ffb792bd417@72.55.168.18:5060
CSeq: 103 BYE
User-Agent: voip.ms
X-Asterisk-HangupCause: Normal Clearing
X-Asterisk-HangupCauseCode: 16
Content-Length: 0


Dec  5 14:34:55.028: //96519/FC3A05359A7F/CCAPI/ccGenerateToneInfo:
   Stop Tone On Digit=FALSE, Tone=Null,
   Tone Direction=Sum Network, Params=0x0, Call Id=96519
Dec  5 14:34:55.028: //96517/FC3A05359A7F/CCAPI/cc_api_call_disconnected:
   Cause Value=16, Interface=0x49C67A38, Call Id=96517
Dec  5 14:34:55.028: //96517/FC3A05359A7F/CCAPI/cc_api_call_disconnected:
   Call Entry(Responsed=TRUE, Cause Value=16, Retry Count=0)
Dec  5 14:34:55.028: //96517/FC3A05359A7F/CCAPI/ccConferenceDestroy:
   Conference Id=0x6B, Tag=0x0
Dec  5 14:34:55.028: //96517/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  5 14:34:55.032: cc_api_get_xcode_stream : 4702
Dec  5 14:34:55.032: //96519/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  5 14:34:55.032: cc_api_get_xcode_stream : 4702
Dec  5 14:34:55.032: //96517/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  5 14:34:55.032: cc_api_get_xcode_stream : 4702
Dec  5 14:34:55.032: //96517/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  5 14:34:55.032: cc_api_get_xcode_stream : 4702
Dec  5 14:34:55.032: //96517/FC3A05359A7F/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0x6B, Source Interface=0x49C67A38, Source Call Id=96517,
   Destination Call Id=96519, Disposition=0x0, Tag=0x0
Dec  5 14:34:55.032: //96519/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  5 14:34:55.032: cc_api_get_xcode_stream : 4702
Dec  5 14:34:55.032: //96517/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  5 14:34:55.032: cc_api_get_xcode_stream : 4702
Dec  5 14:34:55.032: //96519/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  5 14:34:55.032: cc_api_get_xcode_stream : 4702
Dec  5 14:34:55.032: //96519/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Dec  5 14:34:55.032: cc_api_get_xcode_stream : 4702
Dec  5 14:34:55.032: //96519/FC3A05359A7F/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0x6B, Source Interface=0x49C67A38, Source Call Id=96519,
   Destination Call Id=96517, Disposition=0x0, Tag=0x0
Dec  5 14:34:55.032: //96517/FC3A05359A7F/CCAPI/cc_generic_bridge_done:
   Conference Id=0x6B, Source Interface=0x49C67A38, Source Call Id=96519,
   Destination Call Id=96517, Disposition=0x0, Tag=0x0
Dec  5 14:34:55.036: //96517/FC3A05359A7F/CCAPI/ccCallDisconnect:
   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)
Dec  5 14:34:55.036: //96517/FC3A05359A7F/CCAPI/ccCallDisconnect:
   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
Dec  5 14:34:55.036: //96519/FC3A05359A7F/CCAPI/ccCallDisconnect:
   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
Dec  5 14:34:55.036: //96519/FC3A05359A7F/CCAPI/ccCallDisconnect:
   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
Dec  5 14:34:55.036: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
BYE sip:5143601234@172.16.16.2:5060 SIP/2.0
Via: SIP/2.0/UDP 72.55.168.18:5060;branch=z9hG4bK172bf120;rport
Max-Forwards: 70
From: <sip:5148121234@72.55.168.18>;tag=as6ef74c21
To: "Cisco Lab" <sip:5143601234@172.16.16.2>;tag=9A6C6DE8-1925
Call-ID: 548C516-9A9411E5-9A8ABE77-FFDD325D@172.16.16.2
CSeq: 102 BYE
User-Agent: voip.ms
Proxy-Authorization: Digest username="12345678", realm="montreal3.voip.ms", algorithm=MD5, uri="sip:72.55.168.18", nonce="31ddbd60", response="f98daeee834f9f60aa517880a8286327"
X-Asterisk-HangupCause: Normal Clearing
X-Asterisk-HangupCauseCode: 16
Content-Length: 0


Dec  5 14:34:55.040: //96519/FC3A05359A7F/CCAPI/cc_api_call_disconnected:
   Cause Value=16, Interface=0x49C67A38, Call Id=96519
Dec  5 14:34:55.040: //96519/FC3A05359A7F/CCAPI/cc_api_call_disconnected:
   Call Entry(Responsed=TRUE, Cause Value=16, Retry Count=0)
Dec  5 14:34:55.044: //96517/FC3A05359A7F/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x49C67A38, Tag=0x0, Call Id=96517,
   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
Dec  5 14:34:55.044: //96517/FC3A05359A7F/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
Dec  5 14:34:55.044: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  5 14:34:55.044: :cc_free_feature_vsa freeing 48F46E80
Dec  5 14:34:55.044: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  5 14:34:55.044:  vsacount in free is 3
Dec  5 14:34:55.044: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  5 14:34:55.044:  vsacount in free is 2
Dec  5 14:34:55.048: //96519/FC3A05359A7F/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x49C67A38, Tag=0x0, Call Id=96519,
   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
Dec  5 14:34:55.048: //96519/FC3A05359A7F/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
Dec  5 14:34:55.048: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  5 14:34:55.048: :cc_free_feature_vsa freeing 48F479E0
Dec  5 14:34:55.048: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  5 14:34:55.048:  vsacount in free is 1
Dec  5 14:34:55.048: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Dec  5 14:34:55.048:  vsacount in free is 0
Dec  5 14:34:55.052: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 72.55.168.18:5060;branch=z9hG4bK3bdef789;rport
From: "Jakub Stroinski" <sip:5147221234@72.55.168.18>;tag=as3b4c747d
To: <sip:12345678@172.16.16.2:5060>;tag=9A6C3324-498
Date: Sat, 05 Dec 2015 14:34:55 GMT
Call-ID: 15e266a0629829ee1b1e5ffb792bd417@72.55.168.18:5060
Server: Cisco-SIPGateway/IOS-12.x
CSeq: 103 BYE
Reason: Q.850;cause=16
P-RTP-Stat: PS=0,OS=0,PR=0,OR=0,PL=0,JI=0,LA=0,DU=60
Content-Length: 0


Dec  5 14:34:55.052: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 200 OK

Via: SIP/2.0/UDP 72.55.168.18:5060;branch=z9hG4bK172bf120;rport
From: <sip:5148121234@72.55.168.18>;tag=as6ef74c21
To: "Jakub Stroinski" <sip:5143601234@172.16.16.2>;tag=9A6C6DE8-1925
Date: Sat, 05 Dec 2015 14:34:55 GMT
Call-ID: 548C516-9A9411E5-9A8ABE77-FFDD325D@172.16.16.2
Server: Cisco-SIPGateway/IOS-12.x
CSeq: 102 BYE
Reason: Q.850;cause=16
P-RTP-Stat: PS=0,OS=0,PR=0,OR=0,PL=0,JI=0,LA=0,DU=60
Content-Length: 0


LabDOMAIN1#

Jakub,

First of all I must apologise that I didnt read the description of the issues very well. I have looked in detail on your logs now and here is my analysis.

Since this is RTP related, we need to look at the audio ports used for media.

###Here is the original INVITE (media values shown) ITSP and the media IP and Port ####

c=72.55.168.18
m=m=audio 11208 RTP/AVP 0 18 101

++++ Here is the 200 OK to original invite ++++

m=audio 18400 RTP/AVP 0 101
c=IN IP4 172.16.16.2

+++ Here is the outbound INVITE(media values shown) with SDP sent for the redirected number +++

m=audio 17254 RTP/AVP 0 101 121
c=IN IP4 172.16.16.2

### Here is the 200 OK from ITSP for the redirected number's INVITE ###

c=IN IP4 72.55.168.18
t=0 0
m=audio 14754 RTP/AVP 0 101

Now lets us ask basic questions

1. Is there a firewall involved here.

2. Please observe that the media ports used by ITSP is not part of the standard RTP port range (16384 32767)..So if there is a firewall are these lower port ranges allowed? (For inbound leg port=11208) for outboub leg port=14754

3. Has this ever worked before? Does this work when not in SRST?

Please rate all useful posts

1. No firewall

2. We're not blocking anything for the voice lab

3. Interesting point. I assumed that it would and was just having issues on the SRST side. I turned the CUCM network interface back on and waited til the phones registered. Set up call forward all to 95148121234 and the call behaves the same way; phone rings, able to answer it, silence on both ends, hangs up automatically after 60 seconds.

Seems like it's not SRST related but we have a problem somewhere else. Ideas where to go from here?

Content for Community-Ad

Spotlight Awards 2021

This widget could not be displayed.