Oh waaaait a second... my other endpoint is on an ip address with a special rule in the firewall to allow everything from my primary ip address through the firewall. That explains why I can call my other endpoint directly, and going through my server with gnugk did not work. I just updated my firewall rules to allow any connection from the gnugk server and poof, it is working again! Thank you! Marvin Herbold Principal Software Engineer Access Interpreting, Inc. Website: ainterpreting.com (480) 347-9629 (Support VP) (571) 730-4330 (Main Office Voice) (571) 730-4331 (Main Office Fax) (202) 540-8617 (Main Office VP) -----Original Message----- From: Jan Willamowius [mailto:jan@xxxxxxxxxxxxxx] Sent: Friday, February 01, 2013 3:17 PM To: openh323gk-users@xxxxxxxxxxxxxxxxxxxxx Subject: Re: Q.931 error 9/110: Connection timed out, DIDN'T ACCEPT THE CALL Hi Marvin, The error message means that GnuGk on 74.208.147.64 can't establish a TCP connection to IP 65.84.19.45 on port 1720. Either there is no endpoint running on that IP, it is listening on a different port or the connection is blocked by firewall on the path. Regards, Jan -- Jan Willamowius, Founder of the GNU Gatekeeper Project EMail : jan@xxxxxxxxxxxxxx Website: http://www.gnugk.org Support: http://www.willamowius.com/gnugk-support.html Relaxed Communications GmbH Frahmredder 91 22393 Hamburg Geschäftsführer: Jan Willamowius HRB 125261 (Amtsgericht Hamburg) USt-IdNr: DE286003584 Marvin Herbold wrote: > > Hello guys. It's been about a year since I last posted to this > mailing list. At the time I had gotten everything to work > beautifully. I have not updated Gnugk since and have not touched it. > Today we needed to test this system out and I was surprised that calls no longer works. > When calling the endpoint directly, it connects. When trying to call > through Gnugk it does not. I looked in the log and see some kind of > connection timed out and a "didn't accept the call" error. Can > someone explain to me what is happening? 74.208.147.64 is our > gatekeeper IP address. I am confused as to who is trying to connect > to "Q.931 socket at 74.208.147.64:0". If it is relevant, caller is > behind a firewall and callee is not. I tried both with h.245 tunneling and without. > > 2013/02/01 14:09:56.598 4 yasocket.cxx(1116) TCPSrv Accept > request on 74.208.147.64:1720 > 2013/02/01 14:09:56.599 5 job.cxx(351) JOB Worker > threads: 10 total - 10 busy, 0 idle > 2013/02/01 14:09:56.599 5 job.cxx(191) JOB Starting Job > Acceptor at Worker thread 140518605829888 > 2013/02/01 14:09:56.603 5 ProxyChannel.cxx(802) Q931s Reading > from 68.14.209.154:4003 > 2013/02/01 14:09:56.603 3 ProxyChannel.cxx(1162) Q931s Received: > Setup CRV=3378 from 68.14.209.154:4003 > 2013/02/01 14:09:56.604 4 ProxyChannel.cxx(1109) Q931 Received: { > q931pdu = { > protocolDiscriminator = 8 > callReference = 3378 > from = originator > messageType = Setup > IE: Bearer-Capability = { > 88 18 90 a5 .... > } > IE: User-User = { > 30 a8 06 00 08 91 4a 00 06 01 40 19 00 6d 00 68 0.....J...@..m.h > 00 65 00 72 00 62 00 6f 00 6c 00 64 00 40 00 61 .e.r.b.o.l.d.@.a > 00 69 00 6e 00 74 00 65 00 72 00 70 00 72 00 65 .i.n.t.e.r.p.r.e > 00 74 00 69 00 6e 00 67 00 2e 00 63 00 6f 00 6d .t.i.n.g...c.o.m > 22 c0 59 00 44 4c 13 4c 69 66 65 53 69 7a 65 20 ".Y.DL.LifeSize > 53 6f 66 74 70 68 6f 6e 65 00 00 10 38 2e 31 2e Softphone...8.1. > 35 20 28 57 69 6e 64 6f 77 73 29 00 00 00 4a d0 5 (Windows)...J. > 93 40 06 b8 00 c6 07 39 fd 1a 09 19 10 96 38 00 .@.....9......8. > 24 e8 1c 86 17 00 5d 0d 80 07 00 44 0e d1 9a 0f $.....]....D.... > a3 11 00 c6 07 39 fd 1a 09 19 10 96 37 00 24 e8 .....9......7.$. > 1c 86 17 01 00 01 00 01 00 01 00 40 00 00 00 00 ...........@.... > 0a 31 30 37 39 35 32 31 33 34 31 02 80 01 80 .1079521341.... > } > } > h225pdu = { > h323_uu_pdu = { > h323_message_body = setup { > protocolIdentifier = 0.0.8.2250.0.6 > sourceAddress = 1 entries { > [0]=h323_ID 26 characters { > 006d 0068 0065 0072 0062 006f 006c 0064 mherbold > 0040 0061 0069 006e 0074 0065 0072 0070 @ainterp > 0072 0065 0074 0069 006e 0067 002e 0063 reting.c > 006f 006d om > } > } > sourceInfo = { > vendor = { > vendor = { > t35CountryCode = 89 > t35Extension = 0 > manufacturerCode = 17484 > } > productId = 20 octets { > 4c 69 66 65 53 69 7a 65 20 53 6f 66 74 70 68 6f > LifeSize Softpho > 6e 65 00 00 ne.. > } > versionId = 17 octets { > 38 2e 31 2e 35 20 28 57 69 6e 64 6f 77 73 29 00 8.1.5 > (Windows). > 00 . > } > } > terminal = { > } > mc = false > undefinedNode = false > } > destCallSignalAddress = ipAddress { > ip = 4 octets { > 4a d0 93 40 J..@ > } > port = 1720 > } > activeMC = false > conferenceID = 16 octets { > c6 07 39 fd 1a 09 19 10 96 38 00 24 e8 1c 86 17 ..9......8.$.... > } > conferenceGoal = create <<null>> > callType = pointToPoint <<null>> > sourceCallSignalAddress = ipAddress { > ip = 4 octets { > 44 0e d1 9a D... > } > port = 4003 > } > callIdentifier = { > guid = 16 octets { > c6 07 39 fd 1a 09 19 10 96 37 00 24 e8 1c 86 17 > ..9......7.$.... > } > } > mediaWaitForConnect = false > canOverlapSend = false > multipleCalls = false > maintainConnection = false > } > nonStandardData = { > nonStandardIdentifier = h221NonStandard { > t35CountryCode = 0 > t35Extension = 0 > manufacturerCode = 0 > } > data = 10 octets { > 31 30 37 39 35 32 31 33 34 31 1079521341 > } > } > h245Tunneling = true > } > } > } > 2013/02/01 14:09:56.605 5 Routing.cxx(200) ROUTING Checking > policy SqlPolicy for request Setup CRV=3378 > 2013/02/01 14:09:56.605 5 gksql.cxx(321) SqlPolicy > Executing query: SELECT ( SELECT vp_ip_address FROM accounts WHERE id > = account_id ) FROM pool ORDER BY priority > 2013/02/01 14:09:56.605 5 Routing.cxx(1747) SqlPolicy > Query result : 65.84.19.45 > 2013/02/01 14:09:56.606 5 Routing.cxx(203) ROUTING Policy > SqlPolicy applied to the request Setup CRV=3378 > 2013/02/01 14:09:56.606 4 ProxyChannel.cxx(2917) Q931s > Unregistered party is not NATed > 2013/02/01 14:09:56.606 2 RasTbl.cxx(4013) > CallTable::Insert(CALL) Call No. 5, total sessions : 1 > 2013/02/01 14:09:56.606 5 gksql.cxx(321) SQLAcct > Executing query: INSERT INTO gnugk SET id = '510c110000000005', > caller_ip = '68.14.209.154', caller_port = '4003', caller_id = > 'mherbold@xxxxxxxxxxxxxxxxx', ring_duration = '0', call_duration = > '0', total_duration = '0', callee_ip = '65.84.19.45', account_id = ( > SELECT id FROM accounts WHERE vp_ip_address = '65.84.19.45' ), call_id > = 'c6 07 > 39 fd 1a 09 19 10 96 37 00 24 e8 1c 86 17' > 2013/02/01 14:09:56.607 3 gkacct.cxx(914) GKACCT SQLAcct > logged event 1 for call no. 5 > 2013/02/01 14:09:56.607 2 gkacct.cxx(950) GKACCT > Successfully logged event 1 for call no. 5 > 2013/02/01 14:09:56.607 3 ProxyChannel.cxx(3393) Q931s Call 5 > is NAT type 0 > 2013/02/01 14:09:56.607 5 Toolkit.cxx(664) ModeSelection for > 68.14.209.154 -> 65.84.19.45 default=1 > 2013/02/01 14:09:56.607 1 ProxyChannel.cxx(997) Call 5: > h245Routed=0 proxy=0 > 2013/02/01 14:09:56.608 4 ProxyChannel.cxx(1109) Q931 Send to > 65.84.19.45:1720 { > q931pdu = { > protocolDiscriminator = 8 > callReference = 3378 > from = originator > messageType = Setup > IE: Bearer-Capability = { > 88 18 90 a5 .... > } > IE: User-User = { > 30 a8 06 00 08 91 4a 00 06 01 40 19 00 6d 00 68 0.....J...@..m.h > 00 65 00 72 00 62 00 6f 00 6c 00 64 00 40 00 61 .e.r.b.o.l.d.@.a > 00 69 00 6e 00 74 00 65 00 72 00 70 00 72 00 65 .i.n.t.e.r.p.r.e > 00 74 00 69 00 6e 00 67 00 2e 00 63 00 6f 00 6d .t.i.n.g...c.o.m > 22 c0 59 00 44 4c 13 4c 69 66 65 53 69 7a 65 20 ".Y.DL.LifeSize > 53 6f 66 74 70 68 6f 6e 65 00 00 10 38 2e 31 2e Softphone...8.1. > 35 20 28 57 69 6e 64 6f 77 73 29 00 00 00 41 54 5 (Windows)...AT > 13 2d 06 b8 00 c6 07 39 fd 1a 09 19 10 96 38 00 .-.....9......8. > 24 e8 1c 86 17 00 5d 0d 80 07 00 4a d0 93 40 06 $.....]....J..@. > b8 11 00 c6 07 39 fd 1a 09 19 10 96 37 00 24 e8 .....9......7.$. > 1c 86 17 01 00 01 00 01 00 01 00 40 00 00 00 00 ...........@.... > 0a 31 30 37 39 35 32 31 33 34 31 02 80 01 80 .1079521341.... > } > } > h225pdu = { > h323_uu_pdu = { > h323_message_body = setup { > protocolIdentifier = 0.0.8.2250.0.6 > sourceAddress = 1 entries { > [0]=h323_ID 26 characters { > 006d 0068 0065 0072 0062 006f 006c 0064 mherbold > 0040 0061 0069 006e 0074 0065 0072 0070 @ainterp > 0072 0065 0074 0069 006e 0067 002e 0063 reting.c > 006f 006d om > } > } > sourceInfo = { > vendor = { > vendor = { > t35CountryCode = 89 > t35Extension = 0 > manufacturerCode = 17484 > } > productId = 20 octets { > 4c 69 66 65 53 69 7a 65 20 53 6f 66 74 70 68 6f > LifeSize Softpho > 6e 65 00 00 ne.. > } > versionId = 17 octets { > 38 2e 31 2e 35 20 28 57 69 6e 64 6f 77 73 29 00 8.1.5 > (Windows). > 00 . > } > } > terminal = { > } > mc = false > undefinedNode = false > } > destCallSignalAddress = ipAddress { > ip = 4 octets { > 41 54 13 2d AT.- > } > port = 1720 > } > activeMC = false > conferenceID = 16 octets { > c6 07 39 fd 1a 09 19 10 96 38 00 24 e8 1c 86 17 ..9......8.$.... > } > conferenceGoal = create <<null>> > callType = pointToPoint <<null>> > sourceCallSignalAddress = ipAddress { > ip = 4 octets { > 4a d0 93 40 J..@ > } > port = 1720 > } > callIdentifier = { > guid = 16 octets { > c6 07 39 fd 1a 09 19 10 96 37 00 24 e8 1c 86 17 > ..9......7.$.... > } > } > mediaWaitForConnect = false > canOverlapSend = false > multipleCalls = false > maintainConnection = false > } > nonStandardData = { > nonStandardIdentifier = h221NonStandard { > t35CountryCode = 0 > t35Extension = 0 > manufacturerCode = 0 > } > data = 10 octets { > 31 30 37 39 35 32 31 33 34 31 1079521341 > } > } > h245Tunneling = true > } > } > } > 2013/02/01 14:10:02.619 1 ProxyChannel.cxx(5477) Q931d Could not > open/connect Q.931 socket at 74.208.147.64:0 - error 9/110: Connection > timed out > 2013/02/01 14:10:02.619 3 ProxyChannel.cxx(5144) Q931 > 65.84.19.45:1720 DIDN'T ACCEPT THE CALL > 2013/02/01 14:10:02.619 4 ProxyChannel.cxx(1109) Q931 Send to > 68.14.209.154:4003 { > q931pdu = { > protocolDiscriminator = 8 > callReference = 36146 > from = destination > messageType = ReleaseComplete > IE: Cause - No route to destination = { > 80 83 .. > } > IE: User-User = { > 25 c0 06 00 08 91 4a 00 02 10 08 11 00 c6 07 39 %.....J........9 > fd 1a 09 19 10 96 37 00 24 e8 1c 86 17 02 80 01 ......7.$....... > 00 . > } > } > h225pdu = { > h323_uu_pdu = { > h323_message_body = releaseComplete { > protocolIdentifier = 0.0.8.2250.0.2 > reason = unreachableDestination <<null>> > callIdentifier = { > guid = 16 octets { > c6 07 39 fd 1a 09 19 10 96 37 00 24 e8 1c 86 17 > ..9......7.$.... > } > } > } > h245Tunneling = false > } > } > } > 2013/02/01 14:10:02.619 2 RasTbl.cxx(4488) CDR ignore not > connected call > 2013/02/01 14:10:02.620 5 gksql.cxx(321) SQLAcct > Executing query: UPDATE gnugk SET ring_duration = '0', call_duration = > '0', total_duration = '6', disconnect_time = '2013-02-01 14:10:02', > disconnect_cause = '3', who_disconnected = '0' WHERE id = '510c110000000005' > 2013/02/01 14:10:02.621 3 gkacct.cxx(914) GKACCT SQLAcct > logged event 2 for call no. 5 > 2013/02/01 14:10:02.621 2 gkacct.cxx(950) GKACCT > Successfully logged event 2 for call no. 5 > 2013/02/01 14:10:02.621 3 yasocket.cxx(794) Q931d Delete > socket 65.84.19.45:1720 > 2013/02/01 14:10:02.621 3 yasocket.cxx(794) Q931s Delete > socket 68.14.209.154:4003 > 2013/02/01 14:10:02.621 5 job.cxx(403) JOB Job > Acceptor deleted > 2013/02/01 14:10:02.621 5 job.cxx(393) JOB Worker > threads: 10 total - 9 busy, 1 idle > 2013/02/01 14:10:02.844 3 RasTbl.cxx(2370) Gk Delete Call No. 5 > > -- > > Marvin Herbold > marvin.herbold@xxxxxxxxx > 480-347-0326 > > ---------------------------------------------------------------------------- -- Everyone hates slow websites. So do we. Make your web apps faster with AppDynamics Download AppDynamics Lite for free today: http://p.sf.net/sfu/appdyn_d2d_jan _______________________________________________________ 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/ ------------------------------------------------------------------------------ Everyone hates slow websites. So do we. Make your web apps faster with AppDynamics Download AppDynamics Lite for free today: http://p.sf.net/sfu/appdyn_d2d_jan _______________________________________________________ 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/
