[Ekiga-list] Can't establish conncection with my friend ekiga net



Hi,

I'm trying to establish connection with my friend, but
every time I call him, the connection can't be established.

I attach the output.txt file for debugging, if this is a bug.

-- 
Regards, Paul Chany
        dyna.cxx(128)		DYNA	Error loading libavcodec.so - libavcodec.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(128)		DYNA	Error loading `�A/libavcodec.so - `�A/libavcodec.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(128)		DYNA	Error loading ./libavcodec.so - ./libavcodec.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(128)		DYNA	Error loading /usr/local/lib/libavcodec.so - /usr/local/lib/libavcodec.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(128)		DYNA	Error loading avcodec-51.so - avcodec-51.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(128)		DYNA	Error loading `�A/avcodec-51.so - `�A/avcodec-51.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(128)		DYNA	Error loading ./avcodec-51.so - ./avcodec-51.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(128)		DYNA	Error loading /usr/local/lib/avcodec-51.so - /usr/local/lib/avcodec-51.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(128)		DYNA	Error loading avcodec-52.so - avcodec-52.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(128)		DYNA	Error loading `�A/avcodec-52.so - `�A/avcodec-52.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(128)		DYNA	Error loading ./avcodec-52.so - ./avcodec-52.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(128)		DYNA	Error loading /usr/local/lib/avcodec-52.so - /usr/local/lib/avcodec-52.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(221)	MPEG4	DYNA	Failed to load FFMPEG libavcodec library
       mpeg4.cxx(1978)	MPEG4	Codec	Disabled
        dyna.cxx(128)		DYNA	Error loading libavcodec.so - libavcodec.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(128)		DYNA	Error loading �/libavcodec.so - �/libavcodec.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(128)		DYNA	Error loading ./libavcodec.so - ./libavcodec.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(128)		DYNA	Error loading /usr/local/lib/libavcodec.so - /usr/local/lib/libavcodec.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(128)		DYNA	Error loading avcodec-51.so - avcodec-51.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(128)		DYNA	Error loading �/avcodec-51.so - �/avcodec-51.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(128)		DYNA	Error loading ./avcodec-51.so - ./avcodec-51.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(128)		DYNA	Error loading /usr/local/lib/avcodec-51.so - /usr/local/lib/avcodec-51.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(128)		DYNA	Error loading avcodec-52.so - avcodec-52.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(128)		DYNA	Error loading �/avcodec-52.so - �/avcodec-52.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(128)		DYNA	Error loading ./avcodec-52.so - ./avcodec-52.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(128)		DYNA	Error loading /usr/local/lib/avcodec-52.so - /usr/local/lib/avcodec-52.so: nem nyitható meg a megosztott objektumfájl: Nincs ilyen fájl vagy könyvtár
        dyna.cxx(221)	H263+	DYNA	Failed to load FFMPEG libavcodec library
   h263-1998.cxx(2087)	H.263	Codec	Disabled
2010/11/04 21:33:48.131	  0:00.040	                       		Version 3.2.7 by  on Unix Linux (2.6.32-5-amd64-x86_64) with PTLib (v2.6.7) at 2010/11/4 21:33:48.131
2010/11/04 21:33:48.131	  0:00.040	                       	Ekiga git revision: unknown
2010/11/04 21:33:48.132	  0:00.040	                       	Ekiga registered on D-Bus: org.ekiga.Ekiga
2010/11/04 21:33:48.132	  0:00.041	                       	PWLib	File handle high water mark set: 17 Thread unblock pipe
2010/11/04 21:33:48.132	  0:00.041	                       	PTLib	No permission to set priority level 4
2010/11/04 21:33:48.132	  0:00.041	                       	PTLib	Thread high water mark set: 2
2010/11/04 21:33:48.132	  0:00.041	                       	PWLib	File handle high water mark set: 19 Thread unblock pipe
2010/11/04 21:33:48.132	  0:00.041	                       	PTLib	No permission to set priority level 4
2010/11/04 21:33:48.132	  0:00.041	                       	PTLib	Thread high water mark set: 3
2010/11/04 21:33:48.132	  0:00.041	                       	PWLib	File handle high water mark set: 21 Thread unblock pipe
2010/11/04 21:33:48.133	  0:00.042	                       	PWLib	File handle high water mark set: 23 Thread unblock pipe
2010/11/04 21:33:48.134	  0:00.043	                       	PTLib	No permission to set priority level 4
2010/11/04 21:33:48.134	  0:00.043	                       	PTLib	Thread high water mark set: 4
2010/11/04 21:33:48.134	  0:00.043	                       	HalManager_dbus	Initialising HAL Manager
2010/11/04 21:33:48.135	  0:00.044	                       	HalManager_dbus	Populating device list
2010/11/04 21:33:48.142	  0:00.051	                       	HalManager_dbus	Detected V4L capabilities on /dev/video0 name: CIF Single Chip     
2010/11/04 21:33:48.142	  0:00.051	                       	HalManager_dbus	Detected V4L2 capabilities on /dev/video0 name: CIF Single Chip     
2010/11/04 21:33:48.198	  0:00.107	                       	HalManager_dbus	Populated device list with 14 devices
2010/11/04 21:33:48.198	  0:00.107	                       	HalManager_dbus	Populating interface list
2010/11/04 21:33:48.199	  0:00.107	                       	HalManager_dbus	Populating full interface list failed - The name org.freedesktop.NetworkManager was not provided by any .service files
2010/11/04 21:33:48.211	  0:00.120	                       	Detecting V4L2 devices
2010/11/04 21:33:48.211	  0:00.120	                       	PV4L2Plugin	detected device metadata at /sys/class/video4linux/
2010/11/04 21:33:48.223	  0:00.132	                       	PWLib	File handle high water mark set: 28 Thread unblock pipe
2010/11/04 21:33:48.224	  0:00.132	                       	PTLib	Thread high water mark set: 5
2010/11/04 21:33:48.224	  0:00.132	                       	OpalMan	Created manager.
2010/11/04 21:33:48.224	  0:00.133	                       	OpalMan	Attached endpoint with prefix pc
2010/11/04 21:33:48.224	  0:00.133	                       	OpalEP	Created endpoint: pc
2010/11/04 21:33:48.274	  0:00.183	                       	PCSS	Created PC sound system endpoint.
Players:
Default
EKIGA
HDA NVidia
HDA NVidia (1)
*.wav
/dev/dsp
Recorders:
Default
EKIGA
HDA NVidia
HDA NVidia (1)
HDA NVidia (2)
*.wav
/dev/dsp

2010/11/04 21:33:48.274	  0:00.183	                       	OPAL	SetMediaFormatOrder()
2010/11/04 21:33:48.274	  0:00.183	                       	OPAL	SetMediaFormatMask()
2010/11/04 21:33:48.275	  0:00.184	                       	OpalMan	Attached endpoint with prefix sip
2010/11/04 21:33:48.275	  0:00.184	                       	OpalEP	Created endpoint: sip
2010/11/04 21:33:48.275	  0:00.184	                       	PWLib	File handle high water mark set: 29 PUDPSocket
2010/11/04 21:33:48.275	  0:00.184	                       	IfaceMon	Initial interface list:
127.0.0.1 [00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:01] <00-00-00-00-00-00> (lo)
192.168.10.77 [fe:80:00:00:00:00:00:00:02:1a:92:ff:fe:ce:61:70] <00-1A-92-CE-61-70> (eth0)

2010/11/04 21:33:48.275	  0:00.184	                       	PWLib	File handle high water mark set: 30 Thread unblock pipe
2010/11/04 21:33:48.275	  0:00.184	                       	PTLib	Thread high water mark set: 6
2010/11/04 21:33:48.275	  0:00.184	Network In...0xdb1fb710	IfaceMon	Started interface monitor thread.
2010/11/04 21:33:48.275	  0:00.184	                       	PWLib	File handle high water mark set: 32 Thread unblock pipe
2010/11/04 21:33:48.275	  0:00.184	Network In...0xdb1fb710	PWLib	File handle high water mark set: 33 PUDPSocket
2010/11/04 21:33:48.275	  0:00.184	                       	PTLib	Thread high water mark set: 7
2010/11/04 21:33:48.276	  0:00.184	                       	OpalMan	Attached endpoint with prefix sips
2010/11/04 21:33:48.276	  0:00.184	                       	SIP	Created endpoint.
2010/11/04 21:33:48.276	  0:00.185	                       	MonSock	Created socket bundle for all interfaces.
2010/11/04 21:33:48.276	  0:00.185	                       	PWLib	File handle high water mark set: 34 PUDPSocket
2010/11/04 21:33:48.276	  0:00.185	                       	MonSock	Created bundled UDP socket 192.168.10.77:5060
2010/11/04 21:33:48.276	  0:00.185	                       	PWLib	File handle high water mark set: 36 Thread unblock pipe
2010/11/04 21:33:48.276	  0:00.185	                       	PTLib	Thread high water mark set: 8
2010/11/04 21:33:48.276	  0:00.185	                       	PTLib	No permission to set priority level 4
2010/11/04 21:33:48.276	  0:00.185	Opal Liste...0xc8071710	Listen	Started listening thread on udp$*:5060
2010/11/04 21:33:48.276	  0:00.185	                       	OpalMan	Added route "sip:.*=pc:*"
2010/11/04 21:33:48.276	  0:00.185	                       	OpalMan	Added route "pc:.*=sip:<da>"
2010/11/04 21:33:48.277	  0:00.186	                       	OpalMan	Attached endpoint with prefix h323
2010/11/04 21:33:48.277	  0:00.186	                       	OpalEP	Created endpoint: h323
2010/11/04 21:33:48.277	  0:00.186	                       	OpalMan	Attached endpoint with prefix h323s
2010/11/04 21:33:48.277	  0:00.186	                       	H323	Created endpoint.
2010/11/04 21:33:48.277	  0:00.186	                       	PWLib	File handle high water mark set: 37 PTCPSocket
2010/11/04 21:33:48.277	  0:00.186	                       	PWLib	File handle high water mark set: 39 Thread unblock pipe
2010/11/04 21:33:48.277	  0:00.186	                       	PTLib	Thread high water mark set: 9
2010/11/04 21:33:48.277	  0:00.186	                       	OpalMan	Added route "h323:.*=pc:<db>"
2010/11/04 21:33:48.277	  0:00.186	Opal Liste...0xc3fff710	Listen	Started listening thread on tcp$*:1720
2010/11/04 21:33:48.277	  0:00.186	                       	OpalMan	Added route "pc:.*=h323:<da>"
2010/11/04 21:33:48.277	  0:00.186	Opal Liste...0xc3fff710	Listen	Waiting on socket accept on tcp$*:1720
2010/11/04 21:33:48.285	  0:00.194	                       	MediaFormat	Removing codecs G.711-ALaw-64k,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,H.261,H.261-CIF,H.261-QCIF
2010/11/04 21:33:48.285	  0:00.194	                       	OPAL	SetMediaFormatMask(PCM-16-48kHz,CELT-48K,PCM-16-32kHz,CELT-32K,PCM-16-16kHz,G.722-64k,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,PCM-16,G.711-uLaw-64k,G.726-16k,G.726-24k,G.726-32k,G.726-40k,GSM-06.10,GSM-AMR,LPC-10,MS-GSM,MS-IMA-ADPCM,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,YUV420P,RFC4175_YCbCr-4:2:0,theora,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz)
2010/11/04 21:33:48.285	  0:00.194	                       	OPAL	SetMediaFormatOrder(G.711-ALaw-64k,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,H.261,H.261-CIF,H.261-QCIF)
2010/11/04 21:33:48.292	  0:00.201	                       	MediaFormat	Removing codecs G.711-ALaw-64k,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,H.261,H.261-CIF,H.261-QCIF
2010/11/04 21:33:48.292	  0:00.201	                       	OPAL	SetMediaFormatMask(PCM-16-48kHz,CELT-48K,PCM-16-32kHz,CELT-32K,PCM-16-16kHz,G.722-64k,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,PCM-16,G.711-uLaw-64k,G.726-16k,G.726-24k,G.726-32k,G.726-40k,GSM-06.10,GSM-AMR,LPC-10,MS-GSM,MS-IMA-ADPCM,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,YUV420P,RFC4175_YCbCr-4:2:0,theora,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz)
2010/11/04 21:33:48.292	  0:00.201	                       	OPAL	SetMediaFormatOrder(G.711-ALaw-64k,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,H.261,H.261-CIF,H.261-QCIF)
2010/11/04 21:33:48.303	  0:00.212	                       	PWLib	File handle high water mark set: 41 Thread unblock pipe
2010/11/04 21:33:48.303	  0:00.212	                       	PTLib	Thread high water mark set: 10
2010/11/04 21:33:48.303	  0:00.212	StunDetector:0xc3fbe710	PWLib	File handle high water mark set: 42 PUDPSocket
2010/11/04 21:33:48.363	  0:00.272	                       	PWLib	File handle high water mark set: 44 PUDPSocket
2010/11/04 21:33:48.363	  0:00.272	                       	SIP	Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:500 ekiga net, id=9859067f-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:48.363	  0:00.272	                       	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:48.416	  0:00.325	                       	SIP	No SRV record found.
2010/11/04 21:33:48.417	  0:00.326	                       	OpalUDP	Binding to interface: 0.0.0.0:5060
2010/11/04 21:33:48.417	  0:00.326	                       	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2010/11/04 21:33:48.418	  0:00.326	                       	OpalUDP	Started connect to 86.64.162.35:5060
2010/11/04 21:33:48.418	  0:00.327	                       	OpalUDP	Writing to interface 0 - "192.168.10.77%eth0"
2010/11/04 21:33:48.418	  0:00.327	                       	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.10.77:5060
2010/11/04 21:33:48.461	  0:00.370	StunDetector:0xc3fbe710	PWLib	File handle high water mark set: 46 PUDPSocket
2010/11/04 21:33:51.136	  0:03.044	StunDetector:0xc3fbe710	PWLib	File handle low water mark set: 42 PUDPSocket
2010/11/04 21:33:51.282	  0:03.191	StunDetector:0xc3fbe710	OPAL	STUN server "stun.ekiga.net" replies Restricted NAT, external IP 95.85.164.64
2010/11/04 21:33:51.370	  0:03.279	                       	PWLib	File handle low water mark set: 40 PUDPSocket
2010/11/04 21:33:51.370	  0:03.279	                       	SIP	Transaction created.
2010/11/04 21:33:51.372	  0:03.281	                       	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:51.412	  0:03.321	                       	SIP	No SRV record found.
2010/11/04 21:33:51.412	  0:03.321	                       	SIP	Transaction remote address is udp$ekiga.net:5060
2010/11/04 21:33:51.412	  0:03.321	                       	SIP	Sending PDU (570 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.10.77:5060,if=192.168.10.77%eth0
SUBSCRIBE sip:500 ekiga net SIP/2.0
CSeq: 2 SUBSCRIBE
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK2e56d180-c0e6-df11-8a9b-001a92ce6170;rport
User-Agent: Ekiga/3.2.7
From: "Csányi Pál" <sip:csanyipal 95 85 164 64>;tag=462fd180-c0e6-df11-8a9b-001a92ce6170
Call-ID: 9859067f-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:500 ekiga net>
Contact: <sip:csanyipal 95 85 164 64>
Accept: application/pidf+xml
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 300
Event: presence
Content-Length: 0
Max-Forwards: 70


2010/11/04 21:33:51.413	  0:03.322	                       	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:51.413	  0:03.322	                       	SIP	Transaction timers set: retry=0.500, completion=6.000
2010/11/04 21:33:51.413	  0:03.322	                       	SIP	Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:500 ekiga net, id=0cc2d780-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:51.413	  0:03.322	                       	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:51.461	  0:03.370	                       	SIP	No SRV record found.
2010/11/04 21:33:51.461	  0:03.370	                       	OpalUDP	Binding to interface: 0.0.0.0:5060
2010/11/04 21:33:51.461	  0:03.370	                       	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2010/11/04 21:33:51.461	  0:03.370	                       	OpalUDP	Started connect to 86.64.162.35:5060
2010/11/04 21:33:51.461	  0:03.370	                       	OpalUDP	Writing to interface 0 - "192.168.10.77%eth0"
2010/11/04 21:33:51.462	  0:03.371	                       	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.10.77:5060
2010/11/04 21:33:51.463	  0:03.371	                       	SIP	Transaction created.
2010/11/04 21:33:51.464	  0:03.373	                       	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:51.475	  0:03.384	Opal Liste...0xc8071710	OpalUDP	Binding to interface: 192.168.10.77:5060
2010/11/04 21:33:51.475	  0:03.384	Opal Liste...0xc8071710	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.10.77:5060>
2010/11/04 21:33:51.476	  0:03.384	Opal Liste...0xc8071710	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.10.77:5060,if=192.168.10.77%eth0
SIP/2.0 489 Event Not Supported
CSeq: 2 SUBSCRIBE
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK2e56d180-c0e6-df11-8a9b-001a92ce6170;rport=5060
Server: Kamailio (1.5.3-notls (i386/linux))
From: "Csányi Pál" <sip:csanyipal 95 85 164 64>;tag=462fd180-c0e6-df11-8a9b-001a92ce6170
Call-ID: 9859067f-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:500 ekiga net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.5412
Content-Length: 0


2010/11/04 21:33:51.476	  0:03.385	Opal Liste...0xc8071710	SIP	Queueing PDU "2 SUBSCRIBE <489>", transaction=z9hG4bK2e56d180-c0e6-df11-8a9b-001a92ce6170, token=9859067f-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:51.476	  0:03.385	Opal Liste...0xc8071710	PTLib	No permission to set priority level 3
2010/11/04 21:33:51.476	  0:03.385	Opal Liste...0xc8071710	Opal	Transport clean up on termination
2010/11/04 21:33:51.476	  0:03.385	Opal Liste...0xc8071710	Opal	Transport Close
2010/11/04 21:33:51.476	  0:03.385	Opal Liste...0xc8071710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.77:5060>
2010/11/04 21:33:51.477	  0:03.385	        Pool:0xc3fbe710	SIP	Handling PDU "2 SUBSCRIBE <489>" for transaction=z9hG4bK2e56d180-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:51.477	  0:03.385	        Pool:0xc3fbe710	SIP	SUBSCRIBE transaction id=z9hG4bK2e56d180-c0e6-df11-8a9b-001a92ce6170 completed.
2010/11/04 21:33:51.477	  0:03.386	        Pool:0xc3fbe710	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:51.477	  0:03.386	        Pool:0xc3fbe710	SIP	Not retrying SUBSCRIBE due to error response 489 Bad Event
2010/11/04 21:33:51.477	  0:03.386	        Pool:0xc3fbe710	SIP	Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:500 ekiga net, id=9859067f-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:51.477	  0:03.386	        Pool:0xc3fbe710	SIP	Handled PDU "2 SUBSCRIBE <489>"
2010/11/04 21:33:51.520	  0:03.429	                       	SIP	No SRV record found.
2010/11/04 21:33:51.520	  0:03.429	                       	SIP	Transaction remote address is udp$ekiga.net:5060
2010/11/04 21:33:51.520	  0:03.429	                       	SIP	Sending PDU (576 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.10.77:5060,if=192.168.10.77%eth0
SUBSCRIBE sip:500 ekiga net SIP/2.0
CSeq: 2 SUBSCRIBE
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bKa06cdf80-c0e6-df11-8a9b-001a92ce6170;rport
User-Agent: Ekiga/3.2.7
From: "Csányi Pál" <sip:csanyipal 95 85 164 64>;tag=9248df80-c0e6-df11-8a9b-001a92ce6170
Call-ID: 0cc2d780-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:500 ekiga net>
Contact: <sip:500 95 85 164 64>
Accept: application/dialog-info+xml
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 300
Event: dialog;sla;ma
Content-Length: 0
Max-Forwards: 70


2010/11/04 21:33:51.521	  0:03.429	                       	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:51.521	  0:03.429	                       	SIP	Transaction timers set: retry=0.500, completion=6.000
2010/11/04 21:33:51.521	  0:03.430	                       	SIP	Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:501 ekiga net, id=3632e880-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:51.521	  0:03.430	                       	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:51.560	  0:03.469	                       	SIP	No SRV record found.
2010/11/04 21:33:51.561	  0:03.469	                       	OpalUDP	Binding to interface: 0.0.0.0:5060
2010/11/04 21:33:51.561	  0:03.470	                       	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2010/11/04 21:33:51.561	  0:03.470	                       	OpalUDP	Started connect to 86.64.162.35:5060
2010/11/04 21:33:51.561	  0:03.470	                       	OpalUDP	Writing to interface 0 - "192.168.10.77%eth0"
2010/11/04 21:33:51.561	  0:03.470	                       	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.10.77:5060
2010/11/04 21:33:51.562	  0:03.471	                       	SIP	Transaction created.
2010/11/04 21:33:51.564	  0:03.473	                       	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:51.582	  0:03.491	Opal Liste...0xc8071710	OpalUDP	Binding to interface: 192.168.10.77:5060
2010/11/04 21:33:51.583	  0:03.491	Opal Liste...0xc8071710	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.10.77:5060>
2010/11/04 21:33:51.583	  0:03.492	Opal Liste...0xc8071710	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.10.77:5060,if=192.168.10.77%eth0
SIP/2.0 489 Event Not Supported
CSeq: 2 SUBSCRIBE
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bKa06cdf80-c0e6-df11-8a9b-001a92ce6170;rport=5060
Server: Kamailio (1.5.3-notls (i386/linux))
From: "Csányi Pál" <sip:csanyipal 95 85 164 64>;tag=9248df80-c0e6-df11-8a9b-001a92ce6170
Call-ID: 0cc2d780-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:500 ekiga net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.4860
Content-Length: 0


2010/11/04 21:33:51.583	  0:03.492	Opal Liste...0xc8071710	SIP	Queueing PDU "2 SUBSCRIBE <489>", transaction=z9hG4bKa06cdf80-c0e6-df11-8a9b-001a92ce6170, token=0cc2d780-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:51.583	  0:03.492	Opal Liste...0xc8071710	Opal	Transport clean up on termination
2010/11/04 21:33:51.583	  0:03.492	Opal Liste...0xc8071710	Opal	Transport Close
2010/11/04 21:33:51.584	  0:03.492	        Pool:0xc3fbe710	SIP	Handling PDU "2 SUBSCRIBE <489>" for transaction=z9hG4bKa06cdf80-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:51.584	  0:03.492	        Pool:0xc3fbe710	SIP	SUBSCRIBE transaction id=z9hG4bKa06cdf80-c0e6-df11-8a9b-001a92ce6170 completed.
2010/11/04 21:33:51.584	  0:03.492	        Pool:0xc3fbe710	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:51.584	  0:03.493	        Pool:0xc3fbe710	SIP	Not retrying SUBSCRIBE due to error response 489 Bad Event
2010/11/04 21:33:51.584	  0:03.493	        Pool:0xc3fbe710	SIP	Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:500 ekiga net, id=0cc2d780-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:51.583	  0:03.492	Opal Liste...0xc8071710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.77:5060>
2010/11/04 21:33:51.585	  0:03.494	        Pool:0xc3fbe710	SIP	Handled PDU "2 SUBSCRIBE <489>"
2010/11/04 21:33:51.591	  0:03.500	                       	SIP	No SRV record found.
2010/11/04 21:33:51.591	  0:03.500	                       	SIP	Transaction remote address is udp$ekiga.net:5060
2010/11/04 21:33:51.591	  0:03.500	                       	SIP	Sending PDU (570 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.10.77:5060,if=192.168.10.77%eth0
SUBSCRIBE sip:501 ekiga net SIP/2.0
CSeq: 2 SUBSCRIBE
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK7aa1ee80-c0e6-df11-8a9b-001a92ce6170;rport
User-Agent: Ekiga/3.2.7
From: "Csányi Pál" <sip:csanyipal 95 85 164 64>;tag=f87dee80-c0e6-df11-8a9b-001a92ce6170
Call-ID: 3632e880-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:501 ekiga net>
Contact: <sip:csanyipal 95 85 164 64>
Accept: application/pidf+xml
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 300
Event: presence
Content-Length: 0
Max-Forwards: 70


2010/11/04 21:33:51.592	  0:03.500	                       	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:51.592	  0:03.500	                       	SIP	Transaction timers set: retry=0.500, completion=6.000
2010/11/04 21:33:51.592	  0:03.501	                       	SIP	Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:501 ekiga net, id=d604f380-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:51.592	  0:03.501	                       	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:51.680	  0:03.589	Opal Liste...0xc8071710	OpalUDP	Binding to interface: 192.168.10.77:5060
2010/11/04 21:33:51.680	  0:03.589	Opal Liste...0xc8071710	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.10.77:5060>
2010/11/04 21:33:51.681	  0:03.590	Opal Liste...0xc8071710	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.10.77:5060,if=192.168.10.77%eth0
SIP/2.0 489 Event Not Supported
CSeq: 2 SUBSCRIBE
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK7aa1ee80-c0e6-df11-8a9b-001a92ce6170;rport=5060
Server: Kamailio (1.5.3-notls (i386/linux))
From: "Csányi Pál" <sip:csanyipal 95 85 164 64>;tag=f87dee80-c0e6-df11-8a9b-001a92ce6170
Call-ID: 3632e880-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:501 ekiga net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.10bf
Content-Length: 0


2010/11/04 21:33:51.681	  0:03.590	Opal Liste...0xc8071710	SIP	Queueing PDU "2 SUBSCRIBE <489>", transaction=z9hG4bK7aa1ee80-c0e6-df11-8a9b-001a92ce6170, token=3632e880-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:51.681	  0:03.590	Opal Liste...0xc8071710	Opal	Transport clean up on termination
2010/11/04 21:33:51.681	  0:03.590	Opal Liste...0xc8071710	Opal	Transport Close
2010/11/04 21:33:51.681	  0:03.590	        Pool:0xc3fbe710	SIP	Handling PDU "2 SUBSCRIBE <489>" for transaction=z9hG4bK7aa1ee80-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:51.681	  0:03.590	        Pool:0xc3fbe710	SIP	SUBSCRIBE transaction id=z9hG4bK7aa1ee80-c0e6-df11-8a9b-001a92ce6170 completed.
2010/11/04 21:33:51.681	  0:03.590	        Pool:0xc3fbe710	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:51.682	  0:03.590	        Pool:0xc3fbe710	SIP	Not retrying SUBSCRIBE due to error response 489 Bad Event
2010/11/04 21:33:51.682	  0:03.590	        Pool:0xc3fbe710	SIP	Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:501 ekiga net, id=3632e880-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:51.682	  0:03.590	        Pool:0xc3fbe710	SIP	Handled PDU "2 SUBSCRIBE <489>"
2010/11/04 21:33:51.681	  0:03.590	Opal Liste...0xc8071710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.77:5060>
2010/11/04 21:33:51.692	  0:03.601	                       	SIP	No SRV record found.
2010/11/04 21:33:51.692	  0:03.601	                       	OpalUDP	Binding to interface: 0.0.0.0:5060
2010/11/04 21:33:51.693	  0:03.601	                       	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2010/11/04 21:33:51.693	  0:03.602	                       	OpalUDP	Started connect to 86.64.162.35:5060
2010/11/04 21:33:51.693	  0:03.602	                       	OpalUDP	Writing to interface 0 - "192.168.10.77%eth0"
2010/11/04 21:33:51.693	  0:03.602	                       	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.10.77:5060
2010/11/04 21:33:51.694	  0:03.603	                       	SIP	Transaction created.
2010/11/04 21:33:51.696	  0:03.605	                       	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:51.731	  0:03.640	                       	SIP	No SRV record found.
2010/11/04 21:33:51.731	  0:03.640	                       	SIP	Transaction remote address is udp$ekiga.net:5060
2010/11/04 21:33:51.731	  0:03.640	                       	SIP	Sending PDU (576 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.10.77:5060,if=192.168.10.77%eth0
SUBSCRIBE sip:501 ekiga net SIP/2.0
CSeq: 2 SUBSCRIBE
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK5cbf0281-c0e6-df11-8a9b-001a92ce6170;rport
User-Agent: Ekiga/3.2.7
From: "Csányi Pál" <sip:csanyipal 95 85 164 64>;tag=189a0281-c0e6-df11-8a9b-001a92ce6170
Call-ID: d604f380-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:501 ekiga net>
Contact: <sip:501 95 85 164 64>
Accept: application/dialog-info+xml
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 300
Event: dialog;sla;ma
Content-Length: 0
Max-Forwards: 70


2010/11/04 21:33:51.732	  0:03.640	                       	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:51.732	  0:03.641	                       	SIP	Transaction timers set: retry=0.500, completion=6.000
2010/11/04 21:33:51.732	  0:03.641	                       	SIP	Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:letonga ekiga net, id=5c640881-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:51.732	  0:03.641	                       	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:51.757	  0:03.666	                       	SIP	No SRV record found.
2010/11/04 21:33:51.758	  0:03.667	                       	OpalUDP	Binding to interface: 0.0.0.0:5060
2010/11/04 21:33:51.758	  0:03.667	                       	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2010/11/04 21:33:51.758	  0:03.667	                       	OpalUDP	Started connect to 86.64.162.35:5060
2010/11/04 21:33:51.758	  0:03.667	                       	OpalUDP	Writing to interface 0 - "192.168.10.77%eth0"
2010/11/04 21:33:51.758	  0:03.667	                       	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.10.77:5060
2010/11/04 21:33:51.759	  0:03.668	                       	SIP	Transaction created.
2010/11/04 21:33:51.761	  0:03.670	                       	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:51.781	  0:03.689	Opal Liste...0xc8071710	OpalUDP	Binding to interface: 192.168.10.77:5060
2010/11/04 21:33:51.781	  0:03.690	Opal Liste...0xc8071710	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.10.77:5060>
2010/11/04 21:33:51.781	  0:03.690	Opal Liste...0xc8071710	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.10.77:5060,if=192.168.10.77%eth0
SIP/2.0 489 Event Not Supported
CSeq: 2 SUBSCRIBE
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK5cbf0281-c0e6-df11-8a9b-001a92ce6170;rport=5060
Server: Kamailio (1.5.3-notls (i386/linux))
From: "Csányi Pál" <sip:csanyipal 95 85 164 64>;tag=189a0281-c0e6-df11-8a9b-001a92ce6170
Call-ID: d604f380-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:501 ekiga net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.5c7a
Content-Length: 0


2010/11/04 21:33:51.781	  0:03.690	Opal Liste...0xc8071710	SIP	Queueing PDU "2 SUBSCRIBE <489>", transaction=z9hG4bK5cbf0281-c0e6-df11-8a9b-001a92ce6170, token=d604f380-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:51.782	  0:03.690	Opal Liste...0xc8071710	Opal	Transport clean up on termination
2010/11/04 21:33:51.782	  0:03.690	Opal Liste...0xc8071710	Opal	Transport Close
2010/11/04 21:33:51.782	  0:03.690	        Pool:0xc3fbe710	SIP	Handling PDU "2 SUBSCRIBE <489>" for transaction=z9hG4bK5cbf0281-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:51.782	  0:03.691	        Pool:0xc3fbe710	SIP	SUBSCRIBE transaction id=z9hG4bK5cbf0281-c0e6-df11-8a9b-001a92ce6170 completed.
2010/11/04 21:33:51.782	  0:03.691	        Pool:0xc3fbe710	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:51.782	  0:03.691	        Pool:0xc3fbe710	SIP	Not retrying SUBSCRIBE due to error response 489 Bad Event
2010/11/04 21:33:51.782	  0:03.691	        Pool:0xc3fbe710	SIP	Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:501 ekiga net, id=d604f380-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:51.782	  0:03.691	        Pool:0xc3fbe710	SIP	Handled PDU "2 SUBSCRIBE <489>"
2010/11/04 21:33:51.782	  0:03.690	Opal Liste...0xc8071710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.77:5060>
2010/11/04 21:33:51.801	  0:03.710	                       	SIP	No SRV record found.
2010/11/04 21:33:51.801	  0:03.710	                       	SIP	Transaction remote address is udp$ekiga.net:5060
2010/11/04 21:33:51.801	  0:03.710	                       	SIP	Sending PDU (578 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.10.77:5060,if=192.168.10.77%eth0
SUBSCRIBE sip:letonga ekiga net SIP/2.0
CSeq: 2 SUBSCRIBE
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK3eb50c81-c0e6-df11-8a9b-001a92ce6170;rport
User-Agent: Ekiga/3.2.7
From: "Csányi Pál" <sip:csanyipal 95 85 164 64>;tag=9e910c81-c0e6-df11-8a9b-001a92ce6170
Call-ID: 5c640881-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:letonga ekiga net>
Contact: <sip:csanyipal 95 85 164 64>
Accept: application/pidf+xml
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 300
Event: presence
Content-Length: 0
Max-Forwards: 70


2010/11/04 21:33:51.802	  0:03.711	                       	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:51.802	  0:03.711	                       	SIP	Transaction timers set: retry=0.500, completion=6.000
2010/11/04 21:33:51.802	  0:03.711	                       	SIP	Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:letonga ekiga net, id=5a151381-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:51.802	  0:03.711	                       	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:51.845	  0:03.754	                       	SIP	No SRV record found.
2010/11/04 21:33:51.845	  0:03.754	                       	OpalUDP	Binding to interface: 0.0.0.0:5060
2010/11/04 21:33:51.845	  0:03.754	                       	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2010/11/04 21:33:51.845	  0:03.754	                       	OpalUDP	Started connect to 86.64.162.35:5060
2010/11/04 21:33:51.845	  0:03.754	                       	OpalUDP	Writing to interface 0 - "192.168.10.77%eth0"
2010/11/04 21:33:51.846	  0:03.755	                       	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.10.77:5060
2010/11/04 21:33:51.847	  0:03.755	                       	SIP	Transaction created.
2010/11/04 21:33:51.848	  0:03.757	                       	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:51.851	  0:03.760	Opal Liste...0xc8071710	OpalUDP	Binding to interface: 192.168.10.77:5060
2010/11/04 21:33:51.852	  0:03.760	Opal Liste...0xc8071710	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.10.77:5060>
2010/11/04 21:33:51.852	  0:03.761	Opal Liste...0xc8071710	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.10.77:5060,if=192.168.10.77%eth0
SIP/2.0 202 OK
CSeq: 2 SUBSCRIBE
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK3eb50c81-c0e6-df11-8a9b-001a92ce6170;rport=5060
Server: Kamailio (1.5.3-notls (i386/linux))
From: "Csányi Pál" <sip:csanyipal 95 85 164 64>;tag=9e910c81-c0e6-df11-8a9b-001a92ce6170
Call-ID: 5c640881-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:letonga ekiga net>;tag=f85b0bd16aaafa8479586ac9f88b3198-b4f3
Contact: <sip:86.64.162.35:5060>
Expires: 300
Content-Length: 0


2010/11/04 21:33:51.852	  0:03.761	Opal Liste...0xc8071710	SIP	Queueing PDU "2 SUBSCRIBE <202>", transaction=z9hG4bK3eb50c81-c0e6-df11-8a9b-001a92ce6170, token=5c640881-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:51.852	  0:03.761	Opal Liste...0xc8071710	Opal	Transport clean up on termination
2010/11/04 21:33:51.852	  0:03.761	Opal Liste...0xc8071710	Opal	Transport Close
2010/11/04 21:33:51.852	  0:03.761	        Pool:0xc3fbe710	SIP	Handling PDU "2 SUBSCRIBE <202>" for transaction=z9hG4bK3eb50c81-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:51.853	  0:03.761	        Pool:0xc3fbe710	SIP	SUBSCRIBE transaction id=z9hG4bK3eb50c81-c0e6-df11-8a9b-001a92ce6170 completed.
2010/11/04 21:33:51.853	  0:03.761	        Pool:0xc3fbe710	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:51.853	  0:03.762	        Pool:0xc3fbe710	SIP	Expiry time for SUBSCRIBE set to 300 seconds.
2010/11/04 21:33:51.853	  0:03.761	Opal Liste...0xc8071710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.77:5060>
2010/11/04 21:33:51.853	  0:03.762	        Pool:0xc3fbe710	SIP	Product Info: name="Kamailio", version="", vendor="", comments="(1.5.3-notls (i386/linux))"
2010/11/04 21:33:51.853	  0:03.762	        Pool:0xc3fbe710	SIP	Changing SUBSCRIBE handler from Subscribing to Subscribed, target=sip:letonga ekiga net, id=5c640881-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:51.853	  0:03.762	        Pool:0xc3fbe710	SIP	Set Request URI to sip:86.64.162.35:5060
2010/11/04 21:33:51.853	  0:03.762	        Pool:0xc3fbe710	SIP	Updating dialog tag from "" to "f85b0bd16aaafa8479586ac9f88b3198-b4f3"
2010/11/04 21:33:51.853	  0:03.762	Opal Liste...0xc8071710	OpalUDP	Binding to interface: 192.168.10.77:5060
2010/11/04 21:33:51.853	  0:03.762	        Pool:0xc3fbe710	SIP	Product Info: name="Kamailio", version="", vendor="", comments="(1.5.3-notls (i386/linux))"
2010/11/04 21:33:51.853	  0:03.762	        Pool:0xc3fbe710	SIP	Handled PDU "2 SUBSCRIBE <202>"
2010/11/04 21:33:51.853	  0:03.762	Opal Liste...0xc8071710	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.10.77:5060>
2010/11/04 21:33:51.854	  0:03.763	Opal Liste...0xc8071710	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.10.77:5060,if=192.168.10.77%eth0
NOTIFY sip:csanyipal 95 85 164 64 SIP/2.0
CSeq: 1 NOTIFY
Via: SIP/2.0/UDP 86.64.162.35;branch=z9hG4bK3145.8265aae.0
User-Agent: Kamailio (1.5.3-notls (i386/linux))
From: sip:letonga ekiga net;tag=f85b0bd16aaafa8479586ac9f88b3198-b4f3
Call-ID: 5c640881-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: sip:csanyipal 95 85 164 64;tag=9e910c81-c0e6-df11-8a9b-001a92ce6170
Contact: <sip:86.64.162.35:5060>
Subscription-State: active;expires=370
Event: presence
Content-Length: 321
Content-Type: application/pidf+xml
Max-Forwards: 70

<?xml version="1.0" encoding="UTF-8"?>
<presence xmlns="urn:ietf:params:xml:ns:pidf" entity="pres:letonga ekiga net">
<tuple id="sip:letonga ekiga net_on_bakusaiga">
<note>online - I'm online using Ekiga</note>
<status>
<basic>open</basic>
</status>
<contact priority="1">letonga ekiga net</contact>
</tuple>
</presence>

2010/11/04 21:33:51.854	  0:03.763	Opal Liste...0xc8071710	SIP	Received NOTIFY presence
2010/11/04 21:33:51.854	  0:03.763	Opal Liste...0xc8071710	SIP	Found a SUBSCRIBE corresponding to the NOTIFY presence
2010/11/04 21:33:51.854	  0:03.763	Opal Liste...0xc8071710	SIP	Dialog initial sequence number 1
2010/11/04 21:33:51.854	  0:03.763	Opal Liste...0xc8071710	SIP	Subscription is active;expires=370
2010/11/04 21:33:51.855	  0:03.764	Opal Liste...0xc8071710	XML	Loaded XML presence
2010/11/04 21:33:51.856	  0:03.765	Opal Liste...0xc8071710	SIP	Sending PDU (357 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.10.77:5060,if=192.168.10.77%eth0
SIP/2.0 200 OK
CSeq: 1 NOTIFY
Via: SIP/2.0/UDP 86.64.162.35;branch=z9hG4bK3145.8265aae.0
From: sip:letonga ekiga net;tag=f85b0bd16aaafa8479586ac9f88b3198-b4f3
Call-ID: 5c640881-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: sip:csanyipal 95 85 164 64;tag=9e910c81-c0e6-df11-8a9b-001a92ce6170
Contact: <sip:csanyipal 95 85 164 64>
Content-Length: 0


2010/11/04 21:33:51.856	  0:03.765	Opal Liste...0xc8071710	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:51.856	  0:03.765	Opal Liste...0xc8071710	Opal	Transport clean up on termination
2010/11/04 21:33:51.857	  0:03.765	Opal Liste...0xc8071710	Opal	Transport Close
2010/11/04 21:33:51.857	  0:03.765	Opal Liste...0xc8071710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.77:5060>
2010/11/04 21:33:51.893	  0:03.801	                       	SIP	No SRV record found.
2010/11/04 21:33:51.893	  0:03.802	                       	SIP	Transaction remote address is udp$ekiga.net:5060
2010/11/04 21:33:51.893	  0:03.802	                       	SIP	Sending PDU (588 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.10.77:5060,if=192.168.10.77%eth0
SUBSCRIBE sip:letonga ekiga net SIP/2.0
CSeq: 2 SUBSCRIBE
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK82041a81-c0e6-df11-8a9b-001a92ce6170;rport
User-Agent: Ekiga/3.2.7
From: "Csányi Pál" <sip:csanyipal 95 85 164 64>;tag=b0e01981-c0e6-df11-8a9b-001a92ce6170
Call-ID: 5a151381-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:letonga ekiga net>
Contact: <sip:letonga 95 85 164 64>
Accept: application/dialog-info+xml
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 300
Event: dialog;sla;ma
Content-Length: 0
Max-Forwards: 70


2010/11/04 21:33:51.893	  0:03.802	                       	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:51.893	  0:03.802	                       	SIP	Transaction timers set: retry=0.500, completion=6.000
2010/11/04 21:33:51.894	  0:03.803	                       	VideoOutputCoreConfBridge	Updating video view
2010/11/04 21:33:51.894	  0:03.803	                       	VideoOutputCoreConfBridge	Updating zoom
2010/11/04 21:33:51.894	  0:03.803	                       	VideoOutputCoreConfBridge	Updating Video Settings
2010/11/04 21:33:51.895	  0:03.803	                       	VideoOutputCoreConfBridge	Updating Video Settings
2010/11/04 21:33:51.895	  0:03.803	                       	VideoOutputCoreConfBridge	Updating Video Settings
2010/11/04 21:33:51.895	  0:03.803	                       	VideoOutputCoreConfBridge	Updating Video Settings
2010/11/04 21:33:51.895	  0:03.804	                       	VidInputCoreConfBridge	Updating preview size and fps
2010/11/04 21:33:51.895	  0:03.804	                       	VidInputCore	Setting new preview config: 320x240/30
2010/11/04 21:33:51.896	  0:03.805	                       	VidInputCoreConfBridge	Updating preview size and fps
2010/11/04 21:33:51.896	  0:03.805	                       	VidInputCore	Setting new preview config: 320x240/30
2010/11/04 21:33:51.898	  0:03.807	                       	VidInputCoreConfBridge	Updating device
2010/11/04 21:33:51.898	  0:03.807	                       	VidInputCore	Setting device: CIF Single Chip      (PTLIB/V4L2)
2010/11/04 21:33:51.898	  0:03.807	                       	GMVideoInputManager_ptlib	Setting Device CIF Single Chip      (PTLIB/V4L2)
2010/11/04 21:33:51.899	  0:03.807	                       	VidInputCoreConfBridge	Updating device
2010/11/04 21:33:51.899	  0:03.807	                       	VidInputCore	Setting device: CIF Single Chip      (PTLIB/V4L2)
2010/11/04 21:33:51.899	  0:03.807	                       	GMVideoInputManager_ptlib	Setting Device CIF Single Chip      (PTLIB/V4L2)
2010/11/04 21:33:51.899	  0:03.807	                       	VidInputCoreConfBridge	Updating device
2010/11/04 21:33:51.899	  0:03.808	                       	VidInputCore	Setting device: CIF Single Chip      (PTLIB/V4L2)
2010/11/04 21:33:51.899	  0:03.808	                       	GMVideoInputManager_ptlib	Setting Device CIF Single Chip      (PTLIB/V4L2)
2010/11/04 21:33:51.899	  0:03.808	                       	VidInputCoreConfBridge	Updating image
2010/11/04 21:33:51.899	  0:03.808	                       	VidInputCoreConfBridge	Updating preview
2010/11/04 21:33:51.899	  0:03.808	                       	VidInputCore	Starting preview 320x240/30
2010/11/04 21:33:51.899	  0:03.808	                       	VidInputCore	Opening device with 320x240/30
2010/11/04 21:33:51.899	  0:03.808	                       	GMVideoInputManager_ptlib	Opening Device CIF Single Chip      (PTLIB/V4L2)
2010/11/04 21:33:51.899	  0:03.808	                       	GMVideoInputManager_ptlib	Opening Device with 320x240/30
2010/11/04 21:33:51.899	  0:03.808	                       	Detecting V4L2 devices
2010/11/04 21:33:51.900	  0:03.808	                       	PV4L2Plugin	detected device metadata at /sys/class/video4linux/
2010/11/04 21:33:51.911	  0:03.820	                       	PVidInDev	Open()	videoFd:-1
2010/11/04 21:33:51.912	  0:03.820	                       	PVidInDev	Close()	videoFd:-1  started:0
2010/11/04 21:33:51.912	  0:03.820	                       	Detecting V4L2 devices
2010/11/04 21:33:51.912	  0:03.820	                       	PV4L2Plugin	detected device metadata at /sys/class/video4linux/
2010/11/04 21:33:51.923	  0:03.832	                       	PVidInDev	Open()	devName:/dev/video0  videoFd:-1
2010/11/04 21:33:51.924	  0:03.833	                       	VideoInputDevice	S_STD failed : Érvénytelen argumentum
2010/11/04 21:33:51.924	  0:03.833	                       	PVidInDev	G_PARM failed (preserving frame rate may not work) : Érvénytelen argumentum
2010/11/04 21:33:51.924	  0:03.833	                       	PVidInDev	unable to reset frame rate.
2010/11/04 21:33:51.924	  0:03.833	                       	PVidDev	SetColourFormatConverter success for native YUV420P
2010/11/04 21:33:51.924	  0:03.833	                       	PVidDev	SetFrameSize to 320x240
2010/11/04 21:33:51.924	  0:03.833	                       	PVidInDev	G_PARM failed (preserving frame rate may not work) : Érvénytelen argumentum
2010/11/04 21:33:51.924	  0:03.833	                       	PVidInDev	unable to reset frame rate.
2010/11/04 21:33:51.958	  0:03.867	Opal Liste...0xc8071710	OpalUDP	Binding to interface: 192.168.10.77:5060
2010/11/04 21:33:51.958	  0:03.867	Opal Liste...0xc8071710	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.10.77:5060>
2010/11/04 21:33:51.959	  0:03.867	Opal Liste...0xc8071710	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.10.77:5060,if=192.168.10.77%eth0
SIP/2.0 202 OK
CSeq: 2 SUBSCRIBE
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK82041a81-c0e6-df11-8a9b-001a92ce6170;rport=5060
Server: Kamailio (1.5.3-notls (i386/linux))
From: "Csányi Pál" <sip:csanyipal 95 85 164 64>;tag=b0e01981-c0e6-df11-8a9b-001a92ce6170
Call-ID: 5a151381-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:letonga ekiga net>;tag=f85b0bd16aaafa8479586ac9f88b3198-9bad
Contact: <sip:86.64.162.35:5060>
Expires: 300
Content-Length: 0


2010/11/04 21:33:51.959	  0:03.868	Opal Liste...0xc8071710	SIP	Queueing PDU "2 SUBSCRIBE <202>", transaction=z9hG4bK82041a81-c0e6-df11-8a9b-001a92ce6170, token=5a151381-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:51.959	  0:03.868	Opal Liste...0xc8071710	Opal	Transport clean up on termination
2010/11/04 21:33:51.959	  0:03.868	Opal Liste...0xc8071710	Opal	Transport Close
2010/11/04 21:33:51.959	  0:03.868	        Pool:0xc3fbe710	SIP	Handling PDU "2 SUBSCRIBE <202>" for transaction=z9hG4bK82041a81-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:51.959	  0:03.868	        Pool:0xc3fbe710	SIP	SUBSCRIBE transaction id=z9hG4bK82041a81-c0e6-df11-8a9b-001a92ce6170 completed.
2010/11/04 21:33:51.959	  0:03.868	        Pool:0xc3fbe710	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:51.959	  0:03.868	        Pool:0xc3fbe710	SIP	Expiry time for SUBSCRIBE set to 300 seconds.
2010/11/04 21:33:51.959	  0:03.868	        Pool:0xc3fbe710	SIP	Product Info: name="Kamailio", version="", vendor="", comments="(1.5.3-notls (i386/linux))"
2010/11/04 21:33:51.959	  0:03.868	Opal Liste...0xc8071710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.77:5060>
2010/11/04 21:33:51.959	  0:03.868	        Pool:0xc3fbe710	SIP	Changing SUBSCRIBE handler from Subscribing to Subscribed, target=sip:letonga ekiga net, id=5a151381-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:51.960	  0:03.868	        Pool:0xc3fbe710	SIP	Set Request URI to sip:86.64.162.35:5060
2010/11/04 21:33:51.960	  0:03.869	        Pool:0xc3fbe710	SIP	Updating dialog tag from "" to "f85b0bd16aaafa8479586ac9f88b3198-9bad"
2010/11/04 21:33:51.960	  0:03.869	        Pool:0xc3fbe710	SIP	Product Info: name="Kamailio", version="", vendor="", comments="(1.5.3-notls (i386/linux))"
2010/11/04 21:33:51.960	  0:03.869	Opal Liste...0xc8071710	OpalUDP	Binding to interface: 192.168.10.77:5060
2010/11/04 21:33:51.960	  0:03.869	        Pool:0xc3fbe710	SIP	Handled PDU "2 SUBSCRIBE <202>"
2010/11/04 21:33:51.960	  0:03.869	Opal Liste...0xc8071710	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.10.77:5060>
2010/11/04 21:33:51.961	  0:03.869	Opal Liste...0xc8071710	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.10.77:5060,if=192.168.10.77%eth0
NOTIFY sip:letonga 95 85 164 64 SIP/2.0
CSeq: 1 NOTIFY
Via: SIP/2.0/UDP 86.64.162.35;branch=z9hG4bK25b5.7dd548e2.0
User-Agent: Kamailio (1.5.3-notls (i386/linux))
From: sip:letonga ekiga net;tag=f85b0bd16aaafa8479586ac9f88b3198-9bad
Call-ID: 5a151381-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: sip:csanyipal 95 85 164 64;tag=b0e01981-c0e6-df11-8a9b-001a92ce6170
Contact: <sip:86.64.162.35:5060>
Subscription-State: active;expires=370
Event: dialog;sla
Content-Length: 0
Max-Forwards: 70


2010/11/04 21:33:51.961	  0:03.870	Opal Liste...0xc8071710	SIP	Received NOTIFY dialog;sla
2010/11/04 21:33:51.961	  0:03.870	Opal Liste...0xc8071710	SIP	Found a SUBSCRIBE corresponding to the NOTIFY dialog;sla
2010/11/04 21:33:51.961	  0:03.870	Opal Liste...0xc8071710	SIP	Dialog initial sequence number 1
2010/11/04 21:33:51.961	  0:03.870	Opal Liste...0xc8071710	SIP	Subscription is active;expires=370
2010/11/04 21:33:51.962	  0:03.871	Opal Liste...0xc8071710	SIP	Sending PDU (358 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.10.77:5060,if=192.168.10.77%eth0
SIP/2.0 200 OK
CSeq: 1 NOTIFY
Via: SIP/2.0/UDP 86.64.162.35;branch=z9hG4bK25b5.7dd548e2.0
From: sip:letonga ekiga net;tag=f85b0bd16aaafa8479586ac9f88b3198-9bad
Call-ID: 5a151381-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: sip:csanyipal 95 85 164 64;tag=b0e01981-c0e6-df11-8a9b-001a92ce6170
Contact: <sip:csanyipal 95 85 164 64>
Content-Length: 0


2010/11/04 21:33:51.963	  0:03.871	Opal Liste...0xc8071710	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:51.963	  0:03.872	Opal Liste...0xc8071710	Opal	Transport clean up on termination
2010/11/04 21:33:51.963	  0:03.872	Opal Liste...0xc8071710	Opal	Transport Close
2010/11/04 21:33:51.963	  0:03.872	Opal Liste...0xc8071710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.77:5060>
2010/11/04 21:33:51.983	  0:03.892	                       	PreviewManager	Starting Preview
2010/11/04 21:33:51.983	  0:03.892	                       	AudioOutputCoreConfBridge	Updating device
2010/11/04 21:33:51.983	  0:03.892	                       	AudioOutputCore	Setting device[0]: Default (PTLIB/ALSA)
2010/11/04 21:33:51.983	  0:03.892	                       	GMAudioOutputManager_ptlib	Setting Device[0] Default (PTLIB/ALSA)
2010/11/04 21:33:51.984	  0:03.892	                       	AudioOutputCoreConfBridge	Updating device
2010/11/04 21:33:51.984	  0:03.892	                       	AudioOutputCore	Setting device[1]: Default (PTLIB/ALSA)
2010/11/04 21:33:51.985	  0:03.894	                       	AudioInputCoreConfBridge	Updating device
2010/11/04 21:33:51.985	  0:03.894	                       	AudioInputCore	Setting device: Default (PTLIB/ALSA)
2010/11/04 21:33:51.985	  0:03.894	                       	GMAudioInputManager_ptlib	Setting Device Default (PTLIB/ALSA)
2010/11/04 21:33:52.044	  0:03.953	                       	Ekiga version 3.2.7
2010/11/04 21:33:52.044	  0:03.953	                       	OPAL version 3.6.8
2010/11/04 21:33:52.044	  0:03.953	                       	PTLIB version 2.6.7
2010/11/04 21:33:52.044	  0:03.953	                       	GNOME support disabled
2010/11/04 21:33:52.044	  0:03.953	                       	Accelerated rendering support enabled
2010/11/04 21:33:52.044	  0:03.953	                       	DBUS support enabled
2010/11/04 21:33:52.044	  0:03.953	                       	GConf support enabled
2010/11/04 21:33:52.044	  0:03.953	                       	ESound support disabled
2010/11/04 21:33:52.090	  0:03.999	GMVideoOut...0xdb27d710	GMVideoOutputManager_X	Widget not yet realized or gconf info not yet set, not opening display
2010/11/04 21:33:52.185	  0:04.094	GMVideoOut...0xdb27d710	GMVideoOutputManager_X	Opening VO_MODE_LOCAL display with image of 320x240
2010/11/04 21:33:52.185	  0:04.094	GMVideoOut...0xdb27d710	XVideo	Initializing XV window with 320x240 at 26,26
2010/11/04 21:33:52.186	  0:04.094	GMVideoOut...0xdb27d710	XVideo	XvQueryExtension: Version: 2 Release: 2 Request Base: 132 Event Base: 72 Error Base: 140
2010/11/04 21:33:52.186	  0:04.095	GMVideoOut...0xdb27d710	XVideo	#0, Adaptor: NV40 texture adapter, type: input | image | , ports: 32, first port:�63
2010/11/04 21:33:52.186	  0:04.095	GMVideoOut...0xdb27d710	XVideo	Encoding List for Port 63:  id=0 name=XV_IMAGE size=4096x4096 numerator=1 denominator=1
2010/11/04 21:33:52.186	  0:04.095	GMVideoOut...0xdb27d710	XVideo	Attribute List for Port 63:
2010/11/04 21:33:52.186	  0:04.095	GMVideoOut...0xdb27d710	 �name: � � � XV_SET_DEFAULTS
2010/11/04 21:33:52.186	  0:04.095	GMVideoOut...0xdb27d710	 �flags: � �  set
2010/11/04 21:33:52.186	  0:04.095	GMVideoOut...0xdb27d710	 �min_color: �0
2010/11/04 21:33:52.186	  0:04.095	GMVideoOut...0xdb27d710	 �max_color: �0
2010/11/04 21:33:52.186	  0:04.095	GMVideoOut...0xdb27d710	 �name: � � � XV_SYNC_TO_VBLANK
2010/11/04 21:33:52.186	  0:04.095	GMVideoOut...0xdb27d710	 �flags: � �  get set
2010/11/04 21:33:52.186	  0:04.095	GMVideoOut...0xdb27d710	 �min_color: �0
2010/11/04 21:33:52.186	  0:04.095	GMVideoOut...0xdb27d710	 �max_color: �1
2010/11/04 21:33:52.186	  0:04.095	GMVideoOut...0xdb27d710	XVideo	Image format list for Port 63:
2010/11/04 21:33:52.186	  0:04.095	GMVideoOut...0xdb27d710	  0x32315659 (YV12) planar, order: YVU
2010/11/04 21:33:52.186	  0:04.095	GMVideoOut...0xdb27d710	  0x30323449 (I420) planar, order: YUV
2010/11/04 21:33:52.186	  0:04.095	GMVideoOut...0xdb27d710	XVideo	Grabbed Port: 63
2010/11/04 21:33:52.186	  0:04.095	GMVideoOut...0xdb27d710	XVideo	Using XVideo port: 63
2010/11/04 21:33:52.187	  0:04.096	GMVideoOut...0xdb27d710	XVideo	Found visual with colordepth of 24bits per pixel
2010/11/04 21:33:52.187	  0:04.096	GMVideoOut...0xdb27d710	X11	Created Window with ID 62914562
2010/11/04 21:33:52.187	  0:04.096	GMVideoOut...0xdb27d710	XVideo	Colorkey method: NONE
2010/11/04 21:33:52.187	  0:04.096	GMVideoOut...0xdb27d710	XVideo	Vertical sync successfully activated
2010/11/04 21:33:52.187	  0:04.096	GMVideoOut...0xdb27d710	XVideo	XQueryShmExtension success
2010/11/04 21:33:52.187	  0:04.096	GMVideoOut...0xdb27d710	XVideo	Created XvImage (320x240, data size: 115200, num_planes: 3
2010/11/04 21:33:52.187	  0:04.096	GMVideoOut...0xdb27d710	XVideo	  Plane 0: pitch=320, offset=0
2010/11/04 21:33:52.187	  0:04.096	GMVideoOut...0xdb27d710	XVideo	  Plane 1: pitch=160, offset=76800
2010/11/04 21:33:52.187	  0:04.096	GMVideoOut...0xdb27d710	XVideo	  Plane 2: pitch=160, offset=96000
2010/11/04 21:33:52.188	  0:04.096	GMVideoOut...0xdb27d710	XVideo	Using SHM extension
2010/11/04 21:33:52.188	  0:04.097	GMVideoOut...0xdb27d710	X11	Unknown wm type...
2010/11/04 21:33:52.188	  0:04.097	GMVideoOut...0xdb27d710	GMVideoOutputManager_X	VO_MODE_LOCAL: Successfully opened XV Window
2010/11/04 21:33:52.188	  0:04.097	GMVideoOut...0xdb27d710	X11	Unknown X Event 19 received
2010/11/04 21:33:52.224	  0:04.133	Opal Garbage:0xdb23c710	SIP	Deleting SIPSubscribeHandler sip:500 ekiga net
2010/11/04 21:33:52.224	  0:04.133	Opal Garbage:0xdb23c710	Opal	Transport clean up on termination
2010/11/04 21:33:52.224	  0:04.133	Opal Garbage:0xdb23c710	Opal	Transport Close
2010/11/04 21:33:52.224	  0:04.133	Opal Garbage:0xdb23c710	Opal	Transport clean up on termination
2010/11/04 21:33:52.224	  0:04.133	Opal Garbage:0xdb23c710	Opal	Transport Close
2010/11/04 21:33:52.224	  0:04.133	Opal Garbage:0xdb23c710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.77:5060>
2010/11/04 21:33:52.225	  0:04.134	Opal Garbage:0xdb23c710	SIP	Deleted handler.
2010/11/04 21:33:52.225	  0:04.134	Opal Garbage:0xdb23c710	SIP	Deleting SIPSubscribeHandler sip:500 ekiga net
2010/11/04 21:33:52.225	  0:04.134	Opal Garbage:0xdb23c710	Opal	Transport clean up on termination
2010/11/04 21:33:52.225	  0:04.134	Opal Garbage:0xdb23c710	Opal	Transport Close
2010/11/04 21:33:52.225	  0:04.134	Opal Garbage:0xdb23c710	Opal	Transport clean up on termination
2010/11/04 21:33:52.225	  0:04.134	Opal Garbage:0xdb23c710	Opal	Transport Close
2010/11/04 21:33:52.225	  0:04.134	Opal Garbage:0xdb23c710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.77:5060>
2010/11/04 21:33:52.225	  0:04.134	Opal Garbage:0xdb23c710	SIP	Deleted handler.
2010/11/04 21:33:52.226	  0:04.134	Opal Garbage:0xdb23c710	SIP	Deleting SIPSubscribeHandler sip:501 ekiga net
2010/11/04 21:33:52.226	  0:04.134	Opal Garbage:0xdb23c710	Opal	Transport clean up on termination
2010/11/04 21:33:52.226	  0:04.134	Opal Garbage:0xdb23c710	Opal	Transport Close
2010/11/04 21:33:52.226	  0:04.135	Opal Garbage:0xdb23c710	Opal	Transport clean up on termination
2010/11/04 21:33:52.226	  0:04.135	Opal Garbage:0xdb23c710	Opal	Transport Close
2010/11/04 21:33:52.226	  0:04.135	Opal Garbage:0xdb23c710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.77:5060>
2010/11/04 21:33:52.226	  0:04.135	Opal Garbage:0xdb23c710	SIP	Deleted handler.
2010/11/04 21:33:52.226	  0:04.135	Opal Garbage:0xdb23c710	SIP	Deleting SIPSubscribeHandler sip:501 ekiga net
2010/11/04 21:33:52.226	  0:04.135	Opal Garbage:0xdb23c710	Opal	Transport clean up on termination
2010/11/04 21:33:52.226	  0:04.135	Opal Garbage:0xdb23c710	Opal	Transport Close
2010/11/04 21:33:52.226	  0:04.135	Opal Garbage:0xdb23c710	Opal	Transport clean up on termination
2010/11/04 21:33:52.226	  0:04.135	Opal Garbage:0xdb23c710	Opal	Transport Close
2010/11/04 21:33:52.226	  0:04.135	Opal Garbage:0xdb23c710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.77:5060>
2010/11/04 21:33:52.227	  0:04.136	Opal Garbage:0xdb23c710	SIP	Deleted handler.
2010/11/04 21:33:52.477	  0:04.386	 Housekeeper:0xc80b2710	SIP	Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bK2e56d180-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:52.584	  0:04.493	 Housekeeper:0xc80b2710	SIP	Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bKa06cdf80-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:52.682	  0:04.591	 Housekeeper:0xc80b2710	SIP	Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bK7aa1ee80-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:52.783	  0:04.692	 Housekeeper:0xc80b2710	SIP	Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bK5cbf0281-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:52.854	  0:04.763	 Housekeeper:0xc80b2710	SIP	Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bK3eb50c81-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:52.960	  0:04.869	 Housekeeper:0xc80b2710	SIP	Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bK82041a81-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:53.227	  0:05.136	Opal Garbage:0xdb23c710	SIP	Transaction id=z9hG4bK82041a81-c0e6-df11-8a9b-001a92ce6170 destroyed.
2010/11/04 21:33:53.230	  0:05.138	Opal Garbage:0xdb23c710	SIP	Transaction id=z9hG4bK7aa1ee80-c0e6-df11-8a9b-001a92ce6170 destroyed.
2010/11/04 21:33:53.230	  0:05.139	Opal Garbage:0xdb23c710	SIP	Transaction id=z9hG4bK5cbf0281-c0e6-df11-8a9b-001a92ce6170 destroyed.
2010/11/04 21:33:53.230	  0:05.139	Opal Garbage:0xdb23c710	SIP	Transaction id=z9hG4bK2e56d180-c0e6-df11-8a9b-001a92ce6170 destroyed.
2010/11/04 21:33:53.230	  0:05.139	Opal Garbage:0xdb23c710	SIP	Transaction id=z9hG4bK3eb50c81-c0e6-df11-8a9b-001a92ce6170 destroyed.
2010/11/04 21:33:53.230	  0:05.139	Opal Garbage:0xdb23c710	SIP	Transaction id=z9hG4bKa06cdf80-c0e6-df11-8a9b-001a92ce6170 destroyed.
2010/11/04 21:33:53.593	  0:05.502	                       	Listen	Stopping listening thread on udp$*:5060
2010/11/04 21:33:53.593	  0:05.502	                       	MonSock	Closed UDP socket 0x145ba70
2010/11/04 21:33:53.593	  0:05.502	Opal Liste...0xc8071710	Listen	UDP read error.
2010/11/04 21:33:53.613	  0:05.522	                       	MonSock	Deleting UDP socket 0x145ba70
2010/11/04 21:33:53.614	  0:05.522	                       	PWLib	File handle low water mark set: 33 PUDPSocket
2010/11/04 21:33:53.614	  0:05.522	                       	MonSock	Created socket bundle for all interfaces.
2010/11/04 21:33:53.749	  0:05.658	                       	MonSock	Created bundled UDP socket via STUN, internal=192.168.10.77:5060, external=95.85.164.64:5060
2010/11/04 21:33:53.749	  0:05.658	                       	PTLib	No permission to set priority level 4
2010/11/04 21:33:53.749	  0:05.658	Opal Liste...0xc8071710	Listen	Started listening thread on udp$*:5060
2010/11/04 21:33:53.749	  0:05.658	                       	Listen	Stopping listening thread on tcp$*:1720
2010/11/04 21:33:53.750	  0:05.658	Opal Liste...0xc3fff710	Listen	Started listening thread on tcp$*:1720
2010/11/04 21:33:53.750	  0:05.659	                       	PWLib	File handle high water mark set: 47 Thread unblock pipe
2010/11/04 21:33:53.750	  0:05.659	Opal Liste...0xc3fff710	Listen	Waiting on socket accept on tcp$*:1720
2010/11/04 21:33:53.750	  0:05.659	                       	PTLib	Thread high water mark set: 11
2010/11/04 21:33:53.750	  0:05.659	  subscriber:0xba240710	SIP	Start REGISTER
        aor=csanyipal ekiga net
  registrar=ekiga.net
    contact=
     authID=csanyipal
      realm=
     expire=3600
    restore=30
   minRetry=0.000
   maxRetry=0.000
2010/11/04 21:33:53.750	  0:05.659	  subscriber:0xba240710	SIP	Changing REGISTER handler from Unavailable to Subscribing, target=sip:csanyipal ekiga net, id=4a553c82-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:53.750	  0:05.659	  subscriber:0xba240710	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:53.775	  0:05.684	  subscriber:0xba240710	SIP	No SRV record found.
2010/11/04 21:33:53.775	  0:05.684	  subscriber:0xba240710	OpalUDP	Binding to interface: 0.0.0.0:5060
2010/11/04 21:33:53.776	  0:05.684	  subscriber:0xba240710	PWLib	File handle high water mark set: 49 PUDPSocket
2010/11/04 21:33:53.775	  0:05.684	  subscriber:0xba240710	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2010/11/04 21:33:53.776	  0:05.685	  subscriber:0xba240710	OpalUDP	Started connect to 86.64.162.35:5060
2010/11/04 21:33:53.776	  0:05.685	  subscriber:0xba240710	OpalUDP	Writing to interface 0 - "192.168.10.77%eth0"
2010/11/04 21:33:53.923	  0:05.832	  subscriber:0xba240710	OpalMan	Listener interfaces: associated transport=udp$95.85.164.64:5060
    udp$95.85.164.64:5060,udp$192.168.10.77:5060
2010/11/04 21:33:53.924	  0:05.833	  subscriber:0xba240710	SIP	Transaction created.
2010/11/04 21:33:53.925	  0:05.834	  subscriber:0xba240710	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:53.965	  0:05.874	  subscriber:0xba240710	SIP	No SRV record found.
2010/11/04 21:33:53.965	  0:05.874	  subscriber:0xba240710	SIP	Transaction remote address is udp$ekiga.net:5060
2010/11/04 21:33:53.965	  0:05.874	  subscriber:0xba240710	SIP	Sending PDU (549 bytes) to: rem=udp$86.64.162.35:5060,local=udp$95.85.164.64:5060,if=192.168.10.77%eth0
REGISTER sip:ekiga.net SIP/2.0
CSeq: 1 REGISTER
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK3c025782-c0e6-df11-8a9b-001a92ce6170;rport
User-Agent: Ekiga/3.2.7
From: <sip:csanyipal ekiga net>;tag=8e5c3c82-c0e6-df11-8a9b-001a92ce6170
Call-ID: 4a553c82-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:csanyipal ekiga net>
Contact: <sip:csanyipal 95 85 164 64>;q=1, <sip:csanyipal 192 168 10 77>;q=0.500
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 3600
Content-Length: 0
Max-Forwards: 70


2010/11/04 21:33:53.965	  0:05.874	  subscriber:0xba240710	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:53.966	  0:05.874	  subscriber:0xba240710	SIP	Transaction timers set: retry=0.500, completion=6.000
2010/11/04 21:33:54.013	  0:05.922	Opal Liste...0xc8071710	PWLib	File handle low water mark set: 46 PUDPSocket
2010/11/04 21:33:54.013	  0:05.922	Opal Liste...0xc8071710	OpalUDP	Binding to interface: 95.85.164.64:5060
2010/11/04 21:33:54.013	  0:05.922	Opal Liste...0xc8071710	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$95.85.164.64:5060>
2010/11/04 21:33:54.014	  0:05.923	Opal Liste...0xc8071710	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$95.85.164.64:5060,if=192.168.10.77%eth0
SIP/2.0 401 Unauthorized
CSeq: 1 REGISTER
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK3c025782-c0e6-df11-8a9b-001a92ce6170;rport=5060
Server: Kamailio (1.5.3-notls (i386/linux))
From: <sip:csanyipal ekiga net>;tag=8e5c3c82-c0e6-df11-8a9b-001a92ce6170
Call-ID: 4a553c82-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:csanyipal ekiga net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.828c
Content-Length: 0
WWW-Authenticate: Digest realm="ekiga.net", nonce="4cd30ac600013f03efacad8589550cf5379f43a9169b2837"


2010/11/04 21:33:54.014	  0:05.923	Opal Liste...0xc8071710	SIP	Queueing PDU "1 REGISTER <401>", transaction=z9hG4bK3c025782-c0e6-df11-8a9b-001a92ce6170, token=4a553c82-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:54.014	  0:05.923	Opal Liste...0xc8071710	Opal	Transport clean up on termination
2010/11/04 21:33:54.014	  0:05.923	Opal Liste...0xc8071710	Opal	Transport Close
2010/11/04 21:33:54.014	  0:05.923	        Pool:0xc3fbe710	SIP	Handling PDU "1 REGISTER <401>" for transaction=z9hG4bK3c025782-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:54.014	  0:05.923	        Pool:0xc3fbe710	SIP	REGISTER transaction id=z9hG4bK3c025782-c0e6-df11-8a9b-001a92ce6170 completed.
2010/11/04 21:33:54.015	  0:05.923	        Pool:0xc3fbe710	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:54.015	  0:05.923	        Pool:0xc3fbe710	SIP	Received Authentication Required response
2010/11/04 21:33:54.014	  0:05.923	Opal Liste...0xc8071710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$95.85.164.64:5060>
2010/11/04 21:33:54.015	  0:05.924	        Pool:0xc3fbe710	SIP	Located existing credentials for ID "csanyipal" at realm "ekiga.net"
2010/11/04 21:33:54.015	  0:05.924	        Pool:0xc3fbe710	SIP	Found auth info for realm ekiga.net
2010/11/04 21:33:54.015	  0:05.924	        Pool:0xc3fbe710	SIP	Changing REGISTER handler from Unavailable to Subscribing, target=sip:csanyipal ekiga net, id=4a553c82-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:54.016	  0:05.925	        Pool:0xc3fbe710	OpalMan	Listener interfaces: associated transport=udp$95.85.164.64:5060
    udp$95.85.164.64:5060,udp$192.168.10.77:5060
2010/11/04 21:33:54.016	  0:05.925	        Pool:0xc3fbe710	SIP	Transaction created.
2010/11/04 21:33:54.017	  0:05.926	        Pool:0xc3fbe710	SIP	Adding authentication information for user "csanyipal" at realm "ekiga.net"
2010/11/04 21:33:54.017	  0:05.926	        Pool:0xc3fbe710	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:54.082	  0:05.991	        Pool:0xc3fbe710	SIP	No SRV record found.
2010/11/04 21:33:54.082	  0:05.991	        Pool:0xc3fbe710	SIP	Transaction remote address is udp$ekiga.net:5060
2010/11/04 21:33:54.083	  0:05.991	        Pool:0xc3fbe710	SIP	Sending PDU (751 bytes) to: rem=udp$86.64.162.35:5060,local=udp$95.85.164.64:5060,if=192.168.10.77%eth0
REGISTER sip:ekiga.net SIP/2.0
CSeq: 2 REGISTER
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK5c1a6582-c0e6-df11-8a9b-001a92ce6170;rport
User-Agent: Ekiga/3.2.7
Authorization: Digest username="csanyipal", realm="ekiga.net", nonce="4cd30ac600013f03efacad8589550cf5379f43a9169b2837", uri="sip:ekiga.net", algorithm=MD5, response="828a1e800902443dca9f7ce6a3ab32f1"
From: <sip:csanyipal ekiga net>;tag=8e5c3c82-c0e6-df11-8a9b-001a92ce6170
Call-ID: 4a553c82-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:csanyipal ekiga net>
Contact: <sip:csanyipal 95 85 164 64>;q=1, <sip:csanyipal 192 168 10 77>;q=0.500
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 3600
Content-Length: 0
Max-Forwards: 70


2010/11/04 21:33:54.083	  0:05.992	        Pool:0xc3fbe710	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:54.083	  0:05.992	        Pool:0xc3fbe710	SIP	Transaction timers set: retry=0.500, completion=6.000
2010/11/04 21:33:54.083	  0:05.992	        Pool:0xc3fbe710	SIP	Handled PDU "1 REGISTER <401>"
2010/11/04 21:33:54.150	  0:06.059	Opal Liste...0xc8071710	OpalUDP	Binding to interface: 95.85.164.64:5060
2010/11/04 21:33:54.150	  0:06.059	Opal Liste...0xc8071710	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$95.85.164.64:5060>
2010/11/04 21:33:54.150	  0:06.059	Opal Liste...0xc8071710	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$95.85.164.64:5060,if=192.168.10.77%eth0
SIP/2.0 200 OK
CSeq: 2 REGISTER
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK5c1a6582-c0e6-df11-8a9b-001a92ce6170;rport=5060
Server: Kamailio (1.5.3-notls (i386/linux))
From: <sip:csanyipal ekiga net>;tag=8e5c3c82-c0e6-df11-8a9b-001a92ce6170
Call-ID: 4a553c82-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:csanyipal ekiga net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.abc0
Contact: <sip:csanyipal 95 85 164 64>;q=1;expires=1200, <sip:csanyipal 192 168 10 77>;q=0.5;expires=1200, <sip:csanyipal 95 85 164 64, sip:5060>;expires=1109
Content-Length: 0


2010/11/04 21:33:54.151	  0:06.060	Opal Liste...0xc8071710	SIP	Queueing PDU "2 REGISTER <200>", transaction=z9hG4bK5c1a6582-c0e6-df11-8a9b-001a92ce6170, token=4a553c82-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:54.151	  0:06.060	Opal Liste...0xc8071710	Opal	Transport clean up on termination
2010/11/04 21:33:54.151	  0:06.060	Opal Liste...0xc8071710	Opal	Transport Close
2010/11/04 21:33:54.151	  0:06.060	        Pool:0xc3fbe710	SIP	Handling PDU "2 REGISTER <200>" for transaction=z9hG4bK5c1a6582-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:54.151	  0:06.060	        Pool:0xc3fbe710	SIP	REGISTER transaction id=z9hG4bK5c1a6582-c0e6-df11-8a9b-001a92ce6170 completed.
2010/11/04 21:33:54.151	  0:06.060	        Pool:0xc3fbe710	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:54.151	  0:06.060	        Pool:0xc3fbe710	SIP	Product Info: name="Kamailio", version="", vendor="", comments="(1.5.3-notls (i386/linux))"
2010/11/04 21:33:54.151	  0:06.060	        Pool:0xc3fbe710	SIP	Changing REGISTER handler from Subscribing to Subscribed, target=sip:csanyipal ekiga net, id=4a553c82-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:54.151	  0:06.060	Opal Liste...0xc8071710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$95.85.164.64:5060>
2010/11/04 21:33:54.152	  0:06.061	        Pool:0xc3fbe710	SIP	Expiry time for REGISTER set to 1200 seconds.
2010/11/04 21:33:54.152	  0:06.061	        Pool:0xc3fbe710	SIP	Expiry time for REGISTER set to 1200 seconds.
2010/11/04 21:33:54.152	  0:06.061	        Pool:0xc3fbe710	SIP	Product Info: name="Kamailio", version="", vendor="", comments="(1.5.3-notls (i386/linux))"
2010/11/04 21:33:54.152	  0:06.061	        Pool:0xc3fbe710	SIP	Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:csanyipal ekiga net, id=4eaf7982-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:54.152	  0:06.061	        Pool:0xc3fbe710	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:54.178	  0:06.087	        Pool:0xc3fbe710	SIP	No SRV record found.
2010/11/04 21:33:54.178	  0:06.087	        Pool:0xc3fbe710	OpalUDP	Binding to interface: 0.0.0.0:5060
2010/11/04 21:33:54.178	  0:06.087	        Pool:0xc3fbe710	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2010/11/04 21:33:54.179	  0:06.087	        Pool:0xc3fbe710	OpalUDP	Started connect to 86.64.162.35:5060
2010/11/04 21:33:54.179	  0:06.088	        Pool:0xc3fbe710	OpalUDP	Writing to interface 0 - "192.168.10.77%eth0"
2010/11/04 21:33:54.179	  0:06.088	        Pool:0xc3fbe710	SIP	Transaction created.
2010/11/04 21:33:54.181	  0:06.090	        Pool:0xc3fbe710	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:54.246	  0:06.155	        Pool:0xc3fbe710	SIP	No SRV record found.
2010/11/04 21:33:54.247	  0:06.155	        Pool:0xc3fbe710	SIP	Transaction remote address is udp$ekiga.net:5060
2010/11/04 21:33:54.247	  0:06.156	        Pool:0xc3fbe710	SIP	Sending PDU (586 bytes) to: rem=udp$86.64.162.35:5060,local=udp$95.85.164.64:5060,if=192.168.10.77%eth0
SUBSCRIBE sip:csanyipal ekiga net SIP/2.0
CSeq: 2 SUBSCRIBE
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK68e67d82-c0e6-df11-8a9b-001a92ce6170;rport
User-Agent: Ekiga/3.2.7
From: <sip:csanyipal ekiga net>;tag=88c17d82-c0e6-df11-8a9b-001a92ce6170
Call-ID: 4eaf7982-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:csanyipal ekiga net>
Contact: <sip:csanyipal 95 85 164 64>
Accept: application/simple-message-summary
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 3600
Event: message-summary
Content-Length: 0
Max-Forwards: 70


2010/11/04 21:33:54.247	  0:06.156	        Pool:0xc3fbe710	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:54.247	  0:06.156	        Pool:0xc3fbe710	SIP	Transaction timers set: retry=0.500, completion=6.000
2010/11/04 21:33:54.247	  0:06.156	        Pool:0xc3fbe710	SIP	Handled PDU "2 REGISTER <200>"
2010/11/04 21:33:54.251	  0:06.160	                       	SIP	Changing PUBLISH handler from Unavailable to Subscribing, target=sip:csanyipal ekiga net, id=98bf8882-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:54.251	  0:06.160	                       	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:54.279	  0:06.188	                       	SIP	No SRV record found.
2010/11/04 21:33:54.280	  0:06.189	                       	OpalUDP	Binding to interface: 0.0.0.0:5060
2010/11/04 21:33:54.280	  0:06.189	                       	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2010/11/04 21:33:54.280	  0:06.189	                       	OpalUDP	Started connect to 86.64.162.35:5060
2010/11/04 21:33:54.280	  0:06.189	                       	OpalUDP	Writing to interface 0 - "192.168.10.77%eth0"
2010/11/04 21:33:54.280	  0:06.189	                       	SIP	Transaction created.
2010/11/04 21:33:54.282	  0:06.191	                       	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:54.294	  0:06.203	Opal Liste...0xc8071710	OpalUDP	Binding to interface: 95.85.164.64:5060
2010/11/04 21:33:54.294	  0:06.203	Opal Liste...0xc8071710	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$95.85.164.64:5060>
2010/11/04 21:33:54.295	  0:06.204	Opal Liste...0xc8071710	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$95.85.164.64:5060,if=192.168.10.77%eth0
SIP/2.0 489 Event Not Supported
CSeq: 2 SUBSCRIBE
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK68e67d82-c0e6-df11-8a9b-001a92ce6170;rport=5060
Server: Kamailio (1.5.3-notls (i386/linux))
From: <sip:csanyipal ekiga net>;tag=88c17d82-c0e6-df11-8a9b-001a92ce6170
Call-ID: 4eaf7982-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:csanyipal ekiga net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.89e9
Content-Length: 0


2010/11/04 21:33:54.295	  0:06.204	Opal Liste...0xc8071710	SIP	Queueing PDU "2 SUBSCRIBE <489>", transaction=z9hG4bK68e67d82-c0e6-df11-8a9b-001a92ce6170, token=4eaf7982-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:54.295	  0:06.204	Opal Liste...0xc8071710	Opal	Transport clean up on termination
2010/11/04 21:33:54.295	  0:06.204	Opal Liste...0xc8071710	Opal	Transport Close
2010/11/04 21:33:54.295	  0:06.204	        Pool:0xc3fbe710	SIP	Handling PDU "2 SUBSCRIBE <489>" for transaction=z9hG4bK68e67d82-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:54.295	  0:06.204	        Pool:0xc3fbe710	SIP	SUBSCRIBE transaction id=z9hG4bK68e67d82-c0e6-df11-8a9b-001a92ce6170 completed.
2010/11/04 21:33:54.295	  0:06.204	        Pool:0xc3fbe710	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:54.296	  0:06.204	        Pool:0xc3fbe710	SIP	Not retrying SUBSCRIBE due to error response 489 Bad Event
2010/11/04 21:33:54.296	  0:06.204	        Pool:0xc3fbe710	SIP	Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:csanyipal ekiga net, id=4eaf7982-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:54.295	  0:06.204	Opal Liste...0xc8071710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$95.85.164.64:5060>
2010/11/04 21:33:54.296	  0:06.205	        Pool:0xc3fbe710	SIP	Handled PDU "2 SUBSCRIBE <489>"
2010/11/04 21:33:54.307	  0:06.216	                       	SIP	No SRV record found.
2010/11/04 21:33:54.307	  0:06.216	                       	SIP	Transaction remote address is udp$ekiga.net:5060
2010/11/04 21:33:54.307	  0:06.216	                       	SIP	Sending PDU (830 bytes) to: rem=udp$86.64.162.35:5060,local=udp$95.85.164.64:5060,if=192.168.10.77%eth0
PUBLISH sip:csanyipal ekiga net SIP/2.0
CSeq: 3 PUBLISH
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK68638d82-c0e6-df11-8a9b-001a92ce6170;rport
User-Agent: Ekiga/3.2.7
From: <sip:csanyipal ekiga net>;tag=f4408d82-c0e6-df11-8a9b-001a92ce6170
Call-ID: 98bf8882-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:csanyipal ekiga net>
Contact: <sip:csanyipal 95 85 164 64>
Expires: 500
Event: presence
Content-Type: application/pidf+xml
Content-Length: 341
Max-Forwards: 70

<?xml version="1.0" encoding="UTF-8"?>
<presence xmlns="urn:ietf:params:xml:ns:pidf" entity="pres:csanyipal ekiga net">
<tuple id="sip:csanyipal ekiga net_on_debian-asztal">
<note>online - I'm online using Ekiga</note>
<status>
<basic>open</basic>
</status>
<contact priority="1">csanyipal ekiga net</contact>
</tuple>
</presence>

2010/11/04 21:33:54.307	  0:06.216	                       	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:54.308	  0:06.216	                       	SIP	Transaction timers set: retry=0.500, completion=6.000
2010/11/04 21:33:54.372	  0:06.281	Opal Liste...0xc8071710	OpalUDP	Binding to interface: 95.85.164.64:5060
2010/11/04 21:33:54.372	  0:06.281	Opal Liste...0xc8071710	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$95.85.164.64:5060>
2010/11/04 21:33:54.372	  0:06.281	Opal Liste...0xc8071710	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$95.85.164.64:5060,if=192.168.10.77%eth0
SIP/2.0 200 OK
CSeq: 3 PUBLISH
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK68638d82-c0e6-df11-8a9b-001a92ce6170;rport=5060
Server: Kamailio (1.5.3-notls (i386/linux))
From: <sip:csanyipal ekiga net>;tag=f4408d82-c0e6-df11-8a9b-001a92ce6170
Call-ID: 98bf8882-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:csanyipal ekiga net>;tag=f85b0bd16aaafa8479586ac9f88b3198-c892
Expires: 495
Content-Length: 0
SIP-ETag: a.1277353562.26838.11527302.0


2010/11/04 21:33:54.373	  0:06.282	Opal Liste...0xc8071710	SIP	Queueing PDU "3 PUBLISH <200>", transaction=z9hG4bK68638d82-c0e6-df11-8a9b-001a92ce6170, token=98bf8882-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:54.373	  0:06.282	Opal Liste...0xc8071710	Opal	Transport clean up on termination
2010/11/04 21:33:54.373	  0:06.282	Opal Liste...0xc8071710	Opal	Transport Close
2010/11/04 21:33:54.373	  0:06.282	        Pool:0xc3fbe710	SIP	Handling PDU "3 PUBLISH <200>" for transaction=z9hG4bK68638d82-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:54.373	  0:06.282	        Pool:0xc3fbe710	SIP	PUBLISH transaction id=z9hG4bK68638d82-c0e6-df11-8a9b-001a92ce6170 completed.
2010/11/04 21:33:54.373	  0:06.282	        Pool:0xc3fbe710	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:54.373	  0:06.282	        Pool:0xc3fbe710	SIP	Expiry time for PUBLISH set to 495 seconds.
2010/11/04 21:33:54.373	  0:06.282	        Pool:0xc3fbe710	SIP	Product Info: name="Kamailio", version="", vendor="", comments="(1.5.3-notls (i386/linux))"
2010/11/04 21:33:54.373	  0:06.282	        Pool:0xc3fbe710	SIP	Changing PUBLISH handler from Subscribing to Subscribed, target=sip:csanyipal ekiga net, id=98bf8882-c0e6-df11-8a9b-001a92ce6170 debian-asztal
2010/11/04 21:33:54.373	  0:06.282	Opal Liste...0xc8071710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$95.85.164.64:5060>
2010/11/04 21:33:54.373	  0:06.282	        Pool:0xc3fbe710	SIP	Handled PDU "3 PUBLISH <200>"
2010/11/04 21:33:55.083	  0:06.992	 Housekeeper:0xc80b2710	SIP	Set state Terminated_Success for REGISTER transaction id=z9hG4bK3c025782-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:55.248	  0:07.157	Opal Garbage:0xdb23c710	SIP	Transaction id=z9hG4bK3c025782-c0e6-df11-8a9b-001a92ce6170 destroyed.
2010/11/04 21:33:55.248	  0:07.157	 Housekeeper:0xc80b2710	SIP	Set state Terminated_Success for REGISTER transaction id=z9hG4bK5c1a6582-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:55.248	  0:07.157	Opal Garbage:0xdb23c710	SIP	Deleting SIPSubscribeHandler sip:csanyipal ekiga net
2010/11/04 21:33:55.248	  0:07.157	Opal Garbage:0xdb23c710	Opal	Transport clean up on termination
2010/11/04 21:33:55.248	  0:07.157	Opal Garbage:0xdb23c710	Opal	Transport Close
2010/11/04 21:33:55.248	  0:07.157	Opal Garbage:0xdb23c710	Opal	Transport clean up on termination
2010/11/04 21:33:55.248	  0:07.157	Opal Garbage:0xdb23c710	Opal	Transport Close
2010/11/04 21:33:55.248	  0:07.157	Opal Garbage:0xdb23c710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$95.85.164.64:5060>
2010/11/04 21:33:55.248	  0:07.157	Opal Garbage:0xdb23c710	SIP	Deleted handler.
2010/11/04 21:33:55.297	  0:07.206	 Housekeeper:0xc80b2710	SIP	Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bK68e67d82-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:55.373	  0:07.282	 Housekeeper:0xc80b2710	SIP	Set state Terminated_Success for PUBLISH transaction id=z9hG4bK68638d82-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:56.249	  0:08.158	Opal Garbage:0xdb23c710	SIP	Transaction id=z9hG4bK68e67d82-c0e6-df11-8a9b-001a92ce6170 destroyed.
2010/11/04 21:33:56.249	  0:08.158	Opal Garbage:0xdb23c710	SIP	Transaction id=z9hG4bK68638d82-c0e6-df11-8a9b-001a92ce6170 destroyed.
2010/11/04 21:33:56.249	  0:08.158	Opal Garbage:0xdb23c710	SIP	Transaction id=z9hG4bK5c1a6582-c0e6-df11-8a9b-001a92ce6170 destroyed.
2010/11/04 21:33:58.301	  0:10.210	 Housekeeper:0xc80b2710	Opal	Transport clean up on termination
2010/11/04 21:33:58.303	  0:10.212	 Housekeeper:0xc80b2710	Opal	Transport Close
2010/11/04 21:33:58.303	  0:10.212	 Housekeeper:0xc80b2710	Opal	Transport clean up on termination
2010/11/04 21:33:58.303	  0:10.212	 Housekeeper:0xc80b2710	Opal	Transport Close
2010/11/04 21:33:58.303	  0:10.212	 Housekeeper:0xc80b2710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.77:5060>
2010/11/04 21:33:58.303	  0:10.212	 Housekeeper:0xc80b2710	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:58.330	  0:10.239	 Housekeeper:0xc80b2710	SIP	No SRV record found.
2010/11/04 21:33:58.330	  0:10.239	 Housekeeper:0xc80b2710	OpalUDP	Binding to interface: 0.0.0.0:5060
2010/11/04 21:33:58.330	  0:10.239	 Housekeeper:0xc80b2710	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2010/11/04 21:33:58.331	  0:10.240	 Housekeeper:0xc80b2710	OpalUDP	Started connect to 86.64.162.35:5060
2010/11/04 21:33:58.331	  0:10.240	 Housekeeper:0xc80b2710	Opal	Transport clean up on termination
2010/11/04 21:33:58.331	  0:10.240	 Housekeeper:0xc80b2710	Opal	Transport Close
2010/11/04 21:33:58.331	  0:10.240	 Housekeeper:0xc80b2710	Opal	Transport clean up on termination
2010/11/04 21:33:58.331	  0:10.240	 Housekeeper:0xc80b2710	Opal	Transport Close
2010/11/04 21:33:58.331	  0:10.240	 Housekeeper:0xc80b2710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.77:5060>
2010/11/04 21:33:58.332	  0:10.240	 Housekeeper:0xc80b2710	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:58.362	  0:10.271	 Housekeeper:0xc80b2710	SIP	No SRV record found.
2010/11/04 21:33:58.362	  0:10.271	 Housekeeper:0xc80b2710	OpalUDP	Binding to interface: 0.0.0.0:5060
2010/11/04 21:33:58.362	  0:10.271	 Housekeeper:0xc80b2710	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2010/11/04 21:33:58.363	  0:10.271	 Housekeeper:0xc80b2710	OpalUDP	Started connect to 86.64.162.35:5060
2010/11/04 21:33:58.463	  0:10.372	                       	OpalMan	Set up call from pc:* to sip:letonga ekiga net
2010/11/04 21:33:58.464	  0:10.372	                       	Call	Created Call[ka4210d591]
2010/11/04 21:33:58.464	  0:10.373	                       	OpalMan	Set up connection to "pc:*"
2010/11/04 21:33:58.464	  0:10.373	                       	OpalCon	Created connection Call[ka4210d591]-EP<pc>[hdb8ada662]
2010/11/04 21:33:58.464	  0:10.373	                       	Silence	Parameters set: mode=NoSilenceDetection, threshold=0, silencedb=3200, signaldb=80, period=4800
2010/11/04 21:33:58.464	  0:10.373	                       	Silence	Handler created
2010/11/04 21:33:58.464	  0:10.373	                       	Echo Canceler	Handler created
2010/11/04 21:33:58.464	  0:10.373	                       	PCSS	Created PC sound system connection: token="hdb8ada662" player="EKIGA" recorder="EKIGA"
2010/11/04 21:33:58.464	  0:10.373	                       	OpalCon	SetPhase from UninitialisedPhase to SetUpPhase for Call[ka4210d591]-EP<pc>[hdb8ada662]
2010/11/04 21:33:58.464	  0:10.373	                       	OpalMan	OnIncoming connection Call[ka4210d591]-EP<pc>[hdb8ada662]
2010/11/04 21:33:58.464	  0:10.373	                       	OpalCon	Applying string options:


2010/11/04 21:33:58.464	  0:10.373	                       	Call	GetOtherPartyConnection Call[ka4210d591]-EP<pc>[hdb8ada662]
2010/11/04 21:33:58.464	  0:10.373	                       	OpalMan	Searching for route "pc:csanyipal	sip:letonga ekiga net"
2010/11/04 21:33:58.464	  0:10.373	                       	OpalMan	Set up connection to "sip:letonga ekiga net"
2010/11/04 21:33:58.465	  0:10.373	                       	OpalCon	Created connection Call[ka4210d591]-EP<sip>[8eb20b85-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:33:58.465	  0:10.373	                       	RFC2833	Handler created
2010/11/04 21:33:58.465	  0:10.373	                       	RFC2833	Handler created
2010/11/04 21:33:58.465	  0:10.374	                       	SIP	Created connection.
2010/11/04 21:33:58.465	  0:10.374	                       	PCSS	Outgoing call routed to sip:letonga ekiga net for Call[ka4210d591]-EP<pc>[hdb8ada662]
2010/11/04 21:33:58.465	  0:10.374	                       	OpalMan	SetUpCall succeeded, call=Call[ka4210d591]
2010/11/04 21:33:58.466	  0:10.375	   CallSetup:0xba240710	Call	OnSetUp Call[ka4210d591]-EP<pc>[hdb8ada662]
2010/11/04 21:33:58.467	  0:10.375	   CallSetup:0xba240710	SIP	SetUpConnection: sip:letonga ekiga net
2010/11/04 21:33:58.467	  0:10.375	   CallSetup:0xba240710	OpalCon	SetPhase from UninitialisedPhase to SetUpPhase for Call[ka4210d591]-EP<sip>[8eb20b85-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:33:58.467	  0:10.375	   CallSetup:0xba240710	OpalCon	Applying string options:


2010/11/04 21:33:58.467	  0:10.376	   CallSetup:0xba240710	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:58.495	  0:10.404	   CallSetup:0xba240710	SIP	No SRV record found.
2010/11/04 21:33:58.495	  0:10.404	   CallSetup:0xba240710	SIP	Connecting to sip:letonga ekiga net via sip:letonga ekiga net
2010/11/04 21:33:58.495	  0:10.404	   CallSetup:0xba240710	SIP	Found registrar on domain ekiga.net, using interface 192.168.10.77%eth0
2010/11/04 21:33:58.496	  0:10.405	   CallSetup:0xba240710	OpalUDP	Binding to interface: 192.168.10.77:5060
2010/11/04 21:33:58.496	  0:10.405	   CallSetup:0xba240710	SIP	Created transport udp$86.64.162.35:5060<if=udp$95.85.164.64:5060>
2010/11/04 21:33:58.496	  0:10.405	   CallSetup:0xba240710	OpalUDP	Started connect to 86.64.162.35:5060
2010/11/04 21:33:58.496	  0:10.405	   CallSetup:0xba240710	SIP	Updating dialog tag from "" to "8eb20b85-c0e6-df11-8a9b-001a92ce6170"
2010/11/04 21:33:58.499	  0:10.407	   CallSetup:0xba240710	SIP	INVITE transaction id=z9hG4bK3ce11085-c0e6-df11-8a9b-001a92ce6170 created.
2010/11/04 21:33:58.499	  0:10.407	   CallSetup:0xba240710	SIP	Creating INVITE request
2010/11/04 21:33:58.502	  0:10.410	   CallSetup:0xba240710	MediaFormat	Removing codecs PCM-16-48kHz,CELT-48K,PCM-16-32kHz,CELT-32K,PCM-16-16kHz,G.722-64k,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,PCM-16,G.711-uLaw-64k,G.726-16k,G.726-24k,G.726-32k,G.726-40k,GSM-06.10,GSM-AMR,LPC-10,MS-GSM,MS-IMA-ADPCM,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,YUV420P,RFC4175_YCbCr-4:2:0,theora,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz
2010/11/04 21:33:58.502	  0:10.411	   CallSetup:0xba240710	MediaFormat	Removing codecs PCM-16-48kHz,CELT-48K,PCM-16-32kHz,CELT-32K,PCM-16-16kHz,G.722-64k,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,PCM-16,G.711-uLaw-64k,G.726-16k,G.726-24k,G.726-32k,G.726-40k,GSM-06.10,GSM-AMR,LPC-10,MS-GSM,MS-IMA-ADPCM,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,YUV420P,RFC4175_YCbCr-4:2:0,theora,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz
2010/11/04 21:33:58.502	  0:10.411	   CallSetup:0xba240710	Call	GetMediaFormats for Call[ka4210d591]-EP<sip>[8eb20b85-c0e6-df11-8a9b-001a92ce6170]
G.711-ALaw-64k
SpeexIETFNarrow-8k
SpeexNB
SpeexWNarrow-8k
H.261
H.261-CIF
H.261-QCIF

2010/11/04 21:33:58.502	  0:10.411	   CallSetup:0xba240710	SIP	Offering media type audio in SDP with formats
G.711-ALaw-64k,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,H.261,H.261-CIF,H.261-QCIF
2010/11/04 21:33:58.502	  0:10.411	   CallSetup:0xba240710	Call	IsMediaBypassPossible Call[ka4210d591]-EP<sip>[8eb20b85-c0e6-df11-8a9b-001a92ce6170] session 1
2010/11/04 21:33:58.502	  0:10.411	   CallSetup:0xba240710	OpalMan	IsMediaBypassPossible: session 1
2010/11/04 21:33:58.503	  0:10.411	   CallSetup:0xba240710	OpalCon	IsMediaBypassPossible: default returns false
2010/11/04 21:33:58.503	  0:10.411	   CallSetup:0xba240710	RTP	Cannot find media session 1
2010/11/04 21:33:58.503	  0:10.411	   CallSetup:0xba240710	RTP	Cannot find RTP session 1
2010/11/04 21:33:58.503	  0:10.412	   CallSetup:0xba240710	RTP_UDP	Session 1, created with NAT flag set to 0
2010/11/04 21:33:58.503	  0:10.412	   CallSetup:0xba240710	PWLib	File handle high water mark set: 50 PUDPSocket
2010/11/04 21:33:58.503	  0:10.412	   CallSetup:0xba240710	PWLib	File handle high water mark set: 51 PUDPSocket
2010/11/04 21:33:58.504	  0:10.412	   CallSetup:0xba240710	PWLib	File handle high water mark set: 52 PUDPSocket
2010/11/04 21:33:59.074	  0:10.983	   CallSetup:0xba240710	RTP	Session 1, STUN created STUN RTP/RTCP socket pair.
2010/11/04 21:33:59.075	  0:10.983	   CallSetup:0xba240710	RTP_UDP	Session 1 created: 95.85.164.64:5062-5063 ssrc=454801198
2010/11/04 21:33:59.075	  0:10.984	   CallSetup:0xba240710	PWLib	File handle low water mark set: 49 PUDPSocket
2010/11/04 21:33:59.075	  0:10.984	   CallSetup:0xba240710	RTP	Creating new session RTP_UDP
2010/11/04 21:33:59.075	  0:10.984	   CallSetup:0xba240710	RTP	Found existing media session 1
2010/11/04 21:33:59.076	  0:10.984	   CallSetup:0xba240710	SDP	SDP not including SpeexIETFNarrow-8k as it is not a SIP transportable format
2010/11/04 21:33:59.076	  0:10.984	   CallSetup:0xba240710	SDP	SDP not including SpeexWNarrow-8k as it is not a SIP transportable format
2010/11/04 21:33:59.076	  0:10.984	   CallSetup:0xba240710	SIP	Using default RTP payload [pt=101] for UserInput/RFC2833
2010/11/04 21:33:59.076	  0:10.985	   CallSetup:0xba240710	SIP	Using default RTP payload [pt=122] for NamedSignalEvent
2010/11/04 21:33:59.079	  0:10.987	   CallSetup:0xba240710	MediaFormat	Removing codecs PCM-16-48kHz,CELT-48K,PCM-16-32kHz,CELT-32K,PCM-16-16kHz,G.722-64k,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,PCM-16,G.711-uLaw-64k,G.726-16k,G.726-24k,G.726-32k,G.726-40k,GSM-06.10,GSM-AMR,LPC-10,MS-GSM,MS-IMA-ADPCM,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,YUV420P,RFC4175_YCbCr-4:2:0,theora,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz
2010/11/04 21:33:59.079	  0:10.988	   CallSetup:0xba240710	MediaFormat	Removing codecs PCM-16-48kHz,CELT-48K,PCM-16-32kHz,CELT-32K,PCM-16-16kHz,G.722-64k,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,PCM-16,G.711-uLaw-64k,G.726-16k,G.726-24k,G.726-32k,G.726-40k,GSM-06.10,GSM-AMR,LPC-10,MS-GSM,MS-IMA-ADPCM,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,YUV420P,RFC4175_YCbCr-4:2:0,theora,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz
2010/11/04 21:33:59.079	  0:10.988	   CallSetup:0xba240710	Call	GetMediaFormats for Call[ka4210d591]-EP<sip>[8eb20b85-c0e6-df11-8a9b-001a92ce6170]
G.711-ALaw-64k
SpeexIETFNarrow-8k
SpeexNB
SpeexWNarrow-8k
H.261
H.261-CIF
H.261-QCIF

2010/11/04 21:33:59.079	  0:10.988	   CallSetup:0xba240710	SIP	Offering media type video in SDP with formats
G.711-ALaw-64k,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,H.261,H.261-CIF,H.261-QCIF
2010/11/04 21:33:59.079	  0:10.988	   CallSetup:0xba240710	Call	IsMediaBypassPossible Call[ka4210d591]-EP<sip>[8eb20b85-c0e6-df11-8a9b-001a92ce6170] session 2
2010/11/04 21:33:59.079	  0:10.988	   CallSetup:0xba240710	OpalMan	IsMediaBypassPossible: session 2
2010/11/04 21:33:59.080	  0:10.988	   CallSetup:0xba240710	OpalCon	IsMediaBypassPossible: default returns false
2010/11/04 21:33:59.080	  0:10.988	   CallSetup:0xba240710	RTP	Cannot find media session 2
2010/11/04 21:33:59.080	  0:10.988	   CallSetup:0xba240710	RTP	Cannot find RTP session 2
2010/11/04 21:33:59.080	  0:10.989	   CallSetup:0xba240710	RTP_UDP	Session 2, created with NAT flag set to 0
2010/11/04 21:33:59.080	  0:10.989	   CallSetup:0xba240710	PWLib	File handle high water mark set: 53 PUDPSocket
2010/11/04 21:33:59.080	  0:10.989	   CallSetup:0xba240710	PWLib	File handle high water mark set: 54 PUDPSocket
2010/11/04 21:33:59.647	  0:11.556	   CallSetup:0xba240710	RTP	Session 2, STUN created STUN RTP/RTCP socket pair.
2010/11/04 21:33:59.647	  0:11.556	   CallSetup:0xba240710	RTP_UDP	Session 2 created: 95.85.164.64:5066-5067 ssrc=2942473065
2010/11/04 21:33:59.648	  0:11.556	   CallSetup:0xba240710	PWLib	File handle low water mark set: 49 PUDPSocket
2010/11/04 21:33:59.648	  0:11.556	   CallSetup:0xba240710	RTP	Creating new session RTP_UDP
2010/11/04 21:33:59.648	  0:11.556	   CallSetup:0xba240710	RTP	Found existing media session 2
2010/11/04 21:33:59.648	  0:11.557	   CallSetup:0xba240710	SDP	SDP not including H.261-CIF as it is not a SIP transportable format
2010/11/04 21:33:59.648	  0:11.557	   CallSetup:0xba240710	SDP	SDP not including H.261-QCIF as it is not a SIP transportable format
2010/11/04 21:33:59.648	  0:11.557	   CallSetup:0xba240710	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:33:59.675	  0:11.584	   CallSetup:0xba240710	SIP	No SRV record found.
2010/11/04 21:33:59.675	  0:11.584	   CallSetup:0xba240710	SIP	Transaction remote address is udp$ekiga.net:5060
2010/11/04 21:33:59.676	  0:11.584	   CallSetup:0xba240710	OpalPlugin	to_customised_options: H.261
2010/11/04 21:33:59.676	  0:11.585	   CallSetup:0xba240710	OpalPlugin	to_customised_options changed option "Frame Width" from "320" to "176"
2010/11/04 21:33:59.676	  0:11.585	   CallSetup:0xba240710	OpalPlugin	to_customised_options changed option "Frame Height" from "240" to "144"
2010/11/04 21:33:59.676	  0:11.585	   CallSetup:0xba240710	SIP	Sending PDU (1012 bytes) to: rem=udp$86.64.162.35:5060,local=udp$95.85.164.64:5060,if=192.168.10.77%eth0
INVITE sip:letonga ekiga net SIP/2.0
Date: Thu, 04 Nov 2010 20:33:58 GMT
CSeq: 1 INVITE
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK3ce11085-c0e6-df11-8a9b-001a92ce6170;rport
User-Agent: Ekiga/3.2.7
From: "Csányi Pál" <sip:csanyipal ekiga net>;tag=8eb20b85-c0e6-df11-8a9b-001a92ce6170
Call-ID: aeba0b85-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:letonga ekiga net>
Contact: <sip:csanyipal 95 85 164 64>
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Content-Type: application/sdp
Content-Length: 434
Max-Forwards: 70

v=0
o=- 1288902838 1 IN IP4 95.85.164.64
s=Opal SIP Session
c=IN IP4 95.85.164.64
t=0 0
m=audio 5062 RTP/AVP 8 110 101 122
a=sendrecv
a=rtpmap:8 PCMA/8000/1
a=rtpmap:110 Speex/8000/1
a=fmtp:110 sr=8000,mode=any
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16,32,36
a=rtpmap:122 NSE/8000
a=fmtp:122 192-193
m=video 5066 RTP/AVP 31
b=AS:4096
b=TIAS:4096000
a=sendrecv
a=rtpmap:31 h261/90000
a=fmtp:31 CIF=1;QCIF=1

2010/11/04 21:33:59.677	  0:11.586	   CallSetup:0xba240710	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:59.677	  0:11.586	   CallSetup:0xba240710	SIP	Transaction timers set: retry=0.500, completion=1:00.000
2010/11/04 21:33:59.677	  0:11.586	   CallSetup:0xba240710	OpalCon	OnSetUpConnectionCall[ka4210d591]-EP<sip>[8eb20b85-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:33:59.677	  0:11.586	   CallSetup:0xba240710	OpalEP	OnSetUpConnection Call[ka4210d591]-EP<sip>[8eb20b85-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:33:59.729	  0:11.638	Opal Liste...0xc8071710	PWLib	File handle low water mark set: 46 PUDPSocket
2010/11/04 21:33:59.729	  0:11.638	Opal Liste...0xc8071710	OpalUDP	Binding to interface: 95.85.164.64:5060
2010/11/04 21:33:59.729	  0:11.638	Opal Liste...0xc8071710	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$95.85.164.64:5060>
2010/11/04 21:33:59.730	  0:11.638	Opal Liste...0xc8071710	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$95.85.164.64:5060,if=192.168.10.77%eth0
SIP/2.0 405 Method Not Allowed
CSeq: 1 INVITE
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK3ce11085-c0e6-df11-8a9b-001a92ce6170;rport=5060
Server: Kamailio (1.5.3-notls (i386/linux))
From: "Csányi Pál" <sip:csanyipal ekiga net>;tag=8eb20b85-c0e6-df11-8a9b-001a92ce6170
Call-ID: aeba0b85-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:letonga ekiga net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.6249
Content-Length: 0


2010/11/04 21:33:59.730	  0:11.639	Opal Liste...0xc8071710	SIP	Queueing PDU "1 INVITE <405>", transaction=z9hG4bK3ce11085-c0e6-df11-8a9b-001a92ce6170, token=8eb20b85-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:59.730	  0:11.639	Opal Liste...0xc8071710	PTLib	No permission to set priority level 3
2010/11/04 21:33:59.730	  0:11.639	Opal Liste...0xc8071710	Opal	Transport clean up on termination
2010/11/04 21:33:59.730	  0:11.639	Opal Liste...0xc8071710	Opal	Transport Close
2010/11/04 21:33:59.730	  0:11.639	        Pool:0xba240710	SIP	Handling PDU "1 INVITE <405>" for transaction=z9hG4bK3ce11085-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:59.730	  0:11.639	Opal Liste...0xc8071710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$95.85.164.64:5060>
2010/11/04 21:33:59.731	  0:11.640	        Pool:0xba240710	SIP	Sending PDU (401 bytes) to: rem=udp$86.64.162.35:5060,local=udp$95.85.164.64:5060,if=192.168.10.77%eth0
ACK sip:letonga ekiga net SIP/2.0
CSeq: 1 ACK
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK3ce11085-c0e6-df11-8a9b-001a92ce6170;rport
From: "Csányi Pál" <sip:csanyipal ekiga net>;tag=8eb20b85-c0e6-df11-8a9b-001a92ce6170
Call-ID: aeba0b85-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:letonga ekiga net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.6249
Content-Length: 0
Max-Forwards: 70


2010/11/04 21:33:59.732	  0:11.641	        Pool:0xba240710	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:33:59.732	  0:11.641	        Pool:0xba240710	SIP	INVITE transaction id=z9hG4bK3ce11085-c0e6-df11-8a9b-001a92ce6170 completed.
2010/11/04 21:33:59.732	  0:11.641	        Pool:0xba240710	OpalCon	SetPhase from SetUpPhase to ReleasingPhase for Call[ka4210d591]-EP<sip>[8eb20b85-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:33:59.732	  0:11.641	        Pool:0xba240710	OpalCon	Releasing Call[ka4210d591]-EP<sip>[8eb20b85-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:33:59.732	  0:11.641	        Pool:0xba240710	OpalCon	Call end reason for Call[ka4210d591]-EP<sip>[8eb20b85-c0e6-df11-8a9b-001a92ce6170] set to EndedByQ931Cause
2010/11/04 21:33:59.732	  0:11.641	        Pool:0xba240710	PTLib	Thread high water mark set: 12
2010/11/04 21:33:59.732	  0:11.641	        Pool:0xba240710	SIP	Handled PDU "1 INVITE <405>"
2010/11/04 21:33:59.732	  0:11.641	   OnRelease:0xba1ff710	SIP	OnReleased: Call[ka4210d591]-EP<sip>[8eb20b85-c0e6-df11-8a9b-001a92ce6170], phase = ReleasingPhase
2010/11/04 21:33:59.732	  0:11.641	   OnRelease:0xba1ff710	OpalCon	SetPhase from ReleasingPhase to ReleasingPhase for Call[ka4210d591]-EP<sip>[8eb20b85-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:33:59.732	  0:11.641	   OnRelease:0xba1ff710	OpalCon	Media streams closed.
2010/11/04 21:33:59.732	  0:11.641	   OnRelease:0xba1ff710	SIP	Awaiting forked INVITE transaction completion, id=z9hG4bK3ce11085-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:33:59.732	  0:11.641	   OnRelease:0xba1ff710	OpalCon	SetPhase from ReleasingPhase to ReleasedPhase for Call[ka4210d591]-EP<sip>[8eb20b85-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:33:59.732	  0:11.641	   OnRelease:0xba1ff710	OpalCon	OnReleased Call[ka4210d591]-EP<sip>[8eb20b85-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:33:59.732	  0:11.641	   OnRelease:0xba1ff710	OpalEP	OnReleased Call[ka4210d591]-EP<sip>[8eb20b85-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:33:59.732	  0:11.641	   OnRelease:0xba1ff710	OpalMan	OnReleased Call[ka4210d591]-EP<sip>[8eb20b85-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:33:59.733	  0:11.641	   OnRelease:0xba1ff710	Call	OnReleased Call[ka4210d591]-EP<sip>[8eb20b85-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:33:59.733	  0:11.641	   OnRelease:0xba1ff710	OpalCon	SetPhase from SetUpPhase to ReleasingPhase for Call[ka4210d591]-EP<pc>[hdb8ada662]
2010/11/04 21:33:59.733	  0:11.642	   OnRelease:0xba1ff710	OpalCon	Releasing Call[ka4210d591]-EP<pc>[hdb8ada662]
2010/11/04 21:33:59.733	  0:11.642	   OnRelease:0xba1ff710	OpalCon	Call end reason for Call[ka4210d591]-EP<pc>[hdb8ada662] set to EndedByQ931Cause
2010/11/04 21:33:59.733	  0:11.642	   OnRelease:0xba1ff710	OpalCon	OnReleased Call[ka4210d591]-EP<pc>[hdb8ada662]
2010/11/04 21:33:59.733	  0:11.642	   OnRelease:0xba1ff710	OpalEP	OnReleased Call[ka4210d591]-EP<pc>[hdb8ada662]
2010/11/04 21:33:59.733	  0:11.642	   OnRelease:0xba1ff710	OpalMan	OnReleased Call[ka4210d591]-EP<pc>[hdb8ada662]
2010/11/04 21:33:59.733	  0:11.642	   OnRelease:0xba1ff710	Call	OnReleased Call[ka4210d591]-EP<pc>[hdb8ada662]
2010/11/04 21:33:59.733	  0:11.642	   OnRelease:0xba1ff710	OpalCon	Media streams closed.
2010/11/04 21:33:59.733	  0:11.642	   OnRelease:0xba1ff710	OpalCon	Media streams closed.
2010/11/04 21:33:59.733	  0:11.642	   OnRelease:0xba1ff710	OpalCon	OnRelease thread completed for Call[ka4210d591]-EP<sip>[8eb20b85-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:33:59.772	  0:11.681	                       	AEScheduler	Removing Event incoming_call_sound from queue
2010/11/04 21:33:59.772	  0:11.681	                       	AEScheduler	Removing Event ring_tone_sound from queue
2010/11/04 21:33:59.772	  0:11.681	                       	OpalMan	OnClearedCall Call[ka4210d591] from "pc:csanyipal" to "sip:letonga ekiga net"
2010/11/04 21:33:59.772	  0:11.681	                       	OPAL	Attempting to close recording on call ka4210d591 when not recording.
2010/11/04 21:33:59.800	  0:11.709	GMVideoOut...0xdb27d710	X11	Unmapping and destroying Window with ID 62914562
2010/11/04 21:33:59.801	  0:11.709	GMVideoOut...0xdb27d710	GMVideoOutputManager_X	Opening VO_MODE_LOCAL display with image of 320x240
2010/11/04 21:33:59.801	  0:11.709	GMVideoOut...0xdb27d710	XVideo	Initializing XV window with 320x240 at 26,42
2010/11/04 21:33:59.801	  0:11.710	GMVideoOut...0xdb27d710	XVideo	XvQueryExtension: Version: 2 Release: 2 Request Base: 132 Event Base: 72 Error Base: 140
2010/11/04 21:33:59.801	  0:11.710	GMVideoOut...0xdb27d710	XVideo	#0, Adaptor: NV40 texture adapter, type: input | image | , ports: 32, first port:�63
2010/11/04 21:33:59.801	  0:11.710	GMVideoOut...0xdb27d710	XVideo	Encoding List for Port 63:  id=0 name=XV_IMAGE size=4096x4096 numerator=1 denominator=1
2010/11/04 21:33:59.801	  0:11.710	GMVideoOut...0xdb27d710	XVideo	Attribute List for Port 63:
2010/11/04 21:33:59.801	  0:11.710	GMVideoOut...0xdb27d710	 �name: � � � XV_SET_DEFAULTS
2010/11/04 21:33:59.801	  0:11.710	GMVideoOut...0xdb27d710	 �flags: � �  set
2010/11/04 21:33:59.801	  0:11.710	GMVideoOut...0xdb27d710	 �min_color: �0
2010/11/04 21:33:59.801	  0:11.710	GMVideoOut...0xdb27d710	 �max_color: �0
2010/11/04 21:33:59.801	  0:11.710	GMVideoOut...0xdb27d710	 �name: � � � XV_SYNC_TO_VBLANK
2010/11/04 21:33:59.801	  0:11.710	GMVideoOut...0xdb27d710	 �flags: � �  get set
2010/11/04 21:33:59.801	  0:11.710	GMVideoOut...0xdb27d710	 �min_color: �0
2010/11/04 21:33:59.801	  0:11.710	GMVideoOut...0xdb27d710	 �max_color: �1
2010/11/04 21:33:59.801	  0:11.710	GMVideoOut...0xdb27d710	XVideo	Image format list for Port 63:
2010/11/04 21:33:59.802	  0:11.711	GMVideoOut...0xdb27d710	  0x32315659 (YV12) planar, order: YVU
2010/11/04 21:33:59.802	  0:11.711	GMVideoOut...0xdb27d710	  0x30323449 (I420) planar, order: YUV
2010/11/04 21:33:59.802	  0:11.711	GMVideoOut...0xdb27d710	XVideo	Grabbed Port: 63
2010/11/04 21:33:59.802	  0:11.711	GMVideoOut...0xdb27d710	XVideo	Using XVideo port: 63
2010/11/04 21:33:59.806	  0:11.715	GMVideoOut...0xdb27d710	XVideo	Found visual with colordepth of 24bits per pixel
2010/11/04 21:33:59.806	  0:11.715	GMVideoOut...0xdb27d710	X11	Created Window with ID 62914565
2010/11/04 21:33:59.806	  0:11.715	GMVideoOut...0xdb27d710	XVideo	Colorkey method: NONE
2010/11/04 21:33:59.806	  0:11.715	GMVideoOut...0xdb27d710	XVideo	Vertical sync successfully activated
2010/11/04 21:33:59.806	  0:11.715	GMVideoOut...0xdb27d710	XVideo	XQueryShmExtension success
2010/11/04 21:33:59.806	  0:11.715	GMVideoOut...0xdb27d710	XVideo	Created XvImage (320x240, data size: 115200, num_planes: 3
2010/11/04 21:33:59.806	  0:11.715	GMVideoOut...0xdb27d710	XVideo	  Plane 0: pitch=320, offset=0
2010/11/04 21:33:59.806	  0:11.715	GMVideoOut...0xdb27d710	XVideo	  Plane 1: pitch=160, offset=76800
2010/11/04 21:33:59.806	  0:11.715	GMVideoOut...0xdb27d710	XVideo	  Plane 2: pitch=160, offset=96000
2010/11/04 21:33:59.807	  0:11.715	GMVideoOut...0xdb27d710	XVideo	Using SHM extension
2010/11/04 21:33:59.807	  0:11.716	GMVideoOut...0xdb27d710	X11	Unknown wm type...
2010/11/04 21:33:59.807	  0:11.716	GMVideoOut...0xdb27d710	GMVideoOutputManager_X	VO_MODE_LOCAL: Successfully opened XV Window
2010/11/04 21:33:59.807	  0:11.716	GMVideoOut...0xdb27d710	X11	Unknown X Event 19 received
2010/11/04 21:33:59.864	  0:11.773	GMVideoOut...0xdb27d710	X11	Unmapping and destroying Window with ID 62914565
2010/11/04 21:33:59.865	  0:11.773	GMVideoOut...0xdb27d710	GMVideoOutputManager_X	Opening VO_MODE_LOCAL display with image of 320x240
2010/11/04 21:33:59.865	  0:11.773	GMVideoOut...0xdb27d710	XVideo	Initializing XV window with 320x240 at 26,26
2010/11/04 21:33:59.865	  0:11.774	GMVideoOut...0xdb27d710	XVideo	XvQueryExtension: Version: 2 Release: 2 Request Base: 132 Event Base: 72 Error Base: 140
2010/11/04 21:33:59.865	  0:11.774	GMVideoOut...0xdb27d710	XVideo	#0, Adaptor: NV40 texture adapter, type: input | image | , ports: 32, first port:�63
2010/11/04 21:33:59.865	  0:11.774	GMVideoOut...0xdb27d710	XVideo	Encoding List for Port 63:  id=0 name=XV_IMAGE size=4096x4096 numerator=1 denominator=1
2010/11/04 21:33:59.865	  0:11.774	GMVideoOut...0xdb27d710	XVideo	Attribute List for Port 63:
2010/11/04 21:33:59.865	  0:11.774	GMVideoOut...0xdb27d710	 �name: � � � XV_SET_DEFAULTS
2010/11/04 21:33:59.865	  0:11.774	GMVideoOut...0xdb27d710	 �flags: � �  set
2010/11/04 21:33:59.865	  0:11.774	GMVideoOut...0xdb27d710	 �min_color: �0
2010/11/04 21:33:59.865	  0:11.774	GMVideoOut...0xdb27d710	 �max_color: �0
2010/11/04 21:33:59.865	  0:11.774	GMVideoOut...0xdb27d710	 �name: � � � XV_SYNC_TO_VBLANK
2010/11/04 21:33:59.865	  0:11.774	GMVideoOut...0xdb27d710	 �flags: � �  get set
2010/11/04 21:33:59.865	  0:11.774	GMVideoOut...0xdb27d710	 �min_color: �0
2010/11/04 21:33:59.865	  0:11.774	GMVideoOut...0xdb27d710	 �max_color: �1
2010/11/04 21:33:59.865	  0:11.774	GMVideoOut...0xdb27d710	XVideo	Image format list for Port 63:
2010/11/04 21:33:59.866	  0:11.774	GMVideoOut...0xdb27d710	  0x32315659 (YV12) planar, order: YVU
2010/11/04 21:33:59.866	  0:11.774	GMVideoOut...0xdb27d710	  0x30323449 (I420) planar, order: YUV
2010/11/04 21:33:59.866	  0:11.775	GMVideoOut...0xdb27d710	XVideo	Grabbed Port: 63
2010/11/04 21:33:59.866	  0:11.775	GMVideoOut...0xdb27d710	XVideo	Using XVideo port: 63
2010/11/04 21:33:59.866	  0:11.775	GMVideoOut...0xdb27d710	XVideo	Found visual with colordepth of 24bits per pixel
2010/11/04 21:33:59.866	  0:11.775	GMVideoOut...0xdb27d710	X11	Created Window with ID 62914568
2010/11/04 21:33:59.866	  0:11.775	GMVideoOut...0xdb27d710	XVideo	Colorkey method: NONE
2010/11/04 21:33:59.866	  0:11.775	GMVideoOut...0xdb27d710	XVideo	Vertical sync successfully activated
2010/11/04 21:33:59.866	  0:11.775	GMVideoOut...0xdb27d710	XVideo	XQueryShmExtension success
2010/11/04 21:33:59.866	  0:11.775	GMVideoOut...0xdb27d710	XVideo	Created XvImage (320x240, data size: 115200, num_planes: 3
2010/11/04 21:33:59.866	  0:11.775	GMVideoOut...0xdb27d710	XVideo	  Plane 0: pitch=320, offset=0
2010/11/04 21:33:59.866	  0:11.775	GMVideoOut...0xdb27d710	XVideo	  Plane 1: pitch=160, offset=76800
2010/11/04 21:33:59.866	  0:11.775	GMVideoOut...0xdb27d710	XVideo	  Plane 2: pitch=160, offset=96000
2010/11/04 21:33:59.866	  0:11.775	GMVideoOut...0xdb27d710	XVideo	Using SHM extension
2010/11/04 21:33:59.867	  0:11.775	GMVideoOut...0xdb27d710	X11	Unknown wm type...
2010/11/04 21:33:59.867	  0:11.775	GMVideoOut...0xdb27d710	GMVideoOutputManager_X	VO_MODE_LOCAL: Successfully opened XV Window
2010/11/04 21:33:59.867	  0:11.776	GMVideoOut...0xdb27d710	X11	Unknown X Event 19 received
2010/11/04 21:34:00.250	  0:12.159	Opal Garbage:0xdb23c710	PCSS	Deleted PC sound system connection.
2010/11/04 21:34:00.250	  0:12.159	Opal Garbage:0xdb23c710	OpalCon	Connection Call[ka4210d591]-EP<pc>[hdb8ada662] destroyed.
2010/11/04 21:34:00.732	  0:12.641	 Housekeeper:0xc80b2710	SIP	Set state Terminated_Success for INVITE transaction id=z9hG4bK3ce11085-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:34:01.250	  0:13.159	Opal Garbage:0xdb23c710	RTP	Closing session 1
2010/11/04 21:34:01.250	  0:13.159	Opal Garbage:0xdb23c710	RTP	Deleting session 1
2010/11/04 21:34:01.250	  0:13.159	Opal Garbage:0xdb23c710	RTP_UDP	Session 1, Shutting down read.
2010/11/04 21:34:01.250	  0:13.159	Opal Garbage:0xdb23c710	RTP_UDP	Session 1, Shutting down write.
2010/11/04 21:34:01.250	  0:13.159	Opal Garbage:0xdb23c710	RTP	Closing session 2
2010/11/04 21:34:01.250	  0:13.159	Opal Garbage:0xdb23c710	RTP	Deleting session 2
2010/11/04 21:34:01.250	  0:13.159	Opal Garbage:0xdb23c710	RTP_UDP	Session 2, Shutting down read.
2010/11/04 21:34:01.251	  0:13.159	Opal Garbage:0xdb23c710	RTP_UDP	Session 2, Shutting down write.
2010/11/04 21:34:01.251	  0:13.159	Opal Garbage:0xdb23c710	SIP	Transaction id=z9hG4bK3ce11085-c0e6-df11-8a9b-001a92ce6170 destroyed.
2010/11/04 21:34:01.251	  0:13.160	Opal Garbage:0xdb23c710	Opal	Transport clean up on termination
2010/11/04 21:34:01.251	  0:13.160	Opal Garbage:0xdb23c710	Opal	Transport Close
2010/11/04 21:34:01.251	  0:13.160	Opal Garbage:0xdb23c710	Opal	Transport clean up on termination
2010/11/04 21:34:01.251	  0:13.160	Opal Garbage:0xdb23c710	Opal	Transport Close
2010/11/04 21:34:01.251	  0:13.160	Opal Garbage:0xdb23c710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$95.85.164.64:5060>
2010/11/04 21:34:01.251	  0:13.160	Opal Garbage:0xdb23c710	SIP	Deleted connection.
2010/11/04 21:34:01.252	  0:13.161	Opal Garbage:0xdb23c710	OpalCon	Connection Call[ka4210d591]-EP<sip>[8eb20b85-c0e6-df11-8a9b-001a92ce6170] destroyed.
2010/11/04 21:34:02.271	  0:14.180	                       	Call	Call[ka4210d591] destroyed.
2010/11/04 21:34:03.972	  0:15.881	                       	OpalMan	Set up call from pc:* to sip:letonga ekiga net
2010/11/04 21:34:03.972	  0:15.881	                       	Call	Created Call[hdaef8acd3]
2010/11/04 21:34:03.972	  0:15.881	                       	OpalMan	Set up connection to "pc:*"
2010/11/04 21:34:03.972	  0:15.881	                       	OpalCon	Created connection Call[hdaef8acd3]-EP<pc>[j30a62fbc4]
2010/11/04 21:34:03.972	  0:15.881	                       	Silence	Parameters set: mode=NoSilenceDetection, threshold=0, silencedb=3200, signaldb=80, period=4800
2010/11/04 21:34:03.972	  0:15.881	                       	Silence	Handler created
2010/11/04 21:34:03.972	  0:15.881	                       	Echo Canceler	Handler created
2010/11/04 21:34:03.972	  0:15.881	                       	PCSS	Created PC sound system connection: token="j30a62fbc4" player="EKIGA" recorder="EKIGA"
2010/11/04 21:34:03.972	  0:15.881	                       	OpalCon	SetPhase from UninitialisedPhase to SetUpPhase for Call[hdaef8acd3]-EP<pc>[j30a62fbc4]
2010/11/04 21:34:03.972	  0:15.881	                       	OpalMan	OnIncoming connection Call[hdaef8acd3]-EP<pc>[j30a62fbc4]
2010/11/04 21:34:03.972	  0:15.881	                       	OpalCon	Applying string options:


2010/11/04 21:34:03.972	  0:15.881	                       	Call	GetOtherPartyConnection Call[hdaef8acd3]-EP<pc>[j30a62fbc4]
2010/11/04 21:34:03.972	  0:15.881	                       	OpalMan	Searching for route "pc:csanyipal	sip:letonga ekiga net"
2010/11/04 21:34:03.972	  0:15.881	                       	OpalMan	Set up connection to "sip:letonga ekiga net"
2010/11/04 21:34:03.972	  0:15.881	                       	OpalCon	Created connection Call[hdaef8acd3]-EP<sip>[10265488-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:03.973	  0:15.881	                       	RFC2833	Handler created
2010/11/04 21:34:03.973	  0:15.881	                       	RFC2833	Handler created
2010/11/04 21:34:03.973	  0:15.882	                       	SIP	Created connection.
2010/11/04 21:34:03.973	  0:15.882	                       	PCSS	Outgoing call routed to sip:letonga ekiga net for Call[hdaef8acd3]-EP<pc>[j30a62fbc4]
2010/11/04 21:34:03.973	  0:15.882	                       	OpalMan	SetUpCall succeeded, call=Call[hdaef8acd3]
2010/11/04 21:34:03.973	  0:15.882	   CallSetup:0xba1ff710	Call	OnSetUp Call[hdaef8acd3]-EP<pc>[j30a62fbc4]
2010/11/04 21:34:03.973	  0:15.882	   CallSetup:0xba1ff710	SIP	SetUpConnection: sip:letonga ekiga net
2010/11/04 21:34:03.973	  0:15.882	   CallSetup:0xba1ff710	OpalCon	SetPhase from UninitialisedPhase to SetUpPhase for Call[hdaef8acd3]-EP<sip>[10265488-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:03.973	  0:15.882	   CallSetup:0xba1ff710	OpalCon	Applying string options:


2010/11/04 21:34:03.973	  0:15.882	   CallSetup:0xba1ff710	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:34:04.015	  0:15.924	   CallSetup:0xba1ff710	SIP	No SRV record found.
2010/11/04 21:34:04.016	  0:15.924	   CallSetup:0xba1ff710	SIP	Connecting to sip:letonga ekiga net via sip:letonga ekiga net
2010/11/04 21:34:04.016	  0:15.924	   CallSetup:0xba1ff710	SIP	Found registrar on domain ekiga.net, using interface 192.168.10.77%eth0
2010/11/04 21:34:04.016	  0:15.925	   CallSetup:0xba1ff710	OpalUDP	Binding to interface: 192.168.10.77:5060
2010/11/04 21:34:04.016	  0:15.925	   CallSetup:0xba1ff710	SIP	Created transport udp$86.64.162.35:5060<if=udp$95.85.164.64:5060>
2010/11/04 21:34:04.016	  0:15.925	   CallSetup:0xba1ff710	OpalUDP	Started connect to 86.64.162.35:5060
2010/11/04 21:34:04.017	  0:15.925	   CallSetup:0xba1ff710	SIP	Updating dialog tag from "" to "10265488-c0e6-df11-8a9b-001a92ce6170"
2010/11/04 21:34:04.019	  0:15.928	   CallSetup:0xba1ff710	SIP	INVITE transaction id=z9hG4bKfc325b88-c0e6-df11-8a9b-001a92ce6170 created.
2010/11/04 21:34:04.019	  0:15.928	   CallSetup:0xba1ff710	SIP	Creating INVITE request
2010/11/04 21:34:04.022	  0:15.931	   CallSetup:0xba1ff710	MediaFormat	Removing codecs PCM-16-48kHz,CELT-48K,PCM-16-32kHz,CELT-32K,PCM-16-16kHz,G.722-64k,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,PCM-16,G.711-uLaw-64k,G.726-16k,G.726-24k,G.726-32k,G.726-40k,GSM-06.10,GSM-AMR,LPC-10,MS-GSM,MS-IMA-ADPCM,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,YUV420P,RFC4175_YCbCr-4:2:0,theora,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz
2010/11/04 21:34:04.022	  0:15.931	   CallSetup:0xba1ff710	MediaFormat	Removing codecs PCM-16-48kHz,CELT-48K,PCM-16-32kHz,CELT-32K,PCM-16-16kHz,G.722-64k,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,PCM-16,G.711-uLaw-64k,G.726-16k,G.726-24k,G.726-32k,G.726-40k,GSM-06.10,GSM-AMR,LPC-10,MS-GSM,MS-IMA-ADPCM,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,YUV420P,RFC4175_YCbCr-4:2:0,theora,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz
2010/11/04 21:34:04.023	  0:15.931	   CallSetup:0xba1ff710	Call	GetMediaFormats for Call[hdaef8acd3]-EP<sip>[10265488-c0e6-df11-8a9b-001a92ce6170]
G.711-ALaw-64k
SpeexIETFNarrow-8k
SpeexNB
SpeexWNarrow-8k
H.261
H.261-CIF
H.261-QCIF

2010/11/04 21:34:04.023	  0:15.931	   CallSetup:0xba1ff710	SIP	Offering media type audio in SDP with formats
G.711-ALaw-64k,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,H.261,H.261-CIF,H.261-QCIF
2010/11/04 21:34:04.023	  0:15.931	   CallSetup:0xba1ff710	Call	IsMediaBypassPossible Call[hdaef8acd3]-EP<sip>[10265488-c0e6-df11-8a9b-001a92ce6170] session 1
2010/11/04 21:34:04.023	  0:15.931	   CallSetup:0xba1ff710	OpalMan	IsMediaBypassPossible: session 1
2010/11/04 21:34:04.023	  0:15.932	   CallSetup:0xba1ff710	OpalCon	IsMediaBypassPossible: default returns false
2010/11/04 21:34:04.023	  0:15.932	   CallSetup:0xba1ff710	RTP	Cannot find media session 1
2010/11/04 21:34:04.023	  0:15.932	   CallSetup:0xba1ff710	RTP	Cannot find RTP session 1
2010/11/04 21:34:04.023	  0:15.932	   CallSetup:0xba1ff710	RTP_UDP	Session 1, created with NAT flag set to 0
2010/11/04 21:34:04.672	  0:16.581	   CallSetup:0xba1ff710	RTP	Session 1, STUN created STUN RTP/RTCP socket pair.
2010/11/04 21:34:04.672	  0:16.581	   CallSetup:0xba1ff710	RTP_UDP	Session 1 created: 95.85.164.64:5070-5071 ssrc=1239423476
2010/11/04 21:34:04.673	  0:16.582	   CallSetup:0xba1ff710	RTP	Creating new session RTP_UDP
2010/11/04 21:34:04.673	  0:16.582	   CallSetup:0xba1ff710	RTP	Found existing media session 1
2010/11/04 21:34:04.673	  0:16.582	   CallSetup:0xba1ff710	SDP	SDP not including SpeexIETFNarrow-8k as it is not a SIP transportable format
2010/11/04 21:34:04.673	  0:16.582	   CallSetup:0xba1ff710	SDP	SDP not including SpeexWNarrow-8k as it is not a SIP transportable format
2010/11/04 21:34:04.673	  0:16.582	   CallSetup:0xba1ff710	SIP	Using default RTP payload [pt=101] for UserInput/RFC2833
2010/11/04 21:34:04.673	  0:16.582	   CallSetup:0xba1ff710	SIP	Using default RTP payload [pt=122] for NamedSignalEvent
2010/11/04 21:34:04.676	  0:16.585	   CallSetup:0xba1ff710	MediaFormat	Removing codecs PCM-16-48kHz,CELT-48K,PCM-16-32kHz,CELT-32K,PCM-16-16kHz,G.722-64k,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,PCM-16,G.711-uLaw-64k,G.726-16k,G.726-24k,G.726-32k,G.726-40k,GSM-06.10,GSM-AMR,LPC-10,MS-GSM,MS-IMA-ADPCM,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,YUV420P,RFC4175_YCbCr-4:2:0,theora,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz
2010/11/04 21:34:04.677	  0:16.586	   CallSetup:0xba1ff710	MediaFormat	Removing codecs PCM-16-48kHz,CELT-48K,PCM-16-32kHz,CELT-32K,PCM-16-16kHz,G.722-64k,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,PCM-16,G.711-uLaw-64k,G.726-16k,G.726-24k,G.726-32k,G.726-40k,GSM-06.10,GSM-AMR,LPC-10,MS-GSM,MS-IMA-ADPCM,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,YUV420P,RFC4175_YCbCr-4:2:0,theora,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz
2010/11/04 21:34:04.677	  0:16.586	   CallSetup:0xba1ff710	Call	GetMediaFormats for Call[hdaef8acd3]-EP<sip>[10265488-c0e6-df11-8a9b-001a92ce6170]
G.711-ALaw-64k
SpeexIETFNarrow-8k
SpeexNB
SpeexWNarrow-8k
H.261
H.261-CIF
H.261-QCIF

2010/11/04 21:34:04.677	  0:16.586	   CallSetup:0xba1ff710	SIP	Offering media type video in SDP with formats
G.711-ALaw-64k,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,H.261,H.261-CIF,H.261-QCIF
2010/11/04 21:34:04.677	  0:16.586	   CallSetup:0xba1ff710	Call	IsMediaBypassPossible Call[hdaef8acd3]-EP<sip>[10265488-c0e6-df11-8a9b-001a92ce6170] session 2
2010/11/04 21:34:04.677	  0:16.586	   CallSetup:0xba1ff710	OpalMan	IsMediaBypassPossible: session 2
2010/11/04 21:34:04.677	  0:16.586	   CallSetup:0xba1ff710	OpalCon	IsMediaBypassPossible: default returns false
2010/11/04 21:34:04.677	  0:16.586	   CallSetup:0xba1ff710	RTP	Cannot find media session 2
2010/11/04 21:34:04.677	  0:16.586	   CallSetup:0xba1ff710	RTP	Cannot find RTP session 2
2010/11/04 21:34:04.678	  0:16.587	   CallSetup:0xba1ff710	RTP_UDP	Session 2, created with NAT flag set to 0
2010/11/04 21:34:04.678	  0:16.587	   CallSetup:0xba1ff710	PWLib	File handle high water mark set: 55 PUDPSocket
2010/11/04 21:34:04.678	  0:16.587	   CallSetup:0xba1ff710	PWLib	File handle high water mark set: 56 PUDPSocket
2010/11/04 21:34:05.278	  0:17.187	   CallSetup:0xba1ff710	RTP	Session 2, STUN created STUN RTP/RTCP socket pair.
2010/11/04 21:34:05.278	  0:17.187	   CallSetup:0xba1ff710	RTP_UDP	Session 2 created: 95.85.164.64:5074-5075 ssrc=1455317098
2010/11/04 21:34:05.278	  0:17.187	   CallSetup:0xba1ff710	PWLib	File handle low water mark set: 51 PUDPSocket
2010/11/04 21:34:05.278	  0:17.187	   CallSetup:0xba1ff710	RTP	Creating new session RTP_UDP
2010/11/04 21:34:05.278	  0:17.187	   CallSetup:0xba1ff710	RTP	Found existing media session 2
2010/11/04 21:34:05.279	  0:17.188	   CallSetup:0xba1ff710	SDP	SDP not including H.261-CIF as it is not a SIP transportable format
2010/11/04 21:34:05.279	  0:17.188	   CallSetup:0xba1ff710	SDP	SDP not including H.261-QCIF as it is not a SIP transportable format
2010/11/04 21:34:05.279	  0:17.188	   CallSetup:0xba1ff710	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:34:05.309	  0:17.218	   CallSetup:0xba1ff710	SIP	No SRV record found.
2010/11/04 21:34:05.309	  0:17.218	   CallSetup:0xba1ff710	SIP	Transaction remote address is udp$ekiga.net:5060
2010/11/04 21:34:05.309	  0:17.218	   CallSetup:0xba1ff710	OpalPlugin	to_customised_options: H.261
2010/11/04 21:34:05.310	  0:17.219	   CallSetup:0xba1ff710	OpalPlugin	to_customised_options changed option "Frame Width" from "320" to "176"
2010/11/04 21:34:05.310	  0:17.219	   CallSetup:0xba1ff710	OpalPlugin	to_customised_options changed option "Frame Height" from "240" to "144"
2010/11/04 21:34:05.310	  0:17.219	   CallSetup:0xba1ff710	SIP	Sending PDU (1012 bytes) to: rem=udp$86.64.162.35:5060,local=udp$95.85.164.64:5060,if=192.168.10.77%eth0
INVITE sip:letonga ekiga net SIP/2.0
Date: Thu, 04 Nov 2010 20:34:04 GMT
CSeq: 1 INVITE
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bKfc325b88-c0e6-df11-8a9b-001a92ce6170;rport
User-Agent: Ekiga/3.2.7
From: "Csányi Pál" <sip:csanyipal ekiga net>;tag=10265488-c0e6-df11-8a9b-001a92ce6170
Call-ID: 442e5488-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:letonga ekiga net>
Contact: <sip:csanyipal 95 85 164 64>
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Content-Type: application/sdp
Content-Length: 434
Max-Forwards: 70

v=0
o=- 1288902843 1 IN IP4 95.85.164.64
s=Opal SIP Session
c=IN IP4 95.85.164.64
t=0 0
m=audio 5070 RTP/AVP 8 110 101 122
a=sendrecv
a=rtpmap:8 PCMA/8000/1
a=rtpmap:110 Speex/8000/1
a=fmtp:110 sr=8000,mode=any
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16,32,36
a=rtpmap:122 NSE/8000
a=fmtp:122 192-193
m=video 5074 RTP/AVP 31
b=AS:4096
b=TIAS:4096000
a=sendrecv
a=rtpmap:31 h261/90000
a=fmtp:31 CIF=1;QCIF=1

2010/11/04 21:34:05.310	  0:17.219	   CallSetup:0xba1ff710	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:34:05.310	  0:17.219	   CallSetup:0xba1ff710	SIP	Transaction timers set: retry=0.500, completion=1:00.000
2010/11/04 21:34:05.311	  0:17.219	   CallSetup:0xba1ff710	OpalCon	OnSetUpConnectionCall[hdaef8acd3]-EP<sip>[10265488-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:05.311	  0:17.219	   CallSetup:0xba1ff710	OpalEP	OnSetUpConnection Call[hdaef8acd3]-EP<sip>[10265488-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:05.375	  0:17.284	Opal Liste...0xc8071710	PWLib	File handle low water mark set: 49 PUDPSocket
2010/11/04 21:34:05.375	  0:17.284	Opal Liste...0xc8071710	OpalUDP	Binding to interface: 95.85.164.64:5060
2010/11/04 21:34:05.375	  0:17.284	Opal Liste...0xc8071710	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$95.85.164.64:5060>
2010/11/04 21:34:05.376	  0:17.285	Opal Liste...0xc8071710	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$95.85.164.64:5060,if=192.168.10.77%eth0
SIP/2.0 405 Method Not Allowed
CSeq: 1 INVITE
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bKfc325b88-c0e6-df11-8a9b-001a92ce6170;rport=5060
Server: Kamailio (1.5.3-notls (i386/linux))
From: "Csányi Pál" <sip:csanyipal ekiga net>;tag=10265488-c0e6-df11-8a9b-001a92ce6170
Call-ID: 442e5488-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:letonga ekiga net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.9edd
Content-Length: 0


2010/11/04 21:34:05.376	  0:17.285	Opal Liste...0xc8071710	SIP	Queueing PDU "1 INVITE <405>", transaction=z9hG4bKfc325b88-c0e6-df11-8a9b-001a92ce6170, token=10265488-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:34:05.376	  0:17.285	Opal Liste...0xc8071710	Opal	Transport clean up on termination
2010/11/04 21:34:05.376	  0:17.285	Opal Liste...0xc8071710	Opal	Transport Close
2010/11/04 21:34:05.377	  0:17.285	        Pool:0xba240710	SIP	Handling PDU "1 INVITE <405>" for transaction=z9hG4bKfc325b88-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:34:05.376	  0:17.285	Opal Liste...0xc8071710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$95.85.164.64:5060>
2010/11/04 21:34:05.378	  0:17.287	        Pool:0xba240710	SIP	Sending PDU (401 bytes) to: rem=udp$86.64.162.35:5060,local=udp$95.85.164.64:5060,if=192.168.10.77%eth0
ACK sip:letonga ekiga net SIP/2.0
CSeq: 1 ACK
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bKfc325b88-c0e6-df11-8a9b-001a92ce6170;rport
From: "Csányi Pál" <sip:csanyipal ekiga net>;tag=10265488-c0e6-df11-8a9b-001a92ce6170
Call-ID: 442e5488-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:letonga ekiga net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.9edd
Content-Length: 0
Max-Forwards: 70


2010/11/04 21:34:05.378	  0:17.287	        Pool:0xba240710	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:34:05.378	  0:17.287	        Pool:0xba240710	SIP	INVITE transaction id=z9hG4bKfc325b88-c0e6-df11-8a9b-001a92ce6170 completed.
2010/11/04 21:34:05.378	  0:17.287	        Pool:0xba240710	OpalCon	SetPhase from SetUpPhase to ReleasingPhase for Call[hdaef8acd3]-EP<sip>[10265488-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:05.378	  0:17.287	        Pool:0xba240710	OpalCon	Releasing Call[hdaef8acd3]-EP<sip>[10265488-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:05.378	  0:17.287	        Pool:0xba240710	OpalCon	Call end reason for Call[hdaef8acd3]-EP<sip>[10265488-c0e6-df11-8a9b-001a92ce6170] set to EndedByQ931Cause
2010/11/04 21:34:05.378	  0:17.287	        Pool:0xba240710	SIP	Handled PDU "1 INVITE <405>"
2010/11/04 21:34:05.378	  0:17.287	   OnRelease:0xba1ff710	SIP	OnReleased: Call[hdaef8acd3]-EP<sip>[10265488-c0e6-df11-8a9b-001a92ce6170], phase = ReleasingPhase
2010/11/04 21:34:05.378	  0:17.287	   OnRelease:0xba1ff710	OpalCon	SetPhase from ReleasingPhase to ReleasingPhase for Call[hdaef8acd3]-EP<sip>[10265488-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:05.378	  0:17.287	   OnRelease:0xba1ff710	OpalCon	Media streams closed.
2010/11/04 21:34:05.379	  0:17.287	   OnRelease:0xba1ff710	SIP	Awaiting forked INVITE transaction completion, id=z9hG4bKfc325b88-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:34:05.379	  0:17.287	   OnRelease:0xba1ff710	OpalCon	SetPhase from ReleasingPhase to ReleasedPhase for Call[hdaef8acd3]-EP<sip>[10265488-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:05.379	  0:17.287	   OnRelease:0xba1ff710	OpalCon	OnReleased Call[hdaef8acd3]-EP<sip>[10265488-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:05.379	  0:17.287	   OnRelease:0xba1ff710	OpalEP	OnReleased Call[hdaef8acd3]-EP<sip>[10265488-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:05.379	  0:17.287	   OnRelease:0xba1ff710	OpalMan	OnReleased Call[hdaef8acd3]-EP<sip>[10265488-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:05.379	  0:17.288	   OnRelease:0xba1ff710	Call	OnReleased Call[hdaef8acd3]-EP<sip>[10265488-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:05.379	  0:17.288	   OnRelease:0xba1ff710	OpalCon	SetPhase from SetUpPhase to ReleasingPhase for Call[hdaef8acd3]-EP<pc>[j30a62fbc4]
2010/11/04 21:34:05.379	  0:17.288	   OnRelease:0xba1ff710	OpalCon	Releasing Call[hdaef8acd3]-EP<pc>[j30a62fbc4]
2010/11/04 21:34:05.379	  0:17.288	   OnRelease:0xba1ff710	OpalCon	Call end reason for Call[hdaef8acd3]-EP<pc>[j30a62fbc4] set to EndedByQ931Cause
2010/11/04 21:34:05.379	  0:17.288	   OnRelease:0xba1ff710	OpalCon	OnReleased Call[hdaef8acd3]-EP<pc>[j30a62fbc4]
2010/11/04 21:34:05.379	  0:17.288	   OnRelease:0xba1ff710	OpalEP	OnReleased Call[hdaef8acd3]-EP<pc>[j30a62fbc4]
2010/11/04 21:34:05.379	  0:17.288	   OnRelease:0xba1ff710	OpalMan	OnReleased Call[hdaef8acd3]-EP<pc>[j30a62fbc4]
2010/11/04 21:34:05.379	  0:17.288	   OnRelease:0xba1ff710	Call	OnReleased Call[hdaef8acd3]-EP<pc>[j30a62fbc4]
2010/11/04 21:34:05.379	  0:17.288	   OnRelease:0xba1ff710	OpalCon	Media streams closed.
2010/11/04 21:34:05.379	  0:17.288	   OnRelease:0xba1ff710	OpalCon	Media streams closed.
2010/11/04 21:34:05.379	  0:17.288	   OnRelease:0xba1ff710	OpalCon	OnRelease thread completed for Call[hdaef8acd3]-EP<sip>[10265488-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:05.479	  0:17.388	                       	AEScheduler	Removing Event incoming_call_sound from queue
2010/11/04 21:34:05.479	  0:17.388	                       	AEScheduler	Removing Event ring_tone_sound from queue
2010/11/04 21:34:05.479	  0:17.388	                       	OpalMan	OnClearedCall Call[hdaef8acd3] from "pc:csanyipal" to "sip:letonga ekiga net"
2010/11/04 21:34:05.479	  0:17.388	                       	OPAL	Attempting to close recording on call hdaef8acd3 when not recording.
2010/11/04 21:34:05.496	  0:17.405	GMVideoOut...0xdb27d710	X11	Unmapping and destroying Window with ID 62914568
2010/11/04 21:34:05.496	  0:17.405	GMVideoOut...0xdb27d710	GMVideoOutputManager_X	Opening VO_MODE_LOCAL display with image of 320x240
2010/11/04 21:34:05.496	  0:17.405	GMVideoOut...0xdb27d710	XVideo	Initializing XV window with 320x240 at 26,42
2010/11/04 21:34:05.496	  0:17.405	GMVideoOut...0xdb27d710	XVideo	XvQueryExtension: Version: 2 Release: 2 Request Base: 132 Event Base: 72 Error Base: 140
2010/11/04 21:34:05.496	  0:17.405	GMVideoOut...0xdb27d710	XVideo	#0, Adaptor: NV40 texture adapter, type: input | image | , ports: 32, first port:�63
2010/11/04 21:34:05.497	  0:17.405	GMVideoOut...0xdb27d710	XVideo	Encoding List for Port 63:  id=0 name=XV_IMAGE size=4096x4096 numerator=1 denominator=1
2010/11/04 21:34:05.497	  0:17.405	GMVideoOut...0xdb27d710	XVideo	Attribute List for Port 63:
2010/11/04 21:34:05.497	  0:17.406	GMVideoOut...0xdb27d710	 �name: � � � XV_SET_DEFAULTS
2010/11/04 21:34:05.497	  0:17.406	GMVideoOut...0xdb27d710	 �flags: � �  set
2010/11/04 21:34:05.497	  0:17.406	GMVideoOut...0xdb27d710	 �min_color: �0
2010/11/04 21:34:05.497	  0:17.406	GMVideoOut...0xdb27d710	 �max_color: �0
2010/11/04 21:34:05.497	  0:17.406	GMVideoOut...0xdb27d710	 �name: � � � XV_SYNC_TO_VBLANK
2010/11/04 21:34:05.497	  0:17.406	GMVideoOut...0xdb27d710	 �flags: � �  get set
2010/11/04 21:34:05.497	  0:17.406	GMVideoOut...0xdb27d710	 �min_color: �0
2010/11/04 21:34:05.497	  0:17.406	GMVideoOut...0xdb27d710	 �max_color: �1
2010/11/04 21:34:05.497	  0:17.406	GMVideoOut...0xdb27d710	XVideo	Image format list for Port 63:
2010/11/04 21:34:05.497	  0:17.406	GMVideoOut...0xdb27d710	  0x32315659 (YV12) planar, order: YVU
2010/11/04 21:34:05.497	  0:17.406	GMVideoOut...0xdb27d710	  0x30323449 (I420) planar, order: YUV
2010/11/04 21:34:05.497	  0:17.406	GMVideoOut...0xdb27d710	XVideo	Grabbed Port: 63
2010/11/04 21:34:05.497	  0:17.406	GMVideoOut...0xdb27d710	XVideo	Using XVideo port: 63
2010/11/04 21:34:05.498	  0:17.407	GMVideoOut...0xdb27d710	XVideo	Found visual with colordepth of 24bits per pixel
2010/11/04 21:34:05.498	  0:17.407	GMVideoOut...0xdb27d710	X11	Created Window with ID 62914571
2010/11/04 21:34:05.502	  0:17.411	GMVideoOut...0xdb27d710	XVideo	Colorkey method: NONE
2010/11/04 21:34:05.502	  0:17.411	GMVideoOut...0xdb27d710	XVideo	Vertical sync successfully activated
2010/11/04 21:34:05.502	  0:17.411	GMVideoOut...0xdb27d710	XVideo	XQueryShmExtension success
2010/11/04 21:34:05.502	  0:17.411	GMVideoOut...0xdb27d710	XVideo	Created XvImage (320x240, data size: 115200, num_planes: 3
2010/11/04 21:34:05.502	  0:17.411	GMVideoOut...0xdb27d710	XVideo	  Plane 0: pitch=320, offset=0
2010/11/04 21:34:05.502	  0:17.411	GMVideoOut...0xdb27d710	XVideo	  Plane 1: pitch=160, offset=76800
2010/11/04 21:34:05.502	  0:17.411	GMVideoOut...0xdb27d710	XVideo	  Plane 2: pitch=160, offset=96000
2010/11/04 21:34:05.502	  0:17.411	GMVideoOut...0xdb27d710	XVideo	Using SHM extension
2010/11/04 21:34:05.502	  0:17.411	GMVideoOut...0xdb27d710	X11	Unknown wm type...
2010/11/04 21:34:05.502	  0:17.411	GMVideoOut...0xdb27d710	GMVideoOutputManager_X	VO_MODE_LOCAL: Successfully opened XV Window
2010/11/04 21:34:05.502	  0:17.411	GMVideoOut...0xdb27d710	X11	Unknown X Event 19 received
2010/11/04 21:34:05.592	  0:17.501	GMVideoOut...0xdb27d710	X11	Unmapping and destroying Window with ID 62914571
2010/11/04 21:34:05.592	  0:17.501	GMVideoOut...0xdb27d710	GMVideoOutputManager_X	Opening VO_MODE_LOCAL display with image of 320x240
2010/11/04 21:34:05.592	  0:17.501	GMVideoOut...0xdb27d710	XVideo	Initializing XV window with 320x240 at 26,26
2010/11/04 21:34:05.592	  0:17.501	GMVideoOut...0xdb27d710	XVideo	XvQueryExtension: Version: 2 Release: 2 Request Base: 132 Event Base: 72 Error Base: 140
2010/11/04 21:34:05.592	  0:17.501	GMVideoOut...0xdb27d710	XVideo	#0, Adaptor: NV40 texture adapter, type: input | image | , ports: 32, first port:�63
2010/11/04 21:34:05.593	  0:17.501	GMVideoOut...0xdb27d710	XVideo	Encoding List for Port 63:  id=0 name=XV_IMAGE size=4096x4096 numerator=1 denominator=1
2010/11/04 21:34:05.593	  0:17.501	GMVideoOut...0xdb27d710	XVideo	Attribute List for Port 63:
2010/11/04 21:34:05.593	  0:17.502	GMVideoOut...0xdb27d710	 �name: � � � XV_SET_DEFAULTS
2010/11/04 21:34:05.593	  0:17.502	GMVideoOut...0xdb27d710	 �flags: � �  set
2010/11/04 21:34:05.593	  0:17.502	GMVideoOut...0xdb27d710	 �min_color: �0
2010/11/04 21:34:05.593	  0:17.502	GMVideoOut...0xdb27d710	 �max_color: �0
2010/11/04 21:34:05.593	  0:17.502	GMVideoOut...0xdb27d710	 �name: � � � XV_SYNC_TO_VBLANK
2010/11/04 21:34:05.593	  0:17.502	GMVideoOut...0xdb27d710	 �flags: � �  get set
2010/11/04 21:34:05.593	  0:17.502	GMVideoOut...0xdb27d710	 �min_color: �0
2010/11/04 21:34:05.593	  0:17.502	GMVideoOut...0xdb27d710	 �max_color: �1
2010/11/04 21:34:05.593	  0:17.502	GMVideoOut...0xdb27d710	XVideo	Image format list for Port 63:
2010/11/04 21:34:05.593	  0:17.502	GMVideoOut...0xdb27d710	  0x32315659 (YV12) planar, order: YVU
2010/11/04 21:34:05.593	  0:17.502	GMVideoOut...0xdb27d710	  0x30323449 (I420) planar, order: YUV
2010/11/04 21:34:05.593	  0:17.502	GMVideoOut...0xdb27d710	XVideo	Grabbed Port: 63
2010/11/04 21:34:05.593	  0:17.502	GMVideoOut...0xdb27d710	XVideo	Using XVideo port: 63
2010/11/04 21:34:05.593	  0:17.502	GMVideoOut...0xdb27d710	XVideo	Found visual with colordepth of 24bits per pixel
2010/11/04 21:34:05.594	  0:17.502	GMVideoOut...0xdb27d710	X11	Created Window with ID 62914574
2010/11/04 21:34:05.594	  0:17.503	GMVideoOut...0xdb27d710	XVideo	Colorkey method: NONE
2010/11/04 21:34:05.594	  0:17.503	GMVideoOut...0xdb27d710	XVideo	Vertical sync successfully activated
2010/11/04 21:34:05.594	  0:17.503	GMVideoOut...0xdb27d710	XVideo	XQueryShmExtension success
2010/11/04 21:34:05.594	  0:17.503	GMVideoOut...0xdb27d710	XVideo	Created XvImage (320x240, data size: 115200, num_planes: 3
2010/11/04 21:34:05.594	  0:17.503	GMVideoOut...0xdb27d710	XVideo	  Plane 0: pitch=320, offset=0
2010/11/04 21:34:05.594	  0:17.503	GMVideoOut...0xdb27d710	XVideo	  Plane 1: pitch=160, offset=76800
2010/11/04 21:34:05.594	  0:17.503	GMVideoOut...0xdb27d710	XVideo	  Plane 2: pitch=160, offset=96000
2010/11/04 21:34:05.594	  0:17.503	GMVideoOut...0xdb27d710	XVideo	Using SHM extension
2010/11/04 21:34:05.594	  0:17.503	GMVideoOut...0xdb27d710	X11	Unknown wm type...
2010/11/04 21:34:05.594	  0:17.503	GMVideoOut...0xdb27d710	GMVideoOutputManager_X	VO_MODE_LOCAL: Successfully opened XV Window
2010/11/04 21:34:05.594	  0:17.503	GMVideoOut...0xdb27d710	X11	Unknown X Event 19 received
2010/11/04 21:34:06.252	  0:18.161	Opal Garbage:0xdb23c710	PCSS	Deleted PC sound system connection.
2010/11/04 21:34:06.253	  0:18.161	Opal Garbage:0xdb23c710	OpalCon	Connection Call[hdaef8acd3]-EP<pc>[j30a62fbc4] destroyed.
2010/11/04 21:34:06.378	  0:18.287	 Housekeeper:0xc80b2710	SIP	Set state Terminated_Success for INVITE transaction id=z9hG4bKfc325b88-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:34:07.253	  0:19.162	Opal Garbage:0xdb23c710	RTP	Closing session 1
2010/11/04 21:34:07.253	  0:19.162	Opal Garbage:0xdb23c710	RTP	Deleting session 1
2010/11/04 21:34:07.253	  0:19.162	Opal Garbage:0xdb23c710	RTP_UDP	Session 1, Shutting down read.
2010/11/04 21:34:07.253	  0:19.162	Opal Garbage:0xdb23c710	RTP_UDP	Session 1, Shutting down write.
2010/11/04 21:34:07.253	  0:19.162	Opal Garbage:0xdb23c710	RTP	Closing session 2
2010/11/04 21:34:07.253	  0:19.162	Opal Garbage:0xdb23c710	RTP	Deleting session 2
2010/11/04 21:34:07.253	  0:19.162	Opal Garbage:0xdb23c710	RTP_UDP	Session 2, Shutting down read.
2010/11/04 21:34:07.253	  0:19.162	Opal Garbage:0xdb23c710	RTP_UDP	Session 2, Shutting down write.
2010/11/04 21:34:07.253	  0:19.162	Opal Garbage:0xdb23c710	SIP	Transaction id=z9hG4bKfc325b88-c0e6-df11-8a9b-001a92ce6170 destroyed.
2010/11/04 21:34:07.254	  0:19.163	Opal Garbage:0xdb23c710	Opal	Transport clean up on termination
2010/11/04 21:34:07.254	  0:19.163	Opal Garbage:0xdb23c710	Opal	Transport Close
2010/11/04 21:34:07.254	  0:19.163	Opal Garbage:0xdb23c710	Opal	Transport clean up on termination
2010/11/04 21:34:07.254	  0:19.163	Opal Garbage:0xdb23c710	Opal	Transport Close
2010/11/04 21:34:07.254	  0:19.163	Opal Garbage:0xdb23c710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$95.85.164.64:5060>
2010/11/04 21:34:07.254	  0:19.163	Opal Garbage:0xdb23c710	SIP	Deleted connection.
2010/11/04 21:34:07.255	  0:19.163	Opal Garbage:0xdb23c710	OpalCon	Connection Call[hdaef8acd3]-EP<sip>[10265488-c0e6-df11-8a9b-001a92ce6170] destroyed.
2010/11/04 21:34:08.279	  0:20.188	                       	Call	Call[hdaef8acd3] destroyed.
2010/11/04 21:34:08.460	  0:20.368	                       	OpalMan	Set up call from pc:* to sip:letonga ekiga net
2010/11/04 21:34:08.460	  0:20.369	                       	Call	Created Call[m5bb9c46c5]
2010/11/04 21:34:08.460	  0:20.369	                       	OpalMan	Set up connection to "pc:*"
2010/11/04 21:34:08.460	  0:20.369	                       	OpalCon	Created connection Call[m5bb9c46c5]-EP<pc>[t7d4777466]
2010/11/04 21:34:08.460	  0:20.369	                       	Silence	Parameters set: mode=NoSilenceDetection, threshold=0, silencedb=3200, signaldb=80, period=4800
2010/11/04 21:34:08.460	  0:20.369	                       	Silence	Handler created
2010/11/04 21:34:08.460	  0:20.369	                       	Echo Canceler	Handler created
2010/11/04 21:34:08.460	  0:20.369	                       	PCSS	Created PC sound system connection: token="t7d4777466" player="EKIGA" recorder="EKIGA"
2010/11/04 21:34:08.460	  0:20.369	                       	OpalCon	SetPhase from UninitialisedPhase to SetUpPhase for Call[m5bb9c46c5]-EP<pc>[t7d4777466]
2010/11/04 21:34:08.460	  0:20.369	                       	OpalMan	OnIncoming connection Call[m5bb9c46c5]-EP<pc>[t7d4777466]
2010/11/04 21:34:08.460	  0:20.369	                       	OpalCon	Applying string options:


2010/11/04 21:34:08.460	  0:20.369	                       	Call	GetOtherPartyConnection Call[m5bb9c46c5]-EP<pc>[t7d4777466]
2010/11/04 21:34:08.460	  0:20.369	                       	OpalMan	Searching for route "pc:csanyipal	sip:letonga ekiga net"
2010/11/04 21:34:08.460	  0:20.369	                       	OpalMan	Set up connection to "sip:letonga ekiga net"
2010/11/04 21:34:08.460	  0:20.369	                       	OpalCon	Created connection Call[m5bb9c46c5]-EP<sip>[c6f2008b-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:08.460	  0:20.369	                       	RFC2833	Handler created
2010/11/04 21:34:08.460	  0:20.369	                       	RFC2833	Handler created
2010/11/04 21:34:08.461	  0:20.370	                       	SIP	Created connection.
2010/11/04 21:34:08.461	  0:20.370	                       	PCSS	Outgoing call routed to sip:letonga ekiga net for Call[m5bb9c46c5]-EP<pc>[t7d4777466]
2010/11/04 21:34:08.461	  0:20.370	                       	OpalMan	SetUpCall succeeded, call=Call[m5bb9c46c5]
2010/11/04 21:34:08.463	  0:20.372	   CallSetup:0xba1ff710	Call	OnSetUp Call[m5bb9c46c5]-EP<pc>[t7d4777466]
2010/11/04 21:34:08.463	  0:20.372	   CallSetup:0xba1ff710	SIP	SetUpConnection: sip:letonga ekiga net
2010/11/04 21:34:08.463	  0:20.372	   CallSetup:0xba1ff710	OpalCon	SetPhase from UninitialisedPhase to SetUpPhase for Call[m5bb9c46c5]-EP<sip>[c6f2008b-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:08.463	  0:20.372	   CallSetup:0xba1ff710	OpalCon	Applying string options:


2010/11/04 21:34:08.463	  0:20.372	   CallSetup:0xba1ff710	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:34:08.504	  0:20.413	   CallSetup:0xba1ff710	SIP	No SRV record found.
2010/11/04 21:34:08.504	  0:20.413	   CallSetup:0xba1ff710	SIP	Connecting to sip:letonga ekiga net via sip:letonga ekiga net
2010/11/04 21:34:08.504	  0:20.413	   CallSetup:0xba1ff710	SIP	Found registrar on domain ekiga.net, using interface 192.168.10.77%eth0
2010/11/04 21:34:08.504	  0:20.413	   CallSetup:0xba1ff710	OpalUDP	Binding to interface: 192.168.10.77:5060
2010/11/04 21:34:08.504	  0:20.413	   CallSetup:0xba1ff710	SIP	Created transport udp$86.64.162.35:5060<if=udp$95.85.164.64:5060>
2010/11/04 21:34:08.505	  0:20.414	   CallSetup:0xba1ff710	OpalUDP	Started connect to 86.64.162.35:5060
2010/11/04 21:34:08.505	  0:20.414	   CallSetup:0xba1ff710	SIP	Updating dialog tag from "" to "c6f2008b-c0e6-df11-8a9b-001a92ce6170"
2010/11/04 21:34:08.507	  0:20.416	   CallSetup:0xba1ff710	SIP	INVITE transaction id=z9hG4bK6213088b-c0e6-df11-8a9b-001a92ce6170 created.
2010/11/04 21:34:08.507	  0:20.416	   CallSetup:0xba1ff710	SIP	Creating INVITE request
2010/11/04 21:34:08.510	  0:20.419	   CallSetup:0xba1ff710	MediaFormat	Removing codecs PCM-16-48kHz,CELT-48K,PCM-16-32kHz,CELT-32K,PCM-16-16kHz,G.722-64k,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,PCM-16,G.711-uLaw-64k,G.726-16k,G.726-24k,G.726-32k,G.726-40k,GSM-06.10,GSM-AMR,LPC-10,MS-GSM,MS-IMA-ADPCM,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,YUV420P,RFC4175_YCbCr-4:2:0,theora,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz
2010/11/04 21:34:08.511	  0:20.420	   CallSetup:0xba1ff710	MediaFormat	Removing codecs PCM-16-48kHz,CELT-48K,PCM-16-32kHz,CELT-32K,PCM-16-16kHz,G.722-64k,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,PCM-16,G.711-uLaw-64k,G.726-16k,G.726-24k,G.726-32k,G.726-40k,GSM-06.10,GSM-AMR,LPC-10,MS-GSM,MS-IMA-ADPCM,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,YUV420P,RFC4175_YCbCr-4:2:0,theora,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz
2010/11/04 21:34:08.511	  0:20.420	   CallSetup:0xba1ff710	Call	GetMediaFormats for Call[m5bb9c46c5]-EP<sip>[c6f2008b-c0e6-df11-8a9b-001a92ce6170]
G.711-ALaw-64k
SpeexIETFNarrow-8k
SpeexNB
SpeexWNarrow-8k
H.261
H.261-CIF
H.261-QCIF

2010/11/04 21:34:08.511	  0:20.420	   CallSetup:0xba1ff710	SIP	Offering media type audio in SDP with formats
G.711-ALaw-64k,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,H.261,H.261-CIF,H.261-QCIF
2010/11/04 21:34:08.511	  0:20.420	   CallSetup:0xba1ff710	Call	IsMediaBypassPossible Call[m5bb9c46c5]-EP<sip>[c6f2008b-c0e6-df11-8a9b-001a92ce6170] session 1
2010/11/04 21:34:08.511	  0:20.420	   CallSetup:0xba1ff710	OpalMan	IsMediaBypassPossible: session 1
2010/11/04 21:34:08.511	  0:20.420	   CallSetup:0xba1ff710	OpalCon	IsMediaBypassPossible: default returns false
2010/11/04 21:34:08.511	  0:20.420	   CallSetup:0xba1ff710	RTP	Cannot find media session 1
2010/11/04 21:34:08.511	  0:20.420	   CallSetup:0xba1ff710	RTP	Cannot find RTP session 1
2010/11/04 21:34:08.512	  0:20.421	   CallSetup:0xba1ff710	RTP_UDP	Session 1, created with NAT flag set to 0
2010/11/04 21:34:09.133	  0:21.041	   CallSetup:0xba1ff710	RTP	Session 1, STUN created STUN RTP/RTCP socket pair.
2010/11/04 21:34:09.134	  0:21.043	   CallSetup:0xba1ff710	RTP_UDP	Session 1 created: 95.85.164.64:5078-5079 ssrc=2452204245
2010/11/04 21:34:09.134	  0:21.043	   CallSetup:0xba1ff710	RTP	Creating new session RTP_UDP
2010/11/04 21:34:09.134	  0:21.043	   CallSetup:0xba1ff710	RTP	Found existing media session 1
2010/11/04 21:34:09.135	  0:21.044	   CallSetup:0xba1ff710	SDP	SDP not including SpeexIETFNarrow-8k as it is not a SIP transportable format
2010/11/04 21:34:09.135	  0:21.044	   CallSetup:0xba1ff710	SDP	SDP not including SpeexWNarrow-8k as it is not a SIP transportable format
2010/11/04 21:34:09.135	  0:21.044	   CallSetup:0xba1ff710	SIP	Using default RTP payload [pt=101] for UserInput/RFC2833
2010/11/04 21:34:09.135	  0:21.044	   CallSetup:0xba1ff710	SIP	Using default RTP payload [pt=122] for NamedSignalEvent
2010/11/04 21:34:09.138	  0:21.047	   CallSetup:0xba1ff710	MediaFormat	Removing codecs PCM-16-48kHz,CELT-48K,PCM-16-32kHz,CELT-32K,PCM-16-16kHz,G.722-64k,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,PCM-16,G.711-uLaw-64k,G.726-16k,G.726-24k,G.726-32k,G.726-40k,GSM-06.10,GSM-AMR,LPC-10,MS-GSM,MS-IMA-ADPCM,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,YUV420P,RFC4175_YCbCr-4:2:0,theora,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz
2010/11/04 21:34:09.138	  0:21.047	   CallSetup:0xba1ff710	MediaFormat	Removing codecs PCM-16-48kHz,CELT-48K,PCM-16-32kHz,CELT-32K,PCM-16-16kHz,G.722-64k,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,PCM-16,G.711-uLaw-64k,G.726-16k,G.726-24k,G.726-32k,G.726-40k,GSM-06.10,GSM-AMR,LPC-10,MS-GSM,MS-IMA-ADPCM,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,YUV420P,RFC4175_YCbCr-4:2:0,theora,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz
2010/11/04 21:34:09.139	  0:21.048	   CallSetup:0xba1ff710	Call	GetMediaFormats for Call[m5bb9c46c5]-EP<sip>[c6f2008b-c0e6-df11-8a9b-001a92ce6170]
G.711-ALaw-64k
SpeexIETFNarrow-8k
SpeexNB
SpeexWNarrow-8k
H.261
H.261-CIF
H.261-QCIF

2010/11/04 21:34:09.139	  0:21.048	   CallSetup:0xba1ff710	SIP	Offering media type video in SDP with formats
G.711-ALaw-64k,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,H.261,H.261-CIF,H.261-QCIF
2010/11/04 21:34:09.139	  0:21.048	   CallSetup:0xba1ff710	Call	IsMediaBypassPossible Call[m5bb9c46c5]-EP<sip>[c6f2008b-c0e6-df11-8a9b-001a92ce6170] session 2
2010/11/04 21:34:09.139	  0:21.048	   CallSetup:0xba1ff710	OpalMan	IsMediaBypassPossible: session 2
2010/11/04 21:34:09.139	  0:21.048	   CallSetup:0xba1ff710	OpalCon	IsMediaBypassPossible: default returns false
2010/11/04 21:34:09.139	  0:21.048	   CallSetup:0xba1ff710	RTP	Cannot find media session 2
2010/11/04 21:34:09.139	  0:21.048	   CallSetup:0xba1ff710	RTP	Cannot find RTP session 2
2010/11/04 21:34:09.139	  0:21.048	   CallSetup:0xba1ff710	RTP_UDP	Session 2, created with NAT flag set to 0
2010/11/04 21:34:09.718	  0:21.627	   CallSetup:0xba1ff710	RTP	Session 2, STUN created STUN RTP/RTCP socket pair.
2010/11/04 21:34:09.719	  0:21.627	   CallSetup:0xba1ff710	RTP_UDP	Session 2 created: 95.85.164.64:5082-5083 ssrc=673826230
2010/11/04 21:34:09.719	  0:21.628	   CallSetup:0xba1ff710	RTP	Creating new session RTP_UDP
2010/11/04 21:34:09.719	  0:21.628	   CallSetup:0xba1ff710	RTP	Found existing media session 2
2010/11/04 21:34:09.720	  0:21.628	   CallSetup:0xba1ff710	SDP	SDP not including H.261-CIF as it is not a SIP transportable format
2010/11/04 21:34:09.720	  0:21.628	   CallSetup:0xba1ff710	SDP	SDP not including H.261-QCIF as it is not a SIP transportable format
2010/11/04 21:34:09.720	  0:21.629	   CallSetup:0xba1ff710	DNS	SRV Lookup ekiga.net service _sip._udp
2010/11/04 21:34:09.779	  0:21.688	   CallSetup:0xba1ff710	SIP	No SRV record found.
2010/11/04 21:34:09.779	  0:21.688	   CallSetup:0xba1ff710	SIP	Transaction remote address is udp$ekiga.net:5060
2010/11/04 21:34:09.779	  0:21.688	   CallSetup:0xba1ff710	OpalPlugin	to_customised_options: H.261
2010/11/04 21:34:09.780	  0:21.688	   CallSetup:0xba1ff710	OpalPlugin	to_customised_options changed option "Frame Width" from "320" to "176"
2010/11/04 21:34:09.780	  0:21.689	   CallSetup:0xba1ff710	OpalPlugin	to_customised_options changed option "Frame Height" from "240" to "144"
2010/11/04 21:34:09.780	  0:21.689	   CallSetup:0xba1ff710	SIP	Sending PDU (1012 bytes) to: rem=udp$86.64.162.35:5060,local=udp$95.85.164.64:5060,if=192.168.10.77%eth0
INVITE sip:letonga ekiga net SIP/2.0
Date: Thu, 04 Nov 2010 20:34:08 GMT
CSeq: 1 INVITE
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK6213088b-c0e6-df11-8a9b-001a92ce6170;rport
User-Agent: Ekiga/3.2.7
From: "Csányi Pál" <sip:csanyipal ekiga net>;tag=c6f2008b-c0e6-df11-8a9b-001a92ce6170
Call-ID: 06f9008b-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:letonga ekiga net>
Contact: <sip:csanyipal 95 85 164 64>
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Content-Type: application/sdp
Content-Length: 434
Max-Forwards: 70

v=0
o=- 1288902848 1 IN IP4 95.85.164.64
s=Opal SIP Session
c=IN IP4 95.85.164.64
t=0 0
m=audio 5078 RTP/AVP 8 110 101 122
a=sendrecv
a=rtpmap:8 PCMA/8000/1
a=rtpmap:110 Speex/8000/1
a=fmtp:110 sr=8000,mode=any
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16,32,36
a=rtpmap:122 NSE/8000
a=fmtp:122 192-193
m=video 5082 RTP/AVP 31
b=AS:4096
b=TIAS:4096000
a=sendrecv
a=rtpmap:31 h261/90000
a=fmtp:31 CIF=1;QCIF=1

2010/11/04 21:34:09.780	  0:21.689	   CallSetup:0xba1ff710	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:34:09.780	  0:21.689	   CallSetup:0xba1ff710	SIP	Transaction timers set: retry=0.500, completion=1:00.000
2010/11/04 21:34:09.781	  0:21.689	   CallSetup:0xba1ff710	OpalCon	OnSetUpConnectionCall[m5bb9c46c5]-EP<sip>[c6f2008b-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:09.781	  0:21.689	   CallSetup:0xba1ff710	OpalEP	OnSetUpConnection Call[m5bb9c46c5]-EP<sip>[c6f2008b-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:09.831	  0:21.740	Opal Liste...0xc8071710	OpalUDP	Binding to interface: 95.85.164.64:5060
2010/11/04 21:34:09.831	  0:21.740	Opal Liste...0xc8071710	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$95.85.164.64:5060>
2010/11/04 21:34:09.832	  0:21.740	Opal Liste...0xc8071710	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$95.85.164.64:5060,if=192.168.10.77%eth0
SIP/2.0 405 Method Not Allowed
CSeq: 1 INVITE
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK6213088b-c0e6-df11-8a9b-001a92ce6170;rport=5060
Server: Kamailio (1.5.3-notls (i386/linux))
From: "Csányi Pál" <sip:csanyipal ekiga net>;tag=c6f2008b-c0e6-df11-8a9b-001a92ce6170
Call-ID: 06f9008b-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:letonga ekiga net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.ee0f
Content-Length: 0


2010/11/04 21:34:09.832	  0:21.741	Opal Liste...0xc8071710	SIP	Queueing PDU "1 INVITE <405>", transaction=z9hG4bK6213088b-c0e6-df11-8a9b-001a92ce6170, token=c6f2008b-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:34:09.832	  0:21.741	Opal Liste...0xc8071710	Opal	Transport clean up on termination
2010/11/04 21:34:09.832	  0:21.741	Opal Liste...0xc8071710	Opal	Transport Close
2010/11/04 21:34:09.832	  0:21.741	        Pool:0xba240710	SIP	Handling PDU "1 INVITE <405>" for transaction=z9hG4bK6213088b-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:34:09.832	  0:21.741	Opal Liste...0xc8071710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$95.85.164.64:5060>
2010/11/04 21:34:09.833	  0:21.742	        Pool:0xba240710	SIP	Sending PDU (401 bytes) to: rem=udp$86.64.162.35:5060,local=udp$95.85.164.64:5060,if=192.168.10.77%eth0
ACK sip:letonga ekiga net SIP/2.0
CSeq: 1 ACK
Via: SIP/2.0/UDP 95.85.164.64:5060;branch=z9hG4bK6213088b-c0e6-df11-8a9b-001a92ce6170;rport
From: "Csányi Pál" <sip:csanyipal ekiga net>;tag=c6f2008b-c0e6-df11-8a9b-001a92ce6170
Call-ID: 06f9008b-c0e6-df11-8a9b-001a92ce6170 debian-asztal
To: <sip:letonga ekiga net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.ee0f
Content-Length: 0
Max-Forwards: 70


2010/11/04 21:34:09.833	  0:21.742	        Pool:0xba240710	OpalUDP	Setting interface to 192.168.10.77%eth0
2010/11/04 21:34:09.834	  0:21.742	        Pool:0xba240710	SIP	INVITE transaction id=z9hG4bK6213088b-c0e6-df11-8a9b-001a92ce6170 completed.
2010/11/04 21:34:09.834	  0:21.743	        Pool:0xba240710	OpalCon	SetPhase from SetUpPhase to ReleasingPhase for Call[m5bb9c46c5]-EP<sip>[c6f2008b-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:09.834	  0:21.743	        Pool:0xba240710	OpalCon	Releasing Call[m5bb9c46c5]-EP<sip>[c6f2008b-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:09.834	  0:21.743	        Pool:0xba240710	OpalCon	Call end reason for Call[m5bb9c46c5]-EP<sip>[c6f2008b-c0e6-df11-8a9b-001a92ce6170] set to EndedByQ931Cause
2010/11/04 21:34:09.834	  0:21.743	   OnRelease:0xba1ff710	SIP	OnReleased: Call[m5bb9c46c5]-EP<sip>[c6f2008b-c0e6-df11-8a9b-001a92ce6170], phase = ReleasingPhase
2010/11/04 21:34:09.834	  0:21.743	   OnRelease:0xba1ff710	OpalCon	SetPhase from ReleasingPhase to ReleasingPhase for Call[m5bb9c46c5]-EP<sip>[c6f2008b-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:09.834	  0:21.743	        Pool:0xba240710	SIP	Handled PDU "1 INVITE <405>"
2010/11/04 21:34:09.834	  0:21.743	   OnRelease:0xba1ff710	OpalCon	Media streams closed.
2010/11/04 21:34:09.834	  0:21.743	   OnRelease:0xba1ff710	SIP	Awaiting forked INVITE transaction completion, id=z9hG4bK6213088b-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:34:09.834	  0:21.743	   OnRelease:0xba1ff710	OpalCon	SetPhase from ReleasingPhase to ReleasedPhase for Call[m5bb9c46c5]-EP<sip>[c6f2008b-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:09.834	  0:21.743	   OnRelease:0xba1ff710	OpalCon	OnReleased Call[m5bb9c46c5]-EP<sip>[c6f2008b-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:09.834	  0:21.743	   OnRelease:0xba1ff710	OpalEP	OnReleased Call[m5bb9c46c5]-EP<sip>[c6f2008b-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:09.834	  0:21.743	   OnRelease:0xba1ff710	OpalMan	OnReleased Call[m5bb9c46c5]-EP<sip>[c6f2008b-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:09.834	  0:21.743	   OnRelease:0xba1ff710	Call	OnReleased Call[m5bb9c46c5]-EP<sip>[c6f2008b-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:09.834	  0:21.743	   OnRelease:0xba1ff710	OpalCon	SetPhase from SetUpPhase to ReleasingPhase for Call[m5bb9c46c5]-EP<pc>[t7d4777466]
2010/11/04 21:34:09.834	  0:21.743	   OnRelease:0xba1ff710	OpalCon	Releasing Call[m5bb9c46c5]-EP<pc>[t7d4777466]
2010/11/04 21:34:09.834	  0:21.743	   OnRelease:0xba1ff710	OpalCon	Call end reason for Call[m5bb9c46c5]-EP<pc>[t7d4777466] set to EndedByQ931Cause
2010/11/04 21:34:09.834	  0:21.743	   OnRelease:0xba1ff710	OpalCon	OnReleased Call[m5bb9c46c5]-EP<pc>[t7d4777466]
2010/11/04 21:34:09.834	  0:21.743	   OnRelease:0xba1ff710	OpalEP	OnReleased Call[m5bb9c46c5]-EP<pc>[t7d4777466]
2010/11/04 21:34:09.835	  0:21.743	   OnRelease:0xba1ff710	OpalMan	OnReleased Call[m5bb9c46c5]-EP<pc>[t7d4777466]
2010/11/04 21:34:09.835	  0:21.743	   OnRelease:0xba1ff710	Call	OnReleased Call[m5bb9c46c5]-EP<pc>[t7d4777466]
2010/11/04 21:34:09.835	  0:21.743	   OnRelease:0xba1ff710	OpalCon	Media streams closed.
2010/11/04 21:34:09.835	  0:21.743	   OnRelease:0xba1ff710	OpalCon	Media streams closed.
2010/11/04 21:34:09.835	  0:21.744	   OnRelease:0xba1ff710	OpalCon	OnRelease thread completed for Call[m5bb9c46c5]-EP<sip>[c6f2008b-c0e6-df11-8a9b-001a92ce6170]
2010/11/04 21:34:09.866	  0:21.775	                       	AEScheduler	Removing Event incoming_call_sound from queue
2010/11/04 21:34:09.866	  0:21.775	                       	AEScheduler	Removing Event ring_tone_sound from queue
2010/11/04 21:34:09.866	  0:21.775	                       	OpalMan	OnClearedCall Call[m5bb9c46c5] from "pc:csanyipal" to "sip:letonga ekiga net"
2010/11/04 21:34:09.866	  0:21.775	                       	OPAL	Attempting to close recording on call m5bb9c46c5 when not recording.
2010/11/04 21:34:09.880	  0:21.789	GMVideoOut...0xdb27d710	X11	Unmapping and destroying Window with ID 62914574
2010/11/04 21:34:09.880	  0:21.789	GMVideoOut...0xdb27d710	GMVideoOutputManager_X	Opening VO_MODE_LOCAL display with image of 320x240
2010/11/04 21:34:09.880	  0:21.789	GMVideoOut...0xdb27d710	XVideo	Initializing XV window with 320x240 at 26,42
2010/11/04 21:34:09.880	  0:21.789	GMVideoOut...0xdb27d710	XVideo	XvQueryExtension: Version: 2 Release: 2 Request Base: 132 Event Base: 72 Error Base: 140
2010/11/04 21:34:09.880	  0:21.789	GMVideoOut...0xdb27d710	XVideo	#0, Adaptor: NV40 texture adapter, type: input | image | , ports: 32, first port:�63
2010/11/04 21:34:09.880	  0:21.789	GMVideoOut...0xdb27d710	XVideo	Encoding List for Port 63:  id=0 name=XV_IMAGE size=4096x4096 numerator=1 denominator=1
2010/11/04 21:34:09.880	  0:21.789	GMVideoOut...0xdb27d710	XVideo	Attribute List for Port 63:
2010/11/04 21:34:09.880	  0:21.789	GMVideoOut...0xdb27d710	 �name: � � � XV_SET_DEFAULTS
2010/11/04 21:34:09.880	  0:21.789	GMVideoOut...0xdb27d710	 �flags: � �  set
2010/11/04 21:34:09.880	  0:21.789	GMVideoOut...0xdb27d710	 �min_color: �0
2010/11/04 21:34:09.881	  0:21.789	GMVideoOut...0xdb27d710	 �max_color: �0
2010/11/04 21:34:09.881	  0:21.789	GMVideoOut...0xdb27d710	 �name: � � � XV_SYNC_TO_VBLANK
2010/11/04 21:34:09.881	  0:21.789	GMVideoOut...0xdb27d710	 �flags: � �  get set
2010/11/04 21:34:09.881	  0:21.789	GMVideoOut...0xdb27d710	 �min_color: �0
2010/11/04 21:34:09.881	  0:21.790	GMVideoOut...0xdb27d710	 �max_color: �1
2010/11/04 21:34:09.881	  0:21.790	GMVideoOut...0xdb27d710	XVideo	Image format list for Port 63:
2010/11/04 21:34:09.882	  0:21.790	GMVideoOut...0xdb27d710	  0x32315659 (YV12) planar, order: YVU
2010/11/04 21:34:09.882	  0:21.790	GMVideoOut...0xdb27d710	  0x30323449 (I420) planar, order: YUV
2010/11/04 21:34:09.885	  0:21.794	GMVideoOut...0xdb27d710	XVideo	Grabbed Port: 63
2010/11/04 21:34:09.885	  0:21.794	GMVideoOut...0xdb27d710	XVideo	Using XVideo port: 63
2010/11/04 21:34:09.885	  0:21.794	GMVideoOut...0xdb27d710	XVideo	Found visual with colordepth of 24bits per pixel
2010/11/04 21:34:09.885	  0:21.794	GMVideoOut...0xdb27d710	X11	Created Window with ID 62914577
2010/11/04 21:34:09.885	  0:21.794	GMVideoOut...0xdb27d710	XVideo	Colorkey method: NONE
2010/11/04 21:34:09.886	  0:21.794	GMVideoOut...0xdb27d710	XVideo	Vertical sync successfully activated
2010/11/04 21:34:09.886	  0:21.794	GMVideoOut...0xdb27d710	XVideo	XQueryShmExtension success
2010/11/04 21:34:09.886	  0:21.795	GMVideoOut...0xdb27d710	XVideo	Created XvImage (320x240, data size: 115200, num_planes: 3
2010/11/04 21:34:09.886	  0:21.795	GMVideoOut...0xdb27d710	XVideo	  Plane 0: pitch=320, offset=0
2010/11/04 21:34:09.886	  0:21.795	GMVideoOut...0xdb27d710	XVideo	  Plane 1: pitch=160, offset=76800
2010/11/04 21:34:09.886	  0:21.795	GMVideoOut...0xdb27d710	XVideo	  Plane 2: pitch=160, offset=96000
2010/11/04 21:34:09.886	  0:21.795	GMVideoOut...0xdb27d710	XVideo	Using SHM extension
2010/11/04 21:34:09.886	  0:21.795	GMVideoOut...0xdb27d710	X11	Unknown wm type...
2010/11/04 21:34:09.886	  0:21.795	GMVideoOut...0xdb27d710	GMVideoOutputManager_X	VO_MODE_LOCAL: Successfully opened XV Window
2010/11/04 21:34:09.886	  0:21.795	GMVideoOut...0xdb27d710	X11	Unknown X Event 19 received
2010/11/04 21:34:09.976	  0:21.885	GMVideoOut...0xdb27d710	X11	Unmapping and destroying Window with ID 62914577
2010/11/04 21:34:09.976	  0:21.885	GMVideoOut...0xdb27d710	GMVideoOutputManager_X	Opening VO_MODE_LOCAL display with image of 320x240
2010/11/04 21:34:09.976	  0:21.885	GMVideoOut...0xdb27d710	XVideo	Initializing XV window with 320x240 at 26,26
2010/11/04 21:34:09.976	  0:21.885	GMVideoOut...0xdb27d710	XVideo	XvQueryExtension: Version: 2 Release: 2 Request Base: 132 Event Base: 72 Error Base: 140
2010/11/04 21:34:09.976	  0:21.885	GMVideoOut...0xdb27d710	XVideo	#0, Adaptor: NV40 texture adapter, type: input | image | , ports: 32, first port:�63
2010/11/04 21:34:09.976	  0:21.885	GMVideoOut...0xdb27d710	XVideo	Encoding List for Port 63:  id=0 name=XV_IMAGE size=4096x4096 numerator=1 denominator=1
2010/11/04 21:34:09.976	  0:21.885	GMVideoOut...0xdb27d710	XVideo	Attribute List for Port 63:
2010/11/04 21:34:09.976	  0:21.885	GMVideoOut...0xdb27d710	 �name: � � � XV_SET_DEFAULTS
2010/11/04 21:34:09.976	  0:21.885	GMVideoOut...0xdb27d710	 �flags: � �  set
2010/11/04 21:34:09.976	  0:21.885	GMVideoOut...0xdb27d710	 �min_color: �0
2010/11/04 21:34:09.977	  0:21.885	GMVideoOut...0xdb27d710	 �max_color: �0
2010/11/04 21:34:09.977	  0:21.885	GMVideoOut...0xdb27d710	 �name: � � � XV_SYNC_TO_VBLANK
2010/11/04 21:34:09.977	  0:21.885	GMVideoOut...0xdb27d710	 �flags: � �  get set
2010/11/04 21:34:09.977	  0:21.885	GMVideoOut...0xdb27d710	 �min_color: �0
2010/11/04 21:34:09.977	  0:21.885	GMVideoOut...0xdb27d710	 �max_color: �1
2010/11/04 21:34:09.977	  0:21.885	GMVideoOut...0xdb27d710	XVideo	Image format list for Port 63:
2010/11/04 21:34:09.977	  0:21.886	GMVideoOut...0xdb27d710	  0x32315659 (YV12) planar, order: YVU
2010/11/04 21:34:09.977	  0:21.886	GMVideoOut...0xdb27d710	  0x30323449 (I420) planar, order: YUV
2010/11/04 21:34:09.977	  0:21.886	GMVideoOut...0xdb27d710	XVideo	Grabbed Port: 63
2010/11/04 21:34:09.977	  0:21.886	GMVideoOut...0xdb27d710	XVideo	Using XVideo port: 63
2010/11/04 21:34:09.977	  0:21.886	GMVideoOut...0xdb27d710	XVideo	Found visual with colordepth of 24bits per pixel
2010/11/04 21:34:09.977	  0:21.886	GMVideoOut...0xdb27d710	X11	Created Window with ID 62914580
2010/11/04 21:34:09.978	  0:21.886	GMVideoOut...0xdb27d710	XVideo	Colorkey method: NONE
2010/11/04 21:34:09.978	  0:21.886	GMVideoOut...0xdb27d710	XVideo	Vertical sync successfully activated
2010/11/04 21:34:09.978	  0:21.887	GMVideoOut...0xdb27d710	XVideo	XQueryShmExtension success
2010/11/04 21:34:09.978	  0:21.887	GMVideoOut...0xdb27d710	XVideo	Created XvImage (320x240, data size: 115200, num_planes: 3
2010/11/04 21:34:09.978	  0:21.887	GMVideoOut...0xdb27d710	XVideo	  Plane 0: pitch=320, offset=0
2010/11/04 21:34:09.978	  0:21.887	GMVideoOut...0xdb27d710	XVideo	  Plane 1: pitch=160, offset=76800
2010/11/04 21:34:09.978	  0:21.887	GMVideoOut...0xdb27d710	XVideo	  Plane 2: pitch=160, offset=96000
2010/11/04 21:34:09.978	  0:21.887	GMVideoOut...0xdb27d710	XVideo	Using SHM extension
2010/11/04 21:34:09.978	  0:21.887	GMVideoOut...0xdb27d710	X11	Unknown wm type...
2010/11/04 21:34:09.978	  0:21.887	GMVideoOut...0xdb27d710	GMVideoOutputManager_X	VO_MODE_LOCAL: Successfully opened XV Window
2010/11/04 21:34:09.978	  0:21.887	GMVideoOut...0xdb27d710	X11	Unknown X Event 19 received
2010/11/04 21:34:10.255	  0:22.164	Opal Garbage:0xdb23c710	PCSS	Deleted PC sound system connection.
2010/11/04 21:34:10.255	  0:22.164	Opal Garbage:0xdb23c710	OpalCon	Connection Call[m5bb9c46c5]-EP<pc>[t7d4777466] destroyed.
2010/11/04 21:34:10.834	  0:22.743	 Housekeeper:0xc80b2710	SIP	Set state Terminated_Success for INVITE transaction id=z9hG4bK6213088b-c0e6-df11-8a9b-001a92ce6170
2010/11/04 21:34:11.255	  0:23.164	Opal Garbage:0xdb23c710	RTP	Closing session 1
2010/11/04 21:34:11.255	  0:23.164	Opal Garbage:0xdb23c710	RTP	Deleting session 1
2010/11/04 21:34:11.255	  0:23.164	Opal Garbage:0xdb23c710	RTP_UDP	Session 1, Shutting down read.
2010/11/04 21:34:11.256	  0:23.165	Opal Garbage:0xdb23c710	RTP_UDP	Session 1, Shutting down write.
2010/11/04 21:34:11.256	  0:23.165	Opal Garbage:0xdb23c710	RTP	Closing session 2
2010/11/04 21:34:11.256	  0:23.165	Opal Garbage:0xdb23c710	RTP	Deleting session 2
2010/11/04 21:34:11.256	  0:23.165	Opal Garbage:0xdb23c710	RTP_UDP	Session 2, Shutting down read.
2010/11/04 21:34:11.256	  0:23.165	Opal Garbage:0xdb23c710	RTP_UDP	Session 2, Shutting down write.
2010/11/04 21:34:11.256	  0:23.165	Opal Garbage:0xdb23c710	SIP	Transaction id=z9hG4bK6213088b-c0e6-df11-8a9b-001a92ce6170 destroyed.
2010/11/04 21:34:11.256	  0:23.165	Opal Garbage:0xdb23c710	Opal	Transport clean up on termination
2010/11/04 21:34:11.256	  0:23.165	Opal Garbage:0xdb23c710	Opal	Transport Close
2010/11/04 21:34:11.256	  0:23.165	Opal Garbage:0xdb23c710	Opal	Transport clean up on termination
2010/11/04 21:34:11.256	  0:23.165	Opal Garbage:0xdb23c710	Opal	Transport Close
2010/11/04 21:34:11.257	  0:23.165	Opal Garbage:0xdb23c710	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$95.85.164.64:5060>
2010/11/04 21:34:11.257	  0:23.166	Opal Garbage:0xdb23c710	SIP	Deleted connection.
2010/11/04 21:34:11.257	  0:23.166	Opal Garbage:0xdb23c710	OpalCon	Connection Call[m5bb9c46c5]-EP<sip>[c6f2008b-c0e6-df11-8a9b-001a92ce6170] destroyed.
2010/11/04 21:34:12.264	  0:24.173	                       	Call	Call[m5bb9c46c5] destroyed.

(ekiga:2947): GLib-GObject-CRITICAL **: g_object_unref: assertion `G_IS_OBJECT (object)' failed
2010/11/04 21:34:15.160	  0:27.069	                       	PreviewManager	Stopping Preview
2010/11/04 21:34:15.165	  0:27.074	GMVideoOut...0xdb27d710	X11	Unmapping and destroying Window with ID 62914580
2010/11/04 21:34:15.167	  0:27.076	Network In...0xdb1fb710	IfaceMon	Finished interface monitor thread.


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