[cisco-ttl] h323 fxs+cisco---Alcatel 4400

From: artun kocaman <artunkocaman_at_....>
Date: Mon Dec 05 2005 - 09:19:18 EET


  alcatel 4400 santral uzerınde h323 calıstıyoruz ve dırekt karısında cisco 1751V+vic2fxs var.   bu durumda dusunulen calısma soyledır;   alcatel 4400 uzerınde yapılan sıkıstırmayı cısco cozecek ve arada voip yapılmıs olacak; zaten bu konuda bır sıkıntımız yok. cıhazlar karsılıklı olarak calısıyor call gerceklesıyor ve her 2 tarafta bırbırlerının sesını duyuyor.   sorun konusma basladıktan sonra 3 sn ıcersınde karsılıklı normal call clearıng ıle sonlanması.   router uzreındekı tum tımerlarla oynadım fakat herhangı bır degısıklık yasatmadı.   fast call veya slow call nebılıyım akla gelen tum ayarları tek tek denedım    

  routeruzerındekı konfıg ve debugları gonderebılırım   benım anladıgım kadar ıle h245 ve h225 de bır sorun yasıyorlar.   santralden tracelere baktıgımızda karsı taraf dolayısı ıle (kı bu cısco) normal call clearıng gerceklestıgını goruyorum   cıscodan baktıgımdada h245 remote command geldı dıyor ve normal call clearıng e geceerek hattı release edıyor.   

Sorun 3 sn ıle konusmanınn kısıtlanması baska bır sorun yok; bı tarafta sıkıntı olsa anlıcam ama gorusme karsılıklı olarak gerceklestıkten sonra boyle 3sn sonrasında kesılmesı canımı sıkıyor...    

  ciscodaki config;   

Building configuration...
  Current configuration : 882 bytes
!
version 12.2
service timestamps debug datetime msec
service timestamps log datetime msec
no service password-encryption
!
hostname "Router"
!
enable password cisco
!
ip subnet-zero
!
voice call send-alert
!
mta receive maximum-recipients 0
!
interface FastEthernet0/0
 ip address 10.0.0.98 255.255.255.0
 speed auto
!
ip classless
no ip http server
!
no call rsvp-sync
!
voice-port 0/0
voice-port 0/1
 cptone TR
!
mgcp profile default
!
dial-peer cor custom
!
dial-peer voice 10 voip
 description deneme
 incoming called-number .T
 destination-pattern 8..
 session target ipv4:10.0.0.95
 req-qos guaranteed-delay
 codec g723r63
!
dial-peer voice 1 pots
 destination-pattern 410
 port 0/1
!            

  debug debug vtsp all
  debug vpm signal

Router#
Router#
Router#
Router#

*Mar 1 00:44:45.555: //-1/xxxxxxxxxxxx/VTSP:():-1:-1:-1/vtsp_do_call_setup_req: .
*Mar 1 00:44:45.555: //-1/xxxxxxxxxxxx/VTSP:():-1:-1:-1/vtsp_allocate_cdb: ,cdb 0x82355B98
*Mar 1 00:44:45.555: //17/xxxxxxxxxxxx/VTSP:(2/1):-1:0:1/vtsp_insert_cdb: ,cdb 0x82355B98, CallID=17
*Mar 1 00:44:45.555: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_do_call_setup_req: calling oct3 0x1, called oct3 0x81
*Mar 1 00:44:45.559: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_do_call_setup_req: Call ID=8, guid=82366384
*Mar 1 00:44:45.559: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_do_call_setup_req: type=0, under_spec=1, name=, ds0=0, ds1=-1, echo_cancel=1, gain_control 0, auto_gain_control 0, dual_tone_detect 0, seq_tone_detect 0, calling=02165229820, called=410, playout mode=0,playout_init = 0, playout_min = 0, playout_max = 0, playout_fax_nom = 0
vtsp_do_call_setup_req: redirect DN: reason: -1
*Mar 1 00:44:45.563: digit_strip:1, pcn:410, poa:410
*Mar 1 00:44:45.563: pcn:, poa:
*Mar 1 00:44:45.563: Final pcn:, poa:, dial_string:
*Mar 1 00:44:45.563: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_request_call: calling oct3 0x1, called oct3 0x81
*Mar 1 00:44:45.567: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_request_call: cdb->sdb->type = 3
*Mar 1 00:44:45.567: //-1/xxxxxxxxxxxx/VTSP:():-1:-1:-1/vtsp_create_call_active_on_setup_req:
*Mar 1 00:44:45.567: vtsp_create_call_active_on_setup_req: target route label is
*Mar 1 00:44:45.567: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_create_call_active_on_setup_req:
*Mar 1 00:44:45.567: vtsp_create_call_active_on_setup_req : tgt carrier id
  *Mar 1 00:44:45.567: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_create_call_active_on_setup_req:
*Mar 1 00:44:45.567: vtsp_create_call_active_on_setup_req : src carrier id
htsp_setup_req
*Mar 1 00:44:45.567: htsp_process_event: [2/1, FXSLS_ONHOOK, E_HTSP_SETUP_REQ]fxsls_onhook_setup
*Mar 1 00:44:45.571: [2/1] set signal state = 0x0 timestamp = 0htsp_alert
*Mar 1 00:44:45.571: [2/1] set signal state = 0x0 timestamp = 0
*Mar 1 00:44:45.571: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_process_event: vtsp:[2/1 (17), S_SETUP_REQUEST, E_TSP_PROCEEDING]
*Mar 1 00:44:45.571: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_setup_pend_proceeding: .
*Mar 1 00:44:45.571: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_open_voice_and_set_params: .
*Mar 1 00:44:45.571: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_modem_proto_from_cdb: cap_modem_proto 0
*Mar 1 00:44:45.571: //17/438AD0C50008/VTSP:(2/1):-1:0:1/set_playout_cdb: playout default
  *Mar  1 00:44:45.575: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_dsp_echo_canceller_control: echo_cancel: 1

*Mar 1 00:44:45.575: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_process_event: vtsp:[2/1 (17), S_SETUP_REQ_PROC, E_TSP_ALERT]
*Mar 1 00:44:45.575: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_setup_pend_alert: .
*Mar 1 00:44:45.575: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_ring_noan_timer_start: 268557
*Mar 1 00:44:45.579: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_process_event: vtsp:[2/1 (17), S_SETUP_REQ_PROC, E_CC_BRIDGE]
*Mar 1 00:44:45.579: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_bridge: .
*Mar 1 00:44:45.587: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_process_event: vtsp:[2/1 (17), S_SETUP_REQ_PROC, E_CC_CAPS_IND]
*Mar 1 00:44:45.587: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ind: .
*Mar 1 00:44:45.587: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ind: RTP PT:NTE[101],NTEtx[101],NSE[100],FaxInd[96],FaxAck[97],CiscoDTMF[121],FaxRelay[122],CASsig[123],ClearChan[125],PCMu[0],PCMa[8]Codec[256],TxDynamicPayload[0], RxDynamicPayload[0]
*Mar 1 00:44:45.587: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ind: dtmf relay: mode=1, codec=1
*Mar 1 00:44:45.587: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ind: passthrough: cap_modem_proto 0, cap_modem_codec 0, cap_modem_redundancy 0, payload 100, modem_relay 0, gw-xid=0
*Mar 1 00:44:45.587: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ind: Encap 1, Vad 2, Codec 0x100, CodecBytes 24,
             FaxRate 2, FaxBytes 20, FaxNsf 0xAD0051 
             SignalType 2
             DtmfRelay 1, Modem 0, SeqNumStart 0xC98

*Mar 1 00:44:45.591: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ind:
*Mar 1 00:44:45.591: FORKING Parameters are forking mask: 0, simple_forking_codec_mask: 0, complex_forking_codec_mask 0
*Mar 1 00:44:45.591: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ind: [ mode:1,init:60, min:40, max:200, fax:300]
*Mar 1 00:44:45.591: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_process_event: vtsp:[2/1 (17), S_SETUP_REQ_PROC, E_CC_CAPS_ACK]
*Mar 1 00:44:45.591: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ack: .
*Mar 1 00:44:45.591: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ack: passthrough: cap_modem_proto 0, cap_modem_codec 0, cap_modem_redundancy 0, payload 100, modem_relay 0, gw-xid=0
*Mar 1 00:44:45.591: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ack: Named Telephone Event payload: rcv 101, tx 101
*Mar 1 00:44:45.595: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_switch_codec: codec = 8
*Mar 1 00:44:45.595: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_do_send_config_for_switch_codec:
*Mar 1 00:44:45.595: DTMF Relay in vtsp_do_send_config_for_switch_codec is 1
*Mar 1 00:44:45.595: //17/438AD0C50008/VTSP:(2/1):-1:0:1/set_dsp_encap_config:
*Mar 1 00:44:45.595: set_dsp_encap_config: logical ssrc 20
*Mar 1 00:44:45.595: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_modem_proto_from_cdb: cap_modem_proto 0
*Mar 1 00:44:45.595: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_dsp_echo_canceller_control: echo_cancel: 1
*Mar 1 00:44:45.595: //17/438AD0C50008/VTSP:(2/1):-1:0:1/set_dsp_encap_config:
*Mar 1 00:44:45.599: set_dsp_encap_config: logical ssrc 20
*Mar 1 00:44:45.599: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_modem_proto_from_cdb: cap_modem_proto 0
*Mar 1 00:44:45.599: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_dsp_cp_tone_on: cpPtr->off_time_third: 0, cdb->sl_delay: 0
*Mar 1 00:44:45.599: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_switch_codec:
*Mar 1 00:44:45.599: act_switch_codec codec change success
*Mar 1 00:44:45.599: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_add_fork:
*Mar 1 00:44:45.599: vtsp_add_fork
*Mar 1 00:44:45.599: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_update_fork_info:
*Mar 1 00:44:45.599: vtsp_update_fork_info: add_fork=0
*Mar 1 00:44:45.603: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_get_xmit_info_node:
*Mar 1 00:44:45.603: vtsp_get_xmit_info_node
*Mar 1 00:44:45.603: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_update_fork_info:
*Mar 1 00:44:45.603: vtsp_update_fork_info xmit func is 80CA7250, context is 823570DCpeer_call_id: 16, stream_count: 1, update_flag 0
*Mar 1 00:44:45.603: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_update_fork_info:
*Mar 1 00:44:45.603: The stream bit-mask is 1
*Mar 1 00:44:45.603: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_update_fork_info:
*Mar 1 00:44:45.603: The stream type is 0
*Mar 1 00:44:45.603: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_update_fork_info:
*Mar 1 00:44:45.603: The logical ssrc is 32 for stream 0
*Mar 1 00:44:45.603: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_update_stream_count:
*Mar 1 00:44:45.603: g711_voice_count=0 g711_avt_count = 0
 g711_voice_avt_count = 0 complex_voice_count = 1  complex_avt_count = 0 complex_voice_avt_count = 0
*Mar 1 00:44:45.607: htsp_process_event: [2/1, FXSLS_WAIT_OFFHOOK, E_HTSP_VOICE_CUT_THROUGH]fxsls_waitoff_voice
*Mar 1 00:44:56.107: htsp_process_event: [2/1, FXSLS_WAIT_OFFHOOK, E_DSP_SIG_1100]fxsls_waitoff_offhook
*Mar 1 00:44:56.107: [2/1] set signal state = 0x4 timestamp = 0
*Mar 1 00:44:56.107: [2/1] set signal state = 0x6 timestamp = 0 htsp_dial
*Mar 1 00:44:56.107: htsp_process_event: [2/1, FXSLS_CONNECT, E_DSP_DIALING_DONE]
*Mar 1 00:44:56.107: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_process_event: vtsp:[2/1 (17), S_SETUP_REQ_PROC, E_TSP_CONNECT]
*Mar 1 00:44:56.111: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_setup_pend_connect: .
*Mar 1 00:44:56.111: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_ring_noan_timer_stop: 269611
*Mar 1 00:44:56.143: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_process_event: vtsp:[2/1 (17), S_CONNECT, E_CC_CAPS_IND]
*Mar 1 00:44:56.143: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ind: .
*Mar 1 00:44:56.143: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ind: RTP PT:NTE[101],NTEtx[101],NSE[100],FaxInd[96],FaxAck[97],CiscoDTMF[121],FaxRelay[122],CASsig[123],ClearChan[125],PCMu[0],PCMa[8]Codec[256],TxDynamicPayload[0], RxDynamicPayload[0]
*Mar 1 00:44:56.143: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ind: dtmf relay: mode=1, codec=1
*Mar 1 00:44:56.143: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ind: passthrough: cap_modem_proto 0, cap_modem_codec 0, cap_modem_redundancy 0, payload 100, modem_relay 0, gw-xid=0
*Mar 1 00:44:56.147: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ind: Encap 1, Vad 2, Codec 0x100, CodecBytes 24,
             FaxRate 2, FaxBytes 20, FaxNsf 0xAD0051 
             SignalType 2
             DtmfRelay 1, Modem 0, SeqNumStart 0xA0A1

*Mar 1 00:44:56.147: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ind:
*Mar 1 00:44:56.147: FORKING Parameters are forking mask: 0, simple_forking_codec_mask: 0, complex_forking_codec_mask 0
*Mar 1 00:44:56.147: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ind: [ mode:1,init:60, min:40, max:200, fax:300]
*Mar 1 00:44:56.147: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_process_event: vtsp:[2/1 (17), S_CONNECT, E_CC_CAPS_ACK]
*Mar 1 00:44:56.147: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ack: .
*Mar 1 00:44:56.147: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ack: passthrough: cap_modem_proto 0, cap_modem_codec 0, cap_modem_redundancy 0, payload 100, modem_relay 0, gw-xid=0
*Mar 1 00:44:56.151: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ack: Named Telephone Event payload: rcv 101, tx 101
*Mar 1 00:44:56.151: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_switch_codec: codec = 8
*Mar 1 00:44:56.151: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_do_send_config_for_switch_codec:
*Mar 1 00:44:56.151: DTMF Relay in vtsp_do_send_config_for_switch_codec is 1
*Mar 1 00:44:56.151: //17/438AD0C50008/VTSP:(2/1):-1:0:1/set_dsp_encap_config:
*Mar 1 00:44:56.151: set_dsp_encap_config: logical ssrc 20
*Mar 1 00:44:56.151: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_modem_proto_from_cdb: cap_modem_proto 0
*Mar 1 00:44:56.151: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_dsp_echo_canceller_control: echo_cancel: 1
*Mar 1 00:44:56.155: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_compare_and_remove_streams:
*Mar 1 00:44:56.155: vtsp_compare_and_remove_streams: restore_flag=0
*Mar 1 00:44:56.155: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_compare_and_remove_streams:
*Mar 1 00:44:56.155: Replacing existing streams for call leg
*Mar 1 00:44:56.155: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_compare_and_remove_streams:
*Mar 1 00:44:56.155: The stream type is 0
*Mar 1 00:44:56.155: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_add_fork:
*Mar 1 00:44:56.155: vtsp_add_fork
*Mar 1 00:44:56.155: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_update_fork_info:
*Mar 1 00:44:56.155: vtsp_update_fork_info: add_fork=1
*Mar 1 00:44:56.155: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_get_xmit_info_node:
*Mar 1 00:44:56.159: vtsp_get_xmit_info_node
*Mar 1 00:44:56.159: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_update_fork_info:
*Mar 1 00:44:56.159: vtsp_update_fork_info xmit func is 80CA7250, context is 823570DCpeer_call_id: 16, stream_count: 1, update_flag 1
*Mar 1 00:44:56.159: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_update_fork_info:
*Mar 1 00:44:56.159: The stream bit-mask is 1
*Mar 1 00:44:56.159: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_update_fork_info:
*Mar 1 00:44:56.159: The stream type is 0
*Mar 1 00:44:56.159: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_update_fork_info:
*Mar 1 00:44:56.159: The logical ssrc is 32 for stream 0
*Mar 1 00:44:56.159: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_dsp_fork_control:
*Mar 1 00:44:56.159: vtsp_dsp_fork_control:
*Mar 1 00:44:56.159: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_dsp_fork_control:
*Mar 1 00:44:56.163: Adding Fork: ssrc: 32 stream_type: 1
*Mar 1 00:44:58.139: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_process_event: vtsp:[2/1 (17), S_CONNECT, E_CC_CAPS_IND]
*Mar 1 00:44:58.139: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ind: .
*Mar 1 00:44:58.139: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ind: RTP PT:NTE[101],NTEtx[101],NSE[100],FaxInd[96],FaxAck[97],CiscoDTMF[121],FaxRelay[122],CASsig[123],ClearChan[125],PCMu[0],PCMa[8]Codec[256],TxDynamicPayload[0], RxDynamicPayload[0]
*Mar 1 00:44:58.139: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ind: dtmf relay: mode=1, codec=1
*Mar 1 00:44:58.143: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ind: passthrough: cap_modem_proto 0, cap_modem_codec 0, cap_modem_redundancy 0, payload 100, modem_relay 0, gw-xid=0
*Mar 1 00:44:58.143: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ind: Encap 1, Vad 2, Codec 0x100, CodecBytes 24,
             FaxRate 2, FaxBytes 20, FaxNsf 0xAD0051 
             SignalType 2
             DtmfRelay 1, Modem 0, SeqNumStart 0x5

*Mar 1 00:44:58.143: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ind:
*Mar 1 00:44:58.143: FORKING Parameters are forking mask: 0, simple_forking_codec_mask: 0, complex_forking_codec_mask 0
*Mar 1 00:44:58.143: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ind: [ mode:1,init:60, min:40, max:200, fax:300]
*Mar 1 00:44:58.143: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_process_event: vtsp:[2/1 (17), S_CONNECT, E_CC_CAPS_ACK]
*Mar 1 00:44:58.143: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ack: .
*Mar 1 00:44:58.147: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ack: passthrough: cap_modem_proto 0, cap_modem_codec 0, cap_modem_redundancy 0, payload 100, modem_relay 0, gw-xid=0
*Mar 1 00:44:58.147: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_caps_ack: Named Telephone Event payload: rcv 101, tx 101
*Mar 1 00:44:58.147: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_switch_codec: codec = 8
*Mar 1 00:44:58.147: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_do_send_config_for_switch_codec:
*Mar 1 00:44:58.147: DTMF Relay in vtsp_do_send_config_for_switch_codec is 1
*Mar 1 00:44:58.147: //17/438AD0C50008/VTSP:(2/1):-1:0:1/set_dsp_encap_config:
*Mar 1 00:44:58.147: set_dsp_encap_config: logical ssrc 20
*Mar 1 00:44:58.147: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_modem_proto_from_cdb: cap_modem_proto 0
*Mar 1 00:44:58.147: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_dsp_echo_canceller_control: echo_cancel: 1
*Mar 1 00:44:58.151: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_compare_and_remove_streams:
*Mar 1 00:44:58.151: vtsp_compare_and_remove_streams: restore_flag=0
*Mar 1 00:44:58.151: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_compare_and_remove_streams:
*Mar 1 00:44:58.151: Replacing existing streams for call leg
*Mar 1 00:44:58.151: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_compare_and_remove_streams:
*Mar 1 00:44:58.151: The stream type is 0
*Mar 1 00:44:58.151: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_add_fork:
*Mar 1 00:44:58.151: vtsp_add_fork
*Mar 1 00:44:58.151: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_update_fork_info:
*Mar 1 00:44:58.151: vtsp_update_fork_info: add_fork=1
*Mar 1 00:44:58.155: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_get_xmit_info_node:
*Mar 1 00:44:58.155: vtsp_get_xmit_info_node
*Mar 1 00:44:58.155: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_update_fork_info:
*Mar 1 00:44:58.155: vtsp_update_fork_info xmit func is 80CA7250, context is 823570DCpeer_call_id: 16, stream_count: 1, update_flag 1
*Mar 1 00:44:58.155: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_update_fork_info:
*Mar 1 00:44:58.155: The stream bit-mask is 1
*Mar 1 00:44:58.155: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_update_fork_info:
*Mar 1 00:44:58.155: The stream type is 0
*Mar 1 00:44:58.155: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_update_fork_info:
*Mar 1 00:44:58.155: The logical ssrc is 32 for stream 0
*Mar 1 00:44:58.155: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_dsp_fork_control:
*Mar 1 00:44:58.155: vtsp_dsp_fork_control:
*Mar 1 00:44:58.159: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_dsp_fork_control:
*Mar 1 00:44:58.159: Adding Fork: ssrc: 32 stream_type: 1
*Mar 1 00:45:00.175: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_process_event: vtsp:[2/1 (17), S_CONNECT, E_CC_BRIDGE_DROP]
*Mar 1 00:45:00.175: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_remove_stream_node:
*Mar 1 00:45:00.179: vtsp_remove_stream_node
*Mar 1 00:45:00.179: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_get_xmit_info_node:
*Mar 1 00:45:00.179: vtsp_get_xmit_info_node
*Mar 1 00:45:00.179: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_remove_stream_node:
*Mar 1 00:45:00.179: Stream count is 1 in function vtsp_remove_stream_node
*Mar 1 00:45:00.179: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_bdrop: .
*Mar 1 00:45:00.179: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_is_record_active:
*Mar 1 00:45:00.179: vtsp_is_record_active: false
*Mar 1 00:45:00.179: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_process_event: vtsp:[2/1 (17), S_CONNECT, E_CC_DISCONNECT]
*Mar 1 00:45:00.183: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_disconnect: .
*Mar 1 00:45:00.183: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_ring_noan_timer_stop: 270018
*Mar 1 00:45:00.183: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_pcm_tone_detect_timer_stop: 270018
*Mar 1 00:45:00.183: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_pcm_switchover_timer_stop: 270018
*Mar 1 00:45:00.183: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_cm_detect_timer_stop: 270018
*Mar 1 00:45:00.183: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_modem_relay_mode_timer_stop: 270018
*Mar 1 00:45:00.183: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_modem_relay_stats_timer_stop: 270018
*Mar 1 00:45:00.183: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_nse_t38_switchover_timer_stop: 270018
*Mar 1 00:45:00.187: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_timer_stop: 270018
*Mar 1 00:45:00.187: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_disconnect: cdb 0x82355B98, cause 0x10
*Mar 1 00:45:00.187: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_timer: 270018
*Mar 1 00:45:00.191: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_process_event: vtsp:[2/1 (17), S_WAIT_STATS, E_DSP_GET_ERROR]
*Mar 1 00:45:00.191: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_get_error: .
*Mar 1 00:45:00.191: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_print_error_stats: rx_dropped=0 tx_dropped=0
*Mar 1 00:45:00.191: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_print_error_stats: rx_control=50 tx_control=14 tx_control_dropped=0 dsp_mode_channel_1=2 dsp_mode_channel_2=0c[0]=78c[1]=6c[2]=87c[3]=83c[4]=84c[5]=106c[6]=0c[7]=17326c[8]=50548c[9]=0c[10]=0c[11]=0c[12]=0c[13]=0c[14]=0c[15]=65533
*Mar 1 00:45:00.195: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_timer_stop: 270019
*Mar 1 00:45:00.195: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_timer: 270019
*Mar 1 00:45:00.199: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_process_event: vtsp:[2/1 (17), S_WAIT_STATS, E_DSP_GET_LEVELS]
*Mar 1 00:45:00.203: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_get_levels: .
*Mar 1 00:45:00.207: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_stats_complete: .
*Mar 1 00:45:00.207: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_timer_stop: 270020
*Mar 1 00:45:00.207: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_ring_noan_timer_stop: 270020
*Mar 1 00:45:00.207: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_timer: 270020
*Mar 1 00:45:00.207: htsp_process_event: [2/1, FXSLS_CONNECT, E_HTSP_RELEASE_REQ]fxsls_connect_disc
*Mar 1 00:45:00.207: htsp_timer_stop
*Mar 1 00:45:00.211: [2/1] set signal state = 0xC timestamp = 0
*Mar 1 00:45:00.211: [2/1] set signal state = 0x4 timestamp = 750
*Mar 1 00:45:00.211: htsp_timer - 950 msec
*Mar 1 00:45:01.163: htsp_process_event: [2/1, FXSLS_CPC, E_HTSP_EVENT_TIMER]fxsls_cpc_timer
*Mar 1 00:45:01.163: htsp_timer - 60000 msec
*Mar 1 00:45:01.163: htsp_process_event: [2/1, FXSLS_WAIT_ONHOOK, E_DSP_SIG_1100]
*Mar 1 00:45:01.663: htsp_process_event: [2/1, FXSLS_WAIT_ONHOOK, E_DSP_SIG_0100]fxsls_waitonhook_onhook
*Mar 1 00:45:01.663: htsp_timer_stop htsp_report_onhook_sig
*Mar 1 00:45:01.667: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_process_event: vtsp:[2/1 (17), S_WAIT_RELEASE, E_TSP_CALL_FEATURE_IND]
*Mar 1 00:45:01.667: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_call_feature_ind: .
*Mar 1 00:45:01.667: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_process_event: vtsp:[2/1 (17), S_WAIT_RELEASE, E_TSP_DISCONNECT_CONF]
*Mar 1 00:45:01.667: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_wrelease_release: .
*Mar 1 00:45:01.667: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_play_busy_timer_stop:
*Mar 1 00:45:01.667: vtsp_play_busy_timer_stop: 270166
*Mar 1 00:45:01.667: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_timer_stop: 270166
*Mar 1 00:45:01.671: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_do_call_history: .
*Mar 1 00:45:01.671: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_do_call_history:
*Mar 1 00:45:01.671: vtsp_do_call_history : src carrier id
  *Mar 1 00:45:01.671: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_do_call_history:
*Mar 1 00:45:01.671: vtsp_do_call_history : tgt carrier id
  *Mar  1 00:45:01.671: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_do_call_history: CoderRate 8

*Mar 1 00:45:01.675: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_process_event: vtsp:[2/1 (17), S_CLOSE_DSPRM, E_DSPRM_CLOSE_COMPLETE]
*Mar 1 00:45:01.679: //17/438AD0C50008/VTSP:(2/1):-1:0:1/act_terminate: .
*Mar 1 00:45:01.679: //17/438AD0C50008/VTSP:(2/1):-1:0:1/vtsp_free_cdb: ,cdb 0x82355B98
Router#
Router#        

  debug all    



santral arkasindaki telefondan arama yapilirken

        ^
% Invalid input detected at '^' marker.
  Router#
Router#
Router#
*Mar 1 00:16:30.235: cch323_ct_main: SOCK 0 Event 0x1
*Mar 1 00:16:30.235: h323chan_chn_process_read_socket: fd=0 of type LISTENING has data
  *Mar 1 00:16:30.235: Changing to new event: ACCEPT h323chan_chn_accept: fd=0
  *Mar 1 00:16:30.235: h323chan_gw_accept: TCP connection accepted from 10.0.0.95:21142 on fd=2
*Mar 1 00:16:30.239: h323chan_chn_accept: Local(0x0) accepts TCP conn from 10.0.0.95(0xA00005F) port (21142); fd=2changing from LISTENING state to ACCEPTED state
  *Mar 1 00:16:30.239: cch323_get_new_ccb: ccb (0x8235250C) is in use
*Mar 1 00:16:30.295: cch323_ct_main: SOCK 2 Event 0x1
*Mar 1 00:16:30.295: h323chan_chn_process_read_socket: fd=2 of type ACCEPTED has data
  *Mar 1 00:16:30.295: [1]towner_data=0x81FCB9A0, len=499, msgPtr=0x8235338C cch323_gw_process_read_socket: received msg for H.225 h225ParseData: Q.931 SETUP received on fd=2
*Mar 1 00:16:30.299: cch323_h225_receiver: received msg of type SETUPIND_CHOSEN
  *Mar 1 00:16:30.299: cch323_h225_receiver CCB existing from TCP accepted
*Mar 1 00:16:30.299: cch323_h225_receiver Got a new CCB for crv 32776
cch323_h225_setup_indcch323_h225_setup_ind: callingNumber[02165229820] calledNumber[410]   *Mar 1 00:16:30.299: cch323_h225_setup_ind---- calling IE present
*Mar 1 00:16:30.299: ======= PI in cch323_h225_setup_ind = 0

  *Mar  1 00:16:30.299: Receive: infoXCap 0
  *Mar  1 00:16:30.303: Receive infoXCap ccb 0
  *Mar  1 00:16:30.303: cch323_extract_signaled_carriers

*Mar 1 00:16:30.303: No Source IP group match with Src CarrierId/Zone ID
*Mar 1 00:16:30.303: No Source IP group matched with rte id/zone_id/acl.
*Mar 1 00:16:30.303: cch323_determine_source_group
*Mar 1 00:16:30.303: No Source IP group match with Incoming Called Number.
*Mar 1 00:16:30.303: cch323_determine_source_group
*Mar 1 00:16:30.303: No Source IP group match with Destination pattern.cch323_is_preauth_reqd is FALSE
*Mar 1 00:16:30.303: src address = 10.0.0.98 of SETUPIND_CHOSEN
*Mar 1 00:16:30.303: dest address = 10.0.0.95 of SETUPIND_CHOSEN
cch323_run_h225_sm: received event H225_EVENT_FAST_SETUP_IND while at state H225_IDLE
  *Mar  1 00:16:30.303: cch323_run_h225_sm: Setup ccb 0x8235250C callID 0xFFFFFFFF

*Mar 1 00:16:30.307: cch323_build_early_fastStart_cap_response: ccb->remote_fastStart=0x823577B0
*Mar 1 00:16:30.311: cch323_build_early_fastStart_cap_response:symm_mask=29448,tempOtherCodec=12,templocalCodec=12,audioFastStartArray=0x82381754
*Mar 1 00:16:30.311: Not using Voice Class Codec
  *Mar 1 00:16:30.315: cch323_set_peer: peer: 82093770, peer->voice_peer_tag: A, ccb: 8235250C
*Mar 1 00:16:30.315: cch323_build_early_fastStart_cap_response line 2502: Executing legacy code.
*Mar 1 00:16:30.315: Near-end Pref Codecs = G.723r63
*Mar 1 00:16:30.315: cch323_build_early_fastStart_cap_response line 2517: Executing legacy code.
*Mar 1 00:16:30.315: cch323_build_early_fastStart_cap_response: Inbound legs state_mc_mode=0x10F
*Mar 1 00:16:30.315: cch323_build_early_fastStart_cap_response line 2531: Executing legacy code.
*Mar 1 00:16:30.315: Codec: loc(8), rem(8),
Bytes: loc(24), Fwd(24), Rev(24)
  *Mar 1 00:16:30.315: Function: cch323_build_olc_for_ccapi, Line: 1198, audioFastStartArray=0x82381754
*Mar 1 00:16:30.315: cch323_build_olc_for_ccapi: channel_info ptr=0x8237E988, ccb ptr=0x8235250C
*Mar 1 00:16:30.315: cch323_build_olc_for_ccapi: Channel Information:
 Logical Channel Number (fwd/rev): 900
 Channel address (fwd/rev):        0xA00005F
 RTP  Channel (fwd/rev):           32778
 RTCP Channel (fwd/rev):           32779
 QoS Capability (fwd/rev):         0
 Symmetric Audio Cap Mask:         0x300
 Symmetric Audio Codec Bytes:      24
 Flow Mode:                        0
 Silence Suppression:              1

*Mar 1 00:16:30.319: cch323_build_olc_for_ccapi:NumOfElements = 1 idx = 1
*Mar 1 00:16:30.319: cch323_prepare_fastStart_cap_response line 2152
*Mar 1 00:16:30.319: cch323_prepare_fastStart_cap_response: Retrieved qosCapability of 0
  *Mar 1 00:16:30.319: cch323_prepare_fastStart_cap_response: In Response Filling in qosCapability field to 0   *Mar 1 00:16:30.319: h245_encode_faststart
*Mar 1 00:16:30.319: h245_encode_faststart
*Mar 1 00:16:30.323: cch323_prepare_fastStart_cap_response: callID 0xFFFFFFFF(-1), audioFastStartArray = 0x0.
*Mar 1 00:16:30.323: cch323_prepare_fastStart_cap_response, ccb->local_fastStart=0x82354DC8, srcAddr=0xA000062, lport=16718, rport=32778, rc=1
*Mar 1 00:16:30.323: cch323_do_cap_ind: IPIPGW:registry cap_ind is not done.
*Mar 1 00:16:30.323: cch323_h225_act_fastStartSetupInd: codec match = 1
*Mar 1 00:16:30.323: Not using Voice Class Codec
  *Mar 1 00:16:30.323: cch323_set_peer: peer: 82093770, peer->voice_peer_tag: A, ccb: 8235250C
*Mar 1 00:16:30.323: cch323_h225_process_fastStart_setup_for_qos: This seems to be a normal call with Sync OFF; just do a generic notify
*Mar 1 00:16:30.323: cch323_h225_generic_setup_treatment:raw message is 54 bytes:1C 34 9E 01 00 03 67 74 64 00 00 00 29 49 41 4D 2C 0D 0A 47 45 41 2C 74 72 73 33 2C 30 30 2C 31 2C 79 2C 79 2C 31 2C 30 32 31 36 35 32 32 39 38 32 30 0D 0A 0D 0A
*Mar 1 00:16:30.327: cch323_set_h245_state_mc_mode_incoming: h245 state m/c mode=0x10F
*Mar 1 00:16:30.327: cch323_create_incoming_callinfo_block: peer 81B0ADCC, (*peer)->voice_peer_tag 10, ccb: 8235250C
*Mar 1 00:16:30.331: Playout Mode: 1,Init 60, Min 40, Max 300, Fax 300
*Mar 1 00:16:30.331: Not using Voice Class Codec
  *Mar 1 00:16:30.331: cch323_set_peer: peer: 82093770, peer->voice_peer_tag: A, ccb: 8235250C
*Mar 1 00:16:30.331: cch323_update_carriers_in_call_info ccb->tg_label_flag 0x0
*Mar 1 00:16:30.335: cch323_rtp_open_notify:
*Mar 1 00:16:30.335: H.225 SM: changing from H225_IDLE state to H225_REQ_SETUP state for callID 3
  *Mar 1 00:16:30.335: cch323_rsvp_procedures_on_receiving_setup_ind: srcAddres=0xA000062, destAddress=0xA00005F, lport=16718, rport=32778 desired_qos=2, negotiated_codec=8, negotiated_codec_bytes=24
*Mar 1 00:16:30.335: cch323_rsvp_procedures_on_receiving_setup_ind:A Call to QoSListen succeded for callID 3
  *Mar 1 00:16:30.335: cch323_rsvp_procedures_on_receiving_setup_ind:A Call to QoSResv succeded for callID 3   *Mar 1 00:16:30.351: cch323_media_flow_mode: IPIPGW(3):Flow Mode=1
*Mar 1 00:16:30.351: cch323_do_set_dialpeer_tag: gw_id=1, callID=3
  *Mar 1 00:16:30.359: cch323_report_digit_control: enable=0: disabled.
*Mar 1 00:16:30.359: cch323_do_get_dialpeer_tag: gw_id=1, callID=3
  *Mar 1 00:16:30.359: cch323_do_get_dialpeer_tag: gw_id=1, callID=3   *Mar 1 00:16:30.359: cch323_rtp_open_notify:
*Mar 1 00:16:30.363: cch323_post_caps_ind: IPIPGW(3): ExtendedCapsNot Present
  *Mar  1 00:16:30.363: cch323_do_call_proceeding: gw_id=1, callID=3
  *Mar  1 00:16:30.363: H.225 SM: process event H225_EVENT_CALLPROC, for callID 3cch323_run_h225_sm: received event H225_EVENT_CALLPROC while at state H225_REQ_SETUP
  *Mar  1 00:16:30.363: H.225 SM: changing from H225_REQ_SETUP state to H225_ACC_CALLPROC state for callID 3
  *Mar  1 00:16:30.363:  ======= PI in cch323_h225_generic_send_callproc = 0
  *Mar  1 00:16:30.363: compose_TunnelledSignallingMessage_ciscoNo tunnelled content.
Hex representation of the CALL PROCEEDING TPKT to send.08028008027E006C052180060008914A00042800B5000012400138088E001100438486F5BE42DAB3000800809F04D5E73B021A0003830D0000400011140001000A000062414E000A000062414F1E400000060401004D0000400011140001000A00005F800A000A000062414F0100010010800180
*Mar 1 00:16:30.371: h225CallProcRequest: Q.931 CALL PROCEEDING sent fromfd=2.cch323_call_alert: gw_id=1, callID=3
  *Mar  1 00:16:30.375: H.225 SM: process event H225_EVENT_ALERT, for callID 3cch323_run_h225_sm: received event H225_EVENT_ALERT while at state H225_ACC_CALLPROC
  *Mar  1 00:16:30.375: H.225 SM: changing from H225_ACC_CALLPROC state to H225_ACC_ALERT state for callID 3
  *Mar  1 00:16:30.375:  ======= PI in cch323_h225_generic_send_alert = 8
  *Mar  1 00:16:30.375: compose_TunnelledSignallingMessage_ciscoNo tunnelled content.
Hex representation of the ALERTING TPKT to send.08028008011E0280883401017E0030052380060008914A00042800B50000124001380D86001100438486F5BE42DAB3000800809F04D5E70100010010800180
*Mar 1 00:16:30.379: h225AlertRequest: Q.931 ALERTING sent from fd=2. Call state changed to [Call Received].
*Mar 1 00:16:30.379: cch323_caps_ind: cap_modem_proto: 0, cap_modem_codec: 0, cap_modem_redundancy: 0 payload 100, modem_relay 0 gw_xid 0
*Mar 1 00:16:30.379: cch323_caps_ind: Load DSP with Negotiated codec(8) g723r63, Bytes=24
*Mar 1 00:16:30.383: cch323_caps_ind: set DSP for dtmf-relay = CC_CAP_DTMF_RELAY_INBAND_VOICE
*Mar 1 00:16:30.387: cch323_peer_caps_ack: IPIPGW(3):sending caps resp event to CAP state mc.
*Mar 1 00:16:30.387: cch323_peer_caps_ack: IPIPGW:ccb not interested in caps_ack primitive.
*Mar 1 00:16:38.515: cch323_do_get_dialpeer_tag: gw_id=1, callID=3
cch323_call_connect: gw_id=1, callID=3
  *Mar  1 00:16:38.519: H.225 SM: process event H225_EVENT_SETUP_CFM, for callID 3cch323_run_h225_sm: received event H225_EVENT_SETUP_CFM while at state H225_ACC_ALERT
  *Mar  1 00:16:38.519: ======= PI in cch323_h225_generic_send_setup_cfm = 2
  *Mar  1 00:16:38.519: compose_TunnelledSignallingMessage_ciscoNo tunnelled content.
Hex representation of the CONNECT TPKT to send.080280080704038090A31E0280827E0055052280060008914A00042800B500001240013800438486F5BE42DA8A000800809F04D5E71D0C001100438486F5BE42DAB3000800809F04D5E70100010010A00180130140B50000120CC00100048006000400000002
*Mar 1 00:16:38.527: h225SetupResponse: Q.931 CONNECT sent from fd=2cch323_h225_active_notify:
  *Mar 1 00:16:38.527: H.225 SM: changing from H225_ACC_ALERT state to H225_ACTIVE_FASTSTART state for callID 3   *Mar 1 00:16:38.539: cch323_ct_main: SOCK 2 Event 0x1
*Mar 1 00:16:38.539: h323chan_chn_process_read_socket: fd=2 of type ACCEPTED has data
  *Mar 1 00:16:38.539: [1]towner_data=0x81FCB9A0, len=22, msgPtr=0x8237E8E0 cch323_gw_process_read_socket: received msg for H.225 h225ParseData: Q.931 FACILITY received for fd=2
*Mar 1 00:16:38.539: cch323_h225_receiver: received msg of type FACILIND_CHOSEN
  *Mar 1 00:16:38.539: Processing tunneled message   *Mar 1 00:16:38.539: Changing to new event H245_CONNECT_REQ_EVENT
*Mar 1 00:16:38.539: cch323_h245_connection_sm: state = 0 event=1 ccb=8235250C
*Mar 1 00:16:38.543: cch323_h245_connection_sm: listen state=0
*Mar 1 00:16:38.543: cch323_h245_connection_sm:H245_CONNECT: received event H245_CONNECT_REQ_EVENT while at H245_NONE state
  *Mar 1 00:16:38.543: in connection_sm..doing tunneling changing from H245_NONE state to H245_CONNECTED state
*Mar 1 00:16:38.543: cch323_h245_start_cap_sm: IPIPGW(3): starting the cap/msd machine.
*Mar 1 00:16:38.543: Set new event H245_EVENT_CAP_REQ, for callID 3
*Mar 1 00:16:38.543: cch323_run_h245_cap_out_sm: received event H245_EVENT_CAP_REQ while at state H245_CAP_NONE
*Mar 1 00:16:38.543: cch323_send_generic_caps: IPIPGW: audiomask raw =0x7BFF.
*Mar 1 00:16:38.543: Using DP configured Codecs
*Mar 1 00:16:38.543: Near-end Pref Codecs = G.723r63
*Mar 1 00:16:38.543: cch323_send_generic_caps:IPIPGW:[reg]audio mask after operation=0x100.
*Mar 1 00:16:38.543: send_caps_request: included rtp in caps table
  *Mar 1 00:16:38.543: send_caps_request: included signal in caps table
*Mar 1 00:16:38.547: send_caps_request: included alpha in caps table
*Mar 1 00:16:38.547: send_caps_request: included hookflash in caps table
*Mar 1 00:16:38.547: cch323_send_cap_request: included rtp-nte in caps table
*Mar 1 00:16:38.547: h245_encode_terminalCapabilitySet_request
*Mar 1 00:16:38.547: H.225 SM: process event H225_EVENT_TRANSMIT_TUNNELING, for callID 3cch323_run_h225_sm: received event H225_EVENT_TRANSMIT_TUNNELING while at state H225_ACTIVE_FASTSTART
  *Mar 1 00:16:38.551: compose_TunnelledSignallingMessage_ciscoNo tunnelled content. Hex representation of the FACILITY TPKT to send.08028008621C002813636973636F2053797374656D732C20496E632E7E00AC052690060008914A0004438486F5BE42DA8A000800809F04D5E78601001F01801100438486F5BE42DAB3000800809F04D5E70100010010C0018071016F027001060008817500078013800014000100000100000100000CC0010001000580001D8A061404302D31368000134810B50000120C52747044746D6652656C61790000800019830150800018830140800015830110800008220000000080010200001903001D001800150013000008
*Mar 1 00:16:38.563: h225FacilityRequest: Q.931 FACILITY sent from fd=2
*Mar 1 00:16:38.563: changing from H245_CAP_NONE state to H245_CAP_WAIT state
*Mar 1 00:16:38.563: Changing to new event H245_EVENT_MSD, for callID 3
  *Mar 1 00:16:38.563: cch323_run_h245_ms_sm: received event H245_EVENT_MSD while at state H245_MS_NONE
*Mar 1 00:16:38.563: h245_encode_masterSlaveDetermination_request
*Mar 1 00:16:38.563: H.225 SM: process event H225_EVENT_TRANSMIT_TUNNELING, for callID 3cch323_run_h225_sm: received event H225_EVENT_TRANSMIT_TUNNELING while at state H225_ACTIVE_FASTSTART
  *Mar 1 00:16:38.567: compose_TunnelledSignallingMessage_ciscoNo tunnelled content. Hex representation of the FACILITY TPKT to send.08028008621C002813636973636F2053797374656D732C20496E632E7E0043052690060008914A0004438486F5BE42DA8A000800809F04D5E78601001F01801100438486F5BE42DAB3000800809F04D5E70100010010C0018008010601003C400B72
*Mar 1 00:16:38.571: h225FacilityRequest: Q.931 FACILITY sent from fd=2
*Mar 1 00:16:38.571: changing from H245_MS_NONE state to H245_MS_OUTGOING_WAIT state
cch323_run_h245_ms_sm: Sent MSD Request
  *Mar 1 00:16:38.575: Changing to new event H245_PROCESS_H245CONTROL
*Mar 1 00:16:38.575: cch323_h245_connection_sm: state = 2 event=5 ccb=8235250C
*Mar 1 00:16:38.575: cch323_h245_connection_sm: listen state=0
*Mar 1 00:16:38.575: cch323_h245_connection_sm:H245_CONNECT: received event H245_PROCESS_H245CONTROL while at H245_CONNECTED state
  *Mar 1 00:16:38.575: h245_decode_remote_message: received Request PDU
*Mar 1 00:16:38.575: h245_decode_remote_request: received Round Trip Delay Request message
*Mar 1 00:16:38.575: h245_decode_remote_request: request type not supported (10)
*Mar 1 00:16:38.575: src address = 10.0.0.98 of FACILIND_CHOSEN
*Mar 1 00:16:38.575: dest address = 10.0.0.95 of FACILIND_CHOSEN
cch323_run_h225_sm: received event H225_EVENT_FACILITY_IND while at state H225_ACTIVE_FASTSTART   *Mar 1 00:16:38.579: cch323_ct_main: SOCK 2 Event 0x1
*Mar 1 00:16:38.579: h323chan_chn_process_read_socket: fd=2 of type ACCEPTED has data
  *Mar 1 00:16:38.579: [1]towner_data=0x81FCB9A0, len=190, msgPtr=0x82092614 cch323_gw_process_read_socket: received msg for H.225 h225ParseData: Q.931 FACILITY received for fd=2
*Mar 1 00:16:38.579: cch323_h225_receiver: received msg of type FACILIND_CHOSEN
  *Mar 1 00:16:38.583: Processing tunneled message   *Mar 1 00:16:38.583: Changing to new event H245_PROCESS_H245CONTROL
*Mar 1 00:16:38.583: cch323_h245_connection_sm: state = 2 event=5 ccb=8235250C
*Mar 1 00:16:38.583: cch323_h245_connection_sm: listen state=0
*Mar 1 00:16:38.583: cch323_h245_connection_sm:H245_CONNECT: received event H245_PROCESS_H245CONTROL while at H245_CONNECTED state
  *Mar 1 00:16:38.587: h245_decode_remote_message: received Request PDU
*Mar 1 00:16:38.587: h245_decode_remote_request: received Terminal Capability Set message
*Mar 1 00:16:38.587: h245_decode_cap_entry: unknown/unsupported choice (15)
*Mar 1 00:16:38.587: h245_decode_cap_entry: unknown/unsupported choice (15)
*Mar 1 00:16:38.591: cch323_h245_cap_ind: IPIPGW(3): masks au=0x7B0C data=0x4 uinp=0x1E.
*Mar 1 00:16:38.591: Set new event H245_EVENT_CAP_IND, for callID 3
*Mar 1 00:16:38.591: cch323_run_h245_cap_in_sm: received event H245_EVENT_CAP_IND while at state H245_CAP_IDLE
*Mar 1 00:16:38.591: cch323_run_h245_cap_in_sm:IPIPGW(3): got incoming CAPSET msg.
*Mar 1 00:16:38.591: cch323_run_h245_cap_in_sm: IPIPGW(3): we know our local caps.
*Mar 1 00:16:38.591: Set new event H245_EVENT_CAP_REQ, for callID 3
*Mar 1 00:16:38.591: cch323_run_h245_cap_out_sm: received event H245_EVENT_CAP_REQ while at state H245_CAP_WAIT
*Mar 1 00:16:38.591: cch323_run_h245_cap_out_sm: Invalid event H245_EVENT_CAP_REQ for state H245_CAP_WAIT
*Mar 1 00:16:38.591: changing from H245_CAP_IDLE state to H245_CAP_AWAITING_RESPONSE state
*Mar 1 00:16:38.595: cch323_check_cap: Remote audio mask is 7B0C
*Mar 1 00:16:38.595: Remote Pref Codecs UnOrdered = [G729IETF], [G729a], [G729b], [G729ab], [G723ar63], [G723ar53], [G723r63], [G723r53],
*Mar 1 00:16:38.595: cch323_check_cap: Audio Mask 0x7B0C, Negotiated Codec(8) G723r63 Codec Bytes 24
*Mar 1 00:16:38.595: cch323_check_data_and_usr_inp_cap: peer_data_cap_mask=0x4,peer_user_input_cap_mask=0x1E
*Mar 1 00:16:38.595: Sending digits as inband voice. No configured peer
*Mar 1 00:16:38.595: cch323_check_data_and_usr_inp_cap: Negotiated DTMF relay - 0x0
*Mar 1 00:16:38.595: cch323_do_cap_ind: Load codec(8) g723r63, codec_bytes = 24
*Mar 1 00:16:38.595: cch323_do_cap_ind: cap_modem_proto: 0, cap_modem_codec: 0, cap_modem_redundancy: 0, modem_relay 0 gw_xid 0
*Mar 1 00:16:38.595: cch323_do_cap_ind: negotiated dtmf relay is inband voice
  *Mar 1 00:16:38.595: cch323_do_cap_ind: IPIPGW(3):sending caps to the other leg.
*Mar 1 00:16:38.595: cch323_do_cap_ind: IPIPGW(3):SENDING caps_ack bcoz NTFY DSP set
*Mar 1 00:16:38.599: cch323_h245_cap_notify:IPIPGW(3): xmiting capsetack: lcl caps known.
*Mar 1 00:16:38.599: Set new event H245_EVENT_CAP_RESP, for callID 3
*Mar 1 00:16:38.599: cch323_run_h245_cap_in_sm: received event H245_EVENT_CAP_RESP while at state H245_CAP_AWAITING_RESPONSE
*Mar 1 00:16:38.599: h245_encode_terminalCapabilitySetAck_response
*Mar 1 00:16:38.599: H.225 SM: process event H225_EVENT_TRANSMIT_TUNNELING, for callID 3cch323_run_h225_sm: received event H225_EVENT_TRANSMIT_TUNNELING while at state H225_ACTIVE_FASTSTART
  *Mar 1 00:16:38.599: compose_TunnelledSignallingMessage_ciscoNo tunnelled content. Hex representation of the FACILITY TPKT to send.08028008621C002813636973636F2053797374656D732C20496E632E7E0040052690060008914A0004438486F5BE42DA8A000800809F04D5E78601001F01801100438486F5BE42DAB3000800809F04D5E70100010010C00180050103218001
*Mar 1 00:16:38.607: h225FacilityRequest: Q.931 FACILITY sent from fd=2
*Mar 1 00:16:38.607: changing from H245_CAP_AWAITING_RESPONSE state to H245_CAP_IDLE state
*Mar 1 00:16:38.607: cch323_check_data_and_usr_inp_cap: peer_data_cap_mask=0x4,peer_user_input_cap_mask=0x1E
*Mar 1 00:16:38.607: Sending digits as inband voice. No configured peer
*Mar 1 00:16:38.607: cch323_check_data_and_usr_inp_cap: Negotiated DTMF relay - 0x0
*Mar 1 00:16:38.607: cap_notify: check_data_and_usr_inp returned
*Mar 1 00:16:38.607: src address = 10.0.0.98 of FACILIND_CHOSEN
*Mar 1 00:16:38.611: dest address = 10.0.0.95 of FACILIND_CHOSEN
cch323_run_h225_sm: received event H225_EVENT_FACILITY_IND while at state H225_ACTIVE_FASTSTART   *Mar 1 00:16:38.611: cch323_ct_main: SOCK 2 Event 0x1
*Mar 1 00:16:38.611: h323chan_chn_process_read_socket: fd=2 of type ACCEPTED has data
  *Mar 1 00:16:38.611: [1]towner_data=0x81FCB9A0, len=26, msgPtr=0x82380BB0 cch323_gw_process_read_socket: received msg for H.225 h225ParseData: Q.931 FACILITY received for fd=2
*Mar 1 00:16:38.611: cch323_h225_receiver: received msg of type FACILIND_CHOSEN
  *Mar 1 00:16:38.611: Processing tunneled message   *Mar 1 00:16:38.611: Changing to new event H245_PROCESS_H245CONTROL
*Mar 1 00:16:38.615: cch323_h245_connection_sm: state = 2 event=5 ccb=8235250C
*Mar 1 00:16:38.615: cch323_h245_connection_sm: listen state=0
*Mar 1 00:16:38.615: cch323_h245_connection_sm:H245_CONNECT: received event H245_PROCESS_H245CONTROL while at H245_CONNECTED state
  *Mar 1 00:16:38.615: h245_decode_remote_message: received Request PDU
*Mar 1 00:16:38.615: h245_decode_remote_request: received Master/Slave Determination message
*Mar 1 00:16:38.615: Changing to new event H245_EVENT_MS_IND, for callID 3
  *Mar  1 00:16:38.615: cch323_run_h245_ms_sm: received event H245_EVENT_MS_IND while at state H245_MS_OUTGOING_WAITMSDetermination: rtt=50 rsdnum=7929615, ltt=60 lsdnum=2930
MSDetermination: Am MASTER, ccb->h245.h245_mdStatus = 0x1
  *Mar  1 00:16:38.615: h245_encode_masterSlaveDeterminationAck_response

*Mar 1 00:16:38.615: H.225 SM: process event H225_EVENT_TRANSMIT_TUNNELING, for callID 3cch323_run_h225_sm: received event H225_EVENT_TRANSMIT_TUNNELING while at state H225_ACTIVE_FASTSTART
  *Mar 1 00:16:38.619: compose_TunnelledSignallingMessage_ciscoNo tunnelled content. Hex representation of the FACILITY TPKT to send.08028008621C002813636973636F2053797374656D732C20496E632E7E003F052690060008914A0004438486F5BE42DA8A000800809F04D5E78601001F01801100438486F5BE42DAB3000800809F04D5E70100010010C0018004010220A0
*Mar 1 00:16:38.623: h225FacilityRequest: Q.931 FACILITY sent from fd=2MS_Determine_indication to Appl!
  *Mar 1 00:16:38.623: changing from H245_MS_OUTGOING_WAIT state to H245_MS_INCOMING_WAIT state cch323_run_h245_ms_sm: Sent MSD ACK!
  *Mar 1 00:16:38.627: src address = 10.0.0.98 of FACILIND_CHOSEN
*Mar 1 00:16:38.627: dest address = 10.0.0.95 of FACILIND_CHOSEN
cch323_run_h225_sm: received event H225_EVENT_FACILITY_IND while at state H225_ACTIVE_FASTSTART   *Mar 1 00:16:38.627: cch323_peer_caps_ack: IPIPGW(3):sending caps resp event to CAP state mc.
*Mar 1 00:16:38.627: cch323_peer_caps_ack: IPIPGW:ccb not interested in caps_ack primitive.
*Mar 1 00:16:40.539: cch323_ct_main: SOCK 2 Event 0x1
*Mar 1 00:16:40.539: h323chan_chn_process_read_socket: fd=2 of type ACCEPTED has data
  *Mar 1 00:16:40.539: [1]towner_data=0x81FCB9A0, len=176, msgPtr=0x82355530 cch323_gw_process_read_socket: received msg for H.225 h225ParseData: Q.931 FACILITY received for fd=2
*Mar 1 00:16:40.543: cch323_h225_receiver: received msg of type FACILIND_CHOSEN
  *Mar 1 00:16:40.543: Processing tunneled message   *Mar 1 00:16:40.543: Changing to new event H245_PROCESS_H245CONTROL
*Mar 1 00:16:40.543: cch323_h245_connection_sm: state = 2 event=5 ccb=8235250C
*Mar 1 00:16:40.543: cch323_h245_connection_sm: listen state=0
*Mar 1 00:16:40.543: cch323_h245_connection_sm:H245_CONNECT: received event H245_PROCESS_H245CONTROL while at H245_CONNECTED state
  *Mar 1 00:16:40.547: h245_decode_remote_message: received Request PDU
*Mar 1 00:16:40.547: h245_decode_remote_request: received Terminal Capability Set message
*Mar 1 00:16:40.547: h245_decode_cap_entry: unknown/unsupported choice (15)
*Mar 1 00:16:40.547: h245_decode_cap_entry: unknown/unsupported choice (15)
*Mar 1 00:16:40.551: cch323_h245_cap_ind: IPIPGW(3): masks au=0x7B0C data=0x0 uinp=0x1E.
*Mar 1 00:16:40.551: Set new event H245_EVENT_CAP_IND, for callID 3
*Mar 1 00:16:40.551: cch323_run_h245_cap_in_sm: received event H245_EVENT_CAP_IND while at state H245_CAP_IDLE
*Mar 1 00:16:40.551: cch323_run_h245_cap_in_sm:IPIPGW(3): got incoming CAPSET msg.
*Mar 1 00:16:40.551: cch323_run_h245_cap_in_sm: IPIPGW(3): we know our local caps.
*Mar 1 00:16:40.551: Set new event H245_EVENT_CAP_REQ, for callID 3
*Mar 1 00:16:40.551: cch323_run_h245_cap_out_sm: received event H245_EVENT_CAP_REQ while at state H245_CAP_WAIT
*Mar 1 00:16:40.551: cch323_run_h245_cap_out_sm: Invalid event H245_EVENT_CAP_REQ for state H245_CAP_WAIT
*Mar 1 00:16:40.551: changing from H245_CAP_IDLE state to H245_CAP_AWAITING_RESPONSE state
*Mar 1 00:16:40.555: cch323_check_cap: Remote audio mask is 7B0C
*Mar 1 00:16:40.555: Remote Pref Codecs UnOrdered = [G729IETF], [G729a], [G729b], [G729ab], [G723ar63], [G723ar53], [G723r63], [G723r53],
*Mar 1 00:16:40.555: cch323_check_cap: Audio Mask 0x7B0C, Negotiated Codec(8) G723r63 Codec Bytes 24
*Mar 1 00:16:40.555: cch323_check_data_and_usr_inp_cap: peer_data_cap_mask=0x0,peer_user_input_cap_mask=0x1E
*Mar 1 00:16:40.555: Sending digits as inband voice. No configured peer
*Mar 1 00:16:40.555: cch323_check_data_and_usr_inp_cap: Negotiated DTMF relay - 0x0
*Mar 1 00:16:40.555: cch323_do_cap_ind: Load codec(8) g723r63, codec_bytes = 24
*Mar 1 00:16:40.555: cch323_do_cap_ind: cap_modem_proto: 0, cap_modem_codec: 0, cap_modem_redundancy: 0, modem_relay 0 gw_xid 0
*Mar 1 00:16:40.555: cch323_do_cap_ind: negotiated dtmf relay is inband voice
  *Mar 1 00:16:40.555: cch323_do_cap_ind: IPIPGW(3):sending caps to the other leg.
*Mar 1 00:16:40.559: cch323_do_cap_ind: IPIPGW(3):SENDING caps_ack bcoz NTFY DSP set
*Mar 1 00:16:40.559: cch323_h245_cap_notify:IPIPGW(3): xmiting capsetack: lcl caps known.
*Mar 1 00:16:40.559: Set new event H245_EVENT_CAP_RESP, for callID 3
*Mar 1 00:16:40.559: cch323_run_h245_cap_in_sm: received event H245_EVENT_CAP_RESP while at state H245_CAP_AWAITING_RESPONSE
*Mar 1 00:16:40.559: h245_encode_terminalCapabilitySetAck_response
*Mar 1 00:16:40.559: H.225 SM: process event H225_EVENT_TRANSMIT_TUNNELING, for callID 3cch323_run_h225_sm: received event H225_EVENT_TRANSMIT_TUNNELING while at state H225_ACTIVE_FASTSTART
  *Mar 1 00:16:40.559: compose_TunnelledSignallingMessage_ciscoNo tunnelled content. Hex representation of the FACILITY TPKT to send.08028008621C002813636973636F2053797374656D732C20496E632E7E0040052690060008914A0004438486F5BE42DA8A000800809F04D5E78601001F01801100438486F5BE42DAB3000800809F04D5E70100010010C00180050103218002
*Mar 1 00:16:40.567: h225FacilityRequest: Q.931 FACILITY sent from fd=2
*Mar 1 00:16:40.567: changing from H245_CAP_AWAITING_RESPONSE state to H245_CAP_IDLE state
*Mar 1 00:16:40.567: cch323_check_data_and_usr_inp_cap: peer_data_cap_mask=0x0,peer_user_input_cap_mask=0x1E
*Mar 1 00:16:40.567: Sending digits as inband voice. No configured peer
*Mar 1 00:16:40.567: cch323_check_data_and_usr_inp_cap: Negotiated DTMF relay - 0x0
*Mar 1 00:16:40.567: cap_notify: check_data_and_usr_inp returned
*Mar 1 00:16:40.567: src address = 10.0.0.98 of FACILIND_CHOSEN
*Mar 1 00:16:40.571: dest address = 10.0.0.95 of FACILIND_CHOSEN
cch323_run_h225_sm: received event H225_EVENT_FACILITY_IND while at state H225_ACTIVE_FASTSTART   *Mar 1 00:16:40.571: cch323_peer_caps_ack: IPIPGW(3):sending caps resp event to CAP state mc.
*Mar 1 00:16:40.571: cch323_peer_caps_ack: IPIPGW:ccb not interested in caps_ack primitive.
*Mar 1 00:16:42.543: cch323_ct_main: SOCK 2 Event 0x1
*Mar 1 00:16:42.543: h323chan_chn_process_read_socket: fd=2 of type ACCEPTED has data
  *Mar 1 00:16:42.543: [1]towner_data=0x81FCB9A0, len=21, msgPtr=0x8237E8E0 cch323_gw_process_read_socket: received msg for H.225 h225ParseData: Q.931 FACILITY received for fd=2
*Mar 1 00:16:42.543: cch323_h225_receiver: received msg of type FACILIND_CHOSEN
  *Mar 1 00:16:42.547: Processing tunneled message   *Mar 1 00:16:42.547: Changing to new event H245_PROCESS_H245CONTROL
*Mar 1 00:16:42.547: cch323_h245_connection_sm: state = 2 event=5 ccb=8235250C
*Mar 1 00:16:42.547: cch323_h245_connection_sm: listen state=0
*Mar 1 00:16:42.547: cch323_h245_connection_sm:H245_CONNECT: received event H245_PROCESS_H245CONTROL while at H245_CONNECTED state
  *Mar 1 00:16:42.547: h245_decode_remote_message: received Indication PDU
*Mar 1 00:16:42.547: h245_decode_remote_indication: received Terminal Capability Set Release message
*Mar 1 00:16:42.547: Set new event H245_EVENT_CAP_REL, for callID 3
*Mar 1 00:16:42.547: cch323_run_h245_cap_in_sm: received event H245_EVENT_CAP_REL while at state H245_CAP_IDLE
*Mar 1 00:16:42.551: src address = 10.0.0.98 of FACILIND_CHOSEN
*Mar 1 00:16:42.551: dest address = 10.0.0.95 of FACILIND_CHOSEN
cch323_run_h225_sm: received event H225_EVENT_FACILITY_IND while at state H225_ACTIVE_FASTSTART   *Mar 1 00:16:42.599: cch323_ct_main: SOCK 2 Event 0x1
*Mar 1 00:16:42.599: h323chan_chn_process_read_socket: fd=2 of type ACCEPTED has data
  *Mar 1 00:16:42.599: [1]towner_data=0x81FCB9A0, len=21, msgPtr=0x8237E8E0 cch323_gw_process_read_socket: received msg for H.225 h225ParseData: Q.931 FACILITY received for fd=2
*Mar 1 00:16:42.599: cch323_h225_receiver: received msg of type FACILIND_CHOSEN
  *Mar 1 00:16:42.599: Processing tunneled message   *Mar 1 00:16:42.599: Changing to new event H245_PROCESS_H245CONTROL
*Mar 1 00:16:42.599: cch323_h245_connection_sm: state = 2 event=5 ccb=8235250C
*Mar 1 00:16:42.599: cch323_h245_connection_sm: listen state=0
*Mar 1 00:16:42.599: cch323_h245_connection_sm:H245_CONNECT: received event H245_PROCESS_H245CONTROL while at H245_CONNECTED state
  *Mar 1 00:16:42.603: h245_decode_remote_message: received Command PDU
*Mar 1 00:16:42.603: h245_decode_remote_command: received End Session Command message
*Mar 1 00:16:42.603: h245_encode_endSessionCommand_command
*Mar 1 00:16:42.603: H.225 SM: process event H225_EVENT_TRANSMIT_TUNNELING, for callID 3cch323_run_h225_sm: received event H225_EVENT_TRANSMIT_TUNNELING while at state H225_ACTIVE_FASTSTART
  *Mar 1 00:16:42.603: compose_TunnelledSignallingMessage_ciscoNo tunnelled content. Hex representation of the FACILITY TPKT to send.08028008621C002813636973636F2053797374656D732C20496E632E7E003F052690060008914A0004438486F5BE42DA8A000800809F04D5E78601001F01801100438486F5BE42DAB3000800809F04D5E70100010010C001800401024A40
*Mar 1 00:16:42.611: h225FacilityRequest: Q.931 FACILITY sent from fd=2
*Mar 1 00:16:42.611: src address = 10.0.0.98 of FACILIND_CHOSEN
*Mar 1 00:16:42.611: dest address = 10.0.0.95 of FACILIND_CHOSEN
cch323_run_h225_sm: received event H225_EVENT_FACILITY_IND while at state H225_ACTIVE_FASTSTART   *Mar 1 00:16:42.611: cch323_ct_main: SOCK 2 Event 0x1
*Mar 1 00:16:42.611: h323chan_chn_process_read_socket: fd=2 of type ACCEPTED has data
  *Mar 1 00:16:42.615: [1]towner_data=0x81FCB9A0, len=46, msgPtr=0x82355530 cch323_gw_process_read_socket: received msg for H.225 h225ParseData: Q.931 RELEASE COMPLETE received on fd=2
*Mar 1 00:16:42.615: cch323_h225_receiver: received msg of type RELEASEIND_CHOSEN
  *Mar 1 00:16:42.615: cch323_h225_release_ind: disconnect cause 16 location code 1
*Mar 1 00:16:42.615: h323_set_release_source_for_peer: ownCallId[3], src[2]
  *Mar 1 00:16:42.615: src address = 10.0.0.98 of RELEASEIND_CHOSEN
*Mar 1 00:16:42.615: dest address = 10.0.0.95 of RELEASEIND_CHOSEN
cch323_run_h225_sm: received event H225_EVENT_RELEASE_IND while at state H225_ACTIVE_FASTSTART cch323_traverse_enum_contact_list: state = 10   *Mar 1 00:16:42.619: cch323_ct_main: SOCK 2 Event 0x1
*Mar 1 00:16:42.619: h323chan_chn_process_read_socket: fd=2 of type ACCEPTED has data
  *Mar 1 00:16:42.619: h323chan_recvdata: Connection lost fd=2h323chan_chn_close: Calls[1] Exist on socketfd=2 Owner[2]   *Mar 1 00:16:42.619: h323_gw_clean_send_blocked_watch: fd 2
*Mar 1 00:16:42.619: h323chan_close: TCP connection from fd=2 closed
*Mar 1 00:16:42.619: H.225 SM: process event H225_EVENT_CONN_LOST, for callID 3cch323_run_h225_sm: received event H225_EVENT_CONN_LOST while at state H225_ACTIVE_FASTSTART
cch323_cleanup_xport: hashDestroy for TcpFDTbl cch323_do_call_disconnect: gw_id=1, callID=3   *Mar 1 00:16:42.627: H.225 SM: process event H225_EVENT_RELEASE, for callID 3cch323_run_h225_sm: received event H225_EVENT_RELEASE while at state H225_ACTIVE_FASTSTART   *Mar 1 00:16:42.627: H.225 SM: changing from H225_ACTIVE_FASTSTART state to H225_IDLE state for callID 3 cch323_call_generic_cleanup: for callID 3 disconnected flag 1   *Mar 1 00:16:42.627: Call Active Playout Mode: 1,Init 60, Min 40, Max 300, Fax 300
*Mar 1 00:16:42.627: Call History Playout Mode: 1,Init 60, Min 40, Max 300, Fax 300
*Mar 1 00:16:42.631: cch323_call_generic_cleanup: freeing ccb (0x8235250C)
Router#
Router#
Router#--------------------------------------------
Router#router arkasindaki telefondan arama yaparken
Router#--------------------------------------------
Router#
Router#
Router#
Router#router acch323_post_call_setup_request: for callID 6
cch323_call_setup: gw_id=1, callID=6
  *Mar 1 00:16:48.291: cch323_get_new_ccb: ccb (0x8235250C) is in usecch323_call_setup: inserted ccb   *Mar 1 00:16:48.291: cch323_call_setup: callID 0x6(6), no peer leg setup params
*Mar 1 00:16:48.295: cch323_get_peer_info line 1022:
*Mar 1 00:16:48.295: cch323_get_peer_info line 1026:cch323_get_peer_info:faxrate[24]proto[3]bitmask[10082]t38_inhibit[0]global_fax[0]t38fax[0]
  *Mar 1 00:16:48.295: cch323_set_pref_codec_list:IPIPGW(6):first preferred codec(bytes)=8(24)
*Mar 1 00:16:48.295: cch323_get_peer_info: preferred_codec set to G723r63 with Bytes = 24
*Mar 1 00:16:48.295: cch323_get_peer_info: Flow Mode set to FLOW_THROUGH for callId 6
*Mar 1 00:16:48.295: cch323_get_peer_info: peer: 82093770, peer->voice_peer_tag: A, ccb: 8235250C
*Mar 1 00:16:48.295: No account/pin number available
*Mar 1 00:16:48.295: Call_setup Playout Mode: 1,Init 60, Min 40, Max 300, Fax 300
*Mar 1 00:16:48.295: cch323_call_setup_normal: for callID 6
  *Mar 1 00:16:48.295: Changing to new event: CONNECT h323chan_chn_connect: connecting to 82357590:1720   *Mar 1 00:16:48.299: h323chan_gw_conn: Created socket fd=2
*Mar 1 00:16:48.299: h323chan_gw_conn: connect in progress on fd=2h323chan_chn_connect: using fd=2, owner_data(ccb) 0x8235250C
changing from NONE state to CONNECTING state   *Mar 1 00:16:48.303: cch323_ct_main: SOCK 2 Event 0x1
*Mar 1 00:16:48.303: h323chan_chn_process_read_socket: fd=2 of type CONNECT_PENDING has data
  *Mar 1 00:16:48.303: Changing to new event: CONNECTED changing from CONNECTING state to CONNECTED state   *Mar 1 00:16:48.303: H.225 SM: process event H225_EVENT_SETUP, for callID 6cch323_run_h225_sm: received event H225_EVENT_SETUP while at state H225_IDLE   *Mar 1 00:16:48.303: cch323_h225_check_qos_and_snd_setup: Setup ccb 0x8235250C callID 0x6
*Mar 1 00:16:48.303: H.225 SM: process event H225_EVENT_FAST_SETUP, for callID 6cch323_run_h225_sm: received event H225_EVENT_FAST_SETUP while at state H225_IDLE
  *Mar 1 00:16:48.303: cch323_run_h225_sm: Setup ccb 0x8235250C callID 0x6
*Mar 1 00:16:48.307: cch323_run_h225_sm: cch323_h225_send_fastStart_setup called
cch323_h225_send_fastStart_setup: for callID 6   *Mar 1 00:16:48.307: cch323_build_local_encoded_fastStartOLCs: state_mc_mode=0x10F on outbound leg.
*Mar 1 00:16:48.307: cch323_build_local_encoded_fastStartOLCs:srcAddress = 0xA000062, h245_lport = 0, flow mode = 1, minimum_qos=0
*Mar 1 00:16:48.307: Near-end Pref Codecs = G.723r63
*Mar 1 00:16:48.307: cch323_generic_open_logical_channel: IPIPGW: current codec = 8:24:24.
*Mar 1 00:16:48.307: generic_open_logical_channel:codec is g723r63
  *Mar 1 00:16:48.307: cch323_generic_open_logical_channel: Filling in qosCapability field to 0   *Mar 1 00:16:48.307: h245_encode_faststart
*Mar 1 00:16:48.307: h245_encode_faststartcch323_h225_generic_send_setup: for callID 6
  *Mar 1 00:16:48.311: cch323_h225_generic_send_setup-- sending calling IE
*Mar 1 00:16:48.311: ======= PI in cch323_h225_generic_send_setup = 3
*Mar 1 00:16:48.311: Send infoXCap 144

  *Mar 1 00:16:48.311: cch323_h225_generic_send_setup:raw message is 59 bytes:1C 39 9E 01 00 03 67 74 64 00 00 00 2E 49 41 4D 2C 0D 0A 47 43 49 2C 64 66 36 32 32 32 34 66 31 34 66 30 31 31 63 63 38 30 30 32 39 32 31 62 39 37 36 66 63 35 30 37 0D 0A 0D 0A
*Mar 1 00:16:48.315: src address = 10.0.0.98 of h225SetupRequest
*Mar 1 00:16:48.315: dest address = 10.0.0.95 of h225SetupRequest
  *Mar 1 00:16:48.315: compose_TunnelledSignallingMessage_cisco Tunnelled Content: IAM,   GCI,df62224f14f011cc8002921b976fc507      
                                                                                                                                                                   &nbsp;                                                                                                                                                                                                                                                                                                  ....

*Mar 1 00:16:48.315: The length of message content is:[46]
Hex representation of the SETUP TPKT to send.080200010504039090A36C04803431307004813832307E0111052080060008914A00042800B500001240013800DF62224F14F011CC8002921B976FC50700CD1D820007000A0000622AF81100DF62224F14F011CC8004921B976FC5073602140000000D000040000B050001000A0000624B45001F400000060401004D0000400012150001000A0000624B44000A0000624B45000100010001800180010010A80180520140B50000124BE0011200011C3B1C399E0100036774640000002E49414D2C0D0A4743492C64663632323234663134663031316363383030323932316239373666633530370D0A0D0A048006000400000003350204677464012E49414D2C0D0A4743492C64663632323234663134663031316363383030323932316239373666633530370D0A0D0A
*Mar 1 00:16:48.335: h225SetupRequest: Q.931 SETUP sent from fd=2
*Mar 1 00:16:48.335: H.225 SM: changing from H225_IDLE state to H225_REQ_SETUP state for callID 6
  *Mar 1 00:16:48.335: cch323_rsvp_procedures_on_sending_setup: A Call to QoSListen succeded
*Mar 1 00:16:48.335: cch323_ct_main: SOCK 2 Event 0x1
*Mar 1 00:16:48.335: h323chan_chn_process_read_socket: fd=2 of type CONNECTED has data
  *Mar  1 00:16:48.335: h323chan_recvdata: No Data on fd=2
PROCESS_READ: FAILED/NOT COMPLETE,rc 10, fd=2
  *Mar  1 00:16:48.347: cch323_ct_main: SOCK 2 Event 0x1

*Mar 1 00:16:48.347: h323chan_chn_process_read_socket: fd=2 of type CONNECTED has data
  *Mar 1 00:16:48.347: [1]towner_data=0x82357578, len=85, msgPtr=0x82380554 cch323_gw_process_read_socket: received msg for H.225 h225ParseData: Q.931 CALL PROCEEDING received on fd=2
*Mar 1 00:16:48.347: cch323_h225_receiver: received msg of type CALLPROCIND_CHOSEN
cch323_h225_callproc_ind:
  *Mar 1 00:16:48.351: ====== PI in cch323_h225_callproc_ind = 0   *Mar 1 00:16:48.351: src address = 10.0.0.98 of CALLPROCIND_CHOSEN
*Mar 1 00:16:48.351: dest address = 10.0.0.95 of CALLPROCIND_CHOSEN
cch323_run_h225_sm: received event H225_EVENT_CALLPROC_IND while at state H225_REQ_SETUP cch323_h225_generic_callproc_notify:
r
*Mar 1 00:16:48.351: H.225 SM: changing from H225_REQ_SETUP state to H225_REQ_CALLPROC state for callID 6
  *Mar 1 00:16:48.547: cch323_ct_main: SOCK 2 Event 0x1
*Mar 1 00:16:48.547: h323chan_chn_process_read_socket: fd=2 of type CONNECTED has data
  *Mar 1 00:16:48.547: [1]towner_data=0x82357578, len=85, msgPtr=0x8235452C cch323_gw_process_read_socket: received msg for H.225 h225ParseData: Q.931 ALERTING received on fd=2
*Mar 1 00:16:48.551: cch323_h225_receiver: received msg of type ALERTIND_CHOSEN
  *Mar 1 00:16:48.551: ====== PI in cch323_h225_alert_ind = 0   *Mar 1 00:16:48.551: src address = 10.0.0.98 of ALERTIND_CHOSEN
*Mar 1 00:16:48.551: dest address = 10.0.0.95 of ALERTIND_CHOSEN
cch323_run_h225_sm: received event H225_EVENT_ALERT_IND while at state H225_REQ_CALLPROC   *Mar 1 00:16:48.551: H.225 SM: changing from H225_REQ_CALLPROC state to H225_REQ_ALERT state for callID 6   *Mar 1 00:16:50.987: cch323_ct_main: SOCK 2 Event 0x1
*Mar 1 00:16:50.987: h323chan_chn_process_read_socket: fd=2 of type CONNECTED has data
  *Mar 1 00:16:50.987: [1]towner_data=0x82357578, len=168, msgPtr=0x823572EC cch323_gw_process_read_socket: received msg for H.225 h225ParseData: Q.931 CONNECT received on fd=2
*Mar 1 00:16:50.991: cch323_h225_receiver: received msg of type SETUPCFM_CHOSEN
  *Mar  1 00:16:50.991:  ======= PI in cch323_h225_setup_cfm_ind = 0
  *Mar  1 00:16:50.991: Set new event H225_EVENT_FAST_SETUP_CFM_IND
  *Mar  1 00:16:50.991: src  address = 10.0.0.98 of SETUPCFM_CHOSEN

*Mar 1 00:16:50.991: dest address = 10.0.0.95 of SETUPCFM_CHOSEN
cch323_run_h225_sm: received event H225_EVENT_FAST_SETUP_CFM_IND while at state H225_REQ_ALERT   *Mar 1 00:16:50.991: H.225 SM: changing from H225_REQ_ALERT state to H225_ACTIVE_FASTSTART state for callID 6   *Mar 1 00:16:50.995: Codec: loc(8), rem(8), Bytes: loc(24), Fwd(24), Rev(24)
  *Mar 1 00:16:50.995: Function: cch323_receive_fastStart_cap_response Line: 2814
*Mar 1 00:16:50.995: Function: cch323_build_olc_for_ccapi, Line: 1198, audioFastStartArray=0x82358A44
*Mar 1 00:16:50.995: cch323_build_olc_for_ccapi: channel_info ptr=0x823805E0, ccb ptr=0x8235250C
*Mar 1 00:16:50.995: cch323_build_olc_for_ccapi: Channel Information:
 Logical Channel Number (fwd/rev): 1
 Channel address (fwd/rev):        0xA00005F
 RTP  Channel (fwd/rev):           32780
 RTCP Channel (fwd/rev):           32781
 QoS Capability (fwd/rev):         0
 Symmetric Audio Cap Mask:         0x300
 Symmetric Audio Codec Bytes:      24
 Flow Mode:                        0
 Silence Suppression:              1

*Mar 1 00:16:50.995: cch323_build_olc_for_ccapi:NumOfElements = 1 idx = 1
*Mar 1 00:16:50.995: Function: cch323_do_open_channel_ind Line: 1080
*Mar 1 00:16:50.995: cch323_do_cap_ind: IPIPGW:registry cap_ind is not done.
*Mar 1 00:16:50.999: cch323_receive_fastStart_cap_response: callID 0x6(6), audioFastStartArray = 0x0.
*Mar 1 00:16:50.999: cch323_rtp_open_notify:
*Mar 1 00:16:50.999: cch323_rsvp_procedures_on_faststart_response: A Call to QoSResv succeded for Call
ID 6
*Mar 1 00:16:50.999: cch323_h225_generic_setup_cfm_notify: status 4002309
*Mar 1 00:16:50.999: ======= PI in cch323_h225_generic_setup_cfm_notify = 0
  *Mar 1 00:16:51.007: cch323_rtp_open_notify:
*Mar 1 00:16:51.011: cch323_post_caps_ind: IPIPGW(6): ExtendedCapsNot Present
  *Mar 1 00:16:51.011: cch323_caps_ind: cap_modem_proto: 0, cap_modem_codec: 0, cap_modem_redundancy: 0 payload 100, modem_relay 0 gw_xid 0
*Mar 1 00:16:51.011: cch323_caps_ind: Load DSP with Negotiated codec(8) g723r63, Bytes=24
*Mar 1 00:16:51.011: cch323_caps_ind: set DSP for dtmf-relay = CC_CAP_DTMF_RELAY_INBAND_VOICE
*Mar 1 00:16:51.015: cch323_peer_caps_ack: IPIPGW(6):sending caps resp event to CAP state mc.
*Mar 1 00:16:51.015: cch323_peer_caps_ack: IPIPGW:ccb not interested in caps_ack primitive.
*Mar 1 00:16:51.187: cch323_ct_main: SOCK 2 Event 0x1
*Mar 1 00:16:51.187: h323chan_chn_process_read_socket: fd=2 of type CONNECTED has data
  *Mar 1 00:16:51.187: [1]towner_data=0x82357578, len=22, msgPtr=0x82354C6C cch323_gw_process_read_socket: received msg for H.225 h225ParseData: Q.931 FACILITY received for fd=2
*Mar 1 00:16:51.187: cch323_h225_receiver: received msg of type FACILIND_CHOSEN
  *Mar 1 00:16:51.191: Processing tunneled message   *Mar 1 00:16:51.191: Changing to new event H245_CONNECT_REQ_EVENT
*Mar 1 00:16:51.191: cch323_h245_connection_sm: state = 0 event=1 ccb=8235250C
*Mar 1 00:16:51.191: cch323_h245_connection_sm: listen state=0
*Mar 1 00:16:51.191: cch323_h245_connection_sm:H245_CONNECT: received event H245_CONNECT_REQ_EVENT while at H245_NONE state
  *Mar 1 00:16:51.191: in connection_sm..doing tunneling changing from H245_NONE state to H245_CONNECTED state
*Mar 1 00:16:51.191: cch323_h245_start_cap_sm: IPIPGW(6): starting the cap/msd machine.
*Mar 1 00:16:51.191: Set new event H245_EVENT_CAP_REQ, for callID 6
*Mar 1 00:16:51.191: cch323_run_h245_cap_out_sm: received event H245_EVENT_CAP_REQ while at state H245_CAP_NONE
*Mar 1 00:16:51.191: cch323_send_generic_caps: IPIPGW: audiomask raw =0x7BFF.
*Mar 1 00:16:51.195: Using DP configured Codecs
*Mar 1 00:16:51.195: Near-end Pref Codecs = G.723r63
*Mar 1 00:16:51.195: cch323_send_generic_caps:IPIPGW:[reg]audio mask after operation=0x100.
*Mar 1 00:16:51.195: send_caps_request: included rtp in caps table
  *Mar 1 00:16:51.195: send_caps_request: included signal in caps table
*Mar 1 00:16:51.195: send_caps_request: included alpha in caps table
*Mar 1 00:16:51.195: send_caps_request: included hookflash in caps table
*Mar 1 00:16:51.195: cch323_send_cap_request: included rtp-nte in caps table
*Mar 1 00:16:51.195: h245_encode_terminalCapabilitySet_request
*Mar 1 00:16:51.199: H.225 SM: process event H225_EVENT_TRANSMIT_TUNNELING, for callID 6cch323_run_h225_sm: received event H225_EVENT_TRANSMIT_TUNNELING while at state H225_ACTIVE_FASTSTART
  *Mar 1 00:16:51.199: compose_TunnelledSignallingMessage_ciscoNo tunnelled content. Hex representation of the FACILITY TPKT to send.08020001621C002813636973636F2053797374656D732C20496E632E7E00AC052690060008914A0004DF62224F14F011CC8002921B976FC5078601001F01801100DF62224F14F011CC8004921B976FC5070100010010C0018071016F027001060008817500078013800014000100000100000100000CC0010001000580001D8A061404302D31368000134810B50000120C52747044746D6652656C61790000800019830150800018830140800015830110800008220000000080010200001903001D001800150013000008
*Mar 1 00:16:51.211: h225FacilityRequest: Q.931 FACILITY sent from fd=2
*Mar 1 00:16:51.211: changing from H245_CAP_NONE state to H245_CAP_WAIT state
*Mar 1 00:16:51.211: Changing to new event H245_EVENT_MSD, for callID 6
  *Mar 1 00:16:51.215: cch323_run_h245_ms_sm: received event H245_EVENT_MSD while at state H245_MS_NONE
*Mar 1 00:16:51.215: h245_encode_masterSlaveDetermination_request
*Mar 1 00:16:51.215: H.225 SM: process event H225_EVENT_TRANSMIT_TUNNELING, for callID 6cch323_run_h225_sm: received event H225_EVENT_TRANSMIT_TUNNELING while at state H225_ACTIVE_FASTSTART
  *Mar 1 00:16:51.215: compose_TunnelledSignallingMessage_ciscoNo tunnelled content. Hex representation of the FACILITY TPKT to send.08020001621C002813636973636F2053797374656D732C20496E632E7E0043052690060008914A0004DF62224F14F011CC8002921B976FC5078601001F01801100DF62224F14F011CC8004921B976FC5070100010010C0018008010601003C400F61
*Mar 1 00:16:51.223: h225FacilityRequest: Q.931 FACILITY sent from fd=2
*Mar 1 00:16:51.223: changing from H245_MS_NONE state to H245_MS_OUTGOING_WAIT state
cch323_run_h245_ms_sm: Sent MSD Request
  *Mar 1 00:16:51.223: Changing to new event H245_PROCESS_H245CONTROL
*Mar 1 00:16:51.223: cch323_h245_connection_sm: state = 2 event=5 ccb=8235250C
*Mar 1 00:16:51.223: cch323_h245_connection_sm: listen state=0
*Mar 1 00:16:51.223: cch323_h245_connection_sm:H245_CONNECT: received event H245_PROCESS_H245CONTROL while at H245_CONNECTED state
  *Mar 1 00:16:51.223: h245_decode_remote_message: received Request PDU
*Mar 1 00:16:51.223: h245_decode_remote_request: received Round Trip Delay Request message
*Mar 1 00:16:51.227: h245_decode_remote_request: request type not supported (10)
*Mar 1 00:16:51.227: src address = 10.0.0.98 of FACILIND_CHOSEN
*Mar 1 00:16:51.227: dest address = 10.0.0.95 of FACILIND_CHOSEN
cch323_run_h225_sm: received event H225_EVENT_FACILITY_IND while at state H225_ACTIVE_FASTSTART   *Mar 1 00:16:51.227: cch323_ct_main: SOCK 2 Event 0x1
*Mar 1 00:16:51.227: h323chan_chn_process_read_socket: fd=2 of type CONNECTED has data
  *Mar 1 00:16:51.227: [1]towner_data=0x82357578, len=156, msgPtr=0x82354C6C cch323_gw_process_read_socket: received msg for H.225 h225ParseData: Q.931 FACILITY received for fd=2
*Mar 1 00:16:51.231: cch323_h225_receiver: received msg of type FACILIND_CHOSEN
  *Mar 1 00:16:51.231: Processing tunneled message   *Mar 1 00:16:51.231: Changing to new event H245_PROCESS_H245CONTROL
*Mar 1 00:16:51.231: cch323_h245_connection_sm: state = 2 event=5 ccb=8235250C
*Mar 1 00:16:51.231: cch323_h245_connection_sm: listen state=0
*Mar 1 00:16:51.231: cch323_h245_connection_sm:H245_CONNECT: received event H245_PROCESS_H245CONTROL while at H245_CONNECTED state
  *Mar 1 00:16:51.235: h245_decode_remote_message: received Request PDU
*Mar 1 00:16:51.235: h245_decode_remote_request: received Terminal Capability Set message
*Mar 1 00:16:51.235: h245_decode_cap_entry: unknown/unsupported choice (15)
*Mar 1 00:16:51.235: h245_decode_cap_entry: unknown/unsupported choice (15)
*Mar 1 00:16:51.235: cch323_h245_cap_ind: IPIPGW(6): masks au=0x6300 data=0x4 uinp=0x1E.
*Mar 1 00:16:51.239: Set new event H245_EVENT_CAP_IND, for callID 6
*Mar 1 00:16:51.239: cch323_run_h245_cap_in_sm: received event H245_EVENT_CAP_IND while at state H245_CAP_IDLE
*Mar 1 00:16:51.239: cch323_run_h245_cap_in_sm:IPIPGW(6): got incoming CAPSET msg.
*Mar 1 00:16:51.239: cch323_run_h245_cap_in_sm: IPIPGW(6): we know our local caps.
*Mar 1 00:16:51.239: Set new event H245_EVENT_CAP_REQ, for callID 6
*Mar 1 00:16:51.239: cch323_run_h245_cap_out_sm: received event H245_EVENT_CAP_REQ while at state H245_CAP_WAIT
*Mar 1 00:16:51.239: cch323_run_h245_cap_out_sm: Invalid event H245_EVENT_CAP_REQ for state H245_CAP_WAIT
*Mar 1 00:16:51.239: changing from H245_CAP_IDLE state to H245_CAP_AWAITING_RESPONSE state
*Mar 1 00:16:51.239: cch323_check_cap: Remote audio mask is 6300
*Mar 1 00:16:51.239: Remote Pref Codecs UnOrdered = [G723ar63], [G723ar53], [G723r63], [G723r53],
*Mar 1 00:16:51.239: cch323_check_cap: Audio Mask 0x6300, Negotiated Codec(8) G723r63 Codec Bytes 24
*Mar 1 00:16:51.243: cch323_check_data_and_usr_inp_cap: peer_data_cap_mask=0x4,peer_user_input_cap_mask=0x1E
*Mar 1 00:16:51.243: Sending digits as inband voice. No configured peer
*Mar 1 00:16:51.243: cch323_check_data_and_usr_inp_cap: Negotiated DTMF relay - 0x0
*Mar 1 00:16:51.243: cch323_do_cap_ind: Load codec(8) g723r63, codec_bytes = 24
*Mar 1 00:16:51.243: cch323_do_cap_ind: cap_modem_proto: 0, cap_modem_codec: 0, cap_modem_redundancy: 0, modem_relay 0 gw_xid 0
*Mar 1 00:16:51.243: cch323_do_cap_ind: negotiated dtmf relay is inband voice
  *Mar 1 00:16:51.243: cch323_do_cap_ind: IPIPGW(6):sending caps to the other leg.
*Mar 1 00:16:51.243: cch323_do_cap_ind: IPIPGW(6):SENDING caps_ack bcoz NTFY DSP set
*Mar 1 00:16:51.243: cch323_h245_cap_notify:IPIPGW(6): xmiting capsetack: lcl caps known.
*Mar 1 00:16:51.243: Set new event H245_EVENT_CAP_RESP, for callID 6
*Mar 1 00:16:51.247: cch323_run_h245_cap_in_sm: received event H245_EVENT_CAP_RESP while at state H245_CAP_AWAITING_RESPONSE
*Mar 1 00:16:51.247: h245_encode_terminalCapabilitySetAck_response
*Mar 1 00:16:51.247: H.225 SM: process event H225_EVENT_TRANSMIT_TUNNELING, for callID 6cch323_run_h225_sm: received event H225_EVENT_TRANSMIT_TUNNELING while at state H225_ACTIVE_FASTSTART
  *Mar 1 00:16:51.247: compose_TunnelledSignallingMessage_ciscoNo tunnelled content. Hex representation of the FACILITY TPKT to send.08020001621C002813636973636F2053797374656D732C20496E632E7E0040052690060008914A0004DF62224F14F011CC8002921B976FC5078601001F01801100DF62224F14F011CC8004921B976FC5070100010010C00180050103218001
*Mar 1 00:16:51.255: h225FacilityRequest: Q.931 FACILITY sent from fd=2
*Mar 1 00:16:51.255: changing from H245_CAP_AWAITING_RESPONSE state to H245_CAP_IDLE state
*Mar 1 00:16:51.255: cch323_check_data_and_usr_inp_cap: peer_data_cap_mask=0x4,peer_user_input_cap_mask=0x1E
*Mar 1 00:16:51.255: Sending digits as inband voice. No configured peer
*Mar 1 00:16:51.255: cch323_check_data_and_usr_inp_cap: Negotiated DTMF relay - 0x0
*Mar 1 00:16:51.255: cap_notify: check_data_and_usr_inp returned
*Mar 1 00:16:51.255: src address = 10.0.0.98 of FACILIND_CHOSEN
*Mar 1 00:16:51.259: dest address = 10.0.0.95 of FACILIND_CHOSEN
cch323_run_h225_sm: received event H225_EVENT_FACILITY_IND while at state H225_ACTIVE_FASTSTART   *Mar 1 00:16:51.259: cch323_ct_main: SOCK 2 Event 0x1
*Mar 1 00:16:51.259: h323chan_chn_process_read_socket: fd=2 of type CONNECTED has data
  *Mar 1 00:16:51.259: [1]towner_data=0x82357578, len=26, msgPtr=0x82354C6C cch323_gw_process_read_socket: received msg for H.225 h225ParseData: Q.931 FACILITY received for fd=2
*Mar 1 00:16:51.259: cch323_h225_receiver: received msg of type FACILIND_CHOSEN
  *Mar 1 00:16:51.259: Processing tunneled message   *Mar 1 00:16:51.259: Changing to new event H245_PROCESS_H245CONTROL
*Mar 1 00:16:51.263: cch323_h245_connection_sm: state = 2 event=5 ccb=8235250C
*Mar 1 00:16:51.263: cch323_h245_connection_sm: listen state=0
*Mar 1 00:16:51.263: cch323_h245_connection_sm:H245_CONNECT: received event H245_PROCESS_H245CONTROL while at H245_CONNECTED state
  *Mar 1 00:16:51.263: h245_decode_remote_message: received Request PDU
*Mar 1 00:16:51.263: h245_decode_remote_request: received Master/Slave Determination message
*Mar 1 00:16:51.263: Changing to new event H245_EVENT_MS_IND, for callID 6
  *Mar  1 00:16:51.263: cch323_run_h245_ms_sm: received event H245_EVENT_MS_IND while at state H245_MS_OUTGOING_WAITMSDetermination: rtt=50 rsdnum=7929615, ltt=60 lsdnum=3937
MSDetermination: Am MASTER, ccb->h245.h245_mdStatus = 0x1
  *Mar  1 00:16:51.263: h245_encode_masterSlaveDeterminationAck_response

*Mar 1 00:16:51.263: H.225 SM: process event H225_EVENT_TRANSMIT_TUNNELING, for callID 6cch323_run_h225_sm: received event H225_EVENT_TRANSMIT_TUNNELING while at state H225_ACTIVE_FASTSTART
  *Mar 1 00:16:51.267: compose_TunnelledSignallingMessage_ciscoNo tunnelled content. Hex representation of the FACILITY TPKT to send.08020001621C002813636973636F2053797374656D732C20496E632E7E003F052690060008914A0004DF62224F14F011CC8002921B976FC5078601001F01801100DF62224F14F011CC8004921B976FC5070100010010C0018004010220A0
*Mar 1 00:16:51.271: h225FacilityRequest: Q.931 FACILITY sent from fd=2MS_Determine_indication to Appl!
  *Mar 1 00:16:51.275: changing from H245_MS_OUTGOING_WAIT state to H245_MS_INCOMING_WAIT state cch323_run_h245_ms_sm: Sent MSD ACK!
  *Mar 1 00:16:51.275: src address = 10.0.0.98 of FACILIND_CHOSEN
*Mar 1 00:16:51.275: dest address = 10.0.0.95 of FACILIND_CHOSEN
cch323_run_h225_sm: received event H225_EVENT_FACILITY_IND while at state H225_ACTIVE_FASTSTART   *Mar 1 00:16:51.279: cch323_peer_caps_ack: IPIPGW(6):sending caps resp event to CAP state mc.
*Mar 1 00:16:51.279: cch323_peer_caps_ack: IPIPGW:ccb not interested in caps_ack primitive.
*Mar 1 00:16:52.991: cch323_ct_main: SOCK 2 Event 0x1
*Mar 1 00:16:52.991: h323chan_chn_process_read_socket: fd=2 of type CONNECTED has data
  *Mar 1 00:16:52.991: [1]towner_data=0x82357578, len=140, msgPtr=0x82358354 cch323_gw_process_read_socket: received msg for H.225 h225ParseData: Q.931 FACILITY received for fd=2
*Mar 1 00:16:52.991: cch323_h225_receiver: received msg of type FACILIND_CHOSEN
  *Mar 1 00:16:52.995: Processing tunneled message   *Mar 1 00:16:52.995: Changing to new event H245_PROCESS_H245CONTROL
*Mar 1 00:16:52.995: cch323_h245_connection_sm: state = 2 event=5 ccb=8235250C
*Mar 1 00:16:52.995: cch323_h245_connection_sm: listen state=0
*Mar 1 00:16:52.995: cch323_h245_connection_sm:H245_CONNECT: received event H245_PROCESS_H245CONTROL while at H245_CONNECTED state
  *Mar 1 00:16:52.995: h245_decode_remote_message: received Request PDU
*Mar 1 00:16:52.999: h245_decode_remote_request: received Terminal Capability Set message
*Mar 1 00:16:52.999: h245_decode_cap_entry: unknown/unsupported choice (15)
*Mar 1 00:16:52.999: h245_decode_cap_entry: unknown/unsupported choice (15)
*Mar 1 00:16:52.999: cch323_h245_cap_ind: IPIPGW(6): masks au=0x6300 data=0x0 uinp=0x1E.
*Mar 1 00:16:52.999: Set new event H245_EVENT_CAP_IND, for callID 6
*Mar 1 00:16:52.999: cch323_run_h245_cap_in_sm: received event H245_EVENT_CAP_IND while at state H245_CAP_IDLE
*Mar 1 00:16:52.999: cch323_run_h245_cap_in_sm:IPIPGW(6): got incoming CAPSET msg.
*Mar 1 00:16:53.003: cch323_run_h245_cap_in_sm: IPIPGW(6): we know our local caps.
*Mar 1 00:16:53.003: Set new event H245_EVENT_CAP_REQ, for callID 6
*Mar 1 00:16:53.003: cch323_run_h245_cap_out_sm: received event H245_EVENT_CAP_REQ while at state H245_CAP_WAIT
*Mar 1 00:16:53.003: cch323_run_h245_cap_out_sm: Invalid event H245_EVENT_CAP_REQ for state H245_CAP_WAIT
*Mar 1 00:16:53.003: changing from H245_CAP_IDLE state to H245_CAP_AWAITING_RESPONSE state
*Mar 1 00:16:53.003: cch323_check_cap: Remote audio mask is 6300
*Mar 1 00:16:53.003: Remote Pref Codecs UnOrdered = [G723ar63], [G723ar53], [G723r63], [G723r53],
*Mar 1 00:16:53.003: cch323_check_cap: Audio Mask 0x6300, Negotiated Codec(8) G723r63 Codec Bytes 24
*Mar 1 00:16:53.003: cch323_check_data_and_usr_inp_cap: peer_data_cap_mask=0x0,peer_user_input_cap_mask=0x1E
*Mar 1 00:16:53.003: Sending digits as inband voice. No configured peer
*Mar 1 00:16:53.003: cch323_check_data_and_usr_inp_cap: Negotiated DTMF relay - 0x0
*Mar 1 00:16:53.003: cch323_do_cap_ind: Load codec(8) g723r63, codec_bytes = 24
*Mar 1 00:16:53.007: cch323_do_cap_ind: cap_modem_proto: 0, cap_modem_codec: 0, cap_modem_redundancy: 0, modem_relay 0 gw_xid 0
*Mar 1 00:16:53.007: cch323_do_cap_ind: negotiated dtmf relay is inband voice
  *Mar 1 00:16:53.007: cch323_do_cap_ind: IPIPGW(6):sending caps to the other leg.
*Mar 1 00:16:53.007: cch323_do_cap_ind: IPIPGW(6):SENDING caps_ack bcoz NTFY DSP set
*Mar 1 00:16:53.007: cch323_h245_cap_notify:IPIPGW(6): xmiting capsetack: lcl caps known.
*Mar 1 00:16:53.007: Set new event H245_EVENT_CAP_RESP, for callID 6
*Mar 1 00:16:53.007: cch323_run_h245_cap_in_sm: received event H245_EVENT_CAP_RESP while at state H245_CAP_AWAITING_RESPONSE
*Mar 1 00:16:53.007: h245_encode_terminalCapabilitySetAck_response
*Mar 1 00:16:53.007: H.225 SM: process event H225_EVENT_TRANSMIT_TUNNELING, for callID 6cch323_run_h225_sm: received event H225_EVENT_TRANSMIT_TUNNELING while at state H225_ACTIVE_FASTSTART
  *Mar 1 00:16:53.011: compose_TunnelledSignallingMessage_ciscoNo tunnelled content. Hex representation of the FACILITY TPKT to send.08020001621C002813636973636F2053797374656D732C20496E632E7E0040052690060008914A0004DF62224F14F011CC8002921B976FC5078601001F01801100DF62224F14F011CC8004921B976FC5070100010010C00180050103218002
*Mar 1 00:16:53.015: h225FacilityRequest: Q.931 FACILITY sent from fd=2
*Mar 1 00:16:53.019: changing from H245_CAP_AWAITING_RESPONSE state to H245_CAP_IDLE state
*Mar 1 00:16:53.019: cch323_check_data_and_usr_inp_cap: peer_data_cap_mask=0x0,peer_user_input_cap_mask=0x1E
*Mar 1 00:16:53.019: Sending digits as inband voice. No configured peer
*Mar 1 00:16:53.019: cch323_check_data_and_usr_inp_cap: Negotiated DTMF relay - 0x0
*Mar 1 00:16:53.019: cap_notify: check_data_and_usr_inp returned
*Mar 1 00:16:53.019: src address = 10.0.0.98 of FACILIND_CHOSEN
*Mar 1 00:16:53.019: dest address = 10.0.0.95 of FACILIND_CHOSEN
cch323_run_h225_sm: received event H225_EVENT_FACILITY_IND while at state H225_ACTIVE_FASTSTART   *Mar 1 00:16:53.023: cch323_peer_caps_ack: IPIPGW(6):sending caps resp event to CAP state mc.
*Mar 1 00:16:53.023: cch323_peer_caps_ack: IPIPGW:ccb not interested in caps_ack primitive.
*Mar 1 00:16:54.995: cch323_ct_main: SOCK 2 Event 0x1
*Mar 1 00:16:54.995: h323chan_chn_process_read_socket: fd=2 of type CONNECTED has data
  *Mar 1 00:16:54.995: [1]towner_data=0x82357578, len=21, msgPtr=0x82378E40 cch323_gw_process_read_socket: received msg for H.225 h225ParseData: Q.931 FACILITY received for fd=2
*Mar 1 00:16:54.995: cch323_h225_receiver: received msg of type FACILIND_CHOSEN
  *Mar 1 00:16:54.995: Processing tunneled message   *Mar 1 00:16:54.995: Changing to new event H245_PROCESS_H245CONTROL
*Mar 1 00:16:54.999: cch323_h245_connection_sm: state = 2 event=5 ccb=8235250C
*Mar 1 00:16:54.999: cch323_h245_connection_sm: listen state=0
*Mar 1 00:16:54.999: cch323_h245_connection_sm:H245_CONNECT: received event H245_PROCESS_H245CONTROL while at H245_CONNECTED state
  *Mar 1 00:16:54.999: h245_decode_remote_message: received Indication PDU
*Mar 1 00:16:54.999: h245_decode_remote_indication: received Terminal Capability Set Release message
*Mar 1 00:16:54.999: Set new event H245_EVENT_CAP_REL, for callID 6
*Mar 1 00:16:54.999: cch323_run_h245_cap_in_sm: received event H245_EVENT_CAP_REL while at state H245_CAP_IDLE
*Mar 1 00:16:54.999: src address = 10.0.0.98 of FACILIND_CHOSEN
*Mar 1 00:16:54.999: dest address = 10.0.0.95 of FACILIND_CHOSEN
cch323_run_h225_sm: received event H225_EVENT_FACILITY_IND while at state H225_ACTIVE_FASTSTART   *Mar 1 00:16:55.023: cch323_ct_main: SOCK 2 Event 0x1
*Mar 1 00:16:55.023: h323chan_chn_process_read_socket: fd=2 of type CONNECTED has data
  *Mar 1 00:16:55.027: [1]towner_data=0x82357578, len=21, msgPtr=0x82378E40 cch323_gw_process_read_socket: received msg for H.225 h225ParseData: Q.931 FACILITY received for fd=2
*Mar 1 00:16:55.027: cch323_h225_receiver: received msg of type FACILIND_CHOSEN
  *Mar 1 00:16:55.027: Processing tunneled message   *Mar 1 00:16:55.027: Changing to new event H245_PROCESS_H245CONTROL
*Mar 1 00:16:55.027: cch323_h245_connection_sm: state = 2 event=5 ccb=8235250C
*Mar 1 00:16:55.027: cch323_h245_connection_sm: listen state=0
*Mar 1 00:16:55.027: cch323_h245_connection_sm:H245_CONNECT: received event H245_PROCESS_H245CONTROL while at H245_CONNECTED state
  *Mar 1 00:16:55.027: h245_decode_remote_message: received Command PDU
*Mar 1 00:16:55.031: h245_decode_remote_command: received End Session Command message
*Mar 1 00:16:55.031: h245_encode_endSessionCommand_command
*Mar 1 00:16:55.031: H.225 SM: process event H225_EVENT_TRANSMIT_TUNNELING, for callID 6cch323_run_h225_sm: received event H225_EVENT_TRANSMIT_TUNNELING while at state H225_ACTIVE_FASTSTART
  *Mar 1 00:16:55.031: compose_TunnelledSignallingMessage_ciscoNo tunnelled content. Hex representation of the FACILITY TPKT to send.08020001621C002813636973636F2053797374656D732C20496E632E7E003F052690060008914A0004DF62224F14F011CC8002921B976FC5078601001F01801100DF62224F14F011CC8004921B976FC5070100010010C001800401024A40
*Mar 1 00:16:55.039: h225FacilityRequest: Q.931 FACILITY sent from fd=2
*Mar 1 00:16:55.039: src address = 10.0.0.98 of FACILIND_CHOSEN
*Mar 1 00:16:55.039: dest address = 10.0.0.95 of FACILIND_CHOSEN
cch323_run_h225_sm: received event H225_EVENT_FACILITY_IND while at state H225_ACTIVE_FASTSTART   *Mar 1 00:16:55.039: cch323_ct_main: SOCK 2 Event 0x1
*Mar 1 00:16:55.039: h323chan_chn_process_read_socket: fd=2 of type CONNECTED has data
  *Mar 1 00:16:55.043: [1]towner_data=0x82357578, len=46, msgPtr=0x82378E40 cch323_gw_process_read_socket: received msg for H.225 h225ParseData: Q.931 RELEASE COMPLETE received on fd=2
*Mar 1 00:16:55.043: cch323_h225_receiver: received msg of type RELEASEIND_CHOSEN
  *Mar 1 00:16:55.043: cch323_h225_release_ind: disconnect cause 16 location code 1
*Mar 1 00:16:55.043: h323_set_release_source_for_peer: ownCallId[6], src[4]
  *Mar 1 00:16:55.043: src address = 10.0.0.98 of RELEASEIND_CHOSEN
*Mar 1 00:16:55.043: dest address = 10.0.0.95 of RELEASEIND_CHOSEN
cch323_run_h225_sm: received event H225_EVENT_RELEASE_IND while at state H225_ACTIVE_FASTSTART cch323_traverse_enum_contact_list: state = 10   *Mar 1 00:16:55.047: cch323_ct_main: SOCK 2 Event 0x1
*Mar 1 00:16:55.047: h323chan_chn_process_read_socket: fd=2 of type CONNECTED has data
  *Mar 1 00:16:55.047: h323chan_recvdata: Connection lost fd=2h323chan_chn_close: Calls[1] Exist on socketfd=2 Owner[2]   *Mar 1 00:16:55.047: h323_gw_clean_send_blocked_watch: fd 2
*Mar 1 00:16:55.047: h323chan_close: TCP connection from fd=2 closed
*Mar 1 00:16:55.047: H.225 SM: process event H225_EVENT_CONN_LOST, for callID 6cch323_run_h225_sm: received event H225_EVENT_CONN_LOST while at state H225_ACTIVE_FASTSTART
cch323_cleanup_xport: hashDestroy for TcpFDTbl cch323_do_call_disconnect: gw_id=1, callID=6   *Mar 1 00:16:55.051: H.225 SM: process event H225_EVENT_RELEASE, for callID 6cch323_run_h225_sm: received event H225_EVENT_RELEASE while at state H225_ACTIVE_FASTSTART   *Mar 1 00:16:55.055: H.225 SM: changing from H225_ACTIVE_FASTSTART state to H225_IDLE state for callID 6 cch323_call_generic_cleanup: for callID 6 disconnected flag 1   *Mar 1 00:16:55.055: Call Active Playout Mode: 1,Init 60, Min 40, Max 300, Fax 300
*Mar 1 00:16:55.055: Call History Playout Mode: 1,Init 60, Min 40, Max 300, Fax 300
*Mar 1 00:16:55.059: cch323_call_generic_cleanup: freeing ccb (0x8235250C)
   

  ayrıca deneme olarak
  voice service voip
 h323
  h225 timeout tcp call-idle never
  h225 timeout setup 30
  call start slow
  session transport udp komutlarınıda kullandım ama herhangı bır gelısme yok 3SN    

  ilginize tesekkurler

CCNA (2003)
ATI-CASE RS (2004)
Network Specialist
Artun KOCAMAN                 



 Yahoo! Personals
 Single? There's someone we'd like you to meet.  Lots of someones, actually. Yahoo! Personals

[Non-text portions of this message have been removed]

--
Cisco Teknik Tartisma Listesi (Cisco-ttl)

Bu listede onerilen degisikliklerin uygulanmasindaki tum sorumluluk 
kullaniciya aittir. Liste yoneticileri, oneride bulunan liste uyeleri ya da 
bu uyelerin calistigi kuruluslar herhangi bir sekilde sorumlu tutulamazlar. 
Yahoo! Groups Links

<*> To visit your group on the web, go to:
    http://groups.yahoo.com/group/cisco-ttl/

<*> To unsubscribe from this group, send an email to:
    cisco-ttl-unsubscribe@yahoogroups.com

<*> Your use of Yahoo! Groups is subject to:
    http://docs.yahoo.com/info/terms/
 
Received on Mon Dec 5 12:05:19 2005

This archive was generated by hypermail 2.1.8 : Mon Dec 05 2005 - 12:05:20 EET