Re: Does H460.18 / 19 support in GnuGK 2.3 mean that Tandberg VCS Expressway is no longer required?

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

 



On Tue, Jul 14, 2009 at 3:35 PM, Jan Willamowius<jan@xxxxxxxxxxxxxx> wrote:
> Hi Robert,
>
> since you want to use H.460.18/19 for firewall traversal, you don't
> need GnuGks old proxy mode section. Just use
>
> [Gatekeeper::Main]
> Fortytwo=42
>
> [RoutedMode]
> GKRouted=1
> EnableH46018=1
>
> H.460.18 will allow your Polycoms behind a firewall to connect to your
> GnuGk server. Make sure that GnuGk is on a public IP and can reach the
> outside IPs you want to call, just like your border proxy would need to
> be.

Thanks, I'm still trying to troubleshoot this...

Here's what an outbound call to 140.242.250.200 (one of the Polycom IP
video test numbers) looks like:
2009-07-20 16:38:44 DEBUG avc: pc[0]: ********** KEYBOARD DATA,
IR_code: 0x25 RPT: 0
2009-07-20 16:38:44 DEBUG avc: pc[0]: uimsg: S4da8: 20000 dial manual
0 384 h323:140.242.250.200
2009-07-20 16:38:44 DEBUG avc: pc[0]: DIAL STRING = "140.242.250.200"
2009-07-20 16:38:44 DEBUG avc: pc[0]: conn type h323, pDevice type
h323, pDNext type
2009-07-20 16:38:44 DEBUG avc: pc[0]: CTS = h323, scc = 0
2009-07-20 16:38:44 DEBUG avc: pc[0]: CTS = h323, str = h320
2009-07-20 16:38:44 DEBUG avc: pc[0]: CTS = h323 3
2009-07-20 16:38:44 DEBUG avc: pc[0]: ConnMan[0]: allocated H323Conn[3]
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 0 instance 0
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String pe01
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got pe01[0]
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 0 instance 0
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String pd01
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got pd01[0]
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 1 instance 0
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String ce01
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got ce01[0]
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 1 instance 0
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String cd01
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got cd01[0]
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 0 instance 0
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String pe01
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got pe01[0]
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 0 instance 1
2009-07-20 16:38:44 INFO jvm: pc[0]: UI: RemoteControlThread:
CallHandler: addDialInfo() : connectionType    = specified
2009-07-20 16:38:44 INFO jvm: pc[0]: UI: RemoteControlThread:
CallHandler: addDialInfo() : specifiedCallType =
2009-07-20 16:38:44 DEBUG jvm: pc[0]: UI: asyn: CallHandler: #### UI
sending dial(dialInfo) : speed =384, callType = h323, number1 =
140.242.250.200, ext = null
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String pd02
2009-07-20 16:38:44 INFO jvm: pc[0]: UI: asyn: CallHandler:
sendDialCommand: command = [dial manual 0 384 h323:140.242.250.200]
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got pd02[1]
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 1 instance 0
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String ce01
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got ce01[0]
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 1 instance 0
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String cd01
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got cd01[0]
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 0 instance 0
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String pe01
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got pe01[0]
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 0 instance 2
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String pd03
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got pd03[2]
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 1 instance 0
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String ce01
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got ce01[0]
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 1 instance 0
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String cd01
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got cd01[0]
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 0 instance 0
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String pe01
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got pe01[0]
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 0 instance 3
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String (null)
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got nil
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 1 instance 0
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String ce01
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got ce01[0]
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 1 instance 0
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String cd01
2009-07-20 16:38:44 INFO jvm: pc[0]: UI: asyn: SECURITY:
ConfigurationManager dialnumber.dat = {140.242.250.200} ID: user
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got cd01[0]
2009-07-20 16:38:44 INFO jvm: pc[0]: UI: asyn: SECURITY:
ConfigurationManager dialnumber1.dat = {} ID: user
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 0 instance 0
2009-07-20 16:38:44 INFO jvm: pc[0]: UI: asyn: SECURITY:
ConfigurationManager dialnumberext.dat = {} ID: user
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String pe01
2009-07-20 16:38:44 INFO jvm: pc[0]: UI: asyn: SECURITY:
ConfigurationManager macconnectiontype.dat = {h323} ID: user
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got pe01[0]
2009-07-20 16:38:44 DEBUG jvm: pc[0]: UI: asyn: MakeACall: PAC got a
conference Message
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 0 instance 4
2009-07-20 16:38:44 DEBUG jvm: pc[0]: UI: asyn: Call: setType() :
m_nCallType                          = 0
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String (null)
2009-07-20 16:38:44 INFO jvm: pc[0]: UI: asyn: SECURITY:
ConfigurationManager camernameiconfar0.dat =
{CameraSelection_Mainlg.png} ID: user
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got nil
2009-07-20 16:38:44 INFO jvm: pc[0]: UI: asyn: SECURITY:
ConfigurationManager camernameiconfar1.dat =
{CameraSelection_Mainlg.png} ID: user
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 1 instance 0
2009-07-20 16:38:44 INFO jvm: pc[0]: UI: asyn: SECURITY:
ConfigurationManager camernameiconfar2.dat =
{CameraSelection_Mainlg.png} ID: user
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String ce01
2009-07-20 16:38:44 INFO jvm: pc[0]: UI: asyn: SECURITY:
ConfigurationManager camernameiconfar3.dat =
{CameraSelection_Mainlg.png} ID: user
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got ce01[0]
2009-07-20 16:38:44 INFO jvm: pc[0]: UI: asyn: SECURITY:
ConfigurationManager camernameiconfar4.dat =
{CameraSelection_Mainlg.png} ID: user
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 1 instance 0
2009-07-20 16:38:44 INFO jvm: pc[0]: UI: asyn: SECURITY:
ConfigurationManager camernameiconfar5.dat =
{CameraSelection_Mainlg.png} ID: user
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String cd01
2009-07-20 16:38:44 DEBUG jvm: pc[0]: UI: asyn: MakeACall$3: Connection id = 39
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got cd01[0]
2009-07-20 16:38:44 DEBUG jvm: pc[0]: UI: asyn: DisplayManager:
updateMonitor1Panel: entered
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 0 instance 0
2009-07-20 16:38:44 DEBUG jvm: pc[0]: UI: asyn: DisplayManager:
updateMonitor1Panel: entered
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String pe01
2009-07-20 16:38:44 DEBUG jvm: pc[0]: UI: asyn: DisplayManager:
updateMonitor1Panel: entered
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got pe01[0]
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 0 instance 5
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String (null)
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got nil
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 1 instance 0
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String ce01
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got ce01[0]
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 1 instance 0
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String cd01
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got cd01[0]
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 0 instance 0
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String pe01
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got pe01[0]
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 0 instance 6
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String (null)
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got nil
2009-07-20 16:38:44 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 1 instance 0
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String ce01
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got ce01[0]
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 1 instance 0
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String cd01
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got cd01[0]
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 0 instance 0
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String pe01
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got pe01[0]
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 0 instance 7
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String (null)
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got nil
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 1 instance 0
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String ce01
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got ce01[0]
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 1 instance 0
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String cd01
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got cd01[0]
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 0 instance 0
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String pe01
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got pe01[0]
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 0 instance 8
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String (null)
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got nil
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 1 instance 0
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String ce01
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got ce01[0]
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 1 instance 0
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String cd01
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got cd01[0]
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 0 instance 0
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String pe01
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got pe01[0]
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 0 instance 9
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String (null)
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got nil
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 1 instance 0
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String ce01
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got ce01[0]
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 1 instance 0
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String cd01
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got cd01[0]
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 0 instance 0
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String pe01
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got pe01[0]
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 0 instance 10
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String (null)
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got nil
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 1 instance 0
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String ce01
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got ce01[0]
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 1 instance 0
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String cd01
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got cd01[0]
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 0 instance 0
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String pe01
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got pe01[0]
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 0 instance 11
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String (null)
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got nil
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: role 1 instance 0
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: route String ce01
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetEncoder: got ce01[0]
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: role 1 instance 0
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: route String cd01
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]:
VideoRouteProcGetDecoder: got cd01[0]
2009-07-20 16:38:45 INFO avc: pc[0]: Conf[0]: tracking free video bufs: 1152
2009-07-20 16:38:45 DEBUG avc: pc[0]: numNativeConns = 0 gCommConfig.maxConns 4
2009-07-20 16:38:45 DEBUG avc: pc[0]: Conf[0]: ConfAddConn: reqRate
384 nicAvailBW 7168 nicMaxRate 7168 nicUsedRate 0 maxConnRate 4096
2009-07-20 16:38:45 DEBUG avc: pc[0]: H323Conn[3]: Rate set to 384
2009-07-20 16:38:45 INFO avc: pc[0]: Conf[0]: matched rate:384000bps
2009-07-20 16:38:45 INFO avc: pc[0]: Conf[0]: added H323Conn[3],
rate:384000bps restricted:0
2009-07-20 16:38:45 INFO avc: pc[0]: Conf[0]: connections:1 (video:1
voice:0), since boot:24, MP since boot:0
2009-07-20 16:38:45 INFO avc: pc[0]: Conf[0]: serviced h320:0,
h323:24, voice:0, sip:0
2009-07-20 16:38:45 INFO avc: pc[0]: COMM: connection 0 added
2009-07-20 16:38:45 DEBUG avc: pc[0]: XMPPSetPresence: presence=in a
call videoCap=1 InACall=0 chatCap=0
2009-07-20 16:38:45 DEBUG avc: pc[0]: Conf[0]: content event:UserStop
2009-07-20 16:38:45 DEBUG avc: pc[0]: camera: system configure with
auto exposure always on
2009-07-20 16:38:45 DEBUG avc: pc[0]: Conf[0]: serial passthrough: port:2
2009-07-20 16:38:45 DEBUG avc: pc[0]: NOTIFY: COMM conference
connAdded 0 39 h323
2009-07-20 16:38:45 DEBUG avc: pc[0]: H323Conn[3]: dialing
140.242.250.200 at 384Kbps
2009-07-20 16:38:45 DEBUG avc: pc[0]: H323Conn[3]:
state:"disconnected" --> "connecting"
2009-07-20 16:38:45 DEBUG avc: pc[0]: H323Call[0]:
state:"disconnected" --> "allocated"
2009-07-20 16:38:45 DEBUG avc: pc[0]: NOTIFY: COMM call state 0 allocated
2009-07-20 16:38:45 DEBUG avc: pc[0]: call state callid=1 state = 1
cat=1 type=3
2009-07-20 16:38:45 DEBUG avc: pc[0]: H323Conn[3]: adding call:H323Call[0]
2009-07-20 16:38:45 DEBUG avc: pc[0]: NOTIFY: COMM connection
callAdded 39 0 h323 h323
2009-07-20 16:38:45 DEBUG avc: pc[0]: H323Call[0]: state:"allocated"
--> "offHook"
2009-07-20 16:38:45 DEBUG avc: pc[0]: H323Call[0]: state:"offHook" -->
"dialing"
2009-07-20 16:38:45 DEBUG avc: pc[0]: NOTIFY: COMM call state 0 offHook
2009-07-20 16:38:45 DEBUG avc: pc[0]: call state callid=1 state = 2
cat=1 type=3
2009-07-20 16:38:45 DEBUG avc: pc[0]: h323ras: Sending ARQ Request
2009-07-20 16:38:45 DEBUG avc: pc[0]: h323ras: SendARQ Parameters:
2009-07-20 16:38:45 DEBUG avc: pc[0]: h323ras:     GKprIPAddress
0xc0a80517:1719
2009-07-20 16:38:45 DEBUG avc: pc[0]:     GkprID: "OpenH323GK" (Gatekeeper ID)
2009-07-20 16:38:45 DEBUG avc: pc[0]:     EndpointID: "2829_endp" (Endpoint ID)
2009-07-20 16:38:45 DEBUG avc: pc[0]:     CallModel: GK Routed
2009-07-20 16:38:45 DEBUG avc: pc[0]:     CID: 0x5e3d3e94
2009-07-20 16:38:45 DEBUG avc: pc[0]:     Bandwidth: 768000
2009-07-20 16:38:45 DEBUG avc: pc[0]:     AnswerCall: 0
2009-07-20 16:38:45 DEBUG avc: pc[0]:     Destination callAddress:
"140.242.250.200:1720"
2009-07-20 16:38:45 DEBUG avc: pc[0]:     SrcInfo[0]: "cfo-ta" (H.323 ID)
2009-07-20 16:38:45 DEBUG avc: pc[0]:     SrcInfo[1]: "353826" (E.164)
2009-07-20 16:38:45 DEBUG avc: pc[0]:     Call ID: 0x5e3d3ea4
2009-07-20 16:38:45 DEBUG avc: pc[0]:     Turning on H.460.9 support.
2009-07-20 16:38:45 DEBUG avc: pc[0]: h323ras: ARQ sent
2009-07-20 16:38:45 DEBUG avc: pc[0]: NOTIFY: COMM call state 0 dialing
2009-07-20 16:38:45 DEBUG avc: tm[1]: DCCMsgSend: op=b, len=0, dest=100
2009-07-20 16:38:45 DEBUG avc: tm[1]: DCCMsgSend: op=5, len=0, dest=100
2009-07-20 16:38:45 DEBUG avc: pc[0]: call state callid=1 state = 3
cat=1 type=3
2009-07-20 16:38:45 DEBUG avc: pc[0]: NOTIFY: COMM connection state 39
connecting
2009-07-20 16:38:45 DEBUG avc: pc[0]: uimsg: A4da9: 20000 audiocallmix
video codec
2009-07-20 16:38:45 DEBUG avc: pc[0]:  h323ras: cmEvRASConfirm: received
2009-07-20 16:38:45 DEBUG avc: pc[0]: ACF
2009-07-20 16:38:45 DEBUG avc: pc[0]: h323ras:    Gatekeeper Address
ip:port = "192.168.5.23:1719"
2009-07-20 16:38:45 DEBUG avc: pc[0]: h323ras:    Bandwidth = 768000
2009-07-20 16:38:45 DEBUG avc: pc[0]: h323ras:    CallModel = 1
2009-07-20 16:38:45 DEBUG avc: pc[0]: h323ras:    Unsolicited IRR
frequency every 120 seconds
2009-07-20 16:38:45 DEBUG avc: pc[0]: h323ras:    Destination Call
Signal Address ip:port = "192.168.5.23:1721"
2009-07-20 16:38:45 DEBUG avc: pc[0]: h323rasClient: Gatekeeper
192.168.5.23:1719 Granted admission. Bandwidth 768000
2009-07-20 16:38:45 DEBUG avc: pc[0]: CLink2CallCallbacksUnProxy funcIdx 10
2009-07-20 16:38:45 DEBUG avc: pc[0]: NOTIFY: SYS speakerchange local 0 50 38
2009-07-20 16:38:45 INFO avc: tm[1]: Audio (RemoteSysSetCallMix):
Updating the audiocall mix to Video-Only
2009-07-20 16:38:45 INFO avc: tm[1]: Audio
(RemoteSysActiveSpaekerCallBack): Requesting audio routing change.
2009-07-20 16:38:45 INFO avc: tm[1]: CLinkDEP: volume adjusted to 38.
2009-07-20 16:38:45 INFO avc: tm[1]: CLinkDEP: We are the active speaker.
2009-07-20 16:38:45 DEBUG avc: pc[0]: h323nat: localIP =
"10.244.22.21", farIP = "192.168.5.23", both are non-routable but on
different LANs.
2009-07-20 16:38:45 DEBUG avc: last message repeated 1 times
2009-07-20 16:38:45 DEBUG avc: pc[0]: uimsg: A4daa: 20000 wav
../sounds/alertvideotone1.wav
2009-07-20 16:38:45 DEBUG avc: pc[0]: Wav file name =
../sounds/alertvideotone1.wav
2009-07-20 16:38:45 DEBUG avc: pc[0]: AUD: Wav file
../sounds/alertvideotone1.wav is openned.
2009-07-20 16:38:45 DEBUG avc: pc[0]: AUD: Wav file
../sounds/alertvideotone1.wav header read successfully.
2009-07-20 16:38:45 DEBUG avc: tm[1]: Audio: resampler wavRes with 61
ratio is initialized.
2009-07-20 16:38:45 DEBUG avc: tm[1]: wavMWMIn[0]: opened
2009-07-20 16:38:45 DEBUG avc: tm[1]: wavRes[0]: opened
2009-07-20 16:38:45 DEBUG avc: tm[1]: wavIntf[0]: opened
2009-07-20 16:38:45 DEBUG avc: tm[1]: wavB[0]: opened
2009-07-20 16:38:45 DEBUG avc: pc[0]: H323Call[0]: state:"dialing" -->
"ringingOut"
2009-07-20 16:38:45 DEBUG avc: pc[0]: NOTIFY: COMM call state 0 ringingOut
2009-07-20 16:38:45 DEBUG avc: pc[0]: NOTIFY: COMM call address 0
"10.244.22.21:3233" "192.168.5.23:1721" ""
2009-07-20 16:38:45 DEBUG avc: pc[0]: call state callid=1 state = 4
cat=1 type=3
2009-07-20 16:38:45 DEBUG avc: pc[0]: uimsg: A4dbd: 20000 camera near
move auto true
2009-07-20 16:38:45 INFO avc: pc[0]: RemoteIR: RemotecIRLowLvlIoctl()
is called: configured_ioctl:1, ioctl_value:1 ...
2009-07-20 16:38:45 INFO avc: pc[0]: RemoteIR:
RemotecIRLowLvlIoctl()is successful ...
2009-07-20 16:38:45 DEBUG avc: pc[0]: REAGANSERIAL: KEYPAD REPEAT
TIMING MSG[0] = 0xff ....
2009-07-20 16:38:45 DEBUG avc: pc[0]: REAGANSERIAL: KEYPAD REPEAT
TIMING MSG[1] = 0x42 ....
2009-07-20 16:38:45 DEBUG avc: pc[0]: REAGANSERIAL: KEYPAD REPEAT
TIMING MSG[2] = 0x00 ....
2009-07-20 16:38:45 DEBUG avc: pc[0]: REAGANSERIAL: KEYPAD REPEAT
TIMING MSG[3] = 0x04 ....
2009-07-20 16:38:45 DEBUG avc: pc[0]: REAGANSERIAL: KEYPAD REPEAT
TIMING MSG[4] = 0x06 ....
2009-07-20 16:38:45 DEBUG avc: pc[0]: REAGANSERIAL: KEYPAD REPEAT
TIMING MSG[5] = 0xfe ....
2009-07-20 16:38:45 DEBUG avc: pc[0]: REAGANSERIAL: KEYPAD REPEAT
TIMING MSG[6] = 0x01 ....
2009-07-20 16:38:45 DEBUG avc: pc[0]: REAGANSERIAL: KEYPAD REPEAT
TIMING MSG[7] = 0xfe ....
2009-07-20 16:38:45 DEBUG avc: pc[0]: REAGANSERIAL: KEYPAD REPEAT
TIMING MSG[8] = 0x01 ....
2009-07-20 16:38:45 DEBUG avc: pc[0]: REAGANSERIAL: KEYPAD REPEAT
TIMING MSG[9] = 0xfa ....
2009-07-20 16:38:45 INFO avc: pc[0]: CAMERA: UI Response
Buffer[CameraAvail]...
2009-07-20 16:38:45 DEBUG avc: pc[0]: uimsg: A4dbe: 20000 videooutput
vout1 cleardisplay
2009-07-20 16:38:45 DEBUG avc: pc[0]: uimsg: A4dbf: 20000 videoroute
set 192 vout1 1680 1050 DVID 60 progressive vinp 0 0 1680 1048 0 none
2009-07-20 16:38:45 DEBUG avc: pc[0]: Pending[0]:
VideoRouteStateUpdate: Updating vout1
2009-07-20 16:38:45 DEBUG avc: pc[0]: uimsg: A4dc0: 20000 videoroute
set 193 vout1 1680 1050 DVID 60 progressive vinp 0 0 1680 1048 0 none
2009-07-20 16:38:45 DEBUG avc: pc[0]: Pending[0]:
VideoRouteStateUpdate: Updating vout1
2009-07-20 16:38:45 DEBUG avc: pc[0]: H323Call[0]: H.225 call control connected
2009-07-20 16:38:45 DEBUG avc: pc[0]: H323Call[0]: state:"ringingOut"
--> "connected"
2009-07-20 16:38:45 DEBUG avc: pc[0]: NOTIFY: COMM call state 0 connected
2009-07-20 16:38:45 DEBUG avc: pc[0]: NOTIFY: COMM call address 0
"10.244.22.21:3233" "192.168.5.23:1721" "Vsx8000#1"
2009-07-20 16:38:45 DEBUG avc: pc[0]: RouteProc[0]: RouteProcNewRoute:
Diff count is 1. currSeqNum 194, lastSeqNum 192
2009-07-20 16:38:45 DEBUG avc: pc[0]: ChainCtrl[0]:
ChainCtrlUpdateRoute: Updating Node kVideoRouteNodeVideoOut
2009-07-20 16:38:45 DEBUG avc: pc[0]: VIDEO[0]: Current Route vout1:
width 1680, height 1050, refresh 60, Progressive
2009-07-20 16:38:45 DEBUG avc: pc[0]: VIDEO[0]: Current     source count 1
2009-07-20 16:38:45 DEBUG avc: pc[0]: VIDEO[0]: Current          src
vinp, w 1680, h 1050
2009-07-20 16:38:45 DEBUG avc: pc[0]: VIDEO[0]: Current          x 0, y 0, z 0
2009-07-20 16:38:45 DEBUG avc: pc[0]: VIDEO[0]: Current          ar
none, cx 0, cy 0, fr 0
2009-07-20 16:38:45 DEBUG avc: pc[0]: ChainCtrl[0]: Changing vout1
Route from 1050 to 720
2009-07-20 16:38:45 DEBUG avc: pc[0]: ChainCtrl[0]: Changing vinp src
from 1050 to 720
2009-07-20 16:38:45 DEBUG avc: pc[0]: VIDEO[0]:
ChainCtrlUpdateVideoOutRoute new route Route vout1: width 1280, height
720, refresh 60, Progressive
2009-07-20 16:38:45 DEBUG avc: pc[0]: VIDEO[0]:
ChainCtrlUpdateVideoOutRoute new route     source count 1
2009-07-20 16:38:45 DEBUG avc: pc[0]: VIDEO[0]:
ChainCtrlUpdateVideoOutRoute new route          src vinp, w 1280, h
720
2009-07-20 16:38:45 DEBUG avc: pc[0]: VIDEO[0]:
ChainCtrlUpdateVideoOutRoute new route          x 0, y 0, z 0
2009-07-20 16:38:45 DEBUG avc: pc[0]: VIDEO[0]:
ChainCtrlUpdateVideoOutRoute new route          ar none, cx 0, cy 0,
fr 0
2009-07-20 16:38:45 DEBUG avc: pc[0]: ChainCtrl[0]: FindVideoChain:
Looking for vout1, role unknown, spec unknown
2009-07-20 16:38:45 DEBUG avc: pc[0]: ChainCtrl[0]:
ChainCtrlUpdateVideoOutRoute on VideoOut1Ike[0]
2009-07-20 16:38:45 DEBUG avc: pc[0]: VideoOut1Ike[0].VidGenmChan[7]:
VideoGennumChanSetIOEnabled: Turn on/off(2) the Gennum port at 0
2009-07-20 16:38:45 DEBUG avc: pc[0]: call state callid=1 state = 8
cat=1 type=3
2009-07-20 16:38:45 DEBUG avc: pc[0]: speakerphone localNumber =
140.242.250.200
2009-07-20 16:38:45 DEBUG avc: pc[0]: speakerphone Callerid = Vsx8000#1
2009-07-20 16:38:45 INFO avc: pc[0]: H323Conn[3]: remote h225
version:4, product:"VSX 8000", version:"Release 8.7.1 - 04Feb2008
08:45" ManufID:0xb5002331
2009-07-20 16:38:45 DEBUG avc: pc[0]: H323Call[0]: Received NOTIFY
command with rate 128kbps
2009-07-20 16:38:45 INFO avc: pc[0]: H323Call[0]: rate:128000bps
2009-07-20 16:38:45 DEBUG avc: pc[0]: ChainCtrl[0]: FindVideoChain:
Looking for vinp, role unknown, spec unknown
2009-07-20 16:38:45 DEBUG avc: pc[0]: VideoOut1Ike[0].VidGenmChan[7]:
VideoGennumChanSetVHAPanels: Transformation Sucessful Old 0 0 1280
720, new 0 0 1680 1050
2009-07-20 16:38:45 DEBUG avc: pc[0]: VideoOut1Ike[0].VidGenmChan[7]:
====2. SetPanelSizePos: Same Size Setting: hPos = 0, vPos = 0, hSize =
1680, vSize = 1050
2009-07-20 16:38:45 DEBUG avc: pc[0]: VideoOut1Ike[0].VidGenmChan[7]:
VideoGennumChanSetIOEnabled: Turn on/off(1) the Gennum port at 0
2009-07-20 16:38:45 DEBUG avc: ti[3]: CompositorChan[4]: Set pass
through mode to 0
2009-07-20 16:38:45 DEBUG avc: ti[3]: ImageProc[1]:
ImgProcChanSetMinResParameters to false with 704x480
2009-07-20 16:38:45 DEBUG avc: pc[0]: NOTIFY: VID videoroute set 193
complete vout1 1680 1050 DVID 60 Progressive vinp 0 0 1680 1048 0 none
2009-07-20 16:38:45 DEBUG jvm: pc[0]: UI: asyn: ScreenManager: PERF
879 Complete callprogress[callprogresssingle.txt]
2009-07-20 16:38:45 DEBUG jvm: pc[0]: JVM Memory,125,19473812,22469228,41943040
2009-07-20 16:38:45 DEBUG jvm: pc[0]: UI: asyn: NativeAccess$4:
Unrecognized Message  [msg: VID videoroute set]
2009-07-20 16:38:45 DEBUG avc: pc[0]: AUD: Wav file
../sounds/alertvideotone1.wav is closed.
2009-07-20 16:38:45 DEBUG avc: tm[1]: wavMWMIn[0]: closed
2009-07-20 16:38:45 DEBUG avc: tm[1]: wavRes[0]: closed
2009-07-20 16:38:45 DEBUG avc: tm[1]: wavIntf[0]: closed
2009-07-20 16:38:45 DEBUG avc: tm[1]: wavB[0]: closed
2009-07-20 16:38:47 DEBUG avc: pc[0]: H323Call[0]: disconnected,
normal cause 16
2009-07-20 16:38:47 DEBUG avc: pc[0]: H323Call[0]: state:"connected"
--> "disconnecting"
2009-07-20 16:38:47 DEBUG avc: pc[0]: NOTIFY: COMM call state 0 disconnecting
2009-07-20 16:38:47 DEBUG avc: pc[0]: call state callid=1 state = 10
cat=1 type=3
2009-07-20 16:38:47 DEBUG avc: pc[0]: H323Conn[3]: state:"connecting"
--> "disconnecting"
2009-07-20 16:38:47 DEBUG avc: pc[0]: H323Call[0]: hangup, cause code 16
2009-07-20 16:38:47 DEBUG avc: pc[0]: NOTIFY: COMM connection
lastNumber 39 "140.242.250.200"
2009-07-20 16:38:47 DEBUG avc: pc[0]: NOTIFY: COMM connection state 39
disconnecting
2009-07-20 16:38:47 DEBUG avc: pc[0]: --------------- Number of
connected calls: 3 -------------
2009-07-20 16:38:47 DEBUG avc: pc[0]: h323ras: Sending DRQ Request
2009-07-20 16:38:48 DEBUG avc: pc[0]: h323ras: DRQ sent
2009-07-20 16:38:48 DEBUG avc: pc[0]:  h323ras: cmEvRASConfirm: received
2009-07-20 16:38:48 DEBUG avc: pc[0]: DCF
2009-07-20 16:38:48 DEBUG avc: pc[0]: h323ras:    Gatekeeper Address
ip:port = "192.168.5.23:1719"
2009-07-20 16:38:48 DEBUG avc: pc[0]: h323rasClient: Gatekeeper
192.168.5.23 Call Disengaged
2009-07-20 16:38:48 DEBUG avc: pc[0]: H323Call[0]: Gatekeeper
confirmed our DRQ or we timed out waiting for a response; end the
call.
2009-07-20 16:38:48 INFO avc: pc[0]: H323Call[0]: outgoing
disconnected, cause code:16
2009-07-20 16:38:48 DEBUG avc: pc[0]: H323Call[0]:
state:"disconnecting" --> "disconnected"
2009-07-20 16:38:48 DEBUG avc: pc[0]: NOTIFY: COMM call state 0 disconnected 16
2009-07-20 16:38:48 DEBUG avc: pc[0]: call state callid=1 state = 0
cat=1 type=3
2009-07-20 16:38:48 DEBUG avc: pc[0]: H323Conn[3]: deleting call - H323Call[0]
2009-07-20 16:38:48 INFO avc: pc[0]: H323Conn[3]: H323Call[0] deleted,
address:192.168.5.23:1721
2009-07-20 16:38:48 DEBUG avc: pc[0]: NOTIFY: COMM connection callDeleted 39 0
2009-07-20 16:38:48 DEBUG avc: pc[0]: H323Conn[3]: DBA, exit
2009-07-20 16:38:48 DEBUG avc: pc[0]: H323Conn[3]: removing far
cameras with connId (39) before disconnecting
2009-07-20 16:38:48 DEBUG avc: pc[0]: CamMan[0]:
CamManRemoveFarCameras: connId=39
2009-07-20 16:38:48 DEBUG avc: pc[0]: CamMan[0]: ERROR :
CamManGetCameraAtConn, connId=39 no camera found
2009-07-20 16:38:48 DEBUG avc: pc[0]: CamMan[0]: ERROR:
CamManRemoveFarCameras:No such camera with connId = 39
2009-07-20 16:38:48 DEBUG avc: pc[0]: H323Conn[3]:
state:"disconnecting" --> "disconnected"
2009-07-20 16:38:48 DEBUG avc: pc[0]: NOTIFY: COMM connection state 39
disconnected 16
2009-07-20 16:38:48 DEBUG avc: pc[0]: Conf[0]: deleting H323Conn
connection (#0)
2009-07-20 16:38:48 DEBUG avc: pc[0]: NOTIFY: COMM conference connDeleted 0 39
2009-07-20 16:38:48 DEBUG avc: pc[0]: camera: system configure with
auto exposure always on
2009-07-20 16:38:48 DEBUG avc: last message repeated 1 times
2009-07-20 16:38:48 DEBUG avc: pc[0]: Conf[0]: disabled serial passthrough
2009-07-20 16:38:48 DEBUG avc: pc[0]: XMPPSetPresence:
presence=available videoCap=1 InACall=0 chatCap=0
2009-07-20 16:38:48 INFO jvm: pc[0]: UI: LOGM: SECURITY:
ConfigurationManager cdrconfid.dat = {542} ID: user
2009-07-20 16:38:48 INFO jvm: pc[0]: UI: LOGM: SECURITY:
ConfigurationManager cdrconnid.dat = {1} ID: user
2009-07-20 16:38:48 INFO jvm: pc[0]: UI: LOGM: SECURITY:
ConfigurationManager cdrrowid.dat = {22} ID: user
2009-07-20 16:38:48 INFO jvm: pc[0]: UI: asyn: SECURITY:
ConfigurationManager pipstate.dat = {On} ID: user
2009-07-20 16:38:48 INFO jvm: pc[0]: UI: LOGM: SECURITY:
ConfigurationManager cdrconnid.dat = {2} ID: user
2009-07-20 16:38:48 DEBUG avc: pc[0]: ConnMan[0]: freed H323Conn[3]
2009-07-20 16:38:48 INFO jvm: pc[0]: UI: LOGM: SECURITY:
ConfigurationManager percentageipcalls.dat = {100%} ID: user
2009-07-20 16:38:48 DEBUG avc: pc[0]: CapsMan: preferResolution override False
2009-07-20 16:38:48 INFO jvm: pc[0]: UI: LOGM: SECURITY:
ConfigurationManager percentageisdncalls.dat = {0%} ID: user
2009-07-20 16:38:48 DEBUG avc: pc[0]: Comm calling
UpdatePeopleEncSD15Caps w/ bBiasResolution 0 bCommAskedForSD15fpsCaps
0
2009-07-20 16:38:48 INFO jvm: pc[0]: UI: LOGM: SECURITY:
ConfigurationManager percentagev35calls.dat = {0%} ID: user
2009-07-20 16:38:48 DEBUG avc: pc[0]: UpdatePeopleEncSD15Caps:
bBiasResolution 0 bBiasResolutionDATfile 0 bIsFromComm 1
bCommAskedForSD15fpsCaps 0
2009-07-20 16:38:48 INFO jvm: pc[0]: UI: LOGM: SECURITY:
ConfigurationManager totalnumberofcalls.dat = {161} ID: user
2009-07-20 16:38:48 DEBUG avc: pc[0]: UpdatePeopleEncSD15Caps: updated
bCommAskedForSD15fpsCaps to be 0
2009-07-20 16:38:48 INFO jvm: pc[0]: UI: LOGM: SECURITY:
ConfigurationManager totalnumberofipcalls.dat = {161} ID: user
2009-07-20 16:38:48 DEBUG avc: pc[0]: VIDEO[0]: VidCodecSetConfig pd01
CodecConfig: alg unknown, bitrate 0, framerate 0.000000, res SQCIF
updateAnnexes 0x0 cam
2009-07-20 16:38:48 INFO jvm: pc[0]: UI: LOGM: SECURITY:
ConfigurationManager totalnumberofisdncalls.dat = {0} ID: user
2009-07-20 16:38:48 DEBUG avc: pc[0]: VIDEO[0]:     width 0, height 0,
maxpkt 0, Sym, Progressive, sar kAspectNotDefined conceal on
2009-07-20 16:38:48 INFO jvm: pc[0]: UI: LOGM: SECURITY:
ConfigurationManager totalnumberofv35calls.dat = {0} ID: user
2009-07-20 16:38:48 DEBUG avc: pc[0]: VideoCodecStateChange: No need
to adjust people encoding caps for Non-JFK system w/ hwType 20
BrutusCard 1
2009-07-20 16:38:48 INFO jvm: pc[0]: UI: LOGM: SECURITY:
ConfigurationManager timeinlastcall.dat = {0:00:00} ID: user
2009-07-20 16:38:48 DEBUG avc: pc[0]: VIDEO[0]:
VideoRouteProcCodecSetConfig CodecConfig: alg unknown, bitrate 0,
framerate 0.000000, res SQCIF updateAnnexes 0x0 cam
2009-07-20 16:38:48 INFO jvm: pc[0]: UI: LOGM: SECURITY:
ConfigurationManager totaltimeincalls.dat = {4:19:57} ID: user
2009-07-20 16:38:48 DEBUG avc: pc[0]: VIDEO[0]:     width 0, height 0,
maxpkt 0, Sym, Progressive, sar kAspectNotDefined conceal on
2009-07-20 16:38:48 INFO jvm: pc[0]: UI: LOGM: SECURITY:
ConfigurationManager totaltimeipcalls.dat = {4:19:57} ID: user
2009-07-20 16:38:48 DEBUG avc: pc[0]: VIDEO[0]: VidCodecSetConfig pe01
CodecConfig: alg unknown, bitrate 0, framerate 0.000000, res SQCIF
updateAnnexes 0x0 cam
2009-07-20 16:38:48 INFO jvm: pc[0]: UI: LOGM: SECURITY:
ConfigurationManager totaltimeisdncalls.dat = {00:00:00} ID: user
2009-07-20 16:38:48 DEBUG avc: pc[0]: VIDEO[0]:     width 0, height 0,
maxpkt 0, Sym, Progressive, sar kAspectNotDefined conceal off
2009-07-20 16:38:48 INFO jvm: pc[0]: UI: LOGM: SECURITY:
ConfigurationManager totaltimev35calls.dat = {00:00:00} ID: user
2009-07-20 16:38:48 DEBUG avc: pc[0]: VideoCodecStateChange: No need
to adjust people encoding caps for Non-JFK system w/ hwType 20
BrutusCard 1
2009-07-20 16:38:48 INFO jvm: pc[0]: UI: GDS Thread:
GlobalDirectoryThread: run() : Server = 10.1.1.86, state = 4 isEnabled
= true isServerWaiting = false
2009-07-20 16:38:48 DEBUG avc: pc[0]: VIDEO[0]:
VideoRouteProcCodecSetConfig CodecConfig: alg unknown, bitrate 0,
framerate 0.000000, res SQCIF updateAnnexes 0x0 cam
2009-07-20 16:38:48 DEBUG jvm: pc[0]: UI: GDS Thread:
GlobalDirectoryThread: send(10.1.1.86) : Sending "GETCHANGES
200971694745.646"
2009-07-20 16:38:48 DEBUG avc: pc[0]: VIDEO[0]:     width 0, height 0,
maxpkt 0, Sym, Progressive, sar kAspectNotDefined conceal off
2009-07-20 16:38:48 INFO avc: pc[0]: Conf[0]: removed H323Conn[3]
2009-07-20 16:38:48 DEBUG avc: pc[0]: NOTIFY: COMM conference termDrop 0 1.2
2009-07-20 16:38:48 DEBUG avc: tm[1]: DCCMsgSend: op=c, len=0, dest=100
2009-07-20 16:38:48 DEBUG avc: tm[1]: DCCMsgSend: op=6, len=0, dest=100
2009-07-20 16:38:48 DEBUG avc: pc[0]: uimsg: A4dc1: 20000 audiocallmix
none codec
2009-07-20 16:38:48 DEBUG avc: pc[0]: uimsg: S4dc3: 20000 snmp 0 trap
calldown 140.242.250.200
2009-07-20 16:38:48 DEBUG avc: pc[0]: snmp: trap command: T:  calldown
140.242.250.200
2009-07-20 16:38:48 DEBUG avc: pc[0]: appcom: sending SNMP agent
message: T:  calldown 140.242.250.200
2009-07-20 16:38:48 DEBUG avc: pc[0]: CLink2CallCallbacksUnProxy funcIdx 10
2009-07-20 16:38:48 DEBUG avc: pc[0]: NOTIFY: SYS speakerchange local 0 50 38
2009-07-20 16:38:48 INFO avc: tm[1]: Audio (RemoteSysSetCallMix):
Updating the audiocall mix to None
2009-07-20 16:38:48 INFO avc: tm[1]: Audio
(RemoteSysActiveSpaekerCallBack): Requesting audio routing change.
2009-07-20 16:38:48 INFO avc: tm[1]: CLinkDEP: volume adjusted to 38.
2009-07-20 16:38:48 INFO avc: tm[1]: CLinkDEP: We are the active speaker.
2009-07-20 16:38:48 INFO avc: pc[0]: config: cdrconfid[0]:542
2009-07-20 16:38:48 INFO avc: pc[0]: config: cdrconnid[0]:1
2009-07-20 16:38:48 INFO avc: pc[0]: config: cdrrowid[0]:22
2009-07-20 16:38:48 INFO avc: pc[0]: config: cdrconnid[0]:2
2009-07-20 16:38:48 INFO avc: pc[0]: config: totalnumberofcalls[0]:161
2009-07-20 16:38:48 INFO avc: pc[0]: config: totalnumberofipcalls[0]:161
2009-07-20 16:38:48 DEBUG avc: pc[0]: h323ras: Sending RRQ Request
2009-07-20 16:38:48 DEBUG avc: pc[0]:     AliasList[0]: "353826" (E.164)
2009-07-20 16:38:48 DEBUG avc: pc[0]:     AliasList[1]: "cfo-ta" (H.323 ID)
2009-07-20 16:38:48 DEBUG avc: pc[0]: h323ras: RRQ sent
2009-07-20 16:38:48 DEBUG avc: pc[0]:  h323ras: cmEvRASConfirm: received
2009-07-20 16:38:48 DEBUG avc: pc[0]: RCF
2009-07-20 16:38:48 DEBUG avc: pc[0]: h323ras:    Alias type =
GatekeeperID, Alias string = "OpenH323GK"
2009-07-20 16:38:48 DEBUG avc: pc[0]: h323ras:    Gatekeeper Address
ip:port = "192.168.5.23:1719"
2009-07-20 16:38:48 DEBUG avc: pc[0]: h323ras:    Alias type =
EndpointID, Alias string = "2829_endp"
2009-07-20 16:38:48 DEBUG avc: pc[0]: h323ras:    Alias type = E164,
Alias string = "353826"
2009-07-20 16:38:48 DEBUG avc: pc[0]: h323ras:    Alias type = H323ID,
Alias string = "cfo-ta"
2009-07-20 16:38:48 DEBUG avc: pc[0]: h323ras:    Time to live = 29
2009-07-20 16:38:48 INFO jvm: pc[0]: UI: GDS Thread:
GlobalDirectoryThread: populateGlobalList() : server = 10.1.1.86
record.length = 68
2009-07-20 16:38:48 INFO jvm: pc[0]: UI: GDS Thread:
GlobalDirectoryThread: checkForInstuctions() : m_gdsInstructions is
null.
2009-07-20 16:38:48 INFO jvm: pc[0]: UI: GDS Thread:
GlobalDirectoryThread: populateGlobalList() :  server = 10.1.1.86
numberOfInstructs = 0
2009-07-20 16:38:48 DEBUG jvm: pc[0]: UI: GDS Thread:
GlobalDirectoryThread: updateBackupFile() : m_vCachedEntryList size 68
2009-07-20 16:38:48 DEBUG jvm: pc[0]: UI: GDS Thread:
GlobalDirectoryThread: updateBackupFile() : NOT WRITING FILE
2009-07-20 16:38:48 INFO jvm: pc[0]: UI: GDS Thread:
GlobalDirectoryThread: run() : Server = 10.1.1.86, state = 4 isEnabled
= true isServerWaiting = false
2009-07-20 16:38:53 INFO avc: pc[0]: config: synching filesystem
2009-07-20 16:38:54 INFO avc: pc[0]: config: sync complete 734ms
2009-07-20 16:39:00 DEBUG avc: pc[0]: uimsg: A4dd8: 20000 camera near
move auto false
2009-07-20 16:39:00 INFO avc: pc[0]: RemoteIR: RemotecIRLowLvlIoctl()
is called: configured_ioctl:1, ioctl_value:2 ...
2009-07-20 16:39:00 INFO avc: pc[0]: RemoteIR:
RemotecIRLowLvlIoctl()is successful ...
2009-07-20 16:39:00 DEBUG avc: pc[0]: REAGANSERIAL: KEYPAD REPEAT
TIMING MSG[0] = 0xff ....
2009-07-20 16:39:00 DEBUG avc: pc[0]: REAGANSERIAL: KEYPAD REPEAT
TIMING MSG[1] = 0x42 ....
2009-07-20 16:39:00 DEBUG avc: pc[0]: REAGANSERIAL: KEYPAD REPEAT
TIMING MSG[2] = 0x00 ....
2009-07-20 16:39:00 DEBUG avc: pc[0]: REAGANSERIAL: KEYPAD REPEAT
TIMING MSG[3] = 0x04 ....
2009-07-20 16:39:00 DEBUG avc: pc[0]: REAGANSERIAL: KEYPAD REPEAT
TIMING MSG[4] = 0x0a ....
2009-07-20 16:39:00 DEBUG avc: pc[0]: REAGANSERIAL: KEYPAD REPEAT
TIMING MSG[5] = 0xfe ....
2009-07-20 16:39:00 DEBUG avc: pc[0]: REAGANSERIAL: KEYPAD REPEAT
TIMING MSG[6] = 0x01 ....
2009-07-20 16:39:00 DEBUG avc: pc[0]: REAGANSERIAL: KEYPAD REPEAT
TIMING MSG[7] = 0xfe ....
2009-07-20 16:39:00 DEBUG avc: pc[0]: REAGANSERIAL: KEYPAD REPEAT
TIMING MSG[8] = 0x01 ....
2009-07-20 16:39:00 DEBUG avc: pc[0]: REAGANSERIAL: KEYPAD REPEAT
TIMING MSG[9] = 0xf6 ....
2009-07-20 16:39:00 INFO avc: pc[0]: CAMERA: UI Response
Buffer[CameraAvail]...
2009-07-20 16:39:00 DEBUG avc: pc[0]: uimsg: A4dd9: 20000 videoroute
set 194 vout1 1680 1050 DVID 60 progressive vinp 0 0 1680 1050 0 none
2009-07-20 16:39:00 DEBUG avc: pc[0]: Pending[0]:
VideoRouteStateUpdate: Updating vout1
2009-07-20 16:39:00 DEBUG avc: pc[0]: uimsg: A4dda: 20000 videoroute
set 195 vout1 1680 1050 DVID 60 progressive vinp 0 0 1680 1050 0 none
2009-07-20 16:39:00 DEBUG avc: pc[0]: Pending[0]:
VideoRouteStateUpdate: Updating vout1
2009-07-20 16:39:00 DEBUG avc: pc[0]: uimsg: A4ddb: 20000 videooutput
vout1 freeze off
2009-07-20 16:39:00 DEBUG jvm: pc[0]: UI: asyn: DisplayManager:
updateMonitor1Panel: entered
2009-07-20 16:39:00 DEBUG jvm: last message repeated 2 times
2009-07-20 16:39:00 DEBUG jvm: pc[0]: UI: asyn: MakeACall: MAC: postPaintInit()
2009-07-20 16:39:00 DEBUG avc: pc[0]: RouteProc[0]: RouteProcNewRoute:
Diff count is 1. currSeqNum 196, lastSeqNum 194
2009-07-20 16:39:00 DEBUG avc: pc[0]: ChainCtrl[0]:
ChainCtrlUpdateRoute: Updating Node kVideoRouteNodeVideoOut
2009-07-20 16:39:00 DEBUG avc: pc[0]: VIDEO[0]: Current Route vout1:
width 1680, height 1050, refresh 60, Progressive
2009-07-20 16:39:00 DEBUG avc: pc[0]: VIDEO[0]: Current     source count 1
2009-07-20 16:39:00 DEBUG avc: pc[0]: VIDEO[0]: Current          src
vinp, w 1680, h 1048
2009-07-20 16:39:00 DEBUG avc: pc[0]: VIDEO[0]: Current          x 0, y 0, z 0
2009-07-20 16:39:00 DEBUG avc: pc[0]: VIDEO[0]: Current          ar
none, cx 0, cy 0, fr 0
2009-07-20 16:39:00 DEBUG avc: pc[0]: ChainCtrl[0]: Changing vout1
Route from 1050 to 720
2009-07-20 16:39:00 DEBUG avc: pc[0]: ChainCtrl[0]: Changing vinp src
from 1050 to 720
2009-07-20 16:39:00 DEBUG avc: pc[0]: VIDEO[0]:
ChainCtrlUpdateVideoOutRoute new route Route vout1: width 1280, height
720, refresh 60, Progressive
2009-07-20 16:39:00 DEBUG avc: pc[0]: VIDEO[0]:
ChainCtrlUpdateVideoOutRoute new route     source count 1
2009-07-20 16:39:00 DEBUG avc: pc[0]: VIDEO[0]:
ChainCtrlUpdateVideoOutRoute new route          src vinp, w 1280, h
720
2009-07-20 16:39:00 DEBUG avc: pc[0]: VIDEO[0]:
ChainCtrlUpdateVideoOutRoute new route          x 0, y 0, z 0
2009-07-20 16:39:00 DEBUG avc: pc[0]: VIDEO[0]:
ChainCtrlUpdateVideoOutRoute new route          ar none, cx 0, cy 0,
fr 0
2009-07-20 16:39:00 DEBUG avc: pc[0]: ChainCtrl[0]: FindVideoChain:
Looking for vout1, role unknown, spec unknown
2009-07-20 16:39:00 DEBUG avc: pc[0]: ChainCtrl[0]:
ChainCtrlUpdateVideoOutRoute on VideoOut1Ike[0]
2009-07-20 16:39:00 DEBUG avc: pc[0]: VideoOut1Ike[0].VidGenmChan[7]:
VideoGennumChanSetIOEnabled: Turn on/off(2) the Gennum port at 0
2009-07-20 16:39:00 DEBUG avc: pc[0]: ChainCtrl[0]: FindVideoChain:
Looking for vinp, role unknown, spec unknown
2009-07-20 16:39:00 DEBUG avc: ti[3]: CompositorChan[4]: Set pass
through mode to 0
2009-07-20 16:39:00 DEBUG avc: pc[0]: VideoOut1Ike[0].VidGenmChan[7]:
VideoGennumChanSetVHAPanels: Transformation Sucessful Old 0 0 1280
720, new 0 0 1680 1050
2009-07-20 16:39:00 DEBUG avc: pc[0]: VideoOut1Ike[0].VidGenmChan[7]:
====2. SetPanelSizePos: Same Size Setting: hPos = 0, vPos = 0, hSize =
1680, vSize = 1050
2009-07-20 16:39:00 DEBUG avc: pc[0]: VideoOut1Ike[0].VidGenmChan[7]:
VideoGennumChanSetIOEnabled: Turn on/off(1) the Gennum port at 0
2009-07-20 16:39:00 DEBUG avc: pc[0]: NOTIFY: VID videoroute set 195
complete vout1 1680 1050 DVID 60 Progressive vinp 0 0 1680 1050 0 none
2009-07-20 16:39:00 DEBUG avc: ti[3]: ImageProc[1]:
ImgProcChanSetMinResParameters to false with 704x480
2009-07-20 16:39:00 DEBUG jvm: pc[0]: UI: asyn: ScreenManager: PERF
901 Complete makeacall[makeacall.txt]
2009-07-20 16:39:00 DEBUG jvm: pc[0]: JVM Memory,126,19575844,22367196,41943040
2009-07-20 16:39:00 DEBUG jvm: pc[0]: UI: asyn: NativeAccess$4:
Unrecognized Message  [msg: VID videoroute set]
2009-07-20 16:39:15 DEBUG avc: pc[0]: h323ras: Sending RRQ Request
2009-07-20 16:39:15 DEBUG avc: pc[0]:     AliasList[0]: "353826" (E.164)
2009-07-20 16:39:15 DEBUG avc: pc[0]:     AliasList[1]: "cfo-ta" (H.323 ID)
2009-07-20 16:39:15 DEBUG avc: pc[0]: h323ras: RRQ sent
2009-07-20 16:39:15 DEBUG avc: pc[0]:  h323ras: cmEvRASConfirm: received
2009-07-20 16:39:15 DEBUG avc: pc[0]: RCF
2009-07-20 16:39:15 DEBUG avc: pc[0]: h323ras:    Alias type =
GatekeeperID, Alias string = "OpenH323GK"
2009-07-20 16:39:15 DEBUG avc: pc[0]: h323ras:    Gatekeeper Address
ip:port = "192.168.5.23:1719"
2009-07-20 16:39:15 DEBUG avc: pc[0]: h323ras:    Alias type =
EndpointID, Alias string = "2829_endp"
2009-07-20 16:39:15 DEBUG avc: pc[0]: h323ras:    Alias type = E164,
Alias string = "353826"
2009-07-20 16:39:15 DEBUG avc: pc[0]: h323ras:    Alias type = H323ID,
Alias string = "cfo-ta"
2009-07-20 16:39:15 DEBUG avc: pc[0]: h323ras:    Time to live = 29

During the call setup phase, the UI on the Polycom endpoint at my site
goes from the blue quarter circle to the full green gumball almost
immediately, then stays at the green gumball for about 5 seconds, then
the call ends.

It appears that the call connects to distant end Polycom at
2009-07-20 16:38:45 INFO avc: pc[0]: H323Conn[3]: remote h225
version:4, product:"VSX 8000", version:"Release 8.7.1 - 04Feb2008
08:45" ManufID:0xb5002331

but that something happens (or fails to happen) and the call fails to
actually sync video so that by this point I get:

2009-07-20 16:38:47 DEBUG avc: pc[0]: H323Call[0]: state:"connected"
--> "disconnecting"

What sort of logging should I have enabled on the GK side to get a
little more information on whether this is a firewall issue on the
Internet facing portion?

On the client, (Polycom HDX 4000, running 2.5.0.4) I have enabled
Fixed Ports (3230 to 3235 for TCP, 3230 to 3253 for UDP) and "Enable
H.460 Firewall traversal".  "NAT Configuration" is set to off.

Are there other H.323 test number out there that I can use to
determine if this is my end or Polycom's?

Appreciate any help.  Thanks.

------------------------------------------------------------------------------
Enter the BlackBerry Developer Challenge  
This is your chance to win up to $100,000 in prizes! For a limited time, 
vendors submitting new applications to BlackBerry App World(TM) will have
the opportunity to enter the BlackBerry Developer Challenge. See full prize  
details at: http://p.sf.net/sfu/Challenge
_______________________________________________________

Posting: mailto:Openh323gk-users@xxxxxxxxxxxxxxxxxxxxx
Archive: http://sourceforge.net/mailarchive/forum.php?forum_name=openh323gk-users
Unsubscribe: http://lists.sourceforge.net/lists/listinfo/openh323gk-users
Homepage: http://www.gnugk.org/

[Index of Archives]     [SIP]     [Open H.323]     [Gnu Gatekeeper]     [Asterisk PBX]     [ISDN Cause Codes]     [Yosemite News]

  Powered by Linux