VoiceGW#
VoiceGW#debug ccsip calls
SIP Call statistics tracing is enabled
VoiceGW#debug voip ccapi inout
voip ccapi inout debugging is on

VoiceGW#
Aug  3 17:13:45.843: //-1/7784233C8377/CCAPI/cc_api_display_ie_subfields:
   cc_api_call_setup_ind_common:
   cisco-username=
   ----- ccCallInfo IE subfields -----
   cisco-ani=4007
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=FFFFFFFFFFFFFFFF
   cisco-rdn=
   cisco-rdntype=0
   cisco-rdnplan=0
   cisco-rdnpi=0
   cisco-rdnsi=0
   cisco-redirectreason=0   fwd_final_type =0
   final_redirectNumber =
   hunt_group_timeout =0

Aug  3 17:13:45.844: //-1/7784233C8377/CCAPI/cc_api_call_setup_ind_common:
   Interface=0x7FAAA61D95B8, Call Info(
   Calling Number=4007,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=(TON=Unknown, NPI=Unknown),
   Calling Translated=FALSE, Subscriber Type Str=RegularLine, FinalDestinationFlag=FALSE,
   Incoming Dial-peer=20011, Progress Indication=ORIGINATING SIDE IS NON ISDN(3), Calling IE Present=TRUE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=-1
Aug  3 17:13:45.844: //-1/7784233C8377/CCAPI/ccCheckClipClir:
   In: Calling Number=4007(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Aug  3 17:13:45.844: //-1/7784233C8377/CCAPI/ccCheckClipClir:
   Out: Calling Number=4007(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Aug  3 17:13:45.844: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Aug  3 17:13:45.844: :cc_get_feature_vsa malloc success
Aug  3 17:13:45.844: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Aug  3 17:13:45.844:  cc_get_feature_vsa count is 1
Aug  3 17:13:45.844: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Aug  3 17:13:45.844: :FEATURE_VSA attributes are: feature_name:0,feature_time:140370726551660,feature_id:339
Aug  3 17:13:45.844: //369/7784233C8377/CCAPI/cc_api_call_setup_ind_common:
   Set Up Event Sent;
   Call Info(Calling Number=4007(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=(TON=Unknown, NPI=Unknown))
Aug  3 17:13:45.845: //369/7784233C8377/CCAPI/cc_process_call_setup_ind:
   Event=0x7FAA9B4D1B90
Aug  3 17:13:45.846: //369/7784233C8377/CCAPI/ccCallSetContext:
   Context=0x7FAAA71C3AE0
Aug  3 17:13:45.847: //369/7784233C8377/CCAPI/cc_process_call_setup_ind:
   >>>>CCAPI handed cid 369 with tag 20011 to app "_ManagedAppProcess_Default"
Aug  3 17:13:45.848: //369/7784233C8377/CCAPI/ccCallSetupAck:
   Call Id=369
Aug  3 17:13:45.848: //369/7784233C8377/CCAPI/cc_api_set_transfer_info:
   Transfer Number=, Transfer Reason=0x0
Aug  3 17:13:45.848: //369/7784233C8377/CCAPI/ccGenerateToneInfo:
   Stop Tone On Digit=TRUE, Tone=Dial Tone,
   Tone Direction=Network, Params=0x0, Call Id=369
Aug  3 17:13:45.848: //369/7784233C8377/CCAPI/ccSetDigitTimeouts:
   Initial Digit Timeout=-1000(ms), Inter Digit Timeout=-1000(ms)
Aug  3 17:13:45.848: //369/7784233C8377/CCAPI/ccSetDigitTimeouts:
   Call Entry(Inter Digit Timeout=10000(ms), Initial Digit Timeout=10000(ms))
Aug  3 17:13:45.848: //369/7784233C8377/CCAPI/ccCallReportDigits:
   (callID=0x171, digit_event=0x1, enable=TRUE, consume=FALSE)
Aug  3 17:13:45.848: //369/7784233C8377/CCAPI/ccCallReportDigits:
   Enabled=TRUE, Call Id=369
Aug  3 17:13:45.848: //369/7784233C8377/CCAPI/cc_api_call_report_digits_done:
   (vdbPtr=0x7FAAA61D95B8, callID=0x171, disp=0, digit_event=0x1, enable=TRUE, consume=FALSE)
Aug  3 17:13:45.848: //369/7784233C8377/CCAPI/cc_api_call_report_digits_done:
   Enabled=TRUE, Disposition=0x0, Interface=0x7FAAA61D95B8, Call Id=369
Aug  3 17:13:45.848: //369/7784233C8377/CCAPI/cc_api_call_report_digits_done:
   Call Entry(Initial Digit Timeout=15000(ms), Inter Digit Timeout=10000(ms))
Aug  3 17:13:46.258: //369/7784233C8377/CCAPI/cc_api_call_digit_begin:
   Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
   Source Call Id=369, Digit=4, DigitBeginFlags=0x0,
   Rtp Timestamp=0x9DF968, Rtp Expiration=0x0
Aug  3 17:13:46.258: //369/7784233C8377/CCAPI/cc_api_call_digit_end:
   Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
   Source Call Id=369, Digit=4, Duration=100,
   Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Aug  3 17:13:46.258: //369/7784233C8377/CCAPI/cc_api_call_digit_end:
   Call Entry(Handoff Depth=0)
Aug  3 17:13:46.457: //369/7784233C8377/CCAPI/cc_api_call_digit_begin:
   Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
   Source Call Id=369, Digit=4, DigitBeginFlags=0x0,
   Rtp Timestamp=0x9E7668, Rtp Expiration=0x0
Aug  3 17:13:46.458: //369/7784233C8377/CCAPI/cc_api_call_digit_end:
   Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
   Source Call Id=369, Digit=4, Duration=100,
   Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Aug  3 17:13:46.458: //369/7784233C8377/CCAPI/cc_api_call_digit_end:
   Call Entry(Handoff Depth=0)
Aug  3 17:13:46.658: //369/7784233C8377/CCAPI/cc_api_call_digit_begin:
   Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
   Source Call Id=369, Digit=4, DigitBeginFlags=0x0,
   Rtp Timestamp=0x9EF368, Rtp Expiration=0x0
Aug  3 17:13:46.658: //369/7784233C8377/CCAPI/cc_api_call_digit_end:
   Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
   Source Call Id=369, Digit=4, Duration=100,
   Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Aug  3 17:13:46.658: //369/7784233C8377/CCAPI/cc_api_call_digit_end:
   Call Entry(Handoff Depth=0)
Aug  3 17:13:46.858: //369/7784233C8377/CCAPI/cc_api_call_digit_begin:
   Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
   Source Call Id=369, Digit=6, DigitBeginFlags=0x0,
   Rtp Timestamp=0x9F7068, Rtp Expiration=0x0
Aug  3 17:13:46.858: //369/7784233C8377/CCAPI/cc_api_call_digit_end:
   Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
   Source Call Id=369, Digit=6, Duration=100,
   Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Aug  3 17:13:46.858: //369/7784233C8377/CCAPI/cc_api_call_digit_end:
   Call Entry(Handoff Depth=0)
Aug  3 17:13:46.859: //369/7784233C8377/CCAPI/ccCallReportDigits:
   (callID=0x171, digit_event=0x0, enable=FALSE, consume=FALSE)
Aug  3 17:13:46.859: //369/7784233C8377/CCAPI/ccCallReportDigits:
   Enabled=TRUE, Call Id=369
Aug  3 17:13:46.859: //369/7784233C8377/CCAPI/cc_api_call_report_digits_done:
   (vdbPtr=0x7FAAA61D95B8, callID=0x171, disp=0, digit_event=0x0, enable=FALSE, consume=FALSE)
Aug  3 17:13:46.859: //369/7784233C8377/CCAPI/cc_api_call_report_digits_done:
   Enabled=TRUE, Disposition=0x0, Interface=0x7FAAA61D95B8, Call Id=369
Aug  3 17:13:46.859: //369/7784233C8377/CCAPI/cc_api_call_report_digits_done:
   Call Entry(Initial Digit Timeout=15000(ms), Inter Digit Timeout=10000(ms))
Aug  3 17:13:46.859: //369/7784233C8377/CCAPI/ccCallProceeding:
   Progress Indication=NULL(0)
Aug  3 17:13:46.860: //369/7784233C8377/CCAPI/ccCallSetupRequest:
   Destination=, Calling IE Present=TRUE, Mode=0,
   Outgoing Dial-peer=55, Params=0x7FAAA71C2450, Progress Indication=ORIGINATING SIDE IS NON ISDN(3)
Aug  3 17:13:46.860: //369/7784233C8377/CCAPI/ccCheckClipClir:
   In: Calling Number=4007(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Aug  3 17:13:46.860: //369/7784233C8377/CCAPI/ccCheckClipClir:
   Out: Calling Number=4007(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Aug  3 17:13:46.860: //369/7784233C8377/CCAPI/ccCallSetupRequest:
   Destination Pattern=444[5678], Called Number=4446, Digit Strip=FALSE
Aug  3 17:13:46.860: //369/7784233C8377/CCAPI/ccCallSetupRequest:
   Calling Number=4007(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=4446(TON=Unknown, NPI=Unknown),
   Redirect Number=, Display Info=Server Room
   Account Number=, Final Destination Flag=FALSE,
   Guid=7784233C-1286-11ED-8377-DDAE5E19B77A, Outgoing Dial-peer=55
Aug  3 17:13:46.861: //369/7784233C8377/CCAPI/cc_api_display_ie_subfields:
   ccCallSetupRequest:
   cisco-username=
   ----- ccCallInfo IE subfields -----
   cisco-ani=4007
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=4446
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=FFFFFFFFFFFFFFFF
   cisco-rdn=
   cisco-rdntype=0
   cisco-rdnplan=0
   cisco-rdnpi=0
   cisco-rdnsi=0
   cisco-redirectreason=0   fwd_final_type =0
   final_redirectNumber =
   hunt_group_timeout =0

Aug  3 17:13:46.861: //369/7784233C8377/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x7FAA9A2FDB80, Interface Type=3, Destination=, Mode=0x0,
   Call Params(Calling Number=4007,(Calling Name=Server Room)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=4446(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=RegularLine, FinalDestinationFlag=FALSE, Outgoing Dial-peer=55, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
Aug  3 17:13:46.861: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Aug  3 17:13:46.861: :cc_get_feature_vsa malloc success
Aug  3 17:13:46.861: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Aug  3 17:13:46.861:  cc_get_feature_vsa count is 2
Aug  3 17:13:46.861: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Aug  3 17:13:46.861: :FEATURE_VSA attributes are: feature_name:0,feature_time:140370726551436,feature_id:340
Aug  3 17:13:46.862: //370/7784233C8377/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=3, FlowMode=1
Aug  3 17:13:46.862: //370/7784233C8377/CCAPI/ccCallSetContext:
   Context=0x7FAAA71C23D0
Aug  3 17:13:46.862: //369/7784233C8377/CCAPI/ccSaveDialpeerTag:
   Outgoing Dial-peer=55
Aug  3 17:13:46.864: //370/7784233C8377/CCAPI/cc_api_call_disconnected:
   Cause Value=38, Interface=0x7FAA9A2FDB80, Call Id=370
Aug  3 17:13:46.864: //370/7784233C8377/CCAPI/cc_api_call_disconnected:
   Call Entry(Responsed=TRUE, Cause Value=38, Retry Count=0)
Aug  3 17:13:46.865: //369/7784233C8377/CCAPI/ccCallReleaseResources:
   release reserved xcoding resource.
Aug  3 17:13:46.865: //370/7784233C8377/CCAPI/ccCallSetAAA_Accounting:
   Accounting=0, Call Id=370
Aug  3 17:13:46.865: //370/7784233C8377/CCAPI/ccCallDisconnect:
   Cause Value=38, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=38)
Aug  3 17:13:46.865: //370/7784233C8377/CCAPI/ccCallDisconnect:
   Cause Value=38, Call Entry(Responsed=TRUE, Cause Value=38)
Aug  3 17:13:46.866: //370/7784233C8377/CCAPI/cc_api_call_disconnect_done:
   Disposition=-11, Interface=0x7FAA9A2FDB80, Tag=0x0, Call Id=370,
   Call Entry(Disconnect Cause=38, Voice Class Cause Code=0, Retry Count=0)
Aug  3 17:13:46.866: //370/7784233C8377/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
Aug  3 17:13:46.866: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Aug  3 17:13:46.866: :cc_free_feature_vsa freeing 7FAA9B4AFF80
Aug  3 17:13:46.866: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Aug  3 17:13:46.866:  vsacount in free is 1
Aug  3 17:13:46.866: //370/7784233C8377/SIP/Call/sipSPICallInfo:
The Call Setup Information is:
Call Control Block (CCB) : 0x0x7FAAA561F698
State of The Call        : STATE_DEAD
TCP Sockets Used         : YES
Calling Number           : 4007
Called Number            : 4446
Source IP Address (Sig  ): 10.201.47.10
Destn SIP Req Addr:Port  : :0
Destn SIP Resp Addr:Port : :0
Destination Name         :

Aug  3 17:13:46.866: //370/7784233C8377/SIP/Call/sipSPIMediaCallInfo:
Number of Media Streams: 1
Media Stream             : 1
Negotiated Codec         : No Codec
Negotiated Codec Bytes   : 0
Nego. Codec payload      : 255 (tx), 255 (rx)
Negotiated Dtmf-relay    : 0
Dtmf-relay Payload       : 0 (tx), 0 (rx)
Source IP Address (Media): 10.201.47.10
Source IP Port    (Media): 8232
Destn  IP Address (Media):  -
Destn  IP Port    (Media): 0
Orig Destn IP Address:Port (Media): [ - ]:0

Aug  3 17:13:46.867: //370/7784233C8377/SIP/Call/sipSPICallInfo:
Disconnect Cause (CC)    : 38
Disconnect Cause (SIP)   : 200

Aug  3 17:13:46.867: //369/7784233C8377/CCAPI/ccCallDisconnect:
   Cause Value=38, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
Aug  3 17:13:46.867: //369/7784233C8377/CCAPI/ccCallDisconnect:
   Cause Value=38, Call Entry(Responsed=TRUE, Cause Value=38)
Aug  3 17:13:46.867: //369/7784233C8377/CCAPI/cc_api_get_transfer_info:
   Transfer Number=NULL
1557: Aug  3 17:13:47.875: //4294967295/xxxxxxxxxxxx/
------------------ Cover Buffer ---------------
Search-key       = ::NA
  Timestamp      = Aug  3 17:13:46.862
  CallID         = NA
  Peer-CallID    = NA
  Correlator     = NA
  Called-Number  =
  Calling-Number =
  SIP CallID     =
  SIP SessionID  =
  GUID           =
-----------------------------------------------
1540: Aug  3 17:13:46.861: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/MISC/Matched Dialpeer: Dir:Outbound, Peer-Tag:  55
1541: Aug  3 17:13:46.861: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/FSM/SPI-State-Change: Current State = STATE_NONE, Next State = STATE_IDLE, Current Sub-State = STATE_NONE, Next Sub-State = STATE_NONE
1542: Aug  3 17:13:46.862: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/FSM/IWF: Event = E_SIP_IWF_EV_SET_MODE, Current State = CNFSM_CONTAINER_STATE, Next State = CNFSM_NO_STATE_CHANGE
1543: Aug  3 17:13:46.864: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/API: voip_rtp_allocate_port (8232)
1544: Aug  3 17:13:46.864: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/API: cc_api_update_interface_cac_resource (0)
1545: Aug  3 17:13:46.863: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/FSM/Event-Action: Event = SIPSPI_EV_CC_CALL_SETUP, Current State = STATE_IDLE
1546: Aug  3 17:13:46.863: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/MISC/Call Disconnect: Initiated at: 0x1700E2B, Originated at:0x1700E29, Cause Code = 38
1547: Aug  3 17:13:46.863: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/API: cc_api_call_disconnected (0)
1548: Aug  3 17:13:46.863: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/FSM/SPI-State-Change: Current State = STATE_IDLE, Next State = STATE_DISCONNECTING, Current Sub-State = STATE_NONE, Next Sub-State = STATE_NONE
1549: Aug  3 17:13:46.865: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/MISC/Call Disconnect: Initiated at: 0x260070A, Originated at:0x260070B, Cause Code = 38
1550: Aug  3 17:13:46.865: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/API: cc_api_update_interface_cac_resource (0)
1551: Aug  3 17:13:46.865: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/FSM/Event-Action: Event = SIPSPI_EV_CC_CALL_DISCONNECT, Current State = STATE_DISCONNECTING
1552: Aug  3 17:13:46.866: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/API: voip_rtp_release_port (8232)
1553: Aug  3 17:13:46.867: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/API: cc_api_call_disconnect_done (0)
1554: Aug  3 17:13:46.867: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/FSM/SPI-State-Change: Current State = STATE_DISCONNECTING, Next State = STATE_DEAD, Current Sub-State = STATE_NONE, Next Sub-State = STATE_NONE
1555: Aug  3 17:13:46.867: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/MISC/Error: sipSPIFlushDeferredQueue: Invalid deferredQueue
1556: Aug  3 17:13:46.867: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/API: voip_rtp_release_port (8232)
Aug  3 17:13:49.202: //369/7784233C8377/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x7FAAA61D95B8, Tag=0x0, Call Id=369,
   Call Entry(Disconnect Cause=38, Voice Class Cause Code=0, Retry Count=0)
Aug  3 17:13:49.202: //369/7784233C8377/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
Aug  3 17:13:49.203: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Aug  3 17:13:49.203: :cc_free_feature_vsa freeing 7FAA9B4B0060
Aug  3 17:13:49.203: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Aug  3 17:13:49.203:  vsacount in free is 0
QNB_4331-VoiceGW#
QNB_4331-VoiceGW#
QNB_4331-VoiceGW#
QNB_4331-VoiceGW#
QNB_4331-VoiceGW#
QNB_4331-VoiceGW#
QNB_4331-VoiceGW#
QNB_4331-VoiceGW#
QNB_4331-VoiceGW#
QNB_4331-VoiceGW#
QNB_4331-VoiceGW#
QNB_4331-VoiceGW#
QNB_4331-VoiceGW#
QNB_4331-VoiceGW#
QNB_4331-VoiceGW#
QNB_4331-VoiceGW#
QNB_4331-VoiceGW#
QNB_4331-VoiceGW#
QNB_4331-VoiceGW#
QNB_4331-VoiceGW#
QNB_4331-VoiceGW#
QNB_4331-VoiceGW#
Aug  3 17:13:59.445: //-1/7F9FA3C4837C/CCAPI/cc_api_display_ie_subfields:
   cc_api_call_setup_ind_common:
   cisco-username=
   ----- ccCallInfo IE subfields -----
   cisco-ani=4007
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=FFFFFFFFFFFFFFFF
   cisco-rdn=
   cisco-rdntype=0
   cisco-rdnplan=0
   cisco-rdnpi=0
   cisco-rdnsi=0
   cisco-redirectreason=0   fwd_final_type =0
   final_redirectNumber =
   hunt_group_timeout =0

Aug  3 17:13:59.445: //-1/7F9FA3C4837C/CCAPI/cc_api_call_setup_ind_common:
   Interface=0x7FAAA61D95B8, Call Info(
   Calling Number=4007,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=(TON=Unknown, NPI=Unknown),
   Calling Translated=FALSE, Subscriber Type Str=RegularLine, FinalDestinationFlag=FALSE,
   Incoming Dial-peer=20011, Progress Indication=ORIGINATING SIDE IS NON ISDN(3), Calling IE Present=TRUE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=-1
Aug  3 17:13:59.446: //-1/7F9FA3C4837C/CCAPI/ccCheckClipClir:
   In: Calling Number=4007(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Aug  3 17:13:59.446: //-1/7F9FA3C4837C/CCAPI/ccCheckClipClir:
   Out: Calling Number=4007(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Aug  3 17:13:59.446: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Aug  3 17:13:59.446: :cc_get_feature_vsa malloc success
Aug  3 17:13:59.446: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Aug  3 17:13:59.446:  cc_get_feature_vsa count is 1
Aug  3 17:13:59.446: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Aug  3 17:13:59.446: :FEATURE_VSA attributes are: feature_name:0,feature_time:140370726551660,feature_id:341
Aug  3 17:13:59.446: //371/7F9FA3C4837C/CCAPI/cc_api_call_setup_ind_common:
   Set Up Event Sent;
   Call Info(Calling Number=4007(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=(TON=Unknown, NPI=Unknown))
Aug  3 17:13:59.447: //371/7F9FA3C4837C/CCAPI/cc_process_call_setup_ind:
   Event=0x7FAA9B4D1B90
Aug  3 17:13:59.447: //371/7F9FA3C4837C/CCAPI/ccCallSetContext:
   Context=0x7FAAA71AC9E0
Aug  3 17:13:59.447: //371/7F9FA3C4837C/CCAPI/cc_process_call_setup_ind:
   >>>>CCAPI handed cid 371 with tag 20011 to app "_ManagedAppProcess_Default"
Aug  3 17:13:59.447: //371/7F9FA3C4837C/CCAPI/ccCallSetupAck:
   Call Id=371
Aug  3 17:13:59.448: //371/7F9FA3C4837C/CCAPI/cc_api_set_transfer_info:
   Transfer Number=, Transfer Reason=0x0
Aug  3 17:13:59.448: //371/7F9FA3C4837C/CCAPI/ccGenerateToneInfo:
   Stop Tone On Digit=TRUE, Tone=Dial Tone,
   Tone Direction=Network, Params=0x0, Call Id=371
Aug  3 17:13:59.448: //371/7F9FA3C4837C/CCAPI/ccSetDigitTimeouts:
   Initial Digit Timeout=-1000(ms), Inter Digit Timeout=-1000(ms)
Aug  3 17:13:59.448: //371/7F9FA3C4837C/CCAPI/ccSetDigitTimeouts:
   Call Entry(Inter Digit Timeout=10000(ms), Initial Digit Timeout=10000(ms))
Aug  3 17:13:59.448: //371/7F9FA3C4837C/CCAPI/ccCallReportDigits:
   (callID=0x173, digit_event=0x1, enable=TRUE, consume=FALSE)
Aug  3 17:13:59.448: //371/7F9FA3C4837C/CCAPI/ccCallReportDigits:
   Enabled=TRUE, Call Id=371
Aug  3 17:13:59.448: //371/7F9FA3C4837C/CCAPI/cc_api_call_report_digits_done:
   (vdbPtr=0x7FAAA61D95B8, callID=0x173, disp=0, digit_event=0x1, enable=TRUE, consume=FALSE)
Aug  3 17:13:59.448: //371/7F9FA3C4837C/CCAPI/cc_api_call_report_digits_done:
   Enabled=TRUE, Disposition=0x0, Interface=0x7FAAA61D95B8, Call Id=371
Aug  3 17:13:59.448: //371/7F9FA3C4837C/CCAPI/cc_api_call_report_digits_done:
   Call Entry(Initial Digit Timeout=15000(ms), Inter Digit Timeout=10000(ms))
Aug  3 17:13:59.852: //371/7F9FA3C4837C/CCAPI/cc_api_call_digit_begin:
   Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
   Source Call Id=371, Digit=0, DigitBeginFlags=0x0,
   Rtp Timestamp=0x9FF538, Rtp Expiration=0x0
Aug  3 17:13:59.853: //371/7F9FA3C4837C/CCAPI/cc_api_call_digit_end:
   Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
   Source Call Id=371, Digit=0, Duration=100,
   Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Aug  3 17:13:59.853: //371/7F9FA3C4837C/CCAPI/cc_api_call_digit_end:
   Call Entry(Handoff Depth=0)
Aug  3 17:14:00.052: //371/7F9FA3C4837C/CCAPI/cc_api_call_digit_begin:
   Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
   Source Call Id=371, Digit=9, DigitBeginFlags=0x0,
   Rtp Timestamp=0xA07238, Rtp Expiration=0x0
Aug  3 17:14:00.052: //371/7F9FA3C4837C/CCAPI/cc_api_call_digit_end:
   Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
   Source Call Id=371, Digit=9, Duration=100,
   Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Aug  3 17:14:00.052: //371/7F9FA3C4837C/CCAPI/cc_api_call_digit_end:
   Call Entry(Handoff Depth=0)
Aug  3 17:14:00.252: //371/7F9FA3C4837C/CCAPI/cc_api_call_digit_begin:
   Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
   Source Call Id=371, Digit=9, DigitBeginFlags=0x0,
   Rtp Timestamp=0xA0EF38, Rtp Expiration=0x0
Aug  3 17:14:00.252: //371/7F9FA3C4837C/CCAPI/cc_api_call_digit_end:
   Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
   Source Call Id=371, Digit=9, Duration=100,
   Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Aug  3 17:14:00.252: //371/7F9FA3C4837C/CCAPI/cc_api_call_digit_end:
   Call Entry(Handoff Depth=0)
Aug  3 17:14:00.451: //371/7F9FA3C4837C/CCAPI/cc_api_call_digit_begin:
   Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
   Source Call Id=371, Digit=4, DigitBeginFlags=0x0,
   Rtp Timestamp=0xA16C38, Rtp Expiration=0x0
Aug  3 17:14:00.452: //371/7F9FA3C4837C/CCAPI/cc_api_call_digit_end:
   Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
   Source Call Id=371, Digit=4, Duration=100,
   Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Aug  3 17:14:00.452: //371/7F9FA3C4837C/CCAPI/cc_api_call_digit_end:
   Call Entry(Handoff Depth=0)
Aug  3 17:14:00.652: //371/7F9FA3C4837C/CCAPI/cc_api_call_digit_begin:
   Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
   Source Call Id=371, Digit=1, DigitBeginFlags=0x0,
   Rtp Timestamp=0xA1E938, Rtp Expiration=0x0
Aug  3 17:14:00.652: //371/7F9FA3C4837C/CCAPI/cc_api_call_digit_end:
   Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
   Source Call Id=371, Digit=1, Duration=100,
   Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Aug  3 17:14:00.652: //371/7F9FA3C4837C/CCAPI/cc_api_call_digit_end:
   Call Entry(Handoff Depth=0)
Aug  3 17:14:00.852: //371/7F9FA3C4837C/CCAPI/cc_api_call_digit_begin:
   Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
   Source Call Id=371, Digit=4, DigitBeginFlags=0x0,
   Rtp Timestamp=0xA26638, Rtp Expiration=0x0
Aug  3 17:14:00.852: //371/7F9FA3C4837C/CCAPI/cc_api_call_digit_end:
   Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
   Source Call Id=371, Digit=4, Duration=100,
   Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Aug  3 17:14:00.853: //371/7F9FA3C4837C/CCAPI/cc_api_call_digit_end:
   Call Entry(Handoff Depth=0)
Aug  3 17:14:01.052: //371/7F9FA3C4837C/CCAPI/cc_api_call_digit_begin:
   Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
   Source Call Id=371, Digit=5, DigitBeginFlags=0x0,
   Rtp Timestamp=0xA2E338, Rtp Expiration=0x0
Aug  3 17:14:01.052: //371/7F9FA3C4837C/CCAPI/cc_api_call_digit_end:
   Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
   Source Call Id=371, Digit=5, Duration=100,
   Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Aug  3 17:14:01.052: //371/7F9FA3C4837C/CCAPI/cc_api_call_digit_end:
   Call Entry(Handoff Depth=0)
Aug  3 17:14:01.052: //371/7F9FA3C4837C/CCAPI/ccCallReportDigits:
   (callID=0x173, digit_event=0x0, enable=FALSE, consume=FALSE)
Aug  3 17:14:01.052: //371/7F9FA3C4837C/CCAPI/ccCallReportDigits:
   Enabled=TRUE, Call Id=371
Aug  3 17:14:01.053: //371/7F9FA3C4837C/CCAPI/cc_api_call_report_digits_done:
   (vdbPtr=0x7FAAA61D95B8, callID=0x173, disp=0, digit_event=0x0, enable=FALSE, consume=FALSE)
Aug  3 17:14:01.053: //371/7F9FA3C4837C/CCAPI/cc_api_call_report_digits_done:
   Enabled=TRUE, Disposition=0x0, Interface=0x7FAAA61D95B8, Call Id=371
Aug  3 17:14:01.053: //371/7F9FA3C4837C/CCAPI/cc_api_call_report_digits_done:
   Call Entry(Initial Digit Timeout=15000(ms), Inter Digit Timeout=10000(ms))
Aug  3 17:14:01.053: //371/7F9FA3C4837C/CCAPI/ccCallProceeding:
   Progress Indication=NULL(0)
Aug  3 17:14:01.054: //371/7F9FA3C4837C/CCAPI/ccCallSetupRequest:
   Destination=, Calling IE Present=TRUE, Mode=0,
   Outgoing Dial-peer=99, Params=0x7FAAA71C0D40, Progress Indication=ORIGINATING SIDE IS NON ISDN(3)
Aug  3 17:14:01.054: //371/7F9FA3C4837C/CCAPI/ccCheckClipClir:
   In: Calling Number=0154007(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Aug  3 17:14:01.054: //371/7F9FA3C4837C/CCAPI/ccCheckClipClir:
   Out: Calling Number=0154007(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Aug  3 17:14:01.054: //371/7F9FA3C4837C/CCAPI/ccCallSetupRequest:
   Destination Pattern=099...., Called Number=4145, Digit Strip=FALSE
Aug  3 17:14:01.054: //371/7F9FA3C4837C/CCAPI/ccCallSetupRequest:
   Calling Number=0154007(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=4145(TON=Unknown, NPI=Unknown),
   Redirect Number=, Display Info=Server Room
   Account Number=, Final Destination Flag=FALSE,
   Guid=7F9FA3C4-1286-11ED-837C-DDAE5E19B77A, Outgoing Dial-peer=99
Aug  3 17:14:01.055: //371/7F9FA3C4837C/CCAPI/cc_api_display_ie_subfields:
   ccCallSetupRequest:
   cisco-username=
   ----- ccCallInfo IE subfields -----
   cisco-ani=0154007
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=4145
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=FFFFFFFFFFFFFFFF
   cisco-rdn=
   cisco-rdntype=0
   cisco-rdnplan=0
   cisco-rdnpi=0
   cisco-rdnsi=0
   cisco-redirectreason=0   fwd_final_type =0
   final_redirectNumber =
   hunt_group_timeout =0

Aug  3 17:14:01.055: //371/7F9FA3C4837C/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x7FAA9A2FDB80, Interface Type=3, Destination=, Mode=0x0,
   Call Params(Calling Number=0154007,(Calling Name=Server Room)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=4145(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=RegularLine, FinalDestinationFlag=FALSE, Outgoing Dial-peer=99, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
Aug  3 17:14:01.055: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Aug  3 17:14:01.055: :cc_get_feature_vsa malloc success
Aug  3 17:14:01.055: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Aug  3 17:14:01.055:  cc_get_feature_vsa count is 2
Aug  3 17:14:01.055: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Aug  3 17:14:01.055: :FEATURE_VSA attributes are: feature_name:0,feature_time:140370726551436,feature_id:342
Aug  3 17:14:01.056: //372/7F9FA3C4837C/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=3, FlowMode=1
Aug  3 17:14:01.056: //372/7F9FA3C4837C/CCAPI/ccCallSetContext:
   Context=0x7FAAA71C0CC0
Aug  3 17:14:01.056: //371/7F9FA3C4837C/CCAPI/ccSaveDialpeerTag:
   Outgoing Dial-peer=99
Aug  3 17:14:01.058: //372/7F9FA3C4837C/CCAPI/cc_api_call_disconnected:
   Cause Value=38, Interface=0x7FAA9A2FDB80, Call Id=372
Aug  3 17:14:01.058: //372/7F9FA3C4837C/CCAPI/cc_api_call_disconnected:
   Call Entry(Responsed=TRUE, Cause Value=38, Retry Count=0)
Aug  3 17:14:01.059: //371/7F9FA3C4837C/CCAPI/ccCallReleaseResources:
   release reserved xcoding resource.
Aug  3 17:14:01.059: //372/7F9FA3C4837C/CCAPI/ccCallSetAAA_Accounting:
   Accounting=0, Call Id=372
Aug  3 17:14:01.059: //372/7F9FA3C4837C/CCAPI/ccCallDisconnect:
   Cause Value=38, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=38)
Aug  3 17:14:01.059: //372/7F9FA3C4837C/CCAPI/ccCallDisconnect:
   Cause Value=38, Call Entry(Responsed=TRUE, Cause Value=38)
Aug  3 17:14:01.060: //372/7F9FA3C4837C/CCAPI/cc_api_call_disconnect_done:
   Disposition=-11, Interface=0x7FAA9A2FDB80, Tag=0x0, Call Id=372,
   Call Entry(Disconnect Cause=38, Voice Class Cause Code=0, Retry Count=0)
Aug  3 17:14:01.060: //372/7F9FA3C4837C/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
Aug  3 17:14:01.060: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Aug  3 17:14:01.060: :cc_free_feature_vsa freeing 7FAA9B4AFF80
Aug  3 17:14:01.060: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Aug  3 17:14:01.060:  vsacount in free is 1
Aug  3 17:14:01.060: //372/7F9FA3C4837C/SIP/Call/sipSPICallInfo:
The Call Setup Information is:
Call Control Block (CCB) : 0x0x7FAAA561F698
State of The Call        : STATE_DEAD
TCP Sockets Used         : YES
Calling Number           : 0154007
Called Number            : 4145
Source IP Address (Sig  ): 10.201.47.10
Destn SIP Req Addr:Port  : :0
Destn SIP Resp Addr:Port : :0
Destination Name         :

Aug  3 17:14:01.060: //372/7F9FA3C4837C/SIP/Call/sipSPIMediaCallInfo:
Number of Media Streams: 1
Media Stream             : 1
Negotiated Codec         : No Codec
Negotiated Codec Bytes   : 0
Nego. Codec payload      : 255 (tx), 255 (rx)
Negotiated Dtmf-relay    : 0
Dtmf-relay Payload       : 0 (tx), 0 (rx)
Source IP Address (Media): 10.201.47.10
Source IP Port    (Media): 8234
Destn  IP Address (Media):  -
Destn  IP Port    (Media): 0
Orig Destn IP Address:Port (Media): [ - ]:0

Aug  3 17:14:01.060: //372/7F9FA3C4837C/SIP/Call/sipSPICallInfo:
Disconnect Cause (CC)    : 38
Disconnect Cause (SIP)   : 200

Aug  3 17:14:01.061: //371/7F9FA3C4837C/CCAPI/ccCallDisconnect:
   Cause Value=38, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
Aug  3 17:14:01.061: //371/7F9FA3C4837C/CCAPI/ccCallDisconnect:
   Cause Value=38, Call Entry(Responsed=TRUE, Cause Value=38)
Aug  3 17:14:01.061: //371/7F9FA3C4837C/CCAPI/cc_api_get_transfer_info:
   Transfer Number=NULL
1575: Aug  3 17:14:01.852: //4294967295/xxxxxxxxxxxx/
------------------ Cover Buffer ---------------
Search-key       = ::NA
  Timestamp      = Aug  3 17:14:01.055
  CallID         = NA
  Peer-CallID    = NA
  Correlator     = NA
  Called-Number  =
  Calling-Number =
  SIP CallID     =
  SIP SessionID  =
  GUID           =
-----------------------------------------------
1558: Aug  3 17:14:01.056: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/MISC/Matched Dialpeer: Dir:Outbound, Peer-Tag:  99
1559: Aug  3 17:14:01.056: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/FSM/SPI-State-Change: Current State = STATE_NONE, Next State = STATE_IDLE, Current Sub-State = STATE_NONE, Next Sub-State = STATE_NONE
1560: Aug  3 17:14:01.056: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/FSM/IWF: Event = E_SIP_IWF_EV_SET_MODE, Current State = CNFSM_CONTAINER_STATE, Next State = CNFSM_NO_STATE_CHANGE
1561: Aug  3 17:14:01.058: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/API: voip_rtp_allocate_port (8234)
1562: Aug  3 17:14:01.058: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/API: cc_api_update_interface_cac_resource (0)
1563: Aug  3 17:14:01.058: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/FSM/Event-Action: Event = SIPSPI_EV_CC_CALL_SETUP, Current State = STATE_IDLE
1564: Aug  3 17:14:01.058: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/MISC/Call Disconnect: Initiated at: 0x1700E2B, Originated at:0x1700E29, Cause Code = 38
1565: Aug  3 17:14:01.058: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/API: cc_api_call_disconnected (0)
1566: Aug  3 17:14:01.058: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/FSM/SPI-State-Change: Current State = STATE_IDLE, Next State = STATE_DISCONNECTING, Current Sub-State = STATE_NONE, Next Sub-State = STATE_NONE
1567: Aug  3 17:14:01.060: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/MISC/Call Disconnect: Initiated at: 0x260070A, Originated at:0x260070B, Cause Code = 38
1568: Aug  3 17:14:01.059: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/API: cc_api_update_interface_cac_resource (0)
1569: Aug  3 17:14:01.059: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/FSM/Event-Action: Event = SIPSPI_EV_CC_CALL_DISCONNECT, Current State = STATE_DISCONNECTING
1570: Aug  3 17:14:01.059: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/API: voip_rtp_release_port (8234)
1571: Aug  3 17:14:01.060: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/API: cc_api_call_disconnect_done (0)
1572: Aug  3 17:14:01.060: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/FSM/SPI-State-Change: Current State = STATE_DISCONNECTING, Next State = STATE_DEAD, Current Sub-State = STATE_NONE, Next Sub-State = STATE_NONE
1573: Aug  3 17:14:01.060: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/MISC/Error: sipSPIFlushDeferredQueue: Invalid deferredQueue
1574: Aug  3 17:14:01.060: //4294967295/xxxxxxxxxxxx/CUBE_VT/SIP/API: voip_rtp_release_port (8234)
Aug  3 17:14:03.643: //371/7F9FA3C4837C/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x7FAAA61D95B8, Tag=0x0, Call Id=371,
   Call Entry(Disconnect Cause=38, Voice Class Cause Code=0, Retry Count=0)
Aug  3 17:14:03.643: //371/7F9FA3C4837C/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
Aug  3 17:14:03.644: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Aug  3 17:14:03.644: :cc_free_feature_vsa freeing 7FAA9B4B0060
Aug  3 17:14:03.644: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa: