[h323plus] Unable to connect more than one client

Simon Horne s.horne at packetizer.com
Wed Feb 23 16:21:53 EST 2011


Here is the offending line
2011/02/23 15:23:27.018 H225 Answer:be982700 Info H323 Available bandwidth
exceeded

My Guess is that either ekiga is not setting correctly the bandwidth value
in the OLC or the bandwidth setting of the MCU is too low.

Try increasing the bandwidth to 1000Mbps and try again. 
H323Endpoint::SetInitialBandwidth()

Simon

-----Original Message-----
From: h323plus-bounces at lists.packetizer.com
[mailto:h323plus-bounces at lists.packetizer.com] On Behalf Of Jérémy Subtil
Sent: 24 February 2011 01:32
To: h323plus at lists.packetizer.com
Subject: [h323plus] Unable to connect more than one client

Hi there,


I compiled openmcu 2.2.5 on Computer A, along with ptlib 2.8.3 and h323plus
1.22. The server starts fine with all the expected codecs, and the output is
the following:

#openmcu -cd
2011/02/23 15:19:54.998 OpenMCU Message Starting service process "OpenMCU"
v2.2.5 - error = 20 Daemon started with pid 2026
2011/02/23 15:19:55.006 H323 Listener:bebd6700 Info H323 Awaiting TCP
connections on port 1720
2011/02/23 15:19:55.013 OpenMCU Info MCU Codecs (in preference order):
Table:
G.711-ALaw-64k <1>
G.711-uLaw-64k <2>
G.722.1-24k{sw} <3>
G.722.1-32k{sw} <4>
G.726-16k{sw} <5>
G.726-24k{sw} <6>
G.726-32k{sw} <7>
G.726-40k{sw} <8>
GSM-06.10{sw} <9>
GSM-AMR{sw} <10>
LPC-10{sw} <11>
MS-GSM{sw} <12>
MS-IMA-ADPCM{sw} <13>
SpeexIETFNarrow-11k{sw} <14>
SpeexIETFNarrow-15k{sw} <15>
SpeexIETFNarrow-18.2k{sw} <16>
SpeexIETFNarrow-24.6k{sw} <17>
SpeexIETFNarrow-5.95k{sw} <18>
SpeexIETFNarrow-8k{sw} <19>
SpeexIETFWide-20.6k{sw} <20>
SpeexWNarrow-8k{sw} <21>
SpeexWide-20.6k{sw} <22>
iLBC-13k3{sw} <23>
iLBC-15k2{sw} <24>
iLBC{sw} <25>
H.261-CIF{sw} <26>
H.263-CIF{sw} <30>
H.239 Control <33>
UserInput/hookflash <27>
UserInput/basicString <28>
UserInput/dtmf <29>
UserInput/RFC2833 <31>
UserInput/Navigation <32>
UserInput/Softkey <34>
UserInput/PointDevice <35>
UserInput/Modal <36>
Set:
0:
0:
G.711-ALaw-64k <1>
G.711-uLaw-64k <2>
G.722.1-24k{sw} <3>
G.722.1-32k{sw} <4>
G.726-16k{sw} <5>
G.726-24k{sw} <6>
G.726-32k{sw} <7>
G.726-40k{sw} <8>
GSM-06.10{sw} <9>
GSM-AMR{sw} <10>
LPC-10{sw} <11>
MS-GSM{sw} <12>
MS-IMA-ADPCM{sw} <13>
SpeexIETFNarrow-11k{sw} <14>
SpeexIETFNarrow-15k{sw} <15>
SpeexIETFNarrow-18.2k{sw} <16>
SpeexIETFNarrow-24.6k{sw} <17>
SpeexIETFNarrow-5.95k{sw} <18>
SpeexIETFNarrow-8k{sw} <19>
SpeexIETFWide-20.6k{sw} <20>
SpeexWNarrow-8k{sw} <21>
SpeexWide-20.6k{sw} <22>
iLBC-13k3{sw} <23>
iLBC-15k2{sw} <24>
iLBC{sw} <25>
1:
H.261-CIF{sw} <26>
H.263-CIF{sw} <30>
2:
H.239 Control <33>
UserInput/hookflash <27>
UserInput/basicString <28>
UserInput/dtmf <29>
UserInput/RFC2833 <31>
UserInput/Navigation <32>
UserInput/Softkey <34>
UserInput/PointDevice <35>
UserInput/Modal <36>
2011/02/23 15:19:55.015 OpenMCU Info Opened master socket for HTTP: 1420
2011/02/23 15:19:55.015 OpenMCU Info Service OpenMCU Started


Computer B can connect successfully with Ekiga 3 as client:

2011/02/23 15:22:34.241 H323 Listener:bebd6700 Info H323TCP Started
connection: host=10.1.9.153:30000, if=10.1.9.152:1720, handle=18
2011/02/23 15:22:34.274 H225 Answer:beb54700 Info H225 Set remote
application name: " 3.2.7 (OPAL v3.6.8) 9/61"
2011/02/23 15:22:34.305 H225 Answer:beb54700 Info H323 CreateLogicalChannel
- unknown data type
2011/02/23 15:22:34.305 H225 Answer:beb54700 Info H323 CreateLogicalChannel
- unknown data type
2011/02/23 15:22:34.306 H225 Answer:beb54700 Info RTP_UDP Session 1
created: 10.1.9.152:5000-5001 ssrc=3028627343
2011/02/23 15:22:34.306 H225 Answer:beb54700 Info RTP Adding session RTP_UDP
2011/02/23 15:22:34.306 H225 Answer:beb54700 Warning H323RTP Setting dynamic
RTP payload type: 108 - error = 107
2011/02/23 15:22:34.307 H225 Answer:beb54700 Warning H323RTP Setting dynamic
RTP payload type: 108 - error = 107
2011/02/23 15:22:34.308 H225 Answer:beb54700 Warning H323RTP Setting dynamic
RTP payload type: 110 - error = 107
2011/02/23 15:22:34.308 H225 Answer:beb54700 Warning H323RTP Setting dynamic
RTP payload type: 110 - error = 107
2011/02/23 15:22:34.309 H225 Answer:beb54700 Warning H323RTP Setting dynamic
RTP payload type: 119 - error = 107
2011/02/23 15:22:34.310 H225 Answer:beb54700 Warning H323RTP Setting dynamic
RTP payload type: 119 - error = 107
2011/02/23 15:22:34.310 H225 Answer:beb54700 Warning H323RTP Setting dynamic
RTP payload type: 118 - error = 107
2011/02/23 15:22:34.310 H225 Answer:beb54700 Warning H323RTP Setting dynamic
RTP payload type: 118 - error = 107
2011/02/23 15:22:34.311 H225 Answer:beb54700 Warning H323RTP Setting dynamic
RTP payload type: 117 - error = 107
2011/02/23 15:22:34.311 H225 Answer:beb54700 Warning H323RTP Setting dynamic
RTP payload type: 117 - error = 107
2011/02/23 15:22:34.311 H225 Answer:beb54700 Warning H323RTP Setting dynamic
RTP payload type: 116 - error = 107
2011/02/23 15:22:34.312 H225 Answer:beb54700 Warning H323RTP Setting dynamic
RTP payload type: 116 - error = 107
2011/02/23 15:22:34.313 H225 Answer:beb54700 Warning H323RTP Setting dynamic
RTP payload type: 115 - error = 107
2011/02/23 15:22:34.313 H225 Answer:beb54700 Warning H323RTP Setting dynamic
RTP payload type: 115 - error = 107
2011/02/23 15:22:34.314 H225 Answer:beb54700 Warning H323RTP Setting dynamic
RTP payload type: 103 - error = 107
2011/02/23 15:22:34.314 H225 Answer:beb54700 Warning H323RTP Setting dynamic
RTP payload type: 103 - error = 107
2011/02/23 15:22:34.314 H225 Answer:beb54700 Warning H323RTP Setting dynamic
RTP payload type: 109 - error = 107
2011/02/23 15:22:34.315 H225 Answer:beb54700 Warning H323RTP Setting dynamic
RTP payload type: 109 - error = 107
2011/02/23 15:22:34.316 H225 Answer:beb54700 Info RTP_UDP Session 2
created: 10.1.9.152:5002-5003 ssrc=2730609199
2011/02/23 15:22:34.316 H225 Answer:beb54700 Info RTP Adding session RTP_UDP
2011/02/23 15:22:34.326 H225 Answer:beb54700 Info H323 Available bandwidth
exceeded
2011/02/23 15:22:34.326 H225 Answer:beb54700 Info H323 OnReceivedPDU gave
error 7
2011/02/23 15:22:34.326 H225 Answer:beb54700 Info RTP Releasing session 2
2011/02/23 15:22:34.328 H225 Answer:beb54700 Info H323 Available bandwidth
exceeded
2011/02/23 15:22:34.328 H225 Answer:beb54700 Info H323 OnReceivedPDU gave
error 7
2011/02/23 15:22:34.328 H225 Answer:beb54700 Info RTP Releasing session 2
2011/02/23 15:22:34.328 H225 Answer:beb54700 Info H323 Answering call: 
AnswerCallNow
2011/02/23 15:22:34.328 H225 Answer:beb54700 Info H245 Default
OnSelectLogicalChannels, FastStartResponse
2011/02/23 15:22:34.328 H225 Answer:beb54700 Info H323 Started sending
logical channel: SpeexIETFWide-20.6k{sw} <20>
2011/02/23 15:22:34.329 H225 Answer:beb54700 Info H323 Started receiving
logical channel: SpeexIETFWide-20.6k{sw} <20>
2011/02/23 15:22:34.329 LogChanTx:beac7700 Info H323RTP Transmit
SpeexIETFWide-20.6k thread started: rate=320 time=20ms size=1*52=52
2011/02/23 15:22:34.329 H225 Answer:beb54700 Info H323 Started sending
logical channel: H.261-CIF{sw} <26>
2011/02/23 15:22:34.329 LogChanRx:bea86700 Info H323RTP Receive
SpeexIETFWide-20.6k thread started.
2011/02/23 15:22:34.329 LogChanRx:bea86700 Info RTP Jitter buffer
created: size=101 delay=800-4000/800 (100ms) obj=0xc34160
2011/02/23 15:22:34.330 LogChanTx:bea45700 Info H323RTP Transmit H.261-CIF
thread started: rate=29 time=0ms size=1*2000=2000
2011/02/23 15:22:34.331 LogChanTx:beac7700 Warning Cannot open WAV file
/root/entering.wav - error = 2
2011/02/23 15:22:34.331 H225 Answer:beb54700 Info H323 Started receiving
logical channel: H.261-CIF{sw} <26>
2011/02/23 15:22:34.331 H225 Answer:beb54700 Info RTP Releasing session 1
2011/02/23 15:22:34.331 H225 Answer:beb54700 Info RTP Releasing session 1
2011/02/23 15:22:34.331 H225 Answer:beb54700 Info RTP Releasing session 1
2011/02/23 15:22:34.331 H225 Answer:beb54700 Info RTP Releasing session 1
2011/02/23 15:22:34.331 H225 Answer:beb54700 Info RTP Releasing session 1
2011/02/23 15:22:34.331 H225 Answer:beb54700 Info RTP Releasing session 1
2011/02/23 15:22:34.332 H225 Answer:beb54700 Info RTP Releasing session 1
2011/02/23 15:22:34.332 H225 Answer:beb54700 Info RTP Releasing session 1
2011/02/23 15:22:34.332 H225 Answer:beb54700 Info RTP Releasing session 1
2011/02/23 15:22:34.332 H225 Answer:beb54700 Info RTP Releasing session 1
2011/02/23 15:22:34.332 H225 Answer:beb54700 Info RTP Releasing session 1
2011/02/23 15:22:34.332 H225 Answer:beb54700 Info RTP Releasing session 1
2011/02/23 15:22:34.332 H225 Answer:beb54700 Info RTP Releasing session 1
2011/02/23 15:22:34.332 H225 Answer:beb54700 Info RTP Releasing session 1
2011/02/23 15:22:34.332 H225 Answer:beb54700 Info RTP Releasing session 1
2011/02/23 15:22:34.332 H225 Answer:beb54700 Info RTP Releasing session 1
2011/02/23 15:22:34.332 H225 Answer:beb54700 Info RTP Releasing session 1
2011/02/23 15:22:34.332 H225 Answer:beb54700 Info RTP Releasing session 1
2011/02/23 15:22:34.332 H225 Answer:beb54700 Info RTP Releasing session 1
2011/02/23 15:22:34.332 H225 Answer:beb54700 Info RTP Releasing session 1
2011/02/23 15:22:34.333 H225 Answer:beb54700 Info RTP Releasing session 1
2011/02/23 15:22:34.333 H225 Answer:beb54700 Info RTP Releasing session 1
2011/02/23 15:22:34.333 H225 Answer:beb54700 Info RTP Releasing session 2
2011/02/23 15:22:34.333 H225 Answer:beb54700 Info RTP Releasing session 2
2011/02/23 15:22:34.333 LogChanRx:be9c3700 Info H323RTP Receive H.261-CIF
thread started.
2011/02/23 15:22:34.341 H225 Answer:beb54700 Info H323 User Input
RFC2833 payload type set to [pt=101]
2011/02/23 15:22:34.341 H225 Answer:beb54700 Info H245
MasterSlaveDetermination: local is master
2011/02/23 15:22:34.342 H225 Answer:beb54700 Info H225 Reading PDUs: 
callRef=3310
2011/02/23 15:22:34.358 RTP Jitter:bea04700 Info RTP First data: ver=2
pt=[pt=108] psz=52 m=1 x=0 seq=1749 ts=0 src=531892144 ccnt=0
2011/02/23 15:22:34.363 LogChanRx:be9c3700 Info RTP First data: ver=2
pt=H261 psz=969 m=1 x=0 seq=54377 ts=0 src=1679710377 ccnt=0
2011/02/23 15:22:34.364 LogChanRx:be9c3700 Info PVidDev SetFrameSize to
176x144
2011/02/23 15:22:34.365 H225 Answer:beb54700 Info H245 TerminalCapabilitySet
Sent.
2011/02/23 15:22:36.356 RTP Jitter:bea04700 Info RTP Receive statistics: 
packets=101 octets=5252 lost=0 tooLate=0 order=0 avgTime=19 maxTime=21
minTime=19 jitter=7129523 maxJitter=33554431
2011/02/23 15:22:38.332 LogChanTx:beac7700 Info RTP Transmit statistics: 
packets=101 octets=5252 avgTime=40 maxTime=42 minTime=38
2011/02/23 15:22:38.356 RTP Jitter:bea04700 Info RTP Receive statistics: 
packets=201 octets=10452 lost=0 tooLate=0 order=0 avgTime=20 maxTime=21
minTime=19 jitter=11225 maxJitter=33554431
2011/02/23 15:22:40.354 RTP Jitter:bea04700 Info RTP Receive statistics: 
packets=301 octets=15652 lost=0 tooLate=0 order=0 avgTime=19 maxTime=21
minTime=19 jitter=17 maxJitter=33554431
2011/02/23 15:22:42.332 LogChanTx:beac7700 Info RTP Transmit statistics: 
packets=201 octets=10452 avgTime=40 maxTime=42 minTime=38
2011/02/23 15:22:42.354 RTP Jitter:bea04700 Info RTP Receive statistics: 
packets=401 octets=20852 lost=0 tooLate=0 order=0 avgTime=19 maxTime=21
minTime=19 jitter=0 maxJitter=33554431
2011/02/23 15:22:44.353 RTP Jitter:bea04700 Info RTP Receive statistics: 
packets=501 octets=26052 lost=0 tooLate=0 order=0 avgTime=20 maxTime=22
minTime=17 jitter=265213 maxJitter=33554431 



However, when I try to connect Computer C with Ekiga 3 as well, it fails and
openmcu gets a strange beahior: endless log messages even when all clients
are disconnected, unable to connect a single client again, unable to access
the web interface anymore. The only thing I can do is to kill the daemon.
Here is the log I get:

2011/02/23 15:23:26.932 H323 Listener:bebd6700 Info H323TCP Started
connection: host=10.1.8.76:30000, if=10.1.9.152:1720, handle=35
2011/02/23 15:23:26.996 H225 Answer:be982700 Info H225 Set remote
application name: " 3.2.7 (OPAL v3.6.8) 9/61"
2011/02/23 15:23:26.997 H225 Answer:be982700 Info H323 CreateLogicalChannel
- unknown data type
2011/02/23 15:23:26.997 H225 Answer:be982700 Info H323 CreateLogicalChannel
- unknown data type
2011/02/23 15:23:26.997 H225 Answer:be982700 Info RTP_UDP Session 1
created: 10.1.9.152:5004-5005 ssrc=529535172
2011/02/23 15:23:26.997 H225 Answer:be982700 Info RTP Adding session RTP_UDP
2011/02/23 15:23:26.998 H225 Answer:be982700 Warning H323RTP Setting dynamic
RTP payload type: 111 - error = 22
2011/02/23 15:23:26.998 H225 Answer:be982700 Warning H323RTP Setting dynamic
RTP payload type: 111 - error = 22
2011/02/23 15:23:26.999 H225 Answer:be982700 Warning H323RTP Setting dynamic
RTP payload type: 113 - error = 22
2011/02/23 15:23:26.999 H225 Answer:be982700 Warning H323RTP Setting dynamic
RTP payload type: 113 - error = 22
2011/02/23 15:23:27.001 H225 Answer:be982700 Warning H323RTP Setting dynamic
RTP payload type: 119 - error = 22
2011/02/23 15:23:27.001 H225 Answer:be982700 Warning H323RTP Setting dynamic
RTP payload type: 119 - error = 22
2011/02/23 15:23:27.001 H225 Answer:be982700 Warning H323RTP Setting dynamic
RTP payload type: 118 - error = 22
2011/02/23 15:23:27.002 H225 Answer:be982700 Warning H323RTP Setting dynamic
RTP payload type: 118 - error = 22
2011/02/23 15:23:27.003 H225 Answer:be982700 Warning H323RTP Setting dynamic
RTP payload type: 117 - error = 22
2011/02/23 15:23:27.004 H225 Answer:be982700 Warning H323RTP Setting dynamic
RTP payload type: 117 - error = 22
2011/02/23 15:23:27.005 H225 Answer:be982700 Warning H323RTP Setting dynamic
RTP payload type: 116 - error = 22
2011/02/23 15:23:27.005 H225 Answer:be982700 Warning H323RTP Setting dynamic
RTP payload type: 116 - error = 22
2011/02/23 15:23:27.006 H225 Answer:be982700 Warning H323RTP Setting dynamic
RTP payload type: 99 - error = 22
2011/02/23 15:23:27.007 H225 Answer:be982700 Warning H323RTP Setting dynamic
RTP payload type: 99 - error = 22
2011/02/23 15:23:27.007 H225 Answer:be982700 Warning H323RTP Setting dynamic
RTP payload type: 106 - error = 22
2011/02/23 15:23:27.007 H225 Answer:be982700 Warning H323RTP Setting dynamic
RTP payload type: 106 - error = 22
2011/02/23 15:23:27.008 H225 Answer:be982700 Warning H323RTP Setting dynamic
RTP payload type: 112 - error = 22
2011/02/23 15:23:27.008 H225 Answer:be982700 Warning H323RTP Setting dynamic
RTP payload type: 112 - error = 22
2011/02/23 15:23:27.009 H225 Answer:be982700 Info RTP_UDP Session 2
created: 10.1.9.152:5006-5007 ssrc=2416178601
2011/02/23 15:23:27.009 H225 Answer:be982700 Info RTP Adding session RTP_UDP
2011/02/23 15:23:27.018 H225 Answer:be982700 Info H323 Available bandwidth
exceeded
2011/02/23 15:23:27.019 H225 Answer:be982700 Info H323 OnReceivedPDU gave
error 7
2011/02/23 15:23:27.019 H225 Answer:be982700 Info RTP Releasing session 2
2011/02/23 15:23:27.020 H225 Answer:be982700 Info H323 Available bandwidth
exceeded
2011/02/23 15:23:27.020 H225 Answer:be982700 Info H323 OnReceivedPDU gave
error 7
2011/02/23 15:23:27.020 H225 Answer:be982700 Info RTP Releasing session 2
2011/02/23 15:23:27.021 H225 Answer:be982700 Info H323 Answering call: 
AnswerCallNow
2011/02/23 15:23:27.021 H225 Answer:be982700 Info H245 Default
OnSelectLogicalChannels, FastStartResponse
2011/02/23 15:23:27.021 H225 Answer:be982700 Info H323 Started sending
logical channel: SpeexIETFWide-20.6k{sw} <20>
2011/02/23 15:23:27.021 H225 Answer:be982700 Info H323 Started receiving
logical channel: SpeexIETFWide-20.6k{sw} <20>
2011/02/23 15:23:27.021 LogChanTx:be941700 Info H323RTP Transmit
SpeexIETFWide-20.6k thread started: rate=320 time=20ms size=1*52=52
2011/02/23 15:23:27.021 H225 Answer:be982700 Info H323 Started sending
logical channel: H.261-CIF{sw} <26>
2011/02/23 15:23:27.022 LogChanRx:be900700 Info H323RTP Receive
SpeexIETFWide-20.6k thread started.
2011/02/23 15:23:27.022 LogChanRx:be900700 Info RTP Jitter buffer
created: size=101 delay=800-4000/800 (100ms) obj=0xc34310
2011/02/23 15:23:27.023 LogChanTx:be8bf700 Info H323RTP Transmit H.261-CIF
thread started: rate=29 time=0ms size=1*2000=2000
2011/02/23 15:23:28.332 RTP Jitter:bea04700 Info RTP Receive statistics: 
packets=2701 octets=140452 lost=0 tooLate=0 order=0 avgTime=20
maxTime=22 minTime=17 jitter=3 maxJitter=33554431
2011/02/23 15:23:28.812 RTP Jitter:bea04700 Info RTP Jitter buffer full,
throwing away oldest frame (839680)
2011/02/23 15:23:29.212 RTP Jitter:bea04700 Info RTP Jitter buffer
continuously full, throwing away entire buffer.
2011/02/23 15:23:29.232 RTP Jitter:bea04700 Info RTP Jitter buffer full,
threw away 21 oldest frames
2011/02/23 15:23:30.331 RTP Jitter:bea04700 Info RTP Receive statistics: 
packets=2801 octets=145652 lost=0 tooLate=0 order=0 avgTime=19
maxTime=21 minTime=19 jitter=0 maxJitter=33554431
2011/02/23 15:23:31.231 RTP Jitter:bea04700 Info RTP Jitter buffer full,
throwing away oldest frame (878400)
2011/02/23 15:23:31.630 RTP Jitter:bea04700 Info RTP Jitter buffer
continuously full, throwing away entire buffer.


Note that I get the same behavior using other clients, like VidPhone for
Windows or a Sony conferencing hardware. In addition, Computers A, B and C
are on the same LAN.


Do you have any ideas how I can get openmcu working?


Cheers,

Jeremy Subtil
Systems Engineer at Smile
http://www.smile.fr/en/





More information about the h323plus mailing list