As you can see in the log, it's your provider who disconnects the call
(with cause 3 I guess), not the called party.
----- Original Message -----
From: "Suren Hakhnazaryan" <surenx@xxxxxxxxx>
Sent: Wednesday, July 25, 2007 8:31 AM
> I'm having strange problems with my network.
> Almost every time that our provider makes calls to my gatekeeper, the call
> connects but after 6 seconds the call disconnects with the disconnect code
> 3.
>
> 45.87.53.45 - My Gatekeeper
> 45.87.53.42 - My Cisco 3640 Gateway with NM-HDV-2E1
>
> 243.156.41.44 - Provider's Gatekeeper
>
> Here's the called number with the disconnect cause 3 in the database
>
> id | gk_id | gk_ip | src_ip | src_port |
> dst_ip | dst_port | setup_time | called_num | dialed_num |
> call_durn | disc_cause |
> ---------+----------+------------------+------------------+------------------+----------+------------------+----------+---------------------+-------------+-------------+------
> 4953701 | gk | 45.87.53.45/32 | 243.156.41.44/32 | 59235 |
> 45.87.53.42/32 | 1720 | 2007-07-23 19:11:30 | 12653763085 |
> 12653763085
> | 6 | 3 |
>
> 2007/07/23 19:11:30.286 3 ProxyChannel.cxx(890) Q931d
> Received:
> Alerting CRV=30974 from 45.87.53.42:1720
> 2007/07/23 19:11:30.501 3 ProxyChannel.cxx(890) Q931s
> Received:
> Setup CRV=16066 from 243.156.41.44:59235
> 2007/07/23 19:11:30.503 3 gkauth.cxx(1006) GKAUTH
> FileIPAuth Setup check ok
> 2007/07/23 19:11:30.503 2 RasTbl.cxx(700) RASTBL Gateway
> 7109_endp matched by prefix 1265, priority: 1
> 2007/07/23 19:11:30.503 2 RasTbl.cxx(700) RASTBL Gateway
> 7110_endp matched by prefix 1265, priority: 1
> 2007/07/23 19:11:30.503 3 RasTbl.cxx(1110) Prefix apply
> round
> robin
> 2007/07/23 19:11:30.504 2 RasTbl.cxx(2291)
> CallTable::Insert(CALL) Call No. 697407, total sessions : 83
> 2007/07/23 19:11:30.506 3 gkacct.cxx(974) GKACCT SQLAcct
> logged event 1 for call no. 697407
> 2007/07/23 19:11:30.507 2 gkacct.cxx(1014) GKACCT
> Successfully logged event 1 for call no. 697407
> 2007/07/23 19:11:30.507 3 ProxyChannel.cxx(2085) Q931s Call
> 697407 is NAT type 0
> 2007/07/23 19:11:30.518 3 ProxyChannel.cxx(2976) Q931 Connect
> to
> 45.87.53.42:1720 from 45.87.53.45:32229 successful
> 2007/07/23 19:11:30.544 2 RasSrv.cxx(189) RAS Read from
> 45.87.53.42:52401
> 2007/07/23 19:11:30.545 3 RasSrv.cxx(238) RAS
> admissionRequest {
> requestSeqNum = 3287
> callType = pointToPoint <<null>>
> callModel = direct <<null>>
> endpointIdentifier = 9 characters {
> 0037 0031 0030 0039 005f 0065 006e 0064 7109_end
> 0070 p
> }
> destinationInfo = 1 entries {
> [0]=dialedDigits "12653763085"
> }
> srcInfo = 3 entries {
> [0]=dialedDigits "4957893737"
> [1]=dialedDigits "4957893737"
> [2]=h323_ID 13 characters {
> 0047 0057 005f 0057 0069 006c 0074 0065 GW_Wilte
> 0078 005f 0047 0057 0033 x_GW3
> }
> }
> srcCallSignalAddress = ipAddress {
> ip = 4 octets {
> 55 c3 9f 2d U..-
> }
> port = 1720
> }
> bandWidth = 160
> callReferenceValue = 23956
> nonStandardData = {
> nonStandardIdentifier = h221NonStandard {
> t35CountryCode = 181
> t35Extension = 0
> manufacturerCode = 18
> }
> data = 3 octets {
> 00 00 00 ...
> }
> }
> conferenceID = 16 octets {
> 25 68 17 59 38 5d 11 dc 90 42 9f cc 2b a4 1a b3 %h.Y8]...B..+...
> }
> activeMC = FALSE
> answerCall = TRUE
> canMapAlias = TRUE
> callIdentifier = {
> guid = 16 octets {
> 25 68 17 59 38 5d 11 dc 90 44 9f cc 2b a4 1a b3 %h.Y8]...D..+...
> }
> }
> willSupplyUUIEs = FALSE
> }
> 2007/07/23 19:11:30.545 1 RasSrv.cxx(368) RAS ARQ
> Received
> 2007/07/23 19:11:30.546 3 RasSrv.cxx(2137) GK ARQ will
> request bandwith of 160
> 2007/07/23 19:11:30.546 3 RasSrv.cxx(2215) GK ACF: found
> existing call no 697407
> 2007/07/23 19:11:30.547 2 RasSrv.cxx(413)
> ACF|45.87.53.42:1720|7109_endp|23956|12653763085:dialedDigits|4957893737:dialedDigits=4957893737:dialedDigits=GW_Wiltex_GW3:h323_ID|true;
> 2007/07/23 19:11:30.547 3 RasSrv.cxx(250) RAS Send to
> 45.87.53.42:52401
> admissionConfirm {
> requestSeqNum = 3287
> bandWidth = 160
> callModel = gatekeeperRouted <<null>>
> destCallSignalAddress = ipAddress {
> ip = 4 octets {
> 55 c3 9f 2d U..-
> }
> port = 1720
> }
> irrFrequency = 120
> willRespondToIRR = FALSE
> uuiesRequested = {
> setup = FALSE
> callProceeding = FALSE
> connect = FALSE
> alerting = FALSE
> information = FALSE
> releaseComplete = FALSE
> facility = FALSE
> progress = FALSE
> empty = FALSE
> status = FALSE
> statusInquiry = FALSE
> setupAcknowledge = FALSE
> notify = FALSE
> }
> }
> 2007/07/23 19:11:30.670 3 ProxyChannel.cxx(890) Q931d
> Received:
> CallProceeding CRV=16066 from 45.87.53.42:1720
> 2007/07/23 19:11:30.724 3 RasTbl.cxx(1507) Gk Delete
> Call
> No. 697145
> 2007/07/23 19:11:31.519 3 ProxyChannel.cxx(890) Q931d
> Received:
> Alerting CRV=21821 from 45.87.53.44:1720
> 2007/07/23 19:11:31.880 3 ProxyChannel.cxx(890) Q931s
> Received:
> ReleaseComplete CRV=29208 from 212.44.130.41:60481
> 2007/07/23 19:11:31.883 2 RasTbl.cxx(2510) CDR ignore
> caller from neighbor
> 2007/07/23 19:11:31.885 3 gkacct.cxx(974) GKACCT
> FileAcct
> logged event 2 for call no. 697178
> 2007/07/23 19:11:31.895 3 gkacct.cxx(974) GKACCT SQLAcct
> logged event 2 for call no. 697178
> 2007/07/23 19:11:31.895 2 gkacct.cxx(1014) GKACCT
> Successfully logged event 2 for call no. 697178
> 2007/07/23 19:11:31.929 3 ProxyChannel.cxx(890) Q931d
> Received:
> ReleaseComplete CRV=29208 from 45.87.53.42:1720
> 2007/07/23 19:11:31.932 2 RasSrv.cxx(189) RAS Read from
> 45.87.53.42:52401
> 2007/07/23 19:11:31.937 3 RasSrv.cxx(238) RAS
> disengageRequest {
> requestSeqNum = 3288
> endpointIdentifier = 9 characters {
> 0037 0031 0030 0039 005f 0065 006e 0064 7109_end
> 0070 p
> }
> conferenceID = 16 octets {
> ce 6e 42 83 39 ee 11 dc aa 2c 00 03 ba 1b ad 7b .nB.9....,.....{
> }
> callReferenceValue = 23880
> disengageReason = normalDrop <<null>>
> callIdentifier = {
> guid = 16 octets {
> ce 6e 42 83 39 ee 11 dc aa 2c 00 03 ba 1b ad 7b .nB.9....,.....{
> }
> }
> answeredCall = TRUE
> usageInformation = {
> nonStandardUsageFields = 1 entries {
> [0]={
> nonStandardIdentifier = h221NonStandard {
> t35CountryCode = 181
> t35Extension = 0
> manufacturerCode = 18
> }
> data = 2 octets {
> 48 40 H@
> }
> }
> }
> }
> terminationCause = releaseCompleteCauseIE 4 octets {
> 08 02 80 90 ....
> }
> }
> 2007/07/23 19:11:31.943 1 RasSrv.cxx(368) RAS DRQ
> Received
> 2007/07/23 19:11:31.944 2 RasSrv.cxx(413)
> DCF|45.87.53.42|7109_endp|23880|normalDrop;
> 2007/07/23 19:11:31.946 3 RasSrv.cxx(250) RAS Send to
> 45.87.53.42:52401
> disengageConfirm {
> requestSeqNum = 3288
> }
> 2007/07/23 19:11:32.748 3 yasocket.cxx(568) Q931s Delete
> socket 212.44.130.41:57959
> 2007/07/23 19:11:32.748 3 yasocket.cxx(568) Q931d Delete
> socket 45.87.53.42:1720
-------------------------------------------------------------------------
This SF.net email is sponsored by: Splunk Inc.
Still grepping through log files to find problems? Stop.
Now Search log events and configuration files using AJAX and a browser.
Download your FREE copy of Splunk now >> http://get.splunk.com/
_______________________________________________________
Posting: mailto:Openh323gk-users@xxxxxxxxxxxxxxxxxxxxx
Archive: http://sourceforge.net/mailarchive/forum.php?forum_name=openh323gk-users
Unsubscribe: http://lists.sourceforge.net/lists/listinfo/openh323gk-users
Homepage: http://www.gnugk.org/
