cisco 2620 gateway & Teles i-gate gateway

cemalersin · ‎05-04-2005

We have a Teles i-gate gsm gateway which we use as an endpoint. It used to register to a Voice Master.

But yesterday we re-configured it to work gw-to-gw with a cisco 2620. We created dial peers in cisco to route the calls to i-gate. When we dial a number we hear the dial tone ringing and the number we dial is also ringing. but when we open the phone from the called part, the calling part still hears a ringing tone. i think the problem is in h225.i opened the debugs but couldnt understand what the problem is.

Can anyone help me please.

cemalersin · ‎05-05-2005

Here is the debugs that ive taken:

*Apr 29 11:40:36.974: h323chan_chn_process_read_socket: fd=0 of type LISTENING has data

*Apr 29 11:40:36.974: Changing to new event: ACCEPT

h323chan_chn_accept: fd=0

*Apr 29 11:40:36.974: h323chan_gw_accept: TCP connection accepted from 213.139.229.186:10907 on fd=3

*Apr 29 11:40:36.974: h323chan_chn_accept: Local(0x0) accepts TCP conn from 213.139.229.186(0xD58BE5BA) port (10907); fd=3changing from LISTENING state to ACCEPTED state

*Apr 29 11:40:36.986: h323chan_chn_process_read_socket: fd=3 of type ACCEPTED has data

Hex representation of the SETUP TPKT received: 08023B100504038090A3280831313232333233326C0A01803131323233323332700D813930353432353732313131317E00840520B0060008914A00020103804455656520C0B50000120C436973636F204154412031383618763A3078303430303032313020663A20623A3033303530396100010580C38758A54444000000000080F0E0100010000B465DB048005D0D800700D58BE5BA06B81100000000008F36551C1B02000B465DB048010001000100010002800100

h225ParseData: Q.931 SETUP received on fd=3

*Apr 29 11:40:36.994: //338/000000000010/H323/setup_ind: Receive bearer cap infoXRate 16, rateMult 0

*Apr 29 11:40:36.994: //338/000000000010/H323/cch323_set_h245_state_mc_mode_incoming: h245 state m/c mode=0x10F, h323_ctl=0x2F

*Apr 29 11:40:37.006: //-1/xxxxxxxxxxxx/H323/cch245_event_handler: callID=338

*Apr 29 11:40:37.006: //-1/xxxxxxxxxxxx/H323/cch245_event_handler: Event CC_EV_H245_SET_MODE: data ptr=0x833BD4C0

*Apr 29 11:40:37.006: //-1/xxxxxxxxxxxx/H323/cch323_set_mode: callID=338, flow Mode=1 spi_mode=0x1

*Apr 29 11:40:37.006: //-1/xxxxxxxxxxxx/H323/cch245_event_handler: Unknown event(1)

*Apr 29 11:40:37.010: //338/000000000010/H323/cch323_do_call_proceeding: set_mode NOT called yet...saved deferred CALL_PROC

*Apr 29 11:40:37.010: //-1/xxxxxxxxxxxx/H323/cch323_get_dp_pref_mask:

cch323_get_dp_pref_mask:IPIPGW(339):setting mask for 729ar8also as 729 is configured

*Apr 29 11:40:37.010: //339/000000000010/H323/cch323_get_peer_info: Entry

*Apr 29 11:40:37.010: //339/000000000010/H323/cch323_get_peer_info: Have peer

*Apr 29 11:40:37.010: //339/000000000010/H323/cch323_set_pref_codec_list: First preferred codec(bytes)=22(0)

*Apr 29 11:40:37.010: //339/000000000010/H323/cch323_get_peer_info: Flow Mode set to FLOW_THROUGH

*Apr 29 11:40:37.010: //339/000000000010/H323/cch323_set_h245_state_mc_mode_outgoing: call_spi_mode = 1

*Apr 29 11:40:37.014: //339/000000000010/H323/cch323_set_h245_state_mc_mode_outgoing: h245 state m/c mode=0x1AF0, h323_ctl=0x2F

*Apr 29 11:40:37.014: //339/000000000010/H323/cch323_set_h323_control_options_outgoing: h245 sm mode = 6896

*Apr 29 11:40:37.014: //339/000000000010/H323/cch323_set_h323_control_options_outgoing: h323_ctl=0x2F

*Apr 29 11:40:37.014: Changing to new event: CONNECT

h323chan_chn_connect: connecting to 195.142.106.74:1720

cemalersin · ‎05-05-2005

*Apr 29 11:40:37.014: h323chan_gw_conn: Created socket fd=5

*Apr 29 11:40:37.018: h323chan_gw_conn: connect in progress on fd=5h323chan_chn_connect: using fd=5, owner_data(ccb) 0x843DAC1C

changing from NONE state to CONNECTING state

*Apr 29 11:40:37.022: //338/000000000010/H323/cch323_process_set_mode: Setting inbound leg mode flags to 0x1AF0, flow-mode to FLOW_THROUGH

*Apr 29 11:40:37.022: //338/000000000010/H323/cch323_process_set_mode: Sending deferred CALL_PROC

*Apr 29 11:40:37.026: //338/000000000010/H323/cch323_do_call_proceeding: set_mode called so we can proceed with CALLPROC

*Apr 29 11:40:37.026: compose_TunnelledSignallingMessage_ciscoNo tunnelled content.

Hex representation of the CALL PROCEEDING TPKT to send.: 0802BB10027E0046052180060008914A000428C0B50000120B436973636F47617465776179003240023C0501002C0501000443001100000000008F36551C1B02000B465DB0480100010010800100

h225CallProcRequest: Q.931 CALL PROCEEDING sent fromfd=3.

*Apr 29 11:40:37.034: h323chan_chn_process_read_socket: fd=5 of type CONNECT_PENDING has data

*Apr 29 11:40:37.034: Changing to new event: CONNECTED

changing from CONNECTING state to CONNECTED state

*Apr 29 11:40:37.034: //339/000000000010/H323/check_qos_and_send_setup: Sending setup h323 slow rsvp

*Apr 29 11:40:37.034: //339/000000000010/H323/cch323_build_qosInfo: ccb=0x843DAC1C. msg_type=1

*Apr 29 11:40:37.034: //339/000000000010/H323/cch323_build_qosInfo: media_ip_addr=0x0, remote_qos_video=0, audio_lport=0, audio_rport=0, video=0, video_lport=0, video_rport=0, h245_lport=0, h245_rport=0, remote_qos_audio_bw=0, remote_qos_video_bw=0

*Apr 29 11:40:37.038: compose_TunnelledSignallingMessage_cisco Tunnelled Content:

IAM,

GEA,trs3,00,1,y,y,1,11223232

....

*Apr 29 11:40:37.038: The length of message content is:[38]

Hex representation of the SETUP TPKT to send.: 0802006A0504038090A3280831313232333233326C0A01803131323233323332700D813930353432353732313131317E00E9052080060008914A000428C0B50000120B436973636F47617465776179003240023C0501002C050100000000000080F0E0100010000B465DB04800CD0D80000700D58BE5BC53D21100000000008F36551C1B02000B465DB048010001000180018010A80180550140B50000124EE0011200011C331C319E0100036774640000002649414D2C0D0A4745412C747273332C30302C312C792C792C312C31313232333233320D0A0D0A08101127F80000000000000000000000000000002D0204677464012649414D2C0D0A4745412C74

7273332C30302C312C792C792C312C31313232333233320D0A0D0A

h225SetupRequest: Q.931 SETUP sent from fd=5

*Apr 29 11:40:37.046: h323chan_chn_process_read_socket: fd=5 of type CONNECTED has data

*Apr 29 11:40:37.046: h323chan_recvdata: No Data on fd=5

PROCESS_READ: FAILED/NOT COMPLETE,rc 10, fd=5

*Apr 29 11:40:37.066: h323chan_chn_process_read_socket: fd=5 of type CONNECTED has data

Hex representation of the SETUP TPKT received: 0802806A627E005E052690060008914A00040000000080F0E0100010000B465DB0488601001301801100000000008F36551C1B02000B465DB0480100010004C00180230121027001060008817500078013800200400117A0011780011F800CC001000100FFFF

h225ParseData: Q.931 FACILITY received for fd=5

*Apr 29 11:40:37.070: //339/000000000010/H323/cch323_h245_connection_sm: state=0, event=1, ccb=843DAC1C, listen state=0

*Apr 29 11:40:37.278: h323chan_chn_process_read_socket: fd=5 of type CONNECTED has data

cemalersin · ‎05-05-2005

Hex representation of the SETUP TPKT received: 0802806A0D1E0280887E00210528401900060008914A000400000000008F36551C1B02000B465DB04802800180

h225ParseData: Q.931 SETUP ACK received on fd=5

*Apr 29 11:40:37.282: h323chan_chn_process_read_socket: fd=5 of type CONNECTED has data

Hex representation of the SETUP TPKT received: 0802806A027E0028052180060008914A00040201A1801100000000008F36551C1B02000B465DB0480100010002800180

h225ParseData: Q.931 CALL PROCEEDING received on fd=5

*Apr 29 11:40:37.286: //339/000000000010/H323/callproc_notify: Peer not ready so not starting TCP

*Apr 29 11:40:40.266: h323chan_chn_process_read_socket: fd=5 of type CONNECTED has data

Hex representation of the SETUP TPKT received: 0802806A031E0280887E00250528001D80060008914A00040200000000008F36551C1B02000B465DB04801010002800180

h225ParseData: Q.931 PROGRESS received on fd=5

*Apr 29 11:40:40.270: compose_TunnelledSignallingMessage_ciscoNo tunnelled content.

Hex representation of the PROGRESS TPKT to send.: 0802BB10031C001E0280887E00590528003E80060008914A000428C0B50000120B436973636F47617465776179003240023C0501002C05010000000000008F36551C1B02000B465DB04805800100010010A00100120140B50000120B60011000011E041E028188

h225ProgressRequest: Q.931 PROGRESS sent from fd=3

*Apr 29 11:40:49.690: h323chan_chn_process_read_socket: fd=5 of type CONNECTED has data

Hex representation of the SETUP TPKT received: 0802806A011E0280887E0028052380060008914A00040201A1801100000000008F36551C1B02000B465DB0480100010002800180

h225ParseData: Q.931 ALERTING received on fd=5

*Apr 29 11:40:49.694: compose_TunnelledSignallingMessage_ciscoNo tunnelled content.

Hex representation of the ALERTING TPKT to send.: 0802BB10011E0280883401017E0046052380060008914A000428C0B50000120B436973636F47617465776179003240023C0501002C05010006C3001100000000008F36551C1B02000B465DB0480100010010800100

h225AlertRequest: Q.931 ALERTING sent from fd=3. Call state changed to [Call Received].

*Apr 29 11:40:50.474: h323chan_chn_process_read_socket: fd=5 of type CONNECTED has data

Hex representation of the SETUP TPKT received: 0802806A077E0038052280060008914A000402000000000080F0E0100010000B465DB0480D0C1100000000008F36551C1B02000B465DB0480100010002800180

h225ParseData: Q.931 CONNECT received on fd=5

*Apr 29 11:41:17.726: h323chan_chn_process_read_socket: fd=3 of type ACCEPTED has data

cemalersin · ‎05-05-2005

Hex representation of the SETUP TPKT received: 08023B105A080280907E0021052580060008914A0002011100000000008F36551C1B02000B465DB04802800100

h225ParseData: Q.931 RELEASE COMPLETE received on fd=3

*Apr 29 11:41:17.734: compose_TunnelledSignallingMessage_ciscoNo tunnelled content.

Hex representation of the RELEASE COMPLETE TPKT to send.: 0802006A5A080281907E0022052580060008914A000411001100000000008F36551C1B02000B465DB04810800180

h225TerminateRequest: Q.931 RELEASE COMPLETE sent from fd=5. Call state changed to [Null].

*Apr 29 11:41:17.738: h323chan_chn_process_read_socket: fd=3 of type ACCEPTED has data

*Apr 29 11:41:17.738: h323chan_recvdata: Connection lost fd=3h323chan_chn_close: Calls[1] Exist on socketfd=3 Owner[2]

*Apr 29 11:41:17.738: h323chan_close: TCP connection from fd=3 closed

*Apr 29 11:41:17.754: h323chan_chn_process_read_socket: fd=5 of type CONNECTED has data

Hex representation of the SETUP TPKT received: 0802806A5A080281907E00220525C0060008914A000458081100000000008F36551C1B02000B465DB04802800180

h225ParseData: Q.931 RELEASE COMPLETE received on fd=5

*Apr 29 11:41:17.766: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 2, ConnectionId 0 80F0E010 10000B 465DB048, SetupTime *13:40:37.026 gmt Fri Apr 29 2005, PeerAddress 905425721111, PeerSubAddress , DisconnectCause 10 , DisconnectText normal call clearing (16), ConnectTime *13:41:17.766 gmt Fri Apr 29 2005, DisconnectTime *13:41:17.766 gmt Fri Apr 29 2005, CallOrigin 1, ChargedUnits 0, InfoType 2, TransmitPackets 0, TransmitBytes 0, ReceivePackets 0, ReceiveBytes 0

*Apr 29 11:41:17.766: h323chan_close: TCP connection from fd=5 closed

*Apr 29 11:41:17.770: //339/000000000010/H323/cch323_h245_connection_sm: state=2, event=4, ccb=843DAC1C, listen state=0

*Apr 29 11:41:17.786: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 2, ConnectionId 0 80F0E010 10000B 465DB048, SetupTime *13:40:37.002 gmt Fri Apr 29 2005, PeerAddress 11223232, PeerSubAddress , DisconnectCause 10 , DisconnectText normal call clearing (16), ConnectTime *13:41:17.782 gmt Fri Apr 29 2005, DisconnectTime *13:41:17.786 gmt Fri Apr 29 2005, CallOrigin 2, ChargedUnits 0, InfoType 2, TransmitPackets 0, TransmitBytes 0, ReceivePackets 0, ReceiveBytes 0