Highlighted
Frequent Contributor.
Frequent Contributor.
662 views

VuGen 12.53 - TruClient IE not reporting accurate transactions response time

The AUT is a web application developed using angular.js framework.

IE version: 11

I have created a script using Truclient-IE web to measure the time it takes to load the landing page. The script has only one transaction . The script runs without any errors in interctive and load mode. I have setup the run time setting to run it 5 times and simulate a new user in each iteration. I have explicitly added first step to clear cache by executing Utils.Clearcache().

In load mode execution, in first 3 iterations it shows Duration, Think Time and Wasted Time correctly. But in 4th and 5th iteration - wasted time increases exponentially. 

Iteration -1 --> (Duration: 8.7610 Think Time: 0.0150 Wasted Time: 0.5590).

Iteration 2 --> (Duration: 6.3670 Think Time: 0.0150 Wasted Time: 0.7320)

Iteration 3 --> (Duration: 6.4810 Think Time: 0.0050 Wasted Time: 0.6560)

Iteration 4 --> (Duration: 6.4150 Think Time: 0.0150 Wasted Time: 5.8180)

Iteration 5 --> (Duration: 6.5420 Think Time: 0.0220 Wasted Time: 5.9570)

 

The question is how the Wasted Time increases by this huge margin after few iterations. The controller calculates transaction time as "Duration - Wasted Time". Hence for 4th and 5th iteration the transaction resposne time is less than 1 second. I know that this application takes 6-9 seconds to load the landing page. But the 90th percentile in the test summary report is not accurate because of this skewed Wasted Time.

Anyone ran into this issue before ? Is there any trick to get the Wasted Time report correctly ?

 

 

Detailed log

-----------------------------------------------

Starting iteration 1.
t=00003285ms: ** 1: Evaluate JavaScript code Utils.clearCache(); ** started [MsgId: MMSG-205180]
t=00003524ms: ** 1: Evaluate JavaScript code Utils.clearCache(); ** successfully completed with end event 'Action completed' [MsgId: MMSG-205180]
Notify: Transaction "SQT_LandingPage" started.
t=00004096ms: ** 2: Navigate to "https://aut.com/" ** started [MsgId: MMSG-205180]
t=00012509ms: ** 2: Navigate to https://aut.com/ ** successfully completed with end event 'Step network completed' [MsgId: MMSG-205180]
t=00012537ms: ** 3: Wait for Next button ** started [MsgId: MMSG-205180]
t=00012789ms: ** 3: Wait for Next button ** successfully completed with end event 'Action completed' [MsgId: MMSG-205180]
Notify: Transaction "SQT_LandingPage" ended with a "Pass" status (Duration: 8.7610 Think Time: 0.0150 Wasted Time: 0.5590).
Ending iteration 1.
Waiting 2.273000 seconds for iteration pacing.
Starting iteration 2.
t=00015673ms: ** 1: Evaluate JavaScript code Utils.clearCache(); ** started [MsgId: MMSG-205180]
t=00015907ms: ** 1: Evaluate JavaScript code Utils.clearCache(); ** successfully completed with end event 'Action completed' [MsgId: MMSG-205180]
Notify: Transaction "SQT_LandingPage" started.
t=00016467ms: ** 2: Navigate to "https://aut.com/" ** started [MsgId: MMSG-205180]
t=00017481ms: ** 2: Navigate to https://aut.com/ ** successfully completed with end event 'Step network completed' [MsgId: MMSG-205180]
t=00017502ms: ** 3: Wait for Next button ** started [MsgId: MMSG-205180]
t=00022782ms: ** 3: Wait for Next button ** successfully completed with end event 'Action completed' [MsgId: MMSG-205180]
Notify: Transaction "SQT_LandingPage" ended with a "Pass" status (Duration: 6.3670 Think Time: 0.0150 Wasted Time: 0.7320).
Ending iteration 2.
Waiting 6.427000 seconds for iteration pacing.
Starting iteration 3.
t=00029903ms: ** 1: Evaluate JavaScript code Utils.clearCache(); ** started [MsgId: MMSG-205180]
t=00030156ms: ** 1: Evaluate JavaScript code Utils.clearCache(); ** successfully completed with end event 'Action completed' [MsgId: MMSG-205180]
Notify: Transaction "SQT_LandingPage" started.
t=00030715ms: ** 2: Navigate to "https://aut.com/" ** started [MsgId: MMSG-205180]
t=00031683ms: ** 2: Navigate to https://aut.com/ ** successfully completed with end event 'Step network completed' [MsgId: MMSG-205180]
t=00031694ms: ** 3: Wait for Next button ** started [MsgId: MMSG-205180]
t=00037139ms: ** 3: Wait for Next button ** successfully completed with end event 'Action completed' [MsgId: MMSG-205180]
Notify: Transaction "SQT_LandingPage" ended with a "Pass" status (Duration: 6.4810 Think Time: 0.0050 Wasted Time: 0.6560).
Ending iteration 3.
Waiting 2.669000 seconds for iteration pacing.
Starting iteration 4.
t=00040643ms: ** 1: Evaluate JavaScript code Utils.clearCache(); ** started [MsgId: MMSG-205180]
t=00040873ms: ** 1: Evaluate JavaScript code Utils.clearCache(); ** successfully completed with end event 'Action completed' [MsgId: MMSG-205180]
Notify: Transaction "SQT_LandingPage" started.
t=00041415ms: ** 2: Navigate to "https://aut.com/" ** started [MsgId: MMSG-205180]
t=00047532ms: ** 2: Navigate to https://aut.com/ ** successfully completed with end event 'Step network completed' [MsgId: MMSG-205180]
t=00047552ms: ** 3: Wait for Next button ** started [MsgId: MMSG-205180]
t=00047795ms: ** 3: Wait for Next button ** successfully completed with end event 'Action completed' [MsgId: MMSG-205180]
Notify: Transaction "SQT_LandingPage" ended with a "Pass" status (Duration: 6.4150 Think Time: 0.0150 Wasted Time: 5.8180).
Ending iteration 4.
Waiting 6.938000 seconds for iteration pacing.
Starting iteration 5.
t=00055677ms: ** 1: Evaluate JavaScript code Utils.clearCache(); ** started [MsgId: MMSG-205180]
t=00055911ms: ** 1: Evaluate JavaScript code Utils.clearCache(); ** successfully completed with end event 'Action completed' [MsgId: MMSG-205180]
Notify: Transaction "SQT_LandingPage" started.
t=00056472ms: ** 2: Navigate to "https://aut.com/" ** started [MsgId: MMSG-205180]
t=00062688ms: ** 2: Navigate to https://aut.com/ ** successfully completed with end event 'Step network completed' [MsgId: MMSG-205180]
t=00062715ms: ** 3: Wait for Next button ** started [MsgId: MMSG-205180]
t=00062959ms: ** 3: Wait for Next button ** successfully completed with end event 'Action completed' [MsgId: MMSG-205180]
Notify: Transaction "SQT_LandingPage" ended with a "Pass" status (Duration: 6.5420 Think Time: 0.0220 Wasted Time: 5.9570).
Ending iteration 5.
Ending Vuser...

 

 

0 Likes
4 Replies
Highlighted
Micro Focus Expert
Micro Focus Expert

Re: VuGen 12.53 - TruClient IE not reporting accurate transactions response time

Hi,

According to the log, probably it's because value of "End-of-network identification timeout" is too small (by default 150ms, which could be changed in Runtime Settings) for your AUT case. There is a know issue in TC 12.53 to handle this too-small-network-timeout-value case. Could you please provide the WebStepProgress.js file under <LR/LG folder>\dat\WebIE\RRE\content\model folder? I will provide an updated version of this file to avoid this issue.

0 Likes
Highlighted
Frequent Contributor.
Frequent Contributor.

Re: VuGen 12.53 - TruClient IE not reporting accurate transactions response time

Thanks Alex. Please find the WebSetpProgress file attached.

0 Likes
Highlighted
Micro Focus Expert
Micro Focus Expert

Re: VuGen 12.53 - TruClient IE not reporting accurate transactions response time

Hi,

Sorry, my mistake. After reading the WebStepProgress.js file you provided, I realized the issue I mentioned was not in 12.53, but in 12.55. It's not the case here.

More information is needed to investigate your case. I would suggest to submit a case to LR/TC support team,  so more detailed trouble-shooting could be triggered.

 

Highlighted
Frequent Contributor.
Frequent Contributor.

Re: VuGen 12.53 - TruClient IE not reporting accurate transactions response time

Thanks Alex !

0 Likes
The opinions expressed above are the personal opinions of the authors, not of Micro Focus. By using this site, you accept the Terms of Use and Rules of Participation. Certain versions of content ("Material") accessible here may contain branding from Hewlett-Packard Company (now HP Inc.) and Hewlett Packard Enterprise Company. As of September 1, 2017, the Material is now offered by Micro Focus, a separately owned and operated company. Any reference to the HP and Hewlett Packard Enterprise/HPE marks is historical in nature, and the HP and Hewlett Packard Enterprise/HPE marks are the property of their respective owners.