2015-04-27 09:52:14.5280887	Information	Starting task 'Reload and Distribute of CtrlQ-TestData.qvw'. Id:1209d471-a0f4-4001-a9ab-0410f913be5a. Triggered by 'ManualStartTrigger'. Id:00000001-0002-0003-0405-0607080a0b0c
2015-04-27 09:52:14.5436895	Information	Entering Task Execution. 
2015-04-27 09:52:14.5436895	Information	ClusterID=3
2015-04-27 09:52:14.5436895	Information	QDSID=3dc20ac1-f860-5c6e-ad05-9ae631b75f0b
2015-04-27 09:52:14.5436895	Information	TaskID=1209d471-a0f4-4001-a9ab-0410f913be5a
2015-04-27 09:52:14.5436895	Information	MaxRunTime=1.00:00:00
2015-04-27 09:52:14.5436895	Information	MachineName=QLIKVIEWSERVER3
2015-04-27 09:52:14.5436895	Information	Max attempts:1
2015-04-27 09:52:14.5436895	Information	Current Attempt=0
2015-04-27 09:52:14.5436895	Information	Task Dependencies are OK
2015-04-27 09:52:14.5592903	Information	Document is marked to be Reloaded with fresh data. Initializing Reload for Distribution.
2015-04-27 09:52:14.5592903	Information	Opening "\\dc1\share\Back-end\SourceDocuments\CtrlQ-TestData.qvw"
2015-04-27 09:52:14.5592903	Information	Allocating new QlikView Engine. Current usage count=0 of 4 (of type non-reader).
2015-04-27 09:52:14.5592903	Information	Max retries:5
2015-04-27 09:52:14.5592903	Information	Attempt:01
2015-04-27 09:52:15.4017335	Information	Opened the QlikView Engine successfully. ProcessID=4824
2015-04-27 09:52:15.4017335	Information	Allocated QlikView Engine successfully. Current usage count=1 of 4 (of type non-reader). Ticket number=9.
2015-04-27 09:52:15.4017335	Information	Loading document "\\dc1\share\Back-end\SourceDocuments\CtrlQ-TestData.qvw" (0.21 Mb)
2015-04-27 09:52:15.5265399	Information	Physical FileSize=0.21 Mb. Memory Allocation Delta for this file=3.52 Mb. Available Physical Memory Before Open=5131.56 Mb. Available Physical Memory After Open=5127.82 Mb. Total Physical Memory=6143.49 Mb.
2015-04-27 09:52:15.5421407	Information	Attempted to load the document without data.
2015-04-27 09:52:15.5421407	Information	The document was loaded successfully.
2015-04-27 09:52:15.5421407	Information	Document was opened successfully
2015-04-27 09:52:15.5421407	Information	Starting reload
2015-04-27 09:52:15.5577415	Information	QlikView->Settings->Document Peferences->Generate Logfile in document is set. Enabling Log Copier.
2015-04-27 09:52:15.5577415	Information	The Source Document is being reloaded. DocumentPath=\\dc1\share\Back-end\SourceDocuments\CtrlQ-TestData.qvw
2015-04-27 09:52:15.5577415	Information	Waiting for the document log "\\dc1\share\Back-end\SourceDocuments\CtrlQ-TestData.qvw" to become available.. Check until 2015-04-27 09:52:45
2015-04-27 09:52:15.6201447	Information	Found a document log. FileName=\\dc1\share\Back-end\SourceDocuments\CtrlQ-TestData.qvw.log
2015-04-27 09:52:15.6201447	Information	Writing documentLog to \\dc1\share\Back-end\QdsRoot\3\Log\20150427\095214 - Reload and Distribute of CtrlQ-TestData.qvw\DocumentLog.txt
2015-04-27 09:52:15.6513463	Information	The Source Document reload complete. DocumentPath=\\dc1\share\Back-end\SourceDocuments\CtrlQ-TestData.qvw
2015-04-27 09:52:15.6513463	Information	Memory Allocation Delta for this file=6.17 Mb. Available Physical Memory Before Reload=5127.80 Mb. Available Physical Memory After Reload=5125.09 Mb. Total Physical Memory=5125.09 Mb.
2015-04-27 09:52:15.7761527	Information	The Source Document was reloaded successfully.
2015-04-27 09:52:15.8385559	Information	Reload finished successfully
2015-04-27 09:52:15.8385559	Information	Start saving document
2015-04-27 09:52:19.4267399	Information	Check in document: \\dc1\share\Back-end\SourceDocuments\CtrlQ-TestData.qvw
2015-04-27 09:52:19.4579415	Information	Closing the document.
2015-04-27 09:52:20.0819735	Information	Closed the QlikView Engine successfully. ProcessID=4824
2015-04-27 09:52:20.0819735	Information	Start document distribution.
2015-04-27 09:52:20.0819735	Information	Opening source document
2015-04-27 09:52:20.0819735	Information	Opening document: "CtrlQ-TestData.qvw"
2015-04-27 09:52:20.0819735	Information	Allocating new QlikView Engine. Current usage count=0 of 4 (of type non-reader).
2015-04-27 09:52:20.0819735	Information	Max retries:5
2015-04-27 09:52:20.0819735	Information	Attempt:01
2015-04-27 09:52:20.9088159	Information	Opened the QlikView Engine successfully. ProcessID=4488
2015-04-27 09:52:20.9088159	Information	Allocated QlikView Engine successfully. Current usage count=1 of 4 (of type non-reader). Ticket number=10.
2015-04-27 09:52:20.9088159	Information	Loading document "\\dc1\share\Back-end\SourceDocuments\CtrlQ-TestData.qvw" (0.21 Mb)
2015-04-27 09:52:21.1428279	Information	Physical FileSize=0.21 Mb. Memory Allocation Delta for this file=3.59 Mb. Available Physical Memory Before Open=5098.22 Mb. Available Physical Memory After Open=5094.87 Mb. Total Physical Memory=6143.49 Mb.
2015-04-27 09:52:21.1428279	Information	Attempted to load the document with data.
2015-04-27 09:52:21.1428279	Information	The document was loaded successfully.
2015-04-27 09:52:21.1584287	Information	Reduce skipped, nothing is selected.
2015-04-27 09:52:21.1584287	Information	Document was opened successfully
2015-04-27 09:52:21.1584287	Information	Determined 1 static recipients spread over 1 Distribution Resources.
2015-04-27 09:52:21.1584287	Information	Number of rule combinations was calculated successfully. Rounds=1
2015-04-27 09:52:21.1584287	Information	Empty rules
2015-04-27 09:52:21.1584287	Information	Rules resulted in distribution.
2015-04-27 09:52:21.1584287	Information	ROUND: 0 of 1. WarningCount=0
2015-04-27 09:52:21.1584287	Information	Building filename
2015-04-27 09:52:21.1584287	Information	Destination name: CtrlQ-TestData.qvw
2015-04-27 09:52:21.1584287	Information	Set script
2015-04-27 09:52:21.1740295	Information	Resetting of the Document Script for the Distributed Document was successful. ScriptType=Clear
2015-04-27 09:52:21.1740295	Information	Offer resources
2015-04-27 09:52:21.1896303	Information	Commencing ReduceData for \\dc1\share\Back-end\QdsRoot\3\temp\17f9feee-8d69-4652-b96a-939a455be1fd\document.qvw. (Reduce=False, Save=True)
2015-04-27 09:52:21.2520335	Information	Completed ReduceData for \\dc1\share\Back-end\QdsRoot\3\temp\17f9feee-8d69-4652-b96a-939a455be1fd\document.qvw. (Reduce=False, Save=True)
2015-04-27 09:52:21.2520335	Information	Memory Allocation Delta for this file=0.27 Mb. Available Physical Memory Before Reduce=5094.79 Mb. Available Physical Memory After Reduce=5094.05 Mb. Total Physical Memory=5094.05 Mb.
2015-04-27 09:52:21.2520335	Information	Distributing
2015-04-27 09:52:21.2520335	Information	Distributing using resource "Reload and Distribute of CtrlQ-TestData.qvw_QVS_1".
2015-04-27 09:52:21.2520335	Information	Trying to distribute. QVS=qvp://qlikviewserver2
2015-04-27 09:52:21.2520335	Information	Connecting to QlikView Server. Address=qlikviewserver2:4747
2015-04-27 09:52:22.3908919	Warning	Failed to connect to QlikView Server. This error is most likely because the server is not contactable or that the account the QlikView Distribution Service is running as is lacking permissions. Address=qlikviewserver2:4747, Exception=System.Net.Sockets.SocketException (0x80004005): No connection could be made because the target machine actively refused it 172.16.16.101:4747
   at System.Net.Sockets.Socket.Connect(IPAddress[] addresses, Int32 port)
   at System.Net.Sockets.Socket.Connect(String host, Int32 port)
   at QlikTech.NetClient.QvClient.Open()
   at QVSWrapper.QlikViewServer..ctor(Action`2 i_Logger, String i_Hostname, Int32 i_Port, Mode i_Mode, Boolean i_Https)
   at QlikTech.QlikViewServerConnection..ctor(Action`2 i_Logger, String i_Address, String i_Username, String i_Password)
   at QlikTech.QVSHelper.GetQlikViewServerConnection(String i_ForPath, String& o_RelativePath, String i_Username, String i_Password)
2015-04-27 09:52:22.4376943	Warning	Could not connect. Type=QlikView Server, Path=qvp://qlikviewserver2. Exception=System.Exception: Could not connect! Path=qvp://qlikviewserver2 ---> System.Exception: GetQlikViewServerConnection returned null
   at QlikTech.DMS.Connect(String i_Path)
   --- End of inner exception stack trace ---
   at QlikTech.DMS.Connect(String i_Path)
   at QDSMain.FileSystemPluginHelper.CreateInstanceOfPluginHandlingPath(ILogBucket i_LogBucket, String i_Path, String i_Username, String i_Password, LogMessage i_LogMessage, LogFileProgress i_LogFileProgress)
2015-04-27 09:52:22.4376943	Warning	FileSystem Plugin was not found - No operations will be executed! Path=qvp://qlikviewserver2
2015-04-27 09:52:22.4376943	Warning	Could not connect to QVS. QVS=qvp://qlikviewserver2
2015-04-27 09:52:22.4376943	Warning	Could not connect. QVS=qvp://qlikviewserver2
2015-04-27 09:52:22.4376943	Information	Trying to distribute. QVS=qvp://qlikviewserver3
2015-04-27 09:52:22.4376943	Information	Connecting to QlikView Server. Address=qlikviewserver3:4747
2015-04-27 09:52:22.4532951	Information	Successfully connected to QlikView Server. Address=qlikviewserver3:4747
2015-04-27 09:52:22.4532951	Information	Creating/Updating file: qvp://qlikviewserver3/CtrlQ-TestData.qvw
2015-04-27 09:52:22.4532951	Information	<request monitor="Performance"/>
2015-04-27 09:52:22.4532951	Information	<?xml version="1.0" encoding="UTF-8" ?><Performance><ExeType>RLS64</ExeType><ExeVersion>11.20.12577.0409.10</ExeVersion><Timestamp>2015-04-27 09:52:22</Timestamp><DocSessions>0</DocSessions><AnonymousDocSessions>0</AnonymousDocSessions><TunneledDocSessions>0</TunneledDocSessions><DocSessionStartsSinceMidnight>0</DocSessionStartsSinceMidnight><RefDocs>0</RefDocs><LoadedDocs>0</LoadedDocs><IpAddrs>0</IpAddrs><Users>0</Users><CPULoad>0</CPULoad><VMCommitted>32.882813</VMCommitted><VMAllocated>153.769531</VMAllocated><VMFree>5102.531250</VMFree><VMLargestFreeBlock>5102.531250</VMLargestFreeBlock><UsageCalBalance>300.000000</UsageCalBalance><TimeZoneBias>-120</TimeZoneBias></Performance>
2015-04-27 09:52:22.4532951	Information	<Global method="FileUpload"><Path>CtrlQ-TestData.qvw</Path></Global>
2015-04-27 09:52:22.4688959	Information	<Global><_retval_>0</_retval_></Global>
2015-04-27 09:52:22.5156983	Information	<Global method="FileWrite"><h>0</h><Pos>0</Pos><Buffer /></Global>
2015-04-27 09:52:22.5312991	Information	ExecuteWithAttachments returned no data in buffer.
2015-04-27 09:52:22.5312991	Information	<Global></Global>
2015-04-27 09:52:22.5312991	Information	<Global method="FileWrite"><h>0</h><Pos>215552</Pos><Buffer /></Global>
2015-04-27 09:52:22.5312991	Information	ExecuteWithAttachments returned no data in buffer.
2015-04-27 09:52:22.5312991	Information	<Global></Global>
2015-04-27 09:52:22.5312991	Information	<Global method="FileCloseWithMetaData"><h>0</h><Data><Category>Default</Category><Description></Description><LastUpdate>42121.3280208333</LastUpdate><NextUpdate>2958465.95832176</NextUpdate><Clients>5</Clients><RestrictDownload>false</RestrictDownload><AccessList><MetaServiceAccessData><Anonymous>true</Anonymous><User></User><Allow>0</Allow></MetaServiceAccessData></AccessList><AjaxUrl></AjaxUrl><EventDriven>false</EventDriven><MaxOpenSessions>-1</MaxOpenSessions><SessionTimeout>0</SessionTimeout><DocumentTimeoutMinutes>0</DocumentTimeoutMinutes><EnableSessionCollaboration>false</EnableSessionCollaboration><LoadGranularityMode>3</LoadGranularityMode><DocumentLoadInfo><DocumentLoadInfo><Mode>0</Mode><ServerId>QLIKVIEWSERVER1</ServerId></DocumentLoadInfo><DocumentLoadInfo><Mode>1</Mode><ServerId>QLIKVIEWSERVER2</ServerId></DocumentLoadInfo><DocumentLoadInfo><Mode>0</Mode><ServerId>QLIKVIEWSERVER3</ServerId></DocumentLoadInfo></DocumentLoadInfo><EnableServerObjectsCreation>0</EnableServerObjectsCreation><ServerObjectsUsers /><EnableAuditLog>true</EnableAuditLog><RestrictExport>0</RestrictExport><SourceName>CtrlQ-TestData.qvw</SourceName></Data><Part>39</Part><AjaxFolder></AjaxFolder></Global>
2015-04-27 09:52:24.8402175	Information	<Global></Global>
2015-04-27 09:52:24.8402175	Information	Performance data (CopyFile): Connecting to QVS. (0), DMSAccessRules=1 (0), Uploading file: CtrlQ-TestData.qvw (0), Write complete. (215552 bytes processed) (78)
2015-04-27 09:52:24.8558183	Warning	QVS Distribution failed to distribute to one or more nodes in the QVS Cluster, but one node completed with success. NodeCount=1
2015-04-27 09:52:24.8558183	Warning	Distribution reported warnings for resource "Reload and Distribute of CtrlQ-TestData.qvw_QVS_1" (QlikViewServerDistributionResource). Warnings=6
2015-04-27 09:52:24.8558183	Warning	Distribution to resources reported warnings. Warnings: 7
2015-04-27 09:52:24.8558183	Information	Deleting temporary files.
2015-04-27 09:52:24.8714191	Information	Closing the document.
2015-04-27 09:52:25.4954511	Information	Closed the QlikView Engine successfully. ProcessID=4488
2015-04-27 09:52:25.4954511	Information	Document distribution done.
2015-04-27 09:52:25.5266527	Information	Task Execute Duration=00:00:10.9829632
2015-04-27 09:52:25.5266527	Information	The task "Reload and Distribute of CtrlQ-TestData.qvw" finished successfully
2015-04-27 09:52:25.5422535	Information	TaskResult.status=Finished
2015-04-27 09:52:25.5422535	Information	Notifying all triggers of new state:FinishedWithWarnings
2015-04-27 09:52:25.5422535	Information	Notifying all triggers of new state:FinishedWithWarnings - completed
2015-04-27 09:52:25.5578543	Information	Saving Task Result