cancel
Showing results for 
Search instead for 
Did you mean: 
cancel
4858
Views
0
Helpful
3
Replies

SIP trunk call drops with reason 47

HI guys. I am having random call drops on sip trunks. I have 3 servers 1 pub (B) and 2 subs (D and E ).  Site A PBX to CUCMs connected with sip trunk, call coming from site A to E , SUB E sents bye with "Resource unavaliable". If calls come to PUB B or SUB D i see no problem . I think its with either codecs or MTP but can't find where to look difference in config of the servers (D and B has something what E doens't ).

 Can you please point to what to check ?

Thank you

P.S call btw phone systems are internal goes via lan .  

 

Also here is CUCM logs from dropped call. Is it true that  looks like NYCgtwMTP giving error cause of unsuppported dtmf payload?  What can i do to fix it ?

:

38911776.000 |10:13:52.262 |SdlSig |SdlWriteReq |active |SdlUDPConnection(2,100,10,1) |SIPUdp(2,100,73,1) |3,100,14,20.120775^10.132.6.4^NYCGTWMTP |*TraceFlagOverrode
38911776.001 |10:13:52.262 |NetEvent | | |SdlNetworkService(2,100,1,1) | |3,100,14,20.120775^10.132.6.4^NYCGTWMTP |(2,100,10,1) fd: 365 - Async Write Initiated - asyncWriteRequest
38911776.002 |10:13:52.262 |NetEvent | | |SdlNetworkService(2,100,1,1) | |3,100,14,20.120775^10.132.6.4^NYCGTWMTP |(2,100,10,1) fd: 365 - sigpoll write
38911776.003 |10:13:52.262 |NetEvent | | |SdlNetworkService(2,100,1,1) | |3,100,14,20.120775^10.132.6.4^NYCGTWMTP |(2,100,10,1) fd: 365 - Write - Len: 1435 [5349502f 322e3020 32303020 4f4b0d0a 5669613a 20534950 2f322e30 2f554450 2031302e 3133322e 32372e33 303a3530 36303b77 6c737363 69643d36 61613662 ...]
38911777.000 |10:13:52.262 |NetEvent | | |SdlNetworkService(2,100,1,1) | |3,100,14,20.120775^10.132.6.4^NYCGTWMTP |(2,100,10,1) fd: 365 - Async Write Completed - calling handleWriteComplete
38911778.000 |10:13:52.267 |NetEvent | | |SdlNetworkService(2,100,1,1) | | |(2,100,14,544211) fd: 856 - sigpoll read
38911779.000 |10:13:52.267 |NetEvent | | |SdlNetworkService(2,100,1,1) | | |(2,100,14,544211) fd: 856 - Read - Len: 8 [e8000000 03000000]
38911780.000 |10:13:52.267 |NetEvent | | |SdlNetworkService(2,100,1,1) | | |(2,100,14,544211) fd: 856 - Async Read Completed - calling TCP handleReadComplete
38911781.000 |10:13:52.267 |NetEvent | | |SdlNetworkService(2,100,1,1) | | |(2,100,14,544211) fd: 856 - Async Read Initiated - asyncReadRequest
38911782.000 |10:13:52.267 |NetEvent | | |SdlNetworkService(2,100,1,1) | | |(2,100,14,544211) fd: 856 - sigpoll read
38911783.000 |10:13:52.267 |NetEvent | | |SdlNetworkService(2,100,1,1) | | |(2,100,14,544211) fd: 856 - Read - Len: 224 [1c000000 4d584167 656e614f 70656e4c 6f676963 616c4368 616e6e65 6c41636b 00000000 00000000 9c4c62f4 c9d70100 00000000 03000000 64000000 0e000000 ...]
38911784.000 |10:13:52.267 |NetEvent | | |SdlNetworkService(2,100,1,1) | | |(2,100,14,544211) fd: 856 - Async Read Completed - calling TCP handleReadComplete
38911785.000 |10:13:52.267 |NetEvent | | |SdlNetworkService(2,100,1,1) | | |(2,100,14,544211) fd: 856 - Async Read Initiated - asyncReadRequest
38911786.000 |10:13:52.267 |NetEvent | | |SdlNetworkService(2,100,1,1) | | |(2,100,14,544211) fd: 856 - sigpoll read
38911787.000 |10:13:52.267 |SdlSig-I |MXAgenaOpenLogicalChannelAck |waitForMXCapabilitiesorOfferorAnswer |MTPAgenaInterface(2,100,251,13523) |MediaTerminationPointControl(3,100,141,2) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] rc=1 isMultiMedia=F LCN=0 partyId=33570870 port=0 ipAddrType=1 ipv6=::
38911787.001 |10:13:52.267 |AppInfo |DET-AgenaInterfaceBase-(13523)::sessionEstablished_MediaExchangeAgenaOpenLogicalChannelAck, LCN=1, mediaType=1
38911788.000 |10:13:52.267 |SdlSig |MXErrorReport |interfacesEstablished |MediaExchange(2,100,149,92279) |MTPAgenaInterface(2,100,251,13523) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:1,L:0,V:0,Z:0,D:0] error=0 CallMediaFailureCause=unknown failure case Reason=Audio Channel OLCAck with error recd
38911789.000 |10:13:52.267 |SdlSig |MediaExchangeOfferErr |waitStopped |MediaExchange(2,100,149,92279) |MTPAgenaInterface(2,100,251,13523) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:3,L:0,V:0,Z:0,D:0]
38911790.000 |10:13:52.267 |SdlSig-D |MediaExchangeOfferErr |waitStopped |MediaExchange(2,100,149,92279) |MTPAgenaInterface(2,100,251,13523) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |
38911791.000 |10:13:52.267 |SdlSig |MediaConnectErrorInd |waitDisconnect |MediaManager(2,100,144,85708) |MediaExchange(2,100,149,92279) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:2,L:0,V:0,Z:0,D:0] CI1=41108689 CI2=41108698 clearType=0 Cause=0
38911791.001 |10:13:52.267 |AppInfo |DET-MediaManager-(85708)::handle_MediaDisconnectRequest - CACAdjustBWReq MIGHT NOT have been posted for this call yet
38911791.002 |10:13:52.267 |AppInfo |!!ERROR!! -MediaManager-(85708)::handle_MediaConnectErrorInd, mCleanupPreallocatedMTP=0
38911791.003 |10:13:52.267 |AppInfo |!!ERROR!! -MediaManager-(85708)::handle_MediaConnectErrorInd, send disconn to 2 MXs
38911791.004 |10:13:52.267 |AppInfo |!!ERROR!! -MediaManager-(85708)::handleMediaConnectErrorInd, mediaConnectRequestMsg party video capable (1=0, 2=1), ConnecterrorInd party capable (1=0, 2=1)
38911791.005 |10:13:52.267 |AppInfo |DET-MediaManager-(85708)::processRetainedAndReparentToMC(), retainingPartryCI=0
38911791.006 |10:13:52.267 |AppInfo |!!ERROR!! -MediaManager-(85708)::handle_MediaConnectErrorInd, ERROR:remain mConnCount=2
38911791.007 |10:13:52.267 |AppInfo |!!ERROR!! -MediaManager-(85708)::handle_MediaConnectErrorInd, ERROR:sending disconn to MX(2,92278)
38911791.008 |10:13:52.267 |AppInfo |!!ERROR!! -MediaManager-(85708)::handle_MediaConnectErrorInd, ERROR:found MX sender(149,92279)
38911792.000 |10:13:52.267 |SdlSig |MXInterfaceStopStreaming |waitForAnswerorOfferorMXCap |SIPInterface(2,100,79,154729) |MediaExchange(2,100,149,92279) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:4,L:0,V:0,Z:0,D:0] ClearType= 0 StoppedBy= 0 DisconnecType= 1 StopStreamingReason=0 reconPending=F holdingPartyCI=0 forceStopCI=0
38911793.000 |10:13:52.267 |NetEvent | | |SdlNetworkService(2,100,1,1) | | |(2,100,14,544211) fd: 856 - sigpoll read
38911792.001 |10:13:52.267 |AppInfo |SIPInterface::resetRemoteIpAddressForMLines
38911794.000 |10:13:52.267 |NetEvent | | |SdlNetworkService(2,100,1,1) | | |(2,100,14,544211) fd: 856 - Read - Len: 8 [f1000000 03000000]
38911792.002 |10:13:52.267 |AppInfo |DET-SIPInterface-(154729)::prepareAndSendSDPAnswer, preSDP(aud=0,vid=0,app=0,bfcp=0,ix=0),nLines(aud=1,vid=1,app=0,bfcp=0,ix=0)
38911795.000 |10:13:52.267 |NetEvent | | |SdlNetworkService(2,100,1,1) | | |(2,100,14,544211) fd: 856 - Async Read Completed - calling TCP handleReadComplete
38911796.000 |10:13:52.267 |NetEvent | | |SdlNetworkService(2,100,1,1) | | |(2,100,14,544211) fd: 856 - Async Read Initiated - asyncReadRequest
38911797.000 |10:13:52.267 |NetEvent | | |SdlNetworkService(2,100,1,1) | | |(2,100,14,544211) fd: 856 - sigpoll read
38911792.003 |10:13:52.267 |AppInfo |DET-SIPInterface-(154729)::adjustLineStackIdxForMatchLines MLINE_AUDIO lineStackIdx=1
38911792.004 |10:13:52.267 |AppInfo |DET-SIPInterface-(154729)::adjustLineStackIdxForMatchLines MLINE_VIDEO lineStackIdx=2
38911798.000 |10:13:52.267 |NetEvent | | |SdlNetworkService(2,100,1,1) | | |(2,100,14,544211) fd: 856 - Read - Len: 233 [21000000 4d656469 61457863 68616e67 65416765 6e615374 61727454 616c6b69 6e674163 6b000000 00000000 00685567 eacad701 00000000 00030000 00640000 ...]
38911792.005 |10:13:52.267 |AppInfo |DET-SIPInterface-(154729)::prepareAndSendSDPAnswer, preSDP(aud=1,vid=1,app=0,bfcp=0,ix=0), nLines(aud=1,vid=1,app=0,bfcp=0,ix=0)
38911799.000 |10:13:52.267 |NetEvent | | |SdlNetworkService(2,100,1,1) | | |(2,100,14,544211) fd: 856 - Async Read Completed - calling TCP handleReadComplete
38911792.006 |10:13:52.267 |AppInfo |DET-MediaMLinesList::-setSdpLineInfoMap: MLINE_AUDIO numMlines= 1
38911800.000 |10:13:52.267 |NetEvent | | |SdlNetworkService(2,100,1,1) | | |(2,100,14,544211) fd: 856 - Async Read Initiated - asyncReadRequest
38911801.000 |10:13:52.267 |NetEvent | | |SdlNetworkService(2,100,1,1) | | |(2,100,14,544211) fd: 856 - sigpoll read
38911792.007 |10:13:52.267 |AppInfo |DET-MediaMLinesList::-setSdpLineInfoMap: MLINE_VIDEO numMlines= 1
38911792.008 |10:13:52.267 |AppInfo |DET-SDPMsg- - resetAllUnknownAttr, reset smart pointers to NULL
38911792.009 |10:13:52.267 |AppInfo |DET-SDPMsg-setGroupList:
38911792.010 |10:13:52.267 |AppInfo |DET-SDPMsg-setGroupList: size= 0
38911792.011 |10:13:52.267 |AppInfo |DET-MediaMLinesList::-RtcpBWModifiersInMLinesList: TEXOMA_ICE: RTCP BW modifiers found in mlines = 0
38911792.012 |10:13:52.267 |AppInfo |DET-MediaMLinesList::-RtcpBWModifiersInMLinesList: TEXOMA_ICE: RTCP BW modifiers found in mlines = 0
38911792.013 |10:13:52.267 |AppInfo |DET-SDPMsg-RtcpBWModifiersInSDP:: TEXOMA_ICE: TEXOMA_ICE: Rtcp BW modifiers found in SDP=0
38911792.014 |10:13:52.267 |AppInfo |DET-MediaMLinesList::-resetRtcpBWModifiersInMLinesList: TEXOMA_ICE: RTCP BW modifiers removed in mlines
38911792.015 |10:13:52.267 |AppInfo |DET-MediaMLinesList::-resetRtcpBWModifiersInMLinesList: TEXOMA_ICE: RTCP BW modifiers removed in mlines
38911792.016 |10:13:52.267 |AppInfo |DET-SDPMsg-resetRtcpBWModifiersInSDP:: TEXOMA_ICE: TEXOMA_ICE: Rtcp BW modifiers in entire SDP reset
38911802.000 |10:13:52.267 |SdlSig |MXInterfaceStopStreaming |waitStopped |MTPAgenaInterface(2,100,251,13523) |MediaExchange(2,100,149,92279) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:6,L:0,V:0,Z:0,D:0] ClearType= 0 StoppedBy= 0 DisconnecType= 1 StopStreamingReason=0 reconPending=F holdingPartyCI=0 forceStopCI=0
38911802.001 |10:13:52.267 |AppInfo |DET-AgenaInterfaceBase-(13523)::closeRecvForAllAudioChannels, mAudioIncomingLC2AGIDMap size = 1
38911802.002 |10:13:52.267 |AppInfo |DET-MTPAgenaInterface-(13523)::needToPassThru, mediaType=1, aPT=2, vPT=2, switching to Fax=0
38911802.003 |10:13:52.267 |AppInfo |DET-AgenaInterfaceBase-(13523)::can2833BeNegotiated, PeerCapsSupport2833=0 shouldCheckPeerDTMFProfile=1
38911803.000 |10:13:52.267 |SdlSig |MediaCoordinatorDelResource |wait |MediaCoordinator(2,100,145,1) |MediaManager(2,100,144,85708) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:9,L:0,V:0,Z:0,D:0] CI= 41108698;clearType=0
38911803.001 |10:13:52.267 |AppInfo |SIG-MediaCoordinator-wait_MediaCoordinatorDelResource - CI=41108698 count=1 mrmNodeId=2
38911804.000 |10:13:52.267 |SdlSig |MediaConnectErrorInd |wait |MediaCoordinator(2,100,145,1) |MediaManager(2,100,144,85708) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:8,L:0,V:0,Z:0,D:0] CI1=41108688 CI2=41108689 clearType=0 Cause=0
38911804.001 |10:13:52.267 |AppInfo |SIG-MediaCoordinator-wait_MediaConnectErrorInd - removing MediaManager(85708) from connection list
38911805.000 |10:13:52.267 |SdlSig |MediaDisconnectRequest |interfacesEstablished |MediaExchange(2,100,149,92278) |MediaManager(2,100,144,85708) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:8,L:0,V:0,Z:0,D:0] CI1=41108688 CI2=41108698 sc=4 disconnType=1 ssReason=0 clearType=0 IF1Created=T IF2Created=T party1.mMediaCoordinatorNodeId=2 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
38911805.001 |10:13:52.267 |AppInfo |DET-MediaExchange-(92278)::wait_Disconnect, dt=1,stReason=0,IFHandling(0,0)
38911806.000 |10:13:52.267 |SdlSig-I |MediaExchangeAgenaStartTalkingAck |restart |MTPAgenaInterface(2,100,251,13523) |MediaTerminationPointControl(3,100,141,2) |3,100,14,20.120778^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:9,L:0,V:0,Z:0,D:0] result=1 mediaType=1 confID=50366200 partyID=0x2004036 CI=41108698 ipAddrType=1 ipv6=:: port=0
38911806.001 |10:13:52.267 |SdlError |MediaExchangeAgenaStartTalkingAck |restart |MTPAgenaInterface(2,100,251,13523) | | |Error: Description: A transition is not defined for the input signal. Check state machine definition in initStateMachine().
38911807.000 |10:13:52.267 |SdlSig |SDPAnswer |outCall_200Rcvd |SIPCdpc(2,100,85,465755) |SIPInterface(2,100,79,154729) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:8,L:0,V:0,Z:0,D:0] ] nAudio=1 stackIdx=1 audioCapCount=10 Caps[90(20),6(20),89(30),4(20),2(20),86(20),11(20),12(20),15(20),16(20)] port=22312 IP= ipAddrType=0 ipv4=0.0.0.0 SDPMode=3 mediaAttr=0x0 SP=F RTP=T SRTP=F idle=F QoS=F enabledMask=0 rtcbFbCount=0LatentCaps=null TCL_AUDIO ptime=20 ~nVideo=1 stackIdx=2 videoCapCount=3, [103 pt=100 h235=0],[103 pt=126 h235=0],[103 pt=97 h235=0] port=21420 ipAddrType=0 ipv4=0.0.0.0 SDPMode=3 RTP=T SRTP=F idle=F mVideoContentId=1 mContentTypeCount=0 TIAS=4000000enabledMask=0rtcbFbCount=0 TCL_UNSPECIFIED ~nApp=0 ~nT38Fax=0 ^nBFCPApp=0 ^nIXApp=0 DTMFMethod=3 DTMFConfig=1 RFC2833PT=101 wantDTMF=0 provideOOB=F keepAudiomLineForT38=F FaxInviteWithValidIP=F FCOffer=0 transID=0 mANATAddrPref=3Ip_Invalid negIpAddrType=0V4 MTPAllocated=0 mAllowMultiCodecsInAnswer=F
38911807.001 |10:13:52.267 |AppInfo |setLocalDtmfCaps: supportedDTMFMethod=3, mWantDtmfReception=0, mPeersWantDtmfReceptionFlag=0, mDtmfPreference=1
38911807.002 |10:13:52.267 |AppInfo |SIP DTMF Info: mLocalDtmfCaps...UNSOL=0, KPML=0, Inband=1(101) mEndppointsDtmfCaps...UNSOL=0, KPML=1, Inband=1(101) mDefaultTelephonyEvent=101, mDtmfPreference=1, mMtpAllocated=0
38911807.003 |10:13:52.267 |AppInfo |SIPCdpc(465755) - convertMediaSDPMsgToSDP: num Audio m line: 1 RFC2833 pyld: 101
38911807.004 |10:13:52.267 |AppInfo |SIPCdpc(465755) - convertMediaSDPMsgToSDP: (SDP Audio) bytes=1367

SDP:: mSipSdp().mIsPresent=1, role=2
numAudiomLines=1 numVideomLines=1
numAppplicationmLines=0 numBFCPAppmLines=0 numIXAppmLines=0 numT38faxmLines=0
anatPresent=0
Bandwidth:: enabledMask=0x00000001 as=4064 ct=0 tias=0 rr=0, rs=0, maxprate=0
SdpSetupType=0, DTLS Fingerprint=, ektInd=0
audiomLines[0] =
Media_mLine:: remoteIpAddress=0x00000000 remoteRtpPortNumber=22312 mSDPMode=3 mediaAttr=0x00000000 - idle=0
mLineStackIdx=1 telephonyEvent=101 silenceSuppressionFlag=0 midID=-1
SdpSetupType=0, DTLS Fingerprint=, ektInd=0
Bandwidth:: enabledMask=0x00000004 as=0 ct=0 tias=64000 rr=0, rs=0, maxprate=0
rtp=1,srtp=0,rtcpmux=0,trafficclass= TCL_AUDIO
mLine:enabledMask=0x00000000
mLine:mContent:mContentTypeCount=0
caps[0]:: payloadCapability=90 maxFramesPerPacket=20
caps[1]:: payloadCapability=6 maxFramesPerPacket=20
caps[2]:: payloadCapability=89 maxFramesPerPacket=30
caps[3]:: payloadCapability=4 maxFramesPerPacket=20
caps[4]:: payloadCapability=2 maxFramesPerPacket=20
caps[5]:: payloadCapability=86 maxFramesPerPacket=20
ILBC Params:: mode=1 framesPerPacket=20
caps[6]:: payloadCapability=11 maxFramesPerPacket=20
caps[7]:: payloadCapability=12 maxFramesPerPacket=20
caps[8]:: payloadCapability=15 maxFramesPerPacket=20
caps[9]:: payloadCapability=16 maxFramesPerPacket=20

38911807.005 |10:13:52.267 |AppInfo |SIPCdpc(465755) - convertMediaSDPMsgToSDP: (Video) bytes=1233

videomLines[0] =
Media_mLine:: remoteIpAddress=0x00000000 remoteRtpPortNumber=21420 mSDPMode=3 mediaAttr=0x00000000 - idle=0
mLineStackIdx=2 telephonyEvent=0 silenceSuppressionFlag=0 midID=-1
SdpSetupType=0, DTLS Fingerprint=, ektInd=0
Bandwidth:: enabledMask=0x00000004 as=0 ct=0 tias=4000000 rr=0, rs=0, maxprate=0
rtp=1,srtp=0,rtcpmux=0,trafficclass= TCL_UNSPECIFIED
mLine:enabledMask=0x00000000
mLine:mContent:mContentTypeCount=0
imageattr=
mVideoContentId=1
caps[0]:: payloadTypeMapping=100 payloadCapability=103
H264:: maxBitRate=0 Profile:Profile_iop:Level=0x64:c:16 packetizationMode=1 maxRcmdNaluSize=256000 customMaxMBPS=108000 customMaxFS=3600 levelAsymmetryAllowed=1
imageattr=
caps[1]:: payloadTypeMapping=126 payloadCapability=103
H264:: maxBitRate=0 Profile:Profile_iop:Level=0x42:80:16 packetizationMode=1 maxRcmdNaluSize=256000 customMaxMBPS=108000 customMaxFS=3600 levelAsymmetryAllowed=1
imageattr=
caps[2]:: payloadTypeMapping=97 payloadCapability=103
H264:: maxBitRate=0 Profile:Profile_iop:Level=0x42:80:16 packetizationMode=0 maxRcmdNaluSize=256000 customMaxMBPS=108000 customMaxFS=3600 levelAsymmetryAllowed=1
imageattr=

38911807.006 |10:13:52.267 |AppInfo |SIPCdpc(465755) - removeUnknownAttrsNotPassedThrough: Passing all unrecognized SDP attributes.
38911807.007 |10:13:52.267 |AppInfo |sendMediaUpdateToParent: SIP Video Lines 1 CM Video Line 1 !
38911807.008 |10:13:52.267 |AppInfo |updateVideoMlineParams: video RX port 21420 TX Port 0 SDPMode 3
38911807.009 |10:13:52.267 |AppInfo |DET-SDPMsg- - getMaxBitRateFromAllVideoCap(), maxbitrate from SDPMsg video mline cap =0
38911807.010 |10:13:52.267 |AppInfo |SIPCdpc(465755) - setCnNameAndNumber: connectedData - Name Jennifer Glukman origName Number 11166 origNumber host user ti DN NumberPi 1 NamePi 1 Si 3, LocalData - NumberPi 1 NamePi 1 Host user hasBlended falseCucmVersion 0
38911807.011 |10:13:52.267 |AppInfo |SIPCdpc(465755) - setIdentityOutgoingSIPMsg: identityFlag=[RPID;], privacyType[0]
38911807.012 |10:13:52.267 |AppInfo |SIPCdpc(465755) - subscribeForKpml: (getDefReqAnswer)
38911807.013 |10:13:52.267 |AppInfo |getOobScbId: Created scbId. mOobScbId=25414608, ccbId=25414580
38911807.014 |10:13:52.267 |AppInfo |SIPCdpc(465755) - subscribeForKpml: mPeersWantDtmfReceptionFlag=0, UnsolSubscribed=0, DeviceType=4 EndpointSupportKpml=1, Peersupport=3, config=1, peer config=1 2833:1
38911807.015 |10:13:52.267 |AppInfo |SIPCdpc(465755) - addSessionIdHeader: mSessionId.deviceUUID: 249e13bf00105000a000007686fc2b5d, mSessionId.peerUUID: 2e345600dbe4990e7971dfab25414579
38911808.000 |10:13:52.267 |SdlSig-Q |CcSetupCompReq |active |SIPCdpc(2,100,85,465755) |SIPStationCdfc(2,100,77,158988) |2,100,14,1414560.5426^10.132.29.229^* |
38911809.000 |10:13:52.267 |SdlSig |SIPStopStreaming |active |SIPCdpc(2,100,85,465755) |SIPInterface(2,100,79,154729) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:11,L:0,V:0,Z:0,D:0] ClearType=0 StoppedBy=0 DisconnecType=1 StopStreamingReason=0 stackIdx=0 ReconnectPending=F forceStop=F
38911809.001 |10:13:52.267 |AppInfo |resetLocalDtmfCaps: mLocalDtmfCaps.oob.kpmlAvail = 0, mDtmfsrc=0
38911809.002 |10:13:52.267 |AppInfo |sendMediaUpdateToParent: SIP Video Lines 1 CM Video Line 1 !
38911809.003 |10:13:52.267 |AppInfo |updateVideoMlineParams: video RX port 21420 TX Port 0 SDPMode 3
38911809.004 |10:13:52.267 |AppInfo |DET-SDPMsg- - getMaxBitRateFromAllVideoCap(), maxbitrate from SDPMsg video mline cap =0
38911810.000 |10:13:52.267 |SdlSig-O |MXAgenaCloseLogicalChannel |NA RemoteSignal |MediaTerminationPointControl(3,100,141,2) |MTPAgenaInterface(2,100,251,13523) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:12,L:0,V:0,Z:0,D:0] ConferenceID= 50366200 PartyId= 33570870 streamFlag=F ClearType= 0 PortHandling=0 ci=41108698 lcn=0 PT=F PTId=16777216 switchingToFax=F ConnType=3
38911811.000 |10:13:52.267 |SdlSig-O |MXStopTalking |NA RemoteSignal |MediaTerminationPointControl(3,100,141,2) |MTPAgenaInterface(2,100,251,13523) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:11,L:0,V:0,Z:0,D:0] ClearType= 0 mConferenceID= 50366200 ci=41108698 mPartyId=0x2004036 PortHandling=0 ConnType=3
38911812.000 |10:13:52.267 |SdlSig |MXInterfaceStoppedStreaming |waitStopped |MediaExchange(2,100,149,92279) |MTPAgenaInterface(2,100,251,13523) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:10,L:0,V:0,Z:0,D:0]
38911813.000 |10:13:52.267 |SdlSig-O |MediaExchangeAgenaDeassociateReq |NA RemoteSignal |MediaTerminationPointControl(3,100,141,2) |MTPAgenaInterface(2,100,251,13523) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:9,L:0,V:0,Z:0,D:0] confID=50366200 CI=41108698
38911814.000 |10:13:52.267 |SdlSig |MediaConnectErrorInd |wait |ConnectionManager(2,100,219,1) |MediaCoordinator(2,100,145,1) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:8,L:0,V:0,Z:0,D:0] CI1=41108688 CI2=41108689 clearType=0 Cause=0
38911814.001 |10:13:52.268 |AppInfo |ARBTRY-ConnectionManager- wait_MediaConnectErrorInd CI(41108688,41108689)
38911814.002 |10:13:52.268 |AppInfo |ARBTRY-ConnectionManager- deleteMediaInfoEntry(CI=41108688): ENTRY DELETED, size=54
38911814.003 |10:13:52.268 |AppInfo |ARBTRY-ConnectionManager- deleteMediaInfoEntry(CI=41108689): ENTRY DELETED, size=53
38911815.000 |10:13:52.268 |SdlSig |MXInterfaceStopStreaming |sessionEstablished |SIPInterface(2,100,79,154728) |MediaExchange(2,100,149,92278) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:8,L:0,V:0,Z:0,D:0] ClearType= 0 StoppedBy= 0 DisconnecType= 1 StopStreamingReason=0 reconPending=F holdingPartyCI=4138627060 forceStopCI=0
38911816.000 |10:13:52.268 |SdlSig |MXInterfaceStopStreaming |sessionEstablished |MTPAgenaInterface(2,100,251,13522) |MediaExchange(2,100,149,92278) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:8,L:0,V:0,Z:0,D:0] ClearType= 0 StoppedBy= 0 DisconnecType= 1 StopStreamingReason=0 reconPending=F holdingPartyCI=4138627060 forceStopCI=0
38911816.001 |10:13:52.268 |AppInfo |DET-AgenaInterfaceBase-(13522)::closeRecvForAllAudioChannels, mAudioIncomingLC2AGIDMap size = 1
38911816.002 |10:13:52.268 |AppInfo |DET-MTPAgenaInterface-(13522)::needToPassThru, mediaType=1, aPT=2, vPT=2, switching to Fax=0
38911816.003 |10:13:52.268 |AppInfo |DET-AgenaInterfaceBase-(13522)::can2833BeNegotiated, PeerCapsSupport2833=0 shouldCheckPeerDTMFProfile=1
38911817.000 |10:13:52.268 |SdlSig |SIPMediaUpdateNotify |translate |SIPStationCdfc(2,100,77,158988) |SIPCdpc(2,100,85,465755) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:12,L:0,V:0,Z:0,D:0] IP addr Tx: ipAddrType=0 ipv4=0.0.0.0 RTP Port Tx: 0 PacketSize: 20 CompressionType: 90 SilenceSup: Fg723BitRate: 29184 IP addr Rx: ipAddrType=0 ipv4=0.0.0.0 RTP Port Rx: 0 cryptoAlgID: 0 keylen Tx: 0 saltlen Tx: 0 MKIpres Tx: 0 keylen Rx: 0 saltlen Rx: 0 MKIpres Rx: 0 NumVideoStream=1 Video Stream ID=0 IP addr Tx: ipAddrType=0 ipv4=0.0.0.0 RTP Port Tx: 0 BitRate: 0 CompressionType: 103 IP addr Rx: ipAddrType=0 ipv4=10.132.29.229 RTP Port Rx: 21420 type: 2 secureStream: F
38911817.001 |10:13:52.268 |AppInfo |setTargetCapsForBib : payload=0, maxFr=0, g723br=0
38911818.000 |10:13:52.268 |SdlSig |SdlWriteReq |active |SdlTCPConnection(2,100,14,544211) |SdlLinkControl(2,100,19,1) |2,100,19,1.1568704^*^* |*TraceFlagOverrode
38911818.001 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568704^*^* |(2,100,14,544211) fd: 856 - Async Write Initiated - asyncWriteRequest
38911818.002 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568704^*^* |(2,100,14,544211) fd: 856 - sigpoll write
38911819.000 |10:13:52.268 |SdlSig |SIPCallStateInd |waitForDeviceStopStreaming |SIPInterface(2,100,79,154729) |SIPCdpc(2,100,85,465755) |2,100,14,1414560.5426^10.132.29.229^* |[R:N-H:0,N:11,L:0,V:0,Z:0,D:0] mSipCallState = 2 mRecFlag = NO RECORDING
38911818.003 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568704^*^* |(2,100,14,544211) fd: 856 - Write - Len: 278 [16010000 03000000 1a000000 4d584167 656e6143 6c6f7365 4c6f6769 63616c43 68616e6e 656c0000 00000000 000038e4 73eac9d7 01000000 00000300 00006400 ...]
38911820.000 |10:13:52.268 |SdlSig |CcUpdateRegistration |restart0 |LineControl(2,100,178,3269) |SIPCdpc(2,100,85,465755) |2,100,14,1414560.5426^10.132.29.229^* |[R:N-H:0,N:11,L:0,V:0,Z:0,D:0] CI=41108689 CI.branch=0 CSS= AdjunctCSS= cssIns=0 aarCSS= aarDev=F FQDN=pi=0si1 CallRef=0 OLC=0 Name=locale: 1 Name: UnicodeName: pi: 0 encodeType=10 qsig-encodeType=10 ConnType=0 XferMode=0 ConnTime=0 nwLoc=0IpAddrMode=0 ipAddrType=0 ipv4=0.0.0.0:0 region= capCount=0 devType=0 mixerCId=0 mediaReq=0 portToPort.loc=0 MOH.MRGLPkid= MOH.userHoldID=0 MOH.netHoldID=0 MOH.supp=0 devName= mobileDevName= mobilePartyNumber=pi=0si1 mobileCallType=0 ctiActive=F ctiFarEndDev=0 ctiCCMId=0 devCepn= lineCepn= activeCaps=0 VideoCall=F MMUpdateCapMask=0x0 MMCap=0x1 SipConfig: BFCPAllowed=F IXAllowed=F devCap=0 CryptoCapCount=0 secure=1 loginId= UnicodeName: retriedVideo=FFromTag=ToTag=CallId= UAPortFlag=T wantDTMFRecep=1 provOOB=0 supp DTMF=0 DTMF Cfg=1 DTMF PT=0 DTMF reqMed=1 isPrefAltScript=F cdpnPatternUsage=-156339968 audioPtyId=0 doNotAppendLineCSS=F callingDP= BCUpdate=1 ccBearCap.itc=0 ccBearCap.l=0 ccBearCap.itr=0 protected=1 flushCapIns=-158110015 geolocInfo=null locPkid= locName= deductBW=F fateShareId= videoTrafficClass=Unspecified 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=1 vCTCUpdt=1 honorCodec=F honorUpdt=1 finalCalledPartition= cTypeUpdt=1 BibEnabled=0 RecordingQSIGAPDUSupported=F FarEndDeviceName=LatentCaps=null icidVal= icidGenAddr= oioi= tioi= ptParams= CAL={v=-1, m=-1, tDev=F, res=F, devType=0} displayNameUpdateFieldFlag=1 CFBCtrlSecIcon=F connBeforeANN=F
38911821.000 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568704^*^* |(2,100,14,544211) fd: 856 - Async Write Completed - calling handleWriteComplete
38911822.000 |10:13:52.268 |SdlSig |SdlWriteReq |active |SdlTCPConnection(2,100,14,544211) |SdlLinkControl(2,100,19,1) |2,100,19,1.1568705^*^* |*TraceFlagOverrode
38911822.001 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568705^*^* |(2,100,14,544211) fd: 856 - Async Write Initiated - asyncWriteRequest
38911823.000 |10:13:52.268 |SdlSig |SIPStopStreamingInd |waitForDeviceStopStreaming |SIPInterface(2,100,79,154729) |SIPCdpc(2,100,85,465755) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:11,L:0,V:0,Z:0,D:0] disconnType=2175 myId=0
38911822.002 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568705^*^* |(2,100,14,544211) fd: 856 - sigpoll write
38911822.003 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568705^*^* |(2,100,14,544211) fd: 856 - Write - Len: 245 [f5000000 03000000 0d000000 4d585374 6f705461 6c6b696e 67000000 00000000 0044e473 eac9d701 00000000 00030000 00640000 000e0000 00140000 004e5943 ...]
38911824.000 |10:13:52.268 |SdlSig |SIPMediaUpdateNotify |translate |SIPStationCdfc(2,100,77,158988) |SIPCdpc(2,100,85,465755) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:11,L:0,V:0,Z:0,D:0] IP addr Tx: ipAddrType=0 ipv4=0.0.0.0 RTP Port Tx: 0 PacketSize: 20 CompressionType: 90 SilenceSup: Fg723BitRate: 29184 IP addr Rx: ipAddrType=0 ipv4=0.0.0.0 RTP Port Rx: 0 cryptoAlgID: 0 keylen Tx: 0 saltlen Tx: 0 MKIpres Tx: 0 keylen Rx: 0 saltlen Rx: 0 MKIpres Rx: 0 NumVideoStream=1 Video Stream ID=0 IP addr Tx: ipAddrType=0 ipv4=0.0.0.0 RTP Port Tx: 0 BitRate: 0 CompressionType: 103 IP addr Rx: ipAddrType=0 ipv4=10.132.29.229 RTP Port Rx: 21420 type: 2 secureStream: F
38911824.001 |10:13:52.268 |AppInfo |setTargetCapsForBib : payload=0, maxFr=0, g723br=0
38911825.000 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568705^*^* |(2,100,14,544211) fd: 856 - Async Write Completed - calling handleWriteComplete
38911826.000 |10:13:52.268 |SdlSig |SdlWriteReq |active |SdlTCPConnection(2,100,14,544211) |SdlLinkControl(2,100,19,1) |2,100,19,1.1568706^*^* |*TraceFlagOverrode
38911826.001 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568706^*^* |(2,100,14,544211) fd: 856 - Async Write Initiated - asyncWriteRequest
38911827.000 |10:13:52.268 |SdlSig |MediaConnectErrorInd |connecting_ind |MatrixControl(2,100,146,297723) |ConnectionManager(2,100,219,1) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:11,L:0,V:0,Z:0,D:0] CI1=41108688 CI2=41108689 clearType=0 Cause=0
38911826.002 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568706^*^* |(2,100,14,544211) fd: 856 - sigpoll write
38911826.003 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568706^*^* |(2,100,14,544211) fd: 856 - Write - Len: 244 [f4000000 03000000 20000000 4d656469 61457863 68616e67 65416765 6e614465 6173736f 63696174 65526571 00000000 00000000 e0092e0d c9d70100 00000000 ...]
38911828.000 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568706^*^* |(2,100,14,544211) fd: 856 - Async Write Completed - calling handleWriteComplete
38911829.000 |10:13:52.268 |SdlSig |SIPStopStreaming |waitSIPResponse |SIPCdpc(2,100,85,465754) |SIPInterface(2,100,79,154728) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:11,L:0,V:0,Z:0,D:0] ClearType=0 StoppedBy=0 DisconnecType=1 StopStreamingReason=0 stackIdx=0 ReconnectPending=F forceStop=F
38911830.000 |10:13:52.268 |SdlSig-O |MXAgenaCloseLogicalChannel |NA RemoteSignal |MediaTerminationPointControl(3,100,141,2) |MTPAgenaInterface(2,100,251,13522) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:11,L:0,V:0,Z:0,D:0] ConferenceID= 50366200 PartyId= 33570869 streamFlag=F ClearType= 0 PortHandling=0 ci=41108698 lcn=0 PT=F PTId=16777216 switchingToFax=F ConnType=3
38911831.000 |10:13:52.268 |SdlSig |SIPReqAnswer |wait |SIPHandler(2,100,82,1) |SIPCdpc(2,100,85,465755) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[T:N-H:0,N:0,L:0,V:0,Z:0,D:0] SignalInfo= SIPAckSdp CcbId= 25414580 --TransType=1 --TransSecurity=0 PeerAddr = 10.132.29.229:51635
38911832.000 |10:13:52.268 |SdlSig-O |MediaExchangeAgenaUnsubscribeDtmfPayloadReq |NA RemoteSignal |MediaTerminationPointControl(3,100,141,2) |MTPAgenaInterface(2,100,251,13522) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:10,L:0,V:0,Z:0,D:0] conferenceID=50366200 PartyId=0x2004035 CI41108698 PassThru2833=T RFC2833PT=101
38911833.000 |10:13:52.268 |SdlSig-O |MXStopTalking |NA RemoteSignal |MediaTerminationPointControl(3,100,141,2) |MTPAgenaInterface(2,100,251,13522) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:9,L:0,V:0,Z:0,D:0] ClearType= 0 mConferenceID= 50366200 ci=41108698 mPartyId=0x2004035 PortHandling=0 ConnType=3
38911834.000 |10:13:52.268 |SdlSig |MXInterfaceStoppedStreaming |waitStopped |MediaExchange(2,100,149,92278) |MTPAgenaInterface(2,100,251,13522) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:8,L:0,V:0,Z:0,D:0]
38911835.000 |10:13:52.268 |SdlSig-O |MediaExchangeAgenaDeassociateReq |NA RemoteSignal |MediaTerminationPointControl(3,100,141,2) |MTPAgenaInterface(2,100,251,13522) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:7,L:0,V:0,Z:0,D:0] confID=50366200 CI=41108698
38911836.000 |10:13:52.268 |SdlSig |SIPMediaUpdateNotify |wait |SIPStationD(2,100,76,4082) |SIPStationCdfc(2,100,77,158988) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:6,L:0,V:0,Z:0,D:0] IP addr Tx: ipAddrType=0 ipv4=0.0.0.0 RTP Port Tx: 0 PacketSize: 0 CompressionType: 0 SilenceSup: Fg723BitRate: 0 IP addr Rx: ipAddrType=0 ipv4=0.0.0.0 RTP Port Rx: 0 cryptoAlgID: 0 keylen Tx: 0 saltlen Tx: 0 MKIpres Tx: 0 keylen Rx: 0 saltlen Rx: 0 MKIpres Rx: 0 NumVideoStream=1 Video Stream ID=0 IP addr Tx: ipAddrType=0 ipv4=0.0.0.0 RTP Port Tx: 0 BitRate: 0 CompressionType: 103 IP addr Rx: ipAddrType=0 ipv4=10.132.29.229 RTP Port Rx: 21420 type: 2 secureStream: F
38911837.000 |10:13:52.268 |SdlSig |MXSIPCallState |waitStopped |MediaExchange(2,100,149,92279) |SIPInterface(2,100,79,154729) |2,100,14,1414560.5426^10.132.29.229^* |[R:N-H:0,N:5,L:0,V:0,Z:0,D:0] SipCallState=2
38911831.001 |10:13:52.268 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/setSipSPIMsgArg: deliverOriginalIdentityHeader=false; origNumber=, origName=
38911831.002 |10:13:52.268 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/setPresentationIndication: namePi[1], numPi[1]
38911831.003 |10:13:52.268 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/setScreeningIndication: si[3], oct3a[83]
38911838.000 |10:13:52.268 |SdlSig |CcUpdateRegistration |call_active10 |LineCdpc(2,100,179,121990) |LineControl(2,100,178,3269) |2,100,14,1414560.5426^10.132.29.229^* |[R:N-H:0,N:5,L:0,V:0,Z:0,D:0] CI=41108689 CI.branch=0 CSS=83cc7d30-8e56-c8c3-3ed3-57b5a374fb43: AdjunctCSS= cssIns=0 aarCSS= aarDev=F FQDN=pi=0si1 CallRef=0 OLC=0 Name=locale: 1 Name: UnicodeName: pi: 0 encodeType=10 qsig-encodeType=10 ConnType=0 XferMode=0 ConnTime=0 nwLoc=0IpAddrMode=0 ipAddrType=0 ipv4=0.0.0.0:0 region= capCount=0 devType=0 mixerCId=0 mediaReq=0 portToPort.loc=0 MOH.MRGLPkid= MOH.userHoldID=0 MOH.netHoldID=0 MOH.supp=0 devName= mobileDevName= mobilePartyNumber=pi=0si1 mobileCallType=0 ctiActive=F ctiFarEndDev=0 ctiCCMId=0 devCepn= lineCepn= activeCaps=0 VideoCall=F MMUpdateCapMask=0x0 MMCap=0x1 SipConfig: BFCPAllowed=F IXAllowed=F devCap=0 CryptoCapCount=0 secure=1 loginId= UnicodeName: retriedVideo=FFromTag=ToTag=CallId= UAPortFlag=T wantDTMFRecep=1 provOOB=0 supp DTMF=0 DTMF Cfg=1 DTMF PT=0 DTMF reqMed=1 isPrefAltScript=F cdpnPatternUsage=-156339968 audioPtyId=0 doNotAppendLineCSS=F callingDP= BCUpdate=1 ccBearCap.itc=0 ccBearCap.l=0 ccBearCap.itr=0 protected=1 flushCapIns=-158110015 geolocInfo=null locPkid= locName= deductBW=F fateShareId= videoTrafficClass=Unspecified 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=1 vCTCUpdt=1 honorCodec=F honorUpdt=1 finalCalledPartition= cTypeUpdt=1 BibEnabled=0 RecordingQSIGAPDUSupported=F FarEndDeviceName=LatentCaps=null icidVal= icidGenAddr= oioi= tioi= ptParams= CAL={v=-1, m=-1, tDev=F, res=F, devType=0} displayNameUpdateFieldFlag=1 CFBCtrlSecIcon=F connBeforeANN=F
38911839.000 |10:13:52.268 |SdlSig |MXInterfaceStoppedStreaming |waitStopped |MediaExchange(2,100,149,92279) |SIPInterface(2,100,79,154729) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:5,L:0,V:0,Z:0,D:0]
38911831.004 |10:13:52.268 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/insertOPUSParameters: aMLine.ecpPtrList is not NULL
38911831.005 |10:13:52.268 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/setOpaqueFmtpStrForAudioCodecCapability: Entering setOpaqueFmtpStrForAudioCodecCapability function, payloadType=114, opaqueFmtpAttribute.isEmpty=0
38911840.000 |10:13:52.268 |SdlSig |SIPMediaUpdateNotify |wait |SIPStationD(2,100,76,4082) |SIPStationCdfc(2,100,77,158988) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:6,L:0,V:0,Z:0,D:0] IP addr Tx: ipAddrType=0 ipv4=0.0.0.0 RTP Port Tx: 0 PacketSize: 0 CompressionType: 0 SilenceSup: Fg723BitRate: 0 IP addr Rx: ipAddrType=0 ipv4=0.0.0.0 RTP Port Rx: 0 cryptoAlgID: 0 keylen Tx: 0 saltlen Tx: 0 MKIpres Tx: 0 keylen Rx: 0 saltlen Rx: 0 MKIpres Rx: 0 NumVideoStream=1 Video Stream ID=0 IP addr Tx: ipAddrType=0 ipv4=0.0.0.0 RTP Port Tx: 0 BitRate: 0 CompressionType: 103 IP addr Rx: ipAddrType=0 ipv4=10.132.29.229 RTP Port Rx: 21420 type: 2 secureStream: F
38911841.000 |10:13:52.268 |SdlSig |MediaConnectErrorInd |tcc_call_active7 |Cdcc(2,100,224,298787) |MatrixControl(2,100,146,297723) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:5,L:0,V:0,Z:0,D:0] CI1=41108688 CI2=41108689 clearType=0 Cause=0
38911831.006 |10:13:52.268 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/trafficClassEnumToStr: CCMTCL Supported trafficclass enum 1 is "conversational.audio.aq:admitted"
38911831.007 |10:13:52.268 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/insertTrafficClassAttr: CCMTCL adding trafficclass attr with value "conversational.audio.aq:admitted"
38911831.008 |10:13:52.268 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/insertVideoMline: BFCP content count =0, vMline.mVideoContentId = 1
38911831.009 |10:13:52.268 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/insertContentAttr: BFCP content -- adding content: main as mVideoContentId = VideoMain
38911841.001 |10:13:52.268 |AppInfo |cdrWrite PER RR, orig = 0, lrn = 0, current = 0
38911831.010 |10:13:52.268 |AppInfo |//SIP/Stack/Info/0x0/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 (SIP_APPLICATION_MSG), for event 30 (SIPSPI_EV_CC_MEDIA_EVENT)
38911842.000 |10:13:52.268 |SdlSig |SIPStopStreamingInd |waitForDeviceStopStreaming |SIPInterface(2,100,79,154728) |SIPCdpc(2,100,85,465754) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:7,L:0,V:0,Z:0,D:0] disconnType=153827184 myId=0
38911831.011 |10:13:52.268 |AppInfo |//SIP/Stack/Info/0x0x10f27a10/ccsip_buffer_media_event: Buffering event SIPSPI_EV_CC_MEDIA_EVENT - Purpose 0: FALSE

38911843.000 |10:13:52.268 |SdlSig |MXSIPCallState |restart |MTPAgenaInterface(2,100,251,13523) |MediaExchange(2,100,149,92279) |2,100,14,1414560.5426^10.132.29.229^* |[R:N-H:0,N:7,L:0,V:0,Z:0,D:0] SipCallState=2
38911831.012 |10:13:52.268 |AppInfo |//SIP/Stack/Info/0x0x10f27a10/act_handle_app_media_event: method = 107 state = 24
38911831.013 |10:13:52.268 |AppInfo |//SIP/Stack/Info/0x0x10f27a10/act_handle_app_media_event: Received media sip event SIP_REQUEST_ANSWER
38911831.014 |10:13:52.268 |AppInfo |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: timerContext=0x10f289f0 type=SIP_TIMER_MEDIA_ACK value=36000 retries=0
38911844.000 |10:13:52.268 |SdlSig |CcUpdateRegistration |wait |Cc(2,100,225,1) |LineCdpc(2,100,179,121990) |2,100,14,1414560.5426^10.132.29.229^* |[R:N-H:0,N:6,L:0,V:0,Z:0,D:0] CI=41108689 CI.branch=0 CSS=83cc7d30-8e56-c8c3-3ed3-57b5a374fb43: AdjunctCSS= cssIns=0 aarCSS= aarDev=F FQDN=pi=0si1 CallRef=0 OLC=0 Name=locale: 1 Name: UnicodeName: pi: 0 encodeType=10 qsig-encodeType=10 ConnType=0 XferMode=0 ConnTime=0 nwLoc=0IpAddrMode=0 ipAddrType=0 ipv4=0.0.0.0:0 region= capCount=0 devType=0 mixerCId=0 mediaReq=0 portToPort.loc=0 MOH.MRGLPkid= MOH.userHoldID=0 MOH.netHoldID=0 MOH.supp=0 devName= mobileDevName= mobilePartyNumber=pi=0si1 mobileCallType=0 ctiActive=F ctiFarEndDev=0 ctiCCMId=0 devCepn= lineCepn= activeCaps=0 VideoCall=F MMUpdateCapMask=0x0 MMCap=0x1 SipConfig: BFCPAllowed=F IXAllowed=F devCap=0 CryptoCapCount=0 secure=1 loginId= UnicodeName: retriedVideo=FFromTag=ToTag=CallId= UAPortFlag=T wantDTMFRecep=1 provOOB=0 supp DTMF=0 DTMF Cfg=1 DTMF PT=0 DTMF reqMed=1 isPrefAltScript=F cdpnPatternUsage=-156339968 audioPtyId=0 doNotAppendLineCSS=F callingDP= BCUpdate=1 ccBearCap.itc=0 ccBearCap.l=0 ccBearCap.itr=0 protected=1 flushCapIns=-158110015 geolocInfo=null locPkid= locName= deductBW=F fateShareId= videoTrafficClass=Unspecified 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=1 vCTCUpdt=1 honorCodec=F honorUpdt=1 finalCalledPartition= cTypeUpdt=1 BibEnabled=0 RecordingQSIGAPDUSupported=F FarEndDeviceName=LatentCaps=null icidVal= icidGenAddr= oioi= tioi= ptParams= CAL={v=-1, m=-1, tDev=F, res=F, devType=0} displayNameUpdateFieldFlag=1 CFBCtrlSecIcon=F connBeforeANN=F
38911845.000 |10:13:52.268 |SdlSig |MXCloseSession |restart |SIPInterface(2,100,79,154729) |MediaExchange(2,100,149,92279) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:6,L:0,V:0,Z:0,D:0]
38911845.001 |10:13:52.268 |Stopping | | |SIPInterface(2,100,79,154729) |SIPInterface(2,100,79,154729) | |NumOfCurrentInstances: 44
38911846.000 |10:13:52.268 |SdlSig |MXCloseSession |restart |MTPAgenaInterface(2,100,251,13523) |MediaExchange(2,100,149,92279) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:6,L:0,V:0,Z:0,D:0]
38911846.001 |10:13:52.268 |Stopping | | |MTPAgenaInterface(2,100,251,13523) |MTPAgenaInterface(2,100,251,13523) | |NumOfCurrentInstances: 2
38911847.000 |10:13:52.268 |SdlSig |CcDisconnReq |restart0 |SIPD(2,100,84,5) |Cdcc(2,100,224,298787) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:5,L:0,V:0,Z:0,D:0] CI=41108688 CI.branch=0 clearType=0 c.l=1 c.cid=8 c.cs=0 c.lc=0 c.r=0 cv=47 FDataType=0 opId=0 ssType=0 SsKey=0 invokeId=0 resultExp=F bpda=F OnBehalf=Media 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=2 forcedClear=F M=Unknown ;rc=2019237981 Hdrs= CanSupportSIPTandN=true TransId=0 AllowBitMask=0x7bf UserAgentOrServer=Cisco-CP8845/11.7.1 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}
38911847.001 |10:13:52.268 |AppInfo |SIPD(5) - getKeyBasedOnCiAndBranch: AddressingElement branch is 0 and ci is 41108688 mapKey is 41108688
38911847.002 |10:13:52.268 |AppInfo |SIPD(5) - getCdpcPid: found Cdpc Pid (2,100,85,465754) for mapKey 41108688
38911848.000 |10:13:52.268 |SdlSig |CcDisconnReq |restart0 |LineControl(2,100,178,3269) |Cdcc(2,100,224,298787) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:5,L:0,V:0,Z:0,D:0] CI=41108689 CI.branch=0 clearType=0 c.l=1 c.cid=8 c.cs=0 c.lc=0 c.r=0 cv=47 FDataType=0 opId=0 ssType=0 SsKey=0 invokeId=0 resultExp=F bpda=F OnBehalf=Media 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 M=Unknown ;rc=0 Hdrs= CanSupportSIPTandN=true TransId=0 AllowBitMask=0x9bf 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}
38911849.000 |10:13:52.268 |SdlSig |MXInterfaceStoppedStreaming |waitStopped |MediaExchange(2,100,149,92278) |SIPInterface(2,100,79,154728) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:5,L:0,V:0,Z:0,D:0]
38911850.000 |10:13:52.268 |SdlSig |SdlWriteReq |active |SdlTCPConnection(2,100,14,544211) |SdlLinkControl(2,100,19,1) |2,100,19,1.1568707^*^* |*TraceFlagOverrode
38911850.001 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568707^*^* |(2,100,14,544211) fd: 856 - Async Write Initiated - asyncWriteRequest
38911850.002 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568707^*^* |(2,100,14,544211) fd: 856 - sigpoll write
38911850.003 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568707^*^* |(2,100,14,544211) fd: 856 - Write - Len: 278 [16010000 03000000 1a000000 4d584167 656e6143 6c6f7365 4c6f6769 63616c43 68616e6e 656c0000 00000000 000038e4 73eac9d7 01000000 00000300 00006400 ...]
38911851.000 |10:13:52.268 |SdlSig |CcUpdateRegistration |tcc_await_two_way_release10 |Cdcc(2,100,224,298787) |Cc(2,100,225,1) |2,100,14,1414560.5426^10.132.29.229^* |[R:N-H:0,N:6,L:0,V:0,Z:0,D:0] CI=41108689 CI.branch=0 CSS=83cc7d30-8e56-c8c3-3ed3-57b5a374fb43: AdjunctCSS= cssIns=0 aarCSS= aarDev=F FQDN=pi=0si1 CallRef=0 OLC=0 Name=locale: 1 Name: UnicodeName: pi: 0 encodeType=10 qsig-encodeType=10 ConnType=0 XferMode=0 ConnTime=0 nwLoc=0IpAddrMode=0 ipAddrType=0 ipv4=0.0.0.0:0 region= capCount=0 devType=0 mixerCId=0 mediaReq=0 portToPort.loc=0 MOH.MRGLPkid= MOH.userHoldID=0 MOH.netHoldID=0 MOH.supp=0 devName= mobileDevName= mobilePartyNumber=pi=0si1 mobileCallType=0 ctiActive=F ctiFarEndDev=0 ctiCCMId=0 devCepn= lineCepn= activeCaps=0 VideoCall=F MMUpdateCapMask=0x0 MMCap=0x1 SipConfig: BFCPAllowed=F IXAllowed=F devCap=0 CryptoCapCount=0 secure=1 loginId= UnicodeName: retriedVideo=FFromTag=ToTag=CallId= UAPortFlag=T wantDTMFRecep=1 provOOB=0 supp DTMF=0 DTMF Cfg=1 DTMF PT=0 DTMF reqMed=1 isPrefAltScript=F cdpnPatternUsage=-156339968 audioPtyId=0 doNotAppendLineCSS=F callingDP= BCUpdate=1 ccBearCap.itc=0 ccBearCap.l=0 ccBearCap.itr=0 protected=1 flushCapIns=-158110015 geolocInfo=null locPkid= locName= deductBW=F fateShareId= videoTrafficClass=Unspecified 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=1 vCTCUpdt=1 honorCodec=F honorUpdt=1 finalCalledPartition= cTypeUpdt=1 BibEnabled=0 RecordingQSIGAPDUSupported=F FarEndDeviceName=LatentCaps=null icidVal= icidGenAddr= oioi= tioi= ptParams= CAL={v=-1, m=-1, tDev=F, res=F, devType=0} displayNameUpdateFieldFlag=1 CFBCtrlSecIcon=F connBeforeANN=F
38911852.000 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568707^*^* |(2,100,14,544211) fd: 856 - Async Write Completed - calling handleWriteComplete
38911851.001 |10:13:52.268 |AppInfo |Cdcc - (0298787) - dumpSecureStatus - sideA=(cap=1,1, media=0,0, feature=0,0), sideB=(cap=1,1 media=0,0, feature=0,0)
38911851.002 |10:13:52.268 |AppInfo |Cdcc - (0298787)- getSecureStatusTypeGivenSide - CFBCtrlSecIcon=0, notifyDeviceType=8, SecureStatus=0, deviceName=Unigy-NJ
38911853.000 |10:13:52.268 |SdlSig |SdlWriteReq |active |SdlTCPConnection(2,100,14,544211) |SdlLinkControl(2,100,19,1) |2,100,19,1.1568708^*^* |*TraceFlagOverrode
38911853.001 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568708^*^* |(2,100,14,544211) fd: 856 - Async Write Initiated - asyncWriteRequest
38911853.002 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568708^*^* |(2,100,14,544211) fd: 856 - sigpoll write
38911851.003 |10:13:52.268 |AppInfo |Cdcc - (0298787) - dumpSecureStatus - sideA=(cap=1,1, media=0,0, feature=0,0), sideB=(cap=1,1 media=0,0, feature=0,0)
38911851.004 |10:13:52.268 |AppInfo |Cdcc - (0298787)- getSecureStatusTypeGivenSide - CFBCtrlSecIcon=0, notifyDeviceType=4, SecureStatus=0, deviceName=SEP007686FC2B5D
38911851.005 |10:13:52.268 |AppInfo |Cdcc - (0298787) - dumpSecureStatus - sideA=(cap=1,1, media=0,0, feature=0,0), sideB=(cap=1,1 media=0,0, feature=0,0)
38911853.003 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568708^*^* |(2,100,14,544211) fd: 856 - Write - Len: 264 [08010000 03000000 2b000000 4d656469 61457863 68616e67 65416765 6e61556e 73756273 63726962 6544746d 66506179 6c6f6164 52657100 00000000 00000000 ...]
38911854.000 |10:13:52.268 |SdlSig |MXInterfaceClosed |waitShutdown |MediaExchange(2,100,149,92279) |SIPInterface(2,100,79,154729) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:5,L:0,V:0,Z:0,D:0]
38911855.000 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568708^*^* |(2,100,14,544211) fd: 856 - Async Write Completed - calling handleWriteComplete
38911856.000 |10:13:52.268 |SdlSig |MXInterfaceClosed |waitShutdown |MediaExchange(2,100,149,92279) |MTPAgenaInterface(2,100,251,13523) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:4,L:0,V:0,Z:0,D:0]
38911857.000 |10:13:52.268 |SdlSig |SdlWriteReq |active |SdlTCPConnection(2,100,14,544211) |SdlLinkControl(2,100,19,1) |2,100,19,1.1568709^*^* |*TraceFlagOverrode
38911857.001 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568709^*^* |(2,100,14,544211) fd: 856 - Async Write Initiated - asyncWriteRequest
38911857.002 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568709^*^* |(2,100,14,544211) fd: 856 - sigpoll write
38911856.001 |10:13:52.268 |Stopping | | |MediaExchange(2,100,149,92279) |MediaExchange(2,100,149,92279) | |NumOfCurrentInstances: 33
38911857.003 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568709^*^* |(2,100,14,544211) fd: 856 - Write - Len: 245 [f5000000 03000000 0d000000 4d585374 6f705461 6c6b696e 67000000 00000000 00f20600 00c9d701 00000000 00030000 00640000 000e0000 00140000 004e5943 ...]
38911858.000 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568709^*^* |(2,100,14,544211) fd: 856 - Async Write Completed - calling handleWriteComplete
38911859.000 |10:13:52.268 |SdlSig |CcDisconnReq |waitSIPResponse |SIPCdpc(2,100,85,465754) |SIPD(2,100,84,5) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:3,L:0,V:0,Z:0,D:0] CI=41108688 CI.branch=0 clearType=0 c.l=1 c.cid=8 c.cs=0 c.lc=0 c.r=0 cv=47 FDataType=0 opId=0 ssType=0 SsKey=0 invokeId=0 resultExp=F bpda=F OnBehalf=Media 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=2 forcedClear=F M=Unknown ;rc=2019237981 Hdrs= CanSupportSIPTandN=true TransId=0 AllowBitMask=0x7bf UserAgentOrServer=Cisco-CP8845/11.7.1 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}
38911860.000 |10:13:52.268 |SdlSig |SdlWriteReq |active |SdlTCPConnection(2,100,14,544211) |SdlLinkControl(2,100,19,1) |2,100,19,1.1568710^*^* |*TraceFlagOverrode
38911860.001 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568710^*^* |(2,100,14,544211) fd: 856 - Async Write Initiated - asyncWriteRequest
38911860.002 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568710^*^* |(2,100,14,544211) fd: 856 - sigpoll write
38911859.001 |10:13:52.268 |AppInfo |SIPCdpc(465754) - addSessionIdHeader: mSessionId.deviceUUID: 2e345600dbe4990e7971dfab25414579, mSessionId.peerUUID: 249e13bf00105000a000007686fc2b5d
38911859.002 |10:13:52.268 |AppInfo |SIPCdpc(465754) - appendReasonHdr: appendReasonHdr - Invalid Disconnect Cause(cause=47), No Reason Header Appended
38911859.003 |10:13:52.268 |AppInfo |SIPCdpc(465754) - addTransparencyInfo: attaching transparency object
38911860.003 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568710^*^* |(2,100,14,544211) fd: 856 - Write - Len: 244 [f4000000 03000000 20000000 4d656469 61457863 68616e67 65416765 6e614465 6173736f 63696174 65526571 00000000 00000000 e0092e0d c9d70100 00000000 ...]
38911859.004 |10:13:52.268 |AppInfo |//SIP/Stack/Error/0x0/sipAppGetMessagePlatformDataOutbound: Invalid message platform data in the container
38911859.005 |10:13:52.268 |AppInfo |SIPCdpc(465754) - appendRPIDHdrForOriginalCalledParty: SIP device does not Support Orig Dialled Phone nego: 0
38911861.000 |10:13:52.268 |NetEvent | | |SdlNetworkService(2,100,1,1) | |2,100,19,1.1568710^*^* |(2,100,14,544211) fd: 856 - Async Write Completed - calling handleWriteComplete
38911862.000 |10:13:52.268 |SdlSig |CcDisconnReq |call_active10 |LineCdpc(2,100,179,121990) |LineControl(2,100,178,3269) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:3,L:0,V:0,Z:0,D:0] CI=41108689 CI.branch=0 clearType=0 c.l=1 c.cid=8 c.cs=0 c.lc=0 c.r=0 cv=47 FDataType=0 opId=0 ssType=0 SsKey=0 invokeId=0 resultExp=F bpda=F OnBehalf=Media 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 M=Unknown ;rc=0 Hdrs= CanSupportSIPTandN=true TransId=0 AllowBitMask=0x9bf 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}
38911863.000 |10:13:52.268 |SdlSig |DbCdrReq |wait |EnvProcessCdr(2,100,257,1) |Cdcc(2,100,224,298787) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[T:N-H:0,N:0,L:0,V:0,Z:0,D:0] 01000000 02000000 a6230e00 d0447302 2cac2a5a 02000000 d0447302 0a841b1e 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 2f000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 556e6967 792d4e4a 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 04000000 00000000 00000000 00000000 386399f6 de9b63e9 e09b63e9 64000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 0a000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 d1447302 02000000 00000000 0a841de5 31313038 31000000 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 2f000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 53455030 30373638 36464332 42354400 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 04000000 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 30ac2a5a 30ac2a5a 00000000 02000000 03000000 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 31313136 36003235 38303030 31000000 198afa0f 148afa0f 00000000 00000000 00000000 00000000 2c8afa0f 2c8afa0f 00000000 00000000 00000000 00000000 448afa0f 448afa0f 00000000 00000000 e81abb11 31313038 31003233 00303030 31000000 6d8afa0f 688afa0f 009b9811 00000000 00000000 00000000 808afa0f 808afa0f 00000000 00000000 00000000 00000000 988afa0f 988afa0f 00ec9d10 e0461f12 00005011 31313038 31003235 38303030 31000000 c18afa0f bc8afa0f 00000000 00000000 00000000 00000000 d48afa0f d48afa0f 90523e10 d8e2040d d0cd0512 31313038 31003233 00303030 31000000 fd8afa0f f88afa0f 00000000 00000000 00000000 00000000 108bfa0f 108bfa0f a01c9b10 c8bea611 c8f56710 909dfc0c 00000000 00000000 00000000 00000000 388bfa0f 388bfa0f 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 6c8bfa0f 6c8bfa0f 00000000 00000000 18000000 0c000000 848bfa0f 848bfa0f 31302e31 33322e32 372e3330 00000000 a88bfa0f 9c8bfa0f 00302e31 33322e32 372e3400 00010000 b48bfa0f b48bfa0f 01000000 a019e511 00000000 00000000 00000000 00000000 00000000 f4010000 f4010000 e08bfa0f e08bfa0f 00000000 00000000 00000000 00000000 00000000 00000000 00000000 0a000000 06000000 06000000 108cfa0f 108cfa0f 00000000 00000000 06000000 00000000 288cfa0f 288cfa0f 00000000
38911864.000 |10:13:52.268 |SdlSig |MXCloseSession |restart |SIPInterface(2,100,79,154728) |MediaExchange(2,100,149,92278) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:3,L:0,V:0,Z:0,D:0]
38911863.001 |10:13:52.268 |AppInfo |EnvProcessCdr::wait_DbCdrReq
38911863.002 |10:13:52.268 |AppInfo |EnvProcessCdr::wait_DbCdrReq DETAILED Entries 289874, Inserts 289874, ZeroCalls 0, StartRecords 0, Default 0
38911863.003 |10:13:52.268 |AppInfo |EnvProcessCdr::formatCdrData
38911864.001 |10:13:52.268 |Stopping | | |SIPInterface(2,100,79,154728) |SIPInterface(2,100,79,154728) | |NumOfCurrentInstances: 43
38911865.000 |10:13:52.268 |SdlSig |MXCloseSession |restart |MTPAgenaInterface(2,100,251,13522) |MediaExchange(2,100,149,92278) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:3,L:0,V:0,Z:0,D:0]
38911865.001 |10:13:52.268 |Stopping | | |MTPAgenaInterface(2,100,251,13522) |MTPAgenaInterface(2,100,251,13522) | |NumOfCurrentInstances: 1
38911866.000 |10:13:52.268 |SdlSig |CcDisconnReq |wait |SIPStationD(2,100,76,4082) |LineCdpc(2,100,179,121990) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:2,L:0,V:0,Z:0,D:0] CI=41108689 CI.branch=0 clearType=0 c.l=1 c.cid=8 c.cs=0 c.lc=0 c.r=0 cv=47 FDataType=0 opId=0 ssType=0 SsKey=0 invokeId=0 resultExp=F bpda=F OnBehalf=Media 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 M=Unknown ;rc=0 Hdrs= CanSupportSIPTandN=true TransId=0 AllowBitMask=0x9bf 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}
38911863.004 |10:13:52.268 |AppInfo |EnvProcessCdr::outputCdrData CDR data (size-579)- 1,2,926630,41108688,1512746028,2,41108688,505119754,"11166","",0,47,4,0,0,0,0,0,0,0,0,0,0,"0","0",41108689,2,0,-451050486,"11081","11081","11081",0,47,4,0,0,0,0,0,0,0,0,0,0,"0","0",1512746032,1512746032,"11081","da3149c1-5387-45fc-a99b-f382f8f8d91a","PT-INTERNAL","","PT-INTERNAL","PT-INTERNAL",0,"Unigy-NJ","SEP007686FC2B5D",13,13,0,0,0,0,0,"StandAloneCluster",0,"","",0,"",2,3,0,0,0,0,"","","","10.132.27.30","",0,0,0,0,0,0,0,0,0,0,0,0,1,"62A123800001000000065D670D1B840A",0,"",0,0,0,"","",2,"","","","","","","","",0,0,"","","","","","","","",0,0,0,"11081","11081","11081",""

38911867.000 |10:13:52.268 |SdlSig |MXInterfaceClosed |waitShutdown |MediaExchange(2,100,149,92278) |SIPInterface(2,100,79,154728) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:2,L:0,V:0,Z:0,D:0]
38911868.000 |10:13:52.268 |SdlSig |MXInterfaceClosed |waitShutdown |MediaExchange(2,100,149,92278) |MTPAgenaInterface(2,100,251,13522) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:1,L:0,V:0,Z:0,D:0]
38911868.001 |10:13:52.268 |Stopping | | |MediaExchange(2,100,149,92278) |MediaExchange(2,100,149,92278) | |NumOfCurrentInstances: 32
38911869.000 |10:13:52.268 |SdlSig |CcDisconnReq |translate |SIPStationCdfc(2,100,77,158988) |SIPStationD(2,100,76,4082) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:1,L:0,V:0,Z:0,D:0] CI=41108689 CI.branch=0 clearType=0 c.l=1 c.cid=8 c.cs=0 c.lc=0 c.r=0 cv=47 FDataType=0 opId=0 ssType=0 SsKey=0 invokeId=0 resultExp=F bpda=F OnBehalf=Media 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 M=Unknown ;rc=0 Hdrs= CanSupportSIPTandN=true TransId=0 AllowBitMask=0x9bf 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}
38911869.001 |10:13:52.268 |AppInfo |SIPStationCdfc::checkAndInsertAnn annId = 0, s.sv = 2
38911831.015 |10:13:52.268 |AppInfo |//SIP/Stack/Info/0x0x10f27a10/sipSPISendAck: Associated container=0xd0ae828 to Ack
38911870.000 |10:13:52.268 |SdlSig |MediaDisconnectReply |waitErrorCleanup |MediaManager(2,100,144,85708) |MediaExchange(2,100,149,92278) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:3,L:0,V:0,Z:0,D:0] CI1=41108688 CI2=41108698 sc=0 disconnType=1 ssReason=0 clearType=0 IF1Created=T IF2Created=T party1.mMediaCoordinatorNodeId=2 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
38911870.001 |10:13:52.268 |AppInfo |!!ERROR!! -MediaManager-(85708)::waitErrorCleanup_MediaDisconnectReply, ERROR waitErrorCleanup_MediaDisconnectReply
38911831.016 |10:13:52.268 |AppInfo |//SIP/Stack/Transport/0x0x10f27a10/sipSPISendAck: Sending ACK to the transport layer
38911870.002 |10:13:52.268 |AppInfo |!!ERROR!! -MediaManager-(85708)::waitErrorCleanup_MediaDisconnectReply, ERROR:recv all disconnect replies, stopProcess
38911831.017 |10:13:52.268 |AppInfo |//SIP/Stack/Transport/0x0x10f27a10/sipSPITransportSendMessage: msg=0x107bd190, addr=10.132.29.229, port=51635, sentBy_port=0, is_req=1, tran
38911870.003 |10:13:52.268 |Stopping | | |MediaManager(2,100,144,85708) |MediaManager(2,100,144,85708) | |NumOfCurrentInstances: 33
38911831.018 |10:13:52.268 |AppInfo |//SIP/Stack/Transport/0x0/sipInstanceGetConnectionId: gcb=0x10f27a10 is already on connection=0x106aeaa8 context_list
38911831.019 |10:13:52.268 |AppInfo |//SIP/Stack/Transport/0x0x10f27a10/sipTransportLogicSendMsg: Set to send the msg=0x107bd190
38911871.000 |10:13:52.269 |SdlSig |CcDisconnReq |active |SIPCdpc(2,100,85,465755) |SIPStationCdfc(2,100,77,158988) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:3,L:0,V:0,Z:0,D:0] CI=41108689 CI.branch=0 clearType=0 c.l=1 c.cid=8 c.cs=0 c.lc=0 c.r=0 cv=47 FDataType=0 opId=0 ssType=0 SsKey=0 invokeId=0 resultExp=F bpda=F OnBehalf=Media 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 M=Unknown ;rc=0 Hdrs= CanSupportSIPTandN=true TransId=0 AllowBitMask=0x9bf 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}
38911831.020 |10:13:52.269 |AppInfo |//SIP/Stack/Transport/0x0x10f27a10/sipTransportPostSendMessage: Posting send for msg=0x107bd190, addr=10.132.29.229, port=51635, connId=102455 for
38911871.001 |10:13:52.269 |AppInfo |SIPCdpc(465755) - active_CcDisconnReq: ccDisconnReq.onBehalfOf=Media : ccDisconnReq.s.sv=2 : ccDisconnReq.c.cv=47
38911831.021 |10:13:52.269 |AppInfo |//SIP/Stack/States/0x0x10f27a10/sipSPIChangeState: 0x10f27a10 : State change from (SIP_STATE_RECD_SUCCESS, SUBSTATE_NONE) to (STATE_ACTIVE, SUBSTATE_NONE)
38911831.022 |10:13:52.269 |AppInfo |//SIP/SIPHandler/ccbId=25414580/scbId=0/findDevicePID: Routed to SIPD by ccbId/scbId
38911831.023 |10:13:52.269 |AppInfo |//SIP/Stack/Info/0x0x10f27a10/sipSPICallActive: Transaction Complete. Lock on Facilities released.
38911831.024 |10:13:52.269 |AppInfo |//SIP/Stack/Info/0x0x10f27a10/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue that are going to b
38911872.000 |10:13:52.269 |SdlSig |SIPDisconnReq |wait |SIPHandler(2,100,82,1) |SIPCdpc(2,100,85,465754) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[T:N-H:0,N:0,L:0,V:0,Z:0,D:0] CcbId= 25414579 --TransType=2 --TransSecurity=0 PeerAddr = 10.132.27.30:45848 ccCause= 47 sip_disc_cause= 0
38911872.001 |10:13:52.269 |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)
38911872.002 |10:13:52.269 |AppInfo |//SIP/Stack/Info/0x0x11aff060/act_sentsucc_disconnect: Received POTS Disconnect - Holding BYE till we receive ACK or run
38911871.002 |10:13:52.269 |AppInfo |SIPCdpc(465755) - addSessionIdHeader: mSessionId.deviceUUID: 249e13bf00105000a000007686fc2b5d, mSessionId.peerUUID: 2e345600dbe4990e7971dfab25414579
38911871.003 |10:13:52.269 |AppInfo |SIPCdpc(465755) - appendReasonHdr: appendReasonHdr - Invalid Disconnect Cause(cause=47), No Reason Header Appended
38911871.004 |10:13:52.269 |AppInfo |SIPCdpc(465755) - addTransparencyInfo: attaching transparency object
38911871.005 |10:13:52.269 |AppInfo |//SIP/Stack/Error/0x0/sipAppGetMessagePlatformDataOutbound: Invalid message platform data in the container
38911873.000 |10:13:52.269 |SdlSig |DSetCallPhase |wait |SIPStationD(2,100,76,4082) |SIPStationCdfc(2,100,77,158988) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:5,L:0,V:0,Z:0,D:0] CallPhase=CALL_CLEARING
38911873.001 |10:13:52.269 |AppInfo |SIPStationD(4082) - DEBUG- wait_DSetCallPhase updateACall=41108689 from Phase=1 to callPhase=3.
38911874.000 |10:13:52.269 |SdlSig |DSetCallState |wait |SIPStationD(2,100,76,4082) |SIPStationCdfc(2,100,77,158988) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:5,L:0,V:0,Z:0,D:0] CallState = disconnect_request11
38911875.000 |10:13:52.269 |SdlSig |MediaCoordinatorDelResource |wait |MediaCoordinator(2,100,145,1) |MediaManager(2,100,144,85708) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:4,L:0,V:0,Z:0,D:0] CI= 41108698;clearType=0
38911875.001 |10:13:52.269 |AppInfo |SIG-MediaCoordinator-wait_MediaCoordinatorDelResource - CI=41108698 count=0 mrmNodeId=2
38911876.000 |10:13:52.269 |SdlSig |SIPSPISignal |wait |SIPTcp(2,100,74,1) |SIPHandler(2,100,82,1) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:4,L:0,V:0,Z:0,D:0] ACK SIPSPI_EV_SEND_MESSAGE context_id=25219107
38911876.001 |10:13:52.269 |AppInfo |SIPTcp - wait_SdlSPISignal: Outgoing SIP TCP message to 10.132.29.229 on port 51635 index 102455
[74646239,NET]

 

3 Replies 3

seems like the MTP is not getting allocated here:

we would see something as "countChange=1"next to the MTP if its allocated successfully and we don't see it here, 

 

you can collect the below information from gwy to isolate further or try restarting the IPVMSA service on CUCM:

debug dspfarm events
debug sccp events
debug voip xcodemsp
debug voip dspapi all

show sccp connections
show media resource status
show sccp connections summary

 

 

Ayodeji Okanlawon
VIP Alumni
VIP Alumni

You will need to attach the full cucm logs as well as call details. This call traversed more than one cucm.. 

+++ here we see Sdlsig... Inbound request from cucm with CTI ID of 3..for MTP to do OLC.  So we need logs on that cucm too.. 

 

38911787.000 |10:13:52.267 |SdlSig-I |MXAgenaOpenLogicalChannelAck |waitForMXCapabilitiesorOfferorAnswer |MTPAgenaInterface(2,100,251,13523) |MediaTerminationPointControl(3,100,141,2) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:0,L:0,V:0,Z:0,D:0] rc=1 isMultiMedia=F LCN=0 partyId=33570870 port=0 ipAddrType=1 ipv6=::
38911787.001 |10:13:52.267 |AppInfo |DET-AgenaInterfaceBase-(13523)::sessionEstablished_MediaExchangeAgenaOpenLogicalChannelAck, LCN=1, mediaType=1

 

+++ Here this cucm responds with OLCAck error. +++
38911788.000 |10:13:52.267 |SdlSig |MXErrorReport |interfacesEstablished |MediaExchange(2,100,149,92279) |MTPAgenaInterface(2,100,251,13523) |3,100,14,20.120777^10.132.6.4^NYCGTWMTP |[R:N-H:0,N:1,L:0,V:0,Z:0,D:0] error=0 CallMediaFailureCause=unknown failure case Reason=Audio Channel OLCAck with error recd

 

We need full picture of the call to know why MTP or xcoder is needed. We also need to see the debugs requested from the gateway as thus looks like an iOS mtp. 

Please don't paste the logs. Attach them

Please rate all useful posts

I found there was MTP required  enabled on that SIP trunk and  unchecked it. Looks like that fixed issue. We are still monitoring those calls .

As I think mtp req was pushing to use mtp for any calls on that sip trunk. But it's not clear for me was mtp resources exhausted or ??  I saw unknown dtmf payload on that logs does it mean mtp could not process that dtmf payload ?

Thank you