*Jul 15 17:57:47.378: //-1/xxxxxxxxxxxx/H323/cch323_ct_main: SOCK 0 Event 0x1 *Jul 15 17:57:47.378: //-1/xxxxxxxxxxxx/H323/cch323_get_new_ccb: ccb (0x695041D8) is in use *Jul 15 17:57:47.390: //-1/xxxxxxxxxxxx/H323/cch323_ct_main: SOCK 2 Event 0x1 *Jul 15 17:57:47.390: //-1/xxxxxxxxxxxx/H323/cch323_gw_process_read_socket: owner_data=0x69776A64, len=637, msgPtr=0x697D4980 *Jul 15 17:57:47.390: //-1/xxxxxxxxxxxx/H323/cch323_gw_process_read_socket: Received msg for H.225 Q931 Message IE Decodes Protocol Discriminator : 0x08 CRV Length : 2 CRV Value : 0x3B82 Message Type : 0x05: SETUP Bearer Capability: Length Of IE=3 Data 8893A5 Display: Length Of IE=9 Data 67726964626F726700 Called Party Number: Length Of IE=11 Data 8134393234323832373630 User-User: Length Of IE=600 Data 0520B8060008914A000401400700670072006900640062006F0072006722C00900003D1D556E6971616C6C2C20496E632047726964626F72672053657276657200001C312E322E3828706174636 as5350xm#8352920284F50414C2076322E322E31290000000104807C575B5A9300C0A8011306B8000EF0438C43C5DB1193EA0014858BE9D800C51D80040700C0A80108EC49110070ED438C43C5DB1193EA0014858BE9D880F9061D400000060401004C601D80111C000100C0A80108138C00C0A80108138D130000640C601D800B0D000100C0A80108138D8020400000060401004E0C0300830080111C000100C0A80108138C00C0A80108138D160000650E0C03008300800B0D000100C0A80108138D804B400000060401004C10B500534C2A020000000000400100004001020008000000000031000100401F0000590600004100000002004001000080111C000100C0A80108138C00C0A80108138D410000660C10B500534C2A020000000000400100004001020008000000000031000100401F00005906000041000000020040010000800B0D000100C0A80108138D80010001000100010080AF0280A40270010600088175000B8013800064000100000100000100000CC0010001800680000020C0EF80000124180300E6008000022020B500534C2A020000000000400100004001020008000000000031000100401F000059060000410000000200400100008000034A0811860100805C0100014007C00200C80148400090800004830150800005830110800006830140008001030200000001000200000300000401000500060701003280BEEE6602800180 *Jul 15 17:57:47.394: //-1/xxxxxxxxxxxx/H323/cch323_extract_signaled_carriers: Entry *Jul 15 17:57:47.394: //4217/0EF0438C93EA/H323/cch323_determine_source_ip_group_info: No Source IP group match with Src CarrierId/Zone ID *Jul 15 17:57:47.394: //4217/0EF0438C93EA/H323/cch323_determine_source_ip_group_info: No Source IP group matched with rte id/zone_id/acl *Jul 15 17:57:47.394: //-1/xxxxxxxxxxxx/H323/cch323_determine_source_group: Entry *Jul 15 17:57:47.394: //4217/0EF0438C93EA/H323/cch323_determine_source_ip_group_info: No Source IP group match with Incoming Called Number *Jul 15 17:57:47.394: //4217/0EF0438C93EA/H323/cch323_determine_source_ip_group_info: No Source IP group match with Destination pattern *Jul 15 17:57:47.394: //-1/xxxxxxxxxxxx/H323/cch323_associate_incoming_peer: timeout = 1, reason = -1 *Jul 15 17:57:47.394: H245 FS OLC INCOMING ENCODE BUFFER::= 400000060401004C601D80111C000100C0A80108138C00C0A80108138D *Jul 15 17:57:47.394: *Jul 15 17:57:47.394: H245 FS OLC INCOMING PDU ::= value OpenLogicalChannel ::= { forwardLogicalChannelNumber 1 forwardLogicalChannelParameters { dataType nullData : NULL multiplexParameters none : NULL } reverseLogicalChannelParameters { dataType audioData : g711Ulaw64k : 30 multiplexParameters h2250LogicalChannelParameters : { sessionID 1 mediaChannel unicastAddress : iPAddress : { network 'C0A80108'H tsapIdentifier 5004 } mediaGuaranteedDelivery FALSE mediaControlChannel unicastAddress : iPAddress : { network 'C0A80108'H tsapIdentifier 5005 } } } } *Jul 15 17:57:47.394: H245 FS OLC INCOMING ENCODE BUFFER::= 0000640C601D800B0D000100C0A80108138D80 *Jul 15 17:57:47.394: *Jul 15 17:57:47.394: H245 FS OLC INCOMING PDU ::= value OpenLogicalChannel ::= { forwardLogicalChannelNumber 101 forwardLogicalChannelParameters { dataType audioData : g711Ulaw64k : 30 multiplexParameters h2250LogicalChannelParameters : { sessionID 1 mediaGuaranteedDelivery FALSE mediaControlChannel unicastAddress : iPAddress : { network 'C0A80108'H tsapIdentifier 5005 } silenceSuppression TRUE } } } *Jul 15 17:57:47.394: H245 FS OLC INCOMING ENCODE BUFFER::= 400000060401004E0C0300830080111C000100C0A80108138C00C0A80108138D *Jul 15 17:57:47.394: *Jul 15 17:57:47.394: H245 FS OLC INCOMING PDU ::= value OpenLogicalChannel ::= { forwardLogicalChannelNumber 1 forwardLogicalChannelParameters { dataType nullData : NULL multiplexParameters none : NULL } reverseLogicalChannelParameters { dataType audioData : gsmFullRate : { audioUnitSize 132 comfortNoise FALSE scrambled FALSE } multiplexParameters h2250LogicalChannelParameters : { sessionID 1 mediaChannel unicastAddress : iPAddress : { network 'C0A80108'H tsapIdentifier 5004 } mediaGuaranteedDelivery FALSE mediaControlChannel unicastAddress : iPAddress : { network 'C0A80108'H tsapIdentifier 5005 } } } } *Jul 15 17:57:47.394: H245 FS OLC INCOMING ENCODE BUFFER::= 0000650E0C03008300800B0D000100C0A80108138D80 *Jul 15 17:57:47.394: *Jul 15 17:57:47.394: H245 FS OLC INCOMING PDU ::= value OpenLogicalChannel ::= { forwardLogicalChannelNumber 102 forwardLogicalChannelParameters { dataType audioData : gsmFullRate : { audioUnitSize 132 comfortNoise FALSE scrambled FALSE } multiplexParameters h2250LogicalChannelParameters : { sessionID 1 mediaGuaranteedDelivery FALSE mediaControlChannel unicastAddress : iPAddress : { network 'C0A80108'H tsapIdentifier 5005 } silenceSuppression TRUE } } } *Jul 15 17:57:47.394: H245 FS OLC INCOMING ENCODE BUFFER::= 400000060401004C10B500534C2A020000000000400100004001020008000000000031000100401F0000590600004100000002004001000080111C000100C0A80108138C00C0A80108138D *Jul 15 17:57:47.394: *Jul 15 17:57:47.394: H245 FS OLC INCOMING PDU ::= value OpenLogicalChannel ::= { forwardLogicalChannelNumber 1 forwardLogicalChannelParameters { dataType nullData : NULL multiplexParameters none : NULL } reverseLogicalChannelParameters { dataType audioData : nonStandard : { nonStandardIdentifier h221NonStandard : { t35CountryCode 181 t35Extension 0 manufacturerCode 21324 } data '0200000000004001000040010200080000000000...'H } multiplexParameters h2250LogicalChannelParameters : { sessionID 1 mediaChannel unicastAddress : iPAddress : { network 'C0A80108'H tsapIdentifier 5004 } mediaGuaranteedDelivery FALSE mediaControlChannel unicastAddress : iPAddress : { network 'C0A80108'H tsapIdentifier 5005 } } } } *Jul 15 17:57:47.398: H245 FS OLC INCOMING ENCODE BUFFER::= 0000660C10B500534C2A020000000000400100004001020008000000000031000100401F00005906000041000000020040010000800B0D000100C0A80108138D80 *Jul 15 17:57:47.398: *Jul 15 17:57:47.398: H245 FS OLC INCOMING PDU ::= value OpenLogicalChannel ::= { forwardLogicalChannelNumber 103 forwardLogicalChannelParameters { dataType audioData : nonStandard : { nonStandardIdentifier h221NonStandard : { t35CountryCode 181 t35Extension 0 manufacturerCode 21324 } data '0200000000004001000040010200080000000000...'H } multiplexParameters h2250LogicalChannelParameters : { sessionID 1 mediaGuaranteedDelivery FALSE mediaControlChannel unicastAddress : iPAddress : { network 'C0A80108'H tsapIdentifier 5005 } silenceSuppression TRUE } } } *Jul 15 17:57:47.398: //4217/0EF0438C93EA/H323/cch323_selectFastStart_codecs: Codec: loc(10), rem(10); Bytes: loc(33), Fwd(132), Rev(132) *Jul 15 17:57:47.398: //4217/0EF0438C93EA/H323/cch323_update_faststart_media_info: Remote qosCapability 0 *Jul 15 17:57:47.398: //4217/0EF0438C93EA/H323/process_fastStart_setup_for_qos: This seems to be a normal call with Sync OFF; just do a generic notify *Jul 15 17:57:47.398: //-1/xxxxxxxxxxxx/H323/cch323_associate_incoming_peer: timeout = 1, reason = -1 *Jul 15 17:57:47.398: //4217/0EF0438C93EA/H323/h323_gw_setup_ind: is_overlap = 0, info_complete = 0 *Jul 15 17:57:47.398: //-1/0EF0438C93EA/CCAPI/cc_api_display_ie_subfields: cc_api_call_setup_ind_common: cisco-username=gridborg ----- ccCallInfo IE subfields ----- cisco-ani= cisco-anitype=0 cisco-aniplan=0 cisco-anipi=0 cisco-anisi=0 dest=4924282760 cisco-desttype=0 cisco-destplan=1 cisco-rdie=FFFFFFFF cisco-rdn= cisco-rdntype=-1 cisco-rdnplan=-1 cisco-rdnpi=-1 cisco-rdnsi=-1 cisco-redirectreason=-1 fwd_final_type =0 final_redirectNumber = hunt_group_timeout =0 *Jul 15 17:57:47.398: //-1/0EF0438C93EA/CCAPI/cc_api_call_setup_ind_common: Interface=0x65B7E95C, Call Info( Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed), Called Number=4924282760(TON=Unknown, NPI=ISDN), Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Incoming Dial-peer=0, Progress Indication=NULL(0), Calling IE Present=FALSE, Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=4217 *Jul 15 17:57:47.398: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: *Jul 15 17:57:47.398: :cc_get_feature_vsa malloc success *Jul 15 17:57:47.398: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: *Jul 15 17:57:47.398: cc_get_feature_vsa count is 1 *Jul 15 17:57:47.398: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: *Jul 15 17:57:47.398: :FEATURE_VSA attributes are: feature_name:0,fearture_time:1705140048,feature_id:1871 *Jul 15 17:57:47.398: //4217/0EF0438C93EA/CCAPI/cc_api_call_setup_ind_common: Set Up Event Sent; Call Info(Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed), Called Number=4924282760(TON=Unknown, NPI=ISDN)) *Jul 15 17:57:47.398: //-1/xxxxxxxxxxxx/H323/cch323_create_call_info_type_container: cch323_create_call_info_type_container: creating callInfoType container for callID = 4217 *Jul 15 17:57:47.398: //4217/0EF0438C93EA/H323/cch323_update_carriers_in_call_info: tg_label_flag 0x0 *Jul 15 17:57:47.398: //4217/0EF0438C93EA/CCAPI/cc_process_call_setup_ind: Event=0x65A39B18 *Jul 15 17:57:47.398: //4217/0EF0438C93EA/CCAPI/ccCallSetContext: Context=0x66B9A0A4 *Jul 15 17:57:47.398: //4217/0EF0438C93EA/CCAPI/cc_process_call_setup_ind: >>>>CCAPI handed cid 4217 with tag 0 to app "_ManagedAppProcess_Default" *Jul 15 17:57:47.398: //4217/0EF0438C93EA/CCAPI/ccCallProceeding: Progress Indication=NULL(0) *Jul 15 17:57:47.398: //4217/0EF0438C93EA/CCAPI/ccCallSetupRequest: Destination=, Calling IE Present=FALSE, Mode=0, Outgoing Dial-peer=100, Params=0x66B9438C, Progress Indication=NULL(0) *Jul 15 17:57:47.398: //4217/0EF0438C93EA/CCAPI/ccCheckClipClir: In: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed) *Jul 15 17:57:47.398: //4217/0EF0438C93EA/CCAPI/ccCheckClipClir: Out: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed) *Jul 15 17:57:47.398: //4217/0EF0438C93EA/CCAPI/ccCallSetupRequest: Destination Pattern=49T, Called Number=4924282760, Digit Strip=FALSE *Jul 15 17:57:47.398: //4217/0EF0438C93EA/CCAPI/ccCallSetupRequest: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed), Called Number=4924282760(TON=Unknown, NPI=ISDN), Redirect Number=, Display Info=gridborg Account Number=gridborg, Final Destination Flag=TRUE, Guid=0EF0438C-43C5-DB11-93EA-0014858BE9D8, Outgoing Dial-peer=100 *Jul 15 17:57:47.398: //4217/0EF0438C93EA/CCAPI/cc_api_display_ie_subfields: ccCallSetupRequest: cisco-username=gridborg ----- ccCallInfo IE subfields ----- cisco-ani= cisco-anitype=0 cisco-aniplan=0 cisco-anipi=0 cisco-anisi=0 dest=4924282760 cisco-desttype=0 cisco-destplan=1 cisco-rdie=FFFFFFFF cisco-rdn= cisco-rdntype=-1 cisco-rdnplan=-1 cisco-rdnpi=-1 cisco-rdnsi=-1 cisco-redirectreason=-1 fwd_final_type =0 final_redirectNumber = hunt_group_timeout =0 *Jul 15 17:57:47.398: //4217/0EF0438C93EA/CCAPI/ccIFCallSetupRequestPrivate: Interface=0x6576079C, Interface Type=6, Destination=, Mode=0x0, Call Params(Calling Number=,(Calling Name=gridborg)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed), Called Number=4924282760(TON=Unknown, NPI=ISDN), Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=100, Call Count On=FALSE, Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=) *Jul 15 17:57:47.398: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: *Jul 15 17:57:47.398: :cc_get_feature_vsa malloc success *Jul 15 17:57:47.398: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: *Jul 15 17:57:47.398: cc_get_feature_vsa count is 2 *Jul 15 17:57:47.398: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: *Jul 15 17:57:47.398: :FEATURE_VSA attributes are: feature_name:0,fearture_time:1705138968,feature_id:1872 *Jul 15 17:57:47.402: //4218/0EF0438C93EA/CCAPI/ccIFCallSetupRequestPrivate: SPI Call Setup Request Is Success; Interface Type=6, FlowMode=1 *Jul 15 17:57:47.402: //4218/0EF0438C93EA/CCAPI/ccCallSetContext: Context=0x66B9433C *Jul 15 17:57:47.402: //4217/0EF0438C93EA/CCAPI/ccSaveDialpeerTag: Outgoing Dial-peer=100 *Jul 15 17:57:47.402: //4217/0EF0438C93EA/H323/cch323_do_set_dialpeer_tag: gw_id=1 *Jul 15 17:57:47.402: //4217/0EF0438C93EA/H323/cch323_do_call_proceeding: gw_id=1 *Jul 15 17:57:47.402: //4217/0EF0438C93EA/H323/cch323_prepare_fastStart_cap_response: Retrieved qosCapability of 0 *Jul 15 17:57:47.402: //4217/0EF0438C93EA/H323/cch323_prepare_fastStart_cap_response: Filling in qosCapability field to 0 *Jul 15 17:57:47.402: H245 FS OLC OUTGOING PDU ::= value OpenLogicalChannel ::= { forwardLogicalChannelNumber 102 forwardLogicalChannelParameters { dataType audioData : gsmFullRate : { audioUnitSize 33 comfortNoise FALSE scrambled FALSE } multiplexParameters h2250LogicalChannelParameters : { sessionID 1 mediaChannel unicastAddress : iPAddress : { network 'C0A80113'H tsapIdentifier 19730 } mediaControlChannel unicastAddress : iPAddress : { network 'C0A80113'H tsapIdentifier 19731 } silenceSuppression TRUE } } } *Jul 15 17:57:47.402: H245 FS OLC OUTGOING ENCODE BUFFER::= 0000650E0C03002000801215000100C0A801134D1200C0A801134D1380 *Jul 15 17:57:47.402: *Jul 15 17:57:47.402: H245 FS OLC OUTGOING PDU ::= value OpenLogicalChannel ::= { forwardLogicalChannelNumber 1 forwardLogicalChannelParameters { dataType nullData : NULL multiplexParameters none : NULL } reverseLogicalChannelParameters { dataType audioData : gsmFullRate : { audioUnitSize 33 comfortNoise FALSE scrambled FALSE } multiplexParameters h2250LogicalChannelParameters : { sessionID 1 mediaChannel unicastAddress : iPAddress : { network 'C0A80108'H tsapIdentifier 5004 } mediaControlChannel unicastAddress : iPAddress : { network 'C0A80113'H tsapIdentifier 19731 } silenceSuppression TRUE } } } *Jul 15 17:57:47.402: H245 FS OLC OUTGOING ENCODE BUFFER::= 400000060401004E0C03002000801215000100C0A80108138C00C0A801134D1380 *Jul 15 17:57:47.402: *Jul 15 17:57:47.402: //4217/0EF0438C93EA/H323/h323_open_rtp_stream: Media In-active notification object not attached to ccb *Jul 15 17:57:47.402: //4217/0EF0438C93EA/H323/cch323_set_dtmf_iw_enabled: negotiated dtmf relay: 0, dtmf_iw_enabled: 0, dtmf_sccp_enabled: 0 *Jul 15 17:57:47.402: //4217/0EF0438C93EA/H323/cch323_rtp_open_notify: Entry *Jul 15 17:57:47.402: //4217/0EF0438C93EA/H323/cch323_do_call_proceeding: gw_id=1 Q931 Message IE Decodes Protocol Discriminator : 0x08 CRV Length : 2 CRV Value : 0xBB82 Message Type : 0x02: CALL_PROC User-User: Length Of IE=117 Data 052180060008914A00042800B500001240013C050100044700110070ED438C43C5DB1193EA0014858BE9D841021D0000650E0C03002000801215000100C0A801134D1200C0A801134D138021400000060401004E0C03002000801215000100C0A80108138C00C0A801134D13800100010010800180 *Jul 15 17:57:47.402: ISDN Se2/1:23 EVENT: process_pri_call: call id 0x8128, number 24282760, Guid 0EF0438C93EA, speed 0, call type VOICE, redial No, CSM call No, pdata Yes *Jul 15 17:57:47.406: ISDN Se2/1:23 Q931: Applying typeplan for sw-type 0x5 is 0x2 0x1, Called num 24282760 *Jul 15 17:57:47.406: ISDN Se2/1:23 Q931: TX -> SETUP pd = 8 callref = 0x01A5 Bearer Capability i = 0x8090A2 Standard = CCITT Transfer Capability = Speech Transfer Mode = Circuit Transfer Rate = 64 kbit/s Channel ID i = 0xA98397 Exclusive, Channel 23 Display i = 0xB1, 'gridborg' Called Party Number i = 0xA1, '24282760' Plan:ISDN, Type:National *Jul 15 17:57:47.446: ISDN Se2/1:23 Q931: RX <- STATUS pd = 8 callref = 0x81A5 Cause i = 0x83AB28 - Access information discarded Call State i = 0x01 *Jul 15 17:57:47.646: ISDN Se2/1:23 Q931: RX <- CALL_PROC pd = 8 callref = 0x81A5 Channel ID i = 0xE9808317 Exclusive, Interface 0, Channel 23 *Jul 15 17:57:47.646: ISDN Se2/1:23 EVENT: process_rxstate: ces/callid 1/0x8128 calltype 2 CALL_PROCEEDING *Jul 15 17:57:47.650: //4218/0EF0438C93EA/CCAPI/cc_api_call_proceeding: Interface=0x6576079C, Progress Indication=NULL(0) *Jul 15 17:57:48.646: ISDN Se2/1:23 Q931: RX <- ALERTING pd = 8 callref = 0x81A5 Progress Ind i = 0x8082 - Destination address is non-ISDN *Jul 15 17:57:48.646: ISDN Se2/1:23 EVENT: process_rxstate: ces/callid 1/0x8128 calltype 2 CALL_PROGRESS *Jul 15 17:57:48.646: //4218/0EF0438C93EA/CCAPI/cc_api_call_alert: Interface=0x6576079C, Progress Indication=DESTINATION IS NON ISDN(2), Signal Indication=SIGNAL RINGBACK(1) *Jul 15 17:57:48.646: //4218/0EF0438C93EA/CCAPI/cc_api_call_alert: Call Entry(Retry Count=0, Responsed=TRUE) *Jul 15 17:57:48.646: //4217/0EF0438C93EA/CCAPI/ccCallAlert: Progress Indication=DESTINATION IS NON ISDN(2), Signal Indication=SIGNAL RINGBACK(1) *Jul 15 17:57:48.646: //4217/0EF0438C93EA/CCAPI/ccCallAlert: Call Entry(Responsed=TRUE, AlertSent=TRUE) *Jul 15 17:57:48.646: //4218/0EF0438C93EA/CCAPI/cc_api_get_called_ccm_detected: CallInfo(ccm detected=0) *Jul 15 17:57:48.646: //4217/xxxxxxxxxxxx/CCAPI/ccConferenceCreate: (confID=0x66B7E2AC, callID1=0x1079, callID2=0x107A, tag=0x0) *Jul 15 17:57:48.646: //4217/0EF0438C93EA/CCAPI/ccConferenceCreate: Conference Id=0x66B7E2AC, Call Id1=4217, Call Id2=4218, Tag=0x0 *Jul 15 17:57:48.650: //4217/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream: *Jul 15 17:57:48.650: cc_api_get_xcode_stream : 4328 *Jul 15 17:57:48.650: //4217/xxxxxxxxxxxx/CCAPI/cc_api_bridge_done: Conference Id=0x1E7, Source Interface=0x65B7E95C, Source Call Id=4217, Destination Call Id=4218, Disposition=0x0, Tag=0x0 *Jul 15 17:57:48.650: //4218/xxxxxxxxxxxx/CCAPI/cc_api_bridge_done: Conference Id=0x1E7, Source Interface=0x6576079C, Source Call Id=4218, Destination Call Id=4217, Disposition=0x0, Tag=0xFFFFFFFF *Jul 15 17:57:48.650: //4217/0EF0438C93EA/CCAPI/cc_generic_bridge_done: Conference Id=0x1E7, Source Interface=0x6576079C, Source Call Id=4218, Destination Call Id=4217, Disposition=0x0, Tag=0xFFFFFFFF *Jul 15 17:57:48.650: //4217/0EF0438C93EA/CCAPI/ccConferenceCreate: Call Entry(Conference Id=0x1E7, Destination Call Id=4218) *Jul 15 17:57:48.650: //4218/0EF0438C93EA/CCAPI/ccConferenceCreate: Call Entry(Conference Id=0x1E7, Destination Call Id=4217) *Jul 15 17:57:48.650: //4218/0EF0438C93EA/CCAPI/cc_api_caps_ind: Destination Interface=0x65B7E95C, Destination Call Id=4217, Source Call Id=4218, Caps(Codec=0x1, Fax Rate=0x1, Vad=0x1, Modem=0x2, Codec Bytes=20, Signal Type=3) *Jul 15 17:57:48.650: //4218/0EF0438C93EA/CCAPI/cc_api_caps_ind: Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms), Playout Max=250(ms), Fax Nom=300(ms)) *Jul 15 17:57:48.650: //4217/0EF0438C93EA/H323/cch323_call_alert: gw_id=1 *Jul 15 17:57:48.650: //4217/0EF0438C93EA/CCAPI/cc_api_get_delay_xport: CallInfo(delay xport=FALSE) *Jul 15 17:57:48.650: //4217/0EF0438C93EA/H323/cch323_put_embedded_obj_to_ccb: ccb=0x695041D8, tag=18, size=83 *Jul 15 17:57:48.650: //4217/0EF0438C93EA/H323/cch323_put_embedded_obj_to_ccb: Insertion PASSED, embedded at 0x636A8FAC *Jul 15 17:57:48.650: //-1/xxxxxxxxxxxx/H323/cch323_call_alert: stored alert data display_info in ccb *Jul 15 17:57:48.650: //-1/xxxxxxxxxxxx/H323/cch323_iev_queue_service: Dispatch 0x1 internal event to H225 SM *Jul 15 17:57:48.650: //4217/0EF0438C93EA/H323/cch323_get_embedded_obj_from_ccb: ccb=0x695041D8, tag=18, size=83 *Jul 15 17:57:48.650: //4217/0EF0438C93EA/H323/cch323_get_embedded_obj_from_ccb: Extraction PASSED from 0x636A8FAC Q931 Message IE Decodes Protocol Discriminator : 0x08 CRV Length : 2 CRV Value : 0xBB82 Message Type : 0x01: ALERTING Progress Ind: Length Of IE=2 Data 8082 Display: Length Of IE=0 Data Signal: Length Of IE=1 Data 01 User-User: Length Of IE=145 Data 052380060008914A00042800B500001240013C05010006C300110070ED438C43C5DB1193EA0014858BE9D80100010010A801803A0140B50000123360010400011E2C1E0280821C269E8100036774640000001B41434D2C0D0A50524E2C6973646E2A2C2C4E543130302C0D0A0D0A224204677464011B41434D2C0D0A50524E2C6973646E2A2C2C4E543130302C0D0A0D0A *Jul 15 17:57:48.650: //4217/0EF0438C93EA/H323/cch323_set_dtmf_iw_enabled: negotiated dtmf relay: 0, dtmf_iw_enabled: 0, dtmf_sccp_enabled: 0 *Jul 15 17:57:48.650: //4217/0EF0438C93EA/H323/cch323_rtp_open_notify: Entry *Jul 15 17:57:48.650: //4217/0EF0438C93EA/H323/cch323_caps_ind: gw_id=1 *Jul 15 17:57:48.650: //4217/0EF0438C93EA/H323/cch323_peer_caps_ind_common: Load DSP with Negotiated (No DP match) codec(10) gsmfr, Bytes=33 *Jul 15 17:57:48.650: //4217/0EF0438C93EA/H323/cch323_peer_caps_ind_common: Set DSP for dtmf-relay = CC_CAP_DTMF_RELAY_INBAND_VOICE *Jul 15 17:57:48.650: //4217/0EF0438C93EA/H323/cch323_peer_caps_ind_common: cap_modem_proto: 0, cap_modem_codec: 0, cap_modem_redundancy: 0, payload: 100, modem_relay: 0, gw_xid: 1 gw_controlled=0 *Jul 15 17:57:48.650: //4217/0EF0438C93EA/CCAPI/cc_api_caps_ind: Destination Interface=0x6576079C, Destination Call Id=4218, Source Call Id=4217, Caps(Codec=0x400, Fax Rate=0x2, Vad=0x2, Modem=0x0, Codec Bytes=33, Signal Type=2) *Jul 15 17:57:48.650: //4217/0EF0438C93EA/CCAPI/cc_api_caps_ind: Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms), Playout Max=250(ms), Fax Nom=300(ms)) *Jul 15 17:57:48.650: //4217/0EF0438C93EA/CCAPI/cc_api_caps_ack: Destination Interface=0x6576079C, Destination Call Id=4218, Source Call Id=4217, Caps(Codec=gsmfr(0x400), Fax Rate=FAX_RATE_VOICE(0x2), Vad=ON(0x2), Modem=OFF(0x0), Codec Bytes=33, Signal Type=2, Seq Num Start=0) *Jul 15 17:57:48.650: //4218/0EF0438C93EA/CCAPI/cc_api_caps_ack: Destination Interface=0x65B7E95C, Destination Call Id=4217, Source Call Id=4218, Caps(Codec=gsmfr(0x400), Fax Rate=FAX_RATE_VOICE(0x2), Vad=ON(0x2), Modem=OFF(0x0), Codec Bytes=33, Signal Type=2, Seq Num Start=0) *Jul 15 17:57:48.650: //4217/0EF0438C93EA/CCAPI/cc_process_notify_bridge_done: Conference Id=0x1E7, Call Id1=4217, Call Id2=4218 *Jul 15 17:57:48.650: %HPI-3-FAILED_START: channel:2/1:D (4218) DSP ID:0x1, failed mode 1 for service 19 -Traceback= 0x6053A50C 0x61FB4190 0x619ABBF4 0x61883174 0x614511C0 0x614515A0 0x6186E9E4 0x6186EF34 *Jul 15 17:57:48.650: //4218/0EF0438C93EA/CCAPI/cc_api_call_disconnected: Cause Value=172, Interface=0x6576079C, Call Id=4218 *Jul 15 17:57:48.650: //4218/0EF0438C93EA/CCAPI/cc_api_call_disconnected: Call Entry(Responsed=TRUE, Cause Value=172, Retry Count=0) *Jul 15 17:57:48.650: //4217/xxxxxxxxxxxx/CCAPI/ccCallReleaseResources: release reserved xcoding resource. *Jul 15 17:57:48.654: //4218/0EF0438C93EA/CCAPI/ccCallSetAAA_Accounting: Accounting=0, Call Id=4218 *Jul 15 17:57:48.654: //4217/0EF0438C93EA/CCAPI/ccConferenceDestroy: Conference Id=0x1E7, Tag=0x0 *Jul 15 17:57:48.654: //4217/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done: Conference Id=0x1E7, Source Interface=0x65B7E95C, Source Call Id=4217, Destination Call Id=4218, Disposition=0x0, Tag=0x0 *Jul 15 17:57:48.654: //4218/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done: Conference Id=0x1E7, Source Interface=0x6576079C, Source Call Id=4218, Destination Call Id=4217, Disposition=0x0, Tag=0x0 *Jul 15 17:57:48.654: //4217/0EF0438C93EA/CCAPI/cc_generic_bridge_done: Conference Id=0x1E7, Source Interface=0x6576079C, Source Call Id=4218, Destination Call Id=4217, Disposition=0x0, Tag=0x0 *Jul 15 17:57:48.654: //4218/0EF0438C93EA/CCAPI/ccCallDisconnect: Cause Value=172, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=172) *Jul 15 17:57:48.654: //4218/0EF0438C93EA/CCAPI/ccCallDisconnect: Cause Value=172, Call Entry(Responsed=TRUE, Cause Value=172) *Jul 15 17:57:48.654: ISDN Se2/1:23 Q931: TX -> DISCONNECT pd = 8 callref = 0x01A5 Cause i = 0x80AC - Requested circuit/channel not available *Jul 15 17:57:48.746: ISDN Se2/1:23 Q931: RX <- RELEASE pd = 8 callref = 0x81A5 *Jul 15 17:57:48.746: ISDN Se2/1:23 EVENT: process_rxstate: ces/callid 1/0x8128 calltype 2 CALL_CLEARED *Jul 15 17:57:48.746: ISDN Se2/1:23 Q931: TX -> RELEASE_COMP pd = 8 callref = 0x01A5 *Jul 15 17:57:48.750: //4218/0EF0438C93EA/CCAPI/cc_api_call_disconnect_done: Disposition=0, Interface=0x6576079C, Tag=0x0, Call Id=4218, Call Entry(Disconnect Cause=172, Voice Class Cause Code=0, Retry Count=0) *Jul 15 17:57:48.750: //4218/0EF0438C93EA/CCAPI/cc_api_call_disconnect_done: Call Disconnect Event Sent *Jul 15 17:57:48.750: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa: *Jul 15 17:57:48.750: :cc_free_feature_vsa freeing 65A25B10 *Jul 15 17:57:48.750: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa: *Jul 15 17:57:48.750: vsacount in free is 1 *Jul 15 17:57:48.750: //4217/0EF0438C93EA/CCAPI/ccCallDisconnect: Cause Value=172, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0) *Jul 15 17:57:48.750: //4217/0EF0438C93EA/CCAPI/ccCallDisconnect: Cause Value=172, Call Entry(Responsed=TRUE, Cause Value=172) *Jul 15 17:57:48.750: //4217/0EF0438C93EA/CCAPI/cc_api_get_transfer_info: Transfer Number Is Null *Jul 15 17:57:48.750: //4217/0EF0438C93EA/H323/cch323_do_call_disconnect: gw_id=1, discCause=172 *Jul 15 17:57:48.750: //-1/xxxxxxxxxxxx/H323/cch323_iev_queue_service: Dispatch 0x9 internal event to H225 SM Q931 Message IE Decodes Protocol Discriminator : 0x08 CRV Length : 2 CRV Value : 0xBB82 Message Type : 0x5A: RELEASE_COMP Cause: Length Of IE=2 Data 80AC User-User: Length Of IE=34 Data 052580060008914A00041100110070ED438C43C5DB1193EA0014858BE9D810800180 *Jul 15 17:57:48.762: //-1/xxxxxxxxxxxx/H323/cch323_ct_main: SOCK 2 Event 0x1 *Jul 15 17:57:48.762: //-1/xxxxxxxxxxxx/H323/cch323_gw_process_read_socket: owner_data=0x69776A64, len=50, msgPtr=0x696D926C *Jul 15 17:57:48.762: //-1/xxxxxxxxxxxx/H323/cch323_gw_process_read_socket: Received msg for H.225 Q931 Message IE Decodes Protocol Discriminator : 0x08 CRV Length : 2 CRV Value : 0x3B82 Message Type : 0x5A: RELEASE_COMP Cause: Length Of IE=2 Data 80AC User-User: Length Of IE=38 Data 052580060008914A000401110070ED438C43C5DB1193EA0014858BE9D804C001800401024A40 *Jul 15 17:57:48.762: //4217/0EF0438C93EA/H323/cch323_call_generic_cleanup: Disconnected flag 1 *Jul 15 17:57:48.762: //4217/0EF0438C93EA/H323/cch323_store_call_history_entry: Trying to store call history/remove call_info while RTP session exists *Jul 15 17:57:48.762: //4217/0EF0438C93EA/H323/cch323_store_call_history_entry: Call Active Playout Mode: 0,Init 0, Min 0, Max 0, Fax 0 *Jul 15 17:57:48.762: //4217/0EF0438C93EA/H323/cch323_store_call_history_entry: Call History Playout Mode: 0,Init 0, Min 0, Max 0, Fax 0 *Jul 15 17:57:48.762: //-1/xxxxxxxxxxxx/H323/h323_gw_clean_send_blocked_watch: fd 2 *Jul 15 17:57:48.762: //-1/xxxxxxxxxxxx/H323/cch323_cleanup_xport: hashDestroy for TcpFDTbl *Jul 15 17:57:48.762: //4217/0EF0438C93EA/CCAPI/cc_api_call_disconnect_done: Disposition=0, Interface=0x65B7E95C, Tag=0x0, Call Id=4217, Call Entry(Disconnect Cause=172, Voice Class Cause Code=0, Retry Count=0) *Jul 15 17:57:48.762: //4217/0EF0438C93EA/CCAPI/cc_api_call_disconnect_done: Call Disconnect Event Sent *Jul 15 17:57:48.762: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa: *Jul 15 17:57:48.762: :cc_free_feature_vsa freeing 65A25F48 *Jul 15 17:57:48.762: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa: *Jul 15 17:57:48.762: vsacount in free is 0 *Jul 15 17:57:48.762: //-1/xxxxxxxxxxxx/H323/cch323_call_generic_cleanup: Freeing ccb (0x695041D8) as5350xm# as5350xm#