Hardware List

Results for igt@kms_flip@blocking-wf_vblank

Machine description: shard-lnl-7

Result: Fail

i915_display_info9 igt_runner9 results9.json results9-xe-load.json i915_display_info_post_exec9 boot9 dmesg9

Detail	Value
Duration	23.16 seconds
Hostname	shard-lnl-7
Igt-Version	IGT-Version: 1.30-g862d0a83b (x86_64) (Linux: 6.14.0-rc3-xe+ x86_64)
Out	Using IGT_SRANDOM=1739785760 for randomisation Opened device: /dev/dri/card0 Using monotonic timestamps Starting subtest: blocking-wf_vblank Starting dynamic subtest: A-eDP1 2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa Expected frametime: 16664us; measured 15986.4us +- 2.655us accuracy 0.05% vblank interval differs from modeline! expected 16664.0us, measured 15986us +- 2.655us, difference 677.6us (255.2 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-eDP1: FAIL (5.018s) Starting dynamic subtest: B-eDP1 2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa Expected frametime: 16664us; measured 16312.4us +- 3.384us accuracy 0.06% vblank interval differs from modeline! expected 16664.0us, measured 16312us +- 3.384us, difference 351.6us (103.9 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-eDP1: FAIL (6.930s) Starting dynamic subtest: C-eDP1 2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa Expected frametime: 16664us; measured 16520.7us +- 4.377us accuracy 0.08% vblank interval differs from modeline! expected 16664.0us, measured 16521us +- 4.377us, difference 143.3us (32.7 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 C-eDP1: FAIL (11.205s) Subtest blocking-wf_vblank: FAIL (23.158s) 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-eDP1 (kms_flip:3564) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674: (kms_flip:3564) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon) Dynamic subtest A-eDP1 failed. ** DEBUG (kms_flip:3564) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=2880, height=1800, format=XR24(0x34325258), modifier=0x0, size=0) (kms_flip:3564) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=11520) (kms_flip:3564) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd) (kms_flip:3564) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=2880, height=1800, format=XR24(0x34325258), modifier=0x0, size=0) (kms_flip:3564) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=11520) (kms_flip:3564) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd) (kms_flip:3564) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x650470968c50, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x650470968c50, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x650470976010, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x650470976010, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x650470968a80, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x650470968a80, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x650470972ac0, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x650470972ac0, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) igt_kms-INFO: 2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa (kms_flip:3564) DEBUG: No stale events found (kms_flip:3564) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0 (kms_flip:3564) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0 (kms_flip:3564) INFO: Expected frametime: 16664us; measured 15986.4us +- 2.655us accuracy 0.05% (kms_flip:3564) INFO: vblank interval differs from modeline! expected 16664.0us, measured 15986us +- 2.655us, difference 677.6us (255.2 sigma) (kms_flip:3564) DEBUG: name = vblank last_ts = 0.000000 last_received_ts = 0.000000 last_seq = 0 current_ts = 220.263351 current_received_ts = 220.262711 current_seq = 2397 count = 0 seq_step = 10 (kms_flip:3564) DEBUG: name = vblank last_ts = 220.263351 last_received_ts = 220.262711 last_seq = 2397 current_ts = 220.424057 current_received_ts = 220.423508 current_seq = 2407 count = 1 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 220.263351/2397, current 220.424057/2407: elapsed=160703.0us expected=159863.8us +- 799.3us, error 0.5% (kms_flip:3564) DEBUG: inconsistent vblank ts/seq: last 220.263351/2397, current 220.424057/2407: elapsed=160703.0us expected=159863.8us (kms_flip:3564) DEBUG: expected 189156, counted 10, encoder type 2 (kms_flip:3564) DEBUG: dropped frames, expected 189156, counted 10, encoder type 2 (kms_flip:3564) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674: (kms_flip:3564) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon) (kms_flip:3564) igt_core-INFO: Stack trace: (kms_flip:3564) igt_core-INFO: #0 ../lib/igt_core.c:2051 __igt_fail_assert() (kms_flip:3564) igt_core-INFO: #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0() (kms_flip:3564) igt_core-INFO: #2 ../tests/kms_flip.c:1845 run_test() (kms_flip:3564) igt_core-INFO: #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001() (kms_flip:3564) igt_core-INFO: #4 ../tests/kms_flip.c:2001 main() (kms_flip:3564) igt_core-INFO: #5 [__libc_init_first+0x8a] (kms_flip:3564) igt_core-INFO: #6 [__libc_start_main+0x8b] (kms_flip:3564) igt_core-INFO: #7 [_start+0x25] END Dynamic subtest A-eDP1: FAIL (5.018s) Starting dynamic subtest: B-eDP1 (kms_flip:3564) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674: (kms_flip:3564) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon) Dynamic subtest B-eDP1 failed. DEBUG (kms_flip:3564) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=2880, height=1800, format=XR24(0x34325258), modifier=0x0, size=0) (kms_flip:3564) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=3, pitch=11520) (kms_flip:3564) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd) (kms_flip:3564) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=2880, height=1800, format=XR24(0x34325258), modifier=0x0, size=0) (kms_flip:3564) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=4, pitch=11520) (kms_flip:3564) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd) (kms_flip:3564) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x6504709e4870, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x6504709e4870, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x6504709ee230, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x6504709ee230, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x6504709ee230, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x6504709ee230, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x6504709ca5b0, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x6504709ca5b0, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) igt_kms-INFO: 2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa (kms_flip:3564) DEBUG: No stale events found (kms_flip:3564) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0 (kms_flip:3564) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0 (kms_flip:3564) INFO: Expected frametime: 16664us; measured 16312.4us +- 3.384us accuracy 0.06% (kms_flip:3564) INFO: vblank interval differs from modeline! expected 16664.0us, measured 16312us +- 3.384us, difference 351.6us (103.9 sigma) (kms_flip:3564) DEBUG: name = vblank last_ts = 0.000000 last_received_ts = 0.000000 last_seq = 0 current_ts = 225.288589 current_received_ts = 225.287949 current_seq = 232 count = 0 seq_step = 10 (kms_flip:3564) DEBUG: name = vblank last_ts = 225.288589 last_received_ts = 225.287949 last_seq = 232 current_ts = 225.452133 current_received_ts = 225.451584 current_seq = 242 count = 1 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 225.288589/232, current 225.452133/242: elapsed=163549.0us expected=163123.8us +- 815.6us, error 0.3% (kms_flip:3564) DEBUG: name = vblank last_ts = 225.452133 last_received_ts = 225.451584 last_seq = 242 current_ts = 225.615692 current_received_ts = 225.615158 current_seq = 252 count = 2 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 225.452133/242, current 225.615692/252: elapsed=163553.0us expected=163123.8us +- 815.6us, error 0.3% (kms_flip:3564) DEBUG: name = vblank last_ts = 225.615692 last_received_ts = 225.615158 last_seq = 252 current_ts = 225.779251 current_received_ts = 225.778687 current_seq = 262 count = 3 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 225.615692/252, current 225.779251/262: elapsed=163556.0us expected=163123.8us +- 815.6us, error 0.3% (kms_flip:3564) DEBUG: name = vblank last_ts = 225.779251 last_received_ts = 225.778687 last_seq = 262 current_ts = 225.942795 current_received_ts = 225.942261 current_seq = 272 count = 4 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 225.779251/262, current 225.942795/272: elapsed=163554.0us expected=163123.8us +- 815.6us, error 0.3% (kms_flip:3564) DEBUG: name = vblank last_ts = 225.942795 last_received_ts = 225.942261 last_seq = 272 current_ts = 226.106354 current_received_ts = 226.105804 current_seq = 282 count = 5 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 225.942795/272, current 226.106354/282: elapsed=163552.0us expected=163123.8us +- 815.6us, error 0.3% (kms_flip:3564) DEBUG: name = vblank last_ts = 226.106354 last_received_ts = 226.105804 last_seq = 282 current_ts = 226.270020 current_received_ts = 226.269455 current_seq = 292 count = 6 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 226.106354/282, current 226.270020/292: elapsed=163662.0us expected=163123.8us +- 815.6us, error 0.3% (kms_flip:3564) DEBUG: name = vblank last_ts = 226.270020 last_received_ts = 226.269455 last_seq = 292 current_ts = 226.433945 current_received_ts = 226.433441 current_seq = 302 count = 7 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 226.270020/292, current 226.433945/302: elapsed=163930.0us expected=163123.8us +- 815.6us, error 0.5% (kms_flip:3564) DEBUG: name = vblank last_ts = 226.433945 last_received_ts = 226.433441 last_seq = 302 current_ts = 226.597870 current_received_ts = 226.597366 current_seq = 312 count = 8 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 226.433945/302, current 226.597870/312: elapsed=163931.0us expected=163123.8us +- 815.6us, error 0.5% (kms_flip:3564) DEBUG: name = vblank last_ts = 226.597870 last_received_ts = 226.597366 last_seq = 312 current_ts = 226.761810 current_received_ts = 226.761261 current_seq = 322 count = 9 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 226.597870/312, current 226.761810/322: elapsed=163927.0us expected=163123.8us +- 815.6us, error 0.5% (kms_flip:3564) DEBUG: name = vblank last_ts = 226.761810 last_received_ts = 226.761261 last_seq = 322 current_ts = 226.925735 current_received_ts = 226.925247 current_seq = 332 count = 10 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 226.761810/322, current 226.925735/332: elapsed=163926.0us expected=163123.8us +- 815.6us, error 0.5% (kms_flip:3564) DEBUG: name = vblank last_ts = 226.925735 last_received_ts = 226.925247 last_seq = 332 current_ts = 227.089661 current_received_ts = 227.089172 current_seq = 342 count = 11 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 226.925735/332, current 227.089661/342: elapsed=163928.0us expected=163123.8us +- 815.6us, error 0.5% (kms_flip:3564) DEBUG: name = vblank last_ts = 227.089661 last_received_ts = 227.089172 last_seq = 342 current_ts = 227.253647 current_received_ts = 227.253098 current_seq = 352 count = 12 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 227.089661/342, current 227.253647/352: elapsed=163995.0us expected=163123.8us +- 815.6us, error 0.5% (kms_flip:3564) DEBUG: inconsistent vblank ts/seq: last 227.089661/342, current 227.253647/352: elapsed=163995.0us expected=163123.8us (kms_flip:3564) DEBUG: expected 185376, counted 120, encoder type 2 (kms_flip:3564) DEBUG: dropped frames, expected 185376, counted 120, encoder type 2 (kms_flip:3564) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674: (kms_flip:3564) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon) (kms_flip:3564) igt_core-INFO: Stack trace: (kms_flip:3564) igt_core-INFO: #0 ../lib/igt_core.c:2051 __igt_fail_assert() (kms_flip:3564) igt_core-INFO: #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0() (kms_flip:3564) igt_core-INFO: #2 ../tests/kms_flip.c:1845 run_test() (kms_flip:3564) igt_core-INFO: #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001() (kms_flip:3564) igt_core-INFO: #4 ../tests/kms_flip.c:2001 main() (kms_flip:3564) igt_core-INFO: #5 [__libc_init_first+0x8a] (kms_flip:3564) igt_core-INFO: #6 [__libc_start_main+0x8b] (kms_flip:3564) igt_core-INFO: #7 [_start+0x25] END Dynamic subtest B-eDP1: FAIL (6.930s) Starting dynamic subtest: C-eDP1 (kms_flip:3564) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674: (kms_flip:3564) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon) Dynamic subtest C-eDP1 failed. DEBUG (kms_flip:3564) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=2880, height=1800, format=XR24(0x34325258), modifier=0x0, size=0) (kms_flip:3564) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=5, pitch=11520) (kms_flip:3564) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd) (kms_flip:3564) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=2880, height=1800, format=XR24(0x34325258), modifier=0x0, size=0) (kms_flip:3564) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=6, pitch=11520) (kms_flip:3564) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd) (kms_flip:3564) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x6504709ee040, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x6504709ee040, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x6504709ee040, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x6504709ee040, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x6504709f16b0, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x6504709f16b0, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x6504709ee040, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) intel_allocator_simple-DEBUG: <ial: 0x6504709ee040, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3564) igt_kms-INFO: 2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa (kms_flip:3564) DEBUG: No stale events found (kms_flip:3564) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0 (kms_flip:3564) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0 (kms_flip:3564) INFO: Expected frametime: 16664us; measured 16520.7us +- 4.377us accuracy 0.08% (kms_flip:3564) INFO: vblank interval differs from modeline! expected 16664.0us, measured 16521us +- 4.377us, difference 143.3us (32.7 sigma) (kms_flip:3564) DEBUG: name = vblank last_ts = 0.000000 last_received_ts = 0.000000 last_seq = 0 current_ts = 232.100418 current_received_ts = 232.099930 current_seq = 151 count = 0 seq_step = 10 (kms_flip:3564) DEBUG: name = vblank last_ts = 232.100418 last_received_ts = 232.099930 last_seq = 151 current_ts = 232.265671 current_received_ts = 232.265213 current_seq = 161 count = 1 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 232.100418/151, current 232.265671/161: elapsed=165263.0us expected=165206.9us +- 826.0us, error 0.0% (kms_flip:3564) DEBUG: name = vblank last_ts = 232.265671 last_received_ts = 232.265213 last_seq = 161 current_ts = 232.431046 current_received_ts = 232.430573 current_seq = 171 count = 2 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 232.265671/161, current 232.431046/171: elapsed=165370.0us expected=165206.9us +- 826.0us, error 0.1% (kms_flip:3564) DEBUG: name = vblank last_ts = 232.431046 last_received_ts = 232.430573 last_seq = 171 current_ts = 232.596420 current_received_ts = 232.595932 current_seq = 181 count = 3 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 232.431046/171, current 232.596420/181: elapsed=165380.0us expected=165206.9us +- 826.0us, error 0.1% (kms_flip:3564) DEBUG: name = vblank last_ts = 232.596420 last_received_ts = 232.595932 last_seq = 181 current_ts = 232.761810 current_received_ts = 232.761322 current_seq = 191 count = 4 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 232.596420/181, current 232.761810/191: elapsed=165382.0us expected=165206.9us +- 826.0us, error 0.1% (kms_flip:3564) DEBUG: name = vblank last_ts = 232.761810 last_received_ts = 232.761322 last_seq = 191 current_ts = 232.927185 current_received_ts = 232.926712 current_seq = 201 count = 5 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 232.761810/191, current 232.927185/201: elapsed=165375.0us expected=165206.9us +- 826.0us, error 0.1% (kms_flip:3564) DEBUG: name = vblank last_ts = 232.927185 last_received_ts = 232.926712 last_seq = 201 current_ts = 233.092560 current_received_ts = 233.092056 current_seq = 211 count = 6 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 232.927185/201, current 233.092560/211: elapsed=165375.0us expected=165206.9us +- 826.0us, error 0.1% (kms_flip:3564) DEBUG: name = vblank last_ts = 233.092560 last_received_ts = 233.092056 last_seq = 211 current_ts = 233.257965 current_received_ts = 233.257477 current_seq = 221 count = 7 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 233.092560/211, current 233.257965/221: elapsed=165407.0us expected=165206.9us +- 826.0us, error 0.1% (kms_flip:3564) DEBUG: name = vblank last_ts = 233.257965 last_received_ts = 233.257477 last_seq = 221 current_ts = 233.423492 current_received_ts = 233.423050 current_seq = 231 count = 8 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 233.257965/221, current 233.423492/231: elapsed=165527.0us expected=165206.9us +- 826.0us, error 0.2% (kms_flip:3564) DEBUG: name = vblank last_ts = 233.423492 last_received_ts = 233.423050 last_seq = 231 current_ts = 233.589020 current_received_ts = 233.588516 current_seq = 241 count = 9 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 233.423492/231, current 233.589020/241: elapsed=165523.0us expected=165206.9us +- 826.0us, error 0.2% (kms_flip:3564) DEBUG: name = vblank last_ts = 233.589020 last_received_ts = 233.588516 last_seq = 241 current_ts = 233.754532 current_received_ts = 233.754074 current_seq = 251 count = 10 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 233.589020/241, current 233.754532/251: elapsed=165523.0us expected=165206.9us +- 826.0us, error 0.2% (kms_flip:3564) DEBUG: name = vblank last_ts = 233.754532 last_received_ts = 233.754074 last_seq = 251 current_ts = 233.920059 current_received_ts = 233.919586 current_seq = 261 count = 11 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 233.754532/251, current 233.920059/261: elapsed=165522.0us expected=165206.9us +- 826.0us, error 0.2% (kms_flip:3564) DEBUG: name = vblank last_ts = 233.920059 last_received_ts = 233.919586 last_seq = 261 current_ts = 234.085587 current_received_ts = 234.085098 current_seq = 271 count = 12 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 233.920059/261, current 234.085587/271: elapsed=165526.0us expected=165206.9us +- 826.0us, error 0.2% (kms_flip:3564) DEBUG: name = vblank last_ts = 234.085587 last_received_ts = 234.085098 last_seq = 271 current_ts = 234.251144 current_received_ts = 234.250656 current_seq = 281 count = 13 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 234.085587/271, current 234.251144/281: elapsed=165550.0us expected=165206.9us +- 826.0us, error 0.2% (kms_flip:3564) DEBUG: name = vblank last_ts = 234.251144 last_received_ts = 234.250656 last_seq = 281 current_ts = 234.416794 current_received_ts = 234.416306 current_seq = 291 count = 14 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 234.251144/281, current 234.416794/291: elapsed=165657.0us expected=165206.9us +- 826.0us, error 0.3% (kms_flip:3564) DEBUG: name = vblank last_ts = 234.416794 last_received_ts = 234.416306 last_seq = 291 current_ts = 234.582443 current_received_ts = 234.581940 current_seq = 301 count = 15 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 234.416794/291, current 234.582443/301: elapsed=165651.0us expected=165206.9us +- 826.0us, error 0.3% (kms_flip:3564) DEBUG: name = vblank last_ts = 234.582443 last_received_ts = 234.581940 last_seq = 301 current_ts = 234.748093 current_received_ts = 234.747604 current_seq = 311 count = 16 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 234.582443/301, current 234.748093/311: elapsed=165655.0us expected=165206.9us +- 826.0us, error 0.3% (kms_flip:3564) DEBUG: name = vblank last_ts = 234.748093 last_received_ts = 234.747604 last_seq = 311 current_ts = 234.913757 current_received_ts = 234.913223 current_seq = 321 count = 17 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 234.748093/311, current 234.913757/321: elapsed=165659.0us expected=165206.9us +- 826.0us, error 0.3% (kms_flip:3564) DEBUG: name = vblank last_ts = 234.913757 last_received_ts = 234.913223 last_seq = 321 current_ts = 235.079407 current_received_ts = 235.078903 current_seq = 331 count = 18 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 234.913757/321, current 235.079407/331: elapsed=165653.0us expected=165206.9us +- 826.0us, error 0.3% (kms_flip:3564) DEBUG: name = vblank last_ts = 235.079407 last_received_ts = 235.078903 last_seq = 331 current_ts = 235.245087 current_received_ts = 235.244537 current_seq = 341 count = 19 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 235.079407/331, current 235.245087/341: elapsed=165670.0us expected=165206.9us +- 826.0us, error 0.3% (kms_flip:3564) DEBUG: name = vblank last_ts = 235.245087 last_received_ts = 235.244537 last_seq = 341 current_ts = 235.410843 current_received_ts = 235.410324 current_seq = 351 count = 20 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 235.245087/341, current 235.410843/351: elapsed=165767.0us expected=165206.9us +- 826.0us, error 0.3% (kms_flip:3564) DEBUG: name = vblank last_ts = 235.410843 last_received_ts = 235.410324 last_seq = 351 current_ts = 235.576614 current_received_ts = 235.576080 current_seq = 361 count = 21 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 235.410843/351, current 235.576614/361: elapsed=165763.0us expected=165206.9us +- 826.0us, error 0.3% (kms_flip:3564) DEBUG: name = vblank last_ts = 235.576614 last_received_ts = 235.576080 last_seq = 361 current_ts = 235.742386 current_received_ts = 235.741898 current_seq = 371 count = 22 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 235.576614/361, current 235.742386/371: elapsed=165767.0us expected=165206.9us +- 826.0us, error 0.3% (kms_flip:3564) DEBUG: name = vblank last_ts = 235.742386 last_received_ts = 235.741898 last_seq = 371 current_ts = 235.908157 current_received_ts = 235.907654 current_seq = 381 count = 23 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 235.742386/371, current 235.908157/381: elapsed=165771.0us expected=165206.9us +- 826.0us, error 0.3% (kms_flip:3564) DEBUG: name = vblank last_ts = 235.908157 last_received_ts = 235.907654 last_seq = 381 current_ts = 236.073914 current_received_ts = 236.073044 current_seq = 391 count = 24 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 235.908157/381, current 236.073914/391: elapsed=165763.0us expected=165206.9us +- 826.0us, error 0.3% (kms_flip:3564) DEBUG: name = vblank last_ts = 236.073914 last_received_ts = 236.073044 last_seq = 391 current_ts = 236.239700 current_received_ts = 236.239075 current_seq = 401 count = 25 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 236.073914/391, current 236.239700/401: elapsed=165785.0us expected=165206.9us +- 826.0us, error 0.3% (kms_flip:3564) DEBUG: name = vblank last_ts = 236.239700 last_received_ts = 236.239075 last_seq = 401 current_ts = 236.405563 current_received_ts = 236.404922 current_seq = 411 count = 26 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 236.239700/401, current 236.405563/411: elapsed=165865.0us expected=165206.9us +- 826.0us, error 0.4% (kms_flip:3564) DEBUG: name = vblank last_ts = 236.405563 last_received_ts = 236.404922 last_seq = 411 current_ts = 236.571426 current_received_ts = 236.570877 current_seq = 421 count = 27 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 236.405563/411, current 236.571426/421: elapsed=165861.0us expected=165206.9us +- 826.0us, error 0.4% (kms_flip:3564) DEBUG: name = vblank last_ts = 236.571426 last_received_ts = 236.570877 last_seq = 421 current_ts = 236.737289 current_received_ts = 236.736755 current_seq = 431 count = 28 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 236.571426/421, current 236.737289/431: elapsed=165870.0us expected=165206.9us +- 826.0us, error 0.4% (kms_flip:3564) DEBUG: name = vblank last_ts = 236.737289 last_received_ts = 236.736755 last_seq = 431 current_ts = 236.903152 current_received_ts = 236.902603 current_seq = 441 count = 29 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 236.737289/431, current 236.903152/441: elapsed=165859.0us expected=165206.9us +- 826.0us, error 0.4% (kms_flip:3564) DEBUG: name = vblank last_ts = 236.903152 last_received_ts = 236.902603 last_seq = 441 current_ts = 237.069016 current_received_ts = 237.068466 current_seq = 451 count = 30 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 236.903152/441, current 237.069016/451: elapsed=165869.0us expected=165206.9us +- 826.0us, error 0.4% (kms_flip:3564) DEBUG: name = vblank last_ts = 237.069016 last_received_ts = 237.068466 last_seq = 451 current_ts = 237.234909 current_received_ts = 237.234344 current_seq = 461 count = 31 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 237.069016/451, current 237.234909/461: elapsed=165880.0us expected=165206.9us +- 826.0us, error 0.4% (kms_flip:3564) DEBUG: name = vblank last_ts = 237.234909 last_received_ts = 237.234344 last_seq = 461 current_ts = 237.400848 current_received_ts = 237.400299 current_seq = 471 count = 32 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 237.234909/461, current 237.400848/471: elapsed=165949.0us expected=165206.9us +- 826.0us, error 0.4% (kms_flip:3564) DEBUG: name = vblank last_ts = 237.400848 last_received_ts = 237.400299 last_seq = 471 current_ts = 237.566803 current_received_ts = 237.566269 current_seq = 481 count = 33 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 237.400848/471, current 237.566803/481: elapsed=165953.0us expected=165206.9us +- 826.0us, error 0.5% (kms_flip:3564) DEBUG: name = vblank last_ts = 237.566803 last_received_ts = 237.566269 last_seq = 481 current_ts = 237.732758 current_received_ts = 237.732224 current_seq = 491 count = 34 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 237.566803/481, current 237.732758/491: elapsed=165953.0us expected=165206.9us +- 826.0us, error 0.5% (kms_flip:3564) DEBUG: name = vblank last_ts = 237.732758 last_received_ts = 237.732224 last_seq = 491 current_ts = 237.898697 current_received_ts = 237.898148 current_seq = 501 count = 35 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 237.732758/491, current 237.898697/501: elapsed=165947.0us expected=165206.9us +- 826.0us, error 0.4% (kms_flip:3564) DEBUG: name = vblank last_ts = 237.898697 last_received_ts = 237.898148 last_seq = 501 current_ts = 238.064651 current_received_ts = 238.064148 current_seq = 511 count = 36 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 237.898697/501, current 238.064651/511: elapsed=165951.0us expected=165206.9us +- 826.0us, error 0.5% (kms_flip:3564) DEBUG: name = vblank last_ts = 238.064651 last_received_ts = 238.064148 last_seq = 511 current_ts = 238.230606 current_received_ts = 238.230087 current_seq = 521 count = 37 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 238.064651/511, current 238.230606/521: elapsed=165956.0us expected=165206.9us +- 826.0us, error 0.5% (kms_flip:3564) DEBUG: name = vblank last_ts = 238.230606 last_received_ts = 238.230087 last_seq = 521 current_ts = 238.396652 current_received_ts = 238.396133 current_seq = 531 count = 38 seq_step = 10 (kms_flip:3564) DEBUG: vblank ts/seq: last 238.230606/521, current 238.396652/531: elapsed=166034.0us expected=165206.9us +- 826.0us, error 0.5% (kms_flip:3564) DEBUG: inconsistent vblank ts/seq: last 238.230606/521, current 238.396652/531: elapsed=166034.0us expected=165206.9us (kms_flip:3564) DEBUG: expected 183038, counted 380, encoder type 2 (kms_flip:3564) DEBUG: dropped frames, expected 183038, counted 380, encoder type 2 (kms_flip:3564) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674: (kms_flip:3564) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon) (kms_flip:3564) igt_core-INFO: Stack trace: (kms_flip:3564) igt_core-INFO: #0 ../lib/igt_core.c:2051 __igt_fail_assert() (kms_flip:3564) igt_core-INFO: #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0() (kms_flip:3564) igt_core-INFO: #2 ../tests/kms_flip.c:1845 run_test() (kms_flip:3564) igt_core-INFO: #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001() (kms_flip:3564) igt_core-INFO: #4 ../tests/kms_flip.c:2001 main() (kms_flip:3564) igt_core-INFO: #5 [__libc_init_first+0x8a] (kms_flip:3564) igt_core-INFO: #6 [__libc_start_main+0x8b] (kms_flip:3564) igt_core-INFO: #7 [_start+0x25] END ** Dynamic subtest C-eDP1: FAIL (11.205s) Subtest blocking-wf_vblank: FAIL (23.158s) (kms_flip:3564) igt_kms-CRITICAL: Test assertion failure function kmstest_set_connector_dpms, file ../lib/igt_kms.c:2246: (kms_flip:3564) igt_kms-CRITICAL: Failed assertion: found_it (kms_flip:3564) igt_kms-CRITICAL: Last errno: 9, Bad file descriptor (kms_flip:3564) igt_kms-CRITICAL: DPMS property not found on 189
Dmesg	<6> [308.668656] Console: switching to colour dummy device 80x25 <6> [308.668873] [IGT] kms_flip: executing <7> [308.676784] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:198:DP-1] <7> [308.676801] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:198:DP-1] <7> [308.676925] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port D/TC#1: TC port mode reset (disconnected -> tbt-alt) <7> [308.677006] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:198:DP-1] disconnected <7> [308.677227] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:210:DP-2] <7> [308.677234] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:210:DP-2] <7> [308.677330] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port E/TC#2: TC port mode reset (disconnected -> tbt-alt) <7> [308.677404] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:210:DP-2] disconnected <7> [308.677628] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:218:DP-3] <7> [308.677636] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:218:DP-3] <7> [308.677747] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port F/TC#3: TC port mode reset (disconnected -> tbt-alt) <7> [308.677825] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:218:DP-3] disconnected <7> [308.678075] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:189:eDP-1] <7> [308.678082] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:189:eDP-1] <7> [308.678157] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD on <7> [308.678251] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006f <7> [308.678930] xe 0000:00:02.0: [drm:intel_dp_read_dsc_dpcd [xe]] DSC DPCD: 00 11 00 76 0b 01 01 80 00 01 06 66 08 00 00 00 <7> [308.679451] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] source rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 675000, 810000 <7> [308.679647] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] sink rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 810000 <7> [308.679782] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] common rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 810000 <7> [308.679942] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:189:eDP-1] Supported Monitor Refresh rate range is 40 Hz - 120 Hz <5> [308.679950] [drm] DisplayID checksum invalid, remainder is 248 <5> [308.679952] [drm] DisplayID checksum invalid, remainder is 248 <7> [308.679954] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:189:eDP-1] Assigning EDID-1.4 digital sink color depth as 10 bpc. <5> [308.679957] [drm] DisplayID checksum invalid, remainder is 248 <7> [308.679960] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:189:eDP-1] ELD monitor <5> [308.679963] [drm] DisplayID checksum invalid, remainder is 248 <7> [308.679965] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:189:eDP-1] ELD size 20, SAD count 0 <5> [308.679968] [drm] DisplayID checksum invalid, remainder is 248 <7> [308.679983] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:189:eDP-1] VRR capable: yes <7> [308.680111] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:189:eDP-1] DFP max bpc 0, max dotclock 0, TMDS clock 0-0, PCON Max FRL BW 0Gbps <7> [308.680857] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] PCON ENCODER DSC DPCD: 00 00 00 00 00 00 00 00 00 00 00 00 00 <7> [308.680986] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:189:eDP-1] RGB->YcbCr conversion? no, YCbCr 4:2:0 allowed? yes, YCbCr 4:4:4->4:2:0 conversion? no <5> [308.682038] [drm] DisplayID checksum invalid, remainder is 248 <5> [308.682042] [drm] DisplayID checksum invalid, remainder is 248 <5> [308.682043] [drm] DisplayID checksum invalid, remainder is 248 <7> [308.682094] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:189:eDP-1] probed modes: <7> [308.682109] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa <7> [308.682136] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:198:DP-1] <7> [308.682149] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:198:DP-1] <7> [308.682318] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:198:DP-1] disconnected <7> [308.682343] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:210:DP-2] <7> [308.682356] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:210:DP-2] <7> [308.682521] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:210:DP-2] disconnected <7> [308.682545] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:218:DP-3] <7> [308.682567] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:218:DP-3] <7> [308.682759] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:218:DP-3] disconnected <6> [308.683526] [IGT] kms_flip: starting subtest blocking-wf_vblank <6> [308.684677] [IGT] kms_flip: starting dynamic subtest A-eDP1 <7> [308.685322] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225] <7> [308.685505] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228] <7> [308.769353] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A] <7> [308.769569] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.enable (expected yes, found no) <7> [308.769933] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.active (expected yes, found no) <7> [308.770163] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1) <7> [308.770384] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in lane_count (expected 4, found 0) <7> [308.770591] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in dp_m_n (expected tu 64 data 6329869/8388608 link 421991/524288, found tu 0, data 0/0 link 0/0) <7> [308.770838] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000) <7> [308.771030] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0) <7> [308.771213] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0) <7> [308.771428] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0) <7> [308.771635] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0) <7> [308.771816] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0) <7> [308.771982] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0) <7> [308.772146] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0) <7> [308.772338] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0) <7> [308.772515] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0) <7> [308.772688] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0) <7> [308.772857] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0) <7> [308.773009] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0) <7> [308.773157] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0) <7> [308.773303] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0) <7> [308.773441] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0) <7> [308.773580] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0) <7> [308.773751] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0) <7> [308.773904] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0) <7> [308.774054] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0) <7> [308.774184] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0) <7> [308.774331] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0) <7> [308.774456] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0) <7> [308.774579] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0) <7> [308.774733] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0) <7> [308.774854] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0) <7> [308.774970] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0) <7> [308.775106] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0) <7> [308.775231] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0) <7> [308.775344] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in pipe_bpp (expected 30, found 0) <7> [308.775455] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0) <7> [308.775566] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0) <7> [308.775697] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in port_clock (expected 432000, found 0) <7> [308.775813] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset <7> [308.775981] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no <7> [308.776092] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:82:pipe A] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x1 -> 0x0 <7> [308.776253] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] ddb ( 0 - 4054) -> ( 0 - 0), size 4054 -> 0 <7> [308.776349] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:77:cursor A] ddb (4054 - 4096) -> ( 0 - 0), size 42 -> 0 <7> [308.776441] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [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> [308.776531] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] lines 2, 12, 12, 12, 11, 12, 0, 0, 0, 3, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [308.776628] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] blocks 49, 289, 289, 289, 265, 289, 0, 0, 63, 73, 87 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [308.776715] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] min_ddb 55, 319, 319, 319, 293, 319, 0, 0, 64, 82, 88 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [308.776811] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:82:pipe A] data rate 0 num active planes 0 <7> [308.776951] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400 <7> [308.777081] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400 <7> [308.777189] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400 <7> [308.777298] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400 <7> [308.777403] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0 <7> [308.777512] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing <7> [308.777624] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz <7> [308.777738] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0 <7> [308.777884] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:82:pipe A] enable: no [modeset] <7> [308.777994] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:32:plane 1A] fb: [NOFB], visible: no <7> [308.778093] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:41:plane 2A] fb: [NOFB], visible: no <7> [308.778191] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:50:plane 3A] fb: [NOFB], visible: no <7> [308.778286] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:59:plane 4A] fb: [NOFB], visible: no <7> [308.778377] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:68:plane 5A] fb: [NOFB], visible: no <7> [308.778467] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:77:cursor A] fb: [NOFB], visible: no <7> [308.778625] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [308.778739] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [308.778894] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2 <7> [308.796057] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]] <7> [308.998846] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 0 <7> [308.999377] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe A <7> [309.019900] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turn panel power off <7> [309.020258] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 wait for panel power off time <7> [309.020402] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [309.020585] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060 <7> [309.020747] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [309.072766] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [309.073040] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [309.103368] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [309.103814] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A <7> [309.104094] xe 0000:00:02.0: [drm:__intel_fbc_disable [xe]] Disabling FBC on [PLANE:32:plane 1A] <7> [309.104102] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [309.104385] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [309.104544] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A] <7> [309.104742] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1] <7> [309.104955] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A] <7> [309.105134] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B] <7> [309.105316] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C] <7> [309.105491] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2] <7> [309.105701] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A] <7> [309.105914] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B] <7> [309.106091] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C] <7> [309.106274] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3] <7> [309.106449] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A] <7> [309.106624] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B] <7> [309.106814] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C] <7> [309.107006] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1] <7> [309.107238] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [309.107444] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: ) <7> [309.107643] xe 0000:00:02.0: [drm:intel_set_cdclk [xe]] Post changing CDCLK to 153600 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0 <7> [309.107948] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [309.108234] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384 <7> [309.108500] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1 <7> [309.108900] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_A <7> [309.109309] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:82:pipe A] <7> [309.109622] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B] <7> [309.109993] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:186:pipe C] <7> [309.110219] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A] <7> [309.110275] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:189:eDP-1] <7> [309.110424] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:189:eDP-1] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36) <7> [309.110704] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:188:DDI A/PHY A][CRTC:82:pipe A] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 max link_bpp 30.0000 <7> [309.110978] xe 0000:00:02.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 432000 bpp input 30 compressed 0.0000 link rate required 1303913 available 1728000 <7> [309.111224] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:82:pipe A] hw max bpp: 30, pipe bpp: 30, dithering: 0 <7> [309.111462] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:188:DDI A/PHY A] [CRTC:82:pipe A] <7> [309.111715] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.enable (expected no, found yes) <7> [309.111982] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.active (expected no, found yes) <7> [309.112210] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0) <7> [309.112434] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in lane_count (expected 0, found 4) <7> [309.112654] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6329869/8388608 link 421991/524288) <7> [309.112911] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100) <7> [309.113201] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1) <7> [309.113437] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880) <7> [309.113468] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [309.113667] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040) <7> [309.113732] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [309.113941] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880) <7> [309.113990] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10 <7> [309.114171] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040) <7> [309.114259] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [309.114396] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928) <7> [309.114622] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960) <7> [309.114900] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800) <7> [309.115182] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800) <7> [309.115403] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803) <7> [309.115676] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809) <7> [309.115942] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906) <7> [309.116205] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906) <7> [309.116419] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880) <7> [309.116624] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040) <7> [309.116848] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880) <7> [309.117072] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040) <7> [309.117264] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928) <7> [309.117447] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960) <7> [309.117624] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800) <7> [309.117859] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800) <7> [309.118039] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803) <7> [309.118221] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809) <7> [309.118391] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906) <7> [309.118562] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906) <7> [309.118722] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1) <7> [309.118924] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2) <7> [309.119092] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8) <7> [309.119250] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 30) <7> [309.119401] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710) <7> [309.119545] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710) <7> [309.119683] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in port_clock (expected 0, found 432000) <7> [309.119871] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset <7> [309.120316] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes <7> [309.120438] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:82:pipe A] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x1 <7> [309.120609] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] ddb ( 0 - 0) -> ( 0 - 4054), size 0 -> 4054 <7> [309.120724] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:77:cursor A] ddb ( 0 - 0) -> (4054 - 4096), size 0 -> 42 <7> [309.120849] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [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> [309.120955] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 2, 12, 12, 12, 11, 12, 0, 0, 0, 3, 0 <7> [309.121058] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 49, 289, 289, 289, 265, 289, 0, 0, 63, 73, 87 <7> [309.121168] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 55, 319, 319, 319, 293, 319, 0, 0, 64, 82, 88 <7> [309.121268] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:82:pipe A] data rate 1390840 num active planes 1 <7> [309.121401] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400 <7> [309.121529] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400 <7> [309.121653] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400 <7> [309.121781] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400 <7> [309.121901] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461 <7> [309.122016] xe 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [xe]] [PLANE:32:plane 1A] min cdclk (173855 kHz) > [CRTC:82:pipe A] min cdclk (0 kHz) <7> [309.122136] xe 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [xe]] new bandwidth min cdclk (27165 kHz) > old min cdclk (0 kHz) <7> [309.122252] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing <7> [309.122362] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz <7> [309.122468] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0 <7> [309.122591] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:82:pipe A] enable: yes [modeset] <7> [309.122705] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB <7> [309.122822] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 30, dithering: 0 <7> [309.122923] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid> <7> [309.123023] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7> [309.123122] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0 <7> [309.123224] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0 <7> [309.123323] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 6329869, data_n: 8388608, link_m: 421991, link_n: 524288, tu: 64 <7> [309.123418] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0 <7> [309.123509] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled <7> [309.123598] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled <7> [309.123686] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled <7> [309.123778] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0 <7> [309.123863] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4 <7> [309.123946] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14 <7> [309.124026] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB <7> [309.124106] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB <7> [309.124183] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0 <7> [309.124262] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range <7> [309.124337] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined <7> [309.124410] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1 <7> [309.124480] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0 <7> [309.124551] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, vmin: 1906, vmax: 2859, flipline: 1906, pipeline full: 0, guardband: 106 vsync start: 103, vsync end: 97 <7> [309.124622] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1800, vmax vblank: 2753, vmin vtotal: 1906, vmax vtotal: 2859 <7> [309.124691] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] requested mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa <7> [309.124759] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa <7> [309.124843] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa <7> [309.124911] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x40 0xa <7> [309.124976] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa <7> [309.125041] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710 <7> [309.125106] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0 <7> [309.125171] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0 <7> [309.125235] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no <7> [309.125298] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0 <7> [309.125357] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dpll_hw_state: dpll: 0x69780, dpll_md: 0x42110, fp0: 0x1a2, fp1: 0x1000000 <7> [309.125417] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7> [309.125477] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries <7> [309.125535] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000 <7> [309.125594] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [309.125654] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [309.125713] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [309.125778] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000 <7> [309.125837] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000 <7> [309.125898] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [309.125969] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [309.126031] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [309.126089] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000 <7> [309.126146] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:32:plane 1A] fb: [FB:225] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes <7> [309.126206] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7> [309.126264] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0 <7> [309.126323] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:41:plane 2A] fb: [NOFB], visible: no <7> [309.126381] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:50:plane 3A] fb: [NOFB], visible: no <7> [309.126439] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:59:plane 4A] fb: [NOFB], visible: no <7> [309.126497] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:68:plane 5A] fb: [NOFB], visible: no <7> [309.126556] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:77:cursor A] fb: [NOFB], visible: no <7> [309.127794] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [309.128131] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [309.128278] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02 <7> [309.129444] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [309.129523] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [309.129643] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_A <7> [309.129784] xe 0000:00:02.0: [drm:intel_set_cdclk [xe]] Pre changing CDCLK to 192000 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0 <7> [309.129863] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [309.129947] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480 <7> [309.130012] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A] <7> [309.130067] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1] <7> [309.130121] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A] <7> [309.130175] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B] <7> [309.130226] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C] <7> [309.130279] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2] <7> [309.130330] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A] <7> [309.130379] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B] <7> [309.130429] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C] <7> [309.130477] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3] <7> [309.130525] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A] <7> [309.130574] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B] <7> [309.130623] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C] <7> [309.130673] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf <7> [309.130818] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: ) <7> [309.130880] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes) <7> [309.130952] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A <7> [309.131901] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turn panel power on <7> [309.131998] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 wait for panel power cycle (472 ms remaining) <7> [309.618711] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x00000000 PP_CONTROL: 0x00000060 <7> [309.618999] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [309.619218] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 wait for panel power on <7> [309.619432] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063 <7> [309.656114] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [309.656371] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [309.656579] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20 <7> [309.656947] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [309.701950] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port F/TC#3: TC port mode reset (tbt-alt -> disconnected) <7> [309.701957] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port E/TC#2: TC port mode reset (tbt-alt -> disconnected) <7> [309.702121] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port D/TC#1: TC port mode reset (tbt-alt -> disconnected) <7> [309.902053] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [309.904169] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD on <7> [309.904489] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b <7> [309.908080] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX A/DDI A/PHY A: DPCD: 14 1e 44 c1 00 00 01 c0 02 00 02 00 00 0b 80 <7> [309.909430] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Reloading eDP link rates <7> [309.910607] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05 <7> [309.911830] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0 <7> [309.912968] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Using DP training pattern TPS1 <7> [309.914404] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Clock recovery OK <7> [309.914756] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Using DP training pattern TPS4 <7> [309.916557] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful <7> [309.916919] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4 <7> [309.917747] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe A <7> [309.918261] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]] <7> [309.918610] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe A <7> [309.919051] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 4518 <7> [309.920258] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] reserved 10600448 bytes of contiguous stolen space for FBC, limit: 2 <7> [309.920574] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] Enabling FBC on [PLANE:32:plane 1A] <7> [309.935131] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2 <7> [309.937148] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1] <7> [309.937609] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:82:pipe A] <7> [309.958345] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [309.958927] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [309.959457] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02 <7> [310.222149] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [310.222475] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [310.253325] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [310.253890] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [310.254412] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02 <7> [312.553310] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD off <7> [312.553837] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067 <6> [313.702933] [IGT] kms_flip: finished subtest A-eDP1, FAIL <6> [313.703573] [IGT] kms_flip: starting dynamic subtest B-eDP1 <7> [313.704327] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:226] <7> [313.713835] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:230] <7> [313.852808] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A] <7> [313.853022] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.enable (expected yes, found no) <7> [313.853303] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.active (expected yes, found no) <7> [313.853530] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1) <7> [313.853811] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in lane_count (expected 4, found 0) <7> [313.854026] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in dp_m_n (expected tu 64 data 6329869/8388608 link 421991/524288, found tu 0, data 0/0 link 0/0) <7> [313.854232] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000) <7> [313.854429] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0) <7> [313.854656] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0) <7> [313.854854] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0) <7> [313.855045] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0) <7> [313.855232] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0) <7> [313.855455] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0) <7> [313.855667] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0) <7> [313.855851] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0) <7> [313.856070] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0) <7> [313.856258] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0) <7> [313.856429] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0) <7> [313.856608] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0) <7> [313.856803] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0) <7> [313.856972] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0) <7> [313.857139] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0) <7> [313.857299] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0) <7> [313.857455] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0) <7> [313.857609] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0) <7> [313.857798] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0) <7> [313.857944] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0) <7> [313.858104] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0) <7> [313.858247] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0) <7> [313.858393] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0) <7> [313.858531] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0) <7> [313.858667] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0) <7> [313.858835] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0) <7> [313.858990] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0) <7> [313.859119] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0) <7> [313.859250] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in pipe_bpp (expected 30, found 0) <7> [313.859378] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0) <7> [313.859503] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0) <7> [313.859625] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in port_clock (expected 432000, found 0) <7> [313.859757] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset <7> [313.859968] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no <7> [313.860104] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:82:pipe A] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x1 -> 0x0 <7> [313.860277] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] ddb ( 0 - 4054) -> ( 0 - 0), size 4054 -> 0 <7> [313.860400] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:77:cursor A] ddb (4054 - 4096) -> ( 0 - 0), size 42 -> 0 <7> [313.860507] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [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> [313.860613] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] lines 2, 12, 12, 12, 11, 12, 0, 0, 0, 3, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [313.860719] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] blocks 49, 289, 289, 289, 265, 289, 0, 0, 63, 73, 87 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [313.860839] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] min_ddb 55, 319, 319, 319, 293, 319, 0, 0, 64, 82, 88 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [313.860954] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:82:pipe A] data rate 0 num active planes 0 <7> [313.861085] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400 <7> [313.861212] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400 <7> [313.861330] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400 <7> [313.861445] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400 <7> [313.861560] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0 <7> [313.861672] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing <7> [313.861792] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz <7> [313.861903] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0 <7> [313.862039] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:82:pipe A] enable: no [modeset] <7> [313.862164] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:32:plane 1A] fb: [NOFB], visible: no <7> [313.862284] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:41:plane 2A] fb: [NOFB], visible: no <7> [313.862388] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:50:plane 3A] fb: [NOFB], visible: no <7> [313.862492] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:59:plane 4A] fb: [NOFB], visible: no <7> [313.862593] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:68:plane 5A] fb: [NOFB], visible: no <7> [313.862695] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:77:cursor A] fb: [NOFB], visible: no <7> [313.862868] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [313.862997] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [313.863169] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2 <7> [313.863417] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD on <7> [313.863549] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006f <7> [313.880450] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]] <7> [314.089552] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 0 <7> [314.090045] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe A <7> [314.101207] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turn panel power off <7> [314.101595] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 wait for panel power off time <7> [314.101723] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [314.101931] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060 <7> [314.102093] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [314.154062] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [314.154331] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [314.184348] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [314.184777] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A <7> [314.184777] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [314.185076] xe 0000:00:02.0: [drm:__intel_fbc_disable [xe]] Disabling FBC on [PLANE:32:plane 1A] <7> [314.185094] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [314.185535] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A] <7> [314.185779] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1] <7> [314.185963] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A] <7> [314.186133] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B] <7> [314.186289] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C] <7> [314.186471] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2] <7> [314.186661] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A] <7> [314.186812] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B] <7> [314.186958] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C] <7> [314.187110] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3] <7> [314.187263] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A] <7> [314.187412] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B] <7> [314.187559] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C] <7> [314.187777] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1] <7> [314.187989] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [314.188206] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: ) <7> [314.188386] xe 0000:00:02.0: [drm:intel_set_cdclk [xe]] Post changing CDCLK to 153600 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0 <7> [314.188620] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [314.188872] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384 <7> [314.189101] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1 <7> [314.189443] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_A <7> [314.189827] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:82:pipe A] <7> [314.190124] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B] <7> [314.190457] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:186:pipe C] <7> [314.190726] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B] <7> [314.190791] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:189:eDP-1] <7> [314.190958] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:189:eDP-1] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36) <7> [314.191235] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:188:DDI A/PHY A][CRTC:134:pipe B] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 max link_bpp 30.0000 <7> [314.191467] xe 0000:00:02.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 432000 bpp input 30 compressed 0.0000 link rate required 1303913 available 1728000 <7> [314.191703] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:134:pipe B] hw max bpp: 30, pipe bpp: 30, dithering: 0 <7> [314.191990] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:188:DDI A/PHY A] [CRTC:134:pipe B] <7> [314.192222] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.enable (expected no, found yes) <7> [314.192503] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.active (expected no, found yes) <7> [314.192740] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1) <7> [314.193017] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in lane_count (expected 0, found 4) <7> [314.193250] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6329869/8388608 link 421991/524288) <7> [314.193483] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100) <7> [314.193712] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1) <7> [314.193983] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880) <7> [314.194256] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040) <7> [314.194479] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880) <7> [314.194706] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040) <7> [314.194704] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [314.194970] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [314.194983] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928) <7> [314.195211] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960) <7> [314.195227] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10 <7> [314.195437] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800) <7> [314.195516] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [314.195660] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800) <7> [314.195945] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803) <7> [314.196183] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809) <7> [314.196409] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906) <7> [314.196635] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906) <7> [314.196907] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880) <7> [314.197128] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040) <7> [314.197349] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880) <7> [314.197598] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040) <7> [314.197808] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928) <7> [314.198045] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960) <7> [314.198290] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800) <7> [314.198485] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800) <7> [314.198666] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803) <7> [314.198837] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809) <7> [314.199081] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906) <7> [314.199258] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906) <7> [314.199423] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1) <7> [314.199579] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2) <7> [314.199734] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8) <7> [314.199888] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 30) <7> [314.200079] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710) <7> [314.200249] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710) <7> [314.200417] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in port_clock (expected 0, found 432000) <7> [314.200557] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:134:pipe B] fastset requirement not met, forcing full modeset <7> [314.201140] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes <7> [314.201294] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:134:pipe B] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x2 <7> [314.201494] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:84:plane 1B] ddb ( 0 - 0) -> ( 0 - 4054), size 0 -> 4054 <7> [314.201611] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:129:cursor B] ddb ( 0 - 0) -> (4054 - 4096), size 0 -> 42 <7> [314.201723] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [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> [314.201831] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:84:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 2, 12, 12, 12, 11, 12, 0, 0, 0, 3, 0 <7> [314.201937] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:84:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 49, 289, 289, 289, 265, 289, 0, 0, 63, 73, 87 <7> [314.202136] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:84:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 55, 319, 319, 319, 293, 319, 0, 0, 64, 82, 88 <7> [314.202239] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:134:pipe B] data rate 1390840 num active planes 1 <7> [314.202376] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400 <7> [314.202506] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400 <7> [314.202630] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400 <7> [314.202752] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400 <7> [314.202867] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461 <7> [314.202983] xe 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [xe]] [PLANE:84:plane 1B] min cdclk (173855 kHz) > [CRTC:134:pipe B] min cdclk (0 kHz) <7> [314.203125] xe 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [xe]] new bandwidth min cdclk (27165 kHz) > old min cdclk (0 kHz) <7> [314.203279] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing <7> [314.203488] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz <7> [314.203692] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0 <7> [314.203938] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:134:pipe B] enable: yes [modeset] <7> [314.204215] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB <7> [314.204330] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: B, pipe bpp: 30, dithering: 0 <7> [314.204438] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid> <7> [314.204545] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7> [314.204647] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0 <7> [314.204750] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0 <7> [314.204852] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 6329869, data_n: 8388608, link_m: 421991, link_n: 524288, tu: 64 <7> [314.204951] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0 <7> [314.205055] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled <7> [314.205154] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled <7> [314.205252] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled <7> [314.205345] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0 <7> [314.205436] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4 <7> [314.205526] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14 <7> [314.205621] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB <7> [314.205706] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB <7> [314.205789] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0 <7> [314.205870] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range <7> [314.205950] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined <7> [314.206030] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1 <7> [314.206137] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0 <7> [314.206217] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, vmin: 1906, vmax: 2859, flipline: 1906, pipeline full: 0, guardband: 106 vsync start: 103, vsync end: 97 <7> [314.206297] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1800, vmax vblank: 2753, vmin vtotal: 1906, vmax vtotal: 2859 <7> [314.206373] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] requested mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa <7> [314.206448] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa <7> [314.206522] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa <7> [314.206596] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x40 0xa <7> [314.206668] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa <7> [314.206738] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710 <7> [314.206806] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0 <7> [314.206871] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0 <7> [314.206936] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no <7> [314.207002] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0 <7> [314.207069] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dpll_hw_state: dpll: 0x69780, dpll_md: 0x42110, fp0: 0x1a2, fp1: 0x1000000 <7> [314.207145] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7> [314.207217] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries <7> [314.207282] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000 <7> [314.207345] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [314.207408] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [314.207469] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [314.207530] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000 <7> [314.207590] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000 <7> [314.207650] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [314.207710] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [314.207770] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [314.207830] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000 <7> [314.207890] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:84:plane 1B] fb: [FB:226] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes <7> [314.207952] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7> [314.208013] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0 <7> [314.208074] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:93:plane 2B] fb: [NOFB], visible: no <7> [314.208144] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:102:plane 3B] fb: [NOFB], visible: no <7> [314.208203] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:111:plane 4B] fb: [NOFB], visible: no <7> [314.208202] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [314.208265] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:120:plane 5B] fb: [NOFB], visible: no <7> [314.208306] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [314.208324] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:129:cursor B] fb: [NOFB], visible: no <7> [314.208388] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02 <7> [314.208722] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling always-on <7> [314.211086] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling always-on <7> [314.211172] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [314.211267] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [314.211390] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_2 <7> [314.211510] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_B <7> [314.211636] xe 0000:00:02.0: [drm:intel_set_cdclk [xe]] Pre changing CDCLK to 192000 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0 <7> [314.211708] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [314.211787] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480 <7> [314.211853] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A] <7> [314.211913] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1] <7> [314.211972] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A] <7> [314.212031] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B] <7> [314.212089] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C] <7> [314.212147] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2] <7> [314.212205] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A] <7> [314.212277] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B] <7> [314.212343] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C] <7> [314.212399] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3] <7> [314.212456] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A] <7> [314.212515] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B] <7> [314.212572] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C] <7> [314.212628] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf <7> [314.212777] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: ) <7> [314.212839] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes) <7> [314.212910] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A <7> [314.214316] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turn panel power on <7> [314.214411] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 wait for panel power cycle (471 ms remaining) <7> [314.703568] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060 <7> [314.785286] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [314.785575] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 wait for panel power on <7> [314.785819] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063 <7> [314.822465] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [314.822717] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [314.822926] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20 <7> [314.823214] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [315.071167] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [315.073327] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD on <7> [315.073635] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b <7> [315.077156] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX A/DDI A/PHY A: DPCD: 14 1e 44 c1 00 00 01 c0 02 00 02 00 00 0b 80 <7> [315.078499] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Reloading eDP link rates <7> [315.079492] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05 <7> [315.080684] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0 <7> [315.081801] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Using DP training pattern TPS1 <7> [315.083153] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Clock recovery OK <7> [315.083469] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Using DP training pattern TPS4 <7> [315.085191] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful <7> [315.085542] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4 <7> [315.086351] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe B <7> [315.086883] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]] <7> [315.087237] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe B <7> [315.087697] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 4518 <7> [315.088973] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] reserved 10600448 bytes of contiguous stolen space for FBC, limit: 2 <7> [315.089314] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] Enabling FBC on [PLANE:84:plane 1B] <7> [315.103763] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2 <7> [315.105706] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1] <7> [315.106169] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:134:pipe B] <7> [315.126370] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [315.127040] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [315.127629] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02 <7> [315.391237] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [315.391757] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [315.421575] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [315.422082] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [315.422588] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02 <7> [317.653446] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD off <7> [317.653917] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067 <6> [320.634353] [IGT] kms_flip: finished subtest B-eDP1, FAIL <6> [320.635296] [IGT] kms_flip: starting dynamic subtest C-eDP1 <7> [320.636918] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:229] <7> [320.692767] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:232] <7> [320.773358] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A] <7> [320.773625] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [320.773898] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [320.774378] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B] <7> [320.774509] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.enable (expected yes, found no) <7> [320.774722] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.active (expected yes, found no) <7> [320.774921] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1) <7> [320.775135] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in lane_count (expected 4, found 0) <7> [320.775342] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in dp_m_n (expected tu 64 data 6329869/8388608 link 421991/524288, found tu 0, data 0/0 link 0/0) <7> [320.775535] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000) <7> [320.775721] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0) <7> [320.775904] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0) <7> [320.776084] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0) <7> [320.776296] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0) <7> [320.776465] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0) <7> [320.776627] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0) <7> [320.776809] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0) <7> [320.776982] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0) <7> [320.777147] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0) <7> [320.777303] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0) <7> [320.777478] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0) <7> [320.777641] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0) <7> [320.777806] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0) <7> [320.777959] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0) <7> [320.778100] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0) <7> [320.778278] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0) <7> [320.778412] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0) <7> [320.778546] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0) <7> [320.778698] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0) <7> [320.778845] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0) <7> [320.778974] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0) <7> [320.779101] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0) <7> [320.779256] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0) <7> [320.779379] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0) <7> [320.779500] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0) <7> [320.779622] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0) <7> [320.779737] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0) <7> [320.779851] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0) <7> [320.779968] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in pipe_bpp (expected 30, found 0) <7> [320.780083] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0) <7> [320.780215] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0) <7> [320.780327] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:134:pipe B] fastset requirement not met in port_clock (expected 432000, found 0) <7> [320.780437] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:134:pipe B] fastset requirement not met, forcing full modeset <7> [320.780595] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no <7> [320.780716] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:134:pipe B] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x2 -> 0x0 <7> [320.780884] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:84:plane 1B] ddb ( 0 - 4054) -> ( 0 - 0), size 4054 -> 0 <7> [320.780986] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:129:cursor B] ddb (4054 - 4096) -> ( 0 - 0), size 42 -> 0 <7> [320.781078] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [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> [320.781188] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:84:plane 1B] lines 2, 12, 12, 12, 11, 12, 0, 0, 0, 3, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [320.781277] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:84:plane 1B] blocks 49, 289, 289, 289, 265, 289, 0, 0, 63, 73, 87 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [320.781361] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:84:plane 1B] min_ddb 55, 319, 319, 319, 293, 319, 0, 0, 64, 82, 88 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [320.781446] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:134:pipe B] data rate 0 num active planes 0 <7> [320.781560] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400 <7> [320.781671] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400 <7> [320.781777] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400 <7> [320.781880] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400 <7> [320.781980] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0 <7> [320.782084] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing <7> [320.782193] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz <7> [320.782304] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0 <7> [320.782442] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:134:pipe B] enable: no [modeset] <7> [320.782555] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:84:plane 1B] fb: [NOFB], visible: no <7> [320.782652] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:93:plane 2B] fb: [NOFB], visible: no <7> [320.782747] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:102:plane 3B] fb: [NOFB], visible: no <7> [320.782839] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:111:plane 4B] fb: [NOFB], visible: no <7> [320.782930] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:120:plane 5B] fb: [NOFB], visible: no <7> [320.783021] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:129:cursor B] fb: [NOFB], visible: no <7> [320.783163] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2 <7> [320.783386] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD on <7> [320.783506] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006f <7> [320.800249] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]] <7> [321.006563] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 0 <7> [321.006944] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe B <7> [321.017055] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turn panel power off <7> [321.017401] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 wait for panel power off time <7> [321.017782] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [321.018073] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [321.018423] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060 <7> [321.069980] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [321.070240] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [321.087233] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [321.087648] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A <7> [321.087606] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [321.088009] xe 0000:00:02.0: [drm:__intel_fbc_disable [xe]] Disabling FBC on [PLANE:84:plane 1B] <7> [321.088182] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [321.088556] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A] <7> [321.088783] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1] <7> [321.088991] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A] <7> [321.089209] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B] <7> [321.089424] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C] <7> [321.089679] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2] <7> [321.089886] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A] <7> [321.090130] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B] <7> [321.090359] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C] <7> [321.090562] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3] <7> [321.090738] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A] <7> [321.090911] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B] <7> [321.091081] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C] <7> [321.091343] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1] <7> [321.091575] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [321.091778] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: ) <7> [321.091975] xe 0000:00:02.0: [drm:intel_set_cdclk [xe]] Post changing CDCLK to 153600 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0 <7> [321.092262] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [321.092494] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384 <7> [321.092749] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1 <7> [321.093110] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_B <7> [321.093484] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_2 <7> [321.093840] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:134:pipe B] <7> [321.094171] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:186:pipe C] <7> [321.094524] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:186:pipe C] <7> [321.094588] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:189:eDP-1] <7> [321.094764] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:189:eDP-1] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36) <7> [321.095062] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:188:DDI A/PHY A][CRTC:186:pipe C] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 max link_bpp 30.0000 <7> [321.095321] xe 0000:00:02.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 432000 bpp input 30 compressed 0.0000 link rate required 1303913 available 1728000 <7> [321.095558] xe 0000:00:02.0: [drm:intel_psr_compute_config [xe]] PSR2 not supported in transcoder C <7> [321.095753] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:186:pipe C] hw max bpp: 30, pipe bpp: 30, dithering: 0 <7> [321.095984] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:188:DDI A/PHY A] [CRTC:186:pipe C] <7> [321.096213] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.enable (expected no, found yes) <7> [321.096498] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.active (expected no, found yes) <7> [321.096735] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in cpu_transcoder (expected -1, found 2) <7> [321.096970] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in lane_count (expected 0, found 4) <7> [321.097193] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6329869/8388608 link 421991/524288) <7> [321.097451] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100) <7> [321.097677] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in framestart_delay (expected 0, found 1) <7> [321.097900] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880) <7> [321.098137] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040) <7> [321.098397] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880) <7> [321.098671] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040) <7> [321.098898] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928) <7> [321.099121] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960) <7> [321.099367] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800) <7> [321.099592] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800) <7> [321.099807] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803) <7> [321.100022] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809) <7> [321.100234] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906) <7> [321.100475] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906) <7> [321.100721] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880) <7> [321.100926] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040) <7> [321.101121] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880) <7> [321.101313] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040) <7> [321.101534] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928) <7> [321.101737] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960) <7> [321.101903] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800) <7> [321.102071] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800) <7> [321.102240] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803) <7> [321.102454] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809) <7> [321.102625] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906) <7> [321.102780] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906) <7> [321.102950] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in pixel_multiplier (expected 0, found 1) <7> [321.103105] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2) <7> [321.103251] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8) <7> [321.103413] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in pipe_bpp (expected 0, found 30) <7> [321.103552] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710) <7> [321.103688] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710) <7> [321.103818] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in port_clock (expected 0, found 432000) <7> [321.103950] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:186:pipe C] fastset requirement not met, forcing full modeset <7> [321.106538] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xd (total dbuf slices 0xf), mbus joined? no->no <7> [321.106666] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:186:pipe C] dbuf slices 0x0 -> 0xc, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x4 <7> [321.106827] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:136:plane 1C] ddb ( 0 - 0) -> ( 0 - 2006), size 0 -> 2006 <7> [321.106918] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:181:cursor C] ddb ( 0 - 0) -> (2006 - 2048), size 0 -> 42 <7> [321.106996] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:136:plane 1C] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> wm0,wm1,wm2,wm3,wm4,wm5, wm6, wm7,twm,swm,stwm <7> [321.107071] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:136:plane 1C] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 2, 12, 12, 12, 11, 12, 0, 0, 0, 3, 0 <7> [321.107146] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:136:plane 1C] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 49, 289, 289, 289, 265, 289, 0, 0, 63, 73, 87 <7> [321.107226] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:136:plane 1C] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 55, 319, 319, 319, 293, 319, 0, 0, 64, 82, 88 <7> [321.107308] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:186:pipe C] data rate 1390840 num active planes 1 <7> [321.107447] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400 <7> [321.107545] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400 <7> [321.107638] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400 <7> [321.107727] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400 <7> [321.107814] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461 <7> [321.107918] xe 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [xe]] [PLANE:136:plane 1C] min cdclk (173855 kHz) > [CRTC:186:pipe C] min cdclk (0 kHz) <7> [321.108016] xe 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [xe]] new bandwidth min cdclk (27165 kHz) > old min cdclk (0 kHz) <7> [321.108105] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing <7> [321.108188] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz <7> [321.108266] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0 <7> [321.108367] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:186:pipe C] enable: yes [modeset] <7> [321.108449] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB <7> [321.108532] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: C, pipe bpp: 30, dithering: 0 <7> [321.108609] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid> <7> [321.108682] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7> [321.108754] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0 <7> [321.108824] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0 <7> [321.108893] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 6329869, data_n: 8388608, link_m: 421991, link_n: 524288, tu: 64 <7> [321.108962] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0 <7> [321.109028] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled <7> [321.109095] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled <7> [321.109161] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: disabled, panel replay: disabled, selective fetch: disabled <7> [321.109227] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0 <7> [321.109291] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4 <7> [321.109354] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 2, length 8 <7> [321.109430] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB <7> [321.109504] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB <7> [321.109566] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0 <7> [321.109624] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range <7> [321.109682] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined <7> [321.109739] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1 <7> [321.109796] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0 <7> [321.109852] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, vmin: 1906, vmax: 2859, flipline: 1906, pipeline full: 0, guardband: 106 vsync start: 103, vsync end: 97 <7> [321.109909] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1800, vmax vblank: 2753, vmin vtotal: 1906, vmax vtotal: 2859 <7> [321.109966] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] requested mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa <7> [321.110024] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa <7> [321.110081] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa <7> [321.110138] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x40 0xa <7> [321.110195] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa <7> [321.110252] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710 <7> [321.110308] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0 <7> [321.110364] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0 <7> [321.110438] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no <7> [321.110495] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [321.110509] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0 <7> [321.110582] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dpll_hw_state: dpll: 0x69780, dpll_md: 0x42110, fp0: 0x1a2, fp1: 0x1000000 <7> [321.110590] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [321.110647] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7> [321.110665] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10 <7> [321.110708] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries <7> [321.110768] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000 <7> [321.110753] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [321.110823] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [321.110879] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [321.110935] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [321.110990] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000 <7> [321.111044] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000 <7> [321.111098] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [321.111153] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [321.111207] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [321.111261] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000 <7> [321.111315] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:136:plane 1C] fb: [FB:229] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes <7> [321.111371] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7> [321.111437] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0 <7> [321.111502] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:145:plane 2C] fb: [NOFB], visible: no <7> [321.111564] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:154:plane 3C] fb: [NOFB], visible: no <7> [321.111623] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:163:plane 4C] fb: [NOFB], visible: no <7> [321.111678] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:172:plane 5C] fb: [NOFB], visible: no <7> [321.111735] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:181:cursor C] fb: [NOFB], visible: no <7> [321.112515] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [321.112921] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [321.113070] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02 <7> [321.113549] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling always-on <7> [321.114691] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling always-on <7> [321.114769] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [321.114846] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [321.114966] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_2 <7> [321.115079] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_C <7> [321.115196] xe 0000:00:02.0: [drm:intel_set_cdclk [xe]] Pre changing CDCLK to 192000 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0 <7> [321.115267] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [321.115344] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480 <7> [321.115407] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A] <7> [321.115474] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1] <7> [321.115538] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A] <7> [321.115602] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B] <7> [321.115656] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C] <7> [321.115707] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2] <7> [321.115758] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A] <7> [321.115811] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B] <7> [321.115863] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C] <7> [321.115913] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3] <7> [321.115964] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A] <7> [321.116013] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B] <7> [321.116062] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C] <7> [321.116110] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xd <7> [321.116252] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [321.116316] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A <7> [321.117540] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turn panel power on <7> [321.117631] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 wait for panel power cycle (471 ms remaining) <7> [321.596308] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060 <7> [321.741551] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [321.741845] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 wait for panel power on <7> [321.742088] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063 <7> [321.778712] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [321.778970] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [321.779191] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20 <7> [321.779455] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [321.975490] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [321.977506] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD on <7> [321.977783] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b <7> [321.980772] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX A/DDI A/PHY A: DPCD: 14 1e 44 c1 00 00 01 c0 02 00 02 00 00 0b 80 <7> [321.982022] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Reloading eDP link rates <7> [321.982976] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05 <7> [321.983930] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0 <7> [321.984900] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Using DP training pattern TPS1 <7> [321.985950] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Clock recovery OK <7> [321.986156] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Using DP training pattern TPS4 <7> [321.987637] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful <7> [321.987860] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4 <7> [321.988525] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe C <7> [321.988877] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]] <7> [321.989119] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe C <7> [321.989387] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 4518 <7> [321.990252] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] reserved 10600448 bytes of contiguous stolen space for FBC, limit: 2 <7> [321.990502] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] Enabling FBC on [PLANE:136:plane 1C] <7> [322.005764] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR1 <7> [322.007237] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1] <7> [322.007573] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:186:pipe C] <7> [324.571536] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD off <7> [324.571896] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067 <6> [331.840738] [IGT] kms_flip: finished subtest C-eDP1, FAIL <6> [331.842482] [IGT] kms_flip: finished subtest blocking-wf_vblank, FAIL <7> [331.852796] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:232] from all active usage due to RMFB ioctl <7> [331.852858] xe 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:136:plane 1C] because [FB:232] is removed <7> [331.852951] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:136:plane 1C] ddb ( 0 - 2006) -> ( 0 - 0), size 2006 -> 0 <7> [331.853079] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:136:plane 1C] level wm0,wm1,wm2,wm3,wm4,wm5, wm6, wm7,twm,swm,stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm <7> [331.853152] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:136:plane 1C] lines 2, 12, 12, 12, 11, 12, 0, 0, 0, 3, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [331.853216] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:136:plane 1C] blocks 49, 289, 289, 289, 265, 289, 0, 0, 63, 73, 87 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [331.853279] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:136:plane 1C] min_ddb 55, 319, 319, 319, 293, 319, 0, 0, 64, 82, 88 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [331.853342] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:186:pipe C] data rate 0 num active planes 0 <7> [331.853437] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400 <7> [331.853528] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400 <7> [331.853615] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400 <7> [331.853701] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400 <7> [331.853786] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0 <7> [331.854161] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR1 <7> [331.864149] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD on <7> [331.864358] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006f <7> [331.876348] xe 0000:00:02.0: [drm:__intel_fbc_disable [xe]] Disabling FBC on [PLANE:136:plane 1C] <7> [331.908297] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:189:eDP-1] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36) <7> [331.908439] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:188:DDI A/PHY A][CRTC:82:pipe A] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 max link_bpp 30.0000 <7> [331.908534] xe 0000:00:02.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 432000 bpp input 30 compressed 0.0000 link rate required 1303913 available 1728000 <7> [331.908628] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:82:pipe A] hw max bpp: 30, pipe bpp: 30, dithering: 0 <7> [331.908731] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:188:DDI A/PHY A] [CRTC:82:pipe A] <7> [331.908826] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.enable (expected no, found yes) <7> [331.908916] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.active (expected no, found yes) <7> [331.909003] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0) <7> [331.909109] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in lane_count (expected 0, found 4) <7> [331.909195] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6329869/8388608 link 421991/524288) <7> [331.909280] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100) <7> [331.909366] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1) <7> [331.909451] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880) <7> [331.909536] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040) <7> [331.909620] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880) <7> [331.909703] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040) <7> [331.909786] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928) <7> [331.909869] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960) <7> [331.909953] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800) <7> [331.910037] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800) <7> [331.910142] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803) <7> [331.910227] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809) <7> [331.910310] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906) <7> [331.910393] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906) <7> [331.910476] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880) <7> [331.910559] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040) <7> [331.910642] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880) <7> [331.910725] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040) <7> [331.910808] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928) <7> [331.910890] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960) <7> [331.910973] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800) <7> [331.911056] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800) <7> [331.911145] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803) <7> [331.911228] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809) <7> [331.911312] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906) <7> [331.911394] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906) <7> [331.911477] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1) <7> [331.911560] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2) <7> [331.911643] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8) <7> [331.911727] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 30) <7> [331.911810] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710) <7> [331.911893] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710) <7> [331.911976] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in port_clock (expected 0, found 432000) <7> [331.912060] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset <7> [331.912148] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.enable (expected yes, found no) <7> [331.912232] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.active (expected yes, found no) <7> [331.912316] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in cpu_transcoder (expected 2, found -1) <7> [331.912399] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in lane_count (expected 4, found 0) <7> [331.912482] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in dp_m_n (expected tu 64 data 6329869/8388608 link 421991/524288, found tu 0, data 0/0 link 0/0) <7> [331.912566] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000) <7> [331.912650] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in framestart_delay (expected 1, found 0) <7> [331.912733] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0) <7> [331.912816] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0) <7> [331.912899] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0) <7> [331.912982] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0) <7> [331.913065] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0) <7> [331.913157] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0) <7> [331.913243] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0) <7> [331.913329] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0) <7> [331.913414] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0) <7> [331.913497] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0) <7> [331.913580] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0) <7> [331.913663] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0) <7> [331.913747] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0) <7> [331.913832] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0) <7> [331.913915] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0) <7> [331.913998] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0) <7> [331.914082] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0) <7> [331.914175] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0) <7> [331.914260] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0) <7> [331.914344] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0) <7> [331.914428] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0) <7> [331.914510] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0) <7> [331.914594] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0) <7> [331.914676] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0) <7> [331.914759] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in pixel_multiplier (expected 1, found 0) <7> [331.914843] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0) <7> [331.914928] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0) <7> [331.915011] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in pipe_bpp (expected 30, found 0) <7> [331.915102] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0) <7> [331.915188] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0) <7> [331.915272] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:186:pipe C] fastset requirement not met in port_clock (expected 432000, found 0) <7> [331.915358] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:186:pipe C] fastset requirement not met, forcing full modeset <7> [331.915543] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xd -> 0xf (total dbuf slices 0xf), mbus joined? no->yes <7> [331.915624] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:82:pipe A] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x4 -> 0x1 <7> [331.915693] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:186:pipe C] dbuf slices 0xc -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x4 -> 0x1 <7> [331.915790] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] ddb ( 0 - 0) -> ( 0 - 4054), size 0 -> 4054 <7> [331.915856] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:77:cursor A] ddb ( 0 - 0) -> (4054 - 4096), size 0 -> 42 <7> [331.915917] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [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> [331.915979] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 2, 12, 12, 12, 11, 12, 0, 0, 0, 3, 0 <7> [331.916040] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 49, 289, 289, 289, 265, 289, 0, 0, 63, 73, 87 <7> [331.916297] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 55, 319, 319, 319, 293, 319, 0, 0, 64, 82, 88 <7> [331.916365] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:181:cursor C] ddb (2006 - 2048) -> ( 0 - 0), size 42 -> 0 <7> [331.916426] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:82:pipe A] data rate 1390840 num active planes 1 <7> [331.916526] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400 <7> [331.916618] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400 <7> [331.916703] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400 <7> [331.916786] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400 <7> [331.916870] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461 <7> [331.916953] xe 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [xe]] [PLANE:32:plane 1A] min cdclk (173855 kHz) > [CRTC:82:pipe A] min cdclk (0 kHz) <7> [331.917050] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz <7> [331.917153] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0 <7> [331.917295] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:82:pipe A] enable: yes [modeset] <7> [331.917395] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB <7> [331.917488] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 30, dithering: 0 <7> [331.917575] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid> <7> [331.917660] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7> [331.917745] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0 <7> [331.917829] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0 <7> [331.917913] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 6329869, data_n: 8388608, link_m: 421991, link_n: 524288, tu: 64 <7> [331.917999] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0 <7> [331.918185] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled <7> [331.918280] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled <7> [331.918367] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled <7> [331.918451] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0 <7> [331.918535] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4 <7> [331.918621] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14 <7> [331.918708] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB <7> [331.918793] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB <7> [331.918876] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0 <7> [331.918958] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range <7> [331.919043] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined <7> [331.919138] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1 <7> [331.919227] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0 <7> [331.919314] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, vmin: 1906, vmax: 2859, flipline: 1906, pipeline full: 0, guardband: 106 vsync start: 103, vsync end: 97 <7> [331.919399] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1800, vmax vblank: 2753, vmin vtotal: 1906, vmax vtotal: 2859 <7> [331.919483] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] requested mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa <7> [331.919568] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa <7> [331.919653] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa <7> [331.919738] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x40 0xa <7> [331.919826] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa <7> [331.919909] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710 <7> [331.919993] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0 <7> [331.920076] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0 <7> [331.920167] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no <7> [331.920255] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0 <7> [331.920341] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dpll_hw_state: dpll: 0x69780, dpll_md: 0x42110, fp0: 0x1a2, fp1: 0x1000000 <7> [331.920427] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7> [331.920509] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries <7> [331.920592] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000 <7> [331.920675] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [331.920758] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [331.920841] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [331.920924] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000 <7> [331.921007] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000 <7> [331.921097] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [331.921183] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [331.921268] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [331.921353] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000 <7> [331.921438] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:32:plane 1A] fb: [FB:190] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes <7> [331.921524] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7> [331.921608] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0 <7> [331.921692] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:41:plane 2A] fb: [NOFB], visible: no <7> [331.921776] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:50:plane 3A] fb: [NOFB], visible: no <7> [331.921858] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:59:plane 4A] fb: [NOFB], visible: no <7> [331.921943] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:68:plane 5A] fb: [NOFB], visible: no <7> [331.922027] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:77:cursor A] fb: [NOFB], visible: no <7> [331.922118] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:186:pipe C] enable: no [modeset] <7> [331.922205] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:136:plane 1C] fb: [NOFB], visible: no <7> [331.922290] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:145:plane 2C] fb: [NOFB], visible: no <7> [331.922377] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:154:plane 3C] fb: [NOFB], visible: no <7> [331.922464] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:163:plane 4C] fb: [NOFB], visible: no <7> [331.922549] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:172:plane 5C] fb: [NOFB], visible: no <7> [331.922633] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:181:cursor C] fb: [NOFB], visible: no <7> [331.922839] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_A <7> [331.923199] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]] <7> [332.129254] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 0 <7> [332.129886] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe C <7> [332.151109] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turn panel power off <7> [332.151500] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 wait for panel power off time <7> [332.151562] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [332.151840] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060 <7> [332.151983] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [332.204157] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [332.204405] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [332.224285] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [332.225976] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [332.226104] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A <7> [332.226675] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A] <7> [332.226684] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [332.227026] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1] <7> [332.227381] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A] <7> [332.227710] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B] <7> [332.228026] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C] <7> [332.228364] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2] <7> [332.228683] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A] <7> [332.228996] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B] <7> [332.229329] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C] <7> [332.229645] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3] <7> [332.229960] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A] <7> [332.230292] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B] <7> [332.230607] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C] <7> [332.230970] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf <7> [332.231530] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: ) <7> [332.231863] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes) <7> [332.232208] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A <7> [332.233926] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turn panel power on <7> [332.234250] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 wait for panel power cycle (491 ms remaining) <7> [332.244203] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [332.244485] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [332.244709] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10 <7> [332.244978] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [332.729495] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060 <7> [332.793593] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [332.793872] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 wait for panel power on <7> [332.794149] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063 <7> [332.830728] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [332.830997] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [332.831210] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20 <7> [332.831481] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [333.106014] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [333.108179] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD on <7> [333.108512] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b <7> [333.112239] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX A/DDI A/PHY A: DPCD: 14 1e 44 c1 00 00 01 c0 02 00 02 00 00 0b 80 <7> [333.113702] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Reloading eDP link rates <7> [333.114908] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05 <7> [333.116110] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0 <7> [333.117360] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Using DP training pattern TPS1 <7> [333.118966] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Clock recovery OK <7> [333.119347] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Using DP training pattern TPS4 <7> [333.121284] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful <7> [333.121700] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:189:eDP-1][ENCODER:188:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4 <7> [333.122507] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe A <7> [333.123115] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]] <7> [333.123506] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe A <7> [333.123994] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 4518 <7> [333.125403] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] reserved 11059200 bytes of contiguous stolen space for FBC, limit: 2 <7> [333.125785] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] Enabling FBC on [PLANE:32:plane 1A] <7> [333.139998] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2 <7> [333.141845] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1] <7> [333.142301] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:82:pipe A] <7> [333.144853] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_C <7> [333.145427] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_2 <7> [333.146024] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:186:pipe C] <7> [333.147262] xe 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6> [333.148768] [IGT] kms_flip: exiting, ret=98 <7> [333.163615] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [333.163755] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [333.163852] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02

Created at 2025-02-17 10:40:00