Tek-Tips is the largest IT community on the Internet today!

Members share and learn making Tek-Tips Forums the best source of peer-reviewed technical information on the Internet!

  • Congratulations SkipVought on being selected by the Tek-Tips community for having the most helpful posts in the forums last week. Way to Go!

Timeout on Huge report. 1

Status
Not open for further replies.

ddrafts

IS-IT--Management
Dec 26, 2002
119
0
0
US
I'm running a custom report on SQL 2005. If I run the report for one week it is OK. If I choose a month it times out.

We have changed several timeout values that we have found on the internet but are still having the problem.

In the executionlog table I'm showing time processing for the week at 226 and time rendering at 396. For the month I get time processing 40,677 and no time rendering. This is for PDF, XLS, and CSV. The status of all three is rsProcessingAborted.

Here is a copy of the ReportServer log. If anyone can help.

<Header>
<Product>Microsoft SQL Server Reporting Services Version 9.00.3042.00</Product>
<Locale>en-US</Locale>
<TimeZone>Eastern Daylight Time</TimeZone>
<Path>c:\Program Files\Microsoft SQL Server\MSSQL.3\Reporting Services\LogFiles\ReportServer__07_21_2010_08_36_05.log</Path>
<SystemName>IVR-TLH-DB03</SystemName>
<OSName>Microsoft Windows NT 5.2.3790 Service Pack 2</OSName>
<OSVersion>5.2.3790.131072</OSVersion>
</Header>
w3wp!webserver!1!7/21/2010-08:36:05:: i INFO: Reporting Web Server started
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing ConnectionType to '0' as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing IsSchedulingService to 'True' as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing IsNotificationService to 'True' as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing IsEventService to 'True' as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing PollingInterval to '10' second(s) as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing WindowsServiceUseFileShareStorage to 'False' as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing MemoryLimit to '60' percent as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing RecycleTime to '720' minute(s) as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing MaximumMemoryLimit to '80' percent as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing MaxAppDomainUnloadTime to '30' minute(s) as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing MaxQueueThreads to '0' thread(s) as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing IsWebServiceEnabled to 'True' as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing MaxActiveReqForOneUser to '20' requests(s) as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing MaxScheduleWait to '5' second(s) as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing DatabaseQueryTimeout to '920' second(s) as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing ProcessRecycleOptions to '0' as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing RunningRequestsScavengerCycle to '90' second(s) as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing RunningRequestsDbCycle to '120' second(s) as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing RunningRequestsAge to '30' second(s) as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing CleanupCycleMinutes to '10' minute(s) as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing DailyCleanupMinuteOfDay to default value of '120' minutes since midnight because it was not specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing WatsonFlags to '1064' as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing WatsonDumpOnExceptions to 'Microsoft.ReportingServices.Diagnostics.Utilities.InternalCatalogException,Microsoft.ReportingServices.Modeling.InternalModelingException' as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing WatsonDumpExcludeIfContainsExceptions to 'System.Data.SqlClient.SqlException,System.Threading.ThreadAbortException' as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing SecureConnectionLevel to '0' as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing DisplayErrorLink to 'True' as specified in Configuration file.
w3wp!library!1!7/21/2010-08:36:05:: i INFO: Initializing WebServiceUseFileShareStorage to 'False' as specified in Configuration file.
w3wp!resourceutilities!1!7/21/2010-08:36:05:: i INFO: Reporting Services starting SKU: Standard
w3wp!resourceutilities!1!7/21/2010-08:36:05:: i INFO: Evaluation copy: 0 days left
w3wp!resourceutilities!1!7/21/2010-08:36:05:: i INFO: Running on 2 physical processors, 8 logical processors
w3wp!runningjobs!1!7/21/2010-08:36:05:: i INFO: Database Cleanup (Web Service) timer enabled: Next Event: 600 seconds. Cycle: 600 seconds
w3wp!runningjobs!1!7/21/2010-08:36:05:: i INFO: Running Requests Scavenger timer enabled: Next Event: 90 seconds. Cycle: 90 seconds
w3wp!runningjobs!1!7/21/2010-08:36:05:: i INFO: Running Requests DB timer enabled: Next Event: 120 seconds. Cycle: 120 seconds
w3wp!runningjobs!1!7/21/2010-08:36:05:: i INFO: Memory stats update timer enabled: Next Event: 60 seconds. Cycle: 60 seconds
w3wp!library!1!07/21/2010-08:36:06:: Call to GetItemTypeAction(/).
w3wp!library!1!07/21/2010-08:36:06:: i INFO: Catalog SQL Server Edition = Standard
w3wp!library!1!07/21/2010-08:36:06:: Call to ListParentsAction(/).
w3wp!library!1!07/21/2010-08:36:06:: Call to ListChildrenAction(/, False).
w3wp!webserver!1!07/21/2010-08:36:06:: i INFO: Processed folder '/'
w3wp!library!8!07/21/2010-08:36:17:: Call to ListParentsAction(/ASM).
w3wp!library!8!07/21/2010-08:36:17:: Call to ListParentsAction(/ASM).
w3wp!library!8!07/21/2010-08:36:18:: Call to ListChildrenAction(/ASM, False).
w3wp!webserver!8!07/21/2010-08:36:18:: i INFO: Processed folder '/ASM'
w3wp!library!a!07/21/2010-08:36:20:: Call to GetDataSourceContentsAction(/ASM/ASM Data Extension).
w3wp!library!6!07/21/2010-08:36:38:: Call to GetPermissionsAction(/).
w3wp!library!6!07/21/2010-08:36:38:: Call to GetPropertiesAction(/, PathBased).
w3wp!library!6!07/21/2010-08:36:41:: Call to GetSystemPermissionsAction().
w3wp!library!1!07/21/2010-08:36:44:: Call to ListChildrenAction(/, False).
w3wp!library!1!07/21/2010-08:36:44:: Call to GetSystemPropertiesAction().
w3wp!library!1!07/21/2010-08:36:45:: Call to GetSystemPropertiesAction().
w3wp!library!a!07/21/2010-08:42:56:: Call to GetPermissionsAction(/ASM).
w3wp!library!a!07/21/2010-08:42:56:: Call to GetPropertiesAction(/ASM, PathBased).
w3wp!library!a!07/21/2010-08:42:56:: Call to GetSystemPermissionsAction().
w3wp!library!a!07/21/2010-08:42:56:: Call to ListChildrenAction(/ASM, False).
w3wp!library!a!07/21/2010-08:42:56:: Call to GetSystemPropertiesAction().
w3wp!library!6!07/21/2010-08:42:56:: Call to GetSystemPropertiesAction().
w3wp!library!6!07/21/2010-08:44:56:: i INFO: Call to RenderFirst( '/ASM/Selected Event Summary Report' )
w3wp!processing!6!7/21/2010-08:45:38:: e ERROR: Throwing Microsoft.ReportingServices.ReportProcessing.ReportProcessingException: Query execution failed for data set 'ASM_Data_Extension'., ;
Info: Microsoft.ReportingServices.ReportProcessing.ReportProcessingException: Query execution failed for data set 'ASM_Data_Extension'. ---> System.ApplicationException: Plugin 'C:\AccessNet\Bin.NET\AccessNet.ASM.RSProvider.dll' threw error: Error processing request for report [SELECTEDEVENTCOUNT]: 'Reading data from database failed.: 'Timeout expired''
at AccessNet.ASM.RSDataReader.LoadDataSet()
at AccessNet.ASM.RSCommand.ExecuteReader(CommandBehavior behavior)
at Microsoft.ReportingServices.ReportProcessing.ReportProcessing.RuntimeDataSetNode.RunDataSetQuery()
--- End of inner exception stack trace ---
w3wp!processing!6!7/21/2010-08:45:38:: e ERROR: An exception has occurred in data source 'ASM_Data_Extension'. Details: Microsoft.ReportingServices.ReportProcessing.ReportProcessingException: Query execution failed for data set 'ASM_Data_Extension'. ---> System.ApplicationException: Plugin 'C:\AccessNet\Bin.NET\AccessNet.ASM.RSProvider.dll' threw error: Error processing request for report [SELECTEDEVENTCOUNT]: 'Reading data from database failed.: 'Timeout expired''
w3wp!processing!6!7/21/2010-08:45:38:: i INFO: Merge abort handler called for ID=-1. Aborting data sources ...
w3wp!processing!6!7/21/2010-08:45:39:: e ERROR: Exception in abort callback. Details: System.NotImplementedException: The method or operation is not implemented.
at AccessNet.ASM.RSCommand.Cancel()
at Microsoft.ReportingServices.ReportProcessing.ReportProcessing.RuntimeDataSetNode.Abort()
at Microsoft.ReportingServices.ReportProcessing.ReportProcessing.RuntimeDataSourceNode.Abort()
at Microsoft.ReportingServices.ReportProcessing.ReportProcessing.Merge.AbortHandler(Object sender, EventArgs e)
at Microsoft.ReportingServices.ReportProcessing.ReportProcessing.ProcessingContext.AbortHelper.Abort(Int32 reportUniqueName, ProcessingStatus status)
w3wp!processing!6!7/21/2010-08:45:39:: e ERROR: Throwing Microsoft.ReportingServices.ReportProcessing.ProcessingAbortedException: An error has occurred during report processing., ;
Info: Microsoft.ReportingServices.ReportProcessing.ProcessingAbortedException: An error has occurred during report processing.
w3wp!processing!6!7/21/2010-08:45:39:: w WARN: Data source 'ASM Data Extension': Report processing has been aborted.
w3wp!processing!6!7/21/2010-08:45:39:: e ERROR: Throwing Microsoft.ReportingServices.ReportProcessing.ProcessingAbortedException: An error has occurred during report processing., ;
Info: Microsoft.ReportingServices.ReportProcessing.ProcessingAbortedException: An error has occurred during report processing.
w3wp!webserver!6!07/21/2010-08:45:46:: e ERROR: Reporting Services error Microsoft.ReportingServices.Diagnostics.Utilities.RSException: An error has occurred during report processing. ---> Microsoft.ReportingServices.ReportProcessing.ProcessingAbortedException: An error has occurred during report processing.
w3wp!library!6!07/21/2010-08:45:46:: i INFO: Call to RenderFirst( '/ASM/Selected Event Summary Report' )
w3wp!library!1!7/21/2010-08:46:05:: i INFO: Cleaned 0 batch records, 0 policies, 0 sessions, 0 cache entries, 0 snapshots, 0 chunks, 0 running jobs, 0 persisted streams
w3wp!processing!6!7/21/2010-08:46:19:: e ERROR: Throwing Microsoft.ReportingServices.ReportProcessing.ReportProcessingException: Query execution failed for data set 'ASM_Data_Extension'., ;
Info: Microsoft.ReportingServices.ReportProcessing.ReportProcessingException: Query execution failed for data set 'ASM_Data_Extension'. ---> System.ApplicationException: Plugin 'C:\AccessNet\Bin.NET\AccessNet.ASM.RSProvider.dll' threw error: Error processing request for report [SELECTEDEVENTCOUNT]: 'Reading data from database failed.: 'Timeout expired''
at AccessNet.ASM.RSDataReader.LoadDataSet()
at AccessNet.ASM.RSCommand.ExecuteReader(CommandBehavior behavior)
at Microsoft.ReportingServices.ReportProcessing.ReportProcessing.RuntimeDataSetNode.RunDataSetQuery()
--- End of inner exception stack trace ---
w3wp!processing!6!7/21/2010-08:46:19:: e ERROR: An exception has occurred in data source 'ASM_Data_Extension'. Details: Microsoft.ReportingServices.ReportProcessing.ReportProcessingException: Query execution failed for data set 'ASM_Data_Extension'. ---> System.ApplicationException: Plugin 'C:\AccessNet\Bin.NET\AccessNet.ASM.RSProvider.dll' threw error: Error processing request for report [SELECTEDEVENTCOUNT]: 'Reading data from database failed.: 'Timeout expired''
w3wp!processing!6!7/21/2010-08:46:19:: i INFO: Merge abort handler called for ID=-1. Aborting data sources ...
w3wp!processing!6!7/21/2010-08:46:19:: e ERROR: Exception in abort callback. Details: System.NotImplementedException: The method or operation is not implemented.
at AccessNet.ASM.RSCommand.Cancel()
at Microsoft.ReportingServices.ReportProcessing.ReportProcessing.RuntimeDataSetNode.Abort()
at Microsoft.ReportingServices.ReportProcessing.ReportProcessing.RuntimeDataSourceNode.Abort()
at Microsoft.ReportingServices.ReportProcessing.ReportProcessing.Merge.AbortHandler(Object sender, EventArgs e)
at Microsoft.ReportingServices.ReportProcessing.ReportProcessing.ProcessingContext.AbortHelper.Abort(Int32 reportUniqueName, ProcessingStatus status)
w3wp!processing!6!7/21/2010-08:46:19:: e ERROR: Throwing Microsoft.ReportingServices.ReportProcessing.ProcessingAbortedException: An error has occurred during report processing., ;
Info: Microsoft.ReportingServices.ReportProcessing.ProcessingAbortedException: An error has occurred during report processing.
w3wp!processing!6!7/21/2010-08:46:19:: w WARN: Data source 'ASM Data Extension': Report processing has been aborted.
w3wp!processing!6!7/21/2010-08:46:19:: e ERROR: Throwing Microsoft.ReportingServices.ReportProcessing.ProcessingAbortedException: An error has occurred during report processing., ;
Info: Microsoft.ReportingServices.ReportProcessing.ProcessingAbortedException: An error has occurred during report processing.
w3wp!webserver!6!07/21/2010-08:46:19:: e ERROR: Reporting Services error Microsoft.ReportingServices.Diagnostics.Utilities.RSException: An error has occurred during report processing. ---> Microsoft.ReportingServices.ReportProcessing.ProcessingAbortedException: An error has occurred during report processing.
w3wp!library!6!07/21/2010-08:46:19:: i INFO: Call to RenderFirst( '/ASM/Selected Event Summary Report' )
w3wp!processing!6!7/21/2010-08:47:00:: e ERROR: Throwing Microsoft.ReportingServices.ReportProcessing.ReportProcessingException: Query execution failed for data set 'ASM_Data_Extension'., ;
Info: Microsoft.ReportingServices.ReportProcessing.ReportProcessingException: Query execution failed for data set 'ASM_Data_Extension'. ---> System.ApplicationException: Plugin 'C:\AccessNet\Bin.NET\AccessNet.ASM.RSProvider.dll' threw error: Error processing request for report [SELECTEDEVENTCOUNT]: 'Reading data from database failed.: 'Timeout expired''
at AccessNet.ASM.RSDataReader.LoadDataSet()
at AccessNet.ASM.RSCommand.ExecuteReader(CommandBehavior behavior)
at Microsoft.ReportingServices.ReportProcessing.ReportProcessing.RuntimeDataSetNode.RunDataSetQuery()
--- End of inner exception stack trace ---
w3wp!processing!6!7/21/2010-08:47:00:: e ERROR: An exception has occurred in data source 'ASM_Data_Extension'. Details: Microsoft.ReportingServices.ReportProcessing.ReportProcessingException: Query execution failed for data set 'ASM_Data_Extension'. ---> System.ApplicationException: Plugin 'C:\AccessNet\Bin.NET\AccessNet.ASM.RSProvider.dll' threw error: Error processing request for report [SELECTEDEVENTCOUNT]: 'Reading data from database failed.: 'Timeout expired''
w3wp!processing!6!7/21/2010-08:47:00:: i INFO: Merge abort handler called for ID=-1. Aborting data sources ...
w3wp!processing!6!7/21/2010-08:47:00:: e ERROR: Exception in abort callback. Details: System.NotImplementedException: The method or operation is not implemented.
at AccessNet.ASM.RSCommand.Cancel()
at Microsoft.ReportingServices.ReportProcessing.ReportProcessing.RuntimeDataSetNode.Abort()
at Microsoft.ReportingServices.ReportProcessing.ReportProcessing.RuntimeDataSourceNode.Abort()
at Microsoft.ReportingServices.ReportProcessing.ReportProcessing.Merge.AbortHandler(Object sender, EventArgs e)
at Microsoft.ReportingServices.ReportProcessing.ReportProcessing.ProcessingContext.AbortHelper.Abort(Int32 reportUniqueName, ProcessingStatus status)
w3wp!processing!6!7/21/2010-08:47:00:: e ERROR: Throwing Microsoft.ReportingServices.ReportProcessing.ProcessingAbortedException: An error has occurred during report processing., ;
Info: Microsoft.ReportingServices.ReportProcessing.ProcessingAbortedException: An error has occurred during report processing.
w3wp!processing!6!7/21/2010-08:47:00:: w WARN: Data source 'ASM Data Extension': Report processing has been aborted.
w3wp!processing!6!7/21/2010-08:47:00:: e ERROR: Throwing Microsoft.ReportingServices.ReportProcessing.ProcessingAbortedException: An error has occurred during report processing., ;
Info: Microsoft.ReportingServices.ReportProcessing.ProcessingAbortedException: An error has occurred during report processing.
w3wp!webserver!6!07/21/2010-08:47:00:: e ERROR: Reporting Services error Microsoft.ReportingServices.Diagnostics.Utilities.RSException: An error has occurred during report processing. ---> Microsoft.ReportingServices.ReportProcessing.ProcessingAbortedException: An error has occurred during report processing.
 
Looks like the timeout is related to getting the data from the database rather than rendering the report

You have 3 timeout options to look at here:

Connection Timeout
Execution Timeout
ReportServer Session Timeout

1st question would be can you run the query directly on the server?

2nd question would be how you are running the report? Through report manager? Via reportviewer control in an ASP page? Subscription?

Rgds, Geoff

We could learn a lot from crayons. Some are sharp, some are pretty and some are dull. Some have weird names and all are different colours but they all live in the same box.

Please read FAQ222-2244 before you ask a question
 
Geoff,

Thanks for the reply.

If I run the querey on the server it compleats in about 1 min 45 sec. For the Month report.

The reports are ran through our custom ASP pages.
 
Are you using the reportviewer control in the custom ASP pages? That has its own seperate timeout

there is also the session timeout of the report - you can utilise that by adding rs:clearsession=true to your url. May also be worth looking at rs:Command=ResetSessionTimeout

Also, depending on what app the report has been developed in, does it work in preview mode there (ie is it just when running through shared data sources on the server that it has an issue? - data sources could be configured deifferently on the server compared to the local ones int he dev environment?)

all in all, I am thinking that this is to do with the connection to the server as the error is thrown before the report even starts being rendered

Rgds, Geoff

We could learn a lot from crayons. Some are sharp, some are pretty and some are dull. Some have weird names and all are different colours but they all live in the same box.

Please read FAQ222-2244 before you ask a question
 
Status
Not open for further replies.

Part and Inventory Search

Sponsor

Back
Top