<div dir="ltr"><br><br><div class="gmail_quote">2008/10/19 Mindaugas Kezys <span dir="ltr"><<a href="mailto:mkezys@gmail.com">mkezys@gmail.com</a>></span><br><blockquote class="gmail_quote" style="border-left: 1px solid rgb(204, 204, 204); margin: 0pt 0pt 0pt 0.8ex; padding-left: 1ex;">
<div link="blue" vlink="purple" lang="EN-US">
<div>
<p><span style="font-size: 11pt; color: rgb(31, 73, 125);">Hi,</span></p>
<p><span style="font-size: 11pt; color: rgb(31, 73, 125);"> </span></p>
<p><span style="font-size: 11pt; color: rgb(31, 73, 125);">Try downgrade to Asterisk <a href="http://1.4.18.1" target="_blank">1.4.18.1</a>. It works for us perfectly with
H323. </span></p>
<p><span style="font-size: 11pt; color: rgb(31, 73, 125);"> </span></p>
<p><span style="font-size: 11pt; color: rgb(31, 73, 125);">Following versions has nasty bugs, not actually related to H323,
but who knows, maybe it will help to downgrade.</span></p>
<p><span style="font-size: 11pt; color: rgb(31, 73, 125);"> </span></p>
<p><span style="font-size: 11pt; color: rgb(31, 73, 125);">Regards,</span></p>
<p><span style="font-size: 11pt; color: rgb(31, 73, 125);">Mindaugas Kezys</span></p>
<p><span style="font-size: 11pt; color: rgb(31, 73, 125);"><a href="http://www.kolmisoft.com" target="_blank">http://www.kolmisoft.com</a></span></p>
<p><span style="font-size: 11pt; color: rgb(31, 73, 125);">VoIP Billing and Routing Solutions</span></p>
<p><span style="font-size: 11pt; color: rgb(31, 73, 125);"> </span></p>
<div style="border-style: solid none none; border-color: rgb(181, 196, 223) -moz-use-text-color -moz-use-text-color; border-width: 1pt medium medium; padding: 3pt 0cm 0cm;">
<p><b><span style="font-size: 10pt;">From:</span></b><span style="font-size: 10pt;">
<a href="mailto:asterisk-users-bounces@lists.digium.com" target="_blank">asterisk-users-bounces@lists.digium.com</a>
[mailto:<a href="mailto:asterisk-users-bounces@lists.digium.com" target="_blank">asterisk-users-bounces@lists.digium.com</a>] <b>On Behalf Of </b>Giedrius
Augys<br>
<b>Sent:</b> 2008 m. spalio 18 d. 22:08<br>
<b>To:</b> Asterisk Users Mailing List - Non-Commercial Discussion<br>
<b>Subject:</b> [asterisk-users] strange h323 delay issue</span></p>
</div><div><div></div><div class="Wj3C7c">
<p> </p>
<div>
<p>Hello,<br>
<br>
I have a strange h323 issue. After executing command
"Dial("SIP/333-0d1dfe00",
"H323/361737052390920@ccg|5|tT")" at Oct 18 22:32:23.
Meanwile I have sniffing traffic on port 1720. The call was established just at
Oct 18 22:33:03 (New H.323 Connection created.) and also packet sniffer grabs
the h323 invites at this time also. So my question is what asterisk (h323
channel) was doing for 40 sec??? What reasons could invoke this problem? I
haven't any problems with SIP channels.<br>
<br>
My versions:<br>
asterisk-1.4.21.1<br>
asterisk-addons-1.4.6<br>
openh323_v1_18_0<br>
pwlib_v1_10_0<br>
<br>
My h323.conf configurations:<br>
[general]<br>
port = 1720<br>
bindaddr = <a href="http://192.168.1.165" target="_blank">192.168.1.165</a><br>
tos=lowdelay<br>
disallow=all<br>
allow=g729<br>
dtmfmode=rfc2833<br>
gatekeeper = DISABLE<br>
AllowGKRouted = no<br>
AcceptAnonymous = no<br>
context=from-trunk<br>
<br>
<br>
[ccg]<br>
type=friend<br>
context=from-trunk<br>
host=<a href="http://192.168.1.163" target="_blank">192.168.1.163</a><br>
port=1720<br>
disallow=all<br>
;allow=alaw<br>
;allow=ulaw<br>
allow=g729<br>
fastStart=yes<br>
h245Tunneling=yes<br>
<br>
<br>
A full log:<br>
<br>
[Oct 18 22:32:23] VERBOSE[18236] logger.c: -- Executing
[123@from-sip:1] Dial("SIP/333-0d1d8fb0",
"H323/361737052390920@ccg|5|tT") in new stack<br>
[Oct 18 22:32:23] DEBUG[18236] chan_h323.c: type=H323, format=8,
data=361737052390920@ccg.<br>
[Oct 18 22:32:23] DEBUG[18236] chan_h323.c: Extension: 361737052390920 Host:
ccg<br>
[Oct 18 22:32:23] DEBUG[18236] chan_h323.c: Calling to 361737052390920@ccg on
H323/ccg-2<br>
[Oct 18 22:32:23] VERBOSE[18236] logger.c: -- Requested
transfer capability: 0x00 - SPEECH<br>
[Oct 18 22:32:23] DEBUG[18236] chan_h323.c: Placing outgoing call to <a href="http://361737052390920@192.168.1.163:1720" target="_blank">361737052390920@192.168.1.163:1720</a>,
101<br>
[Oct 18 22:32:23] VERBOSE[18236] logger.c: -- Making call to <a href="http://361737052390920@192.168.1.163:1720" target="_blank">361737052390920@192.168.1.163:1720</a>
without gatekeeper.<br>
[Oct 18 22:32:23] VERBOSE[18236] logger.c: Using <a href="http://192.168.1.165" target="_blank">192.168.1.165</a>
for outbound call<br>
[Oct 18 22:33:03] VERBOSE[18236] logger.c: == New
H.323 Connection created.<br>
[Oct 18 22:33:03] VERBOSE[18236] logger.c: --
root is calling host <a href="http://361737052390920@192.168.1.163:1720" target="_blank">361737052390920@192.168.1.163:1720</a><br>
[Oct 18 22:33:03] VERBOSE[18236] logger.c: --
Call token is ip$localhost/6453<br>
[Oct 18 22:33:03] VERBOSE[18236] logger.c: --
Call reference is 6453<br>
[Oct 18 22:33:03] VERBOSE[18236] logger.c: --
DTMF Payload is [pt=101]<br>
[Oct 18 22:33:03] VERBOSE[18236] logger.c: -- Called
361737052390920@ccg<br>
[Oct 18 22:33:03] DEBUG[18238] chan_h323.c: Setting capabilities for connection
ip$localhost/6453<br>
[Oct 18 22:33:03] VERBOSE[18238] logger.c: Setting capabilities to 0x100 (g729)<br>
[Oct 18 22:33:03] VERBOSE[18238] logger.c: Capabilities in preference order is
(g729)<br>
[Oct 18 22:33:03] VERBOSE[18238] logger.c: Allowed Codecs:<br>
[Oct 18 22:33:03] VERBOSE[18238] logger.c:
Table:<br>
[Oct 18 22:33:03] VERBOSE[18238] logger.c: G.729A <1><br>
[Oct 18 22:33:03] VERBOSE[18238] logger.c: G.729 <2><br>
[Oct 18 22:33:03] VERBOSE[18238] logger.c:
UserInput/hookflash <3><br>
[Oct 18 22:33:03] VERBOSE[18238] logger.c: UserInput/RFC2833
<4><br>
[Oct 18 22:33:03] VERBOSE[18238] logger.c: UserInput/dtmf
<5><br>
[Oct 18 22:33:03] VERBOSE[18238] logger.c: Set:<br>
[Oct 18 22:33:03] VERBOSE[18238] logger.c: 0:<br>
[Oct 18 22:33:03] VERBOSE[18238] logger.c: 0:<br>
[Oct 18 22:33:03] VERBOSE[18238]
logger.c: G.729A <1><br>
[Oct 18 22:33:03] VERBOSE[18238]
logger.c: G.729 <2><br>
[Oct 18 22:33:03] VERBOSE[18238] logger.c: 1:<br>
[Oct 18 22:33:03] VERBOSE[18238]
logger.c: UserInput/hookflash
<3><br>
[Oct 18 22:33:03] VERBOSE[18238] logger.c: 2:<br>
[Oct 18 22:33:03] VERBOSE[18238]
logger.c: UserInput/RFC2833 <4><br>
[Oct 18 22:33:03] VERBOSE[18238] logger.c:
UserInput/dtmf <5><br>
[Oct 18 22:33:03] VERBOSE[18238] logger.c:<br>
[Oct 18 22:33:03] DEBUG[18238] chan_h323.c: Capabilities for connection
ip$localhost/6453 is set<br>
[Oct 18 22:33:03] DEBUG[18238] chan_h323.c: Created RTP channel<br>
[Oct 18 22:33:03] DEBUG[18238] chan_h323.c: Setting NAT on RTP to 0<br>
[Oct 18 22:33:03] DEBUG[18238] chan_h323.c: Sending RTP 'US' <a href="http://192.168.1.165:23786" target="_blank">192.168.1.165:23786</a><br>
[Oct 18 22:33:03] DEBUG[18238] chan_h323.c: Sending RTP 'US' <a href="http://192.168.1.165:23786" target="_blank">192.168.1.165:23786</a><br>
[Oct 18 22:33:03] DEBUG[18238] chan_h323.c: Sending RTP 'US' <a href="http://192.168.1.165:23786" target="_blank">192.168.1.165:23786</a><br>
[Oct 18 22:33:03] DEBUG[18238] chan_h323.c: Sending RTP 'US' <a href="http://192.168.1.165:23786" target="_blank">192.168.1.165:23786</a><br>
[Oct 18 22:33:03] VERBOSE[18238] logger.c: --
Sending SETUP message<br>
[Oct 18 22:33:03] VERBOSE[18238] logger.c: --
Transmitting RFC2833 on payload 101<br>
[Oct 18 22:33:03] VERBOSE[18238] logger.c: --
Started logical channel: sending G.729A<br>
[Oct 18 22:33:03] VERBOSE[18238]
logger.c:
-- channelsOpen = 1<br>
[Oct 18 22:33:03] VERBOSE[18238]
logger.c:
External RTP Session Starting<br>
[Oct 18 22:33:03] VERBOSE[18238]
logger.c:
RTP channel id 1 parameters:<br>
[Oct 18 22:33:03] VERBOSE[18238]
logger.c:
-- remoteIpAddress: <a href="http://192.168.1.163" target="_blank">192.168.1.163</a><br>
[Oct 18 22:33:03] VERBOSE[18238]
logger.c:
-- remotePort: 10626<br>
[Oct 18 22:33:03] VERBOSE[18238]
logger.c:
-- ExternalIpAddress: <a href="http://192.168.1.165" target="_blank">192.168.1.165</a><br>
[Oct 18 22:33:03] VERBOSE[18238]
logger.c:
-- ExternalPort: 23786<br>
[Oct 18 22:33:03] DEBUG[18238] chan_h323.c: Setting up RTP connection for ip$localhost/6453<br>
[Oct 18 22:33:03] DEBUG[18238] chan_h323.c: Native format is set to 256 from
256 by RTP payload type 18<br>
[Oct 18 22:33:03] DEBUG[18238] chan_h323.c: RTP connection prepared for
ip$localhost/6453<br>
[Oct 18 22:33:03] VERBOSE[18238] logger.c: --
Started logical channel: receiving G.729A<br>
[Oct 18 22:33:03] VERBOSE[18238]
logger.c:
-- channelsOpen = 2<br>
[Oct 18 22:33:03] VERBOSE[18238]
logger.c:
External RTP Session Starting<br>
[Oct 18 22:33:03] VERBOSE[18238]
logger.c:
RTP channel id 1 parameters:<br>
[Oct 18 22:33:03] VERBOSE[18238]
logger.c:
-- remoteIpAddress: <a href="http://192.168.1.163" target="_blank">192.168.1.163</a><br>
[Oct 18 22:33:03] VERBOSE[18238]
logger.c:
-- remotePort: 10626<br>
[Oct 18 22:33:03] VERBOSE[18238]
logger.c:
-- ExternalIpAddress: <a href="http://192.168.1.165" target="_blank">192.168.1.165</a><br>
[Oct 18 22:33:03] VERBOSE[18238]
logger.c:
-- ExternalPort: 23786<br>
[Oct 18 22:33:03] DEBUG[18238] chan_h323.c: Setting up RTP connection for
ip$localhost/6453<br>
[Oct 18 22:33:03] DEBUG[18238] chan_h323.c: Native format is set to 256 from
256 by RTP payload type 18<br>
[Oct 18 22:33:03] DEBUG[18238] chan_h323.c: RTP connection prepared for
ip$localhost/6453<br>
[Oct 18 22:33:03] VERBOSE[18238] logger.c:
ExternalRTPChannel Destroyed<br>
[Oct 18 22:33:03] VERBOSE[18238] logger.c:
ExternalRTPChannel Destroyed<br>
[Oct 18 22:33:04] VERBOSE[18238] logger.c: =-= In
OnAlerting for call 6453: sessionId=0<br>
[Oct 18 22:33:04] VERBOSE[18238] logger.c: --
Ringing phone for "361737052390920"<br>
[Oct 18 22:33:04] VERBOSE[18238]
logger.c:
- Progress Indicator: 8<br>
[Oct 18 22:33:04] DEBUG[18238] chan_h323.c: Received ALERT/PROGRESS message for
inband tones<br>
[Oct 18 22:33:04] DEBUG[18238] chan_h323.c: Ringing on ip$localhost/6453<br>
[Oct 18 22:33:04] VERBOSE[18236] logger.c: --
H323/ccg-2 is making progress passing it to SIP/333-0d1d8fb0<br>
[Oct 18 22:33:04] VERBOSE[18236] logger.c: --
H323/ccg-2 is ringing<br>
[Oct 18 22:33:04] VERBOSE[18238] logger.c: --
Received Facility message...<br>
[Oct 18 22:33:04] VERBOSE[18238] logger.c: Peer capability is G.729 <2><br>
[Oct 18 22:33:04] VERBOSE[18238] logger.c: Found peer capability G.729
<2>, Asterisk code is 256, frame size (in ms) is 60<br>
[Oct 18 22:33:04] VERBOSE[18238] logger.c: Peer capability is G.729A <3><br>
[Oct 18 22:33:04] VERBOSE[18238] logger.c: Found peer capability G.729A
<3>, Asterisk code is 256, frame size (in ms) is 0<br>
[Oct 18 22:33:04] VERBOSE[18238] logger.c: Peer capability is G.723.1A
<4><br>
[Oct 18 22:33:04] VERBOSE[18238] logger.c: Found peer capability G.723.1A
<4>, Asterisk code is 1, frame size (in ms) is 60<br>
[Oct 18 22:33:04] VERBOSE[18238] logger.c: Peer capability is UserInput/dtmf
<7><br>
[Oct 18 22:33:04] VERBOSE[18238] logger.c: Peer capability is
UserInput/hookflash <8><br>
[Oct 18 22:33:04] VERBOSE[18238] logger.c: Peer capabilities = 0x101
(g723|g729), ordered list is (g729|g723)<br>
[Oct 18 22:33:04] DEBUG[18238] chan_h323.c: Got remote capabilities from
connection ip$localhost/6453<br>
[Oct 18 22:33:04] DEBUG[18238] chan_h323.c: prefs[0]=g729:60<br>
[Oct 18 22:33:04] DEBUG[18238] chan_h323.c: prefs[1]=g723:60<br>
[Oct 18 22:33:04] VERBOSE[18238] logger.c: --
Received Facility message...<br>
[Oct 18 22:33:08] VERBOSE[18236] logger.c: -- Nobody
picked up in 5000 ms<br>
[Oct 18 22:33:08] DEBUG[18236] chan_h323.c: Hanging up and scheduling destroy
of call H323/ccg-2<br>
[Oct 18 22:33:08] VERBOSE[18236] logger.c: --
Sending RELEASE COMPLETE<br>
[Oct 18 22:33:08] VERBOSE[18236] logger.c: --
ClearCall: Request to clear call with token ip$localhost/6453, cause
EndedByRemoteUser<br>
[Oct 18 22:33:08] VERBOSE[18236] logger.c: == Auto fallthrough,
channel 'SIP/333-0d1d8fb0' status is 'NOANSWER'<br>
[Oct 18 22:33:08] VERBOSE[18215]
logger.c:
channelsOpen = 1<br>
[Oct 18 22:33:08] VERBOSE[18215]
logger.c:
channelsOpen = 0<br>
[Oct 18 22:33:08] VERBOSE[18215] logger.c:
ExternalRTPChannel Destroyed<br>
[Oct 18 22:33:08] VERBOSE[18215] logger.c:
ExternalRTPChannel Destroyed<br>
[Oct 18 22:33:08] VERBOSE[18238] logger.c: --
ClearCall: Request to clear call with token ip$localhost/6453, cause
EndedByTransportFail<br>
[Oct 18 22:33:08] VERBOSE[18215] logger.c: -- 361737052390920 has cleared the
call<br>
[Oct 18 22:33:08] DEBUG[18215] chan_h323.c: Cleaning connection to
ip$localhost/6453<br>
[Oct 18 22:33:08] DEBUG[18215] chan_h323.c: No connection for ip$localhost/6453<br>
[Oct 18 22:33:08] VERBOSE[18215] logger.c: ==
H.323 Connection deleted.<br>
<br>
<br clear="all">
Thanks<br>
-- <br>
Pagarbiai / Best Regards,<br>
Giedrius Augys</p>
</div>
</div></div></div>
</div>
<br>_______________________________________________<br>
-- Bandwidth and Colocation Provided by <a href="http://www.api-digital.com" target="_blank">http://www.api-digital.com</a> --<br>
<br>
asterisk-users mailing list<br>
To UNSUBSCRIBE or update options visit:<br>
<a href="http://lists.digium.com/mailman/listinfo/asterisk-users" target="_blank">http://lists.digium.com/mailman/listinfo/asterisk-users</a><br></blockquote></div><br><br clear="all">Not helped...<br><br>-- <br>Pagarbiai / Best Regards,<br>
Giedrius Augys<br>
</div>