Here are the debugs from an inbound call that fails with "party unavailable" recording:
debug ephone detail
This may severely impact system performance. Continue? [confirm]d
GMIT-VOICEROUTER01#ebug voip ccapi inout
^
% Invalid input detected at '^' marker.
GMIT-VOICEROUTER01#debug debug voip ccapi inout
voip ccapi inout debugging is on
GMIT-VOICEROUTER01#debug ccsip message
SIP Call messages tracing is enabled
GMIT-VOICEROUTER01#
*Dec 30 16:52:50.816: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
INVITE sip:17772882353@24.39.49.190:5060 SIP/2.0
v: SIP/2.0/UDP 204.11.192.160:5080;branch=z9hG4bK-78ba91246ea68b8e61d707aa505fa828
f: "Cell Phone ME" <12072277649>;tag=3597411176-875822
t: <>12072267262@ss.callcentric.com>
i: 272535-3597411176-875786@msw2.telengy.net
CSeq: 1 INVITE
Max-Forwards: 8
m: <0D036C82174EFA50E6B6A77EA97BBD5D>
Supported: timer
c: application/sdp
l: 364
v=0
o=NexTone-MSW 26817 24764 IN IP4 204.11.192.160
s=sip call
c=IN IP4 204.11.192.160
t=0 0
m=audio 61240 RTP/AVP 0 18 96 101
a=maxptime:30
a=sendrecv
a=fmtp:101 0-15
a=rtpmap:101 telephone-event/8000
a=fmtp:96 mode=30
a=rtpmap:96 iLBC/8000
a=fmtp:18 annexb=no
a=rtpmap:18 G729/8000
a=rtpmap:0 PCMU/8000
a=silenceSupp:off - - - -
a=setup:actpass
*Dec 30 16:52:50.824: //6766/xxxxxxxxxxxx/CCAPI/cc_api_caps_ind:
GMIT-VOICEROUTCall Entry Is Not Found
*Dec 30 16:52:50.824: //-1/A7330314814B/CCAPI/cc_api_display_ie_subfields:
cc_api_call_setup_ind_common:
cisco-username=12072277649
----- ccCallInfo IE subfields -----
cisco-ani=12072277649
cisco-anitype=0
cisco-aniplan=0
cisco-anipi=0
cisco-anisi=0
dest=17772882353
cisco-desttype=0
cisco-destplan=0
cisco-rdie=FFFFFFFF
cisco-rdn=
cisco-lastrdn=
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 30 16:52:50.824: //-1/A7330314814B/CCAPI/cc_api_call_setup_ind_common:
Interface=0x494F8810, Call Info(
Calling Number=12072277649,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=17772882353(TON=Unknown, NPI=Unknown),
Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,
Incoming Dial-peer=700, Progress Indication=NULL(0), Calling IE Present=TRUE,
Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=6766
*Dec 30 16:52:50.828: //-1/A7330314814B/CCAPI/ccCheckClipClir:
In: Calling Number=12072277649(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Dec 30 16:52:50.828: //-1/A7330314814B/CCAPI/ccCheckClipClir:
Out: Calling Number=12072277649(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Dec 30 16:52:50.828: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
*Dec 30 16:52:50.828: :cc_get_feature_vsa malloc success
*Dec 30 16:52:50.828: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
*Dec 30 16:52:50.828: cc_get_feature_vsa count is 1
*Dec 30 16:52:50.828: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
*Dec 30 16:52:50.828: :FEATURE_VSA attributes are: feature_name:0,feature_time:1289480888,feature_id:57
*Dec 30 16:52:50.828: //6766/A7330314814B/CCAPI/cc_api_call_setup_ind_common:
Set Up Event Sent;
Call Info(Calling Number=12072277649(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=17772882353(TON=Unknown, NPI=Unknown))
*Dec 30 16:52:50.832: //6766/A7330314814B/CCAPI/cc_process_call_setup_ind:
Event=0x4A2CDF80
*Dec 30 16:52:50.832: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
Try with the demoted called number 17772882353
*Dec 30 16:52:50.836: //6766/A7330314814B/CCAPI/ccCallSetContext:
Context=0x47DD3408
*Dec 30 16:52:50.836: //6766/A7330314814B/CCAPI/cc_process_call_setup_ind:
>>>>CCAPI handed cid 6766 with tag 700 to app "_ManagedAppProcess_Default"
*Dec 30 16:52:50.840: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 204.11.192.160:5080;branch=z9hG4bK-78ba91246ea68b8e61d707aa505fa828
From: "Cell Phone ME" <12072277649>;tag=3597411176-875822
To: <>12072267262@ss.callcentric.com>
Date: Mon, 30 Dec 2013 16:52:50 GMT
Call-ID: 272535-3597411176-875786@msw2.telengy.net
CSeq: 1 INVITE
Allow-Events: telephone-event
Server: Cisco-SIPGateway/IOS-12.x
Content-Length: 0
*Dec 30 16:52:50.840: //6766/A7330314814B/CCAPI/ccCallProceeding:
Progress Indication=NULL(0)
*Dec 30 16:52:50.844: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
Try with the demoted called number 17772882353
*Dec 30 16:52:50.844: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:
*Dec 30 16:52:50.844: : updating existing feature vsa
*Dec 30 16:52:50.844: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:
*Dec 30 16:52:50.844: feature call basic
*Dec 30 16:52:50.844: //6766/A7330314814B/CCAPI/ccCallDisconnect:
Cause Value=17, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
*Dec 30 16:52:50.844: //6766/A7330314814B/CCAPI/ccCallDisconnect:
Cause Value=17, Call Entry(Responsed=TRUE, Cause Value=17)
*Dec 30 16:52:50.848: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 486 Busy here
Via: SIP/2.0/UDP 204.11.192.160:5080;branch=z9hG4bK-78ba91246ea68b8e61d707aa505fa828
From: "Cell Phone ME" <12072277649>;tag=3597411176-875822
To: <>12072267262@ss.callcentric.com>;tag=990BDC8-214E
Date: Mon, 30 Dec 2013 16:52:50 GMT
Call-ID: 272535-3597411176-875786@msw2.telengy.net
CSeq: 1 INVITE
Allow-Events: telephone-event
Server: Cisco-SIPGateway/IOS-12.x
Reason: Q.850;cause=17
Content-Length: 0
*Dec 30 16:52:50.904: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:17772882353@24.39.49.190:5060 SIP/2.0
v: SIP/2.0/UDP 204.11.192.160:5080;branch=z9hG4bK-78ba91246ea68b8e61d707aa505fa828
f: "Cell Phone ME" <12072277649>;tag=3597411176-875822
t: <>12072267262@ss.callcentric.com>;tag=990BDC8-214E
i: 272535-3597411176-875786@msw2.telengy.net
CSeq: 1 ACK
Max-Forwards: 10
l: 0
*Dec 30 16:52:50.904: //6766/A7330314814B/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x494F8810, Tag=0x0, Call Id=6766,
Call Entry(Disconnect Cause=17, Voice Class Cause Code=0, Retry Count=0)
*Dec 30 16:52:50.904: //6766/A7330314814B/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
*Dec 30 16:52:50.904: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
*Dec 30 16:52:50.908: :cc_free_feature_vsa freeing 4CDBEAB0
*Dec 30 16:52:50.908: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
*Dec 30 16:52:50.908: vsacount in free is 0ER01#
GMIT-VOICEROUTER01#
*Dec 30 16:53:07.172: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
INVITE sip:17772882353@24.39.49.190:5060 SIP/2.0
v: SIP/2.0/UDP 204.11.192.160:5080;branch=z9hG4bK-9ccc81ceef0a0001bb1ed78a4455f6bb
f: "Cell Phone ME" <12072277649>;tag=3597411193-215572
t: <>12072267262@ss.callcentric.com>
i: 272663-3597411193-215528@msw2.telengy.net
CSeq: 1 INVITE
Max-Forwards: 8
m:
Supported: timer
c: application/sdp
l: 364
v=0
o=NexTone-MSW 26817 24764 IN IP4 204.11.192.160
s=sip call
c=IN IP4 204.11.192.160
t=0 0
m=audio 61256 RTP/AVP 0 18 96 101
a=maxptime:30
a=sendrecv
a=fmtp:101 0-15
a=rtpmap:101 telephone-event/8000
a=fmtp:96 mode=30
a=rtpmap:96 iLBC/8000
a=fmtp:18 annexb=no
a=rtpmap:18 G729/8000
a=rtpmap:0 PCMU/8000
a=silenceSupp:off - - - -
a=setup:actpass
*Dec 30 16:53:07.180: //6767/xxxxxxxxxxxx/CCAPI/cc_api_caps_ind:
GMIT-VOICEROUTCall Entry Is Not Found
*Dec 30 16:53:07.184: //-1/B0F35A4D8150/CCAPI/cc_api_display_ie_subfields:
cc_api_call_setup_ind_common:
cisco-username=12072277649
----- ccCallInfo IE subfields -----
cisco-ani=12072277649
cisco-anitype=0
cisco-aniplan=0
cisco-anipi=0
cisco-anisi=0
dest=17772882353
cisco-desttype=0
cisco-destplan=0
cisco-rdie=FFFFFFFF
cisco-rdn=
cisco-lastrdn=
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 30 16:53:07.184: //-1/B0F35A4D8150/CCAPI/cc_api_call_setup_ind_common:
Interface=0x494F8810, Call Info(
Calling Number=12072277649,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=17772882353(TON=Unknown, NPI=Unknown),
Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,
Incoming Dial-peer=700, Progress Indication=NULL(0), Calling IE Present=TRUE,
Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=6767
*Dec 30 16:53:07.184: //-1/B0F35A4D8150/CCAPI/ccCheckClipClir:
In: Calling Number=12072277649(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Dec 30 16:53:07.184: //-1/B0F35A4D8150/CCAPI/ccCheckClipClir:
Out: Calling Number=12072277649(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Dec 30 16:53:07.184: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
*Dec 30 16:53:07.184: :cc_get_feature_vsa malloc success
*Dec 30 16:53:07.184: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
*Dec 30 16:53:07.188: cc_get_feature_vsa count is 1
*Dec 30 16:53:07.188: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
*Dec 30 16:53:07.188: :FEATURE_VSA attributes are: feature_name:0,feature_time:1289480888,feature_id:58
*Dec 30 16:53:07.188: //6767/B0F35A4D8150/CCAPI/cc_api_call_setup_ind_common:
Set Up Event Sent;
Call Info(Calling Number=12072277649(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=17772882353(TON=Unknown, NPI=Unknown))
*Dec 30 16:53:07.188: //6767/B0F35A4D8150/CCAPI/cc_process_call_setup_ind:
Event=0x4A2CDF80
*Dec 30 16:53:07.188: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
Try with the demoted called number 17772882353
*Dec 30 16:53:07.188: //6767/B0F35A4D8150/CCAPI/ccCallSetContext:
Context=0x47DD5A18
*Dec 30 16:53:07.192: //6767/B0F35A4D8150/CCAPI/cc_process_call_setup_ind:
>>>>CCAPI handed cid 6767 with tag 700 to app "_ManagedAppProcess_Default"
*Dec 30 16:53:07.192: //6767/B0F35A4D8150/CCAPI/ccCallProceeding:
Progress Indication=NULL(0)
*Dec 30 16:53:07.196: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
Try with the demoted called number 17772882353
*Dec 30 16:53:07.196: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:
*Dec 30 16:53:07.196: : updating existing feature vsa
*Dec 30 16:53:07.196: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:
*Dec 30 16:53:07.196: feature call basic
*Dec 30 16:53:07.196: //6767/B0F35A4D8150/CCAPI/ccCallDisconnect:
Cause Value=17, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
*Dec 30 16:53:07.196: //6767/B0F35A4D8150/CCAPI/ccCallDisconnect:
Cause Value=17, Call Entry(Responsed=TRUE, Cause Value=17)
*Dec 30 16:53:07.200: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 204.11.192.160:5080;branch=z9hG4bK-9ccc81ceef0a0001bb1ed78a4455f6bb
From: "Cell Phone ME" <12072277649>;tag=3597411193-215572
To: <>12072267262@ss.callcentric.com>
Date: Mon, 30 Dec 2013 16:53:07 GMT
Call-ID: 272663-3597411193-215528@msw2.telengy.net
CSeq: 1 INVITE
Allow-Events: telephone-event
Server: Cisco-SIPGateway/IOS-12.x
Content-Length: 0
*Dec 30 16:53:07.200: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 486 Busy here
Via: SIP/2.0/UDP 204.11.192.160:5080;branch=z9hG4bK-9ccc81ceef0a0001bb1ed78a4455f6bb
From: "Cell Phone ME" <12072277649>;tag=3597411193-215572
To: <>12072267262@ss.callcentric.com>;tag=990FDA8-DF8
Date: Mon, 30 Dec 2013 16:53:07 GMT
Call-ID: 272663-3597411193-215528@msw2.telengy.net
CSeq: 1 INVITE
Allow-Events: telephone-event
Server: Cisco-SIPGateway/IOS-12.x
Reason: Q.850;cause=17
Content-Length: 0
*Dec 30 16:53:07.260: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:17772882353@24.39.49.190:5060 SIP/2.0
v: SIP/2.0/UDP 204.11.192.160:5080;branch=z9hG4bK-9ccc81ceef0a0001bb1ed78a4455f6bb
f: "Cell Phone ME" <12072277649>;tag=3597411193-215572
t: <>12072267262@ss.callcentric.com>;tag=990FDA8-DF8
i: 272663-3597411193-215528@msw2.telengy.net
CSeq: 1 ACK
Max-Forwards: 10
l: 0
*Dec 30 16:53:07.260: //6767/B0F35A4D8150/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x494F8810, Tag=0x0, Call Id=6767,
Call Entry(Disconnect Cause=17, Voice Class Cause Code=0, Retry Count=0)
*Dec 30 16:53:07.260: //6767/B0F35A4D8150/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
*Dec 30 16:53:07.264: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
*Dec 30 16:53:07.264: :cc_free_feature_vsa freeing 4CDBEAB0
*Dec 30 16:53:07.264: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
*Dec 30 16:53:07.264: vsacount in free is 0
*Dec 30 16:53:08.372: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:12072267262@alpha5.callcentric.com:5070 SIP/2.0
v: SIP/2.0/UDP 204.11.192.160:5080;branch=z9hG4bK-c1461a555741ac74cd4bd429f69f3c0f
f: "Cell Phone ME" <12072277649>;tag=3597411193-215572
t: <>12072267262@ss.callcentric.com>;tag=990FDA8-DF8
i: 272663-3597411193-215528@msw2.telengy.net
CSeq: 1 ACK
Max-Forwards: 8
l: 0
ER01#
GMIT-VOICEROUTER01#no debug all
All possible debugging has been turned off
GMIT-VOICEROUTER01#
