Result:
git-log-oneline i915_display_info11 igt_runner11 runtimes11 results11.json results11-i915-load.json guc_logs11.tar i915_display_info_post_exec11 boot11 dmesg11
| Detail | Value |
|---|---|
| Duration | 19.04 seconds |
| Hostname |
shard-snb7 |
| Igt-Version |
IGT-Version: 2.4-g5666b10ca (x86_64) (Linux: 7.0.0-rc6-CI_DRM_18267-gf1d4727d10d2+ x86_64) |
| Out |
Using IGT_SRANDOM=1775170218 for randomisation Opened device: /dev/dri/card0 Using monotonic timestamps Starting subtest: wf_vblank-ts-check-interruptible Starting dynamic subtest: A-VGA1 1024x768: 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa Expected frametime: 16666us; measured 16724.3us +- 8.522us accuracy 0.15% vblank interval differs from modeline! expected 16665.6us, measured 16724us +- 8.522us, difference 58.7us (6.9 sigma) Event vblank: expected 456, counted 450, passrate = 35.56%, encoder type 1 Expected frametime: 16666us; measured 16897.9us +- 7.759us accuracy 0.14% vblank interval differs from modeline! expected 16665.6us, measured 16898us +- 7.759us, difference 232.3us (29.9 sigma) Event vblank: expected 448, counted 450, passrate = 68.89%, encoder type 1 Stack trace: #0 ../lib/igt_core.c:2075 __igt_fail_assert() #1 ../tests/kms_flip.c:428 run_test_on_crtc_set.constprop.0() #2 ../tests/kms_flip.c:1891 run_test() #3 ../tests/kms_flip.c:2162 __igt_unique____real_main2047() #4 ../tests/kms_flip.c:2047 main() #5 [__libc_init_first+0x8a] #6 [__libc_start_main+0x8b] #7 [_start+0x25] Dynamic subtest A-VGA1: FAIL (19.038s) |
| Err |
Starting subtest: wf_vblank-ts-check-interruptible Starting dynamic subtest: A-VGA1 (kms_flip:2863) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1711: (kms_flip:2863) CRITICAL: Failed assertion: !retried (kms_flip:2863) CRITICAL: Last errno: 4, Interrupted system call Dynamic subtest A-VGA1 failed. **** DEBUG **** (kms_flip:2863) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_flip:2863) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_flip:2863) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS (kms_flip:2863) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_flip:2863) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_flip:2863) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS (kms_flip:2863) igt_kms-INFO: 1024x768: 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa (kms_flip:2863) DEBUG: No stale events found (kms_flip:2863) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0 (kms_flip:2863) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0 (kms_flip:2863) INFO: Expected frametime: 16666us; measured 16724.3us +- 8.522us accuracy 0.15% (kms_flip:2863) INFO: vblank interval differs from modeline! expected 16665.6us, measured 16724us +- 8.522us, difference 58.7us (6.9 sigma) (kms_flip:2863) DEBUG: name = vblank last_ts = 0.000000 last_received_ts = 0.000000 last_seq = 0 current_ts = 296.457397 current_received_ts = 296.456726 current_seq = 10542 count = 0 seq_step = 10 (kms_flip:2863) DEBUG: name = vblank last_ts = 296.457397 last_received_ts = 296.456726 last_seq = 10542 current_ts = 296.624634 current_received_ts = 296.624054 current_seq = 10552 count = 1 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 296.457397/10542, current 296.624634/10552: elapsed=167228.0us expected=167243.1us +- 836.2us, error 0.0% (kms_flip:2863) DEBUG: name = vblank last_ts = 296.624634 last_received_ts = 296.624054 last_seq = 10552 current_ts = 296.791870 current_received_ts = 296.791229 current_seq = 10562 count = 2 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 296.624634/10552, current 296.791870/10562: elapsed=167244.0us expected=167243.1us +- 836.2us, error 0.0% (kms_flip:2863) DEBUG: name = vblank last_ts = 296.791870 last_received_ts = 296.791229 last_seq = 10562 current_ts = 296.959137 current_received_ts = 296.958466 current_seq = 10572 count = 3 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 296.791870/10562, current 296.959137/10572: elapsed=167254.0us expected=167243.1us +- 836.2us, error 0.0% (kms_flip:2863) DEBUG: name = vblank last_ts = 296.959137 last_received_ts = 296.958466 last_seq = 10572 current_ts = 297.126373 current_received_ts = 297.125732 current_seq = 10582 count = 4 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 296.959137/10572, current 297.126373/10582: elapsed=167236.0us expected=167243.1us +- 836.2us, error 0.0% (kms_flip:2863) DEBUG: name = vblank last_ts = 297.126373 last_received_ts = 297.125732 last_seq = 10582 current_ts = 297.293579 current_received_ts = 297.292908 current_seq = 10592 count = 5 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 297.126373/10582, current 297.293579/10592: elapsed=167230.0us expected=167243.1us +- 836.2us, error 0.0% (kms_flip:2863) DEBUG: name = vblank last_ts = 297.293579 last_received_ts = 297.292908 last_seq = 10592 current_ts = 297.460846 current_received_ts = 297.460175 current_seq = 10602 count = 6 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 297.293579/10592, current 297.460846/10602: elapsed=167241.0us expected=167243.1us +- 836.2us, error 0.0% (kms_flip:2863) DEBUG: name = vblank last_ts = 297.460846 last_received_ts = 297.460175 last_seq = 10602 current_ts = 297.628082 current_received_ts = 297.627380 current_seq = 10612 count = 7 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 297.460846/10602, current 297.628082/10612: elapsed=167253.0us expected=167243.1us +- 836.2us, error 0.0% (kms_flip:2863) DEBUG: name = vblank last_ts = 297.628082 last_received_ts = 297.627380 last_seq = 10612 current_ts = 297.795319 current_received_ts = 297.794708 current_seq = 10622 count = 8 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 297.628082/10612, current 297.795319/10622: elapsed=167225.0us expected=167243.1us +- 836.2us, error 0.0% (kms_flip:2863) DEBUG: name = vblank last_ts = 297.795319 last_received_ts = 297.794708 last_seq = 10622 current_ts = 297.962555 current_received_ts = 297.961945 current_seq = 10632 count = 9 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 297.795319/10622, current 297.962555/10632: elapsed=167257.0us expected=167243.1us +- 836.2us, error 0.0% (kms_flip:2863) DEBUG: name = vblank last_ts = 297.962555 last_received_ts = 297.961945 last_seq = 10632 current_ts = 298.129791 current_received_ts = 298.129120 current_seq = 10642 count = 10 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 297.962555/10632, current 298.129791/10642: elapsed=167230.0us expected=167243.1us +- 836.2us, error 0.0% (kms_flip:2863) DEBUG: name = vblank last_ts = 298.129791 last_received_ts = 298.129120 last_seq = 10642 current_ts = 298.297028 current_received_ts = 298.296387 current_seq = 10652 count = 11 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 298.129791/10642, current 298.297028/10652: elapsed=167245.0us expected=167243.1us +- 836.2us, error 0.0% (kms_flip:2863) DEBUG: name = vblank last_ts = 298.297028 last_received_ts = 298.296387 last_seq = 10652 current_ts = 298.464264 current_received_ts = 298.463654 current_seq = 10662 count = 12 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 298.297028/10652, current 298.464264/10662: elapsed=167233.0us expected=167243.1us +- 836.2us, error 0.0% (kms_flip:2863) DEBUG: name = vblank last_ts = 298.464264 last_received_ts = 298.463654 last_seq = 10662 current_ts = 298.631531 current_received_ts = 298.630829 current_seq = 10672 count = 13 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 298.464264/10662, current 298.631531/10672: elapsed=167246.0us expected=167243.1us +- 836.2us, error 0.0% (kms_flip:2863) DEBUG: name = vblank last_ts = 298.631531 last_received_ts = 298.630829 last_seq = 10672 current_ts = 298.798767 current_received_ts = 298.798157 current_seq = 10682 count = 14 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 298.631531/10672, current 298.798767/10682: elapsed=167255.0us expected=167243.1us +- 836.2us, error 0.0% (kms_flip:2863) DEBUG: name = vblank last_ts = 298.798767 last_received_ts = 298.798157 last_seq = 10682 current_ts = 298.966034 current_received_ts = 298.965393 current_seq = 10692 count = 15 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 298.798767/10682, current 298.966034/10692: elapsed=167264.0us expected=167243.1us +- 836.2us, error 0.0% (kms_flip:2863) DEBUG: name = vblank last_ts = 298.966034 last_received_ts = 298.965393 last_seq = 10692 current_ts = 299.138031 current_received_ts = 299.137390 current_seq = 10702 count = 16 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 298.966034/10692, current 299.138031/10702: elapsed=171985.0us expected=167243.1us +- 836.2us, error 2.8% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 298.966034/10692, current 299.138031/10702: elapsed=171985.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 299.138031 last_received_ts = 299.137390 last_seq = 10702 current_ts = 299.310272 current_received_ts = 299.309662 current_seq = 10712 count = 17 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 299.138031/10702, current 299.310272/10712: elapsed=172260.0us expected=167243.1us +- 836.2us, error 3.0% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 299.138031/10702, current 299.310272/10712: elapsed=172260.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 299.310272 last_received_ts = 299.309662 last_seq = 10712 current_ts = 299.482574 current_received_ts = 299.481934 current_seq = 10722 count = 18 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 299.310272/10712, current 299.482574/10722: elapsed=172276.0us expected=167243.1us +- 836.2us, error 3.0% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 299.310272/10712, current 299.482574/10722: elapsed=172276.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 299.482574 last_received_ts = 299.481934 last_seq = 10722 current_ts = 299.654846 current_received_ts = 299.654205 current_seq = 10732 count = 19 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 299.482574/10722, current 299.654846/10732: elapsed=172290.0us expected=167243.1us +- 836.2us, error 3.0% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 299.482574/10722, current 299.654846/10732: elapsed=172290.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 299.654846 last_received_ts = 299.654205 last_seq = 10732 current_ts = 299.827118 current_received_ts = 299.826477 current_seq = 10742 count = 20 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 299.654846/10732, current 299.827118/10742: elapsed=172260.0us expected=167243.1us +- 836.2us, error 3.0% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 299.654846/10732, current 299.827118/10742: elapsed=172260.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 299.827118 last_received_ts = 299.826477 last_seq = 10742 current_ts = 299.999298 current_received_ts = 299.998688 current_seq = 10752 count = 21 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 299.827118/10742, current 299.999298/10752: elapsed=172188.0us expected=167243.1us +- 836.2us, error 3.0% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 299.827118/10742, current 299.999298/10752: elapsed=172188.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 299.999298 last_received_ts = 299.998688 last_seq = 10752 current_ts = 300.170959 current_received_ts = 300.170380 current_seq = 10762 count = 22 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 299.999298/10752, current 300.170959/10762: elapsed=171648.0us expected=167243.1us +- 836.2us, error 2.6% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 299.999298/10752, current 300.170959/10762: elapsed=171648.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 300.170959 last_received_ts = 300.170380 last_seq = 10762 current_ts = 300.342590 current_received_ts = 300.341980 current_seq = 10772 count = 23 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 300.170959/10762, current 300.342590/10772: elapsed=171646.0us expected=167243.1us +- 836.2us, error 2.6% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 300.170959/10762, current 300.342590/10772: elapsed=171646.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 300.342590 last_received_ts = 300.341980 last_seq = 10772 current_ts = 300.514252 current_received_ts = 300.513580 current_seq = 10782 count = 24 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 300.342590/10772, current 300.514252/10782: elapsed=171658.0us expected=167243.1us +- 836.2us, error 2.6% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 300.342590/10772, current 300.514252/10782: elapsed=171658.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 300.514252 last_received_ts = 300.513580 last_seq = 10782 current_ts = 300.685883 current_received_ts = 300.685242 current_seq = 10792 count = 25 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 300.514252/10782, current 300.685883/10792: elapsed=171638.0us expected=167243.1us +- 836.2us, error 2.6% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 300.514252/10782, current 300.685883/10792: elapsed=171638.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 300.685883 last_received_ts = 300.685242 last_seq = 10792 current_ts = 300.857544 current_received_ts = 300.856934 current_seq = 10802 count = 26 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 300.685883/10792, current 300.857544/10802: elapsed=171646.0us expected=167243.1us +- 836.2us, error 2.6% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 300.685883/10792, current 300.857544/10802: elapsed=171646.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 300.857544 last_received_ts = 300.856934 last_seq = 10802 current_ts = 301.029022 current_received_ts = 301.028381 current_seq = 10812 count = 27 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 300.857544/10802, current 301.029022/10812: elapsed=171492.0us expected=167243.1us +- 836.2us, error 2.5% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 300.857544/10802, current 301.029022/10812: elapsed=171492.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 301.029022 last_received_ts = 301.028381 last_seq = 10812 current_ts = 301.200104 current_received_ts = 301.199493 current_seq = 10822 count = 28 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 301.029022/10812, current 301.200104/10822: elapsed=171080.0us expected=167243.1us +- 836.2us, error 2.3% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 301.029022/10812, current 301.200104/10822: elapsed=171080.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 301.200104 last_received_ts = 301.199493 last_seq = 10822 current_ts = 301.371216 current_received_ts = 301.370483 current_seq = 10832 count = 29 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 301.200104/10822, current 301.371216/10832: elapsed=171113.0us expected=167243.1us +- 836.2us, error 2.3% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 301.200104/10822, current 301.371216/10832: elapsed=171113.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 301.371216 last_received_ts = 301.370483 last_seq = 10832 current_ts = 301.542297 current_received_ts = 301.541687 current_seq = 10842 count = 30 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 301.371216/10832, current 301.542297/10842: elapsed=171089.0us expected=167243.1us +- 836.2us, error 2.3% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 301.371216/10832, current 301.542297/10842: elapsed=171089.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 301.542297 last_received_ts = 301.541687 last_seq = 10842 current_ts = 301.713409 current_received_ts = 301.712799 current_seq = 10852 count = 31 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 301.542297/10842, current 301.713409/10852: elapsed=171106.0us expected=167243.1us +- 836.2us, error 2.3% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 301.542297/10842, current 301.713409/10852: elapsed=171106.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 301.713409 last_received_ts = 301.712799 last_seq = 10852 current_ts = 301.884491 current_received_ts = 301.883789 current_seq = 10862 count = 32 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 301.713409/10852, current 301.884491/10862: elapsed=171082.0us expected=167243.1us +- 836.2us, error 2.3% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 301.713409/10852, current 301.884491/10862: elapsed=171082.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 301.884491 last_received_ts = 301.883789 last_seq = 10862 current_ts = 302.055389 current_received_ts = 302.054779 current_seq = 10872 count = 33 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 301.884491/10862, current 302.055389/10872: elapsed=170879.0us expected=167243.1us +- 836.2us, error 2.2% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 301.884491/10862, current 302.055389/10872: elapsed=170879.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 302.055389 last_received_ts = 302.054779 last_seq = 10872 current_ts = 302.226013 current_received_ts = 302.225342 current_seq = 10882 count = 34 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 302.055389/10872, current 302.226013/10882: elapsed=170629.0us expected=167243.1us +- 836.2us, error 2.0% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 302.055389/10872, current 302.226013/10882: elapsed=170629.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 302.226013 last_received_ts = 302.225342 last_seq = 10882 current_ts = 302.396606 current_received_ts = 302.395935 current_seq = 10892 count = 35 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 302.226013/10882, current 302.396606/10892: elapsed=170605.0us expected=167243.1us +- 836.2us, error 2.0% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 302.226013/10882, current 302.396606/10892: elapsed=170605.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 302.396606 last_received_ts = 302.395935 last_seq = 10892 current_ts = 302.567230 current_received_ts = 302.566589 current_seq = 10902 count = 36 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 302.396606/10892, current 302.567230/10902: elapsed=170618.0us expected=167243.1us +- 836.2us, error 2.0% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 302.396606/10892, current 302.567230/10902: elapsed=170618.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 302.567230 last_received_ts = 302.566589 last_seq = 10902 current_ts = 302.737854 current_received_ts = 302.737244 current_seq = 10912 count = 37 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 302.567230/10902, current 302.737854/10912: elapsed=170616.0us expected=167243.1us +- 836.2us, error 2.0% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 302.567230/10902, current 302.737854/10912: elapsed=170616.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 302.737854 last_received_ts = 302.737244 last_seq = 10912 current_ts = 302.908447 current_received_ts = 302.907837 current_seq = 10922 count = 38 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 302.737854/10912, current 302.908447/10922: elapsed=170616.0us expected=167243.1us +- 836.2us, error 2.0% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 302.737854/10912, current 302.908447/10922: elapsed=170616.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 302.908447 last_received_ts = 302.907837 last_seq = 10922 current_ts = 303.078827 current_received_ts = 303.078156 current_seq = 10932 count = 39 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 302.908447/10922, current 303.078827/10932: elapsed=170358.0us expected=167243.1us +- 836.2us, error 1.9% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 302.908447/10922, current 303.078827/10932: elapsed=170358.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 303.078827 last_received_ts = 303.078156 last_seq = 10932 current_ts = 303.249023 current_received_ts = 303.248383 current_seq = 10942 count = 40 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 303.078827/10932, current 303.249023/10942: elapsed=170206.0us expected=167243.1us +- 836.2us, error 1.8% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 303.078827/10932, current 303.249023/10942: elapsed=170206.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 303.249023 last_received_ts = 303.248383 last_seq = 10942 current_ts = 303.419220 current_received_ts = 303.418579 current_seq = 10952 count = 41 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 303.249023/10942, current 303.419220/10952: elapsed=170196.0us expected=167243.1us +- 836.2us, error 1.8% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 303.249023/10942, current 303.419220/10952: elapsed=170196.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 303.419220 last_received_ts = 303.418579 last_seq = 10952 current_ts = 303.589417 current_received_ts = 303.588776 current_seq = 10962 count = 42 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 303.419220/10952, current 303.589417/10962: elapsed=170205.0us expected=167243.1us +- 836.2us, error 1.8% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 303.419220/10952, current 303.589417/10962: elapsed=170205.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 303.589417 last_received_ts = 303.588776 last_seq = 10962 current_ts = 303.759613 current_received_ts = 303.758911 current_seq = 10972 count = 43 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 303.589417/10962, current 303.759613/10972: elapsed=170198.0us expected=167243.1us +- 836.2us, error 1.8% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 303.589417/10962, current 303.759613/10972: elapsed=170198.0us expected=167243.1us (kms_flip:2863) DEBUG: name = vblank last_ts = 303.759613 last_received_ts = 303.758911 last_seq = 10972 current_ts = 303.929810 current_received_ts = 303.929138 current_seq = 10982 count = 44 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 303.759613/10972, current 303.929810/10982: elapsed=170190.0us expected=167243.1us +- 836.2us, error 1.8% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 303.759613/10972, current 303.929810/10982: elapsed=170190.0us expected=167243.1us (kms_flip:2863) INFO: Event vblank: expected 456, counted 450, passrate = 35.56%, encoder type 1 (kms_flip:2863) DEBUG: dropped frames, expected 456, counted 450, passrate = 35.56%, encoder type 1 (kms_flip:2863) DEBUG: Retrying without a hotplug event (kms_flip:2863) DEBUG: No stale events found (kms_flip:2863) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0 (kms_flip:2863) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0 (kms_flip:2863) INFO: Expected frametime: 16666us; measured 16897.9us +- 7.759us accuracy 0.14% (kms_flip:2863) INFO: vblank interval differs from modeline! expected 16665.6us, measured 16898us +- 7.759us, difference 232.3us (29.9 sigma) (kms_flip:2863) DEBUG: name = vblank last_ts = 0.000000 last_received_ts = 0.000000 last_seq = 0 current_ts = 307.548706 current_received_ts = 307.548065 current_seq = 11015 count = 0 seq_step = 10 (kms_flip:2863) DEBUG: name = vblank last_ts = 307.548706 last_received_ts = 307.548065 last_seq = 11015 current_ts = 307.717682 current_received_ts = 307.717102 current_seq = 11025 count = 1 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 307.548706/11015, current 307.717682/11025: elapsed=168978.0us expected=168979.4us +- 844.9us, error 0.0% (kms_flip:2863) DEBUG: name = vblank last_ts = 307.717682 last_received_ts = 307.717102 last_seq = 11025 current_ts = 307.886658 current_received_ts = 307.885986 current_seq = 11035 count = 2 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 307.717682/11025, current 307.886658/11035: elapsed=168980.0us expected=168979.4us +- 844.9us, error 0.0% (kms_flip:2863) DEBUG: name = vblank last_ts = 307.886658 last_received_ts = 307.885986 last_seq = 11035 current_ts = 308.055542 current_received_ts = 308.054993 current_seq = 11045 count = 3 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 307.886658/11035, current 308.055542/11045: elapsed=168873.0us expected=168979.4us +- 844.9us, error 0.1% (kms_flip:2863) DEBUG: name = vblank last_ts = 308.055542 last_received_ts = 308.054993 last_seq = 11045 current_ts = 308.224304 current_received_ts = 308.223694 current_seq = 11055 count = 4 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 308.055542/11045, current 308.224304/11055: elapsed=168763.0us expected=168979.4us +- 844.9us, error 0.1% (kms_flip:2863) DEBUG: name = vblank last_ts = 308.224304 last_received_ts = 308.223694 last_seq = 11055 current_ts = 308.393066 current_received_ts = 308.392487 current_seq = 11065 count = 5 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 308.224304/11055, current 308.393066/11065: elapsed=168764.0us expected=168979.4us +- 844.9us, error 0.1% (kms_flip:2863) DEBUG: name = vblank last_ts = 308.393066 last_received_ts = 308.392487 last_seq = 11065 current_ts = 308.561829 current_received_ts = 308.561188 current_seq = 11075 count = 6 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 308.393066/11065, current 308.561829/11075: elapsed=168773.0us expected=168979.4us +- 844.9us, error 0.1% (kms_flip:2863) DEBUG: name = vblank last_ts = 308.561829 last_received_ts = 308.561188 last_seq = 11075 current_ts = 308.730591 current_received_ts = 308.729950 current_seq = 11085 count = 7 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 308.561829/11075, current 308.730591/11085: elapsed=168762.0us expected=168979.4us +- 844.9us, error 0.1% (kms_flip:2863) DEBUG: name = vblank last_ts = 308.730591 last_received_ts = 308.729950 last_seq = 11085 current_ts = 308.899353 current_received_ts = 308.898712 current_seq = 11095 count = 8 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 308.730591/11085, current 308.899353/11095: elapsed=168767.0us expected=168979.4us +- 844.9us, error 0.1% (kms_flip:2863) DEBUG: name = vblank last_ts = 308.899353 last_received_ts = 308.898712 last_seq = 11095 current_ts = 309.067993 current_received_ts = 309.067383 current_seq = 11105 count = 9 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 308.899353/11095, current 309.067993/11105: elapsed=168645.0us expected=168979.4us +- 844.9us, error 0.2% (kms_flip:2863) DEBUG: name = vblank last_ts = 309.067993 last_received_ts = 309.067383 last_seq = 11105 current_ts = 309.236572 current_received_ts = 309.235962 current_seq = 11115 count = 10 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 309.067993/11105, current 309.236572/11115: elapsed=168575.0us expected=168979.4us +- 844.9us, error 0.2% (kms_flip:2863) DEBUG: name = vblank last_ts = 309.236572 last_received_ts = 309.235962 last_seq = 11115 current_ts = 309.405151 current_received_ts = 309.404541 current_seq = 11125 count = 11 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 309.236572/11115, current 309.405151/11125: elapsed=168575.0us expected=168979.4us +- 844.9us, error 0.2% (kms_flip:2863) DEBUG: name = vblank last_ts = 309.405151 last_received_ts = 309.404541 last_seq = 11125 current_ts = 309.573730 current_received_ts = 309.573090 current_seq = 11135 count = 12 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 309.405151/11125, current 309.573730/11135: elapsed=168577.0us expected=168979.4us +- 844.9us, error 0.2% (kms_flip:2863) DEBUG: name = vblank last_ts = 309.573730 last_received_ts = 309.573090 last_seq = 11135 current_ts = 309.742310 current_received_ts = 309.741699 current_seq = 11145 count = 13 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 309.573730/11135, current 309.742310/11145: elapsed=168568.0us expected=168979.4us +- 844.9us, error 0.2% (kms_flip:2863) DEBUG: name = vblank last_ts = 309.742310 last_received_ts = 309.741699 last_seq = 11145 current_ts = 309.910889 current_received_ts = 309.910217 current_seq = 11155 count = 14 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 309.742310/11145, current 309.910889/11155: elapsed=168587.0us expected=168979.4us +- 844.9us, error 0.2% (kms_flip:2863) DEBUG: name = vblank last_ts = 309.910889 last_received_ts = 309.910217 last_seq = 11155 current_ts = 310.079346 current_received_ts = 310.078766 current_seq = 11165 count = 15 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 309.910889/11155, current 310.079346/11165: elapsed=168469.0us expected=168979.4us +- 844.9us, error 0.3% (kms_flip:2863) DEBUG: name = vblank last_ts = 310.079346 last_received_ts = 310.078766 last_seq = 11165 current_ts = 310.247772 current_received_ts = 310.247101 current_seq = 11175 count = 16 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 310.079346/11165, current 310.247772/11175: elapsed=168415.0us expected=168979.4us +- 844.9us, error 0.3% (kms_flip:2863) DEBUG: name = vblank last_ts = 310.247772 last_received_ts = 310.247101 last_seq = 11175 current_ts = 310.416168 current_received_ts = 310.415527 current_seq = 11185 count = 17 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 310.247772/11175, current 310.416168/11185: elapsed=168406.0us expected=168979.4us +- 844.9us, error 0.3% (kms_flip:2863) DEBUG: name = vblank last_ts = 310.416168 last_received_ts = 310.415527 last_seq = 11185 current_ts = 310.584595 current_received_ts = 310.583923 current_seq = 11195 count = 18 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 310.416168/11185, current 310.584595/11195: elapsed=168406.0us expected=168979.4us +- 844.9us, error 0.3% (kms_flip:2863) DEBUG: name = vblank last_ts = 310.584595 last_received_ts = 310.583923 last_seq = 11195 current_ts = 310.752991 current_received_ts = 310.752289 current_seq = 11205 count = 19 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 310.584595/11195, current 310.752991/11205: elapsed=168396.0us expected=168979.4us +- 844.9us, error 0.3% (kms_flip:2863) DEBUG: name = vblank last_ts = 310.752991 last_received_ts = 310.752289 last_seq = 11205 current_ts = 310.921387 current_received_ts = 310.920715 current_seq = 11215 count = 20 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 310.752991/11205, current 310.921387/11215: elapsed=168413.0us expected=168979.4us +- 844.9us, error 0.3% (kms_flip:2863) DEBUG: name = vblank last_ts = 310.921387 last_received_ts = 310.920715 last_seq = 11215 current_ts = 311.089691 current_received_ts = 311.089081 current_seq = 11225 count = 21 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 310.921387/11215, current 311.089691/11225: elapsed=168308.0us expected=168979.4us +- 844.9us, error 0.4% (kms_flip:2863) DEBUG: name = vblank last_ts = 311.089691 last_received_ts = 311.089081 last_seq = 11225 current_ts = 311.257965 current_received_ts = 311.257355 current_seq = 11235 count = 22 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 311.089691/11225, current 311.257965/11235: elapsed=168278.0us expected=168979.4us +- 844.9us, error 0.4% (kms_flip:2863) DEBUG: name = vblank last_ts = 311.257965 last_received_ts = 311.257355 last_seq = 11235 current_ts = 311.426239 current_received_ts = 311.425568 current_seq = 11245 count = 23 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 311.257965/11235, current 311.426239/11245: elapsed=168265.0us expected=168979.4us +- 844.9us, error 0.4% (kms_flip:2863) DEBUG: name = vblank last_ts = 311.426239 last_received_ts = 311.425568 last_seq = 11245 current_ts = 311.594482 current_received_ts = 311.593872 current_seq = 11255 count = 24 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 311.426239/11245, current 311.594482/11255: elapsed=168250.0us expected=168979.4us +- 844.9us, error 0.4% (kms_flip:2863) DEBUG: name = vblank last_ts = 311.594482 last_received_ts = 311.593872 last_seq = 11255 current_ts = 311.762756 current_received_ts = 311.762146 current_seq = 11265 count = 25 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 311.594482/11255, current 311.762756/11265: elapsed=168261.0us expected=168979.4us +- 844.9us, error 0.4% (kms_flip:2863) DEBUG: name = vblank last_ts = 311.762756 last_received_ts = 311.762146 last_seq = 11265 current_ts = 311.931030 current_received_ts = 311.930420 current_seq = 11275 count = 26 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 311.762756/11265, current 311.931030/11275: elapsed=168267.0us expected=168979.4us +- 844.9us, error 0.4% (kms_flip:2863) DEBUG: name = vblank last_ts = 311.931030 last_received_ts = 311.930420 last_seq = 11275 current_ts = 312.099182 current_received_ts = 312.098572 current_seq = 11285 count = 27 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 311.931030/11275, current 312.099182/11285: elapsed=168172.0us expected=168979.4us +- 844.9us, error 0.5% (kms_flip:2863) DEBUG: name = vblank last_ts = 312.099182 last_received_ts = 312.098572 last_seq = 11285 current_ts = 312.267334 current_received_ts = 312.266693 current_seq = 11295 count = 28 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 312.099182/11285, current 312.267334/11295: elapsed=168152.0us expected=168979.4us +- 844.9us, error 0.5% (kms_flip:2863) DEBUG: name = vblank last_ts = 312.267334 last_received_ts = 312.266693 last_seq = 11295 current_ts = 312.435455 current_received_ts = 312.434875 current_seq = 11305 count = 29 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 312.267334/11295, current 312.435455/11305: elapsed=168124.0us expected=168979.4us +- 844.9us, error 0.5% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 312.267334/11295, current 312.435455/11305: elapsed=168124.0us expected=168979.4us (kms_flip:2863) DEBUG: name = vblank last_ts = 312.435455 last_received_ts = 312.434875 last_seq = 11305 current_ts = 312.603607 current_received_ts = 312.602905 current_seq = 11315 count = 30 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 312.435455/11305, current 312.603607/11315: elapsed=168152.0us expected=168979.4us +- 844.9us, error 0.5% (kms_flip:2863) DEBUG: name = vblank last_ts = 312.603607 last_received_ts = 312.602905 last_seq = 11315 current_ts = 312.771729 current_received_ts = 312.771118 current_seq = 11325 count = 31 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 312.603607/11315, current 312.771729/11325: elapsed=168125.0us expected=168979.4us +- 844.9us, error 0.5% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 312.603607/11315, current 312.771729/11325: elapsed=168125.0us expected=168979.4us (kms_flip:2863) DEBUG: name = vblank last_ts = 312.771729 last_received_ts = 312.771118 last_seq = 11325 current_ts = 312.939880 current_received_ts = 312.939209 current_seq = 11335 count = 32 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 312.771729/11325, current 312.939880/11335: elapsed=168151.0us expected=168979.4us +- 844.9us, error 0.5% (kms_flip:2863) DEBUG: name = vblank last_ts = 312.939880 last_received_ts = 312.939209 last_seq = 11335 current_ts = 313.107941 current_received_ts = 313.107330 current_seq = 11345 count = 33 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 312.939880/11335, current 313.107941/11345: elapsed=168037.0us expected=168979.4us +- 844.9us, error 0.6% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 312.939880/11335, current 313.107941/11345: elapsed=168037.0us expected=168979.4us (kms_flip:2863) DEBUG: name = vblank last_ts = 313.107941 last_received_ts = 313.107330 last_seq = 11345 current_ts = 313.275970 current_received_ts = 313.275299 current_seq = 11355 count = 34 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 313.107941/11345, current 313.275970/11355: elapsed=168043.0us expected=168979.4us +- 844.9us, error 0.6% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 313.107941/11345, current 313.275970/11355: elapsed=168043.0us expected=168979.4us (kms_flip:2863) DEBUG: name = vblank last_ts = 313.275970 last_received_ts = 313.275299 last_seq = 11355 current_ts = 313.443970 current_received_ts = 313.443390 current_seq = 11365 count = 35 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 313.275970/11355, current 313.443970/11365: elapsed=168010.0us expected=168979.4us +- 844.9us, error 0.6% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 313.275970/11355, current 313.443970/11365: elapsed=168010.0us expected=168979.4us (kms_flip:2863) DEBUG: name = vblank last_ts = 313.443970 last_received_ts = 313.443390 last_seq = 11365 current_ts = 313.612030 current_received_ts = 313.611389 current_seq = 11375 count = 36 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 313.443970/11365, current 313.612030/11375: elapsed=168031.0us expected=168979.4us +- 844.9us, error 0.6% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 313.443970/11365, current 313.612030/11375: elapsed=168031.0us expected=168979.4us (kms_flip:2863) DEBUG: name = vblank last_ts = 313.612030 last_received_ts = 313.611389 last_seq = 11375 current_ts = 313.780029 current_received_ts = 313.779419 current_seq = 11385 count = 37 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 313.612030/11375, current 313.780029/11385: elapsed=168028.0us expected=168979.4us +- 844.9us, error 0.6% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 313.612030/11375, current 313.780029/11385: elapsed=168028.0us expected=168979.4us (kms_flip:2863) DEBUG: name = vblank last_ts = 313.780029 last_received_ts = 313.779419 last_seq = 11385 current_ts = 313.948059 current_received_ts = 313.947449 current_seq = 11395 count = 38 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 313.780029/11385, current 313.948059/11395: elapsed=168024.0us expected=168979.4us +- 844.9us, error 0.6% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 313.780029/11385, current 313.948059/11395: elapsed=168024.0us expected=168979.4us (kms_flip:2863) DEBUG: name = vblank last_ts = 313.948059 last_received_ts = 313.947449 last_seq = 11395 current_ts = 314.116028 current_received_ts = 314.115356 current_seq = 11405 count = 39 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 313.948059/11395, current 314.116028/11405: elapsed=167958.0us expected=168979.4us +- 844.9us, error 0.6% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 313.948059/11395, current 314.116028/11405: elapsed=167958.0us expected=168979.4us (kms_flip:2863) DEBUG: name = vblank last_ts = 314.116028 last_received_ts = 314.115356 last_seq = 11405 current_ts = 314.283936 current_received_ts = 314.283325 current_seq = 11415 count = 40 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 314.116028/11405, current 314.283936/11415: elapsed=167918.0us expected=168979.4us +- 844.9us, error 0.6% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 314.116028/11405, current 314.283936/11415: elapsed=167918.0us expected=168979.4us (kms_flip:2863) DEBUG: name = vblank last_ts = 314.283936 last_received_ts = 314.283325 last_seq = 11415 current_ts = 314.451874 current_received_ts = 314.451233 current_seq = 11425 count = 41 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 314.283936/11415, current 314.451874/11425: elapsed=167935.0us expected=168979.4us +- 844.9us, error 0.6% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 314.283936/11415, current 314.451874/11425: elapsed=167935.0us expected=168979.4us (kms_flip:2863) DEBUG: name = vblank last_ts = 314.451874 last_received_ts = 314.451233 last_seq = 11425 current_ts = 314.619812 current_received_ts = 314.619171 current_seq = 11435 count = 42 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 314.451874/11425, current 314.619812/11435: elapsed=167936.0us expected=168979.4us +- 844.9us, error 0.6% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 314.451874/11425, current 314.619812/11435: elapsed=167936.0us expected=168979.4us (kms_flip:2863) DEBUG: name = vblank last_ts = 314.619812 last_received_ts = 314.619171 last_seq = 11435 current_ts = 314.787720 current_received_ts = 314.787079 current_seq = 11445 count = 43 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 314.619812/11435, current 314.787720/11445: elapsed=167920.0us expected=168979.4us +- 844.9us, error 0.6% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 314.619812/11435, current 314.787720/11445: elapsed=167920.0us expected=168979.4us (kms_flip:2863) DEBUG: name = vblank last_ts = 314.787720 last_received_ts = 314.787079 last_seq = 11445 current_ts = 314.955658 current_received_ts = 314.955078 current_seq = 11455 count = 44 seq_step = 10 (kms_flip:2863) DEBUG: vblank ts/seq: last 314.787720/11445, current 314.955658/11455: elapsed=167931.0us expected=168979.4us +- 844.9us, error 0.6% (kms_flip:2863) DEBUG: inconsistent vblank ts/seq: last 314.787720/11445, current 314.955658/11455: elapsed=167931.0us expected=168979.4us (kms_flip:2863) INFO: Event vblank: expected 448, counted 450, passrate = 68.89%, encoder type 1 (kms_flip:2863) DEBUG: dropped frames, expected 448, counted 450, passrate = 68.89%, encoder type 1 (kms_flip:2863) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1711: (kms_flip:2863) CRITICAL: Failed assertion: !retried (kms_flip:2863) CRITICAL: Last errno: 4, Interrupted system call (kms_flip:2863) igt_core-INFO: Stack trace: (kms_flip:2863) igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (kms_flip:2863) igt_core-INFO: #1 ../tests/kms_flip.c:428 run_test_on_crtc_set.constprop.0() (kms_flip:2863) igt_core-INFO: #2 ../tests/kms_flip.c:1891 run_test() (kms_flip:2863) igt_core-INFO: #3 ../tests/kms_flip.c:2162 __igt_unique____real_main2047() (kms_flip:2863) igt_core-INFO: #4 ../tests/kms_flip.c:2047 main() (kms_flip:2863) igt_core-INFO: #5 [__libc_init_first+0x8a] (kms_flip:2863) igt_core-INFO: #6 [__libc_start_main+0x8b] (kms_flip:2863) igt_core-INFO: #7 [_start+0x25] **** END **** Dynamic subtest A-VGA1: FAIL (19.038s) |
| Dmesg |
<6> [295.040469] Console: switching to colour dummy device 80x25
<6> [295.041096] [IGT] kms_flip: executing
<7> [295.045370] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [295.046534] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [295.047111] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [295.051079] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:84:DP-1]
<7> [295.051090] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:84:DP-1]
<7> [295.053875] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.057105] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.060078] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.062971] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.065826] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.068680] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.071566] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.074449] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.077325] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.080284] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.083162] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.086090] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.089116] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.092097] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.095161] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.098315] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.101242] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.104313] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.107250] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.110236] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.113393] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.116327] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.119396] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.122385] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.125430] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.128394] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.131333] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.134298] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.137313] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.140334] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.143364] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.146385] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.146809] i915 0000:00:02.0: [drm:drm_dp_dpcd_access [drm_display_helper]] AUX D/DP D: Too many retries, giving up. First error: -110
<7> [295.149444] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.152475] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.155431] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.158436] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.161428] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.164380] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.167389] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.170424] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.173476] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.176450] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.179430] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.182371] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.185345] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.188227] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.191165] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.194188] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.197156] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.200176] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.203124] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.206217] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.209104] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.212091] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.214975] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.217853] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.220791] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.223789] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.226712] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.229678] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.232636] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.235627] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.238606] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.241573] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.241996] i915 0000:00:02.0: [drm:drm_dp_dpcd_access [drm_display_helper]] AUX D/DP D: Too many retries, giving up. First error: -110
<7> [295.242045] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:84:DP-1] disconnected
<7> [295.242489] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:73:VGA-1]
<7> [295.242504] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:73:VGA-1] force=1
<7> [295.242968] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] ironlake hotplug adpa=0x83f40000, result 1
<7> [295.243538] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT detected via hotplug
<7> [295.244273] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [295.244618] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry
<7> [295.245064] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [295.245468] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [295.245477] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging
<7> [295.245799] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1
<7> [295.247005] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [295.247011] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0
<7> [295.247339] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:73:VGA-1] probed modes:
<7> [295.247346] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [295.247355] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5
<7> [295.247364] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5
<7> [295.247372] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "848x480": 60 33750 848 864 976 1088 480 486 494 517 0x40 0x5
<7> [295.247380] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [295.247415] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:76:HDMI-A-1]
<7> [295.247428] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:76:HDMI-A-1]
<7> [295.272658] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:76:HDMI-A-1] HDMI: DVI dual 0, max TMDS clock 590000 kHz
<7> [295.272668] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:76:HDMI-A-1] HDMI sink does deep color 30.
<7> [295.272673] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:76:HDMI-A-1] HDMI sink does deep color 36.
<7> [295.272678] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:76:HDMI-A-1] HDMI sink does deep color 48.
<7> [295.272682] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:76:HDMI-A-1] Assigning HDMI sink color depth as 16 bpc.
<7> [295.272686] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:76:HDMI-A-1] HDMI sink does YCRCB444 in deep color.
<7> [295.272692] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:76:HDMI-A-1] ELD monitor Mi TV
<7> [295.272696] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:76:HDMI-A-1] HDMI: latency present 0 0, video latency 0 0, audio latency 0 0
<7> [295.272701] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:76:HDMI-A-1] ELD size 36, SAD count 3
<7> [295.272881] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK for addr: 0040 w(1)
<7> [295.273103] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK on first message, retry
<7> [295.273510] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK for addr: 0040 w(1)
<7> [295.273851] i915 0000:00:02.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: (err -6)
<7> [295.275398] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "2560x1600": 60 268500 2560 2608 2640 2720 1600 1603 1609 1646 0x40 0x5 (CLOCK_HIGH)
<7> [295.275418] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "2560x1440": 60 241500 2560 2608 2640 2720 1440 1443 1449 1481 0x40 0x5 (CLOCK_HIGH)
<7> [295.275433] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 30 297000 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [295.275448] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "4096x2160": 30 297000 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [295.275462] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "1920x1080": 120 297000 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5 (CLOCK_HIGH)
<7> [295.275476] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 25 297000 3840 4896 4984 5280 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [295.275489] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 24 297000 3840 5116 5204 5500 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [295.275503] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "4096x2160": 24 297000 4096 5116 5204 5500 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [295.275516] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 50 594000 3840 4896 4984 5280 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [295.275530] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 60 594000 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [295.275543] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "4096x2160": 50 594000 4096 5064 5152 5280 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [295.275557] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "4096x2160": 60 594000 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [295.275570] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 30 296703 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [295.275582] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "4096x2160": 30 296703 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [295.275595] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "1920x1080": 120 296703 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5 (CLOCK_HIGH)
<7> [295.275608] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 24 296703 3840 5116 5204 5500 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [295.275621] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "4096x2160": 24 296703 4096 5116 5204 5500 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [295.275634] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 60 593407 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [295.275647] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "4096x2160": 60 593407 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [295.275667] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:76:HDMI-A-1] probed modes:
<7> [295.275674] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [295.275682] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2880x1800": 30 167000 2880 2910 2920 3030 1800 1820 1828 1836 0x40 0x5
<7> [295.275689] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1200": 60 154000 1920 1968 2000 2080 1200 1203 1209 1235 0x40 0x9
<7> [295.275697] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [295.275704] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148352 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [295.275711] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080i": 60 74250 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x15
<7> [295.275719] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080i": 60 74250 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x20015
<7> [295.275726] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080i": 60 74176 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x15
<7> [295.275734] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080i": 60 74176 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x20015
<7> [295.275741] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 50 148500 1920 2448 2492 2640 1080 1084 1089 1125 0x40 0x5
<7> [295.275749] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080i": 50 74250 1920 2448 2492 2640 1080 1084 1094 1125 0x40 0x15
<7> [295.275756] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080i": 50 74250 1920 2448 2492 2640 1080 1084 1094 1125 0x40 0x20015
<7> [295.275764] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 30 74250 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [295.275772] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 30 74176 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [295.275779] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 25 74250 1920 2448 2492 2640 1080 1084 1089 1125 0x40 0x5
<7> [295.275786] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 24 74250 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x5
<7> [295.275794] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 24 74250 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x1c005
<7> [295.275801] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 24 74250 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x4005
<7> [295.275809] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 24 74176 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x5
<7> [295.275816] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 24 74176 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x1c005
<7> [295.275823] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 24 74176 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x4005
<7> [295.275831] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x1200": 60 162000 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5
<7> [295.275838] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1680x1050": 60 119000 1680 1728 1760 1840 1050 1053 1059 1080 0x40 0x9
<7> [295.275846] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x900": 60 108000 1600 1624 1704 1800 900 901 904 1000 0x40 0x5
<7> [295.275853] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 60 108000 1280 1328 1440 1688 1024 1025 1028 1066 0x40 0x5
<7> [295.275861] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1440x900": 60 88750 1440 1488 1520 1600 900 903 909 926 0x40 0x9
<7> [295.275868] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1366x768": 60 85500 1366 1436 1579 1792 768 771 774 798 0x40 0x5
<7> [295.275876] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x800": 60 71000 1280 1328 1360 1440 800 803 809 823 0x40 0x9
<7> [295.275891] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [295.275898] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x1c005
<7> [295.275906] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x4005
<7> [295.275914] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [295.275921] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x1c005
<7> [295.275929] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x4005
<7> [295.275937] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 50 74250 1280 1720 1760 1980 720 725 730 750 0x40 0x5
<7> [295.275945] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 50 74250 1280 1720 1760 1980 720 725 730 750 0x40 0x1c005
<7> [295.275952] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 50 74250 1280 1720 1760 1980 720 725 730 750 0x40 0x4005
<7> [295.275960] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [295.275968] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5
<7> [295.275975] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x576": 50 27000 720 732 796 864 576 581 586 625 0x40 0xa
<7> [295.275983] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x576i": 50 13500 720 732 795 864 576 580 586 625 0x40 0x101a
<7> [295.275991] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x480": 60 27027 720 736 798 858 480 489 495 525 0x40 0xa
<7> [295.275998] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x480": 60 27000 720 736 798 858 480 489 495 525 0x40 0xa
<7> [295.276006] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25200 640 656 752 800 480 490 492 525 0x40 0xa
<7> [295.276014] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [295.276086] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:84:DP-1]
<7> [295.276095] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:84:DP-1]
<7> [295.279038] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.281945] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.284835] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.287693] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.290578] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.293464] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.296360] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.299336] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.302272] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.305219] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.308175] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.311130] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.314089] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.317043] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.319999] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.322950] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.325886] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.328822] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.331751] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.334693] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.337631] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.340558] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.343482] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.346376] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.349296] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.352332] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.355291] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.358326] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.361298] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.364326] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.367331] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.370326] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.370721] i915 0000:00:02.0: [drm:drm_dp_dpcd_access [drm_display_helper]] AUX D/DP D: Too many retries, giving up. First error: -110
<7> [295.373325] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.376291] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.379323] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.382347] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.385350] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.388324] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.391346] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.394328] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.397290] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.400345] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.403326] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.406327] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.409301] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.412258] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.415260] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.418367] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.421305] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.424185] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.427172] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.430212] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.433266] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.436342] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.439260] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.442294] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.445289] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.448267] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.451269] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.454277] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.457173] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.460229] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.463273] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.466365] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [295.466734] i915 0000:00:02.0: [drm:drm_dp_dpcd_access [drm_display_helper]] AUX D/DP D: Too many retries, giving up. First error: -110
<7> [295.466783] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:84:DP-1] disconnected
<6> [295.476059] [IGT] kms_flip: starting subtest wf_vblank-ts-check-interruptible
<6> [295.477896] [IGT] kms_flip: starting dynamic subtest A-VGA1
<7> [295.478679] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:92]
<7> [295.478843] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:93]
<7> [295.509869] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:53:pipe A]
<7> [295.510010] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [295.510341] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [295.510590] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [295.510836] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in has_pch_encoder (expected yes, found no)
<7> [295.511080] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in fdi_lanes (expected 1, found 0)
<7> [295.511413] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in fdi_m_n (expected tu 64 data 6039797/8388608 link 125829/524288, found tu 0, data 0/0 link 0/0)
<7> [295.511688] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in output_types (expected 0x00000002, found 0x00000000)
<7> [295.511933] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [295.512177] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1024, found 0)
<7> [295.512440] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 1344, found 0)
<7> [295.512684] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1024, found 0)
<7> [295.512928] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 1344, found 0)
<7> [295.513171] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 1048, found 0)
<7> [295.513425] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 1184, found 0)
<7> [295.513656] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 768, found 0)
<7> [295.513886] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 768, found 0)
<7> [295.514115] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 771, found 0)
<7> [295.514413] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 777, found 0)
<7> [295.514670] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 806, found 0)
<7> [295.514902] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 806, found 0)
<7> [295.515131] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1024, found 0)
<7> [295.515574] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 1344, found 0)
<7> [295.515814] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1024, found 0)
<7> [295.516055] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 1344, found 0)
<7> [295.516313] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 1048, found 0)
<7> [295.516561] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 1184, found 0)
<7> [295.516791] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 768, found 0)
<7> [295.517053] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 768, found 0)
<7> [295.517321] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 771, found 0)
<7> [295.517598] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 777, found 0)
<7> [295.517854] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 806, found 0)
<7> [295.518084] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 806, found 0)
<7> [295.518365] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [295.518625] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [295.518856] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [295.519087] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [295.519380] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 64800, found 0)
<7> [295.519642] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 64800, found 0)
<7> [295.519888] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in port_clock (expected 64800, found 0)
<7> [295.520120] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:53:pipe A] fastset requirement not met, forcing full modeset
<7> [295.520378] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:53:pipe A] releasing PCH DPLL A
<7> [295.520653] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:53:pipe A] min cdclk: 72000 kHz -> 0 kHz
<7> [295.520914] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:53:pipe A] enable: no [modeset]
<7> [295.521156] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:35:primary A] fb: [NOFB], visible: no
<7> [295.521602] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [295.534594] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port B found
<7> [295.535053] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port C found
<7> [295.535530] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port D found
<7> [295.551506] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PCH DPLL A (active 0x1, on? 1) for [CRTC:53:pipe A]
<7> [295.551996] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PCH DPLL A
<7> [295.552729] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:74:CRT]
<7> [295.553482] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:75:HDMI D]
<7> [295.554170] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:83:DP D]
<7> [295.554930] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:73:VGA-1]
<7> [295.555312] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:53:pipe A]
<7> [295.555602] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:72:pipe B]
<7> [295.555700] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.enable (expected yes, found no)
<7> [295.555933] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.active (expected yes, found no)
<7> [295.556164] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [295.556430] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in has_pch_encoder (expected yes, found no)
<7> [295.556677] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in fdi_lanes (expected 3, found 0)
<7> [295.556906] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in fdi_m_n (expected tu 64 data 6934582/8388608 link 288940/524288, found tu 0, data 0/0 link 0/0)
<7> [295.557137] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in lane_count (expected 4, found 0)
<7> [295.557524] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [295.557882] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [295.558265] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [295.558635] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [295.558989] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [295.559381] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [295.559666] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [295.559932] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [295.560240] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [295.560493] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [295.560724] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [295.560954] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [295.561304] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [295.561605] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [295.561852] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [295.562097] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [295.562367] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [295.562672] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [295.562909] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [295.563146] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [295.563401] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [295.563694] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [295.563931] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [295.564184] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [295.564540] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [295.564859] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [295.565226] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [295.565540] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [295.565806] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [295.566073] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [295.566367] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [295.566682] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [295.566949] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148800, found 0)
<7> [295.567252] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148800, found 0)
<7> [295.567523] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in port_clock (expected 223200, found 0)
<7> [295.567759] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [295.567996] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [295.568278] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in avi infoframe
<7> [295.568532] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [295.568766] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [295.568769] i915 0000:00:02.0: colorspace: RGB
<7> [295.568771] i915 0000:00:02.0: scan mode: Underscan
<7> [295.568774] i915 0000:00:02.0: colorimetry: No Data
<7> [295.568776] i915 0000:00:02.0: picture aspect: 16:9
<7> [295.568778] i915 0000:00:02.0: active aspect: Same as Picture
<7> [295.568780] i915 0000:00:02.0: itc: No Data
<7> [295.568782] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [295.568784] i915 0000:00:02.0: quantization range: Default
<7> [295.568786] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [295.568788] i915 0000:00:02.0: video code: 16
<7> [295.568790] i915 0000:00:02.0: ycc quantization range: Full
<7> [295.568792] i915 0000:00:02.0: hdmi content type: Graphics
<7> [295.568794] i915 0000:00:02.0: pixel repeat: 0
<7> [295.568796] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [295.568798] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [295.569034] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in spd infoframe
<7> [295.569310] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [295.569576] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [295.569579] i915 0000:00:02.0: vendor: Intel
<7> [295.569581] i915 0000:00:02.0: product: Integrated gfx
<7> [295.569584] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [295.569586] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [295.569822] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:72:pipe B] fastset requirement not met in hdmi infoframe
<7> [295.570056] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [295.570330] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [295.570335] i915 0000:00:02.0: empty frame
<7> [295.570339] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [295.570601] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:72:pipe B] fastset requirement not met, forcing full modeset
<7> [295.570838] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:72:pipe B] releasing PCH DPLL B
<7> [295.571099] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:72:pipe B] min cdclk: 165334 kHz -> 0 kHz
<7> [295.571363] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:72:pipe B] enable: no [modeset]
<7> [295.571622] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:54:primary B] fb: [NOFB], visible: no
<7> [295.571888] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:76:HDMI-A-1][ENCODER:75:HDMI D] Disable audio codec on [CRTC:72:pipe B]
<7> [295.600138] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe B
<7> [295.617015] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port B found
<7> [295.617525] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port C found
<7> [295.617992] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port D found
<7> [295.628498] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PCH DPLL B (active 0x2, on? 1) for [CRTC:72:pipe B]
<7> [295.628987] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PCH DPLL B
<7> [295.629728] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:74:CRT]
<7> [295.630193] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:75:HDMI D]
<7> [295.630673] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:83:DP D]
<7> [295.631122] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:76:HDMI-A-1]
<7> [295.631689] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:72:pipe B]
<7> [295.632385] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:53:pipe A]
<7> [295.632417] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:73:VGA-1]
<7> [295.632517] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:73:VGA-1] Limiting target display pipe bpp to 24 (EDID bpp 0, max requested bpp 0, max platform bpp 36)
<7> [295.632769] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:53:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [295.633008] i915 0000:00:02.0: [drm:intel_fdi_atomic_check_link [i915]] checking fdi config on pipe A, lanes 1
<7> [295.633257] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [295.633530] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [295.633769] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [295.634006] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in has_pch_encoder (expected no, found yes)
<7> [295.634262] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in fdi_lanes (expected 0, found 1)
<7> [295.634534] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in fdi_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6039797/8388608 link 125829/524288)
<7> [295.634771] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000002)
<7> [295.635008] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [295.635297] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1024)
<7> [295.635628] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 1344)
<7> [295.636027] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1024)
<7> [295.636339] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 1344)
<7> [295.636606] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 1048)
<7> [295.636873] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 1184)
<7> [295.637253] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 768)
<7> [295.637544] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 768)
<7> [295.637780] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 771)
<7> [295.638016] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 777)
<7> [295.638263] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 806)
<7> [295.638501] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 806)
<7> [295.638737] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1024)
<7> [295.638972] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 1344)
<7> [295.639234] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1024)
<7> [295.639470] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 1344)
<7> [295.639706] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 1048)
<7> [295.639941] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 1184)
<7> [295.640201] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 768)
<7> [295.640437] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 768)
<7> [295.640674] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 771)
<7> [295.640909] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 777)
<7> [295.641168] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 806)
<7> [295.641403] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 806)
<7> [295.641639] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [295.641876] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [295.642112] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [295.642374] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [295.642632] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 64800)
<7> [295.642868] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 64800)
<7> [295.643103] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in port_clock (expected 0, found 64800)
<7> [295.643362] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:53:pipe A] fastset requirement not met, forcing full modeset
<7> [295.643632] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:53:pipe A] min cdclk: 0 kHz -> 72000 kHz
<7> [295.643868] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:53:pipe A] allocated PCH DPLL A
<7> [295.644102] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:53:pipe A] reserving PCH DPLL A
<7> [295.644365] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:53:pipe A] enable: yes [modeset]
<7> [295.644601] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: ANALOG (0x2), output format: RGB, sink format: RGB
<7> [295.644836] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [295.645070] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [295.645321] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [295.645556] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [295.645788] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [295.646023] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] fdi: lanes: 1; data_m: 6039797, data_n: 8388608, link_m: 125829, link_n: 524288, tu: 64
<7> [295.646286] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [295.646535] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 1
<7> [295.646769] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [295.647002] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: no, vmin: 0, vmax: 0, flipline: 0, pipeline full: 0, guardband: 0 vsync start: 0, vsync end: 0
<7> [295.647262] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 0, vmax vblank: 0, vmin vtotal: 0, vmax vtotal: 0
<7> [295.647497] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [295.647732] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [295.647967] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [295.648232] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=64800, hd=1024 hb=1024-1344 hs=1048-1184 ht=1344, vd=768 vb=768-806 vs=771-777 vt=806, flags=0xa
<7> [295.648468] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1024x768": 60 64800 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [295.648704] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=64800, hd=1024 hb=1024-1344 hs=1048-1184 ht=1344, vd=768 vb=768-806 vs=771-777 vt=806, flags=0xa
<7> [295.648939] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 64800, pixel rate 64800, min cdclk 72000, min voltage level 0
<7> [295.649196] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 0, ips linetime: 0
<7> [295.649432] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe src: 1024x768+0+0
<7> [295.649666] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [295.649900] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [295.650145] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [295.650156] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on
<7> [295.650395] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x84100010, dpll_md: 0x0, fp0: 0x10c09, fp1: 0x10c09
<7> [295.650631] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x3 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [295.650859] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [295.651087] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [295.651374] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [295.651636] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [295.651871] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [295.652105] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:35:primary A] fb: [FB:92] 1024x768 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [295.652370] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [295.652617] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1024.000000x768.000000+0.000000+0.000000 dst: 1024x768+0+0
<7> [295.653967] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on
<7> [295.654263] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:74:CRT]
<7> [295.654505] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:75:HDMI D]
<7> [295.654727] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:83:DP D]
<7> [295.655500] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [295.656564] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI_RX_IIR 0x100
<7> [295.656792] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI train 1 done.
<7> [295.657674] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI_RX_IIR 0x200
<7> [295.657910] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI train 2 done.
<7> [295.658175] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI train done.
<7> [295.658435] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable PCH DPLL A (active 0x1, on? 0) for [CRTC:53:pipe A]
<7> [295.658662] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling PCH DPLL A
<7> [295.710639] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:73:VGA-1]
<7> [295.711234] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:53:pipe A]
<7> [306.506196] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:53:pipe A]
<7> [306.506411] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [306.507024] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [306.507538] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [306.508111] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in has_pch_encoder (expected yes, found no)
<7> [306.508617] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in fdi_lanes (expected 1, found 0)
<7> [306.509193] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in fdi_m_n (expected tu 64 data 6039797/8388608 link 125829/524288, found tu 0, data 0/0 link 0/0)
<7> [306.509523] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in output_types (expected 0x00000002, found 0x00000000)
<7> [306.509882] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [306.510259] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1024, found 0)
<7> [306.510625] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 1344, found 0)
<7> [306.511013] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1024, found 0)
<7> [306.511321] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 1344, found 0)
<7> [306.511558] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 1048, found 0)
<7> [306.511942] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 1184, found 0)
<7> [306.512310] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 768, found 0)
<7> [306.512672] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 768, found 0)
<7> [306.512995] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 771, found 0)
<7> [306.513234] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 777, found 0)
<7> [306.513530] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 806, found 0)
<7> [306.513913] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 806, found 0)
<7> [306.514284] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1024, found 0)
<7> [306.514647] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 1344, found 0)
<7> [306.514978] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1024, found 0)
<7> [306.515236] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 1344, found 0)
<7> [306.515505] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 1048, found 0)
<7> [306.515889] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 1184, found 0)
<7> [306.516260] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 768, found 0)
<7> [306.516613] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 768, found 0)
<7> [306.516904] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 771, found 0)
<7> [306.517163] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 777, found 0)
<7> [306.517515] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 806, found 0)
<7> [306.517911] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 806, found 0)
<7> [306.518280] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [306.518550] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [306.518812] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [306.519155] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [306.519506] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 64800, found 0)
<7> [306.519896] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 64800, found 0)
<7> [306.520225] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in port_clock (expected 64800, found 0)
<7> [306.520473] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:53:pipe A] fastset requirement not met, forcing full modeset
<7> [306.520803] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:53:pipe A] releasing PCH DPLL A
<7> [306.521211] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:53:pipe A] min cdclk: 72000 kHz -> 0 kHz
<7> [306.521567] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:53:pipe A] enable: no [modeset]
<7> [306.521955] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:35:primary A] fb: [NOFB], visible: no
<7> [306.522349] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [306.527869] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port B found
<7> [306.528222] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port C found
<7> [306.528566] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port D found
<7> [306.544429] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PCH DPLL A (active 0x1, on? 1) for [CRTC:53:pipe A]
<7> [306.544945] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PCH DPLL A
<7> [306.545740] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:74:CRT]
<7> [306.546488] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:75:HDMI D]
<7> [306.547220] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:83:DP D]
<7> [306.548025] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:73:VGA-1]
<7> [306.548504] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:53:pipe A]
<7> [306.549029] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:72:pipe B]
<7> [306.549262] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:53:pipe A]
<7> [306.549315] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:73:VGA-1]
<7> [306.549479] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:73:VGA-1] Limiting target display pipe bpp to 24 (EDID bpp 0, max requested bpp 0, max platform bpp 36)
<7> [306.549859] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:53:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [306.550226] i915 0000:00:02.0: [drm:intel_fdi_atomic_check_link [i915]] checking fdi config on pipe A, lanes 1
<7> [306.550614] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [306.550988] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [306.551374] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [306.551762] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in has_pch_encoder (expected no, found yes)
<7> [306.552119] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in fdi_lanes (expected 0, found 1)
<7> [306.552538] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in fdi_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6039797/8388608 link 125829/524288)
<7> [306.552914] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000002)
<7> [306.553270] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [306.553663] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1024)
<7> [306.554052] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 1344)
<7> [306.554454] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1024)
<7> [306.554829] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 1344)
<7> [306.555185] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 1048)
<7> [306.555573] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 1184)
<7> [306.555946] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 768)
<7> [306.556323] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 768)
<7> [306.556692] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 771)
<7> [306.557045] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 777)
<7> [306.557435] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 806)
<7> [306.557806] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 806)
<7> [306.558162] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1024)
<7> [306.558535] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 1344)
<7> [306.558909] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1024)
<7> [306.559342] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 1344)
<7> [306.559739] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 1048)
<7> [306.560096] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 1184)
<7> [306.560487] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 768)
<7> [306.560861] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 768)
<7> [306.561250] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 771)
<7> [306.561614] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 777)
<7> [306.561969] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 806)
<7> [306.562354] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 806)
<7> [306.562744] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [306.563098] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [306.563489] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [306.563864] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [306.564262] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 64800)
<7> [306.564636] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 64800)
<7> [306.565008] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:53:pipe A] fastset requirement not met in port_clock (expected 0, found 64800)
<7> [306.565392] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:53:pipe A] fastset requirement not met, forcing full modeset
<7> [306.565808] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:53:pipe A] min cdclk: 0 kHz -> 72000 kHz
<7> [306.566197] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:53:pipe A] allocated PCH DPLL A
<7> [306.566227] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on
<7> [306.566560] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:53:pipe A] reserving PCH DPLL A
<7> [306.566923] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:53:pipe A] enable: yes [modeset]
<7> [306.567316] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: ANALOG (0x2), output format: RGB, sink format: RGB
<7> [306.567680] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [306.568042] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [306.568427] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [306.568789] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [306.569198] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [306.569576] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] fdi: lanes: 1; data_m: 6039797, data_n: 8388608, link_m: 125829, link_n: 524288, tu: 64
<7> [306.569929] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [306.570315] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 1
<7> [306.570684] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [306.571051] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: no, vmin: 0, vmax: 0, flipline: 0, pipeline full: 0, guardband: 0 vsync start: 0, vsync end: 0
<7> [306.571434] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 0, vmax vblank: 0, vmin vtotal: 0, vmax vtotal: 0
<7> [306.571806] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [306.572204] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [306.572580] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [306.572944] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=64800, hd=1024 hb=1024-1344 hs=1048-1184 ht=1344, vd=768 vb=768-806 vs=771-777 vt=806, flags=0xa
<7> [306.573327] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1024x768": 60 64800 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [306.573701] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=64800, hd=1024 hb=1024-1344 hs=1048-1184 ht=1344, vd=768 vb=768-806 vs=771-777 vt=806, flags=0xa
<7> [306.574055] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 64800, pixel rate 64800, min cdclk 72000, min voltage level 0
<7> [306.574443] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 0, ips linetime: 0
<7> [306.574813] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe src: 1024x768+0+0
<7> [306.575214] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [306.575570] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [306.575922] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [306.576305] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x84100010, dpll_md: 0x0, fp0: 0x10c09, fp1: 0x10c09
<7> [306.576660] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x3 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [306.577021] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [306.577491] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [306.577783] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [306.578023] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [306.578372] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [306.578605] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:35:primary A] fb: [FB:92] 1024x768 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [306.578836] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [306.579117] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1024.000000x768.000000+0.000000+0.000000 dst: 1024x768+0+0
<7> [306.579438] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on
<7> [306.579676] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:74:CRT]
<7> [306.579900] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:75:HDMI D]
<7> [306.580185] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:83:DP D]
<7> [306.581016] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [306.582126] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI_RX_IIR 0x100
<7> [306.582356] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI train 1 done.
<7> [306.583242] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI_RX_IIR 0x200
<7> [306.583470] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI train 2 done.
<7> [306.583694] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI train done.
<7> [306.583947] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable PCH DPLL A (active 0x1, on? 0) for [CRTC:53:pipe A]
<7> [306.584314] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling PCH DPLL A
<7> [306.636228] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:73:VGA-1]
<7> [306.636555] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:53:pipe A]
<6> [314.517053] [IGT] kms_flip: finished subtest A-VGA1, FAIL
|