GNU gdb 6.8-debian Copyright (C) 2008 Free Software Foundation, Inc. License GPLv3+: GNU GPL version 3 or later This is free software: you are free to change and redistribute it. There is NO WARRANTY, to the extent permitted by law. Type "show copying" and "show warranty" for details. This GDB was configured as "i486-linux-gnu"... (gdb) run Starting program: /usr/bin/ekiga -d 4 [Thread debugging using libthread_db enabled] [New Thread 0xb5bfd730 (LWP 18083)] 2009/08/18 15:35:32.563 0:01.312 Version 3.2.0 by on Unix Linux (2.6.28-15-generic-i686) with PTLib (v2.6.1) at 2009/8/18 15:35:32.563 2009/08/18 15:35:32.563 0:01.312 Ekiga SVN revision: unknown 2009/08/18 15:35:32.567 0:01.316 Ekiga registered on D-Bus: org.ekiga.Ekiga 2009/08/18 15:35:32.567 0:01.316 PWLib File handle high water mark set: 19 Thread unblock pipe 2009/08/18 15:35:32.570 0:01.319 PWLib Thread high water mark set: 2 2009/08/18 15:35:32.570 0:01.319 PWLib File handle high water mark set: 21 Thread unblock pipe 2009/08/18 15:35:32.571 0:01.320 PWLib Thread high water mark set: 3 2009/08/18 15:35:32.571 0:01.320 PWLib File handle high water mark set: 23 Thread unblock pipe 2009/08/18 15:35:32.610 0:01.359 PWLib File handle high water mark set: 25 Thread unblock pipe 2009/08/18 15:35:32.616 0:01.365 PWLib Thread high water mark set: 4 2009/08/18 15:35:32.616 0:01.365 HalManager_dbus Initialising HAL Manager 2009/08/18 15:35:32.621 0:01.370 HalManager_dbus Populating device list 2009/08/18 15:35:32.785 0:01.534 HalManager_dbus Detected V4L capabilities on /dev/video0 name: Creative WebCam NX Ultra 2009/08/18 15:35:32.785 0:01.534 HalManager_dbus Detected V4L2 capabilities on /dev/video0 name: Creative WebCam NX Ultra 2009/08/18 15:35:32.915 0:01.664 HalManager_dbus Populated device list with 16 devices 2009/08/18 15:35:32.916 0:01.665 HalManager_dbus Populating interface list 2009/08/18 15:35:32.917 0:01.666 HalManager_dbus Populating full interface list failed - Method "getDevices" with signature "" on interface "org.freedesktop.NetworkManager" doesn't exist 2009/08/18 15:35:32.918 0:01.667 Detecting V4L2 devices 2009/08/18 15:35:32.918 0:01.667 PV4L2Plugin detected device metadata at /sys/class/video4linux/ 2009/08/18 15:35:32.968 0:01.717 PWLib File handle high water mark set: 30 Thread unblock pipe 2009/08/18 15:35:32.969 0:01.718 PWLib Thread high water mark set: 5 2009/08/18 15:35:32.970 0:01.719 OpalMan Created manager. 2009/08/18 15:35:32.970 0:01.719 OpalMan Registered endpoint with prefix pc 2009/08/18 15:35:32.970 0:01.719 OpalEP Created endpoint: pc [New Thread 0xb5749b90 (LWP 18089)] [New Thread 0xb5708b90 (LWP 18090)] [New Thread 0xb56c7b90 (LWP 18091)] [New Thread 0xb5686b90 (LWP 18093)] 2009/08/18 15:35:33.217 0:01.966 PCSS Created PC sound system endpoint. Players: Default EKIGA *.wav Intel ICH7 Intel ICH7 (1) Recorders: Default EKIGA *.wav Intel ICH7 Intel ICH7 (1) Intel ICH7 (2) Intel ICH7 (3) 2009/08/18 15:35:33.219 0:01.968 OPAL SetMediaFormatOrder() 2009/08/18 15:35:33.219 0:01.968 OPAL SetMediaFormatMask() 2009/08/18 15:35:33.220 0:01.969 OpalMan Registered endpoint with prefix sip 2009/08/18 15:35:33.220 0:01.969 OpalEP Created endpoint: sip 2009/08/18 15:35:33.221 0:01.970 PWLib File handle high water mark set: 31 PUDPSocket 2009/08/18 15:35:33.221 0:01.970 IfaceMon Initial interface list: 127.0.0.1 [00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:01] <00-00-00-00-00-00> (lo) 10.1.5.1 [fe:80:00:00:00:00:00:00:02:13:72:ff:fe:02:cb:ae] <00-13-72-02-CB-AE> (eth0) 2009/08/18 15:35:33.221 0:01.970 PWLib File handle high water mark set: 32 Thread unblock pipe 2009/08/18 15:35:33.224 0:01.973 PWLib Thread high water mark set: 6 2009/08/18 15:35:33.224 0:01.973 Network In...0xb5645b90 IfaceMon Started interface monitor thread. 2009/08/18 15:35:33.224 0:01.973 PWLib File handle high water mark set: 34 Thread unblock pipe 2009/08/18 15:35:33.226 0:01.975 Network In...0xb5645b90 PWLib File handle high water mark set: 35 PUDPSocket 2009/08/18 15:35:33.226 0:01.975 PWLib Thread high water mark set: 7 2009/08/18 15:35:33.226 0:01.975 OpalMan Registered endpoint with prefix sips 2009/08/18 15:35:33.227 0:01.976 SIP Created endpoint. 2009/08/18 15:35:33.228 0:01.977 MonSock Created socket bundle for all interfaces. 2009/08/18 15:35:33.228 0:01.977 PWLib File handle high water mark set: 36 PUDPSocket 2009/08/18 15:35:33.228 0:01.977 MonSock Created bundled UDP socket 10.1.5.1:5060 2009/08/18 15:35:33.228 0:01.977 PWLib File handle high water mark set: 38 Thread unblock pipe 2009/08/18 15:35:33.233 0:01.982 PWLib Thread high water mark set: 8 2009/08/18 15:35:33.233 0:01.982 Opal Liste...0xb54beb90 Listen Started listening thread on udp$*:5060 2009/08/18 15:35:33.233 0:01.982 OpalMan Added route "sip:.*=pc:*" 2009/08/18 15:35:33.234 0:01.983 OpalMan Added route "pc:.*=sip:" 2009/08/18 15:35:33.234 0:01.983 OpalMan Registered endpoint with prefix h323 2009/08/18 15:35:33.234 0:01.983 OpalEP Created endpoint: h323 2009/08/18 15:35:33.234 0:01.983 OpalMan Registered endpoint with prefix h323s 2009/08/18 15:35:33.234 0:01.983 H323 Created endpoint. 2009/08/18 15:35:33.235 0:01.984 PWLib File handle high water mark set: 39 PTCPSocket 2009/08/18 15:35:33.235 0:01.984 PWLib File handle high water mark set: 41 Thread unblock pipe 2009/08/18 15:35:33.237 0:01.986 PWLib Thread high water mark set: 9 2009/08/18 15:35:33.238 0:01.987 Opal Liste...0xb547db90 Listen Started listening thread on tcp$*:1720 2009/08/18 15:35:33.238 0:01.987 Opal Liste...0xb547db90 Listen Waiting on socket accept on tcp$*:1720 2009/08/18 15:35:33.238 0:01.987 OpalMan Added route "h323:.*=pc:" 2009/08/18 15:35:33.238 0:01.987 OpalMan Added route "pc:.*=h323:" 2009/08/18 15:35:33.252 0:02.001 MediaFormat Removing codecs theora,H.261,H.261-CIF,H.261-QCIF,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,G.711-uLaw-64k,G.711-ALaw-64k,G.722-64k 2009/08/18 15:35:33.253 0:02.002 OPAL SetMediaFormatMask(PCM-16-48kHz,PCM-16-32kHz,PCM-16-16kHz,PCM-16,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,YUV420P,RFC4175_YCbCr-4:2:0,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz) 2009/08/18 15:35:33.253 0:02.002 OPAL SetMediaFormatOrder(theora,H.261,H.261-CIF,H.261-QCIF,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,G.711-uLaw-64k,G.711-ALaw-64k,G.722-64k) 2009/08/18 15:35:33.263 0:02.012 MediaFormat Removing codecs theora,H.261,H.261-CIF,H.261-QCIF,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,G.711-uLaw-64k,G.711-ALaw-64k,G.722-64k 2009/08/18 15:35:33.264 0:02.013 OPAL SetMediaFormatMask(PCM-16-48kHz,PCM-16-32kHz,PCM-16-16kHz,PCM-16,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,YUV420P,RFC4175_YCbCr-4:2:0,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz) 2009/08/18 15:35:33.264 0:02.013 OPAL SetMediaFormatOrder(theora,H.261,H.261-CIF,H.261-QCIF,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,G.711-uLaw-64k,G.711-ALaw-64k,G.722-64k) 2009/08/18 15:35:33.284 0:02.033 PWLib File handle high water mark set: 43 Thread unblock pipe 2009/08/18 15:35:33.287 0:02.036 PWLib Thread high water mark set: 10 2009/08/18 15:35:33.287 0:02.036 StunDetector:0xb543cb90 PWLib File handle high water mark set: 44 PUDPSocket [New Thread 0xb5645b90 (LWP 18094)] [New Thread 0xb54ffb90 (LWP 18095)] [New Thread 0xb54beb90 (LWP 18096)] [New Thread 0xb547db90 (LWP 18097)] [New Thread 0xb543cb90 (LWP 18098)] [New Thread 0xb53f4b90 (LWP 18099)] [New Thread 0xb4bf3b90 (LWP 18102)] 2009/08/18 15:35:34.294 0:03.043 StunDetector:0xb543cb90 PWLib File handle high water mark set: 57 PUDPSocket 2009/08/18 15:35:34.414 0:03.163 VideoOutputCoreConfBridge Updating video view 2009/08/18 15:35:34.414 0:03.163 VideoOutputCoreConfBridge Updating zoom 2009/08/18 15:35:34.415 0:03.164 VideoOutputCoreConfBridge Updating Video Settings 2009/08/18 15:35:34.415 0:03.164 VideoOutputCoreConfBridge Updating Video Settings 2009/08/18 15:35:34.416 0:03.165 VideoOutputCoreConfBridge Updating Video Settings 2009/08/18 15:35:34.416 0:03.165 VideoOutputCoreConfBridge Updating Video Settings 2009/08/18 15:35:34.416 0:03.165 VidInputCoreConfBridge Updating preview size and fps 2009/08/18 15:35:34.416 0:03.165 VidInputCore Setting new preview config: 640x480/30 2009/08/18 15:35:34.419 0:03.168 VidInputCoreConfBridge Updating preview size and fps 2009/08/18 15:35:34.419 0:03.168 VidInputCore Setting new preview config: 640x480/30 2009/08/18 15:35:34.422 0:03.171 VidInputCoreConfBridge Updating device 2009/08/18 15:35:34.423 0:03.172 VidInputCore Setting device: Creative WebCam NX Ultra (PTLIB/V4L2) 2009/08/18 15:35:34.423 0:03.172 GMVideoInputManager_ptlib Setting Device Creative WebCam NX Ultra (PTLIB/V4L2) 2009/08/18 15:35:34.423 0:03.172 VidInputCoreConfBridge Updating device 2009/08/18 15:35:34.423 0:03.172 VidInputCore Setting device: Creative WebCam NX Ultra (PTLIB/V4L2) 2009/08/18 15:35:34.423 0:03.172 GMVideoInputManager_ptlib Setting Device Creative WebCam NX Ultra (PTLIB/V4L2) 2009/08/18 15:35:34.423 0:03.172 VidInputCoreConfBridge Updating device 2009/08/18 15:35:34.423 0:03.172 VidInputCore Setting device: Creative WebCam NX Ultra (PTLIB/V4L2) 2009/08/18 15:35:34.423 0:03.172 GMVideoInputManager_ptlib Setting Device Creative WebCam NX Ultra (PTLIB/V4L2) 2009/08/18 15:35:34.424 0:03.173 VidInputCoreConfBridge Updating image 2009/08/18 15:35:34.424 0:03.173 VidInputCoreConfBridge Updating preview 2009/08/18 15:35:34.424 0:03.173 VidInputCore Stopping Preview 2009/08/18 15:35:34.425 0:03.174 AudioOutputCoreConfBridge Updating device 2009/08/18 15:35:34.425 0:03.174 AudioOutputCore Setting device[0]: Default (PTLIB/ALSA) 2009/08/18 15:35:34.425 0:03.174 GMAudioOutputManager_ptlib Setting Device[0] Default (PTLIB/ALSA) 2009/08/18 15:35:34.435 0:03.184 AudioOutputCoreConfBridge Updating device 2009/08/18 15:35:34.436 0:03.185 AudioOutputCore Setting device[1]: SILENT (Ekiga/Ekiga) 2009/08/18 15:35:34.436 0:03.185 GMAudioOutputManager_null Setting Device[1] SILENT (Ekiga/Ekiga) 2009/08/18 15:35:34.442 0:03.191 AudioInputCoreConfBridge Updating device 2009/08/18 15:35:34.443 0:03.192 AudioInputCore Setting device: Default (PTLIB/ALSA) 2009/08/18 15:35:34.443 0:03.192 GMAudioInputManager_ptlib Setting Device Default (PTLIB/ALSA) 2009/08/18 15:35:35.861 0:04.610 Ekiga version 3.2.0 2009/08/18 15:35:35.862 0:04.611 OPAL version 3.6.1 2009/08/18 15:35:35.862 0:04.611 PTLIB version 2.6.1 2009/08/18 15:35:35.862 0:04.611 GNOME support disabled 2009/08/18 15:35:35.862 0:04.611 Accelerated rendering support enabled 2009/08/18 15:35:35.862 0:04.611 DBUS support enabled 2009/08/18 15:35:35.862 0:04.611 GConf support enabled 2009/08/18 15:35:35.862 0:04.611 ESound support disabled 2009/08/18 15:35:39.455 0:08.204 StunDetector:0xb543cb90 PWLib File handle low water mark set: 44 PUDPSocket 2009/08/18 15:35:39.609 0:08.358 StunDetector:0xb543cb90 OPAL STUN server "stun.ekiga.net" replies Port Restricted NAT, external IP 201.70.76.253 2009/08/18 15:35:40.563 0:09.312 Listen Stopping listening thread on udp$*:5060 2009/08/18 15:35:40.563 0:09.312 MonSock Closed UDP socket 0xb5501a20 2009/08/18 15:35:40.563 0:09.312 Opal Liste...0xb54beb90 Listen UDP read error. 2009/08/18 15:35:40.585 0:09.334 MonSock Deleting UDP socket 0xb5501a20 2009/08/18 15:35:40.586 0:09.335 PWLib Destroyed thread 0xb5501c40 Opal Listener:0xb54beb90(id = 0) 2009/08/18 15:35:40.586 0:09.335 PWLib File handle low water mark set: 35 PUDPSocket 2009/08/18 15:35:40.586 0:09.335 MonSock Created socket bundle for all interfaces. 2009/08/18 15:35:40.743 0:09.492 MonSock Created bundled UDP socket via STUN, internal=10.1.5.1:5060, external=201.70.76.253:5060 2009/08/18 15:35:40.746 0:09.495 Listen Stopping listening thread on tcp$*:1720 2009/08/18 15:35:40.749 0:09.498 Opal Liste...0xb54beb90 Listen Started listening thread on udp$*:5060 2009/08/18 15:35:40.749 0:09.498 PWLib Destroyed thread 0xb5504108 Opal Listener:0xb547db90(id = 0) 2009/08/18 15:35:40.752 0:09.501 Opal Liste...0xb547db90 Listen Started listening thread on tcp$*:1720 2009/08/18 15:35:40.752 0:09.501 Opal Liste...0xb547db90 Listen Waiting on socket accept on tcp$*:1720 2009/08/18 15:35:40.757 0:09.506 subscriber:0xb3eedb90 SIP Start REGISTER aor=mpaivacc@ekiga.net registrar=ekiga.net contact= authID=mpaivacc realm= expire=3600 restore=30 minRetry=0.000 maxRetry=0.000 2009/08/18 15:35:40.760 0:09.509 subscriber:0xb3eedb90 OpalUDP Binding to interface: 0.0.0.0:5060 2009/08/18 15:35:40.760 0:09.509 subscriber:0xb3eedb90 SIP Created transport udp$86.64.162.35:5060 2009/08/18 15:35:40.760 0:09.509 subscriber:0xb3eedb90 OpalUDP Started connect to 86.64.162.35:5060 2009/08/18 15:35:40.760 0:09.509 subscriber:0xb3eedb90 SIP Changing REGISTER handler from Unavailable to Subscribing, target=sip:mpaivacc@ekiga.net, id=3a577c99-938a-de11-909e-00137202cbae@inf01abl 2009/08/18 15:35:40.761 0:09.510 subscriber:0xb3eedb90 OpalUDP Writing to interface 0 - "10.1.5.1%eth0" 2009/08/18 15:35:40.926 0:09.675 subscriber:0xb3eedb90 OpalMan Listener interfaces: associated transport=udp$201.70.76.253:5060 udp$201.70.76.253:5060,udp$10.1.5.1:5060 2009/08/18 15:35:40.927 0:09.676 subscriber:0xb3eedb90 SIP Transaction created. 2009/08/18 15:35:40.928 0:09.677 subscriber:0xb3eedb90 SIP No SRV lookup as has explicit port number. 2009/08/18 15:35:40.929 0:09.678 subscriber:0xb3eedb90 SIP Transaction remote address is udp$ekiga.net:5060 2009/08/18 15:35:40.929 0:09.678 subscriber:0xb3eedb90 SIP Sending PDU (569 bytes) to: rem=udp$86.64.162.35:5060,local=udp$201.70.76.253:5060,if=10.1.5.1%eth0 REGISTER sip:ekiga.net SIP/2.0 Route: CSeq: 1 REGISTER Via: SIP/2.0/UDP 201.70.76.253:5060;branch=z9hG4bK6c5b9699-938a-de11-909e-00137202cbae;rport User-Agent: Ekiga/3.2.0 From: ;tag=2e957c99-938a-de11-909e-00137202cbae Call-ID: 3a577c99-938a-de11-909e-00137202cbae@inf01abl To: Contact: ;q=1, ;q=0.500 Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING Expires: 3600 Content-Length: 0 Max-Forwards: 70 2009/08/18 15:35:40.929 0:09.678 subscriber:0xb3eedb90 OpalUDP Setting interface to 10.1.5.1%eth0 2009/08/18 15:35:40.929 0:09.678 subscriber:0xb3eedb90 SIP Transaction timers set: retry=0.500, completion=6.000 2009/08/18 15:35:41.224 0:09.973 Opal Liste...0xb54beb90 OpalUDP Binding to interface: 201.70.76.253:5060 2009/08/18 15:35:41.225 0:09.974 Opal Liste...0xb54beb90 SIP Waiting for PDU on udp$86.64.162.35:5060 2009/08/18 15:35:41.225 0:09.974 Opal Liste...0xb54beb90 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$201.70.76.253:5060,if=10.1.5.1%eth0 SIP/2.0 401 Unauthorized CSeq: 1 REGISTER Via: SIP/2.0/UDP 201.70.76.253:5060;branch=z9hG4bK6c5b9699-938a-de11-909e-00137202cbae;rport=5060 Server: Kamailio (1.4.0-notls (i386/linux)) From: ;tag=2e957c99-938a-de11-909e-00137202cbae Call-ID: 3a577c99-938a-de11-909e-00137202cbae@inf01abl To: ;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.8dba Content-Length: 0 WWW-Authenticate: Digest realm="ekiga.net", nonce="4a8af61600000a041846c2da78b343fa77b86291384d1e99" 2009/08/18 15:35:41.226 0:09.975 Opal Liste...0xb54beb90 SIP Transaction 1 REGISTER completed. 2009/08/18 15:35:41.226 0:09.976 Opal Liste...0xb54beb90 SIP Received Authentication Required response 2009/08/18 15:35:41.227 0:09.976 Opal Liste...0xb54beb90 OpalUDP Setting interface to 10.1.5.1%eth0 2009/08/18 15:35:41.227 0:09.976 Opal Liste...0xb54beb90 SIP Changing REGISTER handler from Subscribing to Subscribing, target=sip:mpaivacc@ekiga.net, id=3a577c99-938a-de11-909e-00137202cbae@inf01abl 2009/08/18 15:35:41.228 0:09.977 Opal Liste...0xb54beb90 OpalMan Listener interfaces: associated transport=udp$201.70.76.253:5060 udp$201.70.76.253:5060,udp$10.1.5.1:5060 2009/08/18 15:35:41.229 0:09.978 Opal Liste...0xb54beb90 SIP Transaction created. 2009/08/18 15:35:41.230 0:09.979 Opal Liste...0xb54beb90 SIP Adding authentication information 2009/08/18 15:35:41.230 0:09.979 Opal Liste...0xb54beb90 SIP No SRV lookup as has explicit port number. 2009/08/18 15:35:41.231 0:09.980 Opal Liste...0xb54beb90 SIP Transaction remote address is udp$ekiga.net:5060 2009/08/18 15:35:41.231 0:09.980 Opal Liste...0xb54beb90 SIP Sending PDU (770 bytes) to: rem=udp$86.64.162.35:5060,local=udp$201.70.76.253:5060,if=10.1.5.1%eth0 REGISTER sip:ekiga.net SIP/2.0 Route: CSeq: 2 REGISTER Via: SIP/2.0/UDP 201.70.76.253:5060;branch=z9hG4bK786cc499-938a-de11-909e-00137202cbae;rport User-Agent: Ekiga/3.2.0 Authorization: Digest username="mpaivacc", realm="ekiga.net", nonce="4a8af61600000a041846c2da78b343fa77b86291384d1e99", uri="sip:ekiga.net", algorithm=MD5, response="18551ef17f26ec44fbf33af23538fecf" From: ;tag=2e957c99-938a-de11-909e-00137202cbae Call-ID: 3a577c99-938a-de11-909e-00137202cbae@inf01abl To: Contact: ;q=1, ;q=0.500 Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING Expires: 3600 Content-Length: 0 Max-Forwards: 70 2009/08/18 15:35:41.231 0:09.980 Opal Liste...0xb54beb90 OpalUDP Setting interface to 10.1.5.1%eth0 2009/08/18 15:35:41.231 0:09.980 Opal Liste...0xb54beb90 SIP Transaction timers set: retry=0.500, completion=6.000 2009/08/18 15:35:41.232 0:09.981 Opal Liste...0xb54beb90 Opal Transport clean up on termination 2009/08/18 15:35:41.232 0:09.981 Opal Liste...0xb54beb90 Opal Transport Close 2009/08/18 15:35:41.232 0:09.981 Opal Liste...0xb54beb90 Opal Deleted transport udp$86.64.162.35:5060 2009/08/18 15:35:41.529 0:10.278 Opal Liste...0xb54beb90 OpalUDP Binding to interface: 201.70.76.253:5060 2009/08/18 15:35:41.530 0:10.279 Opal Liste...0xb54beb90 SIP Waiting for PDU on udp$86.64.162.35:5060 2009/08/18 15:35:41.530 0:10.279 Opal Liste...0xb54beb90 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$201.70.76.253:5060,if=10.1.5.1%eth0 SIP/2.0 200 OK CSeq: 2 REGISTER Via: SIP/2.0/UDP 201.70.76.253:5060;branch=z9hG4bK786cc499-938a-de11-909e-00137202cbae;rport=5060 Server: Kamailio (1.4.0-notls (i386/linux)) From: ;tag=2e957c99-938a-de11-909e-00137202cbae Call-ID: 3a577c99-938a-de11-909e-00137202cbae@inf01abl To: ;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.77ef Contact: ;q=1;expires=1200, ;q=0.5;expires=1200 Content-Length: 0 2009/08/18 15:35:41.531 0:10.280 Opal Liste...0xb54beb90 SIP Transaction 2 REGISTER completed. 2009/08/18 15:35:41.531 0:10.280 Opal Liste...0xb54beb90 SIP Changing REGISTER handler from Subscribing to Subscribed, target=sip:mpaivacc@ekiga.net, id=3a577c99-938a-de11-909e-00137202cbae@inf01abl 2009/08/18 15:35:41.531 0:10.280 Opal Liste...0xb54beb90 OpalUDP Setting interface to 10.1.5.1%eth0 2009/08/18 15:35:41.532 0:10.281 Opal Liste...0xb54beb90 SIP Expiry time for REGISTER set to 1200 seconds. 2009/08/18 15:35:41.532 0:10.281 Opal Liste...0xb54beb90 SIP Expiry time for REGISTER set to 1200 seconds. 2009/08/18 15:35:41.533 0:10.282 Opal Liste...0xb54beb90 OpalUDP Binding to interface: 0.0.0.0:5060 2009/08/18 15:35:41.533 0:10.282 Opal Liste...0xb54beb90 SIP Created transport udp$86.64.162.35:5060 2009/08/18 15:35:41.533 0:10.282 Opal Liste...0xb54beb90 OpalUDP Started connect to 86.64.162.35:5060 2009/08/18 15:35:41.533 0:10.283 Opal Liste...0xb54beb90 SIP Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:500@ekiga.net, id=b691f299-938a-de11-909e-00137202cbae@inf01abl 2009/08/18 15:35:41.534 0:10.283 Opal Liste...0xb54beb90 OpalUDP Writing to interface 0 - "10.1.5.1%eth0" 2009/08/18 15:35:41.534 0:10.283 Opal Liste...0xb54beb90 SIP Transaction created. 2009/08/18 15:35:41.537 0:10.286 Opal Liste...0xb54beb90 DNS SRV Lookup ekiga.net service _sip._udp 2009/08/18 15:35:41.783 0:10.532 Opal Liste...0xb54beb90 SIP No SRV record found. 2009/08/18 15:35:41.783 0:10.532 Opal Liste...0xb54beb90 SIP Transaction remote address is udp$ekiga.net:5060 2009/08/18 15:35:41.784 0:10.533 Opal Liste...0xb54beb90 SIP Sending PDU (562 bytes) to: rem=udp$86.64.162.35:5060,local=udp$201.70.76.253:5060,if=10.1.5.1%eth0 SUBSCRIBE sip:500@ekiga.net SIP/2.0 CSeq: 1 SUBSCRIBE Via: SIP/2.0/UDP 201.70.76.253:5060;branch=z9hG4bK12fef299-938a-de11-909e-00137202cbae;rport User-Agent: Ekiga/3.2.0 From: "Marcus Paiva" ;tag=9ec7f299-938a-de11-909e-00137202cbae Call-ID: b691f299-938a-de11-909e-00137202cbae@inf01abl To: Contact: Accept: application/pidf+xml Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING Expires: 300 Event: presence Content-Length: 0 Max-Forwards: 70 2009/08/18 15:35:41.784 0:10.533 Opal Liste...0xb54beb90 OpalUDP Setting interface to 10.1.5.1%eth0 2009/08/18 15:35:41.784 0:10.533 Opal Liste...0xb54beb90 SIP Transaction timers set: retry=0.500, completion=6.000 2009/08/18 15:35:41.785 0:10.534 Opal Liste...0xb54beb90 OpalUDP Binding to interface: 0.0.0.0:5060 2009/08/18 15:35:41.785 0:10.534 Opal Liste...0xb54beb90 SIP Created transport udp$86.64.162.35:5060 2009/08/18 15:35:41.786 0:10.535 Opal Liste...0xb54beb90 OpalUDP Started connect to 86.64.162.35:5060 2009/08/18 15:35:41.786 0:10.535 Opal Liste...0xb54beb90 SIP Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:500@ekiga.net, id=120a199a-938a-de11-909e-00137202cbae@inf01abl 2009/08/18 15:35:41.786 0:10.535 Opal Liste...0xb54beb90 OpalUDP Writing to interface 0 - "10.1.5.1%eth0" 2009/08/18 15:35:41.786 0:10.535 Opal Liste...0xb54beb90 SIP Transaction created. 2009/08/18 15:35:41.789 0:10.538 Opal Liste...0xb54beb90 DNS SRV Lookup ekiga.net service _sip._udp 2009/08/18 15:35:41.790 0:10.539 Opal Liste...0xb54beb90 SIP No SRV record found. 2009/08/18 15:35:41.790 0:10.539 Opal Liste...0xb54beb90 SIP Transaction remote address is udp$ekiga.net:5060 2009/08/18 15:35:41.790 0:10.539 Opal Liste...0xb54beb90 SIP Sending PDU (569 bytes) to: rem=udp$86.64.162.35:5060,local=udp$201.70.76.253:5060,if=10.1.5.1%eth0 SUBSCRIBE sip:500@ekiga.net SIP/2.0 CSeq: 1 SUBSCRIBE Via: SIP/2.0/UDP 201.70.76.253:5060;branch=z9hG4bK5c74199a-938a-de11-909e-00137202cbae;rport User-Agent: Ekiga/3.2.0 From: "Marcus Paiva" ;tag=243e199a-938a-de11-909e-00137202cbae Call-ID: 120a199a-938a-de11-909e-00137202cbae@inf01abl To: Contact: Accept: application/dialog-info+xml Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING Expires: 300 Event: dialog;sla;ma Content-Length: 0 Max-Forwards: 70 2009/08/18 15:35:41.791 0:10.540 Opal Liste...0xb54beb90 OpalUDP Setting interface to 10.1.5.1%eth0 2009/08/18 15:35:41.791 0:10.540 Opal Liste...0xb54beb90 SIP Transaction timers set: retry=0.500, completion=6.000 2009/08/18 15:35:41.791 0:10.540 Opal Liste...0xb54beb90 OpalUDP Binding to interface: 0.0.0.0:5060 2009/08/18 15:35:41.791 0:10.540 Opal Liste...0xb54beb90 SIP Created transport udp$86.64.162.35:5060 2009/08/18 15:35:41.792 0:10.541 Opal Liste...0xb54beb90 OpalUDP Started connect to 86.64.162.35:5060 2009/08/18 15:35:41.792 0:10.541 Opal Liste...0xb54beb90 SIP Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:501@ekiga.net, id=60061a9a-938a-de11-909e-00137202cbae@inf01abl 2009/08/18 15:35:41.792 0:10.541 Opal Liste...0xb54beb90 OpalUDP Writing to interface 0 - "10.1.5.1%eth0" 2009/08/18 15:35:41.792 0:10.541 Opal Liste...0xb54beb90 SIP Transaction created. 2009/08/18 15:35:41.795 0:10.544 Opal Liste...0xb54beb90 DNS SRV Lookup ekiga.net service _sip._udp 2009/08/18 15:35:41.796 0:10.545 Opal Liste...0xb54beb90 SIP No SRV record found. 2009/08/18 15:35:41.796 0:10.545 Opal Liste...0xb54beb90 SIP Transaction remote address is udp$ekiga.net:5060 2009/08/18 15:35:41.797 0:10.546 Opal Liste...0xb54beb90 SIP Sending PDU (562 bytes) to: rem=udp$86.64.162.35:5060,local=udp$201.70.76.253:5060,if=10.1.5.1%eth0 SUBSCRIBE sip:501@ekiga.net SIP/2.0 CSeq: 1 SUBSCRIBE Via: SIP/2.0/UDP 201.70.76.253:5060;branch=z9hG4bK3e6e1a9a-938a-de11-909e-00137202cbae;rport User-Agent: Ekiga/3.2.0 From: "Marcus Paiva" ;tag=8c391a9a-938a-de11-909e-00137202cbae Call-ID: 60061a9a-938a-de11-909e-00137202cbae@inf01abl To: Contact: Accept: application/pidf+xml Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING Expires: 300 Event: presence Content-Length: 0 Max-Forwards: 70 2009/08/18 15:35:41.797 0:10.546 Opal Liste...0xb54beb90 OpalUDP Setting interface to 10.1.5.1%eth0 2009/08/18 15:35:41.797 0:10.546 Opal Liste...0xb54beb90 SIP Transaction timers set: retry=0.500, completion=6.000 2009/08/18 15:35:41.798 0:10.547 Opal Liste...0xb54beb90 OpalUDP Binding to interface: 0.0.0.0:5060 2009/08/18 15:35:41.798 0:10.547 Opal Liste...0xb54beb90 SIP Created transport udp$86.64.162.35:5060 2009/08/18 15:35:41.799 0:10.548 Opal Liste...0xb54beb90 OpalUDP Started connect to 86.64.162.35:5060 2009/08/18 15:35:41.799 0:10.548 Opal Liste...0xb54beb90 SIP Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:501@ekiga.net, id=e8041b9a-938a-de11-909e-00137202cbae@inf01abl 2009/08/18 15:35:41.799 0:10.548 Opal Liste...0xb54beb90 OpalUDP Writing to interface 0 - "10.1.5.1%eth0" 2009/08/18 15:35:41.803 0:10.552 Opal Liste...0xb54beb90 SIP Transaction created. 2009/08/18 15:35:41.806 0:10.555 Opal Liste...0xb54beb90 DNS SRV Lookup ekiga.net service _sip._udp 2009/08/18 15:35:41.806 0:10.555 Opal Liste...0xb54beb90 SIP No SRV record found. 2009/08/18 15:35:41.806 0:10.555 Opal Liste...0xb54beb90 SIP Transaction remote address is udp$ekiga.net:5060 2009/08/18 15:35:41.807 0:10.556 Opal Liste...0xb54beb90 SIP Sending PDU (569 bytes) to: rem=udp$86.64.162.35:5060,local=udp$201.70.76.253:5060,if=10.1.5.1%eth0 SUBSCRIBE sip:501@ekiga.net SIP/2.0 CSeq: 1 SUBSCRIBE Via: SIP/2.0/UDP 201.70.76.253:5060;branch=z9hG4bK3c0a1c9a-938a-de11-909e-00137202cbae;rport User-Agent: Ekiga/3.2.0 From: "Marcus Paiva" ;tag=04cf1b9a-938a-de11-909e-00137202cbae Call-ID: e8041b9a-938a-de11-909e-00137202cbae@inf01abl To: Contact: Accept: application/dialog-info+xml Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING Expires: 300 Event: dialog;sla;ma Content-Length: 0 Max-Forwards: 70 2009/08/18 15:35:41.807 0:10.556 Opal Liste...0xb54beb90 OpalUDP Setting interface to 10.1.5.1%eth0 2009/08/18 15:35:41.807 0:10.556 Opal Liste...0xb54beb90 SIP Transaction timers set: retry=0.500, completion=6.000 2009/08/18 15:35:41.809 0:10.558 Opal Liste...0xb54beb90 OpalUDP Binding to interface: 0.0.0.0:5060 2009/08/18 15:35:41.809 0:10.558 Opal Liste...0xb54beb90 SIP Created transport udp$86.64.162.35:5060 2009/08/18 15:35:41.809 0:10.558 Opal Liste...0xb54beb90 OpalUDP Started connect to 86.64.162.35:5060 2009/08/18 15:35:41.809 0:10.558 Opal Liste...0xb54beb90 SIP Changing SUBSCRIBE handler from Unavailable to Subscribing, target=sip:mpaivacc@ekiga.net, id=6ea51c9a-938a-de11-909e-00137202cbae@inf01abl 2009/08/18 15:35:41.810 0:10.559 Opal Liste...0xb54beb90 OpalUDP Writing to interface 0 - "10.1.5.1%eth0" 2009/08/18 15:35:41.810 0:10.559 Opal Liste...0xb54beb90 SIP Transaction created. 2009/08/18 15:35:41.813 0:10.562 Opal Liste...0xb54beb90 DNS SRV Lookup ekiga.net service _sip._udp 2009/08/18 15:35:41.818 0:10.567 Opal Liste...0xb54beb90 SIP No SRV record found. 2009/08/18 15:35:41.818 0:10.567 Opal Liste...0xb54beb90 SIP Transaction remote address is udp$ekiga.net:5060 2009/08/18 15:35:41.819 0:10.568 Opal Liste...0xb54beb90 SIP Sending PDU (594 bytes) to: rem=udp$86.64.162.35:5060,local=udp$201.70.76.253:5060,if=10.1.5.1%eth0 SUBSCRIBE sip:mpaivacc@ekiga.net SIP/2.0 CSeq: 1 SUBSCRIBE Via: SIP/2.0/UDP 201.70.76.253:5060;branch=z9hG4bKc2191d9a-938a-de11-909e-00137202cbae;rport User-Agent: Ekiga/3.2.0 From: "Marcus Paiva" ;tag=78e11c9a-938a-de11-909e-00137202cbae Call-ID: 6ea51c9a-938a-de11-909e-00137202cbae@inf01abl To: Contact: Accept: application/simple-message-summary Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING Expires: 3600 Event: message-summary Content-Length: 0 Max-Forwards: 70 2009/08/18 15:35:41.819 0:10.568 Opal Liste...0xb54beb90 OpalUDP Setting interface to 10.1.5.1%eth0 2009/08/18 15:35:41.819 0:10.568 Opal Liste...0xb54beb90 SIP Transaction timers set: retry=0.500, completion=6.000 2009/08/18 15:35:41.820 0:10.569 Opal Liste...0xb54beb90 Opal Transport clean up on termination 2009/08/18 15:35:41.820 0:10.569 Opal Liste...0xb54beb90 Opal Transport Close 2009/08/18 15:35:41.820 0:10.569 Opal Liste...0xb54beb90 Opal Deleted transport udp$86.64.162.35:5060 2009/08/18 15:35:41.859 0:10.608 OpalUDP Binding to interface: 0.0.0.0:5060 2009/08/18 15:35:41.860 0:10.609 SIP Created transport udp$86.64.162.35:5060 2009/08/18 15:35:41.860 0:10.609 OpalUDP Started connect to 86.64.162.35:5060 2009/08/18 15:35:41.860 0:10.609 SIP Changing PUBLISH handler from Unavailable to Subscribing, target=sip:mpaivacc@ekiga.net, id=4a49249a-938a-de11-909e-00137202cbae@inf01abl 2009/08/18 15:35:41.861 0:10.610 OpalUDP Writing to interface 0 - "10.1.5.1%eth0" 2009/08/18 15:35:41.861 0:10.610 SIP Expiry time for PUBLISH set to 500 seconds. 2009/08/18 15:35:41.861 0:10.610 SIP Transaction created. 2009/08/18 15:35:41.864 0:10.613 DNS SRV Lookup ekiga.net service _sip._udp 2009/08/18 15:35:41.865 0:10.614 SIP No SRV record found. 2009/08/18 15:35:41.865 0:10.614 SIP Transaction remote address is udp$ekiga.net:5060 2009/08/18 15:35:41.866 0:10.615 SIP Sending PDU (815 bytes) to: rem=udp$86.64.162.35:5060,local=udp$201.70.76.253:5060,if=10.1.5.1%eth0 PUBLISH sip:mpaivacc@ekiga.net SIP/2.0 CSeq: 3 PUBLISH Via: SIP/2.0/UDP 201.70.76.253:5060;branch=z9hG4bK90f8249a-938a-de11-909e-00137202cbae;rport User-Agent: Ekiga/3.2.0 From: ;tag=eec2249a-938a-de11-909e-00137202cbae Call-ID: 4a49249a-938a-de11-909e-00137202cbae@inf01abl To: Contact: Expires: 500 Event: presence Content-Type: application/pidf+xml Content-Length: 333 Max-Forwards: 70 online - I'm online using Ekiga open sip:mpaivacc@ekiga.net 2009/08/18 15:35:41.866 0:10.615 OpalUDP Setting interface to 10.1.5.1%eth0 2009/08/18 15:35:41.866 0:10.616 SIP Transaction timers set: retry=0.500, completion=6.000 2009/08/18 15:35:42.080 0:10.829 Opal Liste...0xb54beb90 OpalUDP Binding to interface: 201.70.76.253:5060 2009/08/18 15:35:42.080 0:10.829 Opal Liste...0xb54beb90 SIP Waiting for PDU on udp$86.64.162.35:5060 2009/08/18 15:35:42.081 0:10.830 Opal Liste...0xb54beb90 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$201.70.76.253:5060,if=10.1.5.1%eth0 SIP/2.0 489 Event Not Supported CSeq: 1 SUBSCRIBE Via: SIP/2.0/UDP 201.70.76.253:5060;branch=z9hG4bK12fef299-938a-de11-909e-00137202cbae;rport=5060 Server: Kamailio (1.4.0-notls (i386/linux)) From: "Marcus Paiva" ;tag=9ec7f299-938a-de11-909e-00137202cbae Call-ID: b691f299-938a-de11-909e-00137202cbae@inf01abl To: ;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.7fa3 Content-Length: 0 2009/08/18 15:35:42.082 0:10.831 Opal Liste...0xb54beb90 SIP Transaction 1 SUBSCRIBE completed. 2009/08/18 15:35:42.082 0:10.831 Opal Liste...0xb54beb90 SIP Not retrying SUBSCRIBE due to error response 489 Bad Event 2009/08/18 15:35:42.082 0:10.831 Opal Liste...0xb54beb90 SIP Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:500@ekiga.net, id=b691f299-938a-de11-909e-00137202cbae@inf01abl 2009/08/18 15:35:42.082 0:10.831 Opal Liste...0xb54beb90 SIP Set state Terminated_Aborted for transaction 1 SUBSCRIBE 2009/08/18 15:35:42.082 0:10.831 Opal Liste...0xb54beb90 SIP Not retrying SUBSCRIBE due to error response 487 Request Terminated 2009/08/18 15:35:42.082 0:10.831 Opal Liste...0xb54beb90 SIP Changing SUBSCRIBE handler from Unsubscribed to Unsubscribed, target=sip:500@ekiga.net, id=b691f299-938a-de11-909e-00137202cbae@inf01abl 2009/08/18 15:35:42.082 0:10.831 Opal Liste...0xb54beb90 Opal Transport clean up on termination 2009/08/18 15:35:42.082 0:10.831 Opal Liste...0xb54beb90 Opal Transport Close 2009/08/18 15:35:42.082 0:10.831 Opal Liste...0xb54beb90 Opal Deleted transport udp$86.64.162.35:5060 2009/08/18 15:35:42.086 0:10.835 Opal Liste...0xb54beb90 OpalUDP Binding to interface: 201.70.76.253:5060 2009/08/18 15:35:42.086 0:10.835 Opal Liste...0xb54beb90 SIP Waiting for PDU on udp$86.64.162.35:5060 2009/08/18 15:35:42.087 0:10.836 Opal Liste...0xb54beb90 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$201.70.76.253:5060,if=10.1.5.1%eth0 SIP/2.0 489 Event Not Supported CSeq: 1 SUBSCRIBE Via: SIP/2.0/UDP 201.70.76.253:5060;branch=z9hG4bK5c74199a-938a-de11-909e-00137202cbae;rport=5060 Server: Kamailio (1.4.0-notls (i386/linux)) From: "Marcus Paiva" ;tag=243e199a-938a-de11-909e-00137202cbae Call-ID: 120a199a-938a-de11-909e-00137202cbae@inf01abl To: ;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.98e9 Content-Length: 0 2009/08/18 15:35:42.087 0:10.836 Opal Liste...0xb54beb90 SIP Transaction 1 SUBSCRIBE completed. 2009/08/18 15:35:42.087 0:10.836 Opal Liste...0xb54beb90 SIP Not retrying SUBSCRIBE due to error response 489 Bad Event 2009/08/18 15:35:42.087 0:10.836 Opal Liste...0xb54beb90 SIP Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:500@ekiga.net, id=120a199a-938a-de11-909e-00137202cbae@inf01abl 2009/08/18 15:35:42.088 0:10.837 Opal Liste...0xb54beb90 SIP Set state Terminated_Aborted for transaction 1 SUBSCRIBE 2009/08/18 15:35:42.088 0:10.837 Opal Liste...0xb54beb90 SIP Not retrying SUBSCRIBE due to error response 487 Request Terminated 2009/08/18 15:35:42.088 0:10.837 Opal Liste...0xb54beb90 SIP Changing SUBSCRIBE handler from Unsubscribed to Unsubscribed, target=sip:500@ekiga.net, id=120a199a-938a-de11-909e-00137202cbae@inf01abl 2009/08/18 15:35:42.088 0:10.837 Opal Liste...0xb54beb90 Opal Transport clean up on termination 2009/08/18 15:35:42.088 0:10.837 Opal Liste...0xb54beb90 Opal Transport Close 2009/08/18 15:35:42.088 0:10.837 Opal Liste...0xb54beb90 Opal Deleted transport udp$86.64.162.35:5060 2009/08/18 15:35:42.093 0:10.842 Opal Liste...0xb54beb90 OpalUDP Binding to interface: 201.70.76.253:5060 2009/08/18 15:35:42.093 0:10.842 Opal Liste...0xb54beb90 SIP Waiting for PDU on udp$86.64.162.35:5060 2009/08/18 15:35:42.094 0:10.843 Opal Liste...0xb54beb90 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$201.70.76.253:5060,if=10.1.5.1%eth0 SIP/2.0 489 Event Not Supported CSeq: 1 SUBSCRIBE Via: SIP/2.0/UDP 201.70.76.253:5060;branch=z9hG4bK3e6e1a9a-938a-de11-909e-00137202cbae;rport=5060 Server: Kamailio (1.4.0-notls (i386/linux)) From: "Marcus Paiva" ;tag=8c391a9a-938a-de11-909e-00137202cbae Call-ID: 60061a9a-938a-de11-909e-00137202cbae@inf01abl To: ;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.eeb0 Content-Length: 0 2009/08/18 15:35:42.094 0:10.843 Opal Liste...0xb54beb90 SIP Transaction 1 SUBSCRIBE completed. 2009/08/18 15:35:42.094 0:10.843 Opal Liste...0xb54beb90 SIP Not retrying SUBSCRIBE due to error response 489 Bad Event 2009/08/18 15:35:42.094 0:10.843 Opal Liste...0xb54beb90 SIP Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:501@ekiga.net, id=60061a9a-938a-de11-909e-00137202cbae@inf01abl 2009/08/18 15:35:42.095 0:10.844 Opal Liste...0xb54beb90 SIP Set state Terminated_Aborted for transaction 1 SUBSCRIBE 2009/08/18 15:35:42.095 0:10.844 Opal Liste...0xb54beb90 SIP Not retrying SUBSCRIBE due to error response 487 Request Terminated 2009/08/18 15:35:42.095 0:10.844 Opal Liste...0xb54beb90 SIP Changing SUBSCRIBE handler from Unsubscribed to Unsubscribed, target=sip:501@ekiga.net, id=60061a9a-938a-de11-909e-00137202cbae@inf01abl 2009/08/18 15:35:42.095 0:10.844 Opal Liste...0xb54beb90 Opal Transport clean up on termination 2009/08/18 15:35:42.095 0:10.844 Opal Liste...0xb54beb90 Opal Transport Close 2009/08/18 15:35:42.095 0:10.844 Opal Liste...0xb54beb90 Opal Deleted transport udp$86.64.162.35:5060 2009/08/18 15:35:42.102 0:10.851 Opal Liste...0xb54beb90 OpalUDP Binding to interface: 201.70.76.253:5060 2009/08/18 15:35:42.102 0:10.851 Opal Liste...0xb54beb90 SIP Waiting for PDU on udp$86.64.162.35:5060 2009/08/18 15:35:42.103 0:10.852 Opal Liste...0xb54beb90 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$201.70.76.253:5060,if=10.1.5.1%eth0 SIP/2.0 489 Event Not Supported CSeq: 1 SUBSCRIBE Via: SIP/2.0/UDP 201.70.76.253:5060;branch=z9hG4bK3c0a1c9a-938a-de11-909e-00137202cbae;rport=5060 Server: Kamailio (1.4.0-notls (i386/linux)) From: "Marcus Paiva" ;tag=04cf1b9a-938a-de11-909e-00137202cbae Call-ID: e8041b9a-938a-de11-909e-00137202cbae@inf01abl To: ;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.3424 Content-Length: 0 2009/08/18 15:35:42.103 0:10.852 Opal Liste...0xb54beb90 SIP Transaction 1 SUBSCRIBE completed. 2009/08/18 15:35:42.103 0:10.852 Opal Liste...0xb54beb90 SIP Not retrying SUBSCRIBE due to error response 489 Bad Event 2009/08/18 15:35:42.103 0:10.852 Opal Liste...0xb54beb90 SIP Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:501@ekiga.net, id=e8041b9a-938a-de11-909e-00137202cbae@inf01abl 2009/08/18 15:35:42.103 0:10.852 Opal Liste...0xb54beb90 SIP Set state Terminated_Aborted for transaction 1 SUBSCRIBE 2009/08/18 15:35:42.104 0:10.853 Opal Liste...0xb54beb90 SIP Not retrying SUBSCRIBE due to error response 487 Request Terminated 2009/08/18 15:35:42.104 0:10.853 Opal Liste...0xb54beb90 SIP Changing SUBSCRIBE handler from Unsubscribed to Unsubscribed, target=sip:501@ekiga.net, id=e8041b9a-938a-de11-909e-00137202cbae@inf01abl 2009/08/18 15:35:42.104 0:10.853 Opal Liste...0xb54beb90 Opal Transport clean up on termination 2009/08/18 15:35:42.104 0:10.853 Opal Liste...0xb54beb90 Opal Transport Close 2009/08/18 15:35:42.104 0:10.853 Opal Liste...0xb54beb90 Opal Deleted transport udp$86.64.162.35:5060 2009/08/18 15:35:42.114 0:10.863 Opal Liste...0xb54beb90 OpalUDP Binding to interface: 201.70.76.253:5060 2009/08/18 15:35:42.114 0:10.863 Opal Liste...0xb54beb90 SIP Waiting for PDU on udp$86.64.162.35:5060 2009/08/18 15:35:42.115 0:10.864 Opal Liste...0xb54beb90 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$201.70.76.253:5060,if=10.1.5.1%eth0 SIP/2.0 489 Event Not Supported CSeq: 1 SUBSCRIBE Via: SIP/2.0/UDP 201.70.76.253:5060;branch=z9hG4bKc2191d9a-938a-de11-909e-00137202cbae;rport=5060 Server: Kamailio (1.4.0-notls (i386/linux)) From: "Marcus Paiva" ;tag=78e11c9a-938a-de11-909e-00137202cbae Call-ID: 6ea51c9a-938a-de11-909e-00137202cbae@inf01abl To: ;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.469a Content-Length: 0 2009/08/18 15:35:42.116 0:10.865 Opal Liste...0xb54beb90 SIP Transaction 1 SUBSCRIBE completed. 2009/08/18 15:35:42.116 0:10.865 Opal Liste...0xb54beb90 SIP Not retrying SUBSCRIBE due to error response 489 Bad Event 2009/08/18 15:35:42.116 0:10.865 Opal Liste...0xb54beb90 SIP Changing SUBSCRIBE handler from Subscribing to Unsubscribed, target=sip:mpaivacc@ekiga.net, id=6ea51c9a-938a-de11-909e-00137202cbae@inf01abl 2009/08/18 15:35:42.116 0:10.865 Opal Liste...0xb54beb90 SIP Set state Terminated_Aborted for transaction 1 SUBSCRIBE 2009/08/18 15:35:42.116 0:10.865 Opal Liste...0xb54beb90 SIP Not retrying SUBSCRIBE due to error response 487 Request Terminated 2009/08/18 15:35:42.116 0:10.865 Opal Liste...0xb54beb90 SIP Changing SUBSCRIBE handler from Unsubscribed to Unsubscribed, target=sip:mpaivacc@ekiga.net, id=6ea51c9a-938a-de11-909e-00137202cbae@inf01abl 2009/08/18 15:35:42.116 0:10.865 Opal Liste...0xb54beb90 Opal Transport clean up on termination 2009/08/18 15:35:42.116 0:10.865 Opal Liste...0xb54beb90 Opal Transport Close 2009/08/18 15:35:42.116 0:10.865 Opal Liste...0xb54beb90 Opal Deleted transport udp$86.64.162.35:5060 2009/08/18 15:35:42.165 0:10.914 Opal Liste...0xb54beb90 OpalUDP Binding to interface: 201.70.76.253:5060 2009/08/18 15:35:42.166 0:10.915 Opal Liste...0xb54beb90 SIP Waiting for PDU on udp$86.64.162.35:5060 2009/08/18 15:35:42.166 0:10.915 Opal Liste...0xb54beb90 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$201.70.76.253:5060,if=10.1.5.1%eth0 SIP/2.0 200 OK CSeq: 3 PUBLISH Via: SIP/2.0/UDP 201.70.76.253:5060;branch=z9hG4bK90f8249a-938a-de11-909e-00137202cbae;rport=5060 Server: Kamailio (1.4.0-notls (i386/linux)) From: ;tag=eec2249a-938a-de11-909e-00137202cbae Call-ID: 4a49249a-938a-de11-909e-00137202cbae@inf01abl To: ;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.e460 Expires: 495 Content-Length: 0 SIP-ETag: a.1250620046.16040.1196.0 2009/08/18 15:35:42.167 0:10.916 Opal Liste...0xb54beb90 SIP Transaction 3 PUBLISH completed. 2009/08/18 15:35:42.167 0:10.916 Opal Liste...0xb54beb90 SIP Expiry time for PUBLISH set to 495 seconds. 2009/08/18 15:35:42.167 0:10.916 Opal Liste...0xb54beb90 SIP Changing PUBLISH handler from Subscribing to Subscribed, target=sip:mpaivacc@ekiga.net, id=4a49249a-938a-de11-909e-00137202cbae@inf01abl 2009/08/18 15:35:42.168 0:10.917 Opal Liste...0xb54beb90 OpalUDP Setting interface to 10.1.5.1%eth0 2009/08/18 15:35:42.168 0:10.917 Opal Liste...0xb54beb90 Opal Transport clean up on termination 2009/08/18 15:35:42.168 0:10.917 Opal Liste...0xb54beb90 Opal Transport Close 2009/08/18 15:35:42.168 0:10.917 Opal Liste...0xb54beb90 Opal Deleted transport udp$86.64.162.35:5060 2009/08/18 15:35:42.232 0:10.982 Housekeeper:0xb54ffb90 SIP Set state Terminated_Success for transaction 1 REGISTER 2009/08/18 15:35:42.821 0:11.570 Housekeeper:0xb54ffb90 SIP Set state Terminated_Success for transaction 2 REGISTER 2009/08/18 15:35:42.971 0:11.720 Opal Garbage:0xb5686b90 SIP Transaction 1 REGISTER destroyed. 2009/08/18 15:35:42.972 0:11.721 Opal Garbage:0xb5686b90 SIP Transaction 2 REGISTER destroyed. 2009/08/18 15:35:42.972 0:11.721 Opal Garbage:0xb5686b90 SIP Transaction 1 SUBSCRIBE destroyed. 2009/08/18 15:35:42.972 0:11.721 Opal Garbage:0xb5686b90 SIP Transaction 1 SUBSCRIBE destroyed. 2009/08/18 15:35:42.972 0:11.721 Opal Garbage:0xb5686b90 SIP Transaction 1 SUBSCRIBE destroyed. 2009/08/18 15:35:42.972 0:11.721 Opal Garbage:0xb5686b90 SIP Transaction 1 SUBSCRIBE destroyed. 2009/08/18 15:35:42.973 0:11.722 Opal Garbage:0xb5686b90 SIP Transaction 1 SUBSCRIBE destroyed. 2009/08/18 15:35:42.973 0:11.722 Opal Garbage:0xb5686b90 SIP Deleting SIPSubscribeHandler sip:500@ekiga.net 2009/08/18 15:35:42.973 0:11.722 Opal Garbage:0xb5686b90 Opal Transport clean up on termination 2009/08/18 15:35:42.973 0:11.722 Opal Garbage:0xb5686b90 Opal Transport Close 2009/08/18 15:35:42.973 0:11.722 Opal Garbage:0xb5686b90 Opal Transport clean up on termination 2009/08/18 15:35:42.973 0:11.722 Opal Garbage:0xb5686b90 Opal Transport Close 2009/08/18 15:35:42.973 0:11.722 Opal Garbage:0xb5686b90 Opal Deleted transport udp$86.64.162.35:5060 2009/08/18 15:35:42.974 0:11.723 Opal Garbage:0xb5686b90 SIP Deleted handler. 2009/08/18 15:35:42.974 0:11.723 Opal Garbage:0xb5686b90 SIP Deleting SIPSubscribeHandler sip:500@ekiga.net 2009/08/18 15:35:42.974 0:11.723 Opal Garbage:0xb5686b90 Opal Transport clean up on termination 2009/08/18 15:35:42.974 0:11.723 Opal Garbage:0xb5686b90 Opal Transport Close 2009/08/18 15:35:42.974 0:11.723 Opal Garbage:0xb5686b90 Opal Transport clean up on termination 2009/08/18 15:35:42.974 0:11.723 Opal Garbage:0xb5686b90 Opal Transport Close 2009/08/18 15:35:42.974 0:11.723 Opal Garbage:0xb5686b90 Opal Deleted transport udp$86.64.162.35:5060 2009/08/18 15:35:42.975 0:11.724 Opal Garbage:0xb5686b90 SIP Deleted handler. 2009/08/18 15:35:42.975 0:11.724 Opal Garbage:0xb5686b90 SIP Deleting SIPSubscribeHandler sip:501@ekiga.net 2009/08/18 15:35:42.975 0:11.724 Opal Garbage:0xb5686b90 Opal Transport clean up on termination 2009/08/18 15:35:42.975 0:11.724 Opal Garbage:0xb5686b90 Opal Transport Close 2009/08/18 15:35:42.975 0:11.724 Opal Garbage:0xb5686b90 Opal Transport clean up on termination 2009/08/18 15:35:42.975 0:11.724 Opal Garbage:0xb5686b90 Opal Transport Close 2009/08/18 15:35:42.975 0:11.724 Opal Garbage:0xb5686b90 Opal Deleted transport udp$86.64.162.35:5060 2009/08/18 15:35:42.975 0:11.724 Opal Garbage:0xb5686b90 SIP Deleted handler. 2009/08/18 15:35:42.976 0:11.725 Opal Garbage:0xb5686b90 SIP Deleting SIPSubscribeHandler sip:501@ekiga.net 2009/08/18 15:35:42.976 0:11.725 Opal Garbage:0xb5686b90 Opal Transport clean up on termination 2009/08/18 15:35:42.976 0:11.725 Opal Garbage:0xb5686b90 Opal Transport Close 2009/08/18 15:35:42.976 0:11.725 Opal Garbage:0xb5686b90 Opal Transport clean up on termination 2009/08/18 15:35:42.976 0:11.725 Opal Garbage:0xb5686b90 Opal Transport Close 2009/08/18 15:35:42.976 0:11.725 Opal Garbage:0xb5686b90 Opal Deleted transport udp$86.64.162.35:5060 2009/08/18 15:35:42.977 0:11.726 Opal Garbage:0xb5686b90 SIP Deleted handler. 2009/08/18 15:35:42.977 0:11.726 Opal Garbage:0xb5686b90 SIP Deleting SIPSubscribeHandler sip:mpaivacc@ekiga.net 2009/08/18 15:35:42.977 0:11.726 Opal Garbage:0xb5686b90 Opal Transport clean up on termination 2009/08/18 15:35:42.977 0:11.726 Opal Garbage:0xb5686b90 Opal Transport Close 2009/08/18 15:35:42.977 0:11.726 Opal Garbage:0xb5686b90 Opal Transport clean up on termination 2009/08/18 15:35:42.977 0:11.726 Opal Garbage:0xb5686b90 Opal Transport Close 2009/08/18 15:35:42.977 0:11.726 Opal Garbage:0xb5686b90 Opal Deleted transport udp$86.64.162.35:5060 2009/08/18 15:35:42.977 0:11.726 Opal Garbage:0xb5686b90 SIP Deleted handler. 2009/08/18 15:35:43.169 0:11.918 Housekeeper:0xb54ffb90 SIP Set state Terminated_Success for transaction 3 PUBLISH 2009/08/18 15:35:43.978 0:12.727 Opal Garbage:0xb5686b90 SIP Transaction 3 PUBLISH destroyed. 2009/08/18 15:39:49.169 4:17.918 Housekeeper:0xb54ffb90 SIP Starting PUBLISH for binding refresh 2009/08/18 15:39:49.169 4:17.918 Housekeeper:0xb54ffb90 SIP Changing PUBLISH handler from Subscribed to Refreshing, target=sip:mpaivacc@ekiga.net, id=4a49249a-938a-de11-909e-00137202cbae@inf01abl 2009/08/18 15:39:49.169 4:17.918 Housekeeper:0xb54ffb90 SIP Expiry time for PUBLISH set to 500 seconds. 2009/08/18 15:39:49.169 4:17.918 Housekeeper:0xb54ffb90 SIP Transaction created. 2009/08/18 15:39:49.172 4:17.921 Housekeeper:0xb54ffb90 DNS SRV Lookup ekiga.net service _sip._udp 2009/08/18 15:39:49.173 4:17.922 Housekeeper:0xb54ffb90 SIP No SRV record found. 2009/08/18 15:39:49.173 4:17.922 Housekeeper:0xb54ffb90 SIP Transaction remote address is udp$ekiga.net:5060 2009/08/18 15:39:49.173 4:17.922 Housekeeper:0xb54ffb90 SIP Sending PDU (521 bytes) to: rem=udp$86.64.162.35:5060,local=udp$201.70.76.253:5060,if=10.1.5.1%eth0 PUBLISH sip:mpaivacc@ekiga.net SIP/2.0 CSeq: 4 PUBLISH Via: SIP/2.0/UDP 201.70.76.253:5060;branch=z9hG4bK62258d2d-948a-de11-909e-00137202cbae;rport User-Agent: Ekiga/3.2.0 From: ;tag=faec8c2d-948a-de11-909e-00137202cbae Call-ID: 4a49249a-938a-de11-909e-00137202cbae@inf01abl To: Contact: SIP-If-Match: a.1250620046.16040.1196.0 Expires: 500 Event: presence Content-Type: application/pidf+xml Content-Length: 0 Max-Forwards: 70 2009/08/18 15:39:49.174 4:17.923 Housekeeper:0xb54ffb90 OpalUDP Setting interface to 10.1.5.1%eth0 2009/08/18 15:39:49.174 4:17.923 Housekeeper:0xb54ffb90 SIP Transaction timers set: retry=0.500, completion=6.000 2009/08/18 15:39:49.470 4:18.219 Opal Liste...0xb54beb90 OpalUDP Binding to interface: 201.70.76.253:5060 2009/08/18 15:39:49.470 4:18.219 Opal Liste...0xb54beb90 SIP Waiting for PDU on udp$86.64.162.35:5060 2009/08/18 15:39:49.470 4:18.219 Opal Liste...0xb54beb90 SIP PDU received: rem=udp$86.64.162.35:5060,local=udp$201.70.76.253:5060,if=10.1.5.1%eth0 SIP/2.0 200 OK CSeq: 4 PUBLISH Via: SIP/2.0/UDP 201.70.76.253:5060;branch=z9hG4bK62258d2d-948a-de11-909e-00137202cbae;rport=5060 Server: Kamailio (1.4.0-notls (i386/linux)) From: ;tag=faec8c2d-948a-de11-909e-00137202cbae Call-ID: 4a49249a-938a-de11-909e-00137202cbae@inf01abl To: ;tag=c64e1f832a41ec1c1f4e5673ac5b80f6.c645 Expires: 495 Content-Length: 0 SIP-ETag: a.1250620046.16039.1790.1 2009/08/18 15:39:49.471 4:18.220 Opal Liste...0xb54beb90 SIP Transaction 4 PUBLISH completed. 2009/08/18 15:39:49.471 4:18.220 Opal Liste...0xb54beb90 SIP Expiry time for PUBLISH set to 495 seconds. 2009/08/18 15:39:49.471 4:18.220 Opal Liste...0xb54beb90 SIP Changing PUBLISH handler from Refreshing to Subscribed, target=sip:mpaivacc@ekiga.net, id=4a49249a-938a-de11-909e-00137202cbae@inf01abl 2009/08/18 15:39:49.471 4:18.220 Opal Liste...0xb54beb90 OpalUDP Setting interface to 10.1.5.1%eth0 2009/08/18 15:39:49.471 4:18.220 Opal Liste...0xb54beb90 Opal Transport clean up on termination 2009/08/18 15:39:49.471 4:18.220 Opal Liste...0xb54beb90 Opal Transport Close 2009/08/18 15:39:49.471 4:18.220 Opal Liste...0xb54beb90 Opal Deleted transport udp$86.64.162.35:5060 2009/08/18 15:39:50.472 4:19.221 Housekeeper:0xb54ffb90 SIP Set state Terminated_Success for transaction 4 PUBLISH 2009/08/18 15:39:51.013 4:19.762 Opal Garbage:0xb5686b90 SIP Transaction 4 PUBLISH destroyed. 2009/08/18 15:40:43.296 5:12.045 OpalMan Set up call from pc:* to sip:neighbour@inf03abl.local:5060 2009/08/18 15:40:43.296 5:12.045 Call Created Call[u5f68d7891] 2009/08/18 15:40:43.296 5:12.045 OpalMan Set up connection to "pc:*" 2009/08/18 15:40:43.298 5:12.047 OpalCon Created connection Call[u5f68d7891]-EP[l70f490032] 2009/08/18 15:40:43.298 5:12.047 Silence Parameters set: mode=NoSilenceDetection, threshold=0, silencedb=3200, signaldb=80, period=4800 2009/08/18 15:40:43.298 5:12.047 Silence Handler created 2009/08/18 15:40:43.298 5:12.047 Echo Canceler Handler created 2009/08/18 15:40:43.298 5:12.047 PCSS Created PC sound system connection: token="l70f490032" player="EKIGA" recorder="EKIGA" 2009/08/18 15:40:43.298 5:12.047 OpalCon SetPhase from UninitialisedPhase to SetUpPhase for Call[u5f68d7891]-EP[l70f490032] 2009/08/18 15:40:43.298 5:12.047 OpalMan OnIncoming connection Call[u5f68d7891]-EP[l70f490032] 2009/08/18 15:40:43.298 5:12.047 OpalCon Applying string options: 2009/08/18 15:40:43.298 5:12.047 Call GetOtherPartyConnection Call[u5f68d7891]-EP[l70f490032] 2009/08/18 15:40:43.298 5:12.047 OpalMan Searching for route "pc:marcus.carneiro sip:neighbour@inf03abl.local:5060" 2009/08/18 15:40:43.298 5:12.047 OpalMan Set up connection to "sip:neighbour@inf03abl.local:5060" 2009/08/18 15:40:43.299 5:12.048 OpalCon Created connection Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:43.299 5:12.048 RFC2833 Handler created 2009/08/18 15:40:43.299 5:12.048 RFC2833 Handler created 2009/08/18 15:40:43.299 5:12.048 SIP Created connection. 2009/08/18 15:40:43.299 5:12.048 PCSS Outgoing call routed to sip:neighbour@inf03abl.local:5060 for Call[u5f68d7891]-EP[l70f490032] 2009/08/18 15:40:43.302 5:12.051 OpalMan SetUpCall succeeded, call=Call[u5f68d7891] 2009/08/18 15:40:43.303 5:12.052 CallSetup:0xb3eacb90 Call OnSetUp Call[u5f68d7891]-EP[l70f490032] 2009/08/18 15:40:43.303 5:12.052 CallSetup:0xb3eacb90 SIP SetUpConnection: sip:neighbour@inf03abl.local:5060 2009/08/18 15:40:43.305 5:12.054 CallSetup:0xb3eacb90 OpalCon SetPhase from UninitialisedPhase to SetUpPhase for Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:43.305 5:12.054 CallSetup:0xb3eacb90 OpalCon Applying string options: 2009/08/18 15:40:43.306 5:12.055 CallSetup:0xb3eacb90 SIP No SRV lookup as has explicit port number. 2009/08/18 15:40:43.306 5:12.055 CallSetup:0xb3eacb90 SIP Connecting to sip:neighbour@inf03abl.local:5060 via sip:neighbour@inf03abl.local:5060 2009/08/18 15:40:43.335 5:12.084 CallSetup:0xb3eacb90 OpalUDP Binding to interface: 0.0.0.0:5060 2009/08/18 15:40:43.336 5:12.085 CallSetup:0xb3eacb90 SIP Created transport udp$10.1.5.3:5060 2009/08/18 15:40:43.336 5:12.085 CallSetup:0xb3eacb90 OpalUDP Started connect to 10.1.5.3:5060 2009/08/18 15:40:43.336 5:12.085 CallSetup:0xb3eacb90 OpalUDP Writing to interface 0 - "10.1.5.1%eth0" 2009/08/18 15:40:43.337 5:12.086 CallSetup:0xb3eacb90 OpalMan Listener interfaces: associated transport=None udp$10.1.5.1:5060 2009/08/18 15:40:43.338 5:12.087 CallSetup:0xb3eacb90 SIP Updating dialog tag from "" to "fc68d04d-948a-de11-909e-00137202cbae" 2009/08/18 15:40:43.339 5:12.088 CallSetup:0xb3eacb90 SIP Transaction 1 INVITE created. 2009/08/18 15:40:43.344 5:12.093 CallSetup:0xb3eacb90 MediaFormat Removing codecs PCM-16-48kHz,PCM-16-32kHz,PCM-16-16kHz,PCM-16,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,YUV420P,RFC4175_YCbCr-4:2:0,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz 2009/08/18 15:40:43.345 5:12.094 CallSetup:0xb3eacb90 Call GetMediaFormats for Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] theora H.261 H.261-CIF H.261-QCIF SpeexIETFWide-20.6k SpeexWB SpeexWide-20.6k G.711-uLaw-64k G.711-ALaw-64k G.722-64k 2009/08/18 15:40:43.345 5:12.094 CallSetup:0xb3eacb90 SIP Offering media type audio in SDP with formats theora,H.261,H.261-CIF,H.261-QCIF,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,G.711-uLaw-64k,G.711-ALaw-64k,G.722-64k 2009/08/18 15:40:43.345 5:12.094 CallSetup:0xb3eacb90 Call IsMediaBypassPossible Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] session 1 2009/08/18 15:40:43.346 5:12.095 CallSetup:0xb3eacb90 OpalMan IsMediaBypassPossible: session 1 2009/08/18 15:40:43.346 5:12.095 CallSetup:0xb3eacb90 OpalCon IsMediaBypassPossible: default returns false 2009/08/18 15:40:43.346 5:12.095 CallSetup:0xb3eacb90 RTP Cannot find media session 1 2009/08/18 15:40:43.346 5:12.095 CallSetup:0xb3eacb90 RTP Cannot find RTP session 1 2009/08/18 15:40:43.347 5:12.096 CallSetup:0xb3eacb90 RTP_UDP Session 1, created with NAT flag set to 0 2009/08/18 15:40:43.347 5:12.096 CallSetup:0xb3eacb90 RTP_UDP Session 1 created: 10.1.5.1:5062-5063 ssrc=3528206225 2009/08/18 15:40:43.347 5:12.096 CallSetup:0xb3eacb90 RTP Creating new session RTP_UDP 2009/08/18 15:40:43.347 5:12.096 CallSetup:0xb3eacb90 RTP Found existing media session 1 2009/08/18 15:40:43.348 5:12.097 CallSetup:0xb3eacb90 SDP SDP not including SpeexIETFWide-20.6k as it is not a SIP transportable format 2009/08/18 15:40:43.348 5:12.097 CallSetup:0xb3eacb90 SDP SDP not including SpeexWide-20.6k as it is not a SIP transportable format 2009/08/18 15:40:43.348 5:12.097 CallSetup:0xb3eacb90 SIP Using default RTP payload [pt=101] for UserInput/RFC2833 2009/08/18 15:40:43.348 5:12.097 CallSetup:0xb3eacb90 SIP Using default RTP payload [pt=120] for NamedSignalEvent 2009/08/18 15:40:43.353 5:12.102 CallSetup:0xb3eacb90 MediaFormat Removing codecs PCM-16-48kHz,PCM-16-32kHz,PCM-16-16kHz,PCM-16,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,YUV420P,RFC4175_YCbCr-4:2:0,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz 2009/08/18 15:40:43.356 5:12.105 CallSetup:0xb3eacb90 Call GetMediaFormats for Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] theora H.261 H.261-CIF H.261-QCIF SpeexIETFWide-20.6k SpeexWB SpeexWide-20.6k G.711-uLaw-64k G.711-ALaw-64k G.722-64k 2009/08/18 15:40:43.359 5:12.108 CallSetup:0xb3eacb90 SIP Offering media type video in SDP with formats theora,H.261,H.261-CIF,H.261-QCIF,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,G.711-uLaw-64k,G.711-ALaw-64k,G.722-64k 2009/08/18 15:40:43.359 5:12.108 CallSetup:0xb3eacb90 Call IsMediaBypassPossible Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] session 2 2009/08/18 15:40:43.359 5:12.108 CallSetup:0xb3eacb90 OpalMan IsMediaBypassPossible: session 2 2009/08/18 15:40:43.359 5:12.108 CallSetup:0xb3eacb90 OpalCon IsMediaBypassPossible: default returns false 2009/08/18 15:40:43.359 5:12.108 CallSetup:0xb3eacb90 RTP Cannot find media session 2 2009/08/18 15:40:43.359 5:12.108 CallSetup:0xb3eacb90 RTP Cannot find RTP session 2 2009/08/18 15:40:43.361 5:12.110 CallSetup:0xb3eacb90 RTP_UDP Session 2, created with NAT flag set to 0 2009/08/18 15:40:43.361 5:12.110 CallSetup:0xb3eacb90 PWLib File handle high water mark set: 59 PUDPSocket 2009/08/18 15:40:43.361 5:12.110 CallSetup:0xb3eacb90 PWLib File handle high water mark set: 60 PUDPSocket 2009/08/18 15:40:43.361 5:12.110 CallSetup:0xb3eacb90 PWLib File handle low water mark set: 59 PUDPSocket 2009/08/18 15:40:43.361 5:12.110 CallSetup:0xb3eacb90 RTP_UDP Session 2 created: 10.1.5.1:5064-5065 ssrc=2675727780 2009/08/18 15:40:43.361 5:12.110 CallSetup:0xb3eacb90 RTP Creating new session RTP_UDP 2009/08/18 15:40:43.361 5:12.110 CallSetup:0xb3eacb90 RTP Found existing media session 2 2009/08/18 15:40:43.362 5:12.111 CallSetup:0xb3eacb90 SDP SDP not including H.261-CIF as it is not a SIP transportable format 2009/08/18 15:40:43.362 5:12.111 CallSetup:0xb3eacb90 SDP SDP not including H.261-QCIF as it is not a SIP transportable format 2009/08/18 15:40:43.362 5:12.111 CallSetup:0xb3eacb90 SIP Creating INVITE request 2009/08/18 15:40:43.362 5:12.111 CallSetup:0xb3eacb90 SIP No SRV lookup as has explicit port number. 2009/08/18 15:40:43.362 5:12.111 CallSetup:0xb3eacb90 SIP Transaction remote address is udp$inf03abl.local:5060 2009/08/18 15:40:43.363 5:12.112 CallSetup:0xb3eacb90 OpalPlugin to_customised_options: theora 2009/08/18 15:40:43.364 5:12.113 CallSetup:0xb3eacb90 OpalPlugin to_customised_options: H.261 2009/08/18 15:40:43.365 5:12.114 CallSetup:0xb3eacb90 OpalPlugin to_customised_options changed option "Frame Width" from "640" to "352" 2009/08/18 15:40:43.365 5:12.115 CallSetup:0xb3eacb90 OpalPlugin to_customised_options changed option "Frame Height" from "480" to "288" 2009/08/18 15:40:43.366 5:12.115 CallSetup:0xb3eacb90 SIP Sending PDU (1175 bytes) to: rem=udp$10.1.5.3:5060,local=udp$10.1.5.1:5060,if=10.1.5.1%eth0 INVITE sip:neighbour@inf03abl.local:5060 SIP/2.0 Date: Tue, 18 Aug 2009 18:40:43 GMT CSeq: 1 INVITE Via: SIP/2.0/UDP 10.1.5.1:5060;branch=z9hG4bK40a6d64d-948a-de11-909e-00137202cbae;rport User-Agent: Ekiga/3.2.0 From: "Marcus Paiva" ;tag=fc68d04d-948a-de11-909e-00137202cbae Call-ID: 3274d04d-948a-de11-909e-00137202cbae@inf01abl To: Contact: Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING Content-Type: application/sdp Content-Length: 575 Max-Forwards: 70 v=0 o=- 1250620843 1250620843 IN IP4 10.1.5.1 s=Opal SIP Session c=IN IP4 10.1.5.1 t=0 0 m=audio 5062 RTP/AVP 116 0 8 9 101 120 a=sendrecv a=rtpmap:116 Speex/16000/1 a=fmtp:116 sr=16000,mode=any a=rtpmap:0 PCMU/8000/1 a=rtpmap:8 PCMA/8000/1 a=rtpmap:9 G722/8000/1 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16,32,36 a=rtpmap:120 NSE/8000 a=fmtp:120 192-193 m=video 5064 RTP/AVP 119 31 a=sendrecv a=rtpmap:119 theora/90000 a=fmtp:119 delivery-method="in_band";height=576;sampling="YCbCr-4:2:0";width=704 a=rtpmap:31 h261/90000 a=fmtp:31 CIF=1;QCIF=1 2009/08/18 15:40:43.366 5:12.115 CallSetup:0xb3eacb90 OpalUDP Setting interface to 10.1.5.1%eth0 2009/08/18 15:40:43.367 5:12.116 CallSetup:0xb3eacb90 SIP Transaction timers set: retry=0.500, completion=1:00.000 2009/08/18 15:40:43.367 5:12.116 CallSetup:0xb3eacb90 OpalCon OnSetUpConnectionCall[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:43.367 5:12.116 CallSetup:0xb3eacb90 OpalEP OnSetUpConnection Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:43.370 5:12.120 Opal Liste...0xb54beb90 OpalUDP Binding to interface: 10.1.5.1:5060 2009/08/18 15:40:43.371 5:12.120 Opal Liste...0xb54beb90 SIP Waiting for PDU on udp$10.1.5.3:5060 2009/08/18 15:40:43.371 5:12.120 Opal Liste...0xb54beb90 SIP PDU received: rem=udp$10.1.5.3:5060,local=udp$10.1.5.1:5060,if=10.1.5.1%eth0 SIP/2.0 100 Trying CSeq: 1 INVITE Via: SIP/2.0/UDP 10.1.5.1:5060;branch=z9hG4bK40a6d64d-948a-de11-909e-00137202cbae;rport From: "Marcus Paiva" ;tag=fc68d04d-948a-de11-909e-00137202cbae Call-ID: 3274d04d-948a-de11-909e-00137202cbae@inf01abl To: Contact: Content-Length: 0 2009/08/18 15:40:43.371 5:12.120 Opal Liste...0xb54beb90 PWLib File handle low water mark set: 43 Thread unblock pipe 2009/08/18 15:40:43.374 5:12.123 Opal Liste...0xb54beb90 Opal Transport clean up on termination 2009/08/18 15:40:43.375 5:12.124 Opal Liste...0xb54beb90 Opal Transport Close 2009/08/18 15:40:43.375 5:12.124 Opal Liste...0xb54beb90 Opal Deleted transport udp$10.1.5.3:5060 2009/08/18 15:40:43.375 5:12.124 Aggregator:0xb3e6bb90 SIP Transaction 1 INVITE proceeding. 2009/08/18 15:40:43.376 5:12.125 Aggregator:0xb3e6bb90 SIP Received Trying response 2009/08/18 15:40:43.376 5:12.125 Aggregator:0xb3e6bb90 OpalCon SetPhase from SetUpPhase to ProceedingPhase for Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:43.376 5:12.125 Aggregator:0xb3e6bb90 OpalMan OnProceeding Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:43.376 5:12.128 Aggregator:0xb3e6bb90 Call OnProceeding Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:43.387 5:12.136 Opal Liste...0xb54beb90 OpalUDP Binding to interface: 10.1.5.1:5060 2009/08/18 15:40:43.387 5:12.136 Opal Liste...0xb54beb90 SIP Waiting for PDU on udp$10.1.5.3:5060 2009/08/18 15:40:43.387 5:12.136 Opal Liste...0xb54beb90 SIP PDU received: rem=udp$10.1.5.3:5060,local=udp$10.1.5.1:5060,if=10.1.5.1%eth0 SIP/2.0 180 Ringing CSeq: 1 INVITE Via: SIP/2.0/UDP 10.1.5.1:5060;branch=z9hG4bK40a6d64d-948a-de11-909e-00137202cbae;rport User-Agent: Ekiga/3.2.0 From: "Marcus Paiva" ;tag=fc68d04d-948a-de11-909e-00137202cbae Call-ID: 3274d04d-948a-de11-909e-00137202cbae@inf01abl To: ;tag=a693404f-948a-de11-8250-00137202ca9b Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING Content-Length: 0 2009/08/18 15:40:43.388 5:12.137 Opal Liste...0xb54beb90 Opal Transport clean up on termination 2009/08/18 15:40:43.388 5:12.137 Opal Liste...0xb54beb90 Opal Transport Close 2009/08/18 15:40:43.388 5:12.137 Opal Liste...0xb54beb90 Opal Deleted transport udp$10.1.5.3:5060 2009/08/18 15:40:43.388 5:12.137 Aggregator:0xb3e6bb90 SIP Updating dialog tag from "" to "a693404f-948a-de11-8250-00137202ca9b" 2009/08/18 15:40:43.389 5:12.138 Aggregator:0xb3e6bb90 SIP Transaction 1 INVITE proceeding. 2009/08/18 15:40:43.389 5:12.138 Aggregator:0xb3e6bb90 SIP Received Ringing response 2009/08/18 15:40:43.389 5:12.138 Aggregator:0xb3e6bb90 OpalCon SetPhase from ProceedingPhase to AlertingPhase for Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:43.389 5:12.138 Aggregator:0xb3e6bb90 OpalMan OnAlerting Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:43.389 5:12.138 Aggregator:0xb3e6bb90 Call OnAlerting Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:43.389 5:12.138 Aggregator:0xb3e6bb90 PCSS SetAlerting(neighbour@inf03abl.local:5060) 2009/08/18 15:40:43.389 5:12.138 Aggregator:0xb3e6bb90 OpalCon SetPhase from SetUpPhase to AlertingPhase for Call[u5f68d7891]-EP[l70f490032] 2009/08/18 15:40:43.423 5:12.172 AEScheduler Adding Event ring_tone_sound 3000/256 to queue 2009/08/18 15:40:43.423 5:12.172 AudioEvent...0xb5708b90 AEScheduler Checking pending list with 1 elements 2009/08/18 15:40:43.423 5:12.172 AudioEvent...0xb5708b90 AEScheduler Trying to load dialtone.wav for event ring_tone_sound 2009/08/18 15:40:43.423 5:12.173 AudioEvent...0xb5708b90 AEScheduler Trying to load /usr/share/sounds/ekiga/dialtone.wav for event ring_tone_sound 2009/08/18 15:40:43.444 5:12.193 AudioEvent...0xb5708b90 PWLib File handle high water mark set: 61 PWAVFile 2009/08/18 15:40:43.456 5:12.205 AudioEvent...0xb5708b90 AudioOutputCore Opening device[0] with 1-8000/16 2009/08/18 15:40:43.456 5:12.205 AudioEvent...0xb5708b90 GMAudioOutputManager_ptlib Opening Device Default (PTLIB/ALSA) 2009/08/18 15:40:43.456 5:12.205 AudioEvent...0xb5708b90 GMAudioOutputManager_ptlib Opening Device with 1-8000/16 [New Thread 0xb46eeb90 (LWP 18106)] [Thread 0xb46eeb90 (LWP 18106) exited] [Thread 0xb543cb90 (LWP 18098) exited] [Thread 0xb54beb90 (LWP 18096) exited] [New Thread 0xb54beb90 (LWP 18108)] [Thread 0xb547db90 (LWP 18097) exited] [New Thread 0xb547db90 (LWP 18109)] [New Thread 0xb3eedb90 (LWP 18110)] [Thread 0xb3eedb90 (LWP 18110) exited] [New Thread 0xb3eacb90 (LWP 18418)] [Thread 0xb3eacb90 (LWP 18418) exited] [New Thread 0xb3e6bb90 (LWP 18421)] 2009/08/18 15:40:43.505 5:12.254 AudioEvent...0xb5708b90 Alsa Buffer time is 16000 2009/08/18 15:40:43.505 5:12.254 AudioEvent...0xb5708b90 Alsa Period time is 4000 2009/08/18 15:40:43.706 5:12.455 AudioEvent...0xb5708b90 ALSA Device default Opened [New Thread 0xb46eeb90 (LWP 18422)] 2009/08/18 15:40:43.765 5:12.514 AudioEvent...0xb5708b90 Got volume 54067 2009/08/18 15:40:43.769 5:12.518 AudioEvent...0xb5708b90 GMAudioOutputManager_ptlib Setting buffer size of device[0] 320/4 2009/08/18 15:40:43.769 5:12.518 AudioEvent...0xb5708b90 Alsa Buffer time is 40000 2009/08/18 15:40:43.769 5:12.518 AudioEvent...0xb5708b90 Alsa Period time is 10000 2009/08/18 15:40:43.794 5:12.543 AudioEvent...0xb5708b90 ALSA Could not write 0 320 Sucesso 2009/08/18 15:40:44.780 5:13.529 AudioEvent...0xb5708b90 AudioOutputCore Closing current device 2009/08/18 15:40:44.780 5:13.529 AudioEvent...0xb5708b90 GMAudioOutputManager_ptlib Closing device[0] Default (PTLIB/ALSA) 2009/08/18 15:40:46.423 5:15.172 AudioEvent...0xb5708b90 AEScheduler Checking pending list with 1 elements 2009/08/18 15:40:46.423 5:15.172 AudioEvent...0xb5708b90 AEScheduler Trying to load dialtone.wav for event ring_tone_sound 2009/08/18 15:40:46.424 5:15.173 AudioEvent...0xb5708b90 AEScheduler Trying to load /usr/share/sounds/ekiga/dialtone.wav for event ring_tone_sound 2009/08/18 15:40:46.424 5:15.173 AudioEvent...0xb5708b90 AudioOutputCore Opening device[0] with 1-8000/16 2009/08/18 15:40:46.424 5:15.173 AudioEvent...0xb5708b90 GMAudioOutputManager_ptlib Opening Device Default (PTLIB/ALSA) 2009/08/18 15:40:46.424 5:15.173 AudioEvent...0xb5708b90 GMAudioOutputManager_ptlib Opening Device with 1-8000/16 2009/08/18 15:40:46.430 5:15.179 AudioEvent...0xb5708b90 Alsa Buffer time is 16000 2009/08/18 15:40:46.430 5:15.179 AudioEvent...0xb5708b90 Alsa Period time is 4000 2009/08/18 15:40:46.431 5:15.180 AudioEvent...0xb5708b90 ALSA Device default Opened 2009/08/18 15:40:46.461 5:15.210 AudioEvent...0xb5708b90 Got volume 54067 2009/08/18 15:40:46.465 5:15.214 AudioEvent...0xb5708b90 GMAudioOutputManager_ptlib Setting buffer size of device[0] 320/4 2009/08/18 15:40:46.465 5:15.214 AudioEvent...0xb5708b90 Alsa Buffer time is 40000 2009/08/18 15:40:46.465 5:15.214 AudioEvent...0xb5708b90 Alsa Period time is 10000 2009/08/18 15:40:47.530 5:16.279 AudioEvent...0xb5708b90 AudioOutputCore Closing current device 2009/08/18 15:40:47.530 5:16.279 AudioEvent...0xb5708b90 GMAudioOutputManager_ptlib Closing device[0] Default (PTLIB/ALSA) 2009/08/18 15:40:48.892 5:17.641 Opal Liste...0xb54beb90 OpalUDP Binding to interface: 10.1.5.1:5060 2009/08/18 15:40:48.892 5:17.641 Opal Liste...0xb54beb90 SIP Waiting for PDU on udp$10.1.5.3:5060 2009/08/18 15:40:48.893 5:17.642 Opal Liste...0xb54beb90 SIP PDU received: rem=udp$10.1.5.3:5060,local=udp$10.1.5.1:5060,if=10.1.5.1%eth0 SIP/2.0 200 OK CSeq: 1 INVITE Via: SIP/2.0/UDP 10.1.5.1:5060;branch=z9hG4bK40a6d64d-948a-de11-909e-00137202cbae;rport User-Agent: Ekiga/3.2.0 From: "Marcus Paiva" ;tag=fc68d04d-948a-de11-909e-00137202cbae Call-ID: 3274d04d-948a-de11-909e-00137202cbae@inf01abl To: ;tag=a693404f-948a-de11-8250-00137202ca9b Contact: Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING Content-Type: application/sdp Content-Length: 446 v=0 o=- 1250620850 1250620850 IN IP4 10.1.5.3 s=Opal SIP Session c=IN IP4 10.1.5.3 t=0 0 m=audio 5062 RTP/AVP 116 101 120 a=sendrecv a=rtpmap:116 Speex/16000/1 a=fmtp:116 sr=16000,mode=any a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16,32,36 a=rtpmap:120 NSE/8000 a=fmtp:120 192-193 m=video 5064 RTP/AVP 119 a=sendrecv a=rtpmap:119 theora/90000 a=fmtp:119 delivery-method="in_band";height=576;sampling="YCbCr-4:2:0";width=704 2009/08/18 15:40:48.893 5:17.642 Opal Liste...0xb54beb90 Opal Transport clean up on termination 2009/08/18 15:40:48.893 5:17.642 Opal Liste...0xb54beb90 Opal Transport Close 2009/08/18 15:40:48.893 5:17.642 Opal Liste...0xb54beb90 Opal Deleted transport udp$10.1.5.3:5060 2009/08/18 15:40:48.893 5:17.642 Aggregator:0xb3e6bb90 SIP Set Request URI to sip:claudia.silva@10.1.5.3 2009/08/18 15:40:48.894 5:17.643 Aggregator:0xb3e6bb90 OpalUDP Setting interface to 10.1.5.1%eth0 2009/08/18 15:40:48.894 5:17.643 Aggregator:0xb3e6bb90 SDP Media session port=5062 2009/08/18 15:40:48.895 5:17.644 Aggregator:0xb3e6bb90 SDP Parsed media session with 3 'audio' formats 2009/08/18 15:40:48.895 5:17.644 Aggregator:0xb3e6bb90 SDP Media session port=5064 2009/08/18 15:40:48.895 5:17.644 Aggregator:0xb3e6bb90 SDP Parsed media session with 1 'video' formats 2009/08/18 15:40:48.895 5:17.644 Aggregator:0xb3e6bb90 OpalPlugin to_normalised_options: theora 2009/08/18 15:40:48.896 5:17.645 Aggregator:0xb3e6bb90 SIP Transaction remote address changed to udp$10.1.5.3:5060 2009/08/18 15:40:48.898 5:17.647 Aggregator:0xb3e6bb90 SIP Sending PDU (454 bytes) to: rem=udp$10.1.5.3:5060,local=udp$10.1.5.1:5060,if=10.1.5.1%eth0 ACK sip:claudia.silva@10.1.5.3 SIP/2.0 CSeq: 1 ACK Via: SIP/2.0/UDP 10.1.5.1:5060;branch=z9hG4bKb6c32651-948a-de11-909e-00137202cbae;rport From: "Marcus Paiva" ;tag=fc68d04d-948a-de11-909e-00137202cbae Call-ID: 3274d04d-948a-de11-909e-00137202cbae@inf01abl To: ;tag=a693404f-948a-de11-8250-00137202ca9b Contact: Content-Length: 0 Max-Forwards: 70 2009/08/18 15:40:48.898 5:17.647 Aggregator:0xb3e6bb90 OpalUDP Setting interface to 10.1.5.1%eth0 2009/08/18 15:40:48.898 5:17.647 Aggregator:0xb3e6bb90 SIP Transaction 1 INVITE completed. 2009/08/18 15:40:48.898 5:17.647 Aggregator:0xb3e6bb90 SIP Handling 200 OK response for INVITE 2009/08/18 15:40:48.898 5:17.647 Aggregator:0xb3e6bb90 SIP Received INVITE OK response 2009/08/18 15:40:48.899 5:17.648 Aggregator:0xb3e6bb90 SIP Processing received SDP media description for audio 2009/08/18 15:40:48.899 5:17.648 Aggregator:0xb3e6bb90 SIP RTP payload type [pt=116] matched to codec SpeexWB 2009/08/18 15:40:48.899 5:17.648 Aggregator:0xb3e6bb90 MediaFormat Removing codecs PCM-16-48kHz,PCM-16-32kHz,PCM-16-16kHz,PCM-16,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,YUV420P,RFC4175_YCbCr-4:2:0,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz 2009/08/18 15:40:48.899 5:17.648 Aggregator:0xb3e6bb90 Call GetOtherPartyConnection Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:48.899 5:17.648 Aggregator:0xb3e6bb90 Call IsMediaBypassPossible Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] session 1 2009/08/18 15:40:48.899 5:17.648 Aggregator:0xb3e6bb90 OpalMan IsMediaBypassPossible: session 1 2009/08/18 15:40:48.899 5:17.648 Aggregator:0xb3e6bb90 OpalCon IsMediaBypassPossible: default returns false 2009/08/18 15:40:48.899 5:17.648 Aggregator:0xb3e6bb90 RTP Found existing RTP session 1 2009/08/18 15:40:48.900 5:17.649 Aggregator:0xb3e6bb90 RTP_UDP Session 1, SetRemoteSocketInfo: data channel, new=10.1.5.3:5062, local=10.1.5.1:5062-5063, remote=0.0.0.0:0-0 2009/08/18 15:40:48.900 5:17.649 Aggregator:0xb3e6bb90 Call OpenSourceMediaStreams opening audio session 1 on Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:48.904 5:17.653 Aggregator:0xb3e6bb90 MediaFormat Removing codecs PCM-16-48kHz,PCM-16-32kHz,PCM-16-16kHz,PCM-16,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,YUV420P,RFC4175_YCbCr-4:2:0,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz 2009/08/18 15:40:48.905 5:17.654 Aggregator:0xb3e6bb90 Call GetMediaFormats for Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] theora H.261 H.261-CIF H.261-QCIF SpeexIETFWide-20.6k SpeexWB SpeexWide-20.6k G.711-uLaw-64k G.711-ALaw-64k G.722-64k 2009/08/18 15:40:48.906 5:17.655 Aggregator:0xb3e6bb90 MediaFormat Merging SpeexWB into SpeexWB 2009/08/18 15:40:48.906 5:17.655 Aggregator:0xb3e6bb90 MediaFormat Merging PCM-16-16kHz into SpeexWB 2009/08/18 15:40:48.906 5:17.655 Aggregator:0xb3e6bb90 MediaFormat Merging SpeexWB into PCM-16-16kHz 2009/08/18 15:40:48.906 5:17.655 Aggregator:0xb3e6bb90 MediaFormat Changed media option "Bandwidth-TIAS" from 256000 to 20800 2009/08/18 15:40:48.906 5:17.655 Aggregator:0xb3e6bb90 MediaFormat Changed media option "Max Bit Rate" from 256000 to 20600 2009/08/18 15:40:48.906 5:17.655 Aggregator:0xb3e6bb90 Call Selected media formats SpeexWB -> PCM-16-16kHz 2009/08/18 15:40:48.906 5:17.655 Aggregator:0xb3e6bb90 Call IsMediaBypassPossible Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] session 1 2009/08/18 15:40:48.907 5:17.656 Aggregator:0xb3e6bb90 OpalMan IsMediaBypassPossible: session 1 2009/08/18 15:40:48.907 5:17.656 Aggregator:0xb3e6bb90 OpalCon IsMediaBypassPossible: default returns false 2009/08/18 15:40:48.907 5:17.656 Aggregator:0xb3e6bb90 RTP Found existing media session 1 2009/08/18 15:40:48.907 5:17.656 Aggregator:0xb3e6bb90 OpalMan OnOpenMediaStream Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae],OpalRTPMediaStream-Source-SpeexWB 2009/08/18 15:40:48.907 5:17.656 Aggregator:0xb3e6bb90 OpalCon Opened source stream u5f68d7891_1 with format SpeexWB 2009/08/18 15:40:48.907 5:17.656 Aggregator:0xb3e6bb90 AudioOutputCore Opening device[0] with 1-16000/16 2009/08/18 15:40:48.907 5:17.656 Aggregator:0xb3e6bb90 GMAudioOutputManager_ptlib Opening Device Default (PTLIB/ALSA) 2009/08/18 15:40:48.907 5:17.656 Aggregator:0xb3e6bb90 GMAudioOutputManager_ptlib Opening Device with 1-16000/16 2009/08/18 15:40:48.913 5:17.662 Aggregator:0xb3e6bb90 Alsa Buffer time is 8000 2009/08/18 15:40:48.914 5:17.663 Aggregator:0xb3e6bb90 Alsa Period time is 2000 2009/08/18 15:40:48.916 5:17.665 Aggregator:0xb3e6bb90 ALSA Device default Opened 2009/08/18 15:40:48.963 5:17.712 Aggregator:0xb3e6bb90 Got volume 54067 2009/08/18 15:40:48.967 5:17.716 Aggregator:0xb3e6bb90 PCSS Opened mono sound channel "EKIGA" for playing at 16.0 kHz. 2009/08/18 15:40:48.967 5:17.716 Aggregator:0xb3e6bb90 OpalMan OnOpenMediaStream Call[u5f68d7891]-EP[l70f490032],OpalAudioMediaStream-Sink-PCM-16-16kHz 2009/08/18 15:40:48.967 5:17.716 Aggregator:0xb3e6bb90 OpalCon Opened sink stream u5f68d7891_1 with format PCM-16-16kHz 2009/08/18 15:40:48.967 5:17.716 Aggregator:0xb3e6bb90 Patch Created Sink: format=PCM-16-16kHz 2009/08/18 15:40:48.968 5:17.717 Aggregator:0xb3e6bb90 OpalPlugin Setting decoder options: Format Name = SpeexWB Media Type = audio Payload Type = [pt=116] Encoding Name = Speex Bandwidth-TIAS (R/W) = 20800 UnsignedInt Channels (R/W) = 1 UnsignedInt Clock Rate (R/O) = 16000 UnsignedInt fmtp (R/W) = "sr=16000,mode=any" String Frame Time (R/O) = 320 UnsignedInt Max Bit Rate (R/O) = 20600 UnsignedInt Max Frame Size (R/O) = 52 UnsignedInt Max Frames Per Packet (R/O) = 1 UnsignedInt Needs Jitter (R/O) = 1 Boolean Rx Frames Per Packet (R/W) = 1 UnsignedInt Tx Frames Per Packet (R/W) = 1 UnsignedInt 2009/08/18 15:40:48.968 5:17.717 Aggregator:0xb3e6bb90 Patch Created primary codec SpeexWB->PCM-16-16kHz with ID u5f68d7891_1 2009/08/18 15:40:48.968 5:17.717 Aggregator:0xb3e6bb90 Media Audio sink data size set to 640 bytes and 5 buffers. 2009/08/18 15:40:48.969 5:17.718 Aggregator:0xb3e6bb90 Media Set data size from 32 to 640 2009/08/18 15:40:48.969 5:17.718 Aggregator:0xb3e6bb90 GMAudioOutputManager_ptlib Setting buffer size of device[0] 640/5 2009/08/18 15:40:48.969 5:17.718 Aggregator:0xb3e6bb90 Patch Added media stream sink OpalAudioMediaStream-Sink-PCM-16-16kHz using transcoder SpeexWB->PCM-16-16kHz, data size=640 2009/08/18 15:40:48.969 5:17.718 Aggregator:0xb3e6bb90 Media RTP data size cannot be changed to 52, fixed at 2048 2009/08/18 15:40:48.969 5:17.718 Aggregator:0xb3e6bb90 PCSS Adding filters to patch 2009/08/18 15:40:48.969 5:17.718 Aggregator:0xb3e6bb90 OpalCon Source stream of connection Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] uses patch Patch OpalRTPMediaStream-Source-SpeexWB -> OpalAudioMediaStream-Sink-PCM-16-16kHz 2009/08/18 15:40:48.969 5:17.718 Aggregator:0xb3e6bb90 RTPCon Adding RFC2833 receive handler 2009/08/18 15:40:48.969 5:17.718 Aggregator:0xb3e6bb90 RTPCon Adding Cisco NSE receive handler 2009/08/18 15:40:48.969 5:17.718 Aggregator:0xb3e6bb90 Call GetOtherPartyConnection Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:48.970 5:17.719 Aggregator:0xb3e6bb90 Call OpenSourceMediaStreams opening audio session 1 on Call[u5f68d7891]-EP[l70f490032] 2009/08/18 15:40:48.971 5:17.720 Aggregator:0xb3e6bb90 MediaFormat Removing codecs PCM-16-48kHz,PCM-16-32kHz,PCM-16-16kHz,PCM-16,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,YUV420P,RFC4175_YCbCr-4:2:0,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz 2009/08/18 15:40:48.971 5:17.720 Aggregator:0xb3e6bb90 Call GetMediaFormats for Call[u5f68d7891]-EP[l70f490032] SpeexIETFWide-20.6k SpeexWB SpeexWide-20.6k G.722-64k T.38 UserInput/RFC2833 NamedSignalEvent 2009/08/18 15:40:48.971 5:17.720 Aggregator:0xb3e6bb90 MediaFormat Merging SpeexWB into SpeexWB 2009/08/18 15:40:48.972 5:17.721 Aggregator:0xb3e6bb90 MediaFormat Merging SpeexWB into PCM-16-16kHz 2009/08/18 15:40:48.972 5:17.721 Aggregator:0xb3e6bb90 MediaFormat Changed media option "Bandwidth-TIAS" from 256000 to 20800 2009/08/18 15:40:48.972 5:17.721 Aggregator:0xb3e6bb90 MediaFormat Changed media option "Max Bit Rate" from 256000 to 20600 2009/08/18 15:40:48.972 5:17.721 Aggregator:0xb3e6bb90 MediaFormat Merging PCM-16-16kHz into SpeexWB 2009/08/18 15:40:48.972 5:17.721 Aggregator:0xb3e6bb90 Call Selected media formats PCM-16-16kHz -> SpeexWB 2009/08/18 15:40:48.972 5:17.721 Aggregator:0xb3e6bb90 AudioInputCore Starting stream 1x16000/16 2009/08/18 15:40:48.972 5:17.721 Aggregator:0xb3e6bb90 AudioInputCore Opening device with 1-16000/16 2009/08/18 15:40:48.972 5:17.721 Aggregator:0xb3e6bb90 GMAudioInputManager_ptlib Opening Device Default (PTLIB/ALSA) 2009/08/18 15:40:48.973 5:17.722 Aggregator:0xb3e6bb90 GMAudioInputManager_ptlib Opening Device with 1-16000/16 2009/08/18 15:40:49.000 5:17.749 Aggregator:0xb3e6bb90 Alsa Buffer time is 8000 2009/08/18 15:40:49.000 5:17.749 Aggregator:0xb3e6bb90 Alsa Period time is 2000 2009/08/18 15:40:49.027 5:17.776 Aggregator:0xb3e6bb90 ALSA Device default Opened 2009/08/18 15:40:49.061 5:17.810 Aggregator:0xb3e6bb90 Got volume 52429 2009/08/18 15:40:49.065 5:17.814 Aggregator:0xb3e6bb90 PCSS Opened mono sound channel "EKIGA" for recording at 16.0 kHz. 2009/08/18 15:40:49.065 5:17.814 Aggregator:0xb3e6bb90 OpalMan OnOpenMediaStream Call[u5f68d7891]-EP[l70f490032],OpalAudioMediaStream-Source-PCM-16-16kHz 2009/08/18 15:40:49.065 5:17.814 Aggregator:0xb3e6bb90 OpalCon Opened source stream u5f68d7891_1 with format PCM-16-16kHz 2009/08/18 15:40:49.065 5:17.814 Aggregator:0xb3e6bb90 Call IsMediaBypassPossible Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] session 1 2009/08/18 15:40:49.066 5:17.815 Aggregator:0xb3e6bb90 OpalMan IsMediaBypassPossible: session 1 2009/08/18 15:40:49.066 5:17.815 Aggregator:0xb3e6bb90 OpalCon IsMediaBypassPossible: default returns false 2009/08/18 15:40:49.066 5:17.815 Aggregator:0xb3e6bb90 RTP Found existing media session 1 2009/08/18 15:40:49.066 5:17.815 Aggregator:0xb3e6bb90 OpalMan OnOpenMediaStream Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae],OpalRTPMediaStream-Sink-SpeexWB 2009/08/18 15:40:49.066 5:17.815 Aggregator:0xb3e6bb90 OpalCon Opened sink stream u5f68d7891_1 with format SpeexWB 2009/08/18 15:40:49.066 5:17.815 Aggregator:0xb3e6bb90 Patch Created Sink: format=SpeexWB 2009/08/18 15:40:49.067 5:17.816 Aggregator:0xb3e6bb90 OpalPlugin Setting encoder options: Format Name = SpeexWB Media Type = audio Payload Type = [pt=116] Encoding Name = Speex Bandwidth-TIAS (R/W) = 20800 UnsignedInt Channels (R/W) = 1 UnsignedInt Clock Rate (R/O) = 16000 UnsignedInt fmtp (R/W) = "sr=16000,mode=any" String Frame Time (R/O) = 320 UnsignedInt Max Bit Rate (R/O) = 20600 UnsignedInt Max Frame Size (R/O) = 52 UnsignedInt Max Frames Per Packet (R/O) = 1 UnsignedInt Needs Jitter (R/O) = 1 Boolean RawFMTP (R/W) = "sr=16000,mode=any" String Rx Frames Per Packet (R/W) = 1 UnsignedInt Tx Frames Per Packet (R/W) = 1 UnsignedInt 2009/08/18 15:40:49.067 5:17.816 Aggregator:0xb3e6bb90 Patch Created primary codec PCM-16-16kHz->SpeexWB with ID u5f68d7891_1 2009/08/18 15:40:49.067 5:17.816 Aggregator:0xb3e6bb90 Media RTP data size cannot be changed to 52, fixed at 528 2009/08/18 15:40:49.067 5:17.816 Aggregator:0xb3e6bb90 Patch Added media stream sink OpalRTPMediaStream-Sink-SpeexWB using transcoder PCM-16-16kHz->SpeexWB, data size=528 2009/08/18 15:40:49.068 5:17.817 Aggregator:0xb3e6bb90 Media Audio source data size set to 640 bytes and 5 buffers. 2009/08/18 15:40:49.068 5:17.817 Aggregator:0xb3e6bb90 Media Set data size from 32 to 640 2009/08/18 15:40:49.068 5:17.817 Aggregator:0xb3e6bb90 AudioInputCore Setting stream buffer size 5/640 2009/08/18 15:40:49.068 5:17.817 Aggregator:0xb3e6bb90 GMAudioInputManager_ptlib Setting buffer size to 640/5 2009/08/18 15:40:49.068 5:17.817 Aggregator:0xb3e6bb90 PCSS Adding filters to patch 2009/08/18 15:40:49.068 5:17.817 Aggregator:0xb3e6bb90 OpalCon Sink stream of connection Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] uses patch Patch OpalAudioMediaStream-Source-PCM-16-16kHz -> OpalRTPMediaStream-Sink-SpeexWB 2009/08/18 15:40:49.068 5:17.817 Aggregator:0xb3e6bb90 SIP Processing received SDP media description for video 2009/08/18 15:40:49.068 5:17.817 Aggregator:0xb3e6bb90 SIP RTP payload type [pt=119] matched to codec theora 2009/08/18 15:40:49.069 5:17.818 Aggregator:0xb3e6bb90 MediaFormat Removing codecs PCM-16-48kHz,PCM-16-32kHz,PCM-16-16kHz,PCM-16,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,YUV420P,RFC4175_YCbCr-4:2:0,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz 2009/08/18 15:40:49.069 5:17.818 Aggregator:0xb3e6bb90 Call GetOtherPartyConnection Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:49.069 5:17.818 Aggregator:0xb3e6bb90 Call IsMediaBypassPossible Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] session 2 2009/08/18 15:40:49.069 5:17.818 Aggregator:0xb3e6bb90 OpalMan IsMediaBypassPossible: session 2 2009/08/18 15:40:49.069 5:17.818 Aggregator:0xb3e6bb90 OpalCon IsMediaBypassPossible: default returns false 2009/08/18 15:40:49.069 5:17.818 Aggregator:0xb3e6bb90 RTP Found existing RTP session 2 2009/08/18 15:40:49.070 5:17.819 Aggregator:0xb3e6bb90 RTP_UDP Session 2, SetRemoteSocketInfo: data channel, new=10.1.5.3:5064, local=10.1.5.1:5064-5065, remote=0.0.0.0:0-0 2009/08/18 15:40:49.070 5:17.819 Aggregator:0xb3e6bb90 Call OpenSourceMediaStreams opening video session 2 on Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:49.075 5:17.824 Aggregator:0xb3e6bb90 MediaFormat Removing codecs PCM-16-48kHz,PCM-16-32kHz,PCM-16-16kHz,PCM-16,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,YUV420P,RFC4175_YCbCr-4:2:0,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz 2009/08/18 15:40:49.077 5:17.826 Aggregator:0xb3e6bb90 Call GetMediaFormats for Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] theora H.261 H.261-CIF H.261-QCIF SpeexIETFWide-20.6k SpeexWB SpeexWide-20.6k G.711-uLaw-64k G.711-ALaw-64k G.722-64k 2009/08/18 15:40:49.077 5:17.826 Aggregator:0xb3e6bb90 MediaFormat Merging theora into theora 2009/08/18 15:40:49.077 5:17.826 Aggregator:0xb3e6bb90 MediaFormat Merging YUV420P into theora 2009/08/18 15:40:49.078 5:17.827 Aggregator:0xb3e6bb90 MediaFormat Merging theora into YUV420P 2009/08/18 15:40:49.078 5:17.827 Aggregator:0xb3e6bb90 MediaFormat Changed media option "Bandwidth-TIAS" from 583925760 to 768000 2009/08/18 15:40:49.078 5:17.827 Aggregator:0xb3e6bb90 MediaFormat Changed media option "Max Rx Frame Height" from 1088 to 720 2009/08/18 15:40:49.078 5:17.827 Aggregator:0xb3e6bb90 MediaFormat Changed media option "Max Rx Frame Width" from 1920 to 1280 2009/08/18 15:40:49.078 5:17.827 Aggregator:0xb3e6bb90 Call Selected media formats theora -> YUV420P 2009/08/18 15:40:49.078 5:17.827 Aggregator:0xb3e6bb90 Call IsMediaBypassPossible Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] session 2 2009/08/18 15:40:49.078 5:17.828 Aggregator:0xb3e6bb90 OpalMan IsMediaBypassPossible: session 2 2009/08/18 15:40:49.079 5:17.828 Aggregator:0xb3e6bb90 OpalCon IsMediaBypassPossible: default returns false 2009/08/18 15:40:49.079 5:17.828 Aggregator:0xb3e6bb90 RTP Found existing media session 2 2009/08/18 15:40:49.079 5:17.828 Aggregator:0xb3e6bb90 OpalMan OnOpenMediaStream Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae],OpalRTPMediaStream-Source-theora 2009/08/18 15:40:49.079 5:17.828 Aggregator:0xb3e6bb90 OpalCon Opened source stream u5f68d7891_2 with format theora 2009/08/18 15:40:49.079 5:17.828 Aggregator:0xb3e6bb90 PVidDev SetColourFormatConverter success for native YUV420P 2009/08/18 15:40:49.080 5:17.829 Aggregator:0xb3e6bb90 PVidDev SetFrameSize to 640x480 2009/08/18 15:40:49.080 5:17.829 Aggregator:0xb3e6bb90 PVidDev SetColourFormatConverter success for native YUV420P 2009/08/18 15:40:49.080 5:17.829 Aggregator:0xb3e6bb90 Media Set data size from 1400 to 608272 2009/08/18 15:40:49.080 5:17.829 Aggregator:0xb3e6bb90 OpalMan OnOpenMediaStream Call[u5f68d7891]-EP[l70f490032],OpalVideoMediaStream-Sink-YUV420P 2009/08/18 15:40:49.080 5:17.829 Aggregator:0xb3e6bb90 OpalCon Opened sink stream u5f68d7891_2 with format YUV420P 2009/08/18 15:40:49.080 5:17.829 Aggregator:0xb3e6bb90 Patch Created Sink: format=YUV420P 2009/08/18 15:40:49.080 5:17.829 Aggregator:0xb3e6bb90 OpalPlugin Setting decoder options: Format Name = theora Media Type = video Payload Type = [pt=119] Encoding Name = theora Bandwidth-TIAS (R/W) = 768000 UnsignedInt CAP Delivery (R/W) = "in_band" FMTP name: delivery-method (in_band) String CAP Height (R/W) = 576 FMTP name: height (15) UnsignedInt CAP Sampling (R/W) = "YCbCr-4:2:0" FMTP name: sampling (YCbCr-4:2:0) String CAP Width (R/W) = 704 FMTP name: width (15) UnsignedInt Clock Rate (R/O) = 90000 UnsignedInt Frame Height (R/W) = 480 UnsignedInt Frame Time (R/W) = 3000 UnsignedInt Frame Width (R/W) = 640 UnsignedInt Max Bit Rate (R/W) = 4096000 UnsignedInt Max Frame Size (R/O) = 1400 UnsignedInt Max Rx Frame Height (R/O) = 720 UnsignedInt Max Rx Frame Width (R/O) = 1280 UnsignedInt Min Rx Frame Height (R/O) = 120 UnsignedInt Min Rx Frame Width (R/O) = 160 UnsignedInt Rate Control Enable (R/W) = 1 Boolean Rate Control Max Frames Skip (R/W) = 1 UnsignedInt Rate Control Window Size (R/W) = 500 UnsignedInt Rate Controller Bit Rate Scaler (R/W) = 100 UnsignedInt Target Bit Rate (R/W) = 1024000 UnsignedInt Temporal Spatial Trade Off (R/O) = 31 UnsignedInt Tx Key Frame Period (R/W) = 125 UnsignedInt 2009/08/18 15:40:49.081 5:17.830 Aggregator:0xb3e6bb90 Patch Created primary codec theora->YUV420P with ID u5f68d7891_2 2009/08/18 15:40:49.081 5:17.830 Aggregator:0xb3e6bb90 Patch Added media stream sink OpalVideoMediaStream-Sink-YUV420P using transcoder theora->YUV420P, data size=608272 2009/08/18 15:40:49.081 5:17.830 Aggregator:0xb3e6bb90 Media RTP data size cannot be changed to 10240, fixed at 2048 2009/08/18 15:40:49.082 5:17.831 Aggregator:0xb3e6bb90 OpalCon Source stream of connection Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] uses patch Patch OpalRTPMediaStream-Source-theora -> OpalVideoMediaStream-Sink-YUV420P 2009/08/18 15:40:49.082 5:17.831 Aggregator:0xb3e6bb90 Call GetOtherPartyConnection Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:49.082 5:17.831 Aggregator:0xb3e6bb90 Call OpenSourceMediaStreams opening video session 2 on Call[u5f68d7891]-EP[l70f490032] 2009/08/18 15:40:49.083 5:17.832 Aggregator:0xb3e6bb90 MediaFormat Removing codecs PCM-16-48kHz,PCM-16-32kHz,PCM-16-16kHz,PCM-16,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,YUV420P,RFC4175_YCbCr-4:2:0,RGB32,RGB24,RFC4175_RGB,SIP-IM,T.140,H.224/H323AnnexQ,H.224/HDLCTunneling,Linear-16-Stereo-48kHz 2009/08/18 15:40:49.084 5:17.833 Aggregator:0xb3e6bb90 Call GetMediaFormats for Call[u5f68d7891]-EP[l70f490032] theora H.261 H.261-CIF H.261-QCIF SpeexIETFWide-20.6k SpeexWB SpeexWide-20.6k G.722-64k T.38 UserInput/RFC2833 NamedSignalEvent 2009/08/18 15:40:49.084 5:17.833 Aggregator:0xb3e6bb90 MediaFormat Merging theora into theora 2009/08/18 15:40:49.085 5:17.834 Aggregator:0xb3e6bb90 MediaFormat Merging theora into YUV420P 2009/08/18 15:40:49.085 5:17.834 Aggregator:0xb3e6bb90 MediaFormat Changed media option "Bandwidth-TIAS" from 583925760 to 768000 2009/08/18 15:40:49.085 5:17.834 Aggregator:0xb3e6bb90 MediaFormat Changed media option "Max Rx Frame Height" from 1088 to 720 2009/08/18 15:40:49.085 5:17.834 Aggregator:0xb3e6bb90 MediaFormat Changed media option "Max Rx Frame Width" from 1920 to 1280 2009/08/18 15:40:49.085 5:17.834 Aggregator:0xb3e6bb90 MediaFormat Merging YUV420P into theora 2009/08/18 15:40:49.085 5:17.834 Aggregator:0xb3e6bb90 Call Selected media formats YUV420P -> theora 2009/08/18 15:40:49.086 5:17.835 Aggregator:0xb3e6bb90 PVidDev SetColourFormatConverter success for native YUV420P 2009/08/18 15:40:49.086 5:17.835 Aggregator:0xb3e6bb90 PVidDev SetFrameSize to 640x480 2009/08/18 15:40:49.086 5:17.835 Aggregator:0xb3e6bb90 PVidDev SetColourFormatConverter success for native YUV420P 2009/08/18 15:40:49.086 5:17.835 Aggregator:0xb3e6bb90 PVidDev SetFrameSize to 640x480 2009/08/18 15:40:49.086 5:17.835 Aggregator:0xb3e6bb90 PVidDev SetColourFormatConverter success for native YUV420P 2009/08/18 15:40:49.086 5:17.835 Aggregator:0xb3e6bb90 VidInputCore Setting new stream config: 640x480/25 2009/08/18 15:40:49.086 5:17.835 Aggregator:0xb3e6bb90 VidInputCore Starting stream 640x480/25 2009/08/18 15:40:49.086 5:17.835 Aggregator:0xb3e6bb90 VidInputCore Opening device with 640x480/25 2009/08/18 15:40:49.087 5:17.836 Aggregator:0xb3e6bb90 GMVideoInputManager_ptlib Opening Device Creative WebCam NX Ultra (PTLIB/V4L2) 2009/08/18 15:40:49.087 5:17.836 Aggregator:0xb3e6bb90 GMVideoInputManager_ptlib Opening Device with 640x480/25 2009/08/18 15:40:49.087 5:17.836 Aggregator:0xb3e6bb90 Detecting V4L2 devices 2009/08/18 15:40:49.087 5:17.836 Aggregator:0xb3e6bb90 PV4L2Plugin detected device metadata at /sys/class/video4linux/ 2009/08/18 15:40:49.139 5:17.888 Aggregator:0xb3e6bb90 PVidInDev Open() videoFd:-1 2009/08/18 15:40:49.139 5:17.888 Aggregator:0xb3e6bb90 PVidInDev Close() videoFd:-1 started:0 2009/08/18 15:40:49.139 5:17.888 Aggregator:0xb3e6bb90 Detecting V4L2 devices 2009/08/18 15:40:49.139 5:17.888 Aggregator:0xb3e6bb90 PV4L2Plugin detected device metadata at /sys/class/video4linux/ 2009/08/18 15:40:49.189 5:17.938 Aggregator:0xb3e6bb90 PVidInDev Open() devName:/dev/video0 videoFd:-1 2009/08/18 15:40:49.190 5:17.939 Aggregator:0xb3e6bb90 PVidInDev G_PARM failed (preserving frame rate may not work) : Argumento inválido 2009/08/18 15:40:49.190 5:17.939 Aggregator:0xb3e6bb90 PVidInDev unable to reset frame rate. 2009/08/18 15:40:49.190 5:17.939 Aggregator:0xb3e6bb90 PVidDev SetColourFormatConverter success for native YUV420P 2009/08/18 15:40:49.190 5:17.939 Aggregator:0xb3e6bb90 PVidDev SetFrameSize to 640x480 2009/08/18 15:40:49.190 5:17.939 Aggregator:0xb3e6bb90 PVidInDev G_PARM failed (preserving frame rate may not work) : Argumento inválido 2009/08/18 15:40:49.190 5:17.939 Aggregator:0xb3e6bb90 PVidInDev unable to reset frame rate. 2009/08/18 15:40:49.200 5:17.949 Aggregator:0xb3e6bb90 PVidDev SetColourFormatConverter success for native YUV420P 2009/08/18 15:40:49.200 5:17.949 Aggregator:0xb3e6bb90 Media Set data size from 1400 to 608272 2009/08/18 15:40:49.200 5:17.949 Aggregator:0xb3e6bb90 OpalMan OnOpenMediaStream Call[u5f68d7891]-EP[l70f490032],OpalVideoMediaStream-Source-YUV420P 2009/08/18 15:40:49.200 5:17.949 Aggregator:0xb3e6bb90 OpalCon Opened source stream u5f68d7891_2 with format YUV420P 2009/08/18 15:40:49.201 5:17.950 Aggregator:0xb3e6bb90 Call IsMediaBypassPossible Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] session 2 2009/08/18 15:40:49.201 5:17.950 Aggregator:0xb3e6bb90 OpalMan IsMediaBypassPossible: session 2 2009/08/18 15:40:49.201 5:17.950 Aggregator:0xb3e6bb90 OpalCon IsMediaBypassPossible: default returns false 2009/08/18 15:40:49.201 5:17.950 Aggregator:0xb3e6bb90 RTP Found existing media session 2 2009/08/18 15:40:49.201 5:17.950 Aggregator:0xb3e6bb90 OpalMan OnOpenMediaStream Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae],OpalRTPMediaStream-Sink-theora 2009/08/18 15:40:49.201 5:17.950 Aggregator:0xb3e6bb90 OpalCon Opened sink stream u5f68d7891_2 with format theora 2009/08/18 15:40:49.202 5:17.951 Aggregator:0xb3e6bb90 RateController New paramaters: bitrate=1024000, window=500, frame time=3000(rate=30), max skipped frames=1 2009/08/18 15:40:49.202 5:17.951 Aggregator:0xb3e6bb90 Patch Created Sink: format=theora 2009/08/18 15:40:49.209 5:17.958 Aggregator:0xb3e6bb90 OpalPlugin Setting encoder options: Format Name = theora Media Type = video Payload Type = [pt=119] Encoding Name = theora Bandwidth-TIAS (R/W) = 768000 UnsignedInt CAP Delivery (R/W) = "in_band" FMTP name: delivery-method (in_band) String CAP Height (R/W) = 576 FMTP name: height (15) UnsignedInt CAP Sampling (R/W) = "YCbCr-4:2:0" FMTP name: sampling (YCbCr-4:2:0) String CAP Width (R/W) = 704 FMTP name: width (15) UnsignedInt Clock Rate (R/O) = 90000 UnsignedInt Frame Height (R/W) = 480 UnsignedInt Frame Time (R/W) = 3000 UnsignedInt Frame Width (R/W) = 640 UnsignedInt Max Bit Rate (R/W) = 4096000 UnsignedInt Max Frame Size (R/O) = 1400 UnsignedInt Max Rx Frame Height (R/O) = 720 UnsignedInt Max Rx Frame Width (R/O) = 1280 UnsignedInt Min Rx Frame Height (R/O) = 120 UnsignedInt Min Rx Frame Width (R/O) = 160 UnsignedInt Rate Control Enable (R/W) = 1 Boolean Rate Control Max Frames Skip (R/W) = 1 UnsignedInt Rate Control Window Size (R/W) = 500 UnsignedInt Rate Controller Bit Rate Scaler (R/W) = 100 UnsignedInt RawFMTP (R/W) = "delivery-method=\"in_band\";height=576;sampling=\"YCbCr-4:2:0\";width=704" String Target Bit Rate (R/W) = 1024000 UnsignedInt Temporal Spatial Trade Off (R/O) = 31 UnsignedInt Tx Key Frame Period (R/W) = 125 UnsignedInt theora_plugin.cxx(688) THEORA Encoder Option CAP Width = 704 theora_plugin.cxx(688) THEORA Encoder Option CAP Delivery = 0 theora_plugin.cxx(688) THEORA Encoder Option Frame Time = 3000 theora_plugin.cxx(688) THEORA Encoder Option Rate Control Enable = 1 theora_plugin.cxx(688) THEORA Encoder Option Rate Control Max Frames Skip = 1 theora_plugin.cxx(688) THEORA Encoder Option Rate Control Window Size = 500 theora_plugin.cxx(688) THEORA Encoder Option Rate Controller Bit Rate Scaler = 100 theora_plugin.cxx(688) THEORA Encoder Option Frame Height = 480 theora_plugin.cxx(688) THEORA Encoder Option Temporal Spatial Trade Off = 31 theora_plugin.cxx(688) THEORA Encoder Option Max Bit Rate = 4096000 theora_plugin.cxx(688) THEORA Encoder Option CAP Height = 576 theora_plugin.cxx(688) THEORA Encoder Option CAP Sampling = 0 theora_plugin.cxx(688) THEORA Encoder Option Clock Rate = 90000 theora_plugin.cxx(688) THEORA Encoder Option RawFMTP = 0 theora_plugin.cxx(688) THEORA Encoder Option Max Rx Frame Height = 720 theora_plugin.cxx(688) THEORA Encoder Option Max Rx Frame Width = 1280 theora_plugin.cxx(688) THEORA Encoder Option Min Rx Frame Height = 120 theora_plugin.cxx(688) THEORA Encoder Option Min Rx Frame Width = 160 theora_plugin.cxx(688) THEORA Encoder Option Max Frame Size = 1400 theora_plugin.cxx(688) THEORA Encoder Option Target Bit Rate = 1024000 theora_plugin.cxx(688) THEORA Encoder Option Frame Width = 640 theora_plugin.cxx(688) THEORA Encoder Option Bandwidth-TIAS = 768000 theora_plugin.cxx(688) THEORA Encoder Option Tx Key Frame Period = 125 2009/08/18 15:40:49.220 5:17.969 Aggregator:0xb3e6bb90 Patch Created primary codec YUV420P->theora with ID u5f68d7891_2 2009/08/18 15:40:49.220 5:17.969 Aggregator:0xb3e6bb90 Media RTP data size cannot be changed to 10240, fixed at 528 2009/08/18 15:40:49.221 5:17.970 Aggregator:0xb3e6bb90 Patch Added media stream sink OpalRTPMediaStream-Sink-theora using transcoder YUV420P->theora, data size=528 2009/08/18 15:40:49.221 5:17.970 Aggregator:0xb3e6bb90 Media Set data size from 608272 to 1382416 2009/08/18 15:40:49.221 5:17.970 Aggregator:0xb3e6bb90 OpalCon Sink stream of connection Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] uses patch Patch OpalVideoMediaStream-Source-YUV420P -> OpalRTPMediaStream-Sink-theora 2009/08/18 15:40:49.221 5:17.970 Aggregator:0xb3e6bb90 OpalCon SetPhase from AlertingPhase to ConnectedPhase for Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:49.221 5:17.970 Aggregator:0xb3e6bb90 OpalCon OnConnected for Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:49.221 5:17.971 Aggregator:0xb3e6bb90 OpalMan OnConnected Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:49.222 5:17.971 Aggregator:0xb3e6bb90 Call OnConnected Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:49.222 5:17.971 Aggregator:0xb3e6bb90 OpalCon SetConnected for Call[u5f68d7891]-EP[l70f490032] 2009/08/18 15:40:49.222 5:17.971 Aggregator:0xb3e6bb90 OpalCon SetPhase from AlertingPhase to ConnectedPhase for Call[u5f68d7891]-EP[l70f490032] 2009/08/18 15:40:49.222 5:17.971 Aggregator:0xb3e6bb90 OpalCon SetPhase from ConnectedPhase to EstablishedPhase for Call[u5f68d7891]-EP[l70f490032] 2009/08/18 15:40:49.222 5:17.971 Aggregator:0xb3e6bb90 OpalCon OnEstablished Call[u5f68d7891]-EP[l70f490032] 2009/08/18 15:40:49.222 5:17.971 Aggregator:0xb3e6bb90 PWLib File handle high water mark set: 73 Thread unblock pipe 2009/08/18 15:40:49.226 5:17.975 Aggregator:0xb3e6bb90 PWLib Thread high water mark set: 11 2009/08/18 15:40:49.226 5:17.975 Aggregator:0xb3e6bb90 Media Starting thread Media Patch 2009/08/18 15:40:49.226 5:17.975 Aggregator:0xb3e6bb90 PWLib File handle high water mark set: 75 Thread unblock pipe 2009/08/18 15:40:49.234 5:17.983 Aggregator:0xb3e6bb90 PWLib Thread high water mark set: 12 2009/08/18 15:40:49.233 5:17.982 Media Patch:0xa1e7bb90 Patch Thread started for Patch OpalRTPMediaStream-Source-SpeexWB -> OpalAudioMediaStream-Sink-PCM-16-16kHz 2009/08/18 15:40:49.234 5:17.983 Media Patch:0xa1e3ab90 Patch Thread started for Patch OpalAudioMediaStream-Source-PCM-16-16kHz -> OpalRTPMediaStream-Sink-SpeexWB 2009/08/18 15:40:49.234 5:17.983 Aggregator:0xb3e6bb90 Media Starting thread Media Patch:0xa1e3ab90 2009/08/18 15:40:49.234 5:17.983 Media Patch:0xa1e7bb90 InfLID Setting jitter buffer time from 320 to 8000 2009/08/18 15:40:49.234 5:17.983 Aggregator:0xb3e6bb90 PWLib File handle high water mark set: 77 Thread unblock pipe 2009/08/18 15:40:49.243 5:17.992 Media Patch:0xa1e3ab90 Alsa Buffer time is 50000 2009/08/18 15:40:49.243 5:17.992 Media Patch:0xa1e3ab90 Alsa Period time is 10000 2009/08/18 15:40:49.243 5:17.992 Media Patch:0xa1e7bb90 RTP Opal jitter buffer created: size=101 delay=20-500 ms /320 (20ms) obj=0xb559a628 2009/08/18 15:40:49.244 5:17.993 Media Patch:0xa1e7bb90 PWLib File handle high water mark set: 79 Thread unblock pipe 2009/08/18 15:40:49.243 5:17.992 Aggregator:0xb3e6bb90 PWLib Thread high water mark set: 13 2009/08/18 15:40:49.254 5:18.003 Media Patch:0xa1df9b90 Patch Thread started for Patch OpalRTPMediaStream-Source-theora -> OpalVideoMediaStream-Sink-YUV420P 2009/08/18 15:40:49.254 5:18.003 Media Patch:0xa1df9b90 RTP Session 2, first receive data: ver=2 pt=[pt=119] psz=1400 m=0 x=0 seq=49247 ts=0 src=ac1b1c93 ccnt=0 2009/08/18 15:40:49.255 5:18.004 Aggregator:0xb3e6bb90 Media Starting thread Media Patch:0xa1df9b90 2009/08/18 15:40:49.255 5:18.004 Aggregator:0xb3e6bb90 PWLib File handle high water mark set: 81 Thread unblock pipe 2009/08/18 15:40:49.264 5:18.013 Media Patch:0xa1e7bb90 PWLib Thread high water mark set: 14 2009/08/18 15:40:49.264 5:18.013 Aggregator:0xb3e6bb90 PWLib Thread high water mark set: 15 2009/08/18 15:40:49.264 5:18.013 Media Patch:0xa1ce2b90 Patch Thread started for Patch OpalVideoMediaStream-Source-YUV420P -> OpalRTPMediaStream-Sink-theora 2009/08/18 15:40:49.264 5:18.013 Aggregator:0xb3e6bb90 Media Starting thread Media Patch:0xa1ce2b90 2009/08/18 15:40:49.264 5:18.013 Aggregator:0xb3e6bb90 OpalCon Media stream threads started. 2009/08/18 15:40:49.264 5:18.013 Aggregator:0xb3e6bb90 OpalMan OnEstablished Call[u5f68d7891]-EP[l70f490032] 2009/08/18 15:40:49.265 5:18.014 Aggregator:0xb3e6bb90 Call OnEstablished Call[u5f68d7891]-EP[l70f490032] 2009/08/18 15:40:49.265 5:18.014 Aggregator:0xb3e6bb90 OpalCon Media stream threads started. 2009/08/18 15:40:49.265 5:18.014 Aggregator:0xb3e6bb90 OpalCon SetPhase from ConnectedPhase to EstablishedPhase for Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:49.265 5:18.014 Aggregator:0xb3e6bb90 OpalCon OnEstablished Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:49.265 5:18.014 Aggregator:0xb3e6bb90 OpalCon Media stream threads started. 2009/08/18 15:40:49.265 5:18.014 Aggregator:0xb3e6bb90 OpalMan OnEstablished Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:49.266 5:18.015 Aggregator:0xb3e6bb90 RTP Found existing RTP session 1 2009/08/18 15:40:49.266 5:18.015 Aggregator:0xb3e6bb90 RTP Found existing RTP session 2 2009/08/18 15:40:49.266 5:18.015 Aggregator:0xb3e6bb90 Call OnEstablished Call[u5f68d7891]-EP[fc68d04d-948a-de11-909e-00137202cbae] 2009/08/18 15:40:49.266 5:18.015 Aggregator:0xb3e6bb90 OpalCon Media stream threads started. 2009/08/18 15:40:49.267 5:18.016 Media Patch:0xa1e3ab90 RTP Session 1, first sent data: ver=2 pt=[pt=116] psz=52 m=1 x=0 seq=974 ts=0 src=d24c2791 ccnt=0 2009/08/18 15:40:49.267 5:18.016 Media Patch:0xa1df9b90 PVidDev SetFrameSize to 320x240 2009/08/18 15:40:49.267 5:18.016 RTP Jitter:0xa1db8b90 RTP Jitter RTP receive thread started: 0xb559a628 2009/08/18 15:40:49.268 5:18.017 RTP Jitter:0xa1db8b90 RTP_UDP Session 1, flushed 17 RTP data packets on startup 2009/08/18 15:40:49.270 5:18.019 Media Patch:0xa1df9b90 GMVideoOutputManager Skipped earlier remote frame 2009/08/18 15:40:49.271 5:18.020 Media Patch:0xa1df9b90 GMVideoOutputManager Skipped earlier remote frame 2009/08/18 15:40:49.272 5:18.021 Media Patch:0xa1df9b90 GMVideoOutputManager Skipped earlier remote frame 2009/08/18 15:40:49.272 5:18.021 RTP Jitter:0xa1db8b90 RTP Session 1, first receive data: ver=2 pt=[pt=116] psz=52 m=0 x=0 seq=48646 ts=5440 src=e71272e8 ccnt=0 2009/08/18 15:40:49.272 5:18.021 Media Patch:0xa1df9b90 GMVideoOutputManager Skipped earlier remote frame 2009/08/18 15:40:49.273 5:18.022 Media Patch:0xa1df9b90 GMVideoOutputManager Skipped earlier remote frame 2009/08/18 15:40:49.274 5:18.023 Media Patch:0xa1df9b90 GMVideoOutputManager Skipped earlier remote frame 2009/08/18 15:40:49.275 5:18.024 Media Patch:0xa1df9b90 GMVideoOutputManager Skipped earlier remote frame 2009/08/18 15:40:49.276 5:18.025 Media Patch:0xa1df9b90 GMVideoOutputManager Skipped earlier remote frame 2009/08/18 15:40:49.277 5:18.026 Media Patch:0xa1df9b90 GMVideoOutputManager Skipped earlier remote frame 2009/08/18 15:40:49.278 5:18.027 GMVideoOut...0xb56c7b90 GMVideoOutputManager_X Opening VO_MODE_REMOTE display with image of 320x240 2009/08/18 15:40:49.278 5:18.027 GMVideoOut...0xb56c7b90 XVideo Initializing XV window with 320x240 at -1,-1 2009/08/18 15:40:49.278 5:18.027 Media Patch:0xa1e7bb90 Alsa Buffer time is 50000 2009/08/18 15:40:49.279 5:18.028 Media Patch:0xa1e7bb90 Alsa Period time is 10000 2009/08/18 15:40:49.386 5:18.135 AEScheduler Removing Event incoming_call_sound from queue 2009/08/18 15:40:49.386 5:18.135 AEScheduler Removing Event ring_tone_sound from queue 2009/08/18 15:40:49.403 5:18.152 GMVideoOut...0xb56c7b90 XVideo XvQueryExtension: Version: 2 Release: 2 Request Base: 132 Event Base: 72 Error Base: 140 2009/08/18 15:40:49.423 5:18.172 AudioEvent...0xb5708b90 AEScheduler Checking pending list with 0 elements 2009/08/18 15:40:49.506 5:18.255 GMVideoOut...0xb56c7b90 XVideo #0, Adaptor: Intel(R) Textured Video, type: input | image | , ports: 16, first port: 78 2009/08/18 15:40:49.696 5:18.445 GMVideoOut...0xb56c7b90 XVideo Encoding List for Port 78: id=0 name=XV_IMAGE size=1920x1088 numerator=1 denominator=1 2009/08/18 15:40:49.696 5:18.445 GMVideoOut...0xb56c7b90 XVideo Attribute List for Port 78: 2009/08/18 15:40:49.697 5:18.446 GMVideoOut...0xb56c7b90  name:       XV_BRIGHTNESS 2009/08/18 15:40:49.697 5:18.446 GMVideoOut...0xb56c7b90  flags:     get set 2009/08/18 15:40:49.697 5:18.446 GMVideoOut...0xb56c7b90  min_color:  -128 2009/08/18 15:40:49.697 5:18.446 GMVideoOut...0xb56c7b90  max_color:  127 2009/08/18 15:40:49.697 5:18.446 GMVideoOut...0xb56c7b90  name:       XV_CONTRAST 2009/08/18 15:40:49.697 5:18.446 GMVideoOut...0xb56c7b90  flags:     get set 2009/08/18 15:40:49.697 5:18.446 GMVideoOut...0xb56c7b90  min_color:  0 2009/08/18 15:40:49.697 5:18.446 GMVideoOut...0xb56c7b90  max_color:  255 2009/08/18 15:40:49.697 5:18.446 GMVideoOut...0xb56c7b90 XVideo Image format list for Port 78: 2009/08/18 15:40:49.697 5:18.446 GMVideoOut...0xb56c7b90 0x32595559 (YUY2) packed, order: YUYV 2009/08/18 15:40:49.697 5:18.446 GMVideoOut...0xb56c7b90 0x32315659 (YV12) planar, order: YVU 2009/08/18 15:40:49.697 5:18.446 GMVideoOut...0xb56c7b90 0x30323449 (I420) planar, order: YUV 2009/08/18 15:40:49.697 5:18.446 GMVideoOut...0xb56c7b90 0x59565955 (UYVY) packed, order: UYVY 2009/08/18 15:40:49.697 5:18.446 GMVideoOut...0xb56c7b90 0x434d5658 (XVMC) planar, order: YVU 2009/08/18 15:40:49.723 5:18.472 GMVideoOut...0xb56c7b90 XVideo Grabbed Port: 78 2009/08/18 15:40:49.723 5:18.472 GMVideoOut...0xb56c7b90 XVideo Using XVideo port: 78 2009/08/18 15:40:49.744 5:18.493 GMVideoOut...0xb56c7b90 XVideo Found visual with colordepth of 24bits per pixel 2009/08/18 15:40:49.744 5:18.493 GMVideoOut...0xb56c7b90 X11 Created Window with ID 77594626 2009/08/18 15:40:49.745 5:18.494 GMVideoOut...0xb56c7b90 XVideo Colorkey method: NONE 2009/08/18 15:40:49.745 5:18.494 GMVideoOut...0xb56c7b90 XVideo Vertical sync not supported 2009/08/18 15:40:49.746 5:18.495 GMVideoOut...0xb56c7b90 XVideo XQueryShmExtension success 2009/08/18 15:40:49.755 5:18.504 GMVideoOut...0xb56c7b90 XVideo Created XvImage (320x240, data size: 115200, num_planes: 3 2009/08/18 15:40:49.755 5:18.504 GMVideoOut...0xb56c7b90 XVideo Plane 0: pitch=320, offset=0 2009/08/18 15:40:49.755 5:18.504 GMVideoOut...0xb56c7b90 XVideo Plane 1: pitch=160, offset=76800 2009/08/18 15:40:49.755 5:18.504 GMVideoOut...0xb56c7b90 XVideo Plane 2: pitch=160, offset=96000 2009/08/18 15:40:49.775 5:18.524 GMVideoOut...0xb56c7b90 XVideo Using SHM extension 2009/08/18 15:40:49.776 5:18.525 GMVideoOut...0xb56c7b90 X11 Unknown wm type... 2009/08/18 15:40:49.776 5:18.525 GMVideoOut...0xb56c7b90 GMVideoOutputManager_X VO_MODE_REMOTE: Successfully opened XV Window 2009/08/18 15:40:49.776 5:18.525 GMVideoOut...0xb56c7b90 X11 Unknown X Event 19 received 2009/08/18 15:40:49.777 5:18.526 Media Patch:0xa1df9b90 GMVideoOutputManager Skipped earlier remote frame 2009/08/18 15:40:49.778 5:18.527 Media Patch:0xa1df9b90 GMVideoOutputManager Skipped earlier remote frame 2009/08/18 15:40:49.779 5:18.528 Media Patch:0xa1df9b90 GMVideoOutputManager Skipped earlier remote frame 2009/08/18 15:40:49.780 5:18.529 Media Patch:0xa1df9b90 GMVideoOutputManager Skipped earlier remote frame 2009/08/18 15:40:49.781 5:18.530 Media Patch:0xa1df9b90 GMVideoOutputManager Skipped earlier remote frame 2009/08/18 15:40:49.782 5:18.531 Media Patch:0xa1df9b90 GMVideoOutputManager Skipped earlier remote frame 2009/08/18 15:40:49.782 5:18.531 Media Patch:0xa1df9b90 GMVideoOutputManager Skipped earlier remote frame 2009/08/18 15:40:49.783 5:18.532 Media Patch:0xa1df9b90 GMVideoOutputManager Skipped earlier remote frame 2009/08/18 15:40:49.784 5:18.533 Media Patch:0xa1df9b90 GMVideoOutputManager Skipped earlier remote frame 2009/08/18 15:40:49.785 5:18.534 Media Patch:0xa1df9b90 GMVideoOutputManager Skipped earlier remote frame 2009/08/18 15:40:49.786 5:18.535 Media Patch:0xa1df9b90 GMVideoOutputManager Skipped earlier remote frame 2009/08/18 15:40:49.786 5:18.535 Media Patch:0xa1df9b90 GMVideoOutputManager Skipped earlier remote frame 2009/08/18 15:40:49.788 5:18.538 Media Patch:0xa1ce2b90 RateController history too small for bit rate control 2009/08/18 15:40:49.815 5:18.564 Media Patch:0xa1df9b90 GMVideoOutputManager Skipped earlier remote frame 2009/08/18 15:40:49.828 5:18.577 Media Patch:0xa1ce2b90 OpalPlugin Sending I-Frame in response to videoFastUpdate 2009/08/18 15:40:49.828 5:18.577 Media Patch:0xa1ce2b90 RTP Session 2, first sent data: ver=2 pt=[pt=119] psz=1400 m=0 x=0 seq=3753 ts=0 src=9f7c5da4 ccnt=0 2009/08/18 15:40:49.874 5:18.623 GMVideoOut...0xb56c7b90 X11 Unmapping and destroying Window with ID 77594626 2009/08/18 15:40:49.874 5:18.623 GMVideoOut...0xb56c7b90 GMVideoOutputManager_X Opening VO_MODE_REMOTE display with image of 320x240 2009/08/18 15:40:49.874 5:18.623 GMVideoOut...0xb56c7b90 XVideo Initializing XV window with 320x240 at 59,67 2009/08/18 15:40:49.875 5:18.624 GMVideoOut...0xb56c7b90 XVideo XvQueryExtension: Version: 2 Release: 2 Request Base: 132 Event Base: 72 Error Base: 140 2009/08/18 15:40:49.876 5:18.625 GMVideoOut...0xb56c7b90 XVideo #0, Adaptor: Intel(R) Textured Video, type: input | image | , ports: 16, first port: 78 2009/08/18 15:40:49.876 5:18.625 GMVideoOut...0xb56c7b90 XVideo Encoding List for Port 78: id=0 name=XV_IMAGE size=1920x1088 numerator=1 denominator=1 2009/08/18 15:40:49.877 5:18.626 GMVideoOut...0xb56c7b90 XVideo Attribute List for Port 78: 2009/08/18 15:40:49.877 5:18.626 GMVideoOut...0xb56c7b90  name:       XV_BRIGHTNESS 2009/08/18 15:40:49.877 5:18.626 GMVideoOut...0xb56c7b90  flags:     get set 2009/08/18 15:40:49.877 5:18.626 GMVideoOut...0xb56c7b90  min_color:  -128 2009/08/18 15:40:49.877 5:18.626 GMVideoOut...0xb56c7b90  max_color:  127 2009/08/18 15:40:49.877 5:18.626 GMVideoOut...0xb56c7b90  name:       XV_CONTRAST 2009/08/18 15:40:49.877 5:18.626 GMVideoOut...0xb56c7b90  flags:     get set 2009/08/18 15:40:49.877 5:18.626 GMVideoOut...0xb56c7b90  min_color:  0 2009/08/18 15:40:49.877 5:18.626 GMVideoOut...0xb56c7b90  max_color:  255 2009/08/18 15:40:49.877 5:18.626 GMVideoOut...0xb56c7b90 XVideo Image format list for Port 78: 2009/08/18 15:40:49.877 5:18.626 GMVideoOut...0xb56c7b90 0x32595559 (YUY2) packed, order: YUYV 2009/08/18 15:40:49.877 5:18.626 GMVideoOut...0xb56c7b90 0x32315659 (YV12) planar, order: YVU 2009/08/18 15:40:49.877 5:18.626 GMVideoOut...0xb56c7b90 0x30323449 (I420) planar, order: YUV 2009/08/18 15:40:49.877 5:18.626 GMVideoOut...0xb56c7b90 0x59565955 (UYVY) packed, order: UYVY 2009/08/18 15:40:49.878 5:18.627 GMVideoOut...0xb56c7b90 0x434d5658 (XVMC) planar, order: YVU 2009/08/18 15:40:49.878 5:18.627 GMVideoOut...0xb56c7b90 XVideo Grabbed Port: 78 2009/08/18 15:40:49.878 5:18.627 GMVideoOut...0xb56c7b90 XVideo Using XVideo port: 78 2009/08/18 15:40:49.878 5:18.627 GMVideoOut...0xb56c7b90 XVideo Found visual with colordepth of 24bits per pixel 2009/08/18 15:40:49.878 5:18.627 GMVideoOut...0xb56c7b90 X11 Created Window with ID 77594629 2009/08/18 15:40:49.879 5:18.628 GMVideoOut...0xb56c7b90 XVideo Colorkey method: NONE 2009/08/18 15:40:49.879 5:18.628 GMVideoOut...0xb56c7b90 XVideo Vertical sync not supported 2009/08/18 15:40:49.880 5:18.629 GMVideoOut...0xb56c7b90 XVideo XQueryShmExtension success 2009/08/18 15:40:49.880 5:18.629 GMVideoOut...0xb56c7b90 XVideo Created XvImage (320x240, data size: 115200, num_planes: 3 2009/08/18 15:40:49.880 5:18.629 GMVideoOut...0xb56c7b90 XVideo Plane 0: pitch=320, offset=0 2009/08/18 15:40:49.880 5:18.629 GMVideoOut...0xb56c7b90 XVideo Plane 1: pitch=160, offset=76800 2009/08/18 15:40:49.880 5:18.629 GMVideoOut...0xb56c7b90 XVideo Plane 2: pitch=160, offset=96000 2009/08/18 15:40:49.881 5:18.630 GMVideoOut...0xb56c7b90 XVideo Using SHM extension 2009/08/18 15:40:49.881 5:18.630 GMVideoOut...0xb56c7b90 X11 Unknown wm type... 2009/08/18 15:40:49.881 5:18.630 GMVideoOut...0xb56c7b90 GMVideoOutputManager_X VO_MODE_REMOTE: Successfully opened XV Window 2009/08/18 15:40:49.881 5:18.630 GMVideoOut...0xb56c7b90 X11 Unknown X Event 19 received 2009/08/18 15:40:50.137 5:18.886 Media Patch:0xa1ce2b90 RateController history too small for bit rate control 2009/08/18 15:40:50.266 5:19.015 Housekeeper:0xb54ffb90 SIP Set state Terminated_Success for transaction 1 INVITE 2009/08/18 15:40:50.267 5:19.016 Media Patch:0xa1e3ab90 RTP Session 1, transmit statistics: packets=51 octets=2652 avgTime=20 maxTime=34 minTime=6 2009/08/18 15:40:50.270 5:19.019 RTP Jitter:0xa1db8b90 RTP Session 1, receive statistics: packets=51 octets=2652 lost=0 tooLate=0 order=0 avgTime=19 maxTime=25 minTime=15 jitter=0 maxJitter=2 2009/08/18 15:40:50.330 5:19.079 Media Patch:0xa1e7bb90 RTP Jitter buffer target size decreased to 320 (20ms) 2009/08/18 15:40:50.586 5:19.335 Media Patch:0xa1ce2b90 RateController history too small for bit rate control 2009/08/18 15:40:50.854 5:19.603 Media Patch:0xa1df9b90 RTP Session 2, receive statistics: packets=53 octets=35486 lost=0 tooLate=0 order=0 avgTime=31 maxTime=483 minTime=0 jitter=8 maxJitter=58 2009/08/18 15:40:51.033 5:19.782 Media Patch:0xa1ce2b90 RateController Report:Total frames:in=4,out=3,dropped=1(25%) 2009/08/18 15:40:51.034 5:19.783 Media Patch:0xa1ce2b90 RateController Report:in=2 fps,out=1 fps,target=30 fps,history=1245ms 3 frames 2009/08/18 15:40:51.034 5:19.783 Media Patch:0xa1ce2b90 RateController history too small for bit rate control 2009/08/18 15:40:51.091 5:19.840 Media Patch:0xa1ce2b90 RTP Session 2, transmit statistics: packets=51 octets=69150 avgTime=25 maxTime=453 minTime=0 2009/08/18 15:40:51.270 5:20.019 RTP Jitter:0xa1db8b90 RTP Session 1, receive statistics: packets=101 octets=5252 lost=0 tooLate=0 order=0 avgTime=20 maxTime=29 minTime=12 jitter=1 maxJitter=2 2009/08/18 15:40:51.277 5:20.026 Media Patch:0xa1e3ab90 RTP Session 1, transmit statistics: packets=101 octets=5252 avgTime=20 maxTime=35 minTime=5 2009/08/18 15:40:51.481 5:20.230 Media Patch:0xa1ce2b90 RateController history too small for bit rate control 2009/08/18 15:40:51.929 5:20.678 Media Patch:0xa1ce2b90 RateController history too small for bit rate control 2009/08/18 15:40:52.270 5:21.019 RTP Jitter:0xa1db8b90 RTP Session 1, receive statistics: packets=151 octets=7852 lost=0 tooLate=0 order=0 avgTime=20 maxTime=23 minTime=17 jitter=0 maxJitter=2 2009/08/18 15:40:52.276 5:21.025 Media Patch:0xa1e3ab90 RTP Session 1, transmit statistics: packets=151 octets=7852 avgTime=19 maxTime=31 minTime=14 2009/08/18 15:40:52.377 5:21.126 Media Patch:0xa1ce2b90 RateController Report:Total frames:in=7,out=6,dropped=1(14%) 2009/08/18 15:40:52.377 5:21.126 Media Patch:0xa1ce2b90 RateController Report:in=2 fps,out=1 fps,target=30 fps,history=2589ms 6 frames 2009/08/18 15:40:52.377 5:21.126 Media Patch:0xa1ce2b90 RateController history too small for bit rate control 2009/08/18 15:40:52.854 5:21.603 Media Patch:0xa1df9b90 RTP Session 2, receive statistics: packets=103 octets=66958 lost=0 tooLate=0 order=0 avgTime=40 maxTime=41 minTime=39 jitter=0 maxJitter=58 2009/08/18 15:40:52.857 5:21.606 Media Patch:0xa1ce2b90 RateController history too small for bit rate control 2009/08/18 15:40:52.879 5:21.628 Media Patch:0xa1e7bb90 RTP Jitter buffer length exceeded 2009/08/18 15:40:52.879 5:21.628 Media Patch:0xa1e7bb90 RTP Jitter buffer size increased to 640 (40ms) 2009/08/18 15:40:53.270 5:22.019 RTP Jitter:0xa1db8b90 RTP Session 1, receive statistics: packets=201 octets=10452 lost=0 tooLate=0 order=0 avgTime=20 maxTime=22 minTime=18 jitter=0 maxJitter=2 2009/08/18 15:40:53.276 5:22.025 Media Patch:0xa1e3ab90 RTP Session 1, transmit statistics: packets=201 octets=10452 avgTime=20 maxTime=47 minTime=1 2009/08/18 15:40:53.305 5:22.054 Media Patch:0xa1ce2b90 RateController history too small for bit rate control 2009/08/18 15:40:53.312 5:22.061 Housekeeper:0xb54ffb90 PWLib File handle high water mark set: 82 PUDPSocket 2009/08/18 15:40:53.350 5:22.099 Media Patch:0xa1ce2b90 RTP Session 2, transmit statistics: packets=101 octets=135682 avgTime=45 maxTime=480 minTime=0 2009/08/18 15:40:53.752 5:22.502 Media Patch:0xa1ce2b90 RateController Report:Total frames:in=10,out=9,dropped=1(10%) 2009/08/18 15:40:53.753 5:22.502 Media Patch:0xa1ce2b90 RateController Report:in=2 fps,out=1 fps,target=30 fps,history=3964ms 9 frames 2009/08/18 15:40:53.753 5:22.502 Media Patch:0xa1ce2b90 RateController history too small for bit rate control 2009/08/18 15:40:54.200 5:22.950 Media Patch:0xa1ce2b90 RateController history too small for bit rate control 2009/08/18 15:40:54.270 5:23.019 RTP Jitter:0xa1db8b90 RTP Session 1, receive statistics: packets=251 octets=13052 lost=0 tooLate=0 order=0 avgTime=20 maxTime=27 minTime=13 jitter=0 maxJitter=2 2009/08/18 15:40:54.276 5:23.025 Media Patch:0xa1e3ab90 RTP Session 1, transmit statistics: packets=251 octets=13052 avgTime=20 maxTime=36 minTime=0 2009/08/18 15:40:54.648 5:23.397 Media Patch:0xa1ce2b90 RateController history too small for bit rate control 2009/08/18 15:40:54.814 5:23.563 Media Patch:0xa1df9b90 RTP Session 2, receive statistics: packets=153 octets=100160 lost=0 tooLate=0 order=0 avgTime=39 maxTime=46 minTime=0 jitter=2 maxJitter=58 2009/08/18 15:40:55.097 5:23.846 Media Patch:0xa1ce2b90 RateController Report:Total frames:in=13,out=12,dropped=1(7%) 2009/08/18 15:40:55.097 5:23.847 Media Patch:0xa1ce2b90 RateController Report:in=2 fps,out=2 fps,target=30 fps,history=4960ms 11 frames 2009/08/18 15:40:55.098 5:23.847 Media Patch:0xa1ce2b90 RateController history too small for bit rate control 2009/08/18 15:40:55.270 5:24.019 RTP Jitter:0xa1db8b90 RTP Session 1, receive statistics: packets=301 octets=15652 lost=0 tooLate=0 order=0 avgTime=20 maxTime=26 minTime=14 jitter=1 maxJitter=2 2009/08/18 15:40:55.276 5:24.025 Media Patch:0xa1e3ab90 RTP Session 1, transmit statistics: packets=301 octets=15652 avgTime=20 maxTime=31 minTime=10 2009/08/18 15:40:55.356 5:24.105 Media Patch:0xa1e3ab90 RTP Session 1, SentSenderReport: ssrc=3528206225 ntp=3459609655.1531691270 rtp=0 psent=305 osent=15860 2009/08/18 15:40:55.357 5:24.106 Media Patch:0xa1e3ab90 RTP Session 1, SentReceiverReport: ssrc=3876745960 fraction=0 lost=0 last_seq=0 jitter=10 lsr=0 dlsr=0 2009/08/18 15:40:55.357 5:24.106 Media Patch:0xa1e3ab90 RTP Session 1, sending SDES: marcus.carneiro@inf01abl 2009/08/18 15:40:55.373 5:24.122 Media Patch:0xa1df9b90 RTP Session 2, SentSenderReport: ssrc=2675727780 ntp=3459609655.1603328072 rtp=0 psent=144 osent=192305 2009/08/18 15:40:55.373 5:24.122 Media Patch:0xa1df9b90 RTP Session 2, SentReceiverReport: ssrc=2887457939 fraction=0 lost=0 last_seq=0 jitter=9 lsr=0 dlsr=0 2009/08/18 15:40:55.373 5:24.122 Media Patch:0xa1df9b90 RTP Session 2, sending SDES: marcus.carneiro@inf01abl 2009/08/18 15:40:55.544 5:24.293 Media Patch:0xa1ce2b90 RateController history too small for bit rate control 2009/08/18 15:40:55.608 5:24.357 Media Patch:0xa1ce2b90 RTP Session 2, transmit statistics: packets=151 octets=202105 avgTime=45 maxTime=464 minTime=0 2009/08/18 15:40:55.993 5:24.742 Media Patch:0xa1ce2b90 RateController history too small for bit rate control 2009/08/18 15:40:56.270 5:25.019 RTP Jitter:0xa1db8b90 RTP Session 1, receive statistics: packets=351 octets=18252 lost=0 tooLate=0 order=0 avgTime=20 maxTime=28 minTime=13 jitter=0 maxJitter=2 2009/08/18 15:40:56.276 5:25.025 Media Patch:0xa1e3ab90 RTP Session 1, transmit statistics: packets=351 octets=18252 avgTime=20 maxTime=30 minTime=11 2009/08/18 15:40:56.441 5:25.190 Media Patch:0xa1ce2b90 RateController Report:Total frames:in=16,out=15,dropped=1(6%) 2009/08/18 15:40:56.441 5:25.190 Media Patch:0xa1ce2b90 RateController Report:in=2 fps,out=2 fps,target=30 fps,history=4960ms 11 frames 2009/08/18 15:40:56.441 5:25.190 Media Patch:0xa1ce2b90 RateController history too small for bit rate control 2009/08/18 15:40:56.813 5:25.562 Media Patch:0xa1df9b90 RTP Session 2, receive statistics: packets=203 octets=130879 lost=0 tooLate=0 order=0 avgTime=39 maxTime=41 minTime=38 jitter=0 maxJitter=58 2009/08/18 15:40:56.888 5:25.637 Media Patch:0xa1ce2b90 RateController history too small for bit rate control 2009/08/18 15:40:57.136 5:25.885 RTP Jitter:0xa1db8b90 RTP_UDP Session 1, Data port on remote not ready. 2009/08/18 15:40:57.156 5:25.905 RTP Jitter:0xa1db8b90 RTP_UDP Session 1, Data port on remote not ready. 2009/08/18 15:40:57.176 5:25.925 RTP Jitter:0xa1db8b90 RTP_UDP Session 1, Data port on remote not ready. 2009/08/18 15:40:57.196 5:25.945 RTP Jitter:0xa1db8b90 RTP_UDP Session 1, Data port on remote not ready. 2009/08/18 15:40:57.216 5:25.965 RTP Jitter:0xa1db8b90 RTP_UDP Session 1, Data port on remote not ready. 2009/08/18 15:40:57.236 5:25.985 RTP Jitter:0xa1db8b90 RTP_UDP Session 1, Data port on remote not ready. 2009/08/18 15:40:57.276 5:26.025 Media Patch:0xa1e3ab90 RTP Session 1, transmit statistics: packets=401 octets=20852 avgTime=20 maxTime=31 minTime=11 2009/08/18 15:40:57.368 5:26.117 Media Patch:0xa1ce2b90 RateController history too small for bit rate control 2009/08/18 15:40:57.816 5:26.565 Media Patch:0xa1ce2b90 RateController Report:Total frames:in=19,out=18,dropped=1(5%) 2009/08/18 15:40:57.817 5:26.566 Media Patch:0xa1ce2b90 RateController Report:in=2 fps,out=2 fps,target=30 fps,history=4959ms 11 frames 2009/08/18 15:40:57.817 5:26.566 Media Patch:0xa1ce2b90 RateController history too small for bit rate control 2009/08/18 15:40:58.136 5:26.885 RTP Jitter:0xa1db8b90 RTP_UDP Session 1, Data port on remote not ready. 2009/08/18 15:40:58.264 5:27.013 Media Patch:0xa1ce2b90 RateController history too small for bit rate control 2009/08/18 15:40:58.295 5:27.044 Media Patch:0xa1e3ab90 RTP Session 1, transmit statistics: packets=451 octets=23452 avgTime=20 maxTime=39 minTime=13 2009/08/18 15:40:58.712 5:27.461 Media Patch:0xa1ce2b90 RateController history too small for bit rate control 2009/08/18 15:40:58.757 5:27.506 Media Patch:0xa1ce2b90 RTP Session 2, transmit statistics: packets=201 octets=269019 avgTime=62 maxTime=465 minTime=0 [New Thread 0xabc7bb90 (LWP 18423)] [Thread 0xabc7bb90 (LWP 18423) exited] [Thread 0xb46eeb90 (LWP 18422) exited] [New Thread 0xb46eeb90 (LWP 18424)] [New Thread 0xabc7bb90 (LWP 18425)] [Thread 0xabc7bb90 (LWP 18425) exited] [Thread 0xb46eeb90 (LWP 18424) exited] [New Thread 0xb46eeb90 (LWP 18426)] [New Thread 0xabc7bb90 (LWP 18427)] [Thread 0xabc7bb90 (LWP 18427) exited] [New Thread 0xabc7bb90 (LWP 18428)] [New Thread 0xa3478b90 (LWP 18429)] [Thread 0xa3478b90 (LWP 18429) exited] [New Thread 0xa1e7bb90 (LWP 18430)] [New Thread 0xa1e3ab90 (LWP 18431)] [New Thread 0xa1df9b90 (LWP 18432)] [New Thread 0xa1db8b90 (LWP 18433)] [New Thread 0xa1ce2b90 (LWP 18434)] Program received signal SIGSEGV, Segmentation fault. [Switching to Thread 0xb5bfd730 (LWP 18083)] 0xb6acee02 in std::_Rb_tree_increment () from /usr/lib/libstdc++.so.6 (gdb) thread apply all bt Thread 31 (Thread 0xa1ce2b90 (LWP 18434)): #0 0xb80db430 in __kernel_vsyscall () #1 0xb69b9a87 in syscall () from /lib/tls/i686/cmov/libc.so.6 #2 0xb58e2961 in ?? () from /usr/lib/libv4l2.so.0 #3 0xb58e3a31 in v4l2_ioctl () from /usr/lib/libv4l2.so.0 #4 0xb58f31dc in PVideoInputDevice_V4L2::GetFrameDataNoDelay (this=0x8d4f740, buffer=0xa1ae6024 "oqqtqinNifotmurqvppXZTVVU[\\fAT\\aAKLKLDIGBE;-+5#\016\v\021\031\035\016\v\027\026\021\017\016\020\024!\027\f-OJDFCFGG-YmW>HWZ[PIIEFFCC;;=?>9<::,17=EGGHNT\\GQfbeba_ege_\\Otiueirhhfehhe`^^\\cdhOJMKK\\g\201\177}\200\205\206\203\206\212\234yA$7R\177\200\214\222\214\207\215\213\211\204\213\213\214\202\234\216hc`@OakFRNMAF`SPRU"..., bytesReturned=0xa1ce2078) at vidinput_v4l2.cxx:683 #5 0xb58f1e66 in PVideoInputDevice_V4L2::GetFrameData (this=0x8d4f740, buffer=0xa1ae6024 "oqqtqinNifotmurqvppXZTVVU[\\fAT\\aAKLKLDIGBE;-+5#\016\v\021\031\035\016\v\027\026\021\017\016\020\024!\027\f-OJDFCFGG-YmW>HWZ[PIIEFFCC;;=?>9<::,17=EGGHNT\\GQfbeba_ege_\\Otiueirhhfehhe`^^\\cdhOJMKK\\g\201\177}\200\205\206\203\206\212\234yA$7R\177\200\214\222\214\207\215\213\211\204\213\213\214\202\234\216hc`@OakFRNMAF`SPRU"..., bytesReturned=0xa1ce2078) at vidinput_v4l2.cxx:666 #6 0x081c650c in GMVideoInputManager_ptlib::get_frame_data (this=0x88cfd58, data=0xa1ae6024 "oqqtqinNifotmurqvppXZTVVU[\\fAT\\aAKLKLDIGBE;-+5#\016\v\021\031\035\016\v\027\026\021\017\016\020\024!\027\f-OJDFCFGG-YmW>HWZ[PIIEFFCC;;=?>9<::,17=EGGHNT\\GQfbeba_ege_\\Otiueirhhfehhe`^^\\cdhOJMKK\\g\201\177}\200\205\206\203\206\212\234yA$7R\177\200\214\222\214\207\215\213\211\204\213\213\214\202\234\216hc`@OakFRNMAF`SPRU"...) at ../../../../lib/engine/components/ptlib/videoinput-manager-ptlib.cpp:181 #7 0x0814c975 in Ekiga::VideoInputCore::get_frame_data (this=0x88d0dc8, data=0xa1ae6024 "oqqtqinNifotmurqvppXZTVVU[\\fAT\\aAKLKLDIGBE;-+5#\016\v\021\031\035\016\v\027\026\021\017\016\020\024!\027\f-OJDFCFGG-YmW>HWZ[PIIEFFCC;;=?>9<::,17=EGGHNT\\GQfbeba_ege_\\Otiueirhhfehhe`^^\\cdhOJMKK\\g\201\177}\200\205\206\203\206\212\234yA$7R\177\200\214\222\214\207\215\213\211\204\213\213\214\202\234\216hc`@OakFRNMAF`SPRU"...) at ../../../lib/engine/videoinput/videoinput-core.cpp:384 #8 0x0816f57f in PVideoInputDevice_EKIGA::GetFrameData (this=0x8d4f3b8, frame=0xa1ae6024 "oqqtqinNifotmurqvppXZTVVU[\\fAT\\aAKLKLDIGBE;-+5#\016\v\021\031\035\016\v\027\026\021\017\016\020\024!\027\f-OJDFCFGG-YmW>HWZ[PIIEFFCC;;=?>9<::,17=EGGHNT\\GQfbeba_ege_\\Otiueirhhfehhe`^^\\cdhOJMKK\\g\201\177}\200\205\206\203\206\212\234yA$7R\177\200\214\222\214\207\215\213\211\204\213\213\214\202\234\216hc`@OakFRNMAF`SPRU"..., i=0xa1ce2180) at ../../../../lib/engine/components/opal/opal-videoinput.cpp:196 #9 0xb751dc5b in PVideoInputDevice::GetFrameData (this=0x8d4f3b8, buffer=0xa1ae6024 "oqqtqinNifotmurqvppXZTVVU[\\fAT\\aAKLKLDIGBE;-+5#\016\v\021\031\035\016\v\027\026\021\017\016\020\024!\027\f-OJDFCFGG-YmW>HWZ[PIIEFFCC;;=?>9<::,17=EGGHNT\\GQfbeba_ege_\\Otiueirhhfehhe`^^\\cdhOJMKK\\g\201\177}\200\205\206\203\206\212\234yA$7R\177\200\214\222\214\207\215\213\211\204\213\213\214\202\234\216hc`@OakFRNMAF`SPRU"..., bytesReturned=0xa1ce2180, flags=@0xa1ce217c) at ptlib/common/videoio.cxx:1334 #10 0xb7a4f87b in OpalVideoMediaStream::ReadData (this=0x8d4f518, data=0xa1ae6014 "", size=1382416, length=@0xa1ce21e8) at /build/buildd/opal-3.6.1~dfsg/src/opal/mediastrm.cxx:1121 #11 0xb7a506f8 in OpalMediaStream::ReadPacket (this=0x8d4f518, packet=@0xa1ce2238) at /build/buildd/opal-3.6.1~dfsg/src/opal/mediastrm.cxx:255 #12 0xb7a5aa6d in OpalMediaPatch::Main (this=0x8d5bca8) at /build/buildd/opal-3.6.1~dfsg/src/opal/patch.cxx:457 #13 0xb7a5ada7 in OpalMediaPatch::Thread::Main (this=0xb5597dd8) at /build/buildd/opal-3.6.1~dfsg/include/opal/patch.h:265 #14 0xb766042d in PThread::PX_ThreadStart (arg=0xb5597dd8) at ptlib/unix/tlibthrd.cxx:853 #15 0xb73e34ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 #16 0xb69bd49e in clone () from /lib/tls/i686/cmov/libc.so.6 Thread 30 (Thread 0xa1db8b90 (LWP 18433)): #0 0xb80db430 in __kernel_vsyscall () #1 0xb69b57b1 in select () from /lib/tls/i686/cmov/libc.so.6 #2 0xb764d642 in PSocket::Select (read=@0xa1db77c8, write=@0xa1db77bc, except=@0xa1db77b0, timeout=@0x8b447c0) at ptlib/unix/socket.cxx:328 #3 0xb7682007 in PSocket::Select (sock1=@0x8915c70, sock2=@0x89131c0, timeout=@0x8b447c0) at ptlib/common/sockets.cxx:1021 #4 0xb7a793c2 in RTP_UDP::Internal_WaitForPDU (this=0x8b44630, dataSocket=@0x8915c70, controlSocket=@0x89131c0, timeout=@0x8b447c0) at /build/buildd/opal-3.6.1~dfsg/src/rtp/rtp.cxx:1878 #5 0xb7a78d6c in RTP_Encoding::WaitForPDU (this=0x891def0, dataSocket=@0x8915c70, controlSocket=@0x89131c0, t=@0x8b447c0) at /build/buildd/opal-3.6.1~dfsg/src/rtp/rtp.cxx:2258 #6 0xb7a7a86c in RTP_UDP::WaitForPDU (this=0x8b44630, dataSocket=@0x8915c70, controlSocket=@0x89131c0, timeout=@0x8b447c0) at /build/buildd/opal-3.6.1~dfsg/src/rtp/rtp.cxx:1858 #7 0xb7a7b3f6 in RTP_UDP::Internal_ReadData (this=0x8b44630, frame=@0xb55a8c38, loop=true) at /build/buildd/opal-3.6.1~dfsg/src/rtp/rtp.cxx:1787 #8 0xb7a78d36 in RTP_Encoding::ReadData (this=0x891def0, frame=@0xb55a8c38, loop=) at /build/buildd/opal-3.6.1~dfsg/src/rtp/rtp.cxx:2253 #9 0xb7a7a8dc in RTP_UDP::ReadData (this=0x8b44630, frame=@0xb55a8c38, loop=true) at /build/buildd/opal-3.6.1~dfsg/src/rtp/rtp.cxx:1781 #10 0xb7a879d4 in RTP_JitterBuffer::OnReadPacket (this=0xb559a628, frame=@0xb55a8c38, loop=254) at /build/buildd/opal-3.6.1~dfsg/src/rtp/jitter.cxx:628 #11 0xb7a8a9eb in OpalJitterBuffer::OnRead (this=0xb559a628, currentReadFrame=@0xa1db8234, markerWarning=@0xa1db823b, loop=true) at /build/buildd/opal-3.6.1~dfsg/src/rtp/jitter.cxx:292 #12 0xb7a8b29e in OpalJitterBuffer::JitterThreadMain (this=0xb559a628) at /build/buildd/opal-3.6.1~dfsg/src/rtp/jitter.cxx:228 #13 0xb7a8c932 in OpalJitterBuffer::JitterThreadMain_PNotifier::Call ( this=0xb55b6278, note=@0xb55b6288, extra=0) at /build/buildd/opal-3.6.1~dfsg/include/rtp/jitter.h:132 warning: (Internal error: pc 0x81b2676 in read in psymtab, but not in symtab.) #14 0x081b2677 in PNotifier::operator() (this=warning: (Internal error: pc 0x81b2640 in read in psymtab, but not in symtab.) warning: (Internal error: pc 0x81b2676 in read in psymtab, but not in symtab.) 0xb55b630c, notifier=warning: (Internal error: pc 0x81b2676 in read in psymtab, but not in symtab.) @0xb55b6288, extra=warning: (Internal error: pc 0x81b2676 in read in psymtab, but not in symtab.) 0) at /usr/include/ptlib/notifier.h:125 #15 0xb7693915 in PSimpleThread::Main (this=0xb55b6288) at ptlib/common/osutils.cxx:2031 #16 0xb766042d in PThread::PX_ThreadStart (arg=0xb55b6288) at ptlib/unix/tlibthrd.cxx:853 #17 0xb73e34ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 #18 0xb69bd49e in clone () from /lib/tls/i686/cmov/libc.so.6 Thread 29 (Thread 0xa1df9b90 (LWP 18432)): #0 0xb80db430 in __kernel_vsyscall () #1 0xb69b57b1 in select () from /lib/tls/i686/cmov/libc.so.6 #2 0xb764d642 in PSocket::Select (read=@0xa1df8848, write=@0xa1df883c, except=@0xa1df8830, timeout=@0x8920dd8) at ptlib/unix/socket.cxx:328 #3 0xb7682007 in PSocket::Select (sock1=@0xb5507138, sock2=@0xb550b2e0, timeout=@0x8920dd8) at ptlib/common/sockets.cxx:1021 #4 0xb7a793c2 in RTP_UDP::Internal_WaitForPDU (this=0x8920c48, dataSocket=@0xb5507138, controlSocket=@0xb550b2e0, timeout=@0x8920dd8) at /build/buildd/opal-3.6.1~dfsg/src/rtp/rtp.cxx:1878 #5 0xb7a78d6c in RTP_Encoding::WaitForPDU (this=0x8925530, dataSocket=@0xb5507138, controlSocket=@0xb550b2e0, t=@0x8920dd8) at /build/buildd/opal-3.6.1~dfsg/src/rtp/rtp.cxx:2258 #6 0xb7a7a86c in RTP_UDP::WaitForPDU (this=0x8920c48, dataSocket=@0xb5507138, controlSocket=@0xb550b2e0, timeout=@0x8920dd8) at /build/buildd/opal-3.6.1~dfsg/src/rtp/rtp.cxx:1858 #7 0xb7a7b3f6 in RTP_UDP::Internal_ReadData (this=0x8920c48, frame=@0xa1df9238, loop=true) at /build/buildd/opal-3.6.1~dfsg/src/rtp/rtp.cxx:1787 #8 0xb7a78d36 in RTP_Encoding::ReadData (this=0x8925530, frame=@0xa1df9238, loop=) at /build/buildd/opal-3.6.1~dfsg/src/rtp/rtp.cxx:2253 #9 0xb7a7a8dc in RTP_UDP::ReadData (this=0x8920c48, frame=@0xa1df9238, loop=true) at /build/buildd/opal-3.6.1~dfsg/src/rtp/rtp.cxx:1781 #10 0xb7a7892f in RTP_Session::ReadBufferedData (this=0xb55b9968, frame=@0xa1df9238) at /build/buildd/opal-3.6.1~dfsg/src/rtp/rtp.cxx:722 #11 0xb7a53b2d in OpalRTPMediaStream::ReadPacket (this=0x8d4db18, packet=@0xa1df9238) at /build/buildd/opal-3.6.1~dfsg/src/opal/mediastrm.cxx:640 #12 0xb7a5aa6d in OpalMediaPatch::Main (this=0x8d4e308) at /build/buildd/opal-3.6.1~dfsg/src/opal/patch.cxx:457 #13 0xb7a5ada7 in OpalMediaPatch::Thread::Main (this=0x8e4c548) at /build/buildd/opal-3.6.1~dfsg/include/opal/patch.h:265 #14 0xb766042d in PThread::PX_ThreadStart (arg=0x8e4c548) at ptlib/unix/tlibthrd.cxx:853 #15 0xb73e34ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 #16 0xb69bd49e in clone () from /lib/tls/i686/cmov/libc.so.6 Thread 28 (Thread 0xa1e3ab90 (LWP 18431)): #0 0xb80db430 in __kernel_vsyscall () #1 0xb69b2ae7 in poll () from /lib/tls/i686/cmov/libc.so.6 #2 0xb5ce8f4d in ?? () from /usr/lib/libasound.so.2 #3 0xb5ce90c4 in snd_pcm_wait () from /usr/lib/libasound.so.2 #4 0xb5ce947d in ?? () from /usr/lib/libasound.so.2 #5 0xb5d2da45 in ?? () from /usr/lib/libasound.so.2 #6 0xb5ce3894 in snd_pcm_readi () from /usr/lib/libasound.so.2 #7 0xb5905024 in PSoundChannelALSA::Read (this=0xb55dc580, buf=0x8f1e71c, len=640) at sound_alsa.cxx:460 #8 0x081c35fd in GMAudioInputManager_ptlib::get_frame_data (this=0x88cff40, data=0x8f1e71c "", size=640, bytes_read=@0xa1e3a15c) at ../../../../lib/engine/components/ptlib/audioinput-manager-ptlib.cpp:174 #9 0x08152e43 in Ekiga::AudioInputCore::get_frame_data (this=0x88d14e8, data=0x8f1e71c "", size=640, bytes_read=@0xa1e3a15c) at ../../../lib/engine/audioinput/audioinput-core.cpp:375 #10 0x0816da87 in PSoundChannel_EKIGA::Read (this=0xb55dc368, buf=0x8f1e71c, len=640) at ../../../../lib/engine/components/opal/opal-audio.cpp:176 #11 0xb7a4f368 in OpalRawMediaStream::ReadData (this=0xb55982e8, buffer=0x8f1e71c "", size=640, length=@0xa1e3a1e8) at /build/buildd/opal-3.6.1~dfsg/src/opal/mediastrm.cxx:748 #12 0xb7a506f8 in OpalMediaStream::ReadPacket (this=0xb55982e8, packet=@0xa1e3a238) at /build/buildd/opal-3.6.1~dfsg/src/opal/mediastrm.cxx:255 #13 0xb7a5aa6d in OpalMediaPatch::Main (this=0xb55a0410) at /build/buildd/opal-3.6.1~dfsg/src/opal/patch.cxx:457 #14 0xb7a5ada7 in OpalMediaPatch::Thread::Main (this=0x8e4c408) at /build/buildd/opal-3.6.1~dfsg/include/opal/patch.h:265 #15 0xb766042d in PThread::PX_ThreadStart (arg=0x8e4c408) at ptlib/unix/tlibthrd.cxx:853 #16 0xb73e34ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 #17 0xb69bd49e in clone () from /lib/tls/i686/cmov/libc.so.6 Thread 27 (Thread 0xa1e7bb90 (LWP 18430)): #0 0xb80db430 in __kernel_vsyscall () #1 0xb69b2ae7 in poll () from /lib/tls/i686/cmov/libc.so.6 #2 0xb5ce8f4d in ?? () from /usr/lib/libasound.so.2 #3 0xb5ce90c4 in snd_pcm_wait () from /usr/lib/libasound.so.2 #4 0xb5ce92a5 in ?? () from /usr/lib/libasound.so.2 #5 0xb5d2dbe5 in ?? () from /usr/lib/libasound.so.2 #6 0xb5ce3b34 in snd_pcm_writei () from /usr/lib/libasound.so.2 #7 0xb5905244 in PSoundChannelALSA::Write (this=0xb5550578, buf=0xb55b65c8, len=640) at sound_alsa.cxx:410 #8 0x081c91de in GMAudioOutputManager_ptlib::set_frame_data (this=0x88d0190, ps=Ekiga::primary, data=0xb55b65c8 "", size=640, bytes_written=@0xa1e7b08c) at ../../../../lib/engine/components/ptlib/audiooutput-manager-ptlib.cpp:176 #9 0x08159088 in Ekiga::AudioOutputCore::set_frame_data (this=0x88d1130, data=0xb55b65c8 "", size=640, bytes_written=@0xa1e7b08c) at ../../../lib/engine/audiooutput/audiooutput-core.cpp:296 #10 0x0816dafb in PSoundChannel_EKIGA::Write (this=0xb552e918, buf=0xb55b65c8, len=640) at ../../../../lib/engine/components/opal/opal-audio.cpp:163 #11 0xb7a5519f in OpalRawMediaStream::WriteData (this=0xb5551fc8, buffer=0xb55b65c8 "", length=640, written=@0xa1e7b108) at /build/buildd/opal-3.6.1~dfsg/src/opal/mediastrm.cxx:799 #12 0xb7a51086 in OpalMediaStream::WritePacket (this=0xb5551fc8, packet=@0xa1e7b238) at /build/buildd/opal-3.6.1~dfsg/src/opal/mediastrm.cxx:313 #13 0xb7a59747 in OpalMediaPatch::Sink::WriteFrame (this=0xb55522c0, sourceFrame=@0xa1e7b238) at /build/buildd/opal-3.6.1~dfsg/src/opal/patch.cxx:627 #14 0xb7a59aad in OpalMediaPatch::DispatchFrame (this=0xb55dd4d0, frame=@0xa1e7b238) at /build/buildd/opal-3.6.1~dfsg/src/opal/patch.cxx:490 #15 0xb7a5aa8f in OpalMediaPatch::Main (this=0xb55dd4d0) at /build/buildd/opal-3.6.1~dfsg/src/opal/patch.cxx:463 #16 0xb7a5ada7 in OpalMediaPatch::Thread::Main (this=0x8e4c378) at /build/buildd/opal-3.6.1~dfsg/include/opal/patch.h:265 #17 0xb766042d in PThread::PX_ThreadStart (arg=0x8e4c378) at ptlib/unix/tlibthrd.cxx:853 #18 0xb73e34ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 #19 0xb69bd49e in clone () from /lib/tls/i686/cmov/libc.so.6 Thread 25 (Thread 0xabc7bb90 (LWP 18428)): #0 0xb80db430 in __kernel_vsyscall () #1 0xb69b2ae7 in poll () from /lib/tls/i686/cmov/libc.so.6 #2 0xb3cc5912 in ?? () from /usr/lib/libpulse.so.0 #3 0xb3cb53c0 in pa_mainloop_poll () from /usr/lib/libpulse.so.0 #4 0xb3cb6d43 in pa_mainloop_iterate () from /usr/lib/libpulse.so.0 #5 0xb3cb6e14 in pa_mainloop_run () from /usr/lib/libpulse.so.0 #6 0xb3cc56c3 in ?? () from /usr/lib/libpulse.so.0 #7 0xb3cefef2 in ?? () from /usr/lib/libpulse.so.0 #8 0xb73e34ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 #9 0xb69bd49e in clone () from /lib/tls/i686/cmov/libc.so.6 Thread 23 (Thread 0xb46eeb90 (LWP 18426)): #0 0xb80db430 in __kernel_vsyscall () #1 0xb69b2ae7 in poll () from /lib/tls/i686/cmov/libc.so.6 #2 0xb3cc5912 in ?? () from /usr/lib/libpulse.so.0 #3 0xb3cb53c0 in pa_mainloop_poll () from /usr/lib/libpulse.so.0 #4 0xb3cb6d43 in pa_mainloop_iterate () from /usr/lib/libpulse.so.0 #5 0xb3cb6e14 in pa_mainloop_run () from /usr/lib/libpulse.so.0 #6 0xb3cc56c3 in ?? () from /usr/lib/libpulse.so.0 #7 0xb3cefef2 in ?? () from /usr/lib/libpulse.so.0 #8 0xb73e34ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 #9 0xb69bd49e in clone () from /lib/tls/i686/cmov/libc.so.6 Thread 18 (Thread 0xb3e6bb90 (LWP 18421)): #0 0xb80db430 in __kernel_vsyscall () #1 0xb73e70e5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 #2 0xb765feec in PSyncPoint::Wait (this=0x891c48c) at ptlib/unix/tlibthrd.cxx:1468 #3 0xb7eba826 in SIPEndPoint::SIP_PDU_Thread::Main (this=0x891c3c0) at /build/buildd/opal-3.6.1~dfsg/src/sip/sipep.cxx:1516 #4 0xb766042d in PThread::PX_ThreadStart (arg=0x891c3c0) at ptlib/unix/tlibthrd.cxx:853 #5 0xb73e34ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 #6 0xb69bd49e in clone () from /lib/tls/i686/cmov/libc.so.6 Thread 15 (Thread 0xb547db90 (LWP 18109)): #0 0xb80db430 in __kernel_vsyscall () #1 0xb69b57b1 in select () from /lib/tls/i686/cmov/libc.so.6 #2 0xb765f35f in PThread::PXBlockOnIO (this=0xb5504108, handle=39, type=2, timeout=@0xb547d020) at ptlib/unix/tlibthrd.cxx:952 #3 0xb76525ac in PChannel::PXSetIOBlock (this=0xb55076ac, type=PChannel::PXAcceptBlock, timeout=@0xb547d020) at ptlib/unix/channel.cxx:119 #4 0xb764d7e3 in PSocket::os_accept (this=0x890a7f8, listener=@0xb55076ac, addr=0xb547d068, size=0xb547d064) at ptlib/unix/socket.cxx:206 #5 0xb7680d72 in PTCPSocket::Accept (this=0x890a7f8, socket=@0xb55076ac) at ptlib/common/sockets.cxx:2359 #6 0xb7a6ce2e in OpalListenerTCP::Accept (this=0xb5507678, timeout=@0xb547d230) at /build/buildd/opal-3.6.1~dfsg/src/opal/transports.cxx:625 #7 0xb7a6aab6 in OpalListener::ListenForConnections (this=0xb5507678, thread=@0xb5504108) at /build/buildd/opal-3.6.1~dfsg/src/opal/transports.cxx:472 #8 0xb7a6d1b2 in OpalListener::ListenForConnections_PNotifier::Call ( this=0xb55091f8, note=@0xb5504108, extra=0) at /build/buildd/opal-3.6.1~dfsg/include/opal/transports.h:357 warning: (Internal error: pc 0x81b2677 in read in psymtab, but not in symtab.) warning: (Internal error: pc 0x81b2676 in read in psymtab, but not in symtab.) warning: (Internal error: pc 0x81b2676 in read in psymtab, but not in symtab.) #9 0x081b2677 in PNotifier::operator() (this=warning: (Internal error: pc 0x81b2640 in read in psymtab, but not in symtab.) warning: (Internal error: pc 0x81b2676 in read in psymtab, but not in symtab.) 0xb550418c, notifier=warning: (Internal error: pc 0x81b2676 in read in psymtab, but not in symtab.) @0xb5504108, extra=warning: (Internal error: pc 0x81b2676 in read in psymtab, but not in symtab.) 0) at /usr/include/ptlib/notifier.h:125 #10 0xb7693915 in PSimpleThread::Main (this=0xb5504108) at ptlib/common/osutils.cxx:2031 #11 0xb766042d in PThread::PX_ThreadStart (arg=0xb5504108) at ptlib/unix/tlibthrd.cxx:853 #12 0xb73e34ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 #13 0xb69bd49e in clone () from /lib/tls/i686/cmov/libc.so.6 Thread 14 (Thread 0xb54beb90 (LWP 18108)): #0 0xb80db430 in __kernel_vsyscall () #1 0xb69b57b1 in select () from /lib/tls/i686/cmov/libc.so.6 #2 0xb764d642 in PSocket::Select (read=@0xb54be0b4, write=@0xb54bdfe0, except=@0xb54bdfd4, timeout=@0xb54be230) at ptlib/unix/socket.cxx:328 #3 0xb7682595 in PSocket::Select (read=@0xb54be0b4, timeout=@0xb54be230) at ptlib/common/sockets.cxx:1045 #4 0xb7688309 in PMonitoredSockets::ReadFromSocket (this=0x89153f8, readers=@0xb54be0b4, socket=@0xb54be0c4, buf=0x8d34908, len=65536, addr=@0xb54be170, port=@0xb54be156, lastReadCount=@0xb54be150, timeout=@0xb54be230) at ptclib/psockbun.cxx:588 #5 0xb768d45e in PMonitoredSocketBundle::ReadFromBundle (this=0x89153f8, buf=0x8d34908, len=65536, addr=@0xb54be170, port=@0xb54be156, iface=@0xb54be128, lastReadCount=@0xb54be150, timeout=@0xb54be230) at ptclib/psockbun.cxx:992 #6 0xb7a693ca in OpalListenerUDP::Accept (this=0x893efb0, timeout=@0xb54be230) at /build/buildd/opal-3.6.1~dfsg/src/opal/transports.cxx:734 #7 0xb7a6aab6 in OpalListener::ListenForConnections (this=0x893efb0, thread=@0x8935108) at /build/buildd/opal-3.6.1~dfsg/src/opal/transports.cxx:472 #8 0xb7a6d1b2 in OpalListener::ListenForConnections_PNotifier::Call ( this=0x88f0140, note=@0x8935108, extra=0) at /build/buildd/opal-3.6.1~dfsg/include/opal/transports.h:357 warning: (Internal error: pc 0x81b2677 in read in psymtab, but not in symtab.) warning: (Internal error: pc 0x81b2676 in read in psymtab, but not in symtab.) warning: (Internal error: pc 0x81b2676 in read in psymtab, but not in symtab.) #9 0x081b2677 in PNotifier::operator() (this=warning: (Internal error: pc 0x81b2640 in read in psymtab, but not in symtab.) warning: (Internal error: pc 0x81b2676 in read in psymtab, but not in symtab.) 0x893518c, notifier=warning: (Internal error: pc 0x81b2676 in read in psymtab, but not in symtab.) @0x8935108, extra=warning: (Internal error: pc 0x81b2676 in read in psymtab, but not in symtab.) 0) at /usr/include/ptlib/notifier.h:125 #10 0xb7693915 in PSimpleThread::Main (this=0x8935108) at ptlib/common/osutils.cxx:2031 #11 0xb766042d in PThread::PX_ThreadStart (arg=0x8935108) at ptlib/unix/tlibthrd.cxx:853 #12 0xb73e34ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 #13 0xb69bd49e in clone () from /lib/tls/i686/cmov/libc.so.6 Thread 12 (Thread 0xb4bf3b90 (LWP 18102)): #0 0xb80db430 in __kernel_vsyscall () #1 0xb69b2ae7 in poll () from /lib/tls/i686/cmov/libc.so.6 #2 0xb6bab74b in IA__g_poll (fds=0x8955d78, nfds=9, timeout=-1) at /build/buildd/glib2.0-2.20.1/glib/gpoll.c:127 #3 0xb6b9df82 in g_main_context_iterate (context=0x89573d0, block=1, dispatch=1, self=0x89571b0) at /build/buildd/glib2.0-2.20.1/glib/gmain.c:2761 #4 0xb6b9e5ba in IA__g_main_loop_run (loop=0x8957228) at /build/buildd/glib2.0-2.20.1/glib/gmain.c:2656 #5 0xb67978c0 in ?? () from /usr/lib/libORBit-2.so.0 #6 0xb6bc57bf in g_thread_create_proxy (data=0x89571b0) at /build/buildd/glib2.0-2.20.1/glib/gthread.c:635 #7 0xb73e34ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 #8 0xb69bd49e in clone () from /lib/tls/i686/cmov/libc.so.6 Thread 11 (Thread 0xb53f4b90 (LWP 18099)): #0 0xb80db430 in __kernel_vsyscall () #1 0xb69b2ae7 in poll () from /lib/tls/i686/cmov/libc.so.6 #2 0xb6bab74b in IA__g_poll (fds=0x8955908, nfds=1, timeout=-1) at /build/buildd/glib2.0-2.20.1/glib/gpoll.c:127 #3 0xb6b9df82 in g_main_context_iterate (context=0x884f238, block=1, dispatch=1, self=0x89557f8) at /build/buildd/glib2.0-2.20.1/glib/gmain.c:2761 #4 0xb6b9e5ba in IA__g_main_loop_run (loop=0x89558f8) at /build/buildd/glib2.0-2.20.1/glib/gmain.c:2656 #5 0xb8080762 in ?? () from /usr/lib/libebook-1.2.so.9 #6 0xb6bc57bf in g_thread_create_proxy (data=0x89557f8) at /build/buildd/glib2.0-2.20.1/glib/gthread.c:635 #7 0xb73e34ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 #8 0xb69bd49e in clone () from /lib/tls/i686/cmov/libc.so.6 Thread 7 (Thread 0xb54ffb90 (LWP 18095)): #0 0xb80db430 in __kernel_vsyscall () #1 0xb73e7412 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 #2 0xb765fd9e in PSyncPoint::Wait (this=0x826a2d0, waitTime=@0xb54ff290) at ptlib/unix/tlibthrd.cxx:1485 #3 0xb766062b in PHouseKeepingThread::Main (this=0xb55004f0) at ptlib/unix/tlibthrd.cxx:129 #4 0xb766042d in PThread::PX_ThreadStart (arg=0xb55004f0) at ptlib/unix/tlibthrd.cxx:853 #5 0xb73e34ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 #6 0xb69bd49e in clone () from /lib/tls/i686/cmov/libc.so.6 Thread 6 (Thread 0xb5645b90 (LWP 18094)): #0 0xb80db430 in __kernel_vsyscall () #1 0xb73e7412 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 #2 0xb765fd9e in PSyncPoint::Wait (this=0x88495c4, waitTime=@0x8849594) at ptlib/unix/tlibthrd.cxx:1485 #3 0xb764ce08 in PIPSocket::WaitForRouteTableChange (timeout=@0x8849594, cancellation=0x2b) at ptlib/unix/socket.cxx:1527 #4 0xb768cfcf in PInterfaceMonitor::UpdateThreadMain (this=0x8849538) at ptclib/psockbun.cxx:258 #5 0xb768f295 in PThreadObj::Main (this=0xfffffdfc) at /build/buildd/ptlib-2.6.1/include/ptlib/thread.h:599 #6 0xb766042d in PThread::PX_ThreadStart (arg=0x8936638) at ptlib/unix/tlibthrd.cxx:853 #7 0xb73e34ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 #8 0xb69bd49e in clone () from /lib/tls/i686/cmov/libc.so.6 Thread 5 (Thread 0xb5686b90 (LWP 18093)): #0 0xb80db430 in __kernel_vsyscall () #1 0xb73e7412 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 #2 0xb765fd9e in PSyncPoint::Wait (this=0x8906ea4, waitTime=@0xb5686230) at ptlib/unix/tlibthrd.cxx:1485 #3 0xb7a14c03 in OpalManager::GarbageMain (this=0x89068b0) at /build/buildd/opal-3.6.1~dfsg/src/opal/manager.cxx:1546 #4 0xb7a1ecd5 in OpalManager::GarbageMain_PNotifier::Call (this=0x8927a68, note=@0x89251b0, extra=0) at /build/buildd/opal-3.6.1~dfsg/include/opal/manager.h:1369 warning: (Internal error: pc 0x81b2677 in read in psymtab, but not in symtab.) warning: (Internal error: pc 0x81b2676 in read in psymtab, but not in symtab.) warning: (Internal error: pc 0x81b2676 in read in psymtab, but not in symtab.) #5 0x081b2677 in PNotifier::operator() (this=warning: (Internal error: pc 0x81b2640 in read in psymtab, but not in symtab.) warning: (Internal error: pc 0x81b2676 in read in psymtab, but not in symtab.) 0x8925234, notifier=warning: (Internal error: pc 0x81b2676 in read in psymtab, but not in symtab.) @0x89251b0, extra=warning: (Internal error: pc 0x81b2676 in read in psymtab, but not in symtab.) 0) at /usr/include/ptlib/notifier.h:125 #6 0xb7693915 in PSimpleThread::Main (this=0x89251b0) at ptlib/common/osutils.cxx:2031 #7 0xb766042d in PThread::PX_ThreadStart (arg=0x89251b0) at ptlib/unix/tlibthrd.cxx:853 #8 0xb73e34ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 #9 0xb69bd49e in clone () from /lib/tls/i686/cmov/libc.so.6 Thread 4 (Thread 0xb56c7b90 (LWP 18091)): #0 0xb80db430 in __kernel_vsyscall () #1 0xb73e7412 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 #2 0xb765fd9e in PSyncPoint::Wait (this=0x88cead0, waitTime=@0xb56c7290) at ptlib/unix/tlibthrd.cxx:1485 #3 0x081efe95 in GMVideoOutputManager::Main (this=0x88ce958) at ../../../../lib/engine/components/common-videooutput/videooutput-manager-common.cpp:90 #4 0xb766042d in PThread::PX_ThreadStart (arg=0x88ce958) at ptlib/unix/tlibthrd.cxx:853 #5 0xb73e34ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 #6 0xb69bd49e in clone () from /lib/tls/i686/cmov/libc.so.6 Thread 3 (Thread 0xb5708b90 (LWP 18090)): #0 0xb80db430 in __kernel_vsyscall () #1 0xb73e70e5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 #2 0xb765feec in PSyncPoint::Wait (this=0x88d12b4) at ptlib/unix/tlibthrd.cxx:1468 #3 0x081a0ef3 in Ekiga::AudioEventScheduler::Main (this=0x88d1230) at ../../../lib/engine/audiooutput/audiooutput-scheduler.cpp:81 #4 0xb766042d in PThread::PX_ThreadStart (arg=0x88d1230) at ptlib/unix/tlibthrd.cxx:853 #5 0xb73e34ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 #6 0xb69bd49e in clone () from /lib/tls/i686/cmov/libc.so.6 Thread 2 (Thread 0xb5749b90 (LWP 18089)): #0 0xb80db430 in __kernel_vsyscall () #1 0xb73e70e5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 #2 0xb765feec in PSyncPoint::Wait (this=0x88d0fe0) at ptlib/unix/tlibthrd.cxx:1468 #3 0x0814ca90 in Ekiga::VideoInputCore::VideoPreviewManager::Main ( this=0x88d0ec4) at ../../../lib/engine/videoinput/videoinput-core.cpp:108 #4 0xb766042d in PThread::PX_ThreadStart (arg=0x88d0ec4) at ptlib/unix/tlibthrd.cxx:853 #5 0xb73e34ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 #6 0xb69bd49e in clone () from /lib/tls/i686/cmov/libc.so.6 Thread 1 (Thread 0xb5bfd730 (LWP 18083)): #0 0xb6acee02 in std::_Rb_tree_increment () from /usr/lib/libstdc++.so.6 #1 0x081f649d in Avahi::Heap::BrowserCallback (this=0x88ec6a0, browser=0x88efec0, interface=2, protocol=0, event=AVAHI_BROWSER_REMOVE, name=0x8918c8c "Luiz Carvalho", type=0x8918ca0 "_sip._udp", domain=0x8918cb0 "local") at /usr/include/c++/4.3/bits/stl_tree.h:182 #2 0x081f6605 in avahi_browser_callback (browser=0x88efec0, interface=2, protocol=0, event=AVAHI_BROWSER_REMOVE, name=0x8918c8c "Luiz Carvalho", type=0x8918ca0 "_sip._udp", domain=0x8918cb0 "local", flags=AVAHI_LOOKUP_RESULT_MULTICAST, data=0x88ec6a0) at ../../../../lib/engine/components/avahi/avahi-heap.cpp:63 #3 0xb80ab40b in avahi_service_browser_event (client=0x88508b8, event=AVAHI_BROWSER_REMOVE, message=0x89056e8) at browser.c:777 #4 0xb80a9032 in filter_func (bus=0x8850b48, message=0x89056e8, userdata=0x88508b8) at client.c:247 #5 0xb689e0d5 in dbus_connection_dispatch () from /lib/libdbus-1.so.3 #6 0xb80b045c in dispatch_timeout_callback (t=0x884e0a8, userdata=0x0) at ../avahi-common/dbus-watch-glue.c:107 #7 0xb80a1452 in dispatch_func (source=0x88514b8, callback=0, userdata=0x0) at glib-watch.c:254 #8 0xb6b9ab88 in IA__g_main_context_dispatch (context=0x8860dd8) at /build/buildd/glib2.0-2.20.1/glib/gmain.c:1814 #9 0xb6b9e0eb in g_main_context_iterate (context=0x8860dd8, block=1, dispatch=1, self=0x885c8c0) at /build/buildd/glib2.0-2.20.1/glib/gmain.c:2448 #10 0xb6b9e5ba in IA__g_main_loop_run (loop=0x8d20a80) at /build/buildd/glib2.0-2.20.1/glib/gmain.c:2656 #11 0xb6e927d9 in IA__gtk_main () at /build/buildd/gtk+2.0-2.16.1/gtk/gtkmain.c:1205 #12 0x080ea3a1 in main (argc=136704972, argv=0x0) at gui/main.cpp:4566 (gdb) quit The program is running. Exit anyway? (y or n)