17 Replies Latest reply: Jun 8, 2011 11:55 AM by thavasikumar RSS

    Failed to allocate Qlikview Engine

      Hi

       

      I am facing a problem where in none of the reports are getting refreshed on the server. The error log for every reload is similar to below:

       

      31041128 2011-05-24 10:50:00NormalInformation

      Trying to allocate a QlikView Engine. Current usagecount=8 of 8. Waiting max=5/24/2011 10:55:00 AM

      31041129 2011-05-24 10:50:00NormalWarning

      All QlikView Engines are in use, waiting maximum 300 seconds for one to get free..

      31041165 2011-05-24 10:55:00NormalError

      Failed to allocate a QlikView Engine.    

       

      I tried increasing the max number of qlikview engine count from 4 to 8 and still it continues giving me the same error.

       

      Any suggestions would be really helpful.

       

      Regards

      Kumar

        • Failed to allocate Qlikview Engine
          Rob Wunderlich

          It looks like you are on V8? The timeout is configurable in V9.

           

          For V8, your only choice is to reduce the scheduling overlap or increase the number of engines.

           

          -Rob

            • Failed to allocate Qlikview Engine

              Hi Rob,

               

              Thanks for your suggestion. I had increased the number of qlikview engines from 4 to 8 and then the usage count was still went up and none of the reports got refreshed.

               

              And every now and then the log files have the following error mentioned

               

              Reload failed Exception=%Exception Exception: System.Runtime.InteropServices.COMException (0x80004005): Error HRESULT E_FAIL has been returned from a call to a COM component.   at QlikView.Doc.Reload(Int32 _Mode)   at QVBWrapper.Document.Reload(Int32 i_ParentLogID, Object i_Partial)

               

              I am trying to work on why the log files are behaving so wierdly but not able to get the root cause of the problem.

               

              Thank you for the help.

               

              Regards

              Kumar

                • Failed to allocate Qlikview Engine

                  Hi...

                   

                  Some of the log files also display the following error:

                   

                  "The task Reload Hourly Graphs failed with an exception: System.NullReferenceException: Object reference not set to an instance of an object.
   at QVBWrapper.Document.Close(Int32 i_ParentLogID)
   at QVBWrapper.DocumentPool.Checkin(Int32 i_ParentLogID, Document i_Document)
   at XSMain.ReloadTask.InternalExecute()
   at XSMain.AbstractTask.InternalExecute2()"

                   

                  I am unable to debug the error. None of files are refreshing on the server. Any help would be great.

                   

                  Thank you.

                   

                  Regards

                  Kumar

                  • Re: Failed to allocate Qlikview Engine
                    Gyan Srivastava

                    Hi Kumar,

                     

                    Please check PF usage ( From Task Manager -->Performance Tab) , if that is maximum , then try restarting QVS service . and load the document again .

                     

                    If the document gets loaded successful.then It might be a proble of loading muliple documents in RAM .

                     

                    Please  check QEMC and go to 'QEMC-->System-->Setup-->Qlikview Servers-->QVS@ServerName-->Documents'

                     

                    and check 'Allow only one copy of document in memory' . this will help to resolve you query .

                     

                    Regards

                    Gyan

                      • Failed to allocate Qlikview Engine

                        Hi Gyan,

                         

                        I checked the PF usage and it seems to be within normal limits and no where near to the maximum. I restarted the QVS service as well.

                         

                        Then as you suggested, I checked the "Allow only one copy of document in memory" and the error still continues. Please have a look at the screenshot below.

                         

                        qvscontrolpanel.JPG

                         

                        I am not able to figure out the problem and thus, finding a solution is even more difficult. Really appreciate your help.

                         

                        Thanks a lot.

                         

                        Regards

                        Kumar

                        • Re: Failed to allocate Qlikview Engine
                          Stefan Bäckstrand

                          I don't think the "Allow only one document [..]" setting will change anything, especially since we have not established any root cause for the is sue. How do you configure something that you don't know will affect it?

                           

                          First of all; if a task fails, it doesn't necessarily mean that it's Publisher's fault. Have you looked in the qvw script log file? Is there any at all? What is the hardware specs on the machine? How does CPU usage look during the failed reload?

                            • Failed to allocate Qlikview Engine

                              Hi Stefan,

                               

                              I checked the qvw script log file as well. It just says general script error.

                               

                              6/1/2011 9:25:00 AM:      Execution started.

                              6/1/2011 9:25:00 AM:      QlikView Version:8.01.4783.11

                              6/1/2011 9:25:00 AM: 0002  SET ThousandSep=','

                              6/1/2011 9:25:00 AM: 0003  SET DecimalSep='.'

                              6/1/2011 9:25:00 AM: 0004  SET MoneyThousandSep=','

                              6/1/2011 9:25:00 AM: 0005  SET MoneyDecimalSep='.'

                              6/1/2011 9:25:00 AM: 0006  SET MoneyFormat='$#,##0.00;($#,##0.00)'

                              6/1/2011 9:25:00 AM: 0007  SET TimeFormat='h:mm:ss TT'

                              6/1/2011 9:25:00 AM: 0008  SET DateFormat='M/D/YYYY'

                              6/1/2011 9:25:00 AM: 0009  SET TimestampFormat='M/D/YYYY h:mm:ss[.fff] TT'

                              6/1/2011 9:25:00 AM: 0010  SET MonthNames='Jan;Feb;Mar;Apr;May;Jun;Jul;Aug;Sep;Oct;Nov;Dec'

                              6/1/2011 9:25:00 AM: 0011  SET DayNames='Mon;Tue;Wed;Thu;Fri;Sat;Sun'

                              6/1/2011 9:25:00 AM: 0014  ODBC CONNECT TO wfprd (XUserId is JeXPbYBOSbbIWCC, XPassword is WEfbOSFMCDbKXSNOSJEB)

                              6/1/2011 9:25:00 AM: 0020  SELECT count(psr.OID) TODAY_ORDERS,

                              6/1/2011 9:25:00 AM: 0021         to_char(psr.req_date, 'HH24') HOUROFDAY,

                              6/1/2011 9:25:00 AM: 0022         trunc(psr.req_date) PLACEDATE,

                              6/1/2011 9:25:00 AM: 0023         scp.prov_name PROVIDER,

                              6/1/2011 9:25:00 AM: 0024         'QC' || scp.oid PROVIDER_NUMBER,

                              6/1/2011 9:25:00 AM: 0025         rsc.FLASH_SVC_CATEGORY CATEGORY,

                              6/1/2011 9:25:00 AM: 0026         rsc.oid CATKEY,

                              6/1/2011 9:25:00 AM: 0027         q.bp_name PARTNER,

                              6/1/2011 9:25:00 AM: 0028         q.ENTITY_NAME      

                              6/1/2011 9:25:00 AM: 0029    FROM system_request psr, category_provider scp, REF_SCP_SRVC_CAT_TYPE rsc,qc_cp_master q

                              6/1/2011 9:25:00 AM: 0030   WHERE psr.oid_provider=scp.oid

                              6/1/2011 9:25:00 AM: 0031   and psr.oid_cm = q.entity_oid

                              6/1/2011 9:25:00 AM: 0032     and trunc(psr.req_date) = trunc(sysdate)

                              6/1/2011 9:25:00 AM: 0033     and psr.req_type=1

                              6/1/2011 9:25:00 AM: 0034     and psr.req_state>=1

                              6/1/2011 9:25:00 AM: 0035     and scp.OID_SERV_CAT_TYPE=rsc.oid

                              6/1/2011 9:25:00 AM: 0036   GROUP BY trunc(psr.req_date),to_char(psr.req_date, 'HH24'),scp.prov_name,'QC' || scp.oid, rsc.FLASH_SVC_CATEGORY,rsc.oid,q.bp_name,q.ENTITY_NAME

                              6/1/2011 9:25:00 AM: 0037   ORDER BY trunc(psr.req_date),to_char(psr.req_date, 'HH24')

                              6/1/2011 9:56:16 AM:       General Script Error

                              6/1/2011 9:56:16 AM:      Execution finished.

                               

                               

                              CPU Usage is normal during the reload failure. The hardware does not seem to be a problem cos now I am refreshing the files using windows batch files on the server machine. The users cannot wait for me to resolve the issue and hence, I had to come up with the back up plan of executing from command line to automate the reloads.

                               

                              Thanks a lot guys for helping me.

                               

                              Regards

                              Kumar

                      • Failed to allocate Qlikview Engine
                        Stefan Bäckstrand

                        You are maxing out the available number of simultaneus QVB engines - the error message clearly states it.

                         

                        How many CPU cores are in the machine?

                        How many jobs runs at the same time at peak times?

                          • Failed to allocate Qlikview Engine

                            Hi Stefan,

                             

                            Thanks for your input.

                             

                            At first even I thought that I would be maxing out the available number of simultaneous QVB engines...but the error occurs even when all the engines are free...

                             

                            The error log is the log for the first job that runs on the day...

                             

                            31096365 2011-05-31 08:00:00NormalInformation Starting Job "UpdateProdReports" (Attempt 1 of 1)

                            31096369 2011-05-31 08:00:00NormalInformation Starting task "ProdReports"

                            31096375 2011-05-31 08:00:00NormalInformation Checking write permissions on "C:\Program Files(x86)\QlikView\Examples\QvsDocuments\OrdersByHour.qvw"

                            31096374 2011-05-31 08:00:00NormalInformation Preparing "C:\Program Files (x86)\QlikView\Examples\QvsDocuments\OrdersByHour.qvw" for reload.

                            31096373 2011-05-31 08:00:00NormalInformation Starting task "ProdReports" (84a02cf2-8ff5-44d0-a8a1-d2f6c95c589f)

                            31096376 2011-05-31 08:00:00NormalInformation Opening "C:\Program Files (x86)\QlikView\Examples\QvsDocuments\OrdersByHour.qvw"

                            31096379 2011-05-31 08:00:00NormalInformation Preparing to load document "C:\Program Files (x86)\QlikView\Examples\QvsDocuments\OrdersByHour.qvw".

                            31096377 2011-05-31 08:00:00NormalInformation Trying to allocate a QlikView Engine. Current usagecount=0 of 13. Waiting max=5/31/2011 8:05:00 AM

                            31096378 2011-05-31 08:00:00NormalInformation Successfully allocated QlikView Engine. Current usagecount=1 of 13

                            31096380 2011-05-31 08:00:00NormalInformation An instance of the QlikView Engine is being created.

                            31096382 2011-05-31 08:00:01NormalInformation Loading document "C:\Program Files (x86)\QlikView\Examples\QvsDocuments\OrdersByHour.qvw".

                            31096381 2011-05-31 08:00:01NormalInformation The QlikView Engine was started successfully. Version=8.01.4783.11 ProcessID=7028

                            31096383 2011-05-31 08:00:01NormalInformation The document "C:\Program Files (x86)\QlikView\Examples\QvsDocuments\OrdersByHour.qvw" was loaded successfully.

                            31096386 2011-05-31 08:00:01NormalInformation Starting reload

                            31096384 2011-05-31 08:00:01NormalInformation All done opening "C:\Program Files (x86)\QlikView\Examples\QvsDocuments\OrdersByHour.qvw"

                            31096385 2011-05-31 08:00:01NormalInformation Physical FileSize=0Mb. Memory Usage for this file=0Mb. Available Physical Memory Before Open=4095Mb. Available Physical Memory After Open=4095Mb. Total Physical Memory=4095Mb.

                            31096605 2011-05-31 08:31:17NormalInformation The document failed to reload. Reason=CrashedWithError

                            31096607 2011-05-31 08:31:17NormalInformation Reload failed

                            31096387 2011-05-31 08:00:01NormalInformation Starting Operation: Reload

                            31096394 2011-05-31 08:00:01NormalInformation Waiting for the document log "C:\Program Files (x86)\QlikView\Examples\QvsDocuments\OrdersByHour.qvw.log" to become available..

                            31096395 2011-05-31 08:00:01NormalInformation The Source Document is being reloaded. DocumentPath=C:\Program Files (x86)\QlikView\Examples\QvsDocuments\OrdersByHour.qvw

                            31096401 2011-05-31 08:01:16NormalWarning The QlikView Engine working with document "C:\Program Files (x86)\QlikView\Examples\QvsDocuments\OrdersByHour.qvw" is not responding.

                            31096594 2011-05-31 08:31:16NormalWarning The QlikView Engine working with document "C:\Program Files (x86)\QlikView\Examples\QvsDocuments\OrdersByHour.qvw" hasn't been responding for 1800 seconds. It will be killed.

                            31096596 2011-05-31 08:31:16NormalInformation Closing QlikView Engine

                            31096598 2011-05-31 08:31:16NormalInformation Closing the Source Document. DocumentPath=C:\Program Files (x86)\QlikView\Examples\QvsDocuments\OrdersByHour.qvw

                            31096600 2011-05-31 08:31:16NormalInformation Closing the QlikView Engine. ProcessID=7028

                            31096599 2011-05-31 08:31:16NormalInformation The Source Document was closed successfully DocumentPath=C:\Program Files (x86)\QlikView\Examples\QvsDocuments\OrdersByHour.qvw

                            31096601 2011-05-31 08:31:16NormalError Reload failed Exception=%Exception Exception: System.Runtime.InteropServices.COMException (0x80004005): Error HRESULT E_FAIL has been returned from a call to a COM component.   at QlikView.Doc.Reload(Int32 _Mode)   at QVBWrapper.Document.Reload(Int32 i_ParentLogID, Object i_Partial).

                            31096602 2011-05-31 08:31:16NormalError System.Exception: Reload failed ---> System.Runtime.InteropServices.COMException (0x80004005): Error HRESULT E_FAIL has been returned from a call to a COM component.   at QlikView.Doc.Reload(Int32 _Mode)   at QVBWrapper.Document.Reload(Int32 i_ParentLogID, Object i_Partial)   --- End of inner exception stack trace ---   at QVBWrapper.Document.Reload(Int32 i_ParentLogID, Object i_Partial)   at QVBWrapper.Document.StartThread2(Int32 i_ParentLogID, Object i_Object)

                            31096603 2011-05-31 08:31:16NormalInformation Closed the QlikView Engine successfully. ProcessID=7028

                            31096604 2011-05-31 08:31:17NormalInformation Document log "C:\Program Files (x86)\QlikView\Examples\QvsDocuments\OrdersByHour.qvw.log" was not found / not updated. Skipped.

                            31096612 2011-05-31 08:31:17NormalError The task ProdReports failed with an exception: System.NullReferenceException: Object reference not set to an instance of an object.   at QVBWrapper.Document.Close(Int32 i_ParentLogID)   at QVBWrapper.DocumentPool.Checkin(Int32 i_ParentLogID, Document i_Document)   at XSMain.ReloadTask.InternalExecute()   at XSMain.AbstractTask.InternalExecute2()

                            31096606 2011-05-31 08:31:17NormalInformation ReloadASync completed

                            31096608 2011-05-31 08:31:17NormalInformation Checkin

                            31096610 2011-05-31 08:31:17NormalInformation Closing QlikView Engine

                            31096371 2011-05-31 08:00:00NormalInformation  Waiting for "ProdReports" to complete.

                            31096366 2011-05-31 08:00:00NormalInformation Job started (Attempt 1 of 1)

                            31096613 2011-05-31 08:31:18NormalInformation 1 task(s) failed - Sending alertmail...

                            31096614 2011-05-31 08:31:20NormalInformation

                            31096616 2011-05-31 08:31:20NormalInformation Job "UpdateProdReports" has exited. 

                            31096615 2011-05-31 08:31:20NormalError Job finished with errors.  

                             

                            The qlikview engine was allocated and started but the job fails. I am not able to find out why.

                             

                            Regards

                            Kumar