U++ forum: Welcome to the forum

Re: RTIMING output makes no sense to me [message #39555 is a reply to message #39554]

Fri, 29 March 2013 12:18

mirek
Messages: 14267
Registered: November 2005

Ultimate Member

wimpie wrote on Fri, 29 March 2013 06:10

Hello,
pretty new to u++ so posting in newbie corner,

I tried RTIMING macro in some routine and got following output:

TIMING progress-sync  : 400.87 ms - 664.80 us (401.00 ms / 603 ), min:  0.00 ns, max:  9.00 ms, nesting: 1 - 603

It has spent total 400ms in code from RTIMING("progress-sync") till the end of block, and it entered it 603 times at level zero (not by recursion). By simple divide, average time spent there was 664us. Those min/max/nesting values are more or less for RTIMING debugging purposes, you can safely ignore them.

Side note: RTIMING itself takes some small time; for single RTIMING this time is measured and subtracted, but if you have nested RTIMING, it is not and you have to account for it during profiling.

Mirek

Report message to a moderator