locked
504 Server time-out RRS feed

  • Question

  • Hi guys,

    I have a problem with our mediation server. When there is an incoming call from the PSTN, the Dialogic DMG4120 receives the call and passes it to another hardware server (mediation server) without any problems. The Number is configured on the front end pool with tel:+43xxxxyyyyyy

    After the mediation server sends the invite to the pool, the mediation server receives a SIP/2.0 100 Trying. After 0.2 seconds the frontend returns

    SIP/2.0 504 Server time-out
    ms-diagnostics: 1022;reason="Cannot process routing destination";source="frontendserver FQDN (not pool FQDN)";Destination="sip:+43xxxxyyyyyy@10.1.1.1:49636"

    ------------EndOfIncoming SipMessage

    10.1.1.1 is the Dialogic Media Gateway

    This was captured on the mediation server. The frontend log looks like this:

    Instance-Id: 00007587

    Direction: outgoing;source="local"

    Peer: "FQDN of mediationserver":54020

    Message-Type: response

    Start-Line: SIP/2.0 504 Server time-out

    From: <sip:+43xxxxzzzzzz@alpla.com;user=phone>;epid=3AFC363C05;tag=969719b39

    To: <sip:+43xxxxyyyyyy@alpla.com;user=phone>;tag=291A823E1475291C60346A6EB65193D7

    CSeq: 30 INVITE

    Call-ID: 499cf30d-81f3-448a-b142-136f8fd4ead9

    Via: SIP/2.0/TLS "Mediationserver IP":54020;branch=z9hG4bKf2af4e7c;received="internal Loadbalancer IP facing the frontend servers";ms-received-port=54020;ms-received-cid=460D00

    ms-diagnostics: 1022;reason="Cannot process routing destination";source="frontendserver FQDN (not pool FQDN)";Destination="sip:+43xxxxyyyyyy@10.1.1.1:49639"

    Content-Length: 0

    Message-Body:

    Is there a solution for this problem?

    Best regards Edgar

    Friday, March 13, 2009 3:32 PM

All replies

  • Hi Edgar, 

    I can only think of that FE is not able to find the number sent by Mediation Server and is not able to route to a registered end point. Can you verify if the number sent by Mediation server / PBX is configured in the exact same way in AD.

    Anuj.

    Anuj
    Saturday, March 14, 2009 10:05 PM
  • Hi Anuj,

    when I log the error on the mediation server and FE i see the invite for sip:+43xxxxyyyyyy@sipdomain.com

    When I make a call from a communicator to the Tanjay everything works. I dial +43xxxxyyyyyy at the communicator. It also works when I only dial the last three digits of the number at the communicator. Our internal numbers are three digits long.

    In AD the number is configured as tel:+43xxxxyyyyyy not as sip:

    I have S4 and SIPStack enabled for logging on the FE and S4 and MediationServer on the Mediation server.

    When I run the Validation Wizard for the FE i get the following error when the wizard is checking the two-party IM:

    Received a failure SIP response: User sip:test.user@sipdomain.com @ Server poolname.sipdomain.com
    Received a failure SIP response: [
    SIP/2.0 504 Server time-out
    FROM: <sip:test2.user@sipdomain.com>;tag=e2c211265257a1f28db;epid=epid00
    TO: <sip:test.user@sipdomain.com>;tag=D1F1D562C7EC6D0987BB4BDEEF5974F8
    CSEQ: 11 INVITE
    CALL-ID: f97a4d7bcfa043bda1bacfd5ba955211
    VIA: SIP/2.0/TLS IPofFE1:59020;branch=z9hG4bK421e828b;received=IPofNLBfacingFE;ms-received-port=59020;ms-received-cid=103E700
    CONTENT-LENGTH: 0
    AUTHENTICATION-INFO: Kerberos rspauth="602306092A864886F71201020201011100FFFFFFFF2FB4ED00A83263817C69E76A2FB9090D", srand="02905B90", snum="3", opaque="2AC58B7C", qop="auth", targetname="sip/FE2.ADDomain.net", realm="SIP Communications Service"
    ms-diagnostics: 1022;reason="Cannot process routing destination";source="FE2.ADDomain.net";Destination="sip:test.user@sipdomain.com:5061;maddr=poolname.sipdomain.com;transport=tls"

    Thanks for any help Edgar
    Monday, March 16, 2009 9:23 AM
  • Edgar,

    Try the VoIP Test harness: http://www.microsoft.com/downloads/details.aspx?displaylang=en&FamilyID=7b6ab4f3-2949-4e97-856e-9c4ae323c75a

    See if this helps you determine more accurately the location of the communication failure.  504 is pretty self-explanatory.  Someone expected to receive a message in a specific time frame and didn't.  So, the question is who didn't get the information necessary in time to respond before the timeout occurred?

    Usually, this is for one of two reasons (when dealing with VoIP):

    1.   There is a network problem and the message never got to the other endpoint.
    2.   The endpoint dropped the message because it was either addressed incorrectly or not formatted in a manner in which it could process it

    If cause #2, which is more likely in this case, and given that you have tested your 3-digit extensions and they work - I suspect that your normalization rule(s) might not be right and the receiver is failing on the inability to resolve who sent what, and then what to do with it.

    I would also take a look at VoIP troubleshooting as it applies to OCS.  Again, I might be stretching, but I think this is where the issue is without having a full set of OCSLogger files to go through.
    Rick OCS UA
    Tuesday, March 17, 2009 2:17 AM
  • Hi Rick,

    I have installed the VoIP Test Set. I used the exact same certificate as the FE has assigned. When dialing the number from the PSTN the Test Set rings and I can answer. So the FE Server seems to be misconfigured somehow. Attached you find a full log from the mediation server captured with OCSLogger when the FE send error 504 back to the mediation server:

    1 TL_INFO(TF_PROTOCOL) [7]1568.03C8::03/16/2009-14:14:49.976.000010c6 (S4,SipMessage.DataLoggingHelper:sipmessage.cs(581))     
    2 <<<<<<<<<<<<Incoming SipMessage c=[<SipTcpConnection_2B7C601>], mediationIPfacingMediaGateway:5060<-MediaGatewayIP:58197     
    3 INVITE sip:dialednumber@mediationIPfacingMediaGateway;user=phone SIP/2.0     
    4 FROM: <sip:callingnumber@MediaGatewayIP;user=phone>;tag=sipcontrol_315705944-3343936     
    5 TO: <sip:dialednumber@mediationIPfacingMediaGateway;user=phone>     
    6 CSEQ: 1 INVITE     
    7 CALL-ID: 12d14a58-310640-c@MediaGatewayName     
    8 MAX-FORWARDS: 70     
    9 VIA: SIP/2.0/TCP MediaGatewayIP:58197;branch=z9hG4bK315705944-3278400     
    10 ACCEPT: application/sdp,application/simple-message-summary     
    11 CONTACT: <sip:callingnumber@MediaGatewayIP:5060;transport=tcp;user=phone>     
    12 CONTENT-LENGTH: 311     
    13 SUPPORTED: replaces,timer     
    14 CONTENT-TYPE: application/sdp     
    15 ALLOW: INVITE,ACK,CANCEL,BYE,OPTIONS,NOTIFY,REFER,PRACK     
    16 Diversion: <sip:dialednumber@MediaGatewayIP:58197>;privacy=off     
    17 Min-SE: 90     
    18 Session-Expires: 600;refresher=uac     
    19 v=0     
    20 o=SIPcontrol 3147328 3147328 IN IP4 MediaGatewayIP     
    21 s=-     
    22 c=IN IP4 MediaGatewayIP     
    23 t=0 0     
    24 m=audio 30024 RTP/AVP 8 0 101     
    25 a=rtpmap:8 PCMA/8000     
    26 a=rtpmap:0 PCMU/8000     
    27 a=rtpmap:101 telephone-event/8000     
    28 a=fmtp:101 0-15,32,36     
    29 a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:8Z0oPWasZmmCXGAwFSGJObGDZAu7lqe9Loo0CPZ2     
    30 a=sendrecv     
    31 ------------EndOfIncoming SipMessage     
    32 TL_INFO(TF_PROTOCOL) [3]1568.0FD4::03/16/2009-14:14:49.976.00001105 (S4,SipMessage.DataLoggingHelper:sipmessage.cs(531))     
    33 >>>>>>>>>>>>Outgoing SipMessage c=[<SipTcpConnection_2B7C601>], mediationIPfacingMediaGateway:5060->MediaGatewayIP:58197     
    34 SIP/2.0 100 Trying     
    35 FROM: <sip:callingnumber@MediaGatewayIP;user=phone>;tag=sipcontrol_315705944-3343936     
    36 TO: <sip:dialednumber@mediationIPfacingMediaGateway;user=phone>     
    37 CSEQ: 1 INVITE     
    38 CALL-ID: 12d14a58-310640-c@MediaGatewayName     
    39 VIA: SIP/2.0/TCP MediaGatewayIP:58197;branch=z9hG4bK315705944-3278400     
    40 CONTENT-LENGTH: 0     
    41 ------------EndOfOutgoing SipMessage     
    42 TL_INFO(TF_COMPONENT) [2]1568.1228::03/16/2009-14:14:49.976.0000112b (MediationServer,MediationCall.constructor:mediationcall.cs(52))$$START-MEDIATIONSERVER     
    43 MediationCall: 989710c857c2494da36479b5315db0f3     
    44 CallId: 12d14a58-310640-c@MediaGatewayName     
    45 From: sip:callingnumber@MediaGatewayIP;user=phone     
    46 To: sip:dialednumber@mediationIPfacingMediaGateway;user=phone     
    47 Direction: Inbound     
    48 Start-Line: Mediation Call constructor.     
    49 $$END-MEDIATIONSERVER     
    50 TL_INFO(TF_PROTOCOL) [2]1568.1228::03/16/2009-14:14:49.976.0000112c (MediationServer,MediationCall.constructor:mediationcall.cs(70))$$START-MEDIATIONSERVER     
    51 MediationCall: 989710c857c2494da36479b5315db0f3     
    52 CallId: 12d14a58-310640-c@MediaGatewayName     
    53 From: sip:callingnumber@MediaGatewayIP;user=phone     
    54 To: sip:dialednumber@mediationIPfacingMediaGateway;user=phone     
    55 Direction: Inbound     
    56 Start-Line: Incoming signalling headers: ACCEPT:application/sdp     
    57 ACCEPT:application/simple-message-summary     
    58 ALLOW:INVITE     
    59 ALLOW:ACK     
    60 ALLOW:CANCEL     
    61 ALLOW:BYE     
    62 ALLOW:OPTIONS     
    63 ALLOW:NOTIFY     
    64 ALLOW:REFER     
    65 ALLOW:PRACK     
    66 CALL-ID:12d14a58-310640-c@MediaGatewayName     
    67 CONTACT:<sip:callingnumber@MediaGatewayIP:5060;transport=tcp;user=phone>     
    68 CONTENT-LENGTH:311     
    69 CONTENT-TYPE:application/sdp     
    70 CSEQ:1 INVITE     
    71 FROM:<sip:callingnumber@MediaGatewayIP;user=phone>;tag=sipcontrol_315705944-3343936     
    72 MAX-FORWARDS:70     
    73 SUPPORTED:replaces     
    74 SUPPORTED:timer     
    75 TO:<sip:dialednumber@mediationIPfacingMediaGateway;user=phone>     
    76 VIA:SIP/2.0/TCP MediaGatewayIP:58197;branch=z9hG4bK315705944-3278400     
    77 Diversion:<sip:dialednumber@MediaGatewayIP:58197>;privacy=off     
    78 Min-SE:90     
    79 Session-Expires:600;refresher=uac     
    80 $$END-MEDIATIONSERVER     
    81 TL_INFO(TF_COMPONENT) [2]1568.1228::03/16/2009-14:14:49.976.0000112d (MediationServer,MediationCall.ProcessIncomingSession:mediationcall.cs(765))( 0000000001051FAB )$$START-MEDIATIONSERVER     
    82 MediationCall: 989710c857c2494da36479b5315db0f3     
    83 CallId: 12d14a58-310640-c@MediaGatewayName     
    84 From: sip:callingnumber@MediaGatewayIP;user=phone     
    85 To: sip:dialednumber@mediationIPfacingMediaGateway;user=phone     
    86 Direction: Inbound     
    87 Start-Line:  Inbound call's from header user part is E164 .     
    88 $$END-MEDIATIONSERVER     
    89 TL_INFO(TF_PROTOCOL) [2]1568.1228::03/16/2009-14:14:49.976.0000112e (MediationServer,GatewaySDP.ParseSdpOffer:gatewaysdp.cs(801))( 0000000001D21280 )$$START-MEDIATIONSERVER     
    90 MediationCall: 989710c857c2494da36479b5315db0f3     
    91 CallId: 12d14a58-310640-c@MediaGatewayName     
    92 From: sip:callingnumber@MediaGatewayIP;user=phone     
    93 To: sip:dialednumber@mediationIPfacingMediaGateway;user=phone     
    94 Direction: Inbound     
    95 Start-Line: Receive invite from Gateway, SDP is: v=0     
    96 o=SIPcontrol 3147328 3147328 IN IP4 MediaGatewayIP     
    97 s=-     
    98 c=IN IP4 MediaGatewayIP     
    99 t=0 0     
    100 m=audio 30024 RTP/AVP 8 0 101     
    101 a=rtpmap:8 PCMA/8000     
    102 a=rtpmap:0 PCMU/8000     
    103 a=rtpmap:101 telephone-event/8000     
    104 a=fmtp:101 0-15,32,36     
    105 a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:8Z0oPWasZmmCXGAwFSGJObGDZAu7lqe9Loo0CPZ2     
    106 a=sendrecv     
    107 $$END-MEDIATIONSERVER     
    108 TL_INFO(TF_COMPONENT) [2]1568.1228::03/16/2009-14:14:49.976.0000112f (MediationServer,GatewayCall.ApplyMediaLineDescriptions:gatewaycall.cs(763))( 0000000002A4F693 )$$START-MEDIATIONSERVER     
    109 MediationCall: 989710c857c2494da36479b5315db0f3     
    110 CallId: 12d14a58-310640-c@MediaGatewayName     
    111 From: sip:callingnumber@MediaGatewayIP;user=phone     
    112 To: sip:dialednumber@mediationIPfacingMediaGateway;user=phone     
    113 Direction: Inbound     
    114 Start-Line: Adding audio stream.     
    115 $$END-MEDIATIONSERVER     
    116 TL_INFO(TF_COMPONENT) [3]1568.1228::03/16/2009-14:14:49.976.00001130 (MediationServer,MediationCall.CreateOutgoingSession:mediationcall.cs(917))( 0000000001051FAB )$$START-MEDIATIONSERVER     
    117 MediationCall: 989710c857c2494da36479b5315db0f3     
    118 CallId: 12d14a58-310640-c@MediaGatewayName     
    119 From: sip:callingnumber@MediaGatewayIP;user=phone     
    120 To: sip:dialednumber@mediationIPfacingMediaGateway;user=phone     
    121 Direction: Inbound     
    122 Start-Line:  Inbound call's from header user part is E164 .     
    123 $$END-MEDIATIONSERVER     
    124 TL_INFO(TF_PROTOCOL) [3]1568.1228::03/16/2009-14:14:49.976.00001131 (MediationServer,MediationCall.CreateOutgoingSession:mediationcall.cs(1028))( 0000000001051FAB )$$START-MEDIATIONSERVER     
    125 MediationCall: 989710c857c2494da36479b5315db0f3     
    126 CallId: 12d14a58-310640-c@MediaGatewayName     
    127 From: sip:callingnumber@MediaGatewayIP;user=phone     
    128 To: sip:dialednumber@mediationIPfacingMediaGateway;user=phone     
    129 Direction: Inbound     
    130 Start-Line: Creating outgoing Session. Local URI: sip:callingnumber@SIPDomain.com;user=phone, Remote Uri: sip:dialednumber@SIPDomain.com;user=phone     
    131 $$END-MEDIATIONSERVER     
    132 TL_INFO(TF_PROTOCOL) [3]1568.1228::03/16/2009-14:14:49.976.00001132 (MediationServer,MediationCall.CreateOutgoingSession:mediationcall.cs(1034))( 0000000001051FAB )$$START-MEDIATIONSERVER     
    133 MediationCall: 989710c857c2494da36479b5315db0f3     
    134 CallId: 12d14a58-310640-c@MediaGatewayName     
    135 From: sip:callingnumber@MediaGatewayIP;user=phone     
    136 To: sip:dialednumber@mediationIPfacingMediaGateway;user=phone     
    137 Direction: Inbound     
    138 Start-Line: Created outgoing Session. Local URI: sip:callingnumber@SIPDomain.com;user=phone, Remote Uri: sip:dialednumber@SIPDomain.com;user=phone, Call Id: c5031b5c-d359-4fc4-a3ac-61d4473741df     
    139 $$END-MEDIATIONSERVER     
    140 TL_INFO(TF_COMPONENT) [3]1568.1228::03/16/2009-14:14:49.976.00001133 (MediationServer,MediaSessionAgent.constructor:mediasessionagent.cs(609))$$START-MEDIATIONSERVER     
    141 MediationCall: 989710c857c2494da36479b5315db0f3     
    142 CallId: c5031b5c-d359-4fc4-a3ac-61d4473741df     
    143 From: sip:callingnumber@SIPDomain.com;user=phone     
    144 To: sip:dialednumber@SIPDomain.com;user=phone     
    145 Direction: Inbound     
    146 Start-Line:  MediaSessionAgent component initialized. Encryption policy: Supported      
    147 $$END-MEDIATIONSERVER     
    148 TL_INFO(TF_COMPONENT) [5]1568.1738::03/16/2009-14:14:49.976.00001135 (MediationServer,MediaSessionAgent.SetNextState:mediasessionagent.cs(4338))( 0000000001D44967 )$$START-MEDIATIONSERVER     
    149 MediationCall: 989710c857c2494da36479b5315db0f3     
    150 CallId: c5031b5c-d359-4fc4-a3ac-61d4473741df     
    151 From: sip:callingnumber@SIPDomain.com;user=phone     
    152 To: sip:dialednumber@SIPDomain.com;user=phone     
    153 Direction: Inbound     
    154 Start-Line:  MediaSessionAgent state transition: Initial -> Negotiating      
    155 $$END-MEDIATIONSERVER     
    156 TL_INFO(TF_COMPONENT) [3]1568.1738::03/16/2009-14:14:49.976.00001137 (MediationServer,ProxyCall.MediaSessionAgentSyncCallback:proxycall.cs(2868))( 000000000250AB0C )$$START-MEDIATIONSERVER     
    157 MediationCall: 989710c857c2494da36479b5315db0f3     
    158 CallId: c5031b5c-d359-4fc4-a3ac-61d4473741df     
    159 From: sip:callingnumber@SIPDomain.com;user=phone     
    160 To: sip:dialednumber@SIPDomain.com;user=phone     
    161 Direction: Inbound     
    162 Start-Line:  Created and Assigned RtpAudioChannel on Proxy side.      
    163 $$END-MEDIATIONSERVER     
    164 TL_INFO(TF_COMPONENT) [3]1568.1228::03/16/2009-14:14:50.011.0000113a (MediationServer,MediaSessionAgent.ProcessRtpEndpointStateChangedWorkitem:mediasessionagent.cs(4630))( 0000000001D44967 )$$START-MEDIATIONSERVER     
    165 MediationCall: 989710c857c2494da36479b5315db0f3     
    166 CallId: c5031b5c-d359-4fc4-a3ac-61d4473741df     
    167 From: sip:callingnumber@SIPDomain.com;user=phone     
    168 To: sip:dialednumber@SIPDomain.com;user=phone     
    169 Direction: Inbound     
    170 Start-Line:  <OBJ><T>MediaSessionAgent</T><ADR>1D44967</ADR><MSG>Local endpoint allocation completed (Succeeded) for RtpEndpoint [50315679]</MSG></OBJ>      
    171 $$END-MEDIATIONSERVER     
    172 TL_INFO(TF_COMPONENT) [3]1568.1228::03/16/2009-14:14:50.016.0000113c (MediationServer,MediaSessionAgent.ProcessRtpEndpointConnectivityEventWorkitem:mediasessionagent.cs(4457))( 0000000001D44967 )$$START-MEDIATIONSERVER     
    173 MediationCall: 989710c857c2494da36479b5315db0f3     
    174 CallId: c5031b5c-d359-4fc4-a3ac-61d4473741df     
    175 From: sip:callingnumber@SIPDomain.com;user=phone     
    176 To: sip:dialednumber@SIPDomain.com;user=phone     
    177 Direction: Inbound     
    178 Start-Line:  ICEv19 RtpEndpoint Connectivity EndpointEvent: LocalEndpointsAllocated; Status: None      
    179 $$END-MEDIATIONSERVER     
    180 TL_INFO(TF_PROTOCOL) [3]1568.1228::03/16/2009-14:14:50.021.00001144 (MediationServer,ProxySDP.GetOffer:proxysdp.cs(48))( 0000000002F60293 )$$START-MEDIATIONSERVER     
    181 MediationCall: 989710c857c2494da36479b5315db0f3     
    182 CallId: c5031b5c-d359-4fc4-a3ac-61d4473741df     
    183 From: sip:callingnumber@SIPDomain.com;user=phone     
    184 To: sip:dialednumber@SIPDomain.com;user=phone     
    185 Direction: Inbound     
    186 Start-Line: Send invite to Proxy, SDP is: v=0     
    187 o=- 0 0 IN IP4 mediationIPfacingOCS     
    188 s=session     
    189 c=IN IP4 mediationIPfacingOCS     
    190 b=CT:1000     
    191 t=0 0     
    192 m=audio 60872 RTP/AVP 0 8 115 13 118 97 101     
    193 c=IN IP4 mediationIPfacingMediaGateway     
    194 a=rtcp:60842     
    195 a=candidate:oH2T5qGP3KGE5VRmpw49w/glg3HMHtUa3d9MCHKu+68 1 tO1Ap7b1Z4mFctBR1rQPcg UDP 0.850 mediationIPfacingMediaGateway 60872     
    196 a=candidate:oH2T5qGP3KGE5VRmpw49w/glg3HMHtUa3d9MCHKu+68 2 tO1Ap7b1Z4mFctBR1rQPcg UDP 0.850 mediationIPfacingMediaGateway 60842     
    197 a=candidate:LfHsdx/SUtrGDzFbaEbx083cwxZmj93x0HbhktAO2BI 1 J79691cpDHOSYhszFKcmJA UDP 0.860 mediationIPfacingOCS 62612     
    198 a=candidate:LfHsdx/SUtrGDzFbaEbx083cwxZmj93x0HbhktAO2BI 2 J79691cpDHOSYhszFKcmJA UDP 0.860 mediationIPfacingOCS 62591     
    199 a=cryptoscale:1 client AES_CM_128_HMAC_SHA1_80 inline:Z3jiIGssN39UgPMv0NExWS4XpYY3wlmIbUvY5UrG|2^31|1:1     
    200 a=crypto:2 AES_CM_128_HMAC_SHA1_80 inline:i6eeT4lCFrf0DjEs8u+ZewcTVYAD+Dz155Ks8adn|2^31|1:1     
    201 a=crypto:3 AES_CM_128_HMAC_SHA1_80 inline:7GtvyureBvmvelJKvY8c4DGDfm1X9T4E5DzR7bMy|2^31     
    202 a=label:main-audio     
    203 a=rtpmap:0 PCMU/8000     
    204 a=rtpmap:8 PCMA/8000     
    205 a=rtpmap:115 x-msrta/8000     
    206 a=fmtp:115 bitrate=11800     
    207 a=rtpmap:13 CN/8000     
    208 a=rtpmap:118 CN/16000     
    209 a=rtpmap:97 RED/8000     
    210 a=rtpmap:101 telephone-event/8000     
    211 a=fmtp:101 0-16     
    212 v=0     
    213 o=- 0 0 IN IP4 mediationIPfacingOCS     
    214 s=session     
    215 c=IN IP4 mediationIPfacingOCS     
    216 b=CT:1000     
    217 t=0 0     
    218 m=audio 60403 RTP/AVP 0 8 115 13 118 97 101     
    219 c=IN IP4 mediationIPfacingOCS     
    220 a=rtcp:61798     
    221 a=ice-ufrag:AgnT     
    222 a=ice-pwd:7rbFafIYUz4kWyLl5DqoQjBB     
    223 a=candidate:1 1 UDP 2130706431 mediationIPfacingOCS 60403 typ host     
    224 a=candidate:1 2 UDP 2130705918 mediationIPfacingOCS 61798 typ host     
    225 a=candidate:2 1 UDP 2130705919 mediationIPfacingMediaGateway 61917 typ host     
    226 a=candidate:2 2 UDP 2130705406 mediationIPfacingMediaGateway 60365 typ host     
    227 a=candidate:3 1 tcp-act 1684798463 mediationIPfacingOCS 60403 typ srflx raddr mediationIPfacingOCS rport 60403     
    228 a=candidate:3 2 tcp-act 1684797950 mediationIPfacingOCS 60403 typ srflx raddr mediationIPfacingOCS rport 60403     
    229 a=cryptoscale:1 client AES_CM_128_HMAC_SHA1_80 inline:Z3jiIGssN39UgPMv0NExWS4XpYY3wlmIbUvY5UrG|2^31|1:1     
    230 a=crypto:2 AES_CM_128_HMAC_SHA1_80 inline:i6eeT4lCFrf0DjEs8u+ZewcTVYAD+Dz155Ks8adn|2^31|1:1     
    231 a=crypto:3 AES_CM_128_HMAC_SHA1_80 inline:7GtvyureBvmvelJKvY8c4DGDfm1X9T4E5DzR7bMy|2^31     
    232 a=label:main-audio     
    233 a=rtpmap:0 PCMU/8000     
    234 a=rtpmap:8 PCMA/8000     
    235 a=rtpmap:115 x-msrta/8000     
    236 a=fmtp:115 bitrate=11800     
    237 a=rtpmap:13 CN/8000     
    238 a=rtpmap:118 CN/16000     
    239 a=rtpmap:97 RED/8000     
    240 a=rtpmap:101 telephone-event/8000     
    241 a=fmtp:101 0-16     
    242 $$END-MEDIATIONSERVER     
    243 TL_INFO(TF_PROTOCOL) [2]1568.1228::03/16/2009-14:14:50.026.000011f2 (S4,SipMessage.DataLoggingHelper:sipmessage.cs(531))     
    244 >>>>>>>>>>>>Outgoing SipMessage c=[<SipTlsConnection_252AC9E>], mediationIPfacingOCS:58923->172.27.16.38:5061     
    245 INVITE sip:dialednumber@SIPDomain.com;user=phone SIP/2.0     
    246 FROM: <sip:callingnumber@SIPDomain.com;user=phone>;epid=A9B327853A;tag=adcf7d7595     
    247 TO: <sip:dialednumber@SIPDomain.com;user=phone>     
    248 CSEQ: 4 INVITE     
    249 CALL-ID: c5031b5c-d359-4fc4-a3ac-61d4473741df     
    250 MAX-FORWARDS: 70     
    251 VIA: SIP/2.0/TLS mediationIPfacingOCS:58923;branch=z9hG4bK61c256c     
    252 ROUTE: <sip:dialednumber@MediaGatewayIP:58197>;privacy=off     
    253 CONTACT: <sip:MediationFQDN.forestFQDN@SIPDomain.com;gruu;opaque=srvr:MediationServer:W3f6xD1eLE22KmXQKx4HcAAA;grid=989710c857c2494da36479b5315db0f3>;isGateway     
    254 CONTENT-LENGTH: 2566     
    255 SUPPORTED: replaces     
    256 SUPPORTED: ms-safe-transfer     
    257 SUPPORTED: gruu-10     
    258 SUPPORTED: 100rel     
    259 USER-AGENT: RTCC/3.5.0.0 MediationServer     
    260 CONTENT-TYPE: multipart/alternative; boundary=lWr5Cy8UqBEB7tytpG0Lr1NnM1QugTid     
    261 ALLOW: UPDATE     
    262 ms-call-source: non-ms-rtc     
    263 ALLOW: Ack, Cancel, Bye,Invite,Refer     
    264 --lWr5Cy8UqBEB7tytpG0Lr1NnM1QugTid     
    265 Content-Type: application/sdp     
    266 Content-Disposition: Session;handling=optional;ms-proxy-2007fallback     
    267 v=0     
    268 o=- 0 0 IN IP4 mediationIPfacingOCS     
    269 s=session     
    270 c=IN IP4 mediationIPfacingOCS     
    271 b=CT:1000     
    272 t=0 0     
    273 m=audio 60872 RTP/AVP 0 8 115 13 118 97 101     
    274 c=IN IP4 mediationIPfacingMediaGateway     
    275 a=rtcp:60842     
    276 a=candidate:oH2T5qGP3KGE5VRmpw49w/glg3HMHtUa3d9MCHKu+68 1 tO1Ap7b1Z4mFctBR1rQPcg UDP 0.850 mediationIPfacingMediaGateway 60872     
    277 a=candidate:oH2T5qGP3KGE5VRmpw49w/glg3HMHtUa3d9MCHKu+68 2 tO1Ap7b1Z4mFctBR1rQPcg UDP 0.850 mediationIPfacingMediaGateway 60842     
    278 a=candidate:LfHsdx/SUtrGDzFbaEbx083cwxZmj93x0HbhktAO2BI 1 J79691cpDHOSYhszFKcmJA UDP 0.860 mediationIPfacingOCS 62612     
    279 a=candidate:LfHsdx/SUtrGDzFbaEbx083cwxZmj93x0HbhktAO2BI 2 J79691cpDHOSYhszFKcmJA UDP 0.860 mediationIPfacingOCS 62591     
    280 a=cryptoscale:1 client AES_CM_128_HMAC_SHA1_80 inline:Z3jiIGssN39UgPMv0NExWS4XpYY3wlmIbUvY5UrG|2^31|1:1     
    281 a=crypto:2 AES_CM_128_HMAC_SHA1_80 inline:i6eeT4lCFrf0DjEs8u+ZewcTVYAD+Dz155Ks8adn|2^31|1:1     
    282 a=crypto:3 AES_CM_128_HMAC_SHA1_80 inline:7GtvyureBvmvelJKvY8c4DGDfm1X9T4E5DzR7bMy|2^31     
    283 a=label:main-audio     
    284 a=rtpmap:0 PCMU/8000     
    285 a=rtpmap:8 PCMA/8000     
    286 a=rtpmap:115 x-msrta/8000     
    287 a=fmtp:115 bitrate=11800     
    288 a=rtpmap:13 CN/8000     
    289 a=rtpmap:118 CN/16000     
    290 a=rtpmap:97 RED/8000     
    291 a=rtpmap:101 telephone-event/8000     
    292 a=fmtp:101 0-16     
    293 --lWr5Cy8UqBEB7tytpG0Lr1NnM1QugTid     
    294 Content-Type: application/sdp     
    295 v=0     
    296 o=- 0 0 IN IP4 mediationIPfacingOCS     
    297 s=session     
    298 c=IN IP4 mediationIPfacingOCS     
    299 b=CT:1000     
    300 t=0 0     
    301 m=audio 60403 RTP/AVP 0 8 115 13 118 97 101     
    302 c=IN IP4 mediationIPfacingOCS     
    303 a=rtcp:61798     
    304 a=ice-ufrag:AgnT     
    305 a=ice-pwd:7rbFafIYUz4kWyLl5DqoQjBB     
    306 a=candidate:1 1 UDP 2130706431 mediationIPfacingOCS 60403 typ host     
    307 a=candidate:1 2 UDP 2130705918 mediationIPfacingOCS 61798 typ host     
    308 a=candidate:2 1 UDP 2130705919 mediationIPfacingMediaGateway 61917 typ host     
    309 a=candidate:2 2 UDP 2130705406 mediationIPfacingMediaGateway 60365 typ host     
    310 a=candidate:3 1 tcp-act 1684798463 mediationIPfacingOCS 60403 typ srflx raddr mediationIPfacingOCS rport 60403     
    311 a=candidate:3 2 tcp-act 1684797950 mediationIPfacingOCS 60403 typ srflx raddr mediationIPfacingOCS rport 60403     
    312 a=cryptoscale:1 client AES_CM_128_HMAC_SHA1_80 inline:Z3jiIGssN39UgPMv0NExWS4XpYY3wlmIbUvY5UrG|2^31|1:1     
    313 a=crypto:2 AES_CM_128_HMAC_SHA1_80 inline:i6eeT4lCFrf0DjEs8u+ZewcTVYAD+Dz155Ks8adn|2^31|1:1     
    314 a=crypto:3 AES_CM_128_HMAC_SHA1_80 inline:7GtvyureBvmvelJKvY8c4DGDfm1X9T4E5DzR7bMy|2^31     
    315 a=label:main-audio     
    316 a=rtpmap:0 PCMU/8000     
    317 a=rtpmap:8 PCMA/8000     
    318 a=rtpmap:115 x-msrta/8000     
    319 a=fmtp:115 bitrate=11800     
    320 a=rtpmap:13 CN/8000     
    321 a=rtpmap:118 CN/16000     
    322 a=rtpmap:97 RED/8000     
    323 a=rtpmap:101 telephone-event/8000     
    324 a=fmtp:101 0-16     
    325 --lWr5Cy8UqBEB7tytpG0Lr1NnM1QugTid--     
    326 ------------EndOfOutgoing SipMessage     
    327 TL_INFO(TF_PROTOCOL) [7]1568.03C8::03/16/2009-14:14:50.041.00001239 (S4,SipMessage.DataLoggingHelper:sipmessage.cs(581))     
    328 <<<<<<<<<<<<Incoming SipMessage c=[<SipTlsConnection_252AC9E>], mediationIPfacingOCS:58923<-172.27.16.38:5061     
    329 SIP/2.0 100 Trying     
    330 FROM: <sip:callingnumber@SIPDomain.com;user=phone>;epid=A9B327853A;tag=adcf7d7595     
    331 TO: <sip:dialednumber@SIPDomain.com;user=phone>     
    332 CSEQ: 4 INVITE     
    333 CALL-ID: c5031b5c-d359-4fc4-a3ac-61d4473741df     
    334 VIA: SIP/2.0/TLS mediationIPfacingOCS:58923;branch=z9hG4bK61c256c;ms-received-port=58923;ms-received-cid=9FE00     
    335 CONTENT-LENGTH: 0     
    336 ------------EndOfIncoming SipMessage     
    337 TL_INFO(TF_PROTOCOL) [7]1568.03C8::03/16/2009-14:14:50.236.00001279 (S4,SipMessage.DataLoggingHelper:sipmessage.cs(581))     
    338 <<<<<<<<<<<<Incoming SipMessage c=[<SipTlsConnection_252AC9E>], mediationIPfacingOCS:58923<-172.27.16.38:5061     
    339 SIP/2.0 504 Server time-out    
    340 FROM: <sip:callingnumber@SIPDomain.com;user=phone>;epid=A9B327853A;tag=adcf7d7595     
    341 TO: <sip:dialednumber@SIPDomain.com;user=phone>;tag=21522874457B9D709346D90A44378DC5     
    342 CSEQ: 4 INVITE     
    343 CALL-ID: c5031b5c-d359-4fc4-a3ac-61d4473741df     
    344 VIA: SIP/2.0/TLS mediationIPfacingOCS:58923;branch=z9hG4bK61c256c;ms-received-port=58923;ms-received-cid=9FE00     
    345 CONTENT-LENGTH: 0     
    346 ms-diagnostics: 1022;reason="Cannot process routing destination";source="FE2.forestFQDN";Destination="sip:dialednumber@MediaGatewayIP:58197"    
    347 ------------EndOfIncoming SipMessage     
    348 TL_INFO(TF_PROTOCOL) [3]1568.0FD4::03/16/2009-14:14:50.236.000012c4 (S4,SipMessage.DataLoggingHelper:sipmessage.cs(531))     
    349 >>>>>>>>>>>>Outgoing SipMessage c=[<SipTlsConnection_252AC9E>], mediationIPfacingOCS:58923->172.27.16.38:5061     
    350 ACK sip:dialednumber@SIPDomain.com;user=phone SIP/2.0     
    351 FROM: <sip:callingnumber@SIPDomain.com;user=phone>;tag=adcf7d7595;epid=A9B327853A     
    352 TO: <sip:dialednumber@SIPDomain.com;user=phone>;tag=21522874457B9D709346D90A44378DC5     
    353 CSEQ: 4 ACK     
    354 CALL-ID: c5031b5c-d359-4fc4-a3ac-61d4473741df     
    355 MAX-FORWARDS: 70     
    356 VIA: SIP/2.0/TLS mediationIPfacingOCS:58923;branch=z9hG4bK61c256c     
    357 ROUTE: <sip:dialednumber@MediaGatewayIP:58197>;privacy=off     
    358 CONTENT-LENGTH: 0    
    Tuesday, March 17, 2009 11:30 AM
  •  
    1 ------------EndOfOutgoing SipMessage     
    2 TL_ERROR(TF_PROTOCOL) [5]1568.1738::03/16/2009-14:14:50.236.000012f4 (MediationServer,ProxyCall.FinishParticipate:proxycall.cs(1565))( 000000000250AB0C )$$START-MEDIATIONSERVER     
    3 MediationCall: 989710c857c2494da36479b5315db0f3     
    4 CallId: c5031b5c-d359-4fc4-a3ac-61d4473741df     
    5 From: sip:callingnumber@SIPDomain.com;user=phone     
    6 To: sip:dialednumber@SIPDomain.com;user=phone     
    7 Direction: Inbound     
    8 Start-Line: FailureResponseException: ResponseCode=504 ResponseText=Server time-out    
    9 DiagnosticInformation=ErrorCode=1022,Source=FE2.forestFQDN,Reason=Cannot process routing destination     
    10 Microsoft.Rtc.Signaling.DiagnosticHeader     
    11 Microsoft.Rtc.Signaling.FailureResponseException: The operation has failed. See the exception's properties as well as the logs for additional information.     
    12    at Microsoft.Rtc.Signaling.SipAsyncResult`1.ThrowIfFailed()     
    13    at Microsoft.Rtc.Signaling.Helper.EndAsyncOperation[T](Object owner, IAsyncResult result)     
    14    at Microsoft.Rtc.Signaling.Helper.EndAsyncOperation[T](Object owner, IAsyncResult result, String operationId)     
    15    at Microsoft.Rtc.Signaling.SignalingSession.EndEnter(SipInviteAsyncResultWrapper asyncWrapper)     
    16    at Microsoft.RTC.MediationServerCore.ProxyCall.FinishParticipate(IAsyncResult ar)     
    17    Detected at System.Environment.get_StackTrace()     
    18    at Microsoft.Rtc.Signaling.FailureResponseException..ctor(String message, Exception innerException, SipResponseData responseData)     
    19    at Microsoft.Rtc.Signaling.RealTimeException.GetWrappedRealTimeException(String message, SipResponseData responseData, Exception exceptionToWrap)     
    20    at Microsoft.Rtc.Signaling.SipTransactionAsyncResult`1.ProcessFailureResponse(SipResponse response)     
    21    at Microsoft.Rtc.Signaling.SipInviteAsyncResult.ProcessFailureResponse(Object state)     
    22    at Microsoft.Rtc.Signaling.QueueWorkItemState.ExecuteWrappedMethod(WaitCallback method, Object state)     
    23    at System.Threading.ExecutionContext.Run(ExecutionContext executionContext, ContextCallback callback, Object state)     
    24    at System.Threading._ThreadPoolWaitCallback.PerformWaitCallbackInternal(_ThreadPoolWaitCallback tpWaitCallBack)     
    25    at System.Threading._ThreadPoolWaitCallback.PerformWaitCallback(Object state)     
    26 $$END-MEDIATIONSERVER     
    27 TL_INFO(TF_PROTOCOL) [2]1568.1228::03/16/2009-14:14:50.241.000013a1 (S4,SipMessage.DataLoggingHelper:sipmessage.cs(531))     
    28 >>>>>>>>>>>>Outgoing SipMessage c=[<SipTlsConnection_135789C>], mediationIPfacingOCS:58924->172.27.16.38:5061     
    29 SERVICE sip:dialednumber@SIPDomain.com;user=phone SIP/2.0     
    30 FROM: <sip:dialednumber@SIPDomain.com;user=phone>;epid=A9B327853A;tag=da70a677c8     
    31 TO: <sip:dialednumber@SIPDomain.com;user=phone>     
    32 CSEQ: 5 SERVICE     
    33 CALL-ID: 6294db35b4e2457fbc61f0802da87021     
    34 MAX-FORWARDS: 70     
    35 VIA: SIP/2.0/TLS mediationIPfacingOCS:58924;branch=z9hG4bK81a5397     
    36 CONTENT-LENGTH: 558     
    37 USER-AGENT: RTCC/3.5.0.0 MediationServer     
    38 CONTENT-TYPE: application/msrtc-reporterror+xml     
    39 <?xml version="1.0" encoding="us-ascii"?><reportError xmlns="http://schemas.microsoft.com/2006/09/sip/error-reporting"><error callId="c5031b5c-d359-4fc4-a3ac-61d4473741df" toUri="sip:dialednumber@SIPDomain.com;user=phone" fromTag="adcf7d7595" toTag="21522874457B9D709346D90A44378DC5" requestType="INVITE" contentType="application/sdp;call-type=audio" responseCode="504"><diagHeader>1022;reason="Cannot process routing destination";source="FE2.forestFQDN";Destination="sip:dialednumber@MediaGatewayIP:58197"</diagHeader><progressReports /></error></reportError>------------EndOfOutgoing SipMessage     
    40 TL_INFO(TF_PROTOCOL) [7]1568.14B8::03/16/2009-14:14:50.276.000013f1 (S4,SipMessage.DataLoggingHelper:sipmessage.cs(531))     
    41 >>>>>>>>>>>>Outgoing SipMessage c=[<SipTcpConnection_2B7C601>], mediationIPfacingMediaGateway:5060->MediaGatewayIP:58197     
    42 SIP/2.0 504 Server time-out    
    43 FROM: <sip:callingnumber@MediaGatewayIP;user=phone>;tag=sipcontrol_315705944-3343936     
    44 TO: <sip:dialednumber@mediationIPfacingMediaGateway;user=phone>;epid=A53F5BA442;tag=54e3ed9f8     
    45 CSEQ: 1 INVITE     
    46 CALL-ID: 12d14a58-310640-c@MediaGatewayName     
    47 VIA: SIP/2.0/TCP MediaGatewayIP:58197;branch=z9hG4bK315705944-3278400     
    48 CONTENT-LENGTH: 0     
    49 SERVER: RTCC/3.5.0.0 MediationServer     
    50 ------------EndOfOutgoing SipMessage     
    51 TL_INFO(TF_COMPONENT) [5]1568.1738::03/16/2009-14:14:50.276.000013f8 (MediationServer,MediationCall.Terminate:mediationcall.cs(216))( 0000000001051FAB )$$START-MEDIATIONSERVER     
    52 MediationCall: 989710c857c2494da36479b5315db0f3     
    53 CallId: 12d14a58-310640-c@MediaGatewayName     
    54 From: sip:callingnumber@MediaGatewayIP;user=phone     
    55 To: sip:dialednumber@mediationIPfacingMediaGateway;user=phone     
    56 Direction: Inbound     
    57 Start-Line: Mediation Call Terminate successfull.     
    58 $$END-MEDIATIONSERVER     
    59 TL_INFO(TF_COMPONENT) [4]1568.1030::03/16/2009-14:14:50.276.000013f9 (MediationServer,MediaSessionAgent.TerminateMediaSession:mediasessionagent.cs(4207))( 0000000001D44967 )$$START-MEDIATIONSERVER     
    60 MediationCall: 989710c857c2494da36479b5315db0f3     
    61 CallId: c5031b5c-d359-4fc4-a3ac-61d4473741df     
    62 From: sip:callingnumber@SIPDomain.com;user=phone     
    63 To: sip:dialednumber@SIPDomain.com;user=phone     
    64 Direction: Inbound     
    65 Start-Line:  Terminating media session, reason: MediaSessionTerminated      
    66 $$END-MEDIATIONSERVER     
    67 TL_INFO(TF_COMPONENT) [4]1568.1030::03/16/2009-14:14:50.276.000013fd (MediationServer,MediaSessionAgent.SetNextState:mediasessionagent.cs(4338))( 0000000001D44967 )$$START-MEDIATIONSERVER     
    68 MediationCall: 989710c857c2494da36479b5315db0f3     
    69 CallId: c5031b5c-d359-4fc4-a3ac-61d4473741df     
    70 From: sip:callingnumber@SIPDomain.com;user=phone     
    71 To: sip:dialednumber@SIPDomain.com;user=phone     
    72 Direction: Inbound     
    73 Start-Line:  MediaSessionAgent state transition: Negotiating -> Terminated      
    74 $$END-MEDIATIONSERVER     
    75 TL_INFO(TF_COMPONENT) [4]1568.1030::03/16/2009-14:14:50.286.00001418 (MediationServer,MediationCall.DisposeConference:mediationcall.cs(258))( 0000000001051FAB )$$START-MEDIATIONSERVER     
    76 MediationCall: 989710c857c2494da36479b5315db0f3     
    77 CallId: 12d14a58-310640-c@MediaGatewayName     
    78 From: sip:callingnumber@MediaGatewayIP;user=phone     
    79 To: sip:dialednumber@mediationIPfacingMediaGateway;user=phone     
    80 Direction: Inbound     
    81 Start-Line: Conference Disposed.      
    82 $$END-MEDIATIONSERVER     
    83 TL_INFO(TF_PROTOCOL) [7]1568.03C8::03/16/2009-14:14:50.302.0000142a (S4,SipMessage.DataLoggingHelper:sipmessage.cs(581))     
    84 <<<<<<<<<<<<Incoming SipMessage c=[<SipTcpConnection_2B7C601>], mediationIPfacingMediaGateway:5060<-MediaGatewayIP:58197     
    85 ACK sip:dialednumber@mediationIPfacingMediaGateway;user=phone SIP/2.0     
    86 FROM: <sip:callingnumber@MediaGatewayIP;user=phone>;tag=sipcontrol_315705944-3343936     
    87 TO: <sip:dialednumber@mediationIPfacingMediaGateway;user=phone>;tag=54e3ed9f8     
    88 CSEQ: 1 ACK     
    89 CALL-ID: 12d14a58-310640-c@MediaGatewayName     
    90 MAX-FORWARDS: 70     
    91 VIA: SIP/2.0/TCP MediaGatewayIP:58197;branch=z9hG4bK315705944-3278400     
    92 CONTACT: <sip:callingnumber@MediaGatewayIP:5060;transport=tcp;user=phone>     
    93 CONTENT-LENGTH: 0     
    94 ------------EndOfIncoming SipMessage     
    95 TL_INFO(TF_PROTOCOL) [7]1568.03C8::03/16/2009-14:14:50.442.0000148b (S4,SipMessage.DataLoggingHelper:sipmessage.cs(581))     
    96 <<<<<<<<<<<<Incoming SipMessage c=[<SipTlsConnection_135789C>], mediationIPfacingOCS:58924<-172.27.16.38:5061     
    97 SIP/2.0 503 Service unavailable     
    98 FROM: <sip:dialednumber@SIPDomain.com;user=phone>;epid=A9B327853A;tag=da70a677c8     
    99 TO: <sip:dialednumber@SIPDomain.com;user=phone>;tag=21522874457B9D709346D90A44378DC5     
    100 CSEQ: 5 SERVICE     
    101 CALL-ID: 6294db35b4e2457fbc61f0802da87021     
    102 VIA: SIP/2.0/TLS mediationIPfacingOCS:58924;branch=z9hG4bK81a5397;ms-received-port=58924;ms-received-cid=9FF00     
    103 CONTENT-LENGTH: 0     
    104 RETRY-AFTER: 70     
    105 ms-diagnostics: 2019;reason="Report error service is not available";source="FE2.forestFQDN"    
    106 ------------EndOfIncoming SipMessage     
    107    

    The next log was captured on FE2:

    1 TL_INFO(TF_CONNECTION) [5]15C4.1F84::03/17/2009-11:07:19.511.0011e094 (SIPStack,SIPAdminLog::TraceConnectionRecord:SIPAdminLog.cpp(161))$$begin_record     
    2 LogType: connection     
    3 Severity: information     
    4 Text: TLS negotiation started     
    5 Local-IP: IPofFE2facingLB:5061     
    6 Peer-IP: IPofLBfacingFE:53830     
    7 Connection-ID: 0x456400     
    8 Transport: TLS     
    9 $$end_record     
    10 TL_INFO(TF_CONNECTION) [1]15C4.23CC::03/17/2009-11:07:19.526.0011e118 (SIPStack,SIPAdminLog::TraceConnectionRecord:SIPAdminLog.cpp(161))$$begin_record     
    11 LogType: connection     
    12 Severity: information     
    13 Text: Connection established     
    14 Local-IP: IPofFE2facingLB:5061     
    15 Peer-IP: IPofLBfacingFE:53830     
    16 Peer-FQDN: FQDNofMediation     
    17 Peer-Name: FQDNofMediation     
    18 Connection-ID: 0x456400     
    19 Transport: M-TLS     
    20 $$end_record     
    21 TL_INFO(TF_PROTOCOL) [1]15C4.23CC::03/17/2009-11:07:19.526.0011e1e4 (SIPStack,SIPAdminLog::TraceProtocolRecord:SIPAdminLog.cpp(122))$$begin_record     
    22 Instance-Id: 00006D18     
    23 Direction: incoming     
    24 Peer: FQDNofMediation:53830     
    25 Message-Type: request     
    26 Start-Line: INVITE sip:+43xxxxyyyyy3@SIPDomain.com;user=phone SIP/2.0     
    27 From: <sip:+43xxxxyyyyy4@SIPDomain.com;user=phone>;epid=BEDCB615BF;tag=bd6122cdf     
    28 To: <sip:+43xxxxyyyyy3@SIPDomain.com;user=phone>     
    29 CSeq: 9 INVITE     
    30 Call-ID: 6d9167a0-e0ad-4375-8325-9790ad7652c7     
    31 MAX-FORWARDS: 70     
    32 VIA: SIP/2.0/TLS IPofMediationfacingFE:53830;branch=z9hG4bKa3a8e4e8     
    33 ROUTE: <sip:+43xxxxyyyyy3@IPofMediaGatewayfacingMediation:58575>;privacy=off     
    34 CONTACT: <sip:FQDNofMediation@SIPDomain.com;gruu;opaque=srvr:MediationServer:W3f6xD1eLE22KmXQKx4HcAAA;grid=75c733237ac14b898433553721b9de4e>;isGateway     
    35 CONTENT-LENGTH: 2566     
    36 SUPPORTED: replaces     
    37 SUPPORTED: ms-safe-transfer     
    38 SUPPORTED: gruu-10     
    39 SUPPORTED: 100rel     
    40 USER-AGENT: RTCC/3.5.0.0 MediationServer     
    41 CONTENT-TYPE: multipart/alternative; boundary=p3hZBnlZdxX3Z1Qh5lcUDmQwR4trLdVZ     
    42 ALLOW: UPDATE     
    43 ms-call-source: non-ms-rtc     
    44 ALLOW: Ack, Cancel, Bye,Invite,Refer     
    45 Message-Body: --p3hZBnlZdxX3Z1Qh5lcUDmQwR4trLdVZ     
    46 Content-Type: application/sdp     
    47 Content-Disposition: Session;handling=optional;ms-proxy-2007fallback     
    48 v=0     
    49 o=- 0 0 IN IP4 IPofMediationfacingFE     
    50 s=session     
    51 c=IN IP4 IPofMediationfacingFE     
    52 b=CT:1000     
    53 t=0 0     
    54 m=audio 62977 RTP/AVP 0 8 115 13 118 97 101     
    55 c=IN IP4 IPofMediationfacingMediaGateway     
    56 a=rtcp:62868     
    57 a=candidate:v7tRdmky+NpxH8MJ/Q+xkFvOfCpbywPlK1L01VJ29F8 1 JqVvN3b34JWAw/KT7TSRTQ UDP 0.890 IPofMediationfacingMediaGateway 62977     
    58 a=candidate:v7tRdmky+NpxH8MJ/Q+xkFvOfCpbywPlK1L01VJ29F8 2 JqVvN3b34JWAw/KT7TSRTQ UDP 0.890 IPofMediationfacingMediaGateway 62868     
    59 a=candidate:7uh8EXJvTAGTwkmTPH1IWwag7PrimHdy6hgBlylO3y0 1 d+ceKUST8Ss2IQwkZ4AXPw UDP 0.900 IPofMediationfacingFE 62476     
    60 a=candidate:7uh8EXJvTAGTwkmTPH1IWwag7PrimHdy6hgBlylO3y0 2 d+ceKUST8Ss2IQwkZ4AXPw UDP 0.900 IPofMediationfacingFE 60526     
    61 a=cryptoscale:1 client AES_CM_128_HMAC_SHA1_80 inline:bK6g7CZY1O0D4KE46vGIBjfB50hTweX8q/Dbky8Z|2^31|1:1     
    62 a=crypto:2 AES_CM_128_HMAC_SHA1_80 inline:5USQ+2IzYCZo37CAiMTSw8n4CvjkCr3PgSYzhyRV|2^31|1:1     
    63 a=crypto:3 AES_CM_128_HMAC_SHA1_80 inline:3clfFnbIQQ3MBQ0rN4X7y8bcKAZep3zCgbcCKpEA|2^31     
    64 a=label:main-audio     
    65 a=rtpmap:0 PCMU/8000     
    66 a=rtpmap:8 PCMA/8000     
    67 a=rtpmap:115 x-msrta/8000     
    68 a=fmtp:115 bitrate=11800     
    69 a=rtpmap:13 CN/8000     
    70 a=rtpmap:118 CN/16000     
    71 a=rtpmap:97 RED/8000     
    72 a=rtpmap:101 telephone-event/8000     
    73 a=fmtp:101 0-16     
    74 --p3hZBnlZdxX3Z1Qh5lcUDmQwR4trLdVZ     
    75 Content-Type: application/sdp     
    76 v=0     
    77 o=- 0 0 IN IP4 IPofMediationfacingFE     
    78 s=session     
    79 c=IN IP4 IPofMediationfacingFE     
    80 b=CT:1000     
    81 t=0 0     
    82 m=audio 60564 RTP/AVP 0 8 115 13 118 97 101     
    83 c=IN IP4 IPofMediationfacingFE     
    84 a=rtcp:61152     
    85 a=ice-ufrag:sTTc     
    86 a=ice-pwd:8E8Qm6eAGgWZSPzDct2t1v9l     
    87 a=candidate:1 1 UDP 2130706431 IPofMediationfacingFE 60564 typ host     
    88 a=candidate:1 2 UDP 2130705918 IPofMediationfacingFE 61152 typ host     
    89 a=candidate:2 1 UDP 2130705919 IPofMediationfacingMediaGateway 63547 typ host     
    90 a=candidate:2 2 UDP 2130705406 IPofMediationfacingMediaGateway 62185 typ host     
    91 a=candidate:3 1 tcp-act 1684798463 IPofMediationfacingFE 60564 typ srflx raddr IPofMediationfacingFE rport 60564     
    92 a=candidate:3 2 tcp-act 1684797950 IPofMediationfacingFE 60564 typ srflx raddr IPofMediationfacingFE rport 60564     
    93 a=cryptoscale:1 client AES_CM_128_HMAC_SHA1_80 inline:bK6g7CZY1O0D4KE46vGIBjfB50hTweX8q/Dbky8Z|2^31|1:1     
    94 a=crypto:2 AES_CM_128_HMAC_SHA1_80 inline:5USQ+2IzYCZo37CAiMTSw8n4CvjkCr3PgSYzhyRV|2^31|1:1     
    95 a=crypto:3 AES_CM_128_HMAC_SHA1_80 inline:3clfFnbIQQ3MBQ0rN4X7y8bcKAZep3zCgbcCKpEA|2^31     
    96 a=label:main-audio     
    97 a=rtpmap:0 PCMU/8000     
    98 a=rtpmap:8 PCMA/8000     
    99 a=rtpmap:115 x-msrta/8000     
    100 a=fmtp:115 bitrate=11800     
    101 a=rtpmap:13 CN/8000     
    102 a=rtpmap:118 CN/16000     
    103 a=rtpmap:97 RED/8000     
    104 a=rtpmap:101 telephone-event/8000     
    105 a=fmtp:101 0-16     
    106 --p3hZBnlZdxX3Z1Qh5lcUDmQwR4trLdVZ--     
    107 $$end_record     
    108 TL_WARN(TF_DIAG) [1]15C4.23CC::03/17/2009-11:07:19.526.0011eb9a (SIPStack,SIPAdminLog::TraceDiagRecord:SIPAdminLog.cpp(142))$$begin_record     
    109 LogType: diagnostic     
    110 Severity: warning     
    111 Text: Non-trusted source with a request URI that is not eligible for static routing     
    112 Result-Code: 0xc3e93c5e SIPPROXY_E_ROUTING     
    113 SIP-Start-Line: INVITE sip:+43xxxxyyyyy3@IPofMediaGatewayfacingMediation:58575 SIP/2.0     
    114 SIP-Call-ID: 6d9167a0-e0ad-4375-8325-9790ad7652c7     
    115 SIP-CSeq: 9 INVITE     
    116 $$end_record     
    117 TL_INFO(TF_DIAG) [1]15C4.23CC::03/17/2009-11:07:19.526.0011edb6 (SIPStack,SIPAdminLog::TraceDiagRecord:SIPAdminLog.cpp(144))$$begin_record     
    118 LogType: diagnostic     
    119 Severity: information     
    120 Text: Response successfully routed     
    121 SIP-Start-Line: SIP/2.0 100 Trying     
    122 SIP-Call-ID: 6d9167a0-e0ad-4375-8325-9790ad7652c7     
    123 SIP-CSeq: 9 INVITE     
    124 Peer: FQDNofMediation:53830     
    125 Data: destination="FQDNofMediation"    
    126 $$end_record     
    127 TL_INFO(TF_PROTOCOL) [1]15C4.23CC::03/17/2009-11:07:19.526.0011ede9 (SIPStack,SIPAdminLog::TraceProtocolRecord:SIPAdminLog.cpp(122))$$begin_record     
    128 Instance-Id: 00006D19     
    129 Direction: outgoing;source="local"    
    130 Peer: FQDNofMediation:53830     
    131 Message-Type: response     
    132 Start-Line: SIP/2.0 100 Trying     
    133 From: <sip:+43xxxxyyyyy4@SIPDomain.com;user=phone>;epid=BEDCB615BF;tag=bd6122cdf     
    134 To: <sip:+43xxxxyyyyy3@SIPDomain.com;user=phone>     
    135 CSeq: 9 INVITE     
    136 Call-ID: 6d9167a0-e0ad-4375-8325-9790ad7652c7     
    137 Via: SIP/2.0/TLS IPofMediationfacingFE:53830;branch=z9hG4bKa3a8e4e8;received=IPofLBfacingFE;ms-received-port=53830;ms-received-cid=456400     
    138 Content-Length: 0     
    139 Message-Body: â€“     
    140 $$end_record     
    141 TL_INFO(TF_DIAG) [1]15C4.23CC::03/17/2009-11:07:19.526.0011f29b (SIPStack,SIPAdminLog::TraceDiagRecord:SIPAdminLog.cpp(144))$$begin_record     
    142 LogType: diagnostic     
    143 Severity: information     
    144 Text: Response successfully routed     
    145 SIP-Start-Line: SIP/2.0 504 Server time-out    
    146 SIP-Call-ID: 6d9167a0-e0ad-4375-8325-9790ad7652c7     
    147 SIP-CSeq: 9 INVITE     
    148 Peer: FQDNofMediation:53830     
    149 Data: destination="FQDNofMediation"    
    150 $$end_record     
    151 TL_INFO(TF_PROTOCOL) [1]15C4.23CC::03/17/2009-11:07:19.526.0011f2d0 (SIPStack,SIPAdminLog::TraceProtocolRecord:SIPAdminLog.cpp(122))$$begin_record     
    152 Instance-Id: 00006D1B     
    153 Direction: outgoing;source="local"    
    154 Peer: FQDNofMediation:53830     
    155 Message-Type: response     
    156 Start-Line: SIP/2.0 504 Server time-out    
    157 From: <sip:+43xxxxyyyyy4@SIPDomain.com;user=phone>;epid=BEDCB615BF;tag=bd6122cdf     
    158 To: <sip:+43xxxxyyyyy3@SIPDomain.com;user=phone>;tag=21522874457B9D709346D90A44378DC5     
    159 CSeq: 9 INVITE     
    160 Call-ID: 6d9167a0-e0ad-4375-8325-9790ad7652c7     
    161 Via: SIP/2.0/TLS IPofMediationfacingFE:53830;branch=z9hG4bKa3a8e4e8;received=IPofLBfacingFE;ms-received-port=53830;ms-received-cid=456400     
    162 ms-diagnostics: 1022;reason="Cannot process routing destination";source="FE2.ForestFQDN";Destination="sip:+43xxxxyyyyy3@IPofMediaGatewayfacingMediation:58575"    
    163 Content-Length: 0     
    164 Message-Body: â€“     
    165 $$end_record     
    166 TL_INFO(TF_PROTOCOL) [5]15C4.1F84::03/17/2009-11:07:19.729.001200e1 (SIPStack,SIPAdminLog::TraceProtocolRecord:SIPAdminLog.cpp(122))$$begin_record     
    167 Instance-Id: 00006D20     
    168 Direction: incoming     
    169 Peer: FQDNofMediation:53830     
    170 Message-Type: request     
    171 Start-Line: ACK sip:+43xxxxyyyyy3@SIPDomain.com;user=phone SIP/2.0     
    172 From: <sip:+43xxxxyyyyy4@SIPDomain.com;user=phone>;tag=bd6122cdf;epid=BEDCB615BF     
    173 To: <sip:+43xxxxyyyyy3@SIPDomain.com;user=phone>;tag=21522874457B9D709346D90A44378DC5     
    174 CSeq: 9 ACK     
    175 Call-ID: 6d9167a0-e0ad-4375-8325-9790ad7652c7     
    176 MAX-FORWARDS: 70     
    177 VIA: SIP/2.0/TLS IPofMediationfacingFE:53830;branch=z9hG4bKa3a8e4e8     
    178 ROUTE: <sip:+43xxxxyyyyy3@IPofMediaGatewayfacingMediation:58575>;privacy=off     
    179 CONTENT-LENGTH: 0     
    180 Message-Body: â€“     
    181 $$end_record   

    When I pick up the call with the test set, I get a 415 "Unsupported Media Type but the call is connected successfully. I don´t know if there is any audio because I cannot connect a Headset to the server as it has no audiocard installed.

    I have also looked at the Normalization Rules and the routes in the voice properties. I have also tested them with the Enterprise Voice Route Helper. The number I call resolves to the user that is signed in at the tanjay phone & status set to available.

    Here is the traget regular expression for the internal route with the mediation server assigned.

    ^\+43xxxxyyy(\d{3})$

    This is the phone pattern regular expression in the normalization rule:

    ^(\d{3})$

    And the Translation pattern regular expression:

    +43xxxxyyy$1

    Internal enterprise extension and use translation when dialing from device are checked.
    Optimize device dialing is not checked.

    Any further suggestions are welcome.


    Tuesday, March 17, 2009 11:32 AM