FreeSWITCH-users
Threads by month
- ----- 2026 -----
- November
- October
- September
- August
- July
- June
- May
- April
- March
- February
- January
- ----- 2025 -----
- December
- November
- October
- September
- August
- July
- June
- May
- April
- March
- February
- January
- ----- 2024 -----
- December
- November
- October
- September
- August
- July
- June
- May
- April
- March
- February
- January
- ----- 2023 -----
- December
- November
- October
- September
- August
- July
- June
- May
- April
- March
- February
- January
- ----- 2022 -----
- December
- November
- October
- September
- August
- July
- June
- May
- April
- March
- February
- January
- ----- 2021 -----
- December
- November
- October
- September
- August
- July
- June
- May
- April
- March
- February
- January
- ----- 2020 -----
- December
- November
- October
- September
- August
- July
- June
- May
- April
- March
- February
- January
- ----- 2019 -----
- December
- November
- October
- September
- August
- July
- June
- May
- April
- March
- February
- January
- ----- 2018 -----
- December
- November
- October
- September
- August
- July
- June
- May
- April
- March
- February
- January
- ----- 2017 -----
- December
- November
- October
- September
- August
- July
- June
- May
- April
- March
- February
- January
- ----- 2016 -----
- December
- November
- October
- September
- August
- July
- June
- May
- April
- March
- February
- January
- ----- 2015 -----
- December
- November
- October
- September
- August
- July
- June
- May
- April
- March
- February
- January
- ----- 2014 -----
- December
- November
- October
- September
- August
- July
- June
- May
- April
- March
- February
- January
- ----- 2013 -----
- December
- November
- October
- September
- August
- July
- June
- May
- April
- March
- February
- January
- ----- 2012 -----
- December
- November
- October
- September
- August
- July
- June
- May
- April
- March
- February
- January
- ----- 2011 -----
- December
- November
- October
- September
- August
- July
- June
- May
- April
- March
- February
- January
- ----- 2010 -----
- December
- November
- October
- September
- August
- July
- June
- May
- April
- March
- February
- January
- ----- 2009 -----
- December
- November
- October
- September
- August
- July
- June
- May
- April
- March
- February
- January
- ----- 2008 -----
- December
- November
- October
- September
- August
- July
- June
- May
- April
- March
- February
- January
- ----- 2007 -----
- December
- November
- October
- September
- August
- July
- June
- May
- April
- March
- February
- January
- ----- 2006 -----
- December
- November
- October
- September
- August
- July
December 2010
- 162 participants
- 315 discussions
Hello! Newbie question.
My wifi SIP phone has stopped answering lately and I don't know if I've
induced a configuration problem by making freeswitch current, or whether
I've staticed the phone firmware. I have the wifi handset set up as a
typical extension 1000. I've got a Twinkle softphone on ext 1001 and I
can call that extension from 1000, but when I call from 1001 to ext
1000, the handset returns the nua_media_error. Both extensions are on
the same network. I've posted a pastebin of log level 9 sip trace on
pastebin 14768
I could use some help understanding the log so I can correct my
nua_media_error negotiation problem. I started the log early in the
conversation, where it negotiates past the IP to the user registration,
but I don't see a clear reason for the "BYE" on line 526.
Thanks for FreeSWITCH!
2
1
I'm working with cepstral support and they seem to have no idea. Does
any one know why cepstral might produce no audio on a cent os 5.5
machine. Its works fine on another box of mine.
Thanks,
Stephen C
-All of my email addresses go to the same place
-Save Paper, think before you print
4
4
I was attempting to build FreeSwitch on a Dockstar running Debian Squeeze,
and ran into the sofia.c logger() compile problem as described here:
http://jira.freeswitch.org/browse/FS-802
The offered solution was to downgrade GCC, but being a Linux newbie, I
didn't know how to do that. So I decided to figure out what the problem
really is.
After learning waaaay too much about va_list, I see that the logger()
function in sofia.c assumes that va_list will always be a pointer. But on
different platforms, va_list can be an array or a struct. On the Dockstar
(with Debian Squeeze and GCC 4.4), va_list is apparently a struct.
I made the following modifications to logger() to make it truly portable,
and it compiles and runs fine on my DockStar, my Debian Lenny x86. (My
Windows build is having bigger problems.) But I'm no C guru, so someone
needs to thoroughly examine my code before anyone else takes it as gospel.
Am I actually checking what needs to be checked with the va_arg() macro?
Changing it to if(1) worked too, after all.
ORIGINAL logger() in sofia.c, to make it easy to see what I changed.
static void logger(void *logarg, char const *fmt, va_list ap)
{
/* gcc 4.4 gets mad at us for testing if (ap) so let's try to work around
it....*/
void *ap_ptr = (void *) (intptr_t) ap; //Error now occurs here, because ap
is a struct.
if (!fmt) return;
if (ap_ptr) { //Error used to occur here, before attempted fix above.
switch_log_vprintf(SWITCH_CHANNEL_LOG_CLEAN,
mod_sofia_globals.tracelevel, fmt, ap);
} else {
switch_log_printf(SWITCH_CHANNEL_LOG_CLEAN, mod_sofia_globals.tracelevel,
"%s", fmt);
}
}
My MODIFIED logger() function, additions and changes labelled with DOCKSTAR:
static void logger(void *logarg, char const *fmt, va_list ap)
{
va_list temp_ap; //DOCKSTAR: Added line (replacing previous ap_ptr cast).
if (!fmt) return;
va_copy(temp_ap, ap); //DOCKSTAR: Added Line. Make copy of "ap" so va_arg()
macro doesn't move pointer.
if (va_arg(temp_ap, int)) { //DOCKSTAR: Modified, get first argument from
ap, check non-null.
switch_log_vprintf(SWITCH_CHANNEL_LOG_CLEAN,
mod_sofia_globals.tracelevel, fmt, ap);
} else {
switch_log_printf(SWITCH_CHANNEL_LOG_CLEAN,
mod_sofia_globals.tracelevel, "%s", fmt);
}
va_end(temp_ap); //DOCKSTAR: Added line. Release our copy of "ap".
}
3
5
Hi i try to start mod_h323 but i have follow issue.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting
on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to
open
transport, connection not started.
On Mon, 2010-12-13 at 17:48 +0300,
freeswitch-users-request(a)lists.freeswitch.org wrote:
> Re: opal to sip problem
2
2
Hi,
Sorry I was away from work. Just recalling the radius AAA and credit-time stuff, I am wondering if there is a way to announce the remaining time of 1 minute or 30 seconds before the call has to disconnect.
Please help if you FS supports this feature.
Regards-----------Abid Saleem
Date: Mon, 15 Nov 2010 08:53:23 +0100
From: tculjaga(a)gmail.com
To: freeswitch-users(a)lists.freeswitch.org
Subject: Re: [Freeswitch-users] Radius AAA
<action application="log" data="INFO credit_time=${credit_time}"/>
<action application="sched_hangup" data="+${credit_time:17:-1} ${Core-UUID}"/>
In this scenario you don't have to check for return code, because you will get hangup
if authentication fails.
Nice one Nazim :P
T.
_______________________________________________
FreeSWITCH-users mailing list
FreeSWITCH-users(a)lists.freeswitch.org
http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
http://www.freeswitch.org
2
1
13 Dec '10
Hi i try to start mod_h323 but i have follow issue.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.430472 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.430472 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
2010-12-13 17:29:22.432465 [DEBUG] transports.cxx:1475 Waiting on socket
accept on ip$10.0.0.1:1720
2010-12-13 17:29:22.432465 [INFO] transports.cxx:1482 Failed to open
transport, connection not started.
On Mon, 2010-12-13 at 17:48 +0300,
freeswitch-users-request(a)lists.freeswitch.org wrote:
> Send FreeSWITCH-users mailing list submissions to
> freeswitch-users(a)lists.freeswitch.org
>
> To subscribe or unsubscribe via the World Wide Web, visit
> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
> or, via email, send a message with subject or body 'help' to
> freeswitch-users-request(a)lists.freeswitch.org
>
> You can reach the person managing the list at
> freeswitch-users-owner(a)lists.freeswitch.org
>
> When replying, please edit your Subject line so it is more specific
> than "Re: Contents of FreeSWITCH-users digest..."
> Today's Topics:
>
> 1. Re: opal to sip problem (Nikolay Kondratyev)
> MHTML Document attachment
> > -------- Forwarded Message --------
> > From: Nikolay Kondratyev <kond(a)nstel.ru>
> > Reply-to: FreeSWITCH Users Help
> > <freeswitch-users(a)lists.freeswitch.org>
> > To: 'FreeSWITCH Users Help' <freeswitch-users(a)lists.freeswitch.org>
> > Subject: Re: [Freeswitch-users] opal to sip problem
> > Date: Mon, 13 Dec 2010 17:48:08 +0300
> >
> > I can't help you with mod_opal, but I use FS with mod_h323 ad sip<->h.323
> > gateway successfully.
> > Rgds,
> > Nikolay.
> >
> > > -----Original Message-----
> > > From: freeswitch-users-bounces(a)lists.freeswitch.org
> > > [mailto:freeswitch-users-bounces@lists.freeswitch.org] On
> > > Behalf Of Gustavo Espeche
> > > Sent: Monday, December 13, 2010 5:24 PM
> > > To: freeswitch-users(a)lists.freeswitch.org
> > > Subject: [Freeswitch-users] opal to sip problem
> > >
> > > Hello list, we are try to do inter-worker between h323 and sip using
> > > opal in freeswitch, but FS don't send the call to our sip gw,
> > > follow is
> > > the call flow:
> > >
> > > h323 endpoint -->FS->sip gateway
> > >
> > > attached a FS debug of call.
> > >
> > > if something know or work with opal in freeSwitch and have
> > > some tips we
> > > appreciate a lot if advice about it.
> > > Best Regards.
> > > --------------------------------------------------------------
> > > ---------------------------------------------------------------
> > > 2010-12-13 11:58:21.325242 [DEBUG] transports.cxx:1200 Started
> > > connection to 200.117.192.17:19270 (if=10.0.0.1:1720)
> > > 2010-12-13 11:58:21.325242 [DEBUG] osutil.cxx:189 File handle
> > > high water
> > > mark set: 67 Thread unblock pipe
> > > 2010-12-13 11:58:21.325242 [DEBUG] tlibthrd.cxx:587 Thread high water
> > > mark set: 8
> > > 2010-12-13 11:58:21.325242 [DEBUG] transports.cxx:666 Waiting
> > > on socket
> > > accept on tcp$10.0.0.1:1720
> > > 2010-12-13 11:58:21.325242 [DEBUG] h323ep.cxx:501 Awaiting first PDU
> > > 2010-12-13 11:58:21.805203 [DEBUG] h323pdu.cxx:80 Receiving PDU:
> > > {
> > > q931pdu = {
> > > protocolDiscriminator = 8
> > > callReference = 22716
> > > from = originator
> > > messageType = Setup
> > > IE: Bearer-Capability = {
> > > 88 93 a5
> > > ...
> > > }
> > > IE: Display = {
> > > 67 75 73 74 61 76 6f 00 gustavo.
> > > }
> > > IE: Called-Party-Number = {
> > > 81 32 33 31 35 34 33 35 31 34 32 38 30 36 33
> > > 33 .231543514280633
> > > }
> > >
> > > IE: User-User = {
> > > 20 b8 06 00 08 91 4a 00 06 01 40 06 00 67 00
> > > 75 .....J...@..g.u
> > > 00 73 00 74 00 61 00 76 00 6f 22 c0 09 00 00
> > > 3d .s.t.a.v.o"....=
> > > ...
> > > }
> > > }
> > > h225pdu = {
> > > h323_uu_pdu = {
> > > h323_me
> > > ssage_body = setup {
> > > protocolIdentifier = 0.0.8.2250.0.6
> > > sourceAddress = 1 entries {
> > > [0]=h323_ID 7 characters {
> > > 0067 0075 0073 0074 0061 0076 006f gustavo
> > > }
> > > }
> > > sour
> > > ceInfo = {
> > > vendor = {
> > > vendor = {
> > > t35CountryCode = 9
> > > t35Extension = 0
> > > manufacturerCode = 61
> > > }
> > > productId = 3 octets {
> > > 00 00 00
> > > (OPAL v3.6
> > > 2e 36 29 00 00 .6
> > > )..
> > > }
> > > }
> > > terminal = {
> > > }
> > > mc = false
> > > undefinedNode = false
> > > }
> > > destinationAddress = 1 entries {
> > > [0]=dialedDigits "231543514280633"
> > > }
> > >
> > > Log-Func:
> > > Log-Line: 0
> > > User-Data:
> > >
> > > destCallSignalAddress = ipAddress {
> > > ip = 4 octets {
> > > 48 33 2f 64 H3/d
> > > }
> > > port = 1720
> > > }
> > > activeMC = falets {
> > > 4e 76 b2 f2 1d 05 e0 11 9b b7 00 1e 64 1f 33 fe
> > > Nv..........d.3.
> > > }
> > > conferenceGoal = create <<null>>
> > > callType = pointToPoint <<null>>
> > > sourceCallSignalAddress = ipAddress {
> > > ip =
> > > Log-Func:
> > > Log-Line: 0
> > > User-Data:
> > >
> > > 4 octets {
> > > c8 75 c0 11 .u..
> > > }
> > > port = 19270
> > > }
> > > callIdentifier = {
> > > guid = 16 octets {
> > > 3a 76 f 33 fe :v..........d.3.
> > > }
> > > }
> > > fastStart = 8 entries {
> > > [0]= 29 octets {
> > > 40 00 00 06 04 01 00 4c 20 13 80 11 1c 00 01 00
> > > @......L .......
> > > c8 75 c0 11 13 de 00 c8 75 c0 11 13
> > > df .u......u....
> > > }
> > > [1]= 19 octets {
> > > 00 00 64 0c 20 13 80 0b 0d 00 01 00 c8 75 c0
> > > 11 ..d. ........u..
> > > 13 df 00 ...
> > > }
> > > [
> > > 2]= 35 octets {
> > > 40 00 00 06 04 01 00 48 78 00 4a ff 00 80 01 00
> > > @......Hx.J.....
> > > 80 11 1c 00 02 00 c8 75 c0 11 13 e0 00 c8 75
> > > c0 .......u......u.
> > > ...
> > > }
> > > [3]= 25 octets {
> > >
> > > 00 00 65 08 78 00 4a ff 00 80 01 00 80 0b 0d
> > > 00 ..e.x.J.........
> > > 02 00 c8 75 c0 11 13 e1
> > > 00 ...u.....
> > > }
> > > [4]= 34 octets {
> > > 40 00 00 06 04 01 00 48 68 4a ff 00 80 01
> > > 00 80 @......HhJ......
> > > 11 1c 00 02 00 c8 75 c0 11 13 e0 00 c8 75 c0
> > > 11 ......u......u..
> > > ...
> > > }
> > > [5]= 24 octets {
> > > 00 00 66 08 68 4a ff 00 80 01 00 80 0b 0d 00
> > > 02 ..f.hJ..........
> > >
> > > 00 c8 75 c0 11 13 e1
> > > 00 ..u.....
> > > }
> > > [6]= 34 octets {
> > > 40 00 00 06 04 01 00 48 70 4a ff 00 80 01 00 80
> > > @......HpJ......
> > > 11 1c 00 02 00 c8 75 c0 11 13 e0 0
> > > 0 c8 75 c0 11 ......u......u..
> > > ...
> > > }
> > > [7]= 24 octets {
> > > 00 00 67 08 70 4a ff 00 80 01 00 80 0b 0d 00
> > > 02 ..g.pJ..........
> > > 00 c8 75 c0 11 13 e1
> > > 00 ..u.....
> > >
> > > }
> > > }
> > > mediaWaitForConnect = false
> > > canOverlapSend = false
> > > multipleCalls = false
> > > maintainConnection = false
> > > parallelH245Control = 2 entries {
> > > [0]= 125 octets {
> > >
> > > 02 70 01 06 00 08 81 75 00 0d 80 13 80 01 f4
> > > 00 .p.....u........
> > > 01 00 00 01 00 00 01 00 00 0c c0 01 00 01 80
> > > 07 ................
> > > ...
> > > }
> > > [1]= 7 octets {
> > > 01 00 32 80 5d 41 2
> > > b ..2.]A+
> > > }
> > > }
> > > }
> > > h245Tunneling = true
> > > }
> > > }
> > > }
> > > 2010-12-13 11:58:21.805203 [DEBUG] h323ep.cxx:510 Incoming call, first
> > > PDU: callReference=22716
> > > 2010-12-13 11:58:21.805203 [DEBUG] call.cxx:72 Created
> > > Call[Cc70e3cf91]
> > > 2010-12-13 11:58:21.805203 [DEBUG] connection.cxx:262 Created
> > > connection
> > > Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
> > > 2010-12-13 11:58:21.805203 [DEBUG] rfc2833.cxx:140 Handler created
> > > 2010-12-13 11:58:21.805203 [DEBUG] rfc2833.cxx:328 Rx
> > > capability set to
> > > "0-16,32,36"
> > > 2010-12-13 11:58:21.805203 [DEBUG] rfc2833.cxx:140 Handler created
> > > 2010-12-13 11:58:21.805203 [DEBUG] rfc2833.cxx:328 Rx
> > > capability set to
> > > "192,193"
> > > 2010-12-13 11:58:21.805203 [DEBUG] osutil.cxx:189 File handle
> > > high water
> > > mark set: 68 PUDPSocket
> > > 2010-12-13 11:58:21.808186 [DEBUG] h4601.cxx:1583 Endpoint Attached
> > > 2010-12-13 11:58:21.808186 [DEBUG] h323ep.cxx:552 Created new
> > > connection: tcp$200.117.192.17:19270/22716
> > > 2010-12-13 11:58:21.808186 [DEBUG] h323.cxx:559 Handling PDU: Setup
> > > callRef=22716
> > > 2010-12-13 11:58:21.808186 [DEBUG] connection.cxx:1516 SetPhase from
> > > UninitialisedPhase to SetUpPhase for Call[Cc70e3cf91]-EP<h323>[tcp
> > > $200.117.192.17:19270/22716]
> > > 2010-12-13 11:58:21.808186 [DEBUG] h323.cxx:943 Set protocol
> > > version to
> > > 6 and implying H.245 version 13
> > > 2010-12-13 11:58:21.808186 [DEBUG] h323.cxx:1240 Set remote
> > > application
> > > name: " 3.2.6 (OPAL v3.6.6) 9/61 "
> > > 2010-12-13 11:58:21.808186 [DEBUG] manager.cxx:1392 Checking incoming
> > > call for NAT: local=72.51.47.100, peer=200.117.192.17,
> > > sig=200.117.192.17
> > > 2010-12-13 11:58:21.808186 [DEBUG] h323.cxx:1041 Sending call
> > > proceeding
> > > PDU
> > > 2010-12-13 11:58:21.811196 [DEBUG] h323pdu.cxx:80 Sending PDU:
> > > {
> > > q931pdu = {
> > > protocolDiscriminator = 8
> > > callReference = 22716
> > > from = destination
> > > messageType = CallProceeding
> > > IE: Display = {
> > > 72 6f 6f 74 00
> > > root.
> > > }
> > > IE: User-User = {
> > > 21 80 06 00 08 91 4a 00 06 22 c0 09 00 00 3d
> > > 1e !.....J.."....=.
> > > 56 6f 78 20 4c 75 63 69 64 61 20 50 74 79 2e 20 Vox Lucida
> > > Pty.
> > > ...
> > > }
> > > }
> > > h225pdu = {
> > >
> > > h323_uu_pdu = {
> > > h323_message_body = callProceeding {
> > > protocolIdentifier = 0.0.8.2250.0.6
> > > destinationInfo = {
> > > vendor = {
> > > vendor = {
> > > t35CountryCode = 9
> > > t35Extensio
> > > n = 0
> > > manufacturerCode = 61
> > > }
> > > productId = 31 octets {
> > > 56 6f 78 20 4c 75 63 69 64 61 20 50 74 79 2e 20 Vox
> > > Lucida Pty.
> > > 4c 74 64 2e 20 6d 6f 64 5f 6f 70 61 6c 00 00
> > > Log-Line: 0
> > > UINCOMING DATA [(null)]
> > >
> > > RECV EVENT
> > > Event-Name: SOCKET_DATA
> > > ser-Data: _undef_
> > >
> > >
> > > }
> > > }
> > > terminal = {
> > > }
> > > mc = false
> > > undefinedNode = false
> > > }
> > > callIdentifier = {
> > > guid = 16 octets {
> > > 3a 76 b2 f2 1d 05 e0 11 9b b7 00 1e 64 1f 33 fe
> > > :v..........d.3.
> > > }
> > > }
> > > multipleCalls = false
> > > maintainConnection = false
> > > }
> > > h245Tunneling = true
> > > }
> > > }
> > > }
> > > 2010-12-13 11:58:21.811196 [DEBUG] manager.cxx:600 OnIncoming
> > > connection
> > > Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
> > > 2010-12-13 11:58:21.811196 [DEBUG] call.cxx:288
> > > GetOtherPartyConnection
> > > Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
> > > 2010-12-13 11:58:21.811196 [DEBUG] manager.cxx:1200 Searching
> > > for route
> > > "h323:root 231543514280633"
> > > 2010-12-13 11:58:21.811196 [DEBUG] manager.cxx:1228 Matched regex
> > > "h323:.*"
> > > 2010-12-13 11:58:21.811196 [DEBUG] manager.cxx:573 Set up
> > > connection to
> > > "local:231543514280633"
> > > 2010-12-13 11:58:21.811196 [DEBUG] connection.cxx:262 Created
> > > connection
> > > Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.811196 [DEBUG] localep.cxx:205 Created connection
> > > with token "Ldc8d6c462"
> > > 2010-12-13 11:58:21.811196 [DEBUG] h323.cxx:1075 Incoming
> > > call accepted
> > > 2010-12-13 11:58:21.811196 [DEBUG] mod_opal.cpp:770 Matched FS codec
> > > PCMA to OPAL media format G.711-ALaw-64k
> > > 2010-12-13 11:58:21.811196 [DEBUG] mod_opal.cpp:770 Matched FS codec
> > > G729 to OPAL media format G.729
> > > 2010-12-13 11:58:21.811196 [DEBUG] mod_opal.cpp:770 Matched FS codec
> > > PCMU to OPAL media format G.711-uLaw-64k
> > > 2010-12-13 11:58:21.811196 [DEBUG] mod_opal.cpp:770 Matched FS codec
> > > G723 to OPAL media format G.723.1
> > > 2010-12-13 11:58:21.814188 [DEBUG] call.cxx:425 GetMediaFormats for
> > > Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
> > > G.723.1
> > > G.729
> > > G.711-uLaw-64k
> > > G.711-ALaw-64k
> > >
> > > 2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2381 Could not find
> > > capability: "G.723.1"
> > > 2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2284 Added capability:
> > > G.723.1 <1>
> > > 2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2381 Could not find
> > > capability: "G.729"
> > > 2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2284 Added capability:
> > > G.729 <2>
> > > 2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2381 Could not find
> > > capability: "G.711-uLaw-64k"
> > > 2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2284 Added capability:
> > > G.711-uLaw-64k <3>
> > > 2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2381 Could not find
> > > capability: "G.711-ALaw-64k"
> > > 2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2284 Added capability:
> > > G.711-ALaw-64k <4>
> > > 2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2376 Found capability:
> > > G.723.1 <1>
> > > 2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2376 Found capability:
> > > G.729 <2>
> > > 2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2376 Found capability:
> > > G.711-uLaw-64k <3>
> > > 2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2376 Found capability:
> > > G.711-ALaw-64k <4>
> > > 2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2284 Added capability:
> > > UserInput/hookflash <5>
> > > 2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2284 Added capability:
> > > UserInput/basicString <6>
> > > 2010-12-13 11:58:21.817197 [DEBUG] h323caps.cxx:2284 Added capability:
> > > UserInput/dtmf <7>
> > > 2010-12-13 11:58:21.817197 [DEBUG] h323caps.cxx:2284 Added capability:
> > > UserInput/RFC2833 <8>
> > > 2010-12-13 11:58:21.817197 [DEBUG] h323caps.cxx:2376 Found capability:
> > > UserInput/RFC2833 <8>
> > > 2010-12-13 11:58:21.817197 [DEBUG] call.cxx:288
> > > GetOtherPartyConnection
> > > Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
> > > 2010-12-13 11:58:21.817197 [DEBUG] h323.cxx:3704 SetLocalCapabilities:
> > > Table:
> > > G.723.1 <1>
> > > G.729 <2>
> > > G.711-uLaw-64k <3>
> > > G.711-ALaw-64k <4>
> > > UserInput/hookflash <5>
> > > UserInput/basicString <6>
> > > UserInput/dtmf <7>
> > > UserInput/RFC2833 <8>
> > > Set:
> > > 0:
> > >
> > >
> > > Log-Func:
> > > Log-Line: 0
> > > User-Data:
> > >
> > > 0:
> > > G.723.1 <1>
> > > G.729 <2>
> > > G.711-uLaw-64k <3>
> > > G.711-ALaw-64k <4>
> > > 1:
> > > UserInput/hookflash <5>
> > > 2:
> > > UserInput/basicString <6>
> > > UserInput/dtINCOMING DATA [(null)]
> > >
> > > RECV EVENT
> > > Event-Name: SOCKET_DATA
> > >
> > >
> > > 2010-12-13 11:58:21.817197 [DEBUG] h323.cxx:1121 Fast start detected
> > > 2010-12-13 11:58:21.817197 [DEBUG] h323caps.cxx:2594 Could not find
> > > capability: audioData, type g711Alaw64k
> > > 2010-12-13 11:58:21.817197 [DEBUG] h323caps.cxx:845
> > > Capability tx frames
> > > left at 20 as remote allows 20
> > > 2010-12-13 11:58:21.817197 [DEBUG] h323caps.cxx:2294 Added capability:
> > > G.711-ALaw-64k <4>
> > > 2010-12-13 11:58:21.817197 [DEBUG] h323caps.cxx:845
> > > Capability tx frames
> > > left at 20 as remote allows 20
> > > 2010-12-13 11:58:21.817197 [DEBUG] h323caps.cxx:2594 Could not find
> > > capability: videoData, type h261VideoCapability
> > > 2010-12-13 11:58:21.817197 [DEBUG] h323caps.cxx:2594 Could not find
> > > capability: videoData, type h261VideoCapability
> > > 2010-12-13 11:58:21.817197 [DEBUG] h323caps.cxx:2594 Could not find
> > > capability: videoData, type h261VideoCapability
> > > 2010-12-13 11:58:21.817197 [DEBUG] h323caps.cxx:2594 Could not find
> > > capability: videoData, type h261VideoCapability
> > > 2010-12-13 11:58:21.820187 [DEBUG] h323caps.cxx:2594 Could not find
> > > capability: videoData, type h261VideoCapability
> > > 2010-12-13 11:58:21.820187 [DEBUG] h323caps.cxx:2594 Could not find
> > > capability: videoData, type h261VideoCapability
> > > 2010-12-13 11:58:21.820187 [DEBUG] h323caps.cxx:2594 Could not find
> > > capability: videoData, type h261VideoCapability
> > > 2010-12-13 11:58:21.820187 [DEBUG] h323caps.cxx:2594 Could not find
> > > capability: videoData, type h261VideoCapability
> > > 2010-12-13 11:58:21.820187 [DEBUG] h323caps.cxx:2594 Could not find
> > > capability: videoData, type h261VideoCapability
> > > 2010-12-13 11:58:21.820187 [DEBUG] h323caps.cxx:2594 Could not find
> > > capability: videoData, type h261VideoCapability
> > > 2010-12-13 11:58:21.820187 [DEBUG] h323caps.cxx:2594 Could not find
> > > capability: videoData, type h261VideoCapability
> > > 2010-12-13 11:58:21.820187 [DEBUG] h323caps.cxx:2594 Could not find
> > > capability: videoData, type h261VideoCapability
> > > 2010-12-13 11:58:21.820187 [DEBUG] call.cxx:288
> > > GetOtherPartyConnection
> > > Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.820187 [DEBUG] call.cxx:169 OnSetUp
> > > Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
> > > 2010-12-13 11:58:21.820187 [DEBUG] localep.cxx:240 Incoming call from
> > > gustavo [200.117.192.17]
> > > 2010-12-13 11:58:21.820187 [DEBUG] mod_opal.cpp:641 Created switch
> > > caller profile:
> > > username =
> > > dialplan = XML
> > > caller_id_name = gustavo [200.117.192.17]
> > > caller_id_number = 0000000000
> > > network_addr =
> > > source = opal
> > > context
> > > Log-Func:
> > > Log-Line: 0
> > > User-Data:
> > >
> > > = default
> > > 2010-12-13 11:58:21.823196 [NOTICE] switch_channel.c:784 New Channel
> > > opal/in:231543514280633 [7b4a89ac-b5d7-4fb4-bab5-ddaa8e73485c]
> > > 2010-12-13 11:58:21.823196 [DEBUG] mod_opal.cpp:647
> > > (opal/in:231543514280633) State Change CS_NEW -> CS_INIT
> > > 2010-12-13 11:58:21.823196 [DEBUG] mod_opal.cpp:1092 State changed on
> > > connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.823196 [DEBUG] switch_core_session.c:1083 Send
> > > signal opal/in:231543514280633 [BREAK]
> > > 2010-12-13 11:58:21.823196 [DEBUG] mod_opal.cpp:931 Kill 3 on
> > > connection
> > > Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.823196 [DEBUG] connection.cxx:1516 SetPhase from
> > > UninitialisedPhase to AlertingPhase for
> > > Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.823196 [NOTICE] mod_opal.cpp:676 Ring-Ready
> > > opal/in:231543514280633!
> > > 2010-12-13 11:58:21.823196 [DEBUG] manager.cxx:678 OnAlerting
> > > Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.823196 [DEBUG] call.cxx:196 OnAlerting
> > > Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.823196 [DEBUG] h323.cxx:2067 SetAlerting
> > > Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
> > > 2010-12-13 11:58:21.823196 [DEBUG] switch_core_state_machine.c:320
> > > (opal/in:231543514280633) Running State Change CS_INIT
> > > 2010-12-13 11:58:21.823196 [DEBUG] switch_core_state_machine.c:356
> > > (opal/in:231543514280633) State INIT
> > > 2010-12-13 11:58:21.823196 [DEBUG] osutil.cxx:189 File handle
> > > high water
> > > mark set: 72 Thread unblock pipe
> > > 2010-12-13 11:58:21.823196 [DEBUG] tlibthrd.cxx:587 Thread high water
> > > mark set: 10
> > > 2010-12-13 11:58:21.823196 [DEBUG] mod_opal.cpp:842 Started
> > > routing for
> > > connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.823196 [DEBUG] mod_opal.cpp:843
> > > (opal/in:231543514280633) State Change CS_INIT -> CS_ROUTING
> > > 2010-12-13 11:58:21.823196 [DEBUG] mod_opal.cpp:1092 State changed on
> > > connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.823196 [DEBUG] switch_core_session.c:1083 Send
> > > signal opal/in:231543514280633 [BREAK]
> > > 2010-12-13 11:58:21.823196 [DEBUG] mod_opal.cpp:931 Kill 3 on
> > > connection
> > > Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.823196 [DEBUG] switch_core_state_machine.c:356
> > > (opal/in:231543514280633) State INIT going to sleep
> > > 2010-12-13 11:58:21.823196 [DEBUG] switch_core_state_machine.c:320
> > > (opal/in:231543514280633) Running State Change CS_ROUTING
> > > 2010-12-13 11:58:21.823196 [DEBUG] switch_channel.c:1615
> > > (opal/in:231543514280633) Callstate Change DOWN -> RINGING
> > > 2010-12-13 11:58:21.823196 [DEBUG] switch_core_state_machine.c:359
> > > (opal/in:231543514280633) State ROUTING
> > > 2010-12-13 11:58:21.823196 [DEBUG] mod_opal.cpp:850 Routing connection
> > > Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.823196 [DEBUG] switch_core_state_machine.c:77
> > > opal/in:231543514280633 Standard ROUTING
> > > 2010-12-13 11:58:21.823196 [INFO] mod_dialplan_xml.c:331 Processing
> > > gustavo [200.117.192.17] <0000000000>->231543514280633 in context
> > > default
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323pdu.cxx:80 Receiving PDU:
> > > request terminalCapabilitySet {
> > > sequenceNumber = 1
> > > protocolIdentifier = 0.0.8.245.0.13
> > > multiplexCapability = h2250Capability {
> > > maximumAudioDelayJitter = 500
> > > receiveMultipointCapabi
> > > lity = {
> > > multicastCapability = false
> > > multiUniCastConference = false
> > > mediaDistributionCapability = 1 entries {
> > > [0]={
> > > centralizedControl = false
> > > distributedControl = false
> > > centraliz
> > > edAudio = false
> > > distributedAudio = false
> > > centralizedVideo = false
> > > distributedVideo = false
> > > }
> > > }
> > > }
> > > transmitMultipointCapability = {
> > > multicastCapability = false
> > > multiUniC
> > > astConference = false
> > > mediaDistributionCapability = 1 entries {
> > > [0]={
> > > centralizedControl = false
> > > distributedControl = false
> > > centralizedAudio = false
> > > distributedAudio = false
> > >
> > > centralizedVideo = false
> > > distributedVideo = false
> > > }
> > > }
> > > }
> > > receiveAndTransmitMultipointCapability = {
> > > multicastCapability = false
> > > multiUniCastConference = false
> > > mediaDistributionCapab
> > > ility = 1 entries {
> > > [0]={
> > > centralizedControl = false
> > > distributedControl = false
> > > centralizedAudio = false
> > > distributedAudio = false
> > > centralizedVideo = false
> > > distributedV
> > > ideo = false
> > > }
> > > }
> > > }
> > > mcCapability = {
> > > centralizedConferenceMC = false
> > > decentralizedConferenceMC = false
> > > }
> > > rtcpVideoControlCapability = false
> > > mediaPacketizationCapability = {
> > > h261a
> > > VideoPacketization = false
> > > }
> > > logicalChannelSwitchingCapability = false
> > > t120DynamicPortCapability = true
> > > }
> > > capabilityTable = 8 entries {
> > > [0]={
> > > capabilityTableEntryNumber = 1
> > > capability = receiveAudioCap
> > > ability g711Alaw64k 240
> > > }
> > > [1]={
> > > capabilityTableEntryNumber = 2
> > > capability = receiveVideoCapability h261VideoCapability {
> > > qcifMPI = 1
> > > cifMPI = 1
> > > temporalSpatialTradeOffCapability = false
> > >
> > > maxBitRate = 19200
> > > stillImageTransmission = false
> > > videoBadMBsCap = false
> > > }
> > > }
> > > [2]={
> > > capabilityTableEntryNumber = 3
> > > capability = receiveVideoCapability h261VideoCapability {
> > > cifMPI
> > > = 1
> > > temporalSpatialTradeOffCapability = false
> > > maxBitRate = 19200
> > > stillImageTransmission = false
> > > videoBadMBsCap = false
> > > }
> > > }
> > > [3]={
> > > capabilityTableEntryNumber = 4
> > > capability =
> > > receiveVideoCapability h261VideoCapability {
> > > qcifMPI = 1
> > > temporalSpatialTradeOffCapability = false
> > > maxBitRate = 19200
> > > stillImageTransmission = false
> > > videoBadMBsCap = false
> > > }
> > > }
> > > [4
> > > ]={
> > > capabilityTableEntryNumber = 5
> > > capability = receiveUserInputCapability hookflash <<null>>
> > > }
> > > [5]={
> > > capabilityTableEntryNumber = 6
> > > capability = receiveUserInputCapability basicString <<null>>
> > > }
> > >
> > > [6]={
> > > capabilityTableEntryNumber = 7
> > > capability = receiveUserInputCapability dtmf <<null>>
> > > }
> > > [7]={
> > > capabilityTableEntryNumber = 8
> > > capability = receiveRTPAudioTelephonyEventCapability {
> > > dynamic
> > > RTPPayloadType = 101
> > > audioTelephoneEvent = "0-16"
> > > }
> > > }
> > > }
> > > capabilityDescriptors = 1 entries {
> > > [0]={
> > > capabilityDescriptorNumber = 1
> > > simultaneousCapabilities = 4 entries {
> > > [0]=1 entries {
> > >
> > > [0]=1
> > > }
> > > [1]=3 entries {
> > > [0]=2
> > > [1]=3
> > > [2]=4
> > > }
> > > [2]=1 entries {
> > > [0]=5
> > > }
> > > [3]=3 entries {
> > > [0]=6
> > > [1]=7
> > >
> > > Log-Func:
> > > Log-Line: 0
> > > User-Data:
> > >
> > > [2]=8
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323.cxx:2792 Set protocol
> > > version to 13
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323neg.cxx:378 Received
> > > TerminalCapabilitySet: state=Idle pduSeq=1 inSeq=4294967295
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:1988
> > > H323Capabilities(ctor)
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2294 Added capability:
> > > G.723.1 <1>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2294 Added capability:
> > > G.729 <2>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2294 Added capability:
> > > G.711-uLaw-64k <3>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2294 Added capability:
> > > G.711-ALaw-64k <4>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2294 Added capability:
> > > UserInput/hookflash <5>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2294 Added capability:
> > > UserInput/basicString <6>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2294 Added capability:
> > > UserInput/dtmf <7>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2294 Added capability:
> > > UserInput/RFC2833 <8>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2355 Found capability:
> > > G.723.1 <1>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2355 Found capability:
> > > G.729 <2>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2355 Found capability:
> > > G.711-uLaw-64k <3>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2355 Found capability:
> > > G.711-ALaw-64k <4>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2355 Found capability:
> > > UserInput/hookflash <5>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2355 Found capability:
> > > UserInput/basicString <6>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2355 Found capability:
> > > UserInput/dtmf <7>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2355 Found capability:
> > > UserInput/RFC2833 <8>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2376 Found capability:
> > > G.711-ALaw-64k <4>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2376 Found capability:
> > > G.711-uLaw-64k <3>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2376 Found capability:
> > > G.723.1 <1>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2381 Could not find
> > > capability: "G.723.1(5.3k)"
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2284 Added capability:
> > > G.723.1 <9>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2381 Could not find
> > > capability: "G.723.1A(5.3k)"
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2284 Added capability:
> > > G.723.1 <10>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2381 Could not find
> > > capability: "G.723.1A(6.3k)"
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2284 Added capability:
> > > G.723.1 <11>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2381 Could not find
> > > capability: "G.728"
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2284 Added capability:
> > > G.728 <12>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2376 Found capability:
> > > G.729 <2>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2381 Could not find
> > > capability: "G.729A"
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2284 Added capability:
> > > G.729A <13>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2381 Could not find
> > > capability: "G.729A/B"
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2284 Added capability:
> > > G.729A/B <14>
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2381 Could not find
> > > capability: "G.729B"
> > > 2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2284 Added capability:
> > > G.729B <15>
> > > 2010-12-13 11:58:21.831146 [DEBUG] h323caps.cxx:2381 Could not find
> > > capability: "GSM-06.10"
> > > 2010-12-13 11:58:21.831146 [DEBUG] h323caps.cxx:2284 Added capability:
> > > GSM-06.10 <16>
> > > 2010-12-13 11:58:21.831146 [DEBUG] h323caps.cxx:2381 Could not find
> > > capability: "GSM-AMR"
> > > 2010-12-13 11:58:21.831146 [DEBUG] h323caps.cxx:2284 Added capability:
> > > GSM-AMR <17>
> > > 2010-12-13 11:58:21.831146 [DEBUG] h323caps.cxx:2381 Could not find
> > > capability: "T.38"
> > > 2010-12-13 11:58:21.831146 [DEBUG] h323caps.cxx:2284 Added capability:
> > > T.38 <18>
> > > 2010-12-13 11:58:21.831146 [DEBUG] h323caps.cxx:2376 Found capability:
> > > UserInput/RFC2833 <8>
> > > 2010-12-13 11:58:21.831146 [DEBUG] h323caps.cxx:2376 Found capability:
> > > UserInput/basicString <6>
> > > 2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2376 Found capability:
> > > UserInput/dtmf <7>
> > > 2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2381 Could not find
> > > capability: "UserInput/generalString"
> > > 2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2284 Added capability:
> > > UserInput/generalString <19>
> > > 2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2376 Found capability:
> > > UserInput/hookflash <5>
> > > 2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2381 Could not find
> > > capability: "UserInput/iA5String"
> > > 2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2284 Added capability:
> > > UserInput/iA5String <20>
> > > 2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2381 Could not find
> > > capability: "iLBC"
> > > 2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2284 Added capability:
> > > iLBC <21>
> > > 2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2284 Added capability:
> > > UserInput/hookflash <22>
> > > 2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2284 Added capability:
> > > UserInput/basicString <23>
> > > 2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2284 Added capability:
> > > UserInput/dtmf <24>
> > > 2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2284 Added capability:
> > > UserInput/RFC2833 <25>
> > > 2010-12-13 11:58:21.834192 [CONSOLE] mod_xml_curl.c:312 XML
> > > response is
> > > in /tmp/90f1dd7d-a63c-4e15-981c-6eed9e70313b.tmp.xml
> > > Dialplan: opal/in:231543514280633 parsing [default->external]
> > > continue=false
> > > Dialplan: opal/in:231543514280633 Regex (PASS) [external]
> > > destination_number(231543514280633) =~ /^231543514280633/
> > > break=on-false
> > > Dialplan: opal/in:231543514280633 Action set(continue_on_fail=true)
> > > Dialplan: opal/in:231543514280633 Action
> > > set(hangup_after_bridge=true)
> > > Dialplan: opal/in:231543514280633 Action set(progress_timeout=15)
> > > Dialplan: opal/in:231543514280633 Action set(proxy_media=false)
> > > Dialplan: opal/in:231543514280633 Action set(bypass_media=true)
> > > Dialplan: opal/in:231543514280633 Action
> > > set(absolute_codec_string=PCMA)
> > > Dialplan: opal/in:231543514280633 Action
> > > bridge(sofia/external/21543514280633(a)200.35.145.149)
> > > 2010-12-13 11:58:21.834192 [DEBUG] switch_core_state_machine.c:119
> > > (opal/in:231543514280633) State Change CS_ROUTING -> CS_EXECUTE
> > > 2010-12-13 11:58:21.834192 [DEBUG] mod_opal.cpp:1092 State changed on
> > > connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.834192 [DEBUG] switch_core_session.c:1083 Send
> > > signal opal/in:231543514280633 [BREAK]
> > > 2010-12-13 11:58:21.834192 [DEBUG] mod_opal.cpp:931 Kill 3 on
> > > connection
> > > Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.834192 [DEBUG] switch_core_state_machine.c:359
> > > (opal/in:231543514280633) State ROUTING going to sleep
> > > 2010-12-13 11:58:21.834192 [DEBUG] switch_core_state_machine.c:320
> > > (opal/in:231543514280633) Running State Change CS_EXECUTE
> > > 2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2284 Added capability:
> > > H.239-Video+H.239-Video <26>
> > > 2010-12-13 11:58:21.834192 [DEBUG] switch_core_state_machine.c:366
> > > (opal/in:231543514280633) State EXECUTE
> > > 2010-12-13 11:58:21.834192 [DEBUG] mod_opal.cpp:857 Executing
> > > connection
> > > Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.834192 [DEBUG] switch_core_state_machine.c:157
> > > opal/in:231543514280633 Standard EXECUTE
> > > EXECUTE opal/in:231543514280633 set(continue_on_fail=true)
> > > 2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2284 Added capability:
> > > H.239-Control <27>
> > > 2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2029 Parsing remote
> > > capabilities
> > > 2010-12-13 11:58:21.837191 [DEBUG] mod_opal.cpp:1076 Received
> > > message 26
> > > on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.837191 [DEBUG] mod_dptools.c:1028
> > > opal/in:231543514280633 SET [continue_on_fail]=[true]
> > > 2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:819
> > > Capability tx frames
> > > left at 20 as remote allows 240
> > > 2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2529 Could not find
> > > capability: receiveVideoCapability, type h261VideoCapability
> > > 2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2529 Could not find
> > > capability: receiveVideoCapability, type h261VideoCapability
> > > 2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2529 Could not find
> > > capability: receiveVideoCapability, type h261VideoCapability
> > > 2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2671 Found capability:
> > > UserInput/RFC2833 <8>
> > > 2010-12-13 11:58:21.837191 [DEBUG] mod_opal.cpp:1076 Received
> > > message 27
> > > on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > EXECUTE opal/in:231543514280633 set(hangup_after_bridge=true)
> > > 2010-12-13 11:58:21.837191 [DEBUG] mod_opal.cpp:1076 Received
> > > message 26
> > > on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.837191 [DEBUG] mod_dptools.c:1028
> > > opal/in:231543514280633 SET [hangup_after_bridge]=[true]
> > > 2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2411 Could not find
> > > capability: G.711-ALaw-64k <1>
> > > 2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2294 Added capability:
> > > G.711-ALaw-64k <1>
> > > 2010-12-13 11:58:21.837191 [DEBUG] mod_opal.cpp:1076 Received
> > > message 27
> > > on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > EXECUTE opal/in:231543514280633 set(progress_timeout=15)
> > > 2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2411 Could not find
> > > capability: UserInput/hookflash <5>
> > > 2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2294 Added capability:
> > > UserInput/hookflash <5>
> > > 2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2411 Could not find
> > > capability: UserInput/basicString <6>
> > > 2010-12-13 11:58:21.837191 [DEBUG] mod_opal.cpp:1076 Received
> > > message 26
> > > on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.837191 [DEBUG] mod_dptools.c:1028
> > > opal/in:231543514280633 SET [progress_timeout]=[15]
> > > 2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2294 Added capability:
> > > UserInput/basicString <6>
> > > 2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2411 Could not find
> > > capability: UserInput/dtmf <7>
> > > 2010-12-13 11:58:21.840189 [DEBUG] h323caps.cxx:2294 Added capability:
> > > UserInput/dtmf <7>
> > > 2010-12-13 11:58:21.840189 [DEBUG] h323caps.cxx:2411 Could not find
> > > capability: UserInput/RFC2833 <8>
> > > 2010-12-13 11:58:21.840189 [DEBUG] h323caps.cxx:2294 Added capability:
> > > UserInput/RFC2833 <8>
> > > 2010-12-13 11:58:21.840189 [DEBUG] h323caps.cxx:2355 Found capability:
> > > G.711-ALaw-64k <1>
> > > 2010-12-13 11:58:21.840189 [DEBUG] h323caps.cxx:2355 Found capability:
> > > UserInput/hookflash <5>
> > > 2010-12-13 11:58:21.840189 [DEBUG] h323caps.cxx:2355 Found capability:
> > > UserInput/basicString <6>
> > > 2010-12-13 11:58:21.840189 [DEBUG] h323caps.cxx:2355 Found capability:
> > > UserInput/dtmf <7>
> > > 2010-12-13 11:58:21.840189 [DEBUG] h323caps.cxx:2355 Found capability:
> > > UserInput/RFC2833 <8>
> > > 2010-12-13 11:58:21.840189 [DEBUG] mod_opal.cpp:1076 Received
> > > message 27
> > > on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > EXECUTE opal/in:231543514280633 set(proxy_media=false)
> > > 2010-12-13 11:58:21.840189 [DEBUG] h323caps.cxx:2777 Capability merge
> > > result:
> > > Table:
> > > G.711-ALaw-64k <1>
> > > UserInput/hookflash <5>
> > > UserInput/basicString <6>
> > > UserInput/dtmf <7>
> > > UserInput/RFC2833 <8>
> > > Set:
> > > 0:
> > > 0:
> > >
> > >
> > > Log-Func:
> > > Log-Line: 0
> > > User-Data:
> > >
> > > G.711-ALaw-64k <1>
> > > 1:
> > > 2:
> > > UserInput/hookflash <5>
> > > 3:
> > > UserInput/basicString <6>
> > > UserInput/dtmf <INCOMING DATA [(null)]
> > >
> > > RECV EVENT
> > > Event-Name: SOCKET_DATA
> > >
> > >
> > > 2010-12-13 11:58:21.840189 [DEBUG] h323caps.cxx:2778 Received
> > > capability
> > > set, is accepted
> > > 2010-12-13 11:58:21.840189 [DEBUG] mod_opal.cpp:1076 Received
> > > message 26
> > > on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.840189 [DEBUG] mod_dptools.c:1028
> > > opal/in:231543514280633 SET [proxy_media]=[false]
> > > 2010-12-13 11:58:21.840189 [DEBUG] h323neg.cxx:341 Sending
> > > TerminalCapabilitySet: outSeq=1
> > > 2010-12-13 11:58:21.840189 [DEBUG] mod_opal.cpp:1076 Received
> > > message 27
> > > on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > EXECUTE opal/in:231543514280633 set(bypass_media=true)
> > > 2010-12-13 11:58:21.840189 [DEBUG] mod_opal.cpp:1076 Received
> > > message 26
> > > on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.840189 [DEBUG] mod_dptools.c:1028
> > > opal/in:231543514280633 SET [bypass_media]=[true]
> > > 2010-12-13 11:58:21.840189 [DEBUG] mod_opal.cpp:1076 Received
> > > message 27
> > > on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > EXECUTE opal/in:231543514280633 set(absolute_codec_string=PCMA)
> > > 2010-12-13 11:58:21.840189 [DEBUG] mod_opal.cpp:1076 Received
> > > message 26
> > > on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.840189 [DEBUG] mod_dptools.c:1028
> > > opal/in:231543514280633 SET [absolute_codec_string]=[PCMA]
> > > 2010-12-13 11:58:21.840189 [DEBUG] mod_opal.cpp:1076 Received
> > > message 27
> > > on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > EXECUTE opal/in:231543514280633
> > > bridge(sofia/external/21543514280633(a)200.35.145.149)
> > > 2010-12-13 11:58:21.840189 [DEBUG] mod_opal.cpp:1076 Received
> > > message 26
> > > on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.840189 [NOTICE] switch_channel.c:784 New Channel
> > > sofia/external/21543514280633(a)200.35.145.149
> > > [f9bf5b9e-a273-400c-b18c-e2c98c84750f]
> > > 2010-12-13 11:58:21.840189 [DEBUG] mod_sofia.c:3995
> > > (sofia/external/21543514280633(a)200.35.145.149) State Change CS_NEW ->
> > > CS_INIT
> > > 2010-12-13 11:58:21.840189 [DEBUG] switch_core_session.c:1083 Send
> > > signal sofia/external/21543514280633(a)200.35.145.149 [BREAK]
> > > 2010-12-13 11:58:21.843189 [DEBUG] h323pdu.cxx:80 Sending PDU:
> > > request terminalCapabilitySet {
> > > sequenceNumber = 1
> > > protocolIdentifier = 0.0.8.245.0.13
> > > multiplexCapability = h2250Capability {
> > > maximumAudioDelayJitter = 250
> > > receiveMultipointCapabili
> > > ty = {
> > > multicastCapability = false
> > > multiUniCastConference = false
> > > mediaDistributionCapability = 1 entries {
> > > [0]={
> > > centralizedControl = false
> > > distributedControl = false
> > > centralized
> > > Audio = false
> > > distributedAudio = false
> > > centralizedVideo = false
> > > distributedVideo = false
> > > }
> > > }
> > > }
> > > transmitMultipointCapability = {
> > > multicastCapability = false
> > > multiUniCas
> > > tConference = false
> > > mediaDistributionCapability = 1 entries {
> > > [0]={
> > > centralizedControl = false
> > > distributedControl = false
> > > centralizedAudio = false
> > > distributedAudio = false
> > >
> > > centralizedVideo = false
> > > distributedVideo = false
> > > }
> > > }
> > > }
> > > receiveAndTransmitMultipointCapability = {
> > > multicastCapability = false
> > > multiUniCastConference = false
> > > mediaDistributionCapabil
> > > ity = 1 entries {
> > > [0]={
> > > centralizedControl = false
> > > distributedControl = false
> > > centralizedAudio = false
> > > distributedAudio = false
> > > centralizedVideo = false
> > > distributedVid
> > > eo = false
> > > }
> > > }
> > > }
> > > mcCapability = {
> > > centralizedConferenceMC = false
> > > decentralizedConferenceMC = false
> > > }
> > > rtcpVideoControlCapability = false
> > > mediaPacketizationCapability = {
> > > h261aVi
> > > deoPacketization = false
> > > }
> > > logicalChannelSwitchingCapability = false
> > > t120DynamicPortCapability = true
> > > }
> > > capabilityTable = 8 entries {
> > > [0]={
> > > capabilityTableEntryNumber = 1
> > > capability = receiveAudioCapab
> > > ility g7231 {
> > > maxAl_sduAudioFrames = 8
> > > silenceSuppression = false
> > > }
> > > }
> > > [1]={
> > > capabilityTableEntryNumber = 2
> > > capability = receiveAudioCapability g729 24
> > > }
> > > [2]={
> > > capabilityTabl
> > > eEntryNumber = 3
> > > capability = receiveAudioCapability g711Ulaw64k 240
> > > }
> > > [3]={
> > > capabilityTableEntryNumber = 4
> > > capability = receiveAudioCapability g711Alaw64k 240
> > > }
> > > [4]={
> > > capabilityTableEntryNumbe
> > > r = 5
> > > capability = receiveUserInputCapability hookflash <<null>>
> > > }
> > > [5]={
> > > capabilityTableEntryNumber = 6
> > > capability = receiveUserInputCapability basicString <<null>>
> > > }
> > > [6]={
> > > capabilityTableEntry
> > > Number = 7
> > > capability = receiveUserInputCapability dtmf <<null>>
> > > }
> > > [7]={
> > > capabilityTableEntryNumber = 8
> > > capability = receiveRTPAudioTelephonyEventCapability {
> > > dynamicRTPPayloadType = 101
> > > audioT
> > > elephoneEvent = "0-16"
> > > }
> > > }
> > > }
> > > capabilityDescriptors = 1 entries {
> > > [0]={
> > > capabilityDescriptorNumber = 1
> > > simultaneousCapabilities = 3 entries {
> > > [0]=4 entries {
> > > [0]=1
> > > [1]=2
> > >
> > > [2]=3
> > > [3]=4
> > > }
> > > [1]=1 entries {
> > > [0]=5
> > > }
> > > [2]=3 entries {
> > > [0]=6
> > > [1]=7
> > > [2]=8
> > > }
> > > }
> > > }
> > > }
> > > }
> > > 2010-12-13 11:58:21.843189 [DEBUG] h323caps.cxx:2376 Found capability:
> > > UserInput/RFC2833 <8>
> > > 2010-12-13 11:58:21.843189 [DEBUG] h323.cxx:3535 User Input RFC2833
> > > payload type set to [pt=101]
> > > 2010-12-13 11:58:21.843189 [DEBUG] h323pdu.cxx:80 Sending PDU:
> > > response terminalCapabilitySetAck {
> > > sequenceNumber = 1
> > > }
> > > 2010-12-13 11:58:21.843189 [DEBUG] switch_core_state_machine.c:320
> > > (sofia/external/21543514280633(a)200.35.145.149) Running State Change
> > > CS_INIT
> > > 2010-12-13 11:58:21.843189 [DEBUG] switch_core_state_machine.c:356
> > > (sofia/external/21543514280633(a)200.35.145.149) State INIT
> > > 2010-12-13 11:58:21.843189 [DEBUG] mod_sofia.c:86
> > > sofia/external/21543514280633(a)200.35.145.149 SOFIA INIT
> > > 2010-12-13 11:58:21.843189 [DEBUG] h323.cxx:3771
> > > InternalEstablishedConnectionCheck:
> > > connectionState=AwaitingLocalAnswer
> > > fastStartState=FastStartResponse H.245 is unavailable
> > > 2010-12-13 11:58:21.843189 [DEBUG] h323pdu.cxx:80 Receiving PDU:
> > > request masterSlaveDetermination {
> > > terminalType = 50
> > > statusDeterminationNumber = 6111531
> > > }
> > > 2010-12-13 11:58:21.843189 [DEBUG] h323neg.cxx:129 Received
> > > MasterSlaveDetermination: state=Idle
> > > 2010-12-13 11:58:21.843189 [DEBUG] h323neg.cxx:160
> > > MasterSlaveDetermination: local is master
> > > 2010-12-13 11:58:21.843189 [DEBUG] h323pdu.cxx:80 Sending PDU:
> > > response masterSlaveDeterminationAck {
> > > decision = slave <<null>>
> > > }
> > > 2010-12-13 11:58:21.843189 [DEBUG] h323.cxx:3771
> > > InternalEstablishedConnectionCheck:
> > > connectionState=AwaitingLocalAnswer
> > > fastStartState=FastStartResponse H.245 is ready
> > > 2010-12-13 11:58:21.843189 [DEBUG] mod_sofia.c:126
> > > (sofia/external/21543514280633(a)200.35.145.149) State Change CS_INIT ->
> > > CS_ROUTING
> > > 2010-12-13 11:58:21.843189 [DEBUG] switch_core_session.c:1083 Send
> > > signal sofia/external/21543514280633(a)200.35.145.149 [BREAK]
> > > 2010-12-13 11:58:21.843189 [DEBUG] sofia.c:4604 Channel
> > > sofia/external/21543514280633(a)200.35.145.149 entering state
> > > [terminated][900]
> > > 2010-12-13 11:58:21.843189 [DEBUG] h323ep.cxx:1033
> > > OnSendAlerting conn =
> > > Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
> > > 2010-12-13 11:58:21.843189 [DEBUG] switch_channel.c:2455
> > > (sofia/external/21543514280633(a)200.35.145.149) Callstate
> > > Change DOWN ->
> > > HANGUP
> > > 2010-12-13 11:58:21.843189 [DEBUG] h323.cxx:2110 SetAlerting sending
> > > Alerting PDU
> > > 2010-12-13 11:58:21.843189 [NOTICE] sofia.c:5244 Hangup
> > > sofia/external/21543514280633(a)200.35.145.149 [CS_ROUTING]
> > > [NORMAL_UNSPECIFIED]
> > > 2010-12-13 11:58:21.843189 [DEBUG] switch_channel.c:2471 Send signal
> > > sofia/external/21543514280633(a)200.35.145.149 [KILL]
> > > 2010-12-13 11:58:21.843189 [DEBUG] switch_core_session.c:1083 Send
> > > signal sofia/external/21543514280633(a)200.35.145.149 [BREAK]
> > > 2010-12-13 11:58:21.843189 [DEBUG] switch_core_state_machine.c:356
> > > (sofia/external/21543514280633(a)200.35.145.149) State INIT
> > > going to sleep
> > > 2010-12-13 11:58:21.843189 [DEBUG] switch_core_state_machine.c:320
> > > (sofia/external/21543514280633(a)200.35.145.149) Running State Change
> > > CS_HANGUP
> > > 2010-12-13 11:58:21.846211 [DEBUG] h323pdu.cxx:80 Sending PDU:
> > > {
> > > q931pdu = {
> > > protocolDiscriminator = 8
> > > callReference = 22716
> > > from = destination
> > > messageType = Alerting
> > > IE: Display = {
> > > 72 6f 6f 74 00
> > > root.
> > > }
> > > IE: User-User = {
> > > 23 80 06 00 08 91 4a 00 06 22 c0 09 00 00 3d 1e
> > > #.....J.."....=.
> > > 56 6f 78 20 4c 75 63 69 64 61 20 50 74 79 2e 20 Vox Lucida
> > > Pty.
> > > ...
> > > }
> > > }
> > > h225pdu = {
> > > h323
> > > _uu_pdu = {
> > > h323_message_body = alerting {
> > > protocolIdentifier = 0.0.8.2250.0.6
> > > destinationInfo = {
> > > vendor = {
> > > vendor = {
> > > t35CountryCode = 9
> > > t35Extension = 0
> > >
> > > manufacturerCode = 61
> > > }
> > > productId = 31 octets {
> > > 56 6f 78 20 4c 75 63 69 64 61 20 50 74 79 2e 20 Vox
> > > Lucida Pty.
> > > 4c 74 64 2e 20 6d 6f 64 5f 6f 70 61 6c 00 00
> > > Ltd.
> > > mod_op
> > > Log-Line: 0
> > > User-Data:
> > >
> > > }
> > > terminal = {
> > > }
> > > mc = false
> > > undefinedNode = false
> > > }
> > > callIdentifier = {
> > > guid = 16 octets {
> > > 3a 76 b2 f2 1d 05 e0 11 9b b7 00 1e 64 1f 33
> > > fe :v........
> > > ..d.3.
> > > }
> > > }
> > > multipleCalls = false
> > > maintainConnection = false
> > > }
> > > h245Tunneling = true
> > > h245Control = 3 entries {
> > > [0]= 108 octets {
> > > 02 70 01 06 00 08 81 75 00 0d 80
> > > 13 80 00 fa 00 .p.....u........
> > > 01 00 00 01 00 00 01 00 00 0c c0 01 00 01 80
> > > 07 ................
> > > ...
> > > }
> > > [1]= 3 octets {
> > > 21 80 01 !..
> > > }
> > >
> > > [2]= 2 octets {
> > > 20 a0 .
> > > }
> > > }
> > > }
> > > }
> > > }
> > > 2010-12-13 11:58:21.846211 [DEBUG] h323ep.cxx:1039
> > > OnSentAlerting conn =
> > > Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
> > > 2010-12-13 11:58:21.846211 [DEBUG] h323.cxx:3771
> > > InternalEstablishedConnectionCheck:
> > > connectionState=AwaitingLocalAnswer
> > > fastStartState=FastStartResponse H.245 is ready
> > > 2010-12-13 11:58:21.846211 [DEBUG] connection.cxx:361
> > > OnSetUpConnectionCall[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.846211 [DEBUG] endpoint.cxx:408 OnSetUpConnection
> > > Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.846211 [DEBUG] h323.cxx:1701 OnAnswerCall
> > > Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716], caller =
> > > gustavo [200.117.192.17]
> > > 2010-12-13 11:58:21.846211 [DEBUG] call.cxx:219 OnAnswerCall
> > > Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716] caller
> > > "gustavo [200.117.192.17]"
> > > 2010-12-13 11:58:21.846211 [DEBUG] h323.cxx:1713 Answering call:
> > > AnswerCallDeferred
> > > 2010-12-13 11:58:21.846211 [DEBUG] connection.cxx:541 Answering call:
> > > AnswerCallDeferred
> > > 2010-12-13 11:58:21.846211 [DEBUG] h323.cxx:3771
> > > InternalEstablishedConnectionCheck:
> > > connectionState=AwaitingLocalAnswer
> > > fastStartState=FastStartResponse H.245 is ready
> > > 2010-12-13 11:58:21.846211 [DEBUG] h323.cxx:506 Reading PDUs:
> > > callRef=22716
> > > 2010-12-13 11:58:21.846211 [DEBUG]
> > > switch_ivr_originate.c:3448 Originate
> > > Resulted in Error Cause: 31 [NORMAL_UNSPECIFIED]
> > > 2010-12-13 11:58:21.849192 [INFO] mod_dptools.c:2579 Originate Failed.
> > > Cause: NORMAL_UNSPECIFIED
> > > 2010-12-13 11:58:21.849192 [DEBUG] mod_opal.cpp:1076 Received
> > > message 27
> > > on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.849192 [NOTICE] switch_core_state_machine.c:189
> > > opal/in:231543514280633 has executed the last dialplan instruction,
> > > hanging up.
> > > 2010-12-13 11:58:21.849192 [DEBUG] switch_channel.c:2455
> > > (opal/in:231543514280633) Callstate Change RINGING -> HANGUP
> > > 2010-12-13 11:58:21.849192 [NOTICE] switch_core_state_machine.c:191
> > > Hangup opal/in:231543514280633 [CS_EXECUTE] [NORMAL_CLEARING]
> > > 2010-12-13 11:58:21.849192 [DEBUG] switch_channel.c:2471 Send signal
> > > opal/in:231543514280633 [KILL]
> > > 2010-12-13 11:58:21.849192 [DEBUG] mod_opal.cpp:931 Kill 1 on
> > > connection
> > > Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.849192 [DEBUG] mod_opal.cpp:1092 State changed on
> > > connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.849192 [DEBUG] switch_core_session.c:1083 Send
> > > signal opal/in:231543514280633 [BREAK]
> > > 2010-12-13 11:58:21.849192 [DEBUG] mod_opal.cpp:931 Kill 3 on
> > > connection
> > > Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.849192 [DEBUG] switch_core_state_machine.c:366
> > > (opal/in:231543514280633) State EXECUTE going to sleep
> > > 2010-12-13 11:58:21.849192 [DEBUG] switch_core_state_machine.c:320
> > > (opal/in:231543514280633) Running State Change CS_HANGUP
> > > 2010-12-13 11:58:21.849192 [DEBUG] switch_core_state_machine.c:557
> > > (sofia/external/21543514280633(a)200.35.145.149) State HANGUP
> > > 2010-12-13 11:58:21.849192 [DEBUG] mod_sofia.c:453
> > > sofia/external/21543514280633(a)200.35.145.149 Overriding SIP cause 480
> > > with 900 from the other leg
> > > 2010-12-13 11:58:21.849192 [DEBUG] mod_sofia.c:459 Channel
> > > sofia/external/21543514280633(a)200.35.145.149 hanging up, cause:
> > > NORMAL_UNSPECIFIED
> > > 2010-12-13 11:58:21.849192 [DEBUG] switch_core_state_machine.c:46
> > > sofia/external/21543514280633(a)200.35.145.149 Standard HANGUP, cause:
> > > NORMAL_UNSPECIFIED
> > > 2010-12-13 11:58:21.849192 [DEBUG] switch_core_state_machine.c:557
> > > (sofia/external/21543514280633(a)200.35.145.149) State HANGUP going to
> > > sleep
> > > 2010-12-13 11:58:21.849192 [DEBUG] switch_core_state_machine.c:351
> > > (sofia/external/21543514280633(a)200.35.145.149) State Change
> > > CS_HANGUP ->
> > > CS_REPORTING
> > > 2010-12-13 11:58:21.849192 [DEBUG] switch_core_session.c:1083 Send
> > > signal sofia/external/21543514280633(a)200.35.145.149 [BREAK]
> > > 2010-12-13 11:58:21.849192 [DEBUG] switch_core_state_machine.c:320
> > > (sofia/external/21543514280633(a)200.35.145.149) Running State Change
> > > CS_REPORTING
> > > 2010-12-13 11:58:21.849192 [DEBUG] switch_core_state_machine.c:617
> > > (sofia/external/21543514280633(a)200.35.145.149) State REPORTING
> > > 2010-12-13 11:58:21.849192 [DEBUG] switch_core_state_machine.c:557
> > > (opal/in:231543514280633) State HANGUP
> > > 2010-12-13 11:58:21.849192 [DEBUG] connection.cxx:401 Call end reason
> > > for Call[Cc70e3cf91]-EP<local>[Ldc8d6c462] set to EndedByRemoteUser
> > > 2010-12-13 11:58:21.849192 [DEBUG] call.cxx:112 Clearing
> > > Call[Cc70e3cf91] reason=EndedByRemoteUser
> > > 2010-12-13 11:58:21.852189 [DEBUG] connection.cxx:1516 SetPhase from
> > > SetUpPhase to ReleasingPhase for Call[Cc70e3cf91]-EP<h323>[tcp
> > > $200.117.192.17:19270/22716]
> > > 2010-12-13 11:58:21.852189 [DEBUG] connection.cxx:459 Releasing
> > > asynchronously
> > > Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
> > > 2010-12-13 11:58:21.852189 [DEBUG] osutil.cxx:196 File handle
> > > low water
> > > mark set: 69 Thread unblock pipe
> > > 2010-12-13 11:58:21.852189 [DEBUG] connection.cxx:1516 SetPhase from
> > > AlertingPhase to ReleasingPhase for
> > > Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.852189 [DEBUG] connection.cxx:448 Releasing
> > > Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.852189 [DEBUG] connection.cxx:489 OnReleased
> > > Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.852189 [DEBUG] connection.cxx:808 Media streams
> > > closed.
> > > 2010-12-13 11:58:21.852189 [DEBUG] endpoint.cxx:450 OnReleased
> > > Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.852189 [DEBUG] manager.cxx:709 OnReleased
> > > Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.852189 [DEBUG] call.cxx:716 OnReleased
> > > Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.852189 [DEBUG] connection.cxx:436 Already released
> > > Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
> > > 2010-12-13 11:58:21.856029 [DEBUG] connection.cxx:1516 SetPhase from
> > > ReleasingPhase to ReleasedPhase for
> > > Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
> > > 2010-12-13 11:58:21.856029 [DEBUG] switch_core_state_machine.c:46
> > > opal/in:231543514280633 Standard HANGUP, cause: NORMAL_CLEARING
> > > 2010-12-13 11:58:21.856029 [DEBUG] switch_core_state_machine.c:557
> > > (opal/in:231543514280633) State HANGUP going to sleep
> > > 2010-12-13 11:58:21.856029 [DEBUG] switch_core_state_machine.c:351
> > > (opal/in:231543514280633) State Change CS_HANGUP -> CS_REPORTING
> > > 2010-12-13 11:58:21.856029 [DEBUG] switch_core_session.c:1083 Send
> > > signal opal/in:231543514280633 [BREAK]
> > > 2010-12-13 11:58:21.856029 [DEBUG] switch_core_state_machine.c:320
> > > (opal/in:231543514280633) Running State Change CS_REPORTING
> > > 2010-12-13 11:58:21.856029 [DEBUG] switch_core_state_machine.c:617
> > > (opal/in:231543514280633) State REPORTING
> > > 2010-12-13 11:58:21.856029 [DEBUG] connection.cxx:401 Call end reason
> > > for Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716] set to
> > > EndedByRemoteUser
> > > 2010-12-13 11:58:21.856029 [DEBUG] h323.cxx:349 OnReleased: tcp
> > > $200.117.192.17:19270/22716, connectionState=AwaitingLocalAnswer
> > > 2010-12-13 11:58:21.856029 [DEBUG] switch_core_state_machine.c:53
> > > sofia/external/21543514280633(a)200.35.145.149 Standard
> > > REPORTING, cause:
> > > NORMAL_UNSPECIFIED
> > > 2010-12-13 11:58:21.856029 [DEBUG] switch_core_state_machine.c:617
> > > (sofia/external/21543514280633(a)200.35.145.149) State
> > > REPORTING going to
> > > sleep
> > > 2010-12-13 11:58:21.856029 [DEBUG] switch_core_state_machine.c:345
> > > (sofia/external/21543514280633(a)200.35.145.149) State Change
> > > CS_REPORTING
> > > -> CS_DESTROY
> > > 2010-12-13 11:58:21.856029 [DEBUG] switch_core_session.c:1083 Send
> > > signal sofia/external/21543514280633(a)200.35.145.149 [BREAK]
> > > 2010-12-13 11:58:21.856029 [DEBUG] switch_core_session.c:1250
> > > Session 2
> > > (sofia/external/21543514280633(a)200.35.145.149) Locked, Waiting on
> > > external entities
> > > 2010-12-13 11:58:21.856029 [NOTICE]
> > > switch_core_session.c:1268 Session 2
> > > (sofia/external/21543514280633(a)200.35.145.149) Ended
> > > 2010-12-13 11:58:21.856029 [NOTICE] switch_core_session.c:1270 Close
> > > Channel sofia/external/21543514280633(a)200.35.145.149 [CS_DESTROY]
> > > 2010-12-13 11:58:21.856029 [DEBUG] switch_core_state_machine.c:449
> > > (sofia/external/21543514280633(a)200.35.145.149) Callstate Change HANGUP
> > > -> DOWN
> > > 2010-12-13 11:58:21.858228 [DEBUG] switch_core_state_machine.c:452
> > > (sofia/external/21543514280633(a)200.35.145.149) Running State Change
> > > CS_DESTROY
> > > 2010-12-13 11:58:21.858228 [DEBUG] switch_core_state_machine.c:462
> > > (sofia/external/21543514280633(a)200.35.145.149) State DESTROY
> > > 2010-12-13 11:58:21.858228 [DEBUG] mod_sofia.c:364
> > > sofia/external/21543514280633(a)200.35.145.149 SOFIA DESTROY
> > > 2010-12-13 11:58:21.858228 [DEBUG] switch_core_state_machine.c:60
> > > sofia/external/21543514280633(a)200.35.145.149 Standard DESTROY
> > > 2010-12-13 11:58:21.858228 [DEBUG] switch_core_state_machine.c:462
> > > (sofia/external/21543514280633(a)200.35.145.149) State DESTROY going to
> > > sleep
> > > 2010-12-13 11:58:21.856029 [DEBUG] h323.cxx:356 Sending
> > > release complete
> > > PDU: callRef=22716
> > > 2010-12-13 11:58:21.858228 [DEBUG] h323pdu.cxx:80 Sending PDU:
> > > command endSessionCommand disconnect <<null>>
> > > 2010-12-13 11:58:21.858228 [DEBUG] h323pdu.cxx:80 Sending PDU:
> > > {
> > > q931pdu = {
> > > protocolDiscriminator = 8
> > > callReference = 22716
> > > from = destination
> > > messageType = ReleaseComplete
> > > IE: Cause - Normal call clearing = {
> > > 80 90
> > > ..
> > > }
> > > IE: Display = {
> > > 72 6f 6f 74 00 root.
> > > }
> > > IE: User-User = {
> > > 25 80 06 00 08 91 4a 00 06 01 11 00 3a 76 b2 f2
> > > %.....J.....:v..
> > >
> > > Log-Func:
> > > Log-Line: 0
> > > User-Data:
> > >
> > > 1d 05 e0 11 9b b7 00 1e 64 1f 33 fe 04 c0 01 80 ........d.3.....
> > > ...
> > > }
> > > }
> > > h225pdu = {
> > > h323_uu_pdu = {
> > > h323_message_body = releaseComplete {
> > > protocolIdentifier = 0.0.8= {
> > > guid = 16 octets {
> > > 3a 76 b2 f2 1d 05 e0 11 9b b7 00 1e 64 1f 33
> > > fe :v..........d.3.
> > > }
> > > }
> > > }
> > > h245Tunneling = true
> > > h245Control = 1 entries {
> > > [0]= 2 octets {
> > >
> > > 4a 40 J@
> > > }
> > > }
> > > }
> > > }
> > > }
> > > 2010-12-13 11:58:21.861189 [DEBUG] h323.cxx:412 Awaiting end session
> > > from remote for 9.997 seconds
> > > 2010-12-13 11:58:21.861189 [DEBUG] switch_core_state_machine.c:53
> > > opal/in:231543514280633 Standard REPORTING, cause: NORMAL_CLEARING
> > > 2010-12-13 11:58:21.861189 [DEBUG] switch_core_state_machine.c:617
> > > (opal/in:231543514280633) State REPORTING going to sleep
> > > 2010-12-13 11:58:21.861189 [DEBUG] switch_core_state_machine.c:345
> > > (opal/in:231543514280633) State Change CS_REPORTING -> CS_DESTROY
> > > 2010-12-13 11:58:21.861189 [DEBUG] switch_core_session.c:1083 Send
> > > signal opal/in:231543514280633 [BREAK]
> > > 2010-12-13 11:58:21.861189 [DEBUG] switch_core_session.c:1250
> > > Session 1
> > > (opal/in:231543514280633) Locked, Waiting on external entities
> > > 2010-12-13 11:58:21.861189 [NOTICE]
> > > switch_core_session.c:1268 Session 1
> > > (opal/in:231543514280633) Ended
> > > 2010-12-13 11:58:21.861189 [NOTICE] switch_core_session.c:1270 Close
> > > Channel opal/in:231543514280633 [CS_DESTROY]
> > > 2010-12-13 11:58:21.861189 [DEBUG] switch_core_state_machine.c:449
> > > (opal/in:231543514280633) Callstate Change HANGUP -> DOWN
> > > 2010-12-13 11:58:21.861189 [DEBUG] switch_core_state_machine.c:452
> > > (opal/in:231543514280633) Running State Change CS_DESTROY
> > > 2010-12-13 11:58:21.861189 [DEBUG] switch_core_state_machine.c:462
> > > (opal/in:231543514280633) State DESTROY
> > > 2010-12-13 11:58:21.861189 [DEBUG] switch_core_state_machine.c:60
> > > opal/in:231543514280633 Standard DESTROY
> > > 2010-12-13 11:58:21.861189 [DEBUG] switch_core_state_machine.c:462
> > > (opal/in:231543514280633) State DESTROY going to sleep
> > > 2010-12-13 11:58:22.087167 [DEBUG] h323pdu.cxx:80 Receiving PDU:
> > > {
> > > q931pdu = {
> > > protocolDiscriminator = 8
> > > callReference = 22716
> > > from = originator
> > > messageType = Facility
> > > IE: Facility = {
> > >
> > > }
> > > IE: Display = {
> > > 67 75 73 74
> > > (..........!...
> > > 80 .
> > > }
> > > }
> > > h225pdu = {
> > >
> > > h323_uu_pdu = {
> > > h323_message_body = empty <<null>>
> > > h245Tunneling = true
> > > h245Control = 2 entries {
> > > [0]= 3 octets {
> > > 21 80 01 !..
> > > }
> > > [1]= 2
> > > octets {
> > > 20 80 .
> > > }
> > > }
> > > }
> > > }
> > > }
> > > 2010-12-13 11:58:22.087167 [DEBUG] h323.cxx:559 Handling PDU: Facility
> > > callRef=22716
> > > 2010-12-13 11:58:22.087167 [DEBUG] h323.cxx:2709 Checking for end
> > > session on PDU: response terminalCapabilitySetAck
> > > 2010-12-13 11:58:22.087167 [DEBUG] h323.cxx:2709 Checking for end
> > > session on PDU: response masterSlaveDeterminationAck
> > > 2010-12-13 11:58:22.087167 [DEBUG] connection.cxx:436 Already released
> > > Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
> > > 2010-12-13 11:58:22.087167 [DEBUG] h323.cxx:549 Signal channel closed.
> > > 2010-12-13 11:58:22.087167 [DEBUG] transports.cxx:900
> > > Transport clean up
> > > on termination
> > > 2010-12-13 11:58:22.087167 [DEBUG] transports.cxx:885 Transport Close
> > > 2010-12-13 11:58:22.090169 [DEBUG] osutil.cxx:196 File handle
> > > low water
> > > mark set: 65 PTextFile
> > > 2010-12-13 11:58:22.090169 [DEBUG] tlibthrd.cxx:1020 Could not parse
> > > thread stat file /proc/21145/task/21190/stat
> > > 2010-12-13 11:58:22.306147 [DEBUG] connection.cxx:489 OnReleased
> > > Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
> > > 2010-12-13 11:58:22.306147 [DEBUG] connection.cxx:808 Media streams
> > > closed.
> > > 2010-12-13 11:58:22.306147 [DEBUG] endpoint.cxx:450 OnReleased
> > > Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
> > > 2010-12-13 11:58:22.306147 [DEBUG] manager.cxx:709 OnReleased
> > > Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
> > > 2010-12-13 11:58:22.306147 [DEBUG] call.cxx:716 OnReleased
> > > Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
> > > 2010-12-13 11:58:22.306147 [DEBUG] manager.cxx:535 OnClearedCall
> > > Call[Cc70e3cf91] from "h323:200.117.192.17" to "h323:231543514280633"
> > > 2010-12-13 11:58:22.306147 [DEBUG] connection.cxx:1516 SetPhase from
> > > ReleasingPhase to ReleasedPhase for Call[Cc70e3cf91]-EP<h323>[tcp
> > > $200.117.192.17:19270/22716]
> > > 2010-12-13 11:58:22.306147 [DEBUG] connection.cxx:480 OnRelease thread
> > > completed for
> > > Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
> > > 2010-12-13 11:58:22.308152 [DEBUG] tlibthrd.cxx:1020 Could not parse
> > > thread stat file /proc/21145/task/21194/stat
> > > 2010-12-13 11:58:22.588122 [DEBUG] transports.cxx:900
> > > Transport clean up
> > > on termination
> > > 2010-12-13 11:58:22.588122 [DEBUG] transports.cxx:885 Transport Close
> > > 2010-12-13 11:58:22.588122 [DEBUG] transports.cxx:1045
> > > Deleted transport
> > > tcp$200.117.192.17:19270<if=tcp$10.0.0.1:1720>
> > > 2010-12-13 11:58:22.590122 [DEBUG] h323.cxx:330 Connection tcp
> > > $200.117.192.17:19270/22716 deleted.
> > > 2010-12-13 11:58:22.590122 [DEBUG] connection.cxx:343 Connection
> > > Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716] destroyed.
> > > 2010-12-13 11:58:22.590122 [DEBUG] localep.cxx:211 Deleted connection.
> > > 2010-12-13 11:58:22.590122 [DEBUG] connection.cxx:343 Connection
> > > Call[Cc70e3cf91]-EP<local>[Ldc8d6c462] destroyed.
> > > 2010-12-13 11:58:23.592039 [DEBUG] call.cxx:86 Call[Cc70e3cf91]
> > > destroyed.
> > >
> > > --------------------------------------------------------------
> > > --------------------------------------------------------------
> > > -----------------------------------------
> > > Gustavo Espeche
> > > www.easyipcall.com
> > >
> > >
> > >
> > >
> > >
> > >
> > >
> > > _______________________________________________
> > > FreeSWITCH-users mailing list
> > > FreeSWITCH-users(a)lists.freeswitch.org
> > > http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
> > > UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freesw
> > > itch-users
> > > http://www.freeswitch.org
> >
> >
> >
> _______________________________________________
> FreeSWITCH-users mailing list
> FreeSWITCH-users(a)lists.freeswitch.org
> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
> http://www.freeswitch.org
1
0
Hi,
I have one server running Freeswitch with some ISDN connections (via
FreeTDM+Sangoma boards) and some SIP connections with service providers and
customer.
The usage of Freeswitch is as switching so it "bridge" each incoming call to
a new outgoing call.
SIP calls use G.729 and ISDN calls use ALaw for voice encoding.
Now the number of call is grow up and also the CPU load is a little high so
I have the necessity to scale UP my Freeswitch to handle more calls: what is
the best way to do that?
My first idea is to use a Sangoma D500 board to reduce the CPU load. Can be
this a solution?
There are different way to scale UP?
Thanks in advance,
Stephen
7
14
If you've never posted to our mailing list you are first post moderated. If you send the same message to the list multiple times while its in the moderator queue I'll reject them all and you'll have to resend it. I know this sounds mean but when you send the same message 10 times within 3 minutes of each wondering why it doesn't make it to the list it just creates more work for our team so please be patient on weekends if your first posts do not make it to the list.
Thanks,
Brian
3
2
Hello list, we are try to do inter-worker between h323 and sip using
opal in freeswitch, but FS don't send the call to our sip gw, follow is
the call flow:
h323 endpoint -->FS->sip gateway
attached a FS debug of call.
if something know or work with opal in freeSwitch and have some tips we
appreciate a lot if advice about it.
Best Regards.
-----------------------------------------------------------------------------------------------------------------------------
2010-12-13 11:58:21.325242 [DEBUG] transports.cxx:1200 Started
connection to 200.117.192.17:19270 (if=72.51.47.100:1720)
2010-12-13 11:58:21.325242 [DEBUG] osutil.cxx:189 File handle high water
mark set: 67 Thread unblock pipe
2010-12-13 11:58:21.325242 [DEBUG] tlibthrd.cxx:587 Thread high water
mark set: 8
2010-12-13 11:58:21.325242 [DEBUG] transports.cxx:666 Waiting on socket
accept on tcp$72.51.47.100:1720
2010-12-13 11:58:21.325242 [DEBUG] h323ep.cxx:501 Awaiting first PDU
2010-12-13 11:58:21.805203 [DEBUG] h323pdu.cxx:80 Receiving PDU:
{
q931pdu = {
protocolDiscriminator = 8
callReference = 22716
from = originator
messageType = Setup
IE: Bearer-Capability = {
88 93 a5
...
}
IE: Display = {
67 75 73 74 61 76 6f 00 gustavo.
}
IE: Called-Party-Number = {
81 32 33 31 35 34 33 35 31 34 32 38 30 36 33
33 .231543514280633
}
IE: User-User = {
20 b8 06 00 08 91 4a 00 06 01 40 06 00 67 00
75 .....J...@..g.u
00 73 00 74 00 61 00 76 00 6f 22 c0 09 00 00
3d .s.t.a.v.o"....=
...
}
}
h225pdu = {
h323_uu_pdu = {
h323_me
ssage_body = setup {
protocolIdentifier = 0.0.8.2250.0.6
sourceAddress = 1 entries {
[0]=h323_ID 7 characters {
0067 0075 0073 0074 0061 0076 006f gustavo
}
}
sour
ceInfo = {
vendor = {
vendor = {
t35CountryCode = 9
t35Extension = 0
manufacturerCode = 61
}
productId = 3 octets {
00 00 00
(OPAL v3.6
2e 36 29 00 00 .6
)..
}
}
terminal = {
}
mc = false
undefinedNode = false
}
destinationAddress = 1 entries {
[0]=dialedDigits "231543514280633"
}
Log-Func:
Log-Line: 0
User-Data:
destCallSignalAddress = ipAddress {
ip = 4 octets {
48 33 2f 64 H3/d
}
port = 1720
}
activeMC = falets {
4e 76 b2 f2 1d 05 e0 11 9b b7 00 1e 64 1f 33 fe
Nv..........d.3.
}
conferenceGoal = create <<null>>
callType = pointToPoint <<null>>
sourceCallSignalAddress = ipAddress {
ip =
Log-Func:
Log-Line: 0
User-Data:
4 octets {
c8 75 c0 11 .u..
}
port = 19270
}
callIdentifier = {
guid = 16 octets {
3a 76 f 33 fe :v..........d.3.
}
}
fastStart = 8 entries {
[0]= 29 octets {
40 00 00 06 04 01 00 4c 20 13 80 11 1c 00 01 00
@......L .......
c8 75 c0 11 13 de 00 c8 75 c0 11 13
df .u......u....
}
[1]= 19 octets {
00 00 64 0c 20 13 80 0b 0d 00 01 00 c8 75 c0
11 ..d. ........u..
13 df 00 ...
}
[
2]= 35 octets {
40 00 00 06 04 01 00 48 78 00 4a ff 00 80 01 00
@......Hx.J.....
80 11 1c 00 02 00 c8 75 c0 11 13 e0 00 c8 75
c0 .......u......u.
...
}
[3]= 25 octets {
00 00 65 08 78 00 4a ff 00 80 01 00 80 0b 0d
00 ..e.x.J.........
02 00 c8 75 c0 11 13 e1
00 ...u.....
}
[4]= 34 octets {
40 00 00 06 04 01 00 48 68 4a ff 00 80 01
00 80 @......HhJ......
11 1c 00 02 00 c8 75 c0 11 13 e0 00 c8 75 c0
11 ......u......u..
...
}
[5]= 24 octets {
00 00 66 08 68 4a ff 00 80 01 00 80 0b 0d 00
02 ..f.hJ..........
00 c8 75 c0 11 13 e1
00 ..u.....
}
[6]= 34 octets {
40 00 00 06 04 01 00 48 70 4a ff 00 80 01 00 80
@......HpJ......
11 1c 00 02 00 c8 75 c0 11 13 e0 0
0 c8 75 c0 11 ......u......u..
...
}
[7]= 24 octets {
00 00 67 08 70 4a ff 00 80 01 00 80 0b 0d 00
02 ..g.pJ..........
00 c8 75 c0 11 13 e1
00 ..u.....
}
}
mediaWaitForConnect = false
canOverlapSend = false
multipleCalls = false
maintainConnection = false
parallelH245Control = 2 entries {
[0]= 125 octets {
02 70 01 06 00 08 81 75 00 0d 80 13 80 01 f4
00 .p.....u........
01 00 00 01 00 00 01 00 00 0c c0 01 00 01 80
07 ................
...
}
[1]= 7 octets {
01 00 32 80 5d 41 2
b ..2.]A+
}
}
}
h245Tunneling = true
}
}
}
2010-12-13 11:58:21.805203 [DEBUG] h323ep.cxx:510 Incoming call, first
PDU: callReference=22716
2010-12-13 11:58:21.805203 [DEBUG] call.cxx:72 Created Call[Cc70e3cf91]
2010-12-13 11:58:21.805203 [DEBUG] connection.cxx:262 Created connection
Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
2010-12-13 11:58:21.805203 [DEBUG] rfc2833.cxx:140 Handler created
2010-12-13 11:58:21.805203 [DEBUG] rfc2833.cxx:328 Rx capability set to
"0-16,32,36"
2010-12-13 11:58:21.805203 [DEBUG] rfc2833.cxx:140 Handler created
2010-12-13 11:58:21.805203 [DEBUG] rfc2833.cxx:328 Rx capability set to
"192,193"
2010-12-13 11:58:21.805203 [DEBUG] osutil.cxx:189 File handle high water
mark set: 68 PUDPSocket
2010-12-13 11:58:21.808186 [DEBUG] h4601.cxx:1583 Endpoint Attached
2010-12-13 11:58:21.808186 [DEBUG] h323ep.cxx:552 Created new
connection: tcp$200.117.192.17:19270/22716
2010-12-13 11:58:21.808186 [DEBUG] h323.cxx:559 Handling PDU: Setup
callRef=22716
2010-12-13 11:58:21.808186 [DEBUG] connection.cxx:1516 SetPhase from
UninitialisedPhase to SetUpPhase for Call[Cc70e3cf91]-EP<h323>[tcp
$200.117.192.17:19270/22716]
2010-12-13 11:58:21.808186 [DEBUG] h323.cxx:943 Set protocol version to
6 and implying H.245 version 13
2010-12-13 11:58:21.808186 [DEBUG] h323.cxx:1240 Set remote application
name: " 3.2.6 (OPAL v3.6.6) 9/61 "
2010-12-13 11:58:21.808186 [DEBUG] manager.cxx:1392 Checking incoming
call for NAT: local=72.51.47.100, peer=200.117.192.17,
sig=200.117.192.17
2010-12-13 11:58:21.808186 [DEBUG] h323.cxx:1041 Sending call proceeding
PDU
2010-12-13 11:58:21.811196 [DEBUG] h323pdu.cxx:80 Sending PDU:
{
q931pdu = {
protocolDiscriminator = 8
callReference = 22716
from = destination
messageType = CallProceeding
IE: Display = {
72 6f 6f 74 00
root.
}
IE: User-User = {
21 80 06 00 08 91 4a 00 06 22 c0 09 00 00 3d
1e !.....J.."....=.
56 6f 78 20 4c 75 63 69 64 61 20 50 74 79 2e 20 Vox Lucida
Pty.
...
}
}
h225pdu = {
h323_uu_pdu = {
h323_message_body = callProceeding {
protocolIdentifier = 0.0.8.2250.0.6
destinationInfo = {
vendor = {
vendor = {
t35CountryCode = 9
t35Extensio
n = 0
manufacturerCode = 61
}
productId = 31 octets {
56 6f 78 20 4c 75 63 69 64 61 20 50 74 79 2e 20 Vox
Lucida Pty.
4c 74 64 2e 20 6d 6f 64 5f 6f 70 61 6c 00 00
Log-Line: 0
UINCOMING DATA [(null)]
RECV EVENT
Event-Name: SOCKET_DATA
ser-Data: _undef_
}
}
terminal = {
}
mc = false
undefinedNode = false
}
callIdentifier = {
guid = 16 octets {
3a 76 b2 f2 1d 05 e0 11 9b b7 00 1e 64 1f 33 fe
:v..........d.3.
}
}
multipleCalls = false
maintainConnection = false
}
h245Tunneling = true
}
}
}
2010-12-13 11:58:21.811196 [DEBUG] manager.cxx:600 OnIncoming connection
Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
2010-12-13 11:58:21.811196 [DEBUG] call.cxx:288 GetOtherPartyConnection
Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
2010-12-13 11:58:21.811196 [DEBUG] manager.cxx:1200 Searching for route
"h323:root 231543514280633"
2010-12-13 11:58:21.811196 [DEBUG] manager.cxx:1228 Matched regex
"h323:.*"
2010-12-13 11:58:21.811196 [DEBUG] manager.cxx:573 Set up connection to
"local:231543514280633"
2010-12-13 11:58:21.811196 [DEBUG] connection.cxx:262 Created connection
Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.811196 [DEBUG] localep.cxx:205 Created connection
with token "Ldc8d6c462"
2010-12-13 11:58:21.811196 [DEBUG] h323.cxx:1075 Incoming call accepted
2010-12-13 11:58:21.811196 [DEBUG] mod_opal.cpp:770 Matched FS codec
PCMA to OPAL media format G.711-ALaw-64k
2010-12-13 11:58:21.811196 [DEBUG] mod_opal.cpp:770 Matched FS codec
G729 to OPAL media format G.729
2010-12-13 11:58:21.811196 [DEBUG] mod_opal.cpp:770 Matched FS codec
PCMU to OPAL media format G.711-uLaw-64k
2010-12-13 11:58:21.811196 [DEBUG] mod_opal.cpp:770 Matched FS codec
G723 to OPAL media format G.723.1
2010-12-13 11:58:21.814188 [DEBUG] call.cxx:425 GetMediaFormats for
Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
G.723.1
G.729
G.711-uLaw-64k
G.711-ALaw-64k
2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2381 Could not find
capability: "G.723.1"
2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2284 Added capability:
G.723.1 <1>
2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2381 Could not find
capability: "G.729"
2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2284 Added capability:
G.729 <2>
2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2381 Could not find
capability: "G.711-uLaw-64k"
2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2284 Added capability:
G.711-uLaw-64k <3>
2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2381 Could not find
capability: "G.711-ALaw-64k"
2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2284 Added capability:
G.711-ALaw-64k <4>
2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2376 Found capability:
G.723.1 <1>
2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2376 Found capability:
G.729 <2>
2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2376 Found capability:
G.711-uLaw-64k <3>
2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2376 Found capability:
G.711-ALaw-64k <4>
2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2284 Added capability:
UserInput/hookflash <5>
2010-12-13 11:58:21.814188 [DEBUG] h323caps.cxx:2284 Added capability:
UserInput/basicString <6>
2010-12-13 11:58:21.817197 [DEBUG] h323caps.cxx:2284 Added capability:
UserInput/dtmf <7>
2010-12-13 11:58:21.817197 [DEBUG] h323caps.cxx:2284 Added capability:
UserInput/RFC2833 <8>
2010-12-13 11:58:21.817197 [DEBUG] h323caps.cxx:2376 Found capability:
UserInput/RFC2833 <8>
2010-12-13 11:58:21.817197 [DEBUG] call.cxx:288 GetOtherPartyConnection
Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
2010-12-13 11:58:21.817197 [DEBUG] h323.cxx:3704 SetLocalCapabilities:
Table:
G.723.1 <1>
G.729 <2>
G.711-uLaw-64k <3>
G.711-ALaw-64k <4>
UserInput/hookflash <5>
UserInput/basicString <6>
UserInput/dtmf <7>
UserInput/RFC2833 <8>
Set:
0:
Log-Func:
Log-Line: 0
User-Data:
0:
G.723.1 <1>
G.729 <2>
G.711-uLaw-64k <3>
G.711-ALaw-64k <4>
1:
UserInput/hookflash <5>
2:
UserInput/basicString <6>
UserInput/dtINCOMING DATA [(null)]
RECV EVENT
Event-Name: SOCKET_DATA
2010-12-13 11:58:21.817197 [DEBUG] h323.cxx:1121 Fast start detected
2010-12-13 11:58:21.817197 [DEBUG] h323caps.cxx:2594 Could not find
capability: audioData, type g711Alaw64k
2010-12-13 11:58:21.817197 [DEBUG] h323caps.cxx:845 Capability tx frames
left at 20 as remote allows 20
2010-12-13 11:58:21.817197 [DEBUG] h323caps.cxx:2294 Added capability:
G.711-ALaw-64k <4>
2010-12-13 11:58:21.817197 [DEBUG] h323caps.cxx:845 Capability tx frames
left at 20 as remote allows 20
2010-12-13 11:58:21.817197 [DEBUG] h323caps.cxx:2594 Could not find
capability: videoData, type h261VideoCapability
2010-12-13 11:58:21.817197 [DEBUG] h323caps.cxx:2594 Could not find
capability: videoData, type h261VideoCapability
2010-12-13 11:58:21.817197 [DEBUG] h323caps.cxx:2594 Could not find
capability: videoData, type h261VideoCapability
2010-12-13 11:58:21.817197 [DEBUG] h323caps.cxx:2594 Could not find
capability: videoData, type h261VideoCapability
2010-12-13 11:58:21.820187 [DEBUG] h323caps.cxx:2594 Could not find
capability: videoData, type h261VideoCapability
2010-12-13 11:58:21.820187 [DEBUG] h323caps.cxx:2594 Could not find
capability: videoData, type h261VideoCapability
2010-12-13 11:58:21.820187 [DEBUG] h323caps.cxx:2594 Could not find
capability: videoData, type h261VideoCapability
2010-12-13 11:58:21.820187 [DEBUG] h323caps.cxx:2594 Could not find
capability: videoData, type h261VideoCapability
2010-12-13 11:58:21.820187 [DEBUG] h323caps.cxx:2594 Could not find
capability: videoData, type h261VideoCapability
2010-12-13 11:58:21.820187 [DEBUG] h323caps.cxx:2594 Could not find
capability: videoData, type h261VideoCapability
2010-12-13 11:58:21.820187 [DEBUG] h323caps.cxx:2594 Could not find
capability: videoData, type h261VideoCapability
2010-12-13 11:58:21.820187 [DEBUG] h323caps.cxx:2594 Could not find
capability: videoData, type h261VideoCapability
2010-12-13 11:58:21.820187 [DEBUG] call.cxx:288 GetOtherPartyConnection
Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.820187 [DEBUG] call.cxx:169 OnSetUp
Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
2010-12-13 11:58:21.820187 [DEBUG] localep.cxx:240 Incoming call from
gustavo [200.117.192.17]
2010-12-13 11:58:21.820187 [DEBUG] mod_opal.cpp:641 Created switch
caller profile:
username =
dialplan = XML
caller_id_name = gustavo [200.117.192.17]
caller_id_number = 0000000000
network_addr =
source = opal
context
Log-Func:
Log-Line: 0
User-Data:
= default
2010-12-13 11:58:21.823196 [NOTICE] switch_channel.c:784 New Channel
opal/in:231543514280633 [7b4a89ac-b5d7-4fb4-bab5-ddaa8e73485c]
2010-12-13 11:58:21.823196 [DEBUG] mod_opal.cpp:647
(opal/in:231543514280633) State Change CS_NEW -> CS_INIT
2010-12-13 11:58:21.823196 [DEBUG] mod_opal.cpp:1092 State changed on
connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.823196 [DEBUG] switch_core_session.c:1083 Send
signal opal/in:231543514280633 [BREAK]
2010-12-13 11:58:21.823196 [DEBUG] mod_opal.cpp:931 Kill 3 on connection
Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.823196 [DEBUG] connection.cxx:1516 SetPhase from
UninitialisedPhase to AlertingPhase for
Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.823196 [NOTICE] mod_opal.cpp:676 Ring-Ready
opal/in:231543514280633!
2010-12-13 11:58:21.823196 [DEBUG] manager.cxx:678 OnAlerting
Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.823196 [DEBUG] call.cxx:196 OnAlerting
Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.823196 [DEBUG] h323.cxx:2067 SetAlerting
Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
2010-12-13 11:58:21.823196 [DEBUG] switch_core_state_machine.c:320
(opal/in:231543514280633) Running State Change CS_INIT
2010-12-13 11:58:21.823196 [DEBUG] switch_core_state_machine.c:356
(opal/in:231543514280633) State INIT
2010-12-13 11:58:21.823196 [DEBUG] osutil.cxx:189 File handle high water
mark set: 72 Thread unblock pipe
2010-12-13 11:58:21.823196 [DEBUG] tlibthrd.cxx:587 Thread high water
mark set: 10
2010-12-13 11:58:21.823196 [DEBUG] mod_opal.cpp:842 Started routing for
connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.823196 [DEBUG] mod_opal.cpp:843
(opal/in:231543514280633) State Change CS_INIT -> CS_ROUTING
2010-12-13 11:58:21.823196 [DEBUG] mod_opal.cpp:1092 State changed on
connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.823196 [DEBUG] switch_core_session.c:1083 Send
signal opal/in:231543514280633 [BREAK]
2010-12-13 11:58:21.823196 [DEBUG] mod_opal.cpp:931 Kill 3 on connection
Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.823196 [DEBUG] switch_core_state_machine.c:356
(opal/in:231543514280633) State INIT going to sleep
2010-12-13 11:58:21.823196 [DEBUG] switch_core_state_machine.c:320
(opal/in:231543514280633) Running State Change CS_ROUTING
2010-12-13 11:58:21.823196 [DEBUG] switch_channel.c:1615
(opal/in:231543514280633) Callstate Change DOWN -> RINGING
2010-12-13 11:58:21.823196 [DEBUG] switch_core_state_machine.c:359
(opal/in:231543514280633) State ROUTING
2010-12-13 11:58:21.823196 [DEBUG] mod_opal.cpp:850 Routing connection
Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.823196 [DEBUG] switch_core_state_machine.c:77
opal/in:231543514280633 Standard ROUTING
2010-12-13 11:58:21.823196 [INFO] mod_dialplan_xml.c:331 Processing
gustavo [200.117.192.17] <0000000000>->231543514280633 in context
default
2010-12-13 11:58:21.826206 [DEBUG] h323pdu.cxx:80 Receiving PDU:
request terminalCapabilitySet {
sequenceNumber = 1
protocolIdentifier = 0.0.8.245.0.13
multiplexCapability = h2250Capability {
maximumAudioDelayJitter = 500
receiveMultipointCapabi
lity = {
multicastCapability = false
multiUniCastConference = false
mediaDistributionCapability = 1 entries {
[0]={
centralizedControl = false
distributedControl = false
centraliz
edAudio = false
distributedAudio = false
centralizedVideo = false
distributedVideo = false
}
}
}
transmitMultipointCapability = {
multicastCapability = false
multiUniC
astConference = false
mediaDistributionCapability = 1 entries {
[0]={
centralizedControl = false
distributedControl = false
centralizedAudio = false
distributedAudio = false
centralizedVideo = false
distributedVideo = false
}
}
}
receiveAndTransmitMultipointCapability = {
multicastCapability = false
multiUniCastConference = false
mediaDistributionCapab
ility = 1 entries {
[0]={
centralizedControl = false
distributedControl = false
centralizedAudio = false
distributedAudio = false
centralizedVideo = false
distributedV
ideo = false
}
}
}
mcCapability = {
centralizedConferenceMC = false
decentralizedConferenceMC = false
}
rtcpVideoControlCapability = false
mediaPacketizationCapability = {
h261a
VideoPacketization = false
}
logicalChannelSwitchingCapability = false
t120DynamicPortCapability = true
}
capabilityTable = 8 entries {
[0]={
capabilityTableEntryNumber = 1
capability = receiveAudioCap
ability g711Alaw64k 240
}
[1]={
capabilityTableEntryNumber = 2
capability = receiveVideoCapability h261VideoCapability {
qcifMPI = 1
cifMPI = 1
temporalSpatialTradeOffCapability = false
maxBitRate = 19200
stillImageTransmission = false
videoBadMBsCap = false
}
}
[2]={
capabilityTableEntryNumber = 3
capability = receiveVideoCapability h261VideoCapability {
cifMPI
= 1
temporalSpatialTradeOffCapability = false
maxBitRate = 19200
stillImageTransmission = false
videoBadMBsCap = false
}
}
[3]={
capabilityTableEntryNumber = 4
capability =
receiveVideoCapability h261VideoCapability {
qcifMPI = 1
temporalSpatialTradeOffCapability = false
maxBitRate = 19200
stillImageTransmission = false
videoBadMBsCap = false
}
}
[4
]={
capabilityTableEntryNumber = 5
capability = receiveUserInputCapability hookflash <<null>>
}
[5]={
capabilityTableEntryNumber = 6
capability = receiveUserInputCapability basicString <<null>>
}
[6]={
capabilityTableEntryNumber = 7
capability = receiveUserInputCapability dtmf <<null>>
}
[7]={
capabilityTableEntryNumber = 8
capability = receiveRTPAudioTelephonyEventCapability {
dynamic
RTPPayloadType = 101
audioTelephoneEvent = "0-16"
}
}
}
capabilityDescriptors = 1 entries {
[0]={
capabilityDescriptorNumber = 1
simultaneousCapabilities = 4 entries {
[0]=1 entries {
[0]=1
}
[1]=3 entries {
[0]=2
[1]=3
[2]=4
}
[2]=1 entries {
[0]=5
}
[3]=3 entries {
[0]=6
[1]=7
Log-Func:
Log-Line: 0
User-Data:
[2]=8
2010-12-13 11:58:21.826206 [DEBUG] h323.cxx:2792 Set protocol
version to 13
2010-12-13 11:58:21.826206 [DEBUG] h323neg.cxx:378 Received
TerminalCapabilitySet: state=Idle pduSeq=1 inSeq=4294967295
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:1988
H323Capabilities(ctor)
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2294 Added capability:
G.723.1 <1>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2294 Added capability:
G.729 <2>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2294 Added capability:
G.711-uLaw-64k <3>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2294 Added capability:
G.711-ALaw-64k <4>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2294 Added capability:
UserInput/hookflash <5>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2294 Added capability:
UserInput/basicString <6>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2294 Added capability:
UserInput/dtmf <7>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2294 Added capability:
UserInput/RFC2833 <8>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2355 Found capability:
G.723.1 <1>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2355 Found capability:
G.729 <2>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2355 Found capability:
G.711-uLaw-64k <3>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2355 Found capability:
G.711-ALaw-64k <4>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2355 Found capability:
UserInput/hookflash <5>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2355 Found capability:
UserInput/basicString <6>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2355 Found capability:
UserInput/dtmf <7>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2355 Found capability:
UserInput/RFC2833 <8>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2376 Found capability:
G.711-ALaw-64k <4>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2376 Found capability:
G.711-uLaw-64k <3>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2376 Found capability:
G.723.1 <1>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2381 Could not find
capability: "G.723.1(5.3k)"
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2284 Added capability:
G.723.1 <9>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2381 Could not find
capability: "G.723.1A(5.3k)"
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2284 Added capability:
G.723.1 <10>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2381 Could not find
capability: "G.723.1A(6.3k)"
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2284 Added capability:
G.723.1 <11>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2381 Could not find
capability: "G.728"
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2284 Added capability:
G.728 <12>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2376 Found capability:
G.729 <2>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2381 Could not find
capability: "G.729A"
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2284 Added capability:
G.729A <13>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2381 Could not find
capability: "G.729A/B"
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2284 Added capability:
G.729A/B <14>
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2381 Could not find
capability: "G.729B"
2010-12-13 11:58:21.826206 [DEBUG] h323caps.cxx:2284 Added capability:
G.729B <15>
2010-12-13 11:58:21.831146 [DEBUG] h323caps.cxx:2381 Could not find
capability: "GSM-06.10"
2010-12-13 11:58:21.831146 [DEBUG] h323caps.cxx:2284 Added capability:
GSM-06.10 <16>
2010-12-13 11:58:21.831146 [DEBUG] h323caps.cxx:2381 Could not find
capability: "GSM-AMR"
2010-12-13 11:58:21.831146 [DEBUG] h323caps.cxx:2284 Added capability:
GSM-AMR <17>
2010-12-13 11:58:21.831146 [DEBUG] h323caps.cxx:2381 Could not find
capability: "T.38"
2010-12-13 11:58:21.831146 [DEBUG] h323caps.cxx:2284 Added capability:
T.38 <18>
2010-12-13 11:58:21.831146 [DEBUG] h323caps.cxx:2376 Found capability:
UserInput/RFC2833 <8>
2010-12-13 11:58:21.831146 [DEBUG] h323caps.cxx:2376 Found capability:
UserInput/basicString <6>
2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2376 Found capability:
UserInput/dtmf <7>
2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2381 Could not find
capability: "UserInput/generalString"
2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2284 Added capability:
UserInput/generalString <19>
2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2376 Found capability:
UserInput/hookflash <5>
2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2381 Could not find
capability: "UserInput/iA5String"
2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2284 Added capability:
UserInput/iA5String <20>
2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2381 Could not find
capability: "iLBC"
2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2284 Added capability:
iLBC <21>
2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2284 Added capability:
UserInput/hookflash <22>
2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2284 Added capability:
UserInput/basicString <23>
2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2284 Added capability:
UserInput/dtmf <24>
2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2284 Added capability:
UserInput/RFC2833 <25>
2010-12-13 11:58:21.834192 [CONSOLE] mod_xml_curl.c:312 XML response is
in /tmp/90f1dd7d-a63c-4e15-981c-6eed9e70313b.tmp.xml
Dialplan: opal/in:231543514280633 parsing [default->external]
continue=false
Dialplan: opal/in:231543514280633 Regex (PASS) [external]
destination_number(231543514280633) =~ /^231543514280633/ break=on-false
Dialplan: opal/in:231543514280633 Action set(continue_on_fail=true)
Dialplan: opal/in:231543514280633 Action set(hangup_after_bridge=true)
Dialplan: opal/in:231543514280633 Action set(progress_timeout=15)
Dialplan: opal/in:231543514280633 Action set(proxy_media=false)
Dialplan: opal/in:231543514280633 Action set(bypass_media=true)
Dialplan: opal/in:231543514280633 Action
set(absolute_codec_string=PCMA)
Dialplan: opal/in:231543514280633 Action
bridge(sofia/external/21543514280633(a)200.35.145.149)
2010-12-13 11:58:21.834192 [DEBUG] switch_core_state_machine.c:119
(opal/in:231543514280633) State Change CS_ROUTING -> CS_EXECUTE
2010-12-13 11:58:21.834192 [DEBUG] mod_opal.cpp:1092 State changed on
connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.834192 [DEBUG] switch_core_session.c:1083 Send
signal opal/in:231543514280633 [BREAK]
2010-12-13 11:58:21.834192 [DEBUG] mod_opal.cpp:931 Kill 3 on connection
Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.834192 [DEBUG] switch_core_state_machine.c:359
(opal/in:231543514280633) State ROUTING going to sleep
2010-12-13 11:58:21.834192 [DEBUG] switch_core_state_machine.c:320
(opal/in:231543514280633) Running State Change CS_EXECUTE
2010-12-13 11:58:21.834192 [DEBUG] h323caps.cxx:2284 Added capability:
H.239-Video+H.239-Video <26>
2010-12-13 11:58:21.834192 [DEBUG] switch_core_state_machine.c:366
(opal/in:231543514280633) State EXECUTE
2010-12-13 11:58:21.834192 [DEBUG] mod_opal.cpp:857 Executing connection
Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.834192 [DEBUG] switch_core_state_machine.c:157
opal/in:231543514280633 Standard EXECUTE
EXECUTE opal/in:231543514280633 set(continue_on_fail=true)
2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2284 Added capability:
H.239-Control <27>
2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2029 Parsing remote
capabilities
2010-12-13 11:58:21.837191 [DEBUG] mod_opal.cpp:1076 Received message 26
on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.837191 [DEBUG] mod_dptools.c:1028
opal/in:231543514280633 SET [continue_on_fail]=[true]
2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:819 Capability tx frames
left at 20 as remote allows 240
2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2529 Could not find
capability: receiveVideoCapability, type h261VideoCapability
2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2529 Could not find
capability: receiveVideoCapability, type h261VideoCapability
2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2529 Could not find
capability: receiveVideoCapability, type h261VideoCapability
2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2671 Found capability:
UserInput/RFC2833 <8>
2010-12-13 11:58:21.837191 [DEBUG] mod_opal.cpp:1076 Received message 27
on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
EXECUTE opal/in:231543514280633 set(hangup_after_bridge=true)
2010-12-13 11:58:21.837191 [DEBUG] mod_opal.cpp:1076 Received message 26
on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.837191 [DEBUG] mod_dptools.c:1028
opal/in:231543514280633 SET [hangup_after_bridge]=[true]
2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2411 Could not find
capability: G.711-ALaw-64k <1>
2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2294 Added capability:
G.711-ALaw-64k <1>
2010-12-13 11:58:21.837191 [DEBUG] mod_opal.cpp:1076 Received message 27
on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
EXECUTE opal/in:231543514280633 set(progress_timeout=15)
2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2411 Could not find
capability: UserInput/hookflash <5>
2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2294 Added capability:
UserInput/hookflash <5>
2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2411 Could not find
capability: UserInput/basicString <6>
2010-12-13 11:58:21.837191 [DEBUG] mod_opal.cpp:1076 Received message 26
on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.837191 [DEBUG] mod_dptools.c:1028
opal/in:231543514280633 SET [progress_timeout]=[15]
2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2294 Added capability:
UserInput/basicString <6>
2010-12-13 11:58:21.837191 [DEBUG] h323caps.cxx:2411 Could not find
capability: UserInput/dtmf <7>
2010-12-13 11:58:21.840189 [DEBUG] h323caps.cxx:2294 Added capability:
UserInput/dtmf <7>
2010-12-13 11:58:21.840189 [DEBUG] h323caps.cxx:2411 Could not find
capability: UserInput/RFC2833 <8>
2010-12-13 11:58:21.840189 [DEBUG] h323caps.cxx:2294 Added capability:
UserInput/RFC2833 <8>
2010-12-13 11:58:21.840189 [DEBUG] h323caps.cxx:2355 Found capability:
G.711-ALaw-64k <1>
2010-12-13 11:58:21.840189 [DEBUG] h323caps.cxx:2355 Found capability:
UserInput/hookflash <5>
2010-12-13 11:58:21.840189 [DEBUG] h323caps.cxx:2355 Found capability:
UserInput/basicString <6>
2010-12-13 11:58:21.840189 [DEBUG] h323caps.cxx:2355 Found capability:
UserInput/dtmf <7>
2010-12-13 11:58:21.840189 [DEBUG] h323caps.cxx:2355 Found capability:
UserInput/RFC2833 <8>
2010-12-13 11:58:21.840189 [DEBUG] mod_opal.cpp:1076 Received message 27
on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
EXECUTE opal/in:231543514280633 set(proxy_media=false)
2010-12-13 11:58:21.840189 [DEBUG] h323caps.cxx:2777 Capability merge
result:
Table:
G.711-ALaw-64k <1>
UserInput/hookflash <5>
UserInput/basicString <6>
UserInput/dtmf <7>
UserInput/RFC2833 <8>
Set:
0:
0:
Log-Func:
Log-Line: 0
User-Data:
G.711-ALaw-64k <1>
1:
2:
UserInput/hookflash <5>
3:
UserInput/basicString <6>
UserInput/dtmf <INCOMING DATA [(null)]
RECV EVENT
Event-Name: SOCKET_DATA
2010-12-13 11:58:21.840189 [DEBUG] h323caps.cxx:2778 Received capability
set, is accepted
2010-12-13 11:58:21.840189 [DEBUG] mod_opal.cpp:1076 Received message 26
on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.840189 [DEBUG] mod_dptools.c:1028
opal/in:231543514280633 SET [proxy_media]=[false]
2010-12-13 11:58:21.840189 [DEBUG] h323neg.cxx:341 Sending
TerminalCapabilitySet: outSeq=1
2010-12-13 11:58:21.840189 [DEBUG] mod_opal.cpp:1076 Received message 27
on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
EXECUTE opal/in:231543514280633 set(bypass_media=true)
2010-12-13 11:58:21.840189 [DEBUG] mod_opal.cpp:1076 Received message 26
on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.840189 [DEBUG] mod_dptools.c:1028
opal/in:231543514280633 SET [bypass_media]=[true]
2010-12-13 11:58:21.840189 [DEBUG] mod_opal.cpp:1076 Received message 27
on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
EXECUTE opal/in:231543514280633 set(absolute_codec_string=PCMA)
2010-12-13 11:58:21.840189 [DEBUG] mod_opal.cpp:1076 Received message 26
on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.840189 [DEBUG] mod_dptools.c:1028
opal/in:231543514280633 SET [absolute_codec_string]=[PCMA]
2010-12-13 11:58:21.840189 [DEBUG] mod_opal.cpp:1076 Received message 27
on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
EXECUTE opal/in:231543514280633
bridge(sofia/external/21543514280633(a)200.35.145.149)
2010-12-13 11:58:21.840189 [DEBUG] mod_opal.cpp:1076 Received message 26
on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.840189 [NOTICE] switch_channel.c:784 New Channel
sofia/external/21543514280633(a)200.35.145.149
[f9bf5b9e-a273-400c-b18c-e2c98c84750f]
2010-12-13 11:58:21.840189 [DEBUG] mod_sofia.c:3995
(sofia/external/21543514280633(a)200.35.145.149) State Change CS_NEW ->
CS_INIT
2010-12-13 11:58:21.840189 [DEBUG] switch_core_session.c:1083 Send
signal sofia/external/21543514280633(a)200.35.145.149 [BREAK]
2010-12-13 11:58:21.843189 [DEBUG] h323pdu.cxx:80 Sending PDU:
request terminalCapabilitySet {
sequenceNumber = 1
protocolIdentifier = 0.0.8.245.0.13
multiplexCapability = h2250Capability {
maximumAudioDelayJitter = 250
receiveMultipointCapabili
ty = {
multicastCapability = false
multiUniCastConference = false
mediaDistributionCapability = 1 entries {
[0]={
centralizedControl = false
distributedControl = false
centralized
Audio = false
distributedAudio = false
centralizedVideo = false
distributedVideo = false
}
}
}
transmitMultipointCapability = {
multicastCapability = false
multiUniCas
tConference = false
mediaDistributionCapability = 1 entries {
[0]={
centralizedControl = false
distributedControl = false
centralizedAudio = false
distributedAudio = false
centralizedVideo = false
distributedVideo = false
}
}
}
receiveAndTransmitMultipointCapability = {
multicastCapability = false
multiUniCastConference = false
mediaDistributionCapabil
ity = 1 entries {
[0]={
centralizedControl = false
distributedControl = false
centralizedAudio = false
distributedAudio = false
centralizedVideo = false
distributedVid
eo = false
}
}
}
mcCapability = {
centralizedConferenceMC = false
decentralizedConferenceMC = false
}
rtcpVideoControlCapability = false
mediaPacketizationCapability = {
h261aVi
deoPacketization = false
}
logicalChannelSwitchingCapability = false
t120DynamicPortCapability = true
}
capabilityTable = 8 entries {
[0]={
capabilityTableEntryNumber = 1
capability = receiveAudioCapab
ility g7231 {
maxAl_sduAudioFrames = 8
silenceSuppression = false
}
}
[1]={
capabilityTableEntryNumber = 2
capability = receiveAudioCapability g729 24
}
[2]={
capabilityTabl
eEntryNumber = 3
capability = receiveAudioCapability g711Ulaw64k 240
}
[3]={
capabilityTableEntryNumber = 4
capability = receiveAudioCapability g711Alaw64k 240
}
[4]={
capabilityTableEntryNumbe
r = 5
capability = receiveUserInputCapability hookflash <<null>>
}
[5]={
capabilityTableEntryNumber = 6
capability = receiveUserInputCapability basicString <<null>>
}
[6]={
capabilityTableEntry
Number = 7
capability = receiveUserInputCapability dtmf <<null>>
}
[7]={
capabilityTableEntryNumber = 8
capability = receiveRTPAudioTelephonyEventCapability {
dynamicRTPPayloadType = 101
audioT
elephoneEvent = "0-16"
}
}
}
capabilityDescriptors = 1 entries {
[0]={
capabilityDescriptorNumber = 1
simultaneousCapabilities = 3 entries {
[0]=4 entries {
[0]=1
[1]=2
[2]=3
[3]=4
}
[1]=1 entries {
[0]=5
}
[2]=3 entries {
[0]=6
[1]=7
[2]=8
}
}
}
}
}
2010-12-13 11:58:21.843189 [DEBUG] h323caps.cxx:2376 Found capability:
UserInput/RFC2833 <8>
2010-12-13 11:58:21.843189 [DEBUG] h323.cxx:3535 User Input RFC2833
payload type set to [pt=101]
2010-12-13 11:58:21.843189 [DEBUG] h323pdu.cxx:80 Sending PDU:
response terminalCapabilitySetAck {
sequenceNumber = 1
}
2010-12-13 11:58:21.843189 [DEBUG] switch_core_state_machine.c:320
(sofia/external/21543514280633(a)200.35.145.149) Running State Change
CS_INIT
2010-12-13 11:58:21.843189 [DEBUG] switch_core_state_machine.c:356
(sofia/external/21543514280633(a)200.35.145.149) State INIT
2010-12-13 11:58:21.843189 [DEBUG] mod_sofia.c:86
sofia/external/21543514280633(a)200.35.145.149 SOFIA INIT
2010-12-13 11:58:21.843189 [DEBUG] h323.cxx:3771
InternalEstablishedConnectionCheck: connectionState=AwaitingLocalAnswer
fastStartState=FastStartResponse H.245 is unavailable
2010-12-13 11:58:21.843189 [DEBUG] h323pdu.cxx:80 Receiving PDU:
request masterSlaveDetermination {
terminalType = 50
statusDeterminationNumber = 6111531
}
2010-12-13 11:58:21.843189 [DEBUG] h323neg.cxx:129 Received
MasterSlaveDetermination: state=Idle
2010-12-13 11:58:21.843189 [DEBUG] h323neg.cxx:160
MasterSlaveDetermination: local is master
2010-12-13 11:58:21.843189 [DEBUG] h323pdu.cxx:80 Sending PDU:
response masterSlaveDeterminationAck {
decision = slave <<null>>
}
2010-12-13 11:58:21.843189 [DEBUG] h323.cxx:3771
InternalEstablishedConnectionCheck: connectionState=AwaitingLocalAnswer
fastStartState=FastStartResponse H.245 is ready
2010-12-13 11:58:21.843189 [DEBUG] mod_sofia.c:126
(sofia/external/21543514280633(a)200.35.145.149) State Change CS_INIT ->
CS_ROUTING
2010-12-13 11:58:21.843189 [DEBUG] switch_core_session.c:1083 Send
signal sofia/external/21543514280633(a)200.35.145.149 [BREAK]
2010-12-13 11:58:21.843189 [DEBUG] sofia.c:4604 Channel
sofia/external/21543514280633(a)200.35.145.149 entering state
[terminated][900]
2010-12-13 11:58:21.843189 [DEBUG] h323ep.cxx:1033 OnSendAlerting conn =
Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
2010-12-13 11:58:21.843189 [DEBUG] switch_channel.c:2455
(sofia/external/21543514280633(a)200.35.145.149) Callstate Change DOWN ->
HANGUP
2010-12-13 11:58:21.843189 [DEBUG] h323.cxx:2110 SetAlerting sending
Alerting PDU
2010-12-13 11:58:21.843189 [NOTICE] sofia.c:5244 Hangup
sofia/external/21543514280633(a)200.35.145.149 [CS_ROUTING]
[NORMAL_UNSPECIFIED]
2010-12-13 11:58:21.843189 [DEBUG] switch_channel.c:2471 Send signal
sofia/external/21543514280633(a)200.35.145.149 [KILL]
2010-12-13 11:58:21.843189 [DEBUG] switch_core_session.c:1083 Send
signal sofia/external/21543514280633(a)200.35.145.149 [BREAK]
2010-12-13 11:58:21.843189 [DEBUG] switch_core_state_machine.c:356
(sofia/external/21543514280633(a)200.35.145.149) State INIT going to sleep
2010-12-13 11:58:21.843189 [DEBUG] switch_core_state_machine.c:320
(sofia/external/21543514280633(a)200.35.145.149) Running State Change
CS_HANGUP
2010-12-13 11:58:21.846211 [DEBUG] h323pdu.cxx:80 Sending PDU:
{
q931pdu = {
protocolDiscriminator = 8
callReference = 22716
from = destination
messageType = Alerting
IE: Display = {
72 6f 6f 74 00
root.
}
IE: User-User = {
23 80 06 00 08 91 4a 00 06 22 c0 09 00 00 3d 1e
#.....J.."....=.
56 6f 78 20 4c 75 63 69 64 61 20 50 74 79 2e 20 Vox Lucida
Pty.
...
}
}
h225pdu = {
h323
_uu_pdu = {
h323_message_body = alerting {
protocolIdentifier = 0.0.8.2250.0.6
destinationInfo = {
vendor = {
vendor = {
t35CountryCode = 9
t35Extension = 0
manufacturerCode = 61
}
productId = 31 octets {
56 6f 78 20 4c 75 63 69 64 61 20 50 74 79 2e 20 Vox
Lucida Pty.
4c 74 64 2e 20 6d 6f 64 5f 6f 70 61 6c 00 00 Ltd.
mod_op
Log-Line: 0
User-Data:
}
terminal = {
}
mc = false
undefinedNode = false
}
callIdentifier = {
guid = 16 octets {
3a 76 b2 f2 1d 05 e0 11 9b b7 00 1e 64 1f 33
fe :v........
..d.3.
}
}
multipleCalls = false
maintainConnection = false
}
h245Tunneling = true
h245Control = 3 entries {
[0]= 108 octets {
02 70 01 06 00 08 81 75 00 0d 80
13 80 00 fa 00 .p.....u........
01 00 00 01 00 00 01 00 00 0c c0 01 00 01 80
07 ................
...
}
[1]= 3 octets {
21 80 01 !..
}
[2]= 2 octets {
20 a0 .
}
}
}
}
}
2010-12-13 11:58:21.846211 [DEBUG] h323ep.cxx:1039 OnSentAlerting conn =
Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
2010-12-13 11:58:21.846211 [DEBUG] h323.cxx:3771
InternalEstablishedConnectionCheck: connectionState=AwaitingLocalAnswer
fastStartState=FastStartResponse H.245 is ready
2010-12-13 11:58:21.846211 [DEBUG] connection.cxx:361
OnSetUpConnectionCall[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.846211 [DEBUG] endpoint.cxx:408 OnSetUpConnection
Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.846211 [DEBUG] h323.cxx:1701 OnAnswerCall
Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716], caller =
gustavo [200.117.192.17]
2010-12-13 11:58:21.846211 [DEBUG] call.cxx:219 OnAnswerCall
Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716] caller
"gustavo [200.117.192.17]"
2010-12-13 11:58:21.846211 [DEBUG] h323.cxx:1713 Answering call:
AnswerCallDeferred
2010-12-13 11:58:21.846211 [DEBUG] connection.cxx:541 Answering call:
AnswerCallDeferred
2010-12-13 11:58:21.846211 [DEBUG] h323.cxx:3771
InternalEstablishedConnectionCheck: connectionState=AwaitingLocalAnswer
fastStartState=FastStartResponse H.245 is ready
2010-12-13 11:58:21.846211 [DEBUG] h323.cxx:506 Reading PDUs:
callRef=22716
2010-12-13 11:58:21.846211 [DEBUG] switch_ivr_originate.c:3448 Originate
Resulted in Error Cause: 31 [NORMAL_UNSPECIFIED]
2010-12-13 11:58:21.849192 [INFO] mod_dptools.c:2579 Originate Failed.
Cause: NORMAL_UNSPECIFIED
2010-12-13 11:58:21.849192 [DEBUG] mod_opal.cpp:1076 Received message 27
on connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.849192 [NOTICE] switch_core_state_machine.c:189
opal/in:231543514280633 has executed the last dialplan instruction,
hanging up.
2010-12-13 11:58:21.849192 [DEBUG] switch_channel.c:2455
(opal/in:231543514280633) Callstate Change RINGING -> HANGUP
2010-12-13 11:58:21.849192 [NOTICE] switch_core_state_machine.c:191
Hangup opal/in:231543514280633 [CS_EXECUTE] [NORMAL_CLEARING]
2010-12-13 11:58:21.849192 [DEBUG] switch_channel.c:2471 Send signal
opal/in:231543514280633 [KILL]
2010-12-13 11:58:21.849192 [DEBUG] mod_opal.cpp:931 Kill 1 on connection
Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.849192 [DEBUG] mod_opal.cpp:1092 State changed on
connection Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.849192 [DEBUG] switch_core_session.c:1083 Send
signal opal/in:231543514280633 [BREAK]
2010-12-13 11:58:21.849192 [DEBUG] mod_opal.cpp:931 Kill 3 on connection
Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.849192 [DEBUG] switch_core_state_machine.c:366
(opal/in:231543514280633) State EXECUTE going to sleep
2010-12-13 11:58:21.849192 [DEBUG] switch_core_state_machine.c:320
(opal/in:231543514280633) Running State Change CS_HANGUP
2010-12-13 11:58:21.849192 [DEBUG] switch_core_state_machine.c:557
(sofia/external/21543514280633(a)200.35.145.149) State HANGUP
2010-12-13 11:58:21.849192 [DEBUG] mod_sofia.c:453
sofia/external/21543514280633(a)200.35.145.149 Overriding SIP cause 480
with 900 from the other leg
2010-12-13 11:58:21.849192 [DEBUG] mod_sofia.c:459 Channel
sofia/external/21543514280633(a)200.35.145.149 hanging up, cause:
NORMAL_UNSPECIFIED
2010-12-13 11:58:21.849192 [DEBUG] switch_core_state_machine.c:46
sofia/external/21543514280633(a)200.35.145.149 Standard HANGUP, cause:
NORMAL_UNSPECIFIED
2010-12-13 11:58:21.849192 [DEBUG] switch_core_state_machine.c:557
(sofia/external/21543514280633(a)200.35.145.149) State HANGUP going to
sleep
2010-12-13 11:58:21.849192 [DEBUG] switch_core_state_machine.c:351
(sofia/external/21543514280633(a)200.35.145.149) State Change CS_HANGUP ->
CS_REPORTING
2010-12-13 11:58:21.849192 [DEBUG] switch_core_session.c:1083 Send
signal sofia/external/21543514280633(a)200.35.145.149 [BREAK]
2010-12-13 11:58:21.849192 [DEBUG] switch_core_state_machine.c:320
(sofia/external/21543514280633(a)200.35.145.149) Running State Change
CS_REPORTING
2010-12-13 11:58:21.849192 [DEBUG] switch_core_state_machine.c:617
(sofia/external/21543514280633(a)200.35.145.149) State REPORTING
2010-12-13 11:58:21.849192 [DEBUG] switch_core_state_machine.c:557
(opal/in:231543514280633) State HANGUP
2010-12-13 11:58:21.849192 [DEBUG] connection.cxx:401 Call end reason
for Call[Cc70e3cf91]-EP<local>[Ldc8d6c462] set to EndedByRemoteUser
2010-12-13 11:58:21.849192 [DEBUG] call.cxx:112 Clearing
Call[Cc70e3cf91] reason=EndedByRemoteUser
2010-12-13 11:58:21.852189 [DEBUG] connection.cxx:1516 SetPhase from
SetUpPhase to ReleasingPhase for Call[Cc70e3cf91]-EP<h323>[tcp
$200.117.192.17:19270/22716]
2010-12-13 11:58:21.852189 [DEBUG] connection.cxx:459 Releasing
asynchronously Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
2010-12-13 11:58:21.852189 [DEBUG] osutil.cxx:196 File handle low water
mark set: 69 Thread unblock pipe
2010-12-13 11:58:21.852189 [DEBUG] connection.cxx:1516 SetPhase from
AlertingPhase to ReleasingPhase for
Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.852189 [DEBUG] connection.cxx:448 Releasing
Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.852189 [DEBUG] connection.cxx:489 OnReleased
Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.852189 [DEBUG] connection.cxx:808 Media streams
closed.
2010-12-13 11:58:21.852189 [DEBUG] endpoint.cxx:450 OnReleased
Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.852189 [DEBUG] manager.cxx:709 OnReleased
Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.852189 [DEBUG] call.cxx:716 OnReleased
Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.852189 [DEBUG] connection.cxx:436 Already released
Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
2010-12-13 11:58:21.856029 [DEBUG] connection.cxx:1516 SetPhase from
ReleasingPhase to ReleasedPhase for
Call[Cc70e3cf91]-EP<local>[Ldc8d6c462]
2010-12-13 11:58:21.856029 [DEBUG] switch_core_state_machine.c:46
opal/in:231543514280633 Standard HANGUP, cause: NORMAL_CLEARING
2010-12-13 11:58:21.856029 [DEBUG] switch_core_state_machine.c:557
(opal/in:231543514280633) State HANGUP going to sleep
2010-12-13 11:58:21.856029 [DEBUG] switch_core_state_machine.c:351
(opal/in:231543514280633) State Change CS_HANGUP -> CS_REPORTING
2010-12-13 11:58:21.856029 [DEBUG] switch_core_session.c:1083 Send
signal opal/in:231543514280633 [BREAK]
2010-12-13 11:58:21.856029 [DEBUG] switch_core_state_machine.c:320
(opal/in:231543514280633) Running State Change CS_REPORTING
2010-12-13 11:58:21.856029 [DEBUG] switch_core_state_machine.c:617
(opal/in:231543514280633) State REPORTING
2010-12-13 11:58:21.856029 [DEBUG] connection.cxx:401 Call end reason
for Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716] set to
EndedByRemoteUser
2010-12-13 11:58:21.856029 [DEBUG] h323.cxx:349 OnReleased: tcp
$200.117.192.17:19270/22716, connectionState=AwaitingLocalAnswer
2010-12-13 11:58:21.856029 [DEBUG] switch_core_state_machine.c:53
sofia/external/21543514280633(a)200.35.145.149 Standard REPORTING, cause:
NORMAL_UNSPECIFIED
2010-12-13 11:58:21.856029 [DEBUG] switch_core_state_machine.c:617
(sofia/external/21543514280633(a)200.35.145.149) State REPORTING going to
sleep
2010-12-13 11:58:21.856029 [DEBUG] switch_core_state_machine.c:345
(sofia/external/21543514280633(a)200.35.145.149) State Change CS_REPORTING
-> CS_DESTROY
2010-12-13 11:58:21.856029 [DEBUG] switch_core_session.c:1083 Send
signal sofia/external/21543514280633(a)200.35.145.149 [BREAK]
2010-12-13 11:58:21.856029 [DEBUG] switch_core_session.c:1250 Session 2
(sofia/external/21543514280633(a)200.35.145.149) Locked, Waiting on
external entities
2010-12-13 11:58:21.856029 [NOTICE] switch_core_session.c:1268 Session 2
(sofia/external/21543514280633(a)200.35.145.149) Ended
2010-12-13 11:58:21.856029 [NOTICE] switch_core_session.c:1270 Close
Channel sofia/external/21543514280633(a)200.35.145.149 [CS_DESTROY]
2010-12-13 11:58:21.856029 [DEBUG] switch_core_state_machine.c:449
(sofia/external/21543514280633(a)200.35.145.149) Callstate Change HANGUP
-> DOWN
2010-12-13 11:58:21.858228 [DEBUG] switch_core_state_machine.c:452
(sofia/external/21543514280633(a)200.35.145.149) Running State Change
CS_DESTROY
2010-12-13 11:58:21.858228 [DEBUG] switch_core_state_machine.c:462
(sofia/external/21543514280633(a)200.35.145.149) State DESTROY
2010-12-13 11:58:21.858228 [DEBUG] mod_sofia.c:364
sofia/external/21543514280633(a)200.35.145.149 SOFIA DESTROY
2010-12-13 11:58:21.858228 [DEBUG] switch_core_state_machine.c:60
sofia/external/21543514280633(a)200.35.145.149 Standard DESTROY
2010-12-13 11:58:21.858228 [DEBUG] switch_core_state_machine.c:462
(sofia/external/21543514280633(a)200.35.145.149) State DESTROY going to
sleep
2010-12-13 11:58:21.856029 [DEBUG] h323.cxx:356 Sending release complete
PDU: callRef=22716
2010-12-13 11:58:21.858228 [DEBUG] h323pdu.cxx:80 Sending PDU:
command endSessionCommand disconnect <<null>>
2010-12-13 11:58:21.858228 [DEBUG] h323pdu.cxx:80 Sending PDU:
{
q931pdu = {
protocolDiscriminator = 8
callReference = 22716
from = destination
messageType = ReleaseComplete
IE: Cause - Normal call clearing = {
80 90
..
}
IE: Display = {
72 6f 6f 74 00 root.
}
IE: User-User = {
25 80 06 00 08 91 4a 00 06 01 11 00 3a 76 b2 f2
%.....J.....:v..
Log-Func:
Log-Line: 0
User-Data:
1d 05 e0 11 9b b7 00 1e 64 1f 33 fe 04 c0 01 80 ........d.3.....
...
}
}
h225pdu = {
h323_uu_pdu = {
h323_message_body = releaseComplete {
protocolIdentifier = 0.0.8= {
guid = 16 octets {
3a 76 b2 f2 1d 05 e0 11 9b b7 00 1e 64 1f 33
fe :v..........d.3.
}
}
}
h245Tunneling = true
h245Control = 1 entries {
[0]= 2 octets {
4a 40 J@
}
}
}
}
}
2010-12-13 11:58:21.861189 [DEBUG] h323.cxx:412 Awaiting end session
from remote for 9.997 seconds
2010-12-13 11:58:21.861189 [DEBUG] switch_core_state_machine.c:53
opal/in:231543514280633 Standard REPORTING, cause: NORMAL_CLEARING
2010-12-13 11:58:21.861189 [DEBUG] switch_core_state_machine.c:617
(opal/in:231543514280633) State REPORTING going to sleep
2010-12-13 11:58:21.861189 [DEBUG] switch_core_state_machine.c:345
(opal/in:231543514280633) State Change CS_REPORTING -> CS_DESTROY
2010-12-13 11:58:21.861189 [DEBUG] switch_core_session.c:1083 Send
signal opal/in:231543514280633 [BREAK]
2010-12-13 11:58:21.861189 [DEBUG] switch_core_session.c:1250 Session 1
(opal/in:231543514280633) Locked, Waiting on external entities
2010-12-13 11:58:21.861189 [NOTICE] switch_core_session.c:1268 Session 1
(opal/in:231543514280633) Ended
2010-12-13 11:58:21.861189 [NOTICE] switch_core_session.c:1270 Close
Channel opal/in:231543514280633 [CS_DESTROY]
2010-12-13 11:58:21.861189 [DEBUG] switch_core_state_machine.c:449
(opal/in:231543514280633) Callstate Change HANGUP -> DOWN
2010-12-13 11:58:21.861189 [DEBUG] switch_core_state_machine.c:452
(opal/in:231543514280633) Running State Change CS_DESTROY
2010-12-13 11:58:21.861189 [DEBUG] switch_core_state_machine.c:462
(opal/in:231543514280633) State DESTROY
2010-12-13 11:58:21.861189 [DEBUG] switch_core_state_machine.c:60
opal/in:231543514280633 Standard DESTROY
2010-12-13 11:58:21.861189 [DEBUG] switch_core_state_machine.c:462
(opal/in:231543514280633) State DESTROY going to sleep
2010-12-13 11:58:22.087167 [DEBUG] h323pdu.cxx:80 Receiving PDU:
{
q931pdu = {
protocolDiscriminator = 8
callReference = 22716
from = originator
messageType = Facility
IE: Facility = {
}
IE: Display = {
67 75 73 74
(..........!...
80 .
}
}
h225pdu = {
h323_uu_pdu = {
h323_message_body = empty <<null>>
h245Tunneling = true
h245Control = 2 entries {
[0]= 3 octets {
21 80 01 !..
}
[1]= 2
octets {
20 80 .
}
}
}
}
}
2010-12-13 11:58:22.087167 [DEBUG] h323.cxx:559 Handling PDU: Facility
callRef=22716
2010-12-13 11:58:22.087167 [DEBUG] h323.cxx:2709 Checking for end
session on PDU: response terminalCapabilitySetAck
2010-12-13 11:58:22.087167 [DEBUG] h323.cxx:2709 Checking for end
session on PDU: response masterSlaveDeterminationAck
2010-12-13 11:58:22.087167 [DEBUG] connection.cxx:436 Already released
Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
2010-12-13 11:58:22.087167 [DEBUG] h323.cxx:549 Signal channel closed.
2010-12-13 11:58:22.087167 [DEBUG] transports.cxx:900 Transport clean up
on termination
2010-12-13 11:58:22.087167 [DEBUG] transports.cxx:885 Transport Close
2010-12-13 11:58:22.090169 [DEBUG] osutil.cxx:196 File handle low water
mark set: 65 PTextFile
2010-12-13 11:58:22.090169 [DEBUG] tlibthrd.cxx:1020 Could not parse
thread stat file /proc/21145/task/21190/stat
2010-12-13 11:58:22.306147 [DEBUG] connection.cxx:489 OnReleased
Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
2010-12-13 11:58:22.306147 [DEBUG] connection.cxx:808 Media streams
closed.
2010-12-13 11:58:22.306147 [DEBUG] endpoint.cxx:450 OnReleased
Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
2010-12-13 11:58:22.306147 [DEBUG] manager.cxx:709 OnReleased
Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
2010-12-13 11:58:22.306147 [DEBUG] call.cxx:716 OnReleased
Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
2010-12-13 11:58:22.306147 [DEBUG] manager.cxx:535 OnClearedCall
Call[Cc70e3cf91] from "h323:200.117.192.17" to "h323:231543514280633"
2010-12-13 11:58:22.306147 [DEBUG] connection.cxx:1516 SetPhase from
ReleasingPhase to ReleasedPhase for Call[Cc70e3cf91]-EP<h323>[tcp
$200.117.192.17:19270/22716]
2010-12-13 11:58:22.306147 [DEBUG] connection.cxx:480 OnRelease thread
completed for Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716]
2010-12-13 11:58:22.308152 [DEBUG] tlibthrd.cxx:1020 Could not parse
thread stat file /proc/21145/task/21194/stat
2010-12-13 11:58:22.588122 [DEBUG] transports.cxx:900 Transport clean up
on termination
2010-12-13 11:58:22.588122 [DEBUG] transports.cxx:885 Transport Close
2010-12-13 11:58:22.588122 [DEBUG] transports.cxx:1045 Deleted transport
tcp$200.117.192.17:19270<if=tcp$72.51.47.100:1720>
2010-12-13 11:58:22.590122 [DEBUG] h323.cxx:330 Connection tcp
$200.117.192.17:19270/22716 deleted.
2010-12-13 11:58:22.590122 [DEBUG] connection.cxx:343 Connection
Call[Cc70e3cf91]-EP<h323>[tcp$200.117.192.17:19270/22716] destroyed.
2010-12-13 11:58:22.590122 [DEBUG] localep.cxx:211 Deleted connection.
2010-12-13 11:58:22.590122 [DEBUG] connection.cxx:343 Connection
Call[Cc70e3cf91]-EP<local>[Ldc8d6c462] destroyed.
2010-12-13 11:58:23.592039 [DEBUG] call.cxx:86 Call[Cc70e3cf91]
destroyed.
---------------------------------------------------------------------------------------------------------------------------------------------------------------------
Gustavo Espeche
www.easyipcall.com
2
1
Test - Please ignore
thanks
Marc
1
0