| Summary: | [i915] i915/vcs1-sema exceeds i915/vcs1-busy value | ||
|---|---|---|---|
| Product: | DRI | Reporter: | andrey.orlov |
| Component: | DRM/Intel | Assignee: | Intel GFX Bugs mailing list <intel-gfx-bugs> |
| Status: | RESOLVED MOVED | QA Contact: | Intel GFX Bugs mailing list <intel-gfx-bugs> |
| Severity: | normal | ||
| Priority: | not set | CC: | dmitry.ermilov, intel-gfx-bugs |
| Version: | XOrg git | ||
| Hardware: | x86-64 (AMD64) | ||
| OS: | Linux (All) | ||
| Whiteboard: | Triaged, ReadyForDev | ||
| i915 platform: | i915 features: | Perf/PMU | |
If you disable busy-stats, what's the output then? I'm curious whether the apparent cap of 85% busy is genuine. 85% is real, Andrey run that test with 1000Hz sampling. Note that this is with GPU fixed at 700MHz and with default settings utilization is lower (~72% cap but I think more variance than then fixed scenario). We probably shouldn't read too much from this since we don't know how the other engines are looking. One of them could easily be the limiting factor. But it is interesting that the sampling error is largest in the 700Mhz case. Must be some unlucky latching of batch periods vs 200Hz sampling. I suggested to clamp sema to busy in the custom monitoring tool to start with. Question is whether we can afford going to 1000Hz in upstream. It would require testing for CPU usage, or maybe even going to like 500Hz would help. Not mentioned is the baseline kernel. I don't think preempt-to-busy has an impact here, as busy-stats is computed from the schedule-in/out events which are separate from unwind(). Just curious though. Put together https://patchwork.freedesktop.org/series/67183/ to help investigate this. I think it is just the sampling issue, but that should also be independent of gpu clock frequency. To be certain of reasonably accuracy with 100ms sample intervals, our estimate is that we want a 1000Hz timer. This is also worth double checking on latest tip as we tweaked i915_pmu.c again. I still expect we will need to bump the timer to meet user requirements though. Andrey, Can you verify the issue with drmtip? Yes, I'll check it today/tomorrow. On the latest drm-tip (5.4.0-rc8-drm-tip / commit: 997d2cef) still see the issue on gpu 700 MHz:
kernel version: 5.4.0-rc8-drm-tip-997d2cef
######## GT Frequency: ########
GT_MIN_FREQ=350
GT_MAX_FREQ=700
GT_BOOST_FREQ=700
######## Ring Frequency: ########
RING_MIN_FREQ=823
RING_MAX_FREQ=8
######## CPU Info: ########
analyzing CPU 0:
driver: intel_pstate
CPUs which run at the same hardware frequency: 0
CPUs which need to have their frequency coordinated by software: 0
maximum transition latency: Cannot determine or is not supported.
hardware limits: 800 MHz - 2.60 GHz
available cpufreq governors: performance powersave
current policy: frequency should be within 800 MHz and 2.60 GHz.
The governor "powersave" may decide which speed to use
within this range.
current CPU frequency: Unable to call hardware
current CPU frequency: 1.00 GHz (asserted by call to kernel)
boost state support:
Supported: no
Active: no
######## psinspect(metrics_monitor) tool: attempt 1 ... ########
FAILED
VDBOX2: value_busy=52.285299; value_sema=59.977265; value_wait=0.000000 | result=-7.691966
######## psinspect(metrics_monitor) tool: attempt 2 ... ########
FAILED
VDBOX2: value_busy=74.231544; value_sema=74.970711; value_wait=0.000000 | result=-0.739167
######## psinspect(metrics_monitor) tool: attempt 3 ... ########
SUCCESS
######## psinspect(metrics_monitor) tool: attempt 4 ... ########
SUCCESS
######## psinspect(metrics_monitor) tool: attempt 5 ... ########
SUCCESS
######## perf tool: attempt 1 ... ########
./perf stat -I 100 -a -e i915/vcs1-busy/,i915/vcs1-sema/,i915/vcs1-wait/ ./sample_multi_transcode -par 0002_FHD23i_1.par
Multi Transcoding Sample Version 8.4.27.
Par file is: 0002_FHD23i_1.par
Session 0:
MFX HARDWARE Session 0 API ver 1.30 parameters:
Input video: AVC
Output video: To child session
Session 1:
MFX HARDWARE Session 1 API ver 1.30 parameters:
Input video: From parent session
Output video: AVC
Pipeline surfaces number (DecPool): 7
Session 0 was NOT joined with other sessions
Session 1 was NOT joined with other sessions
# time counts unit events
0.100161107 40,142,708 ns i915/vcs1-busy/
0.100161107 15,006,686 ns i915/vcs1-sema/
0.100161107 0 ns i915/vcs1-wait/
0.200593615 83,747,594 ns i915/vcs1-busy/
0.200593615 25,004,196 ns i915/vcs1-sema/
0.200593615 0 ns i915/vcs1-wait/
0.300924182 84,834,581 ns i915/vcs1-busy/
0.300924182 50,014,682 ns i915/vcs1-sema/
0.300924182 0 ns i915/vcs1-wait/
0.401230154 88,172,054 ns i915/vcs1-busy/
0.401230154 24,963,833 ns i915/vcs1-sema/
0.401230154 0 ns i915/vcs1-wait/
0.501520017 85,708,576 ns i915/vcs1-busy/
0.501520017 90,001,181 ns i915/vcs1-sema/
0.501520017 0 ns i915/vcs1-wait/
0.601811389 85,230,537 ns i915/vcs1-busy/
0.601811389 74,968,629 ns i915/vcs1-sema/
0.601811389 0 ns i915/vcs1-wait/
0.702120170 83,839,300 ns i915/vcs1-busy/
0.702120170 85,030,859 ns i915/vcs1-sema/
0.702120170 0 ns i915/vcs1-wait/
0.802389185 85,593,756 ns i915/vcs1-busy/
0.802389185 64,988,914 ns i915/vcs1-sema/
0.802389185 0 ns i915/vcs1-wait/
0.902650662 85,740,441 ns i915/vcs1-busy/
0.902650662 79,992,867 ns i915/vcs1-sema/
0.902650662 0 ns i915/vcs1-wait/
1.002989820 87,960,966 ns i915/vcs1-busy/
1.002989820 54,995,955 ns i915/vcs1-sema/
1.002989820 0 ns i915/vcs1-wait/
1.103272168 86,040,106 ns i915/vcs1-busy/
1.103272168 74,994,519 ns i915/vcs1-sema/
1.103272168 0 ns i915/vcs1-wait/
1.203569340 86,973,553 ns i915/vcs1-busy/
1.203569340 70,004,266 ns i915/vcs1-sema/
1.203569340 0 ns i915/vcs1-wait/
1.303857443 84,684,997 ns i915/vcs1-busy/
1.303857443 54,996,736 ns i915/vcs1-sema/
1.303857443 0 ns i915/vcs1-wait/
1.404148585 86,372,747 ns i915/vcs1-busy/
1.404148585 55,022,303 ns i915/vcs1-sema/
1.404148585 0 ns i915/vcs1-wait/
1.504443948 86,984,701 ns i915/vcs1-busy/
1.504443948 35,014,938 ns i915/vcs1-sema/
1.504443948 0 ns i915/vcs1-wait/
1.604749417 85,922,037 ns i915/vcs1-busy/
1.604749417 84,991,496 ns i915/vcs1-sema/
1.604749417 0 ns i915/vcs1-wait/
1.705061616 85,381,924 ns i915/vcs1-busy/
1.705061616 74,985,124 ns i915/vcs1-sema/
1.705061616 0 ns i915/vcs1-wait/
1.805314246 85,221,350 ns i915/vcs1-busy/
1.805314246 90,009,269 ns i915/vcs1-sema/
1.805314246 0 ns i915/vcs1-wait/
1.905608612 86,177,196 ns i915/vcs1-busy/
1.905608612 84,999,181 ns i915/vcs1-sema/
1.905608612 0 ns i915/vcs1-wait/
2.005935197 87,789,683 ns i915/vcs1-busy/
2.005935197 74,991,155 ns i915/vcs1-sema/
2.005935197 0 ns i915/vcs1-wait/
2.106169198 85,409,451 ns i915/vcs1-busy/
2.106169198 54,995,406 ns i915/vcs1-sema/
2.106169198 0 ns i915/vcs1-wait/
2.206439914 86,069,946 ns i915/vcs1-busy/
2.206439914 44,996,472 ns i915/vcs1-sema/
2.206439914 0 ns i915/vcs1-wait/
2.306776216 86,530,106 ns i915/vcs1-busy/
2.306776216 64,987,089 ns i915/vcs1-sema/
2.306776216 0 ns i915/vcs1-wait/
2.407035124 85,398,854 ns i915/vcs1-busy/
2.407035124 65,007,893 ns i915/vcs1-sema/
2.407035124 0 ns i915/vcs1-wait/
2.507383800 88,405,958 ns i915/vcs1-busy/
2.507383800 95,001,924 ns i915/vcs1-sema/
2.507383800 0 ns i915/vcs1-wait/
# time counts unit events
2.607684466 86,215,307 ns i915/vcs1-busy/
2.607684466 70,011,316 ns i915/vcs1-sema/
2.607684466 0 ns i915/vcs1-wait/
2.707979563 83,040,150 ns i915/vcs1-busy/
2.707979563 79,998,468 ns i915/vcs1-sema/
2.707979563 0 ns i915/vcs1-wait/
2.808262030 85,319,347 ns i915/vcs1-busy/
2.808262030 29,991,896 ns i915/vcs1-sema/
2.808262030 0 ns i915/vcs1-wait/
2.908585920 87,262,185 ns i915/vcs1-busy/
2.908585920 30,004,106 ns i915/vcs1-sema/
2.908585920 0 ns i915/vcs1-wait/
3.008872756 84,177,071 ns i915/vcs1-busy/
3.008872756 70,012,390 ns i915/vcs1-sema/
3.008872756 0 ns i915/vcs1-wait/
3.109177776 85,825,753 ns i915/vcs1-busy/
3.109177776 70,004,932 ns i915/vcs1-sema/
3.109177776 0 ns i915/vcs1-wait/
3.209477896 85,603,157 ns i915/vcs1-busy/
3.209477896 65,000,296 ns i915/vcs1-sema/
3.209477896 0 ns i915/vcs1-wait/
3.309770143 85,527,324 ns i915/vcs1-busy/
3.309770143 40,001,500 ns i915/vcs1-sema/
3.309770143 0 ns i915/vcs1-wait/
3.410058673 87,264,603 ns i915/vcs1-busy/
3.410058673 9,988,813 ns i915/vcs1-sema/
3.410058673 0 ns i915/vcs1-wait/
3.510342392 85,299,539 ns i915/vcs1-busy/
3.510342392 95,005,017 ns i915/vcs1-sema/
3.510342392 0 ns i915/vcs1-wait/
3.610753068 87,218,778 ns i915/vcs1-busy/
3.610753068 65,001,587 ns i915/vcs1-sema/
3.610753068 0 ns i915/vcs1-wait/
3.711054680 85,534,143 ns i915/vcs1-busy/
3.711054680 74,984,861 ns i915/vcs1-sema/
3.711054680 0 ns i915/vcs1-wait/
3.811343355 86,038,927 ns i915/vcs1-busy/
3.811343355 54,997,130 ns i915/vcs1-sema/
3.811343355 0 ns i915/vcs1-wait/
3.911615640 86,467,996 ns i915/vcs1-busy/
3.911615640 79,992,394 ns i915/vcs1-sema/
3.911615640 0 ns i915/vcs1-wait/
4.011920357 87,253,708 ns i915/vcs1-busy/
4.011920357 74,994,643 ns i915/vcs1-sema/
4.011920357 0 ns i915/vcs1-wait/
4.112176646 85,294,037 ns i915/vcs1-busy/
4.112176646 45,000,756 ns i915/vcs1-sema/
4.112176646 0 ns i915/vcs1-wait/
4.212504634 87,127,999 ns i915/vcs1-busy/
4.212504634 59,978,011 ns i915/vcs1-sema/
4.212504634 0 ns i915/vcs1-wait/
4.312809653 85,411,923 ns i915/vcs1-busy/
4.312809653 35,000,147 ns i915/vcs1-sema/
4.312809653 0 ns i915/vcs1-wait/
4.413060310 88,646,038 ns i915/vcs1-busy/
4.413060310 94,960,825 ns i915/vcs1-sema/
4.413060310 0 ns i915/vcs1-wait/
4.513350759 85,660,859 ns i915/vcs1-busy/
4.513350759 30,032,891 ns i915/vcs1-sema/
4.513350759 0 ns i915/vcs1-wait/
4.613643125 85,423,835 ns i915/vcs1-busy/
4.613643125 34,977,028 ns i915/vcs1-sema/
4.613643125 0 ns i915/vcs1-wait/
4.713926324 86,558,800 ns i915/vcs1-busy/
4.713926324 74,988,501 ns i915/vcs1-sema/
4.713926324 0 ns i915/vcs1-wait/
4.814271488 86,881,503 ns i915/vcs1-busy/
4.814271488 70,003,854 ns i915/vcs1-sema/
4.814271488 0 ns i915/vcs1-wait/
4.914568704 85,100,369 ns i915/vcs1-busy/
4.914568704 14,989,781 ns i915/vcs1-sema/
4.914568704 0 ns i915/vcs1-wait/
5.014857404 87,146,456 ns i915/vcs1-busy/
5.014857404 84,993,310 ns i915/vcs1-sema/
5.014857404 0 ns i915/vcs1-wait/
# time counts unit events
5.115151732 85,398,672 ns i915/vcs1-busy/
5.115151732 65,002,988 ns i915/vcs1-sema/
5.115151732 0 ns i915/vcs1-wait/
5.215452205 87,041,740 ns i915/vcs1-busy/
5.215452205 45,007,010 ns i915/vcs1-sema/
5.215452205 0 ns i915/vcs1-wait/
5.315743066 85,416,596 ns i915/vcs1-busy/
5.315743066 45,009,219 ns i915/vcs1-sema/
5.315743066 0 ns i915/vcs1-wait/
5.416023999 86,936,095 ns i915/vcs1-busy/
5.416023999 84,998,034 ns i915/vcs1-sema/
5.416023999 0 ns i915/vcs1-wait/
5.516327797 85,412,699 ns i915/vcs1-busy/
5.516327797 44,991,907 ns i915/vcs1-sema/
5.516327797 0 ns i915/vcs1-wait/
5.616639925 86,873,241 ns i915/vcs1-busy/
5.616639925 55,006,366 ns i915/vcs1-sema/
5.616639925 0 ns i915/vcs1-wait/
5.716898265 85,163,234 ns i915/vcs1-busy/
5.716898265 70,005,016 ns i915/vcs1-sema/
5.716898265 0 ns i915/vcs1-wait/
5.817157969 88,129,390 ns i915/vcs1-busy/
5.817157969 54,996,328 ns i915/vcs1-sema/
5.817157969 0 ns i915/vcs1-wait/
5.917450241 85,900,348 ns i915/vcs1-busy/
5.917450241 84,977,885 ns i915/vcs1-sema/
5.917450241 0 ns i915/vcs1-wait/
6.017726888 85,354,811 ns i915/vcs1-busy/
6.017726888 70,017,554 ns i915/vcs1-sema/
6.017726888 0 ns i915/vcs1-wait/
6.117986163 85,198,985 ns i915/vcs1-busy/
6.117986163 80,000,294 ns i915/vcs1-sema/
6.117986163 0 ns i915/vcs1-wait/
6.218275369 87,132,270 ns i915/vcs1-busy/
6.218275369 90,030,066 ns i915/vcs1-sema/
6.218275369 0 ns i915/vcs1-wait/
Transcoding started
......
Transcoding finished
Common transcoding time is 6.21475 sec
-------------------------------------------------------------------------------
*** session 0 [0x55d961d9f710] PASSED (MFX_ERR_NONE) 6.17106 sec, 600 frames, 97.228 fps
-o::sink -i::h264 /msdk/MEDIASDK_STREAMS/_System_Validation/performance/pv_h264_noaudio/1920x1080i_30fps_1200f_8Mbps.h264 -n 600 -async 1 -hw
*** session 1 [0x55d961db3dd0] PASSED (MFX_ERR_NONE) 6.21452 sec, 600 frames, 96.548 fps
-o::h264 streams/0002_FHD23i_1.0.h264 -i::source -b 8000 -u 4 -async 1 -hw
-------------------------------------------------------------------------------
The test PASSED
6.284850305 9,812,459 ns i915/vcs1-busy/
6.284850305 4,999,695 ns i915/vcs1-sema/
6.284850305 0 ns i915/vcs1-wait/
######## perf tool: attempt 2 ... ########
./perf stat -I 100 -a -e i915/vcs1-busy/,i915/vcs1-sema/,i915/vcs1-wait/ ./sample_multi_transcode -par 0002_FHD23i_1.par
Multi Transcoding Sample Version 8.4.27.
Par file is: 0002_FHD23i_1.par
Session 0:
MFX HARDWARE Session 0 API ver 1.30 parameters:
Input video: AVC
Output video: To child session
Session 1:
MFX HARDWARE Session 1 API ver 1.30 parameters:
Input video: From parent session
Output video: AVC
Pipeline surfaces number (DecPool): 7
Session 0 was NOT joined with other sessions
Session 1 was NOT joined with other sessions
# time counts unit events
0.100160358 39,290,829 ns i915/vcs1-busy/
0.100160358 30,076,371 ns i915/vcs1-sema/
0.100160358 0 ns i915/vcs1-wait/
0.200467803 81,521,540 ns i915/vcs1-busy/
0.200467803 45,012,127 ns i915/vcs1-sema/
0.200467803 0 ns i915/vcs1-wait/
0.300723205 83,204,402 ns i915/vcs1-busy/
0.300723205 50,096,013 ns i915/vcs1-sema/
0.300723205 0 ns i915/vcs1-wait/
0.400991451 87,302,832 ns i915/vcs1-busy/
0.400991451 60,075,098 ns i915/vcs1-sema/
0.400991451 0 ns i915/vcs1-wait/
0.501283269 86,163,167 ns i915/vcs1-busy/
0.501283269 100,028,548 ns i915/vcs1-sema/
0.501283269 0 ns i915/vcs1-wait/
0.601559614 85,223,217 ns i915/vcs1-busy/
0.601559614 19,998,554 ns i915/vcs1-sema/
0.601559614 0 ns i915/vcs1-wait/
0.701818148 83,404,827 ns i915/vcs1-busy/
0.701818148 60,028,197 ns i915/vcs1-sema/
0.701818148 0 ns i915/vcs1-wait/
0.802107458 86,607,447 ns i915/vcs1-busy/
0.802107458 39,993,878 ns i915/vcs1-sema/
0.802107458 0 ns i915/vcs1-wait/
0.902412301 84,120,170 ns i915/vcs1-busy/
0.902412301 35,004,212 ns i915/vcs1-sema/
0.902412301 0 ns i915/vcs1-wait/
1.002717636 87,063,674 ns i915/vcs1-busy/
1.002717636 59,977,003 ns i915/vcs1-sema/
1.002717636 0 ns i915/vcs1-wait/
1.103027339 86,583,132 ns i915/vcs1-busy/
1.103027339 80,026,502 ns i915/vcs1-sema/
1.103027339 0 ns i915/vcs1-wait/
1.203283476 86,435,066 ns i915/vcs1-busy/
1.203283476 70,013,810 ns i915/vcs1-sema/
1.203283476 0 ns i915/vcs1-wait/
1.303579997 85,914,680 ns i915/vcs1-busy/
1.303579997 64,986,652 ns i915/vcs1-sema/
1.303579997 0 ns i915/vcs1-wait/
1.403874662 86,960,357 ns i915/vcs1-busy/
1.403874662 95,001,641 ns i915/vcs1-sema/
1.403874662 0 ns i915/vcs1-wait/
1.504182283 87,328,514 ns i915/vcs1-busy/
1.504182283 4,991,218 ns i915/vcs1-sema/
1.504182283 0 ns i915/vcs1-wait/
1.604466864 85,935,098 ns i915/vcs1-busy/
1.604466864 85,007,124 ns i915/vcs1-sema/
1.604466864 0 ns i915/vcs1-wait/
1.704749363 85,586,609 ns i915/vcs1-busy/
1.704749363 100,000,482 ns i915/vcs1-sema/
1.704749363 0 ns i915/vcs1-wait/
1.805037611 85,866,805 ns i915/vcs1-busy/
1.805037611 94,952,704 ns i915/vcs1-sema/
1.805037611 0 ns i915/vcs1-wait/
1.905335140 85,100,567 ns i915/vcs1-busy/
1.905335140 80,029,099 ns i915/vcs1-sema/
1.905335140 0 ns i915/vcs1-wait/
2.005628513 86,064,271 ns i915/vcs1-busy/
2.005628513 50,000,039 ns i915/vcs1-sema/
2.005628513 0 ns i915/vcs1-wait/
2.105920722 87,184,365 ns i915/vcs1-busy/
2.105920722 84,996,341 ns i915/vcs1-sema/
2.105920722 0 ns i915/vcs1-wait/
2.206214925 86,880,551 ns i915/vcs1-busy/
2.206214925 90,006,259 ns i915/vcs1-sema/
2.206214925 0 ns i915/vcs1-wait/
2.306504669 85,527,054 ns i915/vcs1-busy/
2.306504669 74,984,415 ns i915/vcs1-sema/
2.306504669 0 ns i915/vcs1-wait/
2.406795910 86,523,453 ns i915/vcs1-busy/
2.406795910 95,019,737 ns i915/vcs1-sema/
2.406795910 0 ns i915/vcs1-wait/
2.507084801 85,560,879 ns i915/vcs1-busy/
2.507084801 79,973,617 ns i915/vcs1-sema/
2.507084801 0 ns i915/vcs1-wait/
# time counts unit events
2.607370787 85,760,229 ns i915/vcs1-busy/
2.607370787 79,979,113 ns i915/vcs1-sema/
2.607370787 0 ns i915/vcs1-wait/
2.707673821 84,900,506 ns i915/vcs1-busy/
2.707673821 85,029,304 ns i915/vcs1-sema/
2.707673821 0 ns i915/vcs1-wait/
2.807985586 86,401,101 ns i915/vcs1-busy/
2.807985586 99,999,666 ns i915/vcs1-sema/
2.807985586 0 ns i915/vcs1-wait/
2.908285437 83,930,952 ns i915/vcs1-busy/
2.908285437 89,992,935 ns i915/vcs1-sema/
2.908285437 0 ns i915/vcs1-wait/
3.008579450 87,597,678 ns i915/vcs1-busy/
3.008579450 84,985,666 ns i915/vcs1-sema/
3.008579450 0 ns i915/vcs1-wait/
3.108870120 87,067,060 ns i915/vcs1-busy/
3.108870120 80,004,043 ns i915/vcs1-sema/
3.108870120 0 ns i915/vcs1-wait/
3.209168059 86,310,714 ns i915/vcs1-busy/
3.209168059 15,057,794 ns i915/vcs1-sema/
3.209168059 0 ns i915/vcs1-wait/
3.309466994 85,245,115 ns i915/vcs1-busy/
3.309466994 94,994,419 ns i915/vcs1-sema/
3.309466994 0 ns i915/vcs1-wait/
3.409760867 86,025,701 ns i915/vcs1-busy/
3.409760867 84,991,731 ns i915/vcs1-sema/
3.409760867 0 ns i915/vcs1-wait/
3.510062542 86,698,523 ns i915/vcs1-busy/
3.510062542 100,001,001 ns i915/vcs1-sema/
3.510062542 0 ns i915/vcs1-wait/
3.610353175 87,470,265 ns i915/vcs1-busy/
3.610353175 35,006,979 ns i915/vcs1-sema/
3.610353175 0 ns i915/vcs1-wait/
3.710644822 85,528,163 ns i915/vcs1-busy/
3.710644822 100,001,476 ns i915/vcs1-sema/
3.710644822 0 ns i915/vcs1-wait/
3.810943400 85,394,932 ns i915/vcs1-busy/
3.810943400 75,008,763 ns i915/vcs1-sema/
3.810943400 0 ns i915/vcs1-wait/
3.911232265 86,735,160 ns i915/vcs1-busy/
3.911232265 64,997,562 ns i915/vcs1-sema/
3.911232265 0 ns i915/vcs1-wait/
4.011522694 86,344,695 ns i915/vcs1-busy/
4.011522694 69,985,487 ns i915/vcs1-sema/
4.011522694 0 ns i915/vcs1-wait/
4.111828127 87,315,751 ns i915/vcs1-busy/
4.111828127 79,993,814 ns i915/vcs1-sema/
4.111828127 0 ns i915/vcs1-wait/
4.212125814 86,343,957 ns i915/vcs1-busy/
4.212125814 44,995,143 ns i915/vcs1-sema/
4.212125814 0 ns i915/vcs1-wait/
4.312413354 86,672,565 ns i915/vcs1-busy/
4.312413354 75,000,796 ns i915/vcs1-sema/
4.312413354 0 ns i915/vcs1-wait/
4.412718089 85,787,422 ns i915/vcs1-busy/
4.412718089 65,005,028 ns i915/vcs1-sema/
4.412718089 0 ns i915/vcs1-wait/
4.513012118 86,461,675 ns i915/vcs1-busy/
4.513012118 54,998,345 ns i915/vcs1-sema/
4.513012118 0 ns i915/vcs1-wait/
4.613308201 87,269,693 ns i915/vcs1-busy/
4.613308201 24,973,949 ns i915/vcs1-sema/
4.613308201 0 ns i915/vcs1-wait/
4.713604758 86,185,445 ns i915/vcs1-busy/
4.713604758 84,999,761 ns i915/vcs1-sema/
4.713604758 0 ns i915/vcs1-wait/
4.813910631 85,795,573 ns i915/vcs1-busy/
4.813910631 100,006,967 ns i915/vcs1-sema/
4.813910631 0 ns i915/vcs1-wait/
4.914202861 84,460,866 ns i915/vcs1-busy/
4.914202861 79,976,857 ns i915/vcs1-sema/
4.914202861 0 ns i915/vcs1-wait/
5.014490866 83,835,353 ns i915/vcs1-busy/
5.014490866 44,966,935 ns i915/vcs1-sema/
5.014490866 0 ns i915/vcs1-wait/
# time counts unit events
5.114773193 87,037,484 ns i915/vcs1-busy/
5.114773193 44,991,434 ns i915/vcs1-sema/
5.114773193 0 ns i915/vcs1-wait/
5.215078350 85,516,037 ns i915/vcs1-busy/
5.215078350 90,006,247 ns i915/vcs1-sema/
5.215078350 0 ns i915/vcs1-wait/
5.315361059 84,784,992 ns i915/vcs1-busy/
5.315361059 54,983,684 ns i915/vcs1-sema/
5.315361059 0 ns i915/vcs1-wait/
5.415670344 85,887,153 ns i915/vcs1-busy/
5.415670344 50,002,233 ns i915/vcs1-sema/
5.415670344 0 ns i915/vcs1-wait/
5.515949570 88,179,417 ns i915/vcs1-busy/
5.515949570 80,002,633 ns i915/vcs1-sema/
5.515949570 0 ns i915/vcs1-wait/
5.616236102 85,651,091 ns i915/vcs1-busy/
5.616236102 89,997,602 ns i915/vcs1-sema/
5.616236102 0 ns i915/vcs1-wait/
5.716534645 87,213,658 ns i915/vcs1-busy/
5.716534645 79,995,341 ns i915/vcs1-sema/
5.716534645 0 ns i915/vcs1-wait/
5.816825507 86,093,435 ns i915/vcs1-busy/
5.816825507 95,004,910 ns i915/vcs1-sema/
5.816825507 0 ns i915/vcs1-wait/
5.917118610 85,884,755 ns i915/vcs1-busy/
5.917118610 49,959,531 ns i915/vcs1-sema/
5.917118610 0 ns i915/vcs1-wait/
6.017410065 87,326,938 ns i915/vcs1-busy/
6.017410065 90,000,199 ns i915/vcs1-sema/
6.017410065 0 ns i915/vcs1-wait/
6.117722195 85,926,306 ns i915/vcs1-busy/
6.117722195 9,992,649 ns i915/vcs1-sema/
6.117722195 0 ns i915/vcs1-wait/
Transcoding started
......
Transcoding finished
Common transcoding time is 6.17392 sec
-------------------------------------------------------------------------------
*** session 0 [0x561ff82ba710] PASSED (MFX_ERR_NONE) 6.13045 sec, 600 frames, 97.872 fps
-o::sink -i::h264 /msdk/MEDIASDK_STREAMS/_System_Validation/performance/pv_h264_noaudio/1920x1080i_30fps_1200f_8Mbps.h264 -n 600 -async 1 -hw
*** session 1 [0x561ff82cedd0] PASSED (MFX_ERR_NONE) 6.17375 sec, 600 frames, 97.186 fps
-o::h264 streams/0002_FHD23i_1.0.h264 -i::source -b 8000 -u 4 -async 1 -hw
-------------------------------------------------------------------------------
The test PASSED
6.218002715 60,998,545 ns i915/vcs1-busy/
6.218002715 54,999,271 ns i915/vcs1-sema/
6.218002715 0 ns i915/vcs1-wait/
6.246496804 0 ns i915/vcs1-busy/
6.246496804 0 ns i915/vcs1-sema/
6.246496804 0 ns i915/vcs1-wait/
-- GitLab Migration Automatic Message -- This bug has been migrated to freedesktop.org's GitLab instance and has been closed from further activity. You can subscribe and participate further through the new bug through this link to our GitLab instance: https://gitlab.freedesktop.org/drm/intel/issues/445. |
Use of freedesktop.org services, including Bugzilla, is subject to our Code of Conduct. How we collect and use information is described in our Privacy Policy.
Values I got from perf tool (very often we see i915/vcs1-sema > i915/vcs1-busy): {code} # ./perf stat -I 100 -a -e i915/vcs1-busy/,i915/vcs1-sema/,i915/vcs1-wait/ ./sample_multi_transcode -par 0002_FHD23i_1.par libva info: VA-API version 1.6.0 libva info: va_getDriverName() returns 0 libva info: User requested driver 'iHD' libva info: Trying to open /opt/intel/mediasdk/lib64/iHD_drv_video.so libva info: Found init function __vaDriverInit_1_6 libva info: va_openDriver() returns 0 # time counts unit events 0.100160810 34,209,689 ns i915/vcs1-busy/ 0.100160810 15,046,281 ns i915/vcs1-sema/ 0.100160810 0 ns i915/vcs1-wait/ 0.200365878 81,586,469 ns i915/vcs1-busy/ 0.200365878 75,075,011 ns i915/vcs1-sema/ 0.200365878 0 ns i915/vcs1-wait/ 0.300568998 85,209,534 ns i915/vcs1-busy/ 0.300568998 44,998,752 ns i915/vcs1-sema/ 0.300568998 0 ns i915/vcs1-wait/ 0.400733002 85,725,483 ns i915/vcs1-busy/ 0.400733002 90,037,698 ns i915/vcs1-sema/ 0.400733002 0 ns i915/vcs1-wait/ 0.500939741 84,982,430 ns i915/vcs1-busy/ 0.500939741 80,097,984 ns i915/vcs1-sema/ 0.500939741 0 ns i915/vcs1-wait/ 0.601132522 85,518,925 ns i915/vcs1-busy/ 0.601132522 90,071,194 ns i915/vcs1-sema/ 0.601132522 0 ns i915/vcs1-wait/ 0.701333967 83,735,465 ns i915/vcs1-busy/ 0.701333967 85,106,697 ns i915/vcs1-sema/ 0.701333967 0 ns i915/vcs1-wait/ 0.801501148 84,875,175 ns i915/vcs1-busy/ 0.801501148 45,109,484 ns i915/vcs1-sema/ 0.801501148 0 ns i915/vcs1-wait/ 0.901658275 85,498,038 ns i915/vcs1-busy/ 0.901658275 30,055,031 ns i915/vcs1-sema/ 0.901658275 0 ns i915/vcs1-wait/ 1.001859013 86,232,348 ns i915/vcs1-busy/ 1.001859013 89,996,108 ns i915/vcs1-sema/ 1.001859013 0 ns i915/vcs1-wait/ 1.102076724 85,695,796 ns i915/vcs1-busy/ 1.102076724 94,994,151 ns i915/vcs1-sema/ 1.102076724 0 ns i915/vcs1-wait/ 1.202270626 85,122,835 ns i915/vcs1-busy/ 1.202270626 69,968,796 ns i915/vcs1-sema/ 1.202270626 0 ns i915/vcs1-wait/ 1.302443248 85,881,238 ns i915/vcs1-busy/ 1.302443248 95,000,911 ns i915/vcs1-sema/ 1.302443248 0 ns i915/vcs1-wait/ 1.402619770 86,196,687 ns i915/vcs1-busy/ 1.402619770 80,003,731 ns i915/vcs1-sema/ 1.402619770 0 ns i915/vcs1-wait/ 1.502802220 84,797,945 ns i915/vcs1-busy/ 1.502802220 100,000,569 ns i915/vcs1-sema/ 1.502802220 0 ns i915/vcs1-wait/ 1.603005224 84,732,615 ns i915/vcs1-busy/ 1.603005224 100,000,407 ns i915/vcs1-sema/ 1.603005224 0 ns i915/vcs1-wait/ 1.703178374 84,980,237 ns i915/vcs1-busy/ 1.703178374 85,010,242 ns i915/vcs1-sema/ 1.703178374 0 ns i915/vcs1-wait/ 1.803356979 84,558,765 ns i915/vcs1-busy/ 1.803356979 35,035,493 ns i915/vcs1-sema/ 1.803356979 0 ns i915/vcs1-wait/ 1.903561910 85,307,891 ns i915/vcs1-busy/ 1.903561910 80,113,763 ns i915/vcs1-sema/ 1.903561910 0 ns i915/vcs1-wait/ 2.003732306 85,147,056 ns i915/vcs1-busy/ 2.003732306 40,049,492 ns i915/vcs1-sema/ 2.003732306 0 ns i915/vcs1-wait/ 2.103939868 85,385,397 ns i915/vcs1-busy/ 2.103939868 5,002,618 ns i915/vcs1-sema/ 2.103939868 0 ns i915/vcs1-wait/ 2.204145664 86,464,111 ns i915/vcs1-busy/ 2.204145664 34,987,714 ns i915/vcs1-sema/ 2.204145664 0 ns i915/vcs1-wait/ 2.304341045 85,311,024 ns i915/vcs1-busy/ 2.304341045 94,976,653 ns i915/vcs1-sema/ 2.304341045 0 ns i915/vcs1-wait/ 2.404520380 85,852,106 ns i915/vcs1-busy/ 2.404520380 34,996,772 ns i915/vcs1-sema/ 2.404520380 0 ns i915/vcs1-wait/ 2.504729578 85,753,160 ns i915/vcs1-busy/ 2.504729578 44,995,847 ns i915/vcs1-sema/ 2.504729578 0 ns i915/vcs1-wait/ # time counts unit events 2.604946693 83,258,753 ns i915/vcs1-busy/ 2.604946693 74,990,707 ns i915/vcs1-sema/ 2.604946693 0 ns i915/vcs1-wait/ 2.705148192 85,853,133 ns i915/vcs1-busy/ 2.705148192 85,146,362 ns i915/vcs1-sema/ 2.705148192 0 ns i915/vcs1-wait/ 2.805344742 85,636,079 ns i915/vcs1-busy/ 2.805344742 25,033,601 ns i915/vcs1-sema/ 2.805344742 0 ns i915/vcs1-wait/ 2.905514029 83,719,125 ns i915/vcs1-busy/ 2.905514029 65,043,622 ns i915/vcs1-sema/ 2.905514029 0 ns i915/vcs1-wait/ 3.005722647 85,310,040 ns i915/vcs1-busy/ 3.005722647 30,037,930 ns i915/vcs1-sema/ 3.005722647 0 ns i915/vcs1-wait/ 3.105932982 85,260,192 ns i915/vcs1-busy/ 3.105932982 30,031,303 ns i915/vcs1-sema/ 3.105932982 0 ns i915/vcs1-wait/ 3.206102810 85,288,760 ns i915/vcs1-busy/ 3.206102810 50,078,485 ns i915/vcs1-sema/ 3.206102810 0 ns i915/vcs1-wait/ 3.306279745 85,587,333 ns i915/vcs1-busy/ 3.306279745 75,027,713 ns i915/vcs1-sema/ 3.306279745 0 ns i915/vcs1-wait/ 3.406493454 85,765,888 ns i915/vcs1-busy/ 3.406493454 95,011,091 ns i915/vcs1-sema/ 3.406493454 0 ns i915/vcs1-wait/ 3.506691238 85,091,538 ns i915/vcs1-busy/ 3.506691238 85,025,489 ns i915/vcs1-sema/ 3.506691238 0 ns i915/vcs1-wait/ 3.606898304 85,016,700 ns i915/vcs1-busy/ 3.606898304 94,998,820 ns i915/vcs1-sema/ 3.606898304 0 ns i915/vcs1-wait/ 3.707108156 85,224,696 ns i915/vcs1-busy/ 3.707108156 55,041,010 ns i915/vcs1-sema/ 3.707108156 0 ns i915/vcs1-wait/ 3.807313350 84,935,598 ns i915/vcs1-busy/ 3.807313350 99,971,882 ns i915/vcs1-sema/ 3.807313350 0 ns i915/vcs1-wait/ 3.907520124 86,416,994 ns i915/vcs1-busy/ 3.907520124 60,218,944 ns i915/vcs1-sema/ 3.907520124 0 ns i915/vcs1-wait/ 4.007730814 85,646,119 ns i915/vcs1-busy/ 4.007730814 50,073,911 ns i915/vcs1-sema/ 4.007730814 0 ns i915/vcs1-wait/ 4.107904563 85,931,492 ns i915/vcs1-busy/ 4.107904563 80,000,899 ns i915/vcs1-sema/ 4.107904563 0 ns i915/vcs1-wait/ 4.208073659 85,295,903 ns i915/vcs1-busy/ 4.208073659 84,978,887 ns i915/vcs1-sema/ 4.208073659 0 ns i915/vcs1-wait/ 4.308284750 85,051,978 ns i915/vcs1-busy/ 4.308284750 99,963,217 ns i915/vcs1-sema/ 4.308284750 0 ns i915/vcs1-wait/ 4.408481753 86,220,293 ns i915/vcs1-busy/ 4.408481753 100,000,425 ns i915/vcs1-sema/ 4.408481753 0 ns i915/vcs1-wait/ 4.508689997 85,022,693 ns i915/vcs1-busy/ 4.508689997 65,139,017 ns i915/vcs1-sema/ 4.508689997 0 ns i915/vcs1-wait/ 4.608895935 84,892,627 ns i915/vcs1-busy/ 4.608895935 50,069,240 ns i915/vcs1-sema/ 4.608895935 0 ns i915/vcs1-wait/ 4.709103951 85,038,229 ns i915/vcs1-busy/ 4.709103951 80,109,594 ns i915/vcs1-sema/ 4.709103951 0 ns i915/vcs1-wait/ 4.809279557 85,325,514 ns i915/vcs1-busy/ 4.809279557 85,050,025 ns i915/vcs1-sema/ 4.809279557 0 ns i915/vcs1-wait/ 4.909499959 85,595,340 ns i915/vcs1-busy/ 4.909499959 29,999,102 ns i915/vcs1-sema/ 4.909499959 0 ns i915/vcs1-wait/ 5.009715840 86,633,730 ns i915/vcs1-busy/ 5.009715840 94,996,584 ns i915/vcs1-sema/ 5.009715840 0 ns i915/vcs1-wait/ # time counts unit events 5.109927801 85,274,181 ns i915/vcs1-busy/ 5.109927801 94,968,127 ns i915/vcs1-sema/ 5.109927801 0 ns i915/vcs1-wait/ 5.210138711 84,449,606 ns i915/vcs1-busy/ 5.210138711 40,170,670 ns i915/vcs1-sema/ 5.210138711 0 ns i915/vcs1-wait/ 5.310351659 85,629,044 ns i915/vcs1-busy/ 5.310351659 45,012,072 ns i915/vcs1-sema/ 5.310351659 0 ns i915/vcs1-wait/ 5.410568218 86,679,014 ns i915/vcs1-busy/ 5.410568218 99,994,658 ns i915/vcs1-sema/ 5.410568218 0 ns i915/vcs1-wait/ 5.510780105 85,682,007 ns i915/vcs1-busy/ 5.510780105 0 ns i915/vcs1-sema/ 5.510780105 0 ns i915/vcs1-wait/ 5.610987172 84,631,229 ns i915/vcs1-busy/ 5.610987172 50,027,357 ns i915/vcs1-sema/ 5.610987172 0 ns i915/vcs1-wait/ 5.711192665 85,008,656 ns i915/vcs1-busy/ 5.711192665 80,007,406 ns i915/vcs1-sema/ 5.711192665 0 ns i915/vcs1-wait/ 5.811410934 84,773,228 ns i915/vcs1-busy/ 5.811410934 35,052,545 ns i915/vcs1-sema/ 5.811410934 0 ns i915/vcs1-wait/ 5.911616718 84,900,639 ns i915/vcs1-busy/ 5.911616718 30,006,841 ns i915/vcs1-sema/ 5.911616718 0 ns i915/vcs1-wait/ 6.011827360 86,234,742 ns i915/vcs1-busy/ 6.011827360 89,983,850 ns i915/vcs1-sema/ 6.011827360 0 ns i915/vcs1-wait/ 6.081667753 38,056,952 ns i915/vcs1-busy/ 6.081667753 40,003,467 ns i915/vcs1-sema/ 6.081667753 0 ns i915/vcs1-wait/ {code} We have performed one another experiment with GPU frequency (only gt_max_freq_mhz, gt_boost_freq_mhz): default (950), 900, 800, 700, 600, 500, 400. Example: echo 800 > /sys/class/drm/card0/gt_max_freq_mhz echo 800 > /sys/class/drm/card0/gt_boost_freq_mhz Other settings - system defaults. And only one case, where I see big amount of bad samples - 700 MHz. As already was discussed in our internal bug, the fix for more-precise-sampling helps: {code} From 0a1252963a958aefb09d0113afd0caf3359a4462 Mon Sep 17 00:00:00 2001 From: Tvrtko Ursulin <tvrtko.ursulin@intel.com> Date: Wed, 11 Sep 2019 17:52:31 +0100 Subject: [PATCH] more precise sampling Signed-off-by: Tvrtko Ursulin <tvrtko.ursulin@intel.com> --- drivers/gpu/drm/i915/i915_pmu.c | 2 +- 1 file changed, 1 insertion(+), 1 deletion(-) diff --git a/drivers/gpu/drm/i915/i915_pmu.c b/drivers/gpu/drm/i915/i915_pmu.c index 623ad32303a1..9f0bb3b85401 100644 --- a/drivers/gpu/drm/i915/i915_pmu.c +++ b/drivers/gpu/drm/i915/i915_pmu.c @@ -17,7 +17,7 @@ #include "intel_pm.h" /* Frequency for the sampling timer for events which need it. */ -#define FREQUENCY 200 +#define FREQUENCY 1000 #define PERIOD max_t(u64, 10000, NSEC_PER_SEC / FREQUENCY) #define ENGINE_SAMPLE_MASK \ -- 2.20.1 {code}