All pastes #183504 Raw Edit

Unnamed

public text v1 · immutable
#183504 ·published 2006-09-26 23:53 UTC
rendered paste body
47.135.4.128]
2006/09/26 19:39:29.914	  0:25.368	  GMURLHandler:085875a0	OpalCon	OpenSinkMediaStream Call[1]-EP<pc>[Default] session=1
2006/09/26 19:39:29.914	  0:25.368	  GMURLHandler:085875a0	OpalCon	OpenSinkMediaStream, selected G.711-uLaw-64k -> PCM-16
2006/09/26 19:39:30.218	  0:25.672	  GMURLHandler:085875a0	OpalMan	OnOpenMediaStream Call[1]-EP<pc>[Default],OpalAudioMediaStream-Sink-PCM-16
2006/09/26 19:39:30.219	  0:25.673	  GMURLHandler:085875a0	Codec	G711-uLaw-64k decoder created
2006/09/26 19:39:30.219	  0:25.673	  GMURLHandler:085875a0	Media	Audio sink data size set to  320 bytes and 2 buffers.
2006/09/26 19:39:30.219	  0:25.673	  GMURLHandler:085875a0	Patch	Added media stream sink OpalAudioMediaStream-Sink-PCM-16 using transcoder G.711-uLaw-64k->PCM-16
2006/09/26 19:39:30.219	  0:25.673	  GMURLHandler:085875a0	OpalCon	New patch created
2006/09/26 19:39:30.220	  0:25.674	  GMURLHandler:085875a0	OpalCon	New patch created
2006/09/26 19:39:30.221	  0:25.675	  GMURLHandler:085875a0	OpalCon	OpenSourceMediaStream (already opened) for session 1 on Call[1]-EP<sip>[7e0352-7e@147.135.4.128]
2006/09/26 19:39:30.221	  0:25.675	  GMURLHandler:085875a0	RTP_UDP	SetRemoteSocketInfo: session=1 data channel, new=147.135.4.248:13598, local=192.168.1.117:5000-5001, remote=0.0.0.0:0-0
2006/09/26 19:39:30.222	  0:25.676	  GMURLHandler:085875a0	SIP	Could not find matching media type for session 2
2006/09/26 19:39:30.224	  0:25.678	  GMURLHandler:085875a0	SIP	Sending PDU on udp$147.135.4.128:5060<if=udp$192.168.1.117:5063>
SIP/2.0 200 OK
CSeq: 1 INVITE
Via: SIP/2.0/UDP 147.135.4.128:5060
From: "Conte Steve C"<sip:8138851503@147.135.4.128;user=phone>;tag=0356
Call-ID: 7e0352-7e@147.135.4.128
To: "Jonathon Conte"<sip:8136426683@192.168.1.117;user=phone>;tag=ea4320e5-254c-db11-9002-000d60f993e4
Contact: <sip:8136426683@192.168.1.117:5063;transport=udp>
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,NOTIFY,REFER,MESSAGE
Content-Type: application/sdp
Content-Length: 206

v=0
o=- 1159313969 1159313969 IN IP4 192.168.1.117
s=Opal SIP Session
c=IN IP4 192.168.1.117
t=0 0
m=audio 5000 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

2006/09/26 19:39:30.245	  0:25.699	  GMURLHandler:085875a0	Call	GetMediaFormats for Call[1]-EP<sip>[7e0352-7e@147.135.4.128]
G.711-uLaw-64k

2006/09/26 19:39:30.245	  0:25.699	  GMURLHandler:085875a0	Call	OpenSourceMediaStreams for session 1 with media G.711-uLaw-64k
2006/09/26 19:39:30.245	  0:25.699	  GMURLHandler:085875a0	OpalCon	OpenSourceMediaStream (already opened) for session 1 on Call[1]-EP<pc>[Default]
2006/09/26 19:39:30.246	  0:25.700	  GMURLHandler:085875a0	Call	OpenSourceMediaStreams for session 1 adjusted media to G.711-uLaw-64k
2006/09/26 19:39:30.246	  0:25.700	  GMURLHandler:085875a0	Call	OpenSourceMediaStreams for session 2 with media G.711-uLaw-64k
2006/09/26 19:39:30.260	  0:25.714	  GMURLHandler:085875a0	Call	GetMediaFormats for Call[1]-EP<pc>[Default]
G.711-uLaw-64k

2006/09/26 19:39:30.260	  0:25.714	  GMURLHandler:085875a0	Call	OpenSourceMediaStreams for session 1 with media G.711-uLaw-64k
2006/09/26 19:39:30.260	  0:25.714	  GMURLHandler:085875a0	OpalCon	OpenSourceMediaStream (already opened) for session 1 on Call[1]-EP<sip>[7e0352-7e@147.135.4.128]
2006/09/26 19:39:30.261	  0:25.715	  GMURLHandler:085875a0	Call	OpenSourceMediaStreams for session 2 with media G.711-uLaw-64k
2006/09/26 19:39:30.261	  0:25.715	    Media Patch:8581000	Patch	Thread started for Patch OpalAudioMediaStream-Source-PCM-16 -> OpalRTPMediaStream-Sink-G.711-uLaw-64k
2006/09/26 19:39:30.263	  0:25.718	  GMURLHandler:085875a0	Media	Starting thread Media Patch:8581000
2006/09/26 19:39:30.264	  0:25.718	    Media Patch:858e3d0	Patch	Thread started for Patch OpalRTPMediaStream-Source-G.711-uLaw-64k -> OpalAudioMediaStream-Sink-PCM-16
2006/09/26 19:39:30.264	  0:25.719	    Media Patch:858e3d0	RTP	Jitter buffer created: size=51 delay=160-2000/160 (20ms) obj=0x858eb80
2006/09/26 19:39:30.267	  0:25.721	     RTP Jitter:858eb80	RTP	Jitter RTP receive thread started: 0x858eb80
2006/09/26 19:39:30.267	  0:25.721	  GMURLHandler:085875a0	Media	Starting thread Media Patch:858e3d0
2006/09/26 19:39:30.268	  0:25.722	  GMURLHandler:085875a0	OpalCon	Media stream threads started.
2006/09/26 19:39:30.268	  0:25.722	  GMURLHandler:085875a0	OpalCon	Media stream threads started.
2006/09/26 19:39:30.268	  0:25.722	  GMURLHandler:085875a0	GMPCSSEndpoint	 PCSS connection established
2006/09/26 19:39:30.268	  0:25.722	  GMURLHandler:085875a0	GMManager	 Will establish the connection
2006/09/26 19:39:30.268	  0:25.722	  GMURLHandler:085875a0	OpalMan	OnEstablished Call[1]-EP<pc>[Default]
2006/09/26 19:39:30.268	  0:25.722	  GMURLHandler:085875a0	Call	OnEstablished Call[1]-EP<pc>[Default]
2006/09/26 19:39:30.284	  0:25.738	  SIP Transport:85360f0	SIP	PDU Received on udp$147.135.4.128:5060<if=udp$192.168.1.117:5061>
ACK sip:8136426683@192.168.1.117:5063 SIP/2.0
CSeq: 1 ACK
Via: SIP/2.0/UDP 147.135.4.128:5060
From: "Conte Steve C"<sip:8138851503@147.135.4.128;user=phone>;tag=0356
Call-ID: 7e0352-7e@147.135.4.128
To: "Jonathon Conte"<sip:8136426683@192.168.1.117;user=phone>;tag=ea4320e5-254c-db11-9002-000d60f993e4
Content-Length: 0


2006/09/26 19:39:30.285	  0:25.739	  SIP Transport:85360f0	SIP	Queueing PDU: 1 ACK sip:8136426683@192.168.1.117:5063
2006/09/26 19:39:30.285	  0:25.739	    SIP Handler:8534420	SIP	Handling PDU 1 ACK sip:8136426683@192.168.1.117:5063
2006/09/26 19:39:30.285	  0:25.739	    SIP Handler:8534420	SIP	ACK received: ConnectedPhase
2006/09/26 19:39:30.285	  0:25.739	    SIP Handler:8534420	GMSIPEndpoint	 SIP connection established
2006/09/26 19:39:30.287	  0:25.741	  SIP Transport:85360f0	SIP	Waiting for PDU on udp$147.135.4.128:5060<if=udp$192.168.1.117:5061>
2006/09/26 19:39:30.298	  0:25.752	    SIP Handler:8534420	RTP	Found existing session 1
2006/09/26 19:39:30.298	  0:25.752	    SIP Handler:8534420	GMManager	 Will establish the connection
2006/09/26 19:39:30.298	  0:25.752	    SIP Handler:8534420	OpalMan	OnEstablished Call[1]-EP<sip>[7e0352-7e@147.135.4.128]
2006/09/26 19:39:30.299	  0:25.753	    SIP Handler:8534420	Call	OnEstablished Call[1]-EP<sip>[7e0352-7e@147.135.4.128]
2006/09/26 19:39:30.313	  0:25.767	    SIP Handler:8534420	OpalCon	Media stream threads started.
2006/09/26 19:39:30.314	  0:25.768	    SIP Handler:8534420	SIP	Awaiting next PDU.
2006/09/26 19:39:30.316	  0:25.770	    Media Patch:8581000	RTP	First sent data: ver=2 pt=PCMU psz=160 m=1 x=0 seq=41018 ts=0 src=285894948 ccnt=0
2006/09/26 19:39:30.624	  0:26.078	     RTP Jitter:858eb80	RTP	First receive data: ver=2 pt=PCMU psz=160 m=1 x=0 seq=54486 ts=1042974671 src=624332868 ccnt=0
2006/09/26 19:39:30.624	  0:26.078	     RTP Jitter:858eb80	RTP	Received start of talk burst: 1042974671
2006/09/26 19:39:31.300	  0:26.755	            Housekeeper	RTP	Found existing session 1
2006/09/26 19:39:31.640	  0:27.094	    Media Patch:858e3d0	RTP	Jitter buffer target size decreased to 160 (20ms)
2006/09/26 19:39:32.300	  0:27.754	            Housekeeper	RTP	Found existing session 1
2006/09/26 19:39:32.410	  0:27.864	    Media Patch:8581000	RTP	Transmit statistics:  packets=101 octets=16160 avgTime=20 maxTime=44 minTime=14
2006/09/26 19:39:32.623	  0:28.077	     RTP Jitter:858eb80	RTP	Receive statistics:  packets=101 octets=16160 lost=0 tooLate=0 order=0 avgTime=19 maxTime=25 minTime=16 jitter=1 maxJitter=2
2006/09/26 19:39:33.300	  0:28.754	            Housekeeper	RTP	Found existing session 1
2006/09/26 19:39:34.300	  0:29.754	            Housekeeper	RTP	Found existing session 1
2006/09/26 19:39:34.410	  0:29.864	    Media Patch:8581000	RTP	Transmit statistics:  packets=201 octets=32160 avgTime=20 maxTime=28 minTime=12
2006/09/26 19:39:34.625	  0:30.079	     RTP Jitter:858eb80	RTP	Receive statistics:  packets=201 octets=32160 lost=0 tooLate=0 order=0 avgTime=20 maxTime=26 minTime=14 jitter=1 maxJitter=2
2006/09/26 19:39:35.300	  0:30.754	            Housekeeper	RTP	Found existing session 1
2006/09/26 19:39:36.302	  0:31.756	            Housekeeper	RTP	Found existing session 1
2006/09/26 19:39:36.410	  0:31.864	    Media Patch:8581000	RTP	Transmit statistics:  packets=301 octets=48160 avgTime=20 maxTime=34 minTime=10
2006/09/26 19:39:36.624	  0:32.078	     RTP Jitter:858eb80	RTP	Receive statistics:  packets=301 octets=48160 lost=0 tooLate=0 order=0 avgTime=19 maxTime=28 minTime=13 jitter=1 maxJitter=2
2006/09/26 19:39:36.660	  0:32.114	    Media Patch:858e3d0	RTP	Jitter buffer target size decreased to 160 (20ms)
2006/09/26 19:39:37.304	  0:32.758	            Housekeeper	RTP	Found existing session 1
2006/09/26 19:39:38.304	  0:33.758	            Housekeeper	RTP	Found existing session 1
2006/09/26 19:39:38.410	  0:33.864	    Media Patch:8581000	RTP	Transmit statistics:  packets=401 octets=64160 avgTime=20 maxTime=34 minTime=8
2006/09/26 19:39:38.622	  0:34.076	     RTP Jitter:858eb80	RTP	Receive statistics:  packets=401 octets=64160 lost=0 tooLate=0 order=0 avgTime=19 maxTime=22 minTime=17 jitter=0 maxJitter=2
2006/09/26 19:39:39.304	  0:34.758	            Housekeeper	RTP	Found existing session 1
2006/09/26 19:39:40.304	  0:35.758	            Housekeeper	RTP	Found existing session 1
2006/09/26 19:39:40.410	  0:35.864	    Media Patch:8581000	RTP	Transmit statistics:  packets=501 octets=80160 avgTime=20 maxTime=36 minTime=8
2006/09/26 19:39:40.624	  0:36.078	     RTP Jitter:858eb80	RTP	Receive statistics:  packets=501 octets=80160 lost=0 tooLate=0 order=0 avgTime=20 maxTime=23 minTime=17 jitter=1 maxJitter=2
2006/09/26 19:39:41.304	  0:36.758	            Housekeeper	RTP	Found existing session 1
2006/09/26 19:39:41.584	  0:37.038	     RTP Jitter:858eb80	RTP	SentSenderReport:  ssrc=285894948 ntp=3368302781.2509392130 rtp=89280 psent=559 osent=89440
2006/09/26 19:39:41.584	  0:37.038	     RTP Jitter:858eb80	RTP	SentReceiverReport: ssrc=624332868 fraction=0 lost=0 last_seq=0 jitter=12 lsr=0 dlsr=0
2006/09/26 19:39:41.585	  0:37.039	     RTP Jitter:858eb80	RTP	Sending SDES: jconte@peregrine
2006/09/26 19:39:41.680	  0:37.134	    Media Patch:858e3d0	RTP	Jitter buffer target size decreased to 160 (20ms)
2006/09/26 19:39:42.304	  0:37.759	            Housekeeper	RTP	Found existing session 1
2006/09/26 19:39:42.410	  0:37.864	    Media Patch:8581000	RTP	Transmit statistics:  packets=601 octets=96160 avgTime=20 maxTime=38 minTime=7
2006/09/26 19:39:42.551	  0:38.005	  SIP Transport:85360f0	SIP	PDU Received on udp$147.135.4.128:5060<if=udp$192.168.1.117:5061>
BYE sip:8136426683@192.168.1.117:5061 SIP/2.0
CSeq: 2 BYE
Via: SIP/2.0/UDP 147.135.4.128:5060
From: "Conte Steve C"<sip:8138851503@147.135.4.128;user=phone>;tag=0356
Call-ID: 7e0352-7e@147.135.4.128
To: "Jonathon Conte"<sip:8136426683@192.168.1.117;user=phone>;tag=ea4320e5-254c-db11-9002-000d60f993e4
Content-Length: 0


2006/09/26 19:39:42.552	  0:38.006	  SIP Transport:85360f0	SIP	Queueing PDU: 2 BYE sip:8136426683@192.168.1.117:5061
2006/09/26 19:39:42.552	  0:38.006	  SIP Transport:85360f0	SIP	Waiting for PDU on udp$147.135.4.128:5060<if=udp$192.168.1.117:5061>
2006/09/26 19:39:42.552	  0:38.006	    SIP Handler:8534420	SIP	Handling PDU 2 BYE sip:8136426683@192.168.1.117:5061
2006/09/26 19:39:42.553	  0:38.007	    SIP Handler:8534420	SIP	BYE received for call 7e0352-7e@147.135.4.128
2006/09/26 19:39:42.553	  0:38.007	    SIP Handler:8534420	SIP	Sending PDU on udp$147.135.4.128:5060<if=udp$192.168.1.117:5063>
SIP/2.0 200 OK
CSeq: 2 BYE
Via: SIP/2.0/UDP 147.135.4.128:5060
From: "Conte Steve C"<sip:8138851503@147.135.4.128;user=phone>;tag=0356
Call-ID: 7e0352-7e@147.135.4.128
To: "Jonathon Conte"<sip:8136426683@192.168.1.117;user=phone>;tag=ea4320e5-254c-db11-9002-000d60f993e4
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,NOTIFY,REFER,MESSAGE
Content-Length: 0


2006/09/26 19:39:42.554	  0:38.008	    SIP Handler:8534420	OpalCon	Releasing Call[1]-EP<sip>[7e0352-7e@147.135.4.128]
2006/09/26 19:39:42.554	  0:38.008	    SIP Handler:8534420	OpalCon	Call end reason for 7e0352-7e@147.135.4.128 set to EndedByRemoteUser
2006/09/26 19:39:42.554	  0:38.008	    SIP Handler:8534420	OpalCon	SetPhase from EstablishedPhase to ReleasingPhase
2006/09/26 19:39:42.555	  0:38.009	    SIP Handler:8534420	SIP	Awaiting next PDU.
2006/09/26 19:39:42.555	  0:38.009	     OnRelease:b2c038e8	SIP	OnReleased: Call[1]-EP<sip>[7e0352-7e@147.135.4.128], phase = ReleasingPhase
2006/09/26 19:39:42.555	  0:38.009	     OnRelease:b2c038e8	OpalCon	SetPhase from ReleasingPhase to ReleasingPhase
2006/09/26 19:39:42.566	  0:38.020	     OnRelease:b2c038e8	Media	Closing RTP for OpalRTPMediaStream-Sink-G.711-uLaw-64k
2006/09/26 19:39:42.566	  0:38.020	     OnRelease:b2c038e8	RTP_UDP	Session 1, Shutting down write.
2006/09/26 19:39:42.567	  0:38.021	     OnRelease:b2c038e8	Media	Closing stream OpalRTPMediaStream-Sink-G.711-uLaw-64k
2006/09/26 19:39:42.567	  0:38.021	     OnRelease:b2c038e8	Media	Disconnecting OpalRTPMediaStream-Sink-G.711-uLaw-64k from patch thread Patch OpalAudioMediaStream-Source-PCM-16 -> OpalRTPMediaStream-Sink-G.711-uLaw-64k
2006/09/26 19:39:42.567	  0:38.021	     OnRelease:b2c038e8	Patch	Removing media stream sink OpalRTPMediaStream-Sink-G.711-uLaw-64k
2006/09/26 19:39:42.579	  0:38.033	     OnRelease:b2c038e8	Media	Closing RTP for OpalRTPMediaStream-Source-G.711-uLaw-64k
2006/09/26 19:39:42.579	  0:38.033	     OnRelease:b2c038e8	RTP_UDP	Session 1, Shutting down read.
2006/09/26 19:39:42.579	  0:38.033	     RTP Jitter:858eb80	RTP_UDP	Session 1, Read shutdown.
2006/09/26 19:39:42.579	  0:38.033	     RTP Jitter:858eb80	RTP	Jitter RTP receive thread ended
2006/09/26 19:39:42.579	  0:38.033	     OnRelease:b2c038e8	Media	Closing stream OpalRTPMediaStream-Source-G.711-uLaw-64k
2006/09/26 19:39:42.580	  0:38.034	     OnRelease:b2c038e8	Media	Disconnecting OpalRTPMediaStream-Source-G.711-uLaw-64k from patch thread Patch OpalRTPMediaStream-Source-G.711-uLaw-64k -> OpalAudioMediaStream-Sink-PCM-16
2006/09/26 19:39:42.580	  0:38.034	     OnRelease:b2c038e8	Patch	Closing media patch Patch OpalRTPMediaStream-Source-G.711-uLaw-64k -> OpalAudioMediaStream-Sink-PCM-16
2006/09/26 19:39:42.580	  0:38.034	     OnRelease:b2c038e8	Media	Closing RTP for OpalRTPMediaStream-Source-G.711-uLaw-64k
2006/09/26 19:39:42.580	  0:38.034	     OnRelease:b2c038e8	RTP_UDP	Session 1, Shutting down read.
2006/09/26 19:39:42.581	  0:38.035	    Media Patch:858e3d0	Patch	Thread ended for Patch OpalRTPMediaStream-Source-G.711-uLaw-64k
2006/09/26 19:39:42.604	  0:38.059	     OnRelease:b2c038e8	Media	Closing stream OpalRTPMediaStream-Source-G.711-uLaw-64k
2006/09/26 19:39:42.605	  0:38.059	    Media Patch:8581000	Patch	Thread ended for Patch OpalAudioMediaStream-Source-PCM-16
2006/09/26 19:39:42.605	  0:38.059	     OnRelease:b2c038e8	Patch	Removing media stream sink OpalAudioMediaStream-Sink-PCM-16
2006/09/26 19:39:42.605	  0:38.059	     OnRelease:b2c038e8	Patch	Waiting for media patch thread to stop Patch OpalRTPMediaStream-Source-G.711-uLaw-64k
2006/09/26 19:39:42.605	  0:38.059	     OnRelease:b2c038e8	Patch	Media patch thread Patch OpalRTPMediaStream-Source-G.711-uLaw-64k destroyed.
2006/09/26 19:39:42.606	  0:38.060	     OnRelease:b2c038e8	OpalCon	Media stream threads closed.
2006/09/26 19:39:42.606	  0:38.060	     OnRelease:b2c038e8	OpalCon	SetPhase from ReleasingPhase to ReleasedPhase
2006/09/26 19:39:42.606	  0:38.060	    SIP Handler:8534420	SIP	PDU handler thread finished.
2006/09/26 19:39:42.606	  0:38.060	     OnRelease:b2c038e8	Opal	Transport clean up on termination
2006/09/26 19:39:42.606	  0:38.060	     OnRelease:b2c038e8	OpalUDP	Close
2006/09/26 19:39:42.607	  0:38.061	  SIP Transport:85337d0	OpalUDP	Error on connection read select.
2006/09/26 19:39:42.607	  0:38.061	  SIP Transport:85337d0	SIP	Read thread finished.
2006/09/26 19:39:42.607	  0:38.061	     OnRelease:b2c038e8	OpalCon	OnReleased Call[1]-EP<sip>[7e0352-7e@147.135.4.128]
2006/09/26 19:39:42.607	  0:38.061	     OnRelease:b2c038e8	OpalCon	Media stream threads closed.
2006/09/26 19:39:42.607	  0:38.062	     OnRelease:b2c038e8	GMSIPEndpoint	 SIP connection released
2006/09/26 19:39:42.608	  0:38.062	     OnRelease:b2c038e8	OpalEP	OnReleased Call[1]-EP<sip>[7e0352-7e@147.135.4.128]
2006/09/26 19:39:42.626	  0:38.080	     OnRelease:b2c038e8	GMManager	 Will release the connection
2006/09/26 19:39:42.626	  0:38.080	     OnRelease:b2c038e8	OpalMan	OnReleased Call[1]-EP<sip>[7e0352-7e@147.135.4.128]
2006/09/26 19:39:42.626	  0:38.080	     OnRelease:b2c038e8	Call	OnReleased Call[1]-EP<sip>[7e0352-7e@147.135.4.128]
2006/09/26 19:39:42.627	  0:38.081	     OnRelease:b2c038e8	OpalCon	Releasing Call[1]-EP<pc>[Default]
2006/09/26 19:39:42.627	  0:38.081	     OnRelease:b2c038e8	OpalCon	Call end reason for Default set to EndedByRemoteUser
2006/09/26 19:39:42.627	  0:38.081	     OnRelease:b2c038e8	OpalCon	SetPhase from EstablishedPhase to ReleasingPhase
2006/09/26 19:39:42.627	  0:38.081	     OnRelease:b2c038e8	OpalCon	OnRelease thread completed for 7e0352-7e@147.135.4.128
2006/09/26 19:39:42.646	  0:38.101	      OnRelease:85ff430	OpalCon	OnReleased Call[1]-EP<pc>[Default]
2006/09/26 19:39:42.647	  0:38.101	      OnRelease:85ff430	Media	Closing raw media stream OpalAudioMediaStream-Source-PCM-16
2006/09/26 19:39:42.647	  0:38.101	      OnRelease:85ff430	Media	Closing stream OpalAudioMediaStream-Source-PCM-16
2006/09/26 19:39:42.647	  0:38.101	      OnRelease:85ff430	Media	Disconnecting OpalAudioMediaStream-Source-PCM-16 from patch thread Patch OpalAudioMediaStream-Source-PCM-16
2006/09/26 19:39:42.648	  0:38.102	      OnRelease:85ff430	Patch	Closing media patch Patch OpalAudioMediaStream-Source-PCM-16
2006/09/26 19:39:42.648	  0:38.102	      OnRelease:85ff430	Media	Closing raw media stream OpalAudioMediaStream-Source-PCM-16
2006/09/26 19:39:42.648	  0:38.102	      OnRelease:85ff430	Media	Closing stream OpalAudioMediaStream-Source-PCM-16
2006/09/26 19:39:42.648	  0:38.102	      OnRelease:85ff430	Patch	Waiting for media patch thread to stop Patch OpalAudioMediaStream-Source-PCM-16
2006/09/26 19:39:42.649	  0:38.103	      OnRelease:85ff430	Patch	Media patch thread Patch OpalAudioMediaStream-Source-PCM-16 destroyed.
2006/09/26 19:39:42.649	  0:38.103	      OnRelease:85ff430	Media	Closing raw media stream OpalAudioMediaStream-Sink-PCM-16
2006/09/26 19:39:42.649	  0:38.103	      OnRelease:85ff430	Media	Closing stream OpalAudioMediaStream-Sink-PCM-16
2006/09/26 19:39:42.649	  0:38.103	      OnRelease:85ff430	OpalCon	Media stream threads closed.
2006/09/26 19:39:42.668	  0:38.122	      OnRelease:85ff430	GMPCSSEndpoint	 PCSS connection released
2006/09/26 19:39:42.668	  0:38.122	      OnRelease:85ff430	OpalEP	OnReleased Call[1]-EP<pc>[Default]
2006/09/26 19:39:42.669	  0:38.123	      OnRelease:85ff430	GMManager	 Will release the connection
2006/09/26 19:39:42.669	  0:38.123	      OnRelease:85ff430	OpalMan	OnReleased Call[1]-EP<pc>[Default]
2006/09/26 19:39:42.669	  0:38.123	      OnRelease:85ff430	Call	OnReleased Call[1]-EP<pc>[Default]
2006/09/26 19:39:43.169	  0:38.623	            OpalGarbage	Opal	Transport clean up on termination
2006/09/26 19:39:43.169	  0:38.623	            OpalGarbage	OpalUDP	Close
2006/09/26 19:39:43.169	  0:38.623	            OpalGarbage	SIP	Deleted connection.
2006/09/26 19:39:43.169	  0:38.623	            OpalGarbage	OpalCon	Connection Call[1]-EP<sip>[7e0352-7e@147.135.4.128] destroyed.
2006/09/26 19:39:43.170	  0:38.624	            OpalGarbage	RTP_UDP	Session 1, Shutting down write.
2006/09/26 19:39:43.170	  0:38.624	            OpalGarbage	RTP	Final statistics:
    packetsSent       = 608
    octetsSent        = 97280
    averageSendTime   = 20
    maximumSendTime   = 38
    minimumSendTime   = 7
    packetsReceived   = 596
    octetsReceived    = 95360
    packetsLost       = 0
    packetsTooLate    = 0
    packetsOutOfOrder = 0
    averageReceiveTime= 20
    maximumReceiveTime= 23
    minimumReceiveTime= 17
    averageJitter     = 1
    maximumJitter     = 2
2006/09/26 19:39:43.170	  0:38.624	            OpalGarbage	RTP	Removing jitter buffer 0x858eb80 RTP Jitter:858eb80
2006/09/26 19:39:44.531	  0:39.985	      OnRelease:85ff430	OpalCon	OnRelease thread completed for Default
2006/09/26 19:39:45.177	  0:40.631	            OpalGarbage	PCSS	Deleted PC sound system connection.
2006/09/26 19:39:45.177	  0:40.631	            OpalGarbage	OpalCon	Connection Call[1]-EP<pc>[Default] destroyed.
2006/09/26 19:39:46.181	  0:41.635	            OpalGarbage	Call	Call[1] destroyed.
2006/09/26 19:39:57.222	  0:52.676	  SIP Transport:85360f0	SDP	Media session port=13600
2006/09/26 19:39:57.223	  0:52.677	  SIP Transport:85360f0	SDP	Adding media session with 7 formats
2006/09/26 19:39:57.223	  0:52.677	  SIP Transport:85360f0	SIP	PDU Received on udp$147.135.4.128:5060<if=udp$192.168.1.117:5061>
INVITE sip:8136426683@192.168.1.117:5061 SIP/2.0
CSeq: 1 INVITE
Via: SIP/2.0/UDP 147.135.4.128:5060
From: "Conte Steve C"<sip:8138851503@147.135.4.128;user=phone>;tag=hjkl
Call-ID: 1e01a9-1e@147.135.4.128
Supported: 100rel
To: "Jonathon Conte"<sip:8136426683@192.168.1.117;user=phone>
Contact: <sip:8138851503@147.135.4.128:5060>
Content-Length: 299
Content-Type: application/sdp

v=0
o=2475099383 10 10 IN IP4 147.135.4.247
s=-
c=IN IP4 147.135.4.248
t=0 0
m=audio 13600 RTP/AVP 0 18 8 2 96 97 101
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:2 G726-32/8000
a=rtpmap:96 G729AB/8000
a=rtpmap:97 iLBC/8000
a=rtpmap:101 telephone-event/8000

2006/09/26 19:39:57.224	  0:52.678	  SIP Transport:85360f0	SIP	Tranport remote address change from Via: udp$147.135.4.128:5060<if=udp$192.168.1.117:5061>
2006/09/26 19:39:57.225	  0:52.679	  SIP Transport:85360f0	SIP	Sending PDU on udp$147.135.4.128:5060<if=udp$192.168.1.117:5061>
SIP/2.0 100 Trying
CSeq: 1 INVITE
Via: SIP/2.0/UDP 147.135.4.128:5060
From: "Conte Steve C"<sip:8138851503@147.135.4.128;user=phone>;tag=hjkl
Call-ID: 1e01a9-1e@147.135.4.128
To: "Jonathon Conte"<sip:8136426683@192.168.1.117;user=phone>
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,NOTIFY,REFER,MESSAGE
Content-Length: 0


2006/09/26 19:39:57.225	  0:52.679	  SIP Transport:85360f0	Call	Created Call[2]
2006/09/26 19:39:57.225	  0:52.679	  SIP Transport:85360f0	OpalCon	Created connection Call[2]-EP<sip>[1e01a9-1e@147.135.4.128]
2006/09/26 19:39:57.226	  0:52.680	  SIP Transport:85360f0	RFC2833	Handler created
2006/09/26 19:39:57.319	  0:52.773	  SIP Transport:85360f0	OpalUDP	Binding to interface: 192.168.1.117:32789
2006/09/26 19:39:57.319	  0:52.773	  SIP Transport:85360f0	SIP	Created transport udp$0.0.0.0<if=udp$192.168.1.117:32789>
2006/09/26 19:39:57.320	  0:52.774	  SIP Transport:85360f0	OpalUDP	Started connect to 192.168.1.117:5061
2006/09/26 19:39:57.320	  0:52.774	  SIP Transport:85360f0	OpalUDP	Connect on pre-bound interface: 192.168.1.117
2006/09/26 19:39:57.320	  0:52.774	  SIP Transport:85360f0	SIP	Created connection.
2006/09/26 19:39:57.320	  0:52.774	  SIP Transport:85360f0	SIP	Queueing PDU: 1 INVITE sip:8136426683@192.168.1.117:5061
2006/09/26 19:39:57.321	  0:52.775	  SIP Transport:85360f0	SIP	Waiting for PDU on udp$147.135.4.128:5060<if=udp$192.168.1.117:5061>
2006/09/26 19:39:57.321	  0:52.775	  SIP Transport:8534420	SIP	Read thread started.
2006/09/26 19:39:57.321	  0:52.775	  SIP Transport:8534420	SIP	Waiting for PDU on udp$192.168.1.117:5061<if=udp$192.168.1.117:5064>
2006/09/26 19:39:57.321	  0:52.775	    SIP Handler:8577348	SIP	PDU handler thread started.
2006/09/26 19:39:57.321	  0:52.775	    SIP Handler:8577348	SIP	Awaiting next PDU.
2006/09/26 19:39:57.322	  0:52.776	    SIP Handler:8577348	SIP	Handling PDU 1 INVITE sip:8136426683@192.168.1.117:5061
2006/09/26 19:39:57.322	  0:52.776	    SIP Handler:8577348	SIP	Set targetAddress to sip:8138851503@147.135.4.128:5060
2006/09/26 19:39:57.405	  0:52.860	    SIP Handler:8577348	SIP	Adjusting transport to address udp$147.135.4.128:5060
2006/09/26 19:39:57.406	  0:52.860	    SIP Handler:8577348	SIP	Sending PDU on udp$147.135.4.128:5060<if=udp$192.168.1.117:5064>
SIP/2.0 100 Trying
CSeq: 1 INVITE
Via: SIP/2.0/UDP 147.135.4.128:5060
From: "Conte Steve C"<sip:8138851503@147.135.4.128;user=phone>;tag=hjkl
Call-ID: 1e01a9-1e@147.135.4.128
To: "Jonathon Conte"<sip:8136426683@192.168.1.117;user=phone>;tag=5c6f8efc-254c-db11-9002-000d60f993e4
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,NOTIFY,REFER,MESSAGE
Content-Length: 0


2006/09/26 19:39:57.406	  0:52.860	    SIP Handler:8577348	GMSIPEndpoint	Incoming connection
2006/09/26 19:39:57.420	  0:52.874	    SIP Handler:8577348	OpalMan	On incoming connection Call[2]-EP<sip>[1e01a9-1e@147.135.4.128]
2006/09/26 19:39:57.421	  0:52.875	    SIP Handler:8577348	Call	GetOtherPartyConnection Call[2]-EP<sip>[1e01a9-1e@147.135.4.128]
2006/09/26 19:39:57.421	  0:52.875	    SIP Handler:8577348	OpalMan	Searching for route "sip:*"
2006/09/26 19:39:57.421	  0:52.875	    SIP Handler:8577348	OpalMan	Set up connection to "pc:*"
2006/09/26 19:39:57.423	  0:52.877	    SIP Handler:8577348	OpalCon	Created connection Call[2]-EP<pc>[Default]
2006/09/26 19:39:57.423	  0:52.877	    SIP Handler:8577348	RFC2833	Handler created
2006/09/26 19:39:57.423	  0:52.877	    SIP Handler:8577348	Silence	Handler created
2006/09/26 19:39:57.423	  0:52.877	    SIP Handler:8577348	Echo Canceler	Handler created
2006/09/26 19:39:57.424	  0:52.878	    SIP Handler:8577348	PCSS	Created PC sound system connection.
2006/09/26 19:39:57.466	  0:52.920	    SIP Handler:8577348	SIP	OnIncomingConnection succeeded for INVITE from sip:8136426683@192.168.1.117:5061 for Call[2]-EP<sip>[1e01a9-1e@147.135.4.128]
2006/09/26 19:39:57.466	  0:52.920	    SIP Handler:8577348	Call	OnSetUp Call[2]-EP<sip>[1e01a9-1e@147.135.4.128]
2006/09/26 19:39:57.466	  0:52.921	    SIP Handler:8577348	Call	GetOtherPartyConnection Call[2]-EP<pc>[Default]
2006/09/26 19:39:57.467	  0:52.921	    SIP Handler:8577348	Call	GetOtherPartyConnection Call[2]-EP<pc>[Default]
2006/09/26 19:39:57.467	  0:52.921	    SIP Handler:8577348	Call	GetOtherPartyConnection Call[2]-EP<pc>[Default]
2006/09/26 19:39:57.467	  0:52.921	    SIP Handler:8577348	PCSS	SetUpConnection(Conte Steve C)
2006/09/26 19:39:57.470	  0:52.924	    SIP Handler:8577348	OpalMan	OnAlerting Call[2]-EP<pc>[Default]
2006/09/26 19:39:57.470	  0:52.924	    SIP Handler:8577348	Call	OnAlerting Call[2]-EP<pc>[Default]
2006/09/26 19:39:57.470	  0:52.924	    SIP Handler:8577348	SIP	SetAlerting
2006/09/26 19:39:57.471	  0:52.925	    SIP Handler:8577348	SIP	Sending PDU on udp$147.135.4.128:5060<if=udp$192.168.1.117:5064>
SIP/2.0 180 Ringing
CSeq: 1 INVITE
Via: SIP/2.0/UDP 147.135.4.128:5060
From: "Conte Steve C"<sip:8138851503@147.135.4.128;user=phone>;tag=hjkl
Call-ID: 1e01a9-1e@147.135.4.128
To: "Jonathon Conte"<sip:8136426683@192.168.1.117;user=phone>;tag=5c6f8efc-254c-db11-9002-000d60f993e4
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,NOTIFY,REFER,MESSAGE
Content-Length: 0


2006/09/26 19:39:57.471	  0:52.925	    SIP Handler:8577348	SIP	Awaiting next PDU.
2006/09/26 19:40:06.412	  1:01.866	  GMURLHandler:08601f00	OpalMan	OnConnected Call[2]-EP<pc>[Default]
2006/09/26 19:40:06.412	  1:01.866	  GMURLHandler:08601f00	Call	OnConnected Call[2]-EP<pc>[Default]
2006/09/26 19:40:06.412	  1:01.866	  GMURLHandler:08601f00	SIP	SetConnected
2006/09/26 19:40:06.413	  1:01.867	  GMURLHandler:08601f00	SIP	RTP payload type PCMU matched to codec G.711-uLaw-64k
2006/09/26 19:40:06.413	  1:01.867	  GMURLHandler:08601f00	SIP	RTP payload type G729 not matched to audio codec
2006/09/26 19:40:06.413	  1:01.867	  GMURLHandler:08601f00	SIP	RTP payload type PCMA matched to codec G.711-ALaw-64k
2006/09/26 19:40:06.413	  1:01.867	  GMURLHandler:08601f00	SIP	RTP payload type G721 matched to codec G.726-32k
2006/09/26 19:40:06.413	  1:01.867	  GMURLHandler:08601f00	SIP	RTP payload type [pt=96] not matched to audio codec
2006/09/26 19:40:06.414	  1:01.868	  GMURLHandler:08601f00	SIP	RTP payload type [pt=97] not matched to audio codec
2006/09/26 19:40:06.414	  1:01.868	  GMURLHandler:08601f00	Call	CanDoMediaBypass Call[2]-EP<sip>[1e01a9-1e@147.135.4.128] session 1
2006/09/26 19:40:06.414	  1:01.869	  GMURLHandler:08601f00	OpalMan	IsMediaBypassPossible: session 1
2006/09/26 19:40:06.415	  1:01.869	  GMURLHandler:08601f00	SIP	IsMediaBypassPossible: session 1
2006/09/26 19:40:06.415	  1:01.869	  GMURLHandler:08601f00	OpalCon	IsMediaBypassPossible: default returns FALSE
2006/09/26 19:40:06.416	  1:01.870	            Housekeeper	SIP	Starting REGISTER/SUBSCRIBE for binding refresh
2006/09/26 19:40:06.416	  1:01.870	            Housekeeper	Opal	Transport clean up on termination
2006/09/26 19:40:06.416	  1:01.870	            Housekeeper	OpalUDP	Close
2006/09/26 19:40:06.416	  1:01.870	            Housekeeper	Opal	Transport Close
2006/09/26 19:40:06.416	  1:01.870	  SIP Transport:85360f0	SIP	Read thread finished.
2006/09/26 19:40:06.417	  1:01.871	  GMURLHandler:08601f00	RTP_UDP	Session 1 created: 192.168.1.117:5002-5003 ssrc=1085040347
2006/09/26 19:40:06.417	  1:01.871	  GMURLHandler:08601f00	RTP	Adding session RTP_UDP
2006/09/26 19:40:06.417	  1:01.871	  GMURLHandler:08601f00	Call	OpenSourceMediaStreams for session 1 with media G.711-uLaw-64k,UserInput/RFC2833
2006/09/26 19:40:06.417	  1:01.871	  GMURLHandler:08601f00	OpalCon	OpenSourceMediaStream for session 1 on Call[2]-EP<pc>[Default]
2006/09/26 19:40:06.418	  1:01.872	  GMURLHandler:08601f00	OpalCon	Selected media stream PCM-16 -> G.711-uLaw-64k
2006/09/26 19:40:06.546	  1:02.000	            Housekeeper	OpalUDP	Binding to interface: 192.168.1.117:32789
2006/09/26 19:40:06.546	  1:02.000	            Housekeeper	SIP	Created transport udp$0.0.0.0<if=udp$192.168.1.117:32789>
2006/09/26 19:40:06.546	  1:02.000	            Housekeeper	OpalUDP	Started connect to 147.135.4.128:5060
2006/09/26 19:40:06.546	  1:02.000	            Housekeeper	OpalUDP	Connect on pre-bound interface: 192.168.1.117
2006/09/26 19:40:06.546	  1:02.000	            Housekeeper	SIP	Created Transport for Registrar udp$147.135.4.128:5060<if=udp$192.168.1.117:5065>
2006/09/26 19:40:06.547	  1:02.001	            Housekeeper	SIP	Transaction 1 REGISTER destroyed.
2006/09/26 19:40:06.547	  1:02.001	            Housekeeper	SIP	Transaction 3 REGISTER destroyed.
2006/09/26 19:40:06.548	  1:02.002	            Housekeeper	SIP	Sending PDU on udp$147.135.4.128:5060<if=udp$192.168.1.117:5065>
REGISTER sip:sip.broadvoice.com SIP/2.0
CSeq: 4 REGISTER
Via: SIP/2.0/UDP 192.168.1.117:5065;branch=z9hG4bKf6e11c02-264c-db11-9002-000d60f993e4;rport
User-Agent: Ekiga/2.0.3
From: <sip:8136426683@sip.broadvoice.com>;tag=f6dc1c02-264c-db11-9002-000d60f993e4
Call-ID: bef503e0-254c-db11-9002-000d60f993e4@peregrine
To: <sip:8136426683@sip.broadvoice.com>
Contact: <sip:8136426683@192.168.1.117:5065;transport=udp>
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,NOTIFY,REFER,MESSAGE
Expires: 30
Content-Length: 0
Max-Forwards: 70


2006/09/26 19:40:06.549	  1:02.004	  SIP Transport:85b62a8	SIP	Read thread started.
2006/09/26 19:40:06.550	  1:02.004	  SIP Transport:85b62a8	SIP	Waiting for PDU on udp$147.135.4.128:5060<if=udp$192.168.1.117:5065>
2006/09/26 19:40:06.598	  1:02.052	  SIP Transport:85b62a8	SIP	PDU Received on udp$147.135.4.128:5060<if=udp$192.168.1.117:5065>
SIP/2.0 200 OK
CSeq: 4 REGISTER
Via: SIP/2.0/UDP 192.168.1.117:5065;branch=z9hG4bKf6e11c02-264c-db11-9002-000d60f993e4;received=208.118.38.97;rport=5065
User-Agent: Ekiga/2.0.3
From: <sip:8136426683@sip.broadvoice.com>;tag=f6dc1c02-264c-db11-9002-000d60f993e4
Call-ID: bef503e0-254c-db11-9002-000d60f993e4@peregrine
To: <sip:8136426683@sip.broadvoice.com>
Contact: <sip:8136426683@192.168.1.117:5065>
Expires: 30
Content-Length: 0


2006/09/26 19:40:06.598	  1:02.052	  SIP Transport:85b62a8	SIP	Transaction 4 REGISTER completed.
2006/09/26 19:40:06.598	  1:02.052	  SIP Transport:85b62a8	OpalUDP	Ended connect, selecting 192.168.1.117:5065
2006/09/26 19:40:06.601	  1:02.055	  SIP Transport:85b62a8	SIP	Waiting for PDU on udp$147.135.4.128:5060<if=udp$192.168.1.117:5065>
2006/09/26 19:40:06.797	  1:02.251	  GMURLHandler:08601f00	OpalMan	OnOpenMediaStream Call[2]-EP<pc>[Default],OpalAudioMediaStream-Source-PCM-16
2006/09/26 19:40:06.797	  1:02.251	  GMURLHandler:08601f00	Call	PatchMediaStreams Call[2]-EP<pc>[Default]
2006/09/26 19:40:06.797	  1:02.252	  GMURLHandler:08601f00	OpalCon	OpenSinkMediaStream Call[2]-EP<sip>[1e01a9-1e@147.135.4.128] session=1
2006/09/26 19:40:06.798	  1:02.252	  GMURLHandler:08601f00	OpalCon	OpenSinkMediaStream, selected PCM-16 -> G.711-uLaw-64k
2006/09/26 19:40:06.798	  1:02.252	  GMURLHandler:08601f00	Call	CanDoMediaBypass Call[2]-EP<sip>[1e01a9-1e@147.135.4.128] session 1
2006/09/26 19:40:06.798	  1:02.252	  GMURLHandler:08601f00	OpalMan	IsMediaBypassPossible: session 1
2006/09/26 19:40:06.799	  1:02.253	  GMURLHandler:08601f00	SIP	IsMediaBypassPossible: session 1
2006/09/26 19:40:06.799	  1:02.253	  GMURLHandler:08601f00	OpalCon	IsMediaBypassPossible: default returns FALSE
2006/09/26 19:40:06.799	  1:02.253	  GMURLHandler:08601f00	RTP	Found existing session 1
2006/09/26 19:40:06.799	  1:02.253	  GMURLHandler:08601f00	RTP	Found existing session 1
2006/09/26 19:40:06.799	  1:02.253	  GMURLHandler:08601f00	OpalMan	OnOpenMediaStream Call[2]-EP<sip>[1e01a9-1e@147.135.4.128],OpalRTPMediaStream-Sink-G.711-uLaw-64k
2006/09/26 19:40:06.802	  1:02.256	  GMURLHandler:08601f00	Codec	G711-uLaw-64k encoder created
2006/09/26 19:40:06.802	  1:02.256	  GMURLHandler:08601f00	Patch	Added media stream sink OpalRTPMediaStream-Sink-G.711-uLaw-64k using transcoder PCM-16->G.711-uLaw-64k
2006/09/26 19:40:06.802	  1:02.256	  GMURLHandler:08601f00	Media	Audio source data size set to  320 bytes and 2 buffers.
2006/09/26 19:40:06.802	  1:02.256	  GMURLHandler:08601f00	OpalCon	New patch created
2006/09/26 19:40:06.802	  1:02.256	  GMURLHandler:08601f00	OpalCon	New patch created
2006/09/26 19:40:06.803	  1:02.257	  GMURLHandler:08601f00	OpalCon	SetPhase from ConnectedPhase to EstablishedPhase
2006/09/26 19:40:06.803	  1:02.257	  GMURLHandler:08601f00	GMPCSSEndpoint	 PCSS connection established
2006/09/26 19:40:06.803	  1:02.257	  GMURLHandler:08601f00	GMManager	 Will establish the connection
2006/09/26 19:40:06.803	  1:02.257	  GMURLHandler:08601f00	OpalMan	OnEstablished Call[2]-EP<pc>[Default]
2006/09/26 19:40:06.803	  1:02.257	  GMURLHandler:08601f00	Call	OnEstablished Call[2]-EP<pc>[Default]
2006/09/26 19:40:06.804	  1:02.258	  GMURLHandler:08601f00	Call	OpenSourceMediaStreams for session 1 adjusted media to G.711-uLaw-64k
2006/09/26 19:40:06.804	  1:02.258	  GMURLHandler:08601f00	OpalCon	OpenSourceMediaStream for session 1 on Call[2]-EP<sip>[1e01a9-1e@147.135.4.128]
2006/09/26 19:40:06.804	  1:02.258	  GMURLHandler:08601f00	OpalCon	Selected media stream G.711-uLaw-64k -> G.711-uLaw-64k
2006/09/26 19:40:06.804	  1:02.258	  GMURLHandler:08601f00	Call	CanDoMediaBypass Call[2]-EP<sip>[1e01a9-1e@147.135.4.128] session 1
2006/09/26 19:40:06.805	  1:02.259	  GMURLHandler:08601f00	OpalMan	IsMediaBypassPossible: session 1
2006/09/26 19:40:06.805	  1:02.259	  GMURLHandler:08601f00	SIP	IsMediaBypassPossible: session 1
2006/09/26 19:40:06.805	  1:02.259	  GMURLHandler:08601f00	OpalCon	IsMediaBypassPossible: default returns FALSE
2006/09/26 19:40:06.805	  1:02.259	  GMURLHandler:08601f00	RTP	Found existing session 1
2006/09/26 19:40:06.805	  1:02.259	  GMURLHandler:08601f00	RTP	Found existing session 1
2006/09/26 19:40:06.805	  1:02.259	  GMURLHandler:08601f00	OpalMan	OnOpenMediaStream Call[2]-EP<sip>[1e01a9-1e@147.135.4.128],OpalRTPMediaStream-Source-G.711-uLaw-64k
2006/09/26 19:40:06.805	  1:02.259	  GMURLHandler:08601f00	Call	PatchMediaStreams Call[2]-EP<sip>[1e01a9-1e@147.135.4.128]
2006/09/26 19:40:06.806	  1:02.260	  GMURLHandler:08601f00	OpalCon	OpenSinkMediaStream Call[2]-EP<pc>[Default] session=1
2006/09/26 19:40:06.811	  1:02.265	  GMURLHandler:08601f00	OpalCon	OpenSinkMediaStream, selected G.711-uLaw-64k -> PCM-16
2006/09/26 19:40:07.128	  1:02.582	  GMURLHandler:08601f00	OpalMan	OnOpenMediaStream Call[2]-EP<pc>[Default],OpalAudioMediaStream-Sink-PCM-16
2006/09/26 19:40:07.129	  1:02.583	  GMURLHandler:08601f00	Codec	G711-uLaw-64k decoder created
2006/09/26 19:40:07.129	  1:02.583	  GMURLHandler:08601f00	Media	Audio sink data size set to  320 bytes and 2 buffers.
2006/09/26 19:40:07.130	  1:02.584	  GMURLHandler:08601f00	Patch	Added media stream sink OpalAudioMediaStream-Sink-PCM-16 using transcoder G.711-uLaw-64k->PCM-16
2006/09/26 19:40:07.130	  1:02.584	  GMURLHandler:08601f00	OpalCon	New patch created
2006/09/26 19:40:07.130	  1:02.584	  GMURLHandler:08601f00	OpalCon	New patch created
2006/09/26 19:40:07.131	  1:02.585	  GMURLHandler:08601f00	OpalCon	OpenSourceMediaStream (already opened) for session 1 on Call[2]-EP<sip>[1e01a9-1e@147.135.4.128]
2006/09/26 19:40:07.131	  1:02.585	  GMURLHandler:08601f00	RTP_UDP	SetRemoteSocketInfo: session=1 data channel, new=147.135.4.248:13600, local=192.168.1.117:5002-5003, remote=0.0.0.0:0-0
2006/09/26 19:40:07.132	  1:02.586	  GMURLHandler:08601f00	SIP	Could not find matching media type for session 2
2006/09/26 19:40:07.134	  1:02.593	  GMURLHandler:08601f00	SIP	Sending PDU on udp$147.135.4.128:5060<if=udp$192.168.1.117:5064>
SIP/2.0 200 OK
CSeq: 1 INVITE
Via: SIP/2.0/UDP 147.135.4.128:5060
From: "Conte Steve C"<sip:8138851503@147.135.4.128;user=phone>;tag=hjkl
Call-ID: 1e01a9-1e@147.135.4.128
To: "Jonathon Conte"<sip:8136426683@192.168.1.117;user=phone>;tag=5c6f8efc-254c-db11-9002-000d60f993e4
Contact: <sip:8136426683@192.168.1.117:5064;transport=udp>
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,NOTIFY,REFER,MESSAGE
Content-Type: application/sdp
Content-Length: 206

v=0
o=- 1159314006 1159314006 IN IP4 192.168.1.117
s=Opal SIP Session
c=IN IP4 192.168.1.117
t=0 0
m=audio 5002 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

2006/09/26 19:40:07.155	  1:02.609	  GMURLHandler:08601f00	Call	GetMediaFormats for Call[2]-EP<sip>[1e01a9-1e@147.135.4.128]
G.711-uLaw-64k

2006/09/26 19:40:07.155	  1:02.609	  GMURLHandler:08601f00	Call	OpenSourceMediaStreams for session 1 with media G.711-uLaw-64k
2006/09/26 19:40:07.155	  1:02.609	  GMURLHandler:08601f00	OpalCon	OpenSourceMediaStream (already opened) for session 1 on Call[2]-EP<pc>[Default]
2006/09/26 19:40:07.155	  1:02.609	  GMURLHandler:08601f00	Call	OpenSourceMediaStreams for session 1 adjusted media to G.711-uLaw-64k
2006/09/26 19:40:07.155	  1:02.610	  GMURLHandler:08601f00	Call	OpenSourceMediaStreams for session 2 with media G.711-uLaw-64k
2006/09/26 19:40:07.169	  1:02.624	  GMURLHandler:08601f00	Call	GetMediaFormats for Call[2]-EP<pc>[Default]
G.711-uLaw-64k

2006/09/26 19:40:07.170	  1:02.624	  GMURLHandler:08601f00	Call	OpenSourceMediaStreams for session 1 with media G.711-uLaw-64k
2006/09/26 19:40:07.170	  1:02.624	  GMURLHandler:08601f00	OpalCon	OpenSourceMediaStream (already opened) for session 1 on Call[2]-EP<sip>[1e01a9-1e@147.135.4.128]
2006/09/26 19:40:07.170	  1:02.624	  GMURLHandler:08601f00	Call	OpenSourceMediaStreams for session 2 with media G.711-uLaw-64k
2006/09/26 19:40:07.171	  1:02.625	    Media Patch:852e930	Patch	Thread started for Patch OpalAudioMediaStream-Source-PCM-16 -> OpalRTPMediaStream-Sink-G.711-uLaw-64k
2006/09/26 19:40:07.173	  1:02.627	  GMURLHandler:08601f00	Media	Starting thread Media Patch:852e930
2006/09/26 19:40:07.173	  1:02.627	    Media Patch:858ac00	Patch	Thread started for Patch OpalRTPMediaStream-Source-G.711-uLaw-64k -> OpalAudioMediaStream-Sink-PCM-16
2006/09/26 19:40:07.174	  1:02.628	    Media Patch:858ac00	RTP	Jitter buffer created: size=51 delay=160-2000/160 (20ms) obj=0x8532688
2006/09/26 19:40:07.176	  1:02.630	     RTP Jitter:8532688	RTP	Jitter RTP receive thread started: 0x8532688
2006/09/26 19:40:07.176	  1:02.630	  GMURLHandler:08601f00	Media	Starting thread Media Patch:858ac00
2006/09/26 19:40:07.176	  1:02.630	  GMURLHandler:08601f00	OpalCon	Media stream threads started.
2006/09/26 19:40:07.176	  1:02.630	  GMURLHandler:08601f00	OpalCon	Media stream threads started.
2006/09/26 19:40:07.177	  1:02.631	  GMURLHandler:08601f00	GMPCSSEndpoint	 PCSS connection established
2006/09/26 19:40:07.177	  1:02.631	  GMURLHandler:08601f00	GMManager	 Will establish the connection
2006/09/26 19:40:07.177	  1:02.631	  GMURLHandler:08601f00	OpalMan	OnEstablished Call[2]-EP<pc>[Default]
2006/09/26 19:40:07.177	  1:02.631	  GMURLHandler:08601f00	Call	OnEstablished Call[2]-EP<pc>[Default]
2006/09/26 19:40:07.210	  1:02.664	    Media Patch:852e930	RTP	First sent data: ver=2 pt=PCMU psz=160 m=1 x=0 seq=10863 ts=0 src=1085040347 ccnt=0
2006/09/26 19:40:07.492	  1:02.946	     RTP Jitter:8532688	RTP	First receive data: ver=2 pt=PCMU psz=160 m=1 x=0 seq=4223 ts=1042974671 src=142009376 ccnt=0
2006/09/26 19:40:07.493	  1:02.947	     RTP Jitter:8532688	RTP	Received start of talk burst: 1042974671
2006/09/26 19:40:07.602	  1:03.056	            Housekeeper	SIP	Set state Terminated_Success for transaction 4 REGISTER
2006/09/26 19:40:08.502	  1:03.956	    Media Patch:858ac00	RTP	Jitter buffer target size decreased to 160 (20ms)
2006/09/26 19:40:09.284	  1:04.738	    Media Patch:852e930	RTP	Transmit statistics:  packets=101 octets=16160 avgTime=20 maxTime=44 minTime=15
2006/09/26 19:40:09.493	  1:04.947	     RTP Jitter:8532688	RTP	Receive statistics:  packets=101 octets=16160 lost=0 tooLate=0 order=0 avgTime=20 maxTime=21 minTime=19 jitter=0 maxJitter=1
2006/09/26 19:40:11.284	  1:06.738	    Media Patch:852e930	RTP	Transmit statistics:  packets=201 octets=32160 avgTime=20 maxTime=23 minTime=17
2006/09/26 19:40:11.492	  1:06.946	     RTP Jitter:8532688	RTP	Receive statistics:  packets=201 octets=32160 lost=0 tooLate=0 order=0 avgTime=19 maxTime=23 minTime=18 jitter=1 maxJitter=2
2006/09/26 19:40:13.463	  1:08.917	    Media Patch:852e930	RTP	Transmit statistics:  packets=301 octets=48160 avgTime=21 maxTime=44 minTime=19
2006/09/26 19:40:16.223	  1:11.677	    Media Patch:852e930	RTP	Transmit statistics:  packets=401 octets=64160 avgTime=27 maxTime=46 minTime=22
2006/09/26 19:40:18.425	  1:13.879	    Media Patch:852e930	RTP	SentSenderReport:  ssrc=1085040347 ntp=3368302818.1826289728 rtp=76800 psent=481 osent=76960
2006/09/26 19:40:18.425	  1:13.879	    Media Patch:852e930	RTP	SentReceiverReport: ssrc=142009376 fraction=0 lost=0 last_seq=0 jitter=10 lsr=0 dlsr=0
2006/09/26 19:40:18.425	  1:13.879	    Media Patch:852e930	RTP	Sending SDES: jconte@peregrine
2006/09/26 19:40:18.963	  1:14.417	    Media Patch:852e930	RTP	Transmit statistics:  packets=501 octets=80160 avgTime=27 maxTime=46 minTime=22
2006/09/26 19:40:21.723	  1:17.177	    Media Patch:852e930	RTP	Transmit statistics:  packets=601 octets=96160 avgTime=27 maxTime=45 minTime=23
2006/09/26 19:40:24.464	  1:19.918	    Media Patch:852e930	RTP	Transmit statistics:  packets=701 octets=112160 avgTime=27 maxTime=45 minTime=23
2006/09/26 19:40:27.223	  1:22.678	    Media Patch:852e930	RTP	Transmit statistics:  packets=801 octets=128160 avgTime=27 maxTime=44 minTime=23
2006/09/26 19:40:27.924	  1:23.378	    Media Patch:852e930	RTP	SentSenderReport:  ssrc=1085040347 ntp=3368302827.3968119752 rtp=132000 psent=826 osent=132160
2006/09/26 19:40:27.924	  1:23.378	    Media Patch:852e930	RTP	SentReceiverReport: ssrc=142009376 fraction=0 lost=0 last_seq=4488 jitter=10 lsr=0 dlsr=0
2006/09/26 19:40:27.924	  1:23.378	    Media Patch:852e930	RTP	Sending SDES: jconte@peregrine
2006/09/26 19:40:29.984	  1:25.438	    Media Patch:852e930	RTP	Transmit statistics:  packets=901 octets=144160 avgTime=27 maxTime=44 minTime=23
2006/09/26 19:40:32.724	  1:28.178	    Media Patch:852e930	RTP	Transmit statistics:  packets=1001 octets=160160 avgTime=27 maxTime=45 minTime=23
2006/09/26 19:40:35.484	  1:30.938	    Media Patch:852e930	RTP	Transmit statistics:  packets=1101 octets=176160 avgTime=27 maxTime=45 minTime=23
2006/09/26 19:40:36.416	  1:31.870	            Housekeeper	SIP	Starting REGISTER/SUBSCRIBE for binding refresh
2006/09/26 19:40:36.416	  1:31.870	            Housekeeper	Opal	Transport clean up on termination
2006/09/26 19:40:36.417	  1:31.871	            Housekeeper	OpalUDP	Close
2006/09/26 19:40:36.417	  1:31.871	            Housekeeper	Opal	Transport Close
2006/09/26 19:40:36.417	  1:31.871	  SIP Transport:85b62a8	SIP	Read thread finished.
2006/09/26 19:40:36.418	  1:31.872	            Housekeeper	OpalUDP	Binding to interface: 192.168.1.117:32789
2006/09/26 19:40:36.418	  1:31.872	            Housekeeper	SIP	Created transport udp$0.0.0.0<if=udp$192.168.1.117:32789>
2006/09/26 19:40:36.418	  1:31.872	            Housekeeper	OpalUDP	Started connect to 147.135.4.128:5060
2006/09/26 19:40:36.419	  1:31.873	            Housekeeper	OpalUDP	Connect on pre-bound interface: 192.168.1.117
2006/09/26 19:40:36.419	  1:31.873	            Housekeeper	SIP	Created Transport for Registrar udp$147.135.4.128:5060<if=udp$192.168.1.117:5066>
2006/09/26 19:40:36.419	  1:31.873	            Housekeeper	SIP	Transaction 4 REGISTER destroyed.
2006/09/26 19:40:36.422	  1:31.876	            Housekeeper	SIP	Sending PDU on udp$147.135.4.128:5060<if=udp$192.168.1.117:5066>
REGISTER sip:sip.broadvoice.com SIP/2.0
CSeq: 5 REGISTER
Via: SIP/2.0/UDP 192.168.1.117:5066;branch=z9hG4bK4431eb13-264c-db11-9002-000d60f993e4;rport
User-Agent: Ekiga/2.0.3
From: <sip:8136426683@sip.broadvoice.com>;tag=d824eb13-264c-db11-9002-000d60f993e4
Call-ID: bef503e0-254c-db11-9002-000d60f993e4@peregrine
To: <sip:8136426683@sip.broadvoice.com>
Contact: <sip:8136426683@192.168.1.117:5066;transport=udp>
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,NOTIFY,REFER,MESSAGE
Expires: 30
Content-Length: 0
Max-Forwards: 70


2006/09/26 19:40:36.423	  1:31.877	  SIP Transport:85b62a8	SIP	Read thread started.
2006/09/26 19:40:36.423	  1:31.877	  SIP Transport:85b62a8	SIP	Waiting for PDU on udp$147.135.4.128:5060<if=udp$192.168.1.117:5066>
2006/09/26 19:40:36.438	  1:31.892	  SIP Transport:85b62a8	SIP	PDU Received on udp$147.135.4.128:5060<if=udp$192.168.1.117:5066>
SIP/2.0 200 OK
CSeq: 5 REGISTER
Via: SIP/2.0/UDP 192.168.1.117:5066;branch=z9hG4bK4431eb13-264c-db11-9002-000d60f993e4;received=208.118.38.97;rport=5066
User-Agent: Ekiga/2.0.3
From: <sip:8136426683@sip.broadvoice.com>;tag=d824eb13-264c-db11-9002-000d60f993e4
Call-ID: bef503e0-254c-db11-9002-000d60f993e4@peregrine
To: <sip:8136426683@sip.broadvoice.com>
Contact: <sip:8136426683@192.168.1.117:5066>
Expires: 30
Content-Length: 0


2006/09/26 19:40:36.439	  1:31.893	  SIP Transport:85b62a8	SIP	Transaction 5 REGISTER completed.
2006/09/26 19:40:36.439	  1:31.893	  SIP Transport:85b62a8	OpalUDP	Ended connect, selecting 192.168.1.117:5066
2006/09/26 19:40:36.446	  1:31.900	  SIP Transport:85b62a8	SIP	Waiting for PDU on udp$147.135.4.128:5060<if=udp$192.168.1.117:5066>
2006/09/26 19:40:37.448	  1:32.902	            Housekeeper	SIP	Set state Terminated_Success for transaction 5 REGISTER
2006/09/26 19:40:38.244	  1:33.699	    Media Patch:852e930	RTP	Transmit statistics:  packets=1201 octets=192160 avgTime=27 maxTime=45 minTime=22
2006/09/26 19:40:40.377	  1:35.831	    Media Patch:852e930	RTP	SentSenderReport:  ssrc=1085040347 ntp=3368302840.1619091346 rtp=204480 psent=1279 osent=204640
2006/09/26 19:40:40.377	  1:35.831	    Media Patch:852e930	RTP	SentReceiverReport: ssrc=142009376 fraction=0 lost=0 last_seq=4488 jitter=10 lsr=0 dlsr=0
2006/09/26 19:40:40.377	  1:35.831	    Media Patch:852e930	RTP	Sending SDES: jconte@peregrine
2006/09/26 19:40:40.984	  1:36.438	    Media Patch:852e930	RTP	Transmit statistics:  packets=1301 octets=208160 avgTime=27 maxTime=45 minTime=22
2006/09/26 19:40:42.409	  1:37.863	            Housekeeper	OpalCon	Releasing Call[2]-EP<sip>[1e01a9-1e@147.135.4.128]
2006/09/26 19:40:42.409	  1:37.863	            Housekeeper	OpalCon	Call end reason for 1e01a9-1e@147.135.4.128 set to EndedByNoAnswer
2006/09/26 19:40:42.409	  1:37.863	            Housekeeper	OpalCon	SetPhase from ConnectedPhase to ReleasingPhase
2006/09/26 19:40:42.410	  1:37.864	      OnRelease:852fc18	SIP	OnReleased: Call[2]-EP<sip>[1e01a9-1e@147.135.4.128], phase = ReleasingPhase
2006/09/26 19:40:42.410	  1:37.864	      OnRelease:852fc18	OpalCon	SetPhase from ReleasingPhase to ReleasingPhase
2006/09/26 19:40:42.411	  1:37.865	      OnRelease:852fc18	SIP	Sending PDU on udp$147.135.4.128:5060<if=udp$192.168.1.117:5064>
SIP/2.0 502 Bad Gateway
CSeq: 1 INVITE
Via: SIP/2.0/UDP 147.135.4.128:5060
From: "Conte Steve C"<sip:8138851503@147.135.4.128;user=phone>;tag=hjkl
Call-ID: 1e01a9-1e@147.135.4.128
To: "Jonathon Conte"<sip:8136426683@192.168.1.117;user=phone>;tag=5c6f8efc-254c-db11-9002-000d60f993e4
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,NOTIFY,REFER,MESSAGE
Content-Length: 0


2006/09/26 19:40:42.421	  1:37.876	      OnRelease:852fc18	Media	Closing RTP for OpalRTPMediaStream-Sink-G.711-uLaw-64k
2006/09/26 19:40:42.422	  1:37.876	      OnRelease:852fc18	RTP_UDP	Session 1, Shutting down write.
2006/09/26 19:40:42.422	  1:37.876	      OnRelease:852fc18	Media	Closing stream OpalRTPMediaStream-Sink-G.711-uLaw-64k
2006/09/26 19:40:42.422	  1:37.876	      OnRelease:852fc18	Media	Disconnecting OpalRTPMediaStream-Sink-G.711-uLaw-64k from patch thread Patch OpalAudioMediaStream-Source-PCM-16
2006/09/26 19:40:42.444	  1:37.898	    Media Patch:852e930	RTP_UDP	Session 1, Write shutdown.
2006/09/26 19:40:42.444	  1:37.899	      OnRelease:852fc18	Patch	Removing media stream sink OpalRTPMediaStream-Sink-G.711-uLaw-64k
2006/09/26 19:40:42.455	  1:37.909	      OnRelease:852fc18	Media	Closing RTP for OpalRTPMediaStream-Source-G.711-uLaw-64k
2006/09/26 19:40:42.455	  1:37.909	      OnRelease:852fc18	RTP_UDP	Session 1, Shutting down read.
2006/09/26 19:40:42.455	  1:37.909	     RTP Jitter:8532688	RTP_UDP	Session 1, Read shutdown.
2006/09/26 19:40:42.456	  1:37.910	     RTP Jitter:8532688	RTP	Jitter RTP receive thread ended
2006/09/26 19:40:42.456	  1:37.910	      OnRelease:852fc18	Media	Closing stream OpalRTPMediaStream-Source-G.711-uLaw-64k
2006/09/26 19:40:42.456	  1:37.910	      OnRelease:852fc18	Media	Disconnecting OpalRTPMediaStream-Source-G.711-uLaw-64k from patch thread Patch OpalRTPMediaStream-Source-G.711-uLaw-64k -> OpalAudioMediaStream-Sink-PCM-16
2006/09/26 19:40:42.457	  1:37.911	      OnRelease:852fc18	Patch	Closing media patch Patch OpalRTPMediaStream-Source-G.711-uLaw-64k -> OpalAudioMediaStream-Sink-PCM-16
2006/09/26 19:40:42.457	  1:37.911	      OnRelease:852fc18	Media	Closing RTP for OpalRTPMediaStream-Source-G.711-uLaw-64k
2006/09/26 19:40:42.457	  1:37.911	      OnRelease:852fc18	RTP_UDP	Session 1, Shutting down read.
2006/09/26 19:40:42.457	  1:37.911	      OnRelease:852fc18	Media	Closing stream OpalRTPMediaStream-Source-G.711-uLaw-64k
2006/09/26 19:40:42.458	  1:37.912	      OnRelease:852fc18	Patch	Removing media stream sink OpalAudioMediaStream-Sink-PCM-16
2006/09/26 19:40:42.458	  1:37.912	      OnRelease:852fc18	Patch	Waiting for media patch thread to stop Patch OpalRTPMediaStream-Source-G.711-uLaw-64k
2006/09/26 19:40:42.460	  1:37.914	    Media Patch:858ac00	Patch	Thread ended for Patch OpalRTPMediaStream-Source-G.711-uLaw-64k
2006/09/26 19:40:42.469	  1:37.923	      OnRelease:852fc18	Patch	Media patch thread Patch OpalRTPMediaStream-Source-G.711-uLaw-64k destroyed.
2006/09/26 19:40:42.469	  1:37.923	      OnRelease:852fc18	OpalCon	Media stream threads closed.
2006/09/26 19:40:42.469	  1:37.923	      OnRelease:852fc18	OpalCon	SetPhase from ReleasingPhase to ReleasedPhase
2006/09/26 19:40:42.469	  1:37.923	    SIP Handler:8577348	SIP	PDU handler thread finished.
2006/09/26 19:40:42.476	  1:37.930	    Media Patch:852e930	Patch	Thread ended for Patch OpalAudioMediaStream-Source-PCM-16
2006/09/26 19:40:42.481	  1:37.935	      OnRelease:852fc18	Opal	Transport clean up on termination
2006/09/26 19:40:42.481	  1:37.935	      OnRelease:852fc18	OpalUDP	Close
2006/09/26 19:40:42.481	  1:37.935	  SIP Transport:8534420	OpalUDP	Error on connection read select.
2006/09/26 19:40:42.481	  1:37.935	  SIP Transport:8534420	SIP	Read thread finished.
2006/09/26 19:40:42.481	  1:37.935	      OnRelease:852fc18	OpalCon	OnReleased Call[2]-EP<sip>[1e01a9-1e@147.135.4.128]
2006/09/26 19:40:42.481	  1:37.936	      OnRelease:852fc18	OpalCon	Media stream threads closed.
2006/09/26 19:40:42.482	  1:37.936	      OnRelease:852fc18	GMSIPEndpoint	 SIP connection released
2006/09/26 19:40:42.482	  1:37.936	      OnRelease:852fc18	OpalEP	OnReleased Call[2]-EP<sip>[1e01a9-1e@147.135.4.128]
2006/09/26 19:40:42.501	  1:37.955	      OnRelease:852fc18	GMManager	 Will release the connection
2006/09/26 19:40:42.502	  1:37.956	      OnRelease:852fc18	OpalMan	OnReleased Call[2]-EP<sip>[1e01a9-1e@147.135.4.128]
2006/09/26 19:40:42.502	  1:37.956	      OnRelease:852fc18	Call	OnReleased Call[2]-EP<sip>[1e01a9-1e@147.135.4.128]
2006/09/26 19:40:42.502	  1:37.956	      OnRelease:852fc18	OpalCon	Releasing Call[2]-EP<pc>[Default]
2006/09/26 19:40:42.502	  1:37.956	      OnRelease:852fc18	OpalCon	Call end reason for Default set to EndedByNoAnswer
2006/09/26 19:40:42.502	  1:37.956	      OnRelease:852fc18	OpalCon	SetPhase from EstablishedPhase to ReleasingPhase
2006/09/26 19:40:42.503	  1:37.957	      OnRelease:852fc18	OpalCon	OnRelease thread completed for 1e01a9-1e@147.135.4.128
2006/09/26 19:40:42.526	  1:37.980	      OnRelease:8601b00	OpalCon	OnReleased Call[2]-EP<pc>[Default]
2006/09/26 19:40:42.526	  1:37.980	      OnRelease:8601b00	Media	Closing raw media stream OpalAudioMediaStream-Source-PCM-16
2006/09/26 19:40:42.526	  1:37.980	      OnRelease:8601b00	Media	Closing stream OpalAudioMediaStream-Source-PCM-16
2006/09/26 19:40:42.527	  1:37.981	      OnRelease:8601b00	Media	Disconnecting OpalAudioMediaStream-Source-PCM-16 from patch thread Patch OpalAudioMediaStream-Source-PCM-16
2006/09/26 19:40:42.527	  1:37.981	      OnRelease:8601b00	Patch	Closing media patch Patch OpalAudioMediaStream-Source-PCM-16
2006/09/26 19:40:42.527	  1:37.981	      OnRelease:8601b00	Media	Closing raw media stream OpalAudioMediaStream-Source-PCM-16
2006/09/26 19:40:42.527	  1:37.981	      OnRelease:8601b00	Media	Closing stream OpalAudioMediaStream-Source-PCM-16
2006/09/26 19:40:42.527	  1:37.981	      OnRelease:8601b00	Patch	Waiting for media patch thread to stop Patch OpalAudioMediaStream-Source-PCM-16
2006/09/26 19:40:42.528	  1:37.982	      OnRelease:8601b00	Patch	Media patch thread Patch OpalAudioMediaStream-Source-PCM-16 destroyed.
2006/09/26 19:40:42.528	  1:37.982	      OnRelease:8601b00	Media	Closing raw media stream OpalAudioMediaStream-Sink-PCM-16
2006/09/26 19:40:42.529	  1:37.983	      OnRelease:8601b00	Media	Closing stream OpalAudioMediaStream-Sink-PCM-16
2006/09/26 19:40:42.529	  1:37.983	      OnRelease:8601b00	OpalCon	Media stream threads closed.
2006/09/26 19:40:42.549	  1:38.005	      OnRelease:8601b00	GMPCSSEndpoint	 PCSS connection released
2006/09/26 19:40:42.553	  1:38.007	      OnRelease:8601b00	OpalEP	OnReleased Call[2]-EP<pc>[Default]
2006/09/26 19:40:42.554	  1:38.008	      OnRelease:8601b00	GMManager	 Will release the connection
2006/09/26 19:40:42.554	  1:38.008	      OnRelease:8601b00	OpalMan	OnReleased Call[2]-EP<pc>[Default]
2006/09/26 19:40:42.554	  1:38.008	      OnRelease:8601b00	Call	OnReleased Call[2]-EP<pc>[Default]
2006/09/26 19:40:43.412	  1:38.866	            OpalGarbage	Opal	Transport clean up on termination
2006/09/26 19:40:43.412	  1:38.866	            OpalGarbage	OpalUDP	Close
2006/09/26 19:40:43.412	  1:38.866	            OpalGarbage	SIP	Deleted connection.
2006/09/26 19:40:43.413	  1:38.867	            OpalGarbage	OpalCon	Connection Call[2]-EP<sip>[1e01a9-1e@147.135.4.128] destroyed.
2006/09/26 19:40:43.413	  1:38.867	            OpalGarbage	RTP_UDP	Session 1, Shutting down write.
2006/09/26 19:40:43.413	  1:38.867	            OpalGarbage	RTP	Final statistics:
    packetsSent       = 1352
    octetsSent        = 216320
    averageSendTime   = 27
    maximumSendTime   = 45
    minimumSendTime   = 22
    packetsReceived   = 265
    octetsReceived    = 42400
    packetsLost       = 0
    packetsTooLate    = 0
    packetsOutOfOrder = 0
    averageReceiveTime= 19
    maximumReceiveTime= 23
    minimumReceiveTime= 18
    averageJitter     = 1
    maximumJitter     = 2
2006/09/26 19:40:43.413	  1:38.867	            OpalGarbage	RTP	Removing jitter buffer 0x8532688 RTP Jitter:8532688
2006/09/26 19:40:44.361	  1:39.815	      OnRelease:8601b00	OpalCon	OnRelease thread completed for Default
2006/09/26 19:40:44.416	  1:39.870	            OpalGarbage	PCSS	Deleted PC sound system connection.
2006/09/26 19:40:44.416	  1:39.870	            OpalGarbage	OpalCon	Connection Call[2]-EP<pc>[Default] destroyed.
2006/09/26 19:40:45.420	  1:40.874	            OpalGarbage	Call	Call[2] destroyed.
2006/09/26 19:41:06.023	  2:01.477	            Housekeeper	Ekiga	IP Address changed, updating listeners.
2006/09/26 19:41:06.418	  2:01.872	            Housekeeper	SIP	Starting REGISTER/SUBSCRIBE for binding refresh
2006/09/26 19:41:06.418	  2:01.872	            Housekeeper	Opal	Transport clean up on termination
2006/09/26 19:41:06.418	  2:01.872	            Housekeeper	OpalUDP	Close
2006/09/26 19:41:06.418	  2:01.872	            Housekeeper	Opal	Transport Close
2006/09/26 19:41:06.418	  2:01.872	  SIP Transport:85b62a8	SIP	Read thread finished.
2006/09/26 19:41:06.419	  2:01.873	            Housekeeper	OpalUDP	Binding to interface: 192.168.1.117:0
2006/09/26 19:41:06.419	  2:01.873	            Housekeeper	SIP	Created transport udp$0.0.0.0<if=udp$192.168.1.117>
2006/09/26 19:41:06.419	  2:01.874	            Housekeeper	OpalUDP	Started connect to 147.135.4.128:5060
2006/09/26 19:41:06.420	  2:01.874	            Housekeeper	OpalUDP	Connect on pre-bound interface: 192.168.1.117
2006/09/26 19:41:06.421	  2:01.875	            Housekeeper	OpalUDP	Could not bind to any port in range 5060 to 5100
2006/09/26 19:41:06.421	  2:01.875	            Housekeeper	SIP	Could not connect to udp$147.135.4.128:5060 - 
2006/09/26 19:41:06.421	  2:01.875	            Housekeeper	Opal	Transport clean up on termination
2006/09/26 19:41:06.421	  2:01.875	            Housekeeper	OpalUDP	Close
2006/09/26 19:41:06.421	  2:01.875	            Housekeeper	Opal	Transport Close
2006/09/26 19:41:06.422	  2:01.876	            Housekeeper	SIP	Unable to create transport for registrar
2006/09/26 19:41:06.423	  2:01.877	            Housekeeper	SIP	Could not start REGISTER/SUBSCRIBE for binding refresh: Transport creation failed
2006/09/26 19:41:36.443	  2:31.897	            Housekeeper	SIP	Transaction 5 REGISTER destroyed.
2006/09/26 19:42:29.879	  3:25.333	                  ekiga	Listen	Stopping listening thread on tcp$192.168.1.117:1720
2006/09/26 19:42:29.879	  3:25.333	                  ekiga	H323	Deleted endpoint.
2006/09/26 19:42:29.879	  3:25.333	                  ekiga	OpalEP	h323 endpoint destroyed.
2006/09/26 19:42:29.880	  3:25.334	                  ekiga	Listen	Stopping listening thread on udp$192.168.1.117:5060
2006/09/26 19:42:29.880	  3:25.334	  Opal Listener:8346258	Listen	UDP select error: Interrupted system call
2006/09/26 19:42:29.880	  3:25.334	                  ekiga	SIP	Transaction 2 SUBSCRIBE destroyed.
2006/09/26 19:42:29.880	  3:25.334	                  ekiga	Opal	Transport clean up on termination
2006/09/26 19:42:29.881	  3:25.335	                  ekiga	OpalUDP	Close
2006/09/26 19:42:29.881	  3:25.335	  SIP Transport:852c798	OpalUDP	Error on connection read select.
2006/09/26 19:42:29.881	  3:25.335	  SIP Transport:852c798	SIP	Read thread finished.
2006/09/26 19:42:29.891	  3:25.345	                  ekiga	SIP	Deleted endpoint.
2006/09/26 19:42:29.891	  3:25.345	                  ekiga	OpalEP	sip endpoint destroyed.
2006/09/26 19:42:29.891	  3:25.345	                  ekiga	PCSS	Deleted PC sound system endpoint.
2006/09/26 19:42:29.891	  3:25.345	                  ekiga	OpalEP	pc endpoint destroyed.
2006/09/26 19:42:29.892	  3:25.346	                  ekiga	OpalMan	Deleted manager.