ARR 502.3 only during a POST [Answered]RSS

9 replies

Last post Jul 21, 2011 03:10 PM by HelpRequired

  • ARR 502.3 only during a POST

    Apr 20, 2011 05:13 PM|billan|LINK

    I have configured ARR\URL rewrite to perform a simple proxy to a backend resource. Everything is working great until I navigate the backend site. All GET requests are processed but if I perform a POST I get a gateway error. I have enabled request tracing and I have added the section below. Any help would be greatly appreciated. Thanks!

    Is the real error "reached the end of the file"?

    Error from below (some data changed to remove server names etc):

    136. i GENERAL_READ_ENTITY_END BytesReceived="0", ErrorCode="Reached the end of the file.
     (0x80070026)" 18:30:26.242
    137. i ARR_RESPONSE_HEADERS_START  18:30:26.242
    138. r MODULE_SET_RESPONSE_ERROR_STATUS
    Warning ModuleName="ApplicationRequestRouting", Notification="EXECUTE_REQUEST_HANDLER", HttpStatus="502", HttpReason="Bad Gateway", HttpSubStatus="3", ErrorCode="Reached the end of the file.
     (0x80070026)", ConfigExceptionInfo="" 18:30:26.242
    139. r SET_RESPONSE_ERROR_DESCRIPTION

    More Info:

     100. — NOTIFY_MODULE_START ModuleName="ApplicationRequestRouting", Notification="MAP_REQUEST_HANDLER", fIsPostNotification="false" 18:30:26.242
    101. i ARR_WEBFARM_NOT_ROUTED HostName="rscrmbidv01" 18:30:26.242
    102. i HANDLER_CHANGED OldHandlerName="StaticFile", NewHandlerName="ApplicationRequestRoutingHandler", NewHandlerModules="ApplicationRequestRouting", NewHandlerScriptProcessor="", NewHandlerType="" 18:30:26.242
    103. — GENERAL_SET_REQUEST_HEADER HeaderName="Max-Forwards", HeaderValue="10", Replace="true" 18:30:26.242
    104. — GENERAL_SET_REQUEST_HEADER HeaderName="Host", HeaderValue="rscrmbidv01", Replace="true" 18:30:26.242
    105. — GENERAL_SET_REQUEST_HEADER HeaderName="X-Forwarded-For", HeaderValue="0.0.0.43, 1.1.11.214:58213", Replace="true" 18:30:26.242
    106. — GENERAL_SET_REQUEST_HEADER HeaderName="X-ARR-SSL", HeaderValue="", Replace="true" 18:30:26.242
    107. — GENERAL_SET_REQUEST_HEADER HeaderName="X-ARR-ClientCert", HeaderValue="", Replace="true" 18:30:26.242
    108. — GENERAL_SET_REQUEST_HEADER HeaderName="X-ARR-LOG-ID", HeaderValue="d55415ee-495f-4c67-8d69-57c46dab67d6", Replace="true" 18:30:26.242
    109. — GENERAL_SET_REQUEST_HEADER HeaderName="Connection", HeaderValue="", Replace="true" 18:30:26.242
    110. i URL_CHANGED OldUrl="http://servera/analytics/saw.dll?PortalGo&_scid=iPiF2RMUj70", NewUrl="/analytics/saw.dll?PortalGo&_scid=iPiF2RMUj70" 18:30:26.242
    111. — NOTIFY_MODULE_END ModuleName="ApplicationRequestRouting", Notification="MAP_REQUEST_HANDLER", fIsPostNotificationEvent="false", NotificationStatus="NOTIFICATION_CONTINUE" 18:30:26.242
    112. — NOTIFY_MODULE_START ModuleName="StaticCompressionModule", Notification="MAP_REQUEST_HANDLER", fIsPostNotification="false" 18:30:26.242
    113. — NOTIFY_MODULE_END ModuleName="StaticCompressionModule", Notification="MAP_REQUEST_HANDLER", fIsPostNotificationEvent="false", NotificationStatus="NOTIFICATION_CONTINUE" 18:30:26.242
    114. — NOTIFY_MODULE_START ModuleName="HttpRedirectionModule", Notification="MAP_REQUEST_HANDLER", fIsPostNotification="false" 18:30:26.242
    115. — NOTIFY_MODULE_END ModuleName="HttpRedirectionModule", Notification="MAP_REQUEST_HANDLER", fIsPostNotificationEvent="false", NotificationStatus="NOTIFICATION_CONTINUE" 18:30:26.242
    116. — NOTIFY_MODULE_START ModuleName="ManagedPipelineHandler", Notification="MAP_REQUEST_HANDLER", fIsPostNotification="false" 18:30:26.242
    117. — NOTIFY_MODULE_END ModuleName="ManagedPipelineHandler", Notification="MAP_REQUEST_HANDLER", fIsPostNotificationEvent="false", NotificationStatus="NOTIFICATION_CONTINUE" 18:30:26.242
    118. — NOTIFY_MODULE_START ModuleName="MediaRequestSessionModule", Notification="MAP_REQUEST_HANDLER", fIsPostNotification="true" 18:30:26.242
    119. — AspNetPipelineEnter Data1="Sitecore.Resources.Media.MediaRequestSessionModule" 18:30:26.242
    120. — AspNetPipelineLeave Data1="Sitecore.Resources.Media.MediaRequestSessionModule" 18:30:26.242
    121. — NOTIFY_MODULE_END ModuleName="MediaRequestSessionModule", Notification="MAP_REQUEST_HANDLER", fIsPostNotificationEvent="true", NotificationStatus="NOTIFICATION_CONTINUE" 18:30:26.242
    122. — NOTIFY_MODULE_START ModuleName="Session", Notification="REQUEST_ACQUIRE_STATE", fIsPostNotification="false" 18:30:26.242
    123. — AspNetPipelineEnter Data1="System.Web.SessionState.SessionStateModule" 18:30:26.242
    124. i AspNetSessionDataBegin  18:30:26.242
    125. i AspNetSessionDataEnd  18:30:26.242
    126. — AspNetPipelineLeave Data1="System.Web.SessionState.SessionStateModule" 18:30:26.242
    127. — NOTIFY_MODULE_END ModuleName="Session", Notification="REQUEST_ACQUIRE_STATE", fIsPostNotificationEvent="false", NotificationStatus="NOTIFICATION_CONTINUE" 18:30:26.242
    128. — NOTIFY_MODULE_START ModuleName="SitecoreHttpModule", Notification="PRE_EXECUTE_REQUEST_HANDLER", fIsPostNotification="false" 18:30:26.242
    129. — AspNetPipelineEnter Data1="Sitecore.Nexus.Web.HttpModule" 18:30:26.242
    130. — AspNetPipelineLeave Data1="Sitecore.Nexus.Web.HttpModule" 18:30:26.242
    131. — NOTIFY_MODULE_END ModuleName="SitecoreHttpModule", Notification="PRE_EXECUTE_REQUEST_HANDLER", fIsPostNotificationEvent="false", NotificationStatus="NOTIFICATION_CONTINUE" 18:30:26.242
    132. — NOTIFY_MODULE_START ModuleName="ApplicationRequestRouting", Notification="EXECUTE_REQUEST_HANDLER", fIsPostNotification="false" 18:30:26.242
    133. i ARR_REQUEST_HEADERS_START  18:30:26.242
    134. i ARR_REQUEST_HEADERS_END  18:30:26.242
    135. i GENERAL_READ_ENTITY_START  18:30:26.242
    136. i GENERAL_READ_ENTITY_END BytesReceived="0", ErrorCode="Reached the end of the file.
     (0x80070026)" 18:30:26.242
    137. i ARR_RESPONSE_HEADERS_START  18:30:26.242
    138. r MODULE_SET_RESPONSE_ERROR_STATUS
    Warning ModuleName="ApplicationRequestRouting", Notification="EXECUTE_REQUEST_HANDLER", HttpStatus="502", HttpReason="Bad Gateway", HttpSubStatus="3", ErrorCode="Reached the end of the file.
     (0x80070026)", ConfigExceptionInfo="" 18:30:26.242
    139. r SET_RESPONSE_ERROR_DESCRIPTION
    Warning

  • Re: ARR 502.3 only during a POST

    Apr 21, 2011 05:55 PM|abadincrotch|LINK

    Is there a 303 redirect in play by any chance?
    Microsoft Community Contributor

    MCTS: Service Communication Applications
  • Re: ARR 502.3 only during a POST

    Apr 24, 2011 11:27 PM|billan|LINK

    Sorry for the late reply. I didn't get notified by the forum that someone replied even though I have it configured to email me.

    I do not think there is a redirect but I will have to trace it and see. It's IIS talking to Siebel BI on the backend. There "drill down" links are posts that are javascript controlled. All other links besides the report drill downs work.

    Also when this happens it crashes the app pool.

  • Re: ARR 502.3 only during a POST

    Apr 24, 2011 11:29 PM|billan|LINK

    Also if it matters the site is running over SSL but the proxy is to a backend resource over HTTP.

    Thanks!

  • Re: ARR 502.3 only during a POST

    Apr 25, 2011 07:35 AM|abadincrotch|LINK

    How are you offloading/terminating SSL? Any chance you have certs on two machines that both reflect the same common name (domain) but aren't the same cert? And yeah, I've never seen notification work on these forums unfortunately.
    Microsoft Community Contributor

    MCTS: Service Communication Applications
  • Re: ARR 502.3 only during a POST

    Apr 25, 2011 07:36 AM|abadincrotch|LINK

    oh, also, try increasing the timeout in ARR proxy config, if ARR times out before the content server finishes responding, you can get a 502.3 also I believe.
    Microsoft Community Contributor

    MCTS: Service Communication Applications
  • Re: ARR 502.3 only during a POST

    Apr 25, 2011 07:39 AM|abadincrotch|LINK

    annnd, one more thing to try: changing the buffer configuration in ARR as well. There are two different values, response buffer and response buffer threshold. I would start by trying to increase the threshold to half or the same value as the buffer, then possibly try increasing the buffer. Mileage may vary.
    Microsoft Community Contributor

    MCTS: Service Communication Applications
  • Re: ARR 502.3 only during a POST

    Jul 21, 2011 03:57 AM|HelpRequired|LINK

    Having exactly the same problem, but am trying to access ADFS 2.0 behind ARR.

    Has anyone solved this issue, if so, can you post exactly what you did to resolve it

    ARR Redirecteached the end of the file 502.3

  • rob_p rob_p

    17 Posts

    Microsoft

    Re: ARR 502.3 only during a POST

    Jul 21, 2011 03:00 PM|rob_p|LINK

     A network trace would be your best bet. Verify that the client, ARR, and the backend server are all sending the amount of data the headers say they are sending. Also, you mentioned that the app pool crashes- do you mean on the ARR server, or the backend server?

    -rob

  • Re: ARR 502.3 only during a POST

    Jul 21, 2011 03:10 PM|HelpRequired|LINK

     I think this is a kerberos authentication is the issue. Today I stopped using ARR and reverted to using NLB instead. I managed with a bit of help from the DelegConfig tool, to enable kerberos authentication successfully when accessing the service using the NetBios name, however it fails when I try to use the FQDN

    e.g

    NetBios works  using http://web01/Site/Service.svc

    FQDN fails using http://web01.domain.com/Site/Service.svc

    I think this may be what is causing the issue. In saying that ARR should not crash. On the ARR controller the requestRouter.dll faults, causing the w3wp.exe to crash

     

    Does anybody else have any further thoughts. I suspect that the error we are seeing occurs for a number of failure conditions

     

    kerberos NetBios FQDN