Hardware List

Results for igt@kms_flip@blocking-wf_vblank

Machine description: shard-lnl-3

Result: Fail

i915_display_info24 igt_runner24 results24.json results24-xe-load.json i915_display_info_post_exec24 boot24 dmesg24

Detail	Value
Duration	38.23 seconds
Hostname	shard-lnl-3
Igt-Version	IGT-Version: 1.30-g32cab3d52 (x86_64) (Linux: 6.14.0-rc2-xe+ x86_64)
Out	Using IGT_SRANDOM=1739476695 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 16577.8us +- 2.910us accuracy 0.05% vblank interval differs from modeline! expected 16664.0us, measured 16578us +- 2.910us, difference 86.3us (29.6 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 (14.801s) Starting dynamic subtest: B-eDP1 2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa Expected frametime: 16664us; measured 16645.4us +- 3.386us accuracy 0.06% vblank interval differs from modeline! expected 16664.0us, measured 16645us +- 3.386us, difference 18.6us (5.5 sigma) Dynamic subtest B-eDP1: SUCCESS (11.802s) Starting dynamic subtest: C-eDP1 2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa Expected frametime: 16664us; measured 16653.6us +- 4.380us accuracy 0.08% vblank interval differs from modeline! expected 16664.0us, measured 16654us +- 4.380us, difference 10.4us (2.4 sigma) Dynamic subtest C-eDP1: SUCCESS (11.625s) Subtest blocking-wf_vblank: FAIL (38.235s)
Err	Starting subtest: blocking-wf_vblank Starting dynamic subtest: A-eDP1 (kms_flip:3527) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674: (kms_flip:3527) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon) Dynamic subtest A-eDP1 failed. ** DEBUG (kms_flip:3527) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=2880, height=1800, format=XR24(0x34325258), modifier=0x0, size=0) (kms_flip:3527) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=11520) (kms_flip:3527) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd) (kms_flip:3527) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=2880, height=1800, format=XR24(0x34325258), modifier=0x0, size=0) (kms_flip:3527) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=11520) (kms_flip:3527) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd) (kms_flip:3527) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:3527) intel_allocator_simple-DEBUG: <ial: 0x61fc366dfc50, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3527) intel_allocator_simple-DEBUG: <ial: 0x61fc366dfc50, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3527) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:3527) intel_allocator_simple-DEBUG: <ial: 0x61fc36725310, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3527) intel_allocator_simple-DEBUG: <ial: 0x61fc36725310, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3527) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:3527) intel_allocator_simple-DEBUG: <ial: 0x61fc366e9bd0, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3527) intel_allocator_simple-DEBUG: <ial: 0x61fc366e9bd0, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3527) intel_allocator_simple-DEBUG: Using simple allocator (kms_flip:3527) intel_allocator_simple-DEBUG: <ial: 0x61fc366e9bd0, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3527) intel_allocator_simple-DEBUG: <ial: 0x61fc366e9bd0, fd: 5> objects: 3, reserved_areas: 0 (kms_flip:3527) igt_kms-INFO: 2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa (kms_flip:3527) DEBUG: No stale events found (kms_flip:3527) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0 (kms_flip:3527) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0 (kms_flip:3527) INFO: Expected frametime: 16664us; measured 16577.8us +- 2.910us accuracy 0.05% (kms_flip:3527) INFO: vblank interval differs from modeline! expected 16664.0us, measured 16578us +- 2.910us, difference 86.3us (29.6 sigma) (kms_flip:3527) DEBUG: name = vblank last_ts = 0.000000 last_received_ts = 0.000000 last_seq = 0 current_ts = 209.674850 current_received_ts = 209.674042 current_seq = 2749 count = 0 seq_step = 10 (kms_flip:3527) DEBUG: name = vblank last_ts = 209.674850 last_received_ts = 209.674042 last_seq = 2749 current_ts = 209.840698 current_received_ts = 209.839935 current_seq = 2759 count = 1 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 209.674850/2749, current 209.840698/2759: elapsed=165845.0us expected=165777.5us +- 828.9us, error 0.0% (kms_flip:3527) DEBUG: name = vblank last_ts = 209.840698 last_received_ts = 209.839935 last_seq = 2759 current_ts = 210.006577 current_received_ts = 210.005768 current_seq = 2769 count = 2 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 209.840698/2759, current 210.006577/2769: elapsed=165875.0us expected=165777.5us +- 828.9us, error 0.1% (kms_flip:3527) DEBUG: name = vblank last_ts = 210.006577 last_received_ts = 210.005768 last_seq = 2769 current_ts = 210.172455 current_received_ts = 210.171661 current_seq = 2779 count = 3 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 210.006577/2769, current 210.172455/2779: elapsed=165883.0us expected=165777.5us +- 828.9us, error 0.1% (kms_flip:3527) DEBUG: name = vblank last_ts = 210.172455 last_received_ts = 210.171661 last_seq = 2779 current_ts = 210.338333 current_received_ts = 210.337555 current_seq = 2789 count = 4 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 210.172455/2779, current 210.338333/2789: elapsed=165873.0us expected=165777.5us +- 828.9us, error 0.1% (kms_flip:3527) DEBUG: name = vblank last_ts = 210.338333 last_received_ts = 210.337555 last_seq = 2789 current_ts = 210.504211 current_received_ts = 210.503418 current_seq = 2799 count = 5 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 210.338333/2789, current 210.504211/2799: elapsed=165878.0us expected=165777.5us +- 828.9us, error 0.1% (kms_flip:3527) DEBUG: name = vblank last_ts = 210.504211 last_received_ts = 210.503418 last_seq = 2799 current_ts = 210.670090 current_received_ts = 210.669296 current_seq = 2809 count = 6 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 210.504211/2799, current 210.670090/2809: elapsed=165877.0us expected=165777.5us +- 828.9us, error 0.1% (kms_flip:3527) DEBUG: name = vblank last_ts = 210.670090 last_received_ts = 210.669296 last_seq = 2809 current_ts = 210.836014 current_received_ts = 210.835266 current_seq = 2819 count = 7 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 210.670090/2809, current 210.836014/2819: elapsed=165927.0us expected=165777.5us +- 828.9us, error 0.1% (kms_flip:3527) DEBUG: name = vblank last_ts = 210.836014 last_received_ts = 210.835266 last_seq = 2819 current_ts = 211.001984 current_received_ts = 211.001190 current_seq = 2829 count = 8 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 210.836014/2819, current 211.001984/2829: elapsed=165961.0us expected=165777.5us +- 828.9us, error 0.1% (kms_flip:3527) DEBUG: name = vblank last_ts = 211.001984 last_received_ts = 211.001190 last_seq = 2829 current_ts = 211.167938 current_received_ts = 211.167145 current_seq = 2839 count = 9 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 211.001984/2829, current 211.167938/2839: elapsed=165958.0us expected=165777.5us +- 828.9us, error 0.1% (kms_flip:3527) DEBUG: name = vblank last_ts = 211.167938 last_received_ts = 211.167145 last_seq = 2839 current_ts = 211.333893 current_received_ts = 211.333038 current_seq = 2849 count = 10 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 211.167938/2839, current 211.333893/2849: elapsed=165959.0us expected=165777.5us +- 828.9us, error 0.1% (kms_flip:3527) DEBUG: name = vblank last_ts = 211.333893 last_received_ts = 211.333038 last_seq = 2849 current_ts = 211.499863 current_received_ts = 211.499069 current_seq = 2859 count = 11 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 211.333893/2849, current 211.499863/2859: elapsed=165967.0us expected=165777.5us +- 828.9us, error 0.1% (kms_flip:3527) DEBUG: name = vblank last_ts = 211.499863 last_received_ts = 211.499069 last_seq = 2859 current_ts = 211.665817 current_received_ts = 211.665070 current_seq = 2869 count = 12 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 211.499863/2859, current 211.665817/2869: elapsed=165962.0us expected=165777.5us +- 828.9us, error 0.1% (kms_flip:3527) DEBUG: name = vblank last_ts = 211.665817 last_received_ts = 211.665070 last_seq = 2869 current_ts = 211.831833 current_received_ts = 211.831100 current_seq = 2879 count = 13 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 211.665817/2869, current 211.831833/2879: elapsed=166007.0us expected=165777.5us +- 828.9us, error 0.1% (kms_flip:3527) DEBUG: name = vblank last_ts = 211.831833 last_received_ts = 211.831100 last_seq = 2879 current_ts = 211.997864 current_received_ts = 211.997116 current_seq = 2889 count = 14 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 211.831833/2879, current 211.997864/2889: elapsed=166031.0us expected=165777.5us +- 828.9us, error 0.2% (kms_flip:3527) DEBUG: name = vblank last_ts = 211.997864 last_received_ts = 211.997116 last_seq = 2889 current_ts = 212.163895 current_received_ts = 212.163177 current_seq = 2899 count = 15 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 211.997864/2889, current 212.163895/2899: elapsed=166034.0us expected=165777.5us +- 828.9us, error 0.2% (kms_flip:3527) DEBUG: name = vblank last_ts = 212.163895 last_received_ts = 212.163177 last_seq = 2899 current_ts = 212.329926 current_received_ts = 212.329147 current_seq = 2909 count = 16 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 212.163895/2899, current 212.329926/2909: elapsed=166037.0us expected=165777.5us +- 828.9us, error 0.2% (kms_flip:3527) DEBUG: name = vblank last_ts = 212.329926 last_received_ts = 212.329147 last_seq = 2909 current_ts = 212.495972 current_received_ts = 212.495117 current_seq = 2919 count = 17 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 212.329926/2909, current 212.495972/2919: elapsed=166037.0us expected=165777.5us +- 828.9us, error 0.2% (kms_flip:3527) DEBUG: name = vblank last_ts = 212.495972 last_received_ts = 212.495117 last_seq = 2919 current_ts = 212.662003 current_received_ts = 212.661270 current_seq = 2929 count = 18 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 212.495972/2919, current 212.662003/2929: elapsed=166037.0us expected=165777.5us +- 828.9us, error 0.2% (kms_flip:3527) DEBUG: name = vblank last_ts = 212.662003 last_received_ts = 212.661270 last_seq = 2929 current_ts = 212.828079 current_received_ts = 212.827438 current_seq = 2939 count = 19 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 212.662003/2929, current 212.828079/2939: elapsed=166073.0us expected=165777.5us +- 828.9us, error 0.2% (kms_flip:3527) DEBUG: name = vblank last_ts = 212.828079 last_received_ts = 212.827438 last_seq = 2939 current_ts = 212.994186 current_received_ts = 212.993484 current_seq = 2949 count = 20 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 212.828079/2939, current 212.994186/2949: elapsed=166105.0us expected=165777.5us +- 828.9us, error 0.2% (kms_flip:3527) DEBUG: name = vblank last_ts = 212.994186 last_received_ts = 212.993484 last_seq = 2949 current_ts = 213.160278 current_received_ts = 213.159576 current_seq = 2959 count = 21 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 212.994186/2949, current 213.160278/2959: elapsed=166098.0us expected=165777.5us +- 828.9us, error 0.2% (kms_flip:3527) DEBUG: name = vblank last_ts = 213.160278 last_received_ts = 213.159576 last_seq = 2959 current_ts = 213.326385 current_received_ts = 213.325668 current_seq = 2969 count = 22 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 213.160278/2959, current 213.326385/2969: elapsed=166096.0us expected=165777.5us +- 828.9us, error 0.2% (kms_flip:3527) DEBUG: name = vblank last_ts = 213.326385 last_received_ts = 213.325668 last_seq = 2969 current_ts = 213.492477 current_received_ts = 213.491760 current_seq = 2979 count = 23 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 213.326385/2969, current 213.492477/2979: elapsed=166106.0us expected=165777.5us +- 828.9us, error 0.2% (kms_flip:3527) DEBUG: name = vblank last_ts = 213.492477 last_received_ts = 213.491760 last_seq = 2979 current_ts = 213.658585 current_received_ts = 213.657867 current_seq = 2989 count = 24 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 213.492477/2979, current 213.658585/2989: elapsed=166102.0us expected=165777.5us +- 828.9us, error 0.2% (kms_flip:3527) DEBUG: name = vblank last_ts = 213.658585 last_received_ts = 213.657867 last_seq = 2989 current_ts = 213.824722 current_received_ts = 213.823883 current_seq = 2999 count = 25 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 213.658585/2989, current 213.824722/2999: elapsed=166129.0us expected=165777.5us +- 828.9us, error 0.2% (kms_flip:3527) DEBUG: name = vblank last_ts = 213.824722 last_received_ts = 213.823883 last_seq = 2999 current_ts = 213.990875 current_received_ts = 213.990082 current_seq = 3009 count = 26 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 213.824722/2999, current 213.990875/3009: elapsed=166156.0us expected=165777.5us +- 828.9us, error 0.2% (kms_flip:3527) DEBUG: name = vblank last_ts = 213.990875 last_received_ts = 213.990082 last_seq = 3009 current_ts = 214.157028 current_received_ts = 214.156326 current_seq = 3019 count = 27 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 213.990875/3009, current 214.157028/3019: elapsed=166156.0us expected=165777.5us +- 828.9us, error 0.2% (kms_flip:3527) DEBUG: name = vblank last_ts = 214.157028 last_received_ts = 214.156326 last_seq = 3019 current_ts = 214.323181 current_received_ts = 214.322479 current_seq = 3029 count = 28 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 214.157028/3019, current 214.323181/3029: elapsed=166159.0us expected=165777.5us +- 828.9us, error 0.2% (kms_flip:3527) DEBUG: name = vblank last_ts = 214.323181 last_received_ts = 214.322479 last_seq = 3029 current_ts = 214.489349 current_received_ts = 214.488632 current_seq = 3039 count = 29 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 214.323181/3029, current 214.489349/3039: elapsed=166162.0us expected=165777.5us +- 828.9us, error 0.2% (kms_flip:3527) DEBUG: name = vblank last_ts = 214.489349 last_received_ts = 214.488632 last_seq = 3039 current_ts = 214.655502 current_received_ts = 214.654770 current_seq = 3049 count = 30 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 214.489349/3039, current 214.655502/3049: elapsed=166155.0us expected=165777.5us +- 828.9us, error 0.2% (kms_flip:3527) DEBUG: name = vblank last_ts = 214.655502 last_received_ts = 214.654770 last_seq = 3049 current_ts = 214.821686 current_received_ts = 214.820999 current_seq = 3059 count = 31 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 214.655502/3049, current 214.821686/3059: elapsed=166184.0us expected=165777.5us +- 828.9us, error 0.2% (kms_flip:3527) DEBUG: name = vblank last_ts = 214.821686 last_received_ts = 214.820999 last_seq = 3059 current_ts = 214.987900 current_received_ts = 214.987167 current_seq = 3069 count = 32 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 214.821686/3059, current 214.987900/3069: elapsed=166206.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 214.987900 last_received_ts = 214.987167 last_seq = 3069 current_ts = 215.154099 current_received_ts = 215.153397 current_seq = 3079 count = 33 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 214.987900/3069, current 215.154099/3079: elapsed=166205.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 215.154099 last_received_ts = 215.153397 last_seq = 3079 current_ts = 215.320312 current_received_ts = 215.319595 current_seq = 3089 count = 34 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 215.154099/3079, current 215.320312/3089: elapsed=166212.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 215.320312 last_received_ts = 215.319595 last_seq = 3089 current_ts = 215.486511 current_received_ts = 215.485809 current_seq = 3099 count = 35 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 215.320312/3089, current 215.486511/3099: elapsed=166202.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 215.486511 last_received_ts = 215.485809 last_seq = 3099 current_ts = 215.652725 current_received_ts = 215.652069 current_seq = 3109 count = 36 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 215.486511/3099, current 215.652725/3109: elapsed=166214.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 215.652725 last_received_ts = 215.652069 last_seq = 3109 current_ts = 215.818954 current_received_ts = 215.818283 current_seq = 3119 count = 37 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 215.652725/3109, current 215.818954/3119: elapsed=166230.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 215.818954 last_received_ts = 215.818283 last_seq = 3119 current_ts = 215.985214 current_received_ts = 215.984497 current_seq = 3129 count = 38 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 215.818954/3119, current 215.985214/3129: elapsed=166253.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 215.985214 last_received_ts = 215.984497 last_seq = 3129 current_ts = 216.151459 current_received_ts = 216.150894 current_seq = 3139 count = 39 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 215.985214/3129, current 216.151459/3139: elapsed=166245.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 216.151459 last_received_ts = 216.150894 last_seq = 3139 current_ts = 216.317703 current_received_ts = 216.317078 current_seq = 3149 count = 40 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 216.151459/3139, current 216.317703/3149: elapsed=166254.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 216.317703 last_received_ts = 216.317078 last_seq = 3149 current_ts = 216.483963 current_received_ts = 216.483292 current_seq = 3159 count = 41 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 216.317703/3149, current 216.483963/3159: elapsed=166250.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 216.483963 last_received_ts = 216.483292 last_seq = 3159 current_ts = 216.650208 current_received_ts = 216.649567 current_seq = 3169 count = 42 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 216.483963/3159, current 216.650208/3169: elapsed=166252.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 216.650208 last_received_ts = 216.649567 last_seq = 3169 current_ts = 216.816483 current_received_ts = 216.815796 current_seq = 3179 count = 43 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 216.650208/3169, current 216.816483/3179: elapsed=166274.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 216.816483 last_received_ts = 216.815796 last_seq = 3179 current_ts = 216.982773 current_received_ts = 216.982101 current_seq = 3189 count = 44 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 216.816483/3179, current 216.982773/3189: elapsed=166284.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 216.982773 last_received_ts = 216.982101 last_seq = 3189 current_ts = 217.149063 current_received_ts = 217.148193 current_seq = 3199 count = 45 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 216.982773/3189, current 217.149063/3199: elapsed=166291.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 217.149063 last_received_ts = 217.148193 last_seq = 3199 current_ts = 217.315353 current_received_ts = 217.314499 current_seq = 3209 count = 46 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 217.149063/3199, current 217.315353/3209: elapsed=166291.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 217.315353 last_received_ts = 217.314499 last_seq = 3209 current_ts = 217.481644 current_received_ts = 217.480789 current_seq = 3219 count = 47 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 217.315353/3209, current 217.481644/3219: elapsed=166291.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 217.481644 last_received_ts = 217.480789 last_seq = 3219 current_ts = 217.647934 current_received_ts = 217.647079 current_seq = 3229 count = 48 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 217.481644/3219, current 217.647934/3229: elapsed=166292.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 217.647934 last_received_ts = 217.647079 last_seq = 3229 current_ts = 217.814240 current_received_ts = 217.813385 current_seq = 3239 count = 49 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 217.647934/3229, current 217.814240/3239: elapsed=166300.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 217.814240 last_received_ts = 217.813385 last_seq = 3239 current_ts = 217.980560 current_received_ts = 217.979797 current_seq = 3249 count = 50 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 217.814240/3239, current 217.980560/3249: elapsed=166325.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 217.980560 last_received_ts = 217.979797 last_seq = 3249 current_ts = 218.146881 current_received_ts = 218.146103 current_seq = 3259 count = 51 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 217.980560/3249, current 218.146881/3259: elapsed=166319.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 218.146881 last_received_ts = 218.146103 last_seq = 3259 current_ts = 218.313202 current_received_ts = 218.312424 current_seq = 3269 count = 52 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 218.146881/3259, current 218.313202/3269: elapsed=166331.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 218.313202 last_received_ts = 218.312424 last_seq = 3269 current_ts = 218.479523 current_received_ts = 218.478745 current_seq = 3279 count = 53 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 218.313202/3269, current 218.479523/3279: elapsed=166316.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 218.479523 last_received_ts = 218.478745 last_seq = 3279 current_ts = 218.645844 current_received_ts = 218.645096 current_seq = 3289 count = 54 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 218.479523/3279, current 218.645844/3289: elapsed=166323.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 218.645844 last_received_ts = 218.645096 last_seq = 3289 current_ts = 218.812180 current_received_ts = 218.811432 current_seq = 3299 count = 55 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 218.645844/3289, current 218.812180/3299: elapsed=166340.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 218.812180 last_received_ts = 218.811432 last_seq = 3299 current_ts = 218.978531 current_received_ts = 218.977768 current_seq = 3309 count = 56 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 218.812180/3299, current 218.978531/3309: elapsed=166350.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 218.978531 last_received_ts = 218.977768 last_seq = 3309 current_ts = 219.144882 current_received_ts = 219.144196 current_seq = 3319 count = 57 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 218.978531/3309, current 219.144882/3319: elapsed=166350.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 219.144882 last_received_ts = 219.144196 last_seq = 3319 current_ts = 219.311249 current_received_ts = 219.310547 current_seq = 3329 count = 58 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 219.144882/3319, current 219.311249/3329: elapsed=166357.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 219.311249 last_received_ts = 219.310547 last_seq = 3329 current_ts = 219.477600 current_received_ts = 219.476868 current_seq = 3339 count = 59 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 219.311249/3329, current 219.477600/3339: elapsed=166353.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: name = vblank last_ts = 219.477600 last_received_ts = 219.476868 last_seq = 3339 current_ts = 219.643951 current_received_ts = 219.643250 current_seq = 3349 count = 60 seq_step = 10 (kms_flip:3527) DEBUG: vblank ts/seq: last 219.477600/3339, current 219.643951/3349: elapsed=166353.0us expected=165777.5us +- 828.9us, error 0.3% (kms_flip:3527) DEBUG: expected 611, counted 610, encoder type 2 (kms_flip:3527) DEBUG: dropped frames, expected 611, counted 610, encoder type 2 (kms_flip:3527) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674: (kms_flip:3527) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon) (kms_flip:3527) igt_core-INFO: Stack trace: (kms_flip:3527) igt_core-INFO: #0 ../lib/igt_core.c:2051 __igt_fail_assert() (kms_flip:3527) igt_core-INFO: #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0() (kms_flip:3527) igt_core-INFO: #2 ../tests/kms_flip.c:1845 run_test() (kms_flip:3527) igt_core-INFO: #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001() (kms_flip:3527) igt_core-INFO: #4 ../tests/kms_flip.c:2001 main() (kms_flip:3527) igt_core-INFO: #5 [__libc_init_first+0x8a] (kms_flip:3527) igt_core-INFO: #6 [__libc_start_main+0x8b] (kms_flip:3527) igt_core-INFO: #7 [_start+0x25] END ** Dynamic subtest A-eDP1: FAIL (14.801s) Starting dynamic subtest: B-eDP1 Dynamic subtest B-eDP1: SUCCESS (11.802s) Starting dynamic subtest: C-eDP1 Dynamic subtest C-eDP1: SUCCESS (11.625s) Subtest blocking-wf_vblank: FAIL (38.235s)
Dmesg	<6> [237.458220] Console: switching to colour dummy device 80x25 <6> [237.458441] [IGT] kms_flip: executing <7> [237.463752] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:198:DP-1] <7> [237.463769] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:198:DP-1] <7> [237.463889] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:198:DP-1] disconnected <7> [237.464125] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:210:DP-2] <7> [237.464134] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:210:DP-2] <7> [237.464257] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:210:DP-2] disconnected <7> [237.464506] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:218:DP-3] <7> [237.464513] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:218:DP-3] <7> [237.464608] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:218:DP-3] disconnected <7> [237.464855] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:189:eDP-1] <7> [237.464861] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:189:eDP-1] <7> [237.465519] 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> [237.466040] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] source rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 675000, 810000 <7> [237.466145] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] sink rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 810000 <7> [237.466231] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] common rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 810000 <7> [237.466337] 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> [237.466343] [drm] DisplayID checksum invalid, remainder is 248 <5> [237.466345] [drm] DisplayID checksum invalid, remainder is 248 <7> [237.466346] 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> [237.466349] [drm] DisplayID checksum invalid, remainder is 248 <7> [237.466350] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:189:eDP-1] ELD monitor <5> [237.466352] [drm] DisplayID checksum invalid, remainder is 248 <7> [237.466354] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:189:eDP-1] ELD size 20, SAD count 0 <5> [237.466356] [drm] DisplayID checksum invalid, remainder is 248 <7> [237.466370] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:189:eDP-1] VRR capable: yes <7> [237.466452] 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> [237.467141] 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> [237.467224] 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> [237.468241] [drm] DisplayID checksum invalid, remainder is 248 <5> [237.468243] [drm] DisplayID checksum invalid, remainder is 248 <5> [237.468244] [drm] DisplayID checksum invalid, remainder is 248 <7> [237.468276] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:189:eDP-1] probed modes: <7> [237.468287] 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> [237.468308] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:198:DP-1] <7> [237.468317] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:198:DP-1] <7> [237.468431] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:198:DP-1] disconnected <7> [237.468447] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:210:DP-2] <7> [237.468455] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:210:DP-2] <7> [237.468563] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:210:DP-2] disconnected <7> [237.468577] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:218:DP-3] <7> [237.468585] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:218:DP-3] <7> [237.468689] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:218:DP-3] disconnected <6> [237.469103] [IGT] kms_flip: starting subtest blocking-wf_vblank <6> [237.470266] [IGT] kms_flip: starting dynamic subtest A-eDP1 <7> [237.470728] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:227] <7> [237.470913] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:228] <7> [237.554690] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A] <7> [237.554912] 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> [237.555212] 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> [237.555463] 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> [237.555743] 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> [237.555980] 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> [237.556198] 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> [237.556417] 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> [237.556633] 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> [237.556882] 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> [237.557081] 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> [237.557277] 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> [237.557472] 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> [237.557678] 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> [237.557893] 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> [237.558081] 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> [237.558256] 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> [237.558427] 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> [237.558628] 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> [237.558840] 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> [237.559003] 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> [237.559161] 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> [237.559316] 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> [237.559469] 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> [237.559620] 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> [237.559869] 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> [237.560038] 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> [237.560172] 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> [237.560308] 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> [237.560442] 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> [237.560576] 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> [237.560733] 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> [237.560862] 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> [237.561008] 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> [237.561156] 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> [237.561282] 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> [237.561403] 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> [237.561521] 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> [237.561640] 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> [237.561782] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset <7> [237.561968] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no <7> [237.562088] 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> [237.562267] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] ddb ( 0 - 4054) -> ( 0 - 0), size 4054 -> 0 <7> [237.562380] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:77:cursor A] ddb (4054 - 4096) -> ( 0 - 0), size 42 -> 0 <7> [237.562483] 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> [237.562573] 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> [237.562663] 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> [237.562775] 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> [237.562863] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:82:pipe A] data rate 0 num active planes 0 <7> [237.562980] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400 <7> [237.563094] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400 <7> [237.563200] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400 <7> [237.563305] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400 <7> [237.563406] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0 <7> [237.563509] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing <7> [237.563609] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz <7> [237.563722] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0 <7> [237.563848] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:82:pipe A] enable: no [modeset] <7> [237.563954] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:32:plane 1A] fb: [NOFB], visible: no <7> [237.564047] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:41:plane 2A] fb: [NOFB], visible: no <7> [237.564140] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:50:plane 3A] fb: [NOFB], visible: no <7> [237.564232] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:59:plane 4A] fb: [NOFB], visible: no <7> [237.564322] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:68:plane 5A] fb: [NOFB], visible: no <7> [237.564412] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:77:cursor A] fb: [NOFB], visible: no <7> [237.564557] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [237.564674] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [237.564857] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2 <7> [237.581852] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]] <7> [237.785042] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 0 <7> [237.785282] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe A <7> [237.805807] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turn panel power off <7> [237.806061] 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> [237.806265] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [237.806335] 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> [237.806529] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [237.858498] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [237.858689] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [237.876920] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [237.877205] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [237.877266] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A <7> [237.877554] xe 0000:00:02.0: [drm:__intel_fbc_disable [xe]] Disabling FBC on [PLANE:32:plane 1A] <7> [237.877960] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A] <7> [237.878080] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [237.878135] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1] <7> [237.878282] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A] <7> [237.878424] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B] <7> [237.878581] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C] <7> [237.878718] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2] <7> [237.878850] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A] <7> [237.878980] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B] <7> [237.879109] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C] <7> [237.879238] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3] <7> [237.879367] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A] <7> [237.879497] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B] <7> [237.879648] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C] <7> [237.879783] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1] <7> [237.879962] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [237.880113] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: ) <7> [237.880249] 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> [237.880454] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [237.880638] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384 <7> [237.880834] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1 <7> [237.881115] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_A <7> [237.881412] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:82:pipe A] <7> [237.881698] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B] <7> [237.882034] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:186:pipe C] <7> [237.882266] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A] <7> [237.882336] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:189:eDP-1] <7> [237.882510] 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> [237.882782] 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> [237.882960] 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> [237.883146] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:82:pipe A] hw max bpp: 30, pipe bpp: 30, dithering: 0 <7> [237.883330] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:188:DDI A/PHY A] [CRTC:82:pipe A] <7> [237.883520] 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> [237.883723] 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> [237.883906] 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> [237.884084] 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> [237.884261] 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> [237.884438] 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> [237.884633] 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> [237.884812] 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> [237.884988] 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> [237.885163] 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> [237.885336] 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> [237.885509] 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> [237.885701] 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> [237.885877] 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> [237.886052] 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> [237.886225] 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> [237.886398] 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> [237.886589] 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> [237.886765] 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> [237.886939] 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> [237.887112] 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> [237.887284] 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> [237.887457] 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> [237.887649] 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> [237.887826] 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> [237.888000] 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> [237.888175] 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> [237.888346] 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> [237.888519] 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> [237.888739] 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> [237.888915] 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> [237.889087] 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> [237.889249] 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> [237.889410] 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> [237.889636] 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> [237.889796] 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> [237.889948] 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> [237.890099] 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> [237.890246] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset <7> [237.890668] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes <7> [237.890808] 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> [237.891007] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] ddb ( 0 - 0) -> ( 0 - 4054), size 0 -> 4054 <7> [237.891111] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:77:cursor A] ddb ( 0 - 0) -> (4054 - 4096), size 0 -> 42 <7> [237.891206] 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> [237.891299] 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> [237.891389] 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> [237.891478] 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> [237.891567] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:82:pipe A] data rate 1390840 num active planes 1 <7> [237.891734] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400 <7> [237.891876] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400 <7> [237.892003] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400 <7> [237.892127] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400 <7> [237.892245] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461 <7> [237.892365] 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> [237.892485] xe 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [xe]] new bandwidth min cdclk (27165 kHz) > old min cdclk (0 kHz) <7> [237.892616] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing <7> [237.892735] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz <7> [237.892849] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0 <7> [237.892997] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:82:pipe A] enable: yes [modeset] <7> [237.893113] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB <7> [237.893226] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 30, dithering: 0 <7> [237.893331] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid> <7> [237.893436] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7> [237.893538] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0 <7> [237.893648] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0 <7> [237.893753] 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> [237.893855] 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> [237.893954] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled <7> [237.894053] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled <7> [237.894149] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled <7> [237.894244] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0 <7> [237.894335] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4 <7> [237.894428] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14 <7> [237.894521] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB <7> [237.894619] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB <7> [237.894712] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0 <7> [237.894801] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range <7> [237.894888] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined <7> [237.894976] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1 <7> [237.895062] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0 <7> [237.895149] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, vmin: 1906, vmax: 2859, flipline: 1906, pipeline full: 0, guardband: 106 vsync start: 103, vsync end: 97 <7> [237.895237] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1800, vmax vblank: 2753, vmin vtotal: 1906, vmax vtotal: 2859 <7> [237.895324] 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> [237.895412] 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> [237.895499] 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> [237.895587] 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> [237.895694] 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> [237.895785] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710 <7> [237.895873] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0 <7> [237.895961] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0 <7> [237.896048] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no <7> [237.896134] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0 <7> [237.896220] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dpll_hw_state: dpll: 0x69780, dpll_md: 0x42110, fp0: 0x1a2, fp1: 0x1000000 <7> [237.896307] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7> [237.896393] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries <7> [237.896479] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000 <7> [237.896565] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [237.896662] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [237.896751] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [237.896837] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000 <7> [237.896922] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000 <7> [237.897007] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [237.897094] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [237.897180] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [237.897265] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000 <7> [237.897352] 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> [237.897441] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7> [237.897528] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0 <7> [237.897616] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:41:plane 2A] fb: [NOFB], visible: no <7> [237.897712] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:50:plane 3A] fb: [NOFB], visible: no <7> [237.897801] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:59:plane 4A] fb: [NOFB], visible: no <7> [237.897887] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:68:plane 5A] fb: [NOFB], visible: no <7> [237.897973] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:77:cursor A] fb: [NOFB], visible: no <7> [237.898321] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [237.898407] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [237.898480] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10 <7> [237.898658] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [237.899677] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [237.900050] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [237.900183] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02 <7> [237.901287] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [237.901388] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [237.901527] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_A <7> [237.901709] 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> [237.901818] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [237.901915] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480 <7> [237.902005] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A] <7> [237.902074] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1] <7> [237.902140] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A] <7> [237.902206] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B] <7> [237.902270] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C] <7> [237.902335] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2] <7> [237.902399] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A] <7> [237.902464] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B] <7> [237.902528] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C] <7> [237.902593] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3] <7> [237.902667] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A] <7> [237.902736] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B] <7> [237.902802] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C] <7> [237.902868] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf <7> [237.903034] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: ) <7> [237.903105] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes) <7> [237.903188] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A <7> [237.904512] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turn panel power on <7> [237.904596] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 wait for panel power cycle (473 ms remaining) <7> [238.388624] 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> [238.388900] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [238.389160] 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> [238.389516] 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> [238.426016] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [238.426235] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [238.426430] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20 <7> [238.426895] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [238.533252] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port F/TC#3: TC port mode reset (tbt-alt -> disconnected) <7> [238.533378] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port E/TC#2: TC port mode reset (tbt-alt -> disconnected) <7> [238.533463] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port D/TC#1: TC port mode reset (tbt-alt -> disconnected) <7> [238.718567] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [238.720770] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD on <7> [238.721117] 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> [238.724628] 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> [238.725955] 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> [238.727116] 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> [238.728343] 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> [238.729463] 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> [238.730801] 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> [238.731095] 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> [238.732822] 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> [238.733125] 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> [238.733909] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe A <7> [238.734391] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]] <7> [238.734701] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe A <7> [238.735037] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 4518 <7> [238.736094] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] reserved 10600448 bytes of contiguous stolen space for FBC, limit: 2 <7> [238.736424] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] Enabling FBC on [PLANE:32:plane 1A] <7> [238.751172] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2 <7> [238.752963] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1] <7> [238.753342] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:82:pipe A] <7> [238.773479] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [238.773853] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [238.774159] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02 <7> [239.037728] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [239.038284] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [239.069024] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [239.069376] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [239.069680] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02 <7> [241.297814] 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> [241.298221] 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> [252.271891] [IGT] kms_flip: finished subtest A-eDP1, FAIL <6> [252.272446] [IGT] kms_flip: starting dynamic subtest B-eDP1 <7> [252.273122] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225] <7> [252.273402] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:230] <7> [252.377094] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A] <7> [252.377270] 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> [252.377432] 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> [252.377553] 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> [252.377685] 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> [252.377799] 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> [252.377913] 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> [252.378021] 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> [252.378128] 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> [252.378235] 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> [252.378341] 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> [252.378445] 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> [252.378550] 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> [252.378661] 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> [252.378762] 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> [252.378863] 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> [252.378963] 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> [252.379067] 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> [252.379171] 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> [252.379275] 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> [252.379380] 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> [252.379485] 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> [252.379597] 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> [252.379716] 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> [252.379820] 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> [252.379920] 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> [252.380020] 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> [252.380118] 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> [252.380215] 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> [252.380313] 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> [252.380412] 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> [252.380510] 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> [252.380616] 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> [252.380718] 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> [252.380821] 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> [252.380926] 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> [252.381030] 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> [252.381134] 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> [252.381237] 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> [252.381342] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset <7> [252.381518] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no <7> [252.381629] 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> [252.381785] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] ddb ( 0 - 4054) -> ( 0 - 0), size 4054 -> 0 <7> [252.381867] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:77:cursor A] ddb (4054 - 4096) -> ( 0 - 0), size 42 -> 0 <7> [252.381944] 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> [252.382018] 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> [252.382092] 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> [252.382166] 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> [252.382240] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:82:pipe A] data rate 0 num active planes 0 <7> [252.382351] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400 <7> [252.382457] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400 <7> [252.382561] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400 <7> [252.382678] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400 <7> [252.382785] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0 <7> [252.382893] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing <7> [252.382998] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz <7> [252.383097] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0 <7> [252.383237] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:82:pipe A] enable: no [modeset] <7> [252.383346] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:32:plane 1A] fb: [NOFB], visible: no <7> [252.383450] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:41:plane 2A] fb: [NOFB], visible: no <7> [252.383550] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:50:plane 3A] fb: [NOFB], visible: no <7> [252.383654] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:59:plane 4A] fb: [NOFB], visible: no <7> [252.383750] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:68:plane 5A] fb: [NOFB], visible: no <7> [252.383848] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:77:cursor A] fb: [NOFB], visible: no <7> [252.384017] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [252.384125] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [252.384273] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2 <7> [252.384466] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD on <7> [252.384587] 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> [252.401478] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]] <7> [252.602926] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 0 <7> [252.603599] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe A <7> [252.624797] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turn panel power off <7> [252.625173] 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> [252.625189] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [252.625495] 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> [252.625621] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [252.677776] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [252.678081] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [252.706936] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [252.707357] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A <7> [252.707761] xe 0000:00:02.0: [drm:__intel_fbc_disable [xe]] Disabling FBC on [PLANE:32:plane 1A] <7> [252.707794] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [252.708207] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [252.708439] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A] <7> [252.708716] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1] <7> [252.708967] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A] <7> [252.709236] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B] <7> [252.709480] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C] <7> [252.709730] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2] <7> [252.709973] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A] <7> [252.710232] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B] <7> [252.710472] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C] <7> [252.710708] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3] <7> [252.710944] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A] <7> [252.711206] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B] <7> [252.711447] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C] <7> [252.711687] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1] <7> [252.711986] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [252.712268] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: ) <7> [252.712515] 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> [252.712886] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [252.713216] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384 <7> [252.713572] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1 <7> [252.714036] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_A <7> [252.714513] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:82:pipe A] <7> [252.714925] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B] <7> [252.715442] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:186:pipe C] <7> [252.715769] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B] <7> [252.715876] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:189:eDP-1] <7> [252.716169] 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> [252.716605] 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> [252.716929] 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> [252.717084] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [252.717292] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:134:pipe B] hw max bpp: 30, pipe bpp: 30, dithering: 0 <7> [252.717372] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [252.717644] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10 <7> [252.717629] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:188:DDI A/PHY A] [CRTC:134:pipe B] <7> [252.717978] 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> [252.718068] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [252.718333] 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> [252.718663] 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> [252.718988] 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> [252.719334] 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> [252.719668] 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> [252.719993] 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> [252.720343] 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> [252.720670] 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> [252.720969] 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> [252.721280] 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> [252.721575] 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> [252.721858] 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> [252.722139] 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> [252.722400] 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> [252.722637] 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> [252.722873] 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> [252.723170] 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> [252.723399] 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> [252.723624] 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> [252.723846] 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> [252.724103] 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> [252.724308] 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> [252.724502] 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> [252.724691] 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> [252.724873] 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> [252.725073] 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> [252.725255] 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> [252.725429] 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> [252.725603] 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> [252.725773] 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> [252.725935] 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> [252.726115] 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> [252.726278] 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> [252.726437] 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> [252.726586] 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> [252.726727] 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> [252.726865] 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> [252.727003] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:134:pipe B] fastset requirement not met, forcing full modeset <7> [252.728168] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes <7> [252.728295] 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> [252.728480] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:84:plane 1B] ddb ( 0 - 0) -> ( 0 - 4054), size 0 -> 4054 <7> [252.728579] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:129:cursor B] ddb ( 0 - 0) -> (4054 - 4096), size 0 -> 42 <7> [252.728674] 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> [252.728763] 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> [252.728846] 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> [252.728926] 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> [252.729005] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:134:pipe B] data rate 1390840 num active planes 1 <7> [252.729148] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400 <7> [252.729253] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400 <7> [252.729355] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400 <7> [252.729453] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400 <7> [252.729546] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461 <7> [252.729642] 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> [252.729739] xe 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [xe]] new bandwidth min cdclk (27165 kHz) > old min cdclk (0 kHz) <7> [252.729836] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing <7> [252.729922] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz <7> [252.730006] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0 <7> [252.730150] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:134:pipe B] enable: yes [modeset] <7> [252.730246] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB <7> [252.730343] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: B, pipe bpp: 30, dithering: 0 <7> [252.730429] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid> <7> [252.730515] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7> [252.730600] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0 <7> [252.730682] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0 <7> [252.730766] 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> [252.730843] 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> [252.730919] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled <7> [252.730993] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled <7> [252.731077] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled <7> [252.731149] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0 <7> [252.731219] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4 <7> [252.731289] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14 <7> [252.731356] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB <7> [252.731423] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB <7> [252.731489] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0 <7> [252.731554] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range <7> [252.731616] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined <7> [252.731680] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1 <7> [252.731744] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0 <7> [252.731808] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, vmin: 1906, vmax: 2859, flipline: 1906, pipeline full: 0, guardband: 106 vsync start: 103, vsync end: 97 <7> [252.731871] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1800, vmax vblank: 2753, vmin vtotal: 1906, vmax vtotal: 2859 <7> [252.731933] 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> [252.731996] 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> [252.732082] 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> [252.732142] 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> [252.732200] 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> [252.732260] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710 <7> [252.732320] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0 <7> [252.732377] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0 <7> [252.732433] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no <7> [252.732490] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0 <7> [252.732547] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dpll_hw_state: dpll: 0x69780, dpll_md: 0x42110, fp0: 0x1a2, fp1: 0x1000000 <7> [252.732603] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7> [252.732659] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries <7> [252.732713] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000 <7> [252.732769] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [252.732824] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [252.732878] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [252.732933] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000 <7> [252.732991] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000 <7> [252.733055] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [252.733068] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [252.733114] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [252.733172] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [252.733232] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000 <7> [252.733217] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [252.733288] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:84:plane 1B] fb: [FB:225] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes <7> [252.733314] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02 <7> [252.733345] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7> [252.733399] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0 <7> [252.733423] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling always-on <7> [252.733454] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:93:plane 2B] fb: [NOFB], visible: no <7> [252.733509] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:102:plane 3B] fb: [NOFB], visible: no <7> [252.733563] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:111:plane 4B] fb: [NOFB], visible: no <7> [252.733617] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:120:plane 5B] fb: [NOFB], visible: no <7> [252.733671] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:129:cursor B] fb: [NOFB], visible: no <7> [252.735964] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling always-on <7> [252.736044] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [252.736113] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [252.736234] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_2 <7> [252.736346] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_B <7> [252.736466] 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> [252.736538] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [252.736617] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480 <7> [252.736681] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A] <7> [252.736738] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1] <7> [252.736794] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A] <7> [252.736849] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B] <7> [252.736902] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C] <7> [252.736955] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2] <7> [252.737008] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A] <7> [252.737078] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B] <7> [252.737135] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C] <7> [252.737204] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3] <7> [252.737272] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A] <7> [252.737324] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B] <7> [252.737376] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C] <7> [252.737429] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf <7> [252.737569] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: ) <7> [252.737627] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes) <7> [252.737695] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A <7> [252.739099] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turn panel power on <7> [252.739196] 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> [253.211790] 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> [253.222050] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [253.222395] 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> [253.222773] 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> [253.259208] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [253.259507] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [253.259750] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20 <7> [253.260223] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [253.518390] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [253.520555] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD on <7> [253.520915] 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> [253.524639] 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> [253.526024] 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> [253.527378] 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> [253.528638] 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> [253.529827] 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> [253.531276] 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> [253.531635] 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> [253.533392] 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> [253.533746] 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> [253.534597] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe B <7> [253.535128] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]] <7> [253.535502] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe B <7> [253.535902] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 4518 <7> [253.537110] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] reserved 10600448 bytes of contiguous stolen space for FBC, limit: 2 <7> [253.537474] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] Enabling FBC on [PLANE:84:plane 1B] <7> [253.551991] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2 <7> [253.553667] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1] <7> [253.554085] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:134:pipe B] <7> [253.574234] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [253.574600] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [253.574911] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02 <7> [253.838865] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [253.839149] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [253.870548] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [253.870927] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [253.871232] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02 <7> [256.110785] 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> [256.111328] 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> [264.017141] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:230] from all active usage due to RMFB ioctl <7> [264.017354] xe 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:84:plane 1B] because [FB:230] is removed <7> [264.017612] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:84:plane 1B] ddb ( 0 - 4054) -> ( 0 - 0), size 4054 -> 0 <7> [264.018078] 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> [264.018391] 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> [264.018700] 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> [264.019053] 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> [264.019376] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:134:pipe B] data rate 0 num active planes 0 <7> [264.019849] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400 <7> [264.020327] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400 <7> [264.020758] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400 <7> [264.021156] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400 <7> [264.021533] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0 <7> [264.022097] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [264.023318] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [264.023780] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2 <7> [264.036385] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD on <7> [264.036793] 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> [264.050301] xe 0000:00:02.0: [drm:__intel_fbc_disable [xe]] Disabling FBC on [PLANE:84:plane 1B] <6> [264.075605] [IGT] kms_flip: finished subtest B-eDP1, SUCCESS <6> [264.077954] [IGT] kms_flip: starting dynamic subtest C-eDP1 <7> [264.080505] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:225] <7> [264.081660] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:229] <7> [264.085030] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [264.085403] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [264.085672] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02 <7> [264.172114] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A] <7> [264.172517] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [264.172847] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [264.173400] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B] <7> [264.173621] 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> [264.173882] 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> [264.174133] 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> [264.174344] 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> [264.174546] 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> [264.174740] 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> [264.174924] 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> [264.175119] 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> [264.175300] 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> [264.175472] 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> [264.175645] 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> [264.175822] 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> [264.175997] 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> [264.176180] 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> [264.176345] 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> [264.176507] 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> [264.176670] 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> [264.176826] 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> [264.176985] 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> [264.177170] 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> [264.177317] 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> [264.177458] 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> [264.177597] 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> [264.177736] 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> [264.177876] 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> [264.178012] 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> [264.178192] 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> [264.178330] 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> [264.178465] 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> [264.178604] 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> [264.178741] 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> [264.178878] 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> [264.179014] 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> [264.179173] 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> [264.179304] 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> [264.179424] 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> [264.179535] 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> [264.179647] 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> [264.179762] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:134:pipe B] fastset requirement not met, forcing full modeset <7> [264.179979] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no <7> [264.180111] 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> [264.180309] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:129:cursor B] ddb (4054 - 4096) -> ( 0 - 0), size 42 -> 0 <7> [264.180428] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing <7> [264.180560] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz <7> [264.180687] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0 <7> [264.180861] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:134:pipe B] enable: no [modeset] <7> [264.180991] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:84:plane 1B] fb: [NOFB], visible: no <7> [264.181157] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:93:plane 2B] fb: [NOFB], visible: no <7> [264.181276] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:102:plane 3B] fb: [NOFB], visible: no <7> [264.181376] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:111:plane 4B] fb: [NOFB], visible: no <7> [264.181476] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:120:plane 5B] fb: [NOFB], visible: no <7> [264.181573] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:129:cursor B] fb: [NOFB], visible: no <7> [264.181969] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]] <7> [264.389243] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 0 <7> [264.390141] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe B <7> [264.400753] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turn panel power off <7> [264.401243] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [264.401676] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [264.402165] 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> [264.402632] 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> [264.454820] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [264.455066] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [264.485266] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [264.485638] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A <7> [264.486044] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A] <7> [264.486046] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [264.486319] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1] <7> [264.486457] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [264.486547] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A] <7> [264.486781] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B] <7> [264.487001] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C] <7> [264.487218] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2] <7> [264.487457] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A] <7> [264.487676] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B] <7> [264.487893] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C] <7> [264.488110] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3] <7> [264.488358] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A] <7> [264.488576] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B] <7> [264.488790] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C] <7> [264.489003] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1] <7> [264.489336] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [264.489573] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: ) <7> [264.489795] 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> [264.490132] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [264.490410] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384 <7> [264.490730] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1 <7> [264.491135] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_B <7> [264.491579] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_2 <7> [264.491993] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:134:pipe B] <7> [264.492511] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:186:pipe C] <7> [264.492960] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:186:pipe C] <7> [264.493031] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:189:eDP-1] <7> [264.493206] 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> [264.493642] 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> [264.493856] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [264.493959] 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> [264.494112] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [264.494268] xe 0000:00:02.0: [drm:intel_psr_compute_config [xe]] PSR2 not supported in transcoder C <7> [264.494355] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10 <7> [264.494599] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:186:pipe C] hw max bpp: 30, pipe bpp: 30, dithering: 0 <7> [264.494720] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [264.494898] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:188:DDI A/PHY A] [CRTC:186:pipe C] <7> [264.495199] 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> [264.495538] 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> [264.495844] 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> [264.496109] 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> [264.496405] 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> [264.496678] 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> [264.496944] 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> [264.497214] 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> [264.497538] 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> [264.497829] 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> [264.498085] 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> [264.498365] 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> [264.498621] 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> [264.498907] 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> [264.499159] 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> [264.499440] 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> [264.499692] 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> [264.499941] 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> [264.500234] 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> [264.500513] 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> [264.500765] 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> [264.500989] 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> [264.501206] 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> [264.501529] 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> [264.501759] 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> [264.501954] 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> [264.502141] 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> [264.502338] 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> [264.502548] 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> [264.502723] 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> [264.502893] 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> [264.503059] 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> [264.503215] 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> [264.503394] 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> [264.503554] 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> [264.503710] 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> [264.503861] 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> [264.504028] 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> [264.504192] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:186:pipe C] fastset requirement not met, forcing full modeset <7> [264.504470] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xd (total dbuf slices 0xf), mbus joined? no->no <7> [264.504607] 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> [264.504774] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:136:plane 1C] ddb ( 0 - 0) -> ( 0 - 2006), size 0 -> 2006 <7> [264.504892] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:181:cursor C] ddb ( 0 - 0) -> (2006 - 2048), size 0 -> 42 <7> [264.505005] 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> [264.505110] 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> [264.505214] 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> [264.505357] 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> [264.505463] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:186:pipe C] data rate 1390840 num active planes 1 <7> [264.505600] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400 <7> [264.505732] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400 <7> [264.505861] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400 <7> [264.505984] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400 <7> [264.506100] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461 <7> [264.506265] 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> [264.506406] xe 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [xe]] new bandwidth min cdclk (27165 kHz) > old min cdclk (0 kHz) <7> [264.506520] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing <7> [264.506629] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz <7> [264.506736] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0 <7> [264.506873] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:186:pipe C] enable: yes [modeset] <7> [264.506998] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB <7> [264.507120] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: C, pipe bpp: 30, dithering: 0 <7> [264.507228] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid> <7> [264.507342] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7> [264.507440] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0 <7> [264.507533] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0 <7> [264.507624] 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> [264.507715] 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> [264.507804] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled <7> [264.507893] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled <7> [264.507976] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: disabled, panel replay: disabled, selective fetch: disabled <7> [264.508059] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0 <7> [264.508139] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4 <7> [264.508221] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 2, length 8 <7> [264.508311] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB <7> [264.508390] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB <7> [264.508467] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0 <7> [264.508542] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range <7> [264.508616] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined <7> [264.508690] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1 <7> [264.508765] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0 <7> [264.508839] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, vmin: 1906, vmax: 2859, flipline: 1906, pipeline full: 0, guardband: 106 vsync start: 103, vsync end: 97 <7> [264.508910] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1800, vmax vblank: 2753, vmin vtotal: 1906, vmax vtotal: 2859 <7> [264.508979] 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> [264.509047] 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> [264.509113] 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> [264.509179] 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> [264.509245] 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> [264.509327] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710 <7> [264.509393] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0 <7> [264.509456] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0 <7> [264.509519] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no <7> [264.509582] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0 <7> [264.509644] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dpll_hw_state: dpll: 0x69780, dpll_md: 0x42110, fp0: 0x1a2, fp1: 0x1000000 <7> [264.509707] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7> [264.509768] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries <7> [264.509827] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000 <7> [264.509885] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [264.509944] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [264.510003] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [264.510061] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000 <7> [264.510119] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000 <7> [264.510175] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [264.510231] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [264.510307] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [264.510367] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000 <7> [264.510399] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [264.510431] 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> [264.510502] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7> [264.510522] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [264.510563] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0 <7> [264.510615] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02 <7> [264.510626] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:145:plane 2C] fb: [NOFB], visible: no <7> [264.510687] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:154:plane 3C] fb: [NOFB], visible: no <7> [264.510712] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling always-on <7> [264.510749] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:163:plane 4C] fb: [NOFB], visible: no <7> [264.510811] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:172:plane 5C] fb: [NOFB], visible: no <7> [264.510871] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:181:cursor C] fb: [NOFB], visible: no <7> [264.513577] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling always-on <7> [264.513655] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [264.513732] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [264.513853] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_2 <7> [264.513973] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_C <7> [264.514097] 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> [264.514170] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [264.514257] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480 <7> [264.514322] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A] <7> [264.514386] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1] <7> [264.514450] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A] <7> [264.514504] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B] <7> [264.514557] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C] <7> [264.514609] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2] <7> [264.514661] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A] <7> [264.514712] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B] <7> [264.514763] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C] <7> [264.514812] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3] <7> [264.514860] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A] <7> [264.514908] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B] <7> [264.514955] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C] <7> [264.515003] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xd <7> [264.515152] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no) <7> [264.515219] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A <7> [264.516379] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turn panel power on <7> [264.516478] 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> [264.989805] 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> [265.068830] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [265.069121] 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> [265.069366] 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> [265.105923] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [265.106244] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [265.106530] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20 <7> [265.107075] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [265.335069] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [265.337221] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD on <7> [265.337558] 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> [265.341214] 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> [265.342595] 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> [265.343876] 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> [265.345140] 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> [265.346350] 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> [265.347723] 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> [265.348088] 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> [265.349757] 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> [265.350114] 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> [265.350954] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe C <7> [265.351403] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]] <7> [265.351727] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe C <7> [265.352122] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 4518 <7> [265.353138] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] reserved 10600448 bytes of contiguous stolen space for FBC, limit: 2 <7> [265.353457] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] Enabling FBC on [PLANE:136:plane 1C] <7> [265.368227] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR1 <7> [265.369755] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1] <7> [265.370154] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:186:pipe C] <7> [267.894900] 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> [267.895390] 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> [275.666631] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:229] from all active usage due to RMFB ioctl <7> [275.666750] xe 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:136:plane 1C] because [FB:229] is removed <7> [275.666900] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:136:plane 1C] ddb ( 0 - 2006) -> ( 0 - 0), size 2006 -> 0 <7> [275.667096] 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> [275.667224] 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> [275.667385] 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> [275.667498] 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> [275.667612] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:186:pipe C] data rate 0 num active planes 0 <7> [275.667788] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400 <7> [275.667957] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400 <7> [275.668119] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400 <7> [275.668295] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400 <7> [275.668452] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0 <7> [275.668704] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR1 <7> [275.668875] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD on <7> [275.669040] 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> [275.683171] xe 0000:00:02.0: [drm:__intel_fbc_disable [xe]] Disabling FBC on [PLANE:136:plane 1C] <6> [275.703617] [IGT] kms_flip: finished subtest C-eDP1, SUCCESS <6> [275.704844] [IGT] kms_flip: finished subtest blocking-wf_vblank, FAIL <7> [275.718356] 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> [275.718511] 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> [275.718607] 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> [275.718704] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:82:pipe A] hw max bpp: 30, pipe bpp: 30, dithering: 0 <7> [275.718806] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:188:DDI A/PHY A] [CRTC:82:pipe A] <7> [275.718901] 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> [275.718990] 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> [275.719075] 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> [275.719160] 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> [275.719243] 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> [275.719351] 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> [275.719436] 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> [275.719524] 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> [275.719613] 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> [275.719700] 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> [275.719783] 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> [275.719865] 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> [275.719949] 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> [275.720032] 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> [275.720115] 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> [275.720195] 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> [275.720289] 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> [275.720372] 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> [275.720455] 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> [275.720535] 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> [275.720615] 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> [275.720696] 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> [275.720775] 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> [275.720856] 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> [275.720939] 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> [275.721022] 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> [275.721105] 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> [275.721188] 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> [275.721332] 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> [275.721419] 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> [275.721501] 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> [275.721581] 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> [275.721661] 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> [275.721740] 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> [275.721821] 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> [275.721901] 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> [275.721980] 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> [275.722059] 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> [275.722140] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset <7> [275.722220] 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> [275.722324] 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> [275.722426] 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> [275.722516] 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> [275.722609] 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> [275.722700] 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> [275.722798] 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> [275.722896] 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> [275.722986] 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> [275.723068] 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> [275.723156] 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> [275.723243] 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> [275.723354] 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> [275.723442] 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> [275.723528] 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> [275.723608] 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> [275.723687] 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> [275.723767] 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> [275.723845] 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> [275.723924] 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> [275.724007] 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> [275.724094] 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> [275.724188] 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> [275.724287] 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> [275.724379] 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> [275.724473] 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> [275.724566] 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> [275.724651] 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> [275.724736] 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> [275.724824] 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> [275.724910] 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> [275.724990] 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> [275.725069] 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> [275.725147] 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> [275.725227] 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> [275.725711] 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> [275.725814] 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> [275.725905] 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> [275.725998] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:186:pipe C] fastset requirement not met, forcing full modeset <7> [275.726465] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xd -> 0xf (total dbuf slices 0xf), mbus joined? no->yes <7> [275.726576] 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> [275.726645] 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> [275.726761] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:32:plane 1A] ddb ( 0 - 0) -> ( 0 - 4054), size 0 -> 4054 <7> [275.726837] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:77:cursor A] ddb ( 0 - 0) -> (4054 - 4096), size 0 -> 42 <7> [275.726899] 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> [275.726960] 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> [275.727020] 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> [275.727079] 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> [275.727140] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:181:cursor C] ddb (2006 - 2048) -> ( 0 - 0), size 42 -> 0 <7> [275.727203] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:82:pipe A] data rate 1390840 num active planes 1 <7> [275.727319] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400 <7> [275.727426] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400 <7> [275.727517] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400 <7> [275.727604] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400 <7> [275.727691] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461 <7> [275.727778] 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> [275.727875] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz <7> [275.727964] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0 <7> [275.728081] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:82:pipe A] enable: yes [modeset] <7> [275.728173] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB <7> [275.728271] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 30, dithering: 0 <7> [275.728360] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid> <7> [275.728446] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0 <7> [275.728532] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0 <7> [275.728620] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0 <7> [275.728708] 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> [275.728795] 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> [275.728884] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled <7> [275.728971] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled <7> [275.729057] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled <7> [275.729144] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0 <7> [275.729231] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4 <7> [275.729357] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14 <7> [275.729446] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB <7> [275.729533] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB <7> [275.729618] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0 <7> [275.729703] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range <7> [275.729788] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined <7> [275.729874] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1 <7> [275.729960] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0 <7> [275.730047] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, vmin: 1906, vmax: 2859, flipline: 1906, pipeline full: 0, guardband: 106 vsync start: 103, vsync end: 97 <7> [275.730137] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1800, vmax vblank: 2753, vmin vtotal: 1906, vmax vtotal: 2859 <7> [275.730223] 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> [275.730321] 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> [275.730412] 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> [275.730501] 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> [275.730588] 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> [275.730673] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710 <7> [275.730759] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0 <7> [275.730843] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0 <7> [275.730927] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no <7> [275.731013] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0 <7> [275.731099] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dpll_hw_state: dpll: 0x69780, dpll_md: 0x42110, fp0: 0x1a2, fp1: 0x1000000 <7> [275.731186] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0 <7> [275.731283] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries <7> [275.731373] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000 <7> [275.731459] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [275.731544] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [275.731630] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000 <7> [275.731715] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000 <7> [275.731798] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000 <7> [275.731882] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [275.731966] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [275.732049] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000 <7> [275.732132] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000 <7> [275.732217] 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> [275.732312] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0 <7> [275.732408] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0 <7> [275.732506] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:41:plane 2A] fb: [NOFB], visible: no <7> [275.732607] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:50:plane 3A] fb: [NOFB], visible: no <7> [275.732698] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:59:plane 4A] fb: [NOFB], visible: no <7> [275.732794] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:68:plane 5A] fb: [NOFB], visible: no <7> [275.732893] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:77:cursor A] fb: [NOFB], visible: no <7> [275.732989] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:186:pipe C] enable: no [modeset] <7> [275.733077] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:136:plane 1C] fb: [NOFB], visible: no <7> [275.733174] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:145:plane 2C] fb: [NOFB], visible: no <7> [275.733317] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:154:plane 3C] fb: [NOFB], visible: no <7> [275.733418] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:163:plane 4C] fb: [NOFB], visible: no <7> [275.733509] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:172:plane 5C] fb: [NOFB], visible: no <7> [275.733594] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:181:cursor C] fb: [NOFB], visible: no <7> [275.733829] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_A <7> [275.734946] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]] <7> [275.939403] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 0 <7> [275.940029] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe C <7> [275.950752] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turn panel power off <7> [275.950957] 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> [275.951137] 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> [275.951169] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [275.951374] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [276.003642] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000 <7> [276.003833] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - short <7> [276.019247] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [276.019627] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A <7> [276.019932] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:188:DDI A/PHY A] <7> [276.019968] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [276.020109] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:197:DDI TC1/PHY TC1] <7> [276.020304] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:199:DP-MST A] <7> [276.020328] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [276.020473] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:200:DP-MST B] <7> [276.020639] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:201:DP-MST C] <7> [276.020801] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:209:DDI TC2/PHY TC2] <7> [276.020963] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:211:DP-MST A] <7> [276.021124] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DP-MST B] <7> [276.021301] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DP-MST C] <7> [276.021464] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DDI TC3/PHY TC3] <7> [276.021627] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST A] <7> [276.021790] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST B] <7> [276.021950] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:221:DP-MST C] <7> [276.022767] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf <7> [276.023080] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: ) <7> [276.023273] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes) <7> [276.023466] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A <7> [276.024942] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turn panel power on <7> [276.025140] 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> [276.042194] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [276.042411] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [276.042608] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10 <7> [276.042956] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [276.523327] 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> [276.564120] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [276.564378] 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> [276.564638] 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> [276.601146] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010 <7> [276.601339] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:188:DDI A/PHY A] - long <7> [276.601516] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20 <7> [276.601971] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:188:DDI A/PHY A] <7> [276.890033] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete <7> [276.892191] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD on <7> [276.892515] 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> [276.896033] 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> [276.897357] 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> [276.898425] 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> [276.899562] 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> [276.900629] 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> [276.901952] 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> [276.902243] 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> [276.903929] 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> [276.904208] 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> [276.904942] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe A <7> [276.905416] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]] <7> [276.905712] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe A <7> [276.906081] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:189:eDP-1] set backlight PWM = 4518 <7> [276.907220] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] reserved 11059200 bytes of contiguous stolen space for FBC, limit: 2 <7> [276.907503] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] Enabling FBC on [PLANE:32:plane 1A] <7> [276.922151] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2 <7> [276.923978] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:189:eDP-1] <7> [276.924345] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:82:pipe A] <7> [276.926600] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_C <7> [276.927837] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_2 <7> [276.928277] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:186:pipe C] <7> [276.928752] xe 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0 <6> [276.930156] [IGT] kms_flip: exiting, ret=98 <6> [276.939452] Console: switching to colour frame buffer device 180x56 <7> [276.973036] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off <7> [276.973160] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6 <7> [276.973247] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02

Created at 2025-02-13 20:34:34