I am having problems getting Ekiga to register with a sipXecs server.
The problem looks to me to be with DNS lookups. The debug log shows the
SRV lookup followed by failed A record lookups for the sipXecs server
name (as supplied by the SRV RR) and 0.0.0.0.
However, watching the network traffic with Wireshark only shows the SRV
lookup and response. The A record lookups don't seem to be happening.
I am running Ekiga 3.2.6 on Fedora 12 x86_64.
The debug log is attached. I can supply the wireshark capture if
required.
Thanks
Mike
2010/04/12 09:19:30.108 0:00.032 Version
3.2.6 by on Unix Linux (2.6.32.10-90.fc12.x86_64-x86_64) with PTLib (v2.6.5)
at 2010/4/12 9:19:30.108
2010/04/12 09:19:30.108 0:00.033 Ekiga git
revision: unknown
2010/04/12 09:19:30.109 0:00.034 Ekiga
registered on D-Bus: org.ekiga.Ekiga
2010/04/12 09:19:30.110 0:00.034 PWLib File
handle high water mark set: 17 Thread unblock pipe
2010/04/12 09:19:30.110 0:00.034 PTLib Thread
high water mark set: 2
2010/04/12 09:19:30.110 0:00.035 PWLib File
handle high water mark set: 19 Thread unblock pipe
2010/04/12 09:19:30.110 0:00.035 PTLib Thread
high water mark set: 3
2010/04/12 09:19:30.110 0:00.035 PWLib File
handle high water mark set: 21 Thread unblock pipe
2010/04/12 09:19:30.111 0:00.035 PWLib File
handle high water mark set: 23 Thread unblock pipe
2010/04/12 09:19:30.112 0:00.037 PTLib Thread
high water mark set: 4
2010/04/12 09:19:30.112 0:00.037 HalManager_dbus
Initialising HAL Manager
2010/04/12 09:19:30.116 0:00.041 HalManager_dbus
Populating device list
2010/04/12 09:19:30.227 0:00.152 HalManager_dbus
Populated device list with 10 devices
2010/04/12 09:19:30.227 0:00.152 HalManager_dbus
Populating interface list
2010/04/12 09:19:30.228 0:00.152 HalManager_dbus
Populating full interface list failed - Method "getDevices" with signature ""
on interface "org.freedesktop.NetworkManager" doesn't exist
2010/04/12 09:19:30.228 0:00.153 Detecting V4L2
devices
2010/04/12 09:19:30.228 0:00.153 Unable to
detect v4l2 directory
2010/04/12 09:19:30.261 0:00.186 PWLib File
handle high water mark set: 28 Thread unblock pipe
2010/04/12 09:19:30.262 0:00.186 PTLib Thread
high water mark set: 5
2010/04/12 09:19:30.262 0:00.186 OpalMan Created
manager.
2010/04/12 09:19:30.262 0:00.187 OpalMan
Attached endpoint with prefix pc
2010/04/12 09:19:30.262 0:00.187 OpalEP Created
endpoint: pc
2010/04/12 09:19:30.265 0:00.189 PCSS Created
PC sound system endpoint.
Players:
Default
Logitech USB Headset
HDA Intel
EKIGA
*.wav
Recorders:
Default
Logitech USB Headset
HDA Intel
EKIGA
*.wav
2010/04/12 09:19:30.265 0:00.189 OPAL
SetMediaFormatOrder()
2010/04/12 09:19:30.265 0:00.189 OPAL
SetMediaFormatMask()
2010/04/12 09:19:30.265 0:00.190 OpalMan
Attached endpoint with prefix sip
2010/04/12 09:19:30.265 0:00.190 OpalEP Created
endpoint: sip
2010/04/12 09:19:30.266 0:00.190 PWLib File
handle high water mark set: 29 PUDPSocket
2010/04/12 09:19:30.266 0:00.190 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.25.63 [fe:80:00:00:00:00:00:00:02:1b:38:ff:fe:e9:07:64]
<00-1B-38-E9-07-64> (eth0)
2010/04/12 09:19:30.266 0:00.190 PWLib File
handle high water mark set: 30 Thread unblock pipe
2010/04/12 09:19:30.266 0:00.191 PTLib Thread
high water mark set: 6
2010/04/12 09:19:30.266 0:00.191 PWLib File
handle high water mark set: 32 Thread unblock pipe
2010/04/12 09:19:30.266 0:00.191 Network In...0x11127710 IfaceMon
Started interface monitor thread.
2010/04/12 09:19:30.266 0:00.191 PTLib Thread
high water mark set: 7
2010/04/12 09:19:30.266 0:00.191 Network In...0x11127710 PWLib File
handle high water mark set: 33 PUDPSocket
2010/04/12 09:19:30.266 0:00.191 OpalMan
Attached endpoint with prefix sips
2010/04/12 09:19:30.266 0:00.191 SIP Created
endpoint.
2010/04/12 09:19:30.266 0:00.191 MonSock Created
socket bundle for all interfaces.
2010/04/12 09:19:30.267 0:00.191 PWLib File
handle high water mark set: 34 PUDPSocket
2010/04/12 09:19:30.267 0:00.192 MonSock Created
bundled UDP socket 192.168.25.63:5060
2010/04/12 09:19:30.267 0:00.192 PWLib File
handle high water mark set: 36 Thread unblock pipe
2010/04/12 09:19:30.267 0:00.192 PTLib Thread
high water mark set: 8
2010/04/12 09:19:30.267 0:00.192 Opal Liste...0x110a5710 Listen Started
listening thread on udp$*:5060
2010/04/12 09:19:30.267 0:00.192 OpalMan Added
route "sip:.*=pc:*"
2010/04/12 09:19:30.267 0:00.192 OpalMan Added
route "pc:.*=sip:<da>"
2010/04/12 09:19:30.268 0:00.192 OpalMan
Attached endpoint with prefix h323
2010/04/12 09:19:30.268 0:00.192 OpalEP Created
endpoint: h323
2010/04/12 09:19:30.268 0:00.192 OpalMan
Attached endpoint with prefix h323s
2010/04/12 09:19:30.268 0:00.192 H323 Created
endpoint.
2010/04/12 09:19:30.268 0:00.193 PWLib File
handle high water mark set: 37 PTCPSocket
2010/04/12 09:19:30.268 0:00.193 PWLib File
handle high water mark set: 39 Thread unblock pipe
2010/04/12 09:19:30.268 0:00.193 PTLib Thread
high water mark set: 9
2010/04/12 09:19:30.268 0:00.193 OpalMan Added
route "h323:.*=pc:<db>"
2010/04/12 09:19:30.268 0:00.193 Opal Liste...0x11064710 Listen Started
listening thread on tcp$*:1720
2010/04/12 09:19:30.268 0:00.193 OpalMan Added
route "pc:.*=h323:<da>"
2010/04/12 09:19:30.268 0:00.193 Opal Liste...0x11064710 Listen Waiting
on socket accept on tcp$*:1720
2010/04/12 09:19:30.274 0:00.199 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,G.722-64k,theora,H.261,H.261-CIF,H.261-QCIF
2010/04/12 09:19:30.275 0:00.199 OPAL
SetMediaFormatMask(PCM-16-48kHz,PCM-16-32kHz,PCM-16-16kHz,PCM-16,GSM-AMR,LPC-10,MS-GSM,MS-IMA-ADPCM,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,YUV420P,RFC4175_YCbCr-4:2:0,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz)
2010/04/12 09:19:30.275 0:00.200 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,G.722-64k,theora,H.261,H.261-CIF,H.261-QCIF)
2010/04/12 09:19:30.280 0:00.205 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,G.722-64k,theora,H.261,H.261-CIF,H.261-QCIF
2010/04/12 09:19:30.280 0:00.205 OPAL
SetMediaFormatMask(PCM-16-48kHz,PCM-16-32kHz,PCM-16-16kHz,PCM-16,GSM-AMR,LPC-10,MS-GSM,MS-IMA-ADPCM,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,YUV420P,RFC4175_YCbCr-4:2:0,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz)
2010/04/12 09:19:30.280 0:00.205 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,G.722-64k,theora,H.261,H.261-CIF,H.261-QCIF)
2010/04/12 09:19:30.289 0:00.214 PWLib File
handle high water mark set: 41 Thread unblock pipe
2010/04/12 09:19:30.290 0:00.214 PTLib Thread
high water mark set: 10
2010/04/12 09:19:30.290 0:00.214 subscriber:0x11023710 SIP Start
REGISTER
[email protected]
registrar=impactmedia.local
contact=
authID=250
realm=
expire=3600
restore=30
minRetry=0.000
maxRetry=0.000
2010/04/12 09:19:30.290 0:00.215 subscriber:0x11023710 PWLib File
handle high water mark set: 42 PUDPSocket
2010/04/12 09:19:30.290 0:00.215 subscriber:0x11023710 SIP
Changing REGISTER handler from Unavailable to Subscribing,
target=sip:[email protected],
[email protected]
2010/04/12 09:19:30.291 0:00.215 subscriber:0x11023710 DNS SRV
Lookup impactmedia.local service _sip._udp
2010/04/12 09:19:30.339 0:00.264
VideoOutputCoreConfBridge Updating video view
2010/04/12 09:19:30.339 0:00.264
VideoOutputCoreConfBridge Updating zoom
2010/04/12 09:19:30.339 0:00.264
VideoOutputCoreConfBridge Updating Video Settings
2010/04/12 09:19:30.340 0:00.265
VideoOutputCoreConfBridge Updating Video Settings
2010/04/12 09:19:30.340 0:00.265
VideoOutputCoreConfBridge Updating Video Settings
2010/04/12 09:19:30.340 0:00.265
VideoOutputCoreConfBridge Updating Video Settings
2010/04/12 09:19:30.340 0:00.265
VidInputCoreConfBridge Updating preview size and fps
2010/04/12 09:19:30.340 0:00.265 VidInputCore
Setting new preview config: 320x240/30
2010/04/12 09:19:30.341 0:00.266
VidInputCoreConfBridge Updating preview size and fps
2010/04/12 09:19:30.341 0:00.266 VidInputCore
Setting new preview config: 320x240/30
2010/04/12 09:19:30.343 0:00.268
VidInputCoreConfBridge Updating device
2010/04/12 09:19:30.343 0:00.268 VidInputCore
Setting device: UVC Camera (046d:0991) (PTLIB/V4L2)
2010/04/12 09:19:30.343 0:00.268
GMVideoInputManager_ptlib Setting Device UVC Camera (046d:0991)
(PTLIB/V4L2)
2010/04/12 09:19:30.343 0:00.268
VidInputCoreConfBridge Updating device
2010/04/12 09:19:30.343 0:00.268 VidInputCore
Setting device: UVC Camera (046d:0991) (PTLIB/V4L2)
2010/04/12 09:19:30.343 0:00.268
GMVideoInputManager_ptlib Setting Device UVC Camera (046d:0991)
(PTLIB/V4L2)
2010/04/12 09:19:30.343 0:00.268
VidInputCoreConfBridge Updating device
2010/04/12 09:19:30.343 0:00.268 VidInputCore
Setting device: UVC Camera (046d:0991) (PTLIB/V4L2)
2010/04/12 09:19:30.343 0:00.268
GMVideoInputManager_ptlib Setting Device UVC Camera (046d:0991)
(PTLIB/V4L2)
2010/04/12 09:19:30.344 0:00.268
VidInputCoreConfBridge Updating image
2010/04/12 09:19:30.344 0:00.268
VidInputCoreConfBridge Updating preview
2010/04/12 09:19:30.344 0:00.268 VidInputCore
Stopping Preview
2010/04/12 09:19:30.344 0:00.269
AudioOutputCoreConfBridge Updating device
2010/04/12 09:19:30.344 0:00.269 AudioOutputCore
Setting device[0]: Logitech USB Headset (PTLIB/ALSA)
2010/04/12 09:19:30.344 0:00.269
GMAudioOutputManager_ptlib Setting Device[0] Logitech USB Headset
(PTLIB/ALSA)
2010/04/12 09:19:30.344 0:00.269
AudioOutputCoreConfBridge Updating device
2010/04/12 09:19:30.344 0:00.269 AudioOutputCore
Setting device[1]: HDA Intel (PTLIB/ALSA)
2010/04/12 09:19:30.344 0:00.269
GMAudioOutputManager_ptlib Setting Device[1] HDA Intel (PTLIB/ALSA)
2010/04/12 09:19:30.346 0:00.270
AudioInputCoreConfBridge Updating device
2010/04/12 09:19:30.346 0:00.270 AudioInputCore
Setting device: Logitech USB Headset (PTLIB/ALSA)
2010/04/12 09:19:30.346 0:00.270
GMAudioInputManager_ptlib Setting Device Logitech USB Headset (PTLIB/ALSA)
2010/04/12 09:19:30.411 0:00.335 Ekiga version
3.2.6
2010/04/12 09:19:30.411 0:00.335 OPAL version
3.6.6
2010/04/12 09:19:30.411 0:00.335 PTLIB version
2.6.5
2010/04/12 09:19:30.411 0:00.335 GNOME support
disabled
2010/04/12 09:19:30.411 0:00.335 Accelerated
rendering support enabled
2010/04/12 09:19:30.411 0:00.335 DBUS support
enabled
2010/04/12 09:19:30.411 0:00.336 GConf support
enabled
2010/04/12 09:19:30.411 0:00.336 ESound support
disabled
2010/04/12 09:19:35.294 0:05.219 subscriber:0x11023710 Socket Name
lookup of "sipx.impactmedia.local" failed: errno=-2
2010/04/12 09:19:35.295 0:05.219 subscriber:0x11023710 Socket Name
lookup of "0.0.0.0" failed: errno=0
2010/04/12 09:19:35.296 0:05.221 subscriber:0x11023710 SIP
Attempting SRV record entry 0: 0.0.0.0:5060
2010/04/12 09:19:35.296 0:05.221 subscriber:0x11023710 OpalUDP Binding
to interface: 0.0.0.0:5060
2010/04/12 09:19:35.296 0:05.221 subscriber:0x11023710 SIP Created
transport udp$*:5060<if=udp$*:5060>
2010/04/12 09:19:35.297 0:05.222 subscriber:0x11023710 OpalUDP
Broadcast connect to port 5060
2010/04/12 09:19:35.297 0:05.222 subscriber:0x11023710 OpalUDP Writing
to interface 0 - "192.168.25.63%eth0"
2010/04/12 09:19:35.299 0:05.224 subscriber:0x11023710 OpalMan
Listener interfaces: associated transport=udp$192.168.25.63:5060
udp$192.168.25.63:5060
2010/04/12 09:19:35.300 0:05.225 subscriber:0x11023710 SIP
Transaction created.
2010/04/12 09:19:35.302 0:05.227 subscriber:0x11023710 DNS SRV
Lookup impactmedia.local service _sip._udp
2010/04/12 09:19:35.303 0:05.228 subscriber:0x11023710 Socket Name
lookup of "sipx.impactmedia.local" failed: errno=4
2010/04/12 09:19:35.303 0:05.228 subscriber:0x11023710 Socket Name
lookup of "0.0.0.0" failed: errno=4
2010/04/12 09:19:35.303 0:05.229 subscriber:0x11023710 SIP
Attempting SRV record entry 0: 0.0.0.0:5060
2010/04/12 09:19:35.304 0:05.229 subscriber:0x11023710 SIP
Transaction remote address is udp$0.0.0.0:5060
2010/04/12 09:19:35.305 0:05.230 subscriber:0x11023710 SIP Set new
remote address udp$0.0.0.0:5060 for transport
udp$*:5060<if=udp$192.168.25.63:5060>
2010/04/12 09:19:35.305 0:05.230 subscriber:0x11023710 SIP Sending
PDU (528 bytes) to:
rem=udp$*:5060,local=udp$192.168.25.63:5060,if=192.168.25.63%eth0
REGISTER sip:impactmedia.local SIP/2.0
CSeq: 1 REGISTER
Via: SIP/2.0/UDP
192.168.25.63:5060;branch=z9hG4bK9ea0d198-1d44-df11-9337-001b38e90764;rport
User-Agent: Ekiga/3.2.6
From: <sip:[email protected]>;tag=14fdd495-1d44-df11-9337-001b38e90764
Call-ID: [email protected]
To: <sip:[email protected]>
Contact: <sip:[email protected]>;q=1
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 3600
Content-Length: 0
Max-Forwards: 70
2010/04/12 09:19:35.306 0:05.230 subscriber:0x11023710 OpalUDP Setting
interface to 192.168.25.63%eth0
2010/04/12 09:19:35.306 0:05.231 subscriber:0x11023710 SIP
Transaction timers set: retry=0.500, completion=6.000
2010/04/12 09:19:35.807 0:05.731 Housekeeper:0x110e6710 SIP
REGISTER transaction id=z9hG4bK9ea0d198-1d44-df11-9337-001b38e90764 timeout,
making retry 1, timeout 1.000
2010/04/12 09:19:35.807 0:05.732 Housekeeper:0x110e6710 SIP Set new
remote address udp$0.0.0.0:5060 for transport
udp$*:5060<if=udp$192.168.25.63:5060>
2010/04/12 09:19:35.808 0:05.732 Housekeeper:0x110e6710 SIP Sending
PDU (528 bytes) to:
rem=udp$*:5060,local=udp$192.168.25.63:5060,if=192.168.25.63%eth0
REGISTER sip:impactmedia.local SIP/2.0
CSeq: 1 REGISTER
Via: SIP/2.0/UDP
192.168.25.63:5060;branch=z9hG4bK9ea0d198-1d44-df11-9337-001b38e90764;rport
User-Agent: Ekiga/3.2.6
From: <sip:[email protected]>;tag=14fdd495-1d44-df11-9337-001b38e90764
Call-ID: [email protected]
To: <sip:[email protected]>
Contact: <sip:[email protected]>;q=1
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 3600
Content-Length: 0
Max-Forwards: 70
2010/04/12 09:19:35.808 0:05.733 Housekeeper:0x110e6710 OpalUDP Setting
interface to 192.168.25.63%eth0
2010/04/12 09:19:36.808 0:06.733 Housekeeper:0x110e6710 SIP
REGISTER transaction id=z9hG4bK9ea0d198-1d44-df11-9337-001b38e90764 timeout,
making retry 2, timeout 2.000
2010/04/12 09:19:36.809 0:06.734 Housekeeper:0x110e6710 SIP Set new
remote address udp$0.0.0.0:5060 for transport
udp$*:5060<if=udp$192.168.25.63:5060>
2010/04/12 09:19:36.809 0:06.734 Housekeeper:0x110e6710 SIP Sending
PDU (528 bytes) to:
rem=udp$*:5060,local=udp$192.168.25.63:5060,if=192.168.25.63%eth0
REGISTER sip:impactmedia.local SIP/2.0
CSeq: 1 REGISTER
Via: SIP/2.0/UDP
192.168.25.63:5060;branch=z9hG4bK9ea0d198-1d44-df11-9337-001b38e90764;rport
User-Agent: Ekiga/3.2.6
From: <sip:[email protected]>;tag=14fdd495-1d44-df11-9337-001b38e90764
Call-ID: [email protected]
To: <sip:[email protected]>
Contact: <sip:[email protected]>;q=1
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 3600
Content-Length: 0
Max-Forwards: 70
2010/04/12 09:19:36.810 0:06.735 Housekeeper:0x110e6710 OpalUDP Setting
interface to 192.168.25.63%eth0
2010/04/12 09:19:38.810 0:08.735 Housekeeper:0x110e6710 SIP
REGISTER transaction id=z9hG4bK9ea0d198-1d44-df11-9337-001b38e90764 timeout,
making retry 3, timeout 4.000
2010/04/12 09:19:38.811 0:08.736 Housekeeper:0x110e6710 SIP Set new
remote address udp$0.0.0.0:5060 for transport
udp$*:5060<if=udp$192.168.25.63:5060>
2010/04/12 09:19:38.811 0:08.736 Housekeeper:0x110e6710 SIP Sending
PDU (528 bytes) to:
rem=udp$*:5060,local=udp$192.168.25.63:5060,if=192.168.25.63%eth0
REGISTER sip:impactmedia.local SIP/2.0
CSeq: 1 REGISTER
Via: SIP/2.0/UDP
192.168.25.63:5060;branch=z9hG4bK9ea0d198-1d44-df11-9337-001b38e90764;rport
User-Agent: Ekiga/3.2.6
From: <sip:[email protected]>;tag=14fdd495-1d44-df11-9337-001b38e90764
Call-ID: [email protected]
To: <sip:[email protected]>
Contact: <sip:[email protected]>;q=1
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING
Expires: 3600
Content-Length: 0
Max-Forwards: 70
2010/04/12 09:19:38.812 0:08.737 Housekeeper:0x110e6710 OpalUDP Setting
interface to 192.168.25.63%eth0
2010/04/12 09:19:41.306 0:11.231 Housekeeper:0x110e6710 SIP Set
state Terminated_Timeout for REGISTER transaction
id=z9hG4bK9ea0d198-1d44-df11-9337-001b38e90764
2010/04/12 09:19:41.307 0:11.232 Housekeeper:0x110e6710 SIP
Changing REGISTER handler from Subscribing to Unavailable,
target=sip:[email protected],
[email protected]
2010/04/12 09:19:41.307 0:11.232 Housekeeper:0x110e6710 SIP
Retrying REGISTER in 30 seconds.
2010/04/12 09:19:42.264 0:12.189 Opal Garbage:0x11168710 SIP
Transaction id=z9hG4bK9ea0d198-1d44-df11-9337-001b38e90764 destroyed.
2010/04/12 09:19:45.267 0:15.192 Network In...0x11127710 PWLib File
handle low water mark set: 40 PUDPSocket
2010/04/12 09:19:47.231 0:17.156 Network In...0x11127710 IfaceMon
Finished interface monitor thread.
_______________________________________________
ekiga-list mailing list
[email protected]
http://mail.gnome.org/mailman/listinfo/ekiga-list
