[h323plus] Unable to connect more than one client

23 Feb 2011


      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/

[h323plus] Unable to connect more than one client

Jérémy Subtil