locked
OCS help.... Erro with sip stack RRS feed

  • Question

  • Hi All ,
    Need urgent  Help . i am developing a CSTA gateway,  for the purpose of which i am testing my sip stack to communicate with OC .

    the current setup is as follows:

    ocs ----> tcp--->SBC--->udp---->CSTA gw

    the first invite with requestsystem status goes well and i  am getting an ACK for the same. but further 200 ok(GetCSTAFeaturesResponse) for INFO messages with getCSTAFeatures request is being dropped by ocs with the following error:

    SIP_E_AUTH_CANNOT_CHALLENGE

    The detail trace is as Follows , i have marked the relevant trace portion as BOLD

    Hi All ,
    Need urgent  Help . i am developing a CSTA gateway,  for the purpose of which i am testing my sip stack to communicate with OC .

    the current setup is as follows:

    ocs ----> tcp--->SBC--->udp---->CSTA gw

    the first invite with requestsystem status goes well and i  am getting an ACK for the same. but further 200 ok(GetCSTAFeaturesResponse) for INFO messages with getCSTAFeatures request is being dropped by ocs with the following error:

    SIP_E_AUTH_CANNOT_CHALLENGE

    The detail trace is as Follows , i have marked the relevant trace portion as BOLD


    TL_INFO(TF_PROTOCOL) [0]13FC.0E58::07/22/2009-14:50:36.931.00000a4a (SIPStack,SIPAdminLog::TraceProtocolRecord:1224.idx(122))$$begin_record
    Instance-Id: 00000FAE
    Direction: incoming
    Peer: 10.35.1.2:4105
    Message-Type: request
    Start-Line: INVITE sip:jerry@cstagw.telesc5.com SIP/2.0
    From: <sip:jerry@telesocs.com>;tag=5bd4772344;epid=ec3586da71
    To: <sip:jerry@cstagw.telesc5.com>
    CSeq: 1 INVITE
    Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    Via: SIP/2.0/TLS 10.35.1.2:4105
    Max-Forwards: 70
    Contact: <sip:jerry@telesocs.com;opaque=user:epid:TmUjlzz2nFeJA4WJxHJX_wAA;gruu>
    User-Agent: UCCP/2.0.6362.0 OC/2.0.6362.0 (Microsoft Office Communicator)
    Content-Disposition: signal;handling=required
    Supported: timer
    Supported: ms-sender
    Supported: ms-early-media
    ms-keep-alive: UAC;hop-hop=yes
    Proxy-Authorization: Kerberos qop="auth", realm="SIP Communications Service", opaque="7E108FCE", crand="219b1c68", cnum="8", targetname="sip/ocs-srv.telesocs.com", response="602306092a864886f71201020201011100fffffffff2970b75f74a433db3c74a0bbd743459"
    Content-Type: application/csta+xml
    Content-Length: 329
    Message-Body: <?xml version="1.0"?>
    <RequestSystemStatus xmlns="http://www.ecma-international.org/standards/ecma-323/csta/ed3"><extensions><privateData><private><lcs:line xmlns:lcs="http://schemas.microsoft.com/Lcs/2005/04/RCCExtension">tel:9001;phone-context=dialstring</lcs:line></private></privateData></extensions></RequestSystemStatus>
    $$end_record

    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:36.931.00000a4b (SIPStack,CTransactionStateMachine::MakeStateTransition:1365.idx(576))( 010A4898 ) Event[TS_EV_REQUEST] transitioned to state[TS_ST_REQUESTPENDING] generating event[SIP_TRANSACTION_REQUEST_STARTED] timeout [32]
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:36.931.00000a4c (SIPStack,CModuleManager::SubmitItemToEM:85.idx(160))( 010EFE10 ) Calling OnEvent into App [SIP_MODULE_API][http://www.microsoft.com/LCS/ClientVersionFilter][0x50052] for event:SIP_TRANSACTION_REQUEST_STARTED
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:36.931.00000a4d (SIPStack,CISIPRequest::Reply:762.idx(1181))( 02394D98 ) App http://www.microsoft.com/LCS/ClientVersionFilter, response code:100, message:0230E348
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:36.931.00000a4e (SIPStack,CSIPStateRecord::_AcquireExecutionContextOrQueue<APPMESSAGE_WORK_ITEM_PARAMS>:822.idx(264))( 010BC518 ) Queued message [0230E348] processing pending completion of other event(s) for state record
    TL_INFO(TF_COMPONENT) [0]13FC.1160::07/22/2009-14:50:36.962.00000a4f (SIPStack,CISIPRequest::CreateTypicalResponse:762.idx(1467))( 02391168 ) Exit, App http://www.microsoft.com/LCS/UserServices, response code: 200, message:02369F78
    TL_INFO(TF_COMPONENT) [0]13FC.1160::07/22/2009-14:50:36.962.00000a50 (SIPStack,CISIPMessage<ISIPRequest>::Send:1160.idx(2357))( 023984D8 ) App http://www.microsoft.com/LCS/UserServices, message:02369F78
    TL_INFO(TF_COMPONENT) [0]13FC.1160::07/22/2009-14:50:36.962.00000a51 (SIPStack,CSIPStateRecord::_AcquireExecutionContextOrQueue<APPMESSAGE_WORK_ITEM_PARAMS>:822.idx(264))( 010BBE88 ) Queued message [02369F78] processing pending completion of other event(s) for state record
    TL_INFO(TF_COMPONENT) [0]13FC.1160::07/22/2009-14:50:36.962.00000a52 (SIPStack,CISIPEvent::CompleteProcessing:925.idx(349))( 010DFF68 ) App: http://www.microsoft.com/LCS/UserServices done for event:SIP_TRANSACTION_REQUEST_STARTED
    TL_INFO(TF_COMPONENT) [0]13FC.1160::07/22/2009-14:50:36.962.00000a53 (SIPStack,CTransactionStateMachine::MakeStateTransition:1365.idx(576))( 010A3A10 ) Event[TS_EV_RESPONSE_2XX] transitioned to state[TS_ST_INACTIVE] generating event[SIP_TRANSACTION_REPLY_SUCCESS_COMPLETED] timeout [0]
    TL_INFO(TF_COMPONENT) [0]13FC.1160::07/22/2009-14:50:36.962.00000a54 (SIPStack,CModuleManager::SubmitItemToEM:85.idx(160))( 010EFD50 ) Calling OnEvent into App [SIP_MODULE_ES][http://www.microsoft.com/LCS/UserServices][0x1] for event:SIP_TRANSACTION_REPLY_SUCCESS_COMPLETED
    TL_INFO(TF_COMPONENT) [0]13FC.1160::07/22/2009-14:50:36.962.00000a55 (SIPStack,CISIPEvent::CompleteProcessing:925.idx(349))( 0012A258 ) App: http://www.microsoft.com/LCS/UserServices done for event:SIP_TRANSACTION_REPLY_SUCCESS_COMPLETED
    TL_INFO(TF_DIAG) [0]13FC.1160::07/22/2009-14:50:36.962.00000a56 (SIPStack,SIPAdminLog::TraceDiagRecord:1224.idx(144))$$begin_record

    LogType: diagnostic
    Severity: information
    Text: Response successfully routed
    SIP-Start-Line: SIP/2.0 100 Trying
    SIP-Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    SIP-CSeq: 1 INVITE
    Peer: 10.35.1.2:4105
    Data: destination="jerry@telesocs.com"
    $$end_record

    TL_INFO(TF_PROTOCOL) [0]13FC.0E58::07/22/2009-14:50:37.040.00000aa8 (SIPStack,SIPAdminLog::TraceProtocolRecord:1224.idx(122))$$begin_record
    Instance-Id: 00000FB0
    Direction: outgoing;source="local"
    Peer: 10.35.1.2:4105
    Message-Type: response
    Start-Line: SIP/2.0 100 Trying
    From: <sip:jerry@telesocs.com>;tag=5bd4772344;epid=ec3586da71
    To: <sip:jerry@cstagw.telesc5.com>
    CSeq: 1 INVITE
    Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    Authentication-Info: Kerberos rspauth="602306092A864886F71201020201011100FFFFFFFFEF4808B4665D58C2242FB7873BA078BA", srand="8749565C", snum="9", opaque="7E108FCE", qop="auth", targetname="sip/ocs-srv.telesocs.com", realm="SIP Communications Service"
    Via: SIP/2.0/TLS 10.35.1.2:4105;ms-received-port=4105;ms-received-cid=1C600
    Content-Length: 0
    Message-Body: –
    $$end_record

    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000aa9 (SIPStack,CTransactionStateMachine::MakeStateTransition:1365.idx(576))( 010A3A10 ) Event[TS_EV_RESPONSE_100] transitioned to state[TS_ST_REQUESTPENDING_EXTENSION] generating event[SIP_TRANSACTION_REPLY_PROVISIONAL] timeout [32]
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000aaa (SIPStack,CModuleManager::SubmitItemToEM:85.idx(160))( 010EFE10 ) Calling OnEvent into App [SIP_MODULE_API][http://www.microsoft.com/LCS/TranslationService][0x20022] for event:SIP_TRANSACTION_REPLY_PROVISIONAL
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000aab (SIPStack,CISIPEvent::CompleteProcessing:925.idx(349))( 0012A290 ) App: http://www.microsoft.com/LCS/TranslationService done for event:SIP_TRANSACTION_REPLY_PROVISIONAL
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000aac (SIPStack,CModuleManager::SubmitItemToEM:85.idx(160))( 010EFE10 ) Calling OnEvent into App [SIP_MODULE_API][http://www.microsoft.com/LCS/ClientVersionFilter][0x50052] for event:SIP_TRANSACTION_REPLY_PROVISIONAL
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000aad (SIPStack,CISIPResponse::CreateFollowingRequest:903.idx(369))( 02398888 ) App http://www.microsoft.com/LCS/ClientVersionFilter created following request CANCEL (023559C8) with URI sip:jerry@cstagw.telesc5.com
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000aae (SIPStack,CISIPRequest::SetTargetURI:762.idx(674))( 02396998 ) Application http://www.microsoft.com/LCS/ClientVersionFilter set request target to URI sip:jerry@cstagw.telesc5.com
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000aaf (SIPStack,CISIPEvent::CompleteProcessing:925.idx(349))( 0012A290 ) App: http://www.microsoft.com/LCS/ClientVersionFilter done for event:SIP_TRANSACTION_REPLY_PROVISIONAL
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000ab0 (SIPStack,CTransactionStateMachine::MakeStateTransition:1365.idx(576))( 010A3FE0 ) Event[TS_EV_RESPONSE_100] transitioned to state[TS_ST_REQUESTPENDING_EXTENSION] generating event[SIP_TRANSACTION_REPLY_PROVISIONAL] timeout [32]
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000ab1 (SIPStack,CModuleManager::SubmitItemToEM:85.idx(160))( 010EFE10 ) Calling OnEvent into App [SIP_MODULE_API][http://www.microsoft.com/LCS/IIMFilter][0x30032] for event:SIP_TRANSACTION_REPLY_PROVISIONAL
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000ab2 (SIPStack,CISIPEvent::CompleteProcessing:925.idx(349))( 0012A290 ) App: http://www.microsoft.com/LCS/IIMFilter done for event:SIP_TRANSACTION_REPLY_PROVISIONAL
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000ab3 (SIPStack,CModuleManager::SubmitItemToEM:85.idx(160))( 010EFD50 ) Calling OnEvent into App [SIP_MODULE_ES][http://www.microsoft.com/LCS/UserServices][0x1] for event:SIP_TRANSACTION_REPLY_PROVISIONAL
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000ab4 (SIPStack,CISIPEvent::CompleteProcessing:925.idx(349))( 0012A290 ) App: http://www.microsoft.com/LCS/UserServices done for event:SIP_TRANSACTION_REPLY_PROVISIONAL
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000ab5 (SIPStack,CModuleManager::SubmitItemToEM:85.idx(160))( 010EFE10 ) Calling OnEvent into App [SIP_MODULE_API][http://www.microsoft.com/LCS/TranslationService][0x20022] for event:SIP_TRANSACTION_REPLY_PROVISIONAL
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000ab6 (SIPStack,CISIPResponse::CreateFollowingRequest:903.idx(369))( 0239D920 ) App http://www.microsoft.com/LCS/TranslationService created following request CANCEL (02355F50) with URI sip:jerry@cstagw.telesc5.com
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000ab7 (SIPStack,CISIPRequest::SetTargetURI:762.idx(674))( 023989A8 ) Application http://www.microsoft.com/LCS/TranslationService set request target to URI sip:jerry@cstagw.telesc5.com
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000ab8 (SIPStack,CISIPEvent::CompleteProcessing:925.idx(349))( 0012A290 ) App: http://www.microsoft.com/LCS/TranslationService done for event:SIP_TRANSACTION_REPLY_PROVISIONAL
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000ab9 (SIPStack,CTransactionStateMachine::MakeStateTransition:1365.idx(576))( 010A3728 ) Event[TS_EV_RESPONSE_100] transitioned to state[TS_ST_REQUESTPENDING_EXTENSION] generating event[SIP_TRANSACTION_REPLY_PROVISIONAL] timeout [32]
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000aba (SIPStack,CModuleManager::SubmitItemToEM:85.idx(160))( 010EFE10 ) Calling OnEvent into App [SIP_MODULE_API][http://www.microsoft.com/LCS/OutboundRouting][0x10012] for event:SIP_TRANSACTION_REPLY_PROVISIONAL
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000abb (SIPStack,CISIPEvent::CompleteProcessing:925.idx(349))( 0012A290 ) App: http://www.microsoft.com/LCS/OutboundRouting done for event:SIP_TRANSACTION_REPLY_PROVISIONAL
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000abc (SIPStack,CModuleManager::SubmitItemToEM:85.idx(160))( 010EFE10 ) Calling OnEvent into App [SIP_MODULE_API][http://www.microsoft.com/LCS/IIMFilter][0x30032] for event:SIP_TRANSACTION_REPLY_PROVISIONAL
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000abd (SIPStack,CISIPResponse::CreateFollowingRequest:903.idx(369))( 023A1910 ) App http://www.microsoft.com/LCS/IIMFilter created following request CANCEL (023564D8) with URI sip:jerry@cstagw.telesc5.com
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000abe (SIPStack,CISIPRequest::SetTargetURI:762.idx(674))( 0239DA10 ) Application http://www.microsoft.com/LCS/IIMFilter set request target to URI sip:jerry@cstagw.telesc5.com
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000abf (SIPStack,CISIPEvent::CompleteProcessing:925.idx(349))( 0012A290 ) App: http://www.microsoft.com/LCS/IIMFilter done for event:SIP_TRANSACTION_REPLY_PROVISIONAL
    TL_INFO(TF_CONNECTION) [0]13FC.0E58::07/22/2009-14:50:37.040.00000ac0 (SIPStack,SIPAdminLog::TraceConnectionRecord:1224.idx(161))$$begin_record
    LogType: connection
    Severity: information
    Text: Connection established
    Local-IP: 10.35.1.2:4108
    Peer-IP: 172.27.62.180:5082
    Connection-ID: 0x1C700
    Transport: TCP
    $$end_record

    TL_WARN(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000ac1 ((Shared),CTimedEntry::RemoveFromTimer:896.idx(171))( 000C0D78 ) not assigned to a timer
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000ac2 (SIPStack,CAUTHEngine::DoSignMessage:874.idx(923))( 00100428 ) Exit - no security record attached. Returns S_OK
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000ac3 (SIPStack,CCryptoService::UpdateCryptData:837.idx(1215))( 010BE6D8 ) exit. Expiration for [010BE6D8]:[2]
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000ac4 (SIPStack,CSIPRequest::FinalPrepForSend:311.idx(3603))( 02355440 ) Adding Record-Route/Path due to: register[0x00000000(false)] (dialog [0x00000001(true)] and not disabled for GRUU[0x00000001(true)]) em[0x00000000(false)]
    TL_WARN(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000ac5 (SIPStack,ListenPortConfig::GetListeningPort:1085.idx(1841))( 000CD588 ) No socket configured to listen for SIP_TRANSPORT_TCP at [010.035.001.002:4108]
    TL_INFO(TF_DIAG) [0]13FC.0E58::07/22/2009-14:50:37.040.00000ac6 (SIPStack,SIPAdminLog::TraceDiagRecord:1224.idx(144))$$begin_record
    LogType: diagnostic
    Severity: information
    Text: Routed a request to an internal server or static route
    SIP-Start-Line: INVITE sip:jerry@172.27.62.180 SIP/2.0
    SIP-Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    SIP-CSeq: 1 INVITE
    Peer: 172.27.62.180:5082
    Data: destination="Unknown"
    $$end_record

    TL_INFO(TF_PROTOCOL) [0]13FC.0E58::07/22/2009-14:50:37.040.00000ac7 (SIPStack,SIPAdminLog::TraceProtocolRecord:1224.idx(122))$$begin_record
    Instance-Id: 00000FBA
    Direction: outgoing
    Peer: 172.27.62.180:5082
    Message-Type: request
    Start-Line: INVITE sip:jerry@172.27.62.180 SIP/2.0
    From: "jerry"<sip:jerry@telesocs.com>;tag=5bd4772344;epid=ec3586da71
    To: <sip:jerry@cstagw.telesc5.com>
    CSeq: 1 INVITE
    Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    Record-Route: <sip:ocs-srv.telesocs.com:4108;transport=tcp;ms-role-rs-to;lr;ms-route-sig=caahlz3Warv4DbCoy9NV8wOtpY2YB_wffNFquLrQAA>;tag=696802D298BC30DE4A4E74DC438813EC
    Via: SIP/2.0/TCP 10.35.1.2:4108;branch=z9hG4bK1D89C1B7.7FC1F7CD;branched=FALSE;ms-internal-info="bbBV3rkF4b2fubNsIkPrpSlLQ9I3d_wffN_AtJeAAA"
    Max-Forwards: 69
    Content-Length: 329
    Via: SIP/2.0/TLS 10.35.1.2:4105;ms-received-port=4105;ms-received-cid=1C600
    Contact: <sip:jerry@telesocs.com;opaque=user:epid:TmUjlzz2nFeJA4WJxHJX_wAA;gruu>
    User-Agent: UCCP/2.0.6362.0 OC/2.0.6362.0 (Microsoft Office Communicator)
    Content-Disposition: signal;handling=required
    Supported: timer
    Supported: ms-sender
    Supported: ms-early-media
    ms-keep-alive: UAC;hop-hop=yes
    Content-Type: application/csta+xml
    Message-Body: <?xml version="1.0"?>
    <RequestSystemStatus xmlns="http://www.ecma-international.org/standards/ecma-323/csta/ed3"><extensions><privateData><private><lcs:line xmlns:lcs="http://schemas.microsoft.com/Lcs/2005/04/RCCExtension">tel:9001;phone-context=dialstring</lcs:line></private></privateData></extensions></RequestSystemStatus>
    $$end_record

    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000ac8 (SIPStack,CRecvContext::ProcessCompletion:974.idx(155))( 0236ECE0 ) Received 426 bytes
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.040.00000ac9 (SIPStack,CSIPMessage::CacheConnectionFlags:187.idx(1659))( 0236B160 ) From client connection, CID [0x1c700]
    TL_INFO(TF_PROTOCOL) [0]13FC.0E58::07/22/2009-14:50:37.040.00000aca (SIPStack,SIPAdminLog::TraceProtocolRecord:1224.idx(122))$$begin_record
    Instance-Id: 00000FBE
    Direction: incoming
    Peer: 172.27.62.180:5082
    Message-Type: response
    Start-Line: SIP/2.0 100 Trying
    From: "jerry" <sip:jerry@telesocs.com>;tag=5bd4772344;epid=ec3586da71
    To: <sip:jerry@cstagw.telesc5.com>
    CSeq: 1 INVITE
    Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    Via: SIP/2.0/TCP 10.35.1.2:4108;branch=z9hG4bK1D89C1B7.7FC1F7CD;branched=FALSE;ms-internal-info="bbBV3rkF4b2fubNsIkPrpSlLQ9I3d_wffN_AtJeAAA"
    Via: SIP/2.0/TLS 10.35.1.2:4105;ms-received-port=4105;ms-received-cid=1C600
    Content-Length: 0
    Message-Body: –
    $$end_record


    TL_INFO(TF_DIAG) [0]13FC.11E0::07/22/2009-14:50:37.150.00000aea (SIPStack,SIPAdminLog::TraceDiagRecord:1224.idx(144))$$begin_record
    LogType: diagnostic
    Severity: information
    Text: Routed a request on behalf of an application
    SIP-Start-Line: BENOTIFY sip:10.35.1.2:4105;transport=tls;ms-opaque=3c66a33f48;ms-received-cid=1C600 SIP/2.0
    SIP-Call-ID: 96abf7078cb345249a47bba5c9f5f2c9
    SIP-CSeq: 2 BENOTIFY
    Peer: 10.35.1.2:4105
    Data: destination="jerry@telesocs.com";application="http://www.microsoft.com/LCS/UserServices"
    $$end_record

    TL_INFO(TF_PROTOCOL) [0]13FC.11E0::07/22/2009-14:50:37.150.00000aeb (SIPStack,SIPAdminLog::TraceProtocolRecord:1224.idx(122))$$begin_record
    Instance-Id: 00000FC1
    Direction: outgoing;source="local"
    Peer: 10.35.1.2:4105
    Message-Type: request
    Start-Line: BENOTIFY sip:10.35.1.2:4105;transport=tls;ms-opaque=3c66a33f48;ms-received-cid=1C600 SIP/2.0
    From: <sip:jerry@telesocs.com>;tag=BE180080
    To: <sip:jerry@telesocs.com>;tag=851e88b901;epid=ec3586da71
    CSeq: 2 BENOTIFY
    Call-ID: 96abf7078cb345249a47bba5c9f5f2c9
    Via: SIP/2.0/TLS 10.35.1.2:5061;branch=z9hG4bK81DCE3DB.A47C7995;branched=FALSE
    Authentication-Info: Kerberos rspauth="602306092A864886F71201020201011100FFFFFFFFD3EA38A9DEF2D0C300D60CEDBCDEBB37", srand="BFF15492", snum="11", opaque="7E108FCE", qop="auth", targetname="sip/ocs-srv.telesocs.com", realm="SIP Communications Service"
    Max-Forwards: 70
    Content-Length: 8393
    Require: eventlist
    Content-Type: application/vnd-microsoft-roaming-self+xml
    Event: vnd-microsoft-roaming-self
    subscription-state: active;expires=46883
    Message-Body: ----****MESSAGE BODY DELETED****----
    $$end_record

    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.353.00000aec (SIPStack,CRecvContext::ProcessCompletion:974.idx(155))( 0236ECE0 ) Received 1110 bytes
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.353.00000aed (SIPStack,CSIPMessage::CacheConnectionFlags:187.idx(1659))( 0236B160 ) From client connection, CID [0x1c700]
    TL_INFO(TF_PROTOCOL) [0]13FC.0E58::07/22/2009-14:50:37.353.00000aee (SIPStack,SIPAdminLog::TraceProtocolRecord:1224.idx(122))$$begin_record
    Instance-Id: 00000FC2
    Direction: incoming
    Peer: 172.27.62.180:5082
    Message-Type: response
    Start-Line: SIP/2.0 200 OK
    From: "jerry" <sip:jerry@telesocs.com>;tag=5bd4772344;epid=ec3586da71
    To: <sip:jerry@cstagw.telesc5.com>;tag=X7NpiH!DkHmTvzC
    CSeq: 1 INVITE
    Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    User-Agent: TELES.C5/3.4.1
    Via: SIP/2.0/TCP 10.35.1.2:4108;branch=z9hG4bK1D89C1B7.7FC1F7CD;branched=FALSE;ms-internal-info="bbBV3rkF4b2fubNsIkPrpSlLQ9I3d_wffN_AtJeAAA"
    Via: SIP/2.0/TLS 10.35.1.2:4105;ms-received-port=4105;ms-received-cid=1C600
    Contact: <sip:jerry@172.27.62.180:5082;transport=tcp>
    Record-Route: <sip:ocs-srv.telesocs.com:4108;transport=tcp;lr;ms-role-rs-to;ms-route-sig=caahlz3Warv4DbCoy9NV8wOtpY2YB_wffNFquLrQAA>;tag=696802D298BC30DE4A4E74DC438813EC
    Content-Type: application/csta+xml
    Content-Length: 376
    Message-Body: <?xml version="1.0"?><RequestSystemStatusResponse xmlns="http://www.ecma-international.org/standards/ecma-323/csta/ed3"><systemStatus>normal</systemStatus><extensions><privateData><private><lcs:line xmlns:lcs="http://schemas.microsoft.com/Lcs/2005/04/RCCExtension">tel:9001;phone-context=dialstring</lcs:line></private></privateData></extensions></RequestSystemStatusResponse>
    $$end_record

    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.353.00000aef (SIPStack,CTransactionStateMachine::MakeStateTransition:1365.idx(576))( 001219C0 ) Event[TS_EV_INVITE_RESPONSE_2XX] transitioned to state[TS_ST_INACTIVE] generating event[SIP_TRANSACTION_REPLY_SUCCESS_COMPLETED] timeout [0]
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.353.00000af0 (SIPStack,CModuleManager::SubmitItemToEM:85.idx(160))( 010EFE10 ) Calling OnEvent into App [SIP_MODULE_API][http://www.microsoft.com/LCS/OutboundRouting][0x10012] for event:SIP_TRANSACTION_REPLY_SUCCESS_COMPLETED
    TL_WARN(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.353.00000af1 (SIPStack,CISIPMessage<ISIPResponse>::VerifySourceIdentity:1160.idx(3177))( 023A13C8 ) Exit - cannot challenge a response
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.353.00000af2 (SIPStack,CISIPMessage<ISIPRequest>::Forward:1160.idx(2465))( 023A13C8 ) App http://www.microsoft.com/LCS/OutboundRouting, message:0236B160
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.353.00000af3 (SIPStack,CSIPStateRecord::_AcquireExecutionContextOrQueue<APPMESSAGE_WORK_ITEM_PARAMS>:822.idx(264))( 010BC518 ) Queued message [0236B160] processing pending completion of other event(s) for state record
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.353.00000af4 (SIPStack,CISIPEvent::CompleteProcessing:925.idx(349))( 010DFF30 ) App: http://www.microsoft.com/LCS/OutboundRouting done for event:SIP_TRANSACTION_REPLY_SUCCESS_COMPLETED
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.353.00000af5 (SIPStack,CTransactionStateMachine::MakeStateTransition:1365.idx(576))( 010A3728 ) Event[TS_EV_INVITE_RESPONSE_2XX] transitioned to state[TS_ST_INACTIVE] generating event[SIP_TRANSACTION_REPLY_SUCCESS_COMPLETED] timeout [0]
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.353.00000af6 (SIPStack,CModuleManager::SubmitItemToEM:85.idx(160))( 010EFE10 ) Calling OnEvent into App [SIP_MODULE_API][http://www.microsoft.com/LCS/OutboundRouting][0x10012] for event:SIP_TRANSACTION_REPLY_SUCCESS_COMPLETED
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.353.00000af7 (SIPStack,CISIPEvent::CompleteProcessing:925.idx(349))( 010DFF30 ) App: http://www.microsoft.com/LCS/OutboundRouting done for event:SIP_TRANSACTION_REPLY_SUCCESS_COMPLETED
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.353.00000af8 (SIPStack,CModuleManager::SubmitItemToEM:85.idx(160))( 010EFE10 ) Calling OnEvent into App [SIP_MODULE_API][http://www.microsoft.com/LCS/IIMFilter][0x30032] for event:SIP_TRANSACTION_REPLY_SUCCESS_COMPLETED
    TL_WARN(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.353.00000af9 (SIPStack,CISIPMessage<ISIPResponse>::VerifySourceIdentity:1160.idx(3177))( 023A1450 ) Exit - cannot challenge a response
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.353.00000afa (SIPStack,CISIPMessage<ISIPRequest>::Forward:1160.idx(2465))( 023A1450 ) App http://www.microsoft.com/LCS/IIMFilter, message:0236B160
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.353.00000afb (SIPStack,CSIPStateRecord::_AcquireExecutionContextOrQueue<APPMESSAGE_WORK_ITEM_PARAMS>:822.idx(264))( 010BC518 ) Queued message [0236B160] processing pending completion of other event(s) for state record
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.353.00000afc (SIPStack,CISIPEvent::CompleteProcessing:925.idx(349))( 010DFF30 ) App: http://www.microsoft.com/LCS/IIMFilter done for event:SIP_TRANSACTION_REPLY_SUCCESS_COMPLETED
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.353.00000afd (SIPStack,CTransactionStateMachine::MakeStateTransition:1365.idx(576))( 010A3FE0 ) Event[TS_EV_INVITE_RESPONSE_2XX] transitioned to state[TS_ST_INACTIVE] generating event[SIP_TRANSACTION_REPLY_SUCCESS_COMPLETED] timeout [0]
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.353.00000afe (SIPStack,CModuleManager::SubmitItemToEM:85.idx(160))( 010EFE10 ) Calling OnEvent into App [SIP_MODULE_API][http://www.microsoft.com/LCS/IIMFilter][0x30032] for event:SIP_TRANSACTION_REPLY_SUCCESS_COMPLETED
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.353.00000aff (SIPStack,CISIPEvent::CompleteProcessing:925.idx(349))( 010DFF30 ) App: http://www.microsoft.com/LCS/IIMFilter done for event:SIP_TRANSACTION_REPLY_SUCCESS_COMPLETED
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.353.00000b00 (SIPStack,CModuleManager::SubmitItemToEM:85.idx(160))( 010EFD50 ) Calling OnEvent into App [SIP_MODULE_ES][http://www.microsoft.com/LCS/UserServices][0x1] for event:SIP_TRANSACTION_REPLY_SUCCESS_COMPLETED
    TL_WARN(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.353.00000b01 (SIPStack,CISIPMessage<ISIPResponse>::VerifySourceIdentity:1160.idx(3177))( 023A14D8 ) Exit - cannot challenge a response
    TL_WARN(TF_DIAG) [0]13FC.0E58::07/22/2009-14:50:37.353.00000b02 (SIPStack,SIPAdminLog::TraceDiagRecord:1224.idx(142))$$begin_record
    LogType: diagnostic
    Severity: warning
    Text: Message was discarded by the application
    Result-Code: 0xc3e93ec6 SIP_E_AUTH_CANNOT_CHALLENGE
    SIP-Start-Line: SIP/2.0 200 OK
    SIP-Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    SIP-CSeq: 1 INVITE
    Data: application="http://www.microsoft.com/LCS/UserServices"
    $$end_record

    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:37.353.00000b03 (SIPStack,CISIPEvent::CompleteProcessing:925.idx(349))( 010DFF30 ) App: http://www.microsoft.com/LCS/UserServices done for event:SIP_TRANSACTION_REPLY_SUCCESS_COMPLETED
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b04 (SIPStack,CRecvContext::ProcessCompletion:974.idx(155))( 0236ECE0 ) Received 1110 bytes
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b05 (SIPStack,CSIPMessage::CacheConnectionFlags:187.idx(1659))( 02331A58 ) From client connection, CID [0x1c700]
    TL_INFO(TF_PROTOCOL) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b06 (SIPStack,SIPAdminLog::TraceProtocolRecord:1224.idx(122))$$begin_record
    Instance-Id: 00000FC3
    Direction: incoming
    Peer: 172.27.62.180:5082
    Message-Type: response
    Start-Line: SIP/2.0 200 OK
    From: "jerry" <sip:jerry@telesocs.com>;tag=5bd4772344;epid=ec3586da71
    To: <sip:jerry@cstagw.telesc5.com>;tag=X7NpiH!DkHmTvzC
    CSeq: 1 INVITE
    Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    User-Agent: TELES.C5/3.4.1
    Via: SIP/2.0/TCP 10.35.1.2:4108;branch=z9hG4bK1D89C1B7.7FC1F7CD;branched=FALSE;ms-internal-info="bbBV3rkF4b2fubNsIkPrpSlLQ9I3d_wffN_AtJeAAA"
    Via: SIP/2.0/TLS 10.35.1.2:4105;ms-received-port=4105;ms-received-cid=1C600
    Contact: <sip:jerry@172.27.62.180:5082;transport=tcp>
    Record-Route: <sip:ocs-srv.telesocs.com:4108;transport=tcp;lr;ms-role-rs-to;ms-route-sig=caahlz3Warv4DbCoy9NV8wOtpY2YB_wffNFquLrQAA>;tag=696802D298BC30DE4A4E74DC438813EC
    Content-Type: application/csta+xml
    Content-Length: 376
    Message-Body: <?xml version="1.0"?><RequestSystemStatusResponse xmlns="http://www.ecma-international.org/standards/ecma-323/csta/ed3"><systemStatus>normal</systemStatus><extensions><privateData><private><lcs:line xmlns:lcs="http://schemas.microsoft.com/Lcs/2005/04/RCCExtension">tel:9001;phone-context=dialstring</lcs:line></private></privateData></extensions></RequestSystemStatusResponse>
    $$end_record

    TL_INFO(TF_DIAG) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b07 (SIPStack,SIPAdminLog::TraceDiagRecord:1224.idx(144))$$begin_record
    LogType: diagnostic
    Severity: information
    Text: Response successfully routed
    SIP-Start-Line: SIP/2.0 200 OK
    SIP-Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    SIP-CSeq: 1 INVITE
    Peer: 10.35.1.2:4105
    Data: destination="jerry@telesocs.com"
    $$end_record

    TL_INFO(TF_PROTOCOL) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b08 (SIPStack,SIPAdminLog::TraceProtocolRecord:1224.idx(122))$$begin_record
    Instance-Id: 00000FC3
    Direction: outgoing
    Peer: 10.35.1.2:4105
    Message-Type: response
    Start-Line: SIP/2.0 200 OK
    From: "jerry" <sip:jerry@telesocs.com>;tag=5bd4772344;epid=ec3586da71
    To: <sip:jerry@cstagw.telesc5.com>;tag=X7NpiH!DkHmTvzC
    CSeq: 1 INVITE
    Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    Authentication-Info: Kerberos rspauth="602306092A864886F71201020201011100FFFFFFFF2F1AEFAF86ECFF49BF9B8007739C4304", srand="654C1745", snum="12", opaque="7E108FCE", qop="auth", targetname="sip/ocs-srv.telesocs.com", realm="SIP Communications Service"
    Contact: <sip:jerry@172.27.62.180:5082;transport=tcp;ms-received-cid=1C700>
    User-Agent: TELES.C5/3.4.1
    Via: SIP/2.0/TLS 10.35.1.2:4105;ms-received-port=4105;ms-received-cid=1C600
    Record-Route: <sip:ocs-srv.telesocs.com:5061;transport=tls;lr;ms-route-sig=caBPOSDOJh8Cr_iCuZfeeY3d-5Usx_wffNFquLrQAA>
    Content-Type: application/csta+xml
    Content-Length: 376
    Message-Body: <?xml version="1.0"?><RequestSystemStatusResponse xmlns="http://www.ecma-international.org/standards/ecma-323/csta/ed3"><systemStatus>normal</systemStatus><extensions><privateData><private><lcs:line xmlns:lcs="http://schemas.microsoft.com/Lcs/2005/04/RCCExtension">tel:9001;phone-context=dialstring</lcs:line></private></privateData></extensions></RequestSystemStatusResponse>
    $$end_record

    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b09 (SIPStack,CRecvContext::ProcessCompletion:974.idx(155))( 022EDE20 ) Received 786 bytes
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b0a (SIPStack,CSIPMessage::CacheConnectionFlags:187.idx(1659))( 02354930 ) From client connection, CID [0x1c600]
    TL_INFO(TF_PROTOCOL) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b0b (SIPStack,SIPAdminLog::TraceProtocolRecord:1224.idx(122))$$begin_record
    Instance-Id: 00000FC4
    Direction: incoming
    Peer: 10.35.1.2:4105
    Message-Type: request
    Start-Line: ACK sip:ocs-srv.telesocs.com:5061;transport=tls;lr;ms-route-sig=caBPOSDOJh8Cr_iCuZfeeY3d-5Usx_wffNFquLrQAA SIP/2.0
    From: <sip:jerry@telesocs.com>;tag=5bd4772344;epid=ec3586da71
    To: <sip:jerry@cstagw.telesc5.com>;tag=X7NpiH!DkHmTvzC
    CSeq: 1 ACK
    Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    Via: SIP/2.0/TLS 10.35.1.2:4105
    Max-Forwards: 70
    Route: <sip:jerry@172.27.62.180:5082;transport=tcp;ms-received-cid=1C700>
    User-Agent: UCCP/2.0.6362.0 OC/2.0.6362.0 (Microsoft Office Communicator)
    Proxy-Authorization: Kerberos qop="auth", realm="SIP Communications Service", opaque="7E108FCE", crand="53072747", cnum="10", targetname="sip/ocs-srv.telesocs.com", response="602306092a864886f71201020201011100ffffffffe48088aba39c5edb8b0c47db4cfd86ac"
    Content-Length: 0
    Message-Body: –
    $$end_record

    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b0c (SIPStack,CSIPMessage::CacheConnectionFlags:187.idx(1659))( 023564D8 ) From client connection, CID [0x1c600]
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b0d (SIPStack,CTransactionStateMachine::MakeStateTransition:1365.idx(576))( 010A3FE0 ) Event[TS_EV_ACK] transitioned to state[TS_ST_INACTIVE] generating event[SIP_TRANSACTION_REQUEST_ACK] timeout [0]
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b0e (SIPStack,CModuleManager::SubmitItemToEM:85.idx(160))( 010EFD50 ) Calling OnEvent into App [SIP_MODULE_ES][http://www.microsoft.com/LCS/UserServices][0x1] for event:SIP_TRANSACTION_REQUEST_ACK
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b0f (SIPStack,CISIPEvent::CompleteProcessing:925.idx(349))( 010DFF30 ) App: http://www.microsoft.com/LCS/UserServices done for event:SIP_TRANSACTION_REQUEST_ACK
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b10 (SIPStack,CSIPRequest::GetNextHopByRouteHeader:311.idx(1994))( 02354930 ) Exit - there is no route header in the message, use request uri for routing
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b11 (SIPStack,CSIPRequest::IsTrustedForRouting:311.idx(103))( 02354930 ) routedByApplication [0x00000000(false)], routeHeadersValidated [0x00000001(true)], sourceTrusted [0x00000000(false)], serverGRUU [0x00000000(false)]. TrustedForRouting = 0x00000001(true)
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b12 (SIPStack,RoutingLogic::GetDestinationFromUrl:543.idx(455))Using host name as destination
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b13 (SIPStack,CSIPRequest::RouteRequestUriAddr:311.idx(2186))( 02354930 ) Exit - ok, IP address that is trusted for routing
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b14 (SIPStack,CSIPRequest::IsTrustedForRouting:311.idx(103))( 02354930 ) routedByApplication [0x00000000(false)], routeHeadersValidated [0x00000001(true)], sourceTrusted [0x00000000(false)], serverGRUU [0x00000000(false)]. TrustedForRouting = 0x00000001(true)
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b15 (SIPStack,CSIPRequest::IsTrustedForRouting:311.idx(103))( 02354930 ) routedByApplication [0x00000000(false)], routeHeadersValidated [0x00000001(true)], sourceTrusted [0x00000000(false)], serverGRUU [0x00000000(false)]. TrustedForRouting = 0x00000001(true)
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b16 (SIPStack,CAUTHEngine::DoSignMessage:874.idx(923))( 00100428 ) Exit - no security record attached. Returns S_OK
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b17 (SIPStack,CSIPRequest::FinalPrepForSend:311.idx(3624))( 02354930 ) NOT adding Record-Route/Path because request is local or has no Contact header
    TL_INFO(TF_DIAG) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b18 (SIPStack,SIPAdminLog::TraceDiagRecord:1224.idx(144))$$begin_record
    LogType: diagnostic
    Severity: information
    Text: Routed a request using signed route headers
    SIP-Start-Line: ACK sip:jerry@172.27.62.180:5082;transport=tcp;ms-received-cid=1C700 SIP/2.0
    SIP-Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    SIP-CSeq: 1 ACK
    Peer: 172.27.62.180:5082
    Data: destination="Unknown"
    $$end_record

    TL_INFO(TF_PROTOCOL) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b19 (SIPStack,SIPAdminLog::TraceProtocolRecord:1224.idx(122))$$begin_record
    Instance-Id: 00000FC4
    Direction: outgoing
    Peer: 172.27.62.180:5082
    Message-Type: request
    Start-Line: ACK sip:jerry@172.27.62.180:5082;transport=tcp;ms-received-cid=1C700 SIP/2.0
    From: <sip:jerry@telesocs.com>;tag=5bd4772344;epid=ec3586da71
    To: <sip:jerry@cstagw.telesc5.com>;tag=X7NpiH!DkHmTvzC
    CSeq: 1 ACK
    Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    Via: SIP/2.0/TCP 10.35.1.2:4108;branch=z9hG4bK87A02352.65672C48;branched=FALSE
    Max-Forwards: 69
    Via: SIP/2.0/TLS 10.35.1.2:4105;ms-received-port=4105;ms-received-cid=1C600
    User-Agent: UCCP/2.0.6362.0 OC/2.0.6362.0 (Microsoft Office Communicator)
    Content-Length: 0
    Message-Body: –
    $$end_record

    TL_INFO(TF_PROTOCOL) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b1a (SIPStack,SIPAdminLog::TraceProtocolRecord:1224.idx(122))$$begin_record
    Instance-Id: 00000FC5
    Direction: incoming
    Peer: 10.35.1.2:4105
    Message-Type: request
    Start-Line: INFO sip:ocs-srv.telesocs.com:5061;transport=tls;lr;ms-route-sig=caBPOSDOJh8Cr_iCuZfeeY3d-5Usx_wffNFquLrQAA SIP/2.0
    From: <sip:jerry@telesocs.com>;tag=5bd4772344;epid=ec3586da71
    To: <sip:jerry@cstagw.telesc5.com>;tag=X7NpiH!DkHmTvzC
    CSeq: 2 INFO
    Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    Via: SIP/2.0/TLS 10.35.1.2:4105
    Max-Forwards: 70
    Route: <sip:jerry@172.27.62.180:5082;transport=tcp;ms-received-cid=1C700>
    User-Agent: UCCP/2.0.6362.0 OC/2.0.6362.0 (Microsoft Office Communicator)
    Content-Disposition: signal;handling=required
    Supported: timer
    Proxy-Authorization: Kerberos qop="auth", realm="SIP Communications Service", opaque="7E108FCE", crand="a3d28c1a", cnum="11", targetname="sip/ocs-srv.telesocs.com", response="602306092a864886f71201020201011100ffffffffe99227c55b0aefa59406fe65d41bb2dc"
    Content-Type: application/csta+xml
    Content-Length: 321
    Message-Body: <?xml version="1.0"?>
    <GetCSTAFeatures xmlns="http://www.ecma-international.org/standards/ecma-323/csta/ed3"><extensions><privateData><private><lcs:line xmlns:lcs="http://schemas.microsoft.com/Lcs/2005/04/RCCExtension">tel:9001;phone-context=dialstring</lcs:line></private></privateData></extensions></GetCSTAFeatures>
    $$end_record

    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b1b (SIPStack,CTransactionStateMachine::MakeStateTransition:1365.idx(576))( 010A3FE0 ) Event[TS_EV_REQUEST] transitioned to state[TS_ST_REQUESTPENDING] generating event[SIP_TRANSACTION_REQUEST_STARTED] timeout [32]
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b1c (SIPStack,CModuleManager::SubmitItemToEM:85.idx(160))( 010EFD50 ) Calling OnEvent into App [SIP_MODULE_ES][http://www.microsoft.com/LCS/UserServices][0x1] for event:SIP_TRANSACTION_REQUEST_STARTED
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b1d (SIPStack,CISIPEvent::CompleteProcessing:925.idx(349))( 010DFF30 ) App: http://www.microsoft.com/LCS/UserServices done for event:SIP_TRANSACTION_REQUEST_STARTED
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b1e (SIPStack,CSIPRequest::GetNextHopByRouteHeader:311.idx(1994))( 023564D8 ) Exit - there is no route header in the message, use request uri for routing
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b1f (SIPStack,CSIPRequest::IsTrustedForRouting:311.idx(103))( 023564D8 ) routedByApplication [0x00000000(false)], routeHeadersValidated [0x00000001(true)], sourceTrusted [0x00000000(false)], serverGRUU [0x00000000(false)]. TrustedForRouting = 0x00000001(true)
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b20 (SIPStack,RoutingLogic::GetDestinationFromUrl:543.idx(455))Using host name as destination
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b21 (SIPStack,CSIPRequest::RouteRequestUriAddr:311.idx(2186))( 023564D8 ) Exit - ok, IP address that is trusted for routing
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b22 (SIPStack,CSIPRequest::IsTrustedForRouting:311.idx(103))( 023564D8 ) routedByApplication [0x00000000(false)], routeHeadersValidated [0x00000001(true)], sourceTrusted [0x00000000(false)], serverGRUU [0x00000000(false)]. TrustedForRouting = 0x00000001(true)
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b23 (SIPStack,CSIPRequest::IsTrustedForRouting:311.idx(103))( 023564D8 ) routedByApplication [0x00000000(false)], routeHeadersValidated [0x00000001(true)], sourceTrusted [0x00000000(false)], serverGRUU [0x00000000(false)]. TrustedForRouting = 0x00000001(true)
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b24 (SIPStack,CAUTHEngine::DoSignMessage:874.idx(923))( 00100428 ) Exit - no security record attached. Returns S_OK
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b25 (SIPStack,CSIPRequest::FinalPrepForSend:311.idx(3624))( 023564D8 ) NOT adding Record-Route/Path because request is local or has no Contact header
    TL_INFO(TF_DIAG) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b26 (SIPStack,SIPAdminLog::TraceDiagRecord:1224.idx(144))$$begin_record
    LogType: diagnostic
    Severity: information
    Text: Routed a request using signed route headers
    SIP-Start-Line: INFO sip:jerry@172.27.62.180:5082;transport=tcp;ms-received-cid=1C700 SIP/2.0
    SIP-Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    SIP-CSeq: 2 INFO
    Peer: 172.27.62.180:5082
    Data: destination="Unknown"
    $$end_record

    TL_INFO(TF_PROTOCOL) [0]13FC.0E58::07/22/2009-14:50:39.462.00000b27 (SIPStack,SIPAdminLog::TraceProtocolRecord:1224.idx(122))$$begin_record
    Instance-Id: 00000FC5
    Direction: outgoing
    Peer: 172.27.62.180:5082
    Message-Type: request
    Start-Line: INFO sip:jerry@172.27.62.180:5082;transport=tcp;ms-received-cid=1C700 SIP/2.0
    From: <sip:jerry@telesocs.com>;tag=5bd4772344;epid=ec3586da71
    To: <sip:jerry@cstagw.telesc5.com>;tag=X7NpiH!DkHmTvzC
    CSeq: 2 INFO
    Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    Via: SIP/2.0/TCP 10.35.1.2:4108;branch=z9hG4bKB0ABFF9E.DF8A41CD;branched=FALSE;ms-internal-info="bbhP0RpmL7q6fx2Ezu_vBTpBjqdnLfikHN_AtJeAAA"
    Max-Forwards: 69
    Via: SIP/2.0/TLS 10.35.1.2:4105;ms-received-port=4105;ms-received-cid=1C600
    User-Agent: UCCP/2.0.6362.0 OC/2.0.6362.0 (Microsoft Office Communicator)
    Content-Disposition: signal;handling=required
    Supported: timer
    Content-Type: application/csta+xml
    Content-Length: 321
    Message-Body: <?xml version="1.0"?>
    <GetCSTAFeatures xmlns="http://www.ecma-international.org/standards/ecma-323/csta/ed3"><extensions><privateData><private><lcs:line xmlns:lcs="http://schemas.microsoft.com/Lcs/2005/04/RCCExtension">tel:9001;phone-context=dialstring</lcs:line></private></privateData></extensions></GetCSTAFeatures>
    $$end_record

    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.540.00000b28 (SIPStack,CRecvContext::ProcessCompletion:974.idx(155))( 0236ECE0 ) Received 1537 bytes
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.540.00000b29 (SIPStack,CSIPMessage::CacheConnectionFlags:187.idx(1659))( 02331A58 ) From client connection, CID [0x1c700]
    TL_INFO(TF_PROTOCOL) [0]13FC.0E58::07/22/2009-14:50:39.540.00000b2a (SIPStack,SIPAdminLog::TraceProtocolRecord:1224.idx(122))$$begin_record
    Instance-Id: 00000FC6
    Direction: incoming
    Peer: 172.27.62.180:5082
    Message-Type: response
    Start-Line: SIP/2.0 200 OK
    From: "jerry" <sip:jerry@telesocs.com>;tag=5bd4772344;epid=ec3586da71
    To: <sip:jerry@cstagw.telesc5.com>;tag=X7NpiH!DkHmTvzC
    CSeq: 2 INFO
    Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    User-Agent: TELES.C5/3.4.1
    Via: SIP/2.0/TCP 10.35.1.2:4108;branch=z9hG4bKB0ABFF9E.DF8A41CD;branched=FALSE;ms-internal-info="bbhP0RpmL7q6fx2Ezu_vBTpBjqdnLfikHN_AtJeAAA"
    Via: SIP/2.0/TLS 10.35.1.2:4105;ms-received-port=4105;ms-received-cid=1C600
    Content-Type: application/csta+xml
    Content-Length: 1030
    Message-Body: <?xml version="1.0"?><GetCSTAFeaturesResponse xmlns="http://www.ecma-international.org/standards/ecma-323/csta/ed3"><extensions><privateData><private><lcs:line xmlns:lcs="http://schemas.microsoft.com/Lcs/2005/04/RCCExtension">tel:9001;phone-context=dialstring</lcs:line></private></privateData></extensions><supportedServices><capExchangeServList><getSwitchingFunctionCaps/><getSwitchingFunctionDevices/></capExchangeServList><systemStatServList><requestSystemStatus/><systemStatus/></systemStatServList><monitoringServList><monitorStart/><monitorStop/></monitoringServList><snapshotServList><snapshotDevice/></snapshotServList><callControlServList><answerCall/><clearConnection/><deflectCall/><holdCall/><makeCall/><retrieveCall/><singleStepTransfer/></callControlServList></supportedServices><supportedEvents><callControlEvtsList><connectionCleared/><delivered/><diverted/><established/><failed/><held/><netwReached/><retrieved/><serviceInitiated/><transferred/></callControlEvtsList></supportedEvents></GetCSTAFeaturesResponse>
    $$end_record

    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.540.00000b2b (SIPStack,CTransactionStateMachine::MakeStateTransition:1365.idx(576))( 010A3FE0 ) Event[TS_EV_RESPONSE_2XX] transitioned to state[TS_ST_INACTIVE] generating event[SIP_TRANSACTION_REPLY_SUCCESS_COMPLETED] timeout [0]
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.540.00000b2c (SIPStack,CModuleManager::SubmitItemToEM:85.idx(160))( 010EFD50 ) Calling OnEvent into App [SIP_MODULE_ES][http://www.microsoft.com/LCS/UserServices][0x1] for event:SIP_TRANSACTION_REPLY_SUCCESS_COMPLETED
    TL_WARN(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.540.00000b2d (SIPStack,CISIPMessage<ISIPResponse>::VerifySourceIdentity:1160.idx(3177))( 02390478 ) Exit - cannot challenge a response
    TL_WARN(TF_DIAG) [0]13FC.0E58::07/22/2009-14:50:39.540.00000b2e (SIPStack,SIPAdminLog::TraceDiagRecord:1224.idx(142))$$begin_record
    LogType: diagnostic
    Severity: warning
    Text: Message was discarded by the application
    Result-Code: 0xc3e93ec6 SIP_E_AUTH_CANNOT_CHALLENGE
    SIP-Start-Line: SIP/2.0 200 OK
    SIP-Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    SIP-CSeq: 2 INFO
    Data: application="http://www.microsoft.com/LCS/UserServices"
    $$end_record

    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:50:39.540.00000b2f (SIPStack,CISIPEvent::CompleteProcessing:925.idx(349))( 010DFF30 ) App: http://www.microsoft.com/LCS/UserServices done for event:SIP_TRANSACTION_REPLY_SUCCESS_COMPLETED
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:51:11.478.00000b30 (SIPStack,CRecvContext::ProcessCompletion:974.idx(155))( 022EDE20 ) Received 786 bytes
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:51:11.478.00000b31 (SIPStack,CSIPMessage::CacheConnectionFlags:187.idx(1659))( 023564D8 ) From client connection, CID [0x1c600]
    TL_INFO(TF_PROTOCOL) [0]13FC.0E58::07/22/2009-14:51:11.478.00000b32 (SIPStack,SIPAdminLog::TraceProtocolRecord:1224.idx(122))$$begin_record
    Instance-Id: 00000FC7
    Direction: incoming
    Peer: 10.35.1.2:4105
    Message-Type: request
    Start-Line: BYE sip:ocs-srv.telesocs.com:5061;transport=tls;lr;ms-route-sig=caBPOSDOJh8Cr_iCuZfeeY3d-5Usx_wffNFquLrQAA SIP/2.0
    From: <sip:jerry@telesocs.com>;tag=5bd4772344;epid=ec3586da71
    To: <sip:jerry@cstagw.telesc5.com>;tag=X7NpiH!DkHmTvzC
    CSeq: 3 BYE
    Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    Via: SIP/2.0/TLS 10.35.1.2:4105
    Max-Forwards: 70
    Route: <sip:jerry@172.27.62.180:5082;transport=tcp;ms-received-cid=1C700>
    User-Agent: UCCP/2.0.6362.0 OC/2.0.6362.0 (Microsoft Office Communicator)
    Proxy-Authorization: Kerberos qop="auth", realm="SIP Communications Service", opaque="7E108FCE", crand="f2319e94", cnum="12", targetname="sip/ocs-srv.telesocs.com", response="602306092a864886f71201020201011100ffffffff8edbec77e26ba3bdc05871f299c77766"
    Content-Length: 0
    Message-Body: –
    $$end_record

    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:51:11.478.00000b33 (SIPStack,CTransactionStateMachine::MakeStateTransition:1365.idx(576))( 010A3FE0 ) Event[TS_EV_REQUEST] transitioned to state[TS_ST_REQUESTPENDING] generating event[SIP_TRANSACTION_REQUEST_STARTED] timeout [32]
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:51:11.478.00000b34 (SIPStack,CModuleManager::SubmitItemToEM:85.idx(160))( 010EFD50 ) Calling OnEvent into App [SIP_MODULE_ES][http://www.microsoft.com/LCS/UserServices][0x1] for event:SIP_TRANSACTION_REQUEST_STARTED
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:51:11.478.00000b35 (SIPStack,CISIPEvent::CompleteProcessing:925.idx(349))( 010DFF30 ) App: http://www.microsoft.com/LCS/UserServices done for event:SIP_TRANSACTION_REQUEST_STARTED
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:51:11.478.00000b36 (SIPStack,CSIPRequest::GetNextHopByRouteHeader:311.idx(1994))( 023564D8 ) Exit - there is no route header in the message, use request uri for routing
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:51:11.478.00000b37 (SIPStack,CSIPRequest::IsTrustedForRouting:311.idx(103))( 023564D8 ) routedByApplication [0x00000000(false)], routeHeadersValidated [0x00000001(true)], sourceTrusted [0x00000000(false)], serverGRUU [0x00000000(false)]. TrustedForRouting = 0x00000001(true)
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:51:11.478.00000b38 (SIPStack,RoutingLogic::GetDestinationFromUrl:543.idx(455))Using host name as destination
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:51:11.478.00000b39 (SIPStack,CSIPRequest::RouteRequestUriAddr:311.idx(2186))( 023564D8 ) Exit - ok, IP address that is trusted for routing
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:51:11.478.00000b3a (SIPStack,CSIPRequest::IsTrustedForRouting:311.idx(103))( 023564D8 ) routedByApplication [0x00000000(false)], routeHeadersValidated [0x00000001(true)], sourceTrusted [0x00000000(false)], serverGRUU [0x00000000(false)]. TrustedForRouting = 0x00000001(true)
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:51:11.478.00000b3b (SIPStack,CSIPRequest::IsTrustedForRouting:311.idx(103))( 023564D8 ) routedByApplication [0x00000000(false)], routeHeadersValidated [0x00000001(true)], sourceTrusted [0x00000000(false)], serverGRUU [0x00000000(false)]. TrustedForRouting = 0x00000001(true)
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:51:11.478.00000b3c (SIPStack,CAUTHEngine::DoSignMessage:874.idx(923))( 00100428 ) Exit - no security record attached. Returns S_OK
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:51:11.478.00000b3d (SIPStack,CSIPRequest::FinalPrepForSend:311.idx(3624))( 023564D8 ) NOT adding Record-Route/Path because request is local or has no Contact header
    TL_INFO(TF_DIAG) [0]13FC.0E58::07/22/2009-14:51:11.478.00000b3e (SIPStack,SIPAdminLog::TraceDiagRecord:1224.idx(144))$$begin_record
    LogType: diagnostic
    Severity: information
    Text: Routed a request using signed route headers
    SIP-Start-Line: BYE sip:jerry@172.27.62.180:5082;transport=tcp;ms-received-cid=1C700 SIP/2.0
    SIP-Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    SIP-CSeq: 3 BYE
    Peer: 172.27.62.180:5082
    Data: destination="Unknown"
    $$end_record

    TL_INFO(TF_PROTOCOL) [0]13FC.0E58::07/22/2009-14:51:11.478.00000b3f (SIPStack,SIPAdminLog::TraceProtocolRecord:1224.idx(122))$$begin_record
    Instance-Id: 00000FC7
    Direction: outgoing
    Peer: 172.27.62.180:5082
    Message-Type: request
    Start-Line: BYE sip:jerry@172.27.62.180:5082;transport=tcp;ms-received-cid=1C700 SIP/2.0
    From: <sip:jerry@telesocs.com>;tag=5bd4772344;epid=ec3586da71
    To: <sip:jerry@cstagw.telesc5.com>;tag=X7NpiH!DkHmTvzC
    CSeq: 3 BYE
    Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    Via: SIP/2.0/TCP 10.35.1.2:4108;branch=z9hG4bKD9B6DBEB.7AB201DB;branched=FALSE;ms-internal-info="bbtEz0GzYwpdDiH2Z81BEPNEKh68l6sgHb_AtJeAAA"
    Max-Forwards: 69
    Via: SIP/2.0/TLS 10.35.1.2:4105;ms-received-port=4105;ms-received-cid=1C600
    User-Agent: UCCP/2.0.6362.0 OC/2.0.6362.0 (Microsoft Office Communicator)
    Content-Length: 0
    Message-Body: –
    $$end_record

    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:51:11.509.00000b40 (SIPStack,CRecvContext::ProcessCompletion:974.idx(155))( 0236ECE0 ) Received 485 bytes
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:51:11.509.00000b41 (SIPStack,CSIPMessage::CacheConnectionFlags:187.idx(1659))( 02331A58 ) From client connection, CID [0x1c700]
    TL_INFO(TF_PROTOCOL) [0]13FC.0E58::07/22/2009-14:51:11.509.00000b42 (SIPStack,SIPAdminLog::TraceProtocolRecord:1224.idx(122))$$begin_record
    Instance-Id: 00000FC8
    Direction: incoming
    Peer: 172.27.62.180:5082
    Message-Type: response
    Start-Line: SIP/2.0 200 OK
    From: "jerry" <sip:jerry@telesocs.com>;tag=5bd4772344;epid=ec3586da71
    To: <sip:jerry@cstagw.telesc5.com>;tag=X7NpiH!DkHmTvzC
    CSeq: 3 BYE
    Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    Max-Forwards: 68
    User-Agent: TELES.C5/3.4.1
    Via: SIP/2.0/TCP 10.35.1.2:4108;branch=z9hG4bKD9B6DBEB.7AB201DB;branched=FALSE;ms-internal-info="bbtEz0GzYwpdDiH2Z81BEPNEKh68l6sgHb_AtJeAAA"
    Via: SIP/2.0/TLS 10.35.1.2:4105;ms-received-port=4105;ms-received-cid=1C600
    Content-Length: 0
    Message-Body: –
    $$end_record

    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:51:11.509.00000b43 (SIPStack,CTransactionStateMachine::MakeStateTransition:1365.idx(576))( 010A3FE0 ) Event[TS_EV_RESPONSE_2XX] transitioned to state[TS_ST_INACTIVE] generating event[SIP_TRANSACTION_REPLY_SUCCESS_COMPLETED] timeout [0]
    TL_INFO(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:51:11.509.00000b44 (SIPStack,CModuleManager::SubmitItemToEM:85.idx(160))( 010EFD50 ) Calling OnEvent into App [SIP_MODULE_ES][http://www.microsoft.com/LCS/UserServices][0x1] for event:SIP_TRANSACTION_REPLY_SUCCESS_COMPLETED
    TL_WARN(TF_COMPONENT) [0]13FC.0E58::07/22/2009-14:51:11.509.00000b45 (SIPStack,CISIPMessage<ISIPResponse>::VerifySourceIdentity:1160.idx(3177))( 02390478 ) Exit - cannot challenge a response
    TL_WARN(TF_DIAG) [0]13FC.0E58::07/22/2009-14:51:11.509.00000b46 (SIPStack,SIPAdminLog::TraceDiagRecord:1224.idx(142))$$begin_record
    LogType: diagnostic
    Severity: warning
    Text: Message was discarded by the application
    Result-Code: 0xc3e93ec6 SIP_E_AUTH_CANNOT_CHALLENGE
    SIP-Start-Line: SIP/2.0 200 OK
    SIP-Call-ID: 3b315c1351d3445ea6097e3a3fdba18d
    SIP-CSeq: 3 BYE
    Data: application="http://www.microsoft.com/LCS/UserServices"
    $$end_record

    All help will be really appreciated

    regards
    Jerry

    Wednesday, July 22, 2009 3:07 PM

All replies

  • What version of SIP are you using?

    Is there any TLS being performed? If so, do you have correct certs on both?

    HTH

    Thursday, July 23, 2009 3:58 AM
  • hi, the only  TLS being performed is between OC and OCS ..  i am using SIP/2.0. i tested OCS with SIPP with some dummy messages it works.

    The following are the 200 oks  (from my first mail and from SIPP)


    CSTA gw(200ok) ---UDP--> SBC
     

    SIP/2.0 200 OK
    Via: SIP/2.0/UDP 10.33.2.80:5060;branch=z9hG4bK-1851-4a682601-b94ff647-763fc436
    From: <sip:jerry@telesocs.com>;tag=38c84ad5c5
    To: <sip:jerry@cstagw.telesc5.com>;tag=A6quuyeEo4TdjCR
    Call-ID: 4272845d40854055905cd498dae13c32
    CSeq: 2 INFO
    Contact: <sip:172.27.5.50:5060>
    Content-Length: 1130
    Content-Type: application/csta+xml
    User-Agent: TELES.C5/3.4.1
     
    <?xml version="1.0"?><GetCSTAFeaturesResponse xmlns="http://www.ecma-international.org/standards/ecma-323/csta/ed3"><extensions><privateData><private><lcs:line xmlns:lcs="http://schemas.microsoft.com/Lcs/2005/04/RCCExtension">tel:9001;phone-context=dialstring</lcs:line></private></privateData></extensions><supportedServices><systemStatServList><requestSystemStatus /></systemStatServList><monitoringServList><monitorStart /><monitorStop /></monitoringServList><callControlServList><answerCall /><clearConnection /><conferenceCall /><consultationCall /><deflectCall /><holdCall /><makeCall /><retrieveCall /><singleStepTransfer /><transferCall /></callControlServList><callAssociatedServList><generateDigits /></callAssociatedServList><logicalServList><getForwarding /><setForwarding /></logicalServList></supportedServices><supportedEvents><callControlEvtsList><conferenced /><connectionCleared /><delivered /><diverted /><established /><failed /><held /><originated /><retrieved /><transferred /></callControlEvtsList><logicalEvtsList><doNotDisturb /><forwarding /></logicalEvtsList></supportedEvents></GetCSTAFeaturesResponse>
     

     

     

    SBC---TCP-->OCS

    SIP/2.0 200 OK
    From: "jerry" <sip:jerry@telesocs.com>;tag=38c84ad5c5;epid=ec3586da71
    To: <sip:jerry@cstagw.telesc5.com>;tag=A6quuyeEo4TdjCR
    Call-ID: 4272845d40854055905cd498dae13c32
    CSeq: 2 INFO
    User-Agent: TELES.C5/3.4.1
    Via: SIP/2.0/TCP 10.35.1.2:1281;branch=z9hG4bKEA9CD097.1F3D6485;branched=FALSE;ms-internal-info="aass1RQ4JI6Xp_lygRSw8UCP8JDeQfPWSFvb-IJQAA"
    Via: SIP/2.0/TLS 10.35.1.2:1280;ms-received-port=1280;ms-received-cid=A00
    Contact: <sip:jerry@172.27.62.180:5082;transport=tcp>
    Content-Type: application/csta+xml
    Content-Length: 1130
     
    <?xml version="1.0"?><GetCSTAFeaturesResponse xmlns="http://www.ecma-international.org/standards/ecma-323/csta/ed3"><extensions><privateData><private><lcs:line xmlns:lcs="http://schemas.microsoft.com/Lcs/2005/04/RCCExtension">tel:9001;phone-context=dialstring</lcs:line></private></privateData></extensions><supportedServices><systemStatServList><requestSystemStatus /></systemStatServList><monitoringServList><monitorStart /><monitorStop /></monitoringServList><callControlServList><answerCall /><clearConnection /><conferenceCall /><consultationCall /><deflectCall /><holdCall /><makeCall /><retrieveCall /><singleStepTransfer /><transferCall /></callControlServList><callAssociatedServList><generateDigits /></callAssociatedServList><logicalServList><getForwarding /><setForwarding /></logicalServList></supportedServices><supportedEvents><callControlEvtsList><conferenced /><connectionCleared /><delivered /><diverted /><established /><failed /><held /><originated /><retrieved /><transferred /></callControlEvtsList><logicalEvtsList><doNotDisturb /><forwarding /></logicalEvtsList></supportedEvents></GetCSTAFeaturesResponse>
     



    The following trace is from a session between OCS and SIPP without anything in middle. the reply is for the same INFO as above

    THIS ONE WORKS

    SIPP---TCP--->OCS

    SIP/2.0 200 OK
    Via: SIP/2.0/TCP 10.35.1.2:4879;branch=z9hG4bKF4682A52.0551CBB6;branched=FALSE, SIP/2.0/TLS 10.35.1.2:4878;ms-received-port=4878;ms-received-cid=C00
    From: "jerry"<sip:jerry@telesocs.com>;tag=fb7f1445c0;epid=ec3586da71
    To: <sip:jerry@cstagw.sipp.com>;tag=1
    Call-ID: f29a3534aef249e69deda5554f991752
    CSeq: 2 INFO
    Contact: <sip:172.27.5.50:5060;transport=TCP>
    Content-Length: 1138
    Content-Type: application/csta+xml

    <?xml version="1.0"?>

    <GetCSTAFeaturesResponse xmlns="http://www.ecma-international.org/standards/ecma-323/csta/ed3"><extensions><privateData><private><lcs:line xmlns:lcs="http://schemas.microsoft.com/Lcs/2005/04/RCCExtension">tel:9001;phone-context=dialstring</lcs:line></private></privateData></extensions><supportedServices><systemStatServList><requestSystemStatus /></systemStatServList><monitoringServList><monitorStart /><monitorStop /></monitoringServList><callControlServList><answerCall /><clearConnection /><conferenceCall /><consultationCall /><deflectCall /><holdCall /><makeCall /><retrieveCall /><singleStepTransfer /><transferCall /></callControlServList><callAssociatedServList><generateDigits /></callAssociatedServList><logicalServList><getForwarding /><setForwarding /></logicalServList></supportedServices><supportedEvents><callControlEvtsList><conferenced /><connectionCleared /><delivered /><diverted /><established /><failed /><held /><originated /><retrieved /><transferred /></callControlEvtsList><logicalEvtsList><doNotDisturb /><forwarding /></logicalEvtsList></supportedEvents></GetCSTAFeaturesResponse>

    Thanks for your help

    reagrds

    Jerry

    Thursday, July 23, 2009 9:16 AM