   h263-1998.cxx(2083)	H.263	Codec	Enabled with 4 definitions
../common/dyna.cxx(135)		DYNA	Error loading libavcodec
../common/dyna.cxx(135)		DYNA	Error loading @´‘|ÿÿÿÿÅe‘|tá—|%c‘|\libavcodec
../common/dyna.cxx(135)		DYNA	Error loading .\libavcodec
../common/dyna.cxx(135)		DYNA	Error loading /usr/local/lib\libavcodec
../common/dyna.cxx(140)		DYNA	Successfully loaded 'avcodec-52'
../common/dyna.cxx(140)		DYNA	Successfully loaded 'avutil-50'
../common/dyna.cxx(391)	H264	DYNA	Successfully loaded libavcodec library and verified functions
h264pipe_win32.cxx(294)	H264	IPC	PP: Found GPL process executable in .\plugins\h264_video_pwplugin_helper.exe
h264pipe_win32.cxx(324)	H264	IPC	PP: Successfully created child process 3304
h264pipe_win32.cxx(104)	H264	IPC	PP: Successfully established communication with child process
   h264-x264.cxx(853)	H264	Codec	Enabled
../common/dyna.cxx(135)		DYNA	Error loading libavcodec
../common/dyna.cxx(135)		DYNA	Error loading @´‘|ÿÿÿÿÅe‘|tá—|%c‘|\libavcodec
../common/dyna.cxx(135)		DYNA	Error loading .\libavcodec
../common/dyna.cxx(135)		DYNA	Error loading /usr/local/lib\libavcodec
../common/dyna.cxx(140)		DYNA	Successfully loaded 'avcodec-52'
../common/dyna.cxx(140)		DYNA	Successfully loaded 'avutil-50'
../common/dyna.cxx(391)	MPEG4	DYNA	Successfully loaded libavcodec library and verified functions
       mpeg4.cxx(1993)	MPEG4	Codec	Enabled
2011/04/01 21:37:26.609	  0:00.228	                  ekiga		Version 3.3.0 by  on Windows XP (v5.1.2600-i586 (Model=15 Stepping=11)) with PTLib (v2.8.3 (svn:24307)) at 2011/4/1 21:37:26.609
2011/04/01 21:37:26.609	  0:00.228	                  ekiga	Ekiga git revision: unknown
2011/04/01 21:37:26.609	  0:00.230	                  ekiga	PVidDirectShow	PVideoInputDevice_DirectShow: constructor
2011/04/01 21:37:26.609	  0:00.230	                  ekiga	PVidDirectShow	Enumerating Device Names
2011/04/01 21:37:26.625	  0:00.242	                  ekiga	PVidDirectShow	No video capture device was detected.
2011/04/01 21:37:26.625	  0:00.243	                  ekiga	PVidDirectShow	PVideoInputDevice_DirectShow: destructor
2011/04/01 21:37:26.625	  0:00.246	                  ekiga	OpalMan	Created manager.
2011/04/01 21:37:26.625	  0:00.246	                  ekiga	PVidDirectShow	PVideoInputDevice_DirectShow: constructor
2011/04/01 21:37:26.625	  0:00.246	                  ekiga	PVidDirectShow	Enumerating Device Names
2011/04/01 21:37:26.625	  0:00.250	                  ekiga	PVidDirectShow	No video capture device was detected.
2011/04/01 21:37:26.625	  0:00.250	                  ekiga	PVidDirectShow	PVideoInputDevice_DirectShow: destructor
2011/04/01 21:37:26.625	  0:00.252	                  ekiga	OpalMan	Attached endpoint with prefix pc
2011/04/01 21:37:26.625	  0:00.252	                  ekiga	OpalEP	Created endpoint: pc
2011/04/01 21:37:26.625	  0:00.253	                  ekiga	LocalEP	Created endpoint.
2011/04/01 21:37:26.671	  0:00.300	                  ekiga	PCSS	Created PC sound system endpoint.
Players:
Default
EKIGA
*.wav
SoundMAX HD Audio
Recorders:
HD Audio front mic
Default
EKIGA
*.wav
SoundMAX HD Audio

2011/04/01 21:37:26.671	  0:00.300	                  ekiga	OPAL	SetMediaFormatOrder()
2011/04/01 21:37:26.671	  0:00.300	                  ekiga	OPAL	SetMediaFormatMask()
2011/04/01 21:37:26.671	  0:00.301	                  ekiga	OpalMan	Attached endpoint with prefix sip
2011/04/01 21:37:26.671	  0:00.301	                  ekiga	OpalEP	Created endpoint: sip
2011/04/01 21:37:26.671	  0:00.303	                  ekiga	IfaceMon	Initial interface list:
192.168.19.22 <00ffce7de359> (TAP-Win32 Adapter V9 - Packet Scheduler Miniport)
192.168.10.105 <001cc07e4e24> (Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport)
192.168.56.1 <0800270078df> (VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport)
127.0.0.1 (MS TCP Loopback interface)

2011/04/01 21:37:26.687	  0:00.303	                  ekiga	SIP	Created endpoint.
2011/04/01 21:37:26.687	  0:00.303	Network In...nitor:5792	IfaceMon	Started interface monitor thread.
2011/04/01 21:37:26.687	  0:00.306	                  ekiga	MonSock	Created socket bundle for all interfaces.
2011/04/01 21:37:26.687	  0:00.309	                  ekiga	MonSock	Created bundled UDP socket 192.168.19.22:5060
2011/04/01 21:37:26.687	  0:00.310	                  ekiga	MonSock	Created bundled UDP socket 192.168.10.105:5060
2011/04/01 21:37:26.687	  0:00.312	                  ekiga	MonSock	Created bundled UDP socket 192.168.56.1:5060
2011/04/01 21:37:26.687	  0:00.312	                  ekiga	OpalMan	Added route "sip:.*=pc:*"
2011/04/01 21:37:26.687	  0:00.312	     Opal Listener:3864	Listen	Started listening thread on udp$*:5060
2011/04/01 21:37:26.687	  0:00.312	                  ekiga	OpalMan	Added route "pc:.*=sip:<da>"
2011/04/01 21:37:26.687	  0:00.312	                  ekiga	OpalMan	Attached endpoint with prefix h323
2011/04/01 21:37:26.687	  0:00.313	                  ekiga	OpalEP	Created endpoint: h323
2011/04/01 21:37:26.687	  0:00.313	                  ekiga	OpalMan	Attached endpoint with prefix h323s
2011/04/01 21:37:26.687	  0:00.313	                  ekiga	H323	Created endpoint.
2011/04/01 21:37:26.687	  0:00.315	                  ekiga	OpalMan	Added route "h323:.*=pc:<db>"
2011/04/01 21:37:26.687	  0:00.315	     Opal Listener:3988	Listen	Started listening thread on tcp$*:1720
2011/04/01 21:37:26.687	  0:00.315	                  ekiga	OpalMan	Added route "pc:.*=h323:<da>"
2011/04/01 21:37:26.687	  0:00.315	     Opal Listener:3988	Listen	Waiting on socket accept on tcp$*:1720
2011/04/01 21:37:26.734	  0:00.363	                  ekiga	DNS	SRV Lookup ekiga.net service _pres._sip
2011/04/01 21:38:01.890	  0:35.513	                  ekiga	SIP	Start SUBSCRIBE
 eventPackage=presence
          aor=sip:500@ekiga.net
       remote=
        local=
      contact=
       authID=
        realm=
       expire=300
      restore=30
     minRetry=default
     maxRetry=default
2011/04/01 21:38:01.890	  0:35.513	        PThreadObj:2292	SIPPres	'sip:500@ekiga.net' sending subscribe for own presence.watcherinfo
2011/04/01 21:38:01.890	  0:35.513	        PThreadObj:2292	SIP	Start SUBSCRIBE
 eventPackage=presence.winfo
          aor=sip:500@ekiga.net
       remote=86.64.162.35:5060;transport=tcp
        local=sip:500@ekiga.net
      contact=
       authID=sip:500@ekiga.net
        realm=
       expire=300
      restore=30
     minRetry=default
     maxRetry=default
2011/04/01 21:38:01.890	  0:35.514	                  ekiga	SIP	Constructed handler for sip:500@ekiga.net
2011/04/01 21:38:01.890	  0:35.514	        PThreadObj:2292	SIP	Constructed handler for sip:500@ekiga.net;OPAL-local-id=sip%3A500%40ekiga.net
2011/04/01 21:38:01.890	  0:35.515	                  ekiga	SIP	Executing state change to Subscribing for SUBSCRIBE handler, target=sip:500@ekiga.net, id=864da9b2-d303-1910-8985-00ffce7de359@LCS-214-230
2011/04/01 21:38:01.890	  0:35.515	                  ekiga	SIP	Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:500@ekiga.net, id=864da9b2-d303-1910-8985-00ffce7de359@LCS-214-230
2011/04/01 21:38:01.890	  0:35.515	        PThreadObj:2292	SIP	Executing state change to Subscribing for SUBSCRIBE handler, target=sip:500@ekiga.net;OPAL-local-id=sip%3A500%40ekiga.net, id=864da9b2-d303-1910-8986-00ffce7de359@LCS-214-230
2011/04/01 21:38:01.890	  0:35.515	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:38:01.890	  0:35.516	        PThreadObj:2292	SIP	Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:500@ekiga.net;OPAL-local-id=sip%3A500%40ekiga.net, id=864da9b2-d303-1910-8986-00ffce7de359@LCS-214-230
2011/04/01 21:38:01.890	  0:35.516	        PThreadObj:2292	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:38:37.000	  1:10.626	                  ekiga	SIP	No SRV record found.
2011/04/01 21:38:37.000	  1:10.626	                  ekiga	OpalUDP	Binding to interface: 0.0.0.0:5060
2011/04/01 21:38:37.000	  1:10.626	                  ekiga	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2011/04/01 21:38:37.000	  1:10.627	                  ekiga	OpalUDP	Started connect to 86.64.162.35:5060
2011/04/01 21:38:37.000	  1:10.627	                  ekiga	OpalUDP	Writing to interface 0 - "192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport"
2011/04/01 21:38:37.015	  1:10.630	                  ekiga	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.19.22:5060,udp$192.168.10.105:5060,udp$192.168.56.1:5060
2011/04/01 21:38:37.015	  1:10.633	                  ekiga	SIP	Transaction created.
2011/04/01 21:38:37.015	  1:10.636	        PThreadObj:2292	SIP	No SRV record found.
2011/04/01 21:38:37.015	  1:10.637	        PThreadObj:2292	OpalUDP	Binding to interface: 0.0.0.0:5060
2011/04/01 21:38:37.015	  1:10.637	        PThreadObj:2292	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2011/04/01 21:38:37.015	  1:10.638	        PThreadObj:2292	OpalUDP	Started connect to 86.64.162.35:5060
2011/04/01 21:38:37.015	  1:10.638	        PThreadObj:2292	OpalUDP	Writing to interface 0 - "192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport"
2011/04/01 21:38:37.015	  1:10.639	        PThreadObj:2292	SIP	Transaction created.
2011/04/01 21:38:37.015	  1:10.640	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:38:37.015	  1:10.645	        PThreadObj:2292	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:39:12.109	  1:45.730	                  ekiga	SIP	No SRV record found.
2011/04/01 21:39:12.109	  1:45.730	                  ekiga	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:39:12.109	  1:45.731	                  ekiga	SIP	Sending PDU (554 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.19.22:5060,if=192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport
SUBSCRIBE sip:500@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.19.22:5060;branch=z9hG4bK3ae6deb2-d303-1910-8988-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: "kamath" <sip:kamath@192.168.19.22>;tag=3ae6deb2-d303-1910-8986-00ffce7de359

Call-ID: 864da9b2-d303-1910-8985-00ffce7de359@LCS-214-230

To: <sip:500@ekiga.net>

Contact: sip:500@192.168.19.22

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




2011/04/01 21:39:12.109	  1:45.732	                  ekiga	OpalUDP	Setting interface to 192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport
2011/04/01 21:39:12.109	  1:45.732	                  ekiga	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:39:12.109	  1:45.732	                  ekiga	OpalUDP	Writing to interface 1 - "192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport"
2011/04/01 21:39:12.109	  1:45.734	                  ekiga	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.19.22:5060,udp$192.168.10.105:5060,udp$192.168.56.1:5060
2011/04/01 21:39:12.109	  1:45.737	                  ekiga	SIP	Transaction created.
2011/04/01 21:39:12.125	  1:45.738	        PThreadObj:2292	SIP	No SRV record found.
2011/04/01 21:39:12.125	  1:45.738	        PThreadObj:2292	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:39:12.125	  1:45.738	        PThreadObj:2292	SIP	Sending PDU (551 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.19.22:5060,if=192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport
SUBSCRIBE sip:500@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.19.22:5060;branch=z9hG4bK3ae6deb2-d303-1910-8989-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: <sip:500@ekiga.net>;tag=3ae6deb2-d303-1910-8987-00ffce7de359

Call-ID: 864da9b2-d303-1910-8986-00ffce7de359@LCS-214-230

To: <sip:500@ekiga.net>

Contact: sip:500@192.168.19.22

Accept: application/watcherinfo+xml

Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING

Expires: 300

Event: presence.winfo

Content-Length: 0

Max-Forwards: 70




2011/04/01 21:39:12.125	  1:45.740	        PThreadObj:2292	OpalUDP	Setting interface to 192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport
2011/04/01 21:39:12.125	  1:45.740	        PThreadObj:2292	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:39:12.125	  1:45.740	        PThreadObj:2292	OpalUDP	Writing to interface 1 - "192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport"
2011/04/01 21:39:12.125	  1:45.740	        PThreadObj:2292	SIP	Transaction created.
2011/04/01 21:39:12.125	  1:45.745	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:39:12.125	  1:45.748	        PThreadObj:2292	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:39:47.218	  2:20.841	                  ekiga	SIP	No SRV record found.
2011/04/01 21:39:47.218	  2:20.841	                  ekiga	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:39:47.218	  2:20.841	                  ekiga	SIP	Sending PDU (557 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.10.105:5060,if=192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
SUBSCRIBE sip:500@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.10.105:5060;branch=z9hG4bKd47814b3-d303-1910-8989-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: "kamath" <sip:kamath@192.168.10.105>;tag=3ae6deb2-d303-1910-8986-00ffce7de359

Call-ID: 864da9b2-d303-1910-8985-00ffce7de359@LCS-214-230

To: <sip:500@ekiga.net>

Contact: sip:500@192.168.10.105

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




2011/04/01 21:39:47.218	  2:20.842	                  ekiga	OpalUDP	Setting interface to 192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
2011/04/01 21:39:47.218	  2:20.843	                  ekiga	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:39:47.218	  2:20.843	                  ekiga	OpalUDP	Writing to interface 2 - "192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport"
2011/04/01 21:39:47.218	  2:20.845	                  ekiga	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.19.22:5060,udp$192.168.10.105:5060,udp$192.168.56.1:5060
2011/04/01 21:39:47.234	  2:20.848	                  ekiga	SIP	Transaction created.
2011/04/01 21:39:47.234	  2:20.853	        PThreadObj:2292	SIP	No SRV record found.
2011/04/01 21:39:47.234	  2:20.853	        PThreadObj:2292	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:39:47.234	  2:20.853	        PThreadObj:2292	SIP	Sending PDU (553 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.10.105:5060,if=192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
SUBSCRIBE sip:500@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.10.105:5060;branch=z9hG4bKd47814b3-d303-1910-898a-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: <sip:500@ekiga.net>;tag=3ae6deb2-d303-1910-8987-00ffce7de359

Call-ID: 864da9b2-d303-1910-8986-00ffce7de359@LCS-214-230

To: <sip:500@ekiga.net>

Contact: sip:500@192.168.10.105

Accept: application/watcherinfo+xml

Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING

Expires: 300

Event: presence.winfo

Content-Length: 0

Max-Forwards: 70




2011/04/01 21:39:47.234	  2:20.854	        PThreadObj:2292	OpalUDP	Setting interface to 192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
2011/04/01 21:39:47.234	  2:20.854	        PThreadObj:2292	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:39:47.234	  2:20.854	        PThreadObj:2292	OpalUDP	Writing to interface 2 - "192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport"
2011/04/01 21:39:47.234	  2:20.855	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:39:47.234	  2:20.855	        PThreadObj:2292	SIP	Transaction created.
2011/04/01 21:39:47.234	  2:20.861	        PThreadObj:2292	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:39:47.328	  2:20.955	     Opal Listener:3864	OpalUDP	Binding to interface: 192.168.10.105:5060
2011/04/01 21:39:47.328	  2:20.955	     Opal Listener:3864	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:39:47.343	  2:20.957	     Opal Listener:3864	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.10.105:5060,if=192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
SIP/2.0 489 Event Not Supported
CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.10.105:5060;branch=z9hG4bKd47814b3-d303-1910-8989-00ffce7de359;rport=5060;received=74.71.59.242

Server: Kamailio (1.5.3-notls (i386/linux))

From: "kamath" <sip:kamath@192.168.10.105>;tag=3ae6deb2-d303-1910-8986-00ffce7de359

Call-ID: 864da9b2-d303-1910-8985-00ffce7de359@LCS-214-230

To: <sip:500@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.9dcd

Content-Length: 0




2011/04/01 21:39:47.343	  2:20.958	     Opal Listener:3864	SIP	Queueing PDU "1 SUBSCRIBE <489>", transaction=z9hG4bKd47814b3-d303-1910-8989-00ffce7de359, token=864da9b2-d303-1910-8985-00ffce7de359@LCS-214-230
2011/04/01 21:39:47.343	  2:20.958	     Opal Listener:3864	Opal	Transport clean up on termination
2011/04/01 21:39:47.343	  2:20.958	     Opal Listener:3864	Opal	Transport Close
2011/04/01 21:39:47.343	  2:20.958	              Pool:4060	SIP	Handling PDU "1 SUBSCRIBE <489>" for transaction=z9hG4bKd47814b3-d303-1910-8989-00ffce7de359
2011/04/01 21:39:47.343	  2:20.958	              Pool:4060	SIP	SUBSCRIBE transaction id=z9hG4bKd47814b3-d303-1910-8989-00ffce7de359 completed.
2011/04/01 21:39:47.343	  2:20.958	     Opal Listener:3864	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:39:47.343	  2:20.968	     Opal Listener:3864	OpalUDP	Binding to interface: 192.168.10.105:5060
2011/04/01 21:39:47.343	  2:20.968	     Opal Listener:3864	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:39:47.343	  2:20.969	     Opal Listener:3864	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.10.105:5060,if=192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
SIP/2.0 489 Event Not Supported
CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.10.105:5060;branch=z9hG4bKd47814b3-d303-1910-898a-00ffce7de359;rport=5060;received=74.71.59.242

Server: Kamailio (1.5.3-notls (i386/linux))

From: <sip:500@ekiga.net>;tag=3ae6deb2-d303-1910-8987-00ffce7de359

Call-ID: 864da9b2-d303-1910-8986-00ffce7de359@LCS-214-230

To: <sip:500@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.206a

Content-Length: 0




2011/04/01 21:39:47.343	  2:20.970	     Opal Listener:3864	SIP	Queueing PDU "1 SUBSCRIBE <489>", transaction=z9hG4bKd47814b3-d303-1910-898a-00ffce7de359, token=864da9b2-d303-1910-8986-00ffce7de359@LCS-214-230
2011/04/01 21:39:47.343	  2:20.971	     Opal Listener:3864	Opal	Transport clean up on termination
2011/04/01 21:39:47.343	  2:20.971	     Opal Listener:3864	Opal	Transport Close
2011/04/01 21:39:47.343	  2:20.971	              Pool:6072	SIP	Handling PDU "1 SUBSCRIBE <489>" for transaction=z9hG4bKd47814b3-d303-1910-898a-00ffce7de359
2011/04/01 21:39:47.343	  2:20.971	              Pool:6072	SIP	SUBSCRIBE transaction id=z9hG4bKd47814b3-d303-1910-898a-00ffce7de359 completed.
2011/04/01 21:39:47.343	  2:20.971	     Opal Listener:3864	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:40:22.312	  2:55.939	                  ekiga	SIP	No SRV record found.
2011/04/01 21:40:22.312	  2:55.939	                  ekiga	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:40:22.312	  2:55.939	                  ekiga	SIP	Sending PDU (551 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.56.1:5060,if=192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport
SUBSCRIBE sip:500@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.56.1:5060;branch=z9hG4bK6d0b4ab3-d303-1910-898a-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: "kamath" <sip:kamath@192.168.56.1>;tag=3ae6deb2-d303-1910-8986-00ffce7de359

Call-ID: 864da9b2-d303-1910-8985-00ffce7de359@LCS-214-230

To: <sip:500@ekiga.net>

Contact: sip:500@192.168.56.1

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




2011/04/01 21:40:22.328	  2:55.940	                  ekiga	OpalUDP	Setting interface to 192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport
2011/04/01 21:40:22.328	  2:55.940	                  ekiga	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:40:22.328	  2:55.940	              Pool:4060	SIP	SUBSCRIBE transaction id=z9hG4bK3ae6deb2-d303-1910-8988-00ffce7de359 aborted.
2011/04/01 21:40:22.328	  2:55.940	                  ekiga	SIP	Start SUBSCRIBE
 eventPackage=dialog;sla;ma
          aor=sip:500@ekiga.net
       remote=
        local=
      contact=
       authID=
        realm=
       expire=300
      restore=30
     minRetry=default
     maxRetry=default
2011/04/01 21:40:22.328	  2:55.941	              Pool:4060	SIP	Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bK3ae6deb2-d303-1910-8988-00ffce7de359
2011/04/01 21:40:22.328	  2:55.941	              Pool:4060	SIP	SUBSCRIBE transaction id=z9hG4bK6d0b4ab3-d303-1910-898a-00ffce7de359 aborted.
2011/04/01 21:40:22.328	  2:55.941	              Pool:4060	SIP	Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bK6d0b4ab3-d303-1910-898a-00ffce7de359
2011/04/01 21:40:22.328	  2:55.941	              Pool:4060	OpalUDP	Setting interface to 192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
2011/04/01 21:40:22.328	  2:55.941	              Pool:4060	SIP	Not retrying SUBSCRIBE due to error response 489 Bad Event
2011/04/01 21:40:22.328	  2:55.941	              Pool:4060	SIP	Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:500@ekiga.net, id=864da9b2-d303-1910-8985-00ffce7de359@LCS-214-230
2011/04/01 21:40:22.328	  2:55.941	              Pool:4060	SIP	Handled PDU "1 SUBSCRIBE <489>"
2011/04/01 21:40:22.328	  2:55.942	                  ekiga	SIP	Constructed handler for sip:500@ekiga.net
2011/04/01 21:40:22.328	  2:55.942	                  ekiga	SIP	Executing state change to Subscribing for SUBSCRIBE handler, target=sip:500@ekiga.net, id=ec977fb3-d303-1910-898c-00ffce7de359@LCS-214-230
2011/04/01 21:40:22.328	  2:55.942	                  ekiga	SIP	Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:500@ekiga.net, id=ec977fb3-d303-1910-898c-00ffce7de359@LCS-214-230
2011/04/01 21:40:22.328	  2:55.942	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:40:22.328	  2:55.953	        PThreadObj:2292	SIP	No SRV record found.
2011/04/01 21:40:22.328	  2:55.953	        PThreadObj:2292	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:40:22.328	  2:55.954	        PThreadObj:2292	SIP	Sending PDU (549 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.56.1:5060,if=192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport
SUBSCRIBE sip:500@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.56.1:5060;branch=z9hG4bK6d0b4ab3-d303-1910-898b-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: <sip:500@ekiga.net>;tag=3ae6deb2-d303-1910-8987-00ffce7de359

Call-ID: 864da9b2-d303-1910-8986-00ffce7de359@LCS-214-230

To: <sip:500@ekiga.net>

Contact: sip:500@192.168.56.1

Accept: application/watcherinfo+xml

Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING

Expires: 300

Event: presence.winfo

Content-Length: 0

Max-Forwards: 70




2011/04/01 21:40:22.328	  2:55.955	        PThreadObj:2292	OpalUDP	Setting interface to 192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport
2011/04/01 21:40:22.328	  2:55.955	        PThreadObj:2292	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:40:22.328	  2:55.955	              Pool:6072	SIP	SUBSCRIBE transaction id=z9hG4bK3ae6deb2-d303-1910-8989-00ffce7de359 aborted.
2011/04/01 21:40:22.328	  2:55.955	              Pool:6072	SIP	Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bK3ae6deb2-d303-1910-8989-00ffce7de359
2011/04/01 21:40:22.328	  2:55.955	              Pool:6072	SIP	SUBSCRIBE transaction id=z9hG4bK6d0b4ab3-d303-1910-898b-00ffce7de359 aborted.
2011/04/01 21:40:22.328	  2:55.955	              Pool:6072	SIP	Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bK6d0b4ab3-d303-1910-898b-00ffce7de359
2011/04/01 21:40:22.328	  2:55.955	              Pool:6072	OpalUDP	Setting interface to 192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
2011/04/01 21:40:22.343	  2:55.955	              Pool:6072	SIP	Not retrying SUBSCRIBE due to error response 489 Bad Event
2011/04/01 21:40:22.343	  2:55.955	              Pool:6072	SIP	Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:500@ekiga.net;OPAL-local-id=sip%3A500%40ekiga.net, id=864da9b2-d303-1910-8986-00ffce7de359@LCS-214-230
2011/04/01 21:40:22.343	  2:55.955	              Pool:6072	SIP	Handled PDU "1 SUBSCRIBE <489>"
2011/04/01 21:40:22.343	  2:55.956	      Opal Garbage:5348	SIP	Transaction id=z9hG4bK3ae6deb2-d303-1910-8988-00ffce7de359 destroyed.
2011/04/01 21:40:22.343	  2:55.956	      Opal Garbage:5348	SIP	Transaction id=z9hG4bK3ae6deb2-d303-1910-8989-00ffce7de359 destroyed.
2011/04/01 21:40:22.343	  2:55.956	      Opal Garbage:5348	SIP	Deleting SIPSubscribeHandler sip:500@ekiga.net
2011/04/01 21:40:22.343	  2:55.956	      Opal Garbage:5348	Opal	Transport clean up on termination
2011/04/01 21:40:22.343	  2:55.956	      Opal Garbage:5348	Opal	Transport Close
2011/04/01 21:40:22.343	  2:55.956	      Opal Garbage:5348	Opal	Transport clean up on termination
2011/04/01 21:40:22.343	  2:55.956	      Opal Garbage:5348	Opal	Transport Close
2011/04/01 21:40:22.343	  2:55.956	      Opal Garbage:5348	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:40:22.343	  2:55.957	      Opal Garbage:5348	SIP	Deleted handler.
2011/04/01 21:40:22.343	  2:55.957	      Opal Garbage:5348	SIP	Deleting SIPSubscribeHandler sip:500@ekiga.net;OPAL-local-id=sip%3A500%40ekiga.net
2011/04/01 21:40:22.343	  2:55.957	      Opal Garbage:5348	Opal	Transport clean up on termination
2011/04/01 21:40:22.343	  2:55.957	      Opal Garbage:5348	Opal	Transport Close
2011/04/01 21:40:22.343	  2:55.957	      Opal Garbage:5348	Opal	Transport clean up on termination
2011/04/01 21:40:22.343	  2:55.957	      Opal Garbage:5348	Opal	Transport Close
2011/04/01 21:40:22.343	  2:55.957	      Opal Garbage:5348	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:40:22.343	  2:55.958	      Opal Garbage:5348	SIP	Deleted handler.
2011/04/01 21:40:23.343	  2:56.958	      Opal Garbage:5348	SIP	Transaction id=z9hG4bK6d0b4ab3-d303-1910-898a-00ffce7de359 destroyed.
2011/04/01 21:40:23.343	  2:56.958	      Opal Garbage:5348	SIP	Transaction id=z9hG4bK6d0b4ab3-d303-1910-898b-00ffce7de359 destroyed.
2011/04/01 21:40:57.406	  3:31.029	                  ekiga	SIP	No SRV record found.
2011/04/01 21:40:57.406	  3:31.029	                  ekiga	OpalUDP	Binding to interface: 0.0.0.0:5060
2011/04/01 21:40:57.406	  3:31.029	                  ekiga	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2011/04/01 21:40:57.406	  3:31.031	                  ekiga	OpalUDP	Started connect to 86.64.162.35:5060
2011/04/01 21:40:57.406	  3:31.031	                  ekiga	OpalUDP	Writing to interface 0 - "192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport"
2011/04/01 21:40:57.421	  3:31.033	                  ekiga	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.19.22:5060,udp$192.168.10.105:5060,udp$192.168.56.1:5060
2011/04/01 21:40:57.421	  3:31.037	                  ekiga	SIP	Transaction created.
2011/04/01 21:40:57.421	  3:31.047	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:41:32.515	  4:06.132	                  ekiga	SIP	No SRV record found.
2011/04/01 21:41:32.515	  4:06.133	                  ekiga	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:41:32.515	  4:06.133	                  ekiga	SIP	Sending PDU (566 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.19.22:5060,if=192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport
SUBSCRIBE sip:500@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.19.22:5060;branch=z9hG4bK6b24b5b3-d303-1910-898d-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: "kamath" <sip:kamath@192.168.19.22>;tag=6b24b5b3-d303-1910-898c-00ffce7de359

Call-ID: ec977fb3-d303-1910-898c-00ffce7de359@LCS-214-230

To: <sip:500@ekiga.net>

Contact: sip:500@192.168.19.22

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




2011/04/01 21:41:32.515	  4:06.134	                  ekiga	OpalUDP	Setting interface to 192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport
2011/04/01 21:41:32.515	  4:06.135	                  ekiga	SIP	Transaction timers set: retry=0.499, completion=5.999
2011/04/01 21:41:32.515	  4:06.135	                  ekiga	OpalUDP	Writing to interface 1 - "192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport"
2011/04/01 21:41:32.515	  4:06.137	                  ekiga	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.19.22:5060,udp$192.168.10.105:5060,udp$192.168.56.1:5060
2011/04/01 21:41:32.515	  4:06.141	                  ekiga	SIP	Transaction created.
2011/04/01 21:41:32.531	  4:06.152	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:42:07.625	  4:41.236	                  ekiga	SIP	No SRV record found.
2011/04/01 21:42:07.625	  4:41.236	                  ekiga	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:42:07.625	  4:41.236	                  ekiga	SIP	Sending PDU (569 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.10.105:5060,if=192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
SUBSCRIBE sip:500@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.10.105:5060;branch=z9hG4bK05b7eab3-d303-1910-898d-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: "kamath" <sip:kamath@192.168.10.105>;tag=6b24b5b3-d303-1910-898c-00ffce7de359

Call-ID: ec977fb3-d303-1910-898c-00ffce7de359@LCS-214-230

To: <sip:500@ekiga.net>

Contact: sip:500@192.168.10.105

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




2011/04/01 21:42:07.625	  4:41.238	                  ekiga	OpalUDP	Setting interface to 192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
2011/04/01 21:42:07.625	  4:41.238	                  ekiga	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:42:07.625	  4:41.238	                  ekiga	OpalUDP	Writing to interface 2 - "192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport"
2011/04/01 21:42:07.625	  4:41.240	                  ekiga	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.19.22:5060,udp$192.168.10.105:5060,udp$192.168.56.1:5060
2011/04/01 21:42:07.625	  4:41.244	                  ekiga	SIP	Transaction created.
2011/04/01 21:42:07.640	  4:41.257	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:42:07.718	  4:41.340	     Opal Listener:3864	OpalUDP	Binding to interface: 192.168.10.105:5060
2011/04/01 21:42:07.718	  4:41.340	     Opal Listener:3864	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:42:07.718	  4:41.341	     Opal Listener:3864	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.10.105:5060,if=192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
SIP/2.0 489 Event Not Supported
CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.10.105:5060;branch=z9hG4bK05b7eab3-d303-1910-898d-00ffce7de359;rport=5060;received=74.71.59.242

Server: Kamailio (1.5.3-notls (i386/linux))

From: "kamath" <sip:kamath@192.168.10.105>;tag=6b24b5b3-d303-1910-898c-00ffce7de359

Call-ID: ec977fb3-d303-1910-898c-00ffce7de359@LCS-214-230

To: <sip:500@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.5abe

Content-Length: 0




2011/04/01 21:42:07.718	  4:41.342	     Opal Listener:3864	SIP	Queueing PDU "1 SUBSCRIBE <489>", transaction=z9hG4bK05b7eab3-d303-1910-898d-00ffce7de359, token=ec977fb3-d303-1910-898c-00ffce7de359@LCS-214-230
2011/04/01 21:42:07.718	  4:41.342	     Opal Listener:3864	Opal	Transport clean up on termination
2011/04/01 21:42:07.718	  4:41.342	     Opal Listener:3864	Opal	Transport Close
2011/04/01 21:42:07.718	  4:41.343	              Pool:4060	SIP	Handling PDU "1 SUBSCRIBE <489>" for transaction=z9hG4bK05b7eab3-d303-1910-898d-00ffce7de359
2011/04/01 21:42:07.718	  4:41.343	              Pool:4060	SIP	SUBSCRIBE transaction id=z9hG4bK05b7eab3-d303-1910-898d-00ffce7de359 completed.
2011/04/01 21:42:07.718	  4:41.343	     Opal Listener:3864	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:42:42.750	  5:16.358	                  ekiga	SIP	No SRV record found.
2011/04/01 21:42:42.750	  5:16.359	                  ekiga	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:42:42.750	  5:16.359	                  ekiga	SIP	Sending PDU (563 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.56.1:5060,if=192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport
SUBSCRIBE sip:500@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.56.1:5060;branch=z9hG4bK9e4920b4-d303-1910-898d-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: "kamath" <sip:kamath@192.168.56.1>;tag=6b24b5b3-d303-1910-898c-00ffce7de359

Call-ID: ec977fb3-d303-1910-898c-00ffce7de359@LCS-214-230

To: <sip:500@ekiga.net>

Contact: sip:500@192.168.56.1

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




2011/04/01 21:42:42.750	  5:16.360	                  ekiga	OpalUDP	Setting interface to 192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport
2011/04/01 21:42:42.750	  5:16.360	                  ekiga	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:42:42.750	  5:16.360	              Pool:4060	SIP	SUBSCRIBE transaction id=z9hG4bK6b24b5b3-d303-1910-898d-00ffce7de359 aborted.
2011/04/01 21:42:42.750	  5:16.361	              Pool:4060	SIP	Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bK6b24b5b3-d303-1910-898d-00ffce7de359
2011/04/01 21:42:42.750	  5:16.361	              Pool:4060	SIP	SUBSCRIBE transaction id=z9hG4bK9e4920b4-d303-1910-898d-00ffce7de359 aborted.
2011/04/01 21:42:42.750	  5:16.361	              Pool:4060	SIP	Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bK9e4920b4-d303-1910-898d-00ffce7de359
2011/04/01 21:42:42.750	  5:16.361	              Pool:4060	OpalUDP	Setting interface to 192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
2011/04/01 21:42:42.750	  5:16.361	                  ekiga	DNS	SRV Lookup ekiga.net service _pres._sip
2011/04/01 21:42:42.750	  5:16.361	              Pool:4060	SIP	Not retrying SUBSCRIBE due to error response 489 Bad Event
2011/04/01 21:42:42.750	  5:16.361	              Pool:4060	SIP	Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:500@ekiga.net, id=ec977fb3-d303-1910-898c-00ffce7de359@LCS-214-230
2011/04/01 21:42:42.750	  5:16.361	              Pool:4060	SIP	Handled PDU "1 SUBSCRIBE <489>"
2011/04/01 21:42:42.750	  5:16.361	 PTLib Housekeeper:1620	SIP	Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bKd47814b3-d303-1910-8989-00ffce7de359
2011/04/01 21:42:42.750	  5:16.361	 PTLib Housekeeper:1620	SIP	Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bKd47814b3-d303-1910-898a-00ffce7de359
2011/04/01 21:42:42.750	  5:16.361	      Opal Garbage:5348	SIP	Transaction id=z9hG4bK6b24b5b3-d303-1910-898d-00ffce7de359 destroyed.
2011/04/01 21:42:42.750	  5:16.361	      Opal Garbage:5348	SIP	Transaction id=z9hG4bKd47814b3-d303-1910-8989-00ffce7de359 destroyed.
2011/04/01 21:42:42.750	  5:16.361	      Opal Garbage:5348	SIP	Transaction id=z9hG4bKd47814b3-d303-1910-898a-00ffce7de359 destroyed.
2011/04/01 21:42:42.750	  5:16.361	      Opal Garbage:5348	SIP	Deleting SIPSubscribeHandler sip:500@ekiga.net
2011/04/01 21:42:42.750	  5:16.361	      Opal Garbage:5348	Opal	Transport clean up on termination
2011/04/01 21:42:42.750	  5:16.361	      Opal Garbage:5348	Opal	Transport Close
2011/04/01 21:42:42.750	  5:16.361	      Opal Garbage:5348	Opal	Transport clean up on termination
2011/04/01 21:42:42.750	  5:16.361	      Opal Garbage:5348	Opal	Transport Close
2011/04/01 21:42:42.750	  5:16.361	      Opal Garbage:5348	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:42:42.750	  5:16.363	      Opal Garbage:5348	SIP	Deleted handler.
2011/04/01 21:42:43.750	  5:17.361	 PTLib Housekeeper:1620	SIP	Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bK05b7eab3-d303-1910-898d-00ffce7de359
2011/04/01 21:42:43.750	  5:17.362	      Opal Garbage:5348	SIP	Transaction id=z9hG4bK9e4920b4-d303-1910-898d-00ffce7de359 destroyed.
2011/04/01 21:42:43.750	  5:17.362	      Opal Garbage:5348	SIP	Transaction id=z9hG4bK05b7eab3-d303-1910-898d-00ffce7de359 destroyed.
2011/04/01 21:43:18.046	  5:51.669	                  ekiga	SIP	Start SUBSCRIBE
 eventPackage=presence
          aor=sip:501@ekiga.net
       remote=
        local=
      contact=
       authID=
        realm=
       expire=300
      restore=30
     minRetry=default
     maxRetry=default
2011/04/01 21:43:18.046	  5:51.669	        PThreadObj:4848	SIPPres	'sip:501@ekiga.net' sending subscribe for own presence.watcherinfo
2011/04/01 21:43:18.046	  5:51.669	        PThreadObj:4848	SIP	Start SUBSCRIBE
 eventPackage=presence.winfo
          aor=sip:501@ekiga.net
       remote=86.64.162.35:5060;transport=tcp
        local=sip:501@ekiga.net
      contact=
       authID=sip:501@ekiga.net
        realm=
       expire=300
      restore=30
     minRetry=default
     maxRetry=default
2011/04/01 21:43:18.046	  5:51.670	                  ekiga	SIP	Constructed handler for sip:501@ekiga.net
2011/04/01 21:43:18.062	  5:51.670	        PThreadObj:4848	SIP	Constructed handler for sip:501@ekiga.net;OPAL-local-id=sip%3A501%40ekiga.net
2011/04/01 21:43:18.062	  5:51.670	                  ekiga	SIP	Executing state change to Subscribing for SUBSCRIBE handler, target=sip:501@ekiga.net, id=2abe8bb4-d303-1910-898e-00ffce7de359@LCS-214-230
2011/04/01 21:43:18.062	  5:51.670	                  ekiga	SIP	Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:501@ekiga.net, id=2abe8bb4-d303-1910-898e-00ffce7de359@LCS-214-230
2011/04/01 21:43:18.062	  5:51.670	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:43:18.062	  5:51.671	        PThreadObj:4848	SIP	Executing state change to Subscribing for SUBSCRIBE handler, target=sip:501@ekiga.net;OPAL-local-id=sip%3A501%40ekiga.net, id=2abe8bb4-d303-1910-898f-00ffce7de359@LCS-214-230
2011/04/01 21:43:18.062	  5:51.671	        PThreadObj:4848	SIP	Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:501@ekiga.net;OPAL-local-id=sip%3A501%40ekiga.net, id=2abe8bb4-d303-1910-898f-00ffce7de359@LCS-214-230
2011/04/01 21:43:18.062	  5:51.671	        PThreadObj:4848	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:43:53.140	  6:26.756	                  ekiga	SIP	No SRV record found.
2011/04/01 21:43:53.140	  6:26.756	                  ekiga	OpalUDP	Binding to interface: 0.0.0.0:5060
2011/04/01 21:43:53.140	  6:26.757	                  ekiga	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2011/04/01 21:43:53.140	  6:26.758	                  ekiga	OpalUDP	Started connect to 86.64.162.35:5060
2011/04/01 21:43:53.140	  6:26.758	                  ekiga	OpalUDP	Writing to interface 0 - "192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport"
2011/04/01 21:43:53.140	  6:26.761	                  ekiga	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.19.22:5060,udp$192.168.10.105:5060,udp$192.168.56.1:5060
2011/04/01 21:43:53.156	  6:26.764	                  ekiga	SIP	Transaction created.
2011/04/01 21:43:53.156	  6:26.764	        PThreadObj:4848	SIP	No SRV record found.
2011/04/01 21:43:53.156	  6:26.764	        PThreadObj:4848	OpalUDP	Binding to interface: 0.0.0.0:5060
2011/04/01 21:43:53.156	  6:26.764	        PThreadObj:4848	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2011/04/01 21:43:53.156	  6:26.766	        PThreadObj:4848	OpalUDP	Started connect to 86.64.162.35:5060
2011/04/01 21:43:53.156	  6:26.766	        PThreadObj:4848	OpalUDP	Writing to interface 0 - "192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport"
2011/04/01 21:43:53.156	  6:26.766	        PThreadObj:4848	SIP	Transaction created.
2011/04/01 21:43:53.156	  6:26.771	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:43:53.156	  6:26.774	        PThreadObj:4848	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:44:28.250	  7:01.862	                  ekiga	SIP	No SRV record found.
2011/04/01 21:44:28.250	  7:01.862	                  ekiga	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:44:28.250	  7:01.862	                  ekiga	SIP	Sending PDU (554 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.19.22:5060,if=192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport
SUBSCRIBE sip:501@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.19.22:5060;branch=z9hG4bKa94ac1b4-d303-1910-8991-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: "kamath" <sip:kamath@192.168.19.22>;tag=a94ac1b4-d303-1910-898f-00ffce7de359

Call-ID: 2abe8bb4-d303-1910-898e-00ffce7de359@LCS-214-230

To: <sip:501@ekiga.net>

Contact: sip:501@192.168.19.22

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




2011/04/01 21:44:28.250	  7:01.864	                  ekiga	OpalUDP	Setting interface to 192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport
2011/04/01 21:44:28.250	  7:01.864	                  ekiga	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:44:28.250	  7:01.864	                  ekiga	OpalUDP	Writing to interface 1 - "192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport"
2011/04/01 21:44:28.250	  7:01.866	                  ekiga	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.19.22:5060,udp$192.168.10.105:5060,udp$192.168.56.1:5060
2011/04/01 21:44:28.250	  7:01.869	                  ekiga	SIP	Transaction created.
2011/04/01 21:44:28.265	  7:01.875	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:44:28.265	  7:01.883	        PThreadObj:4848	SIP	No SRV record found.
2011/04/01 21:44:28.265	  7:01.883	        PThreadObj:4848	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:44:28.265	  7:01.884	        PThreadObj:4848	SIP	Sending PDU (551 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.19.22:5060,if=192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport
SUBSCRIBE sip:501@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.19.22:5060;branch=z9hG4bKa94ac1b4-d303-1910-8992-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: <sip:501@ekiga.net>;tag=a94ac1b4-d303-1910-8990-00ffce7de359

Call-ID: 2abe8bb4-d303-1910-898f-00ffce7de359@LCS-214-230

To: <sip:501@ekiga.net>

Contact: sip:501@192.168.19.22

Accept: application/watcherinfo+xml

Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING

Expires: 300

Event: presence.winfo

Content-Length: 0

Max-Forwards: 70




2011/04/01 21:44:28.265	  7:01.885	        PThreadObj:4848	OpalUDP	Setting interface to 192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport
2011/04/01 21:44:28.265	  7:01.885	        PThreadObj:4848	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:44:28.265	  7:01.885	        PThreadObj:4848	OpalUDP	Writing to interface 1 - "192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport"
2011/04/01 21:44:28.265	  7:01.885	        PThreadObj:4848	SIP	Transaction created.
2011/04/01 21:44:28.281	  7:01.891	        PThreadObj:4848	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:45:03.359	  7:36.967	                  ekiga	SIP	No SRV record found.
2011/04/01 21:45:03.359	  7:36.967	                  ekiga	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:45:03.359	  7:36.967	                  ekiga	SIP	Sending PDU (557 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.10.105:5060,if=192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
SUBSCRIBE sip:501@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.10.105:5060;branch=z9hG4bK42ddf6b4-d303-1910-8992-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: "kamath" <sip:kamath@192.168.10.105>;tag=a94ac1b4-d303-1910-898f-00ffce7de359

Call-ID: 2abe8bb4-d303-1910-898e-00ffce7de359@LCS-214-230

To: <sip:501@ekiga.net>

Contact: sip:501@192.168.10.105

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




2011/04/01 21:45:03.359	  7:36.969	                  ekiga	OpalUDP	Setting interface to 192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
2011/04/01 21:45:03.359	  7:36.969	                  ekiga	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:45:03.359	  7:36.969	                  ekiga	OpalUDP	Writing to interface 2 - "192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport"
2011/04/01 21:45:03.359	  7:36.971	                  ekiga	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.19.22:5060,udp$192.168.10.105:5060,udp$192.168.56.1:5060
2011/04/01 21:45:03.359	  7:36.974	                  ekiga	SIP	Transaction created.
2011/04/01 21:45:03.375	  7:36.980	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:45:03.406	  7:37.023	        PThreadObj:4848	SIP	No SRV record found.
2011/04/01 21:45:03.406	  7:37.023	        PThreadObj:4848	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:45:03.406	  7:37.024	        PThreadObj:4848	SIP	Sending PDU (553 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.10.105:5060,if=192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
SUBSCRIBE sip:501@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.10.105:5060;branch=z9hG4bK5de3f6b4-d303-1910-8992-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: <sip:501@ekiga.net>;tag=a94ac1b4-d303-1910-8990-00ffce7de359

Call-ID: 2abe8bb4-d303-1910-898f-00ffce7de359@LCS-214-230

To: <sip:501@ekiga.net>

Contact: sip:501@192.168.10.105

Accept: application/watcherinfo+xml

Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING

Expires: 300

Event: presence.winfo

Content-Length: 0

Max-Forwards: 70




2011/04/01 21:45:03.406	  7:37.025	        PThreadObj:4848	OpalUDP	Setting interface to 192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
2011/04/01 21:45:03.406	  7:37.025	        PThreadObj:4848	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:45:03.406	  7:37.025	        PThreadObj:4848	OpalUDP	Writing to interface 2 - "192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport"
2011/04/01 21:45:03.406	  7:37.025	        PThreadObj:4848	SIP	Transaction created.
2011/04/01 21:45:03.421	  7:37.031	        PThreadObj:4848	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:45:03.468	  7:37.076	     Opal Listener:3864	OpalUDP	Binding to interface: 192.168.10.105:5060
2011/04/01 21:45:03.468	  7:37.076	     Opal Listener:3864	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:45:03.468	  7:37.077	     Opal Listener:3864	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.10.105:5060,if=192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
SIP/2.0 489 Event Not Supported
CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.10.105:5060;branch=z9hG4bK42ddf6b4-d303-1910-8992-00ffce7de359;rport=5060;received=74.71.59.242

Server: Kamailio (1.5.3-notls (i386/linux))

From: "kamath" <sip:kamath@192.168.10.105>;tag=a94ac1b4-d303-1910-898f-00ffce7de359

Call-ID: 2abe8bb4-d303-1910-898e-00ffce7de359@LCS-214-230

To: <sip:501@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.439f

Content-Length: 0




2011/04/01 21:45:03.468	  7:37.079	     Opal Listener:3864	SIP	Queueing PDU "1 SUBSCRIBE <489>", transaction=z9hG4bK42ddf6b4-d303-1910-8992-00ffce7de359, token=2abe8bb4-d303-1910-898e-00ffce7de359@LCS-214-230
2011/04/01 21:45:03.468	  7:37.079	     Opal Listener:3864	Opal	Transport clean up on termination
2011/04/01 21:45:03.468	  7:37.079	              Pool:4060	SIP	Handling PDU "1 SUBSCRIBE <489>" for transaction=z9hG4bK42ddf6b4-d303-1910-8992-00ffce7de359
2011/04/01 21:45:03.468	  7:37.079	     Opal Listener:3864	Opal	Transport Close
2011/04/01 21:45:03.468	  7:37.079	              Pool:4060	SIP	SUBSCRIBE transaction id=z9hG4bK42ddf6b4-d303-1910-8992-00ffce7de359 completed.
2011/04/01 21:45:03.468	  7:37.079	     Opal Listener:3864	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:45:03.515	  7:37.133	     Opal Listener:3864	OpalUDP	Binding to interface: 192.168.10.105:5060
2011/04/01 21:45:03.515	  7:37.133	     Opal Listener:3864	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:45:03.515	  7:37.134	     Opal Listener:3864	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.10.105:5060,if=192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
SIP/2.0 489 Event Not Supported
CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.10.105:5060;branch=z9hG4bK5de3f6b4-d303-1910-8992-00ffce7de359;rport=5060;received=74.71.59.242

Server: Kamailio (1.5.3-notls (i386/linux))

From: <sip:501@ekiga.net>;tag=a94ac1b4-d303-1910-8990-00ffce7de359

Call-ID: 2abe8bb4-d303-1910-898f-00ffce7de359@LCS-214-230

To: <sip:501@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.f49d

Content-Length: 0




2011/04/01 21:45:03.515	  7:37.135	     Opal Listener:3864	SIP	Queueing PDU "1 SUBSCRIBE <489>", transaction=z9hG4bK5de3f6b4-d303-1910-8992-00ffce7de359, token=2abe8bb4-d303-1910-898f-00ffce7de359@LCS-214-230
2011/04/01 21:45:03.515	  7:37.135	     Opal Listener:3864	Opal	Transport clean up on termination
2011/04/01 21:45:03.515	  7:37.135	              Pool:6072	SIP	Handling PDU "1 SUBSCRIBE <489>" for transaction=z9hG4bK5de3f6b4-d303-1910-8992-00ffce7de359
2011/04/01 21:45:03.515	  7:37.135	     Opal Listener:3864	Opal	Transport Close
2011/04/01 21:45:03.515	  7:37.135	              Pool:6072	SIP	SUBSCRIBE transaction id=z9hG4bK5de3f6b4-d303-1910-8992-00ffce7de359 completed.
2011/04/01 21:45:03.515	  7:37.135	     Opal Listener:3864	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:45:38.453	  8:12.068	                  ekiga	SIP	No SRV record found.
2011/04/01 21:45:38.453	  8:12.069	                  ekiga	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:45:38.453	  8:12.069	                  ekiga	SIP	Sending PDU (551 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.56.1:5060,if=192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport
SUBSCRIBE sip:501@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.56.1:5060;branch=z9hG4bKdc6f2cb5-d303-1910-8992-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: "kamath" <sip:kamath@192.168.56.1>;tag=a94ac1b4-d303-1910-898f-00ffce7de359

Call-ID: 2abe8bb4-d303-1910-898e-00ffce7de359@LCS-214-230

To: <sip:501@ekiga.net>

Contact: sip:501@192.168.56.1

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




2011/04/01 21:45:38.453	  8:12.070	                  ekiga	OpalUDP	Setting interface to 192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport
2011/04/01 21:45:38.453	  8:12.070	                  ekiga	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:45:38.453	  8:12.070	              Pool:4060	SIP	SUBSCRIBE transaction id=z9hG4bKa94ac1b4-d303-1910-8991-00ffce7de359 aborted.
2011/04/01 21:45:38.453	  8:12.070	                  ekiga	SIP	Start SUBSCRIBE
 eventPackage=dialog;sla;ma
          aor=sip:501@ekiga.net
       remote=
        local=
      contact=
       authID=
        realm=
       expire=300
      restore=30
     minRetry=default
     maxRetry=default
2011/04/01 21:45:38.453	  8:12.070	              Pool:4060	SIP	Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bKa94ac1b4-d303-1910-8991-00ffce7de359
2011/04/01 21:45:38.453	  8:12.070	              Pool:4060	SIP	SUBSCRIBE transaction id=z9hG4bKdc6f2cb5-d303-1910-8992-00ffce7de359 aborted.
2011/04/01 21:45:38.453	  8:12.070	              Pool:4060	SIP	Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bKdc6f2cb5-d303-1910-8992-00ffce7de359
2011/04/01 21:45:38.453	  8:12.070	      Opal Garbage:5348	SIP	Transaction id=z9hG4bKa94ac1b4-d303-1910-8991-00ffce7de359 destroyed.
2011/04/01 21:45:38.453	  8:12.070	              Pool:4060	OpalUDP	Setting interface to 192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
2011/04/01 21:45:38.453	  8:12.071	              Pool:4060	SIP	Not retrying SUBSCRIBE due to error response 489 Bad Event
2011/04/01 21:45:38.453	  8:12.071	              Pool:4060	SIP	Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:501@ekiga.net, id=2abe8bb4-d303-1910-898e-00ffce7de359@LCS-214-230
2011/04/01 21:45:38.453	  8:12.071	              Pool:4060	SIP	Handled PDU "1 SUBSCRIBE <489>"
2011/04/01 21:45:38.453	  8:12.071	                  ekiga	SIP	Constructed handler for sip:501@ekiga.net
2011/04/01 21:45:38.453	  8:12.072	                  ekiga	SIP	Executing state change to Subscribing for SUBSCRIBE handler, target=sip:501@ekiga.net, id=40f661b5-d303-1910-8993-00ffce7de359@LCS-214-230
2011/04/01 21:45:38.453	  8:12.072	                  ekiga	SIP	Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:501@ekiga.net, id=40f661b5-d303-1910-8993-00ffce7de359@LCS-214-230
2011/04/01 21:45:38.453	  8:12.072	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:45:38.515	  8:12.124	        PThreadObj:4848	SIP	No SRV record found.
2011/04/01 21:45:38.515	  8:12.124	        PThreadObj:4848	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:45:38.515	  8:12.124	        PThreadObj:4848	SIP	Sending PDU (549 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.56.1:5060,if=192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport
SUBSCRIBE sip:501@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.56.1:5060;branch=z9hG4bK2b822cb5-d303-1910-8992-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: <sip:501@ekiga.net>;tag=a94ac1b4-d303-1910-8990-00ffce7de359

Call-ID: 2abe8bb4-d303-1910-898f-00ffce7de359@LCS-214-230

To: <sip:501@ekiga.net>

Contact: sip:501@192.168.56.1

Accept: application/watcherinfo+xml

Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING

Expires: 300

Event: presence.winfo

Content-Length: 0

Max-Forwards: 70




2011/04/01 21:45:38.515	  8:12.126	        PThreadObj:4848	OpalUDP	Setting interface to 192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport
2011/04/01 21:45:38.515	  8:12.126	        PThreadObj:4848	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:45:38.515	  8:12.126	              Pool:6072	SIP	SUBSCRIBE transaction id=z9hG4bKa94ac1b4-d303-1910-8992-00ffce7de359 aborted.
2011/04/01 21:45:38.515	  8:12.126	              Pool:6072	SIP	Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bKa94ac1b4-d303-1910-8992-00ffce7de359
2011/04/01 21:45:38.515	  8:12.126	              Pool:6072	SIP	SUBSCRIBE transaction id=z9hG4bK2b822cb5-d303-1910-8992-00ffce7de359 aborted.
2011/04/01 21:45:38.515	  8:12.126	              Pool:6072	SIP	Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bK2b822cb5-d303-1910-8992-00ffce7de359
2011/04/01 21:45:38.515	  8:12.126	              Pool:6072	OpalUDP	Setting interface to 192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
2011/04/01 21:45:38.515	  8:12.126	              Pool:6072	SIP	Not retrying SUBSCRIBE due to error response 489 Bad Event
2011/04/01 21:45:38.515	  8:12.126	              Pool:6072	SIP	Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:501@ekiga.net;OPAL-local-id=sip%3A501%40ekiga.net, id=2abe8bb4-d303-1910-898f-00ffce7de359@LCS-214-230
2011/04/01 21:45:38.515	  8:12.126	              Pool:6072	SIP	Handled PDU "1 SUBSCRIBE <489>"
2011/04/01 21:45:39.453	  8:13.070	      Opal Garbage:5348	SIP	Transaction id=z9hG4bK2b822cb5-d303-1910-8992-00ffce7de359 destroyed.
2011/04/01 21:45:39.453	  8:13.070	      Opal Garbage:5348	SIP	Transaction id=z9hG4bKdc6f2cb5-d303-1910-8992-00ffce7de359 destroyed.
2011/04/01 21:45:39.453	  8:13.070	      Opal Garbage:5348	SIP	Transaction id=z9hG4bKa94ac1b4-d303-1910-8992-00ffce7de359 destroyed.
2011/04/01 21:45:39.453	  8:13.071	      Opal Garbage:5348	SIP	Deleting SIPSubscribeHandler sip:501@ekiga.net
2011/04/01 21:45:39.453	  8:13.071	      Opal Garbage:5348	Opal	Transport clean up on termination
2011/04/01 21:45:39.453	  8:13.071	      Opal Garbage:5348	Opal	Transport Close
2011/04/01 21:45:39.453	  8:13.071	      Opal Garbage:5348	Opal	Transport clean up on termination
2011/04/01 21:45:39.453	  8:13.071	      Opal Garbage:5348	Opal	Transport Close
2011/04/01 21:45:39.453	  8:13.071	      Opal Garbage:5348	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:45:39.453	  8:13.072	      Opal Garbage:5348	SIP	Deleted handler.
2011/04/01 21:45:39.453	  8:13.072	      Opal Garbage:5348	SIP	Deleting SIPSubscribeHandler sip:501@ekiga.net;OPAL-local-id=sip%3A501%40ekiga.net
2011/04/01 21:45:39.453	  8:13.072	      Opal Garbage:5348	Opal	Transport clean up on termination
2011/04/01 21:45:39.453	  8:13.072	      Opal Garbage:5348	Opal	Transport Close
2011/04/01 21:45:39.453	  8:13.072	      Opal Garbage:5348	Opal	Transport clean up on termination
2011/04/01 21:45:39.453	  8:13.072	      Opal Garbage:5348	Opal	Transport Close
2011/04/01 21:45:39.453	  8:13.072	      Opal Garbage:5348	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:45:39.468	  8:13.073	      Opal Garbage:5348	SIP	Deleted handler.
2011/04/01 21:46:13.578	  8:47.187	                  ekiga	SIP	No SRV record found.
2011/04/01 21:46:13.578	  8:47.187	                  ekiga	OpalUDP	Binding to interface: 0.0.0.0:5060
2011/04/01 21:46:13.578	  8:47.187	                  ekiga	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2011/04/01 21:46:13.578	  8:47.188	                  ekiga	OpalUDP	Started connect to 86.64.162.35:5060
2011/04/01 21:46:13.578	  8:47.188	                  ekiga	OpalUDP	Writing to interface 0 - "192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport"
2011/04/01 21:46:13.578	  8:47.191	                  ekiga	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.19.22:5060,udp$192.168.10.105:5060,udp$192.168.56.1:5060
2011/04/01 21:46:13.578	  8:47.195	                  ekiga	SIP	Transaction created.
2011/04/01 21:46:13.593	  8:47.205	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:46:48.671	  9:22.289	                  ekiga	SIP	No SRV record found.
2011/04/01 21:46:48.671	  9:22.289	                  ekiga	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:46:48.671	  9:22.289	                  ekiga	SIP	Sending PDU (566 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.19.22:5060,if=192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport
SUBSCRIBE sip:501@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.19.22:5060;branch=z9hG4bK0f9597b5-d303-1910-8993-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: "kamath" <sip:kamath@192.168.19.22>;tag=f48e97b5-d303-1910-8993-00ffce7de359

Call-ID: 40f661b5-d303-1910-8993-00ffce7de359@LCS-214-230

To: <sip:501@ekiga.net>

Contact: sip:501@192.168.19.22

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




2011/04/01 21:46:48.671	  9:22.290	                  ekiga	OpalUDP	Setting interface to 192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport
2011/04/01 21:46:48.671	  9:22.290	                  ekiga	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:46:48.671	  9:22.290	                  ekiga	OpalUDP	Writing to interface 1 - "192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport"
2011/04/01 21:46:48.687	  9:22.293	                  ekiga	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.19.22:5060,udp$192.168.10.105:5060,udp$192.168.56.1:5060
2011/04/01 21:46:48.687	  9:22.296	                  ekiga	SIP	Transaction created.
2011/04/01 21:46:48.703	  9:22.306	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:47:23.781	  9:57.391	                  ekiga	SIP	No SRV record found.
2011/04/01 21:47:23.781	  9:57.391	                  ekiga	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:47:23.781	  9:57.392	                  ekiga	SIP	Sending PDU (569 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.10.105:5060,if=192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
SUBSCRIBE sip:501@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.10.105:5060;branch=z9hG4bK8e21cdb5-d303-1910-8993-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: "kamath" <sip:kamath@192.168.10.105>;tag=f48e97b5-d303-1910-8993-00ffce7de359

Call-ID: 40f661b5-d303-1910-8993-00ffce7de359@LCS-214-230

To: <sip:501@ekiga.net>

Contact: sip:501@192.168.10.105

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




2011/04/01 21:47:23.781	  9:57.393	                  ekiga	OpalUDP	Setting interface to 192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
2011/04/01 21:47:23.781	  9:57.393	                  ekiga	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:47:23.781	  9:57.393	                  ekiga	OpalUDP	Writing to interface 2 - "192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport"
2011/04/01 21:47:23.781	  9:57.395	                  ekiga	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.19.22:5060,udp$192.168.10.105:5060,udp$192.168.56.1:5060
2011/04/01 21:47:23.796	  9:57.399	                  ekiga	SIP	Transaction created.
2011/04/01 21:47:23.796	  9:57.410	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:47:23.984	  9:57.602	     Opal Listener:3864	OpalUDP	Binding to interface: 192.168.10.105:5060
2011/04/01 21:47:24.000	  9:57.602	     Opal Listener:3864	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:47:24.000	  9:57.603	     Opal Listener:3864	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.10.105:5060,if=192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
SIP/2.0 489 Event Not Supported
CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.10.105:5060;branch=z9hG4bK8e21cdb5-d303-1910-8993-00ffce7de359;rport=5060;received=74.71.59.242

Server: Kamailio (1.5.3-notls (i386/linux))

From: "kamath" <sip:kamath@192.168.10.105>;tag=f48e97b5-d303-1910-8993-00ffce7de359

Call-ID: 40f661b5-d303-1910-8993-00ffce7de359@LCS-214-230

To: <sip:501@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.ab71

Content-Length: 0




2011/04/01 21:47:24.000	  9:57.604	     Opal Listener:3864	SIP	Queueing PDU "1 SUBSCRIBE <489>", transaction=z9hG4bK8e21cdb5-d303-1910-8993-00ffce7de359, token=40f661b5-d303-1910-8993-00ffce7de359@LCS-214-230
2011/04/01 21:47:24.000	  9:57.604	     Opal Listener:3864	Opal	Transport clean up on termination
2011/04/01 21:47:24.000	  9:57.604	              Pool:4060	SIP	Handling PDU "1 SUBSCRIBE <489>" for transaction=z9hG4bK8e21cdb5-d303-1910-8993-00ffce7de359
2011/04/01 21:47:24.000	  9:57.604	     Opal Listener:3864	Opal	Transport Close
2011/04/01 21:47:24.000	  9:57.604	              Pool:4060	SIP	SUBSCRIBE transaction id=z9hG4bK8e21cdb5-d303-1910-8993-00ffce7de359 completed.
2011/04/01 21:47:24.000	  9:57.605	     Opal Listener:3864	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:47:59.031	 10:32.641	                  ekiga	SIP	No SRV record found.
2011/04/01 21:47:59.031	 10:32.642	                  ekiga	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:47:59.031	 10:32.642	                  ekiga	SIP	Sending PDU (563 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.56.1:5060,if=192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport
SUBSCRIBE sip:501@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.56.1:5060;branch=z9hG4bK27b402b6-d303-1910-8993-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: "kamath" <sip:kamath@192.168.56.1>;tag=f48e97b5-d303-1910-8993-00ffce7de359

Call-ID: 40f661b5-d303-1910-8993-00ffce7de359@LCS-214-230

To: <sip:501@ekiga.net>

Contact: sip:501@192.168.56.1

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




2011/04/01 21:47:59.031	 10:32.643	                  ekiga	OpalUDP	Setting interface to 192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport
2011/04/01 21:47:59.031	 10:32.643	                  ekiga	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:47:59.031	 10:32.644	              Pool:4060	SIP	SUBSCRIBE transaction id=z9hG4bK0f9597b5-d303-1910-8993-00ffce7de359 aborted.
2011/04/01 21:47:59.031	 10:32.644	              Pool:4060	SIP	Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bK0f9597b5-d303-1910-8993-00ffce7de359
2011/04/01 21:47:59.031	 10:32.644	              Pool:4060	SIP	SUBSCRIBE transaction id=z9hG4bK27b402b6-d303-1910-8993-00ffce7de359 aborted.
2011/04/01 21:47:59.031	 10:32.644	              Pool:4060	SIP	Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bK27b402b6-d303-1910-8993-00ffce7de359
2011/04/01 21:47:59.031	 10:32.644	              Pool:4060	OpalUDP	Setting interface to 192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
2011/04/01 21:47:59.031	 10:32.644	                  ekiga	DNS	SRV Lookup ekiga.net service _pres._sip
2011/04/01 21:47:59.031	 10:32.644	              Pool:4060	SIP	Not retrying SUBSCRIBE due to error response 489 Bad Event
2011/04/01 21:47:59.031	 10:32.644	              Pool:4060	SIP	Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:501@ekiga.net, id=40f661b5-d303-1910-8993-00ffce7de359@LCS-214-230
2011/04/01 21:47:59.031	 10:32.644	              Pool:4060	SIP	Handled PDU "1 SUBSCRIBE <489>"
2011/04/01 21:47:59.031	 10:32.644	 PTLib Housekeeper:1620	SIP	Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bK42ddf6b4-d303-1910-8992-00ffce7de359
2011/04/01 21:47:59.031	 10:32.644	      Opal Garbage:5348	SIP	Transaction id=z9hG4bK27b402b6-d303-1910-8993-00ffce7de359 destroyed.
2011/04/01 21:47:59.031	 10:32.644	 PTLib Housekeeper:1620	SIP	Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bK5de3f6b4-d303-1910-8992-00ffce7de359
2011/04/01 21:47:59.031	 10:32.644	      Opal Garbage:5348	SIP	Transaction id=z9hG4bK0f9597b5-d303-1910-8993-00ffce7de359 destroyed.
2011/04/01 21:47:59.031	 10:32.644	      Opal Garbage:5348	SIP	Deleting SIPSubscribeHandler sip:501@ekiga.net
2011/04/01 21:47:59.031	 10:32.644	      Opal Garbage:5348	Opal	Transport clean up on termination
2011/04/01 21:47:59.031	 10:32.644	      Opal Garbage:5348	Opal	Transport Close
2011/04/01 21:47:59.031	 10:32.644	      Opal Garbage:5348	Opal	Transport clean up on termination
2011/04/01 21:47:59.031	 10:32.644	      Opal Garbage:5348	Opal	Transport Close
2011/04/01 21:47:59.031	 10:32.644	      Opal Garbage:5348	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:47:59.031	 10:32.646	      Opal Garbage:5348	SIP	Deleted handler.
2011/04/01 21:48:00.031	 10:33.644	 PTLib Housekeeper:1620	SIP	Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bK8e21cdb5-d303-1910-8993-00ffce7de359
2011/04/01 21:48:00.031	 10:33.645	      Opal Garbage:5348	SIP	Transaction id=z9hG4bK8e21cdb5-d303-1910-8993-00ffce7de359 destroyed.
2011/04/01 21:48:00.031	 10:33.646	      Opal Garbage:5348	SIP	Transaction id=z9hG4bK42ddf6b4-d303-1910-8992-00ffce7de359 destroyed.
2011/04/01 21:48:00.031	 10:33.646	      Opal Garbage:5348	SIP	Transaction id=z9hG4bK5de3f6b4-d303-1910-8992-00ffce7de359 destroyed.
2011/04/01 21:48:34.203	 11:07.806	                  ekiga	SIP	Start SUBSCRIBE
 eventPackage=presence
          aor=sip:520@ekiga.net
       remote=
        local=
      contact=
       authID=
        realm=
       expire=300
      restore=30
     minRetry=default
     maxRetry=default
2011/04/01 21:48:34.203	 11:07.806	        PThreadObj:3556	SIPPres	'sip:520@ekiga.net' sending subscribe for own presence.watcherinfo
2011/04/01 21:48:34.203	 11:07.806	        PThreadObj:3556	SIP	Start SUBSCRIBE
 eventPackage=presence.winfo
          aor=sip:520@ekiga.net
       remote=86.64.162.35:5060;transport=tcp
        local=sip:520@ekiga.net
      contact=
       authID=sip:520@ekiga.net
        realm=
       expire=300
      restore=30
     minRetry=default
     maxRetry=default
2011/04/01 21:48:34.203	 11:07.808	                  ekiga	SIP	Constructed handler for sip:520@ekiga.net
2011/04/01 21:48:34.203	 11:07.808	        PThreadObj:3556	SIP	Constructed handler for sip:520@ekiga.net;OPAL-local-id=sip%3A520%40ekiga.net
2011/04/01 21:48:34.203	 11:07.808	                  ekiga	SIP	Executing state change to Subscribing for SUBSCRIBE handler, target=sip:520@ekiga.net, id=98226eb6-d303-1910-8995-00ffce7de359@LCS-214-230
2011/04/01 21:48:34.203	 11:07.808	                  ekiga	SIP	Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:520@ekiga.net, id=98226eb6-d303-1910-8995-00ffce7de359@LCS-214-230
2011/04/01 21:48:34.203	 11:07.808	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:48:34.203	 11:07.809	        PThreadObj:3556	SIP	Executing state change to Subscribing for SUBSCRIBE handler, target=sip:520@ekiga.net;OPAL-local-id=sip%3A520%40ekiga.net, id=98226eb6-d303-1910-8996-00ffce7de359@LCS-214-230
2011/04/01 21:48:34.203	 11:07.809	        PThreadObj:3556	SIP	Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:520@ekiga.net;OPAL-local-id=sip%3A520%40ekiga.net, id=98226eb6-d303-1910-8996-00ffce7de359@LCS-214-230
2011/04/01 21:48:34.203	 11:07.809	        PThreadObj:3556	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:49:09.406	 11:43.007	                  ekiga	SIP	No SRV record found.
2011/04/01 21:49:09.406	 11:43.007	                  ekiga	OpalUDP	Binding to interface: 0.0.0.0:5060
2011/04/01 21:49:09.406	 11:43.007	                  ekiga	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2011/04/01 21:49:09.406	 11:43.009	                  ekiga	OpalUDP	Started connect to 86.64.162.35:5060
2011/04/01 21:49:09.406	 11:43.009	                  ekiga	OpalUDP	Writing to interface 0 - "192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport"
2011/04/01 21:49:09.406	 11:43.011	                  ekiga	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.19.22:5060,udp$192.168.10.105:5060,udp$192.168.56.1:5060
2011/04/01 21:49:09.406	 11:43.014	                  ekiga	SIP	Transaction created.
2011/04/01 21:49:09.406	 11:43.019	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:49:09.421	 11:43.026	        PThreadObj:3556	SIP	No SRV record found.
2011/04/01 21:49:09.421	 11:43.026	        PThreadObj:3556	OpalUDP	Binding to interface: 0.0.0.0:5060
2011/04/01 21:49:09.421	 11:43.026	        PThreadObj:3556	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2011/04/01 21:49:09.421	 11:43.027	        PThreadObj:3556	OpalUDP	Started connect to 86.64.162.35:5060
2011/04/01 21:49:09.421	 11:43.027	        PThreadObj:3556	OpalUDP	Writing to interface 0 - "192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport"
2011/04/01 21:49:09.421	 11:43.027	        PThreadObj:3556	SIP	Transaction created.
2011/04/01 21:49:09.421	 11:43.032	        PThreadObj:3556	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:49:44.500	 12:18.100	                  ekiga	SIP	No SRV record found.
2011/04/01 21:49:44.500	 12:18.100	                  ekiga	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:49:44.500	 12:18.100	                  ekiga	SIP	Sending PDU (554 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.19.22:5060,if=192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport
SUBSCRIBE sip:520@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.19.22:5060;branch=z9hG4bKd1d9a3b6-d303-1910-8997-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: "kamath" <sip:kamath@192.168.19.22>;tag=d1d9a3b6-d303-1910-8996-00ffce7de359

Call-ID: 98226eb6-d303-1910-8995-00ffce7de359@LCS-214-230

To: <sip:520@ekiga.net>

Contact: sip:520@192.168.19.22

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




2011/04/01 21:49:44.500	 12:18.102	                  ekiga	OpalUDP	Setting interface to 192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport
2011/04/01 21:49:44.500	 12:18.102	                  ekiga	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:49:44.500	 12:18.102	                  ekiga	OpalUDP	Writing to interface 1 - "192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport"
2011/04/01 21:49:44.500	 12:18.104	                  ekiga	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.19.22:5060,udp$192.168.10.105:5060,udp$192.168.56.1:5060
2011/04/01 21:49:44.500	 12:18.107	                  ekiga	SIP	Transaction created.
2011/04/01 21:49:44.500	 12:18.113	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:49:44.515	 12:18.118	        PThreadObj:3556	SIP	No SRV record found.
2011/04/01 21:49:44.515	 12:18.118	        PThreadObj:3556	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:49:44.515	 12:18.118	        PThreadObj:3556	SIP	Sending PDU (551 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.19.22:5060,if=192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport
SUBSCRIBE sip:520@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.19.22:5060;branch=z9hG4bKebdfa3b6-d303-1910-8998-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: <sip:520@ekiga.net>;tag=ebdfa3b6-d303-1910-8997-00ffce7de359

Call-ID: 98226eb6-d303-1910-8996-00ffce7de359@LCS-214-230

To: <sip:520@ekiga.net>

Contact: sip:520@192.168.19.22

Accept: application/watcherinfo+xml

Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING

Expires: 300

Event: presence.winfo

Content-Length: 0

Max-Forwards: 70




2011/04/01 21:49:44.515	 12:18.119	        PThreadObj:3556	OpalUDP	Setting interface to 192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport
2011/04/01 21:49:44.515	 12:18.119	        PThreadObj:3556	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:49:44.515	 12:18.119	        PThreadObj:3556	OpalUDP	Writing to interface 1 - "192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport"
2011/04/01 21:49:44.515	 12:18.120	        PThreadObj:3556	SIP	Transaction created.
2011/04/01 21:49:44.515	 12:18.125	        PThreadObj:3556	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:50:19.609	 12:53.210	                  ekiga	SIP	No SRV record found.
2011/04/01 21:50:19.609	 12:53.210	                  ekiga	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:50:19.609	 12:53.210	                  ekiga	SIP	Sending PDU (557 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.10.105:5060,if=192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
SUBSCRIBE sip:520@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.10.105:5060;branch=z9hG4bK5066d9b6-d303-1910-8998-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: "kamath" <sip:kamath@192.168.10.105>;tag=d1d9a3b6-d303-1910-8996-00ffce7de359

Call-ID: 98226eb6-d303-1910-8995-00ffce7de359@LCS-214-230

To: <sip:520@ekiga.net>

Contact: sip:520@192.168.10.105

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




2011/04/01 21:50:19.609	 12:53.212	                  ekiga	OpalUDP	Setting interface to 192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
2011/04/01 21:50:19.609	 12:53.212	                  ekiga	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:50:19.609	 12:53.212	                  ekiga	OpalUDP	Writing to interface 2 - "192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport"
2011/04/01 21:50:19.609	 12:53.214	                  ekiga	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.19.22:5060,udp$192.168.10.105:5060,udp$192.168.56.1:5060
2011/04/01 21:50:19.609	 12:53.214	        PThreadObj:3556	SIP	No SRV record found.
2011/04/01 21:50:19.609	 12:53.215	        PThreadObj:3556	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:50:19.609	 12:53.215	        PThreadObj:3556	SIP	Sending PDU (553 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.10.105:5060,if=192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
SUBSCRIBE sip:520@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.10.105:5060;branch=z9hG4bK6a6cd9b6-d303-1910-8998-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: <sip:520@ekiga.net>;tag=ebdfa3b6-d303-1910-8997-00ffce7de359

Call-ID: 98226eb6-d303-1910-8996-00ffce7de359@LCS-214-230

To: <sip:520@ekiga.net>

Contact: sip:520@192.168.10.105

Accept: application/watcherinfo+xml

Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING

Expires: 300

Event: presence.winfo

Content-Length: 0

Max-Forwards: 70




2011/04/01 21:50:19.609	 12:53.216	        PThreadObj:3556	OpalUDP	Setting interface to 192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
2011/04/01 21:50:19.609	 12:53.216	        PThreadObj:3556	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:50:19.609	 12:53.216	        PThreadObj:3556	OpalUDP	Writing to interface 2 - "192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport"
2011/04/01 21:50:19.609	 12:53.216	        PThreadObj:3556	SIP	Transaction created.
2011/04/01 21:50:19.609	 12:53.218	                  ekiga	SIP	Transaction created.
2011/04/01 21:50:19.625	 12:53.224	        PThreadObj:3556	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:50:19.625	 12:53.225	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:50:19.703	 12:53.313	     Opal Listener:3864	OpalUDP	Binding to interface: 192.168.10.105:5060
2011/04/01 21:50:19.703	 12:53.313	     Opal Listener:3864	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:50:19.703	 12:53.314	     Opal Listener:3864	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.10.105:5060,if=192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
SIP/2.0 489 Event Not Supported
CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.10.105:5060;branch=z9hG4bK5066d9b6-d303-1910-8998-00ffce7de359;rport=5060;received=74.71.59.242

Server: Kamailio (1.5.3-notls (i386/linux))

From: "kamath" <sip:kamath@192.168.10.105>;tag=d1d9a3b6-d303-1910-8996-00ffce7de359

Call-ID: 98226eb6-d303-1910-8995-00ffce7de359@LCS-214-230

To: <sip:520@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.8246

Content-Length: 0




2011/04/01 21:50:19.703	 12:53.315	     Opal Listener:3864	SIP	Queueing PDU "1 SUBSCRIBE <489>", transaction=z9hG4bK5066d9b6-d303-1910-8998-00ffce7de359, token=98226eb6-d303-1910-8995-00ffce7de359@LCS-214-230
2011/04/01 21:50:19.703	 12:53.315	     Opal Listener:3864	Opal	Transport clean up on termination
2011/04/01 21:50:19.703	 12:53.316	              Pool:4060	SIP	Handling PDU "1 SUBSCRIBE <489>" for transaction=z9hG4bK5066d9b6-d303-1910-8998-00ffce7de359
2011/04/01 21:50:19.703	 12:53.316	     Opal Listener:3864	Opal	Transport Close
2011/04/01 21:50:19.703	 12:53.316	              Pool:4060	SIP	SUBSCRIBE transaction id=z9hG4bK5066d9b6-d303-1910-8998-00ffce7de359 completed.
2011/04/01 21:50:19.703	 12:53.316	     Opal Listener:3864	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:50:19.718	 12:53.318	     Opal Listener:3864	OpalUDP	Binding to interface: 192.168.10.105:5060
2011/04/01 21:50:19.718	 12:53.318	     Opal Listener:3864	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:50:19.718	 12:53.319	     Opal Listener:3864	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.10.105:5060,if=192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
SIP/2.0 489 Event Not Supported
CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.10.105:5060;branch=z9hG4bK6a6cd9b6-d303-1910-8998-00ffce7de359;rport=5060;received=74.71.59.242

Server: Kamailio (1.5.3-notls (i386/linux))

From: <sip:520@ekiga.net>;tag=ebdfa3b6-d303-1910-8997-00ffce7de359

Call-ID: 98226eb6-d303-1910-8996-00ffce7de359@LCS-214-230

To: <sip:520@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.866e

Content-Length: 0




2011/04/01 21:50:19.718	 12:53.320	     Opal Listener:3864	SIP	Queueing PDU "1 SUBSCRIBE <489>", transaction=z9hG4bK6a6cd9b6-d303-1910-8998-00ffce7de359, token=98226eb6-d303-1910-8996-00ffce7de359@LCS-214-230
2011/04/01 21:50:19.718	 12:53.320	     Opal Listener:3864	Opal	Transport clean up on termination
2011/04/01 21:50:19.718	 12:53.320	              Pool:6072	SIP	Handling PDU "1 SUBSCRIBE <489>" for transaction=z9hG4bK6a6cd9b6-d303-1910-8998-00ffce7de359
2011/04/01 21:50:19.718	 12:53.320	     Opal Listener:3864	Opal	Transport Close
2011/04/01 21:50:19.718	 12:53.320	              Pool:6072	SIP	SUBSCRIBE transaction id=z9hG4bK6a6cd9b6-d303-1910-8998-00ffce7de359 completed.
2011/04/01 21:50:19.718	 12:53.320	     Opal Listener:3864	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:50:54.734	 13:28.338	        PThreadObj:3556	SIP	No SRV record found.
2011/04/01 21:50:54.734	 13:28.338	        PThreadObj:3556	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:50:54.734	 13:28.338	        PThreadObj:3556	SIP	Sending PDU (549 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.56.1:5060,if=192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport
SUBSCRIBE sip:520@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.56.1:5060;branch=z9hG4bK04ff0eb7-d303-1910-8998-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: <sip:520@ekiga.net>;tag=ebdfa3b6-d303-1910-8997-00ffce7de359

Call-ID: 98226eb6-d303-1910-8996-00ffce7de359@LCS-214-230

To: <sip:520@ekiga.net>

Contact: sip:520@192.168.56.1

Accept: application/watcherinfo+xml

Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING

Expires: 300

Event: presence.winfo

Content-Length: 0

Max-Forwards: 70




2011/04/01 21:50:54.734	 13:28.339	        PThreadObj:3556	OpalUDP	Setting interface to 192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport
2011/04/01 21:50:54.734	 13:28.339	        PThreadObj:3556	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:50:54.734	 13:28.340	              Pool:6072	SIP	SUBSCRIBE transaction id=z9hG4bKebdfa3b6-d303-1910-8998-00ffce7de359 aborted.
2011/04/01 21:50:54.734	 13:28.340	              Pool:6072	SIP	Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bKebdfa3b6-d303-1910-8998-00ffce7de359
2011/04/01 21:50:54.734	 13:28.340	              Pool:6072	SIP	SUBSCRIBE transaction id=z9hG4bK04ff0eb7-d303-1910-8998-00ffce7de359 aborted.
2011/04/01 21:50:54.734	 13:28.340	              Pool:6072	SIP	Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bK04ff0eb7-d303-1910-8998-00ffce7de359
2011/04/01 21:50:54.734	 13:28.340	              Pool:6072	OpalUDP	Setting interface to 192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
2011/04/01 21:50:54.734	 13:28.340	              Pool:6072	SIP	Not retrying SUBSCRIBE due to error response 489 Bad Event
2011/04/01 21:50:54.734	 13:28.340	              Pool:6072	SIP	Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:520@ekiga.net;OPAL-local-id=sip%3A520%40ekiga.net, id=98226eb6-d303-1910-8996-00ffce7de359@LCS-214-230
2011/04/01 21:50:54.734	 13:28.340	              Pool:6072	SIP	Handled PDU "1 SUBSCRIBE <489>"
2011/04/01 21:50:54.734	 13:28.345	                  ekiga	SIP	No SRV record found.
2011/04/01 21:50:54.734	 13:28.345	                  ekiga	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:50:54.734	 13:28.345	                  ekiga	SIP	Sending PDU (551 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.56.1:5060,if=192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport
SUBSCRIBE sip:520@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.56.1:5060;branch=z9hG4bK04ff0eb7-d303-1910-8999-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: "kamath" <sip:kamath@192.168.56.1>;tag=d1d9a3b6-d303-1910-8996-00ffce7de359

Call-ID: 98226eb6-d303-1910-8995-00ffce7de359@LCS-214-230

To: <sip:520@ekiga.net>

Contact: sip:520@192.168.56.1

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




2011/04/01 21:50:54.734	 13:28.346	                  ekiga	OpalUDP	Setting interface to 192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport
2011/04/01 21:50:54.734	 13:28.346	                  ekiga	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:50:54.734	 13:28.346	              Pool:4060	SIP	SUBSCRIBE transaction id=z9hG4bKd1d9a3b6-d303-1910-8997-00ffce7de359 aborted.
2011/04/01 21:50:54.734	 13:28.347	                  ekiga	SIP	Start SUBSCRIBE
 eventPackage=dialog;sla;ma
          aor=sip:520@ekiga.net
       remote=
        local=
      contact=
       authID=
        realm=
       expire=300
      restore=30
     minRetry=default
     maxRetry=default
2011/04/01 21:50:54.734	 13:28.347	              Pool:4060	SIP	Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bKd1d9a3b6-d303-1910-8997-00ffce7de359
2011/04/01 21:50:54.734	 13:28.347	              Pool:4060	SIP	SUBSCRIBE transaction id=z9hG4bK04ff0eb7-d303-1910-8999-00ffce7de359 aborted.
2011/04/01 21:50:54.734	 13:28.347	              Pool:4060	SIP	Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bK04ff0eb7-d303-1910-8999-00ffce7de359
2011/04/01 21:50:54.734	 13:28.347	              Pool:4060	OpalUDP	Setting interface to 192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
2011/04/01 21:50:54.734	 13:28.347	              Pool:4060	SIP	Not retrying SUBSCRIBE due to error response 489 Bad Event
2011/04/01 21:50:54.734	 13:28.347	              Pool:4060	SIP	Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:520@ekiga.net, id=98226eb6-d303-1910-8995-00ffce7de359@LCS-214-230
2011/04/01 21:50:54.734	 13:28.347	              Pool:4060	SIP	Handled PDU "1 SUBSCRIBE <489>"
2011/04/01 21:50:54.734	 13:28.347	      Opal Garbage:5348	SIP	Transaction id=z9hG4bK04ff0eb7-d303-1910-8998-00ffce7de359 destroyed.
2011/04/01 21:50:54.734	 13:28.347	      Opal Garbage:5348	SIP	Transaction id=z9hG4bK04ff0eb7-d303-1910-8999-00ffce7de359 destroyed.
2011/04/01 21:50:54.734	 13:28.347	      Opal Garbage:5348	SIP	Transaction id=z9hG4bKd1d9a3b6-d303-1910-8997-00ffce7de359 destroyed.
2011/04/01 21:50:54.734	 13:28.347	      Opal Garbage:5348	SIP	Transaction id=z9hG4bKebdfa3b6-d303-1910-8998-00ffce7de359 destroyed.
2011/04/01 21:50:54.750	 13:28.347	      Opal Garbage:5348	SIP	Deleting SIPSubscribeHandler sip:520@ekiga.net
2011/04/01 21:50:54.750	 13:28.347	      Opal Garbage:5348	Opal	Transport clean up on termination
2011/04/01 21:50:54.750	 13:28.347	      Opal Garbage:5348	Opal	Transport Close
2011/04/01 21:50:54.750	 13:28.347	      Opal Garbage:5348	Opal	Transport clean up on termination
2011/04/01 21:50:54.750	 13:28.348	      Opal Garbage:5348	Opal	Transport Close
2011/04/01 21:50:54.750	 13:28.348	                  ekiga	SIP	Constructed handler for sip:520@ekiga.net
2011/04/01 21:50:54.750	 13:28.348	                  ekiga	SIP	Executing state change to Subscribing for SUBSCRIBE handler, target=sip:520@ekiga.net, id=b89744b7-d303-1910-899a-00ffce7de359@LCS-214-230
2011/04/01 21:50:54.750	 13:28.348	                  ekiga	SIP	Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:520@ekiga.net, id=b89744b7-d303-1910-899a-00ffce7de359@LCS-214-230
2011/04/01 21:50:54.750	 13:28.349	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:50:54.750	 13:28.348	      Opal Garbage:5348	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:50:54.750	 13:28.349	      Opal Garbage:5348	SIP	Deleted handler.
2011/04/01 21:50:54.750	 13:28.349	      Opal Garbage:5348	SIP	Deleting SIPSubscribeHandler sip:520@ekiga.net;OPAL-local-id=sip%3A520%40ekiga.net
2011/04/01 21:50:54.750	 13:28.349	      Opal Garbage:5348	Opal	Transport clean up on termination
2011/04/01 21:50:54.750	 13:28.349	      Opal Garbage:5348	Opal	Transport Close
2011/04/01 21:50:54.750	 13:28.349	      Opal Garbage:5348	Opal	Transport clean up on termination
2011/04/01 21:50:54.750	 13:28.349	      Opal Garbage:5348	Opal	Transport Close
2011/04/01 21:50:54.750	 13:28.349	      Opal Garbage:5348	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:50:54.750	 13:28.350	      Opal Garbage:5348	SIP	Deleted handler.
2011/04/01 21:50:55.734	 13:29.341	 PTLib Housekeeper:1620	SIP	Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bK6a6cd9b6-d303-1910-8998-00ffce7de359
2011/04/01 21:50:55.750	 13:29.350	      Opal Garbage:5348	SIP	Transaction id=z9hG4bK6a6cd9b6-d303-1910-8998-00ffce7de359 destroyed.
2011/04/01 21:50:55.765	 13:29.366	 PTLib Housekeeper:1620	SIP	Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bK5066d9b6-d303-1910-8998-00ffce7de359
2011/04/01 21:50:56.750	 13:30.350	      Opal Garbage:5348	SIP	Transaction id=z9hG4bK5066d9b6-d303-1910-8998-00ffce7de359 destroyed.
2011/04/01 21:51:29.828	 14:03.435	                  ekiga	SIP	No SRV record found.
2011/04/01 21:51:29.828	 14:03.435	                  ekiga	OpalUDP	Binding to interface: 0.0.0.0:5060
2011/04/01 21:51:29.828	 14:03.435	                  ekiga	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2011/04/01 21:51:29.828	 14:03.436	                  ekiga	OpalUDP	Started connect to 86.64.162.35:5060
2011/04/01 21:51:29.828	 14:03.436	                  ekiga	OpalUDP	Writing to interface 0 - "192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport"
2011/04/01 21:51:29.828	 14:03.439	                  ekiga	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.19.22:5060,udp$192.168.10.105:5060,udp$192.168.56.1:5060
2011/04/01 21:51:29.843	 14:03.443	                  ekiga	SIP	Transaction created.
2011/04/01 21:51:29.843	 14:03.453	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:52:04.937	 14:38.537	                  ekiga	SIP	No SRV record found.
2011/04/01 21:52:04.937	 14:38.538	                  ekiga	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:52:04.937	 14:38.538	                  ekiga	SIP	Sending PDU (566 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.19.22:5060,if=192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport
SUBSCRIBE sip:520@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.19.22:5060;branch=z9hG4bK37247ab7-d303-1910-899b-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: "kamath" <sip:kamath@192.168.19.22>;tag=37247ab7-d303-1910-899a-00ffce7de359

Call-ID: b89744b7-d303-1910-899a-00ffce7de359@LCS-214-230

To: <sip:520@ekiga.net>

Contact: sip:520@192.168.19.22

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




2011/04/01 21:52:04.937	 14:38.539	                  ekiga	OpalUDP	Setting interface to 192.168.19.22%TAP-Win32 Adapter V9 - Packet Scheduler Miniport
2011/04/01 21:52:04.937	 14:38.539	                  ekiga	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:52:04.937	 14:38.539	                  ekiga	OpalUDP	Writing to interface 1 - "192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport"
2011/04/01 21:52:04.937	 14:38.542	                  ekiga	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.19.22:5060,udp$192.168.10.105:5060,udp$192.168.56.1:5060
2011/04/01 21:52:04.937	 14:38.545	                  ekiga	SIP	Transaction created.
2011/04/01 21:52:04.953	 14:38.556	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:52:40.062	 15:13.660	                  ekiga	SIP	No SRV record found.
2011/04/01 21:52:40.062	 15:13.660	                  ekiga	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:52:40.062	 15:13.660	                  ekiga	SIP	Sending PDU (569 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.10.105:5060,if=192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
SUBSCRIBE sip:520@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.10.105:5060;branch=z9hG4bKd0b6afb7-d303-1910-899b-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: "kamath" <sip:kamath@192.168.10.105>;tag=37247ab7-d303-1910-899a-00ffce7de359

Call-ID: b89744b7-d303-1910-899a-00ffce7de359@LCS-214-230

To: <sip:520@ekiga.net>

Contact: sip:520@192.168.10.105

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




2011/04/01 21:52:40.062	 15:13.662	                  ekiga	OpalUDP	Setting interface to 192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
2011/04/01 21:52:40.062	 15:13.662	                  ekiga	SIP	Transaction timers set: retry=0.500, completion=6.000
2011/04/01 21:52:40.062	 15:13.662	                  ekiga	OpalUDP	Writing to interface 2 - "192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport"
2011/04/01 21:52:40.062	 15:13.664	                  ekiga	OpalMan	Listener interfaces: associated transport=None
    udp$192.168.19.22:5060,udp$192.168.10.105:5060,udp$192.168.56.1:5060
2011/04/01 21:52:40.062	 15:13.668	                  ekiga	SIP	Transaction created.
2011/04/01 21:52:40.078	 15:13.679	                  ekiga	DNS	SRV Lookup ekiga.net service _sip._udp
2011/04/01 21:52:40.156	 15:13.764	     Opal Listener:3864	OpalUDP	Binding to interface: 192.168.10.105:5060
2011/04/01 21:52:40.156	 15:13.764	     Opal Listener:3864	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:52:40.156	 15:13.766	     Opal Listener:3864	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.10.105:5060,if=192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
SIP/2.0 489 Event Not Supported
CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.10.105:5060;branch=z9hG4bKd0b6afb7-d303-1910-899b-00ffce7de359;rport=5060;received=74.71.59.242

Server: Kamailio (1.5.3-notls (i386/linux))

From: "kamath" <sip:kamath@192.168.10.105>;tag=37247ab7-d303-1910-899a-00ffce7de359

Call-ID: b89744b7-d303-1910-899a-00ffce7de359@LCS-214-230

To: <sip:520@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.292c

Content-Length: 0




2011/04/01 21:52:40.156	 15:13.767	     Opal Listener:3864	SIP	Queueing PDU "1 SUBSCRIBE <489>", transaction=z9hG4bKd0b6afb7-d303-1910-899b-00ffce7de359, token=b89744b7-d303-1910-899a-00ffce7de359@LCS-214-230
2011/04/01 21:52:40.156	 15:13.767	     Opal Listener:3864	Opal	Transport clean up on termination
2011/04/01 21:52:40.156	 15:13.767	              Pool:4060	SIP	Handling PDU "1 SUBSCRIBE <489>" for transaction=z9hG4bKd0b6afb7-d303-1910-899b-00ffce7de359
2011/04/01 21:52:40.156	 15:13.767	     Opal Listener:3864	Opal	Transport Close
2011/04/01 21:52:40.156	 15:13.767	              Pool:4060	SIP	SUBSCRIBE transaction id=z9hG4bKd0b6afb7-d303-1910-899b-00ffce7de359 completed.
2011/04/01 21:52:40.156	 15:13.767	     Opal Listener:3864	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:53:15.156	 15:48.761	                  ekiga	SIP	No SRV record found.
2011/04/01 21:53:15.156	 15:48.762	                  ekiga	SIP	Transaction remote address is udp$ekiga.net:5060
2011/04/01 21:53:15.156	 15:48.762	                  ekiga	SIP	Sending PDU (563 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.56.1:5060,if=192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport
SUBSCRIBE sip:520@ekiga.net SIP/2.0

CSeq: 1 SUBSCRIBE

Via: SIP/2.0/UDP 192.168.56.1:5060;branch=z9hG4bK844fe5b7-d303-1910-899b-00ffce7de359;rport

User-Agent: Ekiga/3.3.0

From: "kamath" <sip:kamath@192.168.56.1>;tag=37247ab7-d303-1910-899a-00ffce7de359

Call-ID: b89744b7-d303-1910-899a-00ffce7de359@LCS-214-230

To: <sip:520@ekiga.net>

Contact: sip:520@192.168.56.1

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




2011/04/01 21:53:15.156	 15:48.763	                  ekiga	OpalUDP	Setting interface to 192.168.56.1%VirtualBox Host-Only Ethernet Adapter - Packet Scheduler Miniport
2011/04/01 21:53:15.156	 15:48.764	                  ekiga	SIP	Transaction timers set: retry=0.499, completion=5.999
2011/04/01 21:53:15.156	 15:48.764	              Pool:4060	SIP	SUBSCRIBE transaction id=z9hG4bK37247ab7-d303-1910-899b-00ffce7de359 aborted.
2011/04/01 21:53:15.156	 15:48.764	              Pool:4060	SIP	Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bK37247ab7-d303-1910-899b-00ffce7de359
2011/04/01 21:53:15.156	 15:48.764	              Pool:4060	SIP	SUBSCRIBE transaction id=z9hG4bK844fe5b7-d303-1910-899b-00ffce7de359 aborted.
2011/04/01 21:53:15.156	 15:48.764	              Pool:4060	SIP	Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bK844fe5b7-d303-1910-899b-00ffce7de359
2011/04/01 21:53:15.156	 15:48.764	              Pool:4060	OpalUDP	Setting interface to 192.168.10.105%Intel(R) 82567LM-3 Gigabit Network Connection - Packet Scheduler Miniport
2011/04/01 21:53:15.156	 15:48.764	              Pool:4060	SIP	Not retrying SUBSCRIBE due to error response 489 Bad Event
2011/04/01 21:53:15.156	 15:48.764	              Pool:4060	SIP	Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:520@ekiga.net, id=b89744b7-d303-1910-899a-00ffce7de359@LCS-214-230
2011/04/01 21:53:15.156	 15:48.764	              Pool:4060	SIP	Handled PDU "1 SUBSCRIBE <489>"
2011/04/01 21:53:15.156	 15:48.764	      Opal Garbage:5348	SIP	Transaction id=z9hG4bK37247ab7-d303-1910-899b-00ffce7de359 destroyed.
2011/04/01 21:53:15.156	 15:48.764	      Opal Garbage:5348	SIP	Deleting SIPSubscribeHandler sip:520@ekiga.net
2011/04/01 21:53:15.156	 15:48.764	      Opal Garbage:5348	Opal	Transport clean up on termination
2011/04/01 21:53:15.156	 15:48.764	      Opal Garbage:5348	Opal	Transport Close
2011/04/01 21:53:15.156	 15:48.764	      Opal Garbage:5348	Opal	Transport clean up on termination
2011/04/01 21:53:15.156	 15:48.764	      Opal Garbage:5348	Opal	Transport Close
2011/04/01 21:53:15.156	 15:48.764	      Opal Garbage:5348	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.10.105:5060>
2011/04/01 21:53:15.156	 15:48.766	      Opal Garbage:5348	SIP	Deleted handler.
2011/04/01 21:53:15.390	 15:48.996	                  ekiga	AudioOutputCore	Detected Device: Default (PTLIB/WindowsMultimedia)
2011/04/01 21:53:15.390	 15:48.996	                  ekiga	AudioOutputCore	Detected Device: SoundMAX HD Audio (PTLIB/WindowsMultimedia)
2011/04/01 21:53:15.390	 15:48.997	                  ekiga	AudioOutputCore	Detected Device: Default (PTLIB/WindowsMultimedia)
2011/04/01 21:53:15.390	 15:48.997	                  ekiga	AudioOutputCore	Detected Device: SoundMAX HD Audio (PTLIB/WindowsMultimedia)
2011/04/01 21:53:15.390	 15:49.000	                  ekiga	AudioInputCore	Detected Device: Default (PTLIB/WindowsMultimedia)
2011/04/01 21:53:15.390	 15:49.000	                  ekiga	AudioInputCore	Detected Device: SoundMAX HD Audio (PTLIB/WindowsMultimedia)
2011/04/01 21:53:15.390	 15:49.000	                  ekiga	AudioInputCore	Detected Device: HD Audio front mic (PTLIB/WindowsMultimedia)
2011/04/01 21:53:15.406	 15:49.005	                  ekiga	PVidDirectShow	PVideoInputDevice_DirectShow: constructor
2011/04/01 21:53:15.406	 15:49.005	                  ekiga	PVidDirectShow	Enumerating Device Names
2011/04/01 21:53:15.406	 15:49.010	                  ekiga	PVidDirectShow	No video capture device was detected.
2011/04/01 21:53:15.406	 15:49.011	                  ekiga	PVidDirectShow	PVideoInputDevice_DirectShow: destructor
2011/04/01 21:53:15.406	 15:49.013	                  ekiga	VidInputCore	Detected Device: Moving Logo (Moving Logo/Moving Logo)
2011/04/01 21:53:15.406	 15:49.013	                  ekiga	VidInputCore	Detected Device: Microsoft WDM Image Capture (Win32) (PTLIB/VideoForWindows)
2011/04/01 21:53:15.406	 15:49.013	                  ekiga	PVidDirectShow	PVideoInputDevice_DirectShow: constructor
2011/04/01 21:53:15.406	 15:49.013	                  ekiga	PVidDirectShow	Enumerating Device Names
2011/04/01 21:53:15.421	 15:49.017	                  ekiga	PVidDirectShow	No video capture device was detected.
2011/04/01 21:53:15.421	 15:49.017	                  ekiga	PVidDirectShow	PVideoInputDevice_DirectShow: destructor
2011/04/01 21:53:15.421	 15:49.020	                  ekiga	VidInputCore	Detected Device: Moving Logo (Moving Logo/Moving Logo)
2011/04/01 21:53:15.421	 15:49.020	                  ekiga	VidInputCore	Detected Device: Microsoft WDM Image Capture (Win32) (PTLIB/VideoForWindows)
2011/04/01 21:53:15.468	 15:49.072	                  ekiga	AudioOutputCore	Detected Device: Default (PTLIB/WindowsMultimedia)
2011/04/01 21:53:15.468	 15:49.072	                  ekiga	AudioOutputCore	Detected Device: SoundMAX HD Audio (PTLIB/WindowsMultimedia)
2011/04/01 21:53:15.484	 15:49.083	                  ekiga	Ekiga version 3.3.0
2011/04/01 21:53:15.484	 15:49.083	                  ekiga	OPAL version 3.8.3
2011/04/01 21:53:15.484	 15:49.083	                  ekiga	PTLIB version 2.8.3
2011/04/01 21:53:15.484	 15:49.083	                  ekiga	GNOME support disabled
2011/04/01 21:53:15.484	 15:49.083	                  ekiga	Accelerated rendering support enabled
2011/04/01 21:53:15.484	 15:49.083	                  ekiga	DBUS support disabled
2011/04/01 21:53:15.484	 15:49.083	                  ekiga	GConf support disabled
2011/04/01 21:53:15.531	 15:49.134	                  ekiga	MediaFormat	Removing codecs SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,G.711-uLaw-64k,G.711-ALaw-64k,H.264,theora,H.261,H.261-CIF,H.261-QCIF,H.263,H.263P,MPEG4,PCM-16-48kHz,PCM-16-32kHz,PCM-16-16kHz,PCM-16,UserInput/RFC2833,YUV420P,MSRP,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling
2011/04/01 21:53:15.531	 15:49.135	                  ekiga	OPAL	SetMediaFormatMask(CELT-48K,CELT-32K,G.722-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,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,iLBC,iLBC-13k3,iLBC-15k2,RFC4175_YCbCr-4:2:0,T.140,MSRP,SIP-IM)
2011/04/01 21:53:15.531	 15:49.135	                  ekiga	OPAL	SetMediaFormatOrder(SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,G.711-uLaw-64k,G.711-ALaw-64k,H.264,theora,H.261,H.261-CIF,H.261-QCIF,H.263,H.263P,MPEG4,PCM-16-48kHz,PCM-16-32kHz,PCM-16-16kHz,PCM-16,UserInput/RFC2833,YUV420P,MSRP,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling)
2011/04/01 21:53:15.546	 15:49.150	                  ekiga	MediaFormat	Removing codecs SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,G.711-uLaw-64k,G.711-ALaw-64k,H.264,theora,H.261,H.261-CIF,H.261-QCIF,H.263,H.263P,MPEG4,PCM-16-48kHz,PCM-16-32kHz,PCM-16-16kHz,PCM-16,UserInput/RFC2833,YUV420P,MSRP,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling
2011/04/01 21:53:15.546	 15:49.151	                  ekiga	OPAL	SetMediaFormatMask(CELT-48K,CELT-32K,G.722-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,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,iLBC,iLBC-13k3,iLBC-15k2,RFC4175_YCbCr-4:2:0,T.140,MSRP,SIP-IM)
2011/04/01 21:53:15.546	 15:49.151	                  ekiga	OPAL	SetMediaFormatOrder(SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,G.711-uLaw-64k,G.711-ALaw-64k,H.264,theora,H.261,H.261-CIF,H.261-QCIF,H.263,H.263P,MPEG4,PCM-16-48kHz,PCM-16-32kHz,PCM-16-16kHz,PCM-16,UserInput/RFC2833,YUV420P,MSRP,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling)
2011/04/01 21:53:15.562	 15:49.168	                  ekiga	VidInputCoreConfBridge	Updating preview size and fps
2011/04/01 21:53:15.562	 15:49.168	                  ekiga	VidInputCore	Setting new preview config: 176x144/30
2011/04/01 21:53:15.578	 15:49.174	                  ekiga	VidInputCoreConfBridge	Updating preview size and fps
2011/04/01 21:53:15.578	 15:49.174	                  ekiga	VidInputCore	Setting new preview config: 176x144/30
2011/04/01 21:53:15.578	 15:49.182	                  ekiga	VideoOutputCoreConfBridge	Updating video view
2011/04/01 21:53:15.578	 15:49.182	                  ekiga	VideoOutputCoreConfBridge	Updating zoom
2011/04/01 21:53:15.578	 15:49.182	                  ekiga	VideoOutputCoreConfBridge	Updating Video Settings
2011/04/01 21:53:15.578	 15:49.182	                  ekiga	VideoOutputCoreConfBridge	Updating Video Settings
2011/04/01 21:53:15.578	 15:49.182	                  ekiga	VideoOutputCoreConfBridge	Updating Video Settings
2011/04/01 21:53:15.578	 15:49.182	                  ekiga	VideoOutputCoreConfBridge	Updating Video Settings
2011/04/01 21:53:15.578	 15:49.182	                  ekiga	VidInputCoreConfBridge	Updating preview size and fps
2011/04/01 21:53:15.578	 15:49.182	                  ekiga	VidInputCore	Setting new preview config: 176x144/30
2011/04/01 21:53:15.578	 15:49.188	                  ekiga	VidInputCoreConfBridge	Updating preview size and fps
2011/04/01 21:53:15.593	 15:49.188	                  ekiga	VidInputCore	Setting new preview config: 176x144/30
2011/04/01 21:53:15.593	 15:49.194	                  ekiga	PVidDirectShow	PVideoInputDevice_DirectShow: constructor
2011/04/01 21:53:15.593	 15:49.194	                  ekiga	PVidDirectShow	Enumerating Device Names
2011/04/01 21:53:15.593	 15:49.199	                  ekiga	PVidDirectShow	No video capture device was detected.
2011/04/01 21:53:15.593	 15:49.200	                  ekiga	PVidDirectShow	PVideoInputDevice_DirectShow: destructor
2011/04/01 21:53:15.593	 15:49.202	                  ekiga	VidInputCore	Detected Device: Moving Logo (Moving Logo/Moving Logo)
2011/04/01 21:53:15.593	 15:49.202	                  ekiga	VidInputCore	Detected Device: Microsoft WDM Image Capture (Win32) (PTLIB/VideoForWindows)
2011/04/01 21:53:15.593	 15:49.202	                  ekiga	VidInputCoreConfBridge	Updating device
2011/04/01 21:53:15.593	 15:49.202	                  ekiga	VidInputCore	Setting device: Microsoft WDM Image Capture (Win32) (PTLIB/VideoForWindows)
2011/04/01 21:53:15.593	 15:49.202	                  ekiga	GMVideoInputManager_ptlib	Setting Device Microsoft WDM Image Capture (Win32) (PTLIB/VideoForWindows)
2011/04/01 21:53:15.593	 15:49.202	                  ekiga	PVidDirectShow	PVideoInputDevice_DirectShow: constructor
2011/04/01 21:53:15.593	 15:49.202	                  ekiga	PVidDirectShow	Enumerating Device Names
2011/04/01 21:53:15.609	 15:49.206	                  ekiga	PVidDirectShow	No video capture device was detected.
2011/04/01 21:53:15.609	 15:49.206	                  ekiga	PVidDirectShow	PVideoInputDevice_DirectShow: destructor
2011/04/01 21:53:15.609	 15:49.208	                  ekiga	VidInputCore	Detected Device: Moving Logo (Moving Logo/Moving Logo)
2011/04/01 21:53:15.609	 15:49.208	                  ekiga	VidInputCore	Detected Device: Microsoft WDM Image Capture (Win32) (PTLIB/VideoForWindows)
2011/04/01 21:53:15.609	 15:49.208	                  ekiga	VidInputCoreConfBridge	Updating device
2011/04/01 21:53:15.609	 15:49.209	                  ekiga	VidInputCore	Setting device: Microsoft WDM Image Capture (Win32) (PTLIB/VideoForWindows)
2011/04/01 21:53:15.609	 15:49.209	                  ekiga	GMVideoInputManager_ptlib	Setting Device Microsoft WDM Image Capture (Win32) (PTLIB/VideoForWindows)
2011/04/01 21:53:15.609	 15:49.209	                  ekiga	PVidDirectShow	PVideoInputDevice_DirectShow: constructor
2011/04/01 21:53:15.609	 15:49.209	                  ekiga	PVidDirectShow	Enumerating Device Names
2011/04/01 21:53:15.609	 15:49.213	                  ekiga	PVidDirectShow	No video capture device was detected.
2011/04/01 21:53:15.609	 15:49.213	                  ekiga	PVidDirectShow	PVideoInputDevice_DirectShow: destructor
2011/04/01 21:53:15.609	 15:49.215	                  ekiga	VidInputCore	Detected Device: Moving Logo (Moving Logo/Moving Logo)
2011/04/01 21:53:15.609	 15:49.215	                  ekiga	VidInputCore	Detected Device: Microsoft WDM Image Capture (Win32) (PTLIB/VideoForWindows)
2011/04/01 21:53:15.609	 15:49.215	                  ekiga	VidInputCoreConfBridge	Updating device
2011/04/01 21:53:15.609	 15:49.215	                  ekiga	VidInputCore	Setting device: Microsoft WDM Image Capture (Win32) (PTLIB/VideoForWindows)
2011/04/01 21:53:15.609	 15:49.215	                  ekiga	GMVideoInputManager_ptlib	Setting Device Microsoft WDM Image Capture (Win32) (PTLIB/VideoForWindows)
2011/04/01 21:53:15.609	 15:49.215	                  ekiga	VidInputCoreConfBridge	Updating image
2011/04/01 21:53:15.609	 15:49.215	                  ekiga	AudioOutputCore	Detected Device: Default (PTLIB/WindowsMultimedia)
2011/04/01 21:53:15.609	 15:49.215	                  ekiga	AudioOutputCore	Detected Device: SoundMAX HD Audio (PTLIB/WindowsMultimedia)
2011/04/01 21:53:15.609	 15:49.215	                  ekiga	AudioOutputCoreConfBridge	Set device to WindowsMultimedia/Default
2011/04/01 21:53:15.609	 15:49.215	                  ekiga	AudioOutputCore	Setting device[0]: Default (PTLIB/WindowsMultimedia)
2011/04/01 21:53:15.609	 15:49.215	                  ekiga	GMAudioOutputManager_ptlib	Setting Device[0] Default (PTLIB/WindowsMultimedia)
2011/04/01 21:53:15.609	 15:49.215	                  ekiga	AudioOutputCoreConfBridge	Updating device
2011/04/01 21:53:15.609	 15:49.215	                  ekiga	AudioOutputCore	Setting device[1]: Default (PTLIB/WindowsMultimedia)
2011/04/01 21:53:15.625	 15:49.232	                  ekiga	AudioInputCore	Detected Device: Default (PTLIB/WindowsMultimedia)
2011/04/01 21:53:15.625	 15:49.232	                  ekiga	AudioInputCore	Detected Device: SoundMAX HD Audio (PTLIB/WindowsMultimedia)
2011/04/01 21:53:15.625	 15:49.232	                  ekiga	AudioInputCore	Detected Device: HD Audio front mic (PTLIB/WindowsMultimedia)
2011/04/01 21:53:15.625	 15:49.232	                  ekiga	AudioInputCore	Setting device: Default (PTLIB/WindowsMultimedia)
2011/04/01 21:53:15.625	 15:49.232	                  ekiga	GMAudioInputManager_ptlib	Setting Device Default (PTLIB/WindowsMultimedia)
2011/04/01 21:53:15.625	 15:49.232	                  ekiga	AudioInputCore	Set device to WindowsMultimedia/Default
2011/04/01 21:53:16.156	 15:49.764	 PTLib Housekeeper:1620	SIP	Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bKd0b6afb7-d303-1910-899b-00ffce7de359
2011/04/01 21:53:16.156	 15:49.765	      Opal Garbage:5348	SIP	Transaction id=z9hG4bK844fe5b7-d303-1910-899b-00ffce7de359 destroyed.
2011/04/01 21:53:16.156	 15:49.765	      Opal Garbage:5348	SIP	Transaction id=z9hG4bKd0b6afb7-d303-1910-899b-00ffce7de359 destroyed.
2011/04/01 21:53:18.265	 15:51.864	      StunDetector:3284	OPAL	STUN server "stun.ekiga.net" replies Restricted NAT, external IP 74.71.59.242
2011/04/01 21:53:18.265	 15:51.864	      StunDetector:3284	PTLib	Thread ended: name="StunDetector:3284", real=2.687, kernel=0.000 (0%), user=0.000 (0%), both=0.000 (0%)
2011/04/01 21:53:19.000	 15:52.607	                  ekiga	Listen	Stopping listening thread on udp$*:5060
2011/04/01 21:53:19.000	 15:52.607	                  ekiga	MonSock	Closed UDP socket 0xff6588
2011/04/01 21:53:19.000	 15:52.607	     Opal Listener:3864	Listen	UDP read error.
2011/04/01 21:53:19.000	 15:52.607	     Opal Listener:3864	PTLib	Thread ended: name="Opal Listener:3864", real=952.312, kernel=0.094 (0%), user=0.000 (0%), both=0.094 (0%)
2011/04/01 21:53:19.031	 15:52.627	                  ekiga	MonSock	Deleting UDP socket 0xff6588
2011/04/01 21:53:19.031	 15:52.628	                  ekiga	MonSock	Closed UDP socket 0xff6308
2011/04/01 21:53:19.031	 15:52.628	                  ekiga	MonSock	Deleting UDP socket 0xff6308
2011/04/01 21:53:19.031	 15:52.628	                  ekiga	MonSock	Closed UDP socket 0xff6828
2011/04/01 21:53:19.031	 15:52.628	                  ekiga	MonSock	Deleting UDP socket 0xff6828
2011/04/01 21:53:19.031	 15:52.628	                  ekiga	MonSock	Created socket bundle for all interfaces.
2011/04/01 21:53:19.031	 15:52.630	                  ekiga	MonSock	Created bundled UDP socket 192.168.19.22:5060
2011/04/01 21:53:19.109	 15:52.706	                  ekiga	MonSock	Created bundled UDP socket via STUN, internal=192.168.10.105:5060, external=74.71.59.242:5060
2011/04/01 21:53:19.109	 15:52.708	                  ekiga	MonSock	Created bundled UDP socket 192.168.56.1:5060
2011/04/01 21:53:19.109	 15:52.708	                  ekiga	Listen	Stopping listening thread on tcp$*:1720
2011/04/01 21:53:19.109	 15:52.709	     Opal Listener:3988	PTLib	Thread ended: name="Opal Listener:3988", real=952.421, kernel=0.000 (0%), user=0.000 (0%), both=0.000 (0%)
2011/04/01 21:53:19.109	 15:52.709	     Opal Listener:2548	Listen	Started listening thread on udp$*:5060
2011/04/01 21:53:19.109	 15:52.711	     Opal Listener:4584	Listen	Started listening thread on tcp$*:1720
2011/04/01 21:53:19.109	 15:52.711	     Opal Listener:4584	Listen	Waiting on socket accept on tcp$*:1720
