Ok here is a log with the new version.

thead 0930 assigned PT 03AD0BE0, serial# 0console interface not foundcrit_sec_mode 3: spincounts + fairness + profiling/debugingLight-Critical-Section mode 3: adding spin & profilingMemoryHeap Optimization Mode 0: Not optimizing MemoryHeaphook point 1: using DX8 mouse codethead 071C assigned PT 03AD7238, serial# 1Special crit. sec. 1 (@ 17004ED0, thread 930, inited from A6114E) spin 2000 -> 2000Special crit. sec. 2 (@ 17004F10, thread 930, inited from 90A62B) spin 1000 -> 1000Special crit. sec. 3 (@ 2C002420, thread 930, inited from 9835B9) spin 4000 -> 4000Special crit. sec. 4 (@ 17004B90, thread 930, inited from 905CB3) spin 4000 -> 4000Special crit. sec. 5 (@ 17004AD0, thread 930, inited from 905D6F) spin 4000 -> 4000thead 0974 assigned PT 03AD7248, serial# 2thead 0BE4 assigned PT 03AD7428, serial# 3thead 0C7C assigned PT 03AD7438, serial# 4time 503224: 0c7c:1:0086E23A waited on CS 03ae4870 for    2 ms (init -2)time 503229: 0930:0:03910044 waited on CS 03910044 for    8 ms (init -99)time 503232: 0be4:0:03910044 waited on CS 03910044 for    2 ms (init -99)time 503575: 0974:1:0088B93C waited on CS 18084570 for    9 ms (init -2)time 503580: 0974:1:0088B93C waited on CS 18084570 for    5 ms (init -2)initialize2() running in thread 930Suppressing CRITICAL_SECTION Renderer+0x180 (18084570)thead 1040 assigned PT 03AD75D8, serial# 5thead 09CC assigned PT 03ADFC28, serial# 6thead 1030 assigned PT 03ADFC38, serial# 7Special crit. sec. 6 (@ 2C0107A0, thread 930, inited from 9835B9) spin 4000 -> 4000Special crit. sec. 7 (@ 171096D0, thread 930, inited from 905CB3) spin 4000 -> 4000Special crit. sec. 8 (@ 17109610, thread 930, inited from 905D6F) spin 4000 -> 4000thead 12A0 assigned PT 03ADFC48, serial# 8time 523010: 12a0:0:0086E23A waited on CS 03ae4870 for    2 ms (init -2)time 523146: 0be4:0:00878F95 waited on CS 18084470 for    2 ms (init -3)time 523196: 0be4:1:00878F95 waited on CS 18084470 for    2 ms (init -3)time 523761: 12a0:1:0086E23A waited on CS 03ae4870 for    2 ms (init -4)time 523764: 0974:1:0086E55A waited on CS 03ae4870 for    3 ms (init -8)time 523765: 0be4:0:0086E23A waited on CS 03ae4870 for    6 ms (init -2)time 523765: 0930:1:0086E23A waited on CS 03ae4870 for    4 ms (init -10)time 523767: 0974:0:0086E55A waited on CS 03ae4870 for    2 ms (init -6)time 523767: 0be4:1:0086E55A waited on CS 03ae4870 for    2 ms (init -6)time 524219: 0be4:0:00878F95 waited on CS 18084470 for    4 ms (init -3)time 524423: 0be4:0:00878F95 waited on CS 18084470 for    3 ms (init -3)time 524518: 0930:0:0086E23A waited on CS 03ae4870 for    4 ms (init -2)time 524817: 0be4:0:00878F95 waited on CS 18084470 for    3 ms (init -2)begin PerfData3::print_summary01179690    11ms    197k      0ns    1ms18072124     5ms     89k      0ns    1ms03AE4870    35ms   6201       6ns    6msend PerfData3::print_summarytime 524873: 0be4:0:00878F95 waited on CS 18084470 for    6 ms (init -3)time 525402: 0930:0:0058D262 waited on CS 01073ab4 for   39 ms (init -5)time 525404: 0be4:1:0058A85B waited on CS 01073ab4 for    2 ms (init -2)thead 0988 assigned PT 03ADFC58, serial# 9thead 1044 assigned PT 03ADFCB8, serial# 10thead 092C assigned PT 03ADFEF8, serial# 11thead 0980 assigned PT 03ADFF08, serial# 12thead 1048 assigned PT 08B298D8, serial# 13thead 0984 assigned PT 08B298E8, serial# 14time 525743: 0930:0:1A90AC60 waited on CS 0106c980 for    2 ms (init -99)time 525749: 0930:0:1A90AC60 waited on CS 0106c980 for    2 ms (init -99)time 531278: 1048:0:0086E23A waited on CS 03ae4870 for    3 ms (init -2)time 532638: 0c7c:1:3000DA80 waited on CS 010715c0 for    2 ms (init -99)time 533029: 0930:1:0086E55A waited on CS 03ae4870 for    3 ms (init -2)time 538440: 1044:1:00BCF1B8 waited on CS 1a32af98 for    2 ms (init -2)time 539334: 0930:0:0086E55A waited on CS 03ae4870 for    3 ms (init -2)time 539897: 0930:0:0086E23A waited on CS 03ae4870 for    3 ms (init -2)time 541182: 0984:1:0086E23A waited on CS 03ae4870 for    3 ms (init -2)time 541182: 1044:1:0086E23A waited on CS 03ae4870 for    3 ms (init -4)time 541904: 0984:1:00BCF1B8 waited on CS 1a32af98 for    2 ms (init -2)time 541905: 0988:0:00BCF1B8 waited on CS 1a32af98 for    3 ms (init -6)begin PerfData3::print_summary01179690    12ms    207k      0ns    1ms18072124     6ms     91k      0ns    1ms18084470    25ms     10k      2ns    6ms03AE4870    58ms   7786       7ns    6ms010F3194     1ms   2761       0ns    1msend PerfData3::print_summarytime 543158: 0988:0:00BCF1B8 waited on CS 1a32af98 for    3 ms (init -2)time 543158: 0984:1:00BCF1B8 waited on CS 1a32af98 for    3 ms (init -6)time 543723: 0930:1:0086E23A waited on CS 03ae4870 for    3 ms (init -2)time 544186: 0930:1:0086E23A waited on CS 03ae4870 for    3 ms (init -2)time 544251: 0930:1:0086E23A waited on CS 03ae4870 for    3 ms (init -2)time 547760: 0980:1:00BCF1B8 waited on CS 1a32af98 for    3 ms (init -2)time 551821: 0980:1:00BCF1B8 waited on CS 1a32af98 for    4 ms (init -2)time 558751: 1044:1:00BCF1B8 waited on CS 1a32af98 for    2 ms (init -2)time 560635: 0c7c:0:35001C00 waited on CS 0116fca0 for    5 ms (init -99)time 560866: 0c7c:0:35001C00 waited on CS 0116fca0 for    4 ms (init -99)time 561494: 0c7c:0:35001C00 waited on CS 0116fca0 for    6 ms (init -99)time 565438: 0930:0:0086E23A waited on CS 03ae4870 for    2 ms (init -2)

To get some context for the log:
I start out walking down some escalators into the tunnel going N, with no apparent stutter. Further on i get to a small pass through tunnel going to the adjacent metro tunnel continuing N, the stutter really begins after entering this adjacent tunnel and rounding a corner flanked by broken trains.
I guess about 30-45 sec after loading the save.

I also tried with iCriticalSectionMode=0 and iLightCS_Mode=0, still unplayable.



Just for fun i tried with iLights=4 still the same, log included:

thead 1338 assigned PT 08E00BE0, serial# 0console interface not foundcrit_sec_mode 3: spincounts + fairness + profiling/debugingLight-Critical-Section mode 4: stagger w/ profilingMemoryHeap Optimization Mode 0: Not optimizing MemoryHeaphook point 1: using DX8 mouse codethead 13B0 assigned PT 08E07238, serial# 1Special crit. sec. 1 (@ 17004ED0, thread 1338, inited from A6114E) spin 2000 -> 2000Special crit. sec. 2 (@ 17004F10, thread 1338, inited from 90A62B) spin 1000 -> 1000Special crit. sec. 3 (@ 2C002420, thread 1338, inited from 9835B9) spin 4000 -> 4000Special crit. sec. 4 (@ 17004B90, thread 1338, inited from 905CB3) spin 4000 -> 4000Special crit. sec. 5 (@ 17004AD0, thread 1338, inited from 905D6F) spin 4000 -> 4000thead 0CD0 assigned PT 08E07248, serial# 2thead 1114 assigned PT 08E07428, serial# 3time 117486: 1338:0:18CB6D84 waited on CS 0106e5a0 for    3 ms (init -99)time 117537: 0cd0:1:00000008 waited on CS 0106e5a0 for   51 ms (init -99)time 117545: 1338:0:000003E8 waited on CS 0106e5a0 for    8 ms (init -99)thead 1048 assigned PT 08E07438, serial# 4time 120721: 1338:0:0086E23A waited on CS 03aa4870 for    8 ms (init -2)time 120733: 1338:0:00000000 waited on CS 03ab0044 for    5 ms (init -99)initialize2() running in thread 1338Suppressing CRITICAL_SECTION Renderer+0x180 (18084570)thead 1070 assigned PT 08C83020, serial# 5thead 1304 assigned PT 08C830F0, serial# 6thead 0378 assigned PT 08C83100, serial# 7Special crit. sec. 6 (@ 2C0107A0, thread 1338, inited from 9835B9) spin 4000 -> 4000Special crit. sec. 7 (@ 171096D0, thread 1338, inited from 905CB3) spin 4000 -> 4000Special crit. sec. 8 (@ 17109610, thread 1338, inited from 905D6F) spin 4000 -> 4000thead 0EB0 assigned PT 08C83110, serial# 8time 132761: 0eb0:0:0086E23A waited on CS 03aa4870 for    2 ms (init -4)begin PerfData3::print_summary01179690     9ms    196k      0ns    1ms18072124     2ms     70k      0ns    1msend PerfData3::print_summarytime 133147: 1114:0:00878F95 waited on CS 18084470 for    2 ms (init -3)time 133701: 1338:0:0086E23A waited on CS 03aa4870 for    4 ms (init -4)time 133704: 1114:1:00878F95 waited on CS 18084470 for    3 ms (init -3)time 133766: 1114:1:00000000 waited on CS 0108ede0 for    5 ms (init -99)time 134017: 1114:0:00878F95 waited on CS 18084470 for    9 ms (init -3)time 134044: 1338:0:03ABB96C waited on CS 03ab63ec for    2 ms (init -99)time 134046: 1114:0:12EFF828 waited on CS 0106e5a0 for    2 ms (init -99)time 134060: 1114:0:0086E23A waited on CS 03aa4870 for    5 ms (init -2)time 134414: 1114:1:00878F95 waited on CS 18084470 for    7 ms (init -3)time 134512: 1338:1:0086E23A waited on CS 03aa4870 for    3 ms (init -2)time 135063: 1338:1:0058D262 waited on CS 01073ab4 for  205 ms (init -5)begin PerfData3::print_summary01179690     9ms    196k      0ns    1ms18072124     2ms     91k      0ns    1ms03AA4870    45ms   7980       6ns    8ms010F3194     0ms   2709       0ns    0msend PerfData3::print_summarythead 0CC4 assigned PT 08C83120, serial# 9thead 0834 assigned PT 08C83190, serial# 10thead 13FC assigned PT 08C833C0, serial# 11thead 10C0 assigned PT 08C833D0, serial# 12thead 0678 assigned PT 08C86BF0, serial# 13time 135195: 0cc4:0:00BCF122 waited on CS 01178814 for   10 ms (init -14)time 135195: 0834:0:00BCF122 waited on CS 01178814 for   10 ms (init -14)time 135211: 13fc:1:00BCF122 waited on CS 01178814 for   19 ms (init -12)time 135211: 10c0:1:00BCF122 waited on CS 01178814 for   19 ms (init -16)thead 1228 assigned PT 08C86C00, serial# 14time 135211: 1228:0:00BCF122 waited on CS 01178814 for   26 ms (init -14)time 135212: 0678:1:00BCF122 waited on CS 01178814 for   17 ms (init -18)time 135223: 1338:0:03AB2114 waited on CS 0106c980 for    2 ms (init -99)time 135227: 1338:0:03AB2114 waited on CS 0106c980 for    3 ms (init -99)time 140878: 1048:1:00000000 waited on CS 010715c0 for    2 ms (init -99)time 146698: 1048:0:00000000 waited on CS 010715c0 for    2 ms (init -99)time 146766: 1338:1:0086E23A waited on CS 03aa4870 for    3 ms (init -2)time 146996: 1048:0:00000000 waited on CS 0106c980 for    2 ms (init -99)time 147423: 1338:1:0086E23A waited on CS 03aa4870 for    2 ms (init -2)time 147588: 1048:0:00000000 waited on CS 010715c0 for    2 ms (init -99)time 147986: 1338:0:291F5340 waited on CS 0106c980 for    2 ms (init -99)begin PerfData3::print_summary01179690    12ms    285k      0ns    1ms18072124     3ms     95k      0ns    1ms01178814    66ms     17k      4ns   26ms03AA4870    55ms   8175       7ns    8ms18084470    27ms   6769       4ns    9msend PerfData3::print_summarytime 150513: 1338:1:0086E55A waited on CS 03aa4870 for    2 ms (init -2)time 150744: 1338:1:0086E23A waited on CS 03aa4870 for    2 ms (init -2)time 150910: 1048:0:18C979D0 waited on CS 0106c980 for    2 ms (init -99)time 150942: 1338:1:0086E23A waited on CS 03aa4870 for    2 ms (init -2)time 151009: 1048:0:00000000 waited on CS 010715c0 for    2 ms (init -99)time 151834: 1338:1:0086E23A waited on CS 03aa4870 for    2 ms (init -2)time 154607: 1338:0:0086E23A waited on CS 03aa4870 for    2 ms (init -2)time 155732: 1338:0:0086E23A waited on CS 03aa4870 for    3 ms (init -2)time 156325: 1338:0:0086E55A waited on CS 03aa4870 for    2 ms (init -2)time 157118: 1338:0:0086E23A waited on CS 03aa4870 for    3 ms (init -2)time 157349: 1338:1:0086E23A waited on CS 03aa4870 for    3 ms (init -2)time 157382: 1338:1:0086E23A waited on CS 03aa4870 for    3 ms (init -2)time 157415: 1338:1:0086E55A waited on CS 03aa4870 for    3 ms (init -2)time 157447: 0834:0:0086E23A waited on CS 03aa4870 for    2 ms (init -2)time 157447: 1338:0:0086E55A waited on CS 03aa4870 for    2 ms (init -6)time 157547: 1338:1:0086E23A waited on CS 03aa4870 for    3 ms (init -2)time 158405: 1338:1:0086E55A waited on CS 03aa4870 for    3 ms (init -2)time 158438: 1338:0:0086E55A waited on CS 03aa4870 for    3 ms (init -2)time 158899: 1338:0:0086E23A waited on CS 03aa4870 for    2 ms (init -2)time 159031: 1338:1:0086E55A waited on CS 03aa4870 for    2 ms (init -2)time 159197: 1338:0:0086E23A waited on CS 03aa4870 for    3 ms (init -2)time 159494: 1338:0:0086E55A waited on CS 03aa4870 for    3 ms (init -2)time 159692: 1048:0:00000000 waited on CS 010715c0 for    2 ms (init -99)time 159889: 1338:0:0086E23A waited on CS 03aa4870 for    2 ms (init -2)time 159922: 1338:1:0086E55A waited on CS 03aa4870 for    2 ms (init -2)time 160649: 1338:0:0086E55A waited on CS 03aa4870 for    3 ms (init -2)time 163164: 1338:1:0086E23A waited on CS 03aa4870 for    2 ms (init -2)begin PerfData3::print_summary01179690    12ms    285k      0ns    1ms18072124     3ms     95k      0ns    1ms01178814    84ms     17k      5ns   26ms18084470    29ms     15k      2ns    9ms03AA4870   120ms   8847      14ns    8msend PerfData3::print_summarytime 163395: 1338:1:0086E23A waited on CS 03aa4870 for    3 ms (init -2)time 165576: 1048:1:000003E8 waited on CS 0106c980 for    2 ms (init -99)time 165772: 1338:1:0086E23A waited on CS 03aa4870 for    2 ms (init -2)time 171451: 0834:0:0086E55A waited on CS 03aa4870 for    3 ms (init -2)time 171712: 13fc:0:0086E23A waited on CS 03aa4870 for    3 ms (init -6)time 174784: 0834:0:0086E55A waited on CS 03aa4870 for    3 ms (init -2)time 182130: 1338:1:0086E23A waited on CS 03aa4870 for    2 ms (init -2)time 182460: 1338:0:0086E55A waited on CS 03aa4870 for    3 ms (init -2)time 182558: 10c0:1:0086E55A waited on CS 03aa4870 for    3 ms (init 0)time 182695: 1048:0:000003E8 waited on CS 010715c0 for    2 ms (init -99)time 183780: 1338:0:0086E55A waited on CS 03aa4870 for    6 ms (init -4)time 185026: 1338:0:00000001 waited on CS 0106c980 for    6 ms (init -99)time 185485: 1048:0:00BEE098 waited on CS 01179690 for    2 ms (init -2)time 187223: 1048:0:0086E23A waited on CS 03aa4870 for   35 ms (init -2)time 187223: 0678:1:0086E23A waited on CS 03aa4870 for   35 ms (init -4)time 187229: 0834:0:0086E23A waited on CS 03aa4870 for    6 ms (init -4)time 187229: 0678:1:0086E23A waited on CS 03aa4870 for    6 ms (init -5)begin PerfData3::print_summary01179690    14ms    285k      0ns    2ms18072124     3ms     95k      0ns    1ms18084470    29ms     27k      1ns    9ms01178814   104ms     17k      6ns   26ms03AA4870   225ms     12k     18ns   35msend PerfData3::print_summarytime 187242: 0834:0:0086E23A waited on CS 03aa4870 for   13 ms (init -1)time 206076: 1048:0:00000001 waited on CS 0106c980 for   77 ms (init -99)time 211818: 1338:0:008790E0 waited on CS 18084470 for   97 ms (init -2)begin PerfData3::print_summary01179690    14ms    285k      0ns    2ms18072124     3ms     95k      0ns    1ms18084470   126ms     29k      4ns   97ms01178814   104ms     17k      6ns   26ms03AA4870   228ms     12k     19ns   35msend PerfData3::print_summary

Thank you very much! :goodjob:
I will post a new log soon, I hope it will help.

New Log:
http://stashbox.org/634154/sr_Fallout_Stutter_Remover.log

RAY_DK:
First log shows about 42 seconds of game time. Possibly it was truncated somehow. Not much stutter, so far as I can tell.
Second log shows about 80 seconds of game time, with some stutter towards the end. Again, possibly truncated somehow. Some of the stutter is tied to Renderer+0x180, which may be safely suppressible with iCriticalSectionSuppresion=1 (that is, it has been found to be safe to do so on Oblivion, but has not been tested much on Fallout yet). The critical section at 0x01179690 may have reduced the FPS for that run significantly, but did not appear to cause stutter.

alexkapi:
The log looks like a lot less stutter than your previous one. Looks like about 30 minutes of play time, probably 5 visible stutters and 15 more maybe-visible stutters, all in the first 10 minutes of play time; no stutters in the last 20 minues. The majority of your visible stutter probably comes from a critical section at 0x01073ab4 which I don't know much about, but can take a look at. 0x01179690 also produced visible stutter, and 0116d740 may have. Several other critical sections and LightCSes show up as maybe reducing FPS but probably not causing visible stutter.

At the end of both (short) runs the FPS was down to <1 FPS, i am wondering if its not correct for me to use the term "stuttering" as it is closer to "grinding to a halt" but it does seem that the log function isn't quite recording what i experience.

Maybe the problem I have is not in the parts where you log?

iCriticalSectionSupression=1 is the default value, did you mean i should try and change it to 0?

There's way to tell actual FPSes from the current versions of the logs... I can see that the Critical section 0x01179690 is slowing down Fallout in what looks like a non-stuttery manner though. The logging is not measuring time accurately enough atm for me to tell just how much it's slowing things down. I'll switch the profiling to use RDTSC in the next alpha, that will lower performance slightly but improve the information on this kind of case.
The 2nd log corresponds to just over 94 seconds of real time, with maybe 15 seconds of that occuring prior to the start of play.
Anyway, since it looks like it's probably coming from 0x01179690, which is a regular critical section, if FSR is causing this you could probably prevent it by changing iCriticalSectionMode to 0. Though that would also prevent logging of the critical section events.

iCriticalSectionSupression:
No, I was confused. The stutter there came partially from Renderer+0x080, not Renderer+0x180. You could change iCriticalSectionSupression from 1 to 3 to eliminate that stutter, but doing so caused crashes on Oblivion for some users, probably will be at least as bad on Fallout. And apparently your big problem isn't the long blocking events so much as the ten-thousand-short-blocking-events-every-frame. So probably just leave iCriticalSectionSupression at 1.

Any updates on heap replacement?

Yet another log, but with iCriticalSectionSupression=3
http://stashbox.org/636292/sr_Fallout_Stutter_Remover.log

Heap replacement was enabled a while ago, but just crashes when used; I must have screwed something up, but haven't put much work in to figuring out what yet.

But it's probably not a big deal, or heap LightCSes would show up more in the log files (callers 86D7EA and 86D94C). Possibly Fallouts heap is a lot better, or it uses that heap a lot less, or both.

There's another alpha up on my ftp server: ftp://71.115.192.77/sr_Fallout_Stutter_Remover.dll
This one improves logging in several ways. It also adds a new iLightCS_mode called "priority" atm, iLightCS_mode=6. This mode attempts to give higher priority to Fallouts main thread than to secondary threads, hopefully reducing visible stutter at the cost of making background tasks like cell loading stutter more. I may add comparable modes for regular CSes sometime.

I have some new logs for you made with the newest version.

crit_sec_mode 0 Light-Critical-Section mode 3:

thead 080C assigned PT 08D50BE8, serial# 0console interface not foundcrit_sec_mode 0: vanillaLight-Critical-Section mode 3: adding spin & profilingMemoryHeap Optimization Mode 0: Not optimizing MemoryHeaphook point 1: using DX8 mouse codethead 0704 assigned PT 08D50C10, serial# 1thead 088C assigned PT 08D50E98, serial# 2thead 078C assigned PT 08D50C48, serial# 3initialize2() running in thread 80cSuppressing CRITICAL_SECTION Renderer+0x180 (18084570)thead 117C assigned PT 08D50BD8, serial# 4PerfData3::print_summary: time   27   tt:  0.0s   tc:1k039F0044        2ms    183       14us    2ms -99   86D7EA   86D94C 0108EDE0        0ms      7       57us    0ms -99   8268B8   84B6D1 039FCA5C        0ms    163        2us    0ms -99   86D7EA   86D94C 0106E5A0        0ms    494        0us    0ms -99   42364D   469B96   471225   ABB381 039F2114        0ms     70        2us    0ms -99   86D7EA   86D94C 039F10AC        0ms     58        1us    0ms -99   86D7EA 010F2C40        0ms      3        7us    0ms -99   8D2283 039F3A4C        0ms      9        2us    0ms -99   86D7EA   86D94C 039F297C        0ms      9        1us    0ms -99   86D7EA   86D94C 039F63EC        0ms      6        2us    0ms -99   86D7EA   86D94C 039FDAC4        0ms      2        5us    0ms -99   86D7EA 039FB98C        0ms      4        2us    0ms -99   86D7EA 039FEB94        0ms      6        2us    0ms -99   86D7EA   86D94C time   28.00: 4:1:0082735D waited on CS 0108ede0 for   11 ms (init -99)time   28.19: 4:0:0084B6D1 waited on CS 0108ede0 for   24 ms (init -99)thead 0404 assigned PT 08D5CBB0, serial# 5thead 0A38 assigned PT 08D5CBC0, serial# 6time   33.69: 3:0:004DC7DD waited on CS 010715c0 for    2 ms (init -99)time   45.42: 3:1:004DC7DD waited on CS 010715c0 for    2 ms (init -99)PerfData3::print_summary: time   45   tt:  0.1s   tc:2k0108EDE0       31ms     13     2355us   21ms -99   8268B8   82735D   84B6D1 010715C0       12ms     16      746us    2ms -99   4DC7DD   4E1D0F 039F0044        4ms    270       15us    2ms -99   86D7EA   86D94C 039FCA5C        2ms    274        6us    1ms -99   86D7EA   86D94C 0108F080        1ms      2      369us    1ms -99   829370 0106E5A0        0ms    950        1us    0ms -99   42364D   469B96   471225   ABB381 0116FCA0        0ms      2       58us    0ms -99   AE428D   AE6710 0106C980        0ms    179        1us    0ms -99   40A333   40A540   40A6C4   41B279 039F2114        0ms     89        1us    0ms -99   86D7EA   86D94C 

crit_sec_mode 3 Light-Critical-Section mode 3:

thead 12B4 assigned PT 08CF0BE8, serial# 0console interface not foundcrit_sec_mode 3: spincounts + fairness + profiling/debugingLight-Critical-Section mode 3: adding spin & profilingMemoryHeap Optimization Mode 0: Not optimizing MemoryHeaphook point 1: using DX8 mouse codePerfData3::print_summary: time    1   tt:  0.0s   tc:1k18072124        0ms    985        0us    0ms   0   823FE9   8241BC   824270 18BF94B0        0ms     13        0us    0ms   0   857008   8570BD thead 0F60 assigned PT 08CF7980, serial# 1Special crit. sec. 1 (@ 17004ED0, thread 12B4, inited from A6114E) spin 2000 -> 2000Special crit. sec. 2 (@ 17004F10, thread 12B4, inited from 90A62B) spin 1000 -> 1000Special crit. sec. 3 (@ 2C002420, thread 12B4, inited from 9835B9) spin 4000 -> 4000Special crit. sec. 4 (@ 17004B90, thread 12B4, inited from 905CB3) spin 4000 -> 4000Special crit. sec. 5 (@ 17004AD0, thread 12B4, inited from 905D6F) spin 4000 -> 4000thead 0348 assigned PT 08CF7990, serial# 2time    6.62: 2:1:0088B93C waited on CS 18084570 for   10 ms (init -2)time    6.63: 2:1:0088B93C waited on CS 18084570 for   10 ms (init -2)time    6.64: 2:1:0088B93C waited on CS 18084570 for   10 ms (init -2)time    6.72: 2:1:0088B93C waited on CS 18084570 for    7 ms (init -2)time    6.72: 2:0:0088B93C waited on CS 18084570 for    3 ms (init -2)time    6.78: 2:1:0088B93C waited on CS 18084570 for   14 ms (init -2)time    6.79: 2:1:0088B93C waited on CS 18084570 for    9 ms (init -2)time    6.87: 2:1:0088B93C waited on CS 18084570 for    4 ms (init -2)time    6.92: 2:0:0088B93C waited on CS 18084570 for    8 ms (init -2)thead 02D8 assigned PT 08CF7B70, serial# 3time    7.48: 2:0:0088B93C waited on CS 18084570 for    5 ms (init -2)thead 07C0 assigned PT 08CF7B80, serial# 4time    7.55: 2:1:0088B93C waited on CS 18084570 for   34 ms (init -2)time    7.57: 0:1:00873172 waited on CS 18084570 for   33 ms (init -6)time    7.58: 2:1:0088B93C waited on CS 18084570 for    9 ms (init -2)time    7.59: 2:0:0088B93C waited on CS 18084570 for   12 ms (init -2)time    7.62: 3:1:00BC9DBE waited on CS 1808905c for    8 ms (init -2)time    7.64: 0:1:00BC9DBE waited on CS 1808905c for   13 ms (init -2)time    7.64: 2:0:0088B93C waited on CS 18084570 for   18 ms (init -2)time    7.64: 2:0:0088B93C waited on CS 18084570 for    6 ms (init -2)time    7.64: 0:1:00873172 waited on CS 18084570 for    3 ms (init -6)time    7.65: 3:1:00878F95 waited on CS 18084470 for    2 ms (init -3)time    7.68: 2:0:0088B93C waited on CS 18084570 for   11 ms (init -2)time    7.71: 3:1:00BC9DBE waited on CS 1808905c for   15 ms (init -2)time    7.87: 2:1:0088B93C waited on CS 18084570 for    3 ms (init -2)time    8.24: 2:1:0088B93C waited on CS 18084570 for    4 ms (init -2)time    8.25: 2:1:0088B93C waited on CS 18084570 for    6 ms (init -2)time    8.50: 2:0:0088B93C waited on CS 18084570 for    8 ms (init -2)initialize2() running in thread 12b4Suppressing CRITICAL_SECTION Renderer+0x180 (18084570)PerfData3::print_summary: time   22   tt:  0.4s   tc:188k18084570      321ms     47     6819us   46ms   0   828509   873172   88B93C 1808905C       51ms      5     9929us   20ms   0   BC9DBE   BCB86B 18084470        7ms   1450        5us    3ms   0   657FE5   8284F7   878F95   8790E0 01179690        9ms    171k       0us    0ms  -2   BECEA1   BEE098   BF35DD 18072124        1ms     15k       0us    0ms   0   823FE9   8241BC   824270 time   27.09: 2:1:00657FE5 waited on CS 18084470 for    8 ms (init -3)PerfData3::print_summary: time   34   tt:  0.4s   tc:206k18084570      341ms     47     7246us   49ms   0   828509   873172   88B93C 1808905C       54ms      5    10551us   21ms   0   BC9DBE   BCB86B 18084470       16ms   2466        6us    8ms   0   657FE5   8284F7   878F95   8790E0 01179690       11ms    188k       0us    0ms  -2   BECEA1   BEE098   BF35DD 18072124        1ms     16k       0us    0ms   0   823FE9   8241BC   824270 thead 07D4 assigned PT 08B135A8, serial# 5thead 1370 assigned PT 08B13628, serial# 6thead 0F64 assigned PT 08B13638, serial# 7Special crit. sec. 6 (@ 2C0107A0, thread 12B4, inited from 9835B9) spin 4000 -> 4000Special crit. sec. 7 (@ 171096D0, thread 12B4, inited from 905CB3) spin 4000 -> 4000Special crit. sec. 8 (@ 17109610, thread 12B4, inited from 905D6F) spin 4000 -> 4000thead 0B28 assigned PT 08B13648, serial# 8time   41.76: 3:1:00878F95 waited on CS 18084470 for    6 ms (init -3)PerfData3::print_summary: time   44   tt:  0.4s   tc:287k18084570      319ms     47     6778us   46ms   0   828509   873172   88B93C 1808905C       50ms      5     9869us   20ms   0   BC9DBE   BCB86B 18084470       26ms   3003        9us    8ms   0   657FE5   8284F7   876E9D   878F95 01179690       12ms    203k       0us    0ms  -2   BECEA1   BEE098   BF35DD 037A4870        5ms   1155        5us    1ms   0   86E23A   86E55A 18072124        5ms     77k       0us    0ms   0   823FE9   8241BC   824270   8242D2 time   47.94: 2:0:0086E55A waited on CS 037a4870 for    5 ms (init -6)time   47.97: 0:1:0086E23A waited on CS 037a4870 for    4 ms (init -2)time   48.26: 0:1:0086E55A waited on CS 037a4870 for    4 ms (init -2)time   50.86: 0:0:0058D262 waited on CS 01073ab4 for   64 ms (init -5)time   50.86: 3:1:0058A85B waited on CS 01073ab4 for    2 ms (init -2)time   50.92: 8:0:00BC9DBE waited on CS 1808905c for   21 ms (init -2)thead 0734 assigned PT 08B13658, serial# 9thead 0C08 assigned PT 08B136B8, serial# 10time   51.14: A:1:00BCF122 waited on CS 01178814 for   11 ms (init -14)thead 078C assigned PT 08B138B8, serial# 11time   51.14: B:1:00BCF122 waited on CS 01178814 for   12 ms (init -22)thead 11D0 assigned PT 08B13958, serial# 12time   51.16: C:0:00BCF122 waited on CS 01178814 for   35 ms (init -10)thead 085C assigned PT 08B13968, serial# 13time   51.16: D:0:00BCF122 waited on CS 01178814 for   35 ms (init -18)time   51.16: 9:1:00BCF122 waited on CS 01178814 for   25 ms (init -18)thead 0F38 assigned PT 08B16D20, serial# 14time   51.16: E:0:00BCF122 waited on CS 01178814 for   37 ms (init -6)time   53.90: 0:1:004E1D0F waited on CS 010715c0 for    3 ms (init -99)PerfData3::print_summary: time   55   tt:  0.7s   tc:340k18084570      299ms     47     6355us   43ms   0   828509   873172   88B93C 01178814      152ms     20k       8us   36ms  -1   BCEF29   BCF122 01073AB4       65ms    522      124us   62ms  -2   58A85B   58BCF6   58BE20   58C9E3 1808905C       67ms      8     8322us   20ms   0   BC9DBE   BCB86B 037A4870       28ms   4835        6us    4ms   0   86E23A   86E55A 18084470       25ms   6254        4us    7ms   0   657FE5   8284F7   876E9D   878F95 01179690       11ms    212k       0us    0ms  -2   BECEA1   BEE098   BF35DD 010715C0        3ms      1     2799us    3ms -99   4E1D0F 18072124        5ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 0117929C        2ms     56       34us    1ms   0   BD16A9   BD1B4B   BD1D49   BD3B5C 011792B4        2ms      8      222us    1ms   0   BD1DA2   BD3B65   BD3D78 time   64.35: 4:1:00BD1D49 waited on CS 0117929c for    2 ms (init -2)time   66.52: 0:0:0086E23A waited on CS 037a4870 for    4 ms (init -2)PerfData3::print_summary: time   66   tt:  0.6s   tc:349k18084570      286ms     47     6076us   41ms   0   828509   873172   88B93C 01178814      146ms     20k       7us   35ms  -1   BCEF29   BCF122 01073AB4       62ms    522      118us   60ms  -2   58A85B   58BCF6   58BE20   58C9E3 1808905C       64ms      8     7957us   19ms   0   BC9DBE   BCB86B 037A4870       32ms   4878        7us    4ms   0   86E23A   86E55A 18084470       24ms     16k       2us    7ms   0   657FE5   8284F7   876E9D   878F95 010715C0       10ms     11      883us    3ms -99   4DC7DD   4E1D0F 01179690       11ms    212k       0us    0ms  -2   BECEA1   BEE098   BF35DD 0117929C        4ms    113       38us    2ms   0   BD16A9   BD1B4B   BD1D49   BD3B5C 18072124        5ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 011792B4        2ms      8      212us    1ms   0   BD1DA2   BD3B65   BD3D78 time   66.58: 0:1:0086E55A waited on CS 037a4870 for    3 ms (init -2)time   66.63: 0:1:0086E23A waited on CS 037a4870 for    3 ms (init -2)time   66.93: 0:1:0086E23A waited on CS 037a4870 for    3 ms (init -2)PerfData3::print_summary: time   76   tt:  0.6s   tc:358k18084570      278ms     47     5901us   40ms   0   828509   873172   88B93C 01178814      142ms     20k       7us   34ms  -1   BCEF29   BCF122 01073AB4       60ms    522      115us   58ms  -2   58A85B   58BCF6   58BE20   58C9E3 1808905C       63ms      8     7727us   19ms   0   BC9DBE   BCB86B 037A4870       41ms   4983        8us    4ms   0   86E23A   86E55A 18084470       24ms     24k       1us    7ms   0   657FE5   8284F7   876E9D   878F95 010715C0       13ms     17      749us    3ms -99   4DC7DD   4E1D0F 01179690       11ms    212k       0us    0ms  -2   BECEA1   BEE098   BF35DD 0117929C        5ms    165       28us    2ms   0   BD16A9   BD1B4B   BD1D49   BD3B5C 18072124        5ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 011792B4        2ms      8      206us    1ms   0   BD1DA2   BD3B65   BD3D78 time   77.77: 0:1:0086E55A waited on CS 037a4870 for    4 ms (init -2)PerfData3::print_summary: time   87   tt:  0.6s   tc:367k18084570      272ms     47     5767us   39ms   0   828509   873172   88B93C 01178814      139ms     20k       7us   33ms   0   BCEF29   BCF122 01073AB4       59ms    522      112us   57ms  -2   58A85B   58BCF6   58BE20   58C9E3 1808905C       61ms      8     7551us   18ms   0   BC9DBE   BCB86B 037A4870       45ms   5090        9us    4ms   0   86E23A   86E55A 18084470       25ms     33k       1us    7ms   0   657FE5   8284F7   876E9D   878F95 010715C0       17ms     27      622us    3ms -99   4DC7DD   4E1D0F 01179690       10ms    212k       0us    0ms  -2   BECEA1   BEE098   BF35DD 0117929C        6ms    238       24us    2ms   0   BD16A9   BD1B4B   BD1D49   BD3B5C 18072124        5ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 011792B4        2ms      8      201us    1ms   0   BD1DA2   BD3B65   BD3D78 PerfData3::print_summary: time   98   tt:  0.6s   tc:376k18084570      267ms     47     5669us   39ms   0   828509   873172   88B93C 01178814      136ms     20k       7us   32ms   0   BCEF29   BCF122 01073AB4       58ms    522      110us   56ms  -2   58A85B   58BCF6   58BE20   58C9E3 1808905C       60ms      8     7424us   18ms   0   BC9DBE   BCB86B 037A4870       48ms   6390        7us    4ms   0   86E23A   86E55A 18084470       25ms     40k       1us    7ms   0   657FE5   8284F7   876E9D   878F95 010715C0       23ms     37      623us    3ms -99   4DC7DD   4E1D0F 01179690       10ms    212k       0us    0ms  -2   BECEA1   BEE098   BF35DD 0117929C        7ms    304       23us    2ms   0   BD16A9   BD1B4B   BD1D49   BD3B5C 18072124        5ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 011792B4        2ms     13      151us    1ms   0   BD1DA2   BD3B65   BD3D78 time  105.86: B:1:0086E23A waited on CS 037a4870 for   14 ms (init -4)time  105.86: C:0:0086E23A waited on CS 037a4870 for   14 ms (init -6)time  105.87: B:1:0086E23A waited on CS 037a4870 for    9 ms (init -2)time  117.51: 3:1:00BD1DA2 waited on CS 011792b4 for   18 ms (init -2)PerfData3::print_summary: time  117   tt:  0.7s   tc:382k18084570      261ms     47     5539us   38ms   0   828509   873172   88B93C 01178814      133ms     20k       7us   32ms   0   BCEF29   BCF122 01073AB4       56ms    522      108us   54ms  -2   58A85B   58BCF6   58BE20   58C9E3 037A4870       86ms   8502       10us   14ms   0   86E23A   86E55A 1808905C       59ms      8     7254us   18ms   0   BC9DBE   BCB86B 011792B4       20ms     14     1413us   18ms   0   BD1DA2   BD3B65   BD3D78 18084470       25ms     43k       1us    6ms   0   657FE5   8284F7   876E9D   878F95 010715C0       25ms     41      603us    3ms -99   4DC7DD   4E1D0F 01179690       10ms    212k       0us    0ms  -2   BECEA1   BEE098   BF35DD 0117929C        7ms    361       21us    2ms   0   BD16A9   BD1B4B   BD1D49   BD3B5C 18072124        5ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 PerfData3::print_summary: time  130   tt:  0.7s   tc:383k18084570      258ms     47     5476us   37ms   0   828509   873172   88B93C 01178814      132ms     20k       7us   31ms   0   BCEF29   BCF122 01073AB4       56ms    522      107us   54ms  -2   58A85B   58BCF6   58BE20   58C9E3 037A4870       85ms   8579       10us   14ms   0   86E23A   86E55A 1808905C       58ms      8     7171us   17ms   0   BC9DBE   BCB86B 011792B4       20ms     14     1397us   18ms   0   BD1DA2   BD3B65   BD3D78 18084470       24ms     44k       1us    6ms   0   657FE5   8284F7   876E9D   878F95 010715C0       25ms     41      596us    3ms -99   4DC7DD   4E1D0F 01179690       10ms    212k       0us    0ms  -2   BECEA1   BEE098   BF35DD 0117929C        7ms    361       20us    2ms   0   BD16A9   BD1B4B   BD1D49   BD3B5C 18072124        5ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 PerfData3::print_summary: time  144   tt:  0.7s   tc:384k18084570      255ms     47     5423us   37ms   0   828509   873172   88B93C 01178814      130ms     20k       7us   31ms   0   BCEF29   BCF122 01073AB4       55ms    522      106us   53ms  -2   58A85B   58BCF6   58BE20   58C9E3 037A4870       84ms   8579       10us   13ms   0   86E23A   86E55A 1808905C       58ms      8     7102us   17ms   0   BC9DBE   BCB86B 011792B4       20ms     14     1384us   18ms   0   BD1DA2   BD3B65   BD3D78 18084470       24ms     45k       1us    6ms   0   657FE5   8284F7   876E9D   878F95 010715C0       24ms     41      590us    3ms -99   4DC7DD   4E1D0F 01179690       10ms    212k       0us    0ms  -2   BECEA1   BEE098   BF35DD 0117929C        7ms    361       20us    2ms   0   BD16A9   BD1B4B   BD1D49   BD3B5C 18072124        5ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 PerfData3::print_summary: time  157   tt:  0.7s   tc:385k18084570      254ms     47     5382us   37ms   0   828509   873172   88B93C 01178814      129ms     20k       7us   31ms   0   BCEF29   BCF122 01073AB4       55ms    522      105us   53ms  -2   58A85B   58BCF6   58BE20   58C9E3 037A4870       83ms   8579       10us   13ms   0   86E23A   86E55A 1808905C       57ms      8     7048us   17ms   0   BC9DBE   BCB86B 011792B4       19ms     14     1373us   17ms   0   BD1DA2   BD3B65   BD3D78 18084470       24ms     46k       1us    6ms   0   657FE5   8284F7   876E9D   878F95 010715C0       24ms     41      586us    3ms -99   4DC7DD   4E1D0F 01179690       10ms    212k       0us    0ms  -2   BECEA1   BEE098   BF35DD 0117929C        7ms    361       20us    2ms   0   BD16A9   BD1B4B   BD1D49   BD3B5C 18072124        5ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 PerfData3::print_summary: time  177   tt:  0.7s   tc:387k18084570      251ms     47     5332us   36ms   0   828509   873172   88B93C 01178814      128ms     20k       7us   31ms   0   BCEF29   BCF122 01073AB4       54ms    522      104us   52ms  -2   58A85B   58BCF6   58BE20   58C9E3 037A4870       83ms   8579       10us   13ms   0   86E23A   86E55A 1808905C       57ms      8     6982us   17ms   0   BC9DBE   BCB86B 011792B4       19ms     14     1360us   17ms   0   BD1DA2   BD3B65   BD3D78 18084470       24ms     47k       1us    6ms   0   657FE5   8284F7   876E9D   878F95 010715C0       24ms     41      581us    3ms -99   4DC7DD   4E1D0F 01179690       10ms    213k       0us    0ms  -2   BECEA1   BEE098   BF35DD 0117929C        7ms    361       20us    2ms   0   BD16A9   BD1B4B   BD1D49   BD3B5C 18072124        5ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 PerfData3::print_summary: time  194   tt:  0.7s   tc:388k18084570      250ms     47     5299us   36ms   0   828509   873172   88B93C 01178814      127ms     20k       6us   30ms   0   BCEF29   BCF122 01073AB4       54ms    522      103us   52ms  -2   58A85B   58BCF6   58BE20   58C9E3 037A4870       82ms   8579       10us   13ms   0   86E23A   86E55A 1808905C       56ms      8     6939us   17ms   0   BC9DBE   BCB86B 011792B4       19ms     14     1352us   17ms   0   BD1DA2   BD3B65   BD3D78 18084470       24ms     48k       0us    6ms   0   657FE5   8284F7   876E9D   878F95 010715C0       24ms     41      577us    3ms -99   4DC7DD   4E1D0F 01179690       10ms    213k       0us    0ms  -2   BECEA1   BEE098   BF35DD 0117929C        7ms    361       20us    2ms   0   BD16A9   BD1B4B   BD1D49   BD3B5C 18072124        4ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 PerfData3::print_summary: time  205   tt:  0.7s   tc:442k18084570      249ms     47     5279us   36ms   0   828509   873172   88B93C 01178814      127ms     20k       6us   30ms   0   BCEF29   BCF122 01073AB4       54ms    525      102us   52ms  -2   58A85B   58BBB4   58BCF6   58BE20 037A4870       82ms   8579       10us   13ms   0   86E23A   86E55A 1808905C       56ms      8     6913us   17ms   0   BC9DBE   BCB86B 011792B4       19ms     14     1347us   17ms   0   BD1DA2   BD3B65   BD3D78 18084470       24ms     49k       0us    6ms   0   657FE5   8284F7   876E9D   878F95 010715C0       24ms     41      575us    3ms -99   4DC7DD   4E1D0F 01179690       12ms    265k       0us    0ms  -2   BECEA1   BEE098   BF35DD 0117929C        7ms    361       20us    2ms   0   BD16A9   BD1B4B   BD1D49   BD3B5C 18072124        5ms     94k       0us    0ms   0   823FE9   8241BC   824270   8242D2 

crit_sec_mode 3 Light-Critical-Section mode 6:

thead 12E0 assigned PT 03880BE8, serial# 0console interface not foundcrit_sec_mode 3: spincounts + fairness + profiling/debugingLight-Critical-Section mode 6: priority + profilingMemoryHeap Optimization Mode 0: Not optimizing MemoryHeaphook point 1: using DX8 mouse codePerfData3::print_summary: time    1   tt:  0.0s   tc:1k18072124        0ms    985        0us    0ms   0   823FE9   8241BC   824270 18BF94B0        0ms     13        0us    0ms   0   857008   8570BD thead 0B8C assigned PT 03887980, serial# 1Special crit. sec. 1 (@ 17004ED0, thread 12E0, inited from A6114E) spin 2000 -> 2000Special crit. sec. 2 (@ 17004F10, thread 12E0, inited from 90A62B) spin 1000 -> 1000Special crit. sec. 3 (@ 2C002420, thread 12E0, inited from 9835B9) spin 4000 -> 4000Special crit. sec. 4 (@ 17004B90, thread 12E0, inited from 905CB3) spin 4000 -> 4000Special crit. sec. 5 (@ 17004AD0, thread 12E0, inited from 905D6F) spin 4000 -> 4000thead 1284 assigned PT 03887990, serial# 2thead 00B0 assigned PT 03887B70, serial# 3time    5.00: 3:1:0088B93C waited on CS 18084570 for    2 ms (init -2)thead 0B54 assigned PT 03887B80, serial# 4thead 1030 assigned PT 03887B90, serial# 5time    5.34: 3:1:0088B93C waited on CS 18084570 for    3 ms (init -2)time    5.34: 5:0:0086D7EA waited on CS 03b50044 for    7 ms (init -99)time    5.35: 3:1:0088B93C waited on CS 18084570 for   10 ms (init -2)time    5.35: 4:0:00878F95 waited on CS 18084470 for    3 ms (init -3)time    5.36: 5:0:0086D7EA waited on CS 03b5fbfc for   11 ms (init -99)time    5.49: 3:0:0088B93C waited on CS 18084570 for    5 ms (init -2)time    5.68: 3:0:0088B93C waited on CS 18084570 for    2 ms (init -2)time    5.69: 3:0:0088B93C waited on CS 18084570 for    5 ms (init -2)initialize2() running in thread 12e0Suppressing CRITICAL_SECTION Renderer+0x180 (18084570)PerfData3::print_summary: time   11   tt:  0.1s   tc:191k18084570       37ms     13     2794us   13ms   0   828509   873172   88B93C 03B5FBFC       15ms      1    13191us   15ms -99   86D7EA 03B50044        9ms     83      111us    9ms -99   86D7EA   86D94C 01179690        9ms    175k       0us    0ms  -2   BECEA1   BEE098   BF35DD 18084470        4ms    657        6us    4ms   0   657FE5   8284F7   878F95   8790E0 03B44870        3ms     96       28us    1ms   0   86E23A   86E55A 18072124        1ms     15k       0us    0ms   0   823FE9   8241BC   824270 0106E5A0        0ms      7       54us    0ms -99   42364D   58791B   AE7D33   BD68CF 03B52114        0ms     17       16us    0ms -99   86D7EA   86D94C thead 0E08 assigned PT 0388FB28, serial# 6thead 0E20 assigned PT 0388FBE8, serial# 7thead 11FC assigned PT 0388FBF8, serial# 8Special crit. sec. 6 (@ 2C0107A0, thread 12E0, inited from 9835B9) spin 4000 -> 4000Special crit. sec. 7 (@ 171096D0, thread 12E0, inited from 905CB3) spin 4000 -> 4000Special crit. sec. 8 (@ 17109610, thread 12E0, inited from 905D6F) spin 4000 -> 4000time   15.94: 4:0:00878F95 waited on CS 18084470 for    6 ms (init -3)thead 0A9C assigned PT 0388FC08, serial# 9time   16.22: 9:1:0086E23A waited on CS 03b44870 for    4 ms (init -2)time   16.22: 9:1:00471225 waited on CS 0106e5a0 for    4 ms (init -99)time   16.24: 4:0:00878F95 waited on CS 18084470 for    2 ms (init -2)time   16.45: 4:1:00878F95 waited on CS 18084470 for    3 ms (init -3)time   17.16: 4:0:00878F95 waited on CS 18084470 for    3 ms (init -3)time   17.21: 4:0:00878F95 waited on CS 18084470 for    4 ms (init -3)time   17.32: 9:1:0086D7EA waited on CS 03b5ca5c for    4 ms (init -99)time   17.41: 9:1:0042364D waited on CS 0106e5a0 for    8 ms (init -99)time   17.45: 9:1:008F3C16 waited on CS 010f2c40 for    3 ms (init -99)time   17.47: 9:1:00ADE578 waited on CS 0106e5a0 for   12 ms (init -99)time   17.49: 9:1:0086D7EA waited on CS 03b5ca5c for    3 ms (init -99)time   17.80: 0:1:0086E55A waited on CS 03b44870 for    9 ms (init -2)time   17.80: 9:0:0086E23A waited on CS 03b44870 for    3 ms (init -4)time   17.85: 9:0:0086E23A waited on CS 03b44870 for    4 ms (init -4)time   17.86: 9:1:0086E55A waited on CS 03b44870 for    5 ms (init -8)time   17.87: 9:1:0086E23A waited on CS 03b44870 for    6 ms (init -4)time   17.87: 4:0:0086E23A waited on CS 03b44870 for    6 ms (init -4)time   17.88: 4:0:00878F95 waited on CS 18084470 for    3 ms (init -3)time   18.46: 0:0:0058D262 waited on CS 01073ab4 for  171 ms (init -5)time   18.46: 4:1:0058A85B waited on CS 01073ab4 for    2 ms (init -2)thead 0CB8 assigned PT 0388FC18, serial# 10thead 0BE8 assigned PT 0388FC78, serial# 11thead 138C assigned PT 08C768D8, serial# 12thead 01D0 assigned PT 08C768E8, serial# 13thead 11EC assigned PT 08C768F8, serial# 14time   19.18: 0:1:0086E55A waited on CS 03b44870 for    4 ms (init -2)time   19.24: 0:0:0086E23A waited on CS 03b44870 for   26 ms (init 0)PerfData3::print_summary: time   22   tt:  0.4s   tc:325k01073AB4      165ms    523      315us  163ms  -2   58A85B   58BCF6   58BE20   58C9E3 03B44870      103ms   9532       11us   25ms   0   86E23A   86E55A 18084570       34ms     13     2616us   13ms   0   828509   873172   88B93C 0106E5A0       31ms    634       49us   12ms -99   42364D   471225   58791B   845744 18084470       28ms   3673        8us    5ms   0   657FE5   8284F7   876E9D   878F95 03B5FBFC       14ms      3     4384us   14ms -99   86D7EA 03B50044        9ms    155       61us    8ms -99   86D7EA   86D94C 03B5CA5C       11ms    224       51us    4ms -99   86D7EA   86D94C 01179690       10ms    214k       0us    0ms  -2   BECEA1   BEE098   BF35DD 010F2C40        3ms      6      479us    3ms -99   8D21DC   8F3C16 18072124        5ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 03B563EC        1ms      6      227us    1ms -99   86D7EA 011792B4        2ms      6      278us    1ms   0   BD1DA2   BD3B65 03B5E32C        1ms      2      557us    1ms -99   86D7EA 18F780E0        1ms      3      282us    1ms   0   BCA6BC   BCB86B PerfData3::print_summary: time   32   tt:  0.4s   tc:338k01073AB4      154ms    523      295us  153ms  -2   58A85B   58BCF6   58BE20   58C9E3 03B44870       99ms   9601       10us   23ms   0   86E23A   86E55A 18084570       32ms     13     2449us   12ms   0   828509   873172   88B93C 0106E5A0       29ms    637       46us   11ms -99   42364D   471225   58791B   845744 18084470       27ms     13k       2us    5ms   0   657FE5   8284F7   876E9D   878F95 03B5FBFC       13ms      3     4104us   13ms -99   86D7EA 03B50044        9ms    209       43us    8ms -99   86D7EA   86D94C 03B5CA5C       11ms    224       48us    4ms -99   86D7EA   86D94C 01179690       10ms    217k       0us    0ms  -2   BECEA1   BEE098   BF35DD 010F2C40        3ms      6      448us    3ms -99   8D21DC   8F3C16 18072124        4ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 010715C0        3ms      8      408us    1ms -99   4DC7DD   4E1D0F 0106C980        3ms    174       15us    1ms -99   40A333   40A540   40A6C4   41B279 03B563EC        1ms      6      212us    1ms -99   86D7EA 011792B4        2ms      9      196us    1ms   0   BD1DA2   BD3B65 03B5E32C        1ms      2      521us    1ms -99   86D7EA 18F780E0        1ms      3      264us    1ms   0   BCA6BC   BCB86B time   32.77: 2:1:0086E23A waited on CS 03b44870 for    3 ms (init -2)time   35.29: 5:0:004DC7DD waited on CS 010715c0 for    4 ms (init -99)time   35.38: 0:0:0086E23A waited on CS 03b44870 for    4 ms (init -2)time   36.59: 5:0:00AE428D waited on CS 0116fca0 for    5 ms (init -99)time   41.06: 5:0:0040A540 waited on CS 0106c980 for    2 ms (init -99)PerfData3::print_summary: time   43   tt:  0.4s   tc:348k01073AB4      149ms    523      285us  147ms  -2   58A85B   58BCF6   58BE20   58C9E3 03B44870      104ms   9850       11us   23ms   0   86E23A   86E55A 18084570       31ms     13     2366us   11ms   0   828509   873172   88B93C 0106E5A0       28ms    642       44us   11ms -99   42364D   471225   58791B   845744 18084470       27ms     21k       1us    5ms   0   657FE5   8284F7   876E9D   878F95 03B5FBFC       12ms      3     3964us   12ms -99   86D7EA 03B50044        9ms    245       36us    8ms -99   86D7EA   86D94C 010715C0       11ms     16      700us    4ms -99   4DC7DD   4E1D0F 03B5CA5C       10ms    224       46us    3ms -99   86D7EA   86D94C 01179690        9ms    219k       0us    0ms  -2   BECEA1   BEE098   BF35DD 0116FCA0        5ms      1     4241us    5ms -99   AE428D 0106C980        5ms    238       22us    2ms -99   40A333   40A540   40A6C4   41B279 010F2C40        3ms      6      433us    3ms -99   8D21DC   8F3C16 18072124        4ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 03B563EC        1ms      6      205us    1ms -99   86D7EA 011792B4        2ms      9      189us    1ms   0   BD1DA2   BD3B65 03B5E32C        1ms      2      503us    1ms -99   86D7EA 18F780E0        1ms      3      255us    1ms   0   BCA6BC   BCB86B time   46.01: 5:0:00AE428D waited on CS 0116fca0 for    6 ms (init -99)time   48.65: 5:0:00AE428D waited on CS 0116fca0 for    6 ms (init -99)time   50.06: 4:0:00BD1DA2 waited on CS 011792b4 for   14 ms (init -2)time   50.20: 5:1:0040A540 waited on CS 0106c980 for    3 ms (init -99)time   50.64: 5:0:00AE428D waited on CS 0116fca0 for    8 ms (init -99)PerfData3::print_summary: time   55   tt:  0.4s   tc:355k01073AB4      146ms    523      279us  144ms  -2   58A85B   58BCF6   58BE20   58C9E3 03B44870      103ms   9869       10us   22ms   0   86E23A   86E55A 18084570       30ms     13     2316us   11ms   0   828509   873172   88B93C 0106E5A0       28ms    644       43us   10ms -99   42364D   471225   58791B   845744 0116FCA0       24ms      5     4687us    8ms -99   AE428D 18084470       27ms     28k       1us    5ms   0   657FE5   8284F7   876E9D   878F95 011792B4       16ms     21      749us   14ms   0   BD1DA2   BD3B65 03B5FBFC       12ms      3     3881us   12ms -99   86D7EA 03B50044        9ms    274       32us    7ms -99   86D7EA   86D94C 010715C0       11ms     16      686us    4ms -99   4DC7DD   4E1D0F 03B5CA5C       10ms    224       45us    3ms -99   86D7EA   86D94C 0106C980        9ms    263       33us    3ms -99   40A333   40A540   40A6C4   41B279 01179690        9ms    219k       0us    0ms  -2   BECEA1   BEE098   BF35DD 010F2C40        3ms      6      424us    3ms -99   8D21DC   8F3C16 18072124        4ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 03B563EC        1ms      6      201us    1ms -99   86D7EA 03B5E32C        1ms      2      493us    1ms -99   86D7EA 18F780E0        1ms      3      249us    1ms   0   BCA6BC   BCB86B time   55.68: 5:1:00AE428D waited on CS 0116fca0 for   11 ms (init -99)time   55.72: 5:0:00AE428D waited on CS 0116fca0 for   10 ms (init -99)time   55.79: 5:0:00AE428D waited on CS 0116fca0 for    6 ms (init -99)time   57.75: 5:0:00AE428D waited on CS 0116fca0 for    5 ms (init -99)time   59.46: 5:0:00AE428D waited on CS 0116fca0 for    6 ms (init -99)time   59.50: 5:0:00AE428D waited on CS 0116fca0 for    6 ms (init -99)time   59.83: 5:0:00AE428D waited on CS 0116fca0 for    8 ms (init -99)time   61.80: 5:0:0040A540 waited on CS 0106c980 for    5 ms (init -99)time   62.55: 5:0:0086D7EA waited on CS 03b50044 for    4 ms (init -99)time   63.27: 5:0:00AE428D waited on CS 0116fca0 for    5 ms (init -99)time   63.29: 5:0:00AE428D waited on CS 0116fca0 for   13 ms (init -99)PerfData3::print_summary: time   65   tt:  0.5s   tc:361k01073AB4      144ms    523      276us  143ms  -2   58A85B   58BCF6   58BE20   58C9E3 03B44870      101ms   9872       10us   22ms   0   86E23A   86E55A 0116FCA0       94ms     14     6688us   13ms -99   AE428D 18084570       30ms     13     2288us   11ms   0   828509   873172   88B93C 0106E5A0       27ms    644       43us   10ms -99   42364D   471225   58791B   845744 18084470       27ms     33k       1us    4ms   0   657FE5   8284F7   876E9D   878F95 011792B4       16ms     21      740us   13ms   0   BD1DA2   BD3B65 03B5FBFC       12ms      3     3835us   12ms -99   86D7EA 03B50044       13ms    277       46us    7ms -99   86D7EA   86D94C 0106C980       13ms    275       48us    5ms -99   40A333   40A540   40A6C4   41B279 010715C0       11ms     16      677us    4ms -99   4DC7DD   4E1D0F 03B5CA5C       10ms    224       45us    3ms -99   86D7EA   86D94C 01179690        9ms    219k       0us    0ms  -2   BECEA1   BEE098   BF35DD 010F2C40        3ms      6      419us    3ms -99   8D21DC   8F3C16 18072124        4ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 03B563EC        1ms      6      198us    1ms -99   86D7EA 03B5E32C        1ms      2      487us    1ms -99   86D7EA time   66.88: C:1:0086E23A waited on CS 03b44870 for   36 ms (init -2)time   66.88: 5:0:0086E55A waited on CS 03b44870 for   36 ms (init -4)time   68.27: 5:0:00AE428D waited on CS 0116fca0 for   92 ms (init -99)time   68.41: 5:0:00AE428D waited on CS 0116fca0 for  118 ms (init -99)time   74.26: 5:0:00AE428D waited on CS 0116fca0 for  123 ms (init -99)time   74.40: 5:0:00AE428D waited on CS 0116fca0 for  110 ms (init -99)time   77.32: 5:0:00AE428D waited on CS 0116fca0 for   80 ms (init -99)PerfData3::print_summary: time   77   tt:  1.1s   tc:364k0116FCA0      616ms     19    32265us  123ms -99   AE428D 01073AB4      143ms    523      273us  141ms  -2   58A85B   58BCF6   58BE20   58C9E3 03B44870      173ms     11k      15us   36ms   0   86E23A   86E55A 18084570       30ms     13     2266us   11ms   0   828509   873172   88B93C 0106E5A0       27ms    644       42us   10ms -99   42364D   471225   58791B   845744 18084470       27ms     35k       1us    4ms   0   657FE5   8284F7   876E9D   878F95 011792B4       15ms     21      733us   13ms   0   BD1DA2   BD3B65 03B5FBFC       12ms      3     3798us   12ms -99   86D7EA 03B50044       13ms    277       46us    7ms -99   86D7EA   86D94C 0106C980       13ms    275       48us    4ms -99   40A333   40A540   40A6C4   41B279 010715C0       11ms     16      671us    4ms -99   4DC7DD   4E1D0F 03B5CA5C       10ms    224       44us    3ms -99   86D7EA   86D94C 01179690        9ms    219k       0us    0ms  -2   BECEA1   BEE098   BF35DD 010F2C40        3ms      6      415us    3ms -99   8D21DC   8F3C16 18072124        4ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 0117929C        2ms     71       24us    2ms   0   BD16A9   BD1B4B   BD1D49   BD3B5C time   77.42: 5:0:00AE428D waited on CS 0116fca0 for   77 ms (init -99)time   80.97: 5:0:00AE428D waited on CS 0116fca0 for   77 ms (init -99)time   81.08: 5:0:00AE428D waited on CS 0116fca0 for   76 ms (init -99)time   84.09: 5:0:00AE428D waited on CS 0116fca0 for  117 ms (init -99)time   87.81: 5:0:00AE428D waited on CS 0116fca0 for  114 ms (init -99)PerfData3::print_summary: time   87   tt:  1.6s   tc:365k0116FCA0     1071ms     24    44455us  122ms -99   AE428D 01073AB4      142ms    523      271us  140ms  -2   58A85B   58BCF6   58BE20   58C9E3 03B44870      172ms     11k      15us   35ms   0   86E23A   86E55A 18084570       29ms     13     2252us   11ms   0   828509   873172   88B93C 0106E5A0       27ms    644       42us   10ms -99   42364D   471225   58791B   845744 18084470       27ms     36k       1us    4ms   0   657FE5   8284F7   876E9D   878F95 011792B4       15ms     21      729us   13ms   0   BD1DA2   BD3B65 03B5FBFC       12ms      3     3773us   12ms -99   86D7EA 03B50044       13ms    277       45us    7ms -99   86D7EA   86D94C 0106C980       13ms    275       48us    4ms -99   40A333   40A540   40A6C4   41B279 010715C0       11ms     16      667us    4ms -99   4DC7DD   4E1D0F 03B5CA5C       10ms    224       44us    3ms -99   86D7EA   86D94C 01179690        9ms    219k       0us    0ms  -2   BECEA1   BEE098   BF35DD 010F2C40        3ms      6      412us    3ms -99   8D21DC   8F3C16 18072124        4ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 time   87.95: 5:0:00AE428D waited on CS 0116fca0 for  115 ms (init -99)PerfData3::print_summary: time   97   tt:  1.7s   tc:366k0116FCA0     1180ms     25    47026us  122ms -99   AE428D 01073AB4      141ms    523      270us  140ms  -2   58A85B   58BCF6   58BE20   58C9E3 03B44870      171ms     11k      15us   35ms   0   86E23A   86E55A 18084570       29ms     13     2241us   11ms   0   828509   873172   88B93C 0106E5A0       27ms    644       42us   10ms -99   42364D   471225   58791B   845744 18084470       27ms     37k       1us    4ms   0   657FE5   8284F7   876E9D   878F95 011792B4       15ms     21      725us   13ms   0   BD1DA2   BD3B65 03B5FBFC       12ms      3     3755us   12ms -99   86D7EA 03B50044       12ms    277       45us    7ms -99   86D7EA   86D94C 0106C980       13ms    275       47us    4ms -99   40A333   40A540   40A6C4   41B279 010715C0       11ms     16      663us    4ms -99   4DC7DD   4E1D0F 03B5CA5C       10ms    224       44us    3ms -99   86D7EA   86D94C 01179690        9ms    219k       0us    0ms  -2   BECEA1   BEE098   BF35DD 010F2C40        3ms      6      410us    2ms -99   8D21DC   8F3C16 18072124        4ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 PerfData3::print_summary: time  116   tt:  1.7s   tc:368k0116FCA0     1172ms     25    46703us  121ms -99   AE428D 01073AB4      140ms    523      268us  139ms  -2   58A85B   58BCF6   58BE20   58C9E3 03B44870      170ms     11k      15us   35ms   0   86E23A   86E55A 18084570       29ms     13     2225us   11ms   0   828509   873172   88B93C 0106E5A0       27ms    644       41us   10ms -99   42364D   471225   58791B   845744 18084470       27ms     38k       1us    4ms   0   657FE5   8284F7   876E9D   878F95 011792B4       15ms     21      720us   13ms   0   BD1DA2   BD3B65 03B5FBFC       12ms      3     3729us   12ms -99   86D7EA 03B50044       12ms    277       45us    7ms -99   86D7EA   86D94C 0106C980       13ms    275       47us    4ms -99   40A333   40A540   40A6C4   41B279 010715C0       11ms     16      659us    4ms -99   4DC7DD   4E1D0F 03B5CA5C       10ms    224       43us    3ms -99   86D7EA   86D94C 01179690        9ms    220k       0us    0ms  -2   BECEA1   BEE098   BF35DD 010F2C40        2ms      6      407us    2ms -99   8D21DC   8F3C16 18072124        4ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 PerfData3::print_summary: time  127   tt:  1.7s   tc:471k0116FCA0     1169ms     25    46571us  121ms -99   AE428D 01073AB4      140ms    528      265us  138ms  -2   58A85B   58BBB4   58BCF6   58BE20 03B44870      169ms     11k      15us   35ms   0   86E23A   86E55A 18084570       29ms     13     2219us   11ms   0   828509   873172   88B93C 0106E5A0       27ms    644       41us   10ms -99   42364D   471225   58791B   845744 18084470       27ms     39k       1us    4ms   0   657FE5   8284F7   876E9D   878F95 011792B4       15ms     21      718us   13ms   0   BD1DA2   BD3B65 03B5FBFC       12ms      3     3719us   12ms -99   86D7EA 03B50044       12ms    277       45us    7ms -99   86D7EA   86D94C 0106C980       13ms    275       47us    4ms -99   40A333   40A540   40A6C4   41B279 010715C0       11ms     16      657us    4ms -99   4DC7DD   4E1D0F 03B5CA5C       10ms    224       43us    3ms -99   86D7EA   86D94C 01179690       13ms    317k       0us    0ms  -2   BECEA1   BEE098   BF35DD 010F2C40        2ms      6      406us    2ms -99   8D21DC   8F3C16 18072124        4ms     96k       0us    0ms   0   823FE9   8241BC   824270   8242D2 

crit_sec_mode 3 Light-Critical-Section mode 3 and iCriticalSectionSupression=3 just for fun

thead 1338 assigned PT 14C20BE8, serial# 0console interface not foundcrit_sec_mode 3: spincounts + fairness + profiling/debugingLight-Critical-Section mode 3: adding spin & profilingMemoryHeap Optimization Mode 0: Not optimizing MemoryHeaphook point 1: using DX8 mouse codePerfData3::print_summary: time    1   tt:  0.0s   tc:1k03732124        0ms    985        0us    0ms   0   823FE9   8241BC   824270 042B94B0        0ms     13        0us    0ms   0   857008   8570BD thead 0424 assigned PT 14C27980, serial# 1Special crit. sec. 1 (@ 24004ED0, thread 1338, inited from A6114E) spin 2000 -> 2000Special crit. sec. 2 (@ 24004F10, thread 1338, inited from 90A62B) spin 1000 -> 1000Special crit. sec. 3 (@ 2C002420, thread 1338, inited from 9835B9) spin 4000 -> 4000Special crit. sec. 4 (@ 24004B90, thread 1338, inited from 905CB3) spin 4000 -> 4000Special crit. sec. 5 (@ 24004AD0, thread 1338, inited from 905D6F) spin 4000 -> 4000thead 0A9C assigned PT 14C27990, serial# 2thead 0F28 assigned PT 14C27B70, serial# 3thead 01D0 assigned PT 14C27B80, serial# 4time    5.10: 0:0:0086D7EA waited on CS 10010044 for    6 ms (init -99)time    5.45: 3:0:0088B93C waited on CS 03744570 for    6 ms (init -2)initialize2() running in thread 1338Suppressing CRITICAL_SECTION Renderer+0x180 (3744570)Suppressing CRITICAL_SECTION Renderer+0x80 (3744470)PerfData3::print_summary: time   11   tt:  0.0s   tc:191k03744570       10ms      4     2384us    8ms   0   828509   88B93C 10010044        8ms    117       67us    8ms -99   86D7EA   86D94C 01179690       10ms    175k       0us    1ms  -2   BECEA1   BEE098   BF35DD 037CB028        1ms      3      436us    1ms   0   BC9DBE   BCA6BC   BCB86B 03732124        1ms     15k       0us    0ms   0   823FE9   8241BC   824270 03744470        0ms    152        2us    0ms   0   657FE5   8284F7   878F95   8790E0 036E4870        0ms     34        8us    0ms  -2   86E23A   86E55A 10012114        0ms     15        6us    0ms -99   86D7EA   86D94C thead 0E10 assigned PT 14C27B90, serial# 5thead 1234 assigned PT 14C2FA08, serial# 6thead 1258 assigned PT 14C2FA18, serial# 7Special crit. sec. 6 (@ 2C0107A0, thread 1338, inited from 9835B9) spin 4000 -> 4000Special crit. sec. 7 (@ 241096D0, thread 1338, inited from 905CB3) spin 4000 -> 4000Special crit. sec. 8 (@ 24109610, thread 1338, inited from 905D6F) spin 4000 -> 4000thead 02D8 assigned PT 14C2FA28, serial# 8time   18.10: 8:0:0086E23A waited on CS 036e4870 for    6 ms (init -4)time   19.00: 8:1:0086E23A waited on CS 036e4870 for    7 ms (init -4)time   19.28: 3:1:0086E23A waited on CS 036e4870 for    4 ms (init -6)time   19.28: 8:0:0086E23A waited on CS 036e4870 for    4 ms (init -4)time   19.29: 2:1:0086D7EA waited on CS 1001b98c for    6 ms (init -99)time   19.29: 8:0:0086D7EA waited on CS 1001b98c for   11 ms (init -99)time   19.61: 8:0:0086E23A waited on CS 036e4870 for    5 ms (init -2)time   19.68: 8:1:0086E23A waited on CS 036e4870 for    2 ms (init -6)time   19.68: 3:1:0086E55A waited on CS 036e4870 for    2 ms (init -4)time   19.69: 2:1:00878FA2 waited on CS 037444f0 for    8 ms (init -2)time   20.19: 0:0:0058D262 waited on CS 01073ab4 for   98 ms (init -4)thead 13A8 assigned PT 14C2FA38, serial# 9thead 11E0 assigned PT 14C2FAA8, serial# 10thead 0C74 assigned PT 14C2FD18, serial# 11thead 0944 assigned PT 14A657F8, serial# 12thead 130C assigned PT 14A65808, serial# 13thead 127C assigned PT 14A65818, serial# 14time   21.09: C:1:00BCF1B8 waited on CS 059f8b5c for    3 ms (init -2)time   21.87: A:1:00BCF1B8 waited on CS 059f8b5c for    4 ms (init -2)PerfData3::print_summary: time   21   tt:  0.2s   tc:320k01073AB4       98ms    522      187us   96ms  -2   58A85B   58BCF6   58BE20   58C9E3 036E4870       55ms   7704        7us    7ms   0   86E23A   86E55A 1001B98C       17ms      8     2050us   11ms -99   86D7EA 037444F0       17ms     11     1533us    8ms   0   828500   876EA6   878FA2 03744570       10ms      4     2329us    8ms   0   828509   88B93C 10010044        9ms    221       39us    7ms -99   86D7EA   86D94C 01179690       13ms    213k       0us    1ms  -2   BECEA1   BEE098   BF35DD 059F8B5C        7ms      4     1688us    4ms   0   BCF1B8   BCF421 03732124        5ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 011792B4        3ms     11      256us    1ms   0   BD1DA2   BD3B65 043F0A94        2ms      3      553us    1ms   0   BCA6BC   BCB86B 037CB028        1ms      3      426us    1ms   0   BC9DBE   BCA6BC   BCB86B 0108F080        1ms      1      791us    1ms -99   829370 10012114        1ms     61       13us    1ms -99   86D7EA   86D94C 01178814        1ms     42       23us    0ms  -2   BCEF29   BCF122 time   23.34: A:1:00BCF1B8 waited on CS 059f8b5c for    3 ms (init -2)time   28.55: 0:0:0086E23A waited on CS 036e4870 for    3 ms (init -2)time   29.35: E:0:00BCF1B8 waited on CS 059f8b5c for    3 ms (init -2)time   30.49: C:1:00BCF1B8 waited on CS 059f8b5c for    2 ms (init -2)time   31.61: B:1:00BCF1B8 waited on CS 059f8b5c for    3 ms (init -2)time   31.61: E:0:00BCF1B8 waited on CS 059f8b5c for    2 ms (init -6)PerfData3::print_summary: time   33   tt:  0.3s   tc:325k01073AB4       89ms    522      171us   88ms  -2   58A85B   58BCF6   58BE20   58C9E3 036E4870       60ms   8071        7us    6ms   0   86E23A   86E55A 059F8B5C       22ms     77      292us    4ms   0   BCEFB8   BCF1B8   BCF421 1001B98C       15ms      8     1875us   10ms -99   86D7EA 037444F0       16ms     11     1402us    7ms   0   828500   876EA6   878FA2 03744570        9ms      4     2129us    8ms   0   828509   88B93C 10010044        8ms    264       31us    7ms -99   86D7EA   86D94C 01179690       12ms    217k       0us    1ms  -2   BECEA1   BEE098   BF35DD 0117929C        6ms    441       15us    1ms   0   BD1B4B   BD1D49   BD3B5C 010715C0        6ms     12      476us    1ms -99   4DC7DD 03732124        5ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 011792B4        3ms     11      234us    0ms   0   BD1DA2   BD3B65 0106C980        2ms    561        3us    1ms -99   40A333   40A403   40A540   40A6C4 043F0A94        2ms      3      506us    1ms   0   BCA6BC   BCB86B 037CB028        1ms      3      389us    1ms   0   BC9DBE   BCA6BC   BCB86B 0108F080        1ms      1      723us    1ms -99   829370 01178814        1ms     68       20us    0ms  -1   BCEF29   BCF122 10012114        1ms     61       12us    1ms -99   86D7EA   86D94C PerfData3::print_summary: time   53   tt:  0.3s   tc:328k01073AB4       84ms    522      162us   83ms  -2   58A85B   58BCF6   58BE20   58C9E3 036E4870       64ms   8378        8us    6ms   0   86E23A   86E55A 059F8B5C       27ms    142      189us    4ms   0   BCEFB8   BCF1B8   BCF421 1001B98C       14ms      8     1770us    9ms -99   86D7EA 037444F0       15ms     11     1324us    7ms   0   828500   876EA6   878FA2 03744570        8ms      4     2010us    7ms   0   828509   88B93C 10010044        8ms    331       23us    6ms -99   86D7EA   86D94C 010715C0       12ms     22      522us    1ms -99   4DC7DD   4E1D0F 01179690       12ms    219k       0us    1ms  -2   BECEA1   BEE098   BF35DD 0117929C       10ms    731       13us    1ms   0   BD1B4B   BD1D49   BD3B5C 03732124        4ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 011792B4        3ms     16      176us    0ms   0   BD1DA2   BD3B65 0106C980        2ms    980        2us    1ms -99   40A333   40A403   40A540   40A6C4 043F0A94        1ms      3      478us    1ms   0   BCA6BC   BCB86B 037CB028        1ms      3      368us    1ms   0   BC9DBE   BCA6BC   BCB86B 0108F080        1ms      1      683us    1ms -99   829370 01178814        1ms     68       19us    0ms  -1   BCEF29   BCF122 10012114        1ms     61       11us    1ms -99   86D7EA   86D94C PerfData3::print_summary: time   69   tt:  0.3s   tc:329k01073AB4       83ms    522      158us   81ms  -2   58A85B   58BCF6   58BE20   58C9E3 036E4870       65ms   9022        7us    6ms   0   86E23A   86E55A 059F8B5C       28ms    162      176us    4ms   0   BCEFB8   BCF1B8   BCF421 1001B98C       14ms      8     1733us    9ms -99   86D7EA 037444F0       14ms     11     1296us    7ms   0   828500   876EA6   878FA2 010715C0       17ms     30      568us    1ms -99   4DC7DD   4E1D0F 03744570        8ms      4     1968us    7ms   0   828509   88B93C 10010044        8ms    336       22us    6ms -99   86D7EA   86D94C 01179690       12ms    219k       0us    1ms  -2   BECEA1   BEE098   BF35DD 0117929C       10ms    740       13us    1ms   0   BD1B4B   BD1D49   BD3B5C 03732124        4ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 011792B4        3ms     16      172us    0ms   0   BD1DA2   BD3B65 0106C980        2ms    992        2us    1ms -99   40A333   40A403   40A540   40A6C4 043F0A94        1ms      3      468us    1ms   0   BCA6BC   BCB86B 037CB028        1ms      3      360us    1ms   0   BC9DBE   BCA6BC   BCB86B 0108F080        1ms      1      669us    1ms -99   829370 01178814        1ms     68       19us    0ms  -1   BCEF29   BCF122 10012114        1ms     61       11us    1ms -99   86D7EA   86D94C time   69.61: D:0:0086E23A waited on CS 036e4870 for   35 ms (init -9)time   69.61: B:1:0086E23A waited on CS 036e4870 for   35 ms (init -4)time   69.61: 0:1:0086E23A waited on CS 036e4870 for   35 ms (init -12)time   69.61: 4:1:0086E23A waited on CS 036e4870 for   36 ms (init -8)PerfData3::print_summary: time  120   tt:  0.4s   tc:331k036E4870      200ms     10k      19us   35ms   0   86E23A   86E55A 01073AB4       80ms    522      154us   79ms  -2   58A85B   58BCF6   58BE20   58C9E3 059F8B5C       28ms    162      170us    3ms   0   BCEFB8   BCF1B8   BCF421 1001B98C       14ms      8     1682us    9ms -99   86D7EA 037444F0       14ms     11     1258us    7ms   0   828500   876EA6   878FA2 010715C0       17ms     30      551us    1ms -99   4DC7DD   4E1D0F 03744570        8ms      4     1911us    7ms   0   828509   88B93C 10010044        7ms    336       22us    6ms -99   86D7EA   86D94C 01179690       11ms    219k       0us    1ms  -2   BECEA1   BEE098   BF35DD 0117929C        9ms    740       13us    1ms   0   BD1B4B   BD1D49   BD3B5C 03732124        4ms     92k       0us    0ms   0   823FE9   8241BC   824270   8242D2 011792B4        3ms     16      167us    0ms   0   BD1DA2   BD3B65 0106C980        2ms    992        2us    1ms -99   40A333   40A403   40A540   40A6C4 043F0A94        1ms      3      454us    1ms   0   BCA6BC   BCB86B 037CB028        1ms      3      349us    1ms   0   BC9DBE   BCA6BC   BCB86B 0108F080        1ms      1      649us    1ms -99   829370 01178814        1ms     68       18us    0ms  -1   BCEF29   BCF122 10012114        1ms     61       11us    1ms -99   86D7EA   86D94C time  128.15: 4:1:00AE428D waited on CS 0116fca0 for  327 ms (init -99)time  128.48: 4:1:00AE428D waited on CS 0116fca0 for  325 ms (init -99)time  128.82: 4:1:00AE428D waited on CS 0116fca0 for  324 ms (init -99)time  129.15: 4:1:00AE428D waited on CS 0116fca0 for  325 ms (init -99)time  129.44: 4:1:00AE428D waited on CS 0116fca0 for  273 ms (init -99)PerfData3::print_summary: time  136   tt:  2.0s   tc:332k0116FCA0     1572ms      5   308138us  326ms -99   AE428D 036E4870      199ms     10k      19us   34ms   0   86E23A   86E55A 01073AB4       80ms    522      153us   78ms  -2   58A85B   58BCF6   58BE20   58C9E3 059F8B5C       27ms    162      170us    3ms   0   BCEFB8   BCF1B8   BCF421 1001B98C       14ms      8     1675us    9ms -99   86D7EA 037444F0       14ms     11     1252us    6ms   0   828500   876EA6   878FA2 010715C0       17ms     30      548us    1ms -99   4DC7DD   4E1D0F 03744570        8ms      4     1902us    7ms   0   828509   88B93C 10010044        7ms    336       22us    6ms -99   86D7EA   86D94C 01179690       11ms    221k       0us    1ms  -2   BECEA1   BEE098   BF35DD 0117929C        9ms    740       13us    1ms   0   BD1B4B   BD1D49   BD3B5C 

RAY_DK: In order:
crit_sec_mode 0 Light-Critical-Section mode 3:
The log is 45 seconds long, appears to have normal degrees of contention.

crit_sec_mode 3 Light-Critical-Section mode 3:
The log is 205 seconds long, appears to have normal degrees of contention.

crit_sec_mode 3 Light-Critical-Section mode 6:
The log is 127 seconds long, and appears to suffer from severe contention near the end, but it looks like only a background thread is suffering, which might not have any visible effect. Maybe. The problem appears to relate to a single LightCS object at 116FCA0. Investigation of that LCS suggests that it may have something to do with shadows and/or lighting.

crit_sec_mode 3 Light-Critical-Section mode 3 and iCriticalSectionSupression=3 just for fun:
The log is 136 seconds long, and appears to suffer from severe contention near the end, but it looks like only a background thread is suffering, which might not have any visible effect. The contention looks like it might be significantly worse than the contention seen under LCS-mode 6. The problem appears to relate to the same LCS object (116FCA0, something to do with shadows/lighting?).

Also, in every case where you have logging of normal CS events enabled, some CSes show up with maximum numbers of waiters of -2. That number is supposed to be non-negative most of the time, except for the -99s which are special cases. Dunno what's up with that, probably not important.

wow. this really seems to have worked well. did i install correctly tho? i put the fose/plugins/FSR in the Data folder. i already had an ini in the main Fallout file. so where and what name is this log it's supposed to create? i see a fose.log in the main file but think it was there. sorry but i'm comp illiterate

It creates a file named sr_Fallout_Stutter_Remover.log in the Fallout 3 directory. You can also tell if it worked by examining fose.log - its content includes a list of FOSE plugin dlls found and whether or not each was loaded successfully.

I've been told that this OBSE plugin can kill VATS lag in another thread that I posted a detailed description of the two documented kinds of VATS lag.

http://www.gamesas.com/bgsforums/index.php?showtopic=1041233&hl=

Is this true? Does it kill the Calculation Pause?

EDIT: I have determined that it does with default settings, because the max framerate is 30 in the default INI. I did some experimenting, and I was CalcPause-free up to a max of 50. Haven't done a combat stress-test, off to do that now.

EDIT 2: So far, so good. Skyranger, I think you just killed the most agonizing unfixed bug since the v1.1 patch.

First of all, my internet was down for a while and is now at a new IP address. This means that the URL for the alpha has changed. It is now:
ftp://71.115.200.175/sr_Fallout_Stutter_Remover.dll
I've updated the first post of this thread to reflect that.

Second of all, some guy named badhair has been poking around at Oblivion/Fallout performance and directed my attention to its hashtables. The next alpha version of FSR/OSR will include experimental (ie possibly buggy) code to dynamically resize hashtables when they get too full. That should be soon.

MadCat221:
Haven't read your link yet, but FSR is not fixing the delay each time I start VATS on my machine.
edit: actually, I've never tried VATS without FSR... maybe this is a lot better than non-FSR VATS

New alpha is up:
ftp://71.115.200.175/sr_Fallout_Stutter_Remover.dll

It's recommended that you delete your old ini file and let it rebuild one for you, as the spelling of iCriticalSectionSuppression was fixed, and conceivably other changes may have occurred (ini file loading and creating was refactored).

There is a new setting, iHashtableMode. These are its settings:
-1: unhooked
0: hooked but emulates vanilla behavior
1: Attempts to dynamically resize Hashtables (ie make them grow when they get full, to keep collisions managable). This, hopefully, would make Fallout faster (not sure exactly what parts would get faster, best guess is loading times), particularly in longer game sessions and heavily modded games. It appears to work (meaning, it didn't crash) in my testing, but I'm still a little suspicious because my implementation assumes that hashtables are never accessed by multiple threads simultaneously. I have not attempted to measure or observe performance yet.

I did a little more work on heap replacement. It still doesn't work, but it's a little closer now.

I will post a log with iHashtableMode=1 soon.
EDIT: it crashed after about a min. Here is the log:
http://stashbox.org/640296/sr_Fallout_Stutter_Remover.log0

[General]MaximumFPS=60MinimumFPS=15iSmoothFrames=0iSmoothMode=0iSleepExtra=1bFix64Hertz=1bFPSConsoleSPAM=0iSchedulingParanoia=1iSchedulingResolution=1iHardMaxFrametime=200iHeapMode=0iHeapProfiling=0bFastExit=0bManageFPS=1bUseIFPSClamp=1iHashtableMode=1iHookPoint=1[CriticalSections]iCriticalSectionMode=3iLightCS_Mode=3iCriticalSectionSuppression=3iDefaultSpin1=500iDefaultSpin2=500

That log does not appear to correspond to that ini file.

Its not? I will try again.

On the assumption that it crashed due to hashtable-resizing-not-thread-safe issues, I've hacked together a textbook this-is-how-you-DON'T-do-it form of locking (I can't do real locking on this both for performance reasons and because of how my hashtable hooks work) for the resizing stuff that might prevent it from crashing. Unfortunately, this sorta-almost-locking may create its own performance problems, as there can be a little stutter if it decides to resize several hashtables in rapid succession.
The ftp server now has a new alpha with the sorta-locking code for hashtable growth:
ftp://71.115.200.175/sr_Fallout_Stutter_Remover.dll

Hmm, I downloaded the beta, then the latest alpha, overwrited the .dll and deleted the ini that comes with the beta.

Should I get a new ini file after loading a save once, or did I misunderstood? I don?t get any. I have the latest Obse beta from their site, just downloaded it.


EDIT: Nevermind, I somehow read I need the "latest obse beta 1.7", but it was latest Fallout 1.7 patch. I have 1.6. Problem solved.

Even with the latest alpha, I still get lots of random crashing and freezes when I set hashtable to 1.

Just wanted to pop in and give a big thanks to SkyRanger-1 for fixing the vats lag!

Cheers,
Art

I've just been playing with this going on in the background and I do see an improvement, although it's only sometimes I don't get VATS pause or lag.
I started a fresh character so would probably need to see how my game runs with my main character, but so far it's pretty smooth with very minimal stutter, hardly noticeable half the time. There's no pause when I quicksave, nor proper save.
In menus - either by bringing up the Pipboy or using the Escape key - I find it's not so taxing on my system. My PC just idles quietly instead of sounding like something in my case is going into overdrive. I don't have a dual, nor quad, core PC and it's not a heap of crap but resource-hogging games really make it work hard.

If, or when, I get back into Oblivion I'll certainly be grabbing its version especially if it works as well as it does here.

Thanks :goodjob:

The Oblivion one should actually work even better, since it makes a larger difference than in Fallout.

Anyhows, in contrast I have a pretty beefy machine and usually no slow downs at all and still I notice this plugin making the game smoother (likely due to 64 hertz fix?), great job!

Argh, I really thought that one would work. Anyway, there's a few more things I can try, and if they don't work then I'll just have to change the hardwired sizes of specific hashtables at startup, which at least is guaranteed threadsafe.

where do i go to get a copy of my log file so i can see why im stuttering? I tried fose.log but it just shows

FOSE: initialize (version = 1.2.0 01070030)
fallout root = C:\Users\Joe\Desktop\Fallout 3\
plugin directory = C:\Users\Joe\Desktop\Fallout 3\Data\FOSE\Plugins\
checking plugin C:\Users\Joe\Desktop\Fallout 3\Data\FOSE\Plugins\\sr_Fallout_Stutter_Remover.dll
unknown QueryInterface 00000000
plugin C:\Users\Joe\Desktop\Fallout 3\Data\FOSE\Plugins\\sr_Fallout_Stutter_Remover.dll (00000001 sr_Fallout_Stutter_Remover 00000003) loaded correctly
patched
DoLoadGameHook: Save 2 - Joe, Vault 101 Atrium, 00.42.44.fos
loading from C:\Users\Joe\Documents\My Games\Fallout3\Saves\Save 2 - Joe, Vault 101 Atrium, 00.42.44.fose
HandleLoadGame: couldn't open file (C:\Users\Joe\Documents\My Games\Fallout3\Saves\Save 2 - Joe, Vault 101 Atrium, 00.42.44.fose), probably doesn't exist
DoLoadGameHook: Save 2 - Joe, Vault 101 Atrium, 00.42.44.fos
loading from C:\Users\Joe\Documents\My Games\Fallout3\Saves\Save 2 - Joe. Vault 101 Atrium, 00.42.44.fose
HandleLoadGame: couldn't open file (C:\Users\Jose\Documents\My Games\Fallout3\Saves\Save 2 - Jose Giron, Vault 101 Atrium, 00.42.44.fose), probably doesn't exist
FOSE: deinitialize

Also do you think if i change these values on the fallout 3 ini, it would help reduce stutter

uInterior Cell Buffer=3
uExterior Cell Buffer=36
iPreloadSizeLimit=26214400

bBackgroundLoadLipFiles=1
bLoadBackgroundFaceGen=1
bBackgroundCellLoads=1
bLoadHelmetsInBackground=1
iBackgroundLoadLoading=1
bBackgroundPathing=1
bBackgroundNavmeshUpdate=1
bCloneModelsInBackground=1

Some dual core and quad core CPU users have said that by inserting a new command iNumHWThreads=2 under the General section of Fallout.ini, and setting it to a value of 1, 2 or 4, this prevents freezing at certain points in the game. In practice this setting should not be required, as it appears to restrict the number of threads used by the game, however you can experiment with different values depending on how many cores of your CPU you want the game to use.