Hardware List

Results for igt@kms_flip@blocking-wf_vblank

Machine description: shard-lnl-2

Result: Fail

i915_display_info23 igt_runner23 results23.json results23-xe-load.json i915_display_info_post_exec23 boot23 dmesg23

Detail	Value
Duration	26.99 seconds
Hostname	shard-lnl-2
Igt-Version	IGT-Version: 1.30-ge9d9934c7 (x86_64) (Linux: 6.13.0-rc3-xe+ x86_64)
Out	Using IGT_SRANDOM=1734590884 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 17072.9us +- 2.144us accuracy 0.04% vblank interval differs from modeline! expected 16664.0us, measured 17073us +- 2.144us, difference 408.9us (190.8 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 (6.431s) Starting dynamic subtest: B-eDP1 2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa Expected frametime: 16664us; measured 16852.2us +- 2.228us accuracy 0.04% vblank interval differs from modeline! expected 16664.0us, measured 16852us +- 2.228us, difference 188.2us (84.5 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 (8.917s) Starting dynamic subtest: C-eDP1 2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa Expected frametime: 16664us; measured 16726.6us +- 3.862us accuracy 0.07% vblank interval differs from modeline! expected 16664.0us, measured 16727us +- 3.862us, difference 62.6us (16.2 sigma) Dynamic subtest C-eDP1: SUCCESS (11.638s) Subtest blocking-wf_vblank: FAIL (26.992s)
Err	Starting subtest: blocking-wf_vblank Starting dynamic subtest: A-eDP1 (kms_flip:5358) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674: (kms_flip:5358) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon) Dynamic subtest A-eDP1 failed. ** DEBUG (kms_flip:5358) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=2880, height=1800, format=XR24(0x34325258), modifier=0x0, size=0) (kms_flip:5358) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=11520) (kms_flip:5358) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd) (kms_flip:5358) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=2880, height=1800, format=XR24(0x34325258), modifier=0x0, size=0) (kms_flip:5358) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=11520) (kms_flip:5358) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd) (kms_flip:5358) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:5358) intel_allocator_simple-DEBUG: <ial: 0x585432be5fc0, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:5358) intel_allocator_simple-DEBUG: <ial: 0x585432be5fc0, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:5358) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:5358) intel_allocator_simple-DEBUG: <ial: 0x585432bf1fa0, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:5358) intel_allocator_simple-DEBUG: <ial: 0x585432bf1fa0, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:5358) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:5358) intel_allocator_simple-DEBUG: <ial: 0x585432bf6240, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:5358) intel_allocator_simple-DEBUG: <ial: 0x585432bf6240, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:5358) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:5358) intel_allocator_simple-DEBUG: <ial: 0x585432bf6240, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:5358) intel_allocator_simple-DEBUG: <ial: 0x585432bf6240, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:5358) igt_kms-INFO: 2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa (kms_flip:5358) DEBUG: No stale events found (kms_flip:5358) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0 (kms_flip:5358) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0 (kms_flip:5358) INFO: Expected frametime: 16664us; measured 17072.9us +- 2.144us accuracy 0.04% (kms_flip:5358) INFO: vblank interval differs from modeline! expected 16664.0us, measured 17073us +- 2.144us, difference 408.9us (190.8 sigma) (kms_flip:5358) DEBUG: name = vblank last_ts = 0.000000 last_received_ts = 0.000000 last_seq = 0 current_ts = 251.564636 current_received_ts = 251.564102 current_seq = 1438 count = 0 seq_step = 10 (kms_flip:5358) DEBUG: name = vblank last_ts = 251.564636 last_received_ts = 251.564102 last_seq = 1438 current_ts = 251.735352 current_received_ts = 251.734833 current_seq = 1448 count = 1 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 251.564636/1438, current 251.735352/1448: elapsed=170727.0us expected=170729.4us +- 853.6us, error 0.0% (kms_flip:5358) DEBUG: name = vblank last_ts = 251.735352 last_received_ts = 251.734833 last_seq = 1448 current_ts = 251.906082 current_received_ts = 251.905594 current_seq = 1458 count = 2 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 251.735352/1448, current 251.906082/1458: elapsed=170721.0us expected=170729.4us +- 853.6us, error 0.0% (kms_flip:5358) DEBUG: name = vblank last_ts = 251.906082 last_received_ts = 251.905594 last_seq = 1458 current_ts = 252.076767 current_received_ts = 252.076248 current_seq = 1468 count = 3 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 251.906082/1458, current 252.076767/1468: elapsed=170683.0us expected=170729.4us +- 853.6us, error 0.0% (kms_flip:5358) DEBUG: name = vblank last_ts = 252.076767 last_received_ts = 252.076248 last_seq = 1468 current_ts = 252.246994 current_received_ts = 252.246506 current_seq = 1478 count = 4 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 252.076767/1468, current 252.246994/1478: elapsed=170227.0us expected=170729.4us +- 853.6us, error 0.3% (kms_flip:5358) DEBUG: name = vblank last_ts = 252.246994 last_received_ts = 252.246506 last_seq = 1478 current_ts = 252.417206 current_received_ts = 252.416718 current_seq = 1488 count = 5 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 252.246994/1478, current 252.417206/1488: elapsed=170221.0us expected=170729.4us +- 853.6us, error 0.3% (kms_flip:5358) DEBUG: name = vblank last_ts = 252.417206 last_received_ts = 252.416718 last_seq = 1488 current_ts = 252.587448 current_received_ts = 252.586945 current_seq = 1498 count = 6 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 252.417206/1488, current 252.587448/1498: elapsed=170231.0us expected=170729.4us +- 853.6us, error 0.3% (kms_flip:5358) DEBUG: name = vblank last_ts = 252.587448 last_received_ts = 252.586945 last_seq = 1498 current_ts = 252.757675 current_received_ts = 252.757172 current_seq = 1508 count = 7 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 252.587448/1498, current 252.757675/1508: elapsed=170226.0us expected=170729.4us +- 853.6us, error 0.3% (kms_flip:5358) DEBUG: name = vblank last_ts = 252.757675 last_received_ts = 252.757172 last_seq = 1508 current_ts = 252.927887 current_received_ts = 252.927429 current_seq = 1518 count = 8 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 252.757675/1508, current 252.927887/1518: elapsed=170225.0us expected=170729.4us +- 853.6us, error 0.3% (kms_flip:5358) DEBUG: name = vblank last_ts = 252.927887 last_received_ts = 252.927429 last_seq = 1518 current_ts = 253.097992 current_received_ts = 253.097488 current_seq = 1528 count = 9 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 252.927887/1518, current 253.097992/1528: elapsed=170094.0us expected=170729.4us +- 853.6us, error 0.4% (kms_flip:5358) DEBUG: name = vblank last_ts = 253.097992 last_received_ts = 253.097488 last_seq = 1528 current_ts = 253.267776 current_received_ts = 253.267334 current_seq = 1538 count = 10 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 253.097992/1528, current 253.267776/1538: elapsed=169788.0us expected=170729.4us +- 853.6us, error 0.6% (kms_flip:5358) DEBUG: inconsistent vblank ts/seq: last 253.097992/1528, current 253.267776/1538: elapsed=169788.0us expected=170729.4us (kms_flip:5358) DEBUG: expected 236751, counted 100, encoder type 2 (kms_flip:5358) DEBUG: dropped frames, expected 236751, counted 100, encoder type 2 (kms_flip:5358) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674: (kms_flip:5358) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon) (kms_flip:5358) igt_core-INFO: Stack trace: (kms_flip:5358) igt_core-INFO: #0 ../lib/igt_core.c:2051 __igt_fail_assert() (kms_flip:5358) igt_core-INFO: #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0() (kms_flip:5358) igt_core-INFO: #2 ../tests/kms_flip.c:1845 run_test() (kms_flip:5358) igt_core-INFO: #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001() (kms_flip:5358) igt_core-INFO: #4 ../tests/kms_flip.c:2001 main() (kms_flip:5358) igt_core-INFO: #5 [__libc_init_first+0x8a] (kms_flip:5358) igt_core-INFO: #6 [__libc_start_main+0x8b] (kms_flip:5358) igt_core-INFO: #7 [_start+0x25] END Dynamic subtest A-eDP1: FAIL (6.431s) Starting dynamic subtest: B-eDP1 (kms_flip:5358) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674: (kms_flip:5358) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon) Dynamic subtest B-eDP1 failed. DEBUG (kms_flip:5358) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=2880, height=1800, format=XR24(0x34325258), modifier=0x0, size=0) (kms_flip:5358) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=3, pitch=11520) (kms_flip:5358) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd) (kms_flip:5358) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=2880, height=1800, format=XR24(0x34325258), modifier=0x0, size=0) (kms_flip:5358) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=4, pitch=11520) (kms_flip:5358) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd) (kms_flip:5358) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:5358) intel_allocator_simple-DEBUG: <ial: 0x585432c4e270, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:5358) intel_allocator_simple-DEBUG: <ial: 0x585432c4e270, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:5358) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:5358) intel_allocator_simple-DEBUG: <ial: 0x585432c4e270, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:5358) intel_allocator_simple-DEBUG: <ial: 0x585432c4e270, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:5358) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:5358) intel_allocator_simple-DEBUG: <ial: 0x585432c4e270, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:5358) intel_allocator_simple-DEBUG: <ial: 0x585432c4e270, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:5358) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:5358) intel_allocator_simple-DEBUG: <ial: 0x585432c4e270, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:5358) intel_allocator_simple-DEBUG: <ial: 0x585432c4e270, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:5358) igt_kms-INFO: 2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa (kms_flip:5358) DEBUG: No stale events found (kms_flip:5358) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0 (kms_flip:5358) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0 (kms_flip:5358) INFO: Expected frametime: 16664us; measured 16852.2us +- 2.228us accuracy 0.04% (kms_flip:5358) INFO: vblank interval differs from modeline! expected 16664.0us, measured 16852us +- 2.228us, difference 188.2us (84.5 sigma) (kms_flip:5358) DEBUG: name = vblank last_ts = 0.000000 last_received_ts = 0.000000 last_seq = 0 current_ts = 258.075470 current_received_ts = 258.074890 current_seq = 555 count = 0 seq_step = 10 (kms_flip:5358) DEBUG: name = vblank last_ts = 258.075470 last_received_ts = 258.074890 last_seq = 555 current_ts = 258.243774 current_received_ts = 258.243256 current_seq = 565 count = 1 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 258.075470/555, current 258.243774/565: elapsed=168297.0us expected=168521.9us +- 842.6us, error 0.1% (kms_flip:5358) DEBUG: name = vblank last_ts = 258.243774 last_received_ts = 258.243256 last_seq = 565 current_ts = 258.412048 current_received_ts = 258.411530 current_seq = 575 count = 2 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 258.243774/565, current 258.412048/575: elapsed=168296.0us expected=168521.9us +- 842.6us, error 0.1% (kms_flip:5358) DEBUG: name = vblank last_ts = 258.412048 last_received_ts = 258.411530 last_seq = 575 current_ts = 258.580353 current_received_ts = 258.579834 current_seq = 585 count = 3 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 258.412048/575, current 258.580353/585: elapsed=168294.0us expected=168521.9us +- 842.6us, error 0.1% (kms_flip:5358) DEBUG: name = vblank last_ts = 258.580353 last_received_ts = 258.579834 last_seq = 585 current_ts = 258.748657 current_received_ts = 258.748169 current_seq = 595 count = 4 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 258.580353/585, current 258.748657/595: elapsed=168296.0us expected=168521.9us +- 842.6us, error 0.1% (kms_flip:5358) DEBUG: name = vblank last_ts = 258.748657 last_received_ts = 258.748169 last_seq = 595 current_ts = 258.916931 current_received_ts = 258.916443 current_seq = 605 count = 5 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 258.748657/595, current 258.916931/605: elapsed=168292.0us expected=168521.9us +- 842.6us, error 0.1% (kms_flip:5358) DEBUG: name = vblank last_ts = 258.916931 last_received_ts = 258.916443 last_seq = 605 current_ts = 259.085205 current_received_ts = 259.084656 current_seq = 615 count = 6 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 258.916931/605, current 259.085205/615: elapsed=168261.0us expected=168521.9us +- 842.6us, error 0.2% (kms_flip:5358) DEBUG: name = vblank last_ts = 259.085205 last_received_ts = 259.084656 last_seq = 615 current_ts = 259.253296 current_received_ts = 259.252808 current_seq = 625 count = 7 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 259.085205/615, current 259.253296/625: elapsed=168096.0us expected=168521.9us +- 842.6us, error 0.3% (kms_flip:5358) DEBUG: name = vblank last_ts = 259.253296 last_received_ts = 259.252808 last_seq = 625 current_ts = 259.421387 current_received_ts = 259.420898 current_seq = 635 count = 8 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 259.253296/625, current 259.421387/635: elapsed=168094.0us expected=168521.9us +- 842.6us, error 0.3% (kms_flip:5358) DEBUG: name = vblank last_ts = 259.421387 last_received_ts = 259.420898 last_seq = 635 current_ts = 259.589478 current_received_ts = 259.588867 current_seq = 645 count = 9 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 259.421387/635, current 259.589478/645: elapsed=168100.0us expected=168521.9us +- 842.6us, error 0.3% (kms_flip:5358) DEBUG: name = vblank last_ts = 259.589478 last_received_ts = 259.588867 last_seq = 645 current_ts = 259.757599 current_received_ts = 259.757111 current_seq = 655 count = 10 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 259.589478/645, current 259.757599/655: elapsed=168106.0us expected=168521.9us +- 842.6us, error 0.2% (kms_flip:5358) DEBUG: name = vblank last_ts = 259.757599 last_received_ts = 259.757111 last_seq = 655 current_ts = 259.925690 current_received_ts = 259.925201 current_seq = 665 count = 11 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 259.757599/655, current 259.925690/665: elapsed=168096.0us expected=168521.9us +- 842.6us, error 0.3% (kms_flip:5358) DEBUG: name = vblank last_ts = 259.925690 last_received_ts = 259.925201 last_seq = 665 current_ts = 260.093750 current_received_ts = 260.093262 current_seq = 675 count = 12 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 259.925690/665, current 260.093750/675: elapsed=168061.0us expected=168521.9us +- 842.6us, error 0.3% (kms_flip:5358) DEBUG: name = vblank last_ts = 260.093750 last_received_ts = 260.093262 last_seq = 675 current_ts = 260.261688 current_received_ts = 260.261108 current_seq = 685 count = 13 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 260.093750/675, current 260.261688/685: elapsed=167928.0us expected=168521.9us +- 842.6us, error 0.4% (kms_flip:5358) DEBUG: name = vblank last_ts = 260.261688 last_received_ts = 260.261108 last_seq = 685 current_ts = 260.429596 current_received_ts = 260.429169 current_seq = 695 count = 14 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 260.261688/685, current 260.429596/695: elapsed=167926.0us expected=168521.9us +- 842.6us, error 0.4% (kms_flip:5358) DEBUG: name = vblank last_ts = 260.429596 last_received_ts = 260.429169 last_seq = 695 current_ts = 260.597534 current_received_ts = 260.597076 current_seq = 705 count = 15 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 260.429596/695, current 260.597534/705: elapsed=167931.0us expected=168521.9us +- 842.6us, error 0.4% (kms_flip:5358) DEBUG: name = vblank last_ts = 260.597534 last_received_ts = 260.597076 last_seq = 705 current_ts = 260.765472 current_received_ts = 260.765076 current_seq = 715 count = 16 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 260.597534/705, current 260.765472/715: elapsed=167928.0us expected=168521.9us +- 842.6us, error 0.4% (kms_flip:5358) DEBUG: name = vblank last_ts = 260.765472 last_received_ts = 260.765076 last_seq = 715 current_ts = 260.933411 current_received_ts = 260.932922 current_seq = 725 count = 17 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 260.765472/715, current 260.933411/725: elapsed=167928.0us expected=168521.9us +- 842.6us, error 0.4% (kms_flip:5358) DEBUG: name = vblank last_ts = 260.933411 last_received_ts = 260.932922 last_seq = 725 current_ts = 261.101257 current_received_ts = 261.100830 current_seq = 735 count = 18 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 260.933411/725, current 261.101257/735: elapsed=167876.0us expected=168521.9us +- 842.6us, error 0.4% (kms_flip:5358) DEBUG: name = vblank last_ts = 261.101257 last_received_ts = 261.100830 last_seq = 735 current_ts = 261.269043 current_received_ts = 261.268585 current_seq = 745 count = 19 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 261.101257/735, current 261.269043/745: elapsed=167775.0us expected=168521.9us +- 842.6us, error 0.4% (kms_flip:5358) DEBUG: name = vblank last_ts = 261.269043 last_received_ts = 261.268585 last_seq = 745 current_ts = 261.436829 current_received_ts = 261.436279 current_seq = 755 count = 20 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 261.269043/745, current 261.436829/755: elapsed=167777.0us expected=168521.9us +- 842.6us, error 0.4% (kms_flip:5358) DEBUG: name = vblank last_ts = 261.436829 last_received_ts = 261.436279 last_seq = 755 current_ts = 261.604614 current_received_ts = 261.604156 current_seq = 765 count = 21 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 261.436829/755, current 261.604614/765: elapsed=167782.0us expected=168521.9us +- 842.6us, error 0.4% (kms_flip:5358) DEBUG: name = vblank last_ts = 261.604614 last_received_ts = 261.604156 last_seq = 765 current_ts = 261.772369 current_received_ts = 261.771912 current_seq = 775 count = 22 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 261.604614/765, current 261.772369/775: elapsed=167775.0us expected=168521.9us +- 842.6us, error 0.4% (kms_flip:5358) DEBUG: name = vblank last_ts = 261.772369 last_received_ts = 261.771912 last_seq = 775 current_ts = 261.940155 current_received_ts = 261.939697 current_seq = 785 count = 23 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 261.772369/775, current 261.940155/785: elapsed=167780.0us expected=168521.9us +- 842.6us, error 0.4% (kms_flip:5358) DEBUG: name = vblank last_ts = 261.940155 last_received_ts = 261.939697 last_seq = 785 current_ts = 262.107880 current_received_ts = 262.107422 current_seq = 795 count = 24 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 261.940155/785, current 262.107880/795: elapsed=167731.0us expected=168521.9us +- 842.6us, error 0.5% (kms_flip:5358) DEBUG: name = vblank last_ts = 262.107880 last_received_ts = 262.107422 last_seq = 795 current_ts = 262.275543 current_received_ts = 262.275116 current_seq = 805 count = 25 seq_step = 10 (kms_flip:5358) DEBUG: vblank ts/seq: last 262.107880/795, current 262.275543/805: elapsed=167638.0us expected=168521.9us +- 842.6us, error 0.5% (kms_flip:5358) DEBUG: inconsistent vblank ts/seq: last 262.107880/795, current 262.275543/805: elapsed=167638.0us expected=168521.9us (kms_flip:5358) DEBUG: expected 239852, counted 250, encoder type 2 (kms_flip:5358) DEBUG: dropped frames, expected 239852, counted 250, encoder type 2 (kms_flip:5358) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674: (kms_flip:5358) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon) (kms_flip:5358) igt_core-INFO: Stack trace: (kms_flip:5358) igt_core-INFO: #0 ../lib/igt_core.c:2051 __igt_fail_assert() (kms_flip:5358) igt_core-INFO: #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0() (kms_flip:5358) igt_core-INFO: #2 ../tests/kms_flip.c:1845 run_test() (kms_flip:5358) igt_core-INFO: #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001() (kms_flip:5358) igt_core-INFO: #4 ../tests/kms_flip.c:2001 main() (kms_flip:5358) igt_core-INFO: #5 [__libc_init_first+0x8a] (kms_flip:5358) igt_core-INFO: #6 [__libc_start_main+0x8b] (kms_flip:5358) igt_core-INFO: #7 [_start+0x25] END ** Dynamic subtest B-eDP1: FAIL (8.917s) Starting dynamic subtest: C-eDP1 Dynamic subtest C-eDP1: SUCCESS (11.638s) Subtest blocking-wf_vblank: FAIL (26.992s)
Dmesg	<6> [293.781154] Console: switching to colour dummy device 80x25 <6> [293.781416] [IGT] kms_flip: executing <7> [293.787140] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:198:DP-1] <7> [293.787157] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:198:DP-1] <7> [293.787267] xe 0000:00:02.0: [drm:intel_tc_port_update_mode [xe]] Port D/TC#1: TC port mode reset (disconnected -> tbt-alt) <7> [293.787342] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:198:DP-1] disconnected <7> [293.787578] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:210:DP-2] <7> [293.787586] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:210:DP-2] <7> [293.787700] xe 0000:00:02.0: [drm:intel_tc_port_update_mode [xe]] Port E/TC#2: TC port mode reset (disconnected -> tbt-alt) <7> [293.787789] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:210:DP-2] disconnected <7> [293.788043] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:218:DP-3] <7> [293.788050] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:218:DP-3] <7> [293.788144] xe 0000:00:02.0: [drm:intel_tc_port_update_mode [xe]] Port F/TC#3: TC port mode reset (disconnected -> tbt-alt) <7> [293.788212] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:218:DP-3] disconnected <7> [293.788459] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:189:eDP-1] <7> [293.788466] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:189:eDP-1] <7> [293.789139] 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> [293.789653] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] source rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 675000, 810000 <7> [293.789735] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] sink rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 810000 <7> [293.789850] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] common rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 810000 <7> [293.790041] 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> [293.790052] [drm] DisplayID checksum invalid, remainder is 248 <5> [293.790055] [drm] DisplayID checksum invalid, remainder is 248 <7> [293.790057] 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> [293.790063] [drm] DisplayID checksum invalid, remainder is 248 <7> [293.790067] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:189:eDP-1] ELD monitor <5> [293.790073] [drm] DisplayID checksum invalid, remainder is 248 <7> [293.790076] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:189:eDP-1] ELD size 20, SAD count 0 <5> [293.790083] [drm] DisplayID checksum invalid, remainder is 248 <7> [293.790104] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:189:eDP-1] VRR capable: yes <7> [293.790302] 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> [293.791098] 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> [293.791176] 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> [293.792128] [drm] DisplayID checksum invalid, remainder is 248 <5> [293.792132] [drm] DisplayID checksum invalid, remainder is 248 <5> [293.792134] [drm] DisplayID checksum invalid, remainder is 248 <7> [293.792183] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:189:eDP-1] probed modes: <7> [293.792202] 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> [293.792236] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:198:DP-1] <7> [293.792252] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:198:DP-1] <7> [293.792437] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:198:DP-1] disconnected <7> [293.792468] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:210:DP-2] <7> [293.792483] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:210:DP-2] <7> [293.792677] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:210:DP-2] disconnected <7> [293.792707] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:218:DP-3] <7> [293.792724] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:218:DP-3] <7> [293.792901] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:218:DP-3] disconnected <6> [293.793724] [IGT] kms_flip: starting subtest blocking-wf_vblank <6> [293.795175] [IGT] kms_flip: starting dynamic subtest A-eDP1 <7> [293.795953] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:227] <7> [293.796203] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228] <7> [293.865510] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A] <7> [293.865643] 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> [293.865793] 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> [293.865899] 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> [293.865982] 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> [293.866054] 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> [293.866126] 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> [293.866193] 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> [293.866257] 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> [293.866319] 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> [293.866379] 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> [293.866439] 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> [293.866499] 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> [293.866559] 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> [293.866629] 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> [293.866709] 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> [293.866787] 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> [293.866861] 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> [293.866929] 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> [293.866991] 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> [293.867052] 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> [293.867107] 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> [293.867163] 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> [293.867218] 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> [293.867274] 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> [293.867331] 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> [293.867388] 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> [293.867443] 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> [293.867500] 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> [293.867558] 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> [293.867722] 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> [293.867801] 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> [293.867877] 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> [293.867941] 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> [293.868002] 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> [293.868058] 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> [293.868114] 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> [293.868168] 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> [293.868221] 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> [293.868276] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset <7> [293.868387] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no <7> [293.868443] 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> [293.868531] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] ddb ( 0 - 4054) -> ( 0 - 0), size 4054 -> 0 <7> [293.868587] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:77:cursor A] ddb (4054 - 4096) -> ( 0 - 0), size 42 -> 0 <7> [293.868656] 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> [293.868723] 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> [293.868784] 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> [293.868845] 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> [293.868908] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:82:pipe A] data rate 0 num active planes 0 <7> [293.868974] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400 <7> [293.869035] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400 <7> [293.869093] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400 <7> [293.869151] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400 <7> [293.869208] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0 <7> [293.869266] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing <7> [293.869323] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz <7> [293.869379] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0 <7> [293.869448] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:82:pipe A] enable: no [modeset] <7> [293.869513] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:32:plane 1A] fb: [NOFB], visible: no <7> [293.869581] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:41:plane 2A] fb: [NOFB], visible: no <7> [293.869670] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:50:plane 3A] fb: [NOFB], visible: no <7> [293.869755] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:59:plane 4A] fb: [NOFB], visible: no <7> [293.869829] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:68:plane 5A] fb: [NOFB], visible: no <7> [293.869902] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:77:cursor A] fb: [NOFB], visible: no <7> [293.869992] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [293.870067] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [293.870184] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2 <7> [293.887186] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]] <7> [294.093590] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 0 <7> [294.094037] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe A <7> [294.104069] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turn panel power off <7> [294.104396] 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> [294.104756] 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> [294.156654] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [294.157063] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [294.186654] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [294.187043] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [294.187080] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A <7> [294.187513] xe 0000:00:02.0: [drm:__intel_fbc_disable [xe]] Disabling FBC on [PLANE:32:plane 1A] <7> [294.188103] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A] <7> [294.188388] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1] <7> [294.188675] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A] <7> [294.188958] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B] <7> [294.189195] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C] <7> [294.189430] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2] <7> [294.189693] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A] <7> [294.189972] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B] <7> [294.190191] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C] <7> [294.190410] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3] <7> [294.190656] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A] <7> [294.190903] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B] <7> [294.191116] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C] <7> [294.191328] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1] <7> [294.191638] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [294.191867] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: ) <7> [294.192093] 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> [294.192400] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [294.192716] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post [xe]] aud_ts_cdclk set to M=60, N=384 <7> [294.193013] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1 <7> [294.193415] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_A <7> [294.193884] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:82:pipe A] <7> [294.195296] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [294.195641] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [294.195944] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10 <7> [294.196350] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B] <7> [294.196295] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [294.196824] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:186:pipe C] <7> [294.197154] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A] <7> [294.197237] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:189:eDP-1] <7> [294.197447] 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> [294.197896] 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> [294.198216] 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> [294.198550] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:82:pipe A] hw max bpp: 30, pipe bpp: 30, dithering: 0 <7> [294.198887] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:188:DDI A/PHY A] [CRTC:82:pipe A] <7> [294.199201] 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> [294.199516] 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> [294.199807] 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> [294.200092] 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> [294.200387] 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> [294.200700] 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> [294.201006] 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> [294.201282] 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> [294.201617] 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> [294.201895] 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> [294.202168] 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> [294.202421] 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> [294.202722] 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> [294.202965] 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> [294.203226] 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> [294.203447] 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> [294.203718] 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> [294.203925] 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> [294.204147] 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> [294.204345] 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> [294.204555] 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> [294.204744] 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> [294.204929] 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> [294.205108] 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> [294.205287] 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> [294.205467] 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> [294.205643] 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> [294.205801] 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> [294.205950] 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> [294.206100] 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> [294.206273] 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> [294.206436] 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> [294.206605] 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> [294.206750] 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> [294.206886] 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> [294.207019] 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> [294.207147] 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> [294.207273] 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> [294.207414] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset <7> [294.207661] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes <7> [294.207804] 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> [294.207978] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] ddb ( 0 - 0) -> ( 0 - 4054), size 0 -> 4054 <7> [294.208088] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:77:cursor A] ddb ( 0 - 0) -> (4054 - 4096), size 0 -> 42 <7> [294.208190] 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> [294.208288] 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> [294.208382] 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> [294.208492] 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> [294.208583] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:82:pipe A] data rate 1390840 num active planes 1 <7> [294.208704] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400 <7> [294.208820] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400 <7> [294.208930] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400 <7> [294.209041] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400 <7> [294.209146] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461 <7> [294.209250] 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> [294.209359] xe 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [xe]] new bandwidth min cdclk (27165 kHz) > old min cdclk (0 kHz) <7> [294.209499] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing <7> [294.209595] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz <7> [294.209688] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0 <7> [294.209798] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:82:pipe A] enable: yes [modeset] <7> [294.209905] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB <7> [294.210012] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 30, dithering: 0 <7> [294.210117] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid> <7> [294.210205] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7> [294.210289] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0 <7> [294.210372] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0 <7> [294.210451] 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> [294.210549] 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> [294.210628] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled <7> [294.210704] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled <7> [294.210779] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled <7> [294.210851] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0 <7> [294.210921] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4 <7> [294.210990] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14 <7> [294.211058] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB <7> [294.211125] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB <7> [294.211191] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0 <7> [294.211256] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range <7> [294.211320] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined <7> [294.211383] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, vmin: 1905, vmax: 2859, pipeline full: 0, guardband: 106 flipline: 1906, vmin vblank: 1800, vmax vblank: 2753 <7> [294.211445] 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> [294.211527] 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> [294.211597] 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> [294.211666] 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> [294.211735] 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> [294.211798] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710 <7> [294.211857] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0 <7> [294.211915] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0 <7> [294.211973] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no <7> [294.212032] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0 <7> [294.212088] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dpll_hw_state: dpll: 0x69780, dpll_md: 0x42110, fp0: 0x1a2, fp1: 0x1000000 <7> [294.212145] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7> [294.212200] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries <7> [294.212255] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000 <7> [294.212308] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [294.212362] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [294.212415] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [294.212469] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000 <7> [294.212534] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000 <7> [294.212601] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [294.212668] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [294.212735] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [294.212793] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000 <7> [294.212845] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:32:plane 1A] fb: [FB:227] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes <7> [294.212899] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7> [294.212953] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0 <7> [294.213007] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:41:plane 2A] fb: [NOFB], visible: no <7> [294.213060] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:50:plane 3A] fb: [NOFB], visible: no <7> [294.213112] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:59:plane 4A] fb: [NOFB], visible: no <7> [294.213165] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:68:plane 5A] fb: [NOFB], visible: no <7> [294.213217] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:77:cursor A] fb: [NOFB], visible: no <7> [294.215515] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [294.215873] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [294.215997] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02 <7> [294.216085] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [294.216155] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [294.216263] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_A <7> [294.216386] 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> [294.216462] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [294.216552] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post [xe]] aud_ts_cdclk set to M=60, N=480 <7> [294.216631] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A] <7> [294.216701] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1] <7> [294.216767] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A] <7> [294.216823] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B] <7> [294.216874] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C] <7> [294.216925] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2] <7> [294.216973] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A] <7> [294.217021] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B] <7> [294.217068] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C] <7> [294.217115] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3] <7> [294.217161] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A] <7> [294.217206] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B] <7> [294.217251] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C] <7> [294.217296] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf <7> [294.217432] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: ) <7> [294.217498] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes) <7> [294.217574] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A <7> [294.218578] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turn panel power on <7> [294.218673] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 wait for panel power cycle (469 ms remaining) <7> [294.693458] 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> [294.734708] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [294.735099] 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> [294.735520] 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> [294.771195] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [294.771680] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [294.772073] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20 <7> [294.772472] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [294.797430] xe 0000:00:02.0: [drm:intel_tc_port_update_mode [xe]] Port F/TC#3: TC port mode reset (tbt-alt -> disconnected) <7> [294.797537] xe 0000:00:02.0: [drm:intel_tc_port_update_mode [xe]] Port E/TC#2: TC port mode reset (tbt-alt -> disconnected) <7> [294.797674] xe 0000:00:02.0: [drm:intel_tc_port_update_mode [xe]] Port D/TC#1: TC port mode reset (tbt-alt -> disconnected) <7> [295.063962] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [295.066167] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD on <7> [295.066539] 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> [295.069681] 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> [295.071094] 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> [295.072397] 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> [295.073773] 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> [295.075079] 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> [295.076490] 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> [295.076852] 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> [295.078569] 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> [295.078937] 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> [295.079807] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe A <7> [295.080271] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]] <7> [295.080613] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe A <7> [295.081032] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 4518 <7> [295.082179] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] reserved 10600448 bytes of contiguous stolen space for FBC, limit: 2 <7> [295.082515] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] Enabling FBC on [PLANE:32:plane 1A] <7> [295.097169] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2 <7> [295.099005] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1] <7> [295.099412] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:82:pipe A] <7> [295.118950] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [295.119360] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [295.119707] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02 <7> [295.383985] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [295.384275] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [295.414694] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [295.415101] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [295.415451] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02 <7> [297.558607] 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> [297.559048] 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> [300.227109] [IGT] kms_flip: finished subtest A-eDP1, FAIL <6> [300.227718] [IGT] kms_flip: starting dynamic subtest B-eDP1 <7> [300.228189] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:229] <7> [300.232476] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:230] <7> [300.305950] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A] <7> [300.306214] 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> [300.306576] 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> [300.306838] 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> [300.307077] 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> [300.307297] 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> [300.307529] 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> [300.307749] 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> [300.307957] 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> [300.308190] 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> [300.308386] 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> [300.308588] 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> [300.308772] 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> [300.308945] 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> [300.309112] 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> [300.309278] 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> [300.309442] 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> [300.309641] 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> [300.309824] 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> [300.309978] 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> [300.310130] 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> [300.310278] 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> [300.310421] 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> [300.310585] 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> [300.310728] 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> [300.310872] 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> [300.311012] 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> [300.311147] 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> [300.311281] 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> [300.311415] 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> [300.311564] 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> [300.311699] 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> [300.311855] 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> [300.312007] 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> [300.312133] 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> [300.312279] 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> [300.312411] 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> [300.312550] 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> [300.312673] 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> [300.312796] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset <7> [300.312988] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no <7> [300.313098] 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> [300.313277] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] ddb ( 0 - 4054) -> ( 0 - 0), size 4054 -> 0 <7> [300.313378] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:77:cursor A] ddb (4054 - 4096) -> ( 0 - 0), size 42 -> 0 <7> [300.313488] 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> [300.313584] 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> [300.313678] 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> [300.313771] 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> [300.313876] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:82:pipe A] data rate 0 num active planes 0 <7> [300.314026] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400 <7> [300.314156] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400 <7> [300.314271] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400 <7> [300.314383] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400 <7> [300.314503] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0 <7> [300.314615] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing <7> [300.314722] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz <7> [300.314827] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0 <7> [300.314959] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:82:pipe A] enable: no [modeset] <7> [300.315060] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:32:plane 1A] fb: [NOFB], visible: no <7> [300.315157] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:41:plane 2A] fb: [NOFB], visible: no <7> [300.315254] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:50:plane 3A] fb: [NOFB], visible: no <7> [300.315348] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:59:plane 4A] fb: [NOFB], visible: no <7> [300.315446] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:68:plane 5A] fb: [NOFB], visible: no <7> [300.315551] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:77:cursor A] fb: [NOFB], visible: no <7> [300.315721] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [300.315824] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [300.315972] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2 <7> [300.316161] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD on <7> [300.316279] 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> [300.333085] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]] <7> [300.536148] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 0 <7> [300.536679] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe A <7> [300.557727] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turn panel power off <7> [300.558130] 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> [300.558212] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [300.558578] 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> [300.558713] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [300.610341] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [300.610591] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [300.640950] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [300.641511] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [300.641561] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A <7> [300.642035] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [300.642006] xe 0000:00:02.0: [drm:__intel_fbc_disable [xe]] Disabling FBC on [PLANE:32:plane 1A] <7> [300.642727] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A] <7> [300.643040] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1] <7> [300.643357] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A] <7> [300.643632] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B] <7> [300.643978] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C] <7> [300.644339] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2] <7> [300.644627] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A] <7> [300.644886] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B] <7> [300.645131] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C] <7> [300.645416] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3] <7> [300.645658] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A] <7> [300.645895] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B] <7> [300.646130] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C] <7> [300.646411] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1] <7> [300.646721] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [300.646973] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: ) <7> [300.647270] 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> [300.647644] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [300.647930] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post [xe]] aud_ts_cdclk set to M=60, N=384 <7> [300.648293] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1 <7> [300.648722] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_A <7> [300.648889] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [300.649133] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [300.649366] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10 <7> [300.649612] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [300.649716] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:82:pipe A] <7> [300.650736] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B] <7> [300.651236] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:186:pipe C] <7> [300.651550] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B] <7> [300.651628] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:189:eDP-1] <7> [300.651813] 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> [300.652273] 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> [300.652632] 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> [300.652984] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:134:pipe B] hw max bpp: 30, pipe bpp: 30, dithering: 0 <7> [300.653362] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:188:DDI A/PHY A] [CRTC:134:pipe B] <7> [300.653698] 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> [300.654088] 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> [300.654414] 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> [300.654696] 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> [300.654967] 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> [300.655286] 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> [300.655537] 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> [300.655839] 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> [300.656098] 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> [300.656376] 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> [300.656600] 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> [300.656838] 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> [300.657055] 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> [300.657285] 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> [300.657490] 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> [300.657672] 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> [300.657876] 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> [300.658077] 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> [300.658256] 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> [300.658425] 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> [300.658618] 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> [300.658797] 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> [300.658975] 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> [300.659167] 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> [300.659321] 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> [300.659495] 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> [300.659661] 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> [300.659824] 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> [300.659958] 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> [300.660133] 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> [300.660264] 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> [300.660387] 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> [300.660511] 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> [300.660633] 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> [300.660756] 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> [300.660876] 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> [300.660993] 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> [300.661104] 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> [300.661215] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:134:pipe B] fastset requirement not met, forcing full modeset <7> [300.661494] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes <7> [300.661614] 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> [300.661770] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:84:plane 1B] ddb ( 0 - 0) -> ( 0 - 4054), size 0 -> 4054 <7> [300.661867] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:129:cursor B] ddb ( 0 - 0) -> (4054 - 4096), size 0 -> 42 <7> [300.661957] 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> [300.662091] 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> [300.662208] 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> [300.662295] 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> [300.662390] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:134:pipe B] data rate 1390840 num active planes 1 <7> [300.662519] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400 <7> [300.662635] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400 <7> [300.662737] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400 <7> [300.662837] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400 <7> [300.662931] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461 <7> [300.663038] 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> [300.663137] xe 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [xe]] new bandwidth min cdclk (27165 kHz) > old min cdclk (0 kHz) <7> [300.663238] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing <7> [300.663328] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz <7> [300.663413] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0 <7> [300.663520] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:134:pipe B] enable: yes [modeset] <7> [300.663610] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB <7> [300.663695] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: B, pipe bpp: 30, dithering: 0 <7> [300.663779] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid> <7> [300.663860] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7> [300.663945] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0 <7> [300.664028] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0 <7> [300.664105] 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> [300.664180] 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> [300.664254] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled <7> [300.664325] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled <7> [300.664414] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled <7> [300.664485] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0 <7> [300.664554] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4 <7> [300.664622] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14 <7> [300.664689] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB <7> [300.664755] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB <7> [300.664820] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0 <7> [300.664882] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range <7> [300.664947] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined <7> [300.665011] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, vmin: 1905, vmax: 2859, pipeline full: 0, guardband: 106 flipline: 1906, vmin vblank: 1800, vmax vblank: 2753 <7> [300.665086] 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> [300.665154] 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> [300.665213] 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> [300.665273] 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> [300.665332] 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> [300.665389] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710 <7> [300.665446] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0 <7> [300.665501] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0 <7> [300.665557] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no <7> [300.665614] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0 <7> [300.665669] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dpll_hw_state: dpll: 0x69780, dpll_md: 0x42110, fp0: 0x1a2, fp1: 0x1000000 <7> [300.665724] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7> [300.665779] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries <7> [300.665834] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000 <7> [300.665889] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [300.665960] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [300.666018] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [300.666069] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000 <7> [300.666123] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000 <7> [300.666180] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [300.666230] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [300.666279] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [300.666329] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000 <7> [300.666379] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:84:plane 1B] fb: [FB:229] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes <7> [300.666432] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7> [300.666483] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0 <7> [300.666535] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:93:plane 2B] fb: [NOFB], visible: no <7> [300.666586] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:102:plane 3B] fb: [NOFB], visible: no <7> [300.666636] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:111:plane 4B] fb: [NOFB], visible: no <7> [300.666686] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:120:plane 5B] fb: [NOFB], visible: no <7> [300.666737] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:129:cursor B] fb: [NOFB], visible: no <7> [300.668987] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [300.669302] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [300.669433] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02 <7> [300.669511] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling always-on <7> [300.669577] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling always-on <7> [300.669640] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [300.669701] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [300.669809] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_2 <7> [300.669924] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_B <7> [300.670044] 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> [300.670117] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [300.670193] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post [xe]] aud_ts_cdclk set to M=60, N=480 <7> [300.670259] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A] <7> [300.670313] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1] <7> [300.670367] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A] <7> [300.670423] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B] <7> [300.670480] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C] <7> [300.670528] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2] <7> [300.670585] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A] <7> [300.670646] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B] <7> [300.670699] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C] <7> [300.670753] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3] <7> [300.670806] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A] <7> [300.670867] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B] <7> [300.670945] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C] <7> [300.670993] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf <7> [300.671143] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: ) <7> [300.671212] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes) <7> [300.671276] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A <7> [300.672662] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turn panel power on <7> [300.672767] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 wait for panel power cycle (469 ms remaining) <7> [301.144747] 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> [301.155467] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [301.155880] 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> [301.156346] 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> [301.191973] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [301.192298] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [301.192580] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20 <7> [301.192869] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [301.470018] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [301.472228] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD on <7> [301.472614] 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> [301.475577] 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> [301.476910] 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> [301.477933] 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> [301.479131] 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> [301.480301] 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> [301.481624] 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> [301.481929] 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> [301.483583] 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> [301.483883] 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> [301.484656] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe B <7> [301.485077] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]] <7> [301.485418] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe B <7> [301.485754] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 4518 <7> [301.486777] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] reserved 10600448 bytes of contiguous stolen space for FBC, limit: 2 <7> [301.487077] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] Enabling FBC on [PLANE:84:plane 1B] <7> [301.501956] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2 <7> [301.503894] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1] <7> [301.504305] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:134:pipe B] <7> [301.524076] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [301.524488] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [301.524890] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02 <7> [301.789015] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [301.789430] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [301.820618] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [301.821043] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [301.821391] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02 <7> [304.004115] 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> [304.004521] 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> [309.145222] [IGT] kms_flip: finished subtest B-eDP1, FAIL <6> [309.146097] [IGT] kms_flip: starting dynamic subtest C-eDP1 <7> [309.146993] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225] <7> [309.151980] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:232] <7> [309.224849] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A] <7> [309.225234] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [309.225635] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [309.226331] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B] <7> [309.226525] 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> [309.226939] 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> [309.227250] 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> [309.227537] 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> [309.227843] 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> [309.228113] 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> [309.228367] 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> [309.228674] 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> [309.228926] 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> [309.229148] 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> [309.229367] 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> [309.229585] 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> [309.229870] 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> [309.230066] 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> [309.230260] 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> [309.230452] 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> [309.230689] 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> [309.230878] 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> [309.231054] 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> [309.231231] 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> [309.231404] 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> [309.231570] 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> [309.231789] 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> [309.231953] 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> [309.232111] 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> [309.232261] 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> [309.232412] 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> [309.232563] 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> [309.232739] 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> [309.232896] 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> [309.233047] 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> [309.233195] 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> [309.233336] 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> [309.233475] 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> [309.233649] 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> [309.233797] 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> [309.233929] 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> [309.234058] 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> [309.234187] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:134:pipe B] fastset requirement not met, forcing full modeset <7> [309.234353] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no <7> [309.234470] 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> [309.234652] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:84:plane 1B] ddb ( 0 - 4054) -> ( 0 - 0), size 4054 -> 0 <7> [309.234767] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:129:cursor B] ddb (4054 - 4096) -> ( 0 - 0), size 42 -> 0 <7> [309.234874] 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> [309.234978] 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> [309.235084] 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> [309.235187] 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> [309.235288] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:134:pipe B] data rate 0 num active planes 0 <7> [309.235442] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400 <7> [309.235567] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400 <7> [309.235749] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400 <7> [309.235866] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400 <7> [309.235979] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0 <7> [309.236094] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing <7> [309.236202] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz <7> [309.236306] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0 <7> [309.236437] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:134:pipe B] enable: no [modeset] <7> [309.236561] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:84:plane 1B] fb: [NOFB], visible: no <7> [309.236703] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:93:plane 2B] fb: [NOFB], visible: no <7> [309.236809] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:102:plane 3B] fb: [NOFB], visible: no <7> [309.236909] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:111:plane 4B] fb: [NOFB], visible: no <7> [309.237005] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:120:plane 5B] fb: [NOFB], visible: no <7> [309.237100] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:129:cursor B] fb: [NOFB], visible: no <7> [309.237263] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2 <7> [309.237461] 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.237584] 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> [309.254369] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]] <7> [309.460095] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 0 <7> [309.460477] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe B <7> [309.471543] 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.471932] 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.471968] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [309.472216] 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.472479] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [309.524196] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [309.524462] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [309.539635] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [309.540161] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A <7> [309.540654] xe 0000:00:02.0: [drm:__intel_fbc_disable [xe]] Disabling FBC on [PLANE:84:plane 1B] <7> [309.540672] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [309.541152] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [309.541399] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A] <7> [309.541733] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1] <7> [309.542017] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A] <7> [309.542363] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B] <7> [309.542683] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C] <7> [309.542921] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2] <7> [309.543146] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A] <7> [309.543390] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B] <7> [309.543611] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C] <7> [309.543893] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3] <7> [309.544134] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A] <7> [309.544446] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B] <7> [309.544683] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C] <7> [309.544915] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1] <7> [309.545214] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [309.545503] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: ) <7> [309.545774] 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.546116] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [309.546471] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post [xe]] aud_ts_cdclk set to M=60, N=384 <7> [309.546815] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1 <7> [309.547254] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_B <7> [309.547723] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_2 <7> [309.548153] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:134:pipe B] <7> [309.549406] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:186:pipe C] <7> [309.549952] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:186:pipe C] <7> [309.550034] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:189:eDP-1] <7> [309.550227] 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.550708] 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> [309.551071] 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.551457] xe 0000:00:02.0: [drm:intel_psr_compute_config [xe]] PSR2 not supported in transcoder C <7> [309.551769] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:186:pipe C] hw max bpp: 30, pipe bpp: 30, dithering: 0 <7> [309.552120] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:188:DDI A/PHY A] [CRTC:186:pipe C] <7> [309.552544] 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> [309.552883] 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> [309.553208] 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> [309.553584] 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> [309.553863] 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> [309.554135] 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> [309.554425] 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> [309.554684] 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> [309.554921] 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> [309.555188] 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> [309.555431] 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> [309.555646] 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> [309.555855] 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> [309.556088] 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> [309.556311] 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> [309.556506] 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> [309.556689] 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> [309.556910] 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> [309.557084] 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> [309.557270] 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> [309.557437] 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> [309.557598] 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> [309.557760] 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> [309.557949] 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> [309.558109] 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> [309.558263] 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> [309.558407] 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> [309.558546] 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> [309.558684] 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> [309.558821] 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> [309.558952] 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> [309.559080] 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> [309.559203] 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> [309.559358] 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> [309.559481] 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> [309.559597] 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> [309.559710] 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> [309.559822] 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> [309.559950] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:186:pipe C] fastset requirement not met, forcing full modeset <7> [309.560149] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xd (total dbuf slices 0xf), mbus joined? no->no <7> [309.560261] 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> [309.560410] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:136:plane 1C] ddb ( 0 - 0) -> ( 0 - 2006), size 0 -> 2006 <7> [309.560510] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:181:cursor C] ddb ( 0 - 0) -> (2006 - 2048), size 0 -> 42 <7> [309.560609] 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> [309.560709] 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> [309.560807] 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> [309.560898] 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> [309.560997] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:186:pipe C] data rate 1390840 num active planes 1 <7> [309.561118] 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.561223] 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.561354] 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.561457] 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.561558] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461 <7> [309.561677] 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> [309.561778] 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.561873] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing <7> [309.561962] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz <7> [309.562051] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0 <7> [309.562153] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:186:pipe C] enable: yes [modeset] <7> [309.562249] 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.562336] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: C, pipe bpp: 30, dithering: 0 <7> [309.562420] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid> <7> [309.562501] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7> [309.562579] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0 <7> [309.562656] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0 <7> [309.562653] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [309.562735] 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.562800] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [309.562813] 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.562877] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10 <7> [309.562893] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled <7> [309.562968] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled <7> [309.562963] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [309.563042] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: disabled, panel replay: disabled, selective fetch: disabled <7> [309.563114] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0 <7> [309.563182] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4 <7> [309.563259] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 2, length 8 <7> [309.563329] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB <7> [309.563396] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB <7> [309.563463] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0 <7> [309.563527] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range <7> [309.563590] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined <7> [309.563652] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, vmin: 1905, vmax: 2859, pipeline full: 0, guardband: 106 flipline: 1906, vmin vblank: 1800, vmax vblank: 2753 <7> [309.563717] 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.563780] 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.563843] 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.563903] 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.563962] 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.564020] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710 <7> [309.564076] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0 <7> [309.564132] 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.564188] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no <7> [309.564252] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0 <7> [309.564308] 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.564373] 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.564428] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries <7> [309.564481] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000 <7> [309.564537] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [309.564590] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [309.564641] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [309.564693] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000 <7> [309.564745] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000 <7> [309.564796] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [309.564846] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [309.564896] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [309.564946] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000 <7> [309.564996] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:136:plane 1C] fb: [FB:225] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes <7> [309.565047] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7> [309.565097] 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.565148] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:145:plane 2C] fb: [NOFB], visible: no <7> [309.565198] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:154:plane 3C] fb: [NOFB], visible: no <7> [309.565259] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:163:plane 4C] fb: [NOFB], visible: no <7> [309.565311] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:172:plane 5C] fb: [NOFB], visible: no <7> [309.565367] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:181:cursor C] fb: [NOFB], visible: no <7> [309.568066] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_2 <7> [309.568217] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_C <7> [309.568349] 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.568420] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [309.568498] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post [xe]] aud_ts_cdclk set to M=60, N=480 <7> [309.568560] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A] <7> [309.568614] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1] <7> [309.568665] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A] <7> [309.568716] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B] <7> [309.568766] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C] <7> [309.568815] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2] <7> [309.568863] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A] <7> [309.568910] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B] <7> [309.568956] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C] <7> [309.569001] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3] <7> [309.569046] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A] <7> [309.569090] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B] <7> [309.569135] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C] <7> [309.569182] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xd <7> [309.569330] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [309.569407] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A <7> [309.570360] 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.570452] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 wait for panel power cycle (470 ms remaining) <7> [310.041676] 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> [310.177259] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [310.177619] 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> [310.178018] 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> [310.213711] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [310.214146] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [310.214493] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20 <7> [310.214970] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [310.416502] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [310.418756] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD on <7> [310.419245] 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> [310.422448] 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> [310.423912] 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> [310.425068] 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> [310.426506] 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> [310.427827] 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> [310.429243] 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> [310.429629] 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> [310.431372] 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> [310.431754] 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> [310.432714] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe C <7> [310.433293] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]] <7> [310.433680] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe C <7> [310.434154] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 4518 <7> [310.435447] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] reserved 10600448 bytes of contiguous stolen space for FBC, limit: 2 <7> [310.435850] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] Enabling FBC on [PLANE:136:plane 1C] <7> [310.450132] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR1 <7> [310.451741] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1] <7> [310.452214] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:186:pipe C] <7> [312.983651] 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.983995] 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 <7> [320.748878] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:232] from all active usage due to RMFB ioctl <7> [320.749115] xe 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:136:plane 1C] because [FB:232] is removed <7> [320.749398] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:136:plane 1C] ddb ( 0 - 2006) -> ( 0 - 0), size 2006 -> 0 <7> [320.749979] 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> [320.750388] 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> [320.750792] 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> [320.751149] 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> [320.751498] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:186:pipe C] data rate 0 num active planes 0 <7> [320.752097] 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.752627] 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.753123] 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.753668] 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.754146] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0 <7> [320.754803] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR1 <7> [320.755453] 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.755953] 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.765135] xe 0000:00:02.0: [drm:__intel_fbc_disable [xe]] Disabling FBC on [PLANE:136:plane 1C] <6> [320.784400] [IGT] kms_flip: finished subtest C-eDP1, SUCCESS <6> [320.786078] [IGT] kms_flip: finished subtest blocking-wf_vblank, FAIL <7> [320.813137] 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> [320.813335] 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> [320.813487] 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> [320.813663] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:82:pipe A] hw max bpp: 30, pipe bpp: 30, dithering: 0 <7> [320.813820] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:188:DDI A/PHY A] [CRTC:82:pipe A] <7> [320.813973] 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> [320.814098] 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> [320.814217] 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> [320.814334] 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> [320.814446] 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> [320.814569] 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> [320.814678] 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> [320.814785] 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> [320.814891] 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> [320.814993] 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> [320.815093] 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> [320.815189] 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> [320.815285] 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> [320.815377] 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> [320.815468] 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> [320.815572] 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> [320.815664] 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> [320.815754] 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> [320.815841] 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> [320.815925] 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> [320.816009] 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> [320.816093] 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> [320.816174] 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> [320.816254] 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> [320.816337] 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> [320.816418] 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> [320.816499] 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> [320.816591] 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> [320.816669] 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> [320.816745] 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> [320.816821] 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> [320.816895] 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> [320.816967] 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> [320.817039] 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> [320.817110] 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> [320.817177] 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> [320.817246] 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> [320.817313] 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> [320.817381] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset <7> [320.817447] 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> [320.817618] 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> [320.817687] 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> [320.817754] 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> [320.817818] 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> [320.817882] 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> [320.817944] 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> [320.818005] 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> [320.818064] 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> [320.818123] 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> [320.818182] 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> [320.818239] 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> [320.818296] 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> [320.818352] 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> [320.818407] 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> [320.818462] 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> [320.818531] 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> [320.818589] 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> [320.818646] 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> [320.818703] 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> [320.818759] 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> [320.818814] 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> [320.818867] 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> [320.818920] 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> [320.818972] 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> [320.819023] 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> [320.819075] 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> [320.819125] 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> [320.819176] 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> [320.819227] 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> [320.819277] 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> [320.819327] 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> [320.819378] 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> [320.819429] 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> [320.819479] 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> [320.819538] 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> [320.819590] 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> [320.819655] 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> [320.819710] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:186:pipe C] fastset requirement not met, forcing full modeset <7> [320.819891] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xd -> 0xf (total dbuf slices 0xf), mbus joined? no->yes <7> [320.819949] 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> [320.820006] 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> [320.820089] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] ddb ( 0 - 0) -> ( 0 - 4054), size 0 -> 4054 <7> [320.820144] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:77:cursor A] ddb ( 0 - 0) -> (4054 - 4096), size 0 -> 42 <7> [320.820193] 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> [320.820241] 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> [320.820291] 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> [320.820341] 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> [320.820391] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:181:cursor C] ddb (2006 - 2048) -> ( 0 - 0), size 42 -> 0 <7> [320.820440] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:82:pipe A] data rate 1390840 num active planes 1 <7> [320.820512] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400 <7> [320.820576] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400 <7> [320.820635] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400 <7> [320.820693] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400 <7> [320.820751] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461 <7> [320.820809] 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> [320.820872] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz <7> [320.820930] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0 <7> [320.821013] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:82:pipe A] enable: yes [modeset] <7> [320.821078] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB <7> [320.821145] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 30, dithering: 0 <7> [320.821211] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid> <7> [320.821277] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7> [320.821340] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0 <7> [320.821397] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0 <7> [320.821455] 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> [320.821519] 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> [320.821578] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled <7> [320.821640] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled <7> [320.821707] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled <7> [320.821764] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0 <7> [320.821818] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4 <7> [320.821872] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14 <7> [320.821925] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB <7> [320.821979] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB <7> [320.822032] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0 <7> [320.822084] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range <7> [320.822137] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined <7> [320.822189] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, vmin: 1905, vmax: 2859, pipeline full: 0, guardband: 106 flipline: 1906, vmin vblank: 1800, vmax vblank: 2753 <7> [320.822242] 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> [320.822295] 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> [320.822348] 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> [320.822402] 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> [320.822456] 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> [320.822577] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710 <7> [320.822651] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0 <7> [320.822714] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0 <7> [320.822770] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no <7> [320.822824] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0 <7> [320.822877] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dpll_hw_state: dpll: 0x69780, dpll_md: 0x42110, fp0: 0x1a2, fp1: 0x1000000 <7> [320.822930] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7> [320.822983] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries <7> [320.823034] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000 <7> [320.823085] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [320.823136] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [320.823187] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [320.823237] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000 <7> [320.823288] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000 <7> [320.823339] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [320.823390] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [320.823440] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [320.823491] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000 <7> [320.823551] 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> [320.823608] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7> [320.823675] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0 <7> [320.823728] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:41:plane 2A] fb: [NOFB], visible: no <7> [320.823780] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:50:plane 3A] fb: [NOFB], visible: no <7> [320.823833] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:59:plane 4A] fb: [NOFB], visible: no <7> [320.823885] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:68:plane 5A] fb: [NOFB], visible: no <7> [320.823937] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:77:cursor A] fb: [NOFB], visible: no <7> [320.823990] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:186:pipe C] enable: no [modeset] <7> [320.824042] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:136:plane 1C] fb: [NOFB], visible: no <7> [320.824095] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:145:plane 2C] fb: [NOFB], visible: no <7> [320.824147] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:154:plane 3C] fb: [NOFB], visible: no <7> [320.824198] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:163:plane 4C] fb: [NOFB], visible: no <7> [320.824250] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:172:plane 5C] fb: [NOFB], visible: no <7> [320.824301] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:181:cursor C] fb: [NOFB], visible: no <7> [320.826652] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_A <7> [320.826838] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]] <7> [321.032503] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 0 <7> [321.032963] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe C <7> [321.054430] 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.054859] 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.054852] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [321.055289] 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.055439] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [321.107082] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [321.107423] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [321.137924] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [321.138363] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A <7> [321.138679] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A] <7> [321.138686] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [321.138931] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1] <7> [321.138996] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [321.139155] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A] <7> [321.139354] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B] <7> [321.139537] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C] <7> [321.139730] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2] <7> [321.139922] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A] <7> [321.140146] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B] <7> [321.140333] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C] <7> [321.140515] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3] <7> [321.140710] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A] <7> [321.140942] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B] <7> [321.141155] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C] <7> [321.141387] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf <7> [321.141736] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: ) <7> [321.141962] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes) <7> [321.142248] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A <7> [321.143298] 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.143658] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 wait for panel power cycle (495 ms remaining) <7> [321.145221] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [321.145598] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [321.145941] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10 <7> [321.146421] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [321.639946] 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> [321.640625] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [321.641222] 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.641895] 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.677288] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [321.677777] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [321.678218] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20 <7> [321.678886] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [321.898677] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [321.900836] 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.901263] 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.904343] 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.905772] 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.907066] 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.908496] 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.909766] 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.911209] 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.911556] 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.913348] 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.913682] 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.914502] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe A <7> [321.914978] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]] <7> [321.915366] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe A <7> [321.915769] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 4518 <7> [321.916995] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] reserved 11059200 bytes of contiguous stolen space for FBC, limit: 2 <7> [321.917388] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] Enabling FBC on [PLANE:32:plane 1A] <7> [321.931841] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2 <7> [321.933657] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1] <7> [321.934044] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:82:pipe A] <7> [321.936448] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_C <7> [321.936881] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_2 <7> [321.937406] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:186:pipe C] <7> [321.938372] xe 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6> [321.939587] [IGT] kms_flip: exiting, ret=98 <6> [321.949569] Console: switching to colour frame buffer device 180x56 <7> [321.983217] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [321.983480] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [321.983644] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02

Created at 2024-12-19 07:21:22