=~=~=~=~=~=~=~=~=~=~=~= PuTTY log 2019.04.10 21:07:30 =~=~=~=~=~=~=~=~=~=~=~=
termi moni
PRI-VGW-CoreB#
PRI-VGW-CoreB#
PRI-VGW-CoreB#
PRI-VGW-CoreB#debug voip ccapi inout
voip ccapi inout debugging is on
PRI-VGW-CoreB#
PRI-VGW-CoreB#debug h225 asn1
H.225 ASN1 Messages debugging is on
PRI-VGW-CoreB#
PRI-VGW-CoreB#debug h245 asn1
H.245 ASN1 Messages debugging is on
PRI-VGW-CoreB#
PRI-VGW-CoreB#debug cch323 all
All CCH323 call tracing is enabled
PRI-VGW-CoreB#
PRI-VGW-CoreB#debug ip tcp transaction
TCP special event debugging is on
PRI-VGW-CoreB#
PRI-VGW-CoreB#
PRI-VGW-CoreB#
PRI-VGW-CoreB#
PRI-VGW-CoreB#
PRI-VGW-CoreB#termi moni
PRI-VGW-CoreB#
*Apr 10 19:20:43.142: TCP0: keepalive timeout (0/2)
PRI-VGW-CoreB#
*Apr 10 19:20:56.446: TCB7F2FA81CDA68 created
*Apr 10 19:20:56.446: TCP0: state was LISTEN -> SYNRCVD [1720 -> 10.220.128.16(32810)]
*Apr 10 19:20:56.446: TCP: tcb 7F2FA81CDA68 connection to 10.220.128.16:32810, peer MSS 1460, MSS is 516
*Apr 10 19:20:56.446: TCP: Selective ack is disabled from the CLI
*Apr 10 19:20:56.446: TCP: sending SYN, seq 3710575507, ack 2902346710
*Apr 10 19:20:56.446: TCP0: Connection to 10.220.128.16:32810, advertising MSS 1460
*Apr 10 19:20:56.446: TCP0: state was SYNRCVD -> ESTAB [1720 -> 10.220.128.16(32810)]
*Apr 10 19:20:56.446: //-1/xxxxxxxxxxxx/H323/cch323_ct_main: SOCK 0 Event 0x1
*Apr 10 19:20:56.446: TCB7F2F99CDEA18 accepting 7F2FA81CDA68 from 10.220.128.16.32810
*Apr 10 19:20:56.447: TCB7F2FA81CDA68 setting property TCP_NO_DELAY (0) 7F2FA6FE75E4
*Apr 10 19:20:56.447: TCB7F2FA81CDA68 setting property TCP_KEEPALIVE (17) 7F2FA6FE7688
*Apr 10 19:20:56.447: TCP: Setting Keepalive interval and retries to 60 and 4
*Apr 10 19:20:56.447: TCB7F2FA81CDA68 setting property TCP_NO_DELAY (0) 7F2FA6FE7620
*Apr 10 19:20:56.447: //-1/xxxxxxxxxxxx/H323/cch323_get_new_ccb: ccb (0x7F2FA00BEF58) is in use
*Apr 10 19:20:56.448: //-1/xxxxxxxxxxxx/H323/cch323_ct_main: SOCK 2 Event 0x1
*Apr 10 19:20:56.448: //-1/xxxxxxxxxxxx/H323/cch323_gw_process_read_socket: owner_data=0x7F2FA79DCEC0, len=217, msgPtr=0x7F2F9FFB1570
*Apr 10 19:20:56.448: //-1/xxxxxxxxxxxx/H323/cch323_gw_process_read_socket: Received msg for H.225
*Apr 10 19:20:56.448: H225.0 INCOMING ENCODE BUFFER::= 20B0060008914A000501401F005400650061006D004C00650061006400650072003000310000000000000000000000000000000000000000000000000000000000000000000000000000000022C0B50000120F436973636F43616C6C4D616E6167657200310001018076670080E1A0F8183FE1CA090010030ADC7E4E00D50D800007000ADC801006B8110080E1A0F8183FE1CA090010030ADC7E4E010001000100010010A00100140140B50000120D82040020040001030003000103
*Apr 10 19:20:56.448: 
*Apr 10 19:20:56.448: H225.0 INCOMING PDU ::=

value H323_UserInformation ::= 
    {
      h323-uu-pdu 
      {
        h323-message-body setup : 
        {
          protocolIdentifier { 0 0 8 2250 0 5 }
          sourceAddress 
          {
            h323-ID : {"TeamLeader01..."}
          }
          sourceInfo 
          {
            vendor 
            {
              vendor 
              {
                t35CountryCode 181
                t35Extension 0
                manufacturerCode 18
              }
              productId '436973636F43616C6C4D616E61676572'H
              versionId '31'H
            }
            terminal 
            {
            }
            mc FALSE
            undefinedNode FALSE
          }
          destinationAddress 
          {
            dialedDigits : "4334"
          }
          activeMC FALSE
          conferenceID '80E1A0F8183FE1CA090010030ADC7E4E'H
          conferenceGoal create : NULL
          callType pointToPoint : NULL
          sourceCallSignalAddress ipAddress : 
          {
            ip '0ADC8010'H
            port 1720
          }
          callIdentifier 
          {
            guid '80E1A0F8183FE1CA090010030ADC7E4E'H
          }
          mediaWaitForConnect FALSE
          canOverlapSend FALSE
          multipleCalls FALSE
          maintainConnection FALSE
        }
        h245Tunneling FALSE
        nonStandardControl 
        {

          {
            nonStandardIdentifier h221NonStandard : 
            {
              t35CountryCode 181
              t35Extension 0
              manufacturerCode 18
            }
            data '82040020040001030003000103'H
          }
        }
      }
    }



*Apr 10 19:20:56.449: H225 NONSTD INCOMING ENCODE BUFFER::= 82040020040001030003000103
*Apr 10 19:20:56.449: 
*Apr 10 19:20:56.449: H225 NONSTD INCOMING PDU ::=

value H323_UU_NonStdInfo ::= 
    {
      callMgrParam 
      {
        interclusterVersion 3
        enterpriseID {}
      }
    }



*Apr 10 19:20:56.449: //-1/xxxxxxxxxxxx/H323/cch323_h225_receiver: Received msg of type SETUPIND_CHOSEN
*Apr 10 19:20:56.449: //115/80E1A0F80900/H323/setup_ind: callingNumber[4271] calledNumber[4334]
*Apr 10 19:20:56.449: //115/80E1A0F80900/H323/setup_ind: ---- calling IE present
*Apr 10 19:20:56.449: //115/80E1A0F80900/H323/setup_ind: ====== PI = 0
*Apr 10 19:20:56.449: //115/80E1A0F80900/H323/setup_ind: Receive: infoXCap 0
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/setup_ind: Receive: infoXCap ccb 0
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/setup_ind: Receive bearer cap infoXRate 16, rateMult 0
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/copy_recv_rawMsg: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/copy_recv_rawMsg:exit@674cch323_ip_best_local_address: IP 10.220.128.8 found for bound IDB GigabitEthernet0/0/0
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_hashSet_preV3: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_hashSet_preV3:exit@287
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_h225_update_connection_flags: 
*Apr 10 19:20:56.450: //-1/xxxxxxxxxxxx/H323/cch323_extract_signaled_carriers: Entry
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_determine_source_ip_group_info: No Source IP group match with Src CarrierId/Zone ID
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_determine_source_ip_group_info: No Source IP group matched with rte id/zone_id/acl
*Apr 10 19:20:56.450: //-1/xxxxxxxxxxxx/H323/cch323_determine_source_group: Entry
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_determine_source_ip_group_info: No Source IP group match with Incoming Called Number
*Apr 10 19:20:56.450: //-1/xxxxxxxxxxxx/H323/cch323_determine_source_group: Entry
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_determine_source_ip_group_info: No Source IP group match with Destination pattern
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/setup_ind: 
setup_ind: is_overlap = 0, info_complete = 0

*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_remove_obj_from_ccb: 
*Apr 10 19:20:56.450: //-1/xxxxxxxxxxxx/H323/cch323_is_preauth_reqd: FALSE
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/setup_ind: Call Manager detected
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_put_obj_to_ccb: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_alloc_obj_holder: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_insert_obj_holder: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_put_obj_to_ccb:exit@717
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_h225_receiver: SETUPIND_CHOSEN: src address = 10.220.128.8; dest address = 10.220.128.16
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/run_h225_sm: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/run_h225_sm: Received event H225_EV_SETUP_IND while at state H225_IDLE
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/idle_setupInd_hdlr: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/h323_rscmsm_incoming_unavail: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_external_qos_call_setup: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/common_idle_setupInd_hdlr: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_get_obj_from_ccb: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_find_obj: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_get_obj_from_ccb: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_find_obj: 
*Apr 10 19:20:56.450: //-1/xxxxxxxxxxxx/H323/cch323_associate_incoming_peer: timeout = 1, reason = 0
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/common_idle_setupInd_hdlr: full match is found
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_set_peer: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_update_call_info_from_dial_peer: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_set_preferred_codec: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_set_preferred_codec: Using Voice Class Codec, tag = 1
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/h323_is_isdn_data_call: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_set_srtp_call: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_set_peer: peer: 7F2FA79B7570, peer->voice_peer_tag: 2, ccb: 7F2FA00BEF58
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_set_dtmf_relay: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_update_caps_mode: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_set_preferred_dtmf_relay: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_update_t38cap: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_set_peer: ccb h245addr bits = system[0x0007]
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_set_peer: ccb ccm bits = system[0x0028]
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_h225_set_new_state: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_h225_set_new_state: Changing from H225_IDLE state to H225_SETUP state
*Apr 10 19:20:56.450: TCB7F2FA81CDA68 setting property TCP_TOS (11) 7F2FA6FE74F0
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/generic_setup_notify: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/generic_setup_treatment: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_set_h245_state_mc_mode_incoming: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_set_h245_state_mc_mode_incoming: h245 state m/c mode=0x10F, h323_ctl=0x2F
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_create_incoming_callinfo_block: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_get_obj_from_ccb: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_find_obj: 
*Apr 10 19:20:56.450: //115/80E1A0F80900/H323/cch323_get_obj_from_ccb: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_find_obj: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_get_obj_from_ccb: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_find_obj: 
*Apr 10 19:20:56.451: //-1/xxxxxxxxxxxx/H323/cch323_associate_incoming_peer: timeout = 1, reason = 0
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_create_incoming_callinfo_block: peer 7F301B071F64, voice_peer_tag 2, ccb: 7F2FA00BEF58
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_create_incoming_callinfo_block: Calling Party is CCM
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/h323_gw_setup_ind: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/h323_gw_setup_ind: is_overlap = 0, info_complete = 0
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_insert_called_and_calling_uri_into_container: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_get_obj_from_ccb: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_find_obj: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_get_obj_from_ccb: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_find_obj: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_insert_tgcic_into_container: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_insert_mlpp_info_into_container: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_get_rm_embedded_obj_from_ccb: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_insert_mlpp_info_into_container:exit@227
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_fill_call_setup_params: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_get_rm_obj_from_ccb: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_set_srtp_call: 
*Apr 10 19:20:56.451: //-1/80E1A0F80900/CCAPI/cc_api_display_ie_subfields:
   cc_api_call_setup_ind_common:
   cisco-username=TeamLeader01
   ----- ccCallInfo IE subfields -----
   cisco-ani=4271
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=1
   dest=4334
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=FFFFFFFFFFFFFFFF
   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

*Apr 10 19:20:56.451: //-1/80E1A0F80900/CCAPI/cc_api_call_setup_ind_common:
   Interface=0x7F2F9F873758, Call Info(
   Calling Number=4271,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),
   Called Number=4334(TON=Unknown, NPI=Unknown),
   Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,
   Incoming Dial-peer=2, Progress Indication=NULL(0), Calling IE Present=TRUE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=115
*Apr 10 19:20:56.451: //-1/80E1A0F80900/CCAPI/ccCheckClipClir:
   In: Calling Number=4271(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)
*Apr 10 19:20:56.451: //-1/80E1A0F80900/CCAPI/ccCheckClipClir:
   Out: Calling Number=4271(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)
*Apr 10 19:20:56.451: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
   
*Apr 10 19:20:56.451: :cc_get_feature_vsa malloc success
*Apr 10 19:20:56.451: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
   
*Apr 10 19:20:56.451:  cc_get_feature_vsa count is 1
*Apr 10 19:20:56.451: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
   
*Apr 10 19:20:56.451: :FEATURE_VSA attributes are: feature_name:0,feature_time:139842584846644,feature_id:115
*Apr 10 19:20:56.451: //115/80E1A0F80900/CCAPI/cc_api_call_setup_ind_common:
   Set Up Event Sent;
   Call Info(Calling Number=4271(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),
   Called Number=4334(TON=Unknown, NPI=Unknown))
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_save_servicecontrol_to_avlist: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_get_rm_embedded_obj_from_ccb: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_h225_handle_deferred_ind: UnBuffering deferred indications
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_h225_handle_deferred_ind: 
*Apr 10 19:20:56.451: //-1/xxxxxxxxxxxx/H323/cch323_create_call_info_type_container: 
cch323_create_call_info_type_container: creating callInfoType container for callID = 115
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_insert_ccb_into_tree: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_setup_call_active_rec_incoming: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_get_obj_from_ccb: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_find_obj: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_store_call_info_remoteIPAddr: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_apply_translation_rules: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_get_obj_from_ccb: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_find_obj: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/cch323_find_obj:exit@384
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/h323_set_callinfo_num: 
*Apr 10 19:20:56.451: //115/80E1A0F80900/H323/h323_set_callinfo_num: 
*Apr 10 19:20:56.452: //115/80E1A0F80900/H323/h323_gw_insert_call_active_entry: 
*Apr 10 19:20:56.452: //115/80E1A0F80900/H323/cch323_update_call_info_from_dial_peer: 
*Apr 10 19:20:56.452: //115/80E1A0F80900/H323/cch323_update_call_info_from_dial_peer: Playout Mode: 1,Init 60, Min 40, Max 1000, Fax 300
*Apr 10 19:20:56.452: //115/80E1A0F80900/H323/cch323_update_call_preserve_config_in_ccb: 
*Apr 10 19:20:56.452: //115/80E1A0F80900/H323/cch323_update_carriers_in_call_info: 
*Apr 10 19:20:56.452: //115/80E1A0F80900/H323/cch323_update_carriers_in_call_info: tg_label_flag 0x0
*Apr 10 19:20:56.452: //115/80E1A0F80900/H323/setup_treatment_objects_cleanup: 
*Apr 10 19:20:56.452: //115/80E1A0F80900/H323/cch323_remove_obj_from_ccb: 
*Apr 10 19:20:56.452: //115/80E1A0F80900/H323/cch323_dealloc_obj_holder: 
*Apr 10 19:20:56.452: //115/80E1A0F80900/H323/cch323_remove_obj_from_ccb:exit@531
*Apr 10 19:20:56.452: //115/80E1A0F80900/H323/cch323_remove_obj_from_ccb: 
*Apr 10 19:20:56.452: //115/80E1A0F80900/H323/cch323_remove_obj_from_ccb: 
*Apr 10 19:20:56.452: //115/80E1A0F80900/H323/cch323_remove_obj_from_ccb: 
*Apr 10 19:20:56.452: //115/80E1A0F80900/CCAPI/cc_process_call_setup_ind:
   Event=0x7F2FA39A4050
*Apr 10 19:20:56.452: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
   Try with the demoted called number 4334
*Apr 10 19:20:56.452: //115/80E1A0F80900/CCAPI/ccCallSetContext:
   Context=0x7F2FA8111068
*Apr 10 19:20:56.452: //115/80E1A0F80900/CCAPI/cc_process_call_setup_ind:
   >>>>CCAPI handed cid 115 with tag 2 to app "_ManagedAppProcess_TOLLFRAUD_APP"
*Apr 10 19:20:56.453: //-1/xxxxxxxxxxxx/H323/cch323_post_call_statistics: callID=115
*Apr 10 19:20:56.453: //115/80E1A0F80900/CCAPI/ccCallDisconnect:
   Cause Value=21, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
*Apr 10 19:20:56.453: //115/80E1A0F80900/CCAPI/ccCallDisconnect:
   Cause Value=21, Call Entry(Responsed=TRUE, Cause Value=21)
*Apr 10 19:20:56.453: //115/80E1A0F80900/CCAPI/cc_api_get_transfer_info:
   Transfer Number=NULL
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/cch323_do_call_disconnect: 
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/cch323_do_call_disconnect: gw_id=1, discCause=21
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/cch323_peg_disc_counter: 
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/cch323_get_video_olc: 
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/h323_set_release_src_and_iec: 
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/h323_set_release_src_and_iec:exit@6059
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/cch323_send_event_to_h225: 
*Apr 10 19:20:56.453: //-1/xxxxxxxxxxxx/H323/cch323_iev_queue_service: Dispatch 0x9 internal event to H225 SM
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/run_h225_sm: 
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/run_h225_sm: Received event H225_EV_RELEASE while at state H225_SETUP
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/handle_release_event: 
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/cch323_h225_send_release: 
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/h323_set_release_src_and_iec: 
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/h323_set_cc_cause_for_spi_err: 
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/h323_set_cc_cause_for_spi_err:exit@5926
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/cch323_h225_send_release: Cause = 21; Location = 0
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/cch323_h225_copy_send_rawMsg: 
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/cch323_h225_copy_nonStdInfo_prog_ind: 
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/cch323_h225_send_release: h225TerminateRequest: src address = 182222856; dest address = 10.220.128.16
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/cch323_fill_in_callcord: 
*Apr 10 19:20:56.453: H225.0 OUTGOING PDU ::=

value H323_UserInformation ::= 
    {
      h323-uu-pdu 
      {
        h323-message-body releaseComplete : 
        {
          protocolIdentifier { 0 0 8 2250 0 4 }
          callIdentifier 
          {
            guid '80E1A0F8183FE1CA090010030ADC7E4E'H
          }
        }
        h245Tunneling FALSE
      }
    }



*Apr 10 19:20:56.453: H225.0 OUTGOING ENCODE BUFFER::= 2580060008914A00041100110080E1A0F8183FE1CA090010030ADC7E4E10800100
*Apr 10 19:20:56.453: 
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/cch323_h225_cleanup_rawbuf: 
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/cch323_h225_set_new_state: 
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/cch323_h225_set_new_state: Changing from H225_SETUP state to H225_IDLE state
*Apr 10 19:20:56.453: //115/80E1A0F80900/H323/cch323_call_cleanup: 
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_call_generic_cleanup: 
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_call_generic_cleanup: Disconnected flag 1
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_store_call_history_entry: 
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_store_call_history_entry: Call Active Playout Mode: 1,Init 60, Min 40, Max 1000, Fax 300
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_store_call_history_entry: Call History Playout Mode: 1,Init 60, Min 40, Max 1000, Fax 300
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_h225_send_alt_endpoint_cdr: 
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_get_obj_from_ccb: 
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_find_obj: 
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_h225_send_alt_endpoint_cdr:exit@2576
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_call_get: 
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_call_generic_cleanup: 
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_alternate_retry_call_cleanup: 
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_h225_cleanup_tcp_connection: 
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_hashDelete_FD: 
*Apr 10 19:20:56.454: TCP0: state was ESTAB -> FINWAIT1 [1720 -> 10.220.128.16(32810)]
*Apr 10 19:20:56.454: TCP0: sending FIN
*Apr 10 19:20:56.454: //-1/xxxxxxxxxxxx/H323/h323_gw_clean_send_blocked_watch: fd 2
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_send_event_direct_to_h245_iwf_sm: 
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/run_h245_iwf_sm: 
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/run_h245_iwf_sm: received IWF_EV_H245_DISCONN while at state IWF_IDLE
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/defaultHdlr: 
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/defaultHdlr: DEFAULT: Received IWF_EV_H245_DISCONN in state IWF_IDLE
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_h225_free_fastStart_memory: 
*Apr 10 19:20:56.454: //-1/xxxxxxxxxxxx/H323/cch323_cleanup_xport: hashDestroy for TcpFDTbl
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_remove_obj_from_ccb: 
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_free_deferred_ind: 
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_h225_clean_facility_addr_info: 
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_h245_close_h245_conn: 
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_h245_close_h245_listen_conn: 
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/h323_gw_call_disconnect_done: 
*Apr 10 19:20:56.454: //115/80E1A0F80900/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x7F2F9F873758, Tag=0x0, Call Id=115,
   Call Entry(Disconnect Cause=21, Voice Class Cause Code=0, Retry Count=0)
*Apr 10 19:20:56.454: //115/80E1A0F80900/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
*Apr 10 19:20:56.454: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
   
*Apr 10 19:20:56.454: :cc_free_feature_vsa freeing 7F2FA3982128
*Apr 10 19:20:56.454: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
   
*Apr 10 19:20:56.454:  vsacount in free is 0
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_clean_ccb_container: 
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_free_add_olc: 
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_call_generic_cleanup: Freeing ccb (0x7F2FA00BEF58)
*Apr 10 19:20:56.454: //115/80E1A0F80900/H323/cch323_release_ccb: 
*Apr 10 19:20:56.455: TCP0: state was FINWAIT1 -> FINWAIT2 [1720 -> 10.220.128.16(32810)]
PRI-VGW-CoreB#
*Apr 10 19:20:56.455: TCP0: FIN processed
*Apr 10 19:20:56.455: TCP0: state was FINWAIT2 -> TIMEWAIT [1720 -> 10.220.128.16(32810)]
PRI-VGW-CoreB#
*Apr 10 19:20:59.818: TCB7F2F9FFAFB90 setting property TCP_TOS (11) 7F2FA79785DC
*Apr 10 19:21:00.019: TCP0: ACK timeout timer expired
PRI-VGW-CoreB#
*Apr 10 19:21:01.862: TCB7F2F99D61000 setting property TCP_TOS (11) 7F2FA79785DC
*Apr 10 19:21:02.063: TCP0: ACK timeout timer expired
PRI-VGW-CoreB#
*Apr 10 19:21:07.156: TCB7F2F9FFB0510 setting property TCP_TOS (11) 7F2FA79785DC
*Apr 10 19:21:07.358: TCP0: ACK timeout timer expired
PRI-VGW-CoreB#