Inconsistent performance in rendering reports in SSRS 2008 R2
My company ran into the same issues when we installed R2 where we saw the same type of inconsistent report rendering. We noticed that CPU utilization and or memory was not releasing when certain reports would render. We ran into so many issues with the R2 install that we had to roll back.. Here is one of the links I had with one of the MS developers: http://social.msdn.microsoft.com/Forums/en-US/sqlreportingservices/thread/dcc27ec8-060e-4ede-954a-9eeaee33b93e The other item that was brought up was if the original reports were done via SSRS 2000 =>SSRS 2005 and then converted to 2008, there was an issue with the upgrade. If the reports were from SSRS 2000 to SSRS 2008, there was no issue with the upgrade. So yes there is definitly something up with R2 since its original release but I am not sure if things have been updated/fixed. Have not had the time to rebuild a new R2 server... Hope this helps
February 14th, 2011 4:41pm

We have been experiencing inconsistent performance in SSRS 2008 R2 when rendering reports from an SSAS 2008 R2 data source. I have tried to isolate the issue from web server configuration by running reports directly from the SSRS server, but the results remain the same: a report with the same parameters will execute in 1-2 seconds on first and second attempts but, thereafter, may take up to 60 seconds to render. the same report consistently executes in under 2 seconds in a similarly configured Staging environment. User load and resource contention are not likely to be relevant factors as the service is still in a pre-GoLive testing phase. Thank you in advance for your help. Regards dvc
Free Windows Admin Tool Kit Click here and download it now
February 14th, 2011 5:10pm

Hi Dvc, A query plan and multiple associated execution contexts can coexist in plan cache, so it will take less time in the following execution. Besides, you could troubleshoot report performance using Reporting Services log files to determine where most of the time is being spent: in retrieving data, in processing the report layout, or in rendering the report. For more information, see Troubleshooting Techniques for Report Problems. After you determine where the most time is being spent, use the following sections to help troubleshoot specific issues. Improving Data Retrieval Performance Improving Report Processing Performance Improving Report Rendering Performance Thanks, Challen FuChallen Fu [MSFT] MSDN Community Support | Feedback to us Get or Request Code Sample from Microsoft Please remember to mark the replies as answers if they help and unmark them if they provide no help.
February 14th, 2011 10:50pm

Thank you very much for your reply. I am afraid, however, that we have followed all of these troubleshooting steps. There is no consistency in the data retrieval, processing and rendering data - all of these counters can vary between 200 milliseconds and 7200 milliseconds. The issue is this inconsistency when the server is not under load. The reports have all been created in 2008 R2 and they run consistently faster, without performance variation, on the SSRS instance in the Staging environment which has a very similar configuration. I note also that even when a report is cached, the time for the rendered report to display shows similar variations. The Reporting Services execution log typically shows this pattern for 3 successive executions of the same report, with overall execution time increasing each time: library!ReportServer_0-2!e8!02/15/2011-07:55:29:: Call to GetPermissionsAction(/Reports). library!ReportServer_0-2!e8!02/15/2011-07:55:29:: Call to GetPropertiesAction(/Reports, PathBased). library!ReportServer_0-2!e8!02/15/2011-07:55:29:: Call to GetPropertiesAction(/Reports, PathBased). library!ReportServer_0-2!e8!02/15/2011-07:55:29:: Call to GetSystemPermissionsAction(). library!ReportServer_0-2!e8!02/15/2011-07:55:29:: Call to ListChildrenAction(/Reports, False). library!ReportServer_0-2!e8!02/15/2011-07:55:29:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!e8!02/15/2011-07:55:29:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!e8!02/15/2011-07:55:29:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!e8!02/15/2011-07:55:29:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!e8!02/15/2011-07:55:33:: Call to GetPermissionsAction(/Reports/...). library!ReportServer_0-2!e8!02/15/2011-07:55:33:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!e8!02/15/2011-07:55:33:: Call to GetPropertiesAction(/Reports/..., PathBased). library!ReportServer_0-2!e8!02/15/2011-07:55:33:: Call to GetSystemPermissionsAction(). library!ReportServer_0-2!e8!02/15/2011-07:55:33:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!814!02/15/2011-07:55:34:: Call to GetPermissionsAction(/Reports/...). library!ReportServer_0-2!5a0!02/15/2011-07:55:34:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!5a0!02/15/2011-07:55:34:: Call to GetPropertiesAction(/Reports/..., PathBased). library!ReportServer_0-2!77c!02/15/2011-07:55:34:: Call to GetSystemPermissionsAction(). library!ReportServer_0-2!5a0!02/15/2011-07:55:34:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!77c!02/15/2011-07:55:34:: i INFO: RenderForNewSession('/Reports/...') webserver!ReportServer_0-2!77c!02/15/2011-07:55:34:: i INFO: Processed report. Report='/Reports/...', Stream='' library!ReportServer_0-2!e8!02/15/2011-07:55:37:: Call to GetPermissionsAction(/Reports). library!ReportServer_0-2!e8!02/15/2011-07:55:37:: Call to GetPropertiesAction(/Reports, PathBased). library!ReportServer_0-2!e8!02/15/2011-07:55:37:: Call to GetPropertiesAction(/Reports, PathBased). library!ReportServer_0-2!e8!02/15/2011-07:55:37:: Call to GetSystemPermissionsAction(). library!ReportServer_0-2!e8!02/15/2011-07:55:37:: Call to ListChildrenAction(/Reports, False). library!ReportServer_0-2!e8!02/15/2011-07:55:37:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!e8!02/15/2011-07:55:37:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!e8!02/15/2011-07:55:37:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!e8!02/15/2011-07:55:37:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!e8!02/15/2011-07:55:39:: Call to GetPermissionsAction(/Reports/...). library!ReportServer_0-2!e8!02/15/2011-07:55:39:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!e8!02/15/2011-07:55:39:: Call to GetPropertiesAction(/Reports/..., PathBased). library!ReportServer_0-2!e8!02/15/2011-07:55:39:: Call to GetSystemPermissionsAction(). library!ReportServer_0-2!e8!02/15/2011-07:55:40:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!b60!02/15/2011-07:56:04:: Call to GetPermissionsAction(/Reports/...). library!ReportServer_0-2!338!02/15/2011-07:56:04:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!338!02/15/2011-07:56:04:: Call to GetPropertiesAction(/Reports/..., PathBased). library!ReportServer_0-2!4b8!02/15/2011-07:56:04:: Call to GetSystemPermissionsAction(). library!ReportServer_0-2!338!02/15/2011-07:56:04:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!4b8!02/15/2011-07:56:05:: i INFO: RenderForNewSession('/Reports/...') webserver!ReportServer_0-2!4b8!02/15/2011-07:56:05:: i INFO: Processed report. Report='/Reports/...', Stream='' library!ReportServer_0-2!e8!02/15/2011-07:56:09:: Call to GetPermissionsAction(/Reports). library!ReportServer_0-2!e8!02/15/2011-07:56:09:: Call to GetPropertiesAction(/Reports, PathBased). library!ReportServer_0-2!e8!02/15/2011-07:56:09:: Call to GetPropertiesAction(/Reports, PathBased). library!ReportServer_0-2!e8!02/15/2011-07:56:09:: Call to GetSystemPermissionsAction(). library!ReportServer_0-2!e8!02/15/2011-07:56:09:: Call to ListChildrenAction(/Reports, False). library!ReportServer_0-2!e8!02/15/2011-07:56:09:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!e8!02/15/2011-07:56:09:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!e8!02/15/2011-07:56:09:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!e8!02/15/2011-07:56:09:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!e8!02/15/2011-07:56:12:: Call to GetPermissionsAction(/Reports/...). library!ReportServer_0-2!e8!02/15/2011-07:56:12:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!e8!02/15/2011-07:56:12:: Call to GetPropertiesAction(/Reports/..., PathBased). library!ReportServer_0-2!e8!02/15/2011-07:56:12:: Call to GetSystemPermissionsAction(). library!ReportServer_0-2!e8!02/15/2011-07:56:12:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!814!02/15/2011-07:56:55:: Call to GetPermissionsAction(/Reports/...). library!ReportServer_0-2!814!02/15/2011-07:56:55:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!77c!02/15/2011-07:56:55:: Call to GetPropertiesAction(/Reports/..., PathBased). library!ReportServer_0-2!338!02/15/2011-07:56:55:: Call to GetSystemPermissionsAction(). library!ReportServer_0-2!77c!02/15/2011-07:56:55:: Call to GetSystemPropertiesAction(). library!ReportServer_0-2!338!02/15/2011-07:56:55:: i INFO: RenderForNewSession('/Reports/...') webserver!ReportServer_0-2!338!02/15/2011-07:56:55:: i INFO: Processed report. Report='/Reports/...', Stream='' As you can see, there is a long delay in the 2nd and 3rd report runs after the Call to GetSystemPropertiesAction(). Has anyone else seen this behaviour? Thank you again for your help.
Free Windows Admin Tool Kit Click here and download it now
February 15th, 2011 9:10am

dvc, Did you ever resolve this problem? I am running into similar behaviour on one of my client sites. Thanks for your help. -HKM
May 6th, 2011 1:33pm

Hello, My apologies for not wrapping up this question with the resolution we identified for the problem. The issue was caused by tcp/ip port exhaustion on the affected windows 2008 r2 servers and was resolved by increasing the dynamic port range. It may be worth running netsh int ipv4 show dynamicportrange tcp to check on the allocated range. Hope this helps. dvc
Free Windows Admin Tool Kit Click here and download it now
July 3rd, 2011 7:25am

This topic is archived. No further replies will be accepted.

Other recent topics Other recent topics