GNOME.org
 

[GnomeMeeting-devel-list] GSM codec problem with Snapshot 2.0.1-20060521-01

Resent as it didn't pass at the first try (too big, I cut the begining of logs) 

Hi all,
Ekiga behind a firewall is registering to an asterisk server which is on internet. The sip user is authorized with gsm,ulaw,alaw on asterisk side.
When I place a call with GSM, PCMU and PCMA activated in Ekiga, call is started, connection is showed with PCMU (why not GSM?), see the traffic in/out (~6 kB) but have no audio.
I hangup the call, the hangup info is shown in the toolbar, PCMU disappear in codec and immediately after, traffic in/out continue with 0/0, icon in KDE Toolbar show Ekiga on line. The only solution I have is to kill Ekiga.
If I deactivate GSM codec, everything is fine. Below you will find a d4 output from the call. 


[...]
2006/06/02 13:12:32.899 0:10.659 SIP Transport:84fdac8 OpalUDP Ended connect, selecting 82.231.69.24:35065 2006/06/02 13:12:32.899 0:10.659 SIP Transport:84fdac8 SIP Queueing PDU: 1 INVITE <407> 2006/06/02 13:12:32.899 0:10.659 SIP Transport:84fdac8 SIP Waiting for PDU on udp$213.203.241.243:5060<if=udp$82.231.69.24:35065> 2006/06/02 13:12:32.901 0:10.661 SIP Handler:8520268 SIP PDU handler thread started. 2006/06/02 13:12:32.902 0:10.662 SIP Handler:8520268 SIP Awaiting next PDU. 2006/06/02 13:12:32.902 0:10.663 SIP Handler:8520268 SIP Handling PDU 1 INVITE <407> (with transaction) 2006/06/02 13:12:32.903 0:10.663 SIP Handler:8520268 SIP Transaction 1 INVITE completed. 2006/06/02 13:12:32.905 0:10.665 SIP Handler:8520268 SIP Sending PDU on udp$213.203.241.243:5060<if=udp$82.231.69.24:35065> 
ACK sip:800 sip tootai net SIP/2.0
CSeq: 1 ACK
Via: SIP/2.0/UDP 82.231.69.24:35065;branch=z9hG4bK803b125b-96f0-da11-8388-000ea6217592;rport From: "Huhardeaux Daniel" <sip:104 sip tootai net>;tag=8c53075b-96f0-da11-8388-000ea6217592 
Call-ID: fa44075b-96f0-da11-8388-000ea6217592 nomade
To: <sip:800 sip tootai net>;tag=as315809c6
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,NOTIFY,REFER,MESSAGE
Content-Length: 0
Max-Forwards: 70
2006/06/02 13:12:32.905 0:10.665 SIP Handler:8520268 SIP Received Proxy Authentication Required response 2006/06/02 13:12:32.906 0:10.666 SIP Handler:8520268 SIP Transaction 2 INVITE created. 2006/06/02 13:12:32.906 0:10.667 SIP Handler:8520268 Call CanDoMediaBypass Call[1]-EP<sip>[fa44075b-96f0-da11-8388-000ea6217592 nomade] session 1 2006/06/02 13:12:32.907 0:10.667 SIP Handler:8520268 OpalMan IsMediaBypassPossible: session 1 2006/06/02 13:12:32.907 0:10.667 SIP Handler:8520268 SIP IsMediaBypassPossible: session 1 2006/06/02 13:12:32.907 0:10.667 SIP Handler:8520268 OpalCon IsMediaBypassPossible: default returns FALSE 2006/06/02 13:12:33.090 0:10.850 SIP Handler:8520268 RTP_UDP Session 1 created: 82.231.69.24:35010-35011 ssrc=703395120 2006/06/02 13:12:33.091 0:10.851 SIP Handler:8520268 RTP Adding session RTP_UDP 2006/06/02 13:12:33.091 0:10.851 SIP Handler:8520268 SIP Using RTP payload [pt=101] for NTE 2006/06/02 13:12:33.100 0:10.860 SIP Handler:8520268 Call GetMediaFormats for Call[1]-EP<sip>[fa44075b-96f0-da11-8388-000ea6217592 nomade] 
GSM-06.10
G.711-uLaw-64k
G.711-ALaw-64k
H.261(QCIF)
H.261(CIF)
YUV420P
RGB32
RGB24
2006/06/02 13:12:33.101 0:10.861 SIP Handler:8520268 Call CanDoMediaBypass Call[1]-EP<sip>[fa44075b-96f0-da11-8388-000ea6217592 nomade] session 2 2006/06/02 13:12:33.101 0:10.861 SIP Handler:8520268 OpalMan IsMediaBypassPossible: session 2 2006/06/02 13:12:33.101 0:10.861 SIP Handler:8520268 SIP IsMediaBypassPossible: session 2 2006/06/02 13:12:33.101 0:10.861 SIP Handler:8520268 OpalCon IsMediaBypassPossible: default returns FALSE 2006/06/02 13:12:33.281 0:11.041 SIP Handler:8520268 RTP_UDP Session 2 created: 82.231.69.24:35014-35015 ssrc=2454563097 2006/06/02 13:12:33.282 0:11.042 SIP Handler:8520268 RTP Adding session RTP_UDP 2006/06/02 13:12:33.290 0:11.050 SIP Handler:8520268 Call GetMediaFormats for Call[1]-EP<sip>[fa44075b-96f0-da11-8388-000ea6217592 nomade] 
GSM-06.10
G.711-uLaw-64k
G.711-ALaw-64k
H.261(QCIF)
H.261(CIF)
YUV420P
RGB32
RGB24
2006/06/02 13:12:33.290 0:11.050 SIP Handler:8520268 SIP Adding authentication information 2006/06/02 13:12:33.291 0:11.051 SIP Handler:8520268 SIP Sending PDU on udp$213.203.241.243:5060<if=udp$82.231.69.24:35065> 
INVITE sip:800 sip tootai net SIP/2.0
Date: Fri, 02 Jun 2006 11:12:32 GMT
CSeq: 2 INVITE
Via: SIP/2.0/UDP 82.231.69.24:35065;branch=z9hG4bKbe6c575b-96f0-da11-8388-000ea6217592;rport 
User-Agent: Ekiga/2.0.1-20060521-01
From: "Huhardeaux Daniel" <sip:104 sip tootai net>;tag=8c53075b-96f0-da11-8388-000ea6217592 
Call-ID: fa44075b-96f0-da11-8388-000ea6217592 nomade
To: <sip:800 sip tootai net>
Contact: <sip:104 82 231 69 24:35065;transport=udp>
Proxy-Authorization: Digest username="104", realm="sip.tootai.net", nonce="12d01d5d", uri="sip:800 sip tootai net", response="60b65ec9045130eab45495d3c65fbc5e", algorithm=md5 
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,NOTIFY,REFER,MESSAGE
Content-Type: application/sdp
Content-Length: 302
Max-Forwards: 70

v=0
o=- 1149246753 1149246753 IN IP4 82.231.69.24
s=Opal SIP Session
c=IN IP4 82.231.69.24
t=0 0
m=audio 35010 RTP/AVP 101 3 0 8
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=rtpmap:3 GSM/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
m=video 35014 RTP/AVP 31
a=rtpmap:31 H261/90000
2006/06/02 13:12:33.291 0:11.051 SIP Handler:8520268 SIP Awaiting next PDU. 2006/06/02 13:12:33.356 0:11.116 SIP Transport:84fdac8 SIP PDU Received on udp$213.203.241.243:5060<if=udp$82.231.69.24:35065> 
SIP/2.0 100 Trying
CSeq: 2 INVITE
Via: SIP/2.0/UDP 82.231.69.24:35065;branch=z9hG4bKbe6c575b-96f0-da11-8388-000ea6217592;received=82.231.69.24;rport=35065 
User-Agent: Asterisk PBX
From: "Huhardeaux Daniel" <sip:104 sip tootai net>;tag=8c53075b-96f0-da11-8388-000ea6217592 
Call-ID: fa44075b-96f0-da11-8388-000ea6217592 nomade
To: <sip:800 sip tootai net>
Contact: <sip:800 213 203 241 243>
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0
2006/06/02 13:12:33.356 0:11.116 SIP Transport:84fdac8 SIP Queueing PDU: 2 INVITE <100> 2006/06/02 13:12:33.356 0:11.116 SIP Transport:84fdac8 SIP Waiting for PDU on udp$213.203.241.243:5060<if=udp$82.231.69.24:35065> 2006/06/02 13:12:33.358 0:11.118 SIP Handler:8520268 SIP Handling PDU 2 INVITE <100> (with transaction) 2006/06/02 13:12:33.358 0:11.118 SIP Handler:8520268 SIP Transaction 2 INVITE proceeding. 2006/06/02 13:12:33.359 0:11.119 SIP Handler:8520268 SIP Set targetAddress to sip:800 213 203 241 243 2006/06/02 13:12:33.359 0:11.119 SIP Handler:8520268 SIP Received Trying response 2006/06/02 13:12:33.359 0:11.119 SIP Handler:8520268 SIP Awaiting next PDU. 2006/06/02 13:12:33.387 0:11.147 SIP Transport:84fdac8 SDP Media session port=7166 2006/06/02 13:12:33.387 0:11.147 SIP Transport:84fdac8 SDP Adding media session with 2 formats 2006/06/02 13:12:33.387 0:11.147 SIP Transport:84fdac8 SDP Unknown media attribute silenceSupp:off - - - - 2006/06/02 13:12:33.387 0:11.147 SIP Transport:84fdac8 SIP PDU Received on udp$213.203.241.243:5060<if=udp$82.231.69.24:35065> 
SIP/2.0 200 OK
CSeq: 2 INVITE
Via: SIP/2.0/UDP 82.231.69.24:35065;branch=z9hG4bKbe6c575b-96f0-da11-8388-000ea6217592;received=82.231.69.24;rport=35065 
User-Agent: Asterisk PBX
From: "Huhardeaux Daniel" <sip:104 sip tootai net>;tag=8c53075b-96f0-da11-8388-000ea6217592 
Call-ID: fa44075b-96f0-da11-8388-000ea6217592 nomade
To: <sip:800 sip tootai net>;tag=as5d2831d1
Contact: <sip:800 213 203 241 243>
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Type: application/sdp
Content-Length: 221

v=0
o=root 26912 26912 IN IP4 213.203.241.243
s=session
c=IN IP4 213.203.241.243
t=0 0
m=audio 7166 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
2006/06/02 13:12:33.388 0:11.148 SIP Transport:84fdac8 SIP Queueing PDU: 2 INVITE <200> 2006/06/02 13:12:33.388 0:11.148 SIP Transport:84fdac8 SIP Waiting for PDU on udp$213.203.241.243:5060<if=udp$82.231.69.24:35065> 2006/06/02 13:12:33.388 0:11.148 SIP Handler:8520268 SIP Handling PDU 2 INVITE <200> (with transaction) 2006/06/02 13:12:33.389 0:11.149 SIP Handler:8520268 SIP Transaction 2 INVITE completed. 2006/06/02 13:12:33.389 0:11.149 SIP Handler:8520268 SIP Set targetAddress to sip:800 213 203 241 243 2006/06/02 13:12:33.390 0:11.150 SIP Handler:8520268 SIP Adding authentication information 2006/06/02 13:12:33.395 0:11.155 SIP Handler:8520268 SIP Adjusting transport to address udp$213.203.241.243:5060 2006/06/02 13:12:33.395 0:11.155 SIP Handler:8520268 SIP Sending PDU on udp$213.203.241.243:5060<if=udp$82.231.69.24:35065> 
ACK sip:800 213 203 241 243 SIP/2.0
CSeq: 2 ACK
Via: SIP/2.0/UDP 82.231.69.24:35065;branch=z9hG4bK6e2ca15b-96f0-da11-8388-000ea6217592;rport From: "Huhardeaux Daniel" <sip:104 sip tootai net>;tag=8c53075b-96f0-da11-8388-000ea6217592 
Call-ID: fa44075b-96f0-da11-8388-000ea6217592 nomade
To: <sip:800 sip tootai net>;tag=as5d2831d1
Contact: <sip:104 82 231 69 24:35065;transport=udp>
Proxy-Authorization: Digest username="104", realm="sip.tootai.net", nonce="12d01d5d", uri="sip:800 213 203 241 243", response="059defd67706254552a5c23eada565b5", algorithm=md5 
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,NOTIFY,REFER,MESSAGE
Content-Length: 0
Max-Forwards: 70
2006/06/02 13:12:33.396 0:11.156 SIP Handler:8520268 SIP Received INVITE OK response 2006/06/02 13:12:33.396 0:11.156 SIP Handler:8520268 Call CanDoMediaBypass Call[1]-EP<sip>[fa44075b-96f0-da11-8388-000ea6217592 nomade] session 1 2006/06/02 13:12:33.396 0:11.156 SIP Handler:8520268 OpalMan IsMediaBypassPossible: session 1 2006/06/02 13:12:33.396 0:11.156 SIP Handler:8520268 SIP IsMediaBypassPossible: session 1 2006/06/02 13:12:33.396 0:11.156 SIP Handler:8520268 OpalCon IsMediaBypassPossible: default returns FALSE 2006/06/02 13:12:33.396 0:11.156 SIP Handler:8520268 RTP Found existing session 1 2006/06/02 13:12:33.397 0:11.157 SIP Handler:8520268 SIP RTP payload type PCMU matched to codec G.711-uLaw-64k 2006/06/02 13:12:33.397 0:11.157 SIP Handler:8520268 Call OpenSourceMediaStreams for session 1 with media G.711-uLaw-64k 2006/06/02 13:12:33.397 0:11.157 SIP Handler:8520268 OpalCon OpenSourceMediaStream for session 1 on Call[1]-EP<pc>[Default] 2006/06/02 13:12:33.398 0:11.158 SIP Handler:8520268 OpalCon Selected media stream PCM-16 -> G.711-uLaw-64k 2006/06/02 13:12:34.196 0:11.956 SIP Handler:8520268 OpalMan OnOpenMediaStream Call[1]-EP<pc>[Default],OpalAudioMediaStream-Source-PCM-16 2006/06/02 13:12:34.196 0:11.956 SIP Handler:8520268 Call PatchMediaStreams Call[1]-EP<pc>[Default] 2006/06/02 13:12:34.196 0:11.957 SIP Handler:8520268 OpalCon OpenSinkMediaStream Call[1]-EP<sip>[fa44075b-96f0-da11-8388-000ea6217592 nomade] session=1 2006/06/02 13:12:34.197 0:11.957 SIP Handler:8520268 OpalCon OpenSinkMediaStream, selected PCM-16 -> G.711-uLaw-64k 2006/06/02 13:12:34.197 0:11.957 SIP Handler:8520268 Call CanDoMediaBypass Call[1]-EP<sip>[fa44075b-96f0-da11-8388-000ea6217592 nomade] session 1 2006/06/02 13:12:34.197 0:11.957 SIP Handler:8520268 OpalMan IsMediaBypassPossible: session 1 2006/06/02 13:12:34.197 0:11.957 SIP Handler:8520268 SIP IsMediaBypassPossible: session 1 2006/06/02 13:12:34.197 0:11.957 SIP Handler:8520268 OpalCon IsMediaBypassPossible: default returns FALSE 2006/06/02 13:12:34.197 0:11.958 SIP Handler:8520268 RTP Found existing session 1 2006/06/02 13:12:34.198 0:11.958 SIP Handler:8520268 RTP Found existing session 1 2006/06/02 13:12:34.198 0:11.958 SIP Handler:8520268 OpalMan OnOpenMediaStream Call[1]-EP<sip>[fa44075b-96f0-da11-8388-000ea6217592 nomade],OpalRTPMediaStream-Sink-G.711-uLaw-64k 2006/06/02 13:12:34.203 0:11.963 SIP Handler:8520268 Patch Added sink 
  from PCM-16
         Clock Rate = 8000
         Frame Time = 8
         Max Bit Rate = 64000
         Max Frame Size = 16
         Needs Jitter = 1
         Rx Frames Per Packet = 240
         Tx Frames Per Packet = 30
    to G.711-uLaw-64k
         Clock Rate = 8000
         Frame Time = 8
         Max Bit Rate = 64000
         Max Frame Size = 8
         Needs Jitter = 1
         Rx Frames Per Packet = 240
         Tx Frames Per Packet = 30
2006/06/02 13:12:34.203 0:11.963 SIP Handler:8520268 Codec G711-uLaw-64k encoder created 2006/06/02 13:12:34.204 0:11.964 SIP Handler:8520268 Patch Added media stream sink OpalRTPMediaStream-Sink-G.711-uLaw-64k using transcoder PCM-16->G.711-uLaw-64k 2006/06/02 13:12:34.204 0:11.964 SIP Handler:8520268 Media Audio source data size set to 320 bytes and 2 buffers. 2006/06/02 13:12:34.204 0:11.964 SIP Handler:8520268 OpalCon New patch created 2006/06/02 13:12:34.204 0:11.964 SIP Handler:8520268 OpalCon New patch created 2006/06/02 13:12:34.204 0:11.964 SIP Handler:8520268 Call OpenSourceMediaStreams for session 1 adjusted media to G.711-uLaw-64k 2006/06/02 13:12:34.204 0:11.964 SIP Handler:8520268 Call GetOtherPartyConnection Call[1]-EP<sip>[fa44075b-96f0-da11-8388-000ea6217592 nomade] 2006/06/02 13:12:34.205 0:11.965 SIP Handler:8520268 OpalCon OpenSourceMediaStream for session 1 on Call[1]-EP<sip>[fa44075b-96f0-da11-8388-000ea6217592 nomade] 2006/06/02 13:12:34.205 0:11.965 SIP Handler:8520268 OpalCon Selected media stream G.711-uLaw-64k -> PCM-16 2006/06/02 13:12:34.205 0:11.965 SIP Handler:8520268 Call CanDoMediaBypass Call[1]-EP<sip>[fa44075b-96f0-da11-8388-000ea6217592 nomade] session 1 2006/06/02 13:12:34.205 0:11.965 SIP Handler:8520268 OpalMan IsMediaBypassPossible: session 1 2006/06/02 13:12:34.205 0:11.965 SIP Handler:8520268 SIP IsMediaBypassPossible: session 1 2006/06/02 13:12:34.205 0:11.965 SIP Handler:8520268 OpalCon IsMediaBypassPossible: default returns FALSE 2006/06/02 13:12:34.205 0:11.965 SIP Handler:8520268 RTP Found existing session 1 2006/06/02 13:12:34.205 0:11.965 SIP Handler:8520268 RTP Found existing session 1 2006/06/02 13:12:34.206 0:11.966 SIP Handler:8520268 OpalMan OnOpenMediaStream Call[1]-EP<sip>[fa44075b-96f0-da11-8388-000ea6217592 nomade],OpalRTPMediaStream-Source-G.711-uLaw-64k 2006/06/02 13:12:34.206 0:11.966 SIP Handler:8520268 Call PatchMediaStreams Call[1]-EP<sip>[fa44075b-96f0-da11-8388-000ea6217592 nomade] 2006/06/02 13:12:34.206 0:11.966 SIP Handler:8520268 OpalCon OpenSinkMediaStream Call[1]-EP<pc>[Default] session=1 2006/06/02 13:12:34.206 0:11.966 SIP Handler:8520268 OpalCon OpenSinkMediaStream, selected G.711-uLaw-64k -> PCM-16 2006/06/02 13:12:34.513 0:12.274 SIP Handler:8520268 OpalMan OnOpenMediaStream Call[1]-EP<pc>[Default],OpalAudioMediaStream-Sink-PCM-16 2006/06/02 13:12:34.514 0:12.274 SIP Handler:8520268 Patch Added sink 
  from G.711-uLaw-64k
         Clock Rate = 8000
         Frame Time = 8
         Max Bit Rate = 64000
         Max Frame Size = 8
         Needs Jitter = 1
         Rx Frames Per Packet = 240
         Tx Frames Per Packet = 30
    to PCM-16
         Clock Rate = 8000
         Frame Time = 8
         Max Bit Rate = 64000
         Max Frame Size = 16
         Needs Jitter = 1
         Rx Frames Per Packet = 240
         Tx Frames Per Packet = 30
2006/06/02 13:12:34.515 0:12.275 SIP Handler:8520268 Codec G711-uLaw-64k decoder created 2006/06/02 13:12:34.515 0:12.275 SIP Handler:8520268 Media Audio sink data size set to 320 bytes and 2 buffers. 2006/06/02 13:12:34.515 0:12.275 SIP Handler:8520268 Patch Added media stream sink OpalAudioMediaStream-Sink-PCM-16 using transcoder G.711-uLaw-64k->PCM-16 2006/06/02 13:12:34.515 0:12.275 SIP Handler:8520268 OpalCon New patch created 2006/06/02 13:12:34.515 0:12.275 SIP Handler:8520268 OpalCon New patch created 2006/06/02 13:12:34.525 0:12.285 SIP Handler:8520268 OpalCon OpenSourceMediaStream (already opened) for session 1 on Call[1]-EP<sip>[fa44075b-96f0-da11-8388-000ea6217592 nomade] 2006/06/02 13:12:34.527 0:12.287 SIP Handler:8520268 RTP_UDP SetRemoteSocketInfo: session=1 data channel, new=213.203.241.243:7166, local=82.231.69.24:35010-35011, remote=0.0.0.0:0-0 2006/06/02 13:12:34.528 0:12.288 SIP Handler:8520268 SIP Could not find SDP media description for Video 2006/06/02 13:12:34.528 0:12.288 SIP Handler:8520268 OpalMan OnConnected Call[1]-EP<sip>[fa44075b-96f0-da11-8388-000ea6217592 nomade] 2006/06/02 13:12:34.528 0:12.288 SIP Handler:8520268 Call OnConnected Call[1]-EP<sip>[fa44075b-96f0-da11-8388-000ea6217592 nomade] 2006/06/02 13:12:34.528 0:12.288 SIP Handler:8520268 PCSS SetConnected() 2006/06/02 13:12:34.529 0:12.289 SIP Handler:8520268 GMPCSSEndpoint PCSS connection established 2006/06/02 13:12:34.529 0:12.289 SIP Handler:8520268 GMManager Will establish the connection 2006/06/02 13:12:34.529 0:12.289 SIP Handler:8520268 OpalMan OnEstablished Call[1]-EP<pc>[Default] 2006/06/02 13:12:34.529 0:12.289 SIP Handler:8520268 Call OnEstablished Call[1]-EP<pc>[Default] 2006/06/02 13:12:34.540 0:12.300 SIP Handler:8520268 Call GetMediaFormats for Call[1]-EP<pc>[Default] 
G.711-uLaw-64k
2006/06/02 13:12:34.541 0:12.301 SIP Handler:8520268 Call OpenSourceMediaStreams for session 1 with media G.711-uLaw-64k 2006/06/02 13:12:34.542 0:12.302 SIP Handler:8520268 OpalCon OpenSourceMediaStream (already opened) for session 1 on Call[1]-EP<sip>[fa44075b-96f0-da11-8388-000ea6217592 nomade] 2006/06/02 13:12:34.543 0:12.303 SIP Handler:8520268 Call OpenSourceMediaStreams for session 2 with media G.711-uLaw-64k 2006/06/02 13:12:34.551 0:12.311 SIP Handler:8520268 Call GetMediaFormats for Call[1]-EP<sip>[fa44075b-96f0-da11-8388-000ea6217592 nomade] 
G.711-uLaw-64k
2006/06/02 13:12:34.551 0:12.311 SIP Handler:8520268 Call OpenSourceMediaStreams for session 1 with media G.711-uLaw-64k 2006/06/02 13:12:34.551 0:12.311 SIP Handler:8520268 OpalCon OpenSourceMediaStream (already opened) for session 1 on Call[1]-EP<pc>[Default] 2006/06/02 13:12:34.551 0:12.311 SIP Handler:8520268 Call OpenSourceMediaStreams for session 1 adjusted media to G.711-uLaw-64k 2006/06/02 13:12:34.552 0:12.312 SIP Handler:8520268 Call OpenSourceMediaStreams for session 2 with media G.711-uLaw-64k 2006/06/02 13:12:34.553 0:12.313 Media Patch:8175708 Patch Thread started for Patch OpalAudioMediaStream-Source-PCM-16 -> OpalRTPMediaStream-Sink-G.711-uLaw-64k 2006/06/02 13:12:34.556 0:12.316 SIP Handler:8520268 Media Starting thread Media Patch:8175708 2006/06/02 13:12:34.557 0:12.317 Media Patch:8527348 Patch Thread started for Patch OpalRTPMediaStream-Source-G.711-uLaw-64k -> OpalAudioMediaStream-Sink-PCM-16 2006/06/02 13:12:34.568 0:12.329 Media Patch:8527348 RTP Jitter buffer created: size=101 delay=160-4000/160 (20ms) obj=0x8526b30 2006/06/02 13:12:34.572 0:12.333 RTP Jitter:8526b30 RTP Jitter RTP receive thread started: 0x8526b30 2006/06/02 13:12:34.574 0:12.334 RTP Jitter:8526b30 RTP First receive data: ver=2 pt=GSM psz=33 m=0 x=0 seq=39915 ts=160 src=824302623 ccnt=0 2006/06/02 13:12:34.580 0:12.341 SIP Handler:8520268 Media Starting thread Media Patch:8527348 2006/06/02 13:12:34.581 0:12.341 SIP Handler:8520268 OpalCon Media stream threads started. 2006/06/02 13:12:34.582 0:12.342 SIP Handler:8520268 OpalCon Media stream threads started. 2006/06/02 13:12:34.606 0:12.366 SIP Handler:8520268 RTP Found existing session 1 2006/06/02 13:12:34.606 0:12.366 SIP Handler:8520268 RTP Found existing session 2 2006/06/02 13:12:34.606 0:12.366 SIP Handler:8520268 GMManager Will establish the connection 2006/06/02 13:12:34.606 0:12.366 SIP Handler:8520268 OpalMan OnEstablished Call[1]-EP<sip>[fa44075b-96f0-da11-8388-000ea6217592 nomade] 2006/06/02 13:12:34.607 0:12.367 SIP Handler:8520268 Call OnEstablished Call[1]-EP<sip>[fa44075b-96f0-da11-8388-000ea6217592 nomade] 2006/06/02 13:12:34.610 0:12.371 SIP Handler:8520268 SIP Awaiting next PDU. 2006/06/02 13:12:34.648 0:12.408 Media Patch:8527348 RTP Jitter buffer length exceeded 2006/06/02 13:12:34.649 0:12.409 Media Patch:8527348 RTP Jitter buffer length exceed was prior to first write. Not increasing buffer size 2006/06/02 13:12:35.277 0:13.037 Media Patch:8175708 RTP First sent data: ver=2 pt=PCMU psz=160 m=1 x=0 seq=1460 ts=0 src=703395120 ccnt=0 2006/06/02 13:12:35.608 0:13.368 Housekeeper RTP Found existing session 1 2006/06/02 13:12:35.609 0:13.369 Housekeeper RTP Found existing session 2 2006/06/02 13:12:36.137 0:13.898 RTP Jitter:8526b30 RTP Receive statistics: packets=101 octets=3714 lost=0 tooLate=0 order=0 avgTime=15 maxTime=1556 minTime=0 jitter=16 maxJitter=188 2006/06/02 13:12:36.573 0:14.333 RTP Jitter:8526b30 RTP Jitter buffer full, throwing away oldest frame (9760) 2006/06/02 13:12:36.614 0:14.374 Housekeeper RTP Found existing session 1 2006/06/02 13:12:36.615 0:14.375 Housekeeper RTP Found existing session 2 2006/06/02 13:12:36.974 0:14.734 RTP Jitter:8526b30 RTP Jitter buffer continuously full, throwing away entire buffer. 2006/06/02 13:12:36.995 0:14.756 RTP Jitter:8526b30 RTP Jitter buffer full, threw away 21 oldest frames 2006/06/02 13:12:37.374 0:15.134 RTP Jitter:8526b30 RTP Receive statistics: packets=201 octets=19714 lost=0 tooLate=0 order=0 avgTime=12 maxTime=23 minTime=0 jitter=0 maxJitter=188 2006/06/02 13:12:37.620 0:15.380 Housekeeper RTP Found existing session 1 2006/06/02 13:12:37.621 0:15.381 Housekeeper RTP Found existing session 2 2006/06/02 13:12:37.820 0:15.580 Media Patch:8175708 RTP Transmit statistics: packets=101 octets=16160 avgTime=25 maxTime=48 minTime=23 2006/06/02 13:12:38.624 0:16.384 Housekeeper RTP Found existing session 1 2006/06/02 13:12:38.625 0:16.385 Housekeeper RTP Found existing session 2 2006/06/02 13:12:38.993 0:16.753 RTP Jitter:8526b30 RTP Jitter buffer full, throwing away oldest frame (29120) 2006/06/02 13:12:39.374 0:17.134 RTP Jitter:8526b30 RTP Receive statistics: packets=301 octets=35714 lost=0 tooLate=0 order=0 avgTime=20 maxTime=26 minTime=14 jitter=1 maxJitter=188 2006/06/02 13:12:39.395 0:17.155 RTP Jitter:8526b30 RTP Jitter buffer continuously full, throwing away entire buffer. 2006/06/02 13:12:39.415 0:17.176 RTP Jitter:8526b30 RTP Jitter buffer full, threw away 21 oldest frames 2006/06/02 13:12:39.632 0:17.392 Housekeeper RTP Found existing session 1 2006/06/02 13:12:39.633 0:17.393 Housekeeper RTP Found existing session 2 2006/06/02 13:12:40.384 0:18.144 Media Patch:8175708 RTP Transmit statistics: packets=201 octets=32160 avgTime=25 maxTime=44 minTime=22 2006/06/02 13:12:40.640 0:18.400 Housekeeper RTP Found existing session 1 2006/06/02 13:12:40.641 0:18.401 Housekeeper RTP Found existing session 2 2006/06/02 13:12:41.373 0:19.133 RTP Jitter:8526b30 RTP Receive statistics: packets=401 octets=51714 lost=0 tooLate=0 order=0 avgTime=19 maxTime=26 minTime=13 jitter=1 maxJitter=188 2006/06/02 13:12:41.413 0:19.173 RTP Jitter:8526b30 RTP Jitter buffer full, throwing away oldest frame (48480) 2006/06/02 13:12:41.648 0:19.424 Housekeeper RTP Found existing session 1 2006/06/02 13:12:41.665 0:19.425 Housekeeper RTP Found existing session 2 2006/06/02 13:12:41.813 0:19.573 RTP Jitter:8526b30 RTP Jitter buffer continuously full, throwing away entire buffer. 2006/06/02 13:12:41.833 0:19.593 RTP Jitter:8526b30 RTP Jitter buffer full, threw away 21 oldest frames 2006/06/02 13:12:42.672 0:20.432 Housekeeper RTP Found existing session 1 2006/06/02 13:12:42.672 0:20.432 Housekeeper RTP Found existing session 2 2006/06/02 13:12:42.920 0:20.680 Media Patch:8175708 RTP Transmit statistics: packets=301 octets=48160 avgTime=25 maxTime=49 minTime=22 2006/06/02 13:12:43.378 0:21.139 RTP Jitter:8526b30 RTP Receive statistics: packets=501 octets=67714 lost=0 tooLate=0 order=0 avgTime=20 maxTime=27 minTime=12 jitter=1 maxJitter=188 2006/06/02 13:12:43.696 0:21.457 Housekeeper RTP Found existing session 1 2006/06/02 13:12:43.697 0:21.457 Housekeeper RTP Found existing session 2 2006/06/02 13:12:43.812 0:21.572 ekiga-snapshot Call Clearing Call[1] reason=EndedByLocalUser 2006/06/02 13:12:43.812 0:21.572 ekiga-snapshot OpalCon Releasing Call[1]-EP<pc>[Default] 2006/06/02 13:12:43.813 0:21.573 ekiga-snapshot OpalCon Call end reason for Default set to EndedByLocalUser 2006/06/02 13:12:43.813 0:21.573 ekiga-snapshot OpalCon SetPhase from EstablishedPhase to ReleasingPhase 2006/06/02 13:12:43.813 0:21.573 ekiga-snapshot OpalCon Releasing Call[1]-EP<sip>[fa44075b-96f0-da11-8388-000ea6217592 nomade] 2006/06/02 13:12:43.813 0:21.573 ekiga-snapshot OpalCon Call end reason for fa44075b-96f0-da11-8388-000ea6217592 nomade set to EndedByLocalUser 2006/06/02 13:12:43.813 0:21.573 ekiga-snapshot OpalCon SetPhase from EstablishedPhase to ReleasingPhase 2006/06/02 13:12:43.820 0:21.581 OnRelease:856e8a0 OpalCon OnReleased Call[1]-EP<pc>[Default] 2006/06/02 13:12:43.822 0:21.583 OnRelease:856e8a0 Media Closing raw media stream OpalAudioMediaStream-Source-PCM-16 2006/06/02 13:12:43.824 0:21.584 OnRelease:856e8a0 Media Closing stream OpalAudioMediaStream-Source-PCM-16 2006/06/02 13:12:43.825 0:21.585 OnRelease:856e8a0 Media Disconnecting OpalAudioMediaStream-Source-PCM-16 from patch thread Patch OpalAudioMediaStream-Source-PCM-16 -> OpalRTPMediaStream-Sink-G.711-uLaw-64k 2006/06/02 13:12:43.827 0:21.587 OnRelease:856e8a0 Patch Closing media patch Patch OpalAudioMediaStream-Source-PCM-16 -> OpalRTPMediaStream-Sink-G.711-uLaw-64k 2006/06/02 13:12:43.829 0:21.589 OnRelease:856e8a0 Media Closing raw media stream OpalAudioMediaStream-Source-PCM-16 2006/06/02 13:12:43.830 0:21.590 OnRelease:856e8a0 Media Closing stream OpalAudioMediaStream-Source-PCM-16 2006/06/02 13:12:43.831 0:21.591 OnRelease:84f8c00 SIP OnReleased: Call[1]-EP<sip>[fa44075b-96f0-da11-8388-000ea6217592 nomade], phase = ReleasingPhase 2006/06/02 13:12:43.833 0:21.593 OnRelease:84f8c00 OpalCon SetPhase from ReleasingPhase to ReleasingPhase 2006/06/02 13:12:43.834 0:21.594 RTP Jitter:8526b30 RTP Jitter buffer full, throwing away oldest frame (67840) 2006/06/02 13:12:43.836 0:21.596 OnRelease:84f8c00 SIP Transaction 4 BYE created. 2006/06/02 13:12:43.842 0:21.603 OnRelease:84f8c00 Media Closing RTP for OpalRTPMediaStream-Sink-G.711-uLaw-64k 2006/06/02 13:12:43.844 0:21.604 OnRelease:84f8c00 RTP_UDP Session 1, Shutting down write. 2006/06/02 13:12:43.845 0:21.605 OnRelease:84f8c00 Media Closing stream OpalRTPMediaStream-Sink-G.711-uLaw-64k 2006/06/02 13:12:43.846 0:21.606 OnRelease:84f8c00 Media Disconnecting OpalRTPMediaStream-Sink-G.711-uLaw-64k from patch thread Patch OpalAudioMediaStream-Source-PCM-16 -> OpalRTPMediaStream-Sink-G.711-uLaw-64k 2006/06/02 13:12:43.848 0:21.609 OnRelease:84f8c00 Patch Removing media stream sink OpalRTPMediaStream-Sink-G.711-uLaw-64k 2006/06/02 13:12:43.855 0:21.626 OnRelease:84f8c00 Media Closing RTP for OpalRTPMediaStream-Source-G.711-uLaw-64k 2006/06/02 13:12:43.867 0:21.627 OnRelease:84f8c00 RTP_UDP Session 1, Shutting down read. 2006/06/02 13:12:43.868 0:21.628 OnRelease:84f8c00 Media Closing stream OpalRTPMediaStream-Source-G.711-uLaw-64k 2006/06/02 13:12:43.869 0:21.630 OnRelease:84f8c00 Media Disconnecting OpalRTPMediaStream-Source-G.711-uLaw-64k from patch thread Patch OpalRTPMediaStream-Source-G.711-uLaw-64k 2006/06/02 13:12:43.893 0:21.653 Media Patch:8175708 Patch Thread ended for Patch OpalAudioMediaStream-Source-PCM-16 2006/06/02 13:12:43.893 0:21.653 OnRelease:84f8c00 Patch Closing media patch Patch OpalRTPMediaStream-Source-G.711-uLaw-64k 2006/06/02 13:12:43.916 0:21.676 RTP Jitter:8526b30 RTP_UDP Session 1, Read shutdown. 2006/06/02 13:12:43.917 0:21.677 RTP Jitter:8526b30 RTP Jitter RTP receive thread ended 2006/06/02 13:12:43.917 0:21.677 OnRelease:84f8c00 Media Closing RTP for OpalRTPMediaStream-Source-G.711-uLaw-64k 2006/06/02 13:12:43.918 0:21.678 OnRelease:84f8c00 RTP_UDP Session 1, Shutting down read. 2006/06/02 13:12:43.919 0:21.679 OnRelease:84f8c00 Media Closing stream OpalRTPMediaStream-Source-G.711-uLaw-64k 2006/06/02 13:12:43.922 0:21.683 OnRelease:856e8a0 Patch Waiting for media patch thread to stop Patch OpalAudioMediaStream-Source-PCM-16 2006/06/02 13:12:43.926 0:21.686 OnRelease:856e8a0 Patch Media patch thread Patch OpalAudioMediaStream-Source-PCM-16 destroyed. 2006/06/02 13:12:43.930 0:21.691 OnRelease:856e8a0 Media Closing raw media stream OpalAudioMediaStream-Sink-PCM-16 2006/06/02 13:12:43.932 0:21.693 OnRelease:856e8a0 Media Closing stream OpalAudioMediaStream-Sink-PCM-16 2006/06/02 13:12:43.933 0:21.694 OnRelease:856e8a0 Media Disconnecting OpalAudioMediaStream-Sink-PCM-16 from patch thread Patch OpalRTPMediaStream-Source-G.711-uLaw-64k 2006/06/02 13:12:43.956 0:21.717 OnRelease:856e8a0 Patch Removing media stream sink OpalAudioMediaStream-Sink-PCM-16 2006/06/02 13:12:44.696 0:22.456 Housekeeper RTP Found existing session 1 2006/06/02 13:12:44.696 0:22.456 Housekeeper RTP Found existing session 2 2006/06/02 13:12:45.696 0:23.456 Housekeeper RTP Found existing session 1 2006/06/02 13:12:45.697 0:23.457 Housekeeper RTP Found existing session 2 2006/06/02 13:12:46.700 0:24.460 Housekeeper RTP Found existing session 1 2006/06/02 13:12:46.700 0:24.460 Housekeeper RTP Found existing session 2 2006/06/02 13:12:47.704 0:25.464 Housekeeper RTP Found existing session 1 2006/06/02 13:12:47.704 0:25.464 Housekeeper RTP Found existing session 2 2006/06/02 13:12:48.708 0:26.468 Housekeeper RTP Found existing session 1 2006/06/02 13:12:48.709 0:26.469 Housekeeper RTP Found existing session 2 2006/06/02 13:12:49.713 0:27.473 Housekeeper RTP Found existing session 1 2006/06/02 13:12:49.713 0:27.473 Housekeeper RTP Found existing session 2 2006/06/02 13:12:50.712 0:28.473 Housekeeper RTP Found existing session 1 2006/06/02 13:12:50.713 0:28.473 Housekeeper RTP Found existing session 2 2006/06/02 13:12:51.716 0:29.477 Housekeeper RTP Found existing session 1 2006/06/02 13:12:51.717 0:29.477 Housekeeper RTP Found existing session 2 2006/06/02 13:12:52.716 0:30.477 Housekeeper RTP Found existing session 1 2006/06/02 13:12:52.717 0:30.477 Housekeeper RTP Found existing session 2 2006/06/02 13:12:53.717 0:31.477 Housekeeper RTP Found existing session 1 2006/06/02 13:12:53.717 0:31.477 Housekeeper RTP Found existing session 2 2006/06/02 13:12:54.721 0:32.481 Housekeeper RTP Found existing session 1 2006/06/02 13:12:54.721 0:32.481 Housekeeper RTP Found existing session 2 2006/06/02 13:12:55.725 0:33.485 Housekeeper RTP Found existing session 1 2006/06/02 13:12:55.725 0:33.485 Housekeeper RTP Found existing session 2 2006/06/02 13:12:56.730 0:34.490 Housekeeper RTP Found existing session 1 2006/06/02 13:12:56.730 0:34.490 Housekeeper RTP Found existing session 2 2006/06/02 13:12:57.733 0:35.493 Housekeeper RTP Found existing session 1 2006/06/02 13:12:57.734 0:35.494 Housekeeper RTP Found existing session 2 2006/06/02 13:12:58.733 0:36.493 Housekeeper RTP Found existing session 1 2006/06/02 13:12:58.733 0:36.493 Housekeeper RTP Found existing session 2 2006/06/02 13:12:59.733 0:37.493 Housekeeper RTP Found existing session 1 2006/06/02 13:12:59.733 0:37.493 Housekeeper RTP Found existing session 2 2006/06/02 13:13:00.733 0:38.493 Housekeeper RTP Found existing session 1 2006/06/02 13:13:00.733 0:38.493 Housekeeper RTP Found existing session 2 2006/06/02 13:13:01.763 0:39.523 Housekeeper RTP Found existing session 1 2006/06/02 13:13:01.763 0:39.523 Housekeeper RTP Found existing session 2 2006/06/02 13:13:02.777 0:40.538 Housekeeper RTP Found existing session 1 2006/06/02 13:13:02.778 0:40.538 Housekeeper RTP Found existing session 2 2006/06/02 13:13:03.777 0:41.537 Housekeeper RTP Found existing session 1 2006/06/02 13:13:03.777 0:41.537 Housekeeper RTP Found existing session 2 2006/06/02 13:13:04.369 0:42.129 Housekeeper SIP Set state Terminated_Success for transaction 1 INVITE 2006/06/02 13:13:04.777 0:42.537 Housekeeper RTP Found existing session 1 2006/06/02 13:13:04.777 0:42.537 Housekeeper RTP Found existing session 2 2006/06/02 13:13:05.777 0:43.537 Housekeeper RTP Found existing session 1 2006/06/02 13:13:05.777 0:43.538 Housekeeper RTP Found existing session 2 2006/06/02 13:13:06.613 0:44.374 Housekeeper SIP Set state Terminated_Success for transaction 2 INVITE 2006/06/02 13:13:06.777 0:44.537 Housekeeper RTP Found existing session 1 2006/06/02 13:13:06.778 0:44.538 Housekeeper RTP Found existing session 2 2006/06/02 13:13:07.777 0:45.538 Housekeeper RTP Found existing session 1 2006/06/02 13:13:07.778 0:45.538 Housekeeper RTP Found existing session 2 2006/06/02 13:13:08.778 0:46.538 Housekeeper RTP Found existing session 1 2006/06/02 13:13:08.778 0:46.538 Housekeeper RTP Found existing session 2 2006/06/02 13:13:09.778 0:47.538 Housekeeper RTP Found existing session 1 2006/06/02 13:13:09.778 0:47.538 Housekeeper RTP Found existing session 2 
Processus arrêté

--
Daniel
[Date Prev][Date Next]   [Thread Prev][Thread Next]   [Thread Index] [Date Index] [Author Index]