Hi I have just configured my S8300 R5 and my AES 6.1
I have tried to connect my DMCC Softphone, but I am getting the fowllowing error (handshake error), can you please help.

Jul 22, 2011 9:40:21 AM com.avaya.mvap.svcproxy.prov.RemoteServiceProvider initServiceProviderImpl
INFO: CMAPI SERVER IP=10.210.29.17: CMAPI SERVER PORT=4721
=============
View log - dmcc-trace.log.0

2011-07-22 09.40.21,552 com.avaya.api.sessionsvc.SessionSecurityContextFactory getSessionSecurityContext
INFO: created SSC: com.avaya.sessionsvc.securityContext.SSCSDBAuthz@1edc3aa for Farend: null, AAMethod: AAMethod [Authn: true, Authz: SdbAuthz]
2011-07-22 09.40.21,553 com.avaya.sessionsvc.SessionMulticaster addSessionListener
FINE: com.avaya.mvcs.proxy.TPacketReaderNode$MySessionListener@c90b69added to com.avaya.sessionsvc.SessionMulticaster@10c283c
2011-07-22 09.40.21,553 com.avaya.mvcs.proxy.TPacketReaderNode getSessionId
FINE: Mapping channel DefaultTCPChannel Bound to SocketAddress: /10.210.29.17:4721 Connected to SocketAddress: /10.1.9.10:52893session object session 3739C88DBEE447A3FE9B3FA9DA0B1664-2
2011-07-22 09.40.41,559 com.avaya.sessionsvc.CleanupTimerTask run
FINE: CleanupTimerTask cleaning up: session 3739C88DBEE447A3FE9B3FA9DA0B1664-2
2011-07-22 09.40.41,560 com.avaya.sessionsvc.SessionObjectImpl fireSessionCleanedupEvent
FINE: Finished firing Session cleanedup: session

Thank you
Jul 22, 2011 9:40:31 AM com.avaya.common.nio.managed.tlsImpl.TLSTCPChannel connect
WARNING: java.nio.channels.SocketChannel[connected local=/10.1.9.10:52893 remote=/10.210.29.17:4721] handshake timed out
Jul 22, 2011 9:40:41 AM com.avaya.common.packet.TPacketizer readChannel
INFO: End of stream from DefaultTCPChannel Bound to SocketAddress: /10.1.9.10:52893 Connected to SocketAddress: /10.210.29.17:4721
Jul 22, 2011 9:40:41 AM com.avaya.mvcs.proxy.CstaMarshallerNode$CstaMarshallerThread run
WARNING: Xml Marshalling Publish Threshold (7s) exceeded (9.704s) while publishing <?xml version="1.0" encoding="UTF-8"?>
<StartApplicationSession xmlns="http://www.ecma-international.org/standards/ecma-354/appl_session"><applicationInfo><applicationID>cmapiApplication</applicationID><applicationSpecificInfo><ns1:SessionLoginInfo xmlns:ns1="http://www.avaya.com/csta" xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" xsi:type="ns1:SessionLoginInfo"><ns1:userName>aeserver1</ns1:userName><ns1:password>aespassword1</ns1:password><ns1:sessionCleanupDelay>120</ns1:sessionCleanupDelay></ns1:SessionLoginInfo></applicationSpecificInfo></applicationInfo><requestedProtocolVersions><protocolVersion>http://www.ecma-international.org/standards/ecma-323/csta/ed3/priv5</protocolVersion><protocolVersion>http://www.ecma-international.org/standards/ecma-323/csta/ed3/priv4</protocolVersion><protocolVersion>http://www.ecma-international.org/standards/ecma-323/csta/ed3/priv3</protocolVersion><protocolVersion>http://www.ecma-international.org/standards/ecma-323/csta/ed3/priv2</protocolVersion><protocolVersion>http://www.ecma-international.org/standards/ecma-323/csta/ed3/priv1</protocolVersion><protocolVersion>http://www.ecma-international.org/standards/ecma-323/csta/ed2/priv1</protocolVersion><protocolVersion>3.0</protocolVersion></requestedProtocolVersions><requestedSessionDuration>240</requestedSessionDuration></StartApplicationSession>
Jul 22, 2011 9:40:41 AM com.avaya.mvcs.proxy.ClientProxy routeRequest
WARNING: Received an unexpected Exception 1
com.avaya.mvcs.proxy.DisconnectByClientException: Request: session[null] ch.ecma.csta.binding.start.StartApplicationSession@e9493a canceled by client
   at com.avaya.mvcs.proxy.XmlGatewayClient.clearOutstandingRequests(XmlGatewayClient.java:140)
   at com.avaya.mvcs.proxy.Pipeline.clearOutstandingRequests(Pipeline.java:369)
   at com.avaya.mvcs.proxy.ClientProxy.stop(ClientProxy.java:586)
   at com.avaya.mvcs.proxy.ClientProxy.process(ClientProxy.java:728)
   at com.avaya.mvcs.proxy.Pipeline$PipelineSubscriber.inform(Pipeline.java:427)
   at com.avaya.common.eventservice.UnfilteredSubscription.notify(UnfilteredSubscription.java:70)
   at com.avaya.common.multicaster.Multicaster.notify(Multicaster.java:386)
   at com.avaya.common.channel.Channel.publish(Channel.java:115)
   at com.avaya.common.eventservice.EventService.publish(EventService.java:123)
   at com.avaya.common.eventservice.EventServiceManager.publish(EventServiceManager.java:156)
   at com.avaya.common.eventservice.Publisher.publish(Publisher.java:110)
   at com.avaya.mvcs.proxy.ExceptionEventHandlerNode$ExceptionProcessor.run(ExceptionEventHandlerNode.java:197)
   at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
   at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
   at java.lang.Thread.run(Thread.java:662)
Jul 22, 2011 9:40:41 AM com.avaya.mvcs.proxy.SessionManagementServiceProxy startApplicationSession
WARNING: StartApplicationSession Failed.

Did the application request a secure link against a non-secure port (or vice-versa)?

The exception was: Request: session[null] ch.ecma.csta.binding.start.StartApplicationSession@e9493a canceled by client
ch.ecma.csta.errors.CstaException: Request: session[null] ch.ecma.csta.binding.start.StartApplicationSession@e9493a canceled by client
   at com.avaya.mvcs.proxy.CstaSessionManagementServiceProxy.routeRequest(CstaSessionManagementServiceProxy.java:92)
   at com.avaya.mvcs.proxy.CstaSessionManagementServiceProxy.startApplicationSession(CstaSessionManagementServiceProxy.java:103)
   at com.avaya.mvcs.proxy.SessionManagementServiceProxy.startApplicationSession(SessionManagementServiceProxy.java:229)
   at com.avaya.mvcs.proxy.SessionManagementServiceProxy.startApplicationSession(SessionManagementServiceProxy.java:184)
   at com.avaya.mvcs.proxy.ClientProxy.sessionStart(ClientProxy.java:359)
   at com.avaya.mvcs.proxy.ClientProxy.<init>(ClientProxy.java:271)
   at com.avaya.mvap.svcproxy.prov.RemoteServiceProvider.initServiceProviderImpl(RemoteServiceProvider.java:197)
   at com.avaya.mvap.svcproxy.prov.ServiceProviderBuilder.getCmapiServiceProvider(ServiceProviderBuilder.java:192)
   at com.avaya.mvap.svcproxy.prov.ServiceProviderBuilder.getServiceProviderType(ServiceProviderBuilder.java:177)
   at com.avaya.mvap.svcproxy.prov.ServiceProviderBuilder.getServiceProviderImpl(ServiceProviderBuilder.java:112)
   at com.avaya.cmapi.ServiceProvider.getCmapiServiceProvider(ServiceProvider.java:404)
   at com.avaya.cmapi.ServiceProvider.getServiceProvider(ServiceProvider.java:390)
   at sampleapps.softphone.Softphone.<init>(Softphone.java:533)
   at sampleapps.softphone.Softphone.main(Softphone.java:833)
Caused by: com.avaya.mvcs.proxy.DisconnectByClientException: Request: session[null] ch.ecma.csta.binding.start.StartApplicationSession@e9493a canceled by client
   at com.avaya.mvcs.proxy.XmlGatewayClient.clearOutstandingRequests(XmlGatewayClient.java:140)
   at com.avaya.mvcs.proxy.Pipeline.clearOutstandingRequests(Pipeline.java:369)
   at com.avaya.mvcs.proxy.ClientProxy.stop(ClientProxy.java:586)
   at com.avaya.mvcs.proxy.ClientProxy.process(ClientProxy.java:728)
   at com.avaya.mvcs.proxy.Pipeline$PipelineSubscriber.inform(Pipeline.java:427)
   at com.avaya.common.eventservice.UnfilteredSubscription.notify(UnfilteredSubscription.java:70)
   at com.avaya.common.multicaster.Multicaster.notify(Multicaster.java:386)
   at com.avaya.common.channel.Channel.publish(Channel.java:115)
   at com.avaya.common.eventservice.EventService.publish(EventService.java:123)
   at com.avaya.common.eventservice.EventServiceManager.publish(EventServiceManager.java:156)
   at com.avaya.common.eventservice.Publisher.publish(Publisher.java:110)
   at com.avaya.mvcs.proxy.ExceptionEventHandlerNode$ExceptionProcessor.run(ExceptionEventHandlerNode.java:197)
   at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
   at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
   at java.lang.Thread.run(Thread.java:662)
Exception in thread "main" java.lang.RuntimeException: ch.ecma.csta.errors.CstaException: Request: session[null] ch.ecma.csta.binding.start.StartApplicationSession@e9493a canceled by client
   at com.avaya.mvap.svcproxy.prov.ServiceProviderBuilder.getCmapiServiceProvider(ServiceProviderBuilder.java:198)
   at com.avaya.mvap.svcproxy.prov.ServiceProviderBuilder.getServiceProviderType(ServiceProviderBuilder.java:177)
   at com.avaya.mvap.svcproxy.prov.ServiceProviderBuilder.getServiceProviderImpl(ServiceProviderBuilder.java:112)
   at com.avaya.cmapi.ServiceProvider.getCmapiServiceProvider(ServiceProvider.java:404)
   at com.avaya.cmapi.ServiceProvider.getServiceProvider(ServiceProvider.java:390)
   at sampleapps.softphone.Softphone.<init>(Softphone.java:533)
   at sampleapps.softphone.Softphone.main(Softphone.java:833)
Caused by: ch.ecma.csta.errors.CstaException: Request: session[null] ch.ecma.csta.binding.start.StartApplicationSession@e9493a canceled by client
   at com.avaya.mvcs.proxy.CstaSessionManagementServiceProxy.routeRequest(CstaSessionManagementServiceProxy.java:92)
   at com.avaya.mvcs.proxy.CstaSessionManagementServiceProxy.startApplicationSession(CstaSessionManagementServiceProxy.java:103)
   at com.avaya.mvcs.proxy.SessionManagementServiceProxy.startApplicationSession(SessionManagementServiceProxy.java:229)
   at com.avaya.mvcs.proxy.SessionManagementServiceProxy.startApplicationSession(SessionManagementServiceProxy.java:184)
   at com.avaya.mvcs.proxy.ClientProxy.sessionStart(ClientProxy.java:359)
   at com.avaya.mvcs.proxy.ClientProxy.<init>(ClientProxy.java:271)
   at com.avaya.mvap.svcproxy.prov.RemoteServiceProvider.initServiceProviderImpl(RemoteServiceProvider.java:197)
   at com.avaya.mvap.svcproxy.prov.ServiceProviderBuilder.getCmapiServiceProvider(ServiceProviderBuilder.java:192)
   ... 6 more
Caused by: com.avaya.mvcs.proxy.DisconnectByClientException: Request: session[null] ch.ecma.csta.binding.start.StartApplicationSession@e9493a canceled by client
   at com.avaya.mvcs.proxy.XmlGatewayClient.clearOutstandingRequests(XmlGatewayClient.java:140)
   at com.avaya.mvcs.proxy.Pipeline.clearOutstandingRequests(Pipeline.java:369)
   at com.avaya.mvcs.proxy.ClientProxy.stop(ClientProxy.java:586)
   at com.avaya.mvcs.proxy.ClientProxy.process(ClientProxy.java:728)
   at com.avaya.mvcs.proxy.Pipeline$PipelineSubscriber.inform(Pipeline.java:427)
   at com.avaya.common.eventservice.UnfilteredSubscription.notify(UnfilteredSubscription.java:70)
   at com.avaya.common.multicaster.Multicaster.notify(Multicaster.java:386)
   at com.avaya.common.channel.Channel.publish(Channel.java:115)
   at com.avaya.common.eventservice.EventService.publish(EventService.java:123)
   at com.avaya.common.eventservice.EventServiceManager.publish(EventServiceManager.java:156)
   at com.avaya.common.eventservice.Publisher.publish(Publisher.java:110)
   at com.avaya.mvcs.proxy.ExceptionEventHandlerNode$ExceptionProcessor.run(ExceptionEventHandlerNode.java:197)
   at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
   at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
   at java.lang.Thread.run(Thread.java:662)

I changed cmapi1.secure=true to false.
now UI am getting this error:

Jul 22, 2011 10:43:38 AM com.avaya.mvap.svcproxy.prov.RemoteServiceProvider initServiceProviderImpl
INFO: CMAPI SERVER IP=10.210.29.17: CMAPI SERVER PORT=4721
Exception in thread "main" java.lang.RuntimeException: java.lang.SecurityException: Authentication failed : clientID=XML Unencrypted:10.1.9.10:53153, user=aeserver1
   at com.avaya.mvap.svcproxy.prov.ServiceProviderBuilder.getCmapiServiceProvider(ServiceProviderBuilder.java:198)
   at com.avaya.mvap.svcproxy.prov.ServiceProviderBuilder.getServiceProviderType(ServiceProviderBuilder.java:177)
   at com.avaya.mvap.svcproxy.prov.ServiceProviderBuilder.getServiceProviderImpl(ServiceProviderBuilder.java:112)
   at com.avaya.cmapi.ServiceProvider.getCmapiServiceProvider(ServiceProvider.java:404)
   at com.avaya.cmapi.ServiceProvider.getServiceProvider(ServiceProvider.java:390)
   at sampleapps.softphone.Softphone.<init>(Softphone.java:533)
   at sampleapps.softphone.Softphone.main(Softphone.java:833)
Caused by: java.lang.SecurityException: Authentication failed : clientID=XML Unencrypted:10.1.9.10:53153, user=aeserver1
   at com.avaya.mvcs.proxy.SessionManagementServiceProxy.startApplicationSession(SessionManagementServiceProxy.java:256)
   at com.avaya.mvcs.proxy.SessionManagementServiceProxy.startApplicationSession(SessionManagementServiceProxy.java:184)
   at com.avaya.mvcs.proxy.ClientProxy.sessionStart(ClientProxy.java:359)
   at com.avaya.mvcs.proxy.ClientProxy.<init>(ClientProxy.java:271)
   at com.avaya.mvap.svcproxy.prov.RemoteServiceProvider.initServiceProviderImpl(RemoteServiceProvider.java:197)
   at com.avaya.mvap.svcproxy.prov.ServiceProviderBuilder.getCmapiServiceProvider(ServiceProviderBuilder.java:192)
   ... 6 more
Jul 22, 2011 10:43:39 AM com.avaya.common.packet.TPacketizer readChannel
INFO: End of stream from DefaultTCPChannel Bound to SocketAddress: /10.1.9.10:53153 Connected to SocketAddress: /10.210.29.17:4721

I added the aes userid in the configuration.properties file in Avaya AES as a new CTI user,now I am getting the following error:

ul 22, 2011 11:14:04 AM com.avaya.mvcs.proxy.ClientProxy routeRequest
WARNING: Received an unexpected Exception 1
ch.ecma.csta.errors.SecurityViolationException
   at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
   at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:39)
   at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27)
   at java.lang.reflect.Constructor.newInstance(Constructor.java:513)
   at java.lang.Class.newInstance0(Class.java:355)
   at java.lang.Class.newInstance(Class.java:308)
   at com.avaya.mvcs.proxy.ClientNegAckToException.convertErrorToException(ClientNegAckToException.java:105)
   at com.avaya.mvcs.proxy.XmlGatewayClient.handleRequest(XmlGatewayClient.java:233)
   at com.avaya.mvcs.proxy.Pipeline.handleRequest(Pipeline.java:346)
   at com.avaya.mvcs.proxy.ClientProxy.routeRequest(ClientProxy.java:612)
   at com.avaya.mvap.svcproxy.ServiceProxy.marshallRequest(ServiceProxy.java:106)
   at com.avaya.mvap.svcproxy.DeviceServicesProxy.getDeviceID(DeviceServicesProxy.java:146)
   at sampleapps.station.AvayaStation.getID(AvayaStation.java:1122)
   at sampleapps.station.AvayaStation.getID(AvayaStation.java:1101)
   at sampleapps.station.AvayaStation.init(AvayaStation.java:398)
   at sampleapps.station.AvayaStation.init(AvayaStation.java:236)
   at sampleapps.station.AvayaStation.init(AvayaStation.java:310)
   at sampleapps.softphone.Softphone.<init>(Softphone.java:545)
   at sampleapps.softphone.Softphone.main(Softphone.java:833)
Exception in thread "main" ch.ecma.csta.errors.SecurityViolationException
   at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
   at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:39)
   at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27)
   at java.lang.reflect.Constructor.newInstance(Constructor.java:513)
   at java.lang.Class.newInstance0(Class.java:355)
   at java.lang.Class.newInstance(Class.java:308)
   at com.avaya.mvcs.proxy.ClientNegAckToException.convertErrorToException(ClientNegAckToException.java:105)
   at com.avaya.mvcs.proxy.XmlGatewayClient.handleRequest(XmlGatewayClient.java:233)
   at com.avaya.mvcs.proxy.Pipeline.handleRequest(Pipeline.java:346)
   at com.avaya.mvcs.proxy.ClientProxy.routeRequest(ClientProxy.java:612)
   at com.avaya.mvap.svcproxy.ServiceProxy.marshallRequest(ServiceProxy.java:106)
   at com.avaya.mvap.svcproxy.DeviceServicesProxy.getDeviceID(DeviceServicesProxy.java:146)
   at sampleapps.station.AvayaStation.getID(AvayaStation.java:1122)
   at sampleapps.station.AvayaStation.getID(AvayaStation.java:1101)
   at sampleapps.station.AvayaStation.init(AvayaStation.java:398)
   at sampleapps.station.AvayaStation.init(AvayaStation.java:236)
   at sampleapps.station.AvayaStation.init(AvayaStation.java:310)
   at sampleapps.softphone.Softphone.<init>(Softphone.java:545)
   at sampleapps.softphone.Softphone.main(Softphone.java:833)

This is the AESc trace from the DMCC-trace.log

2011-07-22 11.14.04,381 com.avaya.api.sessionsvc.SessionSecurityContextFactory getSessionSecurityContext
INFO: created SSC: com.avaya.sessionsvc.securityContext.SSCSDBAuthz@e1e74d for Farend: null, AAMethod: AAMethod [Authn: true, Authz: SdbAuthz]
2011-07-22 11.14.04,381 com.avaya.sessionsvc.SessionMulticaster addSessionListener
FINE: com.avaya.mvcs.proxy.TPacketReaderNode$MySessionListener@11879eaadded to com.avaya.sessionsvc.SessionMulticaster@1ec08c7
2011-07-22 11.14.04,381 com.avaya.mvcs.proxy.TPacketReaderNode getSessionId
FINE: Mapping channel DefaultTCPChannel Bound to SocketAddress: /10.210.29.17:4721 Connected to SocketAddress: /10.1.9.10:53275session object session BFFBB28663F6770C4C00D444A1B05EE7-4
2011-07-22 11.14.04,384 com.avaya.sessionsvc.SessionMulticaster addSessionListener
FINE: com.avaya.mvcs.proxy.CstaRouterNode$MySessionListener@dbd887added to com.avaya.sessionsvc.SessionMulticaster@1ec08c7
2011-07-22 11.14.04,385 com.avaya.mvcs.proxy.CstaRouterNode processPacket
FINE: Creating a new SubscriptionManager for session=session[session BFFBB28663F6770C4C00D444A1B05EE7-4,DefaultTCPChannel Bound to SocketAddress: /10.210.29.17:4721 Connected to SocketAddress: /10.1.9.10:53275]
2011-07-22 11.14.04,385 com.avaya.mvcs.proxy.CstaRouterNode processPacket
FINE: invokeID= 1 Routing request=session[session BFFBB28663F6770C4C00D444A1B05EE7-4] ch.ecma.csta.binding.start.StartApplicationSession@4c47b5
2011-07-22 11.14.04,385 com.avaya.mvcs.proxy.CstaRouterNode processPacket
FINE: invokeID= 1 Received com.avaya.platform.broker.impl.AsyncResponse@123ef32 in response to session[session BFFBB28663F6770C4C00D444A1B05EE7-4] ch.ecma.csta.binding.start.StartApplicationSession@4c47b5
2011-07-22 11.14.04,386 com.avaya.sessionsvc.SessionServicesImpl asyncStartApplicationSession
FINE: appInfo is not null
2011-07-22 11.14.04,387 com.avaya.api.sessionsvc.ProtocolVersion findMatchingProtocol
INFO: Protocol version negotiated: http://www.ecma-international.org/standards/ecma-323/csta/ed3/priv5
2011-07-22 11.14.04,387 com.avaya.common.logger.PrintStreamLogger log
INFO: STANDARD OUT: 2011-07-22 11:14:04,387 [pool-2-thread-1] DEBUG net.sf.jpam.Pam - Debug mode active.

2011-07-22 11.14.04,401 com.avaya.sessionsvc.securityContext.SSCBaseClass authenticate
INFO: Login successful on CUS Store: user=aeserver1, after 14msecs
2011-07-22 11.14.04,401 com.avaya.cs.dataservice.UserAuthorizationDataService <init>
FINE: GOING TO THE DBCONNECTION POOL...
2011-07-22 11.14.04,406 com.avaya.cs.dataservice.UserAuthorizationDataService isExceptionDevGroup
WARNING: Statement and device group name must be set java.lang.Exception
2011-07-22 11.14.04,411 com.avaya.cs.dataservice.UserAuthorizationDataService isExceptionDevGroup
WARNING: Statement and device group name must be set java.lang.Exception
2011-07-22 11.14.04,413 com.avaya.sessionsvc.SessionObjectImpl validate
INFO: Login successful: user=aeserver1, clientID=XML Unencrypted:10.1.9.10:53275
2011-07-22 11.14.04,413 com.avaya.sessionsvc.SessionObjectImpl validate
FINE: session BFFBB28663F6770C4C00D444A1B05EE7-4 _sessionTimeout=240, _cleanupTimeout=120
2011-07-22 11.14.04,413 com.avaya.sessionsvc.SessionServicesImpl asyncStartApplicationSession
INFO: Validated session=session BFFBB28663F6770C4C00D444A1B05EE7-4, requested sessionTimeout=240, actual sessionTimeout=240, requested cleanupTimeout=120, actual cleanupTimeout=120
2011-07-22 11.14.04,413 com.avaya.sessionsvc.SessionMulticaster addSessionListener
FINE: com.avaya.sessionsvc.SessionServicesImpl$MySessionListener@4561a6added to com.avaya.sessionsvc.SessionMulticaster@1ec08c7
2011-07-22 11.14.04,413 com.avaya.sessionsvc.SessionObjectImpl start
FINE: session BFFBB28663F6770C4C00D444A1B05EE7-4 is starting.
2011-07-22 11.14.04,483 com.avaya.mvcs.proxy.CstaRouterNode processPacket
FINE: invokeID= 2 Routing request=session[session BFFBB28663F6770C4C00D444A1B05EE7-4] com.avaya.csta.binding.GetDeviceId@11f4073
2011-07-22 11.14.04,483 com.avaya.sessionsvc.SessionObjectImpl isAuthorized
FINE: clientID=XML Unencrypted:10.1.9.10:53275, ext=3902 authorization failed.
com.avaya.api.sessionsvc.exceptions.SessionSecurityException: user=aeserver1, ext=3902 is not authorized for AuthzType CALL_ORIG_TERM
   at com.avaya.sessionsvc.securityContext.SSCSDBAuthz.isAuthorized(SSCSDBAuthz.java:197)
   at com.avaya.sessionsvc.SessionObjectImpl.isAuthorized(SessionObjectImpl.java:831)
   at com.avaya.cmapi.extsvc.DeviceServicesImpl.validateGetDeviceIDRequest(DeviceServicesImpl.java:283)
   at com.avaya.cmapi.extsvc.DeviceServicesImpl.getDeviceID(DeviceServicesImpl.java:163)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:597)
   at com.avaya.platform.broker.impl.ServiceMethodImpl.invoke(ServiceMethodImpl.java:96)
   at com.avaya.workflow.impl.RouterImpl.routeRequest(RouterImpl.java:97)
   at com.avaya.mvcs.proxy.CstaRouter.routeRequest(CstaRouter.java:173)
   at com.avaya.mvcs.proxy.CstaRouterService.routeRequest(CstaRouterService.java:141)
   at com.avaya.mvcs.proxy.CstaRouterNode.processPacket(CstaRouterNode.java:332)
   at com.avaya.mvcs.proxy.AbstractPipelineNode.process(AbstractPipelineNode.java:130)
   at com.avaya.mvcs.proxy.Pipeline$PipelineSubscriber.inform(Pipeline.java:427)
   at com.avaya.common.eventservice.UnfilteredSubscription.notify(UnfilteredSubscription.java:70)
   at com.avaya.common.multicaster.Multicaster.notify(Multicaster.java:386)
   at com.avaya.common.channel.Channel.publish(Channel.java:115)
   at com.avaya.common.eventservice.EventService.publish(EventService.java:123)
   at com.avaya.common.eventservice.EventServiceManager.publish(EventServiceManager.java:156)
   at com.avaya.common.eventservice.Publisher.publish(Publisher.java:110)
   at com.avaya.mvcs.proxy.CstaUnmarshallerNode$CstaUnmarshallerProcessorThread.run(CstaUnmarshallerNode.java:253)
   at com.avaya.common.util.concurrent.impl.RunnableWrapper.run(RunnableWrapper.java:53)
   at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
   at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
   at java.lang.Thread.run(Thread.java:619)
2011-07-22 11.14.04,483 com.avaya.workflow.impl.RouterImpl routeRequest
WARNING: A service method threw an Exception when invoked!
ServiceMethod: com.avaya.platform.broker.impl.ServiceMethodImpl@82d3bc[com.avaya.cmapi.extsvc.DeviceServicesImpl@380c76, public com.avaya.csta.binding.GetDeviceIdResponse com.avaya.cmapi.extsvc.DeviceServicesImpl.getDeviceID(com.avaya.csta.binding.GetDeviceId) throws ch.ecma.csta.errors.InvalidParameterValueException,ch.ecma.csta.errors.InvalidDeviceIDException,ch.ecma.csta.errors.InvalidDeviceStateException,ch.ecma.csta.errors.ResourceBusyException,ch.ecma.csta.errors.CstaException]
Exception: com.avaya.api.sessionsvc.exceptions.SessionSecurityException: user=aeserver1, ext=3902 is not authorized for AuthzType CALL_ORIG_TERM
Request: session[session BFFBB28663F6770C4C00D444A1B05EE7-4] com.avaya.csta.binding.GetDeviceId@11f4073
java.lang.reflect.InvocationTargetException
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:597)
   at com.avaya.platform.broker.impl.ServiceMethodImpl.invoke(ServiceMethodImpl.java:96)
   at com.avaya.workflow.impl.RouterImpl.routeRequest(RouterImpl.java:97)
   at com.avaya.mvcs.proxy.CstaRouter.routeRequest(CstaRouter.java:173)
   at com.avaya.mvcs.proxy.CstaRouterService.routeRequest(CstaRouterService.java:141)
   at com.avaya.mvcs.proxy.CstaRouterNode.processPacket(CstaRouterNode.java:332)
   at com.avaya.mvcs.proxy.AbstractPipelineNode.process(AbstractPipelineNode.java:130)
   at com.avaya.mvcs.proxy.Pipeline$PipelineSubscriber.inform(Pipeline.java:427)
   at com.avaya.common.eventservice.UnfilteredSubscription.notify(UnfilteredSubscription.java:70)
   at com.avaya.common.multicaster.Multicaster.notify(Multicaster.java:386)
   at com.avaya.common.channel.Channel.publish(Channel.java:115)
   at com.avaya.common.eventservice.EventService.publish(EventService.java:123)
   at com.avaya.common.eventservice.EventServiceManager.publish(EventServiceManager.java:156)
   at com.avaya.common.eventservice.Publisher.publish(Publisher.java:110)
   at com.avaya.mvcs.proxy.CstaUnmarshallerNode$CstaUnmarshallerProcessorThread.run(CstaUnmarshallerNode.java:253)
   at com.avaya.common.util.concurrent.impl.RunnableWrapper.run(RunnableWrapper.java:53)
   at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
   at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
   at java.lang.Thread.run(Thread.java:619)
Caused by: com.avaya.api.sessionsvc.exceptions.SessionSecurityException: user=aeserver1, ext=3902 is not authorized for AuthzType CALL_ORIG_TERM
   at com.avaya.sessionsvc.securityContext.SSCSDBAuthz.isAuthorized(SSCSDBAuthz.java:197)
   at com.avaya.sessionsvc.SessionObjectImpl.isAuthorized(SessionObjectImpl.java:831)
   at com.avaya.cmapi.extsvc.DeviceServicesImpl.validateGetDeviceIDRequest(DeviceServicesImpl.java:283)
   at com.avaya.cmapi.extsvc.DeviceServicesImpl.getDeviceID(DeviceServicesImpl.java:163)
   ... 22 more
2011-07-22 11.14.04,483 com.avaya.mvcs.proxy.CstaRouterNode processPacket
WARNING: The service method threw com.avaya.api.sessionsvc.exceptions.SessionSecurityException: user=aeserver1, ext=3902 is not authorized for AuthzType CALL_ORIG_TERM, session=session[session BFFBB28663F6770C4C00D444A1B05EE7-4,DefaultTCPChannel Bound to SocketAddress: /10.210.29.17:4721 Connected to SocketAddress: /10.1.9.10:53275], request=session[session BFFBB28663F6770C4C00D444A1B05EE7-4] com.avaya.csta.binding.GetDeviceId@11f4073
com.avaya.api.sessionsvc.exceptions.SessionSecurityException: user=aeserver1, ext=3902 is not authorized for AuthzType CALL_ORIG_TERM
   at com.avaya.sessionsvc.securityContext.SSCSDBAuthz.isAuthorized(SSCSDBAuthz.java:197)
   at com.avaya.sessionsvc.SessionObjectImpl.isAuthorized(SessionObjectImpl.java:831)
   at com.avaya.cmapi.extsvc.DeviceServicesImpl.validateGetDeviceIDRequest(DeviceServicesImpl.java:283)
   at com.avaya.cmapi.extsvc.DeviceServicesImpl.getDeviceID(DeviceServicesImpl.java:163)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:597)
   at com.avaya.platform.broker.impl.ServiceMethodImpl.invoke(ServiceMethodImpl.java:96)
   at com.avaya.workflow.impl.RouterImpl.routeRequest(RouterImpl.java:97)
   at com.avaya.mvcs.proxy.CstaRouter.routeRequest(CstaRouter.java:173)
   at com.avaya.mvcs.proxy.CstaRouterService.routeRequest(CstaRouterService.java:141)
   at com.avaya.mvcs.proxy.CstaRouterNode.processPacket(CstaRouterNode.java:332)
   at com.avaya.mvcs.proxy.AbstractPipelineNode.process(AbstractPipelineNode.java:130)
   at com.avaya.mvcs.proxy.Pipeline$PipelineSubscriber.inform(Pipeline.java:427)
   at com.avaya.common.eventservice.UnfilteredSubscription.notify(UnfilteredSubscription.java:70)
   at com.avaya.common.multicaster.Multicaster.notify(Multicaster.java:386)
   at com.avaya.common.channel.Channel.publish(Channel.java:115)
   at com.avaya.common.eventservice.EventService.publish(EventService.java:123)
   at com.avaya.common.eventservice.EventServiceManager.publish(EventServiceManager.java:156)
   at com.avaya.common.eventservice.Publisher.publish(Publisher.java:110)
   at com.avaya.mvcs.proxy.CstaUnmarshallerNode$CstaUnmarshallerProcessorThread.run(CstaUnmarshallerNode.java:253)
   at com.avaya.common.util.concurrent.impl.RunnableWrapper.run(RunnableWrapper.java:53)
   at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
   at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
   at java.lang.Thread.run(Thread.java:619)
2011-07-22 11.14.04,484 com.avaya.mvcs.proxy.CstaRouterNode processPacket
FINE: invokeID= 2 Received com.avaya.api.sessionsvc.exceptions.SessionSecurityException: user=aeserver1, ext=3902 is not authorized for AuthzType CALL_ORIG_TERM in response to session[session BFFBB28663F6770C4C00D444A1B05EE7-4] com.avaya.csta.binding.GetDeviceId@11f4073
2011-07-22 11.14.04,484 com.avaya.mvcs.proxy.CstaMarshallerNode$CstaMarshallerThread convertThrowable
FINE: Returning negative ack to client session (BFFBB28663F6770C4C00D444A1B05EE7-4) : ch.ecma.csta.errors.SecurityViolationException: com.avaya.api.sessionsvc.exceptions.SessionSecurityException: user=aeserver1, ext=3902 is not authorized for AuthzType CALL_ORIG_TERM
2011-07-22 11.15.16,474 com.avaya.mvcs.proxy.CstaRouterNode processPacket
FINE: invokeID= 3 Routing request=session[session BFFBB28663F6770C4C00D444A1B05EE7-4] ch.ecma.csta.binding.reset.ResetApplicationSessionTimer@190ecf8
2011-07-22 11.15.16,474 com.avaya.sessionsvc.SessionServicesImpl resetApplicationSessionTimer
FINE: Resetting session timer: session BFFBB28663F6770C4C00D444A1B05EE7-4
2011-07-22 11.15.16,474 com.avaya.sessionsvc.SessionObjectImpl refresh
FINE: session BFFBB28663F6770C4C00D444A1B05EE7-4 is being refreshed.
2011-07-22 11.15.16,475 com.avaya.mvcs.proxy.CstaRouterNode processPacket
FINE: invokeID= 3 Received session[null] ch.ecma.csta.binding.reset.ResetApplicationSessionTimerPosResponse@1b5b8a4 in response to session[session BFFBB28663F6770C4C00D444A1B05EE7-4] ch.ecma.csta.binding.reset.ResetApplicationSessionTimer@190ecf8
2011-07-22 11.15.38,451 com.avaya.mvcs.station.h323.GatekeeperIpToInterfaceMapImpl$GkTimerTask run
FINE: Running Station GkTimerTask.
2011-07-22 11.16.28,480 com.avaya.mvcs.proxy.CstaRouterNode processPacket
FINE: invokeID= 4 Routing request=session[session BFFBB28663F6770C4C00D444A1B05EE7-4] ch.ecma.csta.binding.reset.ResetApplicationSessionTimer@193509d
2011-07-22 11.16.28,480 com.avaya.sessionsvc.SessionServicesImpl resetApplicationSessionTimer
FINE: Resetting session timer: session BFFBB28663F6770C4C00D444A1B05EE7-4
2011-07-22 11.16.28,480 com.avaya.sessionsvc.SessionObjectImpl refresh
FINE: session BFFBB28663F6770C4C00D444A1B05EE7-4 is being refreshed.
2011-07-22 11.16.28,480 com.avaya.mvcs.proxy.CstaRouterNode processPacket
FINE: invokeID= 4 Received session[null] ch.ecma.csta.binding.reset.ResetApplicationSessionTimerPosResponse@917854 in response to session[session BFFBB28663F6770C4C00D444A1B05EE7-4] ch.ecma.csta.binding.reset.ResetApplicationSessionTimer@193509d
2011-07-22 11.17.40,487 com.avaya.mvcs.proxy.CstaRouterNode processPacket
FINE: invokeID= 5 Routing request=session[session BFFBB28663F6770C4C00D444A1B05EE7-4] ch.ecma.csta.binding.reset.ResetApplicationSessionTimer@118ed3c
2011-07-22 11.17.40,488 com.avaya.sessionsvc.SessionServicesImpl resetApplicationSessionTimer
FINE: Resetting session timer: session BFFBB28663F6770C4C00D444A1B05EE7-4
2011-07-22 11.17.40,488 com.avaya.sessionsvc.SessionObjectImpl refresh
FINE: session BFFBB28663F6770C4C00D444A1B05EE7-4 is being refreshed.
2011-07-22 11.17.40,488 com.avaya.mvcs.proxy.CstaRouterNode processPacket
FINE: invokeID= 5 Received session[null] ch.ecma.csta.binding.reset.ResetApplicationSessionTimerPosResponse@17f2ad0 in response to session[session BFFBB28663F6770C4C00D444A1B05EE7-4] ch.ecma.csta.binding.reset.ResetApplicationSessionTimer@118ed3c
2011-07-22 11.18.52,496 com.avaya.mvcs.proxy.CstaRouterNode processPacket
FINE: invokeID= 6 Routing request=session[session BFFBB28663F6770C4C00D444A1B05EE7-4] ch.ecma.csta.binding.reset.ResetApplicationSessionTimer@1f88cce
2011-07-22 11.18.52,496 com.avaya.sessionsvc.SessionServicesImpl resetApplicationSessionTimer
FINE: Resetting session timer: session BFFBB28663F6770C4C00D444A1B05EE7-4
2011-07-22 11.18.52,496 com.avaya.sessionsvc.SessionObjectImpl refresh
FINE: session BFFBB28663F6770C4C00D444A1B05EE7-4 is being refreshed.
2011-07-22 11.18.52,496 com.avaya.mvcs.proxy.CstaRouterNode processPacket
FINE: invokeID= 6 Received session[null] ch.ecma.csta.binding.reset.ResetApplicationSessionTimerPosResponse@e465ea in response to session[session BFFBB28663F6770C4C00D444A1B05EE7-4] ch.ecma.csta.binding.reset.ResetApplicationSessionTimer@1f88cce
2011-07-22 11.20.04,506 com.avaya.mvcs.proxy.CstaRouterNode processPacket
FINE: invokeID= 7 Routing request=session[session BFFBB28663F6770C4C00D444A1B05EE7-4] ch.ecma.csta.binding.reset.ResetApplicationSessionTimer@1469d08
2011-07-22 11.20.04,506 com.avaya.sessionsvc.SessionServicesImpl resetApplicationSessionTimer
FINE: Resetting session timer: session BFFBB28663F6770C4C00D444A1B05EE7-4
2011-07-22 11.20.04,506 com.avaya.sessionsvc.SessionObjectImpl refresh
FINE: session BFFBB28663F6770C4C00D444A1B05EE7-4 is being refreshed.
2011-07-22 11.20.04,507 com.avaya.mvcs.proxy.CstaRouterNode processPacket
FINE: invokeID= 7 Received session[null] ch.ecma.csta.binding.reset.ResetApplicationSessionTimerPosResponse@ef98ac in response to session[session BFFBB28663F6770C4C00D444A1B05EE7-4] ch.ecma.csta.binding.reset.ResetApplicationSessionTimer@1469d08
2011-07-22 11.21.16,508 com.avaya.mvcs.proxy.CstaRouterNode processPacket
FINE: invokeID= 8 Routing request=session[session BFFBB28663F6770C4C00D444A1B05EE7-4] ch.ecma.csta.binding.reset.ResetApplicationSessionTimer@1652209
2011-07-22 11.21.16,509 com.avaya.sessionsvc.SessionServicesImpl resetApplicationSessionTimer
FINE: Resetting session timer: session BFFBB28663F6770C4C00D444A1B05EE7-4
2011-07-22 11.21.16,509 com.avaya.sessionsvc.SessionObjectImpl refresh
FINE: session BFFBB28663F6770C4C00D444A1B05EE7-4 is being refreshed.
2011-07-22 11.21.16,509 com.avaya.mvcs.proxy.CstaRouterNode processPacket
FINE: invokeID= 8 Received session[null] ch.ecma.csta.binding.reset.ResetApplicationSessionTimerPosResponse@9d8f06 in response to session[session BFFBB28663F6770C4C00D444A1B05EE7-4] ch.ecma.csta.binding.reset.ResetApplicationSessionTimer@1652209
2011-07-22 11.22.28,517 com.avaya.mvcs.proxy.CstaRouterNode processPacket
FINE: invokeID= 9 Routing request=session[session BFFBB28663F6770C4C00D444A1B05EE7-4] ch.ecma.csta.binding.reset.ResetApplicationSessionTimer@19a83f3
2011-07-22 11.22.28,517 com.avaya.sessionsvc.SessionServicesImpl resetApplicationSessionTimer
FINE: Resetting session timer: session BFFBB28663F6770C4C00D444A1B05EE7-4
2011-07-22 11.22.28,517 com.avaya.sessionsvc.SessionObjectImpl refresh
FINE: session BFFBB28663F6770C4C00D444A1B05EE7-4 is being refreshed.
2011-07-22 11.22.28,517 com.avaya.mvcs.proxy.CstaRouterNode processPacket
FINE: invokeID= 9 Received session[null] ch.ecma.csta.binding.reset.ResetApplicationSessionTimerPosResponse@14ce931 in response to session[session BFFBB28663F6770C4C00D444A1B05EE7-4] ch.ecma.csta.binding.reset.ResetApplicationSessionTimer@19a83f3
2011-07-22 11.22.43,084 com.avaya.licensesvc.LicenseServiceImpl$RenewTimerTask run
FINE: Running License Service RenewTimerTask
2011-07-22 11.22.43,084 com.avaya.common.logger.PrintStreamLogger log
INFO: STANDARD OUT: Current Retry Count : 1

2011-07-22 11.22.43,090 com.avaya.common.logger.PrintStreamLogger log
INFO: STANDARD OUT: Current Retry Count : 1

2011-07-22 11.23.40,527 com.avaya.mvcs.proxy.CstaRouterNode processPacket
FINE: invokeID= 10 Routing request=session[session BFFBB28663F6770C4C00D444A1B05EE7-4] ch.ecma.csta.binding.reset.ResetApplicationSessionTimer@13b5c39
2011-07-22 11.23.40,527 com.avaya.sessionsvc.SessionServicesImpl resetApplicationSessionTimer
FINE: Resetting session timer: session BFFBB28663F6770C4C00D444A1B05EE7-4
2011-07-22 11.23.40,527 com.avaya.sessionsvc.SessionObjectImpl refresh
FINE: session BFFBB28663F6770C4C00D444A1B05EE7-4 is being refreshed.
2011-07-22 11.23.40,527 com.avaya.mvcs.proxy.CstaRouterNode processPacket
FINE: invokeID= 10 Received session[null] ch.ecma.csta.binding.reset.ResetApplicationSessionTimerPosResponse@23b026 in response to session[session BFFBB28663F6770C4C00D444A1B05EE7-4] ch.ecma.csta.binding.reset.ResetApplicationSessionTimer@13b5c39
2011-07-22 11.24.06,165 com.avaya.common.logger.PrintStreamLogger log
INFO: STANDARD OUT: Current Retry Count : 1

2011-07-22 11.24.11,513 com.avaya.common.logger.PrintStreamLogger log
INFO: STANDARD OUT: Current Retry Count : 1

ok, now I am really stuck:

com.avaya.api.sessionsvc.exceptions.SessionSecurityException: user=aeserver1, ext=3904 is not authorized for AuthzType CALL_ORIG_TERM

I tried another extension, same error:
2011-07-22 11.36.06,825 com.avaya.sessionsvc.SessionObjectImpl isAuthorized
FINE: clientID=XML Unencrypted:10.1.9.10:55707, ext=3865 authorization failed.
com.avaya.api.sessionsvc.exceptions.SessionSecurityException: user=aeserver1, ext=3865 is not authorized for AuthzType CALL_ORIG_TERM


Any help would greatly be appreciated
Thank you

It looks like you are failing user authorization in the secure database. You mentioned that you have specified the user as a CTI user, but have you set up the Secure Database (SDB) to give the user the authority to use the device? Please read the documentation on how to set up the SDB, and how to associate the user with one or more devices.

Alternatively, if you don't require the security checks, you can disable the use off the SDB by DMCC from the OAM web-pages.

Thank you for your response Gwilym;
I diabled the SDB by DMCC and tried to connect again, I got the following error/warning:

WARNING: Unable to find a tlink for the switch name, . If you are using an IP address for the address double check that the switch connection H.323 Gatekeeper address is administered correctly in OAM.
ch.ecma.csta.errors.OperationException: Unable to find a tlink for the switch name, . If you are using an IP address for the address double check that the switch connection H.323 Gatekeeper address is administered correctly in OAM.
   at com.avaya.cs.callcontrol.delegs.TsapiSessionMap.getTsapiSession(TsapiSessionMap.java:390)


in OAM --> AE Services--> TSAPI -->TSAPI Links
I have 1 line:
Link =1 switch=s8300, Switch CTI Link #=1

in CM Interface -->Swith connection--> Edit h.323 gatekeeper: i don't have any IP addresses in there, I am not sure if its ther IP address of ther Communication manager or some other address it should be?

Hi Gwilym;

I added the CM's Ip address in the gatekeeper field, and now I am getting this message:

FINE: Found switchname:S8300, hostname:localhost.localdomain, port:1050, Tlink AVAYA#S8300#CSTA#MONTREAPPBLD04
2011-07-22 13.10.43,601 com.avaya.cs.callcontrol.delegs.TsapiSessionMap getTsapiSession
FINE: Opening TsapiSession with session ID F97B4BE265D0B14F6CB670FBA008B4F3-1 to TSAPI IP localhost.localdomain, port number 1050, Tlink AVAYA#S8300#CSTA#MONTREAPPBLD04
2011-07-22 13.10.43,601 com.avaya.cs.callcontrol.delegs.TsapiSessionMap getTsapiSession
FINE: Setting Tsapi requested private data version to: 4-9
2011-07-22 13.10.43,744 com.avaya.cs.dataservice.CMInfoDataService <init>
FINE: GOING TO THE DBCONNECTION POOL...
2011-07-22 13.10.43,773 com.avaya.cmapi.monitor.MonitoringServicesImpl createCallControlServicesListener
FINE: added CallControlListener: 10, id=[3902:S8300:10.169.12.12:0] , listener=com.avaya.cmapi.monitor.CallControlServicesListenerImpl@1fbadc2
2011-07-22 13.10.43,773 com.avaya.mvcs.proxy.CstaRouterNode processPacket
FINE: invokeID= 7 Received com.avaya.platform.broker.impl.AsyncResponse@1f751c9 in response to session[session F97B4BE265D0B14F6CB670FBA008B4F3-1] ch.ecma.csta.binding.MonitorStart@16c54b7
2011-07-22 13.10.43,836 com.avaya.cs.callcontrol.CallControlSnapshotImpl removeCallControlListener
INFO: CCS Remove Listener: listener not found for device: 3902:S8300:10.169.12.12:0 Possibly received CSTAMonitorEndedEvent or device wasunregistered on the switch. Monitor Stop request will not be sent.
2011-07-22 13.10.43,836 com.avaya.cmapi.monitor.MonitoringServicesImpl stopMonitor
FINE: removing CallControlListener: crossRef=10:[Holder]: [3902:S8300:10.169.12.12:0] ,com.avaya.cmapi.monitor.CallControlServicesListenerImpl@1fbadc2,session F97B4BE265D0B14F6CB670FBA008B4F3-1
2011-07-22 13.10.43,836 com.avaya.cmapi.monitor.MonitoringServicesImpl releaseCrossRefId
FINE: released crossRefID=10: 8 are now in use, 79992 still available.
2011-07-22 13.10.43,836 com.avaya.cmapi.monitor.MonitoringServicesImpl stopMonitor
FINE: removed monitor=10
2011-07-22 13.10.43,837 com.avaya.mvcs.proxy.CstaMarshallerNode$CstaMarshallerThread convertThrowable
FINE: Returning negative ack to client session (F97B4BE265D0B14F6CB670FBA008B4F3-1) : ch.ecma.csta.errors.OperationException: Internal logic error in the G3PD. A system administrator may find more detailed information about the error in the G3PD error logs. Contact service representative: error code 71
2011-07-22 13.10.43,838 com.avaya.async.impl.AsyncCallbackImpl handleException
WARNING: A service method threw an Exception when invoked!
ServiceMethod: com.avaya.platform.broker.impl.AsyncServiceMethodImpl@19a9d1[com.avaya.cmapi.monitor.MonitoringServicesImpl@1963273, public synchronized void com.avaya.cmapi.monitor.MonitoringServicesImpl.startMonitor(ch.ecma.csta.binding.MonitorStart,com.avaya.api.async.AsynchronousCallback) throws ch.ecma.csta.errors.InvalidParameterValueException,ch.ecma.csta.errors.InvalidMonitorObjectException,ch.ecma.csta.errors.OverallMonitorLimitExceededException,ch.ecma.csta.errors.OperationException,ch.ecma.csta.errors.InvalidConnectionIDForActiveCallException]
Exception: ch.ecma.csta.errors.OperationException: Internal logic error in the G3PD. A system administrator may find more detailed information about the error in the G3PD error logs. Contact service representative: error code 71

Hi Gwilym;

I ran the following tests, but they failed ,except for the ping!!

ASAI Test Result
=== Test for TSAPI Link 1 ===
Unexpected capability, C_ABORT, received on ASAI node signal33.
Unexpected primitive type, C_REQUEST, received for ASAI node signal33
Heartbeat test with switch for TSAPI link 01 failed.
=== Test Completed ===

TSAPI Test Result
cstaMakeCall() failed with ACS Universal Failure Error 35:
Device is not supported.
I used: 1- user=cmapi.username
2-password= cmapi.password
From= a configured station
To: another configured station

Ping Host Results
PING 10.169.12.12 (10.169.12.12) 64(92) bytes of data.
72 bytes from 10.169.12.12: icmp_seq=1 ttl=58 time=273 ms
72 bytes from 10.169.12.12: icmp_seq=2 ttl=58 time=274 ms
72 bytes from 10.169.12.12: icmp_seq=3 ttl=58 time=273 ms
72 bytes from 10.169.12.12: icmp_seq=4 ttl=58 time=273 ms
72 bytes from 10.169.12.12: icmp_seq=5 ttl=58 time=273 ms
--- 10.169.12.12 ping statistics ---
5 packets transmitted, 5 received, 0% packet loss, time 4002ms
rtt min/avg/max/mdev = 273.418/273.848/274.100/0.230 ms

now geting:
TSAPI Test Result
cstaMakeCall() failed with CSTA Universal Failure Error 71:
Generic operation rejection.

It sounds like there's a problem with your switch connection. On the AES OAM web-pages, if you click on "Status" - > "Status and Control" -> "Switch Conn. Summary", the "Conn. State" for the switch (to which you are trying to connect) should be set to "Talking". If it is not in the "Talking" state, then you have configured it incorrectly, and you need to check your settings. If the "Conn. State" is correctly set to "Talking", you should request Technical Support through the link on this DevConnect forum.

Hi Gwilyn;

Switch Connections Summary
I don't see anything other then the blue headers:
Switch conn|ConState|processor ethe|Since|..
online offline connection details per servrice..

The same goes for TSAPI Links:
TSAPI Link Details
Link| Swithch name| Switch cti liong ih|

when I click on Tlink status, it tells me " No Tlinks found"!!

But in AE Service --> TSAPI -->TSAPI Links -->
I do have Link| Switch connection| Switch CTI Link#|...
1 |S8300 |1

If the "Switch Conn. Summary" page doesn't list the Switch Connection, then you have not configured the connection correctly. Go to the OAM page: "Communication Manager Interface" -> "Switch Connections". Is your switch connection listed there? If so, does the Switch Connection have at least one active connection?

If there is at least one active connection for the Switch Connection, then it should appear on the "Switch Conn. Summary" page. If the Switch Connection has zero active connections, then you need to check your Switch Connection configuration.

To check your configuration, click on the "Edit Connection" button and check that the information specified is correct and matches the information specified on the switch itself.

Also click on the "Edit PE/CLAN IPs" button and check that you have entered a valid IP address. If you checked the "Processor Ethernet" box on the "Edit Connection" page, then this address should be the IP address of the Processor Ethernet connection of the switch. If you did not check the "Processor Ethernet" box, then this IP address should be the address of an active CLAN that is associated with the switch.

In addition, if you make any changes to the "Switch Connections" web page, I suggest that you restart the AE Server from that "Maintenance" -> "Service Controller" page.

Hi Gwilyn;

This actually was my first concern.
the Switch password field does not retain the password. when I leaave the page and come back there is nothuing in the field, its blank

. also , yes there is a swithc connection listed , but zero active connection

connection name|processor ethernet| msg period| number of active connections
S8300|yes|30|0