cancel
Showing results for 
Search instead for 
Did you mean: 
cancel
3593
Views
5
Helpful
7
Replies

Call from Lync to CUCM 10.5 fails with 404 not found call flow Lync client--mediation server--SIP trunk--CUCM--MGCP PRI

gene
Level 1
Level 1

Trying to get calls from Lync to CUCM 10.5. The dialed number is 96617356. Any idea why CUCM is responding with 404?

Thanks!

06344639.037 |15:04:13.761 |AppInfo |//SIP/Stack/States/0x0x106e4058/sipSPIChangeState: 0x106e4058 : State change from (STATE_IDLE, SUBSTATE_NONE) to (SIP_STATE_INCOMING_REGISTER, SUBSTATE_NONE)
06344640.000 |15:04:13.761 |SdlSig |SIPRegisterInd |wait |SIPStationInit(1,100,72,1) |SIPHandler(1,100,79,1) |1,100,14,1067.4209^172.24.133.23^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] ccbID= 122271 --TransType=1 --TransSecurity=0 PeerAddr = 172.24.133.23:50168 MAC = DeviceName = X509SubjectName = SubjectAltname =
06344641.000 |15:04:13.761 |SdlSig |SIPRegisterResp |wait |SIPHandler(1,100,79,1) |SIPStationInit(1,100,72,1) |1,100,14,1067.4209^172.24.133.23^* |[T:N-H:0,N:0,L:0,V:0,Z:0,D:0] ccbID= 122271 --TransType=1 --TransSecurity=0 PeerAddr= 172.24.133.23:50168 respCode= 200 action= 2 device=
06344641.001 |15:04:13.761 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/wait_SIPRegisterResp: ++++++ Decrememted gSipNewRegPendingNum to 0
06344641.002 |15:04:13.761 |AppInfo |//SIP/Stack/Info/0x0/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 (SIP_APPLICATION_MSG), for event 43 (SIPSPI_EV_REGISTER_RESP)
06344641.003 |15:04:13.761 |AppInfo |//SIP/Stack/Info/0x0x106e4058/sipSPISendResponse: Associated container=0x106e3398 to REGISTER Response 200
06344641.004 |15:04:13.761 |AppInfo |//SIP/Stack/Transport/0x0x106e4058/sipSPISendResponse: Sending REGISTER Response to the transport layer
06344641.005 |15:04:13.761 |AppInfo |//SIP/Stack/Transport/0x0x106e4058/sipSPITransportSendMessage: msg=0x1078c050, addr=172.24.133.23, port=50168, sentBy_port=50168, is_req=0, tran
06344641.006 |15:04:13.761 |AppInfo |//SIP/Stack/Transport/0x0/sipInstanceGetConnectionId: gcb=0x106e4058 is already on connection=0xfaa7b80 context_list
06344641.007 |15:04:13.761 |AppInfo |//SIP/Stack/Transport/0x0x106e4058/sipTransportLogicSendMsg: Connection obtained...sending msg=0x1078c050
06344641.008 |15:04:13.761 |AppInfo |//SIP/Stack/Transport/0x0x106e4058/sipTransportPostSendMessage: Posting send for msg=0x1078c050, addr=172.24.133.23, port=50168, connId=34 for
06344641.009 |15:04:13.761 |AppInfo |//SIP/Stack/Info/0x0x106e4058/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue that are going to b
06344641.010 |15:04:13.761 |AppInfo |//SIP/Stack/Transport/0x0/sipConnectionManagerUnregisterCtxtInCon: gConnTab=0xfaa5358, addr=172.24.133.23, port=50168, unregistering context=
06344641.011 |15:04:13.761 |AppInfo |//SIP/Stack/Info/0x0x106e4058/sipSPIUfreeOneCCB: Freeing ccb 106e4058
06344641.012 |15:04:13.761 |AppInfo |//SIP/Stack/Transport/0x0/sipSPITransportSendMessage: gcb has cleanedup, Done with send operations for this context
06344642.000 |15:04:13.761 |SdlSig |SIPSPISignal |wait |SIPTcp(1,100,71,1) |SIPHandler(1,100,79,1) |1,100,14,1067.4209^172.24.133.23^* |*TraceFlagOverrode
06344642.001 |15:04:13.761 |AppInfo |SIPTcp - wait_SdlSPISignal: Outgoing SIP TCP message to 172.24.133.23 on port 50168 index 34
[349720,NET]
SIP/2.0 200 OK
Via: SIP/2.0/TCP 172.24.133.23:50168;branch=z9hG4bK358070b2
From: <sip:6412@10.127.0.2>;tag=9c57adb5c3111bfc4f927767-7d1c3b92
To: <sip:6412@10.127.0.2>;tag=169491427
Date: Wed, 15 Jun 2016 20:04:13 GMT
Call-ID: 9c57adb5-c311038f-30824a27-1d4ee5fb@172.24.133.23
CSeq: 71362 REGISTER
Expires: 0
Content-Length: 0


06344643.000 |15:04:13.863 |SdlSig-I |GlobalCallHandleReq |wait |Cc(1,100,220,1) |CTIHandler(1,200,22,2) |1,200,13,3.58665^*^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0]
06344644.000 |15:04:13.863 |SdlSig-O |GlobalCallHandleRes |NA RemoteSignal |CTIHandler(1,200,22,2) |Cc(1,100,220,1) |1,200,13,3.58665^*^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0]
06344645.000 |15:04:14.238 |SdlSig |SdlDataInd |wait |StationInit(1,100,62,1) |SdlTCPConnection(1,100,14,1390) |1,100,14,1390.329^10.102.4.124^* |*TraceFlagOverrode
06344645.001 |15:04:14.238 |AppInfo |KeepAliveMessage received on backup CM link. Droping KeepAliveAck. DeviceName=, TCPPid = [1.100.14.1390], IPAddr=10.102.4.124, Port=50902, Device Controller=[0,0,0]
06344646.000 |15:04:14.312 |Created | | |SdlTCPConnection(1,100,14,1439) |SdlTCPListener(1,100,12,7) | |NumOfCurrentInstances: 582
06344647.000 |15:04:14.312 |SdlSig |SdlConnectionInd |wait |SIPTcp(1,100,71,1) |SdlTCPConnection(1,100,14,1439) |1,100,12,7.87^*^* |*TraceFlagOverrode
06344647.001 |15:04:14.312 |AppInfo |SIPTcp - Connection Indication - Listen Port = 5060, Peer Port = 54010
06344647.002 |15:04:14.312 |AppInfo |SIPTcp - New Connection - Index = 96, Listen Port = 5060, Peer Port = 54010
06344648.000 |15:04:14.312 |SdlSig |SdlReadRsp |wait |SIPTcp(1,100,71,1) |SdlTCPConnection(1,100,14,1439) |1,100,14,1439.2^10.27.1.132^* |*TraceFlagOverrode
06344648.001 |15:04:14.312 |AppInfo |SIPTcp - SdlRead bufferLen=943
06344648.002 |15:04:14.312 |AppInfo |SIPTcp - wait_SdlReadRsp: Incoming SIP TCP message from 10.27.1.132 on port 54010 index 96 with 943 bytes:
[349721,NET]
INVITE sip:96617356@pkx-ccm-pub.xxx-xx.org;user=phone SIP/2.0
FROM: "LyncTestUser1"<sip:lynctestuser1@xxx-xx.org>;epid=4C61DF0777;tag=b4c36b601b
TO: <sip:96617356@pkx-ccm-pub.xxx-xx.org;user=phone>
CSEQ: 30 INVITE
CALL-ID: 33e3b2ff-cef1-497a-9e76-f5b7628f6c11
MAX-FORWARDS: 70
VIA: SIP/2.0/TCP 10.27.1.132:54010;branch=z9hG4bKab564143
CONTACT: <sip:LyncFE01.xxx-xx.org:5060;transport=Tcp;maddr=10.27.1.132;ms-opaque=a90113d42f32e71c>
CONTENT-LENGTH: 335
SUPPORTED: 100rel
USER-AGENT: RTCC/5.0.0.0 MediationServer
CONTENT-TYPE: application/sdp
ALLOW: ACK
Allow: CANCEL,BYE,INVITE,PRACK,UPDATE

v=0
o=- 8 1 IN IP4 10.27.1.132
s=session
c=IN IP4 10.27.1.132
b=CT:1000
t=0 0
m=audio 55666 RTP/AVP 97 101 13 0 8
c=IN IP4 10.27.1.132
a=rtcp:55667
a=label:Audio
a=sendrecv
a=rtpmap:97 RED/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:13 CN/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=ptime:20

06344648.003 |15:04:14.312 |AppInfo |SIPTcp - SignalCounter = 155918
06344649.000 |15:04:14.312 |SdlSig |SIPSPISignal |wait |SIPHandler(1,100,79,1) |SIPTcp(1,100,71,1) |1,100,12,7.87^*^* |*TraceFlagOverrode
06344649.001 |15:04:14.312 |AppInfo |//SIP/Stack/Info/0x0/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 (SIP_NETWORK_MSG), for event 57 (SIPSPI_EV_NEW_CONNECTION)
06344649.002 |15:04:14.312 |AppInfo |//SIP/Stack/Transport/0x0/sipTransportProcessNWNewConnMsg: context=(nil)
06344649.003 |15:04:14.312 |AppInfo |//SIP/Stack/Transport/0x0/sipConnectionManagerProcessNewConnMsg: gConnTab=0xfaa5358, addr=10.27.1.132, port=54010, connid=96, transport=TCP
06344649.004 |15:04:14.312 |AppInfo |//SIP/Stack/Transport/0x0/sipCreateConnInstance: Created new accptd conn=0xfaa7a18, connid=96, addr=10.27.1.132, port=54010, transport=TCP
06344650.000 |15:04:14.312 |SdlSig |SIPNormalizeReq |wait |SIPNormalization(1,100,78,1) |SIPHandler(1,100,79,1) |1,100,14,1439.2^10.27.1.132^* |*TraceFlagOverrode
06344650.001 |15:04:14.312 |AppInfo |//SIP/SIPNormalization/trace_sip_message: After inbound SIP Normalization msg is:
[349721,INT]
INVITE sip:96617356@pkx-ccm-pub.xxx-xx.org;user=phone SIP/2.0
ALLOW: ACK,CANCEL,BYE,INVITE,PRACK,UPDATE
From: "LyncTestUser1"<sip:lynctestuser1@xxx-xx.org>;epid=4C61DF0777;tag=b4c36b601b
SUPPORTED: 100rel
Content-Length: 335
USER-AGENT: RTCC/5.0.0.0 MediationServer
TO: <sip:96617356@pkx-ccm-pub.xxx-xx.org;user=phone>
CONTACT: <sip:LyncFE01.xxx-xx.org:5060;transport=Tcp;maddr=10.27.1.132;ms-opaque=a90113d42f32e71c>
CONTENT-TYPE: application/sdp
CALL-ID: 33e3b2ff-cef1-497a-9e76-f5b7628f6c11
CSEQ: 30 INVITE
VIA: SIP/2.0/TCP 10.27.1.132:54010;branch=z9hG4bKab564143
MAX-FORWARDS: 70

v=0
o=- 8 1 IN IP4 10.27.1.132
s=session
c=IN IP4 10.27.1.132
b=CT:1000
t=0 0
m=audio 55666 RTP/AVP 97 101 13 0 8
c=IN IP4 10.27.1.132
a=rtcp:55667
a=label:Audio
a=sendrecv
a=rtpmap:97 RED/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:13 CN/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=ptime:20

06344651.000 |15:04:14.312 |SdlSig |SIPNormalizeRes |wait |SIPHandler(1,100,79,1) |SIPNormalization(1,100,78,1) |1,100,14,1439.2^10.27.1.132^* |*TraceFlagOverrode
06344651.001 |15:04:14.312 |AppInfo |//SIP/Stack/Info/0x0/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 (SIP_NETWORK_MSG), for event 1 (SIPSPI_EV_NEW_MESSAGE)
06344651.002 |15:04:14.312 |AppInfo |//SIP/Stack/Transport/0x0/sipTransportProcessNWNewConnMsg: context=(nil)
06344651.003 |15:04:14.312 |AppInfo |//SIP/Stack/Transport/0x0/sipConnectionManagerProcessNewConnMsg: gConnTab=0xfaa5358, addr=10.27.1.132, port=54010, connid=96, transport=TCP
06344651.004 |15:04:14.312 |AppInfo |//SIP/Stack/Info/0x0/sipHolderGetConnInstance: Return existing connection for port 54010 connId 96
06344651.005 |15:04:14.312 |AppInfo |//SIP/Stack/Info/0x0/sipSPIAddContextToTable: Added context(0x106e4058) with key=[122161] to table
06344651.006 |15:04:14.312 |AppInfo |DET-SDPMsg- sBandwidth:: enabledMask=0x0 as=0 ct=0 tias=0 maxprate=0
06344651.007 |15:04:14.312 |AppInfo |DET-SDPMsg- ngroups 0
06344651.008 |15:04:14.312 |AppInfo |DET-SDPMsg- No Session level unrecognized attributes list.
06344651.009 |15:04:14.312 |AppInfo |DET-SDPMsg- nAudio=0, mDTMFP.PayloadNum=0
06344651.010 |15:04:14.312 |AppInfo |DET-SDPMsg- nVideo=0
06344651.011 |15:04:14.312 |AppInfo |DET-SDPMsg- nApp=0
06344651.012 |15:04:14.312 |AppInfo |DET-SDPMsg- nBFCPApp=0
06344651.013 |15:04:14.312 |AppInfo |DET-SDPMsg- nIXApp=0
06344651.014 |15:04:14.312 |AppInfo |DET-SDPMsg- sBandwidth:: enabledMask=0x0 as=0 ct=0 tias=0 maxprate=0
06344651.015 |15:04:14.312 |AppInfo |DET-SDPMsg- sipp: ispres=0, role=0 vers=0 anat=0
06344651.016 |15:04:14.312 |AppInfo |DET-SDPMsg- ngroups 0
06344651.017 |15:04:14.312 |AppInfo |DET-SDPMsg- No Session level unrecognized attributes list.
06344651.018 |15:04:14.312 |AppInfo |DET-SDPMsg- nAudio=0, mDTMFP.PayloadNum=0
06344651.019 |15:04:14.312 |AppInfo |DET-SDPMsg- nVideo=0
06344651.020 |15:04:14.312 |AppInfo |DET-SDPMsg- nApp=0
06344651.021 |15:04:14.312 |AppInfo |DET-SDPMsg- nBFCPApp=0
06344651.022 |15:04:14.312 |AppInfo |DET-SDPMsg- nIXApp=0
06344651.023 |15:04:14.312 |AppInfo |//SIP/Stack/Transport/0x0/sipSPIUpdateResponseInfo: Dialog Transaction Address 10.27.1.132,Port 54010, Transport 2, SentBy Port 54010
06344651.024 |15:04:14.312 |AppInfo |//SIP/Stack/States/0x0x106e4058/sipSPIChangeState: 0x106e4058 : State change from (STATE_NONE, SUBSTATE_NONE) to (STATE_IDLE, SUBSTATE_NONE)
06344651.025 |15:04:14.312 |AppInfo |//SIP/Stack/Transport/0x0/sipSPIUpdateResponseInfo: Dialog Transaction Address 10.27.1.132,Port 54010, Transport 2, SentBy Port 5060
06344651.026 |15:04:14.312 |AppInfo |//SIP/Stack/Transport/0x0/sipSPIUpdateResponseInfo: Dialog Transaction Address 10.27.1.132,Port 54010, Transport 2, SentBy Port 54010
06344651.027 |15:04:14.312 |AppInfo |//SIP/Stack/Error/0x0/httpish_msg_free: Freeing NULL pointer!
06344651.028 |15:04:14.313 |AppInfo |//SIP/Stack/Info/0x0x106e4058/sipSPIUaddCcbToTable: Added to table. ccb=0x106e4058 key=33e3b2ff-cef1-497a-9e76-f5b7628f6c1196617356
06344651.029 |15:04:14.313 |AppInfo |//SIP/SIPHandler/ccbId=4294967295/scbId=0/sipSPIGetCallExtensionSupported: SIPRel1xxEnabledServiceParamSetting=1 , ccb->pld.outboundRel1xx=1
06344651.030 |15:04:14.313 |AppInfo |//SIP/Stack/Info/0x0x106e4058/sipSPIContinueNewMsgInvite: Requires reliable-provisional support
06344651.031 |15:04:14.313 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: timerContext=0x106e505c type=SIP_TIMER_EXPIRES value=1800000 retries=0
06344651.032 |15:04:14.313 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: timerContext=0x106e505c type=SIP_TIMER_EXPIRES value=1800000 retries=0
06344651.033 |15:04:14.313 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/extractAssertedInfo: parseResult[1]
06344651.034 |15:04:14.313 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/getCodecAndFramesFromSDP: -- Error!!!!! Cannot convert SDP pt=13 to CM payload type.
06344651.035 |15:04:14.313 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/convertStackSDPtoCmSDP: ***SDPMsg=0 bytes a: 1 v: 0
06344651.036 |15:04:14.313 |AppInfo |//SIP/SIPHandler/ccbId=122272/scbId=0/_ccsip_api_call_setup_ind: sdppresent? 1 1
06344651.037 |15:04:14.313 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/getCalledNumberUri: SIP URL 96617356@pkx-ccm-pub.xxx-xx.org:5060
06344651.038 |15:04:14.313 |AppInfo |DEBUG - SIPHandler: Decoded other params: []
06344651.039 |15:04:14.313 |AppInfo |//SIP/SIPHandler/ccbId=122272/scbId=0/sendSetupInd: bearerless? 1 1
06344651.040 |15:04:14.313 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/parseContactHeader: Incoming Contact=[<sip:LyncFE01.xxx-xx.org:5060;transport=Tcp;maddr=10.27.1.132;ms-opaque=a90113d42f32e71c>]
06344651.041 |15:04:14.313 |AppInfo |//SIP/Stack/Info/0x0x106e4058/sipSPIContinueNewMsgInvite: ccsip_api_call_setup_ind returned: SIP_SUCCESS
06344651.042 |15:04:14.313 |AppInfo |//SIP/Stack/Transport/0x0x106e4058/sipSPITransportSendMessage: msg=0x108512b0, addr=10.27.1.132, port=54010, sentBy_port=54010, is_req=0, tran
06344651.043 |15:04:14.313 |AppInfo |//SIP/Stack/Transport/0x0/sipInstanceGetConnectionId: Registering gcb=0x106e4058 with connection=0xfaa7a18 context list
06344651.044 |15:04:14.313 |AppInfo |//SIP/Stack/Transport/0x0x106e4058/sipTransportLogicSendMsg: Connection obtained...sending msg=0x108512b0
06344651.045 |15:04:14.313 |AppInfo |//SIP/Stack/Transport/0x0x106e4058/sipTransportPostSendMessage: Posting send for msg=0x108512b0, addr=10.27.1.132, port=54010, connId=96 for
06344651.046 |15:04:14.313 |AppInfo |//SIP/Stack/States/0x0x106e4058/sipSPIChangeState: 0x106e4058 : State change from (STATE_IDLE, SUBSTATE_NONE) to (STATE_RECD_INVITE, SUBSTATE_NONE)
06344652.000 |15:04:14.313 |SdlSig |SIPSetupInd |restart0 |SIPD(1,100,81,4) |SIPHandler(1,100,79,1) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:1,L:0,V:0,Z:0,D:0] SignalInfo= SIPInviteSdp CcbId= 122272 --TransType=1 --TransSecurity=0 PeerAddr = 10.27.1.132:54010 IdParse= 1 callingNum= lynctestuser1 callingName= LyncTestUser1 calledNum= 96617356
06344652.001 |15:04:14.313 |AppInfo |SIPD(4) - restart0_SIPSetupInd: mTsp.deviceName[Lync1IP]
06344652.002 |15:04:14.313 |AppInfo |SIPD(4) - restart0_SIPSetupInd: mTsp.deviceName[Lync1IP], transformDn 96617356
06344652.003 |15:04:14.313 |AppInfo |SIPD(4) - updateSrtpFallbackSupport: mTsp.deviceName[Lync1IP] - sRTP fallback supported = False
06344652.004 |15:04:14.313 |AppInfo |SIPD(4) - updateOriginalCalledExtensionSupport: mTsp.deviceName[Lync1IP] - supported header has 100rel
06344652.005 |15:04:14.313 |AppInfo |SIPD(4) - updateOriginalCalledExtensionSupport: mTsp.deviceName[Lync1IP] - Original Called Extension supported = False
06344652.006 |15:04:14.313 |AppInfo |SIPD:checkPstnSIPSetupIndForVipr Before transformation : viprCgpn=[lynctestuser1], viprCdpn=[96617356]
06344652.007 |15:04:14.313 |AppInfo |SIPD:checkPstnSIPSetupIndForVipr After globalization setupCgpn=[lynctestuser1], setupCdpn=[96617356]
06344652.008 |15:04:14.313 |AppInfo |SIPD:checkPstnSIPSetupIndForVipr viprCgpnE164=[lynctestuser1], viprCdpnE164=[96617356]
06344652.009 |15:04:14.313 |AppInfo |SPROC:getCtrlPidAndIMSCap -- callingNum=lynctestuser1, inputCtrlPid=(1,100,220,1)
06344652.010 |15:04:14.313 |AppInfo |CMUtility routeCallThroughCTIRD: no matching RemDestDynamic record exists for remdest [lynctestuser1]
06344652.011 |15:04:14.313 |AppInfo |DbMobility: getMatchedRemDest starts: cnumber = lynctestuser1
06344652.012 |15:04:14.313 |AppInfo |DbMobility: getMatchedRemDest: full match case
06344652.013 |15:04:14.313 |AppInfo |DbMobility SelectByDestination: no matching RemDestDynamic record exists for remdest [lynctestuser1]
06344652.014 |15:04:14.313 |AppInfo |DbMobility: can't find remdest lynctestuser1 in map
06344652.015 |15:04:14.313 |AppInfo |SIPD(4) - restart0_SIPSetupInd: Trunk Type [0] - The matched isIMSCapable =[0]
06344652.016 |15:04:14.313 |AppInfo |resetLocalDtmfCaps: mLocalDtmfCaps.oob.kpmlAvail = 0
06344652.017 |15:04:14.313 |AppInfo |CcmCcmdbSIPNormalizeHelper::getSipDeviceScriptPkidGivenDeviceName: This is a regular SIPTrunk. deviceName - (Lync1IP)
06344652.018 |15:04:14.314 |Created | | |SIPCdpc(1,100,82,7) |SIPD(1,100,81,4) | |NumOfCurrentInstances: 1
06344653.000 |15:04:14.314 |SdlSig |Start |start |SIPCdpc(1,100,82,7) |SIPCdpc(1,100,82,7) |1,100,14,1439.2^10.27.1.132^* |*TraceFlagOverrode
06344653.001 |15:04:14.314 |AppInfo |SIPCdpc(7) - getDefAe: SIPCdpc=7, nodeId=1, processNumber=81 ci=0, branch=0
06344653.002 |15:04:14.314 |LnkState |LinkAdmin - registerLinkStatus - Pid: [1,82,7], NodeId: 2 regCount: 1
06344653.003 |15:04:14.314 |AppInfo |SIPCdpc(7) - StartTransition: BFCPAllowed=0 allowMultiCodecsInAnswer = 0, ACROutgoing=0 ACRIncoming=0 honorIncomingCodecPref=0
06344653.004 |15:04:14.314 |AppInfo |SIPCdpc(7) - StartTransition: requireInactiveSDPForMidcallMediaChange=0, isTrunkEnabledForVoiceEO=0, mSipMcuControl 0 addrMode 0 ANAT=0
06344654.000 |15:04:14.314 |SdlSig |SIPSetupInd |null0 |SIPCdpc(1,100,82,7) |SIPD(1,100,81,4) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:1,L:0,V:0,Z:0,D:0] SignalInfo= SIPInviteSdp CcbId= 122272 --TransType=1 --TransSecurity=0 PeerAddr = 10.27.1.132:54010 IdParse= 1 callingNum= lynctestuser1 callingName= LyncTestUser1 calledNum= 96617356
06344654.001 |15:04:14.314 |AppInfo |SIPCdpc(7) - handleSIPUASSessionExpires: isMidCall[0], method[102]
06344654.002 |15:04:14.314 |AppInfo |SIPCdpc(7) - handleSIPUASSessionExpires: supported NULL
06344654.003 |15:04:14.314 |AppInfo |SIPCdpc(7) - handleSIPUASPeriodicSessionRefresh: Failed session timers, switch to periodic refresh, method [102]
06344654.004 |15:04:14.314 |AppInfo |SIPCdpc(7) - setPeriodicReInviteTimer: interval[900] secs
06344654.005 |15:04:14.314 |AppInfo |SIPCdpc(7) - getIPAddrModeFromEndpointsOffer: SDP is present = 1, Configured ipAddrMode 0, current mode 0, ANAT Mode = 0
06344654.006 |15:04:14.314 |AppInfo |SIPCdpc(7) - processIncomingGeolocationInfo: no Geolocation support
06344654.007 |15:04:14.314 |AppInfo |SIPCdpc(7) - preProcessOffer: audiomLines[0]: rtp=1,srtp=0,deviceNOTSrtpCapable=1,numCrypto=0,isOfferFromCCM=0,sipEndpointCanRcvSrtpOffers=0,deviceSupportsSrtpFB=0,telephone-event=101
06344654.008 |15:04:14.314 |AppInfo |SIPCdpc(7) - updateAllowedMethods: mEndpointAllowedMethods=00f9
06344654.009 |15:04:14.314 |AppInfo |setEndpointsDtmfCaps: Detected inband DTMF support.
06344654.010 |15:04:14.314 |AppInfo |SIP DTMF Info: mLocalDtmfCaps...UNSOL=1, KPML=0, Inband=0(0) mEndppointsDtmfCaps...UNSOL=0, KPML=0, Inband=1(101) mDefaultTelephonyEvent=101, mDtmfPreference=1, mMtpAllocated=0
06344654.011 |15:04:14.314 |AppInfo |SIPCdpc(0) - globalizeCdpn: SPROC globalizeCdpn calledunknown CSS = , unknownPrefix=Default, unknownStrip=0
06344655.000 |15:04:14.314 |SdlSig |SdlLinkISV |inCall_waitCiRes |SIPCdpc(1,100,82,7) |SdlLinkService(1,100,4,1) |1,100,82,7.1^*^* |*TraceFlagOverrode
06344655.001 |15:04:14.314 |AppInfo |SIPCdpc(7) - star_SdlLinkISV: SDL Link In-Service received
06344656.000 |15:04:14.314 |SdlSig |CcCiReq |wait |Cc(1,100,220,1) |SIPCdpc(1,100,82,7) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] handle=122272 handle2=0ti=1nd=96617356User=96617356Host=pkx-ccm-pub.xxx-xx.orgPort=5060PassWord=Madder=Transport=4mDisplayName=RawUrl=sip:96617356@pkx-ccm-pub.xxx-xx.org;user=phoneOrigPort=0pi=0si1
06344657.000 |15:04:14.314 |SdlSig |CcCiRes |restart0 |SIPD(1,100,81,4) |Cc(1,100,220,1) |1,100,14,1439.2^10.27.1.132^* |[R:H-H:0,N:0,L:0,V:0,Z:0,D:0] CI=23587686 CI.branch=0 ci=23587686 callIns=0 handle=122272 handle2=0
06344657.001 |15:04:14.314 |AppInfo |SIPD(4) - getKeyBasedOnCiAndBranch: AddressingElement branch is 0 and ci is 23587686 mapKey is 23587686
06344657.002 |15:04:14.314 |AppInfo |SIPD(4) - restart0_CcCiRes: Adding Cdpc Pid (1,100,82,7) with mapKey 23587686 and branch 0 to mCiToPid table
06344658.000 |15:04:14.314 |SdlSig |CcCiRes |inCall_waitCiRes |SIPCdpc(1,100,82,7) |SIPD(1,100,81,4) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] CI=23587686 CI.branch=0 ci=23587686 callIns=0 handle=122272 handle2=0
06344658.001 |15:04:14.314 |AppInfo |SIPCdpc(7) - isMidCallFallbackSupported: getXCiscoViPRFallbackID returned false, proceed without PSTN fallback
06344658.002 |15:04:14.314 |AppInfo |SIPCdpc(7) - getDefAe: SIPCdpc=7, nodeId=1, processNumber=81 ci=23587686, branch=0
06344658.003 |15:04:14.314 |AppInfo |SIPCdpc(7) - sendPolicyAndCACRegisterReq: capCount[2], videoCap[0], dataCap[0], MMCap[01], earlyOffer[2], latCaps[NULL]
06344658.004 |15:04:14.314 |AppInfo |DET-SDPMsg- sBandwidth:: enabledMask=0x2 as=0 ct=1000 tias=0 maxprate=0
06344658.005 |15:04:14.314 |AppInfo |DET-SDPMsg- sipp: ispres=1, role=1 vers=1 anat=0
06344658.006 |15:04:14.314 |AppInfo |DET-SDPMsg- ngroups 0
06344658.007 |15:04:14.314 |AppInfo |DET-SDPMsg- No Session level unrecognized attributes list.
06344658.008 |15:04:14.314 |AppInfo |DET-SDPMsg- nAudio=1, mDTMFP.PayloadNum=0
06344658.009 |15:04:14.314 |AppInfo |DET-SDPMsg- remoteIpAddr=10.27.1.132 remoteRtpPortNumber=55666 stackIdx=1 telephonyEvent=101 silenceSuppressionFlag=0 mSDPMode=0 idleFlag=0 mid=-1
06344658.010 |15:04:14.314 |AppInfo |DET-SDPMsg- CurrentStatus:: present=0 QoSStatusType=0 QoSDirectionTag=0
06344658.011 |15:04:14.314 |AppInfo |DET-SDPMsg- DesiredStatus:: present=0 QoSStatusType=0 QoSDirectionTag=0 QoSStrengthTag=2
06344658.012 |15:04:14.314 |AppInfo |DET-SDPMsg- ConfirmStatus:: present=0 QoSStatusType=0 QoSDirectionTag=0
06344658.013 |15:04:14.314 |AppInfo |DET-SDPMsg- RTP=1 SRTP=0 CapCount=2
06344658.014 |15:04:14.314 |AppInfo |DET-SDPMsg-4(20)
06344658.015 |15:04:14.314 |AppInfo |DET-SDPMsg-2(20)
06344658.016 |15:04:14.314 |AppInfo |DET-SDPMsg-v150LC(0,pt=0) t38LC(0)
06344658.017 |15:04:14.314 |AppInfo |DET-SDPMsg- TCL_UNSPECIFIED (0)
06344658.018 |15:04:14.314 |AppInfo |DET-SDPMsg- No unrecognized attributes list.
06344658.019 |15:04:14.314 |AppInfo |DET-SDPMsg- mAudiomLines(i).bandwidth.enabledMask=, TIAS=0, AS=0, CT=0, RS=0, RR=0
06344658.020 |15:04:14.314 |AppInfo |DET-SDPMsg- nVideo=0
06344658.021 |15:04:14.314 |AppInfo |DET-SDPMsg- nApp=0
06344658.022 |15:04:14.314 |AppInfo |DET-SDPMsg- nBFCPApp=0
06344658.023 |15:04:14.314 |AppInfo |DET-SDPMsg- nIXApp=0
06344658.024 |15:04:14.314 |AppInfo |SIPCdpc(7) - sendPolicyAndCACRegisterReq: preconditions: Not using preconditions, rsvpStatus[35] sdp[1]
06344658.025 |15:04:14.314 |AppInfo |Locations_getLocPKIDAndName -- loc= 1; pkid= 335f1d2e-6166-46ee-8d02-e450327b6fab; Name = Main_loc
06344659.000 |15:04:14.314 |SdlSig |PolicyAndCACRegisterReq |wait |ReservationMgr(1,100,110,1) |SIPCdpc(1,100,82,7) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] CI= 23587686 Branch= 0 reg=Main-711_dev cap=2 loc=1 MRGLPkid=93725f74-5c49-4fb9-afb7-78241a901320 PrecLev=5 bearerlessCall=F VCall=F MMCap=0x1 VCapCount=0 regiState=0 medReq=2 IsEmccD=F EmccDName=Lync1IP rcId= ipMode=0 eoType=2 getPort=F sRTP=F cryptocap=0 tm=16 DTMF(wantRecep=1 provOOB=0 suppMeth=2 Cfg=1 PT=101 reqMed=1) honorCodec=F distMed=F mediaEP=F rsvpQoSType=0 qosFallback=F status=35 sipOfferNeededInd=T hasSDP=TLatentCaps=null videoTrafficClass=4 nonPreemptable=F geolocInfo={geolocPkid=, filterPkid=, geolocVal=, devType=8} CAL={v=-1, m=-1, tDev=F, res=F, devType=0} locPkid=335f1d2e-6166-46ee-8d02-e450327b6fab locName=Main_loc deductBW=F fateShareId=StandAloneCluster:23587686 videoTrafficClass=Mixed lbmCACInfo: retryVideoAsAudio=T overrideRegionBW=F sideACmDeviceType=0 isNewPartyRegWithLBM=T videoReservedKbps=0 cacSpecificInfo.cacPartyState=0
06344659.001 |15:04:14.314 |AppInfo |ReservationMgr::wait_PolicyAndCACRegisterReq, Entries= 1, svcp::ConfidentialAccessLevelPolicy.get() = 0
06344660.000 |15:04:14.314 |SdlSig |SIPSPISignal |wait |SIPTcp(1,100,71,1) |SIPHandler(1,100,79,1) |1,100,14,1439.2^10.27.1.132^* |*TraceFlagOverrode
06344660.001 |15:04:14.314 |AppInfo |SIPTcp - wait_SdlSPISignal: Outgoing SIP TCP message to 10.27.1.132 on port 54010 index 96
[349722,NET]
SIP/2.0 100 Trying
Via: SIP/2.0/TCP 10.27.1.132:54010;branch=z9hG4bKab564143
From: "LyncTestUser1"<sip:lynctestuser1@xxx-xx.org>;epid=4C61DF0777;tag=b4c36b601b
To: <sip:96617356@pkx-ccm-pub.xxx-xx.org;user=phone>
Date: Wed, 15 Jun 2016 20:04:14 GMT
Call-ID: 33e3b2ff-cef1-497a-9e76-f5b7628f6c11
CSeq: 30 INVITE
Allow-Events: presence
Content-Length: 0


06344661.000 |15:04:14.315 |SdlSig |LBMRegisterReq |active |LBMInterface(1,100,176,1) |ReservationMgr(1,100,110,1) |1,100,14,1439.2^10.27.1.132^* |[T:N-H:0,N:0,L:0,V:0,Z:0,D:0] ci=23587686 location=1 locName=Main_loc locPkid=335f1d2e-6166-46ee-8d02-e450327b6fab fateShareId=StandAloneCluster:23587686 bearerless=F videoCall=F videoCap=F videoClass=4 videoKbp=0 retryAsAudio=T ipMode=0 mediaEP=F precedence=5 nonPreemptable=F region=Main-711_dev regState=0 XferMode=16 cacPartyState=0
06344661.001 |15:04:14.315 |AppInfo |LBMIF: CI: 23587686 REGISTER 1,100,82,7 dev 0x10850f50
06344662.000 |15:04:14.315 |SdlSig |LBMRegisterRes |wait |ReservationMgr(1,100,110,1) |LBMInterface(1,100,176,1) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] CI= 23587686 Branch= 0 Status=2 vCall=F DevicecontrolPid=1,100,82,7 DeviceCdpcPid=1,100,82,7 LBMCACReturnInfo: lbmReservedKbps=0 locationIsPhantom=F bwPreemption=F
06344662.001 |15:04:14.315 |AppInfo |ReservationMgr::wait_LBMRegisterRes, sendingCrp = (1, 100, 82, 7)
06344662.002 |15:04:14.315 |Created | | |RSVPSession(1,100,107,42) |ReservationMgr(1,100,110,1) | |NumOfCurrentInstances: 1
06344663.000 |15:04:14.315 |SdlSig |RSVPRegisterReq |await_init |RSVPSession(1,100,107,42) |ReservationMgr(1,100,110,1) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] CI= 23587686 Branch= 0 reg=Main-711_dev cap=2 loc=1 MRGLPkid=93725f74-5c49-4fb9-afb7-78241a901320 PrecLev=5 bearerlessCall=F VCall=F MMCap=0x1 VCapCount=0 regiState=0 medReq=2 IsEmccD=F EmccDName=Lync1IP rcId= ipMode=0 eoType=2 getPort=F sRTP=F cryptocap=0 tm=16 DTMF(wantRecep=1 provOOB=0 suppMeth=2 Cfg=1 PT=101 reqMed=1) honorCodec=F distMed=F mediaEP=F rsvpQoSType=0 qosFallback=F status=35 sipOfferNeededInd=T hasSDP=TLatentCaps=null videoTrafficClass=4 nonPreemptable=F
06344663.001 |15:04:14.315 |AppInfo |RSVP(1,42) -await_init_RSVPRegisterReq- SDPMsg
06344663.002 |15:04:14.315 |AppInfo |DET-SDPMsg- sBandwidth:: enabledMask=0x2 as=0 ct=1000 tias=0 maxprate=0
06344663.003 |15:04:14.315 |AppInfo |DET-SDPMsg- sipp: ispres=1, role=1 vers=1 anat=0
06344663.004 |15:04:14.315 |AppInfo |DET-SDPMsg- ngroups 0
06344663.005 |15:04:14.315 |AppInfo |DET-SDPMsg- No Session level unrecognized attributes list.
06344663.006 |15:04:14.315 |AppInfo |DET-SDPMsg- nAudio=1, mDTMFP.PayloadNum=0
06344663.007 |15:04:14.315 |AppInfo |DET-SDPMsg- remoteIpAddr=10.27.1.132 remoteRtpPortNumber=55666 stackIdx=1 telephonyEvent=101 silenceSuppressionFlag=0 mSDPMode=0 idleFlag=0 mid=-1
06344663.008 |15:04:14.315 |AppInfo |DET-SDPMsg- CurrentStatus:: present=0 QoSStatusType=0 QoSDirectionTag=0
06344663.009 |15:04:14.315 |AppInfo |DET-SDPMsg- DesiredStatus:: present=0 QoSStatusType=0 QoSDirectionTag=0 QoSStrengthTag=2
06344663.010 |15:04:14.315 |AppInfo |DET-SDPMsg- ConfirmStatus:: present=0 QoSStatusType=0 QoSDirectionTag=0
06344663.011 |15:04:14.315 |AppInfo |DET-SDPMsg- RTP=1 SRTP=0 CapCount=2
06344663.012 |15:04:14.315 |AppInfo |DET-SDPMsg-4(20)
06344663.013 |15:04:14.315 |AppInfo |DET-SDPMsg-2(20)
06344663.014 |15:04:14.315 |AppInfo |DET-SDPMsg-v150LC(0,pt=0) t38LC(0)
06344663.015 |15:04:14.315 |AppInfo |DET-SDPMsg- TCL_UNSPECIFIED (0)
06344663.016 |15:04:14.315 |AppInfo |DET-SDPMsg- No unrecognized attributes list.
06344663.017 |15:04:14.315 |AppInfo |DET-SDPMsg- mAudiomLines(i).bandwidth.enabledMask=, TIAS=0, AS=0, CT=0, RS=0, RR=0
06344663.018 |15:04:14.315 |AppInfo |DET-SDPMsg- nVideo=0
06344663.019 |15:04:14.315 |AppInfo |DET-SDPMsg- nApp=0
06344663.020 |15:04:14.315 |AppInfo |DET-SDPMsg- nBFCPApp=0
06344663.021 |15:04:14.315 |AppInfo |DET-SDPMsg- nIXApp=0
06344664.000 |15:04:14.315 |SdlSig |RSVPRegisterRes |wait |ReservationMgr(1,100,110,1) |RSVPSession(1,100,107,42) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] CI= 23587686 Branch= 0 Status=1 rsvpPol=0 vCall=F e2eRSVPInserted=F eoStatus=0 mediaFailureCause=0 mediaPassThruCapable=T fallbackLocal=F hasSDPMsg=F DevicecontrolPid=1,100,82,7 DeviceCdpcPid=1,100,82,7 RSVPAgent: confID =0 ci =0 capCt =0 reg= mtpType =2 agentCt =0 mmCapSet=0 agentAllo =0 RemoAgent=F DevCap=0 ipAddrMode=0
06344665.000 |15:04:14.315 |SdlSig |PolicyAndCACRegisterRes |inCall_waitRSVPRes |SIPCdpc(1,100,82,7) |ReservationMgr(1,100,110,1) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] CI= 23587686 Branch= 0 Status=1 Status=1 rsvpPol=0 vCall=F e2eRSVPInserted=F eoStatus=0 mediaFailureCause=0 mediaPassThruCapable=T fallbackLocal=F hasSDPMsg=F DevicecontrolPid=1,100,82,7 DeviceCdpcPid=1,100,82,7 RSVPAgent: confID =0 ci =0 capCt =0 reg= mtpType =2 agentCt =0 mmCapSet=0 agentAllo =0 RemoAgent=F DevCap=0 ipAddrMode=0 LBMCACReturnInfo: lbmReservedKbps=0 locationIsPhantom=F bwPreemption=F CAL={v=-1, m=-1, tDev=F, res=F, devType=0}
06344665.001 |15:04:14.315 |AppInfo |setEndpointsDtmfCaps: Detected inband DTMF support.
06344665.002 |15:04:14.315 |AppInfo |SIP DTMF Info: mLocalDtmfCaps...UNSOL=1, KPML=0, Inband=0(0) mEndppointsDtmfCaps...UNSOL=0, KPML=0, Inband=1(101) mDefaultTelephonyEvent=101, mDtmfPreference=1, mMtpAllocated=0
06344665.003 |15:04:14.315 |AppInfo |SIPCdpc(7) - getDefAe: SIPCdpc=7, nodeId=1, processNumber=81 ci=23587686, branch=0
06344665.004 |15:04:14.315 |AppInfo |$URI SIPCdpc::processSIPSetupMsg calledNumber=96617356 URIDisambiguationPolicy=DNIfOnlyDigitStarPlus BypassDisambiguation=true
06344665.005 |15:04:14.315 |AppInfo |SIPCdpc(7) - getIdentityIncomingSIPMsg: fIdParseRes=[1], fRemoteNum[lynctestuser1], fRemoteName[LyncTestUser1], fRemoteUser[], fRemoteHostname[xxx-xx.org], fHasBlended[false], fUserEqPhone[false], fRemoteNumPi[1], fRemoteNamPi[1], fRemoteSi[0]
06344665.006 |15:04:14.315 |AppInfo |SIPCdpc(7) - getIdentityIncomingSIPMsg: HCSCLLConfig = 0
06344665.007 |15:04:14.315 |AppInfo |SIPCdpc(7) - processRemoteIdentityInfo: host=xxx-xx.org,remotehost=;
06344665.008 |15:04:14.315 |AppInfo |SIPCdpc(7) - processRemoteIdentityInfo: identityFlag=[Changed:- Num;]
06344665.009 |15:04:14.315 |AppInfo |SIPCdpc(7) - preProcessOffer: audiomLines[0]: rtp=1,srtp=0,deviceNOTSrtpCapable=1,numCrypto=0,isOfferFromCCM=0,sipEndpointCanRcvSrtpOffers=0,deviceSupportsSrtpFB=0,telephone-event=101
06344665.010 |15:04:14.315 |AppInfo |SIPCdpc(7) - getDefCcRegister: Secure status=1, mSrtpPresent=0
06344665.011 |15:04:14.315 |AppInfo |SIPCdpc(7) - getEOType: EO Type is set to 0
06344665.012 |15:04:14.315 |AppInfo |Calling Party (callingNumber) info in SIPSetupIndMsg: nd=lynctestuser1, mUser=, mHost=xxx-xx.org, TypeOfId=DN
06344665.013 |15:04:14.315 |AppInfo |SIPCdpc(0) - globalizeCdpn: SPROC globalizeCdpn calledunknown CSS = , unknownPrefix=Default, unknownStrip=0
06344665.014 |15:04:14.315 |AppInfo |Called Party (cdpn) info in CcSetupIndMsg: nd=96617356, mUser=96617356, mHost=pkx-ccm-pub.xxx-xx.org, TypeOfId=DN
06344665.015 |15:04:14.315 |AppInfo |SIPCdpc(7) - getDefCcSetupInd: No Replaces header is Present
06344665.016 |15:04:14.315 |AppInfo |CMSIPUtility::decodeRPHdr - no RP Header received, so namespace & priority string unknown, defaulting to precDmn of 0 and normalized priority of 5
06344665.017 |15:04:14.315 |AppInfo |Locations_getLocPKIDAndName -- loc= 1; pkid= 335f1d2e-6166-46ee-8d02-e450327b6fab; Name = Main_loc
06344665.018 |15:04:14.315 |AppInfo |SIPCdpc(7) - processSIPSetupInd: Before Calling processCallInfoHeaderforTelepresenceConferencing
06344665.019 |15:04:14.315 |AppInfo |SIPCdpc(7) - processCallInfoHeaderforTelepresenceConferencing: Just Before parsing Call-Info Header
06344665.020 |15:04:14.315 |AppInfo |SIPCdpc(7) - extractGuidHeader: guid Header = 53DAF880000100000000000702007F0A
06344665.021 |15:04:14.315 |AppInfo |SIPCdpc(7) - inCall_waitRSVPRes_PolicyAndCACRegisterRes: offAns: sip/cm=1/-1
06344666.000 |15:04:14.315 |SdlSig |CcRegisterPartyA |wait |Cc(1,100,220,1) |SIPCdpc(1,100,82,7) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:2,L:0,V:0,Z:0,D:0] CI=23587686 CI.branch=0 CSS=59a7d9c2-927c-4fe2-8468-c5622dde9643 AdjunctCSS= cssIns=0 aarCSS= aarDev=T FQDN=pi=0si1 CallRef=0 OLC=1 Name=locale: 1 Name: LyncTestUser1 UnicodeName: pi: 1 encodeType=0 qsig-encodeType=10 ConnType=3 XferMode=16 ConnTime=0 nwLoc=2IpAddrMode=0 ipAddrType=0 ipv4=10.27.1.132:54010 region=Main-711_dev capCount=2 devType=8 mixerCId=0 mediaReq=2 portToPort.loc=1 MOH.MRGLPkid=93725f74-5c49-4fb9-afb7-78241a901320 MOH.userHoldID=0 MOH.netHoldID=0 MOH.supp=0 devName=Lync1IP mobileDevName= mobilePartyNumber=pi=0si1 mobileCallType=0 ctiActive=F ctiFarEndDev=2 ctiCCMId=1 devCepn=a077f3bb-64b4-04a2-7d33-c7f5149ce532 lineCepn= activeCaps=0 VideoCall=F MMUpdateCapMask=0x3e MMCap=0x1 SipConfig: BFCPAllowed=F IXAllowed=F devCap=0 CryptoCapCount=0 secure=1 loginId= UnicodeName: retriedVideo=FFromTag=b4c36b601bToTag=122272~6e112458-9282-456d-afd8-f2cf56a822cc-23587686CallId=33e3b2ff-cef1-497a-9e76-f5b7628f6c11 UAPortFlag=F wantDTMFRecep=1 provOOB=0 supp DTMF=2 DTMF Cfg=1 DTMF PT=101 DTMF reqMed=1 isPrefAltScript=F cdpnPatternUsage=0 audioPtyId=0 doNotAppendLineCSS=F callingDP=31b107fb-9f92-40b3-bd55-b182dbabce57 BCUpdate=0 ccBearCap.itc=0 ccBearCap.l=3 ccBearCap.itr=1 protected=1 flushCapIns=0 geolocInfo={geolocPkid=, filterPkid=, geolocVal=, devType=8} locPkid=335f1d2e-6166-46ee-8d02-e450327b6fab locName=Main_loc deductBW=F fateShareId=StandAloneCluster:23587686 videoTrafficClass=Mixed bridgeParticipantID callingUsr= remoteClusterID= isEMCCDevice=F dtmCall=F dtmPrimaryCI=0 dtmMediaIFPid=(0,0,0,0) dtmMcNodeId=0 dtmMTPForDTMFTranslation=F emc=T QSIGIMERoute=F eo=0 eoUpdt=0 vCTCUpdt=1 honorCodec=F honorUpdt=0 finalCalledPartition= cTypeUpdt=0 BibEnabled=0 RecordingQSIGAPDUSupported=F FarEndDeviceName=LatentCaps=null icidVal= icidGenAddr= oioi= tioi= ptParams= CAL={v=-1, m=-1, tDev=F, res=F, devType=0} displayNameUpdateFieldFlag=0 CFBCtrlSecIcon=F
06344666.001 |15:04:14.316 |Created | | |Cdcc(1,100,219,42) |Cc(1,100,220,1) | |NumOfCurrentInstances: 3
06344667.000 |15:04:14.316 |SdlSig |CcSetupInd |wait |Cc(1,100,220,1) |SIPCdpc(1,100,82,7) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:2,L:0,V:0,Z:0,D:0] CI=23587686 CI.branch=0 pli.plid=65 pli.l=1 pli.pl=5 pli.msd-0 FDataType=0opId=0ssType=0 SsKey=0invokeId=0resultExp=Fbpda=F pi.piid=30 pi.l=0 pi2.piid=30 pi2.l=0 pi3.piid=30 pi3.l=0 cgPart= cgPat= AAR=tn=0npi=0ti=1nd=lynctestuser1User=Host=xxx-xx.orgPort=0PassWord=Madder=Transport=4mDisplayName=RawUrl=OrigPort=0pi=1si0 cgpnVM= cgpnVMCSS= cgpnVMPNum= DD=pi=0si1 cdPart= cdPat= cdpn=tn=0npi=1ti=1nd=96617356User=96617356Host=pkx-ccm-pub.xxx-xx.orgPort=5060PassWord=Madder=Transport=4mDisplayName=RawUrl=sip:96617356@pkx-ccm-pub.xxx-xx.org;user=phoneOrigPort=0pi=0si1 cdpnVM= cdpnVMCSS= cdpnVMPNum= itrPart= itrPat= LRPart= LRPat= LR=pi=0si1 LRVM= LRVMCSS= LRVMPNum= LRFR=0 oPart= oPat= oCpdn=pi=0si1 oCdpnVM= oCdpnVMCSS= oCdpnVMPNum= oRFR=0 ts= posMatches= rdn.l=0IpAddrMode=0 ipAddrType=0 ipv4=10.27.1.132:54010 OLF=1 devType=8 devCap=1785130315 bc.l=3 bc.itr=1 bc.itc=0 bc.trm=0 bc.tm=16 maxForwards=69 featurePriority=1 nonTargetPolicy=0 networkDomain= bitMask=0 routeClass=1 linkedCi=0 IWFDI=F isPresent=F transitCount=0 IWFDI=F bridgeParticipantID= IGNI=0 tokens=0 oFromAnalogDvc=F originallyHadISUP=F uri=ti=1User=Host=Port=0PassWord=Madder=Transport=4mDisplayName=RawUrl=<sip:LyncFE01.xxx-xx.org:5060;transport=Tcp;maddr=10.27.1.132;ms-opaque=a90113d42f32e71c>OrigPort=0pi=0si1 M=Unknown ;rc=0 Hdrs= CanSupportSIPTandN=true TransId=0 AllowBitMask=0xf9 UserAgentOrServer=RTCC/5.0.0.0 MediationServer OrigDDName=locale: 1 Name: UnicodeName: pi: 0 mCallerId= mCallerName= icidVal= icidGenAddr= oioi= tioi= ptParams= receivedPAID= routeHdr= routeCepn= requestURI= PCVFlag=F IMSMode=0 GCI=1|2fdd3 featCallType=0 callingUserId= UnicodeName: associatedCallCI=0 hdrMOH=0
06344668.000 |15:04:14.316 |SdlSig |CcUpdateE2ECallRef |wait |Cc(1,100,220,1) |SIPCdpc(1,100,82,7) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:2,L:0,V:0,Z:0,D:0] CI=23587686 CI=23587686 E2Epcol=1E2EcallID=53DAF880000100000000000702007F0A
06344669.000 |15:04:14.316 |SdlSig |CcRegisterPartyA |tcc_idle0 |Cdcc(1,100,219,42) |Cc(1,100,220,1) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:2,L:0,V:0,Z:0,D:0] CI=23587686 CI.branch=0 CSS=59a7d9c2-927c-4fe2-8468-c5622dde9643 AdjunctCSS= cssIns=0 aarCSS= aarDev=T FQDN=pi=0si1 CallRef=0 OLC=1 Name=locale: 1 Name: LyncTestUser1 UnicodeName: pi: 1 encodeType=0 qsig-encodeType=10 ConnType=3 XferMode=16 ConnTime=0 nwLoc=2IpAddrMode=0 ipAddrType=0 ipv4=10.27.1.132:54010 region=Main-711_dev capCount=2 devType=8 mixerCId=0 mediaReq=2 portToPort.loc=1 MOH.MRGLPkid=93725f74-5c49-4fb9-afb7-78241a901320 MOH.userHoldID=0 MOH.netHoldID=0 MOH.supp=0 devName=Lync1IP mobileDevName= mobilePartyNumber=pi=0si1 mobileCallType=0 ctiActive=F ctiFarEndDev=2 ctiCCMId=1 devCepn=a077f3bb-64b4-04a2-7d33-c7f5149ce532 lineCepn= activeCaps=0 VideoCall=F MMUpdateCapMask=0x3e MMCap=0x1 SipConfig: BFCPAllowed=F IXAllowed=F devCap=0 CryptoCapCount=0 secure=1 loginId= UnicodeName: retriedVideo=FFromTag=b4c36b601bToTag=122272~6e112458-9282-456d-afd8-f2cf56a822cc-23587686CallId=33e3b2ff-cef1-497a-9e76-f5b7628f6c11 UAPortFlag=F wantDTMFRecep=1 provOOB=0 supp DTMF=2 DTMF Cfg=1 DTMF PT=101 DTMF reqMed=1 isPrefAltScript=F cdpnPatternUsage=0 audioPtyId=0 doNotAppendLineCSS=F callingDP=31b107fb-9f92-40b3-bd55-b182dbabce57 BCUpdate=0 ccBearCap.itc=0 ccBearCap.l=3 ccBearCap.itr=1 protected=1 flushCapIns=0 geolocInfo={geolocPkid=, filterPkid=, geolocVal=, devType=8} locPkid=335f1d2e-6166-46ee-8d02-e450327b6fab locName=Main_loc deductBW=F fateShareId=StandAloneCluster:23587686 videoTrafficClass=Mixed bridgeParticipantID callingUsr= remoteClusterID= isEMCCDevice=F dtmCall=F dtmPrimaryCI=0 dtmMediaIFPid=(0,0,0,0) dtmMcNodeId=0 dtmMTPForDTMFTranslation=F emc=T QSIGIMERoute=F eo=0 eoUpdt=0 vCTCUpdt=1 honorCodec=F honorUpdt=0 finalCalledPartition= cTypeUpdt=0 BibEnabled=0 RecordingQSIGAPDUSupported=F FarEndDeviceName=LatentCaps=null icidVal= icidGenAddr= oioi= tioi= ptParams= CAL={v=-1, m=-1, tDev=F, res=F, devType=0} displayNameUpdateFieldFlag=0 CFBCtrlSecIcon=F
06344669.001 |15:04:14.316 |AppInfo |Cdcc - (0000042) - storeDchanCrp - secure capability on side 0 is (1,1)
06344670.000 |15:04:14.316 |SdlSig |CcSetupInd |tcc_idle0 |Cdcc(1,100,219,42) |Cc(1,100,220,1) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:1,L:0,V:0,Z:0,D:0] CI=23587686 CI.branch=0 pli.plid=65 pli.l=1 pli.pl=5 pli.msd-0 FDataType=0opId=0ssType=0 SsKey=0invokeId=0resultExp=Fbpda=F pi.piid=30 pi.l=0 pi2.piid=30 pi2.l=0 pi3.piid=30 pi3.l=0 cgPart= cgPat= AAR=tn=0npi=0ti=1nd=lynctestuser1User=Host=xxx-xx.orgPort=0PassWord=Madder=Transport=4mDisplayName=RawUrl=OrigPort=0pi=1si0 cgpnVM= cgpnVMCSS= cgpnVMPNum= DD=pi=0si1 cdPart= cdPat= cdpn=tn=0npi=1ti=1nd=96617356User=96617356Host=pkx-ccm-pub.xxx-xx.orgPort=5060PassWord=Madder=Transport=4mDisplayName=RawUrl=sip:96617356@pkx-ccm-pub.xxx-xx.org;user=phoneOrigPort=0pi=0si1 cdpnVM= cdpnVMCSS= cdpnVMPNum= itrPart= itrPat= LRPart= LRPat= LR=pi=0si1 LRVM= LRVMCSS= LRVMPNum= LRFR=0 oPart= oPat= oCpdn=pi=0si1 oCdpnVM= oCdpnVMCSS= oCdpnVMPNum= oRFR=0 ts= posMatches= rdn.l=0IpAddrMode=0 ipAddrType=0 ipv4=10.27.1.132:54010 OLF=1 devType=8 devCap=1785130315 bc.l=3 bc.itr=1 bc.itc=0 bc.trm=0 bc.tm=16 maxForwards=69 featurePriority=1 nonTargetPolicy=0 networkDomain= bitMask=0 routeClass=1 linkedCi=0 IWFDI=F isPresent=F transitCount=0 IWFDI=F bridgeParticipantID= IGNI=0 tokens=0 oFromAnalogDvc=F originallyHadISUP=F uri=ti=1User=Host=Port=0PassWord=Madder=Transport=4mDisplayName=RawUrl=<sip:LyncFE01.xxx-xx.org:5060;transport=Tcp;maddr=10.27.1.132;ms-opaque=a90113d42f32e71c>OrigPort=0pi=0si1 M=Unknown ;rc=0 Hdrs= CanSupportSIPTandN=true TransId=0 AllowBitMask=0xf9 UserAgentOrServer=RTCC/5.0.0.0 MediationServer OrigDDName=locale: 1 Name: UnicodeName: pi: 0 mCallerId= mCallerName= icidVal= icidGenAddr= oioi= tioi= ptParams= receivedPAID= routeHdr= routeCepn= requestURI= PCVFlag=F IMSMode=0 GCI=1|2fdd3 featCallType=0 callingUserId= UnicodeName: associatedCallCI=0 hdrMOH=0
06344670.001 |15:04:14.316 |AppInfo |Cdcc::preliminaryProcessCcSetupInd(0000042): precLvl=5
06344670.002 |15:04:14.316 |AppInfo |Cdcc - ccSetupInd - ccSetupInd.bc.l=3, ccSetupInd.bc.uil1p=2, ccSetupInd.bc.ur=0, ccSetupInd.bc.sa=0,ir=0,notx=0,norx=0,fcotx=0,fcorx=0,nosb=0,nodb=0,parity=0
06344671.000 |15:04:14.316 |SdlSig |CcUpdateE2ECallRef |setup_da |Cdcc(1,100,219,42) |Cc(1,100,220,1) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:1,L:0,V:0,Z:0,D:0] CI=23587686 CI=23587686 E2Epcol=1E2EcallID=53DAF880000100000000000702007F0A
06344672.000 |15:04:14.316 |SdlSig |DaReq |wait |Da(1,100,211,1) |Cdcc(1,100,219,42) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] CI=23587686 Fqdn=pi=0si1 Cgpn=tn=0npi=0ti=1nd=lynctestuser1User=Host=xxx-xx.orgPort=0PassWord=Madder=Transport=4mDisplayName=RawUrl=OrigPort=0pi=1si0 DialedNum=tn=0npi=1ti=1nd=96617356User=96617356Host=pkx-ccm-pub.xxx-xx.orgPort=5060PassWord=Madder=Transport=4mDisplayName=RawUrl=sip:96617356@pkx-ccm-pub.xxx-xx.org;user=phoneOrigPort=0pi=0si1 requestID=0 DigitAnalysisComplexity=0 CallingUser= IgnoreIntercept=0
06344672.001 |15:04:14.316 |AppInfo |Digit Analysis: star_DaReq: daReq.partitionSearchSpace(59a7d9c2-927c-4fe2-8468-c5622dde9643), filteredPartitionSearchSpaceString(Internal_par:IPCC_par:Unity_par:Main-local_par:Main-LD_par:Main-911_par), partitionSearchSpaceString(MHCSupportAfterHours_par:Internal_par:IPCC_par:Unity_par:Main-local_par:Main-LD_par:Main-911_par)
06344672.002 |15:04:14.316 |AppInfo |Digit Analysis: Host Address=pkx-ccm-pub.xxx-xx.org DOES NOT MATCH any active CUCM node in this cluster.
06344672.003 |15:04:14.316 |AppInfo |Digit Analysis: Host Address=pkx-ccm-pub.xxx-xx.org DOES NOT MATCH top level org domain.
06344672.004 |15:04:14.317 |AppInfo |Digit Analysis: star_DaReq: Matching SIP URL, Host Domain, host=gro.nt-chm.bup-mcc-xkp
06344672.005 |15:04:14.317 |AppInfo |Digit Analysis: getDaRes data: daRes.ssType=[0] Intercept DAMR.sstype=[0], TPcount=[0], DAMR.NotifyCount=[0], DaRes.NotifyCount=[0]
06344672.006 |15:04:14.317 |AppInfo |Digit Analysis: getDaRes - Remote Destination [] isURI[1]
06344672.007 |15:04:14.317 |AppInfo |Digit analysis: patternUsage=2
06344672.008 |15:04:14.317 |AppInfo |Digit analysis: match(pi="2",fqcn="", cn="lynctestuser1", plv="5", pss="MHCSupportAfterHours_par:Internal_par:IPCC_par:Unity_par:Main-local_par:Main-LD_par:Main-911_par", TodFilteredPss="Internal_par:IPCC_par:Unity_par:Main-local_par:Main-LD_par:Main-911_par", dd="96617356",dac="0")
06344672.009 |15:04:14.317 |AppInfo |Digit analysis: potentialMatches=NoPotentialMatchesExist
06344673.000 |15:04:14.317 |SdlSig |DaRes |setup_da |Cdcc(1,100,219,42) |Da(1,100,211,1) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] CI=23587686 Block NoPotentialMatchesExist OnNetpatternUsage =2requestID =0
06344673.001 |15:04:14.317 |Created | | |MatrixControl(1,100,142,43) |Cdcc(1,100,219,42) | |NumOfCurrentInstances: 1
06344674.000 |15:04:14.317 |SdlSig |DropPartyReq |await_command |MatrixControl(1,100,142,43) |Cdcc(1,100,219,42) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] ClearType= 0
06344675.000 |15:04:14.317 |SdlSig |MediaDisconnectRequest |wait |ConnectionManager(1,100,214,1) |MatrixControl(1,100,142,43) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] CI1=23587686 CI2=0 sc=0 disconnType=1 ssReason=0 clearType=0 IF1Created=F IF2Created=F party1.mMediaCoordinatorNodeId=0 party2.mMediaCoordinatorNodeId=0 party1.dtmCall= dtm.mode=0 dtm.CI=0 dtm.MTPForDTMF=F party2.dtmCall= dtm.mode=0 dtm.CI=0 dtm.MTPForDTMF=F reconnectPending=F forceStopCI=0
06344675.001 |15:04:14.317 |AppInfo |!!ERROR!! -ConnectionManager- wait_MediaDisconnectRequest :CI NOT FOUND IN TABLE,CI(23587686,0),discType=1,IFCreated(0,0),PID(0-0,0-0),IFHandling(0,0),MCNode(0,0)
06344676.000 |15:04:14.317 |SdlSig |MediaDisconnectReply |dissolving |MatrixControl(1,100,142,43) |ConnectionManager(1,100,214,1) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] CI1=23587686 CI2=0 sc=245 disconnType=1 ssReason=0 clearType=0 IF1Created=F IF2Created=F party1.mMediaCoordinatorNodeId=0 party2.mMediaCoordinatorNodeId=0 party1.dtmCall= dtm.mode=0 dtm.CI=0 dtm.MTPForDTMF=F party2.dtmCall= dtm.mode=0 dtm.CI=0 dtm.MTPForDTMF=F reconnectPending=F forceStopCI=0
06344676.001 |15:04:14.317 |AppInfo |MatrixControl:updatePartyMediaCoordinatorNodeId: party1 videoCapable=0, party 2 videocapable=0
06344676.002 |15:04:14.317 |Stopping | | |MatrixControl(1,100,142,43) |MatrixControl(1,100,142,43) | |NumOfCurrentInstances: 1
06344677.000 |15:04:14.317 |SdlSig |DropErr |call_blocked_clearing_profile |Cdcc(1,100,219,42) |MatrixControl(1,100,142,43) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] MediaStatusCode= 245
06344678.000 |15:04:14.317 |SdlSig |CcDisconnReq |restart0 |SIPD(1,100,81,4) |Cdcc(1,100,219,42) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] CI=23587686 CI.branch=0 clearType=0 c.l=1 c.cid=8 c.cs=0 c.lc=0 c.r=0 cv=1 FDataType=0opId=0ssType=0 SsKey=0invokeId=0resultExp=Fbpda=F OnBehalf=Device rfr=0 localPatternUsage=2 connectedPatternUsage=2 rdDestPart= rdDestPatt= rdDestCdpn=pi=0si1 lrnCepn= redDestName=locale: 1 Name: UnicodeName: pi: 0 annId=0 lHPMemCEPN= cHPMemCEPN= dtmCall=F dtmDisconn=F dtmMcNodeId=0 forcedClear=F TransparentData=null CanSupportSIPTandN=false TransId=0 AllowBitMask=0x0 UserAgentOrServer= OrigDDName=locale: 1 Name: UnicodeName: pi: 0 mCallerId= mCallerName= mediaCause=0 CAL={v=ffffffff, m=ffffffff, tDev=F, res=F, devType=0} CAL={v=fffffff6, m=ffffffff, tDev=F, res=F, devType=0}
06344678.001 |15:04:14.317 |AppInfo |SIPD(4) - getKeyBasedOnCiAndBranch: AddressingElement branch is 0 and ci is 23587686 mapKey is 23587686
06344678.002 |15:04:14.317 |AppInfo |SIPD(4) - getCdpcPid: found Cdpc Pid (1,100,82,7) for mapKey 23587686
06344679.000 |15:04:14.317 |SdlSig |CcDisconnReq |inCall_inviteRcvd |SIPCdpc(1,100,82,7) |SIPD(1,100,81,4) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] CI=23587686 CI.branch=0 clearType=0 c.l=1 c.cid=8 c.cs=0 c.lc=0 c.r=0 cv=1 FDataType=0opId=0ssType=0 SsKey=0invokeId=0resultExp=Fbpda=F OnBehalf=Device rfr=0 localPatternUsage=2 connectedPatternUsage=2 rdDestPart= rdDestPatt= rdDestCdpn=pi=0si1 lrnCepn= redDestName=locale: 1 Name: UnicodeName: pi: 0 annId=0 lHPMemCEPN= cHPMemCEPN= dtmCall=F dtmDisconn=F dtmMcNodeId=0 forcedClear=F TransparentData=null CanSupportSIPTandN=false TransId=0 AllowBitMask=0x0 UserAgentOrServer= OrigDDName=locale: 1 Name: UnicodeName: pi: 0 mCallerId= mCallerName= mediaCause=0 CAL={v=ffffffff, m=ffffffff, tDev=F, res=F, devType=0} CAL={v=fffffff6, m=ffffffff, tDev=F, res=F, devType=0}
06344679.001 |15:04:14.317 |AppInfo |SIPCdpc(7) - appendReasonHdr: appendReasonHdr - Invalid Disconnect Cause(cause=1), No Reason Header Appended
06344679.002 |15:04:14.317 |AppInfo |SIPCdpc(7) - addTransparencyInfo: Transparency info is NULL. Not attaching anything.
06344679.003 |15:04:14.317 |AppInfo |SIPCdpc(7) - appendRPIDHdrForOriginalCalledParty: SIP device does not Support Orig Dialled Phone nego: 0
06344680.000 |15:04:14.317 |SdlSig |DbCdrReq |wait |EnvProcessCdr(1,100,249,1) |Cdcc(1,100,219,42) |1,100,14,1439.2^10.27.1.132^* |[T:N-H:0,N:0,L:0,V:0,Z:0,D:0] 01000000 01000000 d3fd0200 66eb6701 beb46157 01000000 66eb6701 0a1b0184 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 01000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00696768 4c796e63 31495000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00cb9ee5 00000000 04000000 00000000 00000000 00000000 00000000 00323d30 00000000 00537461 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00647265 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 67eb6701 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000017 00000000 04000000 00000000 00000000 00000000 866e6368 14000003 8734624b 14000003 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 14000003 8e643232 00000000 8f386332 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 beb46157 00000000 02000000 00000000 00000000 02000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 6c796e63 74657374 75736572 31000000 4960a9e5 3c60a9e5 3198fae5 00000000 00000000 00000000 3098fae5 1898fae5 00000000 00000000 00000000 00000000 6c60a9e5 6c60a9e5 00000000 00000000 0820b9e5 39363631 37333536 00000000 00000000 9860a9e5 9060a9e5 407569e7 00000000 00000000 00000000 3f7569e7 207569e7 00000000 00000000 00000000 00000000 c060a9e5 c060a9e5 00000000 00000000 00000000 39363631 37333536 00000000 00000000 ec60a9e5 e460a9e5 981727e6 00000000 00000000 00000000 971727e6 781727e6 00000000 00000000 585092e5 39363631 37333536 00000000 00000000 2861a9e5 2061a9e5 202f6ce6 00000000 00000000 00000000 1f2f6ce6 002f6ce6 00000000 00000000 688773e5 d01173e6 00000000 00cf9810 00000000 00000000 6061a9e5 6061a9e5 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00313533 00000000 00370000 00000000 9461a9e5 9461a9e5 00000000 00000000 00000000 08080000 ac61a9e5 ac61a9e5 31302e32 372e312e 31333200 6047e609 cf61a9e5 c461a9e5 00000000 64000000 0e000000 30040000 dc61a9e5 dc61a9e5 01000000 980a58e6 00000000 00000000 00000000 00020031 302e3132 352e312e 33000000 0862a9e5 0862a9e5 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 3862a9e5 3862a9e5 00000000 01000000 206d92e5 00040000 5062a9e5 5062a9e5 00000000
06344680.001 |15:04:14.317 |AppInfo |EnvProcessCdr::wait_DbCdrReq
06344681.000 |15:04:14.318 |SdlSig |SIPDisconnReq |wait |SIPHandler(1,100,79,1) |SIPCdpc(1,100,82,7) |1,100,14,1439.2^10.27.1.132^* |[T:N-H:0,N:0,L:0,V:0,Z:0,D:0] CcbId= 122272 --TransType=1 --TransSecurity=0 PeerAddr = 10.27.1.132:54010 ccCause= 1 sip_disc_cause= 0
06344681.001 |15:04:14.318 |AppInfo |//SIP/Stack/Info/0x0/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 (SIP_APPLICATION_MSG), for event 8 (SIPSPI_EV_CC_CALL_DISCONNECT)
06344681.002 |15:04:14.318 |AppInfo |//SIP/Stack/Info/0x0x106e4058/act_recdinvite_disconnect: Performing disconnect
06344681.003 |15:04:14.318 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: timerContext=0x106e505c type=SIP_TIMER_EXPIRES value=1800000 retries=0
06344681.004 |15:04:14.318 |AppInfo |//SIP/Stack/Info/0x0x106e4058/sipSPIUaddCcbToTable: Added to table. ccb=0x106e4058 key=33e3b2ff-cef1-497a-9e76-f5b7628f6c11122272~6E112458-9282-456D-AFD8-F2CF56A822CC-23587686
06344681.005 |15:04:14.318 |AppInfo |//SIP/Stack/Info/0x0x106e4058/sipSPISendInviteResponse: Associated container=0xe587bf28 to Invite Response 404
06344681.006 |15:04:14.318 |AppInfo |//SIP/Stack/Transport/0x0x106e4058/sipSPITransportSendMessage: msg=0x10851208, addr=10.27.1.132, port=54010, sentBy_port=54010, is_req=0, tran
06344681.007 |15:04:14.318 |AppInfo |//SIP/Stack/Transport/0x0/sipInstanceGetConnectionId: gcb=0x106e4058 is already on connection=0xfaa7a18 context_list
06344681.008 |15:04:14.318 |AppInfo |//SIP/Stack/Transport/0x0x106e4058/sipTransportLogicSendMsg: Connection obtained...sending msg=0x10851208
06344681.009 |15:04:14.318 |AppInfo |//SIP/Stack/Transport/0x0x106e4058/sipTransportPostSendMessage: Posting send for msg=0x10851208, addr=10.27.1.132, port=54010, connId=96 for
06344681.010 |15:04:14.318 |AppInfo |//SIP/Stack/Info/0x0x106e4058/sentErrResDisconnecting: Sent an 3456XX Error Response
06344681.011 |15:04:14.318 |AppInfo |//SIP/Stack/States/0x0x106e4058/sipSPIChangeState: 0x106e4058 : State change from (STATE_RECD_INVITE, SUBSTATE_NONE) to (STATE_DISCONNECTING, SUBSTATE_NONE)
06344681.012 |15:04:14.318 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: timerContext=0x106e5038 type=SIP_TIMER_CONNECT value=500 retries=6
06344681.013 |15:04:14.318 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: timerContext=0x106e5038 type=SIP_TIMER_CONNECT value=500 retries=6
06344682.000 |15:04:14.319 |SdlSig |SIPSPISignal |wait |SIPTcp(1,100,71,1) |SIPHandler(1,100,79,1) |1,100,14,1439.2^10.27.1.132^* |*TraceFlagOverrode
06344682.001 |15:04:14.319 |AppInfo |SIPTcp - wait_SdlSPISignal: Outgoing SIP TCP message to 10.27.1.132 on port 54010 index 96
[349723,NET]
SIP/2.0 404 Not Found
Via: SIP/2.0/TCP 10.27.1.132:54010;branch=z9hG4bKab564143
From: "LyncTestUser1"<sip:lynctestuser1@xxx-xx.org>;epid=4C61DF0777;tag=b4c36b601b
To: <sip:96617356@pkx-ccm-pub.xxx-xx.org;user=phone>;tag=122272~6e112458-9282-456d-afd8-f2cf56a822cc-23587686
Date: Wed, 15 Jun 2016 20:04:14 GMT
Call-ID: 33e3b2ff-cef1-497a-9e76-f5b7628f6c11
CSeq: 30 INVITE
Allow-Events: presence
Reason: Q.850;cause=1
Server: Cisco-CUCM10.5
Content-Length: 0


06344683.000 |15:04:14.320 |SdlSig |SdlReadRsp |wait |SIPTcp(1,100,71,1) |SdlTCPConnection(1,100,14,1439) |1,100,14,1439.3^10.27.1.132^* |*TraceFlagOverrode
06344683.001 |15:04:14.320 |AppInfo |SIPTcp - SdlRead bufferLen=414
06344683.002 |15:04:14.320 |AppInfo |SIPTcp - wait_SdlReadRsp: Incoming SIP TCP message from 10.27.1.132 on port 54010 index 96 with 414 bytes:
[349724,NET]
ACK sip:96617356@pkx-ccm-pub.xxx-xx.org;user=phone SIP/2.0
FROM: "LyncTestUser1"<sip:lynctestuser1@xxx-xx.org>;tag=b4c36b601b;epid=4C61DF0777
TO: <sip:96617356@pkx-ccm-pub.xxx-xx.org;user=phone>;tag=122272~6e112458-9282-456d-afd8-f2cf56a822cc-23587686
CSEQ: 30 ACK
CALL-ID: 33e3b2ff-cef1-497a-9e76-f5b7628f6c11
MAX-FORWARDS: 70
VIA: SIP/2.0/TCP 10.27.1.132:54010;branch=z9hG4bKab564143
CONTENT-LENGTH: 0


06344683.003 |15:04:14.320 |AppInfo |SIPTcp - SignalCounter = 155919
06344684.000 |15:04:14.321 |SdlSig |SIPNormalizeRes |wait |SIPHandler(1,100,79,1) |SIPNormalization(1,100,78,1) |1,100,14,1439.3^10.27.1.132^* |*TraceFlagOverrode
06344684.001 |15:04:14.321 |AppInfo |//SIP/Stack/Info/0x0/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 (SIP_NETWORK_MSG), for event 1 (SIPSPI_EV_NEW_MESSAGE)
06344684.002 |15:04:14.321 |AppInfo |//SIP/Stack/Transport/0x0/sipTransportProcessNWNewConnMsg: context=(nil)
06344684.003 |15:04:14.321 |AppInfo |//SIP/Stack/Transport/0x0/sipConnectionManagerProcessNewConnMsg: gConnTab=0xfaa5358, addr=10.27.1.132, port=54010, connid=96, transport=TCP
06344684.004 |15:04:14.321 |AppInfo |//SIP/Stack/Info/0x0/sipHolderGetConnInstance: Return existing connection for port 54010 connId 96
06344684.005 |15:04:14.321 |AppInfo |//SIP/Stack/Info/0x0x106e4058/sipSPIFindCcbUASRespTable: *****CCB found in UAS Response table. ccb=0x106e4058
06344684.006 |15:04:14.321 |AppInfo |//SIP/Stack/Transport/0x0/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.27.1.132,Port 54010, Transport 2, SentBy Port 5060
06344684.007 |15:04:14.321 |AppInfo |//SIP/Stack/Transport/0x0/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.27.1.132,Port 54010, Transport 2, SentBy Port 54010
06344684.008 |15:04:14.321 |AppInfo |//SIP/SIPHandler/ccbId=122272/scbId=0/findDevicePID: Routed to SIPD by ccbId/scbId
06344684.009 |15:04:14.321 |AppInfo |//SIP/Stack/States/0x0x106e4058/sipSPIChangeState: 0x106e4058 : State change from (STATE_DISCONNECTING, SUBSTATE_NONE) to (STATE_DEAD, SUBSTATE_NONE)
06344684.010 |15:04:14.321 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: timerContext=0x106e5038 type=SIP_TIMER_CONNECT value=500 retries=6
06344684.011 |15:04:14.321 |AppInfo |//SIP/Stack/Info/0x0x106e4058/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue that are going to b
06344684.012 |15:04:14.321 |AppInfo |//SIP/Stack/Transport/0x0/sipConnectionManagerUnregisterCtxtInCon: gConnTab=0xfaa5358, addr=10.27.1.132, port=54010, unregistering context=
06344684.013 |15:04:14.321 |AppInfo |//SIP/Stack/Info/0x0x106e4058/sipSPIUfreeOneCCB: Freeing ccb 106e4058
06344685.000 |15:04:14.321 |SdlSig |SIPRelCompInd |restart0 |SIPD(1,100,81,4) |SIPHandler(1,100,79,1) |1,100,14,1439.3^10.27.1.132^* |[R:N-H:0,N:1,L:0,V:0,Z:0,D:0] CcbId= 122272 --TransType=1 --TransSecurity=0 PeerAddr = 10.27.1.132:54010
06344685.001 |15:04:14.321 |AppInfo |SIPD(4) - restart0_SIPRelCompInd: Ccbid 122272 and Ci 0
06344686.000 |15:04:14.321 |SdlSig |SIPRelCompInd |disconnectSent |SIPCdpc(1,100,82,7) |SIPD(1,100,81,4) |1,100,14,1439.3^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] CcbId= 122272 --TransType=1 --TransSecurity=0 PeerAddr = 10.27.1.132:54010
06344686.001 |15:04:14.321 |AppInfo |ViprUtils::uploadVCRifRequired VcrUploadNeeded[1] FeatureData NOT added
06344686.002 |15:04:14.321 |AppInfo |SIPCdpc(7) - uploadVCRifRequired: VcrUploadNeeded 1
06344686.003 |15:04:14.321 |AppInfo |SIPCdpc(7) - updateCallStatsForCallCompletion: SIPCdpc=7, nodeId=1, processNumber=81
06344686.004 |15:04:14.321 |AppInfo |SIPCdpc(7) - terminateOobDtmf: Termination not required.
06344687.000 |15:04:14.321 |SdlSig |CcRelInd |wait |Cc(1,100,220,1) |SIPCdpc(1,100,82,7) |1,100,14,1439.3^10.27.1.132^* |[R:N-H:0,N:2,L:0,V:0,Z:0,D:0] CI=23587686 CI.branch=0 c.l=1 c.cid=8 c.cs=0 c.lc=0 c.r=0 CV=1 isDeskPickup=F dtmDisconn=F FDataType=0opId=0ssType=0 SsKey=0invokeId=0resultExp=Fbpda=FTransparentData=null CanSupportSIPTandN=false TransId=0 AllowBitMask=0x0 UserAgentOrServer= OrigDDName=locale: 1 Name: UnicodeName: pi: 0 mCallerId= mCallerName=
06344688.000 |15:04:14.321 |SdlSig |PolicyAndCACUnregisterReq |wait |ReservationMgr(1,100,110,1) |SIPCdpc(1,100,82,7) |1,100,14,1439.3^10.27.1.132^* |[R:N-H:0,N:2,L:0,V:0,Z:0,D:0] CI= 23587686 ClearType=0
06344689.000 |15:04:14.321 |SdlSig |DStopInd |restart0 |SIPD(1,100,81,4) |SIPCdpc(1,100,82,7) |1,100,14,1439.3^10.27.1.132^* |[R:N-H:0,N:3,L:0,V:0,Z:0,D:0]
06344689.001 |15:04:14.321 |AppInfo |SIPD(4) - restart0_DStopInd: Removing Cdpc Pid (1,100,82,7) with mapKey 0 from mCiToPid table
06344690.000 |15:04:14.321 |SdlSig |CcRelInd |tcc_await_incoming_release8 |Cdcc(1,100,219,42) |Cc(1,100,220,1) |1,100,14,1439.3^10.27.1.132^* |[R:N-H:0,N:3,L:0,V:0,Z:0,D:0] CI=23587686 CI.branch=0 c.l=1 c.cid=8 c.cs=0 c.lc=0 c.r=0 CV=1 isDeskPickup=F dtmDisconn=F FDataType=0opId=0ssType=0 SsKey=0invokeId=0resultExp=Fbpda=FTransparentData=null CanSupportSIPTandN=false TransId=0 AllowBitMask=0x0 UserAgentOrServer= OrigDDName=locale: 1 Name: UnicodeName: pi: 0 mCallerId= mCallerName=
06344690.001 |15:04:14.321 |AppInfo |processCCMFeatureData: operationIeIdd=0
06344691.000 |15:04:14.321 |SdlSig |CACUnregisterReq |await_associate |RSVPSession(1,100,107,42) |ReservationMgr(1,100,110,1) |1,100,14,1439.3^10.27.1.132^* |[R:N-H:0,N:3,L:0,V:0,Z:0,D:0] CI= 23587686 ClearType=0
06344692.000 |15:04:14.321 |SdlSig |DStopConf |stop_indication |SIPCdpc(1,100,82,7) |SIPD(1,100,81,4) |1,100,14,1439.3^10.27.1.132^* |[R:N-H:0,N:2,L:0,V:0,Z:0,D:0] varChannelStatus=0
06344692.001 |15:04:14.321 |Stopping | | |SIPCdpc(1,100,82,7) |SIPCdpc(1,100,82,7) | |NumOfCurrentInstances: 1
06344693.000 |15:04:14.321 |SdlSig |PolicyAndCACUnassociateReq |wait |ReservationMgr(1,100,110,1) |Cdcc(1,100,219,42) |1,100,14,1439.3^10.27.1.132^* |[R:N-H:0,N:1,L:0,V:0,Z:0,D:0] CI= 23587686 aCI=23587686 bCI=23587687 ClearType=0F
06344694.000 |15:04:14.321 |SdlSig |RSVPStopInd |wait |ReservationMgr(1,100,110,1) |RSVPSession(1,100,107,42) |1,100,14,1439.3^10.27.1.132^* |[R:N-H:0,N:2,L:0,V:0,Z:0,D:0]
06344695.000 |15:04:14.321 |SdlSig |CACUnassociateReq |wait |RSVPSession(1,100,107,42) |ReservationMgr(1,100,110,1) |1,100,14,1439.3^10.27.1.132^* |[R:N-H:0,N:1,L:0,V:0,Z:0,D:0] CI= 23587686 aCI=23587686 bCI=23587687 ClearType=0F
06344696.000 |15:04:14.321 |SdlSig |RSVPStopConf |wait |RSVPSession(1,100,107,42) |ReservationMgr(1,100,110,1) |1,100,14,1439.3^10.27.1.132^* |[R:N-H:0,N:1,L:0,V:0,Z:0,D:0]
06344696.001 |15:04:14.321 |Stopping | | |RSVPSession(1,100,107,42) |RSVPSession(1,100,107,42) | |NumOfCurrentInstances: 1
06344697.000 |15:04:14.321 |SdlSig |RSVPStopInd |wait |ReservationMgr(1,100,110,1) |RSVPSession(1,100,107,42) |1,100,14,1439.3^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0]
06344698.000 |15:04:14.321 |SdlError |RSVPStopConf |NA |RSVPSession(1,100,107,42) |ReservationMgr(1,100,110,1) |1,100,14,1439.3^10.27.1.132^* |Destination process does not exist
06344699.000 |15:04:14.321 |SdlSig |SdlProcessNE |wait |ReservationMgr(1,100,110,1) |RSVPSession(1,100,107,42) |1,100,14,1439.3^10.27.1.132^* |*TraceFlagOverrode
06344699.001 |15:04:14.321 |SdlError |SdlProcessNE |wait |ReservationMgr(1,100,110,1) | | |Error: Description: A transition is not defined for the input signal. Check state machine definition in initStateMachine().
06344700.000 |15:04:14.321 |SdlSig |CACUnregisterReq |active |LBMInterface(1,100,176,1) |ReservationMgr(1,100,110,1) |1,100,14,1439.3^10.27.1.132^* |[T:N-H:0,N:1,L:0,V:0,Z:0,D:0] CI= 23587686 ClearType=0
06344700.001 |15:04:14.321 |AppInfo |LBMIF: CI: 23587686 UNREG 1,100,82,7 dev 0x10850f50
06344701.000 |15:04:14.321 |SdlSig |SIPNormalizeDialogReq |wait |SIPNormalization(1,100,78,1) |SIPHandler(1,100,79,1) |1,100,14,1439.3^10.27.1.132^* |*TraceFlagOverrode
06344701.001 |15:04:14.321 |AppInfo |//SIPLua/Error/SipContexts_removeContext: call contexts object is missing
06344702.000 |15:04:14.321 |SdlSig |CACUnassociateReq |active |LBMInterface(1,100,176,1) |ReservationMgr(1,100,110,1) |1,100,14,1439.3^10.27.1.132^* |[T:N-H:0,N:0,L:0,V:0,Z:0,D:0] CI= 23587686 aCI=23587686 bCI=23587687 ClearType=0F
06344702.001 |15:04:14.321 |AppInfo |LBMIF: CI: 23587686 UNASSOC 23587687
06344702.002 |15:04:14.321 |AppInfo |LBMIF: CI: 23587686 STOPPED
06344702.003 |15:04:14.321 |AppInfo |LBMIF: CI: 23587687 UNASSOC' (NOOP)
06344702.004 |15:04:14.321 |AppInfo |LBMIF: size of mSides 0
06344703.000 |15:04:14.321 |SdlSig |LBMStopInd |wait |ReservationMgr(1,100,110,1) |LBMInterface(1,100,176,1) |1,100,14,1439.3^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] CI= 23587686 CI= 0
06344704.000 |15:04:14.449 |SdlSig |DbObjectCacheTimer |initialized |Db(1,100,208,1) |SdlTimerService(1,100,3,1) |1,100,146,1.1^*^* |[T:H-H:0,N:0,L:0,V:0,Z:0,D:0] AppCorr: 0
06344705.000 |15:04:14.582 |SdlSig |SdlDataInd |wait |StationInit(1,100,62,1) |SdlTCPConnection(1,100,14,1027) |1,100,14,1027.8412^10.102.4.189^* |*TraceFlagOverrode
06344705.001 |15:04:14.582 |AppInfo |KeepAliveMessage received on backup CM link. Droping KeepAliveAck. DeviceName=, TCPPid = [1.100.14.1027], IPAddr=10.102.4.189, Port=49169, Device Controller=[0,0,0]
06344706.000 |15:04:14.692 |SdlSig |SdlDataInd |wait |StationInit(1,100,62,1) |SdlTCPConnection(1,100,14,1088) |1,100,14,1088.8420^10.105.1.10^* |*TraceFlagOverrode
06344706.001 |15:04:14.692 |AppInfo |KeepAliveMessage received on backup CM link. Droping KeepAliveAck. DeviceName=, TCPPid = [1.100.14.1088], IPAddr=10.105.1.10, Port=53032, Device Controller=[0,0,0]
06344707.000 |15:04:14.814 |SdlSig |SdlDataInd |wait |StationInit(1,100,62,1) |SdlTCPConnection(1,100,14,1115) |1,100,14,1115.8414^10.107.1.9^* |*TraceFlagOverrode
06344707.001 |15:04:14.814 |AppInfo |KeepAliveMessage received on backup CM link. Droping KeepAliveAck. DeviceName=, TCPPid = [1.100.14.1115], IPAddr=10.107.1.9, Port=50952, Device Controller=[0,0,0]
06344708.000 |15:04:14.854 |SdlSig |SdlDataInd |wait |StationInit(1,100,62,1) |SdlTCPConnection(1,100,14,1137) |1,100,14,1137.8412^10.126.0.8^* |*TraceFlagOverrode
06344708.001 |15:04:14.854 |AppInfo |KeepAliveMessage received on backup CM link. Droping KeepAliveAck. DeviceName=, TCPPid = [1.100.14.1137], IPAddr=10.126.0.8, Port=51303, Device Controller=[0,0,0]
06344709.000 |15:04:15.139 |SdlSig |CdccStopTimer |await_stop_timer_expiry |Cdcc(1,100,219,40) |SdlTimerService(1,100,3,1) |1,100,14,1436.3^10.27.1.132^* |[R:H-H:0,N:0,L:0,V:0,Z:0,D:0]
06344710.000 |15:04:15.139 |SdlSig |CcStopInd |wait |Cc(1,100,220,1) |Cdcc(1,100,219,40) |1,100,14,1436.3^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0]
06344710.001 |15:04:15.139 |AppInfo |CiCcp table has 4 entries
06344711.000 |15:04:15.139 |SdlSig |CcStopConf |await_stop_confirmation |Cdcc(1,100,219,40) |Cc(1,100,220,1) |1,100,14,1436.3^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0]
06344711.001 |15:04:15.139 |AppInfo |Cdcc::SsManager table size is 74
06344711.002 |15:04:15.139 |Stopping | | |Cdcc(1,100,219,40) |Cdcc(1,100,219,40) | |NumOfCurrentInstances: 3
06344712.000 |15:04:15.169 |SdlSig |DeviceEventReceiptMonitoringTimer |wait |StationInit(1,100,62,1) |SdlTimerService(1,100,3,1) |1,100,146,1.1^*^* |[R:H-H:1,N:0,L:0,V:0,Z:0,D:0]
06344713.000 |15:04:15.169 |SdlSig |H225ICTThrottlingMonitorTimer |restart0 |H225D(1,100,194,3) |SdlTimerService(1,100,3,1) |1,100,146,1.1^*^* |[R:H-H:0,N:0,L:0,V:0,Z:0,D:0]
06344714.000 |15:04:15.200 |SdlSig |SdlDataInd |wait |StationInit(1,100,62,1) |SdlTCPConnection(1,100,14,972) |1,100,14,972.8420^10.128.1.25^* |*TraceFlagOverrode
06344714.001 |15:04:15.200 |AppInfo |KeepAliveMessage received on backup CM link. Droping KeepAliveAck. DeviceName=, TCPPid = [1.100.14.972], IPAddr=10.128.1.25, Port=49414, Device Controller=[0,0,0]
06344715.000 |15:04:15.313 |SdlSig |SdlDataInd |wait |StationInit(1,100,62,1) |SdlTCPConnection(1,100,14,1018) |1,100,14,1018.8395^10.129.1.22^* |*TraceFlagOverrode
06344715.001 |15:04:15.313 |AppInfo |KeepAliveMessage received on backup CM link. Droping KeepAliveAck. DeviceName=, TCPPid = [1.100.14.1018], IPAddr=10.129.1.22, Port=49197, Device Controller=[0,0,0]
06344716.000 |15:04:15.459 |SdlSig |DbObjectCacheTimer |initialized |Db(1,100,208,1) |SdlTimerService(1,100,3,1) |1,100,146,1.1^*^* |[T:H-H:0,N:0,L:0,V:0,Z:0,D:0] AppCorr: 0
06344717.000 |15:04:15.460 |SdlSig |SdlDataInd |wait |StationInit(1,100,62,1) |SdlTCPConnection(1,100,14,1108) |1,100,14,1108.8378^10.102.1.252^* |*TraceFlagOverrode
06344717.001 |15:04:15.460 |AppInfo |KeepAliveMessage received on backup CM link. Droping KeepAliveAck. DeviceName=, TCPPid = [1.100.14.1108], IPAddr=10.102.1.252, Port=49194, Device Controller=[0,0,0]
06344718.000 |15:04:15.750 |SdlSig |SdlDataInd |wait |StationInit(1,100,62,1) |SdlTCPConnection(1,100,14,1127) |1,100,14,1127.8385^10.102.2.111^* |*TraceFlagOverrode
06344718.001 |15:04:15.750 |AppInfo |KeepAliveMessage received on backup CM link. Droping KeepAliveAck. DeviceName=, TCPPid = [1.100.14.1127], IPAddr=10.102.2.111, Port=49588, Device Controller=[0,0,0]
06344719.000 |15:04:15.836 |SdlSig |SdlDataInd |wait |StationInit(1,100,62,1) |SdlTCPConnection(1,100,14,1117) |1,100,14,1117.8403^10.104.1.7^* |*TraceFlagOverrode
06344719.001 |15:04:15.836 |AppInfo |KeepAliveMessage received on backup CM link. Droping KeepAliveAck. DeviceName=, TCPPid = [1.100.14.1117], IPAddr=10.104.1.7, Port=50864, Device Controller=[0,0,0]
06344720.000 |15:04:15.951 |SdlSig |SdlDataInd |wait |StationInit(1,100,62,1) |SdlTCPConnection(1,100,14,1038) |1,100,14,1038.8220^10.129.1.44^* |*TraceFlagOverrode
06344720.001 |15:04:15.951 |AppInfo |KeepAliveMessage received on backup CM link. Droping KeepAliveAck. DeviceName=, TCPPid = [1.100.14.1038], IPAddr=10.129.1.44, Port=49180, Device Controller=[0,0,0]
06344721.000 |15:04:15.954 |SdlSig |SIPPingReqTimer |restart0 |SIPD(1,100,81,4) |SdlTimerService(1,100,3,1) |1,100,41,1.3227^*^* |[R:H-H:0,N:0,L:0,V:0,Z:0,D:0]
06344722.000 |15:04:15.954 |SdlSig |SIPPingReq |wait |SIPHandler(1,100,79,1) |SIPD(1,100,81,4) |1,100,41,1.3227^*^* |[T:N-H:0,N:0,L:0,V:0,Z:0,D:0] ccbID= 122273 maxForward=0 --TransType=1 --TransSecurity=0 PeerAddr = 10.27.1.132:5060
06344722.001 |15:04:15.954 |AppInfo |//SIP/Stack/Info/0x0/sipSPIAddContextToTable: Added context(0x106e4058) with key=[122162] to table
06344722.002 |15:04:15.955 |AppInfo |DET-SDPMsg- sBandwidth:: enabledMask=0x0 as=0 ct=0 tias=0 maxprate=0
06344722.003 |15:04:15.955 |AppInfo |DET-SDPMsg- ngroups 0
06344722.004 |15:04:15.955 |AppInfo |DET-SDPMsg- No Session level unrecognized attributes list.
06344722.005 |15:04:15.955 |AppInfo |DET-SDPMsg- nAudio=0, mDTMFP.PayloadNum=0
06344722.006 |15:04:15.955 |AppInfo |DET-SDPMsg- nVideo=0
06344722.007 |15:04:15.955 |AppInfo |DET-SDPMsg- nApp=0
06344722.008 |15:04:15.955 |AppInfo |DET-SDPMsg- nBFCPApp=0
06344722.009 |15:04:15.955 |AppInfo |DET-SDPMsg- nIXApp=0
06344722.010 |15:04:15.955 |AppInfo |DET-SDPMsg- sBandwidth:: enabledMask=0x0 as=0 ct=0 tias=0 maxprate=0
06344722.011 |15:04:15.955 |AppInfo |DET-SDPMsg- sipp: ispres=0, role=0 vers=0 anat=0
06344722.012 |15:04:15.955 |AppInfo |DET-SDPMsg- ngroups 0
06344722.013 |15:04:15.955 |AppInfo |DET-SDPMsg- No Session level unrecognized attributes list.
06344722.014 |15:04:15.955 |AppInfo |DET-SDPMsg- nAudio=0, mDTMFP.PayloadNum=0
06344722.015 |15:04:15.955 |AppInfo |DET-SDPMsg- nVideo=0
06344722.016 |15:04:15.955 |AppInfo |DET-SDPMsg- nApp=0
06344722.017 |15:04:15.955 |AppInfo |DET-SDPMsg- nBFCPApp=0
06344722.018 |15:04:15.955 |AppInfo |DET-SDPMsg- nIXApp=0
06344722.019 |15:04:15.955 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/populateTargetInfo: port=5060, isIPAddr=1, type=2, target_port=5060, outboundProxyAddr.isIPAddr=0, target_type=0
06344722.020 |15:04:15.955 |AppInfo |//SIP/Stack/States/0x0x106e4058/sipSPIChangeState: 0x106e4058 : State change from (STATE_NONE, SUBSTATE_NONE) to (STATE_IDLE, SUBSTATE_NONE)
06344722.021 |15:04:15.955 |AppInfo |//SIP/Stack/Info/0x0/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 (SIP_APPLICATION_MSG), for event 39 (SIPSPI_EV_CC_OPTIONS)
06344722.022 |15:04:15.955 |AppInfo |//SIP/Stack/Info/0x0x106e4058/sipSPIUaddCcbToTable: Added to table. ccb=0x106e4058 key=54738f00-7611b4bf-40ec-2007f0a@10.127.0.2
06344722.023 |15:04:15.955 |AppInfo |//SIP/Stack/States/0x0x106e4058/sipSPIChangeState: 0x106e4058 : State change from (STATE_IDLE, SUBSTATE_NONE) to (SIP_STATE_OPTIONS_WAIT, SUBSTATE_NONE)
06344722.024 |15:04:15.955 |AppInfo |//SIP/Stack/Info/0x0x106e4058/sipSPIAddViaParams: inserted z9hG4bK40eb7535e17f into via branch list
06344722.025 |15:04:15.955 |AppInfo |//SIP/Stack/Error/0x0x106e4058/sipSPIAddPrivacyHeader: Orig Container is NULL...should have value
06344722.026 |15:04:15.955 |AppInfo |//SIP/Stack/Error/0x0x106e4058/sipSPIAddAssertedIDHeader: Orig Container is NULL...should have value
06344722.027 |15:04:15.955 |AppInfo |//SIP/Stack/Error/0x0x106e4058/sipSPIAddPreferredIDHeader: Orig Container is NULL...should have value
06344722.028 |15:04:15.955 |AppInfo |//SIP/Stack/Info/0x0x106e4058/sipSPISendOptionsRequest: Associated container=0x106e59b8 to Options
06344722.029 |15:04:15.955 |AppInfo |//SIP/Stack/Transport/0x0x106e4058/sipSPITransportSendMessage: msg=0x1078bde8, addr=10.27.1.132, port=5060, sentBy_port=0, is_req=1, tran
06344722.030 |15:04:15.955 |AppInfo |//SIP/Stack/Transport/0x0/sipInstanceGetConnectionId: Registering gcb=0x106e4058 with connection=0xfaa74f0 context list
06344722.031 |15:04:15.955 |AppInfo |//SIP/Stack/Transport/0x0x106e4058/sipTransportLogicSendMsg: Set to send the msg=0x1078bde8
06344722.032 |15:04:15.955 |AppInfo |//SIP/Stack/Transport/0x0x106e4058/sipTransportPostSendMessage: Posting send for msg=0x1078bde8, addr=10.27.1.132, port=5060, connId=91 for
06344722.033 |15:04:15.955 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: timerContext=0x106e5038 type=SIP_TIMER_TRYING value=500 retries=6
06344722.034 |15:04:15.955 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: timerContext=0x106e5038 type=SIP_TIMER_TRYING value=500 retries=6
06344723.000 |15:04:15.955 |SdlSig |SIPSPISignal |wait |SIPTcp(1,100,71,1) |SIPHandler(1,100,79,1) |1,100,41,1.3227^*^* |*TraceFlagOverrode
06344723.001 |15:04:15.955 |AppInfo |SIPTcp - wait_SdlSPISignal: Outgoing SIP TCP message to 10.27.1.132 on port 5060 index 91
[349725,NET]

7 Replies 7

Jitender Bhandari
Cisco Employee
Cisco Employee

Hi

Please update the call floe example IP Phone -- SIP -- CUCM -- SIP Trunk -- Lync.

Calling and called party number

Attach the file instead of pasting the contents.

JB

I made the requested updates. Thanks!

Deepak Mehta
VIP Alumni
VIP Alumni

As per logs we can see no potential match for incoming number .

can you make digit manipluation on translation pattern is correct for this number incoming number.If using SIP trunk then make sure it has inbound CSS with correct paritition to reach our to the numbers.thanks

++++++++++++++++++++++++++++++++++++++++++++++++++++++

Cgpn=tn=0npi=0ti=1nd=lynctestuser1User=Host=xxx-xx.orgPort=0PassWord=Madder=Transport=4mDisplayName=RawUrl=OrigPort=0pi=1si0 DialedNum=tn=0npi=1ti=1nd=96617356User=96617356Host=pkx-ccm-pub.xxx-xx.orgPort=5060PassWord=Madder=Transport=4mDisplayName=RawUrl=sip:96617356@pkx-ccm-pub.xxx-xx.org;user=phoneOrigPort=0pi=0si1 requestID=0 DigitAnalysisComplexity=0 CallingUser= IgnoreIntercept=0
06344672.001 |15:04:14.316 |AppInfo |Digit Analysis: star_DaReq: daReq.partitionSearchSpace(59a7d9c2-927c-4fe2-8468-c5622dde9643), filteredPartitionSearchSpaceString(Internal_par:IPCC_par:Unity_par:Main-local_par:Main-LD_par:Main-911_par), partitionSearchSpaceString(MHCSupportAfterHours_par:Internal_par:IPCC_par:Unity_par:Main-local_par:Main-LD_par:Main-911_par)
06344672.002 |15:04:14.316 |AppInfo |Digit Analysis: Host Address=pkx-ccm-pub.xxx-xx.org DOES NOT MATCH any active CUCM node in this cluster.
06344672.003 |15:04:14.316 |AppInfo |Digit Analysis: Host Address=pkx-ccm-pub.xxx-xx.org DOES NOT MATCH top level org domain.
06344672.004 |15:04:14.317 |AppInfo |Digit Analysis: star_DaReq: Matching SIP URL, Host Domain, host=gro.nt-chm.bup-mcc-xkp
06344672.005 |15:04:14.317 |AppInfo |Digit Analysis: getDaRes data: daRes.ssType=[0] Intercept DAMR.sstype=[0], TPcount=[0], DAMR.NotifyCount=[0], DaRes.NotifyCount=[0]
06344672.006 |15:04:14.317 |AppInfo |Digit Analysis: getDaRes - Remote Destination [] isURI[1]
06344672.007 |15:04:14.317 |AppInfo |Digit analysis: patternUsage=2
06344672.008 |15:04:14.317 |AppInfo |Digit analysis: match(pi="2",fqcn="", cn="lynctestuser1", plv="5", pss="MHCSupportAfterHours_par:Internal_par:IPCC_par:Unity_par:Main-local_par:Main-LD_par:Main-911_par", TodFilteredPss="Internal_par:IPCC_par:Unity_par:Main-local_par:Main-LD_par:Main-911_par", dd="96617356",dac="0")
06344672.009 |15:04:14.317 |AppInfo |Digit analysis: potentialMatches=NoPotentialMatchesExist>>>>>>>>>>>
06344673.000 |15:04:14.317 |SdlSig |DaRes |setup_da |Cdcc(1,100,219,42) |Da(1,100,211,1) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] CI=23587686 Block NoPotentialMatchesExist OnNetpatternUsage =2requestID =0>>>>>>>>>>>>>>>>>>>>>>>>>>>>
06344673.001 |15:04:14.317 |Created | | |MatrixControl(1,100,142,43) |Cdcc(1,100,219,42) | |NumOfCurrentInstances: 1
06344674.000 |15:04:14.317 |SdlSig |DropPartyReq |await_command |MatrixControl(1,100,142,43) |Cdcc(1,100,219,42) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] ClearType= 0
06344675.000 |15:04:14.317 |SdlSig |MediaDisconnectRequest>>>>>>>>>>>>>>>>>>>>>>>>

||ConnectionManager(1,100,214,1) |MatrixControl(1,100,142,43) |1,100,14,1439.2^10.27.1.132^* |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] CI1=23587686 CI2=0 sc=0 disconnType=1 ssReason=0 clearType=0 IF1Created=F IF2Created=F party1.mMediaCoordinatorNodeId=0

The CSS on the trunk is good. I have applied the CSS to a phone and I can call the number fine.

Thanks for your reply!

Thanks, it may be ringing when called directly ,however when mediation server is involved, it does look like it is not able to find the route to target.

LD_par:Main-911_par)
06344672.002 |15:04:14.316 |AppInfo |Digit Analysis: Host Address=pkx-ccm-pub.xxx-xx.org DOES NOT MATCH any active CUCM node in this cluster.
06344672.003 |15:04:14.316 |AppInfo |Digit Analysis: Host Address=pkx-ccm-pub.xxx-xx.org DOES NOT MATCH top level org domain.

then matching a SIP URL
06344672.004 |15:04:14.317 |AppInfo |Digit Analysis: star_DaReq: Matching SIP URL, Host Domain, host=gro.nt-chm.bup-mcc-xkp
06344672.005 |15:04:14.317 |AppInfo |Digit A

I am not sure on integration part what config is in place but it is clear that it can't find the route to desination.Perhaps other's can help .thanks

Hi You are getting this error because CUCM will not route any traffic for a domain its not aware of. To resolve this you need to add the domain "pkx-ccm-pub.xxx-xx.org"  to the Cluster FQDN in CUCM enterprise parameters.

Please rate all useful posts

I think this is the issues. Thanks for your reply. I will have to get a change window. I will let you know if that fixes the issue.

Getting Started

Find answers to your questions by entering keywords or phrases in the Search bar above. New here? Use these resources to familiarize yourself with the community: