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
------------------------------------------------------------------------- This SF.Net email is sponsored by the Moblin Your Move Developer's challenge Build the coolest Linux based applications with Moblin SDK & win great prizes Grand prize is a trip for two to an Open Source event anywhere in the world http://moblin-contest.org/redirect.php?banner_id=100&url=/
_______________________________________________________ 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/
