Hi
what i can read from that trace is, that the calling
endpoint sends a DRQ with reason normalDrop. The reason for this seems to be
that the gateway is not responding to the Q.931 Setup sent by the calling
Endpoint. Either the gateway did not receive it or was unable (or
unwilling) to send a response.
If you can trace the gateway i would have a look at it
to see if the Q.931 Setup arrives. Since the gateway is not registered with the
gatekeeper you need to make sure the gateway accepts Q.931 Call Setups without
H.225 call signalling.
Why are you using Proxy Mode? Wouldn't it be enogh to
use routed signalling mode?
- Frank
From: openh323gk-users-admin@xxxxxxxxxxxxxxxxxxxxx [mailto:openh323gk-users-admin@xxxxxxxxxxxxxxxxxxxxx] On Behalf Of Code Nirmata
Sent: Monday, December 12, 2005 9:46 AM
To: GnuGK User Forum
Subject: Re: Log contents of Automatic call drop [Frank Fischer]Thank you Frank Fischer to prompt reply to me.
Here I attach my full log to you to analysis,but I lessen in some places to
reduce the attachment size................
please analysis it and descibe how can I trace the problems of dropping
calls frequently..........
Regards.......
----------------------------------------------------------------------------------------------
2005/12/12 14:30:47.071 3 RasSrv.cxx(219) RAS
// HERE I LESS REGISTRATION REQUEST LOG
2005/12/12 14:30:47.073 1 RasSrv.cxx(343) RAS RRQ Received
2005/12/12 14:30:47.074 3 gkauth.cxx(964) GKAUTH SQLAuth RRQ check ok
2005/12/12 14:30:47.075 1 RasTbl.cxx(79) New EP|210.4.78.146:1720|333560880:dialedDigits|terminal|7939_endp
2005/12/12 14:30:47.077 2 RasSrv.cxx(388) RCF|210.4.78.146:1720|333560880:dialedDigits|terminal|7939_endp;
2005/12/12 14:30:47.077 3 RasSrv.cxx(231) RAS Send to 210.4.78.146:1567
// HERE I LESS REGISTRATION CONFIRM REQUEST LOG
2005/12/12 14:30:55.184 1 RasSrv.cxx(343) RAS ARQ Received
2005/12/ 12 14:30:55.184 3 RasSrv.cxx(1948) GK ARQ will request bandwith of 200000
2005/12/12 14:30:55.184 2 RasTbl.cxx(695) RASTBL Gateway 7569_endp matched by prefix 00028801
2005/12/12 14:30:55.186 2 RasTbl.cxx(2029) CallTable::Insert(CALL) Call No. 500, total sessions : 1
2005/12/12 14:30:55.186 2 RasSrv.cxx(388)
ACF|210.4.78.146:1720|7939_endp|11473|0002880176079334:dialedDigits|333560880:dialedDigits|false;
2005/12/12 14:30:55.186 3 RasSrv.cxx(231) RAS Send to 210.4.78.146:1567< br> admissionConfirm {
requestSeqNum = 30115
bandWidth = 200000
callModel = gatekeeperRouted <<null>>
destCallSignalAddress = ipAddress {
ip = 4 octets {
ca 50 a8 f9 .P..
}
port = 1720
}
irrFrequency = 120
willRespondToIRR = FALSE
uuiesRequested = {
setup = FALSE
callProceeding = FALSE
&nb sp; connect = FALSE
alerting = FALSE
information = FALSE
releaseComplete = FALSE
facility = FALSE
progress = FALSE
empty = FALSE
status = FALSE
statusInquiry = FALSE
setupAcknowledge = FALSE
notify = FALSE
}
serviceControl = 1 entries {
[0]={
sessionId = 0
contents = callCreditServiceControl {
callStartingPoint = connect <<null>>
}
reason = refresh <<null>>
}
}
}
2005/12/12 14:30:56.805 3 ProxyChannel.cxx(542) Proxy 210.4.78.146:1568 read timeout?
2005/12/12 14:30:56.805 3 ProxyChannel.cxx(771) Q931s Received: Setup CRV=11473 from 210.4.78.146:1568
2005/12/12 14:30:56.821 2 gkacct.cxx(984) GKACCT Successfully logged event 1 for call no. 500
2005/12/12 14:30:56.821 3 ProxyChannel.cxx(1776) Q931s Call 500 is NAT type 0
2005/12/12 14:30:56.822 3 ProxyChannel.cxx(637) GK Call 500 proxy enabled
2005/12/12 14:30:56.888 2 RasSrv.cxx(173) RAS Read from 210.4.78.146:1567
2005/12/12 14:30:56.890 3 RasSrv.cxx(219) RAS
// HERE I LESS INFORMATION REQUEST LOG
2005/12/12 14:30:56.891 1 RasSrv.cxx(343) RAS IRR Received
2005/12/12 14:30:57.461 3 ProxyChannel.cxx(2305) Q931 Connect to 210.4.77.66:1720 from 202.80.168.249:0 successful
2005/12/12 14:30:59.063 3 ProxyChannel.cxx(771) Q931d Received: CallProceeding CRV=11473 from 210.4.77.66:1720
2005/12/12 14:31:01.824 3 ProxyChannel.cxx(771) Q931d Received: Progress CRV=11473 from 210.4.77.66:1720
2005/12/12 14:31:01.868 3 ProxyChannel.cxx(771) Q931d Received: Alerting CRV=11473 from 210.4.77.66:1720
2005/12/12 14:31:02.807 3 RasTbl.cxx(163) Gk Delete endpoint: 7939_endp 0
2005/12/12 14:31:21.488 3 ProxyChannel.cxx(771) Q931s Received: ReleaseComplete CRV=11473 from 210.4.78.146:1568
2005/12/12 14:31:21.489 2 RasTbl.cxx(2235) CDR ignore not connected call
2005/12/12 14:31:21.506 3 gkacct.cxx(944) GKACCT SQLAcct logged event 2 for call no. 500
2005/12/12 14:31:21.506 2 gkacct.cxx(984) GKACCT Successfully logged event 2 for call no. 500
2005/12/12 14:31:22.147 2 RasSrv.cxx(173) RAS Read from 210.4.78.146:1567
2005/12/12 14:31:22.148 3 RasSrv.cxx(219) RAS
disengageRequest {
requestSeqNum = 30117
endpointIdentifier = 9 characters {
0037 0039 0033 0039 005f 0065 006e 0064 7939_end
0070 p
}
conferenceID = 16 octets {
13 01 bd b3 9b f4 18 10 89 35 00 02 44 48 b3 45 .........5..DH.E
}
callReferenceValue = 11473
disengageReason = normalDrop <<null>>
callIdentifier = {
guid = 16 octets {
13 01 bd b3 9b f4 18 10 89 34 00 02 44 48 b3 45 .........4..DH.E
}
}
gatekeeperIdentifier = 7 characters {
004 2 0044 0043 004f 004d 0047 004b COMGK
}
cryptoTokens = 1 entries {
[0]=cryptoEPPwdHash {
alias = dialedDigits "333560880"
timeStamp = 1134376563
token = {
algorithmOID = 1.2.840.113549.2.5
paramS = {
}
hash = Hex: d0 60 3f ee b4 2d 95 c0 9f c8 f2 35 b8 a4 ee a7
}
}
}
answeredCall = FALSE
usageInformation = {
nonStandardUsageFields = 0 entries {
}
alertingTime = 1134376544
endTime = 1134376563
}
terminationCause = releaseCompleteCauseIE 2 octets {
80 90 ..
}
}
2005/12/12 14:31:22.149 1 RasSrv.cxx(343) RAS DRQ Received
2005/12/12 14:31:22.149 2 RasSrv.cxx(388)&nbs p; DCF|210.4.78.146|7939_endp|11473|normalDrop;
2005/12/12 14:31:22.150 3 RasSrv.cxx(231) RAS Send to 210.4.78.146:1567
disengageConfirm {
requestSeqNum = 30117
}
2005/12/12 14:31:26.657 3 yasocket.cxx(566) RTP Delete socket
2005/12/12 14:31:26.657 3 yasocket.cxx(566) RTCP Delete socket
2005/12/12 14:31:26.657 3 yasocket.cxx(566) Q931s Delete socket 210.4.78.146:1568
2005/12/12 14:31:26.657 3 yasocket.cxx(566) Q931d Delete socket 210.4.77.66:17 20
2005/12/12 14:31:27.047 3 RasTbl.cxx(1368) Gk Delete Call No. 500
2005/12/12 14:31:29.524 2 RasSrv.cxx(173) RAS Read from 210.4.78.146:1567
2005/12/12 14:31:29.525 3 RasSrv.cxx(219) RAS
unregistrationRequest {
requestSeqNum = 30118
callSignalAddress = 1 entries {
[0]=ipAddress {
ip = 4 octets {
d2 04 4e 92 ..N.
}
port = 1720
}
}
endpointAlias = 1 entries {
[0]=dialedDigits "333560880"
}
endpointIdentifier = 9 characters {
0037 0039 0033 0039 005f 0065 006e 0064 7939_end
0070 p
}
gatekeeperIdentifier = 7 characters {
0042 0044 0043 004f 004d 0047 004b COMGK
}
cryptoTokens = 1 entries {
[0]=cryptoEPPwdHash {
alias = dialedDigits "333560880"
timeStamp = 1134376571
token = {
algorithmOID = 1.2.840.113549.2.5
paramS = {
}
hash = Hex: c9 f1 fc b7 34 a2 75 e7 30 91 a4 45 cc 62 f2 f1
}
}
}
}
2005/12/12 14:31:29.525 1 RasSrv.cxx(343) RAS URQ Received
2005/12/12 14:31:29.525 2 RasSrv.cxx(388) UCF|210.4.78.146|7939_endp;
2005/12/12 14:31:29.526 3 RasSrv.cxx(231) RAS Send to 210.4.78.146:1567
unregistrationConfirm {
requestSeqNum = 30118
}
2005/12/12 14:31:31.807 3 yasocket.cxx(566) RTP Delete socket
210.4.78.146:5000<=>202.80.168.249:2972<=>210.4.77.66:10240
2005/12/12 14:31:31.807 3 yasocket.cxx(566) RTCP Delete socket
210.4.78.146:5001<=>202.80.168.249:2973<=>210.4.77.66:10241
2005/12/12 14:32:03.407 3 RasTbl.cxx(163) Gk Delete endpoint: 7939_endp 0
Yahoo! Shopping
Find Great Deals on Holiday Gifts at Yahoo! Shopping