Re: [GnomeMeeting-devel-list] GSM codec problem with Snapshot 2.0.1-20060521-01
- From: Damien Sandras <dsandras seconix com>
- To: GnomeMeeting development mailing list <gnomemeeting-devel-list gnome org>
- Subject: Re: [GnomeMeeting-devel-list] GSM codec problem with Snapshot 2.0.1-20060521-01
- Date: Sat, 03 Jun 2006 20:00:48 +0200
Hi,
Le samedi 03 juin 2006 à 17:11 +0200, Daniel Huhardeaux a écrit :
> 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.
>
Asterisk answers with 200 OK indicating that the call should be done
with PCMU.
> 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.
>
Please try with 2.0.2. Craig has done work in CVS and things are
potentially broken. If the problem persists once plugins support is in
CVS, please report again.
> If I deactivate GSM codec, everything is fine. Below you will find a d4
> output from the call.
>
I do not think activating GSM or not has any influence. The problem is
probably something else.
>
> [...]
> 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é
>
--
_ Damien Sandras
(o-
//\ Ekiga Softphone: http://www.ekiga.org/
v_/_ FOSDEM 2006 : http://www.fosdem.org/
SIP Phone : sip:dsandras ekiga net
sip:600000 ekiga net
[
Date Prev][
Date Next] [
Thread Prev][
Thread Next]
[
Thread Index]
[
Date Index]
[
Author Index]
