Bug#538418: ekiga: Starts, but just hangs with no window popping up

Mark T.B. Carroll mark at ixod.org
Sat Jul 25 17:32:59 UTC 2009


Package: ekiga
Version: 3.2.5-1
Severity: normal

When I start ekiga, it just hangs - no window of any kind pops up.

-d 4 output is enclosed below.

In case it matters: On the relevant computer, I'm not convinced that the
router is currently forwarding UDP 5001-5100 to the machine, though I'd expect
Ekiga to at least say /something/ whatever the network situation.

(Possibly irrelevant: This is not a problem on my home system from which I
normally report bugs. However, when I did the 3.2.1 -> 3.2.5 upgrade on my
home system, which is quite similar but with some subtly different package
versions, no Ekiga windows came the first time I ran it, but a control-C and
trying again had it start working fine.)

Mark

-- System Information:
Debian Release: 5.0.2
  APT prefers stable
  APT policy: (900, 'stable'), (50, 'testing'), (40, 'unstable')
Architecture: amd64 (x86_64)

Kernel: Linux 2.6.26-2-amd64 (SMP w/2 CPU cores)
Locale: LANG=en_GB.UTF-8, LC_CTYPE=en_GB.UTF-8 (charmap=UTF-8)
Shell: /bin/sh linked to /bin/bash

Versions of packages ekiga depends on:
ii  evolution-data-se 2.26.2-1               evolution database backend server
ii  gconf2            2.26.2-1               GNOME configuration database syste
ii  libatk1.0-0       1.22.0-1               The ATK accessibility toolkit
ii  libavahi-client3  0.6.23-3lenny1         Avahi client library
ii  libavahi-common3  0.6.23-3lenny1         Avahi common library
ii  libavahi-glib1    0.6.23-3lenny1         Avahi glib integration library
ii  libc6             2.9-13                 GNU C Library: Shared libraries
ii  libdbus-glib-1-2  0.80-4                 simple interprocess messaging syst
ii  libebook1.2-9     2.26.3-1               Client library for evolution addre
ii  libedataserver1.2 2.26.3-1               Utility library for evolution data
ii  libgcc1           1:4.3.2-1.1            GCC support library
ii  libgconf2-4       2.26.2-1               GNOME configuration database syste
ii  libglib2.0-0      2.20.3-1               The GLib library of C routines
ii  libgtk2.0-0       2.16.4-1               The GTK+ graphical user interface 
ii  libldap-2.4-2     2.4.11-1               OpenLDAP libraries
ii  libnotify1 [libno 0.4.5-1                sends desktop notifications to a n
ii  libopal3.6.4      3.6.4~dfsg-1           Open Phone Abstraction Library - s
ii  libpango1.0-0     1.20.5-5               Layout and rendering of internatio
ii  libpt2.6.4        2.6.4-1                Portable Tools Library
ii  libpt2.6.4-plugin 2.6.4-1                Portable Tools Library plugins
ii  libsasl2-2        2.1.22.dfsg1-23+lenny1 Cyrus SASL - authentication abstra
ii  libsigc++-2.0-0c2 2.0.18-2               type-safe Signal Framework for C++
ii  libstdc++6        4.3.2-1.1              The GNU Standard C++ Library v3
ii  libx11-6          2:1.2.2-1              X11 client-side library
ii  libxext6          2:1.0.4-1              X11 miscellaneous extension librar
ii  libxml2           2.6.32.dfsg-5          GNOME XML library
ii  libxv1            2:1.0.4-1              X11 Video extension library

Versions of packages ekiga recommends:
pi  gvfs                         1.2.3-1     userspace virtual filesystem - ser
pi  yelp                         2.22.1-8+b1 Help browser for GNOME 2

Versions of packages ekiga suggests:
pn  asterisk                      <none>     (no description available)
pn  callweaver                    <none>     (no description available)
pn  gnugk                         <none>     (no description available)
pn  mediaproxy                    <none>     (no description available)
pn  openser                       <none>     (no description available)
pn  rtpproxy                      <none>     (no description available)
pn  ser                           <none>     (no description available)
pn  siproxd                       <none>     (no description available)
pn  yate                          <none>     (no description available)

-- no debconf information

~$ ekiga -d 4
2009/07/25 15:37:48.844	  0:54.976	                       		Version 3.2.5 by  on Unix Linux (2.6.26-2-amd64-x86_64) with PTLib (v2.6.4) at 2009/7/25 15:37:48.843
2009/07/25 15:37:48.845	  0:54.978	                       	Ekiga git revision: unknown
2009/07/25 15:37:48.846	  0:54.978	                       	Ekiga registered on D-Bus: org.ekiga.Ekiga
2009/07/25 15:37:48.848	  0:54.981	                       	PWLib	File handle high water mark set: 17 Thread unblock pipe
2009/07/25 15:37:48.848	  0:54.981	                       	PTLib	Thread high water mark set: 2
2009/07/25 15:37:48.849	  0:54.981	                       	PWLib	File handle high water mark set: 19 Thread unblock pipe
2009/07/25 15:37:48.849	  0:54.981	                       	PTLib	Thread high water mark set: 3
2009/07/25 15:37:48.849	  0:54.981	                       	PWLib	File handle high water mark set: 21 Thread unblock pipe
2009/07/25 15:37:48.850	  0:54.982	                       	PWLib	File handle high water mark set: 23 Thread unblock pipe
2009/07/25 15:37:51.201	  0:57.334	                       	PTLib	Thread high water mark set: 4
2009/07/25 15:37:51.205	  0:57.337	                       	HalManager_dbus	Initialising HAL Manager
2009/07/25 15:37:51.207	  0:57.340	                       	HalManager_dbus	Populating device list
2009/07/25 15:37:51.245	  0:57.378	                       	HalManager_dbus	Detected V4L capabilities on /dev/video0 name: 15704 webcam           
2009/07/25 15:37:51.246	  0:57.378	                       	HalManager_dbus	Detected V4L2 capabilities on /dev/video0 name: 15704 webcam           
2009/07/25 15:37:51.347	  0:57.479	                       	HalManager_dbus	Populated device list with 17 devices
2009/07/25 15:37:51.351	  0:57.484	                       	HalManager_dbus	Populating interface list
2009/07/25 15:37:51.352	  0:57.484	                       	HalManager_dbus	Populating full interface list failed - The name org.freedesktop.NetworkManager was not provided by any .service files
2009/07/25 15:37:51.352	  0:57.485	                       	Detecting V4L2 devices
2009/07/25 15:37:51.352	  0:57.485	                       	PV4L2Plugin	detected device metadata at /sys/class/video4linux/
2009/07/25 15:37:51.352	  0:57.485	                       	PV4L2Plugin	detected capture device 15704 webcam           
2009/07/25 15:37:51.441	  0:57.573	                       	PWLib	File handle high water mark set: 28 Thread unblock pipe
2009/07/25 15:37:51.441	  0:57.574	                       	PTLib	Thread high water mark set: 5
2009/07/25 15:37:51.442	  0:57.574	                       	OpalMan	Created manager.
2009/07/25 15:37:51.442	  0:57.574	                       	OpalMan	Registered endpoint with prefix pc
2009/07/25 15:37:51.442	  0:57.574	                       	OpalEP	Created endpoint: pc
2009/07/25 15:37:51.546	  0:57.678	                       	PCSS	Created PC sound system endpoint.
Players:
Default
EKIGA
HDA NVidia
*.wav
/dev/dsp
/dev/dsp1
Recorders:
Default
EKIGA
HDA NVidia
HDA NVidia (1)
*.wav
15704 webcam           
/dev/dsp
/dev/dsp1

2009/07/25 15:37:51.546	  0:57.678	                       	OPAL	SetMediaFormatOrder()
2009/07/25 15:37:51.546	  0:57.678	                       	OPAL	SetMediaFormatMask()
2009/07/25 15:37:51.547	  0:57.680	                       	OpalMan	Registered endpoint with prefix sip
2009/07/25 15:37:51.547	  0:57.680	                       	OpalEP	Created endpoint: sip
2009/07/25 15:37:51.547	  0:57.680	                       	PWLib	File handle high water mark set: 29 PUDPSocket
2009/07/25 15:37:51.548	  0:57.680	                       	IfaceMon	Initial interface list:
127.0.0.1 [00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:01] <00-00-00-00-00-00> (lo)
192.168.1.64 [fe:80:00:00:00:00:00:00:02:21:85:ff:fe:6c:ec:93] <00-21-85-6C-EC-93> (eth0)

2009/07/25 15:37:51.548	  0:57.680	                       	PWLib	File handle high water mark set: 30 Thread unblock pipe
2009/07/25 15:37:51.548	  0:57.680	                       	PTLib	Thread high water mark set: 6
2009/07/25 15:37:51.548	  0:57.681	                       	PWLib	File handle high water mark set: 32 Thread unblock pipe
2009/07/25 15:37:51.548	  0:57.681	                       	PTLib	Thread high water mark set: 7
2009/07/25 15:37:51.548	  0:57.681	                       	OpalMan	Registered endpoint with prefix sips
2009/07/25 15:37:51.548	  0:57.681	                       	SIP	Created endpoint.
2009/07/25 15:37:51.549	  0:57.681	Network In...0x17be6950	IfaceMon	Started interface monitor thread.
2009/07/25 15:37:51.549	  0:57.682	Network In...0x17be6950	PWLib	File handle high water mark set: 33 PUDPSocket
2009/07/25 15:37:51.550	  0:57.682	                       	MonSock	Created socket bundle for all interfaces.
2009/07/25 15:37:51.550	  0:57.682	                       	PWLib	File handle high water mark set: 34 PUDPSocket
2009/07/25 15:37:51.550	  0:57.682	                       	MonSock	Created bundled UDP socket 192.168.1.64:5060
2009/07/25 15:37:51.551	  0:57.684	                       	PWLib	File handle high water mark set: 36 Thread unblock pipe
2009/07/25 15:37:51.551	  0:57.684	                       	PTLib	Thread high water mark set: 8
2009/07/25 15:37:51.552	  0:57.684	                       	OpalMan	Added route "sip:.*=pc:*"
2009/07/25 15:37:51.552	  0:57.684	                       	OpalMan	Added route "pc:.*=sip:<da>"
2009/07/25 15:37:51.552	  0:57.685	Opal Liste...0x17b64950	Listen	Started listening thread on udp$*:5060
2009/07/25 15:37:51.553	  0:57.685	                       	OpalMan	Registered endpoint with prefix h323
2009/07/25 15:37:51.553	  0:57.685	                       	OpalEP	Created endpoint: h323
2009/07/25 15:37:51.553	  0:57.685	                       	OpalMan	Registered endpoint with prefix h323s
2009/07/25 15:37:51.553	  0:57.685	                       	H323	Created endpoint.
2009/07/25 15:37:51.553	  0:57.685	                       	PWLib	File handle high water mark set: 37 PTCPSocket
2009/07/25 15:37:51.553	  0:57.685	                       	PWLib	File handle high water mark set: 39 Thread unblock pipe
2009/07/25 15:37:51.553	  0:57.686	                       	PTLib	Thread high water mark set: 9
2009/07/25 15:37:51.553	  0:57.686	Opal Liste...0x17b23950	Listen	Started listening thread on tcp$*:1720
2009/07/25 15:37:51.553	  0:57.686	Opal Liste...0x17b23950	Listen	Waiting on socket accept on tcp$*:1720
2009/07/25 15:37:51.553	  0:57.686	                       	OpalMan	Added route "h323:.*=pc:<db>"
2009/07/25 15:37:51.553	  0:57.686	                       	OpalMan	Added route "pc:.*=h323:<da>"
2009/07/25 15:37:51.561	  0:57.693	                       	MediaFormat	Removing codecs SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,G.711-uLaw-64k,G.711-ALaw-64k,GSM-06.10,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,G.726-16k,G.726-24k,G.726-32k,G.726-40k,MS-GSM,CELT-48K,CELT-32K,G.722-64k,theora,H.261,H.261-CIF,H.261-QCIF
2009/07/25 15:37:51.561	  0:57.694	                       	OPAL	SetMediaFormatMask(PCM-16-48kHz,PCM-16-32kHz,PCM-16-16kHz,PCM-16,GSM-AMR,LPC-10,MS-IMA-ADPCM,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,YUV420P,RFC4175_YCbCr-4:2:0,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz)
2009/07/25 15:37:51.600	  0:57.733	                       	OPAL	SetMediaFormatOrder(SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,G.711-uLaw-64k,G.711-ALaw-64k,GSM-06.10,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,G.726-16k,G.726-24k,G.726-32k,G.726-40k,MS-GSM,CELT-48K,CELT-32K,G.722-64k,theora,H.261,H.261-CIF,H.261-QCIF)
2009/07/25 15:37:51.606	  0:57.739	                       	MediaFormat	Removing codecs SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,G.711-uLaw-64k,G.711-ALaw-64k,GSM-06.10,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,G.726-16k,G.726-24k,G.726-32k,G.726-40k,MS-GSM,CELT-48K,CELT-32K,G.722-64k,theora,H.261,H.261-CIF,H.261-QCIF
2009/07/25 15:37:51.607	  0:57.739	                       	OPAL	SetMediaFormatMask(PCM-16-48kHz,PCM-16-32kHz,PCM-16-16kHz,PCM-16,GSM-AMR,LPC-10,MS-IMA-ADPCM,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,YUV420P,RFC4175_YCbCr-4:2:0,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz)
2009/07/25 15:37:51.607	  0:57.739	                       	OPAL	SetMediaFormatOrder(SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,G.711-uLaw-64k,G.711-ALaw-64k,GSM-06.10,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,G.726-16k,G.726-24k,G.726-32k,G.726-40k,MS-GSM,CELT-48K,CELT-32K,G.722-64k,theora,H.261,H.261-CIF,H.261-QCIF)
2009/07/25 15:37:51.617	  0:57.750	                       	PWLib	File handle high water mark set: 41 Thread unblock pipe
2009/07/25 15:37:51.617	  0:57.750	                       	PTLib	Thread high water mark set: 10
2009/07/25 15:37:51.617	  0:57.750	  subscriber:0x17ae2950	SIP	Start REGISTER
        aor=mary.carroll at ekiga.net
  registrar=ekiga.net
    contact=
     authID=mary.carroll
      realm=
     expire=3600
    restore=30
   minRetry=0.000
   maxRetry=0.000
2009/07/25 15:37:51.618	  0:57.750	  subscriber:0x17ae2950	PWLib	File handle high water mark set: 42 PUDPSocket
2009/07/25 15:37:51.618	  0:57.751	  subscriber:0x17ae2950	SIP	Changing REGISTER handler from Unavailable to Subscribing, target=sip:mary.carroll at ekiga.net, id=78588066-9677-de11-8b72-0021856cec93 at dancer
2009/07/25 15:37:51.858	  0:57.990	  subscriber:0x17ae2950	OpalUDP	Binding to interface: 0.0.0.0:5060
2009/07/25 15:37:51.858	  0:57.991	  subscriber:0x17ae2950	PWLib	File handle high water mark set: 43 PUDPSocket
2009/07/25 15:37:51.858	  0:57.991	  subscriber:0x17ae2950	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2009/07/25 15:37:51.859	  0:57.991	  subscriber:0x17ae2950	OpalUDP	Started connect to 86.64.162.35:5060
2009/07/25 15:37:51.859	  0:57.991	  subscriber:0x17ae2950	OpalUDP	Writing to interface 0 - "192.168.1.64%eth0"
2009/07/25 15:37:51.861	  0:57.993	  subscriber:0x17ae2950	OpalMan	Listener interfaces: associated transport=udp$192.168.1.64:5060
    udp$192.168.1.64:5060
2009/07/25 15:37:51.861	  0:57.994	  subscriber:0x17ae2950	SIP	Transaction created.
2009/07/25 15:37:51.863	  0:57.996	  subscriber:0x17ae2950	DNS	SRV Lookup ekiga.net service _sip._udp
2009/07/25 15:37:52.090	  0:58.222	  subscriber:0x17ae2950	SIP	No SRV record found.
2009/07/25 15:37:52.097	  0:58.230	  subscriber:0x17ae2950	SIP	Transaction remote address is udp$ekiga.net:5060
2009/07/25 15:37:52.098	  0:58.230	  subscriber:0x17ae2950	SIP	Sending PDU (512 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.1.64:5060,if=192.168.1.64%eth0
REGISTER sip:ekiga.net SIP/2.0
CSeq: 1 REGISTER
Via: SIP/2.0/UDP 192.168.1.64:5060;branch=z9hG4bK08cba566-9677-de11-8b72-0021856cec93;rport
User-Agent: Ekiga/3.2.5
From: <sip:mary.carroll at ekiga.net>;tag=de6f8066-9677-de11-8b72-0021856cec93
Call-ID: 78588066-9677-de11-8b72-0021856cec93 at dancer
To: <sip:mary.carroll at ekiga.net>
Contact: <sip:mary.carroll at 192.168.1.64>;q=1
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 3600
Content-Length: 0
Max-Forwards: 70


2009/07/25 15:37:52.098	  0:58.231	  subscriber:0x17ae2950	OpalUDP	Setting interface to 192.168.1.64%eth0
2009/07/25 15:37:52.099	  0:58.231	  subscriber:0x17ae2950	SIP	Transaction timers set: retry=0.500, completion=6.000
2009/07/25 15:37:52.099	  0:58.231	  subscriber:0x17ae2950	PTLib	Destroyed thread 0xf9e1f0 subscriber:0x17ae2950(id = 7f5917ae2950)
2009/07/25 15:37:52.599	  0:58.731	 Housekeeper:0x17ba5950	SIP	REGISTER transaction id=z9hG4bK08cba566-9677-de11-8b72-0021856cec93 timeout, making retry 1, timeout 1.000
2009/07/25 15:37:52.600	  0:58.732	 Housekeeper:0x17ba5950	PWLib	File handle low water mark set: 40 PUDPSocket
2009/07/25 15:37:52.599	  0:58.732	 Housekeeper:0x17ba5950	SIP	Sending PDU (512 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.1.64:5060,if=192.168.1.64%eth0
REGISTER sip:ekiga.net SIP/2.0
CSeq: 1 REGISTER
Via: SIP/2.0/UDP 192.168.1.64:5060;branch=z9hG4bK08cba566-9677-de11-8b72-0021856cec93;rport
User-Agent: Ekiga/3.2.5
From: <sip:mary.carroll at ekiga.net>;tag=de6f8066-9677-de11-8b72-0021856cec93
Call-ID: 78588066-9677-de11-8b72-0021856cec93 at dancer
To: <sip:mary.carroll at ekiga.net>
Contact: <sip:mary.carroll at 192.168.1.64>;q=1
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 3600
Content-Length: 0
Max-Forwards: 70


2009/07/25 15:37:52.600	  0:58.732	 Housekeeper:0x17ba5950	OpalUDP	Setting interface to 192.168.1.64%eth0
2009/07/25 15:37:52.787	  0:58.920	Opal Liste...0x17b64950	OpalUDP	Binding to interface: 192.168.1.64:5060
2009/07/25 15:37:52.787	  0:58.920	Opal Liste...0x17b64950	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.1.64:5060>
2009/07/25 15:37:52.788	  0:58.921	Opal Liste...0x17b64950	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.1.64:5060,if=192.168.1.64%eth0
SIP/2.0 401 Unauthorized
CSeq: 1 REGISTER
Via: SIP/2.0/UDP 192.168.1.64:5060;branch=z9hG4bK08cba566-9677-de11-8b72-0021856cec93;rport=63256
Server: Kamailio (1.4.0-notls (i386/linux))
From: <sip:mary.carroll at ekiga.net>;tag=de6f8066-9677-de11-8b72-0021856cec93
Call-ID: 78588066-9677-de11-8b72-0021856cec93 at dancer
To: <sip:mary.carroll at ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.f3f0
Content-Length: 0
WWW-Authenticate: Digest realm="ekiga.net", nonce="4a6b19ec000007712d0cb9af6a3a74f082484d8a5967df23"


2009/07/25 15:37:52.789	  0:58.921	Opal Liste...0x17b64950	SIP	Queueing PDU "1 REGISTER <401>", transaction=z9hG4bK08cba566-9677-de11-8b72-0021856cec93, token=78588066-9677-de11-8b72-0021856cec93 at dancer
2009/07/25 15:37:52.789	  0:58.922	Opal Liste...0x17b64950	Opal	Transport clean up on termination
2009/07/25 15:37:52.789	  0:58.922	Opal Liste...0x17b64950	Opal	Transport Close
2009/07/25 15:37:52.789	  0:58.922	Opal Liste...0x17b64950	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.1.64:5060>
2009/07/25 15:37:52.790	  0:58.922	        Pool:0x17ae2950	SIP	Handling PDU "1 REGISTER <401>" for transaction=z9hG4bK08cba566-9677-de11-8b72-0021856cec93
2009/07/25 15:37:52.790	  0:58.922	        Pool:0x17ae2950	SIP	REGISTER transaction id=z9hG4bK08cba566-9677-de11-8b72-0021856cec93 completed.
2009/07/25 15:37:52.790	  0:58.922	        Pool:0x17ae2950	SIP	Received Authentication Required response
2009/07/25 15:37:52.790	  0:58.923	        Pool:0x17ae2950	SIP	Found auth info for realm ekiga.net
2009/07/25 15:37:52.790	  0:58.923	        Pool:0x17ae2950	OpalUDP	Setting interface to 192.168.1.64%eth0
2009/07/25 15:37:52.790	  0:58.923	        Pool:0x17ae2950	SIP	Changing REGISTER handler from Unavailable to Subscribing, target=sip:mary.carroll at ekiga.net, id=78588066-9677-de11-8b72-0021856cec93 at dancer
2009/07/25 15:37:52.792	  0:58.925	        Pool:0x17ae2950	OpalMan	Listener interfaces: associated transport=udp$192.168.1.64:5060
    udp$192.168.1.64:5060
2009/07/25 15:37:52.793	  0:58.925	        Pool:0x17ae2950	SIP	Transaction created.
2009/07/25 15:37:52.794	  0:58.927	        Pool:0x17ae2950	SIP	Adding authentication information
2009/07/25 15:37:52.795	  0:58.927	        Pool:0x17ae2950	DNS	SRV Lookup ekiga.net service _sip._udp
2009/07/25 15:37:52.975	  0:59.108	Opal Liste...0x17b64950	PWLib	File handle high water mark set: 45 PUDPSocket
2009/07/25 15:37:52.975	  0:59.108	Opal Liste...0x17b64950	OpalUDP	Binding to interface: 192.168.1.64:5060
2009/07/25 15:37:52.975	  0:59.108	Opal Liste...0x17b64950	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.1.64:5060>
2009/07/25 15:37:52.976	  0:59.109	Opal Liste...0x17b64950	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.1.64:5060,if=192.168.1.64%eth0
SIP/2.0 401 Unauthorized
CSeq: 1 REGISTER
Via: SIP/2.0/UDP 192.168.1.64:5060;branch=z9hG4bK08cba566-9677-de11-8b72-0021856cec93;rport=63256
Server: Kamailio (1.4.0-notls (i386/linux))
From: <sip:mary.carroll at ekiga.net>;tag=de6f8066-9677-de11-8b72-0021856cec93
Call-ID: 78588066-9677-de11-8b72-0021856cec93 at dancer
To: <sip:mary.carroll at ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.f3f0
Content-Length: 0
WWW-Authenticate: Digest realm="ekiga.net", nonce="4a6b19ec000007721ce796aa19db51dc51f32b5cec01cfa3"


2009/07/25 15:37:52.977	  0:59.109	Opal Liste...0x17b64950	SIP	Queueing PDU "1 REGISTER <401>", transaction=z9hG4bK08cba566-9677-de11-8b72-0021856cec93, token=78588066-9677-de11-8b72-0021856cec93 at dancer
2009/07/25 15:37:52.977	  0:59.109	Opal Liste...0x17b64950	ThreadPool	Allocated worker thread by group Id 78588066-9677-de11-8b72-0021856cec93 at dancer
2009/07/25 15:37:52.977	  0:59.109	Opal Liste...0x17b64950	Opal	Transport clean up on termination
2009/07/25 15:37:52.977	  0:59.109	Opal Liste...0x17b64950	Opal	Transport Close
2009/07/25 15:37:52.977	  0:59.109	Opal Liste...0x17b64950	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.1.64:5060>
2009/07/25 15:37:52.982	  0:59.114	        Pool:0x17ae2950	SIP	No SRV record found.
2009/07/25 15:37:52.982	  0:59.114	        Pool:0x17ae2950	SIP	Transaction remote address is udp$ekiga.net:5060
2009/07/25 15:37:52.982	  0:59.115	        Pool:0x17ae2950	PWLib	File handle low water mark set: 43 PUDPSocket
2009/07/25 15:37:52.982	  0:59.115	        Pool:0x17ae2950	SIP	Sending PDU (717 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.1.64:5060,if=192.168.1.64%eth0
REGISTER sip:ekiga.net SIP/2.0
CSeq: 2 REGISTER
Via: SIP/2.0/UDP 192.168.1.64:5060;branch=z9hG4bK0ee63367-9677-de11-8b72-0021856cec93;rport
User-Agent: Ekiga/3.2.5
Authorization: Digest username="mary.carroll", realm="ekiga.net", nonce="4a6b19ec000007712d0cb9af6a3a74f082484d8a5967df23", uri="sip:ekiga.net", algorithm=MD5, response="f8740425de3e8e0d5e1c0880356ced03"
From: <sip:mary.carroll at ekiga.net>;tag=de6f8066-9677-de11-8b72-0021856cec93
Call-ID: 78588066-9677-de11-8b72-0021856cec93 at dancer
To: <sip:mary.carroll at ekiga.net>
Contact: <sip:mary.carroll at 192.168.1.64>;q=1
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 3600
Content-Length: 0
Max-Forwards: 70


2009/07/25 15:37:52.983	  0:59.115	        Pool:0x17ae2950	OpalUDP	Setting interface to 192.168.1.64%eth0
2009/07/25 15:37:52.983	  0:59.115	        Pool:0x17ae2950	SIP	Transaction timers set: retry=0.500, completion=6.000
2009/07/25 15:37:52.983	  0:59.115	        Pool:0x17ae2950	SIP	Handled PDU "1 REGISTER <401>"
2009/07/25 15:37:52.983	  0:59.116	        Pool:0x17ae2950	SIP	Handling PDU "1 REGISTER <401>" for transaction=z9hG4bK08cba566-9677-de11-8b72-0021856cec93
2009/07/25 15:37:52.983	  0:59.116	        Pool:0x17ae2950	SIP	Handled PDU "1 REGISTER <401>"
2009/07/25 15:37:53.087	  0:59.220	                       	SIP	Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:500 at ekiga.net, id=18916067-9677-de11-8b72-0021856cec93 at dancer
2009/07/25 15:37:53.087	  0:59.220	                       	OpalUDP	Binding to interface: 0.0.0.0:5060
2009/07/25 15:37:53.088	  0:59.220	                       	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2009/07/25 15:37:53.088	  0:59.221	                       	OpalUDP	Started connect to 86.64.162.35:5060
2009/07/25 15:37:53.088	  0:59.221	                       	OpalUDP	Writing to interface 0 - "192.168.1.64%eth0"
2009/07/25 15:37:53.089	  0:59.221	                       	SIP	Transaction created.
2009/07/25 15:37:53.091	  0:59.224	                       	DNS	SRV Lookup ekiga.net service _sip._udp
2009/07/25 15:37:53.314	  0:59.447	                       	SIP	No SRV record found.
2009/07/25 15:37:53.314	  0:59.447	                       	SIP	Transaction remote address is udp$ekiga.net:5060
2009/07/25 15:37:53.315	  0:59.447	                       	SIP	Sending PDU (566 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.1.64:5060,if=192.168.1.64%eth0
SUBSCRIBE sip:500 at ekiga.net SIP/2.0
CSeq: 1 SUBSCRIBE
Via: SIP/2.0/UDP 192.168.1.64:5060;branch=z9hG4bKfe046167-9677-de11-8b72-0021856cec93;rport
User-Agent: Ekiga/3.2.5
From: "Mary Carroll" <sip:mary.carroll at ekiga.net>;tag=eccb6067-9677-de11-8b72-0021856cec93
Call-ID: 18916067-9677-de11-8b72-0021856cec93 at dancer
To: <sip:500 at ekiga.net>
Contact: <sip:mary.carroll at 192.168.1.64>
Accept: application/pidf+xml
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 300
Event: presence
Content-Length: 0
Max-Forwards: 70


2009/07/25 15:37:53.315	  0:59.448	                       	OpalUDP	Setting interface to 192.168.1.64%eth0
2009/07/25 15:37:53.315	  0:59.448	                       	SIP	Transaction timers set: retry=0.500, completion=6.000
2009/07/25 15:37:53.316	  0:59.448	                       	SIP	Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:500 at ekiga.net, id=42768367-9677-de11-8b72-0021856cec93 at dancer
2009/07/25 15:37:53.316	  0:59.449	                       	OpalUDP	Binding to interface: 0.0.0.0:5060
2009/07/25 15:37:53.316	  0:59.449	                       	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2009/07/25 15:37:53.317	  0:59.449	                       	OpalUDP	Started connect to 86.64.162.35:5060
2009/07/25 15:37:53.317	  0:59.449	                       	OpalUDP	Writing to interface 0 - "192.168.1.64%eth0"
2009/07/25 15:37:53.317	  0:59.450	                       	SIP	Transaction created.
2009/07/25 15:37:53.321	  0:59.453	                       	DNS	SRV Lookup ekiga.net service _sip._udp
2009/07/25 15:37:53.483	  0:59.616	 Housekeeper:0x17ba5950	SIP	REGISTER transaction id=z9hG4bK0ee63367-9677-de11-8b72-0021856cec93 timeout, making retry 1, timeout 1.000
2009/07/25 15:37:53.484	  0:59.616	 Housekeeper:0x17ba5950	SIP	Sending PDU (717 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.1.64:5060,if=192.168.1.64%eth0
REGISTER sip:ekiga.net SIP/2.0
CSeq: 2 REGISTER
Via: SIP/2.0/UDP 192.168.1.64:5060;branch=z9hG4bK0ee63367-9677-de11-8b72-0021856cec93;rport
User-Agent: Ekiga/3.2.5
Authorization: Digest username="mary.carroll", realm="ekiga.net", nonce="4a6b19ec000007712d0cb9af6a3a74f082484d8a5967df23", uri="sip:ekiga.net", algorithm=MD5, response="f8740425de3e8e0d5e1c0880356ced03"
From: <sip:mary.carroll at ekiga.net>;tag=de6f8066-9677-de11-8b72-0021856cec93
Call-ID: 78588066-9677-de11-8b72-0021856cec93 at dancer
To: <sip:mary.carroll at ekiga.net>
Contact: <sip:mary.carroll at 192.168.1.64>;q=1
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 3600
Content-Length: 0
Max-Forwards: 70


2009/07/25 15:37:53.484	  0:59.617	 Housekeeper:0x17ba5950	OpalUDP	Setting interface to 192.168.1.64%eth0
2009/07/25 15:37:53.522	  0:59.654	                       	SIP	No SRV record found.
2009/07/25 15:37:53.522	  0:59.654	                       	SIP	Transaction remote address is udp$ekiga.net:5060
2009/07/25 15:37:53.522	  0:59.655	                       	SIP	Sending PDU (569 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.1.64:5060,if=192.168.1.64%eth0
SUBSCRIBE sip:500 at ekiga.net SIP/2.0
CSeq: 1 SUBSCRIBE
Via: SIP/2.0/UDP 192.168.1.64:5060;branch=z9hG4bK50f48367-9677-de11-8b72-0021856cec93;rport
User-Agent: Ekiga/3.2.5
From: "Mary Carroll" <sip:mary.carroll at ekiga.net>;tag=4eb08367-9677-de11-8b72-0021856cec93
Call-ID: 42768367-9677-de11-8b72-0021856cec93 at dancer
To: <sip:500 at ekiga.net>
Contact: <sip:500 at 192.168.1.64>
Accept: application/dialog-info+xml
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 300
Event: dialog;sla;ma
Content-Length: 0
Max-Forwards: 70


2009/07/25 15:37:53.523	  0:59.655	                       	OpalUDP	Setting interface to 192.168.1.64%eth0
2009/07/25 15:37:53.523	  0:59.655	                       	SIP	Transaction timers set: retry=0.500, completion=6.000
2009/07/25 15:37:53.523	  0:59.656	                       	SIP	Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:501 at ekiga.net, id=6623a367-9677-de11-8b72-0021856cec93 at dancer
2009/07/25 15:37:53.524	  0:59.656	                       	OpalUDP	Binding to interface: 0.0.0.0:5060
2009/07/25 15:37:53.524	  0:59.656	                       	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2009/07/25 15:37:53.524	  0:59.657	                       	OpalUDP	Started connect to 86.64.162.35:5060
2009/07/25 15:37:53.524	  0:59.657	                       	OpalUDP	Writing to interface 0 - "192.168.1.64%eth0"
2009/07/25 15:37:53.525	  0:59.657	                       	SIP	Transaction created.
2009/07/25 15:37:53.528	  0:59.660	                       	DNS	SRV Lookup ekiga.net service _sip._udp
2009/07/25 15:37:53.543	  0:59.676	Opal Liste...0x17b64950	OpalUDP	Binding to interface: 192.168.1.64:5060
2009/07/25 15:37:53.543	  0:59.676	Opal Liste...0x17b64950	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.1.64:5060>
2009/07/25 15:37:53.544	  0:59.677	Opal Liste...0x17b64950	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.1.64:5060,if=192.168.1.64%eth0
SIP/2.0 200 OK
CSeq: 2 REGISTER
Via: SIP/2.0/UDP 192.168.1.64:5060;branch=z9hG4bK0ee63367-9677-de11-8b72-0021856cec93;rport=63256
Server: Kamailio (1.4.0-notls (i386/linux))
From: <sip:mary.carroll at ekiga.net>;tag=de6f8066-9677-de11-8b72-0021856cec93
Call-ID: 78588066-9677-de11-8b72-0021856cec93 at dancer
To: <sip:mary.carroll at ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.a566
Contact: <sip:mary.carroll at 192.168.1.64:5060>;q=1;expires=1200
Content-Length: 0


2009/07/25 15:37:53.545	  0:59.677	Opal Liste...0x17b64950	SIP	Queueing PDU "2 REGISTER <200>", transaction=z9hG4bK0ee63367-9677-de11-8b72-0021856cec93, token=78588066-9677-de11-8b72-0021856cec93 at dancer
2009/07/25 15:37:53.545	  0:59.677	Opal Liste...0x17b64950	Opal	Transport clean up on termination
2009/07/25 15:37:53.545	  0:59.677	Opal Liste...0x17b64950	Opal	Transport Close
2009/07/25 15:37:53.545	  0:59.677	Opal Liste...0x17b64950	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.1.64:5060>
2009/07/25 15:37:53.545	  0:59.678	        Pool:0x17ae2950	SIP	Handling PDU "2 REGISTER <200>" for transaction=z9hG4bK0ee63367-9677-de11-8b72-0021856cec93
2009/07/25 15:37:53.546	  0:59.678	        Pool:0x17ae2950	SIP	REGISTER transaction id=z9hG4bK0ee63367-9677-de11-8b72-0021856cec93 completed.
2009/07/25 15:37:53.546	  0:59.678	        Pool:0x17ae2950	SIP	Product Info: name="Kamailio", version="", vendor="", comments="(1.4.0-notls (i386/linux))"
2009/07/25 15:37:53.546	  0:59.678	        Pool:0x17ae2950	SIP	Changing REGISTER handler from Subscribing to Subscribed, target=sip:mary.carroll at ekiga.net, id=78588066-9677-de11-8b72-0021856cec93 at dancer
2009/07/25 15:37:53.546	  0:59.678	        Pool:0x17ae2950	OpalUDP	Setting interface to 192.168.1.64%eth0
2009/07/25 15:37:53.546	  0:59.679	        Pool:0x17ae2950	SIP	Product Info: name="Kamailio", version="", vendor="", comments="(1.4.0-notls (i386/linux))"
2009/07/25 15:37:53.722	  0:59.854	                       	SIP	No SRV record found.
2009/07/25 15:37:53.722	  0:59.854	                       	SIP	Transaction remote address is udp$ekiga.net:5060
2009/07/25 15:37:53.722	  0:59.855	                       	SIP	Sending PDU (566 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.1.64:5060,if=192.168.1.64%eth0
SUBSCRIBE sip:501 at ekiga.net SIP/2.0
CSeq: 1 SUBSCRIBE
Via: SIP/2.0/UDP 192.168.1.64:5060;branch=z9hG4bKa291a367-9677-de11-8b72-0021856cec93;rport
User-Agent: Ekiga/3.2.5
From: "Mary Carroll" <sip:mary.carroll at ekiga.net>;tag=2a5aa367-9677-de11-8b72-0021856cec93
Call-ID: 6623a367-9677-de11-8b72-0021856cec93 at dancer
To: <sip:501 at ekiga.net>
Contact: <sip:mary.carroll at 192.168.1.64>
Accept: application/pidf+xml
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 300
Event: presence
Content-Length: 0
Max-Forwards: 70


2009/07/25 15:37:53.723	  0:59.855	                       	OpalUDP	Setting interface to 192.168.1.64%eth0
2009/07/25 15:37:53.723	  0:59.855	                       	SIP	Transaction timers set: retry=0.500, completion=6.000
2009/07/25 15:37:53.723	  0:59.856	                       	SIP	Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:501 at ekiga.net, id=1ca9c167-9677-de11-8b72-0021856cec93 at dancer
2009/07/25 15:37:53.724	  0:59.856	                       	OpalUDP	Binding to interface: 0.0.0.0:5060
2009/07/25 15:37:53.724	  0:59.856	                       	SIP	Created transport udp$86.64.162.35:5060<if=udp$*:5060>
2009/07/25 15:37:53.724	  0:59.857	                       	OpalUDP	Started connect to 86.64.162.35:5060
2009/07/25 15:37:53.725	  0:59.857	                       	OpalUDP	Writing to interface 0 - "192.168.1.64%eth0"
2009/07/25 15:37:53.816	  0:59.949	 Housekeeper:0x17ba5950	SIP	SUBSCRIBE transaction id=z9hG4bKfe046167-9677-de11-8b72-0021856cec93 timeout, making retry 1, timeout 1.000
2009/07/25 15:37:53.816	  0:59.949	 Housekeeper:0x17ba5950	SIP	Sending PDU (566 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.1.64:5060,if=192.168.1.64%eth0
SUBSCRIBE sip:500 at ekiga.net SIP/2.0
CSeq: 1 SUBSCRIBE
Via: SIP/2.0/UDP 192.168.1.64:5060;branch=z9hG4bKfe046167-9677-de11-8b72-0021856cec93;rport
User-Agent: Ekiga/3.2.5
From: "Mary Carroll" <sip:mary.carroll at ekiga.net>;tag=eccb6067-9677-de11-8b72-0021856cec93
Call-ID: 18916067-9677-de11-8b72-0021856cec93 at dancer
To: <sip:500 at ekiga.net>
Contact: <sip:mary.carroll at 192.168.1.64>
Accept: application/pidf+xml
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 300
Event: presence
Content-Length: 0
Max-Forwards: 70


2009/07/25 15:37:53.817	  0:59.950	 Housekeeper:0x17ba5950	OpalUDP	Setting interface to 192.168.1.64%eth0
2009/07/25 15:37:53.963	  1:00.095	Opal Liste...0x17b64950	OpalUDP	Binding to interface: 192.168.1.64:5060
2009/07/25 15:37:53.963	  1:00.095	Opal Liste...0x17b64950	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.1.64:5060>
2009/07/25 15:37:53.964	  1:00.096	Opal Liste...0x17b64950	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.1.64:5060,if=192.168.1.64%eth0
SIP/2.0 489 Event Not Supported
CSeq: 1 SUBSCRIBE
Via: SIP/2.0/UDP 192.168.1.64:5060;branch=z9hG4bKfe046167-9677-de11-8b72-0021856cec93;rport=63256
Server: Kamailio (1.4.0-notls (i386/linux))
From: "Mary Carroll" <sip:mary.carroll at ekiga.net>;tag=eccb6067-9677-de11-8b72-0021856cec93
Call-ID: 18916067-9677-de11-8b72-0021856cec93 at dancer
To: <sip:500 at ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.6bf1
Content-Length: 0


2009/07/25 15:37:53.964	  1:00.097	Opal Liste...0x17b64950	SIP	Queueing PDU "1 SUBSCRIBE <489>", transaction=z9hG4bKfe046167-9677-de11-8b72-0021856cec93, token=18916067-9677-de11-8b72-0021856cec93 at dancer
2009/07/25 15:37:53.964	  1:00.097	Opal Liste...0x17b64950	PTLib	Thread high water mark set: 11
2009/07/25 15:37:53.964	  1:00.097	Opal Liste...0x17b64950	Opal	Transport clean up on termination
2009/07/25 15:37:53.964	  1:00.097	Opal Liste...0x17b64950	Opal	Transport Close
2009/07/25 15:37:53.965	  1:00.097	Opal Liste...0x17b64950	PWLib	File handle high water mark set: 46 PUDPSocket
2009/07/25 15:37:53.965	  1:00.097	Opal Liste...0x17b64950	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.1.64:5060>
2009/07/25 15:37:53.965	  1:00.098	        Pool:0x16134950	SIP	Handling PDU "1 SUBSCRIBE <489>" for transaction=z9hG4bKfe046167-9677-de11-8b72-0021856cec93
2009/07/25 15:37:53.965	  1:00.098	        Pool:0x16134950	SIP	SUBSCRIBE transaction id=z9hG4bKfe046167-9677-de11-8b72-0021856cec93 completed.
2009/07/25 15:37:53.965	  1:00.098	        Pool:0x16134950	SIP	Not retrying SUBSCRIBE due to error response 489 Bad Event
2009/07/25 15:37:53.965	  1:00.098	        Pool:0x16134950	SIP	Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:500 at ekiga.net, id=18916067-9677-de11-8b72-0021856cec93 at dancer
2009/07/25 15:37:53.965	  1:00.098	        Pool:0x16134950	SIP	SUBSCRIBE transaction id=z9hG4bKfe046167-9677-de11-8b72-0021856cec93 aborted.
2009/07/25 15:37:53.965	  1:00.098	        Pool:0x16134950	SIP	Handled PDU "1 SUBSCRIBE <489>"
2009/07/25 15:37:53.984	  1:00.116	 Housekeeper:0x17ba5950	SIP	Set state Terminated_Success for REGISTER transaction id=z9hG4bK08cba566-9677-de11-8b72-0021856cec93
2009/07/25 15:37:54.023	  1:00.155	 Housekeeper:0x17ba5950	SIP	SUBSCRIBE transaction id=z9hG4bK50f48367-9677-de11-8b72-0021856cec93 timeout, making retry 1, timeout 1.000
2009/07/25 15:37:54.023	  1:00.156	 Housekeeper:0x17ba5950	SIP	Sending PDU (569 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.1.64:5060,if=192.168.1.64%eth0
SUBSCRIBE sip:500 at ekiga.net SIP/2.0
CSeq: 1 SUBSCRIBE
Via: SIP/2.0/UDP 192.168.1.64:5060;branch=z9hG4bK50f48367-9677-de11-8b72-0021856cec93;rport
User-Agent: Ekiga/3.2.5
From: "Mary Carroll" <sip:mary.carroll at ekiga.net>;tag=4eb08367-9677-de11-8b72-0021856cec93
Call-ID: 42768367-9677-de11-8b72-0021856cec93 at dancer
To: <sip:500 at ekiga.net>
Contact: <sip:500 at 192.168.1.64>
Accept: application/dialog-info+xml
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 300
Event: dialog;sla;ma
Content-Length: 0
Max-Forwards: 70


2009/07/25 15:37:54.024	  1:00.156	 Housekeeper:0x17ba5950	OpalUDP	Setting interface to 192.168.1.64%eth0
2009/07/25 15:37:54.224	  1:00.356	 Housekeeper:0x17ba5950	SIP	SUBSCRIBE transaction id=z9hG4bKa291a367-9677-de11-8b72-0021856cec93 timeout, making retry 1, timeout 1.000
2009/07/25 15:37:54.224	  1:00.357	 Housekeeper:0x17ba5950	SIP	Sending PDU (566 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.1.64:5060,if=192.168.1.64%eth0
SUBSCRIBE sip:501 at ekiga.net SIP/2.0
CSeq: 1 SUBSCRIBE
Via: SIP/2.0/UDP 192.168.1.64:5060;branch=z9hG4bKa291a367-9677-de11-8b72-0021856cec93;rport
User-Agent: Ekiga/3.2.5
From: "Mary Carroll" <sip:mary.carroll at ekiga.net>;tag=2a5aa367-9677-de11-8b72-0021856cec93
Call-ID: 6623a367-9677-de11-8b72-0021856cec93 at dancer
To: <sip:501 at ekiga.net>
Contact: <sip:mary.carroll at 192.168.1.64>
Accept: application/pidf+xml
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 300
Event: presence
Content-Length: 0
Max-Forwards: 70


2009/07/25 15:37:54.225	  1:00.357	 Housekeeper:0x17ba5950	OpalUDP	Setting interface to 192.168.1.64%eth0
2009/07/25 15:37:54.279	  1:00.412	Opal Liste...0x17b64950	OpalUDP	Binding to interface: 192.168.1.64:5060
2009/07/25 15:37:54.279	  1:00.412	Opal Liste...0x17b64950	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.1.64:5060>
2009/07/25 15:37:54.280	  1:00.412	Opal Liste...0x17b64950	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.1.64:5060,if=192.168.1.64%eth0
SIP/2.0 200 OK
CSeq: 2 REGISTER
Via: SIP/2.0/UDP 192.168.1.64:5060;branch=z9hG4bK0ee63367-9677-de11-8b72-0021856cec93;rport=63256
Server: Kamailio (1.4.0-notls (i386/linux))
From: <sip:mary.carroll at ekiga.net>;tag=de6f8066-9677-de11-8b72-0021856cec93
Call-ID: 78588066-9677-de11-8b72-0021856cec93 at dancer
To: <sip:mary.carroll at ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.a566
Contact: <sip:mary.carroll at 192.168.1.64:5060>;q=1;expires=1200
Content-Length: 0


2009/07/25 15:37:54.281	  1:00.413	Opal Liste...0x17b64950	SIP	Queueing PDU "2 REGISTER <200>", transaction=z9hG4bK0ee63367-9677-de11-8b72-0021856cec93, token=78588066-9677-de11-8b72-0021856cec93 at dancer
2009/07/25 15:37:54.281	  1:00.413	Opal Liste...0x17b64950	ThreadPool	Allocated worker thread by group Id 78588066-9677-de11-8b72-0021856cec93 at dancer
2009/07/25 15:37:54.281	  1:00.413	Opal Liste...0x17b64950	Opal	Transport clean up on termination
2009/07/25 15:37:54.281	  1:00.413	Opal Liste...0x17b64950	Opal	Transport Close
2009/07/25 15:37:54.281	  1:00.413	Opal Liste...0x17b64950	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.1.64:5060>
2009/07/25 15:37:54.547	  1:00.679	Opal Liste...0x17b64950	OpalUDP	Binding to interface: 192.168.1.64:5060
2009/07/25 15:37:54.547	  1:00.679	Opal Liste...0x17b64950	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.1.64:5060>
2009/07/25 15:37:54.548	  1:00.680	Opal Liste...0x17b64950	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.1.64:5060,if=192.168.1.64%eth0
SIP/2.0 489 Event Not Supported
CSeq: 1 SUBSCRIBE
Via: SIP/2.0/UDP 192.168.1.64:5060;branch=z9hG4bKa291a367-9677-de11-8b72-0021856cec93;rport=63256
Server: Kamailio (1.4.0-notls (i386/linux))
From: "Mary Carroll" <sip:mary.carroll at ekiga.net>;tag=2a5aa367-9677-de11-8b72-0021856cec93
Call-ID: 6623a367-9677-de11-8b72-0021856cec93 at dancer
To: <sip:501 at ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.193d
Content-Length: 0


2009/07/25 15:37:54.548	  1:00.681	Opal Liste...0x17b64950	SIP	Queueing PDU "1 SUBSCRIBE <489>", transaction=z9hG4bKa291a367-9677-de11-8b72-0021856cec93, token=6623a367-9677-de11-8b72-0021856cec93 at dancer
2009/07/25 15:37:54.548	  1:00.681	        Pool:0x16134950	SIP	Handling PDU "1 SUBSCRIBE <489>" for transaction=z9hG4bKa291a367-9677-de11-8b72-0021856cec93
2009/07/25 15:37:54.548	  1:00.681	        Pool:0x16134950	SIP	SUBSCRIBE transaction id=z9hG4bKa291a367-9677-de11-8b72-0021856cec93 completed.
2009/07/25 15:37:54.548	  1:00.681	        Pool:0x16134950	SIP	Not retrying SUBSCRIBE due to error response 489 Bad Event
2009/07/25 15:37:54.549	  1:00.681	        Pool:0x16134950	SIP	Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:501 at ekiga.net, id=6623a367-9677-de11-8b72-0021856cec93 at dancer
2009/07/25 15:37:54.549	  1:00.681	        Pool:0x16134950	SIP	SUBSCRIBE transaction id=z9hG4bKa291a367-9677-de11-8b72-0021856cec93 aborted.
2009/07/25 15:37:54.549	  1:00.681	        Pool:0x16134950	SIP	Handled PDU "1 SUBSCRIBE <489>"
2009/07/25 15:37:54.549	  1:00.681	Opal Liste...0x17b64950	Opal	Transport clean up on termination
2009/07/25 15:37:54.549	  1:00.681	Opal Liste...0x17b64950	Opal	Transport Close
2009/07/25 15:37:54.549	  1:00.681	Opal Liste...0x17b64950	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.1.64:5060>
2009/07/25 15:37:54.643	  1:00.775	Opal Liste...0x17b64950	OpalUDP	Binding to interface: 192.168.1.64:5060
2009/07/25 15:37:54.643	  1:00.775	Opal Liste...0x17b64950	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.1.64:5060>
2009/07/25 15:37:54.643	  1:00.776	Opal Liste...0x17b64950	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.1.64:5060,if=192.168.1.64%eth0
SIP/2.0 489 Event Not Supported
CSeq: 1 SUBSCRIBE
Via: SIP/2.0/UDP 192.168.1.64:5060;branch=z9hG4bKfe046167-9677-de11-8b72-0021856cec93;rport=63256
Server: Kamailio (1.4.0-notls (i386/linux))
From: "Mary Carroll" <sip:mary.carroll at ekiga.net>;tag=eccb6067-9677-de11-8b72-0021856cec93
Call-ID: 18916067-9677-de11-8b72-0021856cec93 at dancer
To: <sip:500 at ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.6bf1
Content-Length: 0


2009/07/25 15:37:54.644	  1:00.777	Opal Liste...0x17b64950	SIP	Queueing PDU "1 SUBSCRIBE <489>", transaction=z9hG4bKfe046167-9677-de11-8b72-0021856cec93, token=18916067-9677-de11-8b72-0021856cec93 at dancer
2009/07/25 15:37:54.644	  1:00.777	        Pool:0x16134950	SIP	Handling PDU "1 SUBSCRIBE <489>" for transaction=z9hG4bKfe046167-9677-de11-8b72-0021856cec93
2009/07/25 15:37:54.644	  1:00.777	        Pool:0x16134950	SIP	Handled PDU "1 SUBSCRIBE <489>"
2009/07/25 15:37:54.644	  1:00.777	Opal Liste...0x17b64950	Opal	Transport clean up on termination
2009/07/25 15:37:54.644	  1:00.777	Opal Liste...0x17b64950	Opal	Transport Close
2009/07/25 15:37:54.644	  1:00.777	Opal Liste...0x17b64950	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.1.64:5060>
2009/07/25 15:37:54.983	  1:01.115	Opal Liste...0x17b64950	OpalUDP	Binding to interface: 192.168.1.64:5060
2009/07/25 15:37:54.983	  1:01.115	Opal Liste...0x17b64950	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.1.64:5060>
2009/07/25 15:37:54.984	  1:01.116	Opal Liste...0x17b64950	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.1.64:5060,if=192.168.1.64%eth0
SIP/2.0 489 Event Not Supported
CSeq: 1 SUBSCRIBE
Via: SIP/2.0/UDP 192.168.1.64:5060;branch=z9hG4bKa291a367-9677-de11-8b72-0021856cec93;rport=63256
Server: Kamailio (1.4.0-notls (i386/linux))
From: "Mary Carroll" <sip:mary.carroll at ekiga.net>;tag=2a5aa367-9677-de11-8b72-0021856cec93
Call-ID: 6623a367-9677-de11-8b72-0021856cec93 at dancer
To: <sip:501 at ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.193d
Content-Length: 0


2009/07/25 15:37:54.984	  1:01.117	Opal Liste...0x17b64950	SIP	Queueing PDU "1 SUBSCRIBE <489>", transaction=z9hG4bKa291a367-9677-de11-8b72-0021856cec93, token=6623a367-9677-de11-8b72-0021856cec93 at dancer
2009/07/25 15:37:54.984	  1:01.117	        Pool:0x16134950	SIP	Handling PDU "1 SUBSCRIBE <489>" for transaction=z9hG4bKa291a367-9677-de11-8b72-0021856cec93
2009/07/25 15:37:54.984	  1:01.117	        Pool:0x16134950	SIP	Handled PDU "1 SUBSCRIBE <489>"
2009/07/25 15:37:54.984	  1:01.117	Opal Liste...0x17b64950	Opal	Transport clean up on termination
2009/07/25 15:37:54.984	  1:01.117	Opal Liste...0x17b64950	Opal	Transport Close
2009/07/25 15:37:54.985	  1:01.117	Opal Liste...0x17b64950	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.1.64:5060>
2009/07/25 15:37:55.023	  1:01.155	 Housekeeper:0x17ba5950	SIP	SUBSCRIBE transaction id=z9hG4bK50f48367-9677-de11-8b72-0021856cec93 timeout, making retry 2, timeout 2.000
2009/07/25 15:37:55.023	  1:01.155	 Housekeeper:0x17ba5950	SIP	Sending PDU (569 bytes) to: rem=udp$86.64.162.35:5060,local=udp$192.168.1.64:5060,if=192.168.1.64%eth0
SUBSCRIBE sip:500 at ekiga.net SIP/2.0
CSeq: 1 SUBSCRIBE
Via: SIP/2.0/UDP 192.168.1.64:5060;branch=z9hG4bK50f48367-9677-de11-8b72-0021856cec93;rport
User-Agent: Ekiga/3.2.5
From: "Mary Carroll" <sip:mary.carroll at ekiga.net>;tag=4eb08367-9677-de11-8b72-0021856cec93
Call-ID: 42768367-9677-de11-8b72-0021856cec93 at dancer
To: <sip:500 at ekiga.net>
Contact: <sip:500 at 192.168.1.64>
Accept: application/dialog-info+xml
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 300
Event: dialog;sla;ma
Content-Length: 0
Max-Forwards: 70


2009/07/25 15:37:55.023	  1:01.156	 Housekeeper:0x17ba5950	OpalUDP	Setting interface to 192.168.1.64%eth0
2009/07/25 15:37:55.645	  1:01.778	 Housekeeper:0x17ba5950	SIP	Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bKfe046167-9677-de11-8b72-0021856cec93
2009/07/25 15:37:55.815	  1:01.948	Opal Liste...0x17b64950	OpalUDP	Binding to interface: 192.168.1.64:5060
2009/07/25 15:37:55.815	  1:01.948	Opal Liste...0x17b64950	SIP	Waiting for PDU on udp$86.64.162.35:5060<if=udp$192.168.1.64:5060>
2009/07/25 15:37:55.816	  1:01.949	Opal Liste...0x17b64950	SIP	PDU received: rem=udp$86.64.162.35:5060,local=udp$192.168.1.64:5060,if=192.168.1.64%eth0
SIP/2.0 489 Event Not Supported
CSeq: 1 SUBSCRIBE
Via: SIP/2.0/UDP 192.168.1.64:5060;branch=z9hG4bK50f48367-9677-de11-8b72-0021856cec93;rport=63256
Server: Kamailio (1.4.0-notls (i386/linux))
From: "Mary Carroll" <sip:mary.carroll at ekiga.net>;tag=4eb08367-9677-de11-8b72-0021856cec93
Call-ID: 42768367-9677-de11-8b72-0021856cec93 at dancer
To: <sip:500 at ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.11f9
Content-Length: 0


2009/07/25 15:37:55.817	  1:01.949	Opal Liste...0x17b64950	SIP	Queueing PDU "1 SUBSCRIBE <489>", transaction=z9hG4bK50f48367-9677-de11-8b72-0021856cec93, token=42768367-9677-de11-8b72-0021856cec93 at dancer
2009/07/25 15:37:55.817	  1:01.949	        Pool:0x16134950	SIP	Handling PDU "1 SUBSCRIBE <489>" for transaction=z9hG4bK50f48367-9677-de11-8b72-0021856cec93
2009/07/25 15:37:55.817	  1:01.949	        Pool:0x16134950	SIP	SUBSCRIBE transaction id=z9hG4bK50f48367-9677-de11-8b72-0021856cec93 completed.
2009/07/25 15:37:55.817	  1:01.949	        Pool:0x16134950	SIP	Not retrying SUBSCRIBE due to error response 489 Bad Event
2009/07/25 15:37:55.817	  1:01.950	        Pool:0x16134950	SIP	Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:500 at ekiga.net, id=42768367-9677-de11-8b72-0021856cec93 at dancer
2009/07/25 15:37:55.817	  1:01.950	        Pool:0x16134950	SIP	SUBSCRIBE transaction id=z9hG4bK50f48367-9677-de11-8b72-0021856cec93 aborted.
2009/07/25 15:37:55.817	  1:01.950	        Pool:0x16134950	SIP	Handled PDU "1 SUBSCRIBE <489>"
2009/07/25 15:37:55.817	  1:01.950	Opal Liste...0x17b64950	Opal	Transport clean up on termination
2009/07/25 15:37:55.817	  1:01.950	Opal Liste...0x17b64950	Opal	Transport Close
2009/07/25 15:37:55.817	  1:01.950	Opal Liste...0x17b64950	Opal	Deleted transport udp$86.64.162.35:5060<if=udp$192.168.1.64:5060>
2009/07/25 15:37:55.984	  1:02.117	 Housekeeper:0x17ba5950	SIP	Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bKa291a367-9677-de11-8b72-0021856cec93
2009/07/25 15:37:56.817	  1:02.950	 Housekeeper:0x17ba5950	SIP	Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bK50f48367-9677-de11-8b72-0021856cec93






More information about the pkg-gnome-maintainers mailing list