{\rtf1\ansi\ansicpg1252\deff0\deflang1033{\fonttbl{\f0\fnil\fcharset0 Courier New;}{\f1\fswiss\fcharset0 Arial;}} {\*\generator Msftedit 5.41.15.1515;}\viewkind4\uc1\pard\f0\fs20 |\par 03/24/2010 13:26:04.459 CCM|EnvProcessUdpPort - EnvProcessUdpHandler::fireSignal() varId = 0|\par 03/24/2010 13:26:04.459 CCM|EnvProcessUdpPort - EnvProcessUdpHandler::send(buff, 464, 10.249.224.18:5065)|\par 03/24/2010 13:26:04.953 CCM|CMProcMon - ------Entered Router Verification|\par 03/24/2010 13:26:04.953 CCM|CMProcMon - ----Exited Router Verification|\par 03/24/2010 13:26:05.829 CCM|EnvProcessUdpHandler::handle_input Status: 0, Id: 0|\par 03/24/2010 13:26:05.829 CCM|//SIP/Stack/Error/0x0/DROPPING unregistered header Cisco-Guid: 2469131041-909906399-2151588905-2862016808|\par 03/24/2010 13:26:05.829 CCM|//SIP/Stack/Error/0x0/DROPPING unregistered header Timestamp: 1269408365|\par 03/24/2010 13:26:05.829 CCM|//SIP/SIPUdp/wait_UdpDataInd: Incoming SIP UDP message size 1091 from 10.10.6.10:[64248]:\par INVITE sip:0454916903@10.10.6.9:5060 SIP/2.0\par Via: SIP/2.0/UDP 10.10.6.10:5060;branch=z9hG4bK1EE4C\par Remote-Party-ID: ;party=calling;screen=no;privacy=off\par From: ;tag=9055EC-1CF2\par To: \par Date: Wed, 24 Mar 2010 05:26:05 GMT\par Call-ID: 94410CC7-363C11DF-8043A429-AA96E928@10.10.6.10\par Supported: 100rel,timer,resource-priority,replaces\par Min-SE: 1800\par Cisco-Guid: 2469131041-909906399-2151588905-2862016808\par User-Agent: Cisco-SIPGateway/IOS-12.x\par Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER\par CSeq: 101 INVITE\par Max-Forwards: 70\par Timestamp: 1269408365\par Contact: \par Expires: 180\par Allow-Events: telephone-event\par Content-Type: application/sdp\par Content-Disposition: session;handling=required\par Content-Length: 240\par \par v=0\par o=CiscoSystemsSIP-GW-UserAgent 474 8181 IN IP4 10.10.6.10\par s=SIP Call\par c=IN IP4 10.10.6.10\par t=0 0\par m=audio 17726 RTP/AVP 8 101\par c=IN IP4 10.10.6.10\par a=rtpmap:8 PCMA/8000\par a=rtpmap:101 telephone-event/8000\par a=fmtp:101 0-16\par a=ptime:20\par |\par 03/24/2010 13:26:05.829 CCM|//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 2 for event 1|\par 03/24/2010 13:26:05.829 CCM|//SIP/Stack/Transport/0x0/context=(nil)|\par 03/24/2010 13:26:05.829 CCM|//SIP/Stack/Info/0x0/Checking Invite Dialog|\par 03/24/2010 13:26:05.830 CCM|//SIP/Stack/Info/0x0/Added context(0xb415f780) with key=[85] to table|\par 03/24/2010 13:26:05.830 CCM|//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.10.6.10,Port 5060, Transport 1, SentBy Port 5060|\par 03/24/2010 13:26:05.830 CCM|//SIP/Stack/States/0xb415f780/0xb415f780 : State change from (STATE_NONE, SUBSTATE_NONE) to (STATE_IDLE, SUBSTATE_NONE)|\par 03/24/2010 13:26:05.830 CCM|//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.10.6.10,Port 64248, Transport 1, SentBy Port 5060|\par 03/24/2010 13:26:05.830 CCM|//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.10.6.10,Port 64248, Transport 1, SentBy Port 5060|\par 03/24/2010 13:26:05.830 CCM|//SIP/Stack/Info/0xb415f780/Received current remote name: , current remote number: 6000|\par 03/24/2010 13:26:05.830 CCM|//SIP/Stack/Info/0xb415f780/Received ;screen=no ;privacy=off -> Setting Octet3A 0x80, extended_privacy 0x00|\par 03/24/2010 13:26:05.830 CCM|//SIP/Stack/Info/0x0/No GTD found in inbound container|\par 03/24/2010 13:26:05.830 CCM|//SIP/Stack/Info/0xb415f780/****Adding to UAS Request table.|\par 03/24/2010 13:26:05.830 CCM|//SIP/Stack/Info/0xb415f780/Added to table. ccb=0xb415f780 key=94410CC7-363C11DF-8043A429-AA96E928@10.10.6.100454916903|\par 03/24/2010 13:26:05.830 CCM|//SIP/Stack/Info/0xb415f780/Calling name , number 6000, Calling oct3 0x00, oct_3a 0x80, ext_priv 0x00, Called number 0454916903, o|\par 03/24/2010 13:26:05.830 CCM|//SIP/Stack/Info/0xb415f780/Carrier id code , prev_cid NONE, next_cid NONE, prev_tgrp NONE, next_tgrp NONE|\par 03/24/2010 13:26:05.830 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/sipSPIGetCallExtensionSupported: SIPRel1xxEnabledServiceParamSetting=0 , ccb->pld.outboundRel1xx=1|\par 03/24/2010 13:26:05.830 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_EXPIRES value=180000 retries=0|\par 03/24/2010 13:26:05.831 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: type=SIP_TIMER_EXPIRES value=180000 retries=0|\par 03/24/2010 13:26:05.831 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/extractAssertedInfo: parseResult[1]|\par 03/24/2010 13:26:05.831 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/convertStringToCcmIpAddr: return result = 1|\par 03/24/2010 13:26:05.831 CCM|//SIP/SIPD(1,52,10)/ccbId=120/scbId=0/restart0_SIPSetupInd: mTsp.deviceName[10.10.6.10]|\par 03/24/2010 13:26:05.831 CCM|SPROC getCtrlPid - callingNum=6000, inputCtrlPid=(1,100,172,1)|\par 03/24/2010 13:26:05.831 CCM|DbMobility: getMatchedRemDest starts: cnumber = 6000|\par 03/24/2010 13:26:05.831 CCM|DbMobility: getMatchedRemDest: full match case|\par 03/24/2010 13:26:05.831 CCM|DbMobility: can't find remdest 6000 in map|\par 03/24/2010 13:26:05.832 CCM|//SIP/SIPD(1,52,10)/ccbId=120/scbId=0/updateSrtpFallbackSupport: mTsp.deviceName[10.10.6.10] - sRTP fallback supported = False|\par 03/24/2010 13:26:05.832 CCM|//SIP/SIPCdpc(1,53,85)/ci=0/ccbId=120/scbId=0/getDslTaAddr: FDslAddr.ipAddr|\par 03/24/2010 13:26:05.832 CCM|//SIP/SIPCdpc(1,53,85)/ci=0/ccbId=120/scbId=0/getDefAe: SIPCdpc=85, nodeId=1, processNumber=52 ci=0, branch=0|\par 03/24/2010 13:26:05.832 CCM|//SIP/SIPCdpc(1,53,85)/ci=0/ccbId=120/scbId=0/handleSIPUASSessionExpires: isMidCall[0], method[102]|\par 03/24/2010 13:26:05.832 CCM|//SIP/SIPCdpc(1,53,85)/ci=0/ccbId=120/scbId=0/handleSIPUASSessionExpires: In Invite SE=NULL, mOtherUASupp session timers|\par 03/24/2010 13:26:05.832 CCM|//SIP/SIPCdpc(1,53,85)/ci=0/ccbId=120/scbId=0/setSIPSessionExpiresTimer: interval[900] secs|\par 03/24/2010 13:26:05.832 CCM|//SIP/SIPCdpc(1,53,85)/ci=0/ccbId=120/scbId=0/preProcessOffer: |\par 03/24/2010 13:26:05.832 CCM|//SIP/SIPCdpc(1,53,85)/ci=0/ccbId=120/scbId=0/preProcessOffer: endpointSupportsSrtpFallBack=0,allowSrtpFallback=0|\par 03/24/2010 13:26:05.832 CCM|//SIP/SIPCdpc(1,53,85)/ci=0/ccbId=120/scbId=0/preProcessOffer: audiomLines[0]: rtp=1,srtp=0,deviceNOTSrtpCapable=1,numCrypto=0,isOfferFromCCM=0,sipEndpointCanRcvSrtpOffers=0,deviceSupportsSrtpFB=0|\par 03/24/2010 13:26:05.833 CCM|//SIP/SIPD(1,52,10)/ccbId=0/scbId=0/getKeyBasedOnCiAndBranch: AddressingElement branch is 0 and ci is 27646255 mapKey is 27646255|\par 03/24/2010 13:26:05.833 CCM|//SIP/SIPD(1,52,10)/ccbId=120/scbId=0/restart0_CcCiRes: Adding Cdpc Pid (1,100,53,85) with mapKey 27646255 and branch 0 to mCiToPid table|\par 03/24/2010 13:26:05.833 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/getDefAe: SIPCdpc=85, nodeId=1, processNumber=52 ci=27646255, branch=0|\par 03/24/2010 13:26:05.833 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/sendRSVPRegisterReq: capCount[1], videoCap[0], dataCap[2]|\par 03/24/2010 13:26:05.834 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/inBoundWaitRSVPRes_RSVPRegisterRes: policy[0], resvStatus[0]|\par 03/24/2010 13:26:05.834 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/updateAllowedMethods: mEndpointAllowedMethods=07ff|\par 03/24/2010 13:26:05.834 CCM|setEndpointsDtmfCaps: Detected inband DTMF support.|\par 03/24/2010 13:26:05.834 CCM|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|\par 03/24/2010 13:26:05.834 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/getDslTaAddr: FDslAddr.ipAddr|\par 03/24/2010 13:26:05.834 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/getDefAe: SIPCdpc=85, nodeId=1, processNumber=52 ci=27646255, branch=0|\par 03/24/2010 13:26:05.834 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/getIdentityIncomingSIPMsg: fIdParseRes=[1], fRemoteNum[6000], fRemoteNam[], fRemoteNumPi[1], fRemoteNamPi[1], fRemoteSi[0]|\par 03/24/2010 13:26:05.834 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/preProcessOffer: |\par 03/24/2010 13:26:05.834 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/preProcessOffer: endpointSupportsSrtpFallBack=0,allowSrtpFallback=0|\par 03/24/2010 13:26:05.834 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/preProcessOffer: audiomLines[0]: rtp=1,srtp=0,deviceNOTSrtpCapable=1,numCrypto=0,isOfferFromCCM=0,sipEndpointCanRcvSrtpOffers=0,deviceSupportsSrtpFB=0|\par 03/24/2010 13:26:05.834 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/getDefCcRegister: Secure status=1, mSrtpPresent=0|\par 03/24/2010 13:26:05.834 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/getDefCcSetupInd: No Replaces header is Present|\par 03/24/2010 13:26:05.834 CCM|CMSIPUtility::decodeRPHdr - no RP Header found, defaulting to to -000000.0|\par 03/24/2010 13:26:05.834 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/fillLineIdInfoInRegister: partition: DN : |\par 03/24/2010 13:26:05.835 CCM|Cdcc - (0000111) - storeDchanCrp - secure capability on side 0 is (1,1)|\par 03/24/2010 13:26:05.835 CCM|Cdcc::preliminaryProcessCcSetupInd(0000111): precLvl=5|\par 03/24/2010 13:26:05.836 CCM|Digit Analysis: wait_DaReq: daReq.partitionSearchSpace(4e001f26-4690-e654-5bd4-600a1c9b16e1), filteredPartitionSearchSpaceString(Makati_PT:Cebu_PT:Tarlac_PT:PT_INTERNAL), partitionSearchSpaceString(Makati_PT:Cebu_PT:Tarlac_PT:PT_INTERNAL)|\par 03/24/2010 13:26:05.836 CCM|Digit Analysis: Host Address=10.10.6.9 MATCHES this node's IP address.|\par 03/24/2010 13:26:05.836 CCM|Digit Analysis: wait_DaReq: Matching SIP URL, Numeric User, user=0454916903|\par 03/24/2010 13:26:05.836 CCM|Digit analysis: wait_DaReq - cepn=[] BlockFlag=[1]|\par 03/24/2010 13:26:05.836 CCM|Digit Analysis: getDaRes - voiceMailCallingSearchSpace=[]|\par 03/24/2010 13:26:05.836 CCM|Digit analysis: match(pi="2", fqcn="", cn="6000",plv="5", pss="Makati_PT:Cebu_PT:Tarlac_PT:PT_INTERNAL", TodFilteredPss="Makati_PT:Cebu_PT:Tarlac_PT:PT_INTERNAL", dd="0454916903",dac="0")|\par 03/24/2010 13:26:05.836 CCM|Digit analysis: analysis results|\par 03/24/2010 13:26:05.837 CCM||PretransformCallingPartyNumber=6000\par |CallingPartyNumber=6000\par |DialingPartition=23fb1894-1168-7883-3735-a3b2b7c7c872\par |DialingPattern=\par |FullyQualifiedCalledPartyNumber=\par |DialingPatternRegularExpression=\par |DialingWhere=\par |PatternType=Unknown\par |PotentialMatches=NoPotentialMatchesExist\par |DialingSdlProcessId=(0,0,0)\par |PretransformDigitString=0454916903\par |PretransformTagsList=\par |PretransformPositionalMatchList=\par |CollectedDigits=\par |UnconsumedDigits=\par |TagsList=\par |PositionalMatchList=\par |VoiceMailbox=\par |VoiceMailCallingSearchSpace=\par |VoiceMailPilotNumber=\par |RouteBlockFlag=BlockThisPattern\par |RouteBlockCause=1\par |AlertingName=\par |UnicodeDisplayName=\par |DisplayNameLocale=1\par |InterceptPartition=23fb1894-1168-7883-3735-a3b2b7c7c872\par |InterceptPattern=0454916903\par |InterceptWhere=\par |InterceptSdlProcessId=(1,100,1)\par |InterceptSsType=16777227\par |InterceptSsKey=633863\par |InterceptSsNotifyType=1\par |OverlapSendingFlagEnabled=0\par |WithTags=\par |WithValues=\par |CallingPartyNumberPi=NotSelected\par |ConnectedPartyNumberPi=NotSelected\par |CallingPartyNamePi=NotSelected\par |ConnectedPartyNamePi=NotSelected\par |CallManagerDeviceType=NoDeviceType\par |PatternPrecedenceLevel=Routine\par |CallableEndPointName=[]\par |PatternNodeId=[]\par |AARNeighborhood=[]\par |AARDestinationMask=[]\par |AARKeepCallHistory=true\par |AARVoiceMailEnabled=false\par |NetworkLocation=OnNet\par |Calling Party Number Type=Cisco Unified CallManager\par |Calling Party Numbering Plan=Cisco Unified CallManager\par |Called Party Number Type=Cisco Unified CallManager\par |Called Party Numbering Plan=Cisco Unified CallManager\par |ProvideOutsideDialtone=false\par |AllowDeviceOverride=false\par |AlternateMatches= Information Not Available\par |TranslationPatternDetails= Information Not Available\par |ResourcePriorityNamespace=|\par 03/24/2010 13:26:05.837 CCM|processCCMFeatureData: operationIeIdd=0|\par 03/24/2010 13:26:05.837 CCM|Cdcc::fireCfInterceptInd: precLvl=5|\par 03/24/2010 13:26:05.837 CCM|//SIP/SIPD(1,52,10)/ccbId=0/scbId=0/getKeyBasedOnCiAndBranch: AddressingElement branch is 0 and ci is 27646255 mapKey is 27646255|\par 03/24/2010 13:26:05.837 CCM|//SIP/SIPD(1,52,10)/ccbId=0/scbId=0/getCdpcPid: found Cdpc Pid (1,100,53,85) for mapKey 27646255|\par 03/24/2010 13:26:05.837 CCM|MeetMeConferenceManager - wait_SsInterceptInd - MeetMe join request for party=[27646255], DN=[0454916903], ProcessId(1,101,3)|\par 03/24/2010 13:26:05.838 CCM|MeetMeConference - List - sideA( 1,27646229,4,1) sideB( 1,27646232,1)|\par 03/24/2010 13:26:05.838 CCM|MeetMeConference - UpdateMeetMeConfereeInfo - List - sideA( 1,27646229,4,1) sideB( 1,27646232,1,1)|\par 03/24/2010 13:26:05.838 CCM|MeetMeConference - UpdateMeetMeConfereeInfo - MeetMeList enteries in list sideA( 1,27646229,4,1) sideB( 1,27646232,1,1)|\par 03/24/2010 13:26:05.839 CCM|MeetMeConference - UpdateMeetMeConfereeInfo - MeetMeList enteries in list sideA( 1,27646255,8,1) sideB( 0,0,0,0)|\par 03/24/2010 13:26:05.839 CCM|Digit Analysis: wait_DaReq: daReq.partitionSearchSpace(4e001f26-4690-e654-5bd4-600a1c9b16e1), filteredPartitionSearchSpaceString(Makati_PT:Cebu_PT:Tarlac_PT:PT_INTERNAL), partitionSearchSpaceString(Makati_PT:Cebu_PT:Tarlac_PT:PT_INTERNAL)|\par 03/24/2010 13:26:05.839 CCM|Digit Analysis: wait_DaReq: Matching Legacy Numeric, digits=b00103001003|\par 03/24/2010 13:26:05.840 CCM|Digit Analysis: getDaRes - voiceMailCallingSearchSpace=[]|\par 03/24/2010 13:26:05.840 CCM|Digit analysis: match(pi="1", fqcn="", cn="6000",plv="5", pss="Makati_PT:Cebu_PT:Tarlac_PT:PT_INTERNAL", TodFilteredPss="Makati_PT:Cebu_PT:Tarlac_PT:PT_INTERNAL", dd="b00103001003",dac="0")|\par 03/24/2010 13:26:05.840 CCM|Digit analysis: analysis results|\par 03/24/2010 13:26:05.840 CCM||PretransformCallingPartyNumber=6000\par |CallingPartyNumber=6000\par |DialingPartition=\par |DialingPattern=b00103001003\par |FullyQualifiedCalledPartyNumber=b00103001003\par |DialingPatternRegularExpression=(b00103001003)\par |DialingWhere=\par |PatternType=Enterprise\par |PotentialMatches=NoPotentialMatchesExist\par |DialingSdlProcessId=(1,30,1)\par |PretransformDigitString=b00103001003\par |PretransformTagsList=SUBSCRIBER\par |PretransformPositionalMatchList=b00103001003\par |CollectedDigits=b00103001003\par |UnconsumedDigits=\par |TagsList=SUBSCRIBER\par |PositionalMatchList=b00103001003\par |VoiceMailbox=\par |VoiceMailCallingSearchSpace=\par |VoiceMailPilotNumber=\par |RouteBlockFlag=RouteThisPattern\par |RouteBlockCause=0\par |AlertingName=Call Manager\par |UnicodeDisplayName=\par |DisplayNameLocale=1\par |InterceptPartition=\par |InterceptPattern=\par |InterceptWhere=\par |InterceptSdlProcessId=(0,0,0)\par |InterceptSsType=0\par |InterceptSsKey=0\par |InterceptSsNotifyType=0\par |OverlapSendingFlagEnabled=0\par |WithTags=\par |WithValues=\par |CallingPartyNumberPi=NotSelected\par |ConnectedPartyNumberPi=NotSelected\par |CallingPartyNamePi=NotSelected\par |ConnectedPartyNamePi=NotSelected\par |CallManagerDeviceType=UnicastMixer\par |PatternPrecedenceLevel=FlashOverride\par |CallableEndPointName=[b00103001003:]\par |PatternNodeId=[b00103001003:]\par |AARNeighborhood=[]\par |AARDestinationMask=[]\par |AARKeepCallHistory=false\par |AARVoiceMailEnabled=false\par |NetworkLocation=OnNet\par |Calling Party Number Type=Cisco Unified CallManager\par |Calling Party Numbering Plan=Cisco Unified CallManager\par |Called Party Number Type=Cisco Unified CallManager\par |Called Party Numbering Plan=Cisco Unified CallManager\par |ProvideOutsideDialtone=false\par |AllowDeviceOverride=false\par |AlternateMatches= Information Not Available\par |TranslationPatternDetails= Information Not Available\par |ResourcePriorityNamespace=|\par 03/24/2010 13:26:05.840 CCM|Digit analysis: insert daResEntry to daResCache. KeyCi=27646255 ,PID:Cdcc(1,171,111)|\par 03/24/2010 13:26:05.840 CCM|Digit analysis: callableEPName [b00103001003:] sent to device manager|\par 03/24/2010 13:26:05.840 CCM|//SIP/Stack/Info/0xb415f780/ccsip_api_call_setup_ind returned: SIP_SUCCESS|\par 03/24/2010 13:26:05.841 CCM|//SIP/Stack/Info/0xb415f780/Adding call id 78 to table|\par 03/24/2010 13:26:05.841 CCM|//SIP/Stack/Transport/0xb415f780/msg=0xb64a4040, addr=10.10.6.10, port=64248, sentBy_port=5060, is_req=0, transport=1, switch=0, callBack=(nil)|\par 03/24/2010 13:26:05.841 CCM|//SIP/Stack/Transport/0xb415f780/Proceedable for sending msg immediately|\par 03/24/2010 13:26:05.841 CCM|//SIP/Stack/Transport/0xb415f780/switch transport is 0|\par 03/24/2010 13:26:05.841 CCM|//SIP/Stack/Transport/0x0/Posting send for msg=0xb64a4040, addr=10.10.6.10, port=5060, connId=0 for UDP|\par 03/24/2010 13:26:05.841 CCM|//SIP/SIPUdp/wait_SdlSPISignal: Outgoing SIP UDP message to 10.10.6.10:[5060]:\par SIP/2.0 100 Trying\par Date: Wed, 24 Mar 2010 05:26:05 GMT\par From: ;tag=9055EC-1CF2\par Allow-Events: presence\par Content-Length: 0\par To: \par Call-ID: 94410CC7-363C11DF-8043A429-AA96E928@10.10.6.10\par Via: SIP/2.0/UDP 10.10.6.10:5060;branch=z9hG4bK1EE4C\par CSeq: 101 INVITE\par \par |\par 03/24/2010 13:26:05.841 CCM|EnvProcessUdpPort - EnvProcessUdpHandler::fireSignal() varId = 0|\par 03/24/2010 13:26:05.841 CCM|EnvProcessUdpPort - EnvProcessUdpHandler::send(buff, 308, 10.10.6.10:5060)|\par 03/24/2010 13:26:05.842 CCM|//SIP/Stack/States/0xb415f780/0xb415f780 : State change from (STATE_IDLE, SUBSTATE_NONE) to (STATE_RECD_INVITE, SUBSTATE_NONE)|\par 03/24/2010 13:26:05.842 CCM|//SIP/Stack/Info/0xb415f780/Previous Hop 10.10.6.10:5060|\par 03/24/2010 13:26:05.842 CCM|SMDMSharedData::findAliasRegInfo - AliasName = b00103001003: found in AliasInfo hashmap|\par 03/24/2010 13:26:05.842 CCM|DeviceManager::star_DmPidReq - RequestedName=b00103001003: LookupName=1a56e704-9ede-4743-af0d-011784465f59|\par 03/24/2010 13:26:05.842 CCM|SMDMSharedData::findLocalDevice - Name=CFB_2 Key=1a56e704-9ede-4743-af0d-011784465f59 isActvie=1 Pid=(1,30,1) found|\par 03/24/2010 13:26:05.842 CCM|Digit analysis: daResEntry found.|\par 03/24/2010 13:26:05.842 CCM|Digit analysis: wait_DmPidRes - Name=[b00103001003:] cmDeviceType=[UnicastMixer] Pid=UnicastBridgeControl(1,100,30,1)|\par 03/24/2010 13:26:05.842 CCM|Digit analysis: wait_DmPidRes- Partition=[] Pattern=[b00103001003] Where=[],cmDeviceType=[UnicastMixer], OutsideDialtone =[0], DeviceOverride=[0], PID=UnicastBridgeControl(1,100,30,1)|\par 03/24/2010 13:26:05.843 CCM|processCCMFeatureData: operationIeIdd=0|\par 03/24/2010 13:26:05.843 CCM|Cdcc(0000111) - verifySymmetricPrecedenceAfterJoined - A.pl[5], B.pl[5]|\par 03/24/2010 13:26:05.843 CCM|Cdcc::sendCcSetupReq: precLvl=5|\par 03/24/2010 13:26:05.843 CCM|Locations_reserveBandwidth -- cdccPID=(1.171.111) Dest=0 no need to reserve bw.|\par 03/24/2010 13:26:05.844 CCM|RegionsServer - modeA =[0], modeB =[0], preferredIpType =[0]|\par 03/24/2010 13:26:05.844 CCM|Locations_reserveBandwidth -- cdccPID=(1.171.111) adding entry.|\par 03/24/2010 13:26:05.844 CCM|Locations_reserveBandwidth -- cdccPID=(1.171.111) Orig=4 bw set to infinite|\par 03/24/2010 13:26:05.844 CCM|Locations_reserveBandwidth -- cdccPID=(1.171.111) Dest=0 no need to RESERVE/ADJUST_BANDWIDTH.|\par 03/24/2010 13:26:05.844 CCM|UnicastBridgeControl::allocateStream - Device Name=CFB_2, StreamAvailable=47 StreamUsed=1 MaxStreams=48|\par 03/24/2010 13:26:05.844 CCM|UnicastBridgeControl::decAvailableCounter CurrentStreamsAvailable= 47, decrementing streams=1|\par 03/24/2010 13:26:05.844 CCM|UnicastBridgeControl::incActiveCounter|\par 03/24/2010 13:26:05.844 CCM|UnicastBridgeControl::allocateStream - Device Name=CFB_2, StreamAvailable=46 StreamUsed=2 MaxStreams=48|\par 03/24/2010 13:26:05.844 CCM|RegionsServer::MatchCapabilities -- kbps=64, capACount=1, capBCount=3|\par 03/24/2010 13:26:05.844 CCM|UnicastBridgeControl - CcSetupReq - Device= CFB_2 - Party= 27646257 added to existing conference Id= 16787294|\par 03/24/2010 13:26:05.844 CCM|UnicastBridgeControl::checkConferencePL|\par 03/24/2010 13:26:05.844 CCM|UnicastBridgeControl::saveSetupInfo - Device Name = CFB_2, Party CI = 27646257|\par 03/24/2010 13:26:05.844 CCM|UnicastBridgeControl::sendRSVPRegisterRequest - Device Name = CFB_2, Party CI = 27646257|\par 03/24/2010 13:26:05.844 CCM|UnicastBridgeControl::sendRSVPRegisterRequest - Sent RSVP Register Request from UnicastBridgeControl[1 100 30 1] to RSVPSessionMgr[1 100 74 1]|\par 03/24/2010 13:26:05.845 CCM|UnicastBridgeControl::restart0_RSVPRegisterRes - Device Name = CFB_2, Party CI = 27646257, RSVP Success|\par 03/24/2010 13:26:05.845 CCM|UnicastBridgeControl::handleSetupSuccess - Device Name = CFB_2, Party CI = 27646257|\par 03/24/2010 13:26:05.845 CCM|UnicastBridgeControl::handleSetupSuccess - callTableEntry.toDn=b00103001003|\par 03/24/2010 13:26:05.845 CCM|Cdcc - (0000111) - updateDchanCrp - secure capability on side 1 is (1,1)|\par 03/24/2010 13:26:05.846 CCM|Cdcc - (0000111) - dumpSecureStatus - sideA=(cap=1,1, media=0,0, feature=0,0), sideB=(cap=1,1 media=0,0, feature=0,0)|\par 03/24/2010 13:26:05.846 CCM|Cdcc - (0000111) - dumpSecureStatus - sideA=(cap=1,1, media=0,0, feature=0,0), sideB=(cap=1,1 media=0,0, feature=0,0)|\par 03/24/2010 13:26:05.846 CCM|processCCMFeatureData: operationIeIdd=0|\par 03/24/2010 13:26:05.846 CCM|//SIP/SIPD(1,52,10)/ccbId=0/scbId=0/getKeyBasedOnCiAndBranch: AddressingElement branch is 0 and ci is 27646255 mapKey is 27646255|\par 03/24/2010 13:26:05.846 CCM|//SIP/SIPD(1,52,10)/ccbId=0/scbId=0/getCdpcPid: found Cdpc Pid (1,100,53,85) for mapKey 27646255|\par 03/24/2010 13:26:05.847 CCM|MeetMeConference - redirecting_participant_SsRedirectCallRes - Adding Participant - [27646255], No. of current instances = [1].|\par 03/24/2010 13:26:05.847 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/processLocalIdentityInfo: num=,localCnNum=0454916903;|\par 03/24/2010 13:26:05.847 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/processLocalIdentityInfo: identityFlag=[Changed:- Num;]|\par 03/24/2010 13:26:05.848 CCM|ConnectionManager - wait_AuConnectRequest(27646255,27646257)|\par 03/24/2010 13:26:05.848 CCM|ConnectionManager - storeMediaInfo(27646255): ADD NEW ENTRY, size=3|\par 03/24/2010 13:26:05.848 CCM|ConnectionManager - storeMediaInfo(27646257): ADD NEW ENTRY, size=4|\par 03/24/2010 13:26:05.848 CCM|MediaCoordinator - wait_AuConnectRequest()|\par 03/24/2010 13:26:05.848 CCM|MediaCoordinator - wait_AuConnectRequest - new MediaManager(105,53) started|\par 03/24/2010 13:26:05.849 CCM|MediaManager(53)::wait_AuConnectRequest, CI(27646255,27646257), mcNodeId(0,0), xferMode(16,8), reConnectType(0), mrid (0, 0) IFCreated(0 0) proIns(0 0), AC(0,0) party1DTMF(1 2 101 1) party2DTMF(1 1 0 1),reConnFlag=0, connType(3,3), IFHand(0,0),MTP(2,0),MRGL(1b81dc26-d052-f3ec-a456-3e4aa7af8ed5,1b81dc26-d052-f3ec-a456-3e4aa7af8ed5) videoCap(0 0), mmCallType(0),FS(0,0) IpAddrMode(0 0) aPid(1, 53, 85), bPid(1, 30, 1)|\par 03/24/2010 13:26:05.850 CCM|MeetMeConference - List - sideA( 1,27646229,4,1) sideB( 1,27646232,1)|\par 03/24/2010 13:26:05.850 CCM|MeetMeConference - List - sideA( 1,27646255,8,1) sideB( 0,0,0)|\par 03/24/2010 13:26:05.850 CCM|MeetMeConference - UpdateMeetMeConfereeInfo - List - sideA( 1,27646229,4,1) sideB( 1,27646232,1,1)|\par 03/24/2010 13:26:05.850 CCM|MeetMeConference - UpdateMeetMeConfereeInfo - List - sideA( 1,27646255,8,1) sideB( 0,0,0,0)|\par 03/24/2010 13:26:05.850 CCM|MeetMeConference - UpdateMeetMeConfereeInfo - MeetMeList enteries in list sideA( 1,27646229,4,1) sideB( 1,27646232,1,1)|\par 03/24/2010 13:26:05.850 CCM|MeetMeConference - UpdateMeetMeConfereeInfo - MeetMeList enteries in list sideA( 1,27646255,8,1) sideB( 1,27646257,1,1)|\par 03/24/2010 13:26:05.851 CCM|LineCdpc(79): -dispatchToAllDevices-, sigName=CcInfoReq, device=SEP000DED23C82E|\par 03/24/2010 13:26:05.851 CCM|StationD(4): StationCtiD - CcInfoReq CI=27646229fid = 123|\par 03/24/2010 13:26:05.851 CCM|StationD(4): StationCtiD - CcInfoReq CI=27646229fid = 123|\par 03/24/2010 13:26:05.851 CCM|MediaManager(53)::waitRSVPInfoRes_RSVPInfoRes, rsvp=0, aE2ERegion(64) deviceAcaps(0) deviceBCaps(0),noVideoResv(0), mm(0)|\par 03/24/2010 13:26:05.851 CCM|MediaManager(53)::bothPartiesVideoCapable, ret=0|\par 03/24/2010 13:26:05.851 CCM|MediaManager(53)::mapVideoCallToMMCallType, policy=0, hasRSVP=0, videoCap=0,dataCap=0, mmCall=1, V region(e2e=-1, 0)|\par 03/24/2010 13:26:05.852 CCM|MediaManager(53)::buildMtpXcoderAllocList, savedConnectionCount=0|\par 03/24/2010 13:26:05.852 CCM|MediaManager(53)::preCheckCapabilities, region1=Makati_RG, region2=Default, capCount1=1, capCount2=3|\par 03/24/2010 13:26:05.852 CCM|RegionsServer::MatchCapabilities -- kbps=64, capACount=1, capBCount=3|\par 03/24/2010 13:26:05.852 CCM|MediaManager(53)::prepareInitialConnectionList, Party1CapCount=1 Party2CapCount=3 XcoderRequired=0 xcodingSide=0|\par 03/24/2010 13:26:05.852 CCM|MediaManager(53)::AllocateXcoderandMTPWithZeroSavedConnection|\par 03/24/2010 13:26:05.852 CCM|MediaManager(53)::isMTPNeededForDTMF, isMTPNeeded(1)|\par 03/24/2010 13:26:05.852 CCM|MediaManager(53) - isIpv6CapableMTPNeeded(0) ipAddrMode(0 0) mtpside(0)|\par 03/24/2010 13:26:05.852 CCM|MediaManager(53)::handleAuConnectRequest, connCount=2|\par 03/24/2010 13:26:05.852 CCM|MediaManager(53)::allocateProxies, j=0 XferMode(16 0) CI(27646255 0) mrid(0 0) resrcCI(0 0)|\par 03/24/2010 13:26:05.852 CCM|MediaManager(53)::allocateProxies, connCount=2, party1 mrid =0 party2 mrid=0, j=0, party1MediaRequire=2 party2mediaRequire=0,mediaRequire=5|\par 03/24/2010 13:26:05.852 CCM|MediaManager(53)::getCapsAndRegionForBothSides, entryInList=0, connCount=2|\par 03/24/2010 13:26:05.852 CCM|MediaManager(53)::sendMTPXcoderAllocationRequest, (CapCount,Region),SideA:(1,Makati_RG), SideB:(3,Default), supressMatchCap=0,MTPNeededForDTMF=1|\par 03/24/2010 13:26:05.852 CCM|MediaManager(53)::sendMTPXcoderAllocationRequest, allocate MTP(ci=27646258), suppressMatchCap=0, mrgl=1b81dc26-d052-f3ec-a456-3e4aa7af8ed5 DTMF=9|\par 03/24/2010 13:26:05.852 CCM|MediaManager(53)::allocateProxies, j=1 XferMode(8 0) CI(27646257 0) mrid(0 0) resrcCI(0 27646258)|\par 03/24/2010 13:26:05.852 CCM|MediaManager(53)::allocateProxies, allocating resources(1), additional res(0)|\par 03/24/2010 13:26:05.853 CCM|StationCdpc(91): StationCtiCdpc - processToneChange to send ToneChangeNotify CH=1|27646229 CmSsFeature=1 ReasonForRedirection=0 OnBehalf=Device CallReason=1 CallState=8|\par 03/24/2010 13:26:05.853 CCM|MediaResourceManager::waiting_MrmAllocateMtpResourceReq CI=27646258, Count=1|\par 03/24/2010 13:26:05.853 CCM|MediaResourceManager::waiting_MrmAllocateMtpResourceReq - CREATING CHILD USING MRGL LIST|\par 03/24/2010 13:26:05.853 CCM|MRM::convertScmStringToStdString CCM_MG|\par 03/24/2010 13:26:05.853 CCM|MRM::getMtpDeviceGivenMrgl MRGL=CCM_MG|\par 03/24/2010 13:26:05.853 CCM|MRM::getMtpDeviceGivenMrgl DeviceName=MTP_2 DeviceType=110 Group=0 Counter=0 Capability=0 MultiCast=0 MRGL=1b81dc26-d052-f3ec-a456-3e4aa7af8ed5|\par 03/24/2010 13:26:05.853 CCM|MRM::getMtpDeviceGivenMrgl GETTING MTP FROM DEFAULT LIST|\par 03/24/2010 13:26:05.853 CCM|MRM::getMtpDeviceGivenMrgl DeviceName=mtpsoft DeviceType=83 Group=1 Counter=0 Capability=0 MultiCast=0 MRGL=1b81dc26-d052-f3ec-a456-3e4aa7af8ed5|\par 03/24/2010 13:26:05.854 CCM|MRM::getMtpDeviceGivenMrgl GETTING XCODE FROM DEFAULT LIST|\par 03/24/2010 13:26:05.854 CCM|MediaResourceManager::waiting_MrmAllocateMtpResourceReq - CREATED CHILD USING MRGL AND DEFAULT LIST|\par 03/24/2010 13:26:05.854 CCM|MediaResourceCdpc(0)::createTempDeviceTable - Entries copied in the Temp Device Table = 2|\par 03/24/2010 13:26:05.854 CCM|MediaResourceCdpc(92) - Started|\par 03/24/2010 13:26:05.854 CCM|StationD: (0000004) StartTone tone=50(Zip), direction=2.|\par 03/24/2010 13:26:05.854 CCM|StationD: (0000004) SetLamp mode=2, stim=123 stimInst=1.|\par 03/24/2010 13:26:05.854 CCM|StationD(4): StationCtiD - StationOutputSetLamp|\par 03/24/2010 13:26:05.854 CCM|StationD(4): StationCtiD - StationOutputSetLamp|\par 03/24/2010 13:26:05.855 CCM|MediaResourceCdpc(92)::waiting_MrmAllocateMtpResourceReq - CI=27646258 Count=1 TryPassThru=0|\par 03/24/2010 13:26:05.855 CCM|DeviceManager::star_DmMultiPidReq - PID(s) Requested=2|\par 03/24/2010 13:26:05.855 CCM|SMDMSharedData::findAliasRegInfo - AliasName = d861dc31-5dc0-4c57-a7e7-15df75c28f96 not in AliasInfo hashmap|\par 03/24/2010 13:26:05.855 CCM|SMDMSharedData::findLocalDevice - Name=MTP_2 Key=d861dc31-5dc0-4c57-a7e7-15df75c28f96 isActvie=1 Pid=(1,102,1) found|\par 03/24/2010 13:26:05.855 CCM|SMDMSharedData::findAliasRegInfo - AliasName = a4a0e9b0-ade6-8556-81e5-9df05bc257e6 not in AliasInfo hashmap|\par 03/24/2010 13:26:05.855 CCM|SMDMSharedData::findRemoteDeviceAny - Key=a4a0e9b0-ade6-8556-81e5-9df05bc257e6 not in RemoteDeviceInfo hashmap|\par 03/24/2010 13:26:05.856 CCM|MediaResourceCdpc(92)::createDevicePidTable - Entries copied in the Device Table = 1|\par 03/24/2010 13:26:05.856 CCM|MediaResourceCdpc(92)::createLookupTbl|\par 03/24/2010 13:26:05.856 CCM|MediaResourceCdpc(92)::createLookupTbl Name=MTP_2 Cepn=d861dc31-5dc0-4c57-a7e7-15df75c28f96 Weight=0 Group=0 Counter=0|\par 03/24/2010 13:26:05.856 CCM|MediaResourceCdpc(92)::waiting_MrmAllocateMtpResourceReq - CI=27646258 Count=1 TryPassThru=0|\par 03/24/2010 13:26:05.856 CCM|MediaResourceCdpc(92)::findDeviceGivenList - Name=MTP_2 type=1 isTRPMust=1 weight=0|\par 03/24/2010 13:26:05.856 CCM|MediaResourceCdpc::getNextMTPDevice MtpDevice=MTP_2 Cepn=d861dc31-5dc0-4c57-a7e7-15df75c28f96 devCap=9 resoureCount=1|\par 03/24/2010 13:26:05.856 CCM|MediaResourceCdpc(92)::sendMtpAllocateRequestToDevice MtpResource=MTP_2 Cepn=d861dc31-5dc0-4c57-a7e7-15df75c28f96|\par 03/24/2010 13:26:05.857 CCM|MediaTerminationPointControl(1)::waiting_AllocateMtpResourceReq - (capCount,region),A(1,Makati_RG),B(3,Default), reqDevCap=0x9, supDevCap=0x9, passthru=0, resourceCount=1|\par 03/24/2010 13:26:05.857 CCM|MediaTerminationPointControl(1)::getResourcesAllocated -- DeviceName=MTP_2 Ci=27646258 ResourceCount=1|\par 03/24/2010 13:26:05.857 CCM|MediaTerminationPointControl(1)::getResourcesAllocated -- Logging RegionA=Makati_RG Caps and MTP/XCoder Region=Default Caps|\par 03/24/2010 13:26:05.857 CCM|MediaTerminationPointControl(1)::logCapabilitiesinTrace -- MTP/XCoder Device Caps = 25 4 2 257 259 |\par 03/24/2010 13:26:05.857 CCM|MediaTerminationPointControl(1)::logCapabilitiesinTrace -- Device Caps = 2 |\par 03/24/2010 13:26:05.857 CCM|RegionsServer::MatchCapabilities -- kbps=64, capACount=1, capBCount=5|\par 03/24/2010 13:26:05.857 CCM|MediaTerminationPointControl(1)::getResourcesAllocated -- Logging RegionB=Default Caps and MTP/XCoder Region=Default Caps|\par 03/24/2010 13:26:05.857 CCM|MediaTerminationPointControl(1)::logCapabilitiesinTrace -- MTP/XCoder Device Caps = 25 4 2 257 259 |\par 03/24/2010 13:26:05.857 CCM|MediaTerminationPointControl(1)::logCapabilitiesinTrace -- Device Caps = 25 4 2 |\par 03/24/2010 13:26:05.857 CCM|RegionsServer::MatchCapabilities -- kbps=64, capACount=3, capBCount=5|\par 03/24/2010 13:26:05.858 CCM|MediaTerminationPointControl(1)::getResourcesAllocated -- match1=1 match2=2|\par 03/24/2010 13:26:05.858 CCM|MediaTerminationPointControl(1)::getResourcesAllocated -- DeviceName=MTP_2 Ci=27646258 ResourceAllocated=1|\par 03/24/2010 13:26:05.858 CCM|MediaTerminationPointControl(1)::getResourcesAllocated -- allocateErrBitset=0x0|\par 03/24/2010 13:26:05.858 CCM|MediaTerminationPointControl(1)::handleMtpDeviceFound|\par 03/24/2010 13:26:05.858 CCM|MediaTerminationPointControl(1)::logResourceStatusinTrace -- Device Name=MTP_2 ResourceAvailable=24 ResourceUsed=0|\par 03/24/2010 13:26:05.858 CCM|MediaTerminationPointControl(1)::handleMtpDeviceFound ConversationId=16787301 CI=27646258 Allocated resource=1 Device Capability = 9|\par 03/24/2010 13:26:05.858 CCM|MediaTerminationPointControl(1)::incActiveCounter - Count=1|\par 03/24/2010 13:26:05.858 CCM|MediaTerminationPointControl(1)::decAvailableCounter - Count=1|\par 03/24/2010 13:26:05.858 CCM|MediaTerminationPointControl(1)::logResourceStatusinTrace -- Device Name=MTP_2 ResourceAvailable=23 ResourceUsed=1|\par 03/24/2010 13:26:05.858 CCM|MediaResourceCdpc(92)::resource_rsvp_AllocateMtpResourceRes CI=27646258, DeviceCapability=9, Count=1|\par 03/24/2010 13:26:05.858 CCM|MediaResourceCdpc(92)::getMrglGivenDeviceName - DeviceName=MTP_2 MRGLPkid=1b81dc26-d052-f3ec-a456-3e4aa7af8ed5|\par 03/24/2010 13:26:05.858 CCM|MediaResourceManager::waiting_MrmAllocateMtpResourceRes - CI=27646258 deviceName=MTP_2 deviceCap=9 count=1|\par 03/24/2010 13:26:05.858 CCM|MRM::updateMtpCounter MTP_2|\par 03/24/2010 13:26:05.858 CCM|MRM::MRM::updateMtpCounter MRL allocateCounter=1|\par 03/24/2010 13:26:05.859 CCM|MRM::updateXcodeCounter MTP_2|\par 03/24/2010 13:26:05.859 CCM|MediaManager(53) - checkIfNeedToAddTRP(0) - DeviceIdx=0 useOneMRGL(0) v6MTP(1)|\par 03/24/2010 13:26:05.859 CCM|MediaMagdhnager(53)::wait_AllocateMtpResourceRes, connCount=2, proxyCount=1,addCount=0,numRespons=1|\par 03/24/2010 13:26:05.859 CCM|MediaManager(53)::wait_AllocateMtpResourceRes, j=0, CI(27646255,27646258) mrmNodeId(0,1) mrid(0 0) resourceCI(0,27646258) DTMF mtp sub PassT Inject party1(0 0 0) party2(0 0 0)|\par 03/24/2010 13:26:05.859 CCM|MediaManager(53)::wait_AllocateMtpResourceRes, j=1, CI(27646257,27646258) mrmNodeId(0,1) mrid(0 0) resourceCI(0,27646258) DTMF mtp sub PassT Inject party1(0 0 0) party2(0 0 0)|\par 03/24/2010 13:26:05.859 CCM|MediaManager(53)::allocatedMtpSupportsAnyDtmfCapability|\par 03/24/2010 13:26:05.859 CCM|MediaManager(53)::DTMFMTPSide(1), mtpNeededForDtmf(1) firstconnDTMF(2) secondconn DTMF(1)|\par 03/24/2010 13:26:05.859 CCM|MediaManager(53)::needToInjectDigitsToMTP, isMTPNeededDueToDTMFCapMismatch dtmfMTPSide(1)index(0) injecttoMTP(1)|\par 03/24/2010 13:26:05.859 CCM|MediaManager(0)::can2833beNegotiatedForCall, --2833 can nto be negotiated for the call|\par 03/24/2010 13:26:05.859 CCM|MediaManager(53)::setSubscriptionInfo, subscribe(1), passthru(0), inject(1) index(0)|\par 03/24/2010 13:26:05.859 CCM|MediaManager(53)::allocatedMtpSupportsAnyDtmfCapability|\par 03/24/2010 13:26:05.860 CCM|MediaManager(53)::DTMFMTPSide(1), mtpNeededForDtmf(1) firstconnDTMF(2) secondconn DTMF(1)|\par 03/24/2010 13:26:05.860 CCM|MediaManager(53)::needToInjectDigitsToMTP, isMTPNeededDueToDTMFCapMismatch dtmfMTPSide(1)index(1) injecttoMTP(0)|\par 03/24/2010 13:26:05.860 CCM|MediaManager(0)::can2833beNegotiatedForCall, --2833 can nto be negotiated for the call|\par 03/24/2010 13:26:05.860 CCM|MediaManager(53)::setSubscriptionInfo, subscribe(0), passthru(0), inject(0) index(1)|\par 03/24/2010 13:26:05.860 CCM|MediaManager(53) - updateMMCallTypeAndResource, least=1|\par 03/24/2010 13:26:05.860 CCM|MediaManager(53)::CreateConnections, mmCallType=1,aPT=2,vPT=2,capEnd2End=0, e2eRegion(64,-1),RSVPpending=0|\par 03/24/2010 13:26:05.860 CCM|MediaManager(53)::createConnections, creat connection between party1(27646255) and party2(27646258), newConnCount=1 mrid(0 0), xferMode(16,10), farEnd(XferMode=8, AC=0, T38=0,FS=0, rf=0, mediaReq=0)|\par 03/24/2010 13:26:05.860 CCM|MediaManager(53)::createConnections, creat connection between party1(27646257) and party2(27646258), newConnCount=2 mrid(0 0), xferMode(8,10), farEnd(XferMode=16, AC=0, T38=0,FS=0, rf=0, mediaReq=2)|\par 03/24/2010 13:26:05.860 CCM|MediaResourceCdpc(92)::shutting_down_MrmChildStopConf|\par 03/24/2010 13:26:05.861 CCM|MediaCoordinator - wait_MediaCoordinatorAddResource - CI=27646258 count=1 mrmNodeId=1|\par 03/24/2010 13:26:05.861 CCM|MediaCoordinator - wait_MediaCoordinatorAddResource - CI=27646258 count=2 mrmNodeId=1|\par 03/24/2010 13:26:05.861 CCM|MediaExchange(87)::wait_AuConnectRequest, party1(CI=27646255, MXIFHandling=0, MTPRequired=2,xferMode=16),party2(CI=27646258, MXIFHandling=0,xferMode=10), farEnd(XferMode=8,AC=0,T38=0,FS=0, mediaReq=0), PT(2,2),connType(3,3), linkLoss=0 farendIpAddrMode=0|\par 03/24/2010 13:26:05.861 CCM|MediaExchange(87)::addPartyAandPartyB, party1:xferMode=16, party2:xferMode=10|\par 03/24/2010 13:26:05.861 CCM|MediaExchange(87)::addPartyAandPartyB, videoCall(0), normalStart(1), audioRegion(64), videoRegion(-1), party1VidCapable(0), party2VidCapable(0)|\par 03/24/2010 13:26:05.861 CCM|MediaExchange(87)::addPartyAandPartyB, party1iport( 64248),party2ipport( 0)|\par 03/24/2010 13:26:05.861 CCM|AgenaInterface(0)::allow2833(1), audioPartyId=0, mrid=0, connType(3 3 3) IPAddrMode(0 0 0) isMidMTP(0) ipAddrType(0)|\par 03/24/2010 13:26:05.862 CCM|MediaExchange(88)::wait_AuConnectRequest, party1(CI=27646257, MXIFHandling=0, MTPRequired=0,xferMode=8),party2(CI=27646258, MXIFHandling=0,xferMode=10), farEnd(XferMode=16,AC=0,T38=0,FS=0, mediaReq=2), PT(2,2),connType(3,3), linkLoss=0 farendIpAddrMode=0|\par 03/24/2010 13:26:05.862 CCM|MediaExchange(88)::addPartyAandPartyB, party1:xferMode=8, party2:xferMode=10|\par 03/24/2010 13:26:05.862 CCM|MediaExchange(88)::addPartyAandPartyB, videoCall(0), normalStart(1), audioRegion(64), videoRegion(-1), party1VidCapable(0), party2VidCapable(0)|\par 03/24/2010 13:26:05.862 CCM|AgenaInterface(0)::allow2833(1), audioPartyId=0, mrid=0, connType(3 3 3) IPAddrMode(0 0 0) isMidMTP(0) ipAddrType(0)|\par 03/24/2010 13:26:05.862 CCM|MediaExchange(88)::addPartyAandPartyB, party1iport( 0),party2ipport( 0)|\par 03/24/2010 13:26:05.862 CCM|AgenaInterface(0)::allow2833(1), audioPartyId=0, mrid=0, connType(3 3 3) IPAddrMode(0 0 0) isMidMTP(0) ipAddrType(0)|\par 03/24/2010 13:26:05.863 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/handleSDPOfferInd: SDP: \par \par SDP:: isPresent=1, role=1\par numAudiomLines=1 numVideomLines=0\par numAppplicationmLines=0 numT38faxmLines=0\par anatPresent=0\par Bandwidth:: enabledMask=0x00000000 as=0 ct=0 tias=0 maxprate=0\par audiomLines[0] =\par Media_mLine:: remoteIpAddress=0x0a060a0a remoteRtpPortNumber=17726 mSDPMode=0\par mLineStackIdx=1 telephonyEvent=101 silenceSuppressionFlag=0 midID=-1\par Bandwidth:: enabledMask=0x00000000 as=0 ct=0 tias=0 maxprate=0\par rtp=1,srtp=0\par caps[0]:: payloadCapability=2 maxFramesPerPacket=20|\par 03/24/2010 13:26:05.863 CCM|//SIP/SIPD(1,53,85)/ccbId=0/scbId=0/handleSDPOfferInd: ipAddrMode IpAddrMode_v4|\par 03/24/2010 13:26:05.863 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/getDefCcRegister: Secure status=1, mSrtpPresent=0|\par 03/24/2010 13:26:05.863 CCM|MediaTerminationPointControl(1) - MediaExchangeAgenaAssociateReq confId=16787301 inserted AIF(136,0)|\par 03/24/2010 13:26:05.863 CCM|MediaTerminationPointControl(1) - MediaExchangeAgenaAssociateReq confId=16787301 inserted AIF(136,138)|\par 03/24/2010 13:26:05.864 CCM|SIPInterface(35)::waitSDPResponse_SDPOfferInd, sessionJoined=0,noVideoAttempted=0,videoCall=0|\par 03/24/2010 13:26:05.864 CCM|MediaManager(53)::wait_AuConnectReply|\par 03/24/2010 13:26:05.864 CCM|AgenaInterface(4) - supportsRFC2429(0) mPayloadsupported(0 0) customPictureFormatCount(47146108)|\par 03/24/2010 13:26:05.864 CCM|AgenaInterface(4) - supportsRFC2429(0) mPayloadsupported(0 0) customPictureFormatCount(47146108)|\par 03/24/2010 13:26:05.864 CCM|MediaManager(53)::wait_AuConnectReply|\par 03/24/2010 13:26:05.864 CCM|MediaManager(53)::checkPartyMTPRequired, mcNodeId=1|\par 03/24/2010 13:26:05.865 CCM|MediaManager(53)::wait_AuConnectReply, received 2 resps, sent AuConnecReply for party(27646255,27646257), mrid(0 0),IFCreated(1,1),reply.dsc(0)|\par 03/24/2010 13:26:05.865 CCM|AgenaInterface(4) - supportsRFC2429(0) mPayloadsupported(0 0) customPictureFormatCount(47146108)|\par 03/24/2010 13:26:05.865 CCM|MediaExchange(87)::canForwardCapsToOtherEnd, activeCapEnabled(0, 0), canForwardCapsToOtherEnd=1|\par 03/24/2010 13:26:05.865 CCM|Cdcc - (0000111) - dumpSecureStatus - sideA=(cap=1,1, media=0,0, feature=0,0), sideB=(cap=1,1 media=0,0, feature=0,0)|\par 03/24/2010 13:26:05.865 CCM|Cdcc - (0000111) - updateDchanCrp - secure capability on side 0 is (1,1)|\par 03/24/2010 13:26:05.865 CCM|Cdcc - (0000111) - dumpSecureStatus - sideA=(cap=1,1, media=0,0, feature=0,0), sideB=(cap=1,1 media=0,0, feature=0,0)|\par 03/24/2010 13:26:05.866 CCM|MediaExchange(87)::canForwardCapsToOtherEnd, activeCapEnabled(0, 0), canForwardCapsToOtherEnd=1|\par 03/24/2010 13:26:05.866 CCM|MediaExchange(87)::finishCapExchange, capFromTwoIFs=1,capFromFarEnd=0,aPT=2,vPT=2,capE2E=0,capDone=1|\par 03/24/2010 13:26:05.866 CCM|MediaExchange(87)::handleInterfaceVisited, returned finishCapExchange|\par 03/24/2010 13:26:05.866 CCM|MediaExchange(87)::handleInterfaceVisited, allowReConnect(1) partyAHasCapsorACE(1)partybHasCapsorACE (1)|\par 03/24/2010 13:26:05.867 CCM|MediaExchange(88)::canForwardCapsToOtherEnd, activeCapEnabled(0, 0), canForwardCapsToOtherEnd=1|\par 03/24/2010 13:26:05.867 CCM|MediaCoordinator - wait_AuConnectReply|\par 03/24/2010 13:26:05.867 CCM|MediaExchange(88)::canForwardCapsToOtherEnd, activeCapEnabled(0, 0), canForwardCapsToOtherEnd=1|\par 03/24/2010 13:26:05.867 CCM|MediaExchange(88)::finishCapExchange, capFromTwoIFs=1,capFromFarEnd=0,aPT=2,vPT=2,capE2E=0,capDone=1|\par 03/24/2010 13:26:05.868 CCM|MediaExchange(88)::handleInterfaceVisited, returned finishCapExchange|\par 03/24/2010 13:26:05.868 CCM|MediaExchange(88)::handleInterfaceVisited, allowReConnect(1) partyAHasCapsorACE(1)partybHasCapsorACE (1)|\par 03/24/2010 13:26:05.868 CCM|RegionsServer::MatchCapabilities -- kbps=64, capACount=1, capBCount=5|\par 03/24/2010 13:26:05.868 CCM|AgenaInterface(136)::getPartyIdForAgena, numofportopened=0, mediaType=1, fcodec=0|\par 03/24/2010 13:26:05.868 CCM|allowIncomingOLCTowardsDevice mAllowOneWayMedia(1) ccCallConnType(3) peerCCCallConntype(3) ignoreSDP(0)|\par 03/24/2010 13:26:05.868 CCM|AgenaInterface(136)::can2833BeNegotiated, PeerCapsSupport2833=0 shouldCheckPeerDTMFProfile=1|\par 03/24/2010 13:26:05.868 CCM|areCryptoCapsMatched: capCount=1 caps= 2 |\par 03/24/2010 13:26:05.868 CCM|AgenaInterface(136)::can2833BeNegotiated, PeerCapsSupport2833=0 shouldCheckPeerDTMFProfile=1|\par 03/24/2010 13:26:05.868 CCM|AgenaInterface() - openChannel,lcn=1, partyid=16777402, channelDir=0|\par 03/24/2010 13:26:05.868 CCM|AgenaInterface() - mapChannelToPartyId,lcn=1, partyid=16777402, channelDir=0|\par 03/24/2010 13:26:05.868 CCM|AgenaInterface(136)::sendOLCtoDevice, ip=, port=17726|\par 03/24/2010 13:26:05.868 CCM|AgenaInterface(136)::openOutgoingAudioChannel, audioRegion=64, videoRegion=-1, mVideoCall=0 allowOWM=1 ConnType=3|\par 03/24/2010 13:26:05.868 CCM|shouldInitiateOLC(1) AllowOneWayMedia(1) ConnType(3 3 3)|\par 03/24/2010 13:26:05.869 CCM|RegionsServer::MatchCapabilities -- kbps=64, capACount=1, capBCount=5|\par 03/24/2010 13:26:05.869 CCM|areCryptoCapsMatched: capCount=1 caps= 2 |\par 03/24/2010 13:26:05.869 CCM|AgenaInterface(136)::can2833BeNegotiated, PeerCapsSupport2833=0 shouldCheckPeerDTMFProfile=1|\par 03/24/2010 13:26:05.869 CCM|AgenaInterface() - openChannel,lcn=1, partyid=0, channelDir=1|\par 03/24/2010 13:26:05.869 CCM|AgenaInterface() - mapChannelToPartyId,lcn=1, partyid=0, channelDir=1|\par 03/24/2010 13:26:05.869 CCM|AgenaInterface() - mapChannelToPartyId,lcn=1, partyid=16777402, channelDir=1|\par 03/24/2010 13:26:05.869 CCM|AgenaInterface(136)::SendStartTalkingForNonMultiCastConnection, partyid=16777402, lcn=1 |\par 03/24/2010 13:26:05.869 CCM|AgenaInterface(138)::peerOrFarEndCapReceived, isMTP=1,capR=1,farEndCapR=0,PT(2,2), bR=1|\par 03/24/2010 13:26:05.869 CCM|RegionsServer::MatchCapabilities -- kbps=64, capACount=3, capBCount=5|\par 03/24/2010 13:26:05.869 CCM|AgenaInterface(138)::proceedToOLC, xferMode=10,ac=0,msd=0,bCont=1, isPeerSIPAndMeMTPAndPT=0,bRet=1|\par 03/24/2010 13:26:05.869 CCM|AgenaInterface(138)::openOutgoingAudioChannel, audioRegion=64, videoRegion=-1, mVideoCall=0 allowOWM=1 ConnType=3|\par 03/24/2010 13:26:05.869 CCM|shouldInitiateOLC(1) AllowOneWayMedia(1) ConnType(3 3 3)|\par 03/24/2010 13:26:05.869 CCM|RegionsServer::MatchCapabilities -- kbps=64, capACount=2, capBCount=5|\par 03/24/2010 13:26:05.869 CCM|areCryptoCapsMatched: capCount=2 caps= 4 2 |\par 03/24/2010 13:26:05.869 CCM|AgenaInterface(138)::can2833BeNegotiated, PeerCapsSupport2833=0 shouldCheckPeerDTMFProfile=0|\par 03/24/2010 13:26:05.869 CCM|AgenaInterface(138)::can2833BeNegotiated, is false|\par 03/24/2010 13:26:05.870 CCM|AgenaInterface() - openChannel,lcn=1, partyid=0, channelDir=1|\par 03/24/2010 13:26:05.870 CCM|AgenaInterface() - mapChannelToPartyId,lcn=1, partyid=0, channelDir=1|\par 03/24/2010 13:26:05.870 CCM|AgenaInterface(138) - openOutgoingChannels can't open video. videoCall(0,1,0),vPT(2),capCount(0,0)|\par 03/24/2010 13:26:05.870 CCM|ConnectionManager - wait_AuConnectReply(27646255,27646257)|\par 03/24/2010 13:26:05.870 CCM|AgenaInterface(137)::peerOrFarEndCapReceived, isMTP=0,capR=1,farEndCapR=0,PT(2,2), bR=1|\par 03/24/2010 13:26:05.870 CCM|RegionsServer::MatchCapabilities -- kbps=64, capACount=5, capBCount=3|\par 03/24/2010 13:26:05.870 CCM|AgenaInterface(137)::proceedToOLC, xferMode=8,ac=0,msd=0,bCont=1, isPeerSIPAndMeMTPAndPT=0,bRet=1|\par 03/24/2010 13:26:05.870 CCM|AgenaInterface(137)::openOutgoingAudioChannel, audioRegion=64, videoRegion=-1, mVideoCall=0 allowOWM=1 ConnType=3|\par 03/24/2010 13:26:05.870 CCM|shouldInitiateOLC(1) AllowOneWayMedia(1) ConnType(3 3 3)|\par 03/24/2010 13:26:05.870 CCM|RegionsServer::MatchCapabilities -- kbps=64, capACount=2, capBCount=3|\par 03/24/2010 13:26:05.870 CCM|areCryptoCapsMatched: capCount=2 caps= 4 2 |\par 03/24/2010 13:26:05.870 CCM|AgenaInterface(137)::can2833BeNegotiated, PeerCapsSupport2833=1 shouldCheckPeerDTMFProfile=0|\par 03/24/2010 13:26:05.871 CCM|AgenaInterface(137)::can2833BeNegotiated, is false|\par 03/24/2010 13:26:05.871 CCM|AgenaInterface() - openChannel,lcn=1, partyid=0, channelDir=1|\par 03/24/2010 13:26:05.871 CCM|AgenaInterface() - mapChannelToPartyId,lcn=1, partyid=0, channelDir=1|\par 03/24/2010 13:26:05.871 CCM|AgenaInterface(137) - openOutgoingChannels can't open video. videoCall(0,1,0),vPT(2),capCount(0,0)|\par 03/24/2010 13:26:05.871 CCM|MediaTerminationPointControl(1)::star_MediaExchangeAgenaOpenLogicalChannel - PartyId = 16777402|\par 03/24/2010 13:26:05.871 CCM|MediaTerminationPointControl(1)::fillAudioPartyIDtoMediaPidTable - PartyId = 16777402, OLCRecd=1, StartTlkRecd=0|\par 03/24/2010 13:26:05.871 CCM|MediaTerminationPointControl(1)::star_MediaExchangeAgenaOpenLogicalChannel - confernceId=16787301 inserted AgenaInstance=136|\par 03/24/2010 13:26:05.871 CCM|MediaTerminationPointControl(1)::star_MediaExchangeStartTalking - CI=16787301, DSCPValue = 184|\par 03/24/2010 13:26:05.871 CCM|MediaTerminationPointControl(1)::fillAudioPartyIDtoMediaPidTable - PartyId = 16777402, OLCRecd=1, StartTlkRecd=1|\par 03/24/2010 13:26:05.872 CCM|MediaTerminationPointControl(1)::star_StationOutputOpenReceiveChannel - TCPPid = [1.100.9.7] myIP: 0x9060a0a (10.10.6.9) ConferenceID: 16787301, MediaPartyId: 16777402, msecPacketSize: 20 compressionType: 2|\par 03/24/2010 13:26:05.872 CCM|MediaTerminationPointControl(1)::star_StationOutputStartMediaTransmission - TCPPid = [1.100.9.7] myIP: 0x9060a0a (10.10.6.9)|\par 03/24/2010 13:26:05.872 CCM|MediaTerminationPointControl(1)::star_StationOutputStartMediaTransmission - ConferenceID: 16787301, MediaPartyId: 16777402, RemoteIpAddr: 0xa060a0a (10.10.6.10) RemoteRtpPortNumber: 17726 msecPacketSize: 20 compressionType: 2|\par 03/24/2010 13:26:05.872 CCM|allowIncomingOLCTowardsDevice mAllowOneWayMedia(1) ccCallConnType(3) peerCCCallConntype(3) ignoreSDP(0)|\par 03/24/2010 13:26:05.872 CCM|AgenaInterface(137)::getPartyIdForAgena, numofportopened=0, mediaType=1, fcodec=0|\par 03/24/2010 13:26:05.873 CCM|AgenaInterface() - openChannel,lcn=1, partyid=16777403, channelDir=0|\par 03/24/2010 13:26:05.873 CCM|AgenaInterface() - mapChannelToPartyId,lcn=1, partyid=16777403, channelDir=0|\par 03/24/2010 13:26:05.873 CCM|AgenaInterface(137)::sendOLCtoDevice, ip=, port=4000|\par 03/24/2010 13:26:05.873 CCM|Cdcc - setupCompSideB|\par 03/24/2010 13:26:05.873 CCM|Cdcc - (0000111) - setupCompSideB - ccSetupCompReq.secureStatusInfo= (1,1)|\par 03/24/2010 13:26:05.873 CCM|Cdcc - setupResSideA|\par 03/24/2010 13:26:05.873 CCM|Cdcc - (0000111) - setupResSideA - ccSetupRes.secureStatusInfo= (1,1)|\par 03/24/2010 13:26:05.873 CCM|Cdcc::setupResSideA: precLvl=5|\par 03/24/2010 13:26:05.873 CCM|allowIncomingOLCTowardsDevice mAllowOneWayMedia(1) ccCallConnType(3) peerCCCallConntype(3) ignoreSDP(0)|\par 03/24/2010 13:26:05.873 CCM|AgenaInterface(138)::getPartyIdForAgena, numofportopened=0, mediaType=1, fcodec=0|\par 03/24/2010 13:26:05.873 CCM|AgenaInterface() - openChannel,lcn=1, partyid=16777404, channelDir=0|\par 03/24/2010 13:26:05.873 CCM|AgenaInterface() - mapChannelToPartyId,lcn=1, partyid=16777404, channelDir=0|\par 03/24/2010 13:26:05.873 CCM|AgenaInterface(138)::sendOLCtoDevice, ip=, port=4000|\par 03/24/2010 13:26:05.874 CCM|UnicastBridgeControl - fillAudioPartyIDtoMediaPidTable PartyId = 16777403, CLCRecd=0, StopTlkRecd=1|\par 03/24/2010 13:26:05.874 CCM|//SIP/SIPD(1,52,10)/ccbId=0/scbId=0/getKeyBasedOnCiAndBranch: AddressingElement branch is 0 and ci is 27646255 mapKey is 27646255|\par 03/24/2010 13:26:05.874 CCM|//SIP/SIPD(1,52,10)/ccbId=0/scbId=0/getCdpcPid: found Cdpc Pid (1,100,53,85) for mapKey 27646255|\par 03/24/2010 13:26:05.874 CCM|MediaTerminationPointControl(1)::star_MediaExchangeAgenaOpenLogicalChannel - PartyId = 16777404|\par 03/24/2010 13:26:05.874 CCM|MediaTerminationPointControl(1)::fillAudioPartyIDtoMediaPidTable - PartyId = 16777404, OLCRecd=1, StartTlkRecd=0|\par 03/24/2010 13:26:05.875 CCM|MediaTerminationPointControl(1)::star_MediaExchangeAgenaOpenLogicalChannel - confernceId=16787301 inserted AgenaInstance=138|\par 03/24/2010 13:26:05.875 CCM|UnicastBridgeControl - stationOutputOpenReceiveChannel TCPPid = [1.100.9.5] myIP: 9060a0a (10.10.6.9) ConferenceID: 16787294 MediaPartyId: 16777403, msecPacketSize: 20, compressionType: 4, security: 0|\par 03/24/2010 13:26:05.875 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/getCcSignalCnNameAndNumberInfo: identityFlag=0xff|\par 03/24/2010 13:26:05.875 CCM|MediaTerminationPointControl(1)::star_StationOutputOpenReceiveChannel - TCPPid = [1.100.9.7] myIP: 0x9060a0a (10.10.6.9) ConferenceID: 16787301, MediaPartyId: 16777404, msecPacketSize: 20 compressionType: 4|\par 03/24/2010 13:26:05.877 CCM|StationInit: (0000001) OpenReceiveChannelAck Status=0, IpAddr=IpAddr.type:0 ipAddr:0x0a0a0609000000000000000000000000(10.10.6.9), Port=24892, PartyID=16777402|\par 03/24/2010 13:26:05.877 CCM|AgenaInterface(136)::setDeviceOLCAckInfo, lcn=1, ip=, port=24892|\par 03/24/2010 13:26:05.877 CCM|AgenaInterface(136)::isSrtpCall, ConnectionIsEaronly and outgoing channel is still open|\par 03/24/2010 13:26:05.877 CCM|AgenaInterface(136)::can2833BeNegotiated, PeerCapsSupport2833=0 shouldCheckPeerDTMFProfile=1|\par 03/24/2010 13:26:05.877 CCM|AgenaInterface(136)::sendAudioMXConnectInfoIndToParent, sdpMode(0,0), iaAns(0), connType(3)|\par 03/24/2010 13:26:05.877 CCM|AgenaInterface(136)::sendAudioMXConnectInfoToParent, Sending audioMXConnectInfo, mIsSRTP=0|\par 03/24/2010 13:26:05.877 CCM|AgenaInterface(136)::handleDTMFSubscribe, subscribe(1) rfc2833PT(101), passThru2833(0) |\par 03/24/2010 13:26:05.877 CCM|AgenaInterface(136) - sendSubscribetoMTP rfc2833PT(101), passThru2833(0), skip by fax mode=0 |\par 03/24/2010 13:26:05.878 CCM|MediaExchange(87)::expectedWayPathEstablised, connType(3,3,3), sdpMode(0,0), path(4), ret(0)|\par 03/24/2010 13:26:05.878 CCM|MediaExchange(87)::expectedWayPathEstablised, connType(3,3,3), sdpMode(0,0), path(4), ret(0)|\par 03/24/2010 13:26:05.878 CCM|SIPInterface(35)::filterAudioCaps, audioRegion=64, nAudio=1|\par 03/24/2010 13:26:05.878 CCM|SIPInterface(0)::sendMXConnectInfoIndtoMX,-Sending audioMXConnectInfoIndtoMX, info(1 -1278980176)|\par 03/24/2010 13:26:05.878 CCM|SIPInterface(35)-Sending audioMXConnectInfoIndtoMX, mIsSRTP=0, isSecureAudioVideo=0|\par 03/24/2010 13:26:05.878 CCM|MediaTerminationPointControl(1)::star_StationSubscribeDtmfPayloadReq TCPPid = [1.100.9.7] myIP: 0x9060a0a (10.10.6.9) conferenceID=16787301, passthruPartyID=16777402, payloadDtmf=101, dtmfType=0|\par 03/24/2010 13:26:05.879 CCM|setLocalDtmfCaps: supportedDTMFMethod=3, mWantDtmfReception=1, mPeersWantDtmfReceptionFlag=1, mDtmfPreference=1|\par 03/24/2010 13:26:05.879 CCM|SIP DTMF Info: mLocalDtmfCaps...UNSOL=1, KPML=1, Inband=1(101) mEndppointsDtmfCaps...UNSOL=0, KPML=0, Inband=1(101) mDefaultTelephonyEvent=101, mDtmfPreference=1, mMtpAllocated=1|\par 03/24/2010 13:26:05.879 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/convertSDPMsgToSDP: \par \par SDP:: isPresent=1, role=0\par numAudiomLines=1 numVideomLines=0\par numAppplicationmLines=0 numT38faxmLines=0\par anatPresent=0\par Bandwidth:: enabledMask=0x00000000 as=0 ct=0 tias=0 maxprate=0\par audiomLines[0] =\par Media_mLine:: remoteIpAddress=0x09060a0a remoteRtpPortNumber=24892 mSDPMode=0\par mLineStackIdx=1 telephonyEvent=101 silenceSuppressionFlag=0 midID=-1\par Bandwidth:: enabledMask=0x00000000 as=0 ct=0 tias=0 maxprate=0\par rtp=1,srtp=0\par caps[0]:: payloadCapability=2 maxFramesPerPacket=20|\par 03/24/2010 13:26:05.879 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/setCnNumPresentation: fIdPresentation is 1 and the SIP Trunk Config is 0 |\par 03/24/2010 13:26:05.879 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/applyNumPresentationBasedOnDirection: fIdPresentation is 1 and the DialogDirection is 2 |\par 03/24/2010 13:26:05.879 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/setCnNamePresentation: fIdPresentation is 1 and the SIP Trunk Config is 0 |\par 03/24/2010 13:26:05.879 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/applyNamePresentationBasedOnDirection: fIdPresentation is 1 |\par 03/24/2010 13:26:05.879 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/setCnNameAndNumber: connectedName Conference connectedNumber 0454916903 connectedNumberPi 1 connectedNamePi 1 connectedSi 1|\par 03/24/2010 13:26:05.879 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/setIdentityOutgoingSIPMsg: identityFlag=[PAI;RPID;], privacyType[0]|\par 03/24/2010 13:26:05.879 CCM|(setHoldeeState): er=0,ee=0,mh=0|\par 03/24/2010 13:26:05.880 CCM|getOobScbId: Created scbId. mOobScbId=121, ccbId=120|\par 03/24/2010 13:26:05.880 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=121/subscribeForKpml: SIP stack not ready to handle Subscribe request.|\par 03/24/2010 13:26:05.880 CCM|MediaExchange(87)::fillAuConnectInfoIndMsg, noMediaInfo=0, resType=0|\par 03/24/2010 13:26:05.880 CCM|MediaExchange(87)::fillAudioMediaInfo, partyIdx=0, xferMode=16, codec=2, maxFramesPerPacket=20i, audioSRTP=0, videoSRTP=0, dataAppSRTP=0, mediaSecurity=1|\par 03/24/2010 13:26:05.880 CCM|MediaExchange(87)::fillAddressInfo, idx=1, addr=,port=24892|\par 03/24/2010 13:26:05.880 CCM|MediaExchange(87)::fillAudioMediaInfo, partyIdx=1, xferMode=10, codec=2, maxFramesPerPacket=20i, audioSRTP=0, videoSRTP=0, dataAppSRTP=0, mediaSecurity=1|\par 03/24/2010 13:26:05.880 CCM|MediaExchange(87)::fillAddressInfo, idx=0, addr=,port=17726|\par 03/24/2010 13:26:05.880 CCM|MediaExchange(87)::expectedWayPathEstablised, connType(3,3,3), sdpMode(0,0), path(2), ret(1)|\par 03/24/2010 13:26:05.880 CCM|StationInit: (0000001) OpenReceiveChannelAck Status=0, IpAddr=IpAddr.type:0 ipAddr:0x0a0a0609000000000000000000000000(10.10.6.9), Port=24896, PartyID=16777403|\par 03/24/2010 13:26:05.881 CCM|AgenaInterface(137)::setDeviceOLCAckInfo, lcn=1, ip=, port=24896|\par 03/24/2010 13:26:05.881 CCM|AgenaInterface(137)::get2833PayloadType, LCN(1) rfc2833PT (0)|\par 03/24/2010 13:26:05.881 CCM|AgenaInterface(137)::handleDTMFSubscribe, subscribe(0) rfc2833PT(0), passThru2833(0) |\par 03/24/2010 13:26:05.881 CCM|MediaExchange(88)::expectedWayPathEstablised, connType(3,3,3), sdpMode(0,0), path(0), ret(0)|\par 03/24/2010 13:26:05.881 CCM|AgenaInterface(138)::getPartyIdForAgena, numofportopened=0, mediaType=1, fcodec=0|\par 03/24/2010 13:26:05.881 CCM|AgenaInterface(138)::sessionEstablished_MediaExchangeInterfacePathEstablished, mediaType=1, aPT=2, vPT=2|\par 03/24/2010 13:26:05.881 CCM|AgenaInterface() - mapChannelToPartyId,lcn=1, partyid=16777404, channelDir=1|\par 03/24/2010 13:26:05.881 CCM|AgenaInterface(138)::SendStartTalkingForNonMultiCastConnection, partyid=16777404, lcn=1 |\par 03/24/2010 13:26:05.881 CCM|MediaTerminationPointControl(1)::star_MediaExchangeStartTalking - CI=16787301, DSCPValue = 184|\par 03/24/2010 13:26:05.881 CCM|MediaTerminationPointControl(1)::fillAudioPartyIDtoMediaPidTable - PartyId = 16777404, OLCRecd=1, StartTlkRecd=1|\par 03/24/2010 13:26:05.881 CCM|MediaTerminationPointControl(1)::star_StationOutputStartMediaTransmission - TCPPid = [1.100.9.7] myIP: 0x9060a0a (10.10.6.9)|\par 03/24/2010 13:26:05.882 CCM|MediaTerminationPointControl(1)::star_StationOutputStartMediaTransmission - ConferenceID: 16787301, MediaPartyId: 16777404, RemoteIpAddr: 0x9060a0a (10.10.6.9) RemoteRtpPortNumber: 24896 msecPacketSize: 20 compressionType: 4|\par 03/24/2010 13:26:05.882 CCM|StationInit: (0000001) OpenReceiveChannelAck Status=0, IpAddr=IpAddr.type:0 ipAddr:0x0a0a0609000000000000000000000000(10.10.6.9), Port=24894, PartyID=16777404|\par 03/24/2010 13:26:05.882 CCM|AgenaInterface(138)::setDeviceOLCAckInfo, lcn=1, ip=, port=24894|\par 03/24/2010 13:26:05.882 CCM|AgenaInterface(138)::handleDTMFSubscribe, subscribe(0) rfc2833PT(0), passThru2833(0) |\par 03/24/2010 13:26:05.882 CCM|MediaExchange(88)::fillAuConnectInfoIndMsg, noMediaInfo=0, resType=0|\par 03/24/2010 13:26:05.882 CCM|MediaExchange(88)::fillAudioMediaInfo, partyIdx=0, xferMode=8, codec=4, maxFramesPerPacket=20i, audioSRTP=0, videoSRTP=0, dataAppSRTP=0, mediaSecurity=1|\par 03/24/2010 13:26:05.883 CCM|MediaExchange(88)::fillAddressInfo, idx=1, addr=,port=24894|\par 03/24/2010 13:26:05.883 CCM|MediaExchange(88)::fillAudioMediaInfo, partyIdx=1, xferMode=10, codec=4, maxFramesPerPacket=20i, audioSRTP=0, videoSRTP=0, dataAppSRTP=0, mediaSecurity=1|\par 03/24/2010 13:26:05.883 CCM|MediaExchange(88)::fillAddressInfo, idx=0, addr=,port=24896|\par 03/24/2010 13:26:05.883 CCM|AgenaInterface(137)::getPartyIdForAgena, numofportopened=0, mediaType=1, fcodec=0|\par 03/24/2010 13:26:05.883 CCM|AgenaInterface(137)::sessionEstablished_MediaExchangeInterfacePathEstablished, mediaType=1, aPT=2, vPT=2|\par 03/24/2010 13:26:05.883 CCM|AgenaInterface() - mapChannelToPartyId,lcn=1, partyid=16777403, channelDir=1|\par 03/24/2010 13:26:05.883 CCM|AgenaInterface(137)::SendStartTalkingForNonMultiCastConnection, partyid=16777403, lcn=1 |\par 03/24/2010 13:26:05.883 CCM|AgenaInterface(137)::get2833PayloadType, LCN(1) rfc2833PT (0)|\par 03/24/2010 13:26:05.883 CCM|MediaManager(53)::wait_AuConnectInfo, AuConnectInfoInd Optimization - CI(27646257,27646258), resType(0), CI( 27646255 27646257), mediaType(1), mediaPathType(2), codec(2,4,4) |\par 03/24/2010 13:26:05.883 CCM|UnicastBridgeControl - fillAudioPartyIDtoMediaPidTable PartyId = 16777403, CLCRecd=0, StopTlkRecd=0|\par 03/24/2010 13:26:05.883 CCM|MediaCoordinator - wait_AuConnectInfoInd|\par 03/24/2010 13:26:05.884 CCM|UnicastBridgeControl - stationOutputStartMediaTransmission TCPPid = [1.100.9.5] myIP: 9060a0a (10.10.6.9), security: 0.|\par 03/24/2010 13:26:05.884 CCM|UnicastBridgeControl - star_StationOutputStartMediaTransmission - ConferenceID: 16787294 MediaPartyId: 16777403, RemoteIpAddr: 9060a0a (10.10.6.9) RemoteRtpPortNumber: 613E msecPacketSize: 20 compressionType: 4, TCPPid = [1.100.9.5]|\par 03/24/2010 13:26:05.884 CCM|Cdcc - (0000111) - dumpSecureStatus - sideA=(cap=1,1, media=0,0, feature=0,0), sideB=(cap=1,1 media=0,0, feature=0,0)|\par 03/24/2010 13:26:05.884 CCM|Cdcc - (0000111) - updateDchanCrpMediaSecurity - media security=1, intermediateDeviceExists=1|\par 03/24/2010 13:26:05.884 CCM|Cdcc - (0000111) - updateDchanCrpMediaSecurity - media security on side 0 is (1,1)|\par 03/24/2010 13:26:05.884 CCM|Cdcc - (0000111) - updateDchanCrpMediaSecurity - media security on side 1 is (1,1)|\par 03/24/2010 13:26:05.884 CCM|Cdcc - (0000111) - broadcastSsConnectInfoInd - ss1=27646255, ss2=27646257, sideA=(cap=1,1, media=1,1, feature=0,0), sideB=(cap=1,1, media=1,1, feature=0,0),|\par 03/24/2010 13:26:05.884 CCM|Cdcc - (0000111) - dumpSecureStatus - sideA=(cap=1,1, media=1,1, feature=0,0), sideB=(cap=1,1 media=1,1, feature=0,0)|\par 03/24/2010 13:26:05.884 CCM|Cdcc - (0000111) - getSecureStatusOfCall - overall=1|\par 03/24/2010 13:26:05.885 CCM|Cdcc - (0000111) - notifySecurityStatus side=0, security=1|\par 03/24/2010 13:26:05.885 CCM|Cdcc - (0000111) - dumpSecureStatus - sideA=(cap=1,1, media=1,1, feature=0,0), sideB=(cap=1,1 media=1,1, feature=0,0)|\par 03/24/2010 13:26:05.885 CCM|Cdcc - (0000111) - getSecureStatusOfCall - overall=1|\par 03/24/2010 13:26:05.885 CCM|Cdcc - (0000111) - notifySecurityStatus side=1, security=1|\par 03/24/2010 13:26:05.885 CCM|Cdcc - (0000111) - dumpSecureStatus - sideA=(cap=1,1, media=1,1, feature=0,0), sideB=(cap=1,1 media=1,1, feature=0,0)|\par 03/24/2010 13:26:05.885 CCM|Cdcc - (0000111) - getSecureStatusOfCall - overall=1|\par 03/24/2010 13:26:05.885 CCM|Cdcc - (0000111) - dumpSecureStatus - sideA=(cap=1,1, media=1,1, feature=0,0), sideB=(cap=1,1 media=1,1, feature=0,0)|\par 03/24/2010 13:26:05.885 CCM|Cdcc - (0000111) - getSecureStatusOfCall - overall=1|\par 03/24/2010 13:26:05.885 CCM|Locations_adjustBandwidth -- cdccPID=(1.171.111) Dest=0 no bw to adjust.|\par 03/24/2010 13:26:05.885 CCM|Locations_adjustBandwidth -- cdccPID=(1.171.111) bw already released for User Party|\par 03/24/2010 13:26:05.885 CCM|Locations_adjustBandwidth -- cdccPID=(1.171.111) Media Source no bw to release.|\par 03/24/2010 13:26:05.885 CCM|Locations_adjustBandwidth -- cdccPID=(1.171.111) Orig=4 bw set to infinite.|\par 03/24/2010 13:26:05.885 CCM|Locations_adjustBandwidth -- cdccPID=(1.171.111) Orig=4 audio bw set to infinite, no need to release|\par 03/24/2010 13:26:05.885 CCM|Locations_adjustBandwidth -- cdccPID=(1.171.111) Dest=0 no need to release audio bw.|\par 03/24/2010 13:26:05.885 CCM|Locations_adjustBandwidth -- cdccPID=(1.171.111) Orig=4 bw set to infinite|\par 03/24/2010 13:26:05.885 CCM|Locations_adjustBandwidth -- cdccPID=(1.171.111) Dest=0 no need to RESERVE/ADJUST_BANDWIDTH.|\par 03/24/2010 13:26:05.886 CCM|//SIP/SIPD(1,52,10)/ccbId=0/scbId=0/getKeyBasedOnCiAndBranch: AddressingElement branch is 0 and ci is 27646255 mapKey is 27646255|\par 03/24/2010 13:26:05.886 CCM|//SIP/SIPD(1,52,10)/ccbId=0/scbId=0/getCdpcPid: found Cdpc Pid (1,100,53,85) for mapKey 27646255|\par 03/24/2010 13:26:05.886 CCM|UnicastBridgeControl - restart0_CcNotifyReq - Ci = 27646257, Q931SignalVal = 0, AnnAttached=0|\par 03/24/2010 13:26:05.886 CCM|MeetMeConference - handleSecurityUpdate - SideB is ConferenceResourceParty |\par 03/24/2010 13:26:05.886 CCM|MeetMeConference - handleSecurityUpdate - sideA( 1,27646229,4) , sideA.Party =1 , sideA.media =2 , sideA.feature = 0 , sideB( 1,27646232,1) sideB.Party =1 , sideB.media =2 , sideB.feature = 0 |\par 03/24/2010 13:26:05.886 CCM|MeetMeConference - handleSecurityUpdate - SideB is ConferenceResourceParty |\par 03/24/2010 13:26:05.886 CCM|MeetMeConference - handleSecurityUpdate - sideA( 1,27646255,8) , sideA.Party =1 , sideA.media =1 , sideA.feature = 0 , sideB( 1,27646257,1) sideB.Party =1 , sideB.media =1 , sideB.feature = 0 |\par 03/24/2010 13:26:05.887 CCM|Cdcc - (0000104) - dumpSecureStatus - sideA=(cap=1,1, media=1,2, feature=0,0), sideB=(cap=1,1 media=1,2, feature=1,3)|\par 03/24/2010 13:26:05.887 CCM|Cdcc - (0000104) - getSecureStatusOfCall - overall=1|\par 03/24/2010 13:26:05.887 CCM|Cdcc - (0000104) - processSsUpdateInfoReq - add feature security, side=1, (1,1)|\par 03/24/2010 13:26:05.887 CCM|Cdcc - (0000104) - broadcastSsUpdateInfoInd - ss=27646232, partySecureStatus=(cap=1,1, media=1,2, feature=1,1)|\par 03/24/2010 13:26:05.887 CCM|Cdcc - (0000104) - broadcastSsUpdateInfoInd - ss=27646232, partySecureStatus=(cap=1,1, media=1,2, feature=1,1)|\par 03/24/2010 13:26:05.887 CCM|Cdcc - (0000104) - dumpSecureStatus - sideA=(cap=1,1, media=1,2, feature=0,0), sideB=(cap=1,1 media=1,2, feature=1,1)|\par 03/24/2010 13:26:05.887 CCM|Cdcc - (0000104) - getSecureStatusOfCall - overall=1|\par 03/24/2010 13:26:05.887 CCM|Cdcc - (0000104) - dumpSecureStatus - sideA=(cap=1,1, media=1,2, feature=0,0), sideB=(cap=1,1 media=1,2, feature=1,1)|\par 03/24/2010 13:26:05.887 CCM|Cdcc - (0000104) - getSecureStatusOfCall - overall=1|\par 03/24/2010 13:26:05.888 CCM|Cdcc - (0000111) - dumpSecureStatus - sideA=(cap=1,1, media=1,1, feature=0,0), sideB=(cap=1,1 media=1,1, feature=0,0)|\par 03/24/2010 13:26:05.888 CCM|Cdcc - (0000111) - getSecureStatusOfCall - overall=1|\par 03/24/2010 13:26:05.888 CCM|Cdcc - (0000111) - processSsUpdateInfoReq - add feature security, side=1, (1,1)|\par 03/24/2010 13:26:05.888 CCM|Cdcc - (0000111) - broadcastSsUpdateInfoInd - ss=27646257, partySecureStatus=(cap=1,1, media=1,1, feature=1,1)|\par 03/24/2010 13:26:05.888 CCM|Cdcc - (0000111) - dumpSecureStatus - sideA=(cap=1,1, media=1,1, feature=0,0), sideB=(cap=1,1 media=1,1, feature=1,1)|\par 03/24/2010 13:26:05.888 CCM|Cdcc - (0000111) - getSecureStatusOfCall - overall=1|\par 03/24/2010 13:26:05.888 CCM|Cdcc - (0000111) - dumpSecureStatus - sideA=(cap=1,1, media=1,1, feature=0,0), sideB=(cap=1,1 media=1,1, feature=1,1)|\par 03/24/2010 13:26:05.888 CCM|Cdcc - (0000111) - getSecureStatusOfCall - overall=1|\par 03/24/2010 13:26:05.889 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/setPresentationIndication: namePi[1], numPi[1]|\par 03/24/2010 13:26:05.889 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/setScreeningIndication: si[1], oct3a[81]|\par 03/24/2010 13:26:05.889 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/setIdentityHeaders: ccb[b415f780], currLocalNum[0454916903], currLocalNam[Conference], callbackNumber[], localNumPi[1], localNamPi[1], id.flag[10], id.privacy[0]|\par 03/24/2010 13:26:05.889 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/setRpidHeader: rpidHdrStr["Conference" ;party=called;screen=yes;privacy=off]|\par 03/24/2010 13:26:05.889 CCM|//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 3 for event 6|\par 03/24/2010 13:26:05.889 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_EXPIRES value=180000 retries=0|\par 03/24/2010 13:26:05.889 CCM|//SIP/Stack/Info/0xb415f780/****Adding to UAS Response table.|\par 03/24/2010 13:26:05.889 CCM|//SIP/Stack/Info/0xb415f780/Added to table. ccb=0xb415f780 key=94410CC7-363C11DF-8043A429-AA96E928@10.10.6.1050BBA51F-8870-4670-AA5B-5318556CE26F-27646255|\par 03/24/2010 13:26:05.890 CCM|//SIP/Stack/Info/0xb415f780/Associated container=0xb3bff648 to Invite Response 200|\par 03/24/2010 13:26:05.890 CCM|//SIP/Stack/Transport/0xb415f780/Sending 200OK Response to the Transport Layer|\par 03/24/2010 13:26:05.890 CCM|//SIP/Stack/Transport/0xb415f780/msg=0xb64a4040, addr=10.10.6.10, port=64248, sentBy_port=5060, is_req=0, transport=1, switch=0, callBack=0x9cbafc4|\par 03/24/2010 13:26:05.890 CCM|//SIP/Stack/Transport/0xb415f780/Proceedable for sending msg immediately|\par 03/24/2010 13:26:05.890 CCM|//SIP/Stack/Transport/0xb415f780/switch transport is 0|\par 03/24/2010 13:26:05.890 CCM|//SIP/Stack/Transport/0x0/Posting send for msg=0xb64a4040, addr=10.10.6.10, port=5060, connId=0 for UDP|\par 03/24/2010 13:26:05.890 CCM|//SIP/Stack/Info/0xb415f780/Sent 200Ok for Invite in state STATE_RECD_INVITE|\par 03/24/2010 13:26:05.890 CCM|//SIP/Stack/Info/0x0/Transaction active. Facilities will be queued.|\par 03/24/2010 13:26:05.890 CCM|//SIP/Stack/Info/0xb415f780/sip_callentry_call_active_notify_app not implemented on this platform|\par 03/24/2010 13:26:05.890 CCM|//SIP/Stack/States/0xb415f780/0xb415f780 : State change from (STATE_RECD_INVITE, SUBSTATE_NONE) to (STATE_SENT_SUCCESS, SUBSTATE_NONE)|\par 03/24/2010 13:26:05.890 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_CONNECT value=500 retries=6|\par 03/24/2010 13:26:05.890 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: type=SIP_TIMER_CONNECT value=500 retries=6|\par 03/24/2010 13:26:05.891 CCM|//SIP/SIPUdp/wait_SdlSPISignal: Outgoing SIP UDP message to 10.10.6.10:[5060]:\par SIP/2.0 200 OK\par Date: Wed, 24 Mar 2010 05:26:05 GMT\par Allow: INVITE, OPTIONS, INFO, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY\par From: ;tag=9055EC-1CF2\par Allow-Events: presence, kpml\par P-Asserted-Identity: "Conference" \par Supported: replaces\par Remote-Party-ID: "Conference" ;party=called;screen=yes;privacy=off\par Content-Length: 206\par Require: timer\par To: ;tag=50bba51f-8870-4670-aa5b-5318556ce26f-27646255\par Contact: ;isfocus\par Content-Type: application/sdp\par Call-ID: 94410CC7-363C11DF-8043A429-AA96E928@10.10.6.10\par Via: SIP/2.0/UDP 10.10.6.10:5060;branch=z9hG4bK1EE4C\par CSeq: 101 INVITE\par Session-Expires: 1800;refresher=uas\par \par v=0\par o=CiscoSystemsCCM-SIP 2000 1 IN IP4 10.10.6.9\par s=SIP Call\par c=IN IP4 10.10.6.9\par t=0 0\par m=audio 24892 RTP/AVP 8 101\par a=rtpmap:8 PCMA/8000\par a=ptime:20\par a=rtpmap:101 telephone-event/8000\par a=fmtp:101 0-15\par |\par 03/24/2010 13:26:05.891 CCM|EnvProcessUdpPort - EnvProcessUdpHandler::fireSignal() varId = 0|\par 03/24/2010 13:26:05.892 CCM|EnvProcessUdpPort - EnvProcessUdpHandler::send(buff, 970, 10.10.6.10:5060)|\par 03/24/2010 13:26:05.892 CCM|StationInit: (0000001) StationSubscribeDtmfPayloadResMessage DtmfPayload=0 conferenceID=16787301, passthruID=16777402|\par 03/24/2010 13:26:05.892 CCM|MediaTerminationPointControl(1)::star_StationSubscribeDtmfPayloadRes payload=0, confId=16787301 partyId=16777402|\par 03/24/2010 13:26:05.905 CCM|EnvProcessUdpHandler::handle_input Status: 0, Id: 0|\par 03/24/2010 13:26:05.905 CCM|//SIP/SIPUdp/wait_UdpDataInd: Incoming SIP UDP message size 403 from 10.10.6.10:[64248]:\par ACK sip:0454916903@10.10.6.9:5060 SIP/2.0\par Via: SIP/2.0/UDP 10.10.6.10:5060;branch=z9hG4bK1FDFD\par From: ;tag=9055EC-1CF2\par To: ;tag=50bba51f-8870-4670-aa5b-5318556ce26f-27646255\par Date: Wed, 24 Mar 2010 05:26:05 GMT\par Call-ID: 94410CC7-363C11DF-8043A429-AA96E928@10.10.6.10\par Max-Forwards: 70\par CSeq: 101 ACK\par Allow-Events: telephone-event\par Content-Length: 0\par \par |\par 03/24/2010 13:26:05.905 CCM|//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 2 for event 1|\par 03/24/2010 13:26:05.905 CCM|//SIP/Stack/Transport/0x0/context=(nil)|\par 03/24/2010 13:26:05.905 CCM|//SIP/Stack/Info/0x0/Checking Invite Dialog|\par 03/24/2010 13:26:05.905 CCM|//SIP/Stack/Info/0xb415f780/*****CCB found in UAS Response table. ccb=0xb415f780|\par 03/24/2010 13:26:05.905 CCM|//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.10.6.10,Port 64248, Transport 1, SentBy Port 5060|\par 03/24/2010 13:26:05.905 CCM|//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.10.6.10,Port 64248, Transport 1, SentBy Port 5060|\par 03/24/2010 13:26:05.905 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_CONNECT value=500 retries=6|\par 03/24/2010 13:26:05.905 CCM|//SIP/Stack/Info/0xb415f780/Transaction Complete. Lock on Facilities released.|\par 03/24/2010 13:26:05.905 CCM|//SIP/Stack/States/0xb415f780/0xb415f780 : State change from (STATE_SENT_SUCCESS, SUBSTATE_NONE) to (STATE_ACTIVE, SUBSTATE_NONE)|\par 03/24/2010 13:26:05.905 CCM|//SIP/Stack/Info/0xb415f780/sip_spi_handle_media_inact_timer not implemented on this platform. |\par 03/24/2010 13:26:05.906 CCM|//SIP/Stack/Info/0xb415f780/sip_spi_handle_loopback_rtp not implemented on this platform.|\par 03/24/2010 13:26:05.906 CCM|//SIP/SIPHandler/ccbId=120/scbId=0/findDevicePID: Routed by ccbId/scbId|\par 03/24/2010 13:26:05.906 CCM|//SIP/SIPHandler/ccbId=120/scbId=0/findDevicePID: Routed by ccbId/scbId|\par 03/24/2010 13:26:05.906 CCM|//SIP/SIPHandler/ccbId=120/scbId=0/findDevicePID: Routed by ccbId/scbId|\par 03/24/2010 13:26:05.906 CCM|//SIP/SIPD(1,52,10)/ccbId=0/scbId=0/getKeyBasedOnCiAndBranch: AddressingElement branch is 0 and ci is 27646255 mapKey is 27646255|\par 03/24/2010 13:26:05.906 CCM|//SIP/SIPD(1,52,10)/ccbId=0/scbId=0/getCdpcPidGivenCcbidAndCi: found Cdpc Pid (1,100,53,85) for mapKey 27646255|\par 03/24/2010 13:26:05.906 CCM|//SIP/SIPD(1,52,10)/ccbId=0/scbId=0/getKeyBasedOnCiAndBranch: AddressingElement branch is 0 and ci is 27646255 mapKey is 27646255|\par 03/24/2010 13:26:05.906 CCM|//SIP/SIPD(1,52,10)/ccbId=0/scbId=0/getCdpcPidGivenCcbidAndCi: found Cdpc Pid (1,100,53,85) for mapKey 27646255|\par 03/24/2010 13:26:05.906 CCM|//SIP/SIPD(1,52,10)/ccbId=0/scbId=0/getKeyBasedOnCiAndBranch: AddressingElement branch is 0 and ci is 27646255 mapKey is 27646255|\par 03/24/2010 13:26:05.906 CCM|//SIP/SIPD(1,52,10)/ccbId=0/scbId=0/getCdpcPidGivenCcbidAndCi: found Cdpc Pid (1,100,53,85) for mapKey 27646255|\par 03/24/2010 13:26:05.906 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/processLocalIdentityInfo: num=,localCnNum=0454916903;numPi=0,localCnNumPi=1;name=,localCnName=\'804;|\par 03/24/2010 13:26:05.906 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/processLocalIdentityInfo: identityFlag=[Changed:- Num;Num PI;Name;]|\par 03/24/2010 13:26:05.906 CCM|(isHeldOrHolding): er=0,ee=0,mh=0|\par 03/24/2010 13:26:05.906 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/updateDisplayInfoAndSendMsg: mSrtpPresent 0 prevSecurity 1 mSecurity 1 media-hold 0 mDialogDirection 2 Configured status 1 msgType 3 devType 8|\par 03/24/2010 13:26:05.906 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/star_SIPUpdateAllowed: mIsUpdateForSignalingAllowed = 1 mIsUpdateForMediaAllowed = 1|\par 03/24/2010 13:26:06.884 CCM|CiCcp table has 6 entries|\par 03/24/2010 13:26:06.954 CCM|CMProcMon - ------Entered Router Verification|\par 03/24/2010 13:26:06.954 CCM|CMProcMon - ----Exited Router Verification|\par 03/24/2010 13:26:08.468 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/wait_SIPTimer: TimerExpired type=SIP_TIMER_DISCONNECT value=4000 retries=1|\par 03/24/2010 13:26:08.468 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: type=SIP_TIMER_DISCONNECT value=4000 retries=0|\par 03/24/2010 13:26:08.468 CCM|//SIP/Stack/Info/0xb415b460/Stopping hold timer|\par 03/24/2010 13:26:08.468 CCM|//SIP/Stack/Transport/0xb415b460/Sending BYE to the transport layer|\par 03/24/2010 13:26:08.468 CCM|//SIP/Stack/Transport/0xb415b460/msg=0xb645afa8, addr=10.249.224.18, port=5065, sentBy_port=0, is_req=1, transport=1, switch=0, callBack=(nil)|\par 03/24/2010 13:26:08.468 CCM|//SIP/Stack/Transport/0xb415b460/Proceedable for sending msg immediately|\par 03/24/2010 13:26:08.468 CCM|//SIP/Stack/Transport/0xb415b460/switch transport is 0|\par 03/24/2010 13:26:08.468 CCM|//SIP/Stack/Transport/0xb415b460/Set to send the msg=0xb645afa8|\par 03/24/2010 13:26:08.468 CCM|//SIP/Stack/Transport/0x0/Posting send for msg=0xb645afa8, addr=10.249.224.18, port=5065, connId=0 for UDP|\par 03/24/2010 13:26:08.469 CCM|//SIP/SIPUdp/wait_SdlSPISignal: Outgoing SIP UDP message to 10.249.224.18:[5065]:\par BYE sip:8806301@10.249.224.18:5065;transport=udp SIP/2.0\par Reason: Q.850;cause=86\par Date: Wed, 24 Mar 2010 05:25:17 GMT\par From: ;tag=50bba51f-8870-4670-aa5b-5318556ce26f-27646251\par Content-Length: 0\par User-Agent: Cisco-CUCM7.0\par To: "8806301";tag=50bba51f-8870-4670-aa5b-5318556ce26f-27646249\par Call-ID: E0DA5DA000@10.249.0.6\par Via: SIP/2.0/UDP 10.10.6.9:5060;branch=z9hG4bK4bee8648\par CSeq: 101 BYE\par Max-Forwards: 70\par \par |\par 03/24/2010 13:26:08.469 CCM|EnvProcessUdpPort - EnvProcessUdpHandler::fireSignal() varId = 0|\par 03/24/2010 13:26:08.469 CCM|EnvProcessUdpPort - EnvProcessUdpHandler::send(buff, 464, 10.249.224.18:5065)|\par 03/24/2010 13:26:08.955 CCM|CMProcMon - ------Entered Router Verification|\par 03/24/2010 13:26:08.955 CCM|CMProcMon - ----Exited Router Verification|\par 03/24/2010 13:26:09.657 CCM|EnvProcessUdpHandler::handle_input Status: 0, Id: 0|\par 03/24/2010 13:26:09.657 CCM|//SIP/Stack/Error/0x0/DROPPING unregistered header Timestamp: 1269408369|\par 03/24/2010 13:26:09.657 CCM|//SIP/SIPUdp/wait_UdpDataInd: Incoming SIP UDP message size 459 from 10.10.6.10:[64248]:\par BYE sip:0454916903@10.10.6.9:5060 SIP/2.0\par Via: SIP/2.0/UDP 10.10.6.10:5060;branch=z9hG4bK201421\par From: ;tag=9055EC-1CF2\par To: ;tag=50bba51f-8870-4670-aa5b-5318556ce26f-27646255\par Date: Wed, 24 Mar 2010 05:26:05 GMT\par Call-ID: 94410CC7-363C11DF-8043A429-AA96E928@10.10.6.10\par User-Agent: Cisco-SIPGateway/IOS-12.x\par Max-Forwards: 70\par Timestamp: 1269408369\par CSeq: 102 BYE\par Reason: Q.850;cause=16\par Content-Length: 0\par \par |\par 03/24/2010 13:26:09.657 CCM|//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 2 for event 1|\par 03/24/2010 13:26:09.657 CCM|//SIP/Stack/Transport/0x0/context=(nil)|\par 03/24/2010 13:26:09.657 CCM|//SIP/Stack/Info/0x0/Checking Invite Dialog|\par 03/24/2010 13:26:09.657 CCM|//SIP/Stack/Info/0xb415f780/*****CCB found in UAS Response table. ccb=0xb415f780|\par 03/24/2010 13:26:09.657 CCM|//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.10.6.10,Port 64248, Transport 1, SentBy Port 5060|\par 03/24/2010 13:26:09.657 CCM|//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.10.6.10,Port 64248, Transport 1, SentBy Port 5060|\par 03/24/2010 13:26:09.657 CCM|//SIP/Stack/Info/0xb415f780/Stopping hold timer|\par 03/24/2010 13:26:09.657 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/parseReasonHeaderField: Reason Header: Q.850 Cause: 16|\par 03/24/2010 13:26:09.657 CCM|//SIP/Stack/Info/0x0/No GTD found in inbound container|\par 03/24/2010 13:26:09.658 CCM|//SIP/Stack/Info/0xb415f780/Initiate call disconnect(16) for incoming call|\par 03/24/2010 13:26:09.658 CCM|//SIP/SIPHandler/ccbId=120/scbId=0/findDevicePID: Routed by ccbId/scbId|\par 03/24/2010 13:26:09.658 CCM|//SIP/Stack/States/0xb415f780/0xb415f780 : State change from (STATE_ACTIVE, SUBSTATE_NONE) to (STATE_DISCONNECTING, SUBSTATE_NONE)|\par 03/24/2010 13:26:09.658 CCM|//SIP/SIPD(1,52,10)/ccbId=0/scbId=0/getKeyBasedOnCiAndBranch: AddressingElement branch is 0 and ci is 27646255 mapKey is 27646255|\par 03/24/2010 13:26:09.658 CCM|//SIP/SIPD(1,52,10)/ccbId=0/scbId=0/getCdpcPidGivenCcbidAndCi: found Cdpc Pid (1,100,53,85) for mapKey 27646255|\par 03/24/2010 13:26:09.658 CCM|(isHeldOrHolding): er=0,ee=0,mh=0|\par 03/24/2010 13:26:09.658 CCM|processCCMFeatureData: operationIeIdd=0|\par 03/24/2010 13:26:09.658 CCM|EnvProcessCdr::wait_DbCdrReq|\par 03/24/2010 13:26:09.658 CCM|EnvProcessCdr::wait_DbCdrReq DETAILED Entries 106, Inserts 106, ZeroCalls 0, StartRecords 0, Default 0|\par 03/24/2010 13:26:09.658 CCM|EnvProcessCdr::formatCdrData|\par 03/24/2010 13:26:09.660 CCM|MeetMeConference - removeMeetMeConfereeInfoGivenNodeIdSsParty - MeetMeList deleted(node 1,27646255) remaining sideA( 1,27646229,4,1) remaining sideB( 1,27646232,1,1)|\par 03/24/2010 13:26:09.660 CCM|MeetMeConference - CalculateOverallSecurityofConf - Conference level changed = 1|\par 03/24/2010 13:26:09.660 CCM|MeetMeConference - handleSecurityUpdate - SideB is ConferenceResourceParty |\par 03/24/2010 13:26:09.660 CCM|MeetMeConference - handleSecurityUpdate - sideA( 1,27646229,4) , sideA.Party =1 , sideA.media =2 , sideA.feature = 0 , sideB( 1,27646232,1) sideB.Party =1 , sideB.media =2 , sideB.feature = 0 |\par 03/24/2010 13:26:09.660 CCM|MeetMeConference - await_conference_extension_SsDataInd - Removing Conferee - [27646255], No. of current instances = [1].|\par 03/24/2010 13:26:09.660 CCM|ConnectionManager - wait_AuDisconnectRequest(27646255,27646257),disconnectType(1), IFHandling(0,0)|\par 03/24/2010 13:26:09.660 CCM|ConnectionManager - storeMediaInfo(27646255): EXISTING ENTRY DISCOVERED, size=4|\par 03/24/2010 13:26:09.660 CCM|ConnectionManager - storeMediaInfo(27646257): EXISTING ENTRY DISCOVERED, size=4|\par 03/24/2010 13:26:09.660 CCM|MediaCoordinator - wait_AuDisconnectRequest,CI(27646255,27646257),IFCreated(1,1)|\par 03/24/2010 13:26:09.660 CCM|MediaCoordinator - wait_AuDisconnectRequest - sending disconnect to MediaManager(53)|\par 03/24/2010 13:26:09.661 CCM|Cdcc - (0000104) - dumpSecureStatus - sideA=(cap=1,1, media=1,2, feature=0,0), sideB=(cap=1,1 media=1,2, feature=1,1)|\par 03/24/2010 13:26:09.661 CCM|Cdcc - (0000104) - getSecureStatusOfCall - overall=1|\par 03/24/2010 13:26:09.661 CCM|Cdcc - (0000104) - processSsUpdateInfoReq - add feature security, side=1, (1,3)|\par 03/24/2010 13:26:09.661 CCM|Cdcc - (0000104) - broadcastSsUpdateInfoInd - ss=27646232, partySecureStatus=(cap=1,1, media=1,2, feature=1,3)|\par 03/24/2010 13:26:09.661 CCM|Cdcc - (0000104) - broadcastSsUpdateInfoInd - ss=27646232, partySecureStatus=(cap=1,1, media=1,2, feature=1,3)|\par 03/24/2010 13:26:09.661 CCM|Cdcc - (0000104) - dumpSecureStatus - sideA=(cap=1,1, media=1,2, feature=0,0), sideB=(cap=1,1 media=1,2, feature=1,3)|\par 03/24/2010 13:26:09.661 CCM|Cdcc - (0000104) - getSecureStatusOfCall - overall=1|\par 03/24/2010 13:26:09.661 CCM|Cdcc - (0000104) - dumpSecureStatus - sideA=(cap=1,1, media=1,2, feature=0,0), sideB=(cap=1,1 media=1,2, feature=1,3)|\par 03/24/2010 13:26:09.661 CCM|Cdcc - (0000104) - getSecureStatusOfCall - overall=1|\par 03/24/2010 13:26:09.661 CCM|MediaManager(53)::wait_AuDisconnectRequest, mCleanupPreallocatedMTP=0|\par 03/24/2010 13:26:09.661 CCM|MediaManager(53)::wait_AuDisconnectRequest, mrid(0,0) ci(2764625527646257) size(2), dt(1)|\par 03/24/2010 13:26:09.661 CCM|MediaManager(53)::wait_AuDisconnectRequest, StopSession,disconn MX(110,87) mrid (0 0), IFHandling(0,0)|\par 03/24/2010 13:26:09.661 CCM|MediaManager(53)::wait_AuDisconnectRequest, StopSession,disconn MX(110,88) mrid (0 0), IFHandling(0,0)|\par 03/24/2010 13:26:09.662 CCM|MediaExchange(87)::wait_Disconnect, dt=1,stReason=0,IFHandling(0,0)|\par 03/24/2010 13:26:09.662 CCM|MediaExchange(88)::wait_Disconnect, dt=1,stReason=0,IFHandling(0,0)|\par 03/24/2010 13:26:09.662 CCM|LineCdpc(79): -dispatchToAllDevices-, sigName=CcInfoReq, device=SEP000DED23C82E|\par 03/24/2010 13:26:09.662 CCM|AgenaInterface(136)::closeRecvForAllAudioChannels, mAudioIncomingLC2AGIDMap size = 1|\par 03/24/2010 13:26:09.663 CCM|AgenaInterface(136)::needToPassThru, isMTP=1, mediaType=1, aPT=2, vPT=2, switching to Fax=0|\par 03/24/2010 13:26:09.663 CCM|AgenaInterface(136)::can2833BeNegotiated, PeerCapsSupport2833=0 shouldCheckPeerDTMFProfile=1|\par 03/24/2010 13:26:09.663 CCM|AgenaInterface(137)::closeRecvForAllAudioChannels, mAudioIncomingLC2AGIDMap size = 1|\par 03/24/2010 13:26:09.663 CCM|AgenaInterface(137)::needToPassThru, isMTP=0, mediaType=1, aPT=2, vPT=2, switching to Fax=0|\par 03/24/2010 13:26:09.663 CCM|AgenaInterface(137)::can2833BeNegotiated, PeerCapsSupport2833=1 shouldCheckPeerDTMFProfile=0|\par 03/24/2010 13:26:09.663 CCM|AgenaInterface(137)::can2833BeNegotiated, is false|\par 03/24/2010 13:26:09.663 CCM|AgenaInterface(138)::closeRecvForAllAudioChannels, mAudioIncomingLC2AGIDMap size = 1|\par 03/24/2010 13:26:09.663 CCM|AgenaInterface(138)::needToPassThru, isMTP=1, mediaType=1, aPT=2, vPT=2, switching to Fax=0|\par 03/24/2010 13:26:09.663 CCM|AgenaInterface(138)::can2833BeNegotiated, PeerCapsSupport2833=0 shouldCheckPeerDTMFProfile=0|\par 03/24/2010 13:26:09.664 CCM|AgenaInterface(138)::can2833BeNegotiated, is false|\par 03/24/2010 13:26:09.664 CCM|StationD(4): StationCtiD - CcInfoReq CI=27646229fid = 123|\par 03/24/2010 13:26:09.664 CCM|StationD(4): StationCtiD - CcInfoReq CI=27646229fid = 123|\par 03/24/2010 13:26:09.664 CCM|MediaTerminationPointControl(1)::star_MediaExchangeAgenaCloseLogicalChannel - PartyId = 16777402|\par 03/24/2010 13:26:09.664 CCM|MediaTerminationPointControl(1)::star_MediaExchangeAgenaCloseLogicalChannel - confernceId=16787301 removed AgenaInstance=136|\par 03/24/2010 13:26:09.664 CCM|MediaTerminationPointControl(1)::star_MediaExchangeAgenaCloseLogicalChannel - Sending Close Channel for Party id =16777402|\par 03/24/2010 13:26:09.664 CCM|MediaTerminationPointControl(1)::star_MediaExchangeAgenaUnsubscribeDtmfPayloadReq - CI = 16787301|\par 03/24/2010 13:26:09.664 CCM|MediaTerminationPointControl(1)::star_MediaExchangeStopTalking - Sending Stop Talking for Party id =16777402|\par 03/24/2010 13:26:09.664 CCM|MediaTerminationPointControl(1)::removeAudioPartyIdtoMediaPidEntry - Close Channel and Stop Talking both received for PartyId = 16777402. Removing it from our tables.|\par 03/24/2010 13:26:09.665 CCM|MediaTerminationPointControl(1) - MediaExchangeAgenaDeassociateReq confId=16787301 current AIF(0,138)|\par 03/24/2010 13:26:09.665 CCM|UnicastBridgeControl - removeAudioPartyIdtoMediaPidEntry Close Channel and Stop Talking both received for PartyId = 16777403. Removing it from our tables.|\par 03/24/2010 13:26:09.665 CCM|EnvProcessCdr::outputCdrData CDR data - 1,1,17115,27646255,1269408365,1,27646255,168167946,"6000","",0,16,4,168167946,17726,2,20,0,0,0,0,0,0,"0","0",27646257,1,16787294,151390730,"0454916903","b00103001003","",0,0,4,151390730,24896,4,20,0,0,0,0,0,0,"0","0",1269408365,1269408369,"0454916903","2317be8d-9184-493d-9fc8-7274a4640320","Tarlac_PT","","","Tarlac_PT",4,"10.10.6.10","CFB_2",12,0,7,7,0,0,16787294,"StandAloneCluster",7,"","",0,"",2,1,0,0,64,64,"","","","10.10.6.10","10.10.6.9"\par |\par 03/24/2010 13:26:09.665 CCM|MediaTerminationPointControl(1)::star_MediaExchangeAgenaCloseLogicalChannel - PartyId = 16777404|\par 03/24/2010 13:26:09.665 CCM|MediaTerminationPointControl(1)::star_MediaExchangeAgenaCloseLogicalChannel - confernceId=16787301 removed AgenaInstance=138|\par 03/24/2010 13:26:09.665 CCM|MediaTerminationPointControl(1)::star_MediaExchangeAgenaCloseLogicalChannel - Sending Close Channel for Party id =16777404|\par 03/24/2010 13:26:09.665 CCM|MediaTerminationPointControl(1)::star_MediaExchangeStopTalking - Sending Stop Talking for Party id =16777404|\par 03/24/2010 13:26:09.665 CCM|MediaTerminationPointControl(1)::removeAudioPartyIdtoMediaPidEntry - Close Channel and Stop Talking both received for PartyId = 16777404. Removing it from our tables.|\par 03/24/2010 13:26:09.665 CCM|MediaTerminationPointControl(1) - MediaExchangeAgenaDeassociateReq confId=16787301 is removed|\par 03/24/2010 13:26:09.666 CCM|StationCdpc(91): StationCtiCdpc - processToneChange to send ToneChangeNotify CH=1|27646229 CmSsFeature=1 ReasonForRedirection=0 OnBehalf=Device CallReason=1 CallState=8|\par 03/24/2010 13:26:09.666 CCM|MediaTerminationPointControl(1)::star_StationOutputCloseReceiveChannel - TCPPid = [1.100.9.7] myIP: 0x9060a0a (10.10.6.9) ConferenceID: 16787301, MediaPartyId: 16777402|\par 03/24/2010 13:26:09.666 CCM|MediaTerminationPointControl(1)::star_StationUnSubscribeDtmfPayloadReq TCPPid = [1.100.9.7] myIP: 0x9060a0a (10.10.6.9) conferenceID=16787301, passthruPartyID=16777402, payloadDtmf=101, dtmfType=1|\par 03/24/2010 13:26:09.666 CCM|MediaTerminationPointControl(1)::star_StationOutputStopMediaTransmission - TCPPid = [1.100.9.7] myIP: 0x9060a0a (10.10.6.9) ConferenceID: 16787301 MediaPartyId: 16777402|\par 03/24/2010 13:26:09.666 CCM|UnicastBridgeControl - stationOutputCloseReceiveChannel TCPPid = [1.100.9.5] myIP: 9060a0a (10.10.6.9) ConferenceID: 16787294 MediaPartyId: 16777403|\par 03/24/2010 13:26:09.666 CCM|UnicastBridgeControl - stationOutputStopMediaTransmission TCPPid = [1.100.9.5] myIP: 9060a0a (10.10.6.9) ConferenceID: 16787294 MediaPartyId: 16777403|\par 03/24/2010 13:26:09.666 CCM|MediaTerminationPointControl(1)::star_StationOutputCloseReceiveChannel - TCPPid = [1.100.9.7] myIP: 0x9060a0a (10.10.6.9) ConferenceID: 16787301, MediaPartyId: 16777404|\par 03/24/2010 13:26:09.666 CCM|MediaTerminationPointControl(1)::star_StationOutputStopMediaTransmission - TCPPid = [1.100.9.7] myIP: 0x9060a0a (10.10.6.9) ConferenceID: 16787301 MediaPartyId: 16777404|\par 03/24/2010 13:26:09.667 CCM|StationD: (0000004) StartTone tone=49(ZipZip), direction=2.|\par 03/24/2010 13:26:09.667 CCM|StationD: (0000004) SetLamp mode=2, stim=123 stimInst=1.|\par 03/24/2010 13:26:09.667 CCM|StationD(4): StationCtiD - StationOutputSetLamp|\par 03/24/2010 13:26:09.667 CCM|StationD(4): StationCtiD - StationOutputSetLamp|\par 03/24/2010 13:26:09.668 CCM|MediaManager(53)::wait_AuDisconnectReply, CI(27646257,27646258), disconnType(1), stopStreamingReason(0) DTMFMethod(1 3),MC(0,0),rf(0), nD(2,1)|\par 03/24/2010 13:26:09.668 CCM|MediaManager(53)::wait_AuDisconnectReply, videoCap (0, 0), CallType=0|\par 03/24/2010 13:26:09.668 CCM|MediaCoordinator - wait_MediaCoordinatorDelResource - CI=27646258 count=1 mrmNodeId=1|\par 03/24/2010 13:26:09.668 CCM|MediaManager(53)::wait_AuDisconnectReply, CI(27646255,27646258), disconnType(1), stopStreamingReason(0) DTMFMethod(2 3),MC(1,0),rf(0), nD(2,2)|\par 03/24/2010 13:26:09.668 CCM|MediaManager(53)::wait_AuDisconnectReply, videoCap (0, 0), CallType=0|\par 03/24/2010 13:26:09.668 CCM|MediaManager(53)::wait_AuDisconnectReply, recv all disconn replies, forward reply for party(27646255,27646257) mcNodeId(0,0) mrid(0 0) capcounts(1 3), videoCapable(0, 0)|\par 03/24/2010 13:26:09.668 CCM|MediaCoordinator - wait_MediaCoordinatorDelResource - CI=27646258 count=0 mrmNodeId=1|\par 03/24/2010 13:26:09.668 CCM|MediaCoordinator - wait_AuDisconnectReply - removing MediaManager(53) from connection list|\par 03/24/2010 13:26:09.669 CCM|MediaCoordinator - wait_AuDisconnectReply,MMList=1,1/2List=0|\par 03/24/2010 13:26:09.669 CCM|MRM::waiting_MrmDeallocateMtpResourceReq- Deallocate received for CI=27646258 count=0|\par 03/24/2010 13:26:09.669 CCM|MRM::updateMtpCounter MTP_2|\par 03/24/2010 13:26:09.669 CCM|MRM::MRM::updateMtpCounter MRL allocateCounter=0|\par 03/24/2010 13:26:09.669 CCM|MRM::updateXcodeCounter MTP_2|\par 03/24/2010 13:26:09.669 CCM|ConnectionManager - wait_AuDisconnectReply(27646255,27646257),disconnectType(1),IFHandling(0,0)|\par 03/24/2010 13:26:09.669 CCM|ConnectionManager - deleteMediaInfoEntry(27646255): ENTRY DELETED, size=3|\par 03/24/2010 13:26:09.669 CCM|ConnectionManager - deleteMediaInfoEntry(27646257): ENTRY DELETED, size=2|\par 03/24/2010 13:26:09.669 CCM|MediaTerminationPointControl(1)::waiting_DeallocateMtpResourceReq CI=27646258|\par 03/24/2010 13:26:09.669 CCM|MediaTerminationPointControl(1)::waiting_DeallocateMtpResourceReq Allocated = 1 CI=27646258 Count=1|\par 03/24/2010 13:26:09.669 CCM|MediaTerminationPointControl(1)::logResourceStatusinTrace -- Device Name=MTP_2 ResourceAvailable=23 ResourceUsed=1|\par 03/24/2010 13:26:09.669 CCM|MediaTerminationPointControl(1)::decActiveCounter - Count=1|\par 03/24/2010 13:26:09.669 CCM|MediaTerminationPointControl(1)::incAvailableCounter Count=1|\par 03/24/2010 13:26:09.669 CCM|MediaTerminationPointControl(1)::logResourceStatusinTrace -- Device Name=MTP_2 ResourceAvailable=24 ResourceUsed=0|\par 03/24/2010 13:26:09.670 CCM|MatrixControl:updatePartyMediaCoordinatorNodeId: party1 videoCapable=0, party 2 videocapable=0|\par 03/24/2010 13:26:09.670 CCM|Cdcc - (0000111) - resetMediaSecurity|\par 03/24/2010 13:26:09.670 CCM|UnicastBridgeControl::restart0_CcDisconnReq - Device Name = CFB_2, Party Ci = 27646257|\par 03/24/2010 13:26:09.670 CCM|UnicastBridgeControl::sendRSVPUnregisterRequest - Party CI = 27646257|\par 03/24/2010 13:26:09.670 CCM|UnicastBridgeControl::sendRSVPUnregisterRequest - Sent RSVP UnRegister Request from UnicastBridgeControl[1 100 30 1] to RSVPSessionMgr[1 100 74 1]|\par 03/24/2010 13:26:09.670 CCM|UnicastBridgeControl - CcDisconnReq - Device= CFB_2 - Party= 27646257|\par 03/24/2010 13:26:09.670 CCM|UnicastBridgeControl - clearCallInfo - Party= 27646257 Removed from ConferenceId= 16787294, 1 participant(s) remaining|\par 03/24/2010 13:26:09.670 CCM|UnicastBridgeControl::checkConferencePL|\par 03/24/2010 13:26:09.670 CCM|UnicastBridgeControl::releaseStream - Device Name=CFB_2, StreamAvailable=46 StreamUsed=2 MaxStreams=48 |\par 03/24/2010 13:26:09.670 CCM|UnicastBridgeControl::incAvailableCounter CurrentStreamsAvailable= 47|\par 03/24/2010 13:26:09.670 CCM|UnicastBridgeControl::decActiveCounter|\par 03/24/2010 13:26:09.670 CCM|UnicastBridgeControl::releaseStream - Device Name=CFB_2, StreamAvailable=47 StreamUsed=1 MaxStreams=48 |\par 03/24/2010 13:26:09.670 CCM|//SIP/SIPD(1,52,10)/ccbId=0/scbId=0/getKeyBasedOnCiAndBranch: AddressingElement branch is 0 and ci is 27646255 mapKey is 27646255|\par 03/24/2010 13:26:09.670 CCM|//SIP/SIPD(1,52,10)/ccbId=0/scbId=0/getCdpcPid: found Cdpc Pid (1,100,53,85) for mapKey 27646255|\par 03/24/2010 13:26:09.671 CCM|//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 3 for event 7|\par 03/24/2010 13:26:09.671 CCM|Locations_releaseBandwidth -- cdccPID=(1.171.111) Orig=4 audio bw set to infinite, no need to release|\par 03/24/2010 13:26:09.671 CCM|Locations_releaseBandwidth -- cdccPID=(1.171.111) Dest=0 no need to release audio bw.|\par 03/24/2010 13:26:09.671 CCM|//SIP/Stack/Transport/0xb415f780/Sending BYE Response to the transport layer|\par 03/24/2010 13:26:09.671 CCM|Locations_releaseBandwidth party B = media resource -- cdccPID=(1.171.111) removing entry.|\par 03/24/2010 13:26:09.671 CCM|//SIP/Stack/Transport/0xb415f780/msg=0xb645afa8, addr=10.10.6.10, port=64248, sentBy_port=5060, is_req=0, transport=1, switch=0, callBack=0x9cbb296|\par 03/24/2010 13:26:09.671 CCM|//SIP/Stack/Transport/0xb415f780/Proceedable for sending msg immediately|\par 03/24/2010 13:26:09.671 CCM|//SIP/Stack/Transport/0xb415f780/switch transport is 0|\par 03/24/2010 13:26:09.671 CCM|//SIP/Stack/Transport/0x0/Posting send for msg=0xb645afa8, addr=10.10.6.10, port=5060, connId=0 for UDP|\par 03/24/2010 13:26:09.671 CCM|//SIP/Stack/Info/0xb415f780/Sent 200ok to the BYE, tearing down the call|\par 03/24/2010 13:26:09.672 CCM|//SIP/SIPUdp/wait_SdlSPISignal: Outgoing SIP UDP message to 10.10.6.10:[5060]:\par SIP/2.0 200 OK\par Date: Wed, 24 Mar 2010 05:26:09 GMT\par From: ;tag=9055EC-1CF2\par Content-Length: 0\par To: ;tag=50bba51f-8870-4670-aa5b-5318556ce26f-27646255\par Call-ID: 94410CC7-363C11DF-8043A429-AA96E928@10.10.6.10\par Via: SIP/2.0/UDP 10.10.6.10:5060;branch=z9hG4bK201421\par CSeq: 102 BYE\par \par |\par 03/24/2010 13:26:09.672 CCM|//SIP/SIPHandler/ccbId=120/scbId=0/findDevicePID: Routed by ccbId/scbId|\par 03/24/2010 13:26:09.672 CCM|//SIP/Stack/States/0xb415f780/0xb415f780 : State change from (STATE_DISCONNECTING, SUBSTATE_NONE) to (STATE_DEAD, SUBSTATE_NONE)|\par 03/24/2010 13:26:09.672 CCM|//SIP/Stack/Info/0xb415f780/Removing call id 78|\par 03/24/2010 13:26:09.672 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_REMOVE_TRANSACTION value=32000 retries=0|\par 03/24/2010 13:26:09.672 CCM|EnvProcessUdpPort - EnvProcessUdpHandler::fireSignal() varId = 0|\par 03/24/2010 13:26:09.672 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: type=SIP_TIMER_REMOVE_TRANSACTION value=32000 retries=0|\par 03/24/2010 13:26:09.672 CCM|EnvProcessUdpPort - EnvProcessUdpHandler::send(buff, 328, 10.10.6.10:5060)|\par 03/24/2010 13:26:09.672 CCM|//SIP/SIPCdpc(1,53,85)/ci=27646255/ccbId=120/scbId=0/updateCallStatsForCallCompletion: SIPCdpc=85, nodeId=1, processNumber=52|\par 03/24/2010 13:26:09.672 CCM|RSVPSessionMgr::wait_RSVPUnregisterReq, cannot find RSVPSession, ci= 27646255 |\par 03/24/2010 13:26:09.672 CCM|//SIP/SIPD(1,52,10)/ccbId=120/scbId=0/restart0_DStopInd: Removing Cdpc Pid (1,100,53,85) with mapKey 27646255 from mCiToPid table|\par 03/24/2010 13:26:09.672 CCM|StationInit: (0000001) StationUnSubscribeDtmfPayloadErrMessage DtmfPayload=0 conferenceID=16787301, passthruID=16777402|\par 03/24/2010 13:26:09.673 CCM|MediaTerminationPointControl(1)::star_StationUnSubscribeDtmfPayloadErr payload=0, confId=16787301 partyId=16777402|\par 03/24/2010 13:26:10.957 CCM|CMProcMon - ------Entered Router Verification|\par 03/24/2010 13:26:10.957 CCM|CMProcMon - ----Exited Router Verification|\par 03/24/2010 13:26:12.475 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/wait_SIPTimer: TimerExpired type=SIP_TIMER_DISCONNECT value=4000 retries=0|\par 03/24/2010 13:26:12.475 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_DISCONNECT value=4000 retries=0|\par 03/24/2010 13:26:12.475 CCM|//SIP/Stack/Error/0xb415b460/Out of retries|\par 03/24/2010 13:26:12.475 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=UNDEFINED value=4000 retries=0|\par 03/24/2010 13:26:12.475 CCM|//SIP/SIPHandler/ccbId=118/scbId=0/findDevicePID: Routed by ccbId/scbId|\par 03/24/2010 13:26:12.475 CCM|//SIP/Stack/States/0xb415b460/0xb415b460 : State change from (STATE_DISCONNECTING, SUBSTATE_NONE) to (STATE_DEAD, SUBSTATE_NONE)|\par 03/24/2010 13:26:12.475 CCM|//SIP/Stack/Info/0xb415b460/Removing call id 76|\par 03/24/2010 13:26:12.475 CCM|//SIP/Stack/Info/0x0/Context for key=[84] removed.|\par 03/24/2010 13:26:12.476 CCM|//SIP/SIPCdpc(1,53,84)/ci=27646251/ccbId=118/scbId=0/updateCallStatsForCallCompletion: SIPCdpc=84, nodeId=1, processNumber=52|\par 03/24/2010 13:26:12.476 CCM|//SIP/Stack/Info/0xb415b460/****Deleting from UAS Request table.|\par 03/24/2010 13:26:12.476 CCM|//SIP/Stack/Info/0xb415b460/Deleting from table. ccb=0xb415b460 key=E0DA5DA000@10.249.0.60454916903|\par 03/24/2010 13:26:12.476 CCM|RSVPSessionMgr::wait_RSVPUnregisterReq, cannot find RSVPSession, ci= 27646251 |\par 03/24/2010 13:26:12.476 CCM|//SIP/Stack/Info/0xb415b460/****Deleting from UAS Response table.|\par 03/24/2010 13:26:12.476 CCM|//SIP/Stack/Info/0xb415b460/Deleting from table. ccb=0xb415b460 key=E0DA5DA000@10.249.0.650BBA51F-8870-4670-AA5B-5318556CE26F-27646251|\par 03/24/2010 13:26:12.476 CCM|//SIP/SIPD(1,52,9)/ccbId=118/scbId=0/restart0_DStopInd: Removing Cdpc Pid (1,100,53,84) with mapKey 27646251 from mCiToPid table|\par 03/24/2010 13:26:12.476 CCM|//SIP/Stack/Info/0xb415b460/There are 0 events on the internal queue that are going to be free'd|\par 03/24/2010 13:26:12.476 CCM|//SIP/Stack/Info/0xb415b460/Freeing ccb b415b460|\par 03/24/2010 13:26:12.958 CCM|CMProcMon - ------Entered Router Verification|\par 03/24/2010 13:26:12.958 CCM|CMProcMon - ----Exited Router Verification|\par 03/24/2010 13:26:14.959 CCM|CMProcMon - ------Entered Router Verification|\par 03/24/2010 13:26:14.959 CCM|CMProcMon - ----Exited Router Verification|\par 03/24/2010 13:26:16.960 CCM|CMProcMon - ------Entered Router Verification|\par 03/24/2010 13:26:16.960 CCM|CMProcMon - ----Exited Router Verification|\par 03/24/2010 13:26:18.961 CCM|CMProcMon - ------Entered Router Verification|\par 03/24/2010 13:26:18.962 CCM|CMProcMon - ----Exited Router Verification|\par 03/24/2010 13:26:20.963 CCM|CMProcMon - ------Entered Router Verification|\par 03/24/2010 13:26:20.963 CCM|CMProcMon - ----Exited Router Verification|\par 03/24/2010 13:26:21.127 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/wait_SIPTimer: TimerExpired type=SIP_TIMER_REMOVE_TRANSACTION value=32000 retries=0|\par 03/24/2010 13:26:21.127 CCM|//SIP/Stack/Info/0x0/Context for key=[83] removed.|\par 03/24/2010 13:26:21.127 CCM|//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_REMOVE_TRANSACTION value=32000 retries=0|\par 03/24/2010 13:26:21.127 CCM|//SIP/Stack/Info/0xb415cac0/****Deleting from UAC table.|\par 03/24/2010 13:26:21.127 CCM|//SIP/Stack/Info/0xb415cac0/Deleting from table. ccb=0xb415cac0 key=a0622200-ba91a23d-53-9060a0a@10.10.6.9|\par 03/24/2010 13:26:21.127 CCM|//SIP/Stack/Info/0xb415cac0/There are 0 events on the internal queue that are going to be free'd|\par 03/24/2010 13:26:21.127 CCM|//SIP/Stack/Info/0xb415cac0/Freeing ccb b415cac0|\par 03/24/2010 13:26:22.964 CCM|CMProcMon - ------Entered Router Verification|\par 03/24/2010 13:26:22.964 CCM|CMProcMon - ----Exited Router Verification|\par 03/24/2010 13:26:23.262 CCM|CiCcp table has 4 entries|\par 03/24/2010 13:26:24.965 CCM|CMProcMon - ------Entered Router Verification|\par 03/24/2010 13:26:24.965 CCM|CMProcMon - ----Exited Router Verification|\par 03/24/2010 13:26:25.433 CCM|EnvProcessCdr::wait_CdrFileTimer|\par 03/24/2010 13:26:25.433 CCM|EnvProcessCdr::closeCdrFile|\par 03/24/2010 13:26:25.433 CCM|EnvProcessCdr::getSequenceNumber = 0000000195|\par 03/24/2010 13:26:25.433 CCM|EnvProcessCdr::generateFileNames - /var/log/active/cm/cdr/_cdrActiveFile.act, /var/log/active/cm/cdr/cdr_StandAloneCluster_01_201003240526_195|