For the second call check the line:
2008/10/30 17:15:27.629 3
ProxyChannel.cxx(1926) Q931s No destination for unregistered call
02 2b d8 03 b2 69 f5 1a 04 93 f6 f7 64 cd 82 93 from
202.177.196.34:2640
It seems no endpoint/gateway matched the dialed
number.
For the first problem, your calling endpoint
disconnects the call - check for the problem here (Release Complete Cause,
codecs etc., H.245 tunnelling being disabled, Facility with startH245 and a
private address being sent, ...)
----- Original Message -----
Sent: Friday, October 31, 2008 7:42
AM
Subject: gnugk drop
call for nated ip
Hi,
our gnugk is unable to
set up call to a public skycam at 203.174.20.80. The gnugk is in proxy routed
mode:
[RoutedMode]
GKRouted=1 H245Routed=1 CallSignalHandlerNumber=15 AcceptNeighborsCalls=1 AcceptUnregisteredCalls=1 RemoveH245AddressOnTunneling=1 RemoveCallOnDRQ==0 DropCallsByReleaseComplete=1 SendReleaseCompleteOnDRQ=1 SupportNATedEndpoints=1 SupportCallingNATedEndpoints=1 TreatUnregisteredNAT=1 TranslateFacility=1 ActivateFailover=1 EnableH450.2=1
[Proxy] Enable=1
ProxyForNAT=1
[RasSrv::ARQFeatures] CallUnregisteredEndpoints=1 ArjReasonRouteCallToGatekeeper=0
The trace logs initially indicated that the call is NAT type 0 and so
continues to normal call setup but very quickly the call drops and CDR
generated. Only after this the gnugk drops another called ip which is behind
NAT and generate another CDR. Please see below trace logs:
2008/10/30 17:15:27.301 2
RasTbl.cxx(2656) CallTable::Insert(CALL)
Call No. 15, total sessions : 1 2008/10/30 17:15:27.301 2
RasSrv.cxx(415)
ACF|130.194.xx.xx:1720|00000000000000000000000082C2550F06B8jNXq|3769|203.174.20.80:1720|Paul
Hii:h323_ID=51172:dialedDigits|false|02-2b-d8-03-b2-00-00-10-04-92-f6-f7-64-cd-82-93;
2008/10/30 17:15:27.301 3
RasSrv.cxx(252) RAS Send to
130.194.xx.xx:1719 2008/10/30
17:15:27.302 5 RasSrv.cxx(266)
RAS Sent Successful 2008/10/30 17:15:27.302 5
job.cxx(426) JOB Job ARQ deleted
2008/10/30 17:15:27.302 5
job.cxx(415) JOB
Worker threads: 20 total - 19 busy, 1 idle 2008/10/30 17:15:27.322 5
yasocket.cxx(783) TCPSrv 1 sockets selected from 2, total
2/0 2008/10/30 17:15:27.322 4
yasocket.cxx(905) TCPSrv Accept
request on 130.194.gk.ip:1721 2008/10/30 17:15:27.322 5
job.cxx(363) JOB Worker threads: 20 total -
20 busy, 0 idle 2008/10/30
17:15:27.323 5
job.cxx(189) JOB Starting Job Acceptor at Worker
thread 25021344 2008/10/30
17:15:27.357 5 ProxyChannel.cxx(619) Q931s
Reading from 130.194.xx.xx:3230 2008/10/30 17:15:27.357 3 ProxyChannel.cxx(910)
Q931s Received: Setup CRV=3769 from 130.194.xx.xx:3230
2008/10/30 17:15:27.359 4
ProxyChannel.cxx(853) Q931 Received: {
2008/10/30 17:15:27.359 2
gkacct.cxx(1028) GKACCT Successfully
logged event 1 for call no. 15 2008/10/30 17:15:27.359 3 ProxyChannel.cxx(2161)
Q931s Call 15 is NAT type 0 2008/10/30 17:15:27.359 3 ProxyChannel.cxx(776)
GK Call 15 proxy enabled 2008/10/30 17:15:27.361 4
ProxyChannel.cxx(853) Q931 Send to 203.174.20.80:1720
{ 2008/10/30 17:15:27.384 3
ProxyChannel.cxx(3374) Q931 Connect to
203.174.20.80:1720 from 130.194.gk.ip:0 successful 2008/10/30 17:15:27.533 5
ProxyChannel.cxx(5103) ProxyH(14) total sockets 2 2008/10/30 17:15:27.534 5
job.cxx(426) JOB Job Acceptor
deleted 2008/10/30 17:15:27.534 5
job.cxx(415) JOB
Worker threads: 20 total - 19 busy, 1 idle 2008/10/30 17:15:27.534 5
yasocket.cxx(783) ProxyH(14) 1 sockets
selected from 2, total 2/0 2008/10/30
17:15:27.534 5 ProxyChannel.cxx(619) Q931d
Reading from 203.174.20.80:1720 2008/10/30 17:15:27.534 3 ProxyChannel.cxx(910)
Q931d Received: Facility CRV=3769 from 203.174.20.80:1720
2008/10/30 17:15:27.535 4
ProxyChannel.cxx(853) Q931 Received: {
2008/10/30 17:15:27.535 4
ProxyChannel.cxx(853) Q931 Send to
130.194.xx.xx:3230 { 2008/10/30
17:15:27.540 5 yasocket.cxx(783)
ProxyH(14) 1 sockets selected from 2, total 2/0
2008/10/30 17:15:27.540 5
ProxyChannel.cxx(619) Q931s Reading from
130.194.xx.xx:3230 2008/10/30
17:15:27.540 3 ProxyChannel.cxx(910) Q931s
Received: ReleaseComplete CRV=3769 from 130.194.xx.xx:3230 2008/10/30 17:15:27.540 4
ProxyChannel.cxx(853) Q931 Received: { 2008/10/30 17:15:27.541 2
RasTbl.cxx(3063) CDR ignore not connected
call 2008/10/30 17:15:27.541 5
gkacct.cxx(806) GKACCT
FileAcct - CDR string for event 2, call no. 15: CDR|15|02 2b d8 03 b2 00
00 10 04 92 f6 f7 64 cd 82 93|0||17:15:27.000 EST Thu Oct 30
2008|130.194.xx.xx:3230|00000000000000000000000082C2550F06B8jNXq|203.174.20.80:1720||203.174.20.80:1720|Paul
Hii:h323_ID=51172:dialedDigits|16 2008/10/30 17:15:27.541 3
gkacct.cxx(988) GKACCT FileAcct logged event 2 for call no.
15 2008/10/30 17:15:27.541 2
gkacct.cxx(1028) GKACCT
Successfully logged event 2 for call no. 15 2008/10/30 17:15:27.542 4
ProxyChannel.cxx(853) Q931 Send to 203.174.20.80:1720
{ 2008/10/30 17:15:27.582 5
yasocket.cxx(783) ProxyH(14)
1 sockets selected from 1, total 0/2 2008/10/30 17:15:27.582 5 ProxyChannel.cxx(619)
Q931d Reading from 203.174.20.80:1720 2008/10/30 17:15:27.582 5
yasocket.cxx(660) Q931d 203.174.20.80:1720 closed by
remote 2008/10/30 17:15:27.625 5
yasocket.cxx(783) TCPSrv 1
sockets selected from 2, total 2/0 2008/10/30 17:15:27.625 4
yasocket.cxx(905) TCPSrv Accept request on
130.194.gk.ip:1721 2008/10/30
17:15:27.625 5
job.cxx(363) JOB Worker threads: 20 total - 20
busy, 0 idle 2008/10/30 17:15:27.625 5
job.cxx(189) JOB
Starting Job Acceptor at Worker thread 25021344 2008/10/30 17:15:27.626 5
ProxyChannel.cxx(619) Q931s Reading from
202.177.196.34:2640 2008/10/30
17:15:27.626 3 ProxyChannel.cxx(910) Q931s
Received: Setup CRV=3989 from 202.177.196.34:2640 2008/10/30 17:15:27.628 4
ProxyChannel.cxx(853) Q931 Received: { 2008/10/30 17:15:27.629 5
Routing.cxx(201) ROUTING Checking policy Explicit for
request Setup CRV=3989 2008/10/30
17:15:27.629 5 Routing.cxx(201)
ROUTING Checking policy Internal for request Setup CRV=3989
2008/10/30 17:15:27.629 5
Routing.cxx(201) ROUTING Checking policy
ENUM for request Setup CRV=3989 2008/10/30 17:15:27.629 5
Routing.cxx(201) ROUTING Checking policy DNS for request Setup
CRV=3989 2008/10/30 17:15:27.629 5
Routing.cxx(201) ROUTING
Checking policy Internal for request Setup CRV=3989 2008/10/30 17:15:27.629 5
Routing.cxx(201) ROUTING Checking policy Neighbor for
request Setup CRV=3989 2008/10/30
17:15:27.629 3 ProxyChannel.cxx(1926) Q931s
No destination for unregistered call 02 2b d8 03 b2 69 f5 1a 04 93 f6 f7 64 cd
82 93 from 202.177.196.34:2640 2008/10/30 17:15:27.629 4 ProxyChannel.cxx(1956)
Q931s Source address 130.194.xx.xx peer address 202.177.196.34
caller is behind NAT 2008/10/30
17:15:27.629 2 RasTbl.cxx(2656)
CallTable::Insert(CALL) Call No. 16, total sessions : 1 2008/10/30 17:15:27.629 2
gkacct.cxx(1028) GKACCT Successfully logged event 1
for call no. 16 2008/10/30
17:15:27.630 2 RasTbl.cxx(3063)
CDR ignore not connected call 2008/10/30 17:15:27.630 5
gkacct.cxx(806) GKACCT FileAcct - CDR string for
event 2, call no. 16: CDR|16|02 2b d8 03 b2 69 f5 1a 04 93 f6 f7 64 cd 82
93|0||17:15:27.000 EST Thu Oct 30 2008|202.177.196.34:2640||0.0.0.0:0|||Paul
Hii:h323_ID=51172:dialedDigits|20 2008/10/30 17:15:27.630 3
gkacct.cxx(988) GKACCT FileAcct logged event 2 for call no.
16 2008/10/30 17:15:27.631 2
gkacct.cxx(1028) GKACCT
Successfully logged event 2 for call no. 16 2008/10/30 17:15:27.631 4
ProxyChannel.cxx(853) Q931 Send to 202.177.196.34:2640
{ 2008/10/30 17:15:27.631 3
yasocket.cxx(577) Q931s Delete
socket 202.177.196.34:2640 2008/10/30
17:15:27.631 5
job.cxx(426) JOB Job Acceptor deleted
2008/10/30 17:15:27.632 5
job.cxx(415) JOB
Worker threads: 20 total - 19 busy, 1 idle 2008/10/30 17:15:27.663 5
yasocket.cxx(783) RasSrv 1 sockets selected from 3, total
3/0
This is suspicious but i'm
unsure if it's normal call dropping. Thanks for your advice.
Cheers, Paul
|