Unaccounted frame time in profiler

Artfunkel · May 2013

Can anyone explain this?

The profiled frame took 32ms (31fps) to generate. But the various threads that generated it only add up to about 22ms (45fps). Where did the extra time come from? The profiler's top panel is buggy in this build, is the main display incorrect too?

DC_Darkling · May 2013

the odd thing is.. my profiler works fine.

I have been wondering.. can you lot with the weird profilers test the following:
* to go your windows start menu and start command prompt.
- Alternatively go to start menu, then run option, there type cmd and you also got the prompt.
* type "ping 127.0.0.1 /t" in the command prompt and hit enter. (without the "")
* After it went on for lets say 5 or 6 goes, check if there are any minus values or values in the thousands in this screen.
* close and let me know.

* alternatively completely unsubscribe from any mod & delete the mods from your workshop folder.

Artfunkel · May 2013

I think I found the problem:

ClientGame::Update incorrectly reports no time spent.

Trouble is, the sum of the bigger bars is 39.5...but the frame only took 35.4 to render! Perhaps there are some asynchronous threads being counted strange ways?

Edit: nothing unusual happened when I ran ping.

ezekel · May 2013

what do the numbers mean, mason?

DC_Darkling · May 2013

I have noticed form every picture of every person having the weird incorrect profiler % values, that the game one is freaking huge on ms.
Something odd is going on here.

ScardyBob · May 2013

DC_Darkling said:

I have noticed form every picture of every person having the weird incorrect profiler % values, that the game one is freaking huge on ms.
Something odd is going on here.

I've actually run into this once but haven't been any to repro it since. I also couldn't tell if it was an issue with the game or the profiler itself.

DC_Darkling · May 2013

Thats my point.
The only ones lately who complain are people who ALSO have weird profile pictures.
I tried to reproduce this myself so many times, but it just wont do.

So I assume its related.

Artfunkel · May 2013

The % bars work correctly at the main menu, and ClientGame::Update correctly reports the time it spent. But the moment that I finish loading a map (on a listenserver with no mods) everything starts behaving as per the screenshots above.

This is spammed over and over into the console whenever the profiler is open during a game:

<pre>Error: ExitNode for ClientGame::UpdateScript doesn't have matching EnterNode (current node is GUIDeathScreen:Update)
Error: ExitNode for ClientGame::Update doesn't have matching EnterNode (current node is GUIDeathScreen:Update)
Error: ExitNode for GUIManager:Update doesn't have matching EnterNode (current node is GUIDeathScreen:Update)</pre>

None of those functions are profiled correctly.

ScardyBob · May 2013

So I've had this happen to me a few times now and its appears to occur and fix itself at random. The only way I know its happening is that my fps randomly starts to tank. Besides the console spam from turning on profiler that Artfunkel has described, there doesn't appear to be any other errors. Even more bizarre, after trying to turn on/off various other debug commands, the problem disappears.

DC_Darkling · May 2013

I will add to the bizarre. I managed to get the same weird profiler without tanking fps.

I have only see people with problems with this weird profiler, so I asume im the odd one out.

baconbits · May 2013

Hey my profiler is weird as hell and I'm getting the same error message with high ms. People just think its my processor giving me shitty frames though >.< .

@artfunkel you seem to have a strong understanding of this stuff and I've already seen you point out a bug in another topic. You should check out my post about ns2 and skyrim performance. I have a lot of data there (on the same issue?) that can be analyzed.

Unaccounted frame time in profiler

Comments