Hardware List

Results for igt@kms_flip@blocking-wf_vblank

Machine description: shard-rkl-5

Result: Fail

integration-manifest git-log-oneline i915_display_info21 igt_runner21 runtimes21 results21.json boot21 dmesg21

Detail	Value
Duration	25.98 seconds
Hostname	shard-rkl-5
Igt-Version	IGT-Version: 1.29-NO-GIT (x86_64) (Linux: 6.13.0-rc1-CI_DRM_15769-g4ca0f09b17f7+ x86_64)
Out	Using IGT_SRANDOM=1733154520 for randomisation Opened device: /dev/dri/card0 Using monotonic timestamps Starting subtest: blocking-wf_vblank Starting dynamic subtest: A-HDMI-A2 1920x1080: 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 Expected frametime: 18974us; measured 18730.2us +- 7.353us accuracy 0.12% vblank interval differs from modeline! expected 18973.8us, measured 18730us +- 7.353us, difference 243.5us (33.1 sigma) Stack trace: #0 ../lib/igt_core.c:2051 __igt_fail_assert() #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0() #2 ../tests/kms_flip.c:1845 run_test() #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001() #4 ../tests/kms_flip.c:2001 main() #5 [__libc_init_first+0x8a] #6 [__libc_start_main+0x8b] #7 [_start+0x25] Dynamic subtest A-HDMI-A2: FAIL (7.318s) Starting dynamic subtest: B-HDMI-A2 1920x1080: 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 Expected frametime: 18974us; measured 18878.4us +- 7.312us accuracy 0.12% vblank interval differs from modeline! expected 18973.8us, measured 18878us +- 7.312us, difference 95.3us (13.0 sigma) Stack trace: #0 ../lib/igt_core.c:2051 __igt_fail_assert() #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0() #2 ../tests/kms_flip.c:1845 run_test() #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001() #4 ../tests/kms_flip.c:2001 main() #5 [__libc_init_first+0x8a] #6 [__libc_start_main+0x8b] #7 [_start+0x25] Dynamic subtest B-HDMI-A2: FAIL (18.665s) Subtest blocking-wf_vblank: FAIL (25.985s) Stack trace: #0 ../lib/igt_core.c:2051 __igt_fail_assert() #1 ../lib/igt_kms.c:2246 kmstest_set_connector_dpms() #2 ../lib/igt_core.c:2930 igt_atexit_handler() #3 [erand48_r+0x1d6] #4 [exit+0x1e] #5 ../lib/igt_core.c:2386 igt_exit() #6 [main+0x3f] #7 [__libc_init_first+0x8a] #8 [__libc_start_main+0x8b] #9 [_start+0x25]
Err	Starting subtest: blocking-wf_vblank Starting dynamic subtest: A-HDMI-A2 (kms_flip:2056) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674: (kms_flip:2056) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon) Dynamic subtest A-HDMI-A2 failed. ** DEBUG (kms_flip:2056) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x0, size=0) (kms_flip:2056) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=7680) (kms_flip:2056) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd) (kms_flip:2056) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x0, size=0) (kms_flip:2056) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=7680) (kms_flip:2056) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd) (kms_flip:2056) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_flip:2056) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_flip:2056) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS (kms_flip:2056) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_flip:2056) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_flip:2056) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS (kms_flip:2056) igt_kms-INFO: 1920x1080: 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 (kms_flip:2056) DEBUG: No stale events found (kms_flip:2056) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0 (kms_flip:2056) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0 (kms_flip:2056) INFO: Expected frametime: 18974us; measured 18730.2us +- 7.353us accuracy 0.12% (kms_flip:2056) INFO: vblank interval differs from modeline! expected 18973.8us, measured 18730us +- 7.353us, difference 243.5us (33.1 sigma) (kms_flip:2056) DEBUG: name = vblank last_ts = 0.000000 last_received_ts = 0.000000 last_seq = 0 current_ts = 66.536690 current_received_ts = 66.536240 current_seq = 715 count = 0 seq_step = 10 (kms_flip:2056) DEBUG: name = vblank last_ts = 66.536690 last_received_ts = 66.536240 last_seq = 715 current_ts = 66.723991 current_received_ts = 66.723564 current_seq = 725 count = 1 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 66.536690/715, current 66.723991/725: elapsed=187298.0us expected=187302.5us +- 936.5us, error 0.0% (kms_flip:2056) DEBUG: name = vblank last_ts = 66.723991 last_received_ts = 66.723564 last_seq = 725 current_ts = 66.911369 current_received_ts = 66.910904 current_seq = 735 count = 2 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 66.723991/725, current 66.911369/735: elapsed=187376.0us expected=187302.5us +- 936.5us, error 0.0% (kms_flip:2056) DEBUG: name = vblank last_ts = 66.911369 last_received_ts = 66.910904 last_seq = 735 current_ts = 67.098976 current_received_ts = 67.098717 current_seq = 745 count = 3 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 66.911369/735, current 67.098976/745: elapsed=187610.0us expected=187302.5us +- 936.5us, error 0.2% (kms_flip:2056) DEBUG: name = vblank last_ts = 67.098976 last_received_ts = 67.098717 last_seq = 745 current_ts = 67.286591 current_received_ts = 67.285988 current_seq = 755 count = 4 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 67.098976/745, current 67.286591/755: elapsed=187611.0us expected=187302.5us +- 936.5us, error 0.2% (kms_flip:2056) DEBUG: name = vblank last_ts = 67.286591 last_received_ts = 67.285988 last_seq = 755 current_ts = 67.474213 current_received_ts = 67.473747 current_seq = 765 count = 5 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 67.286591/755, current 67.474213/765: elapsed=187621.0us expected=187302.5us +- 936.5us, error 0.2% (kms_flip:2056) DEBUG: name = vblank last_ts = 67.474213 last_received_ts = 67.473747 last_seq = 765 current_ts = 67.661819 current_received_ts = 67.661423 current_seq = 775 count = 6 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 67.474213/765, current 67.661819/775: elapsed=187609.0us expected=187302.5us +- 936.5us, error 0.2% (kms_flip:2056) DEBUG: name = vblank last_ts = 67.661819 last_received_ts = 67.661423 last_seq = 775 current_ts = 67.849419 current_received_ts = 67.849098 current_seq = 785 count = 7 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 67.661819/775, current 67.849419/785: elapsed=187599.0us expected=187302.5us +- 936.5us, error 0.2% (kms_flip:2056) DEBUG: name = vblank last_ts = 67.849419 last_received_ts = 67.849098 last_seq = 785 current_ts = 68.037270 current_received_ts = 68.036911 current_seq = 795 count = 8 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 67.849419/785, current 68.037270/795: elapsed=187849.0us expected=187302.5us +- 936.5us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 68.037270 last_received_ts = 68.036911 last_seq = 795 current_ts = 68.225143 current_received_ts = 68.224670 current_seq = 805 count = 9 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 68.037270/795, current 68.225143/805: elapsed=187881.0us expected=187302.5us +- 936.5us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 68.225143 last_received_ts = 68.224670 last_seq = 805 current_ts = 68.413025 current_received_ts = 68.412590 current_seq = 815 count = 10 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 68.225143/805, current 68.413025/815: elapsed=187875.0us expected=187302.5us +- 936.5us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 68.413025 last_received_ts = 68.412590 last_seq = 815 current_ts = 68.600899 current_received_ts = 68.600471 current_seq = 825 count = 11 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 68.413025/815, current 68.600899/825: elapsed=187877.0us expected=187302.5us +- 936.5us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 68.600899 last_received_ts = 68.600471 last_seq = 825 current_ts = 68.788773 current_received_ts = 68.788414 current_seq = 835 count = 12 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 68.600899/825, current 68.788773/835: elapsed=187875.0us expected=187302.5us +- 936.5us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 68.788773 last_received_ts = 68.788414 last_seq = 835 current_ts = 68.976768 current_received_ts = 68.976295 current_seq = 845 count = 13 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 68.788773/835, current 68.976768/845: elapsed=187998.0us expected=187302.5us +- 936.5us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 68.976768 last_received_ts = 68.976295 last_seq = 845 current_ts = 69.164886 current_received_ts = 69.164497 current_seq = 855 count = 14 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 68.976768/845, current 69.164886/855: elapsed=188116.0us expected=187302.5us +- 936.5us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 69.164886 last_received_ts = 69.164497 last_seq = 855 current_ts = 69.352989 current_received_ts = 69.352539 current_seq = 865 count = 15 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 69.164886/855, current 69.352989/865: elapsed=188099.0us expected=187302.5us +- 936.5us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 69.352989 last_received_ts = 69.352539 last_seq = 865 current_ts = 69.541107 current_received_ts = 69.540756 current_seq = 875 count = 16 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 69.352989/865, current 69.541107/875: elapsed=188119.0us expected=187302.5us +- 936.5us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 69.541107 last_received_ts = 69.540756 last_seq = 875 current_ts = 69.729210 current_received_ts = 69.728752 current_seq = 885 count = 17 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 69.541107/875, current 69.729210/885: elapsed=188107.0us expected=187302.5us +- 936.5us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 69.729210 last_received_ts = 69.728752 last_seq = 885 current_ts = 69.917366 current_received_ts = 69.916870 current_seq = 895 count = 18 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 69.729210/885, current 69.917366/895: elapsed=188151.0us expected=187302.5us +- 936.5us, error 0.5% (kms_flip:2056) DEBUG: name = vblank last_ts = 69.917366 last_received_ts = 69.916870 last_seq = 895 current_ts = 70.105667 current_received_ts = 70.105408 current_seq = 905 count = 19 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 69.917366/895, current 70.105667/905: elapsed=188302.0us expected=187302.5us +- 936.5us, error 0.5% (kms_flip:2056) DEBUG: inconsistent vblank ts/seq: last 69.917366/895, current 70.105667/905: elapsed=188302.0us expected=187302.5us (kms_flip:2056) DEBUG: expected 0, counted 190, encoder type 2 (kms_flip:2056) DEBUG: dropped frames, expected 0, counted 190, encoder type 2 (kms_flip:2056) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674: (kms_flip:2056) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon) (kms_flip:2056) igt_core-INFO: Stack trace: (kms_flip:2056) igt_core-INFO: #0 ../lib/igt_core.c:2051 __igt_fail_assert() (kms_flip:2056) igt_core-INFO: #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0() (kms_flip:2056) igt_core-INFO: #2 ../tests/kms_flip.c:1845 run_test() (kms_flip:2056) igt_core-INFO: #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001() (kms_flip:2056) igt_core-INFO: #4 ../tests/kms_flip.c:2001 main() (kms_flip:2056) igt_core-INFO: #5 [__libc_init_first+0x8a] (kms_flip:2056) igt_core-INFO: #6 [__libc_start_main+0x8b] (kms_flip:2056) igt_core-INFO: #7 [_start+0x25] END Dynamic subtest A-HDMI-A2: FAIL (7.318s) Starting dynamic subtest: B-HDMI-A2 (kms_flip:2056) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674: (kms_flip:2056) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon) Dynamic subtest B-HDMI-A2 failed. DEBUG (kms_flip:2056) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x0, size=0) (kms_flip:2056) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=3, pitch=7680) (kms_flip:2056) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd) (kms_flip:2056) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x0, size=0) (kms_flip:2056) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=4, pitch=7680) (kms_flip:2056) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd) (kms_flip:2056) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_flip:2056) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_flip:2056) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS (kms_flip:2056) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_flip:2056) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_flip:2056) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS (kms_flip:2056) igt_kms-INFO: 1920x1080: 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 (kms_flip:2056) DEBUG: No stale events found (kms_flip:2056) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0 (kms_flip:2056) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0 (kms_flip:2056) INFO: Expected frametime: 18974us; measured 18878.4us +- 7.312us accuracy 0.12% (kms_flip:2056) INFO: vblank interval differs from modeline! expected 18973.8us, measured 18878us +- 7.312us, difference 95.3us (13.0 sigma) (kms_flip:2056) DEBUG: name = vblank last_ts = 0.000000 last_received_ts = 0.000000 last_seq = 0 current_ts = 73.799309 current_received_ts = 73.798836 current_seq = 30 count = 0 seq_step = 10 (kms_flip:2056) DEBUG: name = vblank last_ts = 73.799309 last_received_ts = 73.798836 last_seq = 30 current_ts = 73.988167 current_received_ts = 73.987778 current_seq = 40 count = 1 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 73.799309/30, current 73.988167/40: elapsed=188857.0us expected=188784.4us +- 943.9us, error 0.0% (kms_flip:2056) DEBUG: name = vblank last_ts = 73.988167 last_received_ts = 73.987778 last_seq = 40 current_ts = 74.177071 current_received_ts = 74.176804 current_seq = 50 count = 2 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 73.988167/40, current 74.177071/50: elapsed=188899.0us expected=188784.4us +- 943.9us, error 0.1% (kms_flip:2056) DEBUG: name = vblank last_ts = 74.177071 last_received_ts = 74.176804 last_seq = 50 current_ts = 74.365959 current_received_ts = 74.365479 current_seq = 60 count = 3 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 74.177071/50, current 74.365959/60: elapsed=188894.0us expected=188784.4us +- 943.9us, error 0.1% (kms_flip:2056) DEBUG: name = vblank last_ts = 74.365959 last_received_ts = 74.365479 last_seq = 60 current_ts = 74.554871 current_received_ts = 74.554375 current_seq = 70 count = 4 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 74.365959/60, current 74.554871/70: elapsed=188908.0us expected=188784.4us +- 943.9us, error 0.1% (kms_flip:2056) DEBUG: name = vblank last_ts = 74.554871 last_received_ts = 74.554375 last_seq = 70 current_ts = 74.743767 current_received_ts = 74.743294 current_seq = 80 count = 5 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 74.554871/70, current 74.743767/80: elapsed=188899.0us expected=188784.4us +- 943.9us, error 0.1% (kms_flip:2056) DEBUG: name = vblank last_ts = 74.743767 last_received_ts = 74.743294 last_seq = 80 current_ts = 74.932709 current_received_ts = 74.932343 current_seq = 90 count = 6 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 74.743767/80, current 74.932709/90: elapsed=188936.0us expected=188784.4us +- 943.9us, error 0.1% (kms_flip:2056) DEBUG: name = vblank last_ts = 74.932709 last_received_ts = 74.932343 last_seq = 90 current_ts = 75.121712 current_received_ts = 75.121284 current_seq = 100 count = 7 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 74.932709/90, current 75.121712/100: elapsed=189007.0us expected=188784.4us +- 943.9us, error 0.1% (kms_flip:2056) DEBUG: name = vblank last_ts = 75.121712 last_received_ts = 75.121284 last_seq = 100 current_ts = 75.310722 current_received_ts = 75.310387 current_seq = 110 count = 8 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 75.121712/100, current 75.310722/110: elapsed=189012.0us expected=188784.4us +- 943.9us, error 0.1% (kms_flip:2056) DEBUG: name = vblank last_ts = 75.310722 last_received_ts = 75.310387 last_seq = 110 current_ts = 75.499725 current_received_ts = 75.499306 current_seq = 120 count = 9 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 75.310722/110, current 75.499725/120: elapsed=189004.0us expected=188784.4us +- 943.9us, error 0.1% (kms_flip:2056) DEBUG: name = vblank last_ts = 75.499725 last_received_ts = 75.499306 last_seq = 120 current_ts = 75.688721 current_received_ts = 75.688461 current_seq = 130 count = 10 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 75.499725/120, current 75.688721/130: elapsed=188995.0us expected=188784.4us +- 943.9us, error 0.1% (kms_flip:2056) DEBUG: name = vblank last_ts = 75.688721 last_received_ts = 75.688461 last_seq = 130 current_ts = 75.877739 current_received_ts = 75.877319 current_seq = 140 count = 11 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 75.688721/130, current 75.877739/140: elapsed=189019.0us expected=188784.4us +- 943.9us, error 0.1% (kms_flip:2056) DEBUG: name = vblank last_ts = 75.877739 last_received_ts = 75.877319 last_seq = 140 current_ts = 76.066841 current_received_ts = 76.066582 current_seq = 150 count = 12 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 75.877739/140, current 76.066841/150: elapsed=189097.0us expected=188784.4us +- 943.9us, error 0.2% (kms_flip:2056) DEBUG: name = vblank last_ts = 76.066841 last_received_ts = 76.066582 last_seq = 150 current_ts = 76.255936 current_received_ts = 76.255554 current_seq = 160 count = 13 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 76.066841/150, current 76.255936/160: elapsed=189099.0us expected=188784.4us +- 943.9us, error 0.2% (kms_flip:2056) DEBUG: name = vblank last_ts = 76.255936 last_received_ts = 76.255554 last_seq = 160 current_ts = 76.445045 current_received_ts = 76.444771 current_seq = 170 count = 14 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 76.255936/160, current 76.445045/170: elapsed=189105.0us expected=188784.4us +- 943.9us, error 0.2% (kms_flip:2056) DEBUG: name = vblank last_ts = 76.445045 last_received_ts = 76.444771 last_seq = 170 current_ts = 76.634132 current_received_ts = 76.633675 current_seq = 180 count = 15 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 76.445045/170, current 76.634132/180: elapsed=189088.0us expected=188784.4us +- 943.9us, error 0.2% (kms_flip:2056) DEBUG: name = vblank last_ts = 76.634132 last_received_ts = 76.633675 last_seq = 180 current_ts = 76.823242 current_received_ts = 76.822968 current_seq = 190 count = 16 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 76.634132/180, current 76.823242/190: elapsed=189109.0us expected=188784.4us +- 943.9us, error 0.2% (kms_flip:2056) DEBUG: name = vblank last_ts = 76.823242 last_received_ts = 76.822968 last_seq = 190 current_ts = 77.012383 current_received_ts = 77.012077 current_seq = 200 count = 17 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 76.823242/190, current 77.012383/200: elapsed=189143.0us expected=188784.4us +- 943.9us, error 0.2% (kms_flip:2056) DEBUG: name = vblank last_ts = 77.012383 last_received_ts = 77.012077 last_seq = 200 current_ts = 77.201561 current_received_ts = 77.201103 current_seq = 210 count = 18 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 77.012383/200, current 77.201561/210: elapsed=189175.0us expected=188784.4us +- 943.9us, error 0.2% (kms_flip:2056) DEBUG: name = vblank last_ts = 77.201561 last_received_ts = 77.201103 last_seq = 210 current_ts = 77.390732 current_received_ts = 77.390472 current_seq = 220 count = 19 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 77.201561/210, current 77.390732/220: elapsed=189176.0us expected=188784.4us +- 943.9us, error 0.2% (kms_flip:2056) DEBUG: name = vblank last_ts = 77.390732 last_received_ts = 77.390472 last_seq = 220 current_ts = 77.579918 current_received_ts = 77.579674 current_seq = 230 count = 20 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 77.390732/220, current 77.579918/230: elapsed=189186.0us expected=188784.4us +- 943.9us, error 0.2% (kms_flip:2056) DEBUG: name = vblank last_ts = 77.579918 last_received_ts = 77.579674 last_seq = 230 current_ts = 77.769104 current_received_ts = 77.768730 current_seq = 240 count = 21 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 77.579918/230, current 77.769104/240: elapsed=189182.0us expected=188784.4us +- 943.9us, error 0.2% (kms_flip:2056) DEBUG: name = vblank last_ts = 77.769104 last_received_ts = 77.768730 last_seq = 240 current_ts = 77.958305 current_received_ts = 77.957726 current_seq = 250 count = 22 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 77.769104/240, current 77.958305/250: elapsed=189202.0us expected=188784.4us +- 943.9us, error 0.2% (kms_flip:2056) DEBUG: name = vblank last_ts = 77.958305 last_received_ts = 77.957726 last_seq = 250 current_ts = 78.147545 current_received_ts = 78.147293 current_seq = 260 count = 23 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 77.958305/250, current 78.147545/260: elapsed=189242.0us expected=188784.4us +- 943.9us, error 0.2% (kms_flip:2056) DEBUG: name = vblank last_ts = 78.147545 last_received_ts = 78.147293 last_seq = 260 current_ts = 78.336792 current_received_ts = 78.336533 current_seq = 270 count = 24 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 78.147545/260, current 78.336792/270: elapsed=189246.0us expected=188784.4us +- 943.9us, error 0.2% (kms_flip:2056) DEBUG: name = vblank last_ts = 78.336792 last_received_ts = 78.336533 last_seq = 270 current_ts = 78.526047 current_received_ts = 78.525551 current_seq = 280 count = 25 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 78.336792/270, current 78.526047/280: elapsed=189252.0us expected=188784.4us +- 943.9us, error 0.2% (kms_flip:2056) DEBUG: name = vblank last_ts = 78.526047 last_received_ts = 78.525551 last_seq = 280 current_ts = 78.715294 current_received_ts = 78.714920 current_seq = 290 count = 26 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 78.526047/280, current 78.715294/290: elapsed=189251.0us expected=188784.4us +- 943.9us, error 0.2% (kms_flip:2056) DEBUG: name = vblank last_ts = 78.715294 last_received_ts = 78.714920 last_seq = 290 current_ts = 78.904556 current_received_ts = 78.903915 current_seq = 300 count = 27 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 78.715294/290, current 78.904556/300: elapsed=189260.0us expected=188784.4us +- 943.9us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 78.904556 last_received_ts = 78.903915 last_seq = 300 current_ts = 79.093864 current_received_ts = 79.093163 current_seq = 310 count = 28 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 78.904556/300, current 79.093864/310: elapsed=189311.0us expected=188784.4us +- 943.9us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 79.093864 last_received_ts = 79.093163 last_seq = 310 current_ts = 79.283173 current_received_ts = 79.282471 current_seq = 320 count = 29 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 79.093864/310, current 79.283173/320: elapsed=189310.0us expected=188784.4us +- 943.9us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 79.283173 last_received_ts = 79.282471 last_seq = 320 current_ts = 79.472488 current_received_ts = 79.471779 current_seq = 330 count = 30 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 79.283173/320, current 79.472488/330: elapsed=189311.0us expected=188784.4us +- 943.9us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 79.472488 last_received_ts = 79.471779 last_seq = 330 current_ts = 79.661789 current_received_ts = 79.661118 current_seq = 340 count = 31 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 79.472488/330, current 79.661789/340: elapsed=189302.0us expected=188784.4us +- 943.9us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 79.661789 last_received_ts = 79.661118 last_seq = 340 current_ts = 79.851097 current_received_ts = 79.850441 current_seq = 350 count = 32 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 79.661789/340, current 79.851097/350: elapsed=189308.0us expected=188784.4us +- 943.9us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 79.851097 last_received_ts = 79.850441 last_seq = 350 current_ts = 80.040466 current_received_ts = 80.039764 current_seq = 360 count = 33 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 79.851097/350, current 80.040466/360: elapsed=189366.0us expected=188784.4us +- 943.9us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 80.040466 last_received_ts = 80.039764 last_seq = 360 current_ts = 80.229820 current_received_ts = 80.229164 current_seq = 370 count = 34 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 80.040466/360, current 80.229820/370: elapsed=189360.0us expected=188784.4us +- 943.9us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 80.229820 last_received_ts = 80.229164 last_seq = 370 current_ts = 80.419189 current_received_ts = 80.418808 current_seq = 380 count = 35 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 80.229820/370, current 80.419189/380: elapsed=189366.0us expected=188784.4us +- 943.9us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 80.419189 last_received_ts = 80.418808 last_seq = 380 current_ts = 80.608551 current_received_ts = 80.607933 current_seq = 390 count = 36 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 80.419189/380, current 80.608551/390: elapsed=189360.0us expected=188784.4us +- 943.9us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 80.608551 last_received_ts = 80.607933 last_seq = 390 current_ts = 80.797913 current_received_ts = 80.797478 current_seq = 400 count = 37 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 80.608551/390, current 80.797913/400: elapsed=189365.0us expected=188784.4us +- 943.9us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 80.797913 last_received_ts = 80.797478 last_seq = 400 current_ts = 80.987305 current_received_ts = 80.986809 current_seq = 410 count = 38 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 80.797913/400, current 80.987305/410: elapsed=189392.0us expected=188784.4us +- 943.9us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 80.987305 last_received_ts = 80.986809 last_seq = 410 current_ts = 81.176704 current_received_ts = 81.176186 current_seq = 420 count = 39 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 80.987305/410, current 81.176704/420: elapsed=189400.0us expected=188784.4us +- 943.9us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 81.176704 last_received_ts = 81.176186 last_seq = 420 current_ts = 81.366127 current_received_ts = 81.365700 current_seq = 430 count = 40 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 81.176704/420, current 81.366127/430: elapsed=189424.0us expected=188784.4us +- 943.9us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 81.366127 last_received_ts = 81.365700 last_seq = 430 current_ts = 81.555527 current_received_ts = 81.554916 current_seq = 440 count = 41 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 81.366127/430, current 81.555527/440: elapsed=189396.0us expected=188784.4us +- 943.9us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 81.555527 last_received_ts = 81.554916 last_seq = 440 current_ts = 81.744934 current_received_ts = 81.744591 current_seq = 450 count = 42 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 81.555527/440, current 81.744934/450: elapsed=189408.0us expected=188784.4us +- 943.9us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 81.744934 last_received_ts = 81.744591 last_seq = 450 current_ts = 81.934364 current_received_ts = 81.934074 current_seq = 460 count = 43 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 81.744934/450, current 81.934364/460: elapsed=189428.0us expected=188784.4us +- 943.9us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 81.934364 last_received_ts = 81.934074 last_seq = 460 current_ts = 82.123817 current_received_ts = 82.123375 current_seq = 470 count = 44 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 81.934364/460, current 82.123817/470: elapsed=189455.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 82.123817 last_received_ts = 82.123375 last_seq = 470 current_ts = 82.313271 current_received_ts = 82.312950 current_seq = 480 count = 45 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 82.123817/470, current 82.313271/480: elapsed=189454.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 82.313271 last_received_ts = 82.312950 last_seq = 480 current_ts = 82.502708 current_received_ts = 82.502457 current_seq = 490 count = 46 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 82.313271/480, current 82.502708/490: elapsed=189441.0us expected=188784.4us +- 943.9us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 82.502708 last_received_ts = 82.502457 last_seq = 490 current_ts = 82.692177 current_received_ts = 82.691902 current_seq = 500 count = 47 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 82.502708/490, current 82.692177/500: elapsed=189464.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 82.692177 last_received_ts = 82.691902 last_seq = 500 current_ts = 82.881615 current_received_ts = 82.881241 current_seq = 510 count = 48 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 82.692177/500, current 82.881615/510: elapsed=189438.0us expected=188784.4us +- 943.9us, error 0.3% (kms_flip:2056) DEBUG: name = vblank last_ts = 82.881615 last_received_ts = 82.881241 last_seq = 510 current_ts = 83.071106 current_received_ts = 83.070679 current_seq = 520 count = 49 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 82.881615/510, current 83.071106/520: elapsed=189492.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 83.071106 last_received_ts = 83.070679 last_seq = 520 current_ts = 83.260597 current_received_ts = 83.260338 current_seq = 530 count = 50 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 83.071106/520, current 83.260597/530: elapsed=189490.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 83.260597 last_received_ts = 83.260338 last_seq = 530 current_ts = 83.450073 current_received_ts = 83.449821 current_seq = 540 count = 51 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 83.260597/530, current 83.450073/540: elapsed=189476.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 83.450073 last_received_ts = 83.449821 last_seq = 540 current_ts = 83.639572 current_received_ts = 83.639099 current_seq = 550 count = 52 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 83.450073/540, current 83.639572/550: elapsed=189502.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 83.639572 last_received_ts = 83.639099 last_seq = 550 current_ts = 83.829048 current_received_ts = 83.828667 current_seq = 560 count = 53 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 83.639572/550, current 83.829048/560: elapsed=189473.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 83.829048 last_received_ts = 83.828667 last_seq = 560 current_ts = 84.018570 current_received_ts = 84.018311 current_seq = 570 count = 54 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 83.829048/560, current 84.018570/570: elapsed=189522.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 84.018570 last_received_ts = 84.018311 last_seq = 570 current_ts = 84.208084 current_received_ts = 84.207825 current_seq = 580 count = 55 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 84.018570/570, current 84.208084/580: elapsed=189514.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 84.208084 last_received_ts = 84.207825 last_seq = 580 current_ts = 84.397591 current_received_ts = 84.397339 current_seq = 590 count = 56 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 84.208084/580, current 84.397591/590: elapsed=189510.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 84.397591 last_received_ts = 84.397339 last_seq = 590 current_ts = 84.587128 current_received_ts = 84.586754 current_seq = 600 count = 57 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 84.397591/590, current 84.587128/600: elapsed=189534.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 84.587128 last_received_ts = 84.586754 last_seq = 600 current_ts = 84.776634 current_received_ts = 84.776215 current_seq = 610 count = 58 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 84.587128/600, current 84.776634/610: elapsed=189511.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 84.776634 last_received_ts = 84.776215 last_seq = 610 current_ts = 84.966171 current_received_ts = 84.965775 current_seq = 620 count = 59 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 84.776634/610, current 84.966171/620: elapsed=189531.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 84.966171 last_received_ts = 84.965775 last_seq = 620 current_ts = 85.155716 current_received_ts = 85.155121 current_seq = 630 count = 60 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 84.966171/620, current 85.155716/630: elapsed=189546.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 85.155716 last_received_ts = 85.155121 last_seq = 630 current_ts = 85.345253 current_received_ts = 85.344810 current_seq = 640 count = 61 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 85.155716/630, current 85.345253/640: elapsed=189539.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 85.345253 last_received_ts = 85.344810 last_seq = 640 current_ts = 85.534798 current_received_ts = 85.534409 current_seq = 650 count = 62 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 85.345253/640, current 85.534798/650: elapsed=189543.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 85.534798 last_received_ts = 85.534409 last_seq = 650 current_ts = 85.724342 current_received_ts = 85.724083 current_seq = 660 count = 63 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 85.534798/650, current 85.724342/660: elapsed=189545.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 85.724342 last_received_ts = 85.724083 last_seq = 660 current_ts = 85.913902 current_received_ts = 85.913460 current_seq = 670 count = 64 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 85.724342/660, current 85.913902/670: elapsed=189560.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 85.913902 last_received_ts = 85.913460 last_seq = 670 current_ts = 86.103477 current_received_ts = 86.103203 current_seq = 680 count = 65 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 85.913902/670, current 86.103477/680: elapsed=189577.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 86.103477 last_received_ts = 86.103203 last_seq = 680 current_ts = 86.293045 current_received_ts = 86.292679 current_seq = 690 count = 66 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 86.103477/680, current 86.293045/690: elapsed=189564.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 86.293045 last_received_ts = 86.292679 last_seq = 690 current_ts = 86.482613 current_received_ts = 86.482170 current_seq = 700 count = 67 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 86.293045/690, current 86.482613/700: elapsed=189570.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 86.482613 last_received_ts = 86.482170 last_seq = 700 current_ts = 86.672180 current_received_ts = 86.671814 current_seq = 710 count = 68 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 86.482613/700, current 86.672180/710: elapsed=189566.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 86.672180 last_received_ts = 86.671814 last_seq = 710 current_ts = 86.861748 current_received_ts = 86.861343 current_seq = 720 count = 69 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 86.672180/710, current 86.861748/720: elapsed=189570.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 86.861748 last_received_ts = 86.861343 last_seq = 720 current_ts = 87.051346 current_received_ts = 87.050728 current_seq = 730 count = 70 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 86.861748/720, current 87.051346/730: elapsed=189594.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 87.051346 last_received_ts = 87.050728 last_seq = 730 current_ts = 87.240921 current_received_ts = 87.240509 current_seq = 740 count = 71 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 87.051346/730, current 87.240921/740: elapsed=189581.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 87.240921 last_received_ts = 87.240509 last_seq = 740 current_ts = 87.430511 current_received_ts = 87.430298 current_seq = 750 count = 72 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 87.240921/740, current 87.430511/750: elapsed=189588.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 87.430511 last_received_ts = 87.430298 last_seq = 750 current_ts = 87.620110 current_received_ts = 87.619530 current_seq = 760 count = 73 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 87.430511/750, current 87.620110/760: elapsed=189600.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 87.620110 last_received_ts = 87.619530 last_seq = 760 current_ts = 87.809692 current_received_ts = 87.809471 current_seq = 770 count = 74 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 87.620110/760, current 87.809692/770: elapsed=189580.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 87.809692 last_received_ts = 87.809471 last_seq = 770 current_ts = 87.999306 current_received_ts = 87.998985 current_seq = 780 count = 75 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 87.809692/770, current 87.999306/780: elapsed=189615.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 87.999306 last_received_ts = 87.998985 last_seq = 780 current_ts = 88.188919 current_received_ts = 88.188492 current_seq = 790 count = 76 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 87.999306/780, current 88.188919/790: elapsed=189610.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 88.188919 last_received_ts = 88.188492 last_seq = 790 current_ts = 88.378517 current_received_ts = 88.378136 current_seq = 800 count = 77 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 88.188919/790, current 88.378517/800: elapsed=189602.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 88.378517 last_received_ts = 88.378136 last_seq = 800 current_ts = 88.568130 current_received_ts = 88.567802 current_seq = 810 count = 78 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 88.378517/800, current 88.568130/810: elapsed=189608.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: name = vblank last_ts = 88.568130 last_received_ts = 88.567802 last_seq = 810 current_ts = 88.757744 current_received_ts = 88.757301 current_seq = 820 count = 79 seq_step = 10 (kms_flip:2056) DEBUG: vblank ts/seq: last 88.568130/810, current 88.757744/820: elapsed=189615.0us expected=188784.4us +- 943.9us, error 0.4% (kms_flip:2056) DEBUG: expected 802, counted 800, encoder type 2 (kms_flip:2056) DEBUG: dropped frames, expected 802, counted 800, encoder type 2 (kms_flip:2056) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674: (kms_flip:2056) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon) (kms_flip:2056) igt_core-INFO: Stack trace: (kms_flip:2056) igt_core-INFO: #0 ../lib/igt_core.c:2051 __igt_fail_assert() (kms_flip:2056) igt_core-INFO: #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0() (kms_flip:2056) igt_core-INFO: #2 ../tests/kms_flip.c:1845 run_test() (kms_flip:2056) igt_core-INFO: #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001() (kms_flip:2056) igt_core-INFO: #4 ../tests/kms_flip.c:2001 main() (kms_flip:2056) igt_core-INFO: #5 [__libc_init_first+0x8a] (kms_flip:2056) igt_core-INFO: #6 [__libc_start_main+0x8b] (kms_flip:2056) igt_core-INFO: #7 [_start+0x25] END ** Dynamic subtest B-HDMI-A2: FAIL (18.665s) Subtest blocking-wf_vblank: FAIL (25.985s) (kms_flip:2056) igt_kms-CRITICAL: Test assertion failure function kmstest_set_connector_dpms, file ../lib/igt_kms.c:2246: (kms_flip:2056) igt_kms-CRITICAL: Failed assertion: found_it (kms_flip:2056) igt_kms-CRITICAL: Last errno: 9, Bad file descriptor (kms_flip:2056) igt_kms-CRITICAL: DPMS property not found on 147
Dmesg	<6> [66.075186] Console: switching to colour dummy device 80x25 <6> [66.075240] [IGT] kms_flip: executing <7> [66.077237] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7> [66.077802] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7> [66.078014] i915 0000:00:02.0: [drm:i915_gem_open [i915]] <7> [66.081493] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:137:HDMI-A-1] <7> [66.081510] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:137:HDMI-A-1] <7> [66.086317] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:137:HDMI-A-1] disconnected <7> [66.086725] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:151:DP-1] <7> [66.086735] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:151:DP-1] <7> [66.091401] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:151:DP-1] disconnected <7> [66.091696] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:158:HDMI-A-3] <7> [66.091707] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:158:HDMI-A-3] <7> [66.096487] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:158:HDMI-A-3] disconnected <7> [66.096746] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:137:HDMI-A-1] <7> [66.096756] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:137:HDMI-A-1] <7> [66.101499] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:137:HDMI-A-1] disconnected <7> [66.101550] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:147:HDMI-A-2] <7> [66.101573] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:147:HDMI-A-2] <7> [66.127905] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:147:HDMI-A-2] Supported Monitor Refresh rate range is 0 Hz - 0 Hz <7> [66.127915] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:147:HDMI-A-2] Assigning EDID-1.4 digital sink color depth as 8 bpc. <7> [66.127919] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:147:HDMI-A-2] ELD monitor fitHeadless4k <7> [66.127921] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:147:HDMI-A-2] ELD size 36, SAD count 0 <7> [66.128156] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus tc1] NAK for addr: 0040 w(1) <7> [66.128303] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus tc1] NAK on first message, retry <7> [66.128664] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus tc1] NAK for addr: 0040 w(1) <7> [66.128806] i915 0000:00:02.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: (err -6) <7> [66.129300] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "1366x768": 216 268000 1366 1414 1446 1526 768 771 777 814 0x40 0x6 (CLOCK_HIGH) <7> [66.129308] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "1920x1080i": 60 74250 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x15 (NO_INTERLACE) <7> [66.129313] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "1920x1080i": 60 74176 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x15 (NO_INTERLACE) <7> [66.129319] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:147:HDMI-A-2] probed modes: <7> [66.129329] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 <7> [66.129339] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "4088x2304": 10 108000 4088 4152 4280 4536 2304 2305 2308 2340 0x40 0x5 <7> [66.129348] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "3840x2160": 15 128430 3840 3889 3921 4000 2160 2163 2169 2195 0x40 0xa <7> [66.129357] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "2880x1800": 11 60000 2880 2888 2984 3040 1800 1802 1820 1845 0x40 0xa <7> [66.129366] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "2560x1600": 13 60000 2560 2568 2664 2720 1600 1602 1620 1645 0x40 0xa <7> [66.129374] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "2560x1440": 15 60000 2560 2568 2664 2720 1440 1442 1460 1485 0x40 0xa <7> [66.129383] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "2048x1536": 17 60000 2048 2056 2152 2208 1536 1538 1556 1581 0x40 0xa <7> [66.129391] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1600x1200": 60 162000 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5 <7> [66.129400] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1680x1050": 60 146250 1680 1784 1960 2240 1050 1053 1059 1089 0x40 0x6 <7> [66.129408] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1600x900": 60 108000 1600 1624 1704 1800 900 901 904 1000 0x40 0x5 <7> [66.129416] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x1024": 75 135000 1280 1296 1440 1688 1024 1025 1028 1066 0x40 0x5 <7> [66.129425] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1360x768": 60 84963 1366 1431 1567 1776 768 771 781 798 0x0 0x6 <7> [66.129433] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1360x768": 20 25190 1360 1368 1464 1520 768 770 788 813 0x40 0xa <7> [66.129442] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x800": 60 83500 1280 1352 1480 1680 800 803 809 831 0x40 0x6 <7> [66.129450] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1152x864": 75 108000 1152 1216 1344 1600 864 865 868 900 0x40 0x5 <7> [66.129458] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5 <7> [66.129466] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5 <7> [66.129475] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x5 <7> [66.129483] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x768": 75 78750 1024 1040 1136 1312 768 769 772 800 0x40 0x5 <7> [66.129491] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa <7> [66.129499] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1440x480": 60 54054 1440 1472 1596 1716 480 489 495 525 0x40 0xa <7> [66.129507] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1440x480": 60 54000 1440 1472 1596 1716 480 489 495 525 0x40 0xa <7> [66.129515] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x576": 60 46560 1024 1064 1160 1296 576 579 584 599 0x0 0x6 <7> [66.129523] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "832x624": 75 57284 832 864 928 1152 624 625 628 667 0x40 0xa <7> [66.129531] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 75 49500 800 816 896 1056 600 601 604 625 0x40 0x5 <7> [66.129539] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5 <7> [66.129547] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 75 31500 640 656 720 840 480 481 484 500 0x40 0xa <7> [66.129555] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25200 640 656 752 800 480 490 492 525 0x40 0xa <7> [66.129563] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa <7> [66.129571] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa <7> [66.129580] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "720x400": 70 28320 720 738 846 900 400 412 414 449 0x40 0x6 <7> [66.129611] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:151:DP-1] <7> [66.129619] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:151:DP-1] <7> [66.133987] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:151:DP-1] disconnected <7> [66.134008] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:158:HDMI-A-3] <7> [66.134017] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:158:HDMI-A-3] <7> [66.139074] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:158:HDMI-A-3] disconnected <6> [66.139454] [IGT] kms_flip: starting subtest blocking-wf_vblank <6> [66.140411] [IGT] kms_flip: starting dynamic subtest A-HDMI-A2 <7> [66.140709] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:164] <7> [66.140761] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:165] <7> [66.181589] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A] <7> [66.181731] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.enable (expected yes, found no) <7> [66.182069] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.active (expected yes, found no) <7> [66.182380] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1) <7> [66.182706] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in lane_count (expected 4, found 0) <7> [66.183026] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000) <7> [66.183342] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0) <7> [66.183660] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0) <7> [66.183958] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2360, found 0) <7> [66.184253] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0) <7> [66.184546] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2360, found 0) <7> [66.184828] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0) <7> [66.185072] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2096, found 0) <7> [66.185319] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0) <7> [66.185560] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0) <7> [66.185821] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0) <7> [66.186070] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0) <7> [66.186314] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0) <7> [66.186551] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0) <7> [66.186806] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0) <7> [66.187044] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2360, found 0) <7> [66.187293] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0) <7> [66.187534] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2360, found 0) <7> [66.187739] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0) <7> [66.187926] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2096, found 0) <7> [66.188110] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0) <7> [66.188295] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0) <7> [66.188479] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0) <7> [66.188672] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0) <7> [66.188858] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0) <7> [66.189045] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0) <7> [66.189229] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0) <7> [66.189413] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0) <7> [66.189598] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0) <7> [66.189794] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0) <7> [66.189981] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 139929, found 0) <7> [66.190169] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 139929, found 0) <7> [66.190354] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in port_clock (expected 139929, found 0) <7> [66.190529] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset <7> [66.190698] i915 0000:00:02.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:82:pipe A] releasing DPLL 0 <7> [66.190915] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no <7> [66.191077] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:82:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0 <7> [66.191268] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0 <7> [66.191425] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:77:cursor A] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0 <7> [66.191581] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] level wm0,wm1,wm2,wm3,wm4,wm5,wm6,wm7,twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm <7> [66.191782] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] lines 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [66.191942] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] blocks 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [66.192100] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] min_ddb 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [66.192257] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:82:pipe A] data rate 0 num active planes 0 <7> [66.192424] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 0 <7> [66.192606] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 180000 kHz, actual 180000 kHz <7> [66.192785] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0 <7> [66.192951] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:82:pipe A] enable: no [modeset] <7> [66.193114] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane 1A] fb: [NOFB], visible: no <7> [66.193279] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:41:plane 2A] fb: [NOFB], visible: no <7> [66.193444] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:50:plane 3A] fb: [NOFB], visible: no <7> [66.193608] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:59:plane 4A] fb: [NOFB], visible: no <7> [66.193778] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:68:plane 5A] fb: [NOFB], visible: no <7> [66.193940] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:77:cursor A] fb: [NOFB], visible: no <7> [66.201663] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A <7> [66.221187] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_TC1 <7> [66.221835] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:82:pipe A] <7> [66.222550] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling DPLL 0 <7> [66.223241] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:32:plane 1A] <7> [66.223824] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:136:DDI B/PHY B] <7> [66.224425] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:146:DDI TC1/PHY C] <7> [66.225032] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:150:DDI TC2/PHY D] <7> [66.225621] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:152:DP-MST A] <7> [66.226202] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:153:DP-MST B] <7> [66.226750] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:147:HDMI-A-2] <7> [66.227361] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1 <7> [66.227895] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3 <7> [66.228444] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:82:pipe A] <7> [66.229388] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B] <7> [66.229714] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A] <7> [66.229752] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:147:HDMI-A-2] <7> [66.229848] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:147:HDMI-A-2] Limiting display bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36) <7> [66.230241] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24) <7> [66.230566] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:82:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0 <7> [66.230734] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:146:DDI TC1/PHY C] [CRTC:82:pipe A] <7> [66.230892] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.enable (expected no, found yes) <7> [66.231057] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.active (expected no, found yes) <7> [66.231232] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0) <7> [66.231396] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in lane_count (expected 0, found 4) <7> [66.231557] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040) <7> [66.231723] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1) <7> [66.231889] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920) <7> [66.232052] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2360) <7> [66.232229] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920) <7> [66.232392] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2360) <7> [66.232551] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008) <7> [66.232711] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2096) <7> [66.232870] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080) <7> [66.233029] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080) <7> [66.233189] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084) <7> [66.233359] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089) <7> [66.233521] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125) <7> [66.233680] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125) <7> [66.233839] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920) <7> [66.233998] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2360) <7> [66.234156] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920) <7> [66.234326] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2360) <7> [66.234485] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008) <7> [66.234643] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2096) <7> [66.234802] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080) <7> [66.234962] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080) <7> [66.235120] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084) <7> [66.235288] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089) <7> [66.235447] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125) <7> [66.235605] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125) <7> [66.235763] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1) <7> [66.235921] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1) <7> [66.236078] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4) <7> [66.236237] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24) <7> [66.236405] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 139929) <7> [66.236565] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 139929) <7> [66.236723] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in port_clock (expected 0, found 139929) <7> [66.236881] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset <7> [66.237055] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no <7> [66.237212] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:82:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x1 <7> [66.237414] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016 <7> [66.237578] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:77:cursor A] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32 <7> [66.237738] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> wm0,wm1,wm2,wm3,wm4,wm5,wm6,wm7,twm, swm, stwm <7> [66.237896] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0 <7> [66.238052] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0 <7> [66.238206] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0 <7> [66.238386] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:82:pipe A] data rate 559716 num active planes 1 <7> [66.238546] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 560 <7> [66.238721] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1 <7> [66.238893] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:32:plane 1A] min cdclk (69965 kHz) > [CRTC:82:pipe A] min cdclk (0 kHz) <7> [66.239059] i915 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [i915]] new bandwidth min cdclk (10932 kHz) > old min cdclk (0 kHz) <7> [66.239228] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 180000 kHz, actual 180000 kHz <7> [66.239399] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0 <7> [66.239563] i915 0000:00:02.0: [drm:intel_find_shared_dpll [i915]] [CRTC:82:pipe A] allocated DPLL 0 <7> [66.239728] i915 0000:00:02.0: [drm:intel_reference_shared_dpll_crtc [i915]] [CRTC:82:pipe A] reserving DPLL 0 <7> [66.239891] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:82:pipe A] enable: yes [modeset] <7> [66.240056] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB <7> [66.240216] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0 <7> [66.240385] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid> <7> [66.240546] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7> [66.240705] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0 <7> [66.240863] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0 <7> [66.241022] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0 <7> [66.241180] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0 <7> [66.241349] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, vmin: 0, vmax: 0, pipeline full: 0, guardband: 0 flipline: 0, vmin vblank: -1, vmax vblank: -2 <7> [66.241516] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 <7> [66.241668] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 <7> [66.241841] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5 <7> [66.242000] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 53 139929 1920 2008 2096 2360 1080 1084 1089 1125 0x40 0x5 <7> [66.242158] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5 <7> [66.242319] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139929, pipe src: 1920x1080+0+0, pixel rate 139929 <7> [66.242524] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0 <7> [66.242683] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0 <7> [66.242841] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no <7> [66.242998] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0 <7> [66.243156] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1a6655d, cfgcr1: 0xe84, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0 <7> [66.243316] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7> [66.243499] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries <7> [66.243658] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000 <7> [66.243813] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [66.243967] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [66.244119] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [66.244270] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000 <7> [66.244454] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000 <7> [66.244614] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [66.244773] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [66.244931] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [66.245088] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000 <7> [66.245245] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane 1A] fb: [FB:164] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes <7> [66.245410] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 1 <7> [66.245575] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0 <7> [66.245747] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:41:plane 2A] fb: [NOFB], visible: no <7> [66.245903] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:50:plane 3A] fb: [NOFB], visible: no <7> [66.246060] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:59:plane 4A] fb: [NOFB], visible: no <7> [66.246218] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:68:plane 5A] fb: [NOFB], visible: no <7> [66.246382] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:77:cursor A] fb: [NOFB], visible: no <7> [66.247013] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3 <7> [66.247193] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:136:DDI B/PHY B] <7> [66.247353] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:146:DDI TC1/PHY C] <7> [66.247523] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:150:DDI TC2/PHY D] <7> [66.247685] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:152:DP-MST A] <7> [66.247845] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:153:DP-MST B] <7> [66.248032] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3 <7> [66.248231] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:82:pipe A] <7> [66.248395] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enabling DPLL 0 <7> [66.248628] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_TC1 <7> [66.248815] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A <7> [66.249173] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1 <7> [66.249325] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:32:plane 1A] <7> [66.268620] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:147:HDMI-A-2] <7> [66.268869] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:82:pipe A] <6> [73.458135] [IGT] kms_flip: finished subtest A-HDMI-A2, FAIL <6> [73.458404] [IGT] kms_flip: starting dynamic subtest B-HDMI-A2 <7> [73.458701] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:166] <7> [73.458762] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:167] <7> [73.492692] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A] <7> [73.492762] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.enable (expected yes, found no) <7> [73.492951] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.active (expected yes, found no) <7> [73.493111] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1) <7> [73.493278] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in lane_count (expected 4, found 0) <7> [73.493458] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000) <7> [73.493623] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0) <7> [73.493784] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0) <7> [73.493944] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2360, found 0) <7> [73.494109] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0) <7> [73.494286] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2360, found 0) <7> [73.494465] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0) <7> [73.494614] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2096, found 0) <7> [73.494763] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0) <7> [73.494913] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0) <7> [73.495061] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0) <7> [73.495210] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0) <7> [73.495429] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0) <7> [73.495582] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0) <7> [73.495734] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0) <7> [73.495886] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2360, found 0) <7> [73.496038] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0) <7> [73.496190] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2360, found 0) <7> [73.496403] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0) <7> [73.496570] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2096, found 0) <7> [73.496722] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0) <7> [73.496874] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0) <7> [73.497025] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0) <7> [73.497177] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0) <7> [73.497371] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0) <7> [73.497524] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0) <7> [73.497676] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0) <7> [73.497826] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0) <7> [73.497977] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0) <7> [73.498128] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0) <7> [73.498285] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 139929, found 0) <7> [73.498469] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 139929, found 0) <7> [73.498619] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in port_clock (expected 139929, found 0) <7> [73.498770] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset <7> [73.498922] i915 0000:00:02.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:82:pipe A] releasing DPLL 0 <7> [73.499094] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no <7> [73.499246] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:82:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0 <7> [73.499476] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0 <7> [73.499629] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:77:cursor A] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0 <7> [73.499779] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] level wm0,wm1,wm2,wm3,wm4,wm5,wm6,wm7,twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm <7> [73.499928] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] lines 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [73.500076] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] blocks 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [73.500223] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] min_ddb 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [73.500411] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:82:pipe A] data rate 0 num active planes 0 <7> [73.500569] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 0 <7> [73.500741] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 180000 kHz, actual 180000 kHz <7> [73.500896] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0 <7> [73.501053] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:82:pipe A] enable: no [modeset] <7> [73.501208] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane 1A] fb: [NOFB], visible: no <7> [73.501407] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:41:plane 2A] fb: [NOFB], visible: no <7> [73.501562] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:50:plane 3A] fb: [NOFB], visible: no <7> [73.501715] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:59:plane 4A] fb: [NOFB], visible: no <7> [73.501867] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:68:plane 5A] fb: [NOFB], visible: no <7> [73.502020] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:77:cursor A] fb: [NOFB], visible: no <7> [73.516484] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A <7> [73.535668] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_TC1 <7> [73.536416] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:82:pipe A] <7> [73.537227] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling DPLL 0 <7> [73.537973] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:32:plane 1A] <7> [73.538761] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:136:DDI B/PHY B] <7> [73.539442] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:146:DDI TC1/PHY C] <7> [73.540200] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:150:DDI TC2/PHY D] <7> [73.540902] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:152:DP-MST A] <7> [73.541566] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:153:DP-MST B] <7> [73.542166] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:147:HDMI-A-2] <7> [73.542975] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1 <7> [73.543743] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3 <7> [73.544397] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:82:pipe A] <7> [73.545434] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B] <7> [73.545846] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B] <7> [73.545905] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:147:HDMI-A-2] <7> [73.546043] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:147:HDMI-A-2] Limiting display bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36) <7> [73.546586] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24) <7> [73.547044] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:134:pipe B] hw max bpp: 24, pipe bpp: 24, dithering: 0 <7> [73.547452] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:146:DDI TC1/PHY C] [CRTC:134:pipe B] <7> [73.547866] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.enable (expected no, found yes) <7> [73.548260] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.active (expected no, found yes) <7> [73.548667] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1) <7> [73.549050] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in lane_count (expected 0, found 4) <7> [73.549430] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040) <7> [73.549833] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1) <7> [73.550224] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920) <7> [73.550506] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2360) <7> [73.550805] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920) <7> [73.551089] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2360) <7> [73.551368] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008) <7> [73.551668] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2096) <7> [73.551965] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080) <7> [73.552264] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080) <7> [73.552562] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084) <7> [73.552845] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089) <7> [73.553125] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125) <7> [73.553348] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125) <7> [73.553559] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920) <7> [73.553758] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2360) <7> [73.553955] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920) <7> [73.554152] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2360) <7> [73.554350] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008) <7> [73.554549] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2096) <7> [73.554759] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080) <7> [73.554957] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080) <7> [73.555153] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084) <7> [73.555349] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089) <7> [73.555545] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125) <7> [73.555757] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125) <7> [73.555953] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1) <7> [73.556149] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1) <7> [73.556336] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4) <7> [73.556494] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in dpll_hw_state <7> [73.556677] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected: <7> [73.556835] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: cfgcr0: 0x0, cfgcr1: 0x0, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0 <7> [73.556994] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found: <7> [73.557151] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: cfgcr0: 0x1a6655d, cfgcr1: 0xe84, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0 <7> [73.557321] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 24) <7> [73.557478] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 139929) <7> [73.557645] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 139929) <7> [73.557802] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in port_clock (expected 0, found 139929) <7> [73.557961] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:134:pipe B] fastset requirement not met, forcing full modeset <7> [73.558136] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no <7> [73.558293] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:134:pipe B] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x2 <7> [73.558479] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016 <7> [73.558646] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:129:cursor B] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32 <7> [73.558808] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> wm0,wm1,wm2,wm3,wm4,wm5,wm6,wm7,twm, swm, stwm <7> [73.558964] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0 <7> [73.559120] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0 <7> [73.559274] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0 <7> [73.559428] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:134:pipe B] data rate 559716 num active planes 1 <7> [73.559601] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 560 <7> [73.559765] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1 <7> [73.559940] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:84:plane 1B] min cdclk (69965 kHz) > [CRTC:134:pipe B] min cdclk (0 kHz) <7> [73.560108] i915 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [i915]] new bandwidth min cdclk (10932 kHz) > old min cdclk (0 kHz) <7> [73.560274] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 180000 kHz, actual 180000 kHz <7> [73.560437] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0 <7> [73.560608] i915 0000:00:02.0: [drm:intel_find_shared_dpll [i915]] [CRTC:134:pipe B] allocated DPLL 0 <7> [73.560774] i915 0000:00:02.0: [drm:intel_reference_shared_dpll_crtc [i915]] [CRTC:134:pipe B] reserving DPLL 0 <7> [73.560940] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:134:pipe B] enable: yes [modeset] <7> [73.561107] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB <7> [73.561270] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 24, dithering: 0 <7> [73.561432] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid> <7> [73.561598] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7> [73.561760] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0 <7> [73.561918] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0 <7> [73.562077] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0 <7> [73.562235] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0 <7> [73.562394] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, vmin: 0, vmax: 0, pipeline full: 0, guardband: 0 flipline: 0, vmin vblank: -1, vmax vblank: -2 <7> [73.562554] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 <7> [73.562722] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 <7> [73.562882] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5 <7> [73.563040] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 53 139929 1920 2008 2096 2360 1080 1084 1089 1125 0x40 0x5 <7> [73.563202] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5 <7> [73.563368] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139929, pipe src: 1920x1080+0+0, pixel rate 139929 <7> [73.563530] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0 <7> [73.563698] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0 <7> [73.563860] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no <7> [73.564019] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0 <7> [73.564178] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1a6655d, cfgcr1: 0xe84, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0 <7> [73.564338] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7> [73.564497] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries <7> [73.564663] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000 <7> [73.564821] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [73.564977] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [73.565134] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [73.565290] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000 <7> [73.565446] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000 <7> [73.565611] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [73.565773] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [73.565929] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [73.566086] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000 <7> [73.566242] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:84:plane 1B] fb: [FB:166] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes <7> [73.566400] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7> [73.566557] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0 <7> [73.566763] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:93:plane 2B] fb: [NOFB], visible: no <7> [73.566929] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:102:plane 3B] fb: [NOFB], visible: no <7> [73.567091] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:111:plane 4B] fb: [NOFB], visible: no <7> [73.567252] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:120:plane 5B] fb: [NOFB], visible: no <7> [73.567412] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:129:cursor B] fb: [NOFB], visible: no <7> [73.568018] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3 <7> [73.568207] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:136:DDI B/PHY B] <7> [73.568369] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:146:DDI TC1/PHY C] <7> [73.568529] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:150:DDI TC2/PHY D] <7> [73.568700] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:152:DP-MST A] <7> [73.568862] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:153:DP-MST B] <7> [73.569047] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3 <7> [73.569245] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enable DPLL 0 (active 0x2, on? 0) for [CRTC:134:pipe B] <7> [73.569409] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enabling DPLL 0 <7> [73.569758] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_TC1 <7> [73.569954] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B <7> [73.590016] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:147:HDMI-A-2] <7> [73.590233] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:134:pipe B] <6> [92.123824] [IGT] kms_flip: finished subtest B-HDMI-A2, FAIL <6> [92.124166] [IGT] kms_flip: finished subtest blocking-wf_vblank, FAIL <7> [92.132195] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:167] from all active usage due to RMFB ioctl <7> [92.132372] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:84:plane 1B] because [FB:167] is removed <7> [92.132459] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0 <7> [92.132654] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] level wm0,wm1,wm2,wm3,wm4,wm5,wm6,wm7,twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm <7> [92.132817] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] lines 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [92.132976] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] blocks 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [92.133133] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] min_ddb 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [92.133290] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:134:pipe B] data rate 0 num active planes 0 <7> [92.133499] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 0 <6> [92.146610] [IGT] kms_flip: exiting, ret=98 <7> [92.157220] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:147:HDMI-A-2] Limiting display bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36) <7> [92.157448] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24) <7> [92.157616] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:82:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0 <7> [92.157790] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:146:DDI TC1/PHY C] [CRTC:82:pipe A] <7> [92.157944] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.enable (expected no, found yes) <7> [92.158105] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.active (expected no, found yes) <7> [92.158267] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0) <7> [92.158469] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in lane_count (expected 0, found 4) <7> [92.158677] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040) <7> [92.158840] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1) <7> [92.159002] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920) <7> [92.159163] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2360) <7> [92.159324] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920) <7> [92.159493] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2360) <7> [92.159653] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008) <7> [92.159818] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2096) <7> [92.159978] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080) <7> [92.160137] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080) <7> [92.160295] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084) <7> [92.160463] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089) <7> [92.160622] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125) <7> [92.160779] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125) <7> [92.160937] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920) <7> [92.161096] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2360) <7> [92.161254] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920) <7> [92.161420] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2360) <7> [92.161578] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008) <7> [92.161736] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2096) <7> [92.161893] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080) <7> [92.162050] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080) <7> [92.162208] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084) <7> [92.162365] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089) <7> [92.162568] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125) <7> [92.162726] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125) <7> [92.162884] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1) <7> [92.163044] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1) <7> [92.163202] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4) <7> [92.163361] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24) <7> [92.163531] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 139929) <7> [92.163688] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 139929) <7> [92.163846] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in port_clock (expected 0, found 139929) <7> [92.164004] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset <7> [92.164161] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.enable (expected yes, found no) <7> [92.164318] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.active (expected yes, found no) <7> [92.164484] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1) <7> [92.164641] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in lane_count (expected 4, found 0) <7> [92.164799] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000) <7> [92.164956] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0) <7> [92.165113] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0) <7> [92.165272] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2360, found 0) <7> [92.165441] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0) <7> [92.165599] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2360, found 0) <7> [92.165756] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0) <7> [92.165914] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2096, found 0) <7> [92.166071] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0) <7> [92.166229] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0) <7> [92.166386] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0) <7> [92.166554] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0) <7> [92.166713] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0) <7> [92.166870] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0) <7> [92.167027] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0) <7> [92.167185] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2360, found 0) <7> [92.167342] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0) <7> [92.167509] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2360, found 0) <7> [92.167666] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0) <7> [92.167824] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2096, found 0) <7> [92.167981] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0) <7> [92.168137] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0) <7> [92.168295] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0) <7> [92.168530] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0) <7> [92.168689] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0) <7> [92.168847] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0) <7> [92.169004] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0) <7> [92.169163] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0) <7> [92.169322] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0) <7> [92.169507] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in pipe_bpp (expected 24, found 0) <7> [92.169666] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 139929, found 0) <7> [92.169824] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 139929, found 0) <7> [92.169982] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in port_clock (expected 139929, found 0) <7> [92.170141] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:134:pipe B] fastset requirement not met, forcing full modeset <7> [92.170300] i915 0000:00:02.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:134:pipe B] releasing DPLL 0 <7> [92.171191] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:82:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x2 -> 0x1 <7> [92.171357] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:134:pipe B] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x2 -> 0x1 <7> [92.171547] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016 <7> [92.171707] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:77:cursor A] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32 <7> [92.171864] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> wm0,wm1,wm2,wm3,wm4,wm5,wm6,wm7,twm, swm, stwm <7> [92.172019] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0 <7> [92.172175] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0 <7> [92.172329] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0 <7> [92.172497] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:129:cursor B] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0 <7> [92.172653] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:82:pipe A] data rate 559716 num active planes 1 <7> [92.172820] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 560 <7> [92.172984] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1 <7> [92.173164] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:32:plane 1A] min cdclk (69965 kHz) > [CRTC:82:pipe A] min cdclk (0 kHz) <7> [92.173336] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 180000 kHz, actual 180000 kHz <7> [92.173577] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0 <7> [92.173742] i915 0000:00:02.0: [drm:intel_find_shared_dpll [i915]] [CRTC:82:pipe A] allocated DPLL 0 <7> [92.173907] i915 0000:00:02.0: [drm:intel_reference_shared_dpll_crtc [i915]] [CRTC:82:pipe A] reserving DPLL 0 <7> [92.174073] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:82:pipe A] enable: yes [modeset] <7> [92.174237] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB <7> [92.174418] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0 <7> [92.174581] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid> <7> [92.174742] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7> [92.174902] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0 <7> [92.175066] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0 <7> [92.175231] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0 <7> [92.175418] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0 <7> [92.175581] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, vmin: 0, vmax: 0, pipeline full: 0, guardband: 0 flipline: 0, vmin vblank: -1, vmax vblank: -2 <7> [92.175742] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 <7> [92.175902] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 <7> [92.176062] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5 <7> [92.176222] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 53 139929 1920 2008 2096 2360 1080 1084 1089 1125 0x40 0x5 <7> [92.176381] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5 <7> [92.176561] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139929, pipe src: 1920x1080+0+0, pixel rate 139929 <7> [92.176722] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0 <7> [92.176880] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0 <7> [92.177037] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no <7> [92.177195] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0 <7> [92.177369] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1a6655d, cfgcr1: 0xe84, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0 <7> [92.177549] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7> [92.177707] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries <7> [92.177864] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000 <7> [92.178021] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [92.178179] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [92.178335] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [92.178513] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000 <7> [92.178671] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000 <7> [92.178829] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [92.178986] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [92.179143] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [92.179299] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000 <7> [92.179477] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane 1A] fb: [FB:162] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes <7> [92.179636] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 1 <7> [92.179793] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0 <7> [92.179951] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:41:plane 2A] fb: [NOFB], visible: no <7> [92.180107] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:50:plane 3A] fb: [NOFB], visible: no <7> [92.180265] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:59:plane 4A] fb: [NOFB], visible: no <7> [92.180439] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:68:plane 5A] fb: [NOFB], visible: no <7> [92.180605] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:77:cursor A] fb: [NOFB], visible: no <7> [92.180768] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:134:pipe B] enable: no [modeset] <7> [92.180928] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:84:plane 1B] fb: [NOFB], visible: no <7> [92.181092] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:93:plane 2B] fb: [NOFB], visible: no <7> [92.181251] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:102:plane 3B] fb: [NOFB], visible: no <7> [92.181426] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:111:plane 4B] fb: [NOFB], visible: no <7> [92.181585] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:120:plane 5B] fb: [NOFB], visible: no <7> [92.181743] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:129:cursor B] fb: [NOFB], visible: no <7> [92.182366] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe B <7> [92.185291] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_TC1 <7> [92.185526] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disable DPLL 0 (active 0x2, on? 1) for [CRTC:134:pipe B] <7> [92.185774] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling DPLL 0 <7> [92.185947] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:136:DDI B/PHY B] <7> [92.186113] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:146:DDI TC1/PHY C] <7> [92.186274] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:150:DDI TC2/PHY D] <7> [92.186445] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:152:DP-MST A] <7> [92.186603] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:153:DP-MST B] <7> [92.186842] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:82:pipe A] <7> [92.187012] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enabling DPLL 0 <7> [92.187235] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_TC1 <7> [92.187447] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A <7> [92.187825] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1 <7> [92.187988] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:32:plane 1A] <7> [92.206932] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:147:HDMI-A-2] <7> [92.207145] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:82:pipe A] <7> [92.207585] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:134:pipe B] <7> [92.208033] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0

Created at 2024-12-02 16:47:14