Login
[x]
Log in using an account from:
Fedora Account System
Red Hat Associate
Red Hat Customer
Or login using a Red Hat Bugzilla account
Forgot Password
Login:
Hide Forgot
Create an Account
Red Hat Bugzilla – Attachment 868916 Details for
Bug 1069663
Assert of null pointer reference whet trying to add a H323 contact
[?]
New
Simple Search
Advanced Search
My Links
Browse
Requests
Reports
Current State
Search
Tabular reports
Graphical reports
Duplicates
Other Reports
User Changes
Plotly Reports
Bug Status
Bug Severity
Non-Defaults
|
Product Dashboard
Help
Page Help!
Bug Writing Guidelines
What's new
Browser Support Policy
5.0.4.rh83 Release notes
FAQ
Guides index
User guide
Web Services
Contact
Legal
This site requires JavaScript to be enabled to function correctly, please enable it.
ekiga -d 4
ekigad4.log (text/plain), 207.15 KB, created by
Martin Simon
on 2014-02-28 08:59:01 UTC
(
hide
)
Description:
ekiga -d 4
Filename:
MIME Type:
Creator:
Martin Simon
Created:
2014-02-28 08:59:01 UTC
Size:
207.15 KB
patch
obsolete
>[msimon@msimon ~]$ ekiga -d 4 > on Unix Linux (3.10.0-97.el7.x86_64-x86_64) with PTLib (v2.10.10 (svn:29149)) at 2014/2/28 9:50:15.734 >2014/02/28 09:50:15.736 0:00.002 PTLib Maximum per-process file handles is 1024 >2014/02/28 09:50:15.737 0:00.002 PLUGIN Enumerating plugin directory /usr/lib64/ptlib-2.10.10/ >2014/02/28 09:50:15.737 0:00.003 PLUGIN Enumerating plugin directory /usr/lib64/ptlib-2.10.10/devices/ >2014/02/28 09:50:15.737 0:00.003 PLUGIN Enumerating plugin directory /usr/lib64/ptlib-2.10.10/devices/videoinput/ >2014/02/28 09:50:15.737 0:00.003 UDLL opening /usr/lib64/ptlib-2.10.10/devices/videoinput/v4l2_pwplugin.so >2014/02/28 09:50:15.739 0:00.004 PLUGIN Enumerating plugin directory /usr/lib64/ptlib-2.10.10/devices/sound/ >2014/02/28 09:50:15.739 0:00.004 UDLL opening /usr/lib64/ptlib-2.10.10/devices/sound/pulse_pwplugin.so >2014/02/28 09:50:15.747 0:00.013 UDLL opening /usr/lib64/ptlib-2.10.10/devices/sound/alsa_pwplugin.so >2014/02/28 09:50:15.749 0:00.015 PLUGIN Enumerating plugin directory /usr/lib64/opal-3.10.10/ >2014/02/28 09:50:15.750 0:00.015 PLUGIN Enumerating plugin directory /usr/lib64/opal-3.10.10/codecs/ >2014/02/28 09:50:15.750 0:00.015 PLUGIN Enumerating plugin directory /usr/lib64/opal-3.10.10/codecs/audio/ >2014/02/28 09:50:15.750 0:00.015 UDLL opening /usr/lib64/opal-3.10.10/codecs/audio/lpc10_ptplugin.so >2014/02/28 09:50:15.750 0:00.016 UDLL opening /usr/lib64/opal-3.10.10/codecs/audio/ima_adpcm_ptplugin.so >2014/02/28 09:50:15.750 0:00.016 UDLL opening /usr/lib64/opal-3.10.10/codecs/audio/g726_ptplugin.so >2014/02/28 09:50:15.750 0:00.016 UDLL opening /usr/lib64/opal-3.10.10/codecs/audio/speex_ptplugin.so >2014/02/28 09:50:15.751 0:00.016 UDLL opening /usr/lib64/opal-3.10.10/codecs/audio/g7221_ptplugin.so >2014/02/28 09:50:15.751 0:00.017 UDLL opening /usr/lib64/opal-3.10.10/codecs/audio/gsm0610_ptplugin.so >2014/02/28 09:50:15.751 0:00.017 UDLL opening /usr/lib64/opal-3.10.10/codecs/audio/g7222_ptplugin.so >2014/02/28 09:50:15.752 0:00.017 UDLL opening /usr/lib64/opal-3.10.10/codecs/audio/iLBC_ptplugin.so >2014/02/28 09:50:15.752 0:00.017 UDLL opening /usr/lib64/opal-3.10.10/codecs/audio/g722_ptplugin.so >2014/02/28 09:50:15.752 0:00.018 UDLL opening /usr/lib64/opal-3.10.10/codecs/audio/gsmamrcodec_ptplugin.so >2014/02/28 09:50:15.752 0:00.018 PLUGIN Enumerating plugin directory /usr/lib64/opal-3.10.10/codecs/video/ >2014/02/28 09:50:15.752 0:00.018 UDLL opening /usr/lib64/opal-3.10.10/codecs/video/h261_vic_ptplugin.so >2014/02/28 09:50:15.753 0:00.018 UDLL opening /usr/lib64/opal-3.10.10/codecs/video/theora_ptplugin.so >2014/02/28 09:50:15.753 0:00.019 OpalPlugin Using default handler for plugin codec lpc10_ptplugin >2014/02/28 09:50:15.753 0:00.019 OpalPlugin Creating new media format LPC-10 >2014/02/28 09:50:15.753 0:00.019 OpalPlugin Using default handler for plugin codec ima_adpcm_ptplugin >2014/02/28 09:50:15.754 0:00.019 OpalPlugin Creating new media format MS-IMA-ADPCM >2014/02/28 09:50:15.754 0:00.019 OpalPlugin Using default handler for plugin codec g726_ptplugin >2014/02/28 09:50:15.754 0:00.019 OpalPlugin Creating new media format G.726-40k >2014/02/28 09:50:15.754 0:00.019 OpalPlugin Creating new media format G.726-32k >2014/02/28 09:50:15.754 0:00.020 OpalPlugin Creating new media format G.726-24k >2014/02/28 09:50:15.754 0:00.020 OpalPlugin Creating new media format G.726-16k >2014/02/28 09:50:15.754 0:00.020 OpalPlugin Using default handler for plugin codec speex_ptplugin >2014/02/28 09:50:15.754 0:00.020 OpalPlugin Creating new media format SpeexIETFNarrow-5.95k >2014/02/28 09:50:15.754 0:00.020 OpalPlugin Creating new media format SpeexIETFNarrow-8k >2014/02/28 09:50:15.755 0:00.020 OpalPlugin Creating new media format SpeexIETFNarrow-11k >2014/02/28 09:50:15.755 0:00.021 OpalPlugin Creating new media format SpeexIETFNarrow-15k >2014/02/28 09:50:15.755 0:00.021 OpalPlugin Creating new media format SpeexIETFNarrow-18.2k >2014/02/28 09:50:15.755 0:00.021 OpalPlugin Creating new media format SpeexIETFNarrow-24.6k >2014/02/28 09:50:15.755 0:00.021 OpalPlugin Creating new media format SpeexIETFWide-20.6k >2014/02/28 09:50:15.756 0:00.021 OpalPlugin Creating new media format SpeexWNarrow-8k >2014/02/28 09:50:15.756 0:00.022 OpalPlugin Creating new media format SpeexWide-20.6k >2014/02/28 09:50:15.756 0:00.022 OpalPlugin Creating new media format SpeexNB >2014/02/28 09:50:15.756 0:00.022 OpalPlugin Creating new media format SpeexWB >2014/02/28 09:50:15.757 0:00.022 OpalPlugin Using default handler for plugin codec g7221_ptplugin >2014/02/28 09:50:15.757 0:00.022 OpalPlugin Creating new media format G.722.1-24k >2014/02/28 09:50:15.757 0:00.023 OpalPlugin Creating new media format G.722.1-32k >2014/02/28 09:50:15.757 0:00.023 OpalPlugin Using default handler for plugin codec gsm0610_ptplugin >2014/02/28 09:50:15.757 0:00.023 OpalPlugin Creating new media format GSM-06.10 >2014/02/28 09:50:15.757 0:00.023 OpalPlugin Creating new media format MS-GSM >2014/02/28 09:50:15.758 0:00.023 OpalPlugin Using default handler for plugin codec g7222_ptplugin >2014/02/28 09:50:15.758 0:00.023 OpalPlugin Creating new media format G.722.2 >2014/02/28 09:50:15.758 0:00.024 OpalPlugin Using default handler for plugin codec iLBC_ptplugin >2014/02/28 09:50:15.758 0:00.024 OpalPlugin Creating new media format iLBC >2014/02/28 09:50:15.758 0:00.024 OpalPlugin Creating new media format iLBC-13k3 >2014/02/28 09:50:15.758 0:00.024 OpalPlugin Creating new media format iLBC-15k2 >2014/02/28 09:50:15.759 0:00.024 OpalPlugin Using default handler for plugin codec g722_ptplugin >2014/02/28 09:50:15.759 0:00.024 OpalPlugin Creating new media format G.722-64k >2014/02/28 09:50:15.759 0:00.025 OpalPlugin Using default handler for plugin codec gsmamrcodec_ptplugin >2014/02/28 09:50:15.759 0:00.025 OpalPlugin Creating new media format GSM-AMR >2014/02/28 09:50:15.759 0:00.025 OpalPlugin Using default handler for plugin codec h261_vic_ptplugin >2014/02/28 09:50:15.759 0:00.025 OpalPlugin Creating new media format H.261 >2014/02/28 09:50:15.759 0:00.025 OpalPlugin Creating H.261 plugin capability >2014/02/28 09:50:15.759 0:00.025 OpalPlugin Creating H.261 plugin capability >2014/02/28 09:50:15.759 0:00.025 OpalPlugin Using default handler for plugin codec theora_ptplugin >2014/02/28 09:50:15.760 0:00.025 Plugin Started logging. >2014/02/28 09:50:15.760 0:00.025 OpalPlugin Creating new media format theora >2014/02/28 09:50:15.762 0:00.027 PWLib File handle high water mark set: 10 Thread unblock pipe >2014/02/28 09:50:15.762 0:00.027 PWLib File handle high water mark set: 12 Thread unblock pipe >2014/02/28 09:50:15.762 0:00.027 PTLib No permission to set priority level 4 >2014/02/28 09:50:15.762 0:00.027 PTLib Thread high water mark set: 2 >2014/02/28 09:50:15.762 0:00.027 PTLib No permission to set priority level 4 >2014/02/28 09:50:15.762 0:00.027 PTLib Thread high water mark set: 3 >2014/02/28 09:50:15.762 0:00.028 PWLib File handle high water mark set: 17 Thread unblock pipe >2014/02/28 09:50:15.762 0:00.028 PTLib No permission to set priority level 4 >2014/02/28 09:50:15.762 0:00.028 PTLib Thread high water mark set: 4 >2014/02/28 09:50:15.763 0:00.029 PWLib File handle high water mark set: 19 Thread unblock pipe >2014/02/28 09:50:15.764 0:00.029 PTLib No permission to set priority level 4 >2014/02/28 09:50:15.764 0:00.029 PTLib Thread high water mark set: 5 >2014/02/28 09:50:15.764 0:00.030 HalManager_dbus Initialising HAL Manager >2014/02/28 09:50:15.766 0:00.032 HalManager_dbus Populating device list >2014/02/28 09:50:15.766 0:00.032 HalManager_dbus Populating full device list failed - The name org.freedesktop.Hal was not provided by any .service files >2014/02/28 09:50:15.767 0:00.032 HalManager_dbus Populating interface list >2014/02/28 09:50:15.767 0:00.033 HalManager_dbus Populating full interface list failed - Method "getDevices" with signature "" on interface "org.freedesktop.NetworkManager" doesn't exist > >2014/02/28 09:50:15.768 0:00.033 PV4L2Plugin Detecting V4L2 devices >2014/02/28 09:50:15.768 0:00.033 PV4L2Plugin detected device metadata at /sys/class/video4linux/ >2014/02/28 09:50:15.815 0:00.081 PWLib File handle high water mark set: 25 Thread unblock pipe >2014/02/28 09:50:15.815 0:00.081 PTLib Thread high water mark set: 6 >2014/02/28 09:50:15.815 0:00.081 OpalMan Created manager. >2014/02/28 09:50:15.815 0:00.081 PV4L2Plugin Detecting V4L2 devices >2014/02/28 09:50:15.815 0:00.081 PV4L2Plugin detected device metadata at /sys/class/video4linux/ >2014/02/28 09:50:15.825 0:00.091 OpalMan Attached endpoint with prefix pc >2014/02/28 09:50:15.825 0:00.091 OpalEP Created endpoint: pc >2014/02/28 09:50:15.825 0:00.091 LocalEP Created endpoint. >2014/02/28 09:50:15.828 0:00.094 PCSS Created PC sound system endpoint. >Players: >alsa_output.pci-0000_00_1b.0.analog-stereo >Null Audio >Default >PulseAudio >HDA Intel PCH [ALC269VC Analog] >HDA Intel PCH [HDMI 0] >HDA Intel PCH [HDMI 1] >HDA Intel PCH [HDMI 2] >EKIGA >*.wav >Recorders: >Null Audio >Default >PulseAudio >alsa_input.pci-0000_00_1b.0.analog-stereo >HDA Intel PCH [ALC269VC Analog] >EKIGA >*.wav > >2014/02/28 09:50:15.829 0:00.095 OPAL SetMediaFormatOrder() >2014/02/28 09:50:15.830 0:00.095 OPAL SetMediaFormatMask() >2014/02/28 09:50:15.830 0:00.096 OpalMan Attached endpoint with prefix sip >2014/02/28 09:50:15.830 0:00.096 OpalEP Created endpoint: sip >2014/02/28 09:50:15.831 0:00.097 PWLib File handle high water mark set: 26 PUDPSocket >2014/02/28 09:50:15.831 0:00.097 IfaceMon Initial interface list: >127.0.0.1 <00-00-00-00-00-00> (lo) >10.34.130.146 <3C-97-0E-8E-D1-1E> (em1) >10.200.138.63 <3C-A9-F4-20-41-40> (wlp3s0) > >2014/02/28 09:50:15.832 0:00.098 PTLIB Opened NetLink socket >2014/02/28 09:50:15.832 0:00.098 PWLib File handle high water mark set: 30 Thread unblock pipe >2014/02/28 09:50:15.833 0:00.098 PTLib Thread high water mark set: 7 >2014/02/28 09:50:15.833 0:00.098 Network In...090af67700 IfaceMon Started interface monitor thread. >2014/02/28 09:50:15.833 0:00.099 OpalMan Attached endpoint with prefix sips >2014/02/28 09:50:15.833 0:00.099 SIP Created endpoint. >2014/02/28 09:50:15.833 0:00.099 PWLib File handle high water mark set: 31 PUDPSocket >2014/02/28 09:50:15.833 0:00.099 MonSock Created socket bundle for all interfaces. >2014/02/28 09:50:15.833 0:00.099 PWLib File handle high water mark set: 32 PUDPSocket >2014/02/28 09:50:15.834 0:00.099 MonSock Created bundled UDP socket 10.34.130.146:5060 >2014/02/28 09:50:15.834 0:00.099 PWLib File handle high water mark set: 33 PUDPSocket >2014/02/28 09:50:15.834 0:00.099 MonSock Created bundled UDP socket 10.200.138.63:5060 >2014/02/28 09:50:15.834 0:00.099 PWLib File handle high water mark set: 35 Thread unblock pipe >2014/02/28 09:50:15.834 0:00.100 PTLib Thread high water mark set: 8 >2014/02/28 09:50:15.834 0:00.100 PTLib No permission to set priority level 4 >2014/02/28 09:50:15.834 0:00.100 Opal Liste...08ec121700 Listen Started listening thread on udp$*:5060 >2014/02/28 09:50:15.834 0:00.100 OpalMan Added route "sip:.*=pc:*" >2014/02/28 09:50:15.834 0:00.100 OpalMan Added route "pc:.*=sip:<da>" >2014/02/28 09:50:15.835 0:00.101 OpalMan Attached endpoint with prefix h323 >2014/02/28 09:50:15.835 0:00.101 OpalEP Created endpoint: h323 >2014/02/28 09:50:15.835 0:00.101 OpalMan Attached endpoint with prefix h323s >2014/02/28 09:50:15.835 0:00.101 H323 Created endpoint. >2014/02/28 09:50:15.835 0:00.101 PWLib File handle high water mark set: 36 PTCPSocket >2014/02/28 09:50:15.835 0:00.101 PWLib File handle high water mark set: 38 Thread unblock pipe >2014/02/28 09:50:15.836 0:00.101 PTLib Thread high water mark set: 9 >2014/02/28 09:50:15.836 0:00.101 OpalMan Added route "h323:.*=pc:*" >2014/02/28 09:50:15.836 0:00.101 OpalMan Added route "pc:.*=h323:<da>" >2014/02/28 09:50:15.836 0:00.102 Opal Liste...08ec0e0700 Listen Started listening thread on tcp$*:1720 >2014/02/28 09:50:15.836 0:00.102 Opal Liste...08ec0e0700 Listen Waiting on socket accept on tcp$*:1720 >2014/02/28 09:50:15.836 0:00.102 Error: cannot create presentity for h323:desktopqe@spranto.net >2014/02/28 09:50:15.836 0:00.102 PWLib File handle high water mark set: 39 PUDPSocket >2014/02/28 09:50:15.837 0:00.102 OpalMan Added presentity for SIP_Presentity >2014/02/28 09:50:15.837 0:00.102 Created presentity for sip:desktopqe@ekiga.net >2014/02/28 09:50:15.843 0:00.109 MediaFormat Removing codecs SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,G.711-uLaw-64k,G.711-ALaw-64k,theora,H.261,PCM-16S-48kHz,PCM-16S-32kHz,PCM-16S-16kHz,PCM-16-48kHz,PCM-16-32kHz,PCM-16-16kHz,PCM-16,UserInput/RFC2833,NamedSignalEvent,YUV420P,MSRP,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling >2014/02/28 09:50:15.843 0:00.109 OPAL SetMediaFormatMask(G.722-64k,G.722.1-24k,G.722.1-32k,G.722.2,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,NamedSignalEvent) >2014/02/28 09:50:15.843 0:00.109 OPAL SetMediaFormatOrder(SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,G.711-uLaw-64k,G.711-ALaw-64k,theora,H.261,PCM-16S-48kHz,PCM-16S-32kHz,PCM-16S-16kHz,PCM-16-48kHz,PCM-16-32kHz,PCM-16-16kHz,PCM-16,UserInput/RFC2833,NamedSignalEvent,YUV420P,MSRP,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling) >2014/02/28 09:50:15.849 0:00.115 MediaFormat Removing codecs SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,G.711-uLaw-64k,G.711-ALaw-64k,theora,H.261,PCM-16S-48kHz,PCM-16S-32kHz,PCM-16S-16kHz,PCM-16-48kHz,PCM-16-32kHz,PCM-16-16kHz,PCM-16,UserInput/RFC2833,NamedSignalEvent,YUV420P,MSRP,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling >2014/02/28 09:50:15.849 0:00.115 OPAL SetMediaFormatMask(G.722-64k,G.722.1-24k,G.722.1-32k,G.722.2,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,NamedSignalEvent) >2014/02/28 09:50:15.849 0:00.115 OPAL SetMediaFormatOrder(SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,G.711-uLaw-64k,G.711-ALaw-64k,theora,H.261,PCM-16S-48kHz,PCM-16S-32kHz,PCM-16S-16kHz,PCM-16-48kHz,PCM-16-32kHz,PCM-16-16kHz,PCM-16,UserInput/RFC2833,NamedSignalEvent,YUV420P,MSRP,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling) >2014/02/28 09:50:15.850 0:00.116 OpalConfBridge maximum_video_tx_bitrate set to 1024kb/s >2014/02/28 09:50:15.857 0:00.122 Ekiga Nat binding delay set to 10 >2014/02/28 09:50:15.857 0:00.122 Ekiga Sent its own presence (publish) for sip:desktopqe@ekiga.net: available, note I'm available using Ekiga >2014/02/28 09:50:15.860 0:00.126 PWLib File handle high water mark set: 40 Thread unblock pipe >2014/02/28 09:50:15.860 0:00.126 Ekiga Started STUN detector >2014/02/28 09:50:15.860 0:00.126 PTLib Thread high water mark set: 10 >2014/02/28 09:50:15.860 0:00.126 StunDetect...08ec09f700 PWLib File handle high water mark set: 41 PUDPSocket >2014/02/28 09:50:15.892 0:00.157 AudioOutputCore Detected Device: PulseAudio (PTLIB/Pulse) >2014/02/28 09:50:15.892 0:00.157 AudioOutputCore Detected Device: alsa_output.pci-0000_00_1b.0.analog-stereo (PTLIB/Pulse) >2014/02/28 09:50:15.892 0:00.157 AudioOutputCore Detected Device: Default (PTLIB/ALSA) >2014/02/28 09:50:15.892 0:00.157 AudioOutputCore Detected Device: HDA Intel PCH [ALC269VC Analog] (PTLIB/ALSA) >2014/02/28 09:50:15.892 0:00.157 AudioOutputCore Detected Device: HDA Intel PCH [HDMI 0] (PTLIB/ALSA) >2014/02/28 09:50:15.892 0:00.157 AudioOutputCore Detected Device: HDA Intel PCH [HDMI 1] (PTLIB/ALSA) >2014/02/28 09:50:15.892 0:00.157 AudioOutputCore Detected Device: HDA Intel PCH [HDMI 2] (PTLIB/ALSA) >2014/02/28 09:50:15.897 0:00.163 StunDetect...08ec09f700 PWLib File handle high water mark set: 42 PUDPSocket >2014/02/28 09:50:15.941 0:00.206 StunDetect...08ec09f700 PWLib File handle high water mark set: 45 PUDPSocket >2014/02/28 09:50:15.960 0:00.225 AudioOutputCore Detected Device: PulseAudio (PTLIB/Pulse) >2014/02/28 09:50:15.960 0:00.225 AudioOutputCore Detected Device: alsa_output.pci-0000_00_1b.0.analog-stereo (PTLIB/Pulse) >2014/02/28 09:50:15.960 0:00.225 AudioOutputCore Detected Device: Default (PTLIB/ALSA) >2014/02/28 09:50:15.960 0:00.225 AudioOutputCore Detected Device: HDA Intel PCH [ALC269VC Analog] (PTLIB/ALSA) >2014/02/28 09:50:15.960 0:00.225 AudioOutputCore Detected Device: HDA Intel PCH [HDMI 0] (PTLIB/ALSA) >2014/02/28 09:50:15.960 0:00.226 AudioOutputCore Detected Device: HDA Intel PCH [HDMI 1] (PTLIB/ALSA) >2014/02/28 09:50:15.960 0:00.226 AudioOutputCore Detected Device: HDA Intel PCH [HDMI 2] (PTLIB/ALSA) >2014/02/28 09:50:15.964 0:00.230 AudioInputCore Detected Device: PulseAudio (PTLIB/Pulse) >2014/02/28 09:50:15.964 0:00.230 AudioInputCore Detected Device: alsa_input.pci-0000_00_1b.0.analog-stereo (PTLIB/Pulse) >2014/02/28 09:50:15.964 0:00.230 AudioInputCore Detected Device: Default (PTLIB/ALSA) >2014/02/28 09:50:15.964 0:00.230 AudioInputCore Detected Device: HDA Intel PCH [ALC269VC Analog] (PTLIB/ALSA) >2014/02/28 09:50:15.968 0:00.233 PV4L2Plugin Detecting V4L2 devices >2014/02/28 09:50:15.968 0:00.234 PV4L2Plugin detected device metadata at /sys/class/video4linux/ >2014/02/28 09:50:15.975 0:00.241 VidInputCore Detected Device: Moving Logo (Moving Logo/Moving Logo) >2014/02/28 09:50:15.975 0:00.241 VidInputCore Detected Device: Integrated Camera (PTLIB/V4L2) >2014/02/28 09:50:16.025 0:00.291 VideoOutputCoreConfBridge Updating video view >2014/02/28 09:50:16.026 0:00.291 VideoOutputCoreConfBridge Updating zoom >2014/02/28 09:50:16.026 0:00.291 VideoOutputCoreConfBridge Updating Video Settings >2014/02/28 09:50:16.026 0:00.292 VideoOutputCoreConfBridge Updating Video Settings >2014/02/28 09:50:16.026 0:00.292 VideoOutputCoreConfBridge Updating Video Settings >2014/02/28 09:50:16.026 0:00.292 VideoOutputCoreConfBridge Updating Video Settings >2014/02/28 09:50:16.026 0:00.292 VidInputCoreConfBridge Updating preview size and fps >2014/02/28 09:50:16.026 0:00.292 VidInputCore Setting new preview config: 320x240/30 >2014/02/28 09:50:16.027 0:00.293 VidInputCoreConfBridge Updating preview size and fps >2014/02/28 09:50:16.027 0:00.293 VidInputCore Setting new preview config: 320x240/30 >2014/02/28 09:50:16.028 0:00.294 PV4L2Plugin Detecting V4L2 devices >2014/02/28 09:50:16.028 0:00.294 PV4L2Plugin detected device metadata at /sys/class/video4linux/ >2014/02/28 09:50:16.036 0:00.302 VidInputCore Detected Device: Moving Logo (Moving Logo/Moving Logo) >2014/02/28 09:50:16.036 0:00.302 VidInputCore Detected Device: Integrated Camera (PTLIB/V4L2) >2014/02/28 09:50:16.036 0:00.302 VidInputCoreConfBridge Updating device >2014/02/28 09:50:16.036 0:00.302 VidInputCore Setting device: Integrated Camera (PTLIB/V4L2) >2014/02/28 09:50:16.036 0:00.302 GMVideoInputManager_ptlib Setting Device Integrated Camera (PTLIB/V4L2) >2014/02/28 09:50:16.036 0:00.302 PV4L2Plugin Detecting V4L2 devices >2014/02/28 09:50:16.036 0:00.302 PV4L2Plugin detected device metadata at /sys/class/video4linux/ >2014/02/28 09:50:16.044 0:00.310 VidInputCore Detected Device: Moving Logo (Moving Logo/Moving Logo) >2014/02/28 09:50:16.044 0:00.310 VidInputCore Detected Device: Integrated Camera (PTLIB/V4L2) >2014/02/28 09:50:16.044 0:00.310 VidInputCoreConfBridge Updating device >2014/02/28 09:50:16.044 0:00.310 VidInputCore Setting device: Integrated Camera (PTLIB/V4L2) >2014/02/28 09:50:16.044 0:00.310 GMVideoInputManager_ptlib Setting Device Integrated Camera (PTLIB/V4L2) >2014/02/28 09:50:16.045 0:00.310 PV4L2Plugin Detecting V4L2 devices >2014/02/28 09:50:16.045 0:00.310 PV4L2Plugin detected device metadata at /sys/class/video4linux/ >2014/02/28 09:50:16.052 0:00.318 VidInputCore Detected Device: Moving Logo (Moving Logo/Moving Logo) >2014/02/28 09:50:16.052 0:00.318 VidInputCore Detected Device: Integrated Camera (PTLIB/V4L2) >2014/02/28 09:50:16.052 0:00.318 VidInputCoreConfBridge Updating device >2014/02/28 09:50:16.052 0:00.318 VidInputCore Setting device: Integrated Camera (PTLIB/V4L2) >2014/02/28 09:50:16.052 0:00.318 GMVideoInputManager_ptlib Setting Device Integrated Camera (PTLIB/V4L2) >2014/02/28 09:50:16.053 0:00.318 VidInputCoreConfBridge Updating image >2014/02/28 09:50:16.054 0:00.319 AudioOutputCore Detected Device: PulseAudio (PTLIB/Pulse) >2014/02/28 09:50:16.054 0:00.319 AudioOutputCore Detected Device: alsa_output.pci-0000_00_1b.0.analog-stereo (PTLIB/Pulse) >2014/02/28 09:50:16.054 0:00.319 AudioOutputCore Detected Device: Default (PTLIB/ALSA) >2014/02/28 09:50:16.054 0:00.319 AudioOutputCore Detected Device: HDA Intel PCH [ALC269VC Analog] (PTLIB/ALSA) >2014/02/28 09:50:16.054 0:00.319 AudioOutputCore Detected Device: HDA Intel PCH [HDMI 0] (PTLIB/ALSA) >2014/02/28 09:50:16.054 0:00.319 AudioOutputCore Detected Device: HDA Intel PCH [HDMI 1] (PTLIB/ALSA) >2014/02/28 09:50:16.054 0:00.319 AudioOutputCore Detected Device: HDA Intel PCH [HDMI 2] (PTLIB/ALSA) >2014/02/28 09:50:16.054 0:00.319 AudioOutputCoreConfBridge Set device to ALSA/Default >2014/02/28 09:50:16.054 0:00.319 AudioOutputCore Setting device[0]: Default (PTLIB/ALSA) >2014/02/28 09:50:16.054 0:00.320 GMAudioOutputManager_ptlib Setting Device[0] Default (PTLIB/ALSA) >2014/02/28 09:50:16.054 0:00.320 AudioOutputCoreConfBridge Updating device >2014/02/28 09:50:16.054 0:00.320 AudioOutputCore Setting device[1]: Default (PTLIB/ALSA) >2014/02/28 09:50:16.069 0:00.334 AudioInputCore Detected Device: PulseAudio (PTLIB/Pulse) >2014/02/28 09:50:16.069 0:00.334 AudioInputCore Detected Device: alsa_input.pci-0000_00_1b.0.analog-stereo (PTLIB/Pulse) >2014/02/28 09:50:16.069 0:00.334 AudioInputCore Detected Device: Default (PTLIB/ALSA) >2014/02/28 09:50:16.069 0:00.334 AudioInputCore Detected Device: HDA Intel PCH [ALC269VC Analog] (PTLIB/ALSA) >2014/02/28 09:50:16.069 0:00.334 AudioInputCore Setting device: Default (PTLIB/ALSA) >2014/02/28 09:50:16.069 0:00.335 GMAudioInputManager_ptlib Setting Device Default (PTLIB/ALSA) >2014/02/28 09:50:16.069 0:00.335 AudioInputCore Set device to ALSA/Default >2014/02/28 09:50:16.092 0:00.357 Ekiga version 4.0.1 >2014/02/28 09:50:16.092 0:00.357 PTLIB version 2.10.10 >2014/02/28 09:50:16.092 0:00.357 OPAL version 3.10.10 >2014/02/28 09:50:16.092 0:00.357 Accelerated rendering support enabled >2014/02/28 09:50:16.092 0:00.357 DBUS support enabled >2014/02/28 09:50:16.092 0:00.358 GConf support enabled >2014/02/28 09:50:20.788 0:05.054 StunDetect...08ec09f700 PWLib File handle low water mark set: 41 PUDPSocket >2014/02/28 09:50:20.831 0:05.097 StunDetect...08ec09f700 OPAL STUN server "stun.ekiga.net" replies Port Restricted NAT, external IP 209.132.186.34 >2014/02/28 09:50:20.831 0:05.097 StunDetect...08ec09f700 PTLib Thread ended: name="StunDetector:0x7f08ec09f700", real=4.971, kernel=0.000 (0%), user=0.000 (0%), both=0.000 (0%) >2014/02/28 09:50:21.028 0:05.293 Listen Stopping listening thread on udp$*:5060 >2014/02/28 09:50:21.028 0:05.293 MonSock Closed UDP socket 0x8b0d20 >2014/02/28 09:50:21.028 0:05.294 Opal Liste...08ec121700 Listen UDP read error. >2014/02/28 09:50:21.028 0:05.294 Opal Liste...08ec121700 PWLib File handle low water mark set: 33 PTextFile >2014/02/28 09:50:21.028 0:05.294 Opal Liste...08ec121700 PTLib Thread ended: name="Opal Listener:0x7f08ec121700", real=5.194, kernel=0.000 (0%), user=0.000 (0%), both=0.000 (0%) >2014/02/28 09:50:21.048 0:05.314 MonSock Deleting UDP socket 0x8b0d20 >2014/02/28 09:50:21.048 0:05.314 MonSock Closed UDP socket 0x8b0940 >2014/02/28 09:50:21.048 0:05.314 MonSock Deleting UDP socket 0x8b0940 >2014/02/28 09:50:21.048 0:05.314 Housekeepe...090b0ac700 Ekiga Stopped STUN detector >2014/02/28 09:50:21.048 0:05.314 PWLib File handle low water mark set: 31 PUDPSocket >2014/02/28 09:50:21.049 0:05.314 MonSock Created socket bundle for all interfaces. >2014/02/28 09:50:21.091 0:05.357 MonSock Created bundled UDP socket via STUN, internal=10.34.130.146:5060, external=209.132.186.34:27476 >2014/02/28 09:50:21.091 0:05.357 MonSock Created bundled UDP socket 10.200.138.63:5060 >2014/02/28 09:50:21.091 0:05.357 PTLib No permission to set priority level 4 >2014/02/28 09:50:21.092 0:05.357 Listen Stopping listening thread on tcp$*:1720 >2014/02/28 09:50:21.091 0:05.357 Opal Liste...08ec121700 Listen Started listening thread on udp$*:5060 >2014/02/28 09:50:21.092 0:05.357 Opal Liste...08ec0e0700 PTLib Thread ended: name="Opal Listener:0x7f08ec0e0700", real=5.255, kernel=0.000 (0%), user=0.000 (0%), both=0.000 (0%) >2014/02/28 09:50:21.102 0:05.368 Opal Liste...08ec0e0700 Listen Started listening thread on tcp$*:1720 >2014/02/28 09:50:21.102 0:05.368 Opal Liste...08ec0e0700 Listen Waiting on socket accept on tcp$*:1720 >2014/02/28 09:50:21.103 0:05.368 subscriber...08e40cc700 MonSock Created socket bundle for all interfaces. >2014/02/28 09:50:21.103 0:05.368 subscriber...08e40cc700 H323 Authenticator list is size 3 >2014/02/28 09:50:21.103 0:05.369 subscriber...08e40cc700 H460 Endpoint Attached >2014/02/28 09:50:21.103 0:05.369 PWLib File handle high water mark set: 54 Thread unblock pipe >2014/02/28 09:50:21.103 0:05.369 subscriber...08e40cc700 PWLib File handle high water mark set: 57 Thread unblock pipe >2014/02/28 09:50:21.103 0:05.369 PTLib Thread high water mark set: 11 >2014/02/28 09:50:21.103 0:05.369 subscriber...08e40cc700 PTLib Thread high water mark set: 12 >2014/02/28 09:50:21.103 0:05.369 subscriber...08e40cc700 H460 Endpoint Attached >2014/02/28 09:50:21.103 0:05.369 GkMonitor:...08e404a700 RAS Background thread started >2014/02/28 09:50:21.103 0:05.369 subscriber...08e408b700 OpalPres 'sip:desktopqe@ekiga.net' opening. >2014/02/28 09:50:21.104 0:05.369 subscriber...08e408b700 SIPPres Using sip:desktopqe@ekiga.net as presence server for sip:desktopqe@ekiga.net >2014/02/28 09:50:21.104 0:05.369 subscriber...08e408b700 PWLib File handle high water mark set: 60 Thread unblock pipe >2014/02/28 09:50:21.104 0:05.369 subscriber...08e408b700 PTLib Thread high water mark set: 13 >2014/02/28 09:50:21.104 0:05.369 subscriber...08e408b700 OpalPres Creating presentity command 'SIP_Presentity21SIPWatcherInfoCommand' >2014/02/28 09:50:21.104 0:05.370 subscriber...08e408b700 SIP Start REGISTER > aor=desktopqe@ekiga.net > remote=ekiga.net > local= > contact= > proxy= > authID=desktopqe > realm= > expire=3600 > restore=30 > minRetry=default > maxRetry=default >compatibility=FullyCompliant >2014/02/28 09:50:21.104 0:05.370 subscriber...08e408b700 SIP Constructed REGISTER handler for sip:desktopqe@ekiga.net >2014/02/28 09:50:21.104 0:05.370 subscriber...08e408b700 SIP Executing state change to Subscribing for REGISTER handler, target=sip:desktopqe@ekiga.net, id=f2bf3206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.105 0:05.370 subscriber...08e408b700 SIP Changing REGISTER handler from Unavailable to Subscribing, target=sip:desktopqe@ekiga.net, id=f2bf3206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.105 0:05.370 subscriber...08e408b700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.105 0:05.370 PThreadObj...08b8172700 OpalPres Command thread started >2014/02/28 09:50:21.105 0:05.370 PThreadObj...08b8172700 SIPPres 'sip:desktopqe@ekiga.net' sending subscribe for own presence.watcherinfo >2014/02/28 09:50:21.105 0:05.371 PThreadObj...08b8172700 SIP Start SUBSCRIBE > eventPackage=presence.winfo > aor=sip:desktopqe@ekiga.net > remote=sip:desktopqe@ekiga.net;transport=tcp > local=sip:desktopqe@ekiga.net > contact= > proxy= > authID=desktopqe > realm= > expire=300 > restore=30 > minRetry=default > maxRetry=default >2014/02/28 09:50:21.105 0:05.371 PThreadObj...08b8172700 SIP Constructed SUBSCRIBE handler for sip:desktopqe@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net >2014/02/28 09:50:21.105 0:05.371 PThreadObj...08b8172700 SIP Executing state change to Subscribing for SUBSCRIBE handler, target=sip:desktopqe@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=6ae83206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.105 0:05.371 PThreadObj...08b8172700 SIP Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:desktopqe@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=6ae83206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.105 0:05.371 PThreadObj...08b8172700 DNS SRV Lookup "_sip._tcp.ekiga.net" >2014/02/28 09:50:21.139 0:05.405 subscriber...08e40cc700 OpalUDP Started connect to 23.23.152.202:1719 >2014/02/28 09:50:21.139 0:05.405 subscriber...08e40cc700 PWLib File handle low water mark set: 58 PUDPSocket >2014/02/28 09:50:21.176 0:05.442 subscriber...08e408b700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.176 0:05.442 subscriber...08e408b700 OpalUDP Binding to interface: 0.0.0.0:5060 >2014/02/28 09:50:21.177 0:05.442 subscriber...08e408b700 PWLib File handle high water mark set: 62 PUDPSocket >2014/02/28 09:50:21.177 0:05.442 subscriber...08e408b700 SIP Created transport udp$86.64.162.35:5060<if=udp$*:5060> >2014/02/28 09:50:21.177 0:05.442 subscriber...08e408b700 OpalUDP Started connect to 86.64.162.35:5060 >2014/02/28 09:50:21.177 0:05.442 subscriber...08e408b700 OpalUDP Writing to interface 0 - "10.200.138.63%wlp3s0" >2014/02/28 09:50:21.177 0:05.443 subscriber...08e408b700 OpalMan Listener interfaces: associated transport=udp$10.200.138.63:5060 > udp$209.132.186.34:5060,udp$10.34.130.146:5060,udp$10.200.138.63:5060 >2014/02/28 09:50:21.178 0:05.443 subscriber...08e408b700 SIP Transaction created. >2014/02/28 09:50:21.178 0:05.444 subscriber...08e408b700 SIP Transaction remembering interface "10.200.138.63%wlp3s0" >2014/02/28 09:50:21.178 0:05.444 subscriber...08e408b700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.181 0:05.447 subscriber...08e40cc700 MonSock Created bundled UDP socket via STUN, internal=10.34.130.146:5061, external=209.132.186.34:5061 >2014/02/28 09:50:21.182 0:05.447 subscriber...08e40cc700 MonSock Created bundled UDP socket 10.200.138.63:5061 >2014/02/28 09:50:21.182 0:05.447 subscriber...08e40cc700 PWLib File handle high water mark set: 64 Thread unblock pipe >2014/02/28 09:50:21.182 0:05.447 subscriber...08e40cc700 PTLib Thread high water mark set: 14 >2014/02/28 09:50:21.182 0:05.447 subscriber...08e40cc700 PWLib File handle high water mark set: 65 PTextFile >2014/02/28 09:50:21.182 0:05.447 subscriber...08e40cc700 PTLib Thread ended: name="subscriber:0x7f08e40cc700", real=0.079, kernel=0.000 (0%), user=0.000 (0%), both=0.000 (0%) >2014/02/28 09:50:21.182 0:05.447 Transactor...08b8131700 Trans Starting listener thread on udp$23.23.152.202:1719<if=udp$*:5061> >2014/02/28 09:50:21.205 0:05.471 OpalPres Creating presentity command 'SIP_Presentity27OpalSetLocalPresenceCommand' >2014/02/28 09:50:21.205 0:05.471 Ekiga Sent its own presence (publish) for sip:desktopqe@ekiga.net: available, note I'm available using Ekiga >2014/02/28 09:50:21.320 0:05.585 PThreadObj...08b8172700 DNS Query failed: error=-1 >2014/02/28 09:50:21.320 0:05.586 PThreadObj...08b8172700 SIP No SRV record found. >2014/02/28 09:50:21.320 0:05.586 subscriber...08e408b700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.320 0:05.586 subscriber...08e408b700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:21.320 0:05.586 PThreadObj...08b8172700 SIP No compatible listener to create transport for tcp$ekiga.net:5060 >2014/02/28 09:50:21.320 0:05.586 PThreadObj...08b8172700 SIP Changing SUBSCRIBE handler from Subscribing to Unavailable, target=sip:desktopqe@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=6ae83206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.320 0:05.586 PThreadObj...08b8172700 SIP Retrying SUBSCRIBE after 30 seconds. >2014/02/28 09:50:21.320 0:05.586 PThreadObj...08b8172700 SIPPres 'sip:desktopqe@ekiga.net' sending own presence Available/I'm available using Ekiga >2014/02/28 09:50:21.320 0:05.586 subscriber...08e408b700 PWLib File handle low water mark set: 39 PUDPSocket >2014/02/28 09:50:21.320 0:05.586 PThreadObj...08b8172700 SIPPres PIDF entity derived from AOR as pres:desktopqe@ekiga.net >2014/02/28 09:50:21.320 0:05.586 subscriber...08e408b700 SIP Sending PDU (620 bytes) to: rem=udp$86.64.162.35:5060,local=udp$10.200.138.63:5060,if=10.200.138.63%wlp3s0 >REGISTER sip:ekiga.net SIP/2.0 >CSeq: 1 REGISTER >Via: SIP/2.0/UDP 10.200.138.63:5060;branch=z9hG4bK62f93d06-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=56c53206-c39e-e311-8b48-3c970e8ed11e >Call-ID: f2bf3206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net> >Contact: <sip:desktopqe@209.132.186.34:5060>;q=1, <sip:desktopqe@10.34.130.146:5060>;q=0.667, <sip:desktopqe@10.200.138.63:5060>;q=0.334 >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 3600 >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:21.320 0:05.586 PThreadObj...08b8172700 SIP Start PUBLISH > eventPackage=presence > aor=sip:desktopqe@ekiga.net > remote=sip:desktopqe@ekiga.net > local= > contact= > proxy= > authID= > realm= > expire=300 > restore=30 > minRetry=default > maxRetry=default >2014/02/28 09:50:21.320 0:05.586 subscriber...08e408b700 OpalUDP Setting interface to 10.200.138.63%wlp3s0 >2014/02/28 09:50:21.320 0:05.586 subscriber...08e408b700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:21.320 0:05.586 subscriber...08e408b700 OpalUDP Writing to interface 1 - "10.34.130.146%em1" >2014/02/28 09:50:21.321 0:05.586 PThreadObj...08b8172700 SIP Constructed PUBLISH handler for sip:desktopqe@ekiga.net >2014/02/28 09:50:21.321 0:05.586 PThreadObj...08b8172700 SIP Executing state change to Subscribing for PUBLISH handler, target=sip:desktopqe@ekiga.net, id=b2c05306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.321 0:05.586 PThreadObj...08b8172700 SIP Changing PUBLISH handler from Unavailable to Subscribing, target=sip:desktopqe@ekiga.net, id=b2c05306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.321 0:05.586 PThreadObj...08b8172700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.321 0:05.586 PThreadObj...08b8172700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.321 0:05.586 PThreadObj...08b8172700 OpalUDP Binding to interface: 0.0.0.0:5060 >2014/02/28 09:50:21.321 0:05.587 PThreadObj...08b8172700 SIP Created transport udp$86.64.162.35:5060<if=udp$*:5060> >2014/02/28 09:50:21.321 0:05.587 PThreadObj...08b8172700 OpalUDP Started connect to 86.64.162.35:5060 >2014/02/28 09:50:21.321 0:05.587 PThreadObj...08b8172700 OpalUDP Writing to interface 0 - "10.200.138.63%wlp3s0" >2014/02/28 09:50:21.321 0:05.587 PThreadObj...08b8172700 SIP Transaction created. >2014/02/28 09:50:21.321 0:05.587 subscriber...08e408b700 OpalMan Listener interfaces: associated transport=udp$209.132.186.34:27476 > udp$209.132.186.34:27476,udp$209.132.186.34:5060,udp$10.34.130.146:5060,udp$10.200.138.63:5060 >2014/02/28 09:50:21.321 0:05.587 PThreadObj...08b8172700 SIP Transaction remembering interface "10.200.138.63%wlp3s0" >2014/02/28 09:50:21.321 0:05.587 PThreadObj...08b8172700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.321 0:05.587 PThreadObj...08b8172700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.322 0:05.587 PThreadObj...08b8172700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:21.322 0:05.587 subscriber...08e408b700 SIP Transaction created. >2014/02/28 09:50:21.322 0:05.587 PThreadObj...08b8172700 SIP Sending PDU (908 bytes) to: rem=udp$86.64.162.35:5060,local=udp$10.200.138.63:5060,if=10.200.138.63%wlp3s0 >PUBLISH sip:desktopqe@ekiga.net SIP/2.0 >CSeq: 2 PUBLISH >Via: SIP/2.0/UDP 10.200.138.63:5060;branch=z9hG4bKbedc5306-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net> >Call-ID: b2c05306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net> >Expires: 300 >Event: presence >Content-Length: 490 >Content-Type: application/pidf+xml >Max-Forwards: 70 > ><?xml version="1.0" encoding="UTF-8"?> ><presence xmlns="urn:ietf:params:xml:ns:pidf" xmlns:dm="urn:ietf:params:xml:ns:pidf:data-model" xmlns:rpid="urn:ietf:params:xml:ns:pidf:rpid" entity="pres:desktopqe@ekiga.net"> > <tuple id="TC2D0471E"> > <status> > <basic>open</basic> > </status> > <contact priority="1">sip:desktopqe@ekiga.net</contact> > <note>I'm available using Ekiga</note> > <timestamp>2014-02-28T09:50:21+01:00</timestamp> > </tuple> ></presence> > >2014/02/28 09:50:21.322 0:05.587 PThreadObj...08b8172700 OpalUDP Setting interface to 10.200.138.63%wlp3s0 >2014/02/28 09:50:21.322 0:05.588 PThreadObj...08b8172700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:21.322 0:05.588 PThreadObj...08b8172700 OpalUDP Writing to interface 1 - "10.34.130.146%em1" >2014/02/28 09:50:21.322 0:05.588 PThreadObj...08b8172700 SIP Transaction created. >2014/02/28 09:50:21.322 0:05.588 subscriber...08e408b700 SIP Transaction remembering interface "10.34.130.146%em1" >2014/02/28 09:50:21.322 0:05.588 subscriber...08e408b700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.322 0:05.588 subscriber...08e408b700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.322 0:05.588 PThreadObj...08b8172700 SIP Transaction remembering interface "10.34.130.146%em1" >2014/02/28 09:50:21.322 0:05.588 subscriber...08e408b700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:21.322 0:05.588 PThreadObj...08b8172700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.322 0:05.588 PThreadObj...08b8172700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.322 0:05.588 PThreadObj...08b8172700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:21.322 0:05.588 subscriber...08e408b700 SIP Sending PDU (668 bytes) to: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >REGISTER sip:ekiga.net SIP/2.0 >CSeq: 1 REGISTER >Via: SIP/2.0/UDP 209.132.186.34:27476;branch=z9hG4bKecf45306-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=56c53206-c39e-e311-8b48-3c970e8ed11e >Call-ID: f2bf3206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net> >Contact: <sip:desktopqe@209.132.186.34:27476>;q=1, <sip:desktopqe@209.132.186.34:5060>;q=0.750, <sip:desktopqe@10.34.130.146:5060>;q=0.500, <sip:desktopqe@10.200.138.63:5060>;q=0.250 >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 3600 >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:21.323 0:05.588 subscriber...08e408b700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:21.322 0:05.588 PThreadObj...08b8172700 SIP Sending PDU (910 bytes) to: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >PUBLISH sip:desktopqe@ekiga.net SIP/2.0 >CSeq: 2 PUBLISH >Via: SIP/2.0/UDP 209.132.186.34:27476;branch=z9hG4bK10fe5306-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net> >Call-ID: b2c05306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net> >Expires: 300 >Event: presence >Content-Length: 490 >Content-Type: application/pidf+xml >Max-Forwards: 70 > ><?xml version="1.0" encoding="UTF-8"?> ><presence xmlns="urn:ietf:params:xml:ns:pidf" xmlns:dm="urn:ietf:params:xml:ns:pidf:data-model" xmlns:rpid="urn:ietf:params:xml:ns:pidf:rpid" entity="pres:desktopqe@ekiga.net"> > <tuple id="TC2D0471E"> > <status> > <basic>open</basic> > </status> > <contact priority="1">sip:desktopqe@ekiga.net</contact> > <note>I'm available using Ekiga</note> > <timestamp>2014-02-28T09:50:21+01:00</timestamp> > </tuple> ></presence> > >2014/02/28 09:50:21.323 0:05.588 PThreadObj...08b8172700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:21.323 0:05.588 subscriber...08e408b700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:21.323 0:05.588 PThreadObj...08b8172700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:21.323 0:05.589 subscriber...08e408b700 PTLib Thread ended: name="subscriber:0x7f08e408b700", real=0.220, kernel=0.000 (0%), user=0.000 (0%), both=0.000 (0%) >2014/02/28 09:50:21.370 0:05.636 Opal Liste...08ec121700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:50:21.370 0:05.636 Opal Liste...08ec121700 SIP Waiting for PDU on udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:21.370 0:05.636 Opal Liste...08ec121700 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SIP/2.0 401 Unauthorized >CSeq: 1 REGISTER >Via: SIP/2.0/UDP 10.34.130.146:5060;branch=z9hG4bKecf45306-c39e-e311-8b48-3c970e8ed11e;rport=27476 >Server: Kamailio (1.5.3-notls (i386/linux)) >From: <sip:desktopqe@ekiga.net>;tag=56c53206-c39e-e311-8b48-3c970e8ed11e >Call-ID: f2bf3206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.94f7 >Content-Length: 0 >WWW-Authenticate: Digest realm="ekiga.net", nonce="53104deb000055269c962fe0f6a1adb2e35939ab3284f321" > > >2014/02/28 09:50:21.370 0:05.636 Opal Liste...08ec121700 SIP Queueing PDU "1 REGISTER <401>", transaction=z9hG4bKecf45306-c39e-e311-8b48-3c970e8ed11e, token=f2bf3206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.370 0:05.636 Opal Liste...08ec121700 PTLib No permission to set priority level 3 >2014/02/28 09:50:21.371 0:05.636 Opal Liste...08ec121700 Opal Transport clean up on termination >2014/02/28 09:50:21.371 0:05.636 Opal Liste...08ec121700 Opal Transport Close >2014/02/28 09:50:21.371 0:05.636 Pool:0x7f08b80f0700 SIP Handling PDU "1 REGISTER <401>" for transaction=z9hG4bKecf45306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.371 0:05.636 Opal Liste...08ec121700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:21.371 0:05.636 Pool:0x7f08b80f0700 SIP REGISTER transaction id=z9hG4bKecf45306-c39e-e311-8b48-3c970e8ed11e completing. >2014/02/28 09:50:21.371 0:05.636 Pool:0x7f08b80f0700 SIP Finalising handlers interface "10.34.130.146%em1" >2014/02/28 09:50:21.371 0:05.636 Pool:0x7f08b80f0700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:21.371 0:05.637 Pool:0x7f08b80f0700 SIP Attempting to abort REGISTER transaction id=z9hG4bK62f93d06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.371 0:05.637 Pool:0x7f08b80f0700 SIP Set state Terminated_Aborted for REGISTER transaction id=z9hG4bK62f93d06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.371 0:05.637 Opal Liste...08ec121700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:50:21.371 0:05.637 Pool:0x7f08b80f0700 SIP Completed state for transaction id=z9hG4bK62f93d06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.371 0:05.637 Pool:0x7f08b80f0700 SIP Received Authentication Required response for z9hG4bKecf45306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.371 0:05.637 Pool:0x7f08b80f0700 SIP Creating authentication credentials of user "desktopqe" for realm "ekiga.net" >2014/02/28 09:50:21.371 0:05.637 Opal Liste...08ec121700 SIP Waiting for PDU on udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:21.371 0:05.637 Pool:0x7f08b80f0700 SIP Auth realm set to ekiga.net >2014/02/28 09:50:21.371 0:05.637 Opal Liste...08ec121700 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SIP/2.0 200 OK >CSeq: 2 PUBLISH >Via: SIP/2.0/UDP 10.34.130.146:5060;branch=z9hG4bK10fe5306-c39e-e311-8b48-3c970e8ed11e;rport=27476 >Server: Kamailio (1.5.3-notls (i386/linux)) >From: <sip:desktopqe@ekiga.net> >Call-ID: b2c05306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net>;tag=f85b0bd16aaafa8479586ac9f88b3198-8266 >Expires: 295 >Content-Length: 0 >SIP-ETag: a.1393349837.25351.408240.0 > > >2014/02/28 09:50:21.371 0:05.637 Opal Liste...08ec121700 SIP Queueing PDU "2 PUBLISH <200>", transaction=z9hG4bK10fe5306-c39e-e311-8b48-3c970e8ed11e, token=b2c05306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.371 0:05.637 Opal Liste...08ec121700 PTLib No permission to set priority level 3 >2014/02/28 09:50:21.371 0:05.637 Opal Liste...08ec121700 Opal Transport clean up on termination >2014/02/28 09:50:21.371 0:05.637 Opal Liste...08ec121700 Opal Transport Close >2014/02/28 09:50:21.371 0:05.637 Pool:0x7f08b80af700 SIP Handling PDU "2 PUBLISH <200>" for transaction=z9hG4bK10fe5306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.372 0:05.637 Pool:0x7f08b80af700 SIP PUBLISH transaction id=z9hG4bK10fe5306-c39e-e311-8b48-3c970e8ed11e completing. >2014/02/28 09:50:21.372 0:05.637 Opal Liste...08ec121700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:21.372 0:05.637 Pool:0x7f08b80af700 SIP Finalising handlers interface "10.34.130.146%em1" >2014/02/28 09:50:21.372 0:05.637 Pool:0x7f08b80af700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:21.372 0:05.638 Pool:0x7f08b80af700 SIP Attempting to abort PUBLISH transaction id=z9hG4bKbedc5306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.372 0:05.638 Pool:0x7f08b80af700 SIP Set state Terminated_Aborted for PUBLISH transaction id=z9hG4bKbedc5306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.372 0:05.638 Pool:0x7f08b80af700 SIP Completed state for transaction id=z9hG4bKbedc5306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.372 0:05.638 Pool:0x7f08b80af700 SIP Expiry time for PUBLISH set to 295 seconds. >2014/02/28 09:50:21.372 0:05.638 Pool:0x7f08b80af700 SIP Product Info: name="Kamailio", version="", vendor="", comments="(1.5.3-notls (i386/linux))" >2014/02/28 09:50:21.372 0:05.638 Pool:0x7f08b80af700 SIP Changing PUBLISH handler from Subscribing to Subscribed, target=sip:desktopqe@ekiga.net, id=b2c05306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.372 0:05.638 Pool:0x7f08b80f0700 OpalMan Listener interfaces: associated transport=udp$209.132.186.34:27476 > udp$209.132.186.34:27476,udp$209.132.186.34:5060,udp$10.34.130.146:5060,udp$10.200.138.63:5060 >2014/02/28 09:50:21.372 0:05.638 Pool:0x7f08b80af700 SIP PUBLISH transaction id=z9hG4bK10fe5306-c39e-e311-8b48-3c970e8ed11e completed. >2014/02/28 09:50:21.372 0:05.638 Pool:0x7f08b80af700 SIP Handled PDU "2 PUBLISH <200>" >2014/02/28 09:50:21.372 0:05.638 Pool:0x7f08b80f0700 SIP Transaction created. >2014/02/28 09:50:21.373 0:05.638 Pool:0x7f08b80f0700 HTTP Adding authentication information >2014/02/28 09:50:21.373 0:05.639 Pool:0x7f08b80f0700 SIP Transaction remembering interface "10.34.130.146%em1" >2014/02/28 09:50:21.373 0:05.639 Pool:0x7f08b80f0700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.373 0:05.639 Pool:0x7f08b80f0700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.373 0:05.639 Pool:0x7f08b80f0700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:21.373 0:05.639 Pool:0x7f08b80f0700 SIP Sending PDU (870 bytes) to: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >REGISTER sip:ekiga.net SIP/2.0 >CSeq: 4 REGISTER >Via: SIP/2.0/UDP 209.132.186.34:27476;branch=z9hG4bK26b35b06-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >Authorization: Digest username="desktopqe", realm="ekiga.net", nonce="53104deb000055269c962fe0f6a1adb2e35939ab3284f321", uri="sip:ekiga.net", algorithm=MD5, response="422a2d9e0329fa9676bb69ccc0caeb3b" >From: <sip:desktopqe@ekiga.net>;tag=56c53206-c39e-e311-8b48-3c970e8ed11e >Call-ID: f2bf3206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net> >Contact: <sip:desktopqe@209.132.186.34:27476>;q=1, <sip:desktopqe@209.132.186.34:5060>;q=0.750, <sip:desktopqe@10.34.130.146:5060>;q=0.500, <sip:desktopqe@10.200.138.63:5060>;q=0.250 >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 3600 >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:21.373 0:05.639 Pool:0x7f08b80f0700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:21.373 0:05.639 Pool:0x7f08b80f0700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:21.373 0:05.639 Pool:0x7f08b80f0700 SIP REGISTER transaction id=z9hG4bKecf45306-c39e-e311-8b48-3c970e8ed11e completed. >2014/02/28 09:50:21.373 0:05.639 Pool:0x7f08b80f0700 SIP Handled PDU "1 REGISTER <401>" >2014/02/28 09:50:21.426 0:05.692 Opal Liste...08ec121700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:50:21.427 0:05.692 Opal Liste...08ec121700 SIP Waiting for PDU on udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:21.427 0:05.692 Opal Liste...08ec121700 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SIP/2.0 200 OK >CSeq: 4 REGISTER >Via: SIP/2.0/UDP 10.34.130.146:5060;branch=z9hG4bK26b35b06-c39e-e311-8b48-3c970e8ed11e;rport=27476 >Server: Kamailio (1.5.3-notls (i386/linux)) >From: <sip:desktopqe@ekiga.net>;tag=56c53206-c39e-e311-8b48-3c970e8ed11e >Call-ID: f2bf3206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.c65f >Contact: <sip:desktopqe@10.34.130.146:5060>;q=1;expires=1200, <sip:desktopqe@10.34.130.146:27476>;q=1;expires=1133, <sip:desktopqe@10.34.130.122:5060>;q=0.75;expires=1200, <sip:desktopqe@10.200.138.63:5060>;q=0.25;expires=1200 >Content-Length: 0 > > >2014/02/28 09:50:21.427 0:05.693 Opal Liste...08ec121700 SIP Queueing PDU "4 REGISTER <200>", transaction=z9hG4bK26b35b06-c39e-e311-8b48-3c970e8ed11e, token=f2bf3206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.427 0:05.693 Opal Liste...08ec121700 Opal Transport clean up on termination >2014/02/28 09:50:21.427 0:05.693 Opal Liste...08ec121700 Opal Transport Close >2014/02/28 09:50:21.427 0:05.693 Pool:0x7f08b80f0700 SIP Handling PDU "4 REGISTER <200>" for transaction=z9hG4bK26b35b06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.427 0:05.693 Pool:0x7f08b80f0700 SIP REGISTER transaction id=z9hG4bK26b35b06-c39e-e311-8b48-3c970e8ed11e completing. >2014/02/28 09:50:21.427 0:05.693 Opal Liste...08ec121700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:21.427 0:05.693 Pool:0x7f08b80f0700 SIP Finalising handlers interface "10.34.130.146%em1" >2014/02/28 09:50:21.427 0:05.693 Pool:0x7f08b80f0700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:21.427 0:05.693 Pool:0x7f08b80f0700 SIP Product Info: name="Kamailio", version="", vendor="", comments="(1.5.3-notls (i386/linux))" >2014/02/28 09:50:21.428 0:05.693 Pool:0x7f08b80f0700 SIP Expiry time for REGISTER set to 1133 seconds. >2014/02/28 09:50:21.428 0:05.693 Pool:0x7f08b80f0700 SIP Changing REGISTER handler from Subscribing to Subscribed, target=sip:desktopqe@ekiga.net, id=f2bf3206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.428 0:05.693 Pool:0x7f08b80f0700 SIP REGISTER transaction id=z9hG4bK26b35b06-c39e-e311-8b48-3c970e8ed11e completed. >2014/02/28 09:50:21.428 0:05.693 Pool:0x7f08b80f0700 SIP Handled PDU "4 REGISTER <200>" >2014/02/28 09:50:21.524 0:05.790 Ekiga SubscribeToPresence for sip:500@ekiga.net (Account Registered) >2014/02/28 09:50:21.524 0:05.790 OpalPres Creating presentity command 'SIP_Presentity30OpalSubscribeToPresenceCommand' >2014/02/28 09:50:21.524 0:05.790 Ekiga SubscribeToPresence for sip:501@ekiga.net (Account Registered) >2014/02/28 09:50:21.525 0:05.790 OpalPres Creating presentity command 'SIP_Presentity30OpalSubscribeToPresenceCommand' >2014/02/28 09:50:21.525 0:05.790 PThreadObj...08b8172700 SIPPres 'sip:desktopqe@ekiga.net' subscribing to presence of 'sip:500@ekiga.net' >2014/02/28 09:50:21.525 0:05.790 Ekiga SubscribeToPresence for sip:520@ekiga.net (Account Registered) >2014/02/28 09:50:21.525 0:05.790 PThreadObj...08b8172700 SIP Start SUBSCRIBE > eventPackage=presence > aor=sip:500@ekiga.net > remote= > local=sip:desktopqe@ekiga.net > contact= > proxy= > authID=desktopqe > realm= > expire=300 > restore=30 > minRetry=default > maxRetry=default >2014/02/28 09:50:21.525 0:05.791 OpalPres Creating presentity command 'SIP_Presentity30OpalSubscribeToPresenceCommand' >2014/02/28 09:50:21.525 0:05.791 OpalPres Creating presentity command 'SIP_Presentity27OpalSetLocalPresenceCommand' >2014/02/28 09:50:21.525 0:05.791 SIP Start SUBSCRIBE > eventPackage=message-summary > aor=sip:desktopqe@ekiga.net > remote= > local= > contact= > proxy= > authID= > realm= > expire=3600 > restore=30 > minRetry=default > maxRetry=default >2014/02/28 09:50:21.525 0:05.791 PThreadObj...08b8172700 SIP Constructed SUBSCRIBE handler for sip:500@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net >2014/02/28 09:50:21.525 0:05.791 SIP Constructed SUBSCRIBE handler for sip:desktopqe@ekiga.net >2014/02/28 09:50:21.525 0:05.791 PThreadObj...08b8172700 SIP Executing state change to Subscribing for SUBSCRIBE handler, target=sip:500@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=def77206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.525 0:05.791 SIP Executing state change to Subscribing for SUBSCRIBE handler, target=sip:desktopqe@ekiga.net, id=ecf87206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.525 0:05.791 PThreadObj...08b8172700 SIP Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:500@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=def77206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.525 0:05.791 SIP Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:desktopqe@ekiga.net, id=ecf87206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.525 0:05.791 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.525 0:05.791 PThreadObj...08b8172700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.525 0:05.791 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.525 0:05.791 PThreadObj...08b8172700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.525 0:05.791 OpalUDP Binding to interface: 0.0.0.0:5060 >2014/02/28 09:50:21.525 0:05.791 PThreadObj...08b8172700 OpalUDP Binding to interface: 0.0.0.0:5060 >2014/02/28 09:50:21.526 0:05.791 PThreadObj...08b8172700 SIP Created transport udp$86.64.162.35:5060<if=udp$*:5060> >2014/02/28 09:50:21.526 0:05.791 PThreadObj...08b8172700 OpalUDP Started connect to 86.64.162.35:5060 >2014/02/28 09:50:21.526 0:05.791 SIP Created transport udp$86.64.162.35:5060<if=udp$*:5060> >2014/02/28 09:50:21.526 0:05.792 PThreadObj...08b8172700 OpalUDP Writing to interface 0 - "10.200.138.63%wlp3s0" >2014/02/28 09:50:21.526 0:05.792 OpalUDP Started connect to 86.64.162.35:5060 >2014/02/28 09:50:21.526 0:05.792 OpalUDP Writing to interface 0 - "10.200.138.63%wlp3s0" >2014/02/28 09:50:21.526 0:05.792 PThreadObj...08b8172700 SIP Transaction created. >2014/02/28 09:50:21.526 0:05.792 SIP Transaction created. >2014/02/28 09:50:21.527 0:05.792 PThreadObj...08b8172700 SIP Transaction remembering interface "10.200.138.63%wlp3s0" >2014/02/28 09:50:21.527 0:05.792 PThreadObj...08b8172700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.527 0:05.792 PThreadObj...08b8172700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.527 0:05.792 SIP Transaction remembering interface "10.200.138.63%wlp3s0" >2014/02/28 09:50:21.527 0:05.793 PThreadObj...08b8172700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:21.527 0:05.793 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.527 0:05.793 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.527 0:05.793 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:21.527 0:05.793 PThreadObj...08b8172700 SIP Sending PDU (647 bytes) to: rem=udp$86.64.162.35:5060,local=udp$10.200.138.63:5060,if=10.200.138.63%wlp3s0 >SUBSCRIBE sip:500@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.200.138.63:5060;branch=z9hG4bKdc217306-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=e61c7306-c39e-e311-8b48-3c970e8ed11e >Call-ID: def77206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >Supported: eventlist >To: <sip:500@ekiga.net> >Accept: application/pidf+xml >Accept: multipart/related >Accept: application/rlmi+xml >Contact: <sip:desktopqe@10.200.138.63> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 300 >Event: presence >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:21.527 0:05.793 PThreadObj...08b8172700 OpalUDP Setting interface to 10.200.138.63%wlp3s0 >2014/02/28 09:50:21.527 0:05.793 SIP Sending PDU (602 bytes) to: rem=udp$86.64.162.35:5060,local=udp$10.200.138.63:5060,if=10.200.138.63%wlp3s0 >SUBSCRIBE sip:desktopqe@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.200.138.63:5060;branch=z9hG4bK70247306-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=a21f7306-c39e-e311-8b48-3c970e8ed11e >Call-ID: ecf87206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net> >Accept: application/simple-message-summary >Contact: <sip:desktopqe@10.200.138.63> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 3600 >Event: message-summary >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:21.527 0:05.793 PThreadObj...08b8172700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:21.527 0:05.793 OpalUDP Setting interface to 10.200.138.63%wlp3s0 >2014/02/28 09:50:21.527 0:05.793 PThreadObj...08b8172700 OpalUDP Writing to interface 1 - "10.34.130.146%em1" >2014/02/28 09:50:21.527 0:05.793 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:21.527 0:05.793 OpalUDP Writing to interface 1 - "10.34.130.146%em1" >2014/02/28 09:50:21.527 0:05.793 PThreadObj...08b8172700 SIP Transaction created. >2014/02/28 09:50:21.527 0:05.793 SIP Transaction created. >2014/02/28 09:50:21.528 0:05.794 PThreadObj...08b8172700 SIP Transaction remembering interface "10.34.130.146%em1" >2014/02/28 09:50:21.528 0:05.794 PThreadObj...08b8172700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.528 0:05.794 SIP Transaction remembering interface "10.34.130.146%em1" >2014/02/28 09:50:21.528 0:05.794 PThreadObj...08b8172700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.528 0:05.794 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.528 0:05.794 PThreadObj...08b8172700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:21.528 0:05.794 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.528 0:05.794 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:21.528 0:05.794 PThreadObj...08b8172700 SIP Sending PDU (656 bytes) to: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SUBSCRIBE sip:500@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 209.132.186.34:27476;branch=z9hG4bK94557306-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=e61c7306-c39e-e311-8b48-3c970e8ed11e >Call-ID: def77206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >Supported: eventlist >To: <sip:500@ekiga.net> >Accept: application/pidf+xml >Accept: multipart/related >Accept: application/rlmi+xml >Contact: <sip:desktopqe@209.132.186.34:27476> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 300 >Event: presence >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:21.528 0:05.794 SIP Sending PDU (611 bytes) to: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SUBSCRIBE sip:desktopqe@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 209.132.186.34:27476;branch=z9hG4bK06577306-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=a21f7306-c39e-e311-8b48-3c970e8ed11e >Call-ID: ecf87206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net> >Accept: application/simple-message-summary >Contact: <sip:desktopqe@209.132.186.34:27476> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 3600 >Event: message-summary >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:21.528 0:05.794 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:21.528 0:05.794 PThreadObj...08b8172700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:21.528 0:05.794 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:21.528 0:05.794 PThreadObj...08b8172700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:21.529 0:05.794 OpalPres Creating presentity command 'SIP_Presentity27OpalSetLocalPresenceCommand' >2014/02/28 09:50:21.529 0:05.794 PThreadObj...08b8172700 SIPPres 'sip:desktopqe@ekiga.net' subscribing to presence of 'sip:501@ekiga.net' >2014/02/28 09:50:21.529 0:05.794 Ekiga Sent its own presence (publish) for sip:desktopqe@ekiga.net: available, note I'm available using Ekiga >2014/02/28 09:50:21.529 0:05.794 PThreadObj...08b8172700 SIP Start SUBSCRIBE > eventPackage=presence > aor=sip:501@ekiga.net > remote= > local=sip:desktopqe@ekiga.net > contact= > proxy= > authID=desktopqe > realm= > expire=300 > restore=30 > minRetry=default > maxRetry=default >2014/02/28 09:50:21.529 0:05.794 PThreadObj...08b8172700 SIP Constructed SUBSCRIBE handler for sip:501@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net >2014/02/28 09:50:21.529 0:05.795 PThreadObj...08b8172700 SIP Executing state change to Subscribing for SUBSCRIBE handler, target=sip:501@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=ac887306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.529 0:05.795 PThreadObj...08b8172700 SIP Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:501@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=ac887306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.529 0:05.795 PThreadObj...08b8172700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.529 0:05.795 PThreadObj...08b8172700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.529 0:05.795 PThreadObj...08b8172700 OpalUDP Binding to interface: 0.0.0.0:5060 >2014/02/28 09:50:21.529 0:05.795 PThreadObj...08b8172700 SIP Created transport udp$86.64.162.35:5060<if=udp$*:5060> >2014/02/28 09:50:21.529 0:05.795 PThreadObj...08b8172700 OpalUDP Started connect to 86.64.162.35:5060 >2014/02/28 09:50:21.529 0:05.795 PThreadObj...08b8172700 OpalUDP Writing to interface 0 - "10.200.138.63%wlp3s0" >2014/02/28 09:50:21.529 0:05.795 PThreadObj...08b8172700 SIP Transaction created. >2014/02/28 09:50:21.530 0:05.796 PThreadObj...08b8172700 SIP Transaction remembering interface "10.200.138.63%wlp3s0" >2014/02/28 09:50:21.530 0:05.796 PThreadObj...08b8172700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.530 0:05.796 PThreadObj...08b8172700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.530 0:05.796 PThreadObj...08b8172700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:21.530 0:05.796 PThreadObj...08b8172700 SIP Sending PDU (647 bytes) to: rem=udp$86.64.162.35:5060,local=udp$10.200.138.63:5060,if=10.200.138.63%wlp3s0 >SUBSCRIBE sip:501@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.200.138.63:5060;branch=z9hG4bK3aa07306-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=809b7306-c39e-e311-8b48-3c970e8ed11e >Call-ID: ac887306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >Supported: eventlist >To: <sip:501@ekiga.net> >Accept: application/pidf+xml >Accept: multipart/related >Accept: application/rlmi+xml >Contact: <sip:desktopqe@10.200.138.63> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 300 >Event: presence >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:21.530 0:05.796 PThreadObj...08b8172700 OpalUDP Setting interface to 10.200.138.63%wlp3s0 >2014/02/28 09:50:21.530 0:05.796 PThreadObj...08b8172700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:21.531 0:05.796 PThreadObj...08b8172700 OpalUDP Writing to interface 1 - "10.34.130.146%em1" >2014/02/28 09:50:21.531 0:05.796 PThreadObj...08b8172700 SIP Transaction created. >2014/02/28 09:50:21.531 0:05.797 PThreadObj...08b8172700 SIP Transaction remembering interface "10.34.130.146%em1" >2014/02/28 09:50:21.531 0:05.797 PThreadObj...08b8172700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.531 0:05.797 PThreadObj...08b8172700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.531 0:05.797 PThreadObj...08b8172700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:21.531 0:05.797 PThreadObj...08b8172700 SIP Sending PDU (656 bytes) to: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SUBSCRIBE sip:501@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 209.132.186.34:27476;branch=z9hG4bK92d47306-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=809b7306-c39e-e311-8b48-3c970e8ed11e >Call-ID: ac887306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >Supported: eventlist >To: <sip:501@ekiga.net> >Accept: application/pidf+xml >Accept: multipart/related >Accept: application/rlmi+xml >Contact: <sip:desktopqe@209.132.186.34:27476> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 300 >Event: presence >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:21.537 0:05.803 PThreadObj...08b8172700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:21.537 0:05.803 PThreadObj...08b8172700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:21.537 0:05.803 PThreadObj...08b8172700 SIPPres 'sip:desktopqe@ekiga.net' subscribing to presence of 'sip:520@ekiga.net' >2014/02/28 09:50:21.538 0:05.803 PThreadObj...08b8172700 SIP Start SUBSCRIBE > eventPackage=presence > aor=sip:520@ekiga.net > remote= > local=sip:desktopqe@ekiga.net > contact= > proxy= > authID=desktopqe > realm= > expire=300 > restore=30 > minRetry=default > maxRetry=default >2014/02/28 09:50:21.538 0:05.804 PThreadObj...08b8172700 SIP Constructed SUBSCRIBE handler for sip:520@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net >2014/02/28 09:50:21.538 0:05.804 PThreadObj...08b8172700 SIP Executing state change to Subscribing for SUBSCRIBE handler, target=sip:520@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=deeb7406-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.538 0:05.804 PThreadObj...08b8172700 SIP Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:520@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=deeb7406-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.538 0:05.804 PThreadObj...08b8172700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.538 0:05.804 PThreadObj...08b8172700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.538 0:05.804 PThreadObj...08b8172700 OpalUDP Binding to interface: 0.0.0.0:5060 >2014/02/28 09:50:21.538 0:05.804 PThreadObj...08b8172700 SIP Created transport udp$86.64.162.35:5060<if=udp$*:5060> >2014/02/28 09:50:21.539 0:05.804 PThreadObj...08b8172700 OpalUDP Started connect to 86.64.162.35:5060 >2014/02/28 09:50:21.539 0:05.804 PThreadObj...08b8172700 OpalUDP Writing to interface 0 - "10.200.138.63%wlp3s0" >2014/02/28 09:50:21.539 0:05.804 PThreadObj...08b8172700 SIP Transaction created. >2014/02/28 09:50:21.539 0:05.805 PThreadObj...08b8172700 SIP Transaction remembering interface "10.200.138.63%wlp3s0" >2014/02/28 09:50:21.539 0:05.805 PThreadObj...08b8172700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.539 0:05.805 PThreadObj...08b8172700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.539 0:05.805 PThreadObj...08b8172700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:21.540 0:05.805 PThreadObj...08b8172700 SIP Sending PDU (647 bytes) to: rem=udp$86.64.162.35:5060,local=udp$10.200.138.63:5060,if=10.200.138.63%wlp3s0 >SUBSCRIBE sip:520@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.200.138.63:5060;branch=z9hG4bK2e0f7506-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=a2097506-c39e-e311-8b48-3c970e8ed11e >Call-ID: deeb7406-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >Supported: eventlist >To: <sip:520@ekiga.net> >Accept: application/pidf+xml >Accept: multipart/related >Accept: application/rlmi+xml >Contact: <sip:desktopqe@10.200.138.63> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 300 >Event: presence >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:21.540 0:05.805 PThreadObj...08b8172700 OpalUDP Setting interface to 10.200.138.63%wlp3s0 >2014/02/28 09:50:21.540 0:05.805 PThreadObj...08b8172700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:21.540 0:05.806 PThreadObj...08b8172700 OpalUDP Writing to interface 1 - "10.34.130.146%em1" >2014/02/28 09:50:21.540 0:05.806 PThreadObj...08b8172700 SIP Transaction created. >2014/02/28 09:50:21.541 0:05.806 PThreadObj...08b8172700 SIP Transaction remembering interface "10.34.130.146%em1" >2014/02/28 09:50:21.541 0:05.806 PThreadObj...08b8172700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.541 0:05.806 PThreadObj...08b8172700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.541 0:05.806 PThreadObj...08b8172700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:21.541 0:05.806 PThreadObj...08b8172700 SIP Sending PDU (656 bytes) to: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SUBSCRIBE sip:520@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 209.132.186.34:27476;branch=z9hG4bK2e417506-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=a2097506-c39e-e311-8b48-3c970e8ed11e >Call-ID: deeb7406-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >Supported: eventlist >To: <sip:520@ekiga.net> >Accept: application/pidf+xml >Accept: multipart/related >Accept: application/rlmi+xml >Contact: <sip:desktopqe@209.132.186.34:27476> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 300 >Event: presence >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:21.541 0:05.807 PThreadObj...08b8172700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:21.541 0:05.807 PThreadObj...08b8172700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:21.576 0:05.842 Opal Liste...08ec121700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:50:21.577 0:05.842 Opal Liste...08ec121700 SIP Waiting for PDU on udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:21.577 0:05.842 Opal Liste...08ec121700 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SIP/2.0 489 Event Not Supported >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.34.130.146:5060;branch=z9hG4bK94557306-c39e-e311-8b48-3c970e8ed11e;rport=27476 >Server: Kamailio (1.5.3-notls (i386/linux)) >From: <sip:desktopqe@ekiga.net>;tag=e61c7306-c39e-e311-8b48-3c970e8ed11e >Call-ID: def77206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:500@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.7785 >Content-Length: 0 > > >2014/02/28 09:50:21.577 0:05.843 Opal Liste...08ec121700 SIP Queueing PDU "1 SUBSCRIBE <489>", transaction=z9hG4bK94557306-c39e-e311-8b48-3c970e8ed11e, token=def77206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.577 0:05.843 Opal Liste...08ec121700 Opal Transport clean up on termination >2014/02/28 09:50:21.577 0:05.843 Opal Liste...08ec121700 Opal Transport Close >2014/02/28 09:50:21.577 0:05.843 Pool:0x7f08b80f0700 SIP Handling PDU "1 SUBSCRIBE <489>" for transaction=z9hG4bK94557306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.577 0:05.843 Pool:0x7f08b80f0700 SIP SUBSCRIBE transaction id=z9hG4bK94557306-c39e-e311-8b48-3c970e8ed11e completing. >2014/02/28 09:50:21.577 0:05.843 Opal Liste...08ec121700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:21.577 0:05.843 Pool:0x7f08b80f0700 SIPPres 'sip:desktopqe@ekiga.net' error subscribing to presence of 'sip:500@ekiga.net' >2014/02/28 09:50:21.577 0:05.843 Opal Liste...08ec121700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:50:21.577 0:05.843 Pool:0x7f08b80f0700 SIP Expiry time for SUBSCRIBE set to 300 seconds. >2014/02/28 09:50:21.577 0:05.843 Pool:0x7f08b80f0700 SIP Queueing state change to Unsubscribing for SUBSCRIBE handler while in Subscribing state, target=sip:500@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=def77206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.577 0:05.843 Opal Liste...08ec121700 SIP Waiting for PDU on udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:21.577 0:05.843 Pool:0x7f08b80f0700 SIP Not retrying SUBSCRIBE due to error response 489 Bad Event >2014/02/28 09:50:21.577 0:05.843 Pool:0x7f08b80f0700 SIP Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:500@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=def77206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.578 0:05.843 Pool:0x7f08b80f0700 SIP Changing SUBSCRIBE handler from Unsubscribed to Unsubscribing, target=sip:500@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=def77206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.577 0:05.843 Opal Liste...08ec121700 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SIP/2.0 489 Event Not Supported >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.34.130.146:5060;branch=z9hG4bK06577306-c39e-e311-8b48-3c970e8ed11e;rport=27476 >Server: Kamailio (1.5.3-notls (i386/linux)) >From: <sip:desktopqe@ekiga.net>;tag=a21f7306-c39e-e311-8b48-3c970e8ed11e >Call-ID: ecf87206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.1a42 >Content-Length: 0 > > >2014/02/28 09:50:21.578 0:05.843 Pool:0x7f08b80f0700 OpalUDP Writing to interface 0 - "10.200.138.63%wlp3s0" >2014/02/28 09:50:21.578 0:05.843 Opal Liste...08ec121700 SIP Queueing PDU "1 SUBSCRIBE <489>", transaction=z9hG4bK06577306-c39e-e311-8b48-3c970e8ed11e, token=ecf87206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.578 0:05.843 Opal Liste...08ec121700 Opal Transport clean up on termination >2014/02/28 09:50:21.578 0:05.843 Opal Liste...08ec121700 Opal Transport Close >2014/02/28 09:50:21.578 0:05.843 Pool:0x7f08b80af700 SIP Handling PDU "1 SUBSCRIBE <489>" for transaction=z9hG4bK06577306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.578 0:05.843 Pool:0x7f08b80af700 SIP SUBSCRIBE transaction id=z9hG4bK06577306-c39e-e311-8b48-3c970e8ed11e completing. >2014/02/28 09:50:21.578 0:05.843 Pool:0x7f08b80f0700 SIP Transaction created. >2014/02/28 09:50:21.578 0:05.843 Opal Liste...08ec121700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:21.578 0:05.844 Pool:0x7f08b80af700 SIP Not retrying SUBSCRIBE due to error response 489 Bad Event >2014/02/28 09:50:21.578 0:05.844 Pool:0x7f08b80af700 SIP Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:desktopqe@ekiga.net, id=ecf87206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.578 0:05.844 Pool:0x7f08b80af700 SIP SUBSCRIBE transaction id=z9hG4bK06577306-c39e-e311-8b48-3c970e8ed11e completed. >2014/02/28 09:50:21.578 0:05.844 Pool:0x7f08b80af700 SIP Handled PDU "1 SUBSCRIBE <489>" >2014/02/28 09:50:21.578 0:05.844 Pool:0x7f08b80f0700 SIP Transaction remembering interface "10.200.138.63%wlp3s0" >2014/02/28 09:50:21.578 0:05.844 Pool:0x7f08b80f0700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.579 0:05.844 Pool:0x7f08b80f0700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.579 0:05.844 Pool:0x7f08b80f0700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:21.579 0:05.844 Pool:0x7f08b80f0700 SIP Sending PDU (645 bytes) to: rem=udp$86.64.162.35:5060,local=udp$10.200.138.63:5060,if=10.200.138.63%wlp3s0 >SUBSCRIBE sip:500@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.200.138.63:5060;branch=z9hG4bKf6097b06-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=e61c7306-c39e-e311-8b48-3c970e8ed11e >Call-ID: def77206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >Supported: eventlist >To: <sip:500@ekiga.net> >Accept: application/pidf+xml >Accept: multipart/related >Accept: application/rlmi+xml >Contact: <sip:desktopqe@10.200.138.63> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 0 >Event: presence >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:21.579 0:05.844 Pool:0x7f08b80f0700 OpalUDP Setting interface to 10.200.138.63%wlp3s0 >2014/02/28 09:50:21.579 0:05.844 Pool:0x7f08b80f0700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:21.579 0:05.845 Pool:0x7f08b80f0700 OpalUDP Writing to interface 1 - "10.34.130.146%em1" >2014/02/28 09:50:21.579 0:05.845 Pool:0x7f08b80f0700 SIP Transaction created. >2014/02/28 09:50:21.579 0:05.845 Pool:0x7f08b80f0700 SIP Transaction remembering interface "10.34.130.146%em1" >2014/02/28 09:50:21.580 0:05.845 Pool:0x7f08b80f0700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.580 0:05.845 Pool:0x7f08b80f0700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.580 0:05.845 Pool:0x7f08b80f0700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:21.580 0:05.845 Pool:0x7f08b80f0700 SIP Sending PDU (654 bytes) to: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SUBSCRIBE sip:500@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 209.132.186.34:27476;branch=z9hG4bKb4327b06-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=e61c7306-c39e-e311-8b48-3c970e8ed11e >Call-ID: def77206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >Supported: eventlist >To: <sip:500@ekiga.net> >Accept: application/pidf+xml >Accept: multipart/related >Accept: application/rlmi+xml >Contact: <sip:desktopqe@209.132.186.34:27476> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 0 >Event: presence >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:21.580 0:05.845 Pool:0x7f08b80f0700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:21.580 0:05.845 Pool:0x7f08b80f0700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:21.580 0:05.846 Pool:0x7f08b80f0700 SIP SUBSCRIBE transaction id=z9hG4bK94557306-c39e-e311-8b48-3c970e8ed11e completed. >2014/02/28 09:50:21.580 0:05.846 Pool:0x7f08b80f0700 SIP Handled PDU "1 SUBSCRIBE <489>" >2014/02/28 09:50:21.584 0:05.849 Opal Liste...08ec121700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:50:21.584 0:05.849 Opal Liste...08ec121700 SIP Waiting for PDU on udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:21.584 0:05.849 Opal Liste...08ec121700 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SIP/2.0 489 Event Not Supported >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.34.130.146:5060;branch=z9hG4bK92d47306-c39e-e311-8b48-3c970e8ed11e;rport=27476 >Server: Kamailio (1.5.3-notls (i386/linux)) >From: <sip:desktopqe@ekiga.net>;tag=809b7306-c39e-e311-8b48-3c970e8ed11e >Call-ID: ac887306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:501@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.ec48 >Content-Length: 0 > > >2014/02/28 09:50:21.584 0:05.850 Opal Liste...08ec121700 SIP Queueing PDU "1 SUBSCRIBE <489>", transaction=z9hG4bK92d47306-c39e-e311-8b48-3c970e8ed11e, token=ac887306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.584 0:05.850 Opal Liste...08ec121700 Opal Transport clean up on termination >2014/02/28 09:50:21.584 0:05.850 Opal Liste...08ec121700 Opal Transport Close >2014/02/28 09:50:21.584 0:05.850 Pool:0x7f08b80f0700 SIP Handling PDU "1 SUBSCRIBE <489>" for transaction=z9hG4bK92d47306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.584 0:05.850 Pool:0x7f08b80f0700 SIP SUBSCRIBE transaction id=z9hG4bK92d47306-c39e-e311-8b48-3c970e8ed11e completing. >2014/02/28 09:50:21.584 0:05.850 Pool:0x7f08b80f0700 SIPPres 'sip:desktopqe@ekiga.net' error subscribing to presence of 'sip:501@ekiga.net' >2014/02/28 09:50:21.584 0:05.850 Opal Liste...08ec121700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:21.584 0:05.850 Pool:0x7f08b80f0700 SIP Expiry time for SUBSCRIBE set to 300 seconds. >2014/02/28 09:50:21.584 0:05.850 Pool:0x7f08b80f0700 SIP Queueing state change to Unsubscribing for SUBSCRIBE handler while in Subscribing state, target=sip:501@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=ac887306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.584 0:05.850 Pool:0x7f08b80f0700 SIP Not retrying SUBSCRIBE due to error response 489 Bad Event >2014/02/28 09:50:21.584 0:05.850 Pool:0x7f08b80f0700 SIP Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:501@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=ac887306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.584 0:05.850 Pool:0x7f08b80f0700 SIP Changing SUBSCRIBE handler from Unsubscribed to Unsubscribing, target=sip:501@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=ac887306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.584 0:05.850 Pool:0x7f08b80f0700 OpalUDP Writing to interface 0 - "10.200.138.63%wlp3s0" >2014/02/28 09:50:21.584 0:05.850 Pool:0x7f08b80f0700 SIP Transaction created. >2014/02/28 09:50:21.585 0:05.851 Pool:0x7f08b80f0700 SIP Transaction remembering interface "10.200.138.63%wlp3s0" >2014/02/28 09:50:21.585 0:05.851 Pool:0x7f08b80f0700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.585 0:05.851 Pool:0x7f08b80f0700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.585 0:05.851 Pool:0x7f08b80f0700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:21.585 0:05.851 Pool:0x7f08b80f0700 SIP Sending PDU (645 bytes) to: rem=udp$86.64.162.35:5060,local=udp$10.200.138.63:5060,if=10.200.138.63%wlp3s0 >SUBSCRIBE sip:501@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.200.138.63:5060;branch=z9hG4bKa80b7c06-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=809b7306-c39e-e311-8b48-3c970e8ed11e >Call-ID: ac887306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >Supported: eventlist >To: <sip:501@ekiga.net> >Accept: application/pidf+xml >Accept: multipart/related >Accept: application/rlmi+xml >Contact: <sip:desktopqe@10.200.138.63> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 0 >Event: presence >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:21.585 0:05.851 Pool:0x7f08b80f0700 OpalUDP Setting interface to 10.200.138.63%wlp3s0 >2014/02/28 09:50:21.585 0:05.851 Pool:0x7f08b80f0700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:21.585 0:05.851 Pool:0x7f08b80f0700 OpalUDP Writing to interface 1 - "10.34.130.146%em1" >2014/02/28 09:50:21.586 0:05.851 Pool:0x7f08b80f0700 SIP Transaction created. >2014/02/28 09:50:21.586 0:05.852 Pool:0x7f08b80f0700 SIP Transaction remembering interface "10.34.130.146%em1" >2014/02/28 09:50:21.586 0:05.852 Pool:0x7f08b80f0700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.586 0:05.852 Pool:0x7f08b80f0700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.586 0:05.852 Pool:0x7f08b80f0700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:21.586 0:05.852 Pool:0x7f08b80f0700 SIP Sending PDU (654 bytes) to: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SUBSCRIBE sip:501@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 209.132.186.34:27476;branch=z9hG4bK1c337c06-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=809b7306-c39e-e311-8b48-3c970e8ed11e >Call-ID: ac887306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >Supported: eventlist >To: <sip:501@ekiga.net> >Accept: application/pidf+xml >Accept: multipart/related >Accept: application/rlmi+xml >Contact: <sip:desktopqe@209.132.186.34:27476> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 0 >Event: presence >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:21.586 0:05.852 Pool:0x7f08b80f0700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:21.586 0:05.852 Pool:0x7f08b80f0700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:21.586 0:05.852 Pool:0x7f08b80f0700 SIP SUBSCRIBE transaction id=z9hG4bK92d47306-c39e-e311-8b48-3c970e8ed11e completed. >2014/02/28 09:50:21.586 0:05.852 Pool:0x7f08b80f0700 SIP Handled PDU "1 SUBSCRIBE <489>" >2014/02/28 09:50:21.589 0:05.855 Opal Liste...08ec121700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:50:21.589 0:05.855 Opal Liste...08ec121700 SIP Waiting for PDU on udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:21.589 0:05.855 Opal Liste...08ec121700 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SIP/2.0 489 Event Not Supported >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.34.130.146:5060;branch=z9hG4bK2e417506-c39e-e311-8b48-3c970e8ed11e;rport=27476 >Server: Kamailio (1.5.3-notls (i386/linux)) >From: <sip:desktopqe@ekiga.net>;tag=a2097506-c39e-e311-8b48-3c970e8ed11e >Call-ID: deeb7406-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:520@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.a90b >Content-Length: 0 > > >2014/02/28 09:50:21.607 0:05.873 Opal Liste...08ec121700 SIP Queueing PDU "1 SUBSCRIBE <489>", transaction=z9hG4bK2e417506-c39e-e311-8b48-3c970e8ed11e, token=deeb7406-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.607 0:05.873 Opal Liste...08ec121700 Opal Transport clean up on termination >2014/02/28 09:50:21.607 0:05.873 Opal Liste...08ec121700 Opal Transport Close >2014/02/28 09:50:21.607 0:05.873 Pool:0x7f08b80f0700 SIP Handling PDU "1 SUBSCRIBE <489>" for transaction=z9hG4bK2e417506-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.607 0:05.873 Pool:0x7f08b80f0700 SIP SUBSCRIBE transaction id=z9hG4bK2e417506-c39e-e311-8b48-3c970e8ed11e completing. >2014/02/28 09:50:21.607 0:05.873 Pool:0x7f08b80f0700 SIPPres 'sip:desktopqe@ekiga.net' error subscribing to presence of 'sip:520@ekiga.net' >2014/02/28 09:50:21.607 0:05.873 Opal Liste...08ec121700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:21.607 0:05.873 Pool:0x7f08b80f0700 SIP Expiry time for SUBSCRIBE set to 300 seconds. >2014/02/28 09:50:21.607 0:05.873 Pool:0x7f08b80f0700 SIP Queueing state change to Unsubscribing for SUBSCRIBE handler while in Subscribing state, target=sip:520@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=deeb7406-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.608 0:05.873 Pool:0x7f08b80f0700 SIP Not retrying SUBSCRIBE due to error response 489 Bad Event >2014/02/28 09:50:21.608 0:05.873 Pool:0x7f08b80f0700 SIP Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:520@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=deeb7406-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.608 0:05.873 Pool:0x7f08b80f0700 SIP Changing SUBSCRIBE handler from Unsubscribed to Unsubscribing, target=sip:520@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=deeb7406-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.608 0:05.874 Pool:0x7f08b80f0700 OpalUDP Writing to interface 0 - "10.200.138.63%wlp3s0" >2014/02/28 09:50:21.608 0:05.874 Pool:0x7f08b80f0700 SIP Transaction created. >2014/02/28 09:50:21.609 0:05.875 Pool:0x7f08b80f0700 SIP Transaction remembering interface "10.200.138.63%wlp3s0" >2014/02/28 09:50:21.609 0:05.875 Pool:0x7f08b80f0700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.609 0:05.875 Pool:0x7f08b80f0700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.609 0:05.875 Pool:0x7f08b80f0700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:21.609 0:05.875 Pool:0x7f08b80f0700 SIP Sending PDU (645 bytes) to: rem=udp$86.64.162.35:5060,local=udp$10.200.138.63:5060,if=10.200.138.63%wlp3s0 >SUBSCRIBE sip:520@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.200.138.63:5060;branch=z9hG4bKe4a87f06-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=a2097506-c39e-e311-8b48-3c970e8ed11e >Call-ID: deeb7406-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >Supported: eventlist >To: <sip:520@ekiga.net> >Accept: application/pidf+xml >Accept: multipart/related >Accept: application/rlmi+xml >Contact: <sip:desktopqe@10.200.138.63> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 0 >Event: presence >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:21.610 0:05.875 Pool:0x7f08b80f0700 OpalUDP Setting interface to 10.200.138.63%wlp3s0 >2014/02/28 09:50:21.610 0:05.876 Pool:0x7f08b80f0700 SIP Transaction timers set: retry=0.499, completion=5.999 >2014/02/28 09:50:21.610 0:05.876 Pool:0x7f08b80f0700 OpalUDP Writing to interface 1 - "10.34.130.146%em1" >2014/02/28 09:50:21.610 0:05.876 Pool:0x7f08b80f0700 SIP Transaction created. >2014/02/28 09:50:21.611 0:05.877 Pool:0x7f08b80f0700 SIP Transaction remembering interface "10.34.130.146%em1" >2014/02/28 09:50:21.611 0:05.877 Pool:0x7f08b80f0700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:21.611 0:05.877 Pool:0x7f08b80f0700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:21.611 0:05.877 Pool:0x7f08b80f0700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:21.611 0:05.877 Pool:0x7f08b80f0700 SIP Sending PDU (654 bytes) to: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SUBSCRIBE sip:520@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 209.132.186.34:27476;branch=z9hG4bK04f77f06-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=a2097506-c39e-e311-8b48-3c970e8ed11e >Call-ID: deeb7406-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >Supported: eventlist >To: <sip:520@ekiga.net> >Accept: application/pidf+xml >Accept: multipart/related >Accept: application/rlmi+xml >Contact: <sip:desktopqe@209.132.186.34:27476> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 0 >Event: presence >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:21.611 0:05.877 Pool:0x7f08b80f0700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:21.611 0:05.877 Pool:0x7f08b80f0700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:21.611 0:05.877 Pool:0x7f08b80f0700 SIP SUBSCRIBE transaction id=z9hG4bK2e417506-c39e-e311-8b48-3c970e8ed11e completed. >2014/02/28 09:50:21.611 0:05.877 Pool:0x7f08b80f0700 SIP Handled PDU "1 SUBSCRIBE <489>" >2014/02/28 09:50:21.627 0:05.892 Opal Liste...08ec121700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:50:21.627 0:05.892 Opal Liste...08ec121700 SIP Waiting for PDU on udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:21.627 0:05.893 Opal Liste...08ec121700 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SIP/2.0 489 Event Not Supported >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.34.130.146:5060;branch=z9hG4bKb4327b06-c39e-e311-8b48-3c970e8ed11e;rport=27476 >Server: Kamailio (1.5.3-notls (i386/linux)) >From: <sip:desktopqe@ekiga.net>;tag=e61c7306-c39e-e311-8b48-3c970e8ed11e >Call-ID: def77206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:500@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.5e62 >Content-Length: 0 > > >2014/02/28 09:50:21.627 0:05.893 Opal Liste...08ec121700 SIP Queueing PDU "1 SUBSCRIBE <489>", transaction=z9hG4bKb4327b06-c39e-e311-8b48-3c970e8ed11e, token=def77206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.627 0:05.893 Opal Liste...08ec121700 Opal Transport clean up on termination >2014/02/28 09:50:21.627 0:05.893 Opal Liste...08ec121700 Opal Transport Close >2014/02/28 09:50:21.627 0:05.893 Pool:0x7f08b80f0700 SIP Handling PDU "1 SUBSCRIBE <489>" for transaction=z9hG4bKb4327b06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.627 0:05.893 Pool:0x7f08b80f0700 SIP SUBSCRIBE transaction id=z9hG4bKb4327b06-c39e-e311-8b48-3c970e8ed11e completing. >2014/02/28 09:50:21.627 0:05.893 Opal Liste...08ec121700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:21.627 0:05.893 Pool:0x7f08b80f0700 SIP Not retrying SUBSCRIBE due to error response 489 Bad Event >2014/02/28 09:50:21.627 0:05.893 Pool:0x7f08b80f0700 SIP Changing SUBSCRIBE handler from Unsubscribing to Unsubscribed, target=sip:500@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=def77206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.627 0:05.893 Pool:0x7f08b80f0700 SIP SUBSCRIBE transaction id=z9hG4bKb4327b06-c39e-e311-8b48-3c970e8ed11e completed. >2014/02/28 09:50:21.627 0:05.893 Pool:0x7f08b80f0700 SIP Handled PDU "1 SUBSCRIBE <489>" >2014/02/28 09:50:21.682 0:05.947 GkMonitor:...08e404a700 RAS Time To Live reregistration >2014/02/28 09:50:21.682 0:05.948 GkMonitor:...08e404a700 OpalUDP Writing to interface 0 - "10.200.138.63%wlp3s0" >2014/02/28 09:50:21.683 0:05.949 GkMonitor:...08e404a700 OpalMan Listener interfaces: associated transport=udp$10.200.138.63:5061 > tcp$209.132.186.34:1720,tcp$10.34.130.146:1720,tcp$10.200.138.63:1720 >2014/02/28 09:50:21.683 0:05.949 GkMonitor:...08e404a700 Trans Sending PDU: > gatekeeperRequest { > requestSeqNum = 54506 > protocolIdentifier = 0.0.8.2250.0.6 > rasAddress = ipAddress { > ip = 4 octets { > 0a c8 8a 3f ...? > } > port = 5061 > } > endpointType = { > vendor = { > vendor = { > t35CountryCode = 9 > t35Extension = 0 > manufacturerCode = 61 > } > productId = 3 octets { > 00 00 00 ... > } > versionId = 35 octets { > 34 2e 30 2e 31 20 28 4f 50 41 4c 20 76 33 2e 31 4.0.1 (OPAL v3.1 > 30 2e 31 30 20 28 73 76 6e 3a 32 39 31 35 30 29 0.10 (svn:29150) > ... > } > } > terminal = { > } > mc = false > undefinedNode = false > } > endpointAlias = 2 entries { > [0]=h323_ID 9 characters { > 0064 0065 0073 006b 0074 006f 0070 0071 desktopq > 0065 e > } > [1]=h323_ID 12 characters { > 004d 0061 0072 0074 0069 006e 0020 0053 Martin S > 0069 006d 006f 006e imon > } > } > authenticationCapability = 2 entries { > [0]=pwdHash <<null>> > [1]=authenticationBES radius <<null>> > } > algorithmOIDs = 3 entries { > [0]=0.0.8.235.0.2.6 > [1]=1.2.840.113548.10.1.2.1 > [2]=1.2.840.113549.2.5 > } > supportsAltGK = <<null>> > } >2014/02/28 09:50:21.683 0:05.949 GkMonitor:...08e404a700 OpalUDP Writing to interface 1 - "10.34.130.146%em1" >2014/02/28 09:50:21.684 0:05.949 GkMonitor:...08e404a700 OpalMan Listener interfaces: associated transport=udp$209.132.186.34:5061 > tcp$209.132.186.34:1720,tcp$10.34.130.146:1720,tcp$10.200.138.63:1720 >2014/02/28 09:50:21.684 0:05.950 GkMonitor:...08e404a700 Trans Sending PDU: > gatekeeperRequest { > requestSeqNum = 54506 > protocolIdentifier = 0.0.8.2250.0.6 > rasAddress = ipAddress { > ip = 4 octets { > d1 84 ba 22 ..." > } > port = 5061 > } > endpointType = { > vendor = { > vendor = { > t35CountryCode = 9 > t35Extension = 0 > manufacturerCode = 61 > } > productId = 3 octets { > 00 00 00 ... > } > versionId = 35 octets { > 34 2e 30 2e 31 20 28 4f 50 41 4c 20 76 33 2e 31 4.0.1 (OPAL v3.1 > 30 2e 31 30 20 28 73 76 6e 3a 32 39 31 35 30 29 0.10 (svn:29150) > ... > } > } > terminal = { > } > mc = false > undefinedNode = false > } > endpointAlias = 2 entries { > [0]=h323_ID 9 characters { > 0064 0065 0073 006b 0074 006f 0070 0071 desktopq > 0065 e > } > [1]=h323_ID 12 characters { > 004d 0061 0072 0074 0069 006e 0020 0053 Martin S > 0069 006d 006f 006e imon > } > } > authenticationCapability = 2 entries { > [0]=pwdHash <<null>> > [1]=authenticationBES radius <<null>> > } > algorithmOIDs = 3 entries { > [0]=0.0.8.235.0.2.6 > [1]=1.2.840.113548.10.1.2.1 > [2]=1.2.840.113549.2.5 > } > supportsAltGK = <<null>> > } >2014/02/28 09:50:21.684 0:05.950 GkMonitor:...08e404a700 OpalUDP Setting interface to >2014/02/28 09:50:21.684 0:05.950 GkMonitor:...08e404a700 Trans Waiting on response to seqnum=54506 for 5.0 seconds >2014/02/28 09:50:21.816 0:06.082 Opal Garba...090afa8700 SIP Transaction id=z9hG4bK62f93d06-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:21.817 0:06.082 Opal Garba...090afa8700 SIP Transaction id=z9hG4bKbedc5306-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:21.817 0:06.083 Opal Garba...090afa8700 SIP Attempting to abort SUBSCRIBE transaction id=z9hG4bKdc217306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.817 0:06.083 Opal Garba...090afa8700 SIP Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bKdc217306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.817 0:06.083 Opal Garba...090afa8700 SIP Handler SIPSubscribeHandler unsubscribed, awaiting shutdown. >2014/02/28 09:50:21.817 0:06.083 Opal Garba...090afa8700 SIP Attempting to abort SUBSCRIBE transaction id=z9hG4bKdc217306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.817 0:06.083 Opal Garba...090afa8700 SIP Attempting to abort SUBSCRIBE transaction id=z9hG4bKf6097b06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.817 0:06.083 Opal Garba...090afa8700 SIP Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bKf6097b06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.817 0:06.083 Opal Garba...090afa8700 SIP Handler SIPSubscribeHandler unsubscribed, awaiting shutdown. >2014/02/28 09:50:21.817 0:06.083 Opal Garba...090afa8700 SIP Attempting to abort SUBSCRIBE transaction id=z9hG4bKdc217306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.817 0:06.083 Opal Garba...090afa8700 SIP Attempting to abort SUBSCRIBE transaction id=z9hG4bKf6097b06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.817 0:06.083 Opal Garba...090afa8700 SIP Transaction 1 SUBSCRIBE sip:500@ekiga.net failed, unknown handler, ID: def77206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.817 0:06.083 Opal Garba...090afa8700 SIP Completed state for transaction id=z9hG4bKf6097b06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.817 0:06.083 Opal Garba...090afa8700 SIP Transaction 1 SUBSCRIBE sip:500@ekiga.net failed, unknown handler, ID: def77206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:21.817 0:06.083 Opal Garba...090afa8700 SIP Completed state for transaction id=z9hG4bKdc217306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.817 0:06.083 Opal Garba...090afa8700 SIP Attempting to abort SUBSCRIBE transaction id=z9hG4bKf6097b06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:21.817 0:06.083 Opal Garba...090afa8700 Opal Transport clean up on termination >2014/02/28 09:50:21.817 0:06.083 Opal Garba...090afa8700 Opal Transport Close >2014/02/28 09:50:21.817 0:06.083 Opal Garba...090afa8700 Opal Transport clean up on termination >2014/02/28 09:50:21.817 0:06.083 Opal Garba...090afa8700 Opal Transport Close >2014/02/28 09:50:21.818 0:06.083 Opal Garba...090afa8700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$*:5060> >2014/02/28 09:50:21.818 0:06.083 Opal Garba...090afa8700 SIP Destroyed SUBSCRIBE handler for sip:500@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net >2014/02/28 09:50:21.839 0:06.105 Transactor...08b8131700 H225RAS Receiving PDU: > gatekeeperConfirm { > requestSeqNum = 54506 > protocolIdentifier = 0.0.8.2250.0.6 > gatekeeperIdentifier = 9 characters { > 0068 0033 0032 0033 006e 0065 0074 005f h323net_ > 0034 4 > } > rasAddress = ipAddress { > ip = 4 octets { > 17 17 98 ca .... > } > port = 1719 > } > alternateGatekeeper = 2 entries { > [0]={ > rasAddress = ipAddress { > ip = 4 octets { > 6b 15 e7 2e k... > } > port = 20075 > } > needToRegister = true > priority = 0 > } > [1]={ > rasAddress = ipAddress { > ip = 4 octets { > 36 e1 ef 65 6..e > } > port = 20075 > } > needToRegister = true > priority = 1 > } > } > authenticationMode = pwdHash <<null>> > algorithmOID = 1.2.840.113549.2.5 > } >2014/02/28 09:50:21.840 0:06.105 Transactor...08b8131700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:21.840 0:06.106 Transactor...08b8131700 RAS Gatekeeper discovered at: udp$23.23.152.202:1719 (if=udp$209.132.186.34:5061) >2014/02/28 09:50:21.840 0:06.106 Transactor...08b8131700 RAS Set alternate gatekeepers: >ip$107.21.231.46:20075 >ip$54.225.239.101:20075;priority=1 > >2014/02/28 09:50:21.884 0:06.149 GkMonitor:...08e404a700 OpalMan Listener interfaces: associated transport=udp$209.132.186.34:5061 > tcp$209.132.186.34:1720,tcp$10.34.130.146:1720,tcp$10.200.138.63:1720 >2014/02/28 09:50:21.884 0:06.149 GkMonitor:...08e404a700 Trans Making request: registrationRequest >2014/02/28 09:50:21.884 0:06.150 GkMonitor:...08e404a700 H235RAS Prepared PDU with authenticator MD5<active> >2014/02/28 09:50:21.884 0:06.150 GkMonitor:...08e404a700 Trans Sending PDU: > registrationRequest { > requestSeqNum = 54507 > protocolIdentifier = 0.0.8.2250.0.6 > discoveryComplete = true > callSignalAddress = 3 entries { > [0]=ipAddress { > ip = 4 octets { > d1 84 ba 22 ..." > } > port = 1720 > } > [1]=ipAddress { > ip = 4 octets { > 0a 22 82 92 .".. > } > port = 1720 > } > [2]=ipAddress { > ip = 4 octets { > 0a c8 8a 3f ...? > } > port = 1720 > } > } > rasAddress = 1 entries { > [0]=ipAddress { > ip = 4 octets { > d1 84 ba 22 ..." > } > port = 5061 > } > } > terminalType = { > vendor = { > vendor = { > t35CountryCode = 9 > t35Extension = 0 > manufacturerCode = 61 > } > productId = 3 octets { > 00 00 00 ... > } > versionId = 35 octets { > 34 2e 30 2e 31 20 28 4f 50 41 4c 20 76 33 2e 31 4.0.1 (OPAL v3.1 > 30 2e 31 30 20 28 73 76 6e 3a 32 39 31 35 30 29 0.10 (svn:29150) > ... > } > } > terminal = { > } > mc = false > undefinedNode = false > } > terminalAlias = 2 entries { > [0]=h323_ID 9 characters { > 0064 0065 0073 006b 0074 006f 0070 0071 desktopq > 0065 e > } > [1]=h323_ID 12 characters { > 004d 0061 0072 0074 0069 006e 0020 0053 Martin S > 0069 006d 006f 006e imon > } > } > gatekeeperIdentifier = 9 characters { > 0068 0033 0032 0033 006e 0065 0074 005f h323net_ > 0034 4 > } > endpointVendor = { > vendor = { > t35CountryCode = 9 > t35Extension = 0 > manufacturerCode = 61 > } > productId = 3 octets { > 00 00 00 ... > } > versionId = 35 octets { > 34 2e 30 2e 31 20 28 4f 50 41 4c 20 76 33 2e 31 4.0.1 (OPAL v3.1 > 30 2e 31 30 20 28 73 76 6e 3a 32 39 31 35 30 29 0.10 (svn:29150) > ... > } > } > timeToLive = 3600 > cryptoTokens = 1 entries { > [0]=cryptoEPPwdHash { > alias = h323_ID 9 characters { > 0064 0065 0073 006b 0074 006f 0070 0071 desktopq > 0065 e > } > timeStamp = 1393577421 > token = { > algorithmOID = 1.2.840.113549.2.5 > paramS = { > } > hash = Hex: b0 61 b7 f9 df e4 7b 20 22 a4 33 80 bc 51 7a 91 > } > } > } > keepAlive = false > willSupplyUUIEs = true > maintainConnection = false > supportsAltGK = <<null>> > usageReportingCapability = { > nonStandardUsageTypes = 0 entries { > } > startTime = <<null>> > endTime = <<null>> > terminationCause = <<null>> > } > callCreditCapability = { > canEnforceDurationLimit = true > } > } >2014/02/28 09:50:21.884 0:06.150 GkMonitor:...08e404a700 Trans Waiting on response to seqnum=54507 for 3.0 seconds >2014/02/28 09:50:22.014 0:06.280 Transactor...08b8131700 H225RAS Receiving PDU: > registrationConfirm { > requestSeqNum = 54507 > protocolIdentifier = 0.0.8.2250.0.6 > nonStandardData = { > nonStandardIdentifier = h221NonStandard { > t35CountryCode = 138 > t35Extension = 2 > manufacturerCode = 2 > } > data = 5 octets { > 4e 6f 4e 41 54 NoNAT > } > } > callSignalAddress = 1 entries { > [0]=ipAddress { > ip = 4 octets { > 17 17 98 ca .... > } > port = 1720 > } > } > terminalAlias = 4 entries { > [0]=url_ID "desktopqe@spranto.net" > [1]=dialedDigits "1081333021" > [2]=dialedDigits "878401081333021" > [3]=h323_ID 9 characters { > 0064 0065 0073 006b 0074 006f 0070 0071 desktopq > 0065 e > } > } > gatekeeperIdentifier = 9 characters { > 0068 0033 0032 0033 006e 0065 0074 005f h323net_ > 0034 4 > } > endpointIdentifier = 9 characters { > 0035 0031 0032 0036 005f 0065 006e 0064 5126_end > 0070 p > } > alternateGatekeeper = 2 entries { > [0]={ > rasAddress = ipAddress { > ip = 4 octets { > 6b 15 e7 2e k... > } > port = 20075 > } > needToRegister = true > priority = 0 > } > [1]={ > rasAddress = ipAddress { > ip = 4 octets { > 36 e1 ef 65 6..e > } > port = 20075 > } > needToRegister = true > priority = 1 > } > } > timeToLive = 30 > willRespondToIRR = false > maintainConnection = false > serviceControl = 1 entries { > [0]={ > sessionId = 0 > contents = callCreditServiceControl { > callStartingPoint = connect <<null>> > } > reason = refresh <<null>> > } > } > supportsAdditiveRegistration = <<null>> > } >2014/02/28 09:50:22.014 0:06.280 Transactor...08b8131700 Trans Using credentials from request: H235AnnexD_Procedure1<disabled>,CAT<disabled>,MD5<active> >2014/02/28 09:50:22.014 0:06.280 Transactor...08b8131700 RAS Registered 5126_endp with h323net_4 >2014/02/28 09:50:22.015 0:06.280 Transactor...08b8131700 RAS Set alternate gatekeepers: >ip$54.225.239.101:20075;priority=1 >ip$107.21.231.46:20075 > >2014/02/28 09:50:22.015 0:06.280 Transactor...08b8131700 RAS Gatekeeper add of alias "desktopqe@spranto.net" >2014/02/28 09:50:22.015 0:06.280 Transactor...08b8131700 RAS Gatekeeper add of alias "1081333021" >2014/02/28 09:50:22.015 0:06.280 Transactor...08b8131700 RAS Gatekeeper add of alias "878401081333021" >2014/02/28 09:50:22.015 0:06.280 Transactor...08b8131700 RAS Gatekeeper removal of alias "Martin Simon" >2014/02/28 09:50:22.015 0:06.280 Transactor...08b8131700 SvcCtrl OnChange Call Credit service control debit 0 >2014/02/28 09:50:22.040 0:06.306 Housekeepe...090b0ac700 SIP SUBSCRIBE transaction id=z9hG4bK70247306-c39e-e311-8b48-3c970e8ed11e timeout, making retry 1, timeout 1.000, state 1 >2014/02/28 09:50:22.040 0:06.306 Housekeepe...090b0ac700 OpalUDP Setting interface to 10.200.138.63%wlp3s0 >2014/02/28 09:50:22.040 0:06.306 Housekeepe...090b0ac700 SIP Set new interface 10.200.138.63%wlp3s0 for transport udp$86.64.162.35:5060<if=udp$10.200.138.63:5060> >2014/02/28 09:50:22.040 0:06.306 Housekeepe...090b0ac700 SIP Sending PDU (602 bytes) to: rem=udp$86.64.162.35:5060,local=udp$10.200.138.63:5060,if=10.200.138.63%wlp3s0 >SUBSCRIBE sip:desktopqe@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.200.138.63:5060;branch=z9hG4bK70247306-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=a21f7306-c39e-e311-8b48-3c970e8ed11e >Call-ID: ecf87206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net> >Accept: application/simple-message-summary >Contact: <sip:desktopqe@10.200.138.63> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 3600 >Event: message-summary >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:22.041 0:06.306 Housekeepe...090b0ac700 OpalUDP Setting interface to >2014/02/28 09:50:22.041 0:06.306 Housekeepe...090b0ac700 SIP SUBSCRIBE transaction id=z9hG4bK3aa07306-c39e-e311-8b48-3c970e8ed11e timeout, making retry 1, timeout 1.000, state 1 >2014/02/28 09:50:22.041 0:06.306 Housekeepe...090b0ac700 OpalUDP Setting interface to 10.200.138.63%wlp3s0 >2014/02/28 09:50:22.041 0:06.306 Housekeepe...090b0ac700 SIP Set new interface 10.200.138.63%wlp3s0 for transport udp$86.64.162.35:5060<if=udp$10.200.138.63:5060> >2014/02/28 09:50:22.041 0:06.307 Housekeepe...090b0ac700 SIP Sending PDU (647 bytes) to: rem=udp$86.64.162.35:5060,local=udp$10.200.138.63:5060,if=10.200.138.63%wlp3s0 >SUBSCRIBE sip:501@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.200.138.63:5060;branch=z9hG4bK3aa07306-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=809b7306-c39e-e311-8b48-3c970e8ed11e >Call-ID: ac887306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >Supported: eventlist >To: <sip:501@ekiga.net> >Accept: application/pidf+xml >Accept: multipart/related >Accept: application/rlmi+xml >Contact: <sip:desktopqe@10.200.138.63> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 300 >Event: presence >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:22.041 0:06.307 Housekeepe...090b0ac700 OpalUDP Setting interface to >2014/02/28 09:50:22.041 0:06.307 Housekeepe...090b0ac700 SIP SUBSCRIBE transaction id=z9hG4bK2e0f7506-c39e-e311-8b48-3c970e8ed11e timeout, making retry 1, timeout 1.000, state 1 >2014/02/28 09:50:22.041 0:06.307 Housekeepe...090b0ac700 OpalUDP Setting interface to 10.200.138.63%wlp3s0 >2014/02/28 09:50:22.041 0:06.307 Housekeepe...090b0ac700 SIP Set new interface 10.200.138.63%wlp3s0 for transport udp$86.64.162.35:5060<if=udp$10.200.138.63:5060> >2014/02/28 09:50:22.041 0:06.307 Housekeepe...090b0ac700 SIP Sending PDU (647 bytes) to: rem=udp$86.64.162.35:5060,local=udp$10.200.138.63:5060,if=10.200.138.63%wlp3s0 >SUBSCRIBE sip:520@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.200.138.63:5060;branch=z9hG4bK2e0f7506-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=a2097506-c39e-e311-8b48-3c970e8ed11e >Call-ID: deeb7406-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >Supported: eventlist >To: <sip:520@ekiga.net> >Accept: application/pidf+xml >Accept: multipart/related >Accept: application/rlmi+xml >Contact: <sip:desktopqe@10.200.138.63> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 300 >Event: presence >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:22.042 0:06.307 Housekeepe...090b0ac700 OpalUDP Setting interface to >2014/02/28 09:50:22.092 0:06.358 Housekeepe...090b0ac700 SIP SUBSCRIBE transaction id=z9hG4bKa80b7c06-c39e-e311-8b48-3c970e8ed11e timeout, making retry 1, timeout 0.999, state 1 >2014/02/28 09:50:22.092 0:06.358 Housekeepe...090b0ac700 OpalUDP Setting interface to 10.200.138.63%wlp3s0 >2014/02/28 09:50:22.092 0:06.358 Housekeepe...090b0ac700 SIP Set new interface 10.200.138.63%wlp3s0 for transport udp$86.64.162.35:5060<if=udp$10.200.138.63:5060> >2014/02/28 09:50:22.092 0:06.358 Housekeepe...090b0ac700 SIP Sending PDU (645 bytes) to: rem=udp$86.64.162.35:5060,local=udp$10.200.138.63:5060,if=10.200.138.63%wlp3s0 >SUBSCRIBE sip:501@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.200.138.63:5060;branch=z9hG4bKa80b7c06-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=809b7306-c39e-e311-8b48-3c970e8ed11e >Call-ID: ac887306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >Supported: eventlist >To: <sip:501@ekiga.net> >Accept: application/pidf+xml >Accept: multipart/related >Accept: application/rlmi+xml >Contact: <sip:desktopqe@10.200.138.63> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 0 >Event: presence >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:22.092 0:06.358 Housekeepe...090b0ac700 OpalUDP Setting interface to >2014/02/28 09:50:22.092 0:06.358 Housekeepe...090b0ac700 SIP SUBSCRIBE transaction id=z9hG4bK1c337c06-c39e-e311-8b48-3c970e8ed11e timeout, making retry 1, timeout 1.000, state 1 >2014/02/28 09:50:22.092 0:06.358 Housekeepe...090b0ac700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:22.092 0:06.358 Housekeepe...090b0ac700 SIP Set new interface 10.34.130.146%em1 for transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:22.093 0:06.358 Housekeepe...090b0ac700 SIP Sending PDU (654 bytes) to: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SUBSCRIBE sip:501@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 209.132.186.34:27476;branch=z9hG4bK1c337c06-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=809b7306-c39e-e311-8b48-3c970e8ed11e >Call-ID: ac887306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >Supported: eventlist >To: <sip:501@ekiga.net> >Accept: application/pidf+xml >Accept: multipart/related >Accept: application/rlmi+xml >Contact: <sip:desktopqe@209.132.186.34:27476> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 0 >Event: presence >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:22.093 0:06.359 Housekeepe...090b0ac700 OpalUDP Setting interface to >2014/02/28 09:50:22.118 0:06.384 Housekeepe...090b0ac700 SIP SUBSCRIBE transaction id=z9hG4bKe4a87f06-c39e-e311-8b48-3c970e8ed11e timeout, making retry 1, timeout 1.000, state 1 >2014/02/28 09:50:22.118 0:06.384 Housekeepe...090b0ac700 OpalUDP Setting interface to 10.200.138.63%wlp3s0 >2014/02/28 09:50:22.118 0:06.384 Housekeepe...090b0ac700 SIP Set new interface 10.200.138.63%wlp3s0 for transport udp$86.64.162.35:5060<if=udp$10.200.138.63:5060> >2014/02/28 09:50:22.118 0:06.384 Housekeepe...090b0ac700 SIP Sending PDU (645 bytes) to: rem=udp$86.64.162.35:5060,local=udp$10.200.138.63:5060,if=10.200.138.63%wlp3s0 >SUBSCRIBE sip:520@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.200.138.63:5060;branch=z9hG4bKe4a87f06-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=a2097506-c39e-e311-8b48-3c970e8ed11e >Call-ID: deeb7406-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >Supported: eventlist >To: <sip:520@ekiga.net> >Accept: application/pidf+xml >Accept: multipart/related >Accept: application/rlmi+xml >Contact: <sip:desktopqe@10.200.138.63> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 0 >Event: presence >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:22.119 0:06.384 Housekeepe...090b0ac700 OpalUDP Setting interface to >2014/02/28 09:50:22.119 0:06.384 Housekeepe...090b0ac700 SIP SUBSCRIBE transaction id=z9hG4bK04f77f06-c39e-e311-8b48-3c970e8ed11e timeout, making retry 1, timeout 1.000, state 1 >2014/02/28 09:50:22.119 0:06.384 Housekeepe...090b0ac700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:22.119 0:06.384 Housekeepe...090b0ac700 SIP Set new interface 10.34.130.146%em1 for transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:22.119 0:06.384 Housekeepe...090b0ac700 SIP Sending PDU (654 bytes) to: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SUBSCRIBE sip:520@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 209.132.186.34:27476;branch=z9hG4bK04f77f06-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=a2097506-c39e-e311-8b48-3c970e8ed11e >Call-ID: deeb7406-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >Supported: eventlist >To: <sip:520@ekiga.net> >Accept: application/pidf+xml >Accept: multipart/related >Accept: application/rlmi+xml >Contact: <sip:desktopqe@209.132.186.34:27476> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 0 >Event: presence >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:22.119 0:06.385 Housekeepe...090b0ac700 OpalUDP Setting interface to >2014/02/28 09:50:22.140 0:06.406 Opal Liste...08ec121700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:50:22.140 0:06.406 Opal Liste...08ec121700 SIP Waiting for PDU on udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:22.140 0:06.406 Opal Liste...08ec121700 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SIP/2.0 489 Event Not Supported >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.34.130.146:5060;branch=z9hG4bK1c337c06-c39e-e311-8b48-3c970e8ed11e;rport=27476 >Server: Kamailio (1.5.3-notls (i386/linux)) >From: <sip:desktopqe@ekiga.net>;tag=809b7306-c39e-e311-8b48-3c970e8ed11e >Call-ID: ac887306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:501@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.e2c2 >Content-Length: 0 > > >2014/02/28 09:50:22.141 0:06.406 Opal Liste...08ec121700 SIP Queueing PDU "1 SUBSCRIBE <489>", transaction=z9hG4bK1c337c06-c39e-e311-8b48-3c970e8ed11e, token=ac887306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:22.141 0:06.406 Opal Liste...08ec121700 Opal Transport clean up on termination >2014/02/28 09:50:22.141 0:06.407 Opal Liste...08ec121700 Opal Transport Close >2014/02/28 09:50:22.141 0:06.407 Pool:0x7f08b80f0700 SIP Handling PDU "1 SUBSCRIBE <489>" for transaction=z9hG4bK1c337c06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.141 0:06.407 Pool:0x7f08b80f0700 SIP SUBSCRIBE transaction id=z9hG4bK1c337c06-c39e-e311-8b48-3c970e8ed11e completing. >2014/02/28 09:50:22.141 0:06.407 Opal Liste...08ec121700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:22.141 0:06.407 Pool:0x7f08b80f0700 SIP Not retrying SUBSCRIBE due to error response 489 Bad Event >2014/02/28 09:50:22.141 0:06.407 Pool:0x7f08b80f0700 SIP Changing SUBSCRIBE handler from Unsubscribing to Unsubscribed, target=sip:501@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=ac887306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:22.141 0:06.407 Pool:0x7f08b80f0700 SIP SUBSCRIBE transaction id=z9hG4bK1c337c06-c39e-e311-8b48-3c970e8ed11e completed. >2014/02/28 09:50:22.141 0:06.407 Pool:0x7f08b80f0700 SIP Handled PDU "1 SUBSCRIBE <489>" >2014/02/28 09:50:22.166 0:06.431 Opal Liste...08ec121700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:50:22.166 0:06.431 Opal Liste...08ec121700 SIP Waiting for PDU on udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:22.166 0:06.432 Opal Liste...08ec121700 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SIP/2.0 489 Event Not Supported >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.34.130.146:5060;branch=z9hG4bK04f77f06-c39e-e311-8b48-3c970e8ed11e;rport=27476 >Server: Kamailio (1.5.3-notls (i386/linux)) >From: <sip:desktopqe@ekiga.net>;tag=a2097506-c39e-e311-8b48-3c970e8ed11e >Call-ID: deeb7406-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:520@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.e4b1 >Content-Length: 0 > > >2014/02/28 09:50:22.166 0:06.432 Opal Liste...08ec121700 SIP Queueing PDU "1 SUBSCRIBE <489>", transaction=z9hG4bK04f77f06-c39e-e311-8b48-3c970e8ed11e, token=deeb7406-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:22.166 0:06.432 Opal Liste...08ec121700 Opal Transport clean up on termination >2014/02/28 09:50:22.166 0:06.432 Opal Liste...08ec121700 Opal Transport Close >2014/02/28 09:50:22.166 0:06.432 Pool:0x7f08b80f0700 SIP Handling PDU "1 SUBSCRIBE <489>" for transaction=z9hG4bK04f77f06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.166 0:06.432 Pool:0x7f08b80f0700 SIP SUBSCRIBE transaction id=z9hG4bK04f77f06-c39e-e311-8b48-3c970e8ed11e completing. >2014/02/28 09:50:22.166 0:06.432 Opal Liste...08ec121700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:22.166 0:06.432 Pool:0x7f08b80f0700 SIP Not retrying SUBSCRIBE due to error response 489 Bad Event >2014/02/28 09:50:22.166 0:06.432 Pool:0x7f08b80f0700 SIP Changing SUBSCRIBE handler from Unsubscribing to Unsubscribed, target=sip:520@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=deeb7406-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:22.166 0:06.432 Pool:0x7f08b80f0700 SIP SUBSCRIBE transaction id=z9hG4bK04f77f06-c39e-e311-8b48-3c970e8ed11e completed. >2014/02/28 09:50:22.166 0:06.432 Pool:0x7f08b80f0700 SIP Handled PDU "1 SUBSCRIBE <489>" >2014/02/28 09:50:22.373 0:06.638 Housekeepe...090b0ac700 SIP Set state Terminated_Success for PUBLISH transaction id=z9hG4bK10fe5306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.373 0:06.638 Housekeepe...090b0ac700 SIP Completed state for transaction id=z9hG4bK10fe5306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.398 0:06.664 Housekeepe...090b0ac700 SIP Set state Terminated_Success for REGISTER transaction id=z9hG4bKecf45306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.398 0:06.664 Housekeepe...090b0ac700 SIP Completed state for transaction id=z9hG4bKecf45306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.428 0:06.694 Housekeepe...090b0ac700 SIP Set state Terminated_Success for REGISTER transaction id=z9hG4bK26b35b06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.428 0:06.694 Housekeepe...090b0ac700 SIP Completed state for transaction id=z9hG4bK26b35b06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.541 0:06.807 PThreadObj...08b8172700 SIPPres 'sip:desktopqe@ekiga.net' sending own presence Available/I'm available using Ekiga >2014/02/28 09:50:22.541 0:06.807 PThreadObj...08b8172700 SIPPres PIDF entity derived from AOR as pres:desktopqe@ekiga.net >2014/02/28 09:50:22.541 0:06.807 PThreadObj...08b8172700 SIP Start PUBLISH > eventPackage=presence > aor=sip:desktopqe@ekiga.net > remote=sip:desktopqe@ekiga.net > local= > contact= > proxy= > authID= > realm= > expire=300 > restore=30 > minRetry=default > maxRetry=default >2014/02/28 09:50:22.541 0:06.807 PThreadObj...08b8172700 SIP Executing state change to Subscribing for PUBLISH handler, target=sip:desktopqe@ekiga.net, id=b2c05306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:22.541 0:06.807 PThreadObj...08b8172700 SIP Changing PUBLISH handler from Subscribed to Subscribing, target=sip:desktopqe@ekiga.net, id=b2c05306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:22.541 0:06.807 PThreadObj...08b8172700 SIP Transaction created. >2014/02/28 09:50:22.542 0:06.807 PThreadObj...08b8172700 SIP Transaction remembering interface "10.34.130.146%em1" >2014/02/28 09:50:22.542 0:06.808 PThreadObj...08b8172700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:22.542 0:06.808 PThreadObj...08b8172700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:22.542 0:06.808 PThreadObj...08b8172700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:22.542 0:06.808 PThreadObj...08b8172700 SIP Sending PDU (953 bytes) to: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >PUBLISH sip:desktopqe@ekiga.net SIP/2.0 >CSeq: 5 PUBLISH >Via: SIP/2.0/UDP 209.132.186.34:27476;branch=z9hG4bK88160e07-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net> >Call-ID: b2c05306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net> >SIP-If-Match: a.1393349837.25351.408240.0 >Expires: 300 >Event: presence >Content-Length: 490 >Content-Type: application/pidf+xml >Max-Forwards: 70 > ><?xml version="1.0" encoding="UTF-8"?> ><presence xmlns="urn:ietf:params:xml:ns:pidf" xmlns:dm="urn:ietf:params:xml:ns:pidf:data-model" xmlns:rpid="urn:ietf:params:xml:ns:pidf:rpid" entity="pres:desktopqe@ekiga.net"> > <tuple id="TC2D0471E"> > <status> > <basic>open</basic> > </status> > <contact priority="1">sip:desktopqe@ekiga.net</contact> > <note>I'm available using Ekiga</note> > <timestamp>2014-02-28T09:50:22+01:00</timestamp> > </tuple> ></presence> > >2014/02/28 09:50:22.542 0:06.808 PThreadObj...08b8172700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:22.542 0:06.808 PThreadObj...08b8172700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:22.579 0:06.844 Housekeepe...090b0ac700 SIP Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bK06577306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.579 0:06.844 Housekeepe...090b0ac700 SIP Completed state for transaction id=z9hG4bK06577306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.590 0:06.856 Opal Liste...08ec121700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:50:22.590 0:06.856 Opal Liste...08ec121700 SIP Waiting for PDU on udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:22.590 0:06.856 Opal Liste...08ec121700 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SIP/2.0 200 OK >CSeq: 5 PUBLISH >Via: SIP/2.0/UDP 10.34.130.146:5060;branch=z9hG4bK88160e07-c39e-e311-8b48-3c970e8ed11e;rport=27476 >Server: Kamailio (1.5.3-notls (i386/linux)) >From: <sip:desktopqe@ekiga.net> >Call-ID: b2c05306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net>;tag=f85b0bd16aaafa8479586ac9f88b3198-cf0e >Expires: 295 >Content-Length: 0 >SIP-ETag: a.1393349837.25351.408252.1 > > >2014/02/28 09:50:22.591 0:06.856 Opal Liste...08ec121700 SIP Queueing PDU "5 PUBLISH <200>", transaction=z9hG4bK88160e07-c39e-e311-8b48-3c970e8ed11e, token=b2c05306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:22.591 0:06.856 Opal Liste...08ec121700 Opal Transport clean up on termination >2014/02/28 09:50:22.591 0:06.856 Opal Liste...08ec121700 Opal Transport Close >2014/02/28 09:50:22.591 0:06.856 Pool:0x7f08b80f0700 SIP Handling PDU "5 PUBLISH <200>" for transaction=z9hG4bK88160e07-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.591 0:06.857 Pool:0x7f08b80f0700 SIP PUBLISH transaction id=z9hG4bK88160e07-c39e-e311-8b48-3c970e8ed11e completing. >2014/02/28 09:50:22.591 0:06.857 Housekeepe...090b0ac700 SIP Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bK94557306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.591 0:06.857 Housekeepe...090b0ac700 SIP Completed state for transaction id=z9hG4bK94557306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.591 0:06.857 Pool:0x7f08b80f0700 SIP Finalising handlers interface "10.34.130.146%em1" >2014/02/28 09:50:22.591 0:06.857 Pool:0x7f08b80f0700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:22.591 0:06.856 Opal Liste...08ec121700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:22.591 0:06.857 Pool:0x7f08b80f0700 SIP Expiry time for PUBLISH set to 295 seconds. >2014/02/28 09:50:22.591 0:06.857 Housekeepe...090b0ac700 SIP Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bK92d47306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.591 0:06.857 Pool:0x7f08b80f0700 SIP Product Info: name="Kamailio", version="", vendor="", comments="(1.5.3-notls (i386/linux))" >2014/02/28 09:50:22.591 0:06.857 Pool:0x7f08b80f0700 SIP Changing PUBLISH handler from Subscribing to Subscribed, target=sip:desktopqe@ekiga.net, id=b2c05306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:22.591 0:06.857 Housekeepe...090b0ac700 SIP Completed state for transaction id=z9hG4bK92d47306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.591 0:06.857 Pool:0x7f08b80f0700 SIP PUBLISH transaction id=z9hG4bK88160e07-c39e-e311-8b48-3c970e8ed11e completed. >2014/02/28 09:50:22.591 0:06.857 Pool:0x7f08b80f0700 SIP Handled PDU "5 PUBLISH <200>" >2014/02/28 09:50:22.616 0:06.882 Housekeepe...090b0ac700 SIP Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bK2e417506-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.617 0:06.882 Housekeepe...090b0ac700 SIP Completed state for transaction id=z9hG4bK2e417506-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.642 0:06.907 Housekeepe...090b0ac700 SIP Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bKb4327b06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.642 0:06.907 Housekeepe...090b0ac700 SIP Completed state for transaction id=z9hG4bKb4327b06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.818 0:07.084 Opal Garba...090afa8700 SIP Transaction id=z9hG4bK94557306-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:22.818 0:07.084 Opal Garba...090afa8700 SIP Transaction id=z9hG4bK92d47306-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:22.818 0:07.084 Opal Garba...090afa8700 SIP Transaction id=z9hG4bK26b35b06-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:22.818 0:07.084 Opal Garba...090afa8700 SIP Transaction id=z9hG4bK2e417506-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:22.819 0:07.084 Opal Garba...090afa8700 SIP Transaction id=z9hG4bK06577306-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:22.819 0:07.084 Opal Garba...090afa8700 SIP Transaction id=z9hG4bK10fe5306-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:22.819 0:07.084 Opal Garba...090afa8700 SIP Transaction id=z9hG4bKf6097b06-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:22.819 0:07.084 Opal Garba...090afa8700 SIP Transaction id=z9hG4bKdc217306-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:22.819 0:07.085 Opal Garba...090afa8700 SIP Transaction id=z9hG4bKecf45306-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:22.819 0:07.085 Opal Garba...090afa8700 SIP Transaction id=z9hG4bKb4327b06-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:22.819 0:07.085 Opal Garba...090afa8700 SIP Attempting to abort SUBSCRIBE transaction id=z9hG4bK70247306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.819 0:07.085 Opal Garba...090afa8700 SIP Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bK70247306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.819 0:07.085 Opal Garba...090afa8700 SIP Handler SIPSubscribeHandler unsubscribed, awaiting shutdown. >2014/02/28 09:50:22.819 0:07.085 Opal Garba...090afa8700 SIP Attempting to abort SUBSCRIBE transaction id=z9hG4bK70247306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.819 0:07.085 Opal Garba...090afa8700 SIP Transaction 1 SUBSCRIBE sip:desktopqe@ekiga.net failed, unknown handler, ID: ecf87206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:22.819 0:07.085 Opal Garba...090afa8700 SIP Completed state for transaction id=z9hG4bK70247306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:22.819 0:07.085 Opal Garba...090afa8700 Opal Transport clean up on termination >2014/02/28 09:50:22.819 0:07.085 Opal Garba...090afa8700 Opal Transport Close >2014/02/28 09:50:22.819 0:07.085 Opal Garba...090afa8700 Opal Transport clean up on termination >2014/02/28 09:50:22.819 0:07.085 Opal Garba...090afa8700 Opal Transport Close >2014/02/28 09:50:22.819 0:07.085 Opal Garba...090afa8700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$*:5060> >2014/02/28 09:50:22.820 0:07.085 Opal Garba...090afa8700 SIP Destroyed SUBSCRIBE handler for sip:desktopqe@ekiga.net >2014/02/28 09:50:23.041 0:07.307 Housekeepe...090b0ac700 SIP SUBSCRIBE transaction id=z9hG4bK3aa07306-c39e-e311-8b48-3c970e8ed11e timeout, making retry 2, timeout 1.999, state 1 >2014/02/28 09:50:23.041 0:07.307 Housekeepe...090b0ac700 OpalUDP Setting interface to 10.200.138.63%wlp3s0 >2014/02/28 09:50:23.041 0:07.307 Housekeepe...090b0ac700 SIP Set new interface 10.200.138.63%wlp3s0 for transport udp$86.64.162.35:5060<if=udp$10.200.138.63:5060> >2014/02/28 09:50:23.041 0:07.307 Housekeepe...090b0ac700 SIP Sending PDU (647 bytes) to: rem=udp$86.64.162.35:5060,local=udp$10.200.138.63:5060,if=10.200.138.63%wlp3s0 >SUBSCRIBE sip:501@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.200.138.63:5060;branch=z9hG4bK3aa07306-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=809b7306-c39e-e311-8b48-3c970e8ed11e >Call-ID: ac887306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >Supported: eventlist >To: <sip:501@ekiga.net> >Accept: application/pidf+xml >Accept: multipart/related >Accept: application/rlmi+xml >Contact: <sip:desktopqe@10.200.138.63> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 300 >Event: presence >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:23.041 0:07.307 Housekeepe...090b0ac700 OpalUDP Setting interface to >2014/02/28 09:50:23.067 0:07.332 Housekeepe...090b0ac700 SIP SUBSCRIBE transaction id=z9hG4bK2e0f7506-c39e-e311-8b48-3c970e8ed11e timeout, making retry 2, timeout 2.000, state 1 >2014/02/28 09:50:23.067 0:07.332 Housekeepe...090b0ac700 OpalUDP Setting interface to 10.200.138.63%wlp3s0 >2014/02/28 09:50:23.067 0:07.333 Housekeepe...090b0ac700 SIP Set new interface 10.200.138.63%wlp3s0 for transport udp$86.64.162.35:5060<if=udp$10.200.138.63:5060> >2014/02/28 09:50:23.067 0:07.333 Housekeepe...090b0ac700 SIP Sending PDU (647 bytes) to: rem=udp$86.64.162.35:5060,local=udp$10.200.138.63:5060,if=10.200.138.63%wlp3s0 >SUBSCRIBE sip:520@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.200.138.63:5060;branch=z9hG4bK2e0f7506-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=a2097506-c39e-e311-8b48-3c970e8ed11e >Call-ID: deeb7406-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >Supported: eventlist >To: <sip:520@ekiga.net> >Accept: application/pidf+xml >Accept: multipart/related >Accept: application/rlmi+xml >Contact: <sip:desktopqe@10.200.138.63> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 300 >Event: presence >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:23.067 0:07.333 Housekeepe...090b0ac700 OpalUDP Setting interface to >2014/02/28 09:50:23.093 0:07.358 Housekeepe...090b0ac700 SIP SUBSCRIBE transaction id=z9hG4bKa80b7c06-c39e-e311-8b48-3c970e8ed11e timeout, making retry 2, timeout 2.000, state 1 >2014/02/28 09:50:23.093 0:07.358 Housekeepe...090b0ac700 OpalUDP Setting interface to 10.200.138.63%wlp3s0 >2014/02/28 09:50:23.093 0:07.358 Housekeepe...090b0ac700 SIP Set new interface 10.200.138.63%wlp3s0 for transport udp$86.64.162.35:5060<if=udp$10.200.138.63:5060> >2014/02/28 09:50:23.093 0:07.359 Housekeepe...090b0ac700 SIP Sending PDU (645 bytes) to: rem=udp$86.64.162.35:5060,local=udp$10.200.138.63:5060,if=10.200.138.63%wlp3s0 >SUBSCRIBE sip:501@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.200.138.63:5060;branch=z9hG4bKa80b7c06-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=809b7306-c39e-e311-8b48-3c970e8ed11e >Call-ID: ac887306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >Supported: eventlist >To: <sip:501@ekiga.net> >Accept: application/pidf+xml >Accept: multipart/related >Accept: application/rlmi+xml >Contact: <sip:desktopqe@10.200.138.63> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 0 >Event: presence >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:23.093 0:07.359 Housekeepe...090b0ac700 OpalUDP Setting interface to >2014/02/28 09:50:23.120 0:07.385 Housekeepe...090b0ac700 SIP SUBSCRIBE transaction id=z9hG4bKe4a87f06-c39e-e311-8b48-3c970e8ed11e timeout, making retry 2, timeout 2.000, state 1 >2014/02/28 09:50:23.120 0:07.385 Housekeepe...090b0ac700 OpalUDP Setting interface to 10.200.138.63%wlp3s0 >2014/02/28 09:50:23.120 0:07.385 Housekeepe...090b0ac700 SIP Set new interface 10.200.138.63%wlp3s0 for transport udp$86.64.162.35:5060<if=udp$10.200.138.63:5060> >2014/02/28 09:50:23.120 0:07.386 Housekeepe...090b0ac700 SIP Sending PDU (645 bytes) to: rem=udp$86.64.162.35:5060,local=udp$10.200.138.63:5060,if=10.200.138.63%wlp3s0 >SUBSCRIBE sip:520@ekiga.net SIP/2.0 >CSeq: 1 SUBSCRIBE >Via: SIP/2.0/UDP 10.200.138.63:5060;branch=z9hG4bKe4a87f06-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=a2097506-c39e-e311-8b48-3c970e8ed11e >Call-ID: deeb7406-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >Supported: eventlist >To: <sip:520@ekiga.net> >Accept: application/pidf+xml >Accept: multipart/related >Accept: application/rlmi+xml >Contact: <sip:desktopqe@10.200.138.63> >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 0 >Event: presence >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:23.120 0:07.386 Housekeepe...090b0ac700 OpalUDP Setting interface to >2014/02/28 09:50:23.145 0:07.411 Housekeepe...090b0ac700 SIP Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bK1c337c06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:23.145 0:07.411 Housekeepe...090b0ac700 SIP Completed state for transaction id=z9hG4bK1c337c06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:23.170 0:07.436 Housekeepe...090b0ac700 SIP Set state Terminated_Success for SUBSCRIBE transaction id=z9hG4bK04f77f06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:23.171 0:07.436 Housekeepe...090b0ac700 SIP Completed state for transaction id=z9hG4bK04f77f06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:23.543 0:07.808 PThreadObj...08b8172700 SIPPres 'sip:desktopqe@ekiga.net' sending own presence Available/I'm available using Ekiga >2014/02/28 09:50:23.543 0:07.808 PThreadObj...08b8172700 SIPPres PIDF entity derived from AOR as pres:desktopqe@ekiga.net >2014/02/28 09:50:23.543 0:07.808 PThreadObj...08b8172700 SIP Start PUBLISH > eventPackage=presence > aor=sip:desktopqe@ekiga.net > remote=sip:desktopqe@ekiga.net > local= > contact= > proxy= > authID= > realm= > expire=300 > restore=30 > minRetry=default > maxRetry=default >2014/02/28 09:50:23.543 0:07.809 PThreadObj...08b8172700 SIP Executing state change to Subscribing for PUBLISH handler, target=sip:desktopqe@ekiga.net, id=b2c05306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:23.543 0:07.809 PThreadObj...08b8172700 SIP Changing PUBLISH handler from Subscribed to Subscribing, target=sip:desktopqe@ekiga.net, id=b2c05306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:23.543 0:07.809 PThreadObj...08b8172700 SIP Transaction created. >2014/02/28 09:50:23.544 0:07.809 PThreadObj...08b8172700 SIP Transaction remembering interface "10.34.130.146%em1" >2014/02/28 09:50:23.544 0:07.809 PThreadObj...08b8172700 DNS SRV Lookup "_sip._udp.ekiga.net" >2014/02/28 09:50:23.544 0:07.809 PThreadObj...08b8172700 SIP Attempting SRV record entry 0: 86.64.162.35:5060 >2014/02/28 09:50:23.544 0:07.809 PThreadObj...08b8172700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:23.544 0:07.810 PThreadObj...08b8172700 SIP Sending PDU (953 bytes) to: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >PUBLISH sip:desktopqe@ekiga.net SIP/2.0 >CSeq: 6 PUBLISH >Via: SIP/2.0/UDP 209.132.186.34:27476;branch=z9hG4bK34f4a607-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net> >Call-ID: b2c05306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net> >SIP-If-Match: a.1393349837.25351.408252.1 >Expires: 300 >Event: presence >Content-Length: 490 >Content-Type: application/pidf+xml >Max-Forwards: 70 > ><?xml version="1.0" encoding="UTF-8"?> ><presence xmlns="urn:ietf:params:xml:ns:pidf" xmlns:dm="urn:ietf:params:xml:ns:pidf:data-model" xmlns:rpid="urn:ietf:params:xml:ns:pidf:rpid" entity="pres:desktopqe@ekiga.net"> > <tuple id="TC2D0471E"> > <status> > <basic>open</basic> > </status> > <contact priority="1">sip:desktopqe@ekiga.net</contact> > <note>I'm available using Ekiga</note> > <timestamp>2014-02-28T09:50:23+01:00</timestamp> > </tuple> ></presence> > >2014/02/28 09:50:23.544 0:07.810 PThreadObj...08b8172700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:23.544 0:07.810 PThreadObj...08b8172700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:23.591 0:07.857 Housekeepe...090b0ac700 SIP Set state Terminated_Success for PUBLISH transaction id=z9hG4bK88160e07-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:23.591 0:07.857 Housekeepe...090b0ac700 SIP Completed state for transaction id=z9hG4bK88160e07-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:23.592 0:07.858 Opal Liste...08ec121700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:50:23.592 0:07.858 Opal Liste...08ec121700 SIP Waiting for PDU on udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:23.592 0:07.858 Opal Liste...08ec121700 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SIP/2.0 200 OK >CSeq: 6 PUBLISH >Via: SIP/2.0/UDP 10.34.130.146:5060;branch=z9hG4bK34f4a607-c39e-e311-8b48-3c970e8ed11e;rport=27476 >Server: Kamailio (1.5.3-notls (i386/linux)) >From: <sip:desktopqe@ekiga.net> >Call-ID: b2c05306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net>;tag=f85b0bd16aaafa8479586ac9f88b3198-1e76 >Expires: 295 >Content-Length: 0 >SIP-ETag: a.1393349837.25351.408261.2 > > >2014/02/28 09:50:23.593 0:07.858 Opal Liste...08ec121700 SIP Queueing PDU "6 PUBLISH <200>", transaction=z9hG4bK34f4a607-c39e-e311-8b48-3c970e8ed11e, token=b2c05306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:23.593 0:07.858 Opal Liste...08ec121700 Opal Transport clean up on termination >2014/02/28 09:50:23.593 0:07.858 Opal Liste...08ec121700 Opal Transport Close >2014/02/28 09:50:23.593 0:07.858 Pool:0x7f08b80f0700 SIP Handling PDU "6 PUBLISH <200>" for transaction=z9hG4bK34f4a607-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:23.593 0:07.858 Pool:0x7f08b80f0700 SIP PUBLISH transaction id=z9hG4bK34f4a607-c39e-e311-8b48-3c970e8ed11e completing. >2014/02/28 09:50:23.593 0:07.858 Pool:0x7f08b80f0700 SIP Finalising handlers interface "10.34.130.146%em1" >2014/02/28 09:50:23.593 0:07.858 Pool:0x7f08b80f0700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:23.593 0:07.858 Pool:0x7f08b80f0700 SIP Expiry time for PUBLISH set to 295 seconds. >2014/02/28 09:50:23.593 0:07.858 Opal Liste...08ec121700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:23.593 0:07.859 Pool:0x7f08b80f0700 SIP Product Info: name="Kamailio", version="", vendor="", comments="(1.5.3-notls (i386/linux))" >2014/02/28 09:50:23.593 0:07.859 Pool:0x7f08b80f0700 SIP Changing PUBLISH handler from Subscribing to Subscribed, target=sip:desktopqe@ekiga.net, id=b2c05306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:23.593 0:07.859 Pool:0x7f08b80f0700 SIP PUBLISH transaction id=z9hG4bK34f4a607-c39e-e311-8b48-3c970e8ed11e completed. >2014/02/28 09:50:23.593 0:07.859 Pool:0x7f08b80f0700 SIP Handled PDU "6 PUBLISH <200>" >2014/02/28 09:50:23.820 0:08.086 Opal Garba...090afa8700 SIP Transaction id=z9hG4bK88160e07-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:23.821 0:08.086 Opal Garba...090afa8700 SIP Transaction id=z9hG4bK70247306-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:23.821 0:08.087 Opal Garba...090afa8700 SIP Transaction id=z9hG4bK04f77f06-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:23.821 0:08.087 Opal Garba...090afa8700 SIP Transaction id=z9hG4bK1c337c06-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:23.821 0:08.087 Opal Garba...090afa8700 SIP Attempting to abort SUBSCRIBE transaction id=z9hG4bK3aa07306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:23.821 0:08.087 Opal Garba...090afa8700 SIP Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bK3aa07306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:23.821 0:08.087 Opal Garba...090afa8700 SIP Handler SIPSubscribeHandler unsubscribed, awaiting shutdown. >2014/02/28 09:50:23.822 0:08.087 Opal Garba...090afa8700 SIP Attempting to abort SUBSCRIBE transaction id=z9hG4bK3aa07306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:23.822 0:08.087 Opal Garba...090afa8700 SIP Attempting to abort SUBSCRIBE transaction id=z9hG4bKa80b7c06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:23.822 0:08.087 Opal Garba...090afa8700 SIP Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bKa80b7c06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:23.822 0:08.087 Opal Garba...090afa8700 SIP Handler SIPSubscribeHandler unsubscribed, awaiting shutdown. >2014/02/28 09:50:23.822 0:08.087 Opal Garba...090afa8700 SIP Attempting to abort SUBSCRIBE transaction id=z9hG4bK3aa07306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:23.822 0:08.087 Opal Garba...090afa8700 SIP Attempting to abort SUBSCRIBE transaction id=z9hG4bKa80b7c06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:23.822 0:08.087 Opal Garba...090afa8700 SIP Transaction 1 SUBSCRIBE sip:501@ekiga.net failed, unknown handler, ID: ac887306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:23.822 0:08.087 Opal Garba...090afa8700 SIP Completed state for transaction id=z9hG4bKa80b7c06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:23.822 0:08.087 Opal Garba...090afa8700 SIP Transaction 1 SUBSCRIBE sip:501@ekiga.net failed, unknown handler, ID: ac887306-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:23.822 0:08.087 Opal Garba...090afa8700 SIP Completed state for transaction id=z9hG4bK3aa07306-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:23.822 0:08.088 Opal Garba...090afa8700 SIP Attempting to abort SUBSCRIBE transaction id=z9hG4bKa80b7c06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:23.822 0:08.088 Opal Garba...090afa8700 Opal Transport clean up on termination >2014/02/28 09:50:23.822 0:08.088 Opal Garba...090afa8700 Opal Transport Close >2014/02/28 09:50:23.822 0:08.088 Opal Garba...090afa8700 Opal Transport clean up on termination >2014/02/28 09:50:23.822 0:08.088 Opal Garba...090afa8700 Opal Transport Close >2014/02/28 09:50:23.822 0:08.088 Opal Garba...090afa8700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$*:5060> >2014/02/28 09:50:23.822 0:08.088 Opal Garba...090afa8700 SIP Destroyed SUBSCRIBE handler for sip:501@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net >2014/02/28 09:50:24.594 0:08.859 Housekeepe...090b0ac700 SIP Set state Terminated_Success for PUBLISH transaction id=z9hG4bK34f4a607-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:24.594 0:08.859 Housekeepe...090b0ac700 SIP Completed state for transaction id=z9hG4bK34f4a607-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:24.823 0:09.088 Opal Garba...090afa8700 SIP Transaction id=z9hG4bK3aa07306-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:24.823 0:09.089 Opal Garba...090afa8700 SIP Transaction id=z9hG4bK34f4a607-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:24.824 0:09.089 Opal Garba...090afa8700 SIP Transaction id=z9hG4bKa80b7c06-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:24.824 0:09.089 Opal Garba...090afa8700 SIP Attempting to abort SUBSCRIBE transaction id=z9hG4bK2e0f7506-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:24.824 0:09.089 Opal Garba...090afa8700 SIP Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bK2e0f7506-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:24.824 0:09.089 Opal Garba...090afa8700 SIP Handler SIPSubscribeHandler unsubscribed, awaiting shutdown. >2014/02/28 09:50:24.824 0:09.090 Opal Garba...090afa8700 SIP Attempting to abort SUBSCRIBE transaction id=z9hG4bK2e0f7506-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:24.824 0:09.090 Opal Garba...090afa8700 SIP Attempting to abort SUBSCRIBE transaction id=z9hG4bKe4a87f06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:24.824 0:09.090 Opal Garba...090afa8700 SIP Set state Terminated_Aborted for SUBSCRIBE transaction id=z9hG4bKe4a87f06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:24.824 0:09.090 Opal Garba...090afa8700 SIP Handler SIPSubscribeHandler unsubscribed, awaiting shutdown. >2014/02/28 09:50:24.824 0:09.090 Opal Garba...090afa8700 SIP Attempting to abort SUBSCRIBE transaction id=z9hG4bK2e0f7506-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:24.824 0:09.090 Opal Garba...090afa8700 SIP Attempting to abort SUBSCRIBE transaction id=z9hG4bKe4a87f06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:24.824 0:09.090 Opal Garba...090afa8700 SIP Transaction 1 SUBSCRIBE sip:520@ekiga.net failed, unknown handler, ID: deeb7406-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:24.824 0:09.090 Opal Garba...090afa8700 SIP Completed state for transaction id=z9hG4bKe4a87f06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:24.824 0:09.090 Opal Garba...090afa8700 SIP Transaction 1 SUBSCRIBE sip:520@ekiga.net failed, unknown handler, ID: deeb7406-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:24.824 0:09.090 Opal Garba...090afa8700 SIP Completed state for transaction id=z9hG4bK2e0f7506-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:24.824 0:09.090 Opal Garba...090afa8700 SIP Attempting to abort SUBSCRIBE transaction id=z9hG4bKe4a87f06-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:24.824 0:09.090 Opal Garba...090afa8700 Opal Transport clean up on termination >2014/02/28 09:50:24.824 0:09.090 Opal Garba...090afa8700 Opal Transport Close >2014/02/28 09:50:24.825 0:09.090 Opal Garba...090afa8700 Opal Transport clean up on termination >2014/02/28 09:50:24.825 0:09.090 Opal Garba...090afa8700 Opal Transport Close >2014/02/28 09:50:24.825 0:09.090 Opal Garba...090afa8700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$*:5060> >2014/02/28 09:50:24.825 0:09.091 Opal Garba...090afa8700 SIP Destroyed SUBSCRIBE handler for sip:520@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net >2014/02/28 09:50:25.825 0:10.091 Opal Garba...090afa8700 SIP Transaction id=z9hG4bK2e0f7506-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:25.826 0:10.092 Opal Garba...090afa8700 SIP Transaction id=z9hG4bKe4a87f06-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:25.856 0:10.122 Housekeepe...090b0ac700 SIP NAT Binding refresh for REGISTER to sip:desktopqe@ekiga.net, id=f2bf3206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:25.857 0:10.122 Housekeepe...090b0ac700 SIP Constructed OPTIONS handler for sip:desktopqe@ekiga.net >2014/02/28 09:50:25.857 0:10.122 Housekeepe...090b0ac700 SIP Changing OPTIONS handler from Unavailable to Subscribed, target=sip:desktopqe@ekiga.net, id=d6ea0709-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:25.857 0:10.123 Housekeepe...090b0ac700 SIP Executing state change to Unsubscribing for OPTIONS handler, target=sip:desktopqe@ekiga.net, id=d6ea0709-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:25.857 0:10.123 Housekeepe...090b0ac700 SIP Changing OPTIONS handler from Subscribed to Unsubscribing, target=sip:desktopqe@ekiga.net, id=d6ea0709-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:25.857 0:10.123 Housekeepe...090b0ac700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:50:25.857 0:10.123 Housekeepe...090b0ac700 SIP Created transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:25.857 0:10.123 Housekeepe...090b0ac700 OpalUDP Started connect to 86.64.162.35:5060 >2014/02/28 09:50:25.857 0:10.123 Housekeepe...090b0ac700 SIP Transaction created. >2014/02/28 09:50:25.858 0:10.123 Housekeepe...090b0ac700 SIP Transaction remembering interface "10.34.130.146%em1" >2014/02/28 09:50:25.858 0:10.123 Housekeepe...090b0ac700 SIP No SRV lookup as has explicit port number. >2014/02/28 09:50:25.858 0:10.123 Housekeepe...090b0ac700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:25.858 0:10.124 Housekeepe...090b0ac700 SIP Sending PDU (622 bytes) to: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >OPTIONS sip:desktopqe@ekiga.net SIP/2.0 >Route: <sip:86.64.162.35:5060;lr> >CSeq: 7 OPTIONS >Via: SIP/2.0/UDP 209.132.186.34:27476;branch=z9hG4bK90080809-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=ae030809-c39e-e311-8b48-3c970e8ed11e >Call-ID: d6ea0709-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net> >Accept: application/sdp, application/media_control+xml, application/dtmf, application/dtmf-relay >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 0 >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:25.858 0:10.124 Housekeepe...090b0ac700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:25.858 0:10.124 Housekeepe...090b0ac700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:25.905 0:10.170 Opal Liste...08ec121700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:50:25.905 0:10.170 Opal Liste...08ec121700 SIP Waiting for PDU on udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:25.905 0:10.171 Opal Liste...08ec121700 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SIP/2.0 200 OK >CSeq: 7 OPTIONS >Via: SIP/2.0/UDP 10.34.130.146:5060;branch=z9hG4bK90080809-c39e-e311-8b48-3c970e8ed11e;rport=27476 >Server: Kamailio (1.5.3-notls (i386/linux)) >From: <sip:desktopqe@ekiga.net>;tag=ae030809-c39e-e311-8b48-3c970e8ed11e >Call-ID: d6ea0709-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.1143 >Content-Length: 0 > > >2014/02/28 09:50:25.905 0:10.171 Opal Liste...08ec121700 SIP Queueing PDU "7 OPTIONS <200>", transaction=z9hG4bK90080809-c39e-e311-8b48-3c970e8ed11e, token=d6ea0709-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:25.905 0:10.171 Opal Liste...08ec121700 Opal Transport clean up on termination >2014/02/28 09:50:25.905 0:10.171 Opal Liste...08ec121700 Opal Transport Close >2014/02/28 09:50:25.905 0:10.171 Pool:0x7f08b80f0700 SIP Handling PDU "7 OPTIONS <200>" for transaction=z9hG4bK90080809-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:25.905 0:10.171 Pool:0x7f08b80f0700 SIP OPTIONS transaction id=z9hG4bK90080809-c39e-e311-8b48-3c970e8ed11e completing. >2014/02/28 09:50:25.905 0:10.171 Pool:0x7f08b80f0700 SIP Finalising handlers interface "10.34.130.146%em1" >2014/02/28 09:50:25.905 0:10.171 Pool:0x7f08b80f0700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:25.905 0:10.171 Opal Liste...08ec121700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:25.905 0:10.171 Pool:0x7f08b80f0700 SIP Completed OPTIONS command to sip:desktopqe@ekiga.net;OPAL-proxy=86.64.162.35;OPAL-interface=10.34.130.146%25em1, status=200 OK >2014/02/28 09:50:25.905 0:10.171 Pool:0x7f08b80f0700 SIP Product Info: name="Kamailio", version="", vendor="", comments="(1.5.3-notls (i386/linux))" >2014/02/28 09:50:25.905 0:10.171 Pool:0x7f08b80f0700 SIP Changing OPTIONS handler from Unsubscribing to Unsubscribed, target=sip:desktopqe@ekiga.net, id=d6ea0709-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:25.906 0:10.171 Pool:0x7f08b80f0700 SIP OPTIONS transaction id=z9hG4bK90080809-c39e-e311-8b48-3c970e8ed11e completed. >2014/02/28 09:50:25.906 0:10.171 Pool:0x7f08b80f0700 SIP Handled PDU "7 OPTIONS <200>" >2014/02/28 09:50:26.826 0:11.092 Opal Garba...090afa8700 Opal Transport clean up on termination >2014/02/28 09:50:26.826 0:11.092 Opal Garba...090afa8700 Opal Transport Close >2014/02/28 09:50:26.827 0:11.092 Opal Garba...090afa8700 Opal Transport clean up on termination >2014/02/28 09:50:26.827 0:11.092 Opal Garba...090afa8700 Opal Transport Close >2014/02/28 09:50:26.827 0:11.092 Opal Garba...090afa8700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:26.827 0:11.093 Opal Garba...090afa8700 SIP Destroyed OPTIONS handler for sip:desktopqe@ekiga.net >2014/02/28 09:50:26.905 0:11.171 Housekeepe...090b0ac700 SIP Set state Terminated_Success for OPTIONS transaction id=z9hG4bK90080809-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:26.905 0:11.171 Housekeepe...090b0ac700 SIP Completed state for transaction id=z9hG4bK90080809-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:27.827 0:12.093 Opal Garba...090afa8700 SIP Transaction id=z9hG4bK90080809-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:35.856 0:20.122 Housekeepe...090b0ac700 SIP NAT Binding refresh for REGISTER to sip:desktopqe@ekiga.net, id=f2bf3206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:35.857 0:20.123 Housekeepe...090b0ac700 SIP Constructed OPTIONS handler for sip:desktopqe@ekiga.net >2014/02/28 09:50:35.857 0:20.123 Housekeepe...090b0ac700 SIP Changing OPTIONS handler from Unavailable to Subscribed, target=sip:desktopqe@ekiga.net, id=f2d7fd0e-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:35.857 0:20.123 Housekeepe...090b0ac700 SIP Executing state change to Unsubscribing for OPTIONS handler, target=sip:desktopqe@ekiga.net, id=f2d7fd0e-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:35.857 0:20.123 Housekeepe...090b0ac700 SIP Changing OPTIONS handler from Subscribed to Unsubscribing, target=sip:desktopqe@ekiga.net, id=f2d7fd0e-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:35.857 0:20.123 Housekeepe...090b0ac700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:50:35.857 0:20.123 Housekeepe...090b0ac700 SIP Created transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:35.857 0:20.123 Housekeepe...090b0ac700 OpalUDP Started connect to 86.64.162.35:5060 >2014/02/28 09:50:35.858 0:20.123 Housekeepe...090b0ac700 SIP Transaction created. >2014/02/28 09:50:35.858 0:20.124 Housekeepe...090b0ac700 SIP Transaction remembering interface "10.34.130.146%em1" >2014/02/28 09:50:35.858 0:20.124 Housekeepe...090b0ac700 SIP No SRV lookup as has explicit port number. >2014/02/28 09:50:35.858 0:20.124 Housekeepe...090b0ac700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:35.858 0:20.124 Housekeepe...090b0ac700 SIP Sending PDU (622 bytes) to: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >OPTIONS sip:desktopqe@ekiga.net SIP/2.0 >Route: <sip:86.64.162.35:5060;lr> >CSeq: 8 OPTIONS >Via: SIP/2.0/UDP 209.132.186.34:27476;branch=z9hG4bKc0f5fd0e-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=24f1fd0e-c39e-e311-8b48-3c970e8ed11e >Call-ID: f2d7fd0e-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net> >Accept: application/sdp, application/media_control+xml, application/dtmf, application/dtmf-relay >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 0 >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:35.858 0:20.124 Housekeepe...090b0ac700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:35.858 0:20.124 Housekeepe...090b0ac700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:35.905 0:20.171 Opal Liste...08ec121700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:50:35.905 0:20.171 Opal Liste...08ec121700 SIP Waiting for PDU on udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:35.905 0:20.171 Opal Liste...08ec121700 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SIP/2.0 200 OK >CSeq: 8 OPTIONS >Via: SIP/2.0/UDP 10.34.130.146:5060;branch=z9hG4bKc0f5fd0e-c39e-e311-8b48-3c970e8ed11e;rport=27476 >Server: Kamailio (1.5.3-notls (i386/linux)) >From: <sip:desktopqe@ekiga.net>;tag=24f1fd0e-c39e-e311-8b48-3c970e8ed11e >Call-ID: f2d7fd0e-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.f935 >Content-Length: 0 > > >2014/02/28 09:50:35.905 0:20.171 Opal Liste...08ec121700 SIP Queueing PDU "8 OPTIONS <200>", transaction=z9hG4bKc0f5fd0e-c39e-e311-8b48-3c970e8ed11e, token=f2d7fd0e-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:35.905 0:20.171 Opal Liste...08ec121700 Opal Transport clean up on termination >2014/02/28 09:50:35.905 0:20.171 Opal Liste...08ec121700 Opal Transport Close >2014/02/28 09:50:35.905 0:20.171 Pool:0x7f08b80f0700 SIP Handling PDU "8 OPTIONS <200>" for transaction=z9hG4bKc0f5fd0e-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:35.906 0:20.171 Pool:0x7f08b80f0700 SIP OPTIONS transaction id=z9hG4bKc0f5fd0e-c39e-e311-8b48-3c970e8ed11e completing. >2014/02/28 09:50:35.905 0:20.171 Opal Liste...08ec121700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:35.906 0:20.171 Pool:0x7f08b80f0700 SIP Finalising handlers interface "10.34.130.146%em1" >2014/02/28 09:50:35.906 0:20.171 Pool:0x7f08b80f0700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:35.906 0:20.171 Pool:0x7f08b80f0700 SIP Completed OPTIONS command to sip:desktopqe@ekiga.net;OPAL-proxy=86.64.162.35;OPAL-interface=10.34.130.146%25em1, status=200 OK >2014/02/28 09:50:35.906 0:20.171 Pool:0x7f08b80f0700 SIP Product Info: name="Kamailio", version="", vendor="", comments="(1.5.3-notls (i386/linux))" >2014/02/28 09:50:35.906 0:20.172 Pool:0x7f08b80f0700 SIP Changing OPTIONS handler from Unsubscribing to Unsubscribed, target=sip:desktopqe@ekiga.net, id=f2d7fd0e-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:35.906 0:20.172 Pool:0x7f08b80f0700 SIP OPTIONS transaction id=z9hG4bKc0f5fd0e-c39e-e311-8b48-3c970e8ed11e completed. >2014/02/28 09:50:35.906 0:20.172 Pool:0x7f08b80f0700 SIP Handled PDU "8 OPTIONS <200>" >2014/02/28 09:50:36.829 0:21.095 Opal Garba...090afa8700 Opal Transport clean up on termination >2014/02/28 09:50:36.829 0:21.095 Opal Garba...090afa8700 Opal Transport Close >2014/02/28 09:50:36.829 0:21.095 Opal Garba...090afa8700 Opal Transport clean up on termination >2014/02/28 09:50:36.829 0:21.095 Opal Garba...090afa8700 Opal Transport Close >2014/02/28 09:50:36.829 0:21.095 Opal Garba...090afa8700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:36.830 0:21.095 Opal Garba...090afa8700 SIP Destroyed OPTIONS handler for sip:desktopqe@ekiga.net >2014/02/28 09:50:36.906 0:21.172 Housekeepe...090b0ac700 SIP Set state Terminated_Success for OPTIONS transaction id=z9hG4bKc0f5fd0e-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:36.906 0:21.172 Housekeepe...090b0ac700 SIP Completed state for transaction id=z9hG4bKc0f5fd0e-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:37.830 0:22.096 Opal Garba...090afa8700 SIP Transaction id=z9hG4bKc0f5fd0e-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:45.857 0:30.123 Housekeepe...090b0ac700 SIP NAT Binding refresh for REGISTER to sip:desktopqe@ekiga.net, id=f2bf3206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:45.858 0:30.123 Housekeepe...090b0ac700 SIP Constructed OPTIONS handler for sip:desktopqe@ekiga.net >2014/02/28 09:50:45.858 0:30.124 Housekeepe...090b0ac700 SIP Changing OPTIONS handler from Unavailable to Subscribed, target=sip:desktopqe@ekiga.net, id=ead4f314-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:45.858 0:30.124 Housekeepe...090b0ac700 SIP Executing state change to Unsubscribing for OPTIONS handler, target=sip:desktopqe@ekiga.net, id=ead4f314-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:45.858 0:30.124 Housekeepe...090b0ac700 SIP Changing OPTIONS handler from Subscribed to Unsubscribing, target=sip:desktopqe@ekiga.net, id=ead4f314-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:45.858 0:30.124 Housekeepe...090b0ac700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:50:45.858 0:30.124 Housekeepe...090b0ac700 SIP Created transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:45.858 0:30.124 Housekeepe...090b0ac700 OpalUDP Started connect to 86.64.162.35:5060 >2014/02/28 09:50:45.858 0:30.124 Housekeepe...090b0ac700 SIP Transaction created. >2014/02/28 09:50:45.859 0:30.124 Housekeepe...090b0ac700 SIP Transaction remembering interface "10.34.130.146%em1" >2014/02/28 09:50:45.859 0:30.125 Housekeepe...090b0ac700 SIP No SRV lookup as has explicit port number. >2014/02/28 09:50:45.859 0:30.125 Housekeepe...090b0ac700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:45.859 0:30.125 Housekeepe...090b0ac700 SIP Sending PDU (622 bytes) to: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >OPTIONS sip:desktopqe@ekiga.net SIP/2.0 >Route: <sip:86.64.162.35:5060;lr> >CSeq: 9 OPTIONS >Via: SIP/2.0/UDP 209.132.186.34:27476;branch=z9hG4bKfcf4f314-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=1af0f314-c39e-e311-8b48-3c970e8ed11e >Call-ID: ead4f314-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net> >Accept: application/sdp, application/media_control+xml, application/dtmf, application/dtmf-relay >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 0 >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:45.859 0:30.125 Housekeepe...090b0ac700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:45.859 0:30.125 Housekeepe...090b0ac700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:45.905 0:30.171 Opal Liste...08ec121700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:50:45.906 0:30.171 Opal Liste...08ec121700 SIP Waiting for PDU on udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:45.906 0:30.172 Opal Liste...08ec121700 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SIP/2.0 200 OK >CSeq: 9 OPTIONS >Via: SIP/2.0/UDP 10.34.130.146:5060;branch=z9hG4bKfcf4f314-c39e-e311-8b48-3c970e8ed11e;rport=27476 >Server: Kamailio (1.5.3-notls (i386/linux)) >From: <sip:desktopqe@ekiga.net>;tag=1af0f314-c39e-e311-8b48-3c970e8ed11e >Call-ID: ead4f314-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.5bfb >Content-Length: 0 > > >2014/02/28 09:50:45.906 0:30.172 Opal Liste...08ec121700 SIP Queueing PDU "9 OPTIONS <200>", transaction=z9hG4bKfcf4f314-c39e-e311-8b48-3c970e8ed11e, token=ead4f314-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:45.906 0:30.172 Opal Liste...08ec121700 Opal Transport clean up on termination >2014/02/28 09:50:45.906 0:30.172 Opal Liste...08ec121700 Opal Transport Close >2014/02/28 09:50:45.906 0:30.172 Pool:0x7f08b80f0700 SIP Handling PDU "9 OPTIONS <200>" for transaction=z9hG4bKfcf4f314-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:45.906 0:30.172 Pool:0x7f08b80f0700 SIP OPTIONS transaction id=z9hG4bKfcf4f314-c39e-e311-8b48-3c970e8ed11e completing. >2014/02/28 09:50:45.906 0:30.172 Pool:0x7f08b80f0700 SIP Finalising handlers interface "10.34.130.146%em1" >2014/02/28 09:50:45.906 0:30.172 Pool:0x7f08b80f0700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:45.906 0:30.172 Pool:0x7f08b80f0700 SIP Completed OPTIONS command to sip:desktopqe@ekiga.net;OPAL-proxy=86.64.162.35;OPAL-interface=10.34.130.146%25em1, status=200 OK >2014/02/28 09:50:45.906 0:30.172 Opal Liste...08ec121700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:45.907 0:30.172 Pool:0x7f08b80f0700 SIP Product Info: name="Kamailio", version="", vendor="", comments="(1.5.3-notls (i386/linux))" >2014/02/28 09:50:45.907 0:30.172 Pool:0x7f08b80f0700 SIP Changing OPTIONS handler from Unsubscribing to Unsubscribed, target=sip:desktopqe@ekiga.net, id=ead4f314-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:45.907 0:30.172 Pool:0x7f08b80f0700 SIP OPTIONS transaction id=z9hG4bKfcf4f314-c39e-e311-8b48-3c970e8ed11e completed. >2014/02/28 09:50:45.907 0:30.172 Pool:0x7f08b80f0700 SIP Handled PDU "9 OPTIONS <200>" >2014/02/28 09:50:46.832 0:31.098 Opal Garba...090afa8700 Opal Transport clean up on termination >2014/02/28 09:50:46.833 0:31.098 Opal Garba...090afa8700 Opal Transport Close >2014/02/28 09:50:46.833 0:31.098 Opal Garba...090afa8700 Opal Transport clean up on termination >2014/02/28 09:50:46.833 0:31.098 Opal Garba...090afa8700 Opal Transport Close >2014/02/28 09:50:46.833 0:31.098 Opal Garba...090afa8700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:46.833 0:31.099 Opal Garba...090afa8700 SIP Destroyed OPTIONS handler for sip:desktopqe@ekiga.net >2014/02/28 09:50:46.906 0:31.172 Housekeepe...090b0ac700 SIP Set state Terminated_Success for OPTIONS transaction id=z9hG4bKfcf4f314-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:46.907 0:31.172 Housekeepe...090b0ac700 SIP Completed state for transaction id=z9hG4bKfcf4f314-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:47.040 0:31.306 GkMonitor:...08e404a700 RAS Time To Live reregistration >2014/02/28 09:50:47.084 0:31.349 GkMonitor:...08e404a700 OpalMan Listener interfaces: associated transport=udp$209.132.186.34:5061 > tcp$209.132.186.34:1720,tcp$10.34.130.146:1720,tcp$10.200.138.63:1720 >2014/02/28 09:50:47.084 0:31.350 GkMonitor:...08e404a700 Trans Making request: registrationRequest >2014/02/28 09:50:47.084 0:31.350 GkMonitor:...08e404a700 H235RAS Prepared PDU with authenticator MD5<active> >2014/02/28 09:50:47.084 0:31.350 GkMonitor:...08e404a700 Trans Sending PDU: > registrationRequest { > requestSeqNum = 54508 > protocolIdentifier = 0.0.8.2250.0.6 > discoveryComplete = false > callSignalAddress = 3 entries { > [0]=ipAddress { > ip = 4 octets { > d1 84 ba 22 ..." > } > port = 1720 > } > [1]=ipAddress { > ip = 4 octets { > 0a 22 82 92 .".. > } > port = 1720 > } > [2]=ipAddress { > ip = 4 octets { > 0a c8 8a 3f ...? > } > port = 1720 > } > } > rasAddress = 1 entries { > [0]=ipAddress { > ip = 4 octets { > d1 84 ba 22 ..." > } > port = 5061 > } > } > terminalType = { > vendor = { > vendor = { > t35CountryCode = 9 > t35Extension = 0 > manufacturerCode = 61 > } > productId = 3 octets { > 00 00 00 ... > } > versionId = 35 octets { > 34 2e 30 2e 31 20 28 4f 50 41 4c 20 76 33 2e 31 4.0.1 (OPAL v3.1 > 30 2e 31 30 20 28 73 76 6e 3a 32 39 31 35 30 29 0.10 (svn:29150) > ... > } > } > terminal = { > } > mc = false > undefinedNode = false > } > terminalAlias = 4 entries { > [0]=h323_ID 9 characters { > 0064 0065 0073 006b 0074 006f 0070 0071 desktopq > 0065 e > } > [1]=h323_ID 21 characters { > 0064 0065 0073 006b 0074 006f 0070 0071 desktopq > 0065 0040 0073 0070 0072 0061 006e 0074 e@sprant > 006f 002e 006e 0065 0074 o.net > } > [2]=dialedDigits "1081333021" > [3]=dialedDigits "878401081333021" > } > gatekeeperIdentifier = 9 characters { > 0068 0033 0032 0033 006e 0065 0074 005f h323net_ > 0034 4 > } > endpointVendor = { > vendor = { > t35CountryCode = 9 > t35Extension = 0 > manufacturerCode = 61 > } > productId = 3 octets { > 00 00 00 ... > } > versionId = 35 octets { > 34 2e 30 2e 31 20 28 4f 50 41 4c 20 76 33 2e 31 4.0.1 (OPAL v3.1 > 30 2e 31 30 20 28 73 76 6e 3a 32 39 31 35 30 29 0.10 (svn:29150) > ... > } > } > timeToLive = 3600 > cryptoTokens = 1 entries { > [0]=cryptoEPPwdHash { > alias = h323_ID 9 characters { > 0064 0065 0073 006b 0074 006f 0070 0071 desktopq > 0065 e > } > timeStamp = 1393577447 > token = { > algorithmOID = 1.2.840.113549.2.5 > paramS = { > } > hash = Hex: eb c2 b0 26 ba af f4 d9 c7 71 0e f7 f8 1a 44 55 > } > } > } > keepAlive = true > endpointIdentifier = 9 characters { > 0035 0031 0032 0036 005f 0065 006e 0064 5126_end > 0070 p > } > willSupplyUUIEs = true > maintainConnection = false > supportsAltGK = <<null>> > usageReportingCapability = { > nonStandardUsageTypes = 0 entries { > } > startTime = <<null>> > endTime = <<null>> > terminationCause = <<null>> > } > callCreditCapability = { > canEnforceDurationLimit = true > } > } >2014/02/28 09:50:47.084 0:31.350 GkMonitor:...08e404a700 Trans Waiting on response to seqnum=54508 for 3.0 seconds >2014/02/28 09:50:47.252 0:31.518 Transactor...08b8131700 H225RAS Receiving PDU: > registrationConfirm { > requestSeqNum = 54508 > protocolIdentifier = 0.0.8.2250.0.6 > callSignalAddress = 1 entries { > [0]=ipAddress { > ip = 4 octets { > 17 17 98 ca .... > } > port = 1720 > } > } > terminalAlias = 4 entries { > [0]=url_ID "desktopqe@spranto.net" > [1]=dialedDigits "1081333021" > [2]=dialedDigits "878401081333021" > [3]=h323_ID 9 characters { > 0064 0065 0073 006b 0074 006f 0070 0071 desktopq > 0065 e > } > } > gatekeeperIdentifier = 9 characters { > 0068 0033 0032 0033 006e 0065 0074 005f h323net_ > 0034 4 > } > endpointIdentifier = 9 characters { > 0035 0031 0032 0036 005f 0065 006e 0064 5126_end > 0070 p > } > timeToLive = 30 > willRespondToIRR = false > maintainConnection = false > supportsAdditiveRegistration = <<null>> > } >2014/02/28 09:50:47.252 0:31.518 Transactor...08b8131700 Trans Using credentials from request: H235AnnexD_Procedure1<disabled>,CAT<disabled>,MD5<active> >2014/02/28 09:50:47.252 0:31.518 Transactor...08b8131700 RAS Registered 5126_endp with h323net_4 >2014/02/28 09:50:47.834 0:32.099 Opal Garba...090afa8700 SIP Transaction id=z9hG4bKfcf4f314-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:50:51.226 0:35.491 Ekiga SubscribeToPresence for h323:qedesktop@spranto.net (fetch) >2014/02/28 09:50:51.226 0:35.491 PWLib Assertion fail: Null pointer reference, file /usr/include/ptlib/safecoll.h, line 877, Error=11 >Assertion fail: Null pointer reference, file /usr/include/ptlib/safecoll.h, line 877, Error=11 > ><A>bort, <C>ore dump, <I>gnore? 2014/02/28 09:50:51.320 0:35.586 Housekeepe...090b0ac700 SIP Starting SUBSCRIBE for offline retry >2014/02/28 09:50:51.320 0:35.586 Housekeepe...090b0ac700 SIP Changing SUBSCRIBE handler from Unavailable to Restoring, target=sip:desktopqe@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=6ae83206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:51.320 0:35.586 Housekeepe...090b0ac700 DNS SRV Lookup "_sip._tcp.ekiga.net" >2014/02/28 09:50:51.501 0:35.767 Housekeepe...090b0ac700 DNS Query failed: error=-1 >2014/02/28 09:50:51.501 0:35.767 Housekeepe...090b0ac700 SIP No SRV record found. >2014/02/28 09:50:51.501 0:35.767 Housekeepe...090b0ac700 SIP No compatible listener to create transport for tcp$ekiga.net:5060 >2014/02/28 09:50:51.501 0:35.767 Housekeepe...090b0ac700 SIP Changing SUBSCRIBE handler from Restoring to Unavailable, target=sip:desktopqe@ekiga.net;OPAL-local-id=sip:desktopqe%40ekiga.net, id=6ae83206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:51.501 0:35.767 Housekeepe...090b0ac700 SIP Retrying SUBSCRIBE after 30 seconds. >2014/02/28 09:50:55.858 0:40.124 Housekeepe...090b0ac700 SIP NAT Binding refresh for REGISTER to sip:desktopqe@ekiga.net, id=f2bf3206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:55.858 0:40.124 Housekeepe...090b0ac700 SIP Constructed OPTIONS handler for sip:desktopqe@ekiga.net >2014/02/28 09:50:55.859 0:40.124 Housekeepe...090b0ac700 SIP Changing OPTIONS handler from Unavailable to Subscribed, target=sip:desktopqe@ekiga.net, id=78d2e91a-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:55.859 0:40.124 Housekeepe...090b0ac700 SIP Executing state change to Unsubscribing for OPTIONS handler, target=sip:desktopqe@ekiga.net, id=78d2e91a-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:55.859 0:40.124 Housekeepe...090b0ac700 SIP Changing OPTIONS handler from Subscribed to Unsubscribing, target=sip:desktopqe@ekiga.net, id=78d2e91a-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:55.859 0:40.124 Housekeepe...090b0ac700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:50:55.859 0:40.124 Housekeepe...090b0ac700 SIP Created transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:55.859 0:40.125 Housekeepe...090b0ac700 OpalUDP Started connect to 86.64.162.35:5060 >2014/02/28 09:50:55.859 0:40.125 Housekeepe...090b0ac700 SIP Transaction created. >2014/02/28 09:50:55.859 0:40.125 Housekeepe...090b0ac700 SIP Transaction remembering interface "10.34.130.146%em1" >2014/02/28 09:50:55.860 0:40.125 Housekeepe...090b0ac700 SIP No SRV lookup as has explicit port number. >2014/02/28 09:50:55.860 0:40.125 Housekeepe...090b0ac700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:50:55.860 0:40.125 Housekeepe...090b0ac700 SIP Sending PDU (623 bytes) to: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >OPTIONS sip:desktopqe@ekiga.net SIP/2.0 >Route: <sip:86.64.162.35:5060;lr> >CSeq: 10 OPTIONS >Via: SIP/2.0/UDP 209.132.186.34:27476;branch=z9hG4bK06f4e91a-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=e8eee91a-c39e-e311-8b48-3c970e8ed11e >Call-ID: 78d2e91a-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net> >Accept: application/sdp, application/media_control+xml, application/dtmf, application/dtmf-relay >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 0 >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:50:55.860 0:40.126 Housekeepe...090b0ac700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:55.860 0:40.126 Housekeepe...090b0ac700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:50:55.907 0:40.172 Opal Liste...08ec121700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:50:55.907 0:40.172 Opal Liste...08ec121700 SIP Waiting for PDU on udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:55.907 0:40.173 Opal Liste...08ec121700 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SIP/2.0 200 OK >CSeq: 10 OPTIONS >Via: SIP/2.0/UDP 10.34.130.146:5060;branch=z9hG4bK06f4e91a-c39e-e311-8b48-3c970e8ed11e;rport=27476 >Server: Kamailio (1.5.3-notls (i386/linux)) >From: <sip:desktopqe@ekiga.net>;tag=e8eee91a-c39e-e311-8b48-3c970e8ed11e >Call-ID: 78d2e91a-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.5bc7 >Content-Length: 0 > > >2014/02/28 09:50:55.907 0:40.173 Opal Liste...08ec121700 SIP Queueing PDU "10 OPTIONS <200>", transaction=z9hG4bK06f4e91a-c39e-e311-8b48-3c970e8ed11e, token=78d2e91a-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:55.907 0:40.173 Opal Liste...08ec121700 Opal Transport clean up on termination >2014/02/28 09:50:55.907 0:40.173 Opal Liste...08ec121700 Opal Transport Close >2014/02/28 09:50:55.907 0:40.173 Pool:0x7f08b80f0700 SIP Handling PDU "10 OPTIONS <200>" for transaction=z9hG4bK06f4e91a-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:55.908 0:40.173 Pool:0x7f08b80f0700 SIP OPTIONS transaction id=z9hG4bK06f4e91a-c39e-e311-8b48-3c970e8ed11e completing. >2014/02/28 09:50:55.908 0:40.173 Pool:0x7f08b80f0700 SIP Finalising handlers interface "10.34.130.146%em1" >2014/02/28 09:50:55.908 0:40.173 Pool:0x7f08b80f0700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:50:55.907 0:40.173 Opal Liste...08ec121700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:55.908 0:40.173 Pool:0x7f08b80f0700 SIP Completed OPTIONS command to sip:desktopqe@ekiga.net;OPAL-proxy=86.64.162.35;OPAL-interface=10.34.130.146%25em1, status=200 OK >2014/02/28 09:50:55.908 0:40.173 Pool:0x7f08b80f0700 SIP Product Info: name="Kamailio", version="", vendor="", comments="(1.5.3-notls (i386/linux))" >2014/02/28 09:50:55.908 0:40.173 Pool:0x7f08b80f0700 SIP Changing OPTIONS handler from Unsubscribing to Unsubscribed, target=sip:desktopqe@ekiga.net, id=78d2e91a-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:50:55.908 0:40.173 Pool:0x7f08b80f0700 SIP OPTIONS transaction id=z9hG4bK06f4e91a-c39e-e311-8b48-3c970e8ed11e completed. >2014/02/28 09:50:55.908 0:40.173 Pool:0x7f08b80f0700 SIP Handled PDU "10 OPTIONS <200>" >2014/02/28 09:50:56.836 0:41.102 Opal Garba...090afa8700 Opal Transport clean up on termination >2014/02/28 09:50:56.836 0:41.102 Opal Garba...090afa8700 Opal Transport Close >2014/02/28 09:50:56.836 0:41.102 Opal Garba...090afa8700 Opal Transport clean up on termination >2014/02/28 09:50:56.836 0:41.102 Opal Garba...090afa8700 Opal Transport Close >2014/02/28 09:50:56.836 0:41.102 Opal Garba...090afa8700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:50:56.836 0:41.102 Opal Garba...090afa8700 SIP Destroyed OPTIONS handler for sip:desktopqe@ekiga.net >2014/02/28 09:50:56.908 0:41.173 Housekeepe...090b0ac700 SIP Set state Terminated_Success for OPTIONS transaction id=z9hG4bK06f4e91a-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:56.908 0:41.173 Housekeepe...090b0ac700 SIP Completed state for transaction id=z9hG4bK06f4e91a-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:50:57.837 0:42.103 Opal Garba...090afa8700 SIP Transaction id=z9hG4bK06f4e91a-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:51:05.858 0:50.123 Housekeepe...090b0ac700 SIP NAT Binding refresh for REGISTER to sip:desktopqe@ekiga.net, id=f2bf3206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:51:05.858 0:50.124 Housekeepe...090b0ac700 SIP Constructed OPTIONS handler for sip:desktopqe@ekiga.net >2014/02/28 09:51:05.858 0:50.124 Housekeepe...090b0ac700 SIP Changing OPTIONS handler from Unavailable to Subscribed, target=sip:desktopqe@ekiga.net, id=30abdf20-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:51:05.858 0:50.124 Housekeepe...090b0ac700 SIP Executing state change to Unsubscribing for OPTIONS handler, target=sip:desktopqe@ekiga.net, id=30abdf20-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:51:05.858 0:50.124 Housekeepe...090b0ac700 SIP Changing OPTIONS handler from Subscribed to Unsubscribing, target=sip:desktopqe@ekiga.net, id=30abdf20-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:51:05.859 0:50.124 Housekeepe...090b0ac700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:51:05.859 0:50.124 Housekeepe...090b0ac700 SIP Created transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:51:05.859 0:50.124 Housekeepe...090b0ac700 OpalUDP Started connect to 86.64.162.35:5060 >2014/02/28 09:51:05.859 0:50.124 Housekeepe...090b0ac700 SIP Transaction created. >2014/02/28 09:51:05.859 0:50.125 Housekeepe...090b0ac700 SIP Transaction remembering interface "10.34.130.146%em1" >2014/02/28 09:51:05.859 0:50.125 Housekeepe...090b0ac700 SIP No SRV lookup as has explicit port number. >2014/02/28 09:51:05.859 0:50.125 Housekeepe...090b0ac700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:51:05.859 0:50.125 Housekeepe...090b0ac700 SIP Sending PDU (623 bytes) to: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >OPTIONS sip:desktopqe@ekiga.net SIP/2.0 >Route: <sip:86.64.162.35:5060;lr> >CSeq: 11 OPTIONS >Via: SIP/2.0/UDP 209.132.186.34:27476;branch=z9hG4bK24cbdf20-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=24c6df20-c39e-e311-8b48-3c970e8ed11e >Call-ID: 30abdf20-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net> >Accept: application/sdp, application/media_control+xml, application/dtmf, application/dtmf-relay >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 0 >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:51:05.860 0:50.125 Housekeepe...090b0ac700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:51:05.860 0:50.125 Housekeepe...090b0ac700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:51:05.906 0:50.172 Opal Liste...08ec121700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:51:05.907 0:50.172 Opal Liste...08ec121700 SIP Waiting for PDU on udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:51:05.907 0:50.173 Opal Liste...08ec121700 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SIP/2.0 200 OK >CSeq: 11 OPTIONS >Via: SIP/2.0/UDP 10.34.130.146:5060;branch=z9hG4bK24cbdf20-c39e-e311-8b48-3c970e8ed11e;rport=27476 >Server: Kamailio (1.5.3-notls (i386/linux)) >From: <sip:desktopqe@ekiga.net>;tag=24c6df20-c39e-e311-8b48-3c970e8ed11e >Call-ID: 30abdf20-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.df20 >Content-Length: 0 > > >2014/02/28 09:51:05.907 0:50.173 Opal Liste...08ec121700 SIP Queueing PDU "11 OPTIONS <200>", transaction=z9hG4bK24cbdf20-c39e-e311-8b48-3c970e8ed11e, token=30abdf20-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:51:05.907 0:50.173 Opal Liste...08ec121700 Opal Transport clean up on termination >2014/02/28 09:51:05.907 0:50.173 Opal Liste...08ec121700 Opal Transport Close >2014/02/28 09:51:05.907 0:50.173 Pool:0x7f08b80f0700 SIP Handling PDU "11 OPTIONS <200>" for transaction=z9hG4bK24cbdf20-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:51:05.908 0:50.173 Pool:0x7f08b80f0700 SIP OPTIONS transaction id=z9hG4bK24cbdf20-c39e-e311-8b48-3c970e8ed11e completing. >2014/02/28 09:51:05.908 0:50.173 Pool:0x7f08b80f0700 SIP Finalising handlers interface "10.34.130.146%em1" >2014/02/28 09:51:05.908 0:50.173 Pool:0x7f08b80f0700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:51:05.908 0:50.173 Opal Liste...08ec121700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:51:05.908 0:50.173 Pool:0x7f08b80f0700 SIP Completed OPTIONS command to sip:desktopqe@ekiga.net;OPAL-proxy=86.64.162.35;OPAL-interface=10.34.130.146%25em1, status=200 OK >2014/02/28 09:51:05.908 0:50.174 Pool:0x7f08b80f0700 SIP Product Info: name="Kamailio", version="", vendor="", comments="(1.5.3-notls (i386/linux))" >2014/02/28 09:51:05.908 0:50.174 Pool:0x7f08b80f0700 SIP Changing OPTIONS handler from Unsubscribing to Unsubscribed, target=sip:desktopqe@ekiga.net, id=30abdf20-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:51:05.908 0:50.174 Pool:0x7f08b80f0700 SIP OPTIONS transaction id=z9hG4bK24cbdf20-c39e-e311-8b48-3c970e8ed11e completed. >2014/02/28 09:51:05.908 0:50.174 Pool:0x7f08b80f0700 SIP Handled PDU "11 OPTIONS <200>" >2014/02/28 09:51:06.839 0:51.105 Opal Garba...090afa8700 Opal Transport clean up on termination >2014/02/28 09:51:06.839 0:51.105 Opal Garba...090afa8700 Opal Transport Close >2014/02/28 09:51:06.839 0:51.105 Opal Garba...090afa8700 Opal Transport clean up on termination >2014/02/28 09:51:06.839 0:51.105 Opal Garba...090afa8700 Opal Transport Close >2014/02/28 09:51:06.839 0:51.105 Opal Garba...090afa8700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:51:06.840 0:51.105 Opal Garba...090afa8700 SIP Destroyed OPTIONS handler for sip:desktopqe@ekiga.net >2014/02/28 09:51:06.908 0:51.174 Housekeepe...090b0ac700 SIP Set state Terminated_Success for OPTIONS transaction id=z9hG4bK24cbdf20-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:51:06.908 0:51.174 Housekeepe...090b0ac700 SIP Completed state for transaction id=z9hG4bK24cbdf20-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:51:07.840 0:52.106 Opal Garba...090afa8700 SIP Transaction id=z9hG4bK24cbdf20-c39e-e311-8b48-3c970e8ed11e destroyed. >2014/02/28 09:51:12.253 0:56.519 GkMonitor:...08e404a700 RAS Time To Live reregistration >2014/02/28 09:51:12.296 0:56.562 GkMonitor:...08e404a700 OpalMan Listener interfaces: associated transport=udp$209.132.186.34:5061 > tcp$209.132.186.34:1720,tcp$10.34.130.146:1720,tcp$10.200.138.63:1720 >2014/02/28 09:51:12.296 0:56.562 GkMonitor:...08e404a700 Trans Making request: registrationRequest >2014/02/28 09:51:12.296 0:56.562 GkMonitor:...08e404a700 H235RAS Prepared PDU with authenticator MD5<active> >2014/02/28 09:51:12.296 0:56.562 GkMonitor:...08e404a700 Trans Sending PDU: > registrationRequest { > requestSeqNum = 54509 > protocolIdentifier = 0.0.8.2250.0.6 > discoveryComplete = false > callSignalAddress = 3 entries { > [0]=ipAddress { > ip = 4 octets { > d1 84 ba 22 ..." > } > port = 1720 > } > [1]=ipAddress { > ip = 4 octets { > 0a 22 82 92 .".. > } > port = 1720 > } > [2]=ipAddress { > ip = 4 octets { > 0a c8 8a 3f ...? > } > port = 1720 > } > } > rasAddress = 1 entries { > [0]=ipAddress { > ip = 4 octets { > d1 84 ba 22 ..." > } > port = 5061 > } > } > terminalType = { > vendor = { > vendor = { > t35CountryCode = 9 > t35Extension = 0 > manufacturerCode = 61 > } > productId = 3 octets { > 00 00 00 ... > } > versionId = 35 octets { > 34 2e 30 2e 31 20 28 4f 50 41 4c 20 76 33 2e 31 4.0.1 (OPAL v3.1 > 30 2e 31 30 20 28 73 76 6e 3a 32 39 31 35 30 29 0.10 (svn:29150) > ... > } > } > terminal = { > } > mc = false > undefinedNode = false > } > terminalAlias = 4 entries { > [0]=h323_ID 9 characters { > 0064 0065 0073 006b 0074 006f 0070 0071 desktopq > 0065 e > } > [1]=h323_ID 21 characters { > 0064 0065 0073 006b 0074 006f 0070 0071 desktopq > 0065 0040 0073 0070 0072 0061 006e 0074 e@sprant > 006f 002e 006e 0065 0074 o.net > } > [2]=dialedDigits "1081333021" > [3]=dialedDigits "878401081333021" > } > gatekeeperIdentifier = 9 characters { > 0068 0033 0032 0033 006e 0065 0074 005f h323net_ > 0034 4 > } > endpointVendor = { > vendor = { > t35CountryCode = 9 > t35Extension = 0 > manufacturerCode = 61 > } > productId = 3 octets { > 00 00 00 ... > } > versionId = 35 octets { > 34 2e 30 2e 31 20 28 4f 50 41 4c 20 76 33 2e 31 4.0.1 (OPAL v3.1 > 30 2e 31 30 20 28 73 76 6e 3a 32 39 31 35 30 29 0.10 (svn:29150) > ... > } > } > timeToLive = 3600 > cryptoTokens = 1 entries { > [0]=cryptoEPPwdHash { > alias = h323_ID 9 characters { > 0064 0065 0073 006b 0074 006f 0070 0071 desktopq > 0065 e > } > timeStamp = 1393577472 > token = { > algorithmOID = 1.2.840.113549.2.5 > paramS = { > } > hash = Hex: 81 ac a1 e2 a6 c9 ac e1 7d 91 2c 4b e6 84 b1 50 > } > } > } > keepAlive = true > endpointIdentifier = 9 characters { > 0035 0031 0032 0036 005f 0065 006e 0064 5126_end > 0070 p > } > willSupplyUUIEs = true > maintainConnection = false > supportsAltGK = <<null>> > usageReportingCapability = { > nonStandardUsageTypes = 0 entries { > } > startTime = <<null>> > endTime = <<null>> > terminationCause = <<null>> > } > callCreditCapability = { > canEnforceDurationLimit = true > } > } >2014/02/28 09:51:12.296 0:56.562 GkMonitor:...08e404a700 Trans Waiting on response to seqnum=54509 for 3.0 seconds >2014/02/28 09:51:12.418 0:56.684 Transactor...08b8131700 H225RAS Receiving PDU: > registrationConfirm { > requestSeqNum = 54509 > protocolIdentifier = 0.0.8.2250.0.6 > callSignalAddress = 1 entries { > [0]=ipAddress { > ip = 4 octets { > 17 17 98 ca .... > } > port = 1720 > } > } > terminalAlias = 4 entries { > [0]=url_ID "desktopqe@spranto.net" > [1]=dialedDigits "1081333021" > [2]=dialedDigits "878401081333021" > [3]=h323_ID 9 characters { > 0064 0065 0073 006b 0074 006f 0070 0071 desktopq > 0065 e > } > } > gatekeeperIdentifier = 9 characters { > 0068 0033 0032 0033 006e 0065 0074 005f h323net_ > 0034 4 > } > endpointIdentifier = 9 characters { > 0035 0031 0032 0036 005f 0065 006e 0064 5126_end > 0070 p > } > timeToLive = 30 > willRespondToIRR = false > maintainConnection = false > supportsAdditiveRegistration = <<null>> > } >2014/02/28 09:51:12.419 0:56.684 Transactor...08b8131700 Trans Using credentials from request: H235AnnexD_Procedure1<disabled>,CAT<disabled>,MD5<active> >2014/02/28 09:51:12.419 0:56.684 Transactor...08b8131700 RAS Registered 5126_endp with h323net_4 >2014/02/28 09:51:15.857 1:00.123 Housekeepe...090b0ac700 SIP NAT Binding refresh for REGISTER to sip:desktopqe@ekiga.net, id=f2bf3206-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:51:15.858 1:00.123 Housekeepe...090b0ac700 SIP Constructed OPTIONS handler for sip:desktopqe@ekiga.net >2014/02/28 09:51:15.858 1:00.123 Housekeepe...090b0ac700 SIP Changing OPTIONS handler from Unavailable to Subscribed, target=sip:desktopqe@ekiga.net, id=9077d526-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:51:15.858 1:00.124 Housekeepe...090b0ac700 SIP Executing state change to Unsubscribing for OPTIONS handler, target=sip:desktopqe@ekiga.net, id=9077d526-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:51:15.858 1:00.124 Housekeepe...090b0ac700 SIP Changing OPTIONS handler from Subscribed to Unsubscribing, target=sip:desktopqe@ekiga.net, id=9077d526-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:51:15.858 1:00.124 Housekeepe...090b0ac700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:51:15.858 1:00.124 Housekeepe...090b0ac700 SIP Created transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:51:15.858 1:00.124 Housekeepe...090b0ac700 OpalUDP Started connect to 86.64.162.35:5060 >2014/02/28 09:51:15.858 1:00.124 Housekeepe...090b0ac700 SIP Transaction created. >2014/02/28 09:51:15.859 1:00.124 Housekeepe...090b0ac700 SIP Transaction remembering interface "10.34.130.146%em1" >2014/02/28 09:51:15.859 1:00.124 Housekeepe...090b0ac700 SIP No SRV lookup as has explicit port number. >2014/02/28 09:51:15.859 1:00.124 Housekeepe...090b0ac700 SIP Transaction remote address is udp$86.64.162.35:5060 >2014/02/28 09:51:15.859 1:00.125 Housekeepe...090b0ac700 SIP Sending PDU (623 bytes) to: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >OPTIONS sip:desktopqe@ekiga.net SIP/2.0 >Route: <sip:86.64.162.35:5060;lr> >CSeq: 12 OPTIONS >Via: SIP/2.0/UDP 209.132.186.34:27476;branch=z9hG4bKe095d526-c39e-e311-8b48-3c970e8ed11e;rport >User-Agent: Ekiga/4.0.1 >From: <sip:desktopqe@ekiga.net>;tag=1291d526-c39e-e311-8b48-3c970e8ed11e >Call-ID: 9077d526-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net> >Accept: application/sdp, application/media_control+xml, application/dtmf, application/dtmf-relay >Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK >Expires: 0 >Content-Length: 0 >Max-Forwards: 70 > > >2014/02/28 09:51:15.859 1:00.125 Housekeepe...090b0ac700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:51:15.859 1:00.125 Housekeepe...090b0ac700 SIP Transaction timers set: retry=0.500, completion=6.000 >2014/02/28 09:51:15.906 1:00.171 Opal Liste...08ec121700 OpalUDP Binding to interface: 10.34.130.146:5060 >2014/02/28 09:51:15.906 1:00.172 Opal Liste...08ec121700 SIP Waiting for PDU on udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:51:15.906 1:00.172 Opal Liste...08ec121700 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$209.132.186.34:27476,if=10.34.130.146%em1 >SIP/2.0 200 OK >CSeq: 12 OPTIONS >Via: SIP/2.0/UDP 10.34.130.146:5060;branch=z9hG4bKe095d526-c39e-e311-8b48-3c970e8ed11e;rport=27476 >Server: Kamailio (1.5.3-notls (i386/linux)) >From: <sip:desktopqe@ekiga.net>;tag=1291d526-c39e-e311-8b48-3c970e8ed11e >Call-ID: 9077d526-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >To: <sip:desktopqe@ekiga.net>;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.fdaa >Content-Length: 0 > > >2014/02/28 09:51:15.906 1:00.172 Opal Liste...08ec121700 SIP Queueing PDU "12 OPTIONS <200>", transaction=z9hG4bKe095d526-c39e-e311-8b48-3c970e8ed11e, token=9077d526-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:51:15.906 1:00.172 Opal Liste...08ec121700 Opal Transport clean up on termination >2014/02/28 09:51:15.906 1:00.172 Opal Liste...08ec121700 Opal Transport Close >2014/02/28 09:51:15.907 1:00.172 Pool:0x7f08b80f0700 SIP Handling PDU "12 OPTIONS <200>" for transaction=z9hG4bKe095d526-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:51:15.907 1:00.172 Pool:0x7f08b80f0700 SIP OPTIONS transaction id=z9hG4bKe095d526-c39e-e311-8b48-3c970e8ed11e completing. >2014/02/28 09:51:15.907 1:00.172 Pool:0x7f08b80f0700 SIP Finalising handlers interface "10.34.130.146%em1" >2014/02/28 09:51:15.907 1:00.172 Pool:0x7f08b80f0700 OpalUDP Setting interface to 10.34.130.146%em1 >2014/02/28 09:51:15.907 1:00.172 Opal Liste...08ec121700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:51:15.907 1:00.172 Pool:0x7f08b80f0700 SIP Completed OPTIONS command to sip:desktopqe@ekiga.net;OPAL-proxy=86.64.162.35;OPAL-interface=10.34.130.146%25em1, status=200 OK >2014/02/28 09:51:15.907 1:00.172 Pool:0x7f08b80f0700 SIP Product Info: name="Kamailio", version="", vendor="", comments="(1.5.3-notls (i386/linux))" >2014/02/28 09:51:15.907 1:00.173 Pool:0x7f08b80f0700 SIP Changing OPTIONS handler from Unsubscribing to Unsubscribed, target=sip:desktopqe@ekiga.net, id=9077d526-c39e-e311-8b48-3c970e8ed11e@msimon.brq.redhat.com >2014/02/28 09:51:15.907 1:00.173 Pool:0x7f08b80f0700 SIP OPTIONS transaction id=z9hG4bKe095d526-c39e-e311-8b48-3c970e8ed11e completed. >2014/02/28 09:51:15.907 1:00.173 Pool:0x7f08b80f0700 SIP Handled PDU "12 OPTIONS <200>" >2014/02/28 09:51:16.842 1:01.108 Opal Garba...090afa8700 Opal Transport clean up on termination >2014/02/28 09:51:16.842 1:01.108 Opal Garba...090afa8700 Opal Transport Close >2014/02/28 09:51:16.842 1:01.108 Opal Garba...090afa8700 Opal Transport clean up on termination >2014/02/28 09:51:16.842 1:01.108 Opal Garba...090afa8700 Opal Transport Close >2014/02/28 09:51:16.842 1:01.108 Opal Garba...090afa8700 Opal Deleted transport udp$86.64.162.35:5060<if=udp$209.132.186.34:27476> >2014/02/28 09:51:16.842 1:01.108 Opal Garba...090afa8700 SIP Destroyed OPTIONS handler for sip:desktopqe@ekiga.net >2014/02/28 09:51:16.908 1:01.173 Housekeepe...090b0ac700 SIP Set state Terminated_Success for OPTIONS transaction id=z9hG4bKe095d526-c39e-e311-8b48-3c970e8ed11e >2014/02/28 09:51:16.908 1:01.173 Housekeepe...090b0ac700 SIP Completed state for transaction id=z9hG4bKe095d526-c39e-e311-8b48-3c970e8ed11e >A
You cannot view the attachment while viewing its details because your browser does not support IFRAMEs.
View the attachment on a separate page
.
View Attachment As Raw
Actions:
View
Attachments on
bug 1069663
:
867419
| 868916 |
872637