Results for igt@kms_vrr@seamless-rr-switch-virtual@pipe-a-edp-1

Result: Fail

i915_display_info18 igt_runner18 results18.json results18-xe-load.json guc_logs18.tar i915_display_info_post_exec18 serial_data18 boot18 dmesg18

DetailValue
Duration 6.14 seconds
Hostname
shard-lnl-2
Igt-Version
IGT-Version: 2.4-g98b65acc4 (x86_64) (Linux: 7.1.0-rc4-lgci-xe-xe-5116-127c8434a6a018110-debug+ x86_64)
Out
Using IGT_SRANDOM=1779465162 for randomisation
Opened device: /dev/dri/card0
Starting subtest: seamless-rr-switch-virtual
Default Mode:   2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa 
Starting dynamic subtest: pipe-A-eDP-1
Use HIGH_RR Mode as default
  2880x1800: 120 695310 2880 2928 2960 3040 1800 1803 1809 1906 0x40 0xa 
Requested rate[0]: 8333333 ns (120.00 Hz), Expected rate between: 8264462 ns (121.00 Hz) to 8403361 ns (119.00 Hz)
Completed 470 flips, 0 were in threshold for [(120 Hz) 8333333ns]
Stack trace:
  #0 ../lib/igt_core.c:2106 __igt_fail_assert()
  #1 ../tests/kms_vrr.c:773 test_seamless_virtual_rr_basic()
  #2 ../tests/kms_vrr.c:998 run_vrr_test.constprop.0()
  #3 ../tests/kms_vrr.c:1105 __igt_unique____real_main1046()
  #4 ../tests/kms_vrr.c:1046 main()
  #5 ../sysdeps/nptl/libc_start_call_main.h:74 __libc_start_call_main()
  #6 ../csu/libc-start.c:128 __libc_start_main@@GLIBC_2.34()
  #7 [_start+0x25]
Dynamic subtest pipe-A-eDP-1: FAIL (6.143s)
Subtest seamless-rr-switch-virtual: FAIL (6.442s)
Err
Starting subtest: seamless-rr-switch-virtual
Starting dynamic subtest: pipe-A-eDP-1
[468.049423] (kms_vrr:9106) CRITICAL: Test assertion failure function test_seamless_virtual_rr_basic, file ../tests/kms_vrr.c:776:
[468.049434] (kms_vrr:9106) CRITICAL: Failed assertion: result > 75
[468.049443] (kms_vrr:9106) CRITICAL: Refresh rate (120 Hz) 8333333ns: Target threshold not reached, result was 0%
Dynamic subtest pipe-A-eDP-1 failed.
**** DEBUG ****
commit {
[467.996223] (kms_vrr:9106) igt_kms-DEBUG: display:     populating plane data: A.0, fb 450
[467.996223] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_X" to 0x0/0
[467.996224] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_Y" to 0x0/0
[467.996224] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_W" to 0xb400000/188743680
[467.996225] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_H" to 0x7080000/117964800
[467.996225] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_W" to 0xb40/2880
[467.996226] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_H" to 0x708/1800
[467.996226] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "FB_ID" to 0x1c2/450
[467.996226] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_ID" to 0x97/151
[467.996227] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_ENCODING" to 0x0/0
[467.996227] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_RANGE" to 0x0/0
[467.998748] (kms_vrr:9106) igt_kms-DEBUG: display: }
[467.998754] (kms_vrr:9106) DEBUG: event_ns - last_event_ns: 16929000 (59.07 Hz)
[467.998755] (kms_vrr:9106) igt_kms-DEBUG: display: A.0: plane_set_fb(451)
[467.998755] (kms_vrr:9106) igt_kms-DEBUG: display: A.0: plane_set_size (2880x1800)
[467.998756] (kms_vrr:9106) igt_kms-DEBUG: display: A.0: fb_set_position(0,0)
[467.998757] (kms_vrr:9106) igt_kms-DEBUG: display: A.0: fb_set_size(2880x1800)
[467.998757] (kms_vrr:9106) igt_kms-DEBUG: display: commit {
[467.998758] (kms_vrr:9106) igt_kms-DEBUG: display:     populating plane data: A.0, fb 451
[467.998758] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_X" to 0x0/0
[467.998759] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_Y" to 0x0/0
[467.998759] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_W" to 0xb400000/188743680
[467.998760] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_H" to 0x7080000/117964800
[467.998760] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_W" to 0xb40/2880
[467.998760] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_H" to 0x708/1800
[467.998761] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "FB_ID" to 0x1c3/451
[467.998761] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_ID" to 0x97/151
[467.998762] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_ENCODING" to 0x0/0
[467.998762] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_RANGE" to 0x0/0
[468.005574] (kms_vrr:9106) igt_kms-DEBUG: display: }
[468.005576] (kms_vrr:9106) igt_kms-DEBUG: display: commit {
[468.005577] (kms_vrr:9106) igt_kms-DEBUG: display:     populating plane data: A.0, fb 451
[468.005579] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_X" to 0x0/0
[468.005580] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_Y" to 0x0/0
[468.005580] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_W" to 0xb400000/188743680
[468.005581] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_H" to 0x7080000/117964800
[468.005581] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_W" to 0xb40/2880
[468.005582] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_H" to 0x708/1800
[468.005582] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "FB_ID" to 0x1c3/451
[468.005582] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_ID" to 0x97/151
[468.005583] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_ENCODING" to 0x0/0
[468.005584] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_RANGE" to 0x0/0
[468.010096] (kms_vrr:9106) igt_kms-DEBUG: display: }
[468.010096] (kms_vrr:9106) igt_kms-DEBUG: display: commit {
[468.010097] (kms_vrr:9106) igt_kms-DEBUG: display:     populating plane data: A.0, fb 451
[468.010098] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_X" to 0x0/0
[468.010098] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_Y" to 0x0/0
[468.010099] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_W" to 0xb400000/188743680
[468.010099] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_H" to 0x7080000/117964800
[468.010100] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_W" to 0xb40/2880
[468.010100] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_H" to 0x708/1800
[468.010100] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "FB_ID" to 0x1c3/451
[468.010101] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_ID" to 0x97/151
[468.010101] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_ENCODING" to 0x0/0
[468.010102] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_RANGE" to 0x0/0
[468.014750] (kms_vrr:9106) igt_kms-DEBUG: display: }
[468.014751] (kms_vrr:9106) igt_kms-DEBUG: display: commit {
[468.014751] (kms_vrr:9106) igt_kms-DEBUG: display:     populating plane data: A.0, fb 451
[468.014752] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_X" to 0x0/0
[468.014752] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_Y" to 0x0/0
[468.014753] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_W" to 0xb400000/188743680
[468.014753] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_H" to 0x7080000/117964800
[468.014753] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_W" to 0xb40/2880
[468.014754] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_H" to 0x708/1800
[468.014754] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "FB_ID" to 0x1c3/451
[468.014755] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_ID" to 0x97/151
[468.014755] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_ENCODING" to 0x0/0
[468.014755] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_RANGE" to 0x0/0
[468.019086] (kms_vrr:9106) igt_kms-DEBUG: display: }
[468.019094] (kms_vrr:9106) DEBUG: event_ns - last_event_ns: 16928000 (59.07 Hz)
[468.019095] (kms_vrr:9106) igt_kms-DEBUG: display: A.0: plane_set_fb(450)
[468.019096] (kms_vrr:9106) igt_kms-DEBUG: display: A.0: plane_set_size (2880x1800)
[468.019097] (kms_vrr:9106) igt_kms-DEBUG: display: A.0: fb_set_position(0,0)
[468.019097] (kms_vrr:9106) igt_kms-DEBUG: display: A.0: fb_set_size(2880x1800)
[468.019098] (kms_vrr:9106) igt_kms-DEBUG: display: commit {
[468.019098] (kms_vrr:9106) igt_kms-DEBUG: display:     populating plane data: A.0, fb 450
[468.019099] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_X" to 0x0/0
[468.019099] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_Y" to 0x0/0
[468.019100] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_W" to 0xb400000/188743680
[468.019100] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_H" to 0x7080000/117964800
[468.019101] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_W" to 0xb40/2880
[468.019101] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_H" to 0x708/1800
[468.019101] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "FB_ID" to 0x1c2/450
[468.019102] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_ID" to 0x97/151
[468.019102] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_ENCODING" to 0x0/0
[468.019103] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_RANGE" to 0x0/0
[468.023781] (kms_vrr:9106) igt_kms-DEBUG: display: }
[468.023782] (kms_vrr:9106) igt_kms-DEBUG: display: commit {
[468.023782] (kms_vrr:9106) igt_kms-DEBUG: display:     populating plane data: A.0, fb 450
[468.023783] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_X" to 0x0/0
[468.023783] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_Y" to 0x0/0
[468.023784] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_W" to 0xb400000/188743680
[468.023784] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_H" to 0x7080000/117964800
[468.023784] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_W" to 0xb40/2880
[468.023785] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_H" to 0x708/1800
[468.023785] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "FB_ID" to 0x1c2/450
[468.023786] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_ID" to 0x97/151
[468.023786] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_ENCODING" to 0x0/0
[468.023786] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_RANGE" to 0x0/0
[468.028482] (kms_vrr:9106) igt_kms-DEBUG: display: }
[468.028495] (kms_vrr:9106) DEBUG: event_ns - last_event_ns: 8470000 (118.06 Hz)
[468.028496] (kms_vrr:9106) igt_kms-DEBUG: display: A.0: plane_set_fb(451)
[468.028497] (kms_vrr:9106) igt_kms-DEBUG: display: A.0: plane_set_size (2880x1800)
[468.028498] (kms_vrr:9106) igt_kms-DEBUG: display: A.0: fb_set_position(0,0)
[468.028499] (kms_vrr:9106) igt_kms-DEBUG: display: A.0: fb_set_size(2880x1800)
[468.028499] (kms_vrr:9106) igt_kms-DEBUG: display: commit {
[468.028500] (kms_vrr:9106) igt_kms-DEBUG: display:     populating plane data: A.0, fb 451
[468.028501] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_X" to 0x0/0
[468.028502] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_Y" to 0x0/0
[468.028502] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_W" to 0xb400000/188743680
[468.028503] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_H" to 0x7080000/117964800
[468.028503] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_W" to 0xb40/2880
[468.028503] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_H" to 0x708/1800
[468.028504] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "FB_ID" to 0x1c3/451
[468.028504] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_ID" to 0x97/151
[468.028505] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_ENCODING" to 0x0/0
[468.028505] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_RANGE" to 0x0/0
[468.033017] (kms_vrr:9106) igt_kms-DEBUG: display: }
[468.033017] (kms_vrr:9106) igt_kms-DEBUG: display: commit {
[468.033018] (kms_vrr:9106) igt_kms-DEBUG: display:     populating plane data: A.0, fb 451
[468.033019] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_X" to 0x0/0
[468.033019] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_Y" to 0x0/0
[468.033020] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_W" to 0xb400000/188743680
[468.033020] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_H" to 0x7080000/117964800
[468.033021] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_W" to 0xb40/2880
[468.033021] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_H" to 0x708/1800
[468.033021] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "FB_ID" to 0x1c3/451
[468.033022] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_ID" to 0x97/151
[468.033022] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_ENCODING" to 0x0/0
[468.033023] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_RANGE" to 0x0/0
[468.037502] (kms_vrr:9106) igt_kms-DEBUG: display: }
[468.037502] (kms_vrr:9106) igt_kms-DEBUG: display: commit {
[468.037503] (kms_vrr:9106) igt_kms-DEBUG: display:     populating plane data: A.0, fb 451
[468.037503] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_X" to 0x0/0
[468.037504] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_Y" to 0x0/0
[468.037504] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_W" to 0xb400000/188743680
[468.037505] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_H" to 0x7080000/117964800
[468.037505] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_W" to 0xb40/2880
[468.037505] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_H" to 0x708/1800
[468.037506] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "FB_ID" to 0x1c3/451
[468.037506] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_ID" to 0x97/151
[468.037507] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_ENCODING" to 0x0/0
[468.037507] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_RANGE" to 0x0/0
[468.040035] (kms_vrr:9106) igt_kms-DEBUG: display: }
[468.040041] (kms_vrr:9106) DEBUG: event_ns - last_event_ns: 16930000 (59.07 Hz)
[468.040043] (kms_vrr:9106) igt_kms-DEBUG: display: A.0: plane_set_fb(450)
[468.040043] (kms_vrr:9106) igt_kms-DEBUG: display: A.0: plane_set_size (2880x1800)
[468.040044] (kms_vrr:9106) igt_kms-DEBUG: display: A.0: fb_set_position(0,0)
[468.040044] (kms_vrr:9106) igt_kms-DEBUG: display: A.0: fb_set_size(2880x1800)
[468.040045] (kms_vrr:9106) igt_kms-DEBUG: display: commit {
[468.040045] (kms_vrr:9106) igt_kms-DEBUG: display:     populating plane data: A.0, fb 450
[468.040046] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_X" to 0x0/0
[468.040046] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_Y" to 0x0/0
[468.040047] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_W" to 0xb400000/188743680
[468.040047] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_H" to 0x7080000/117964800
[468.040048] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_W" to 0xb40/2880
[468.040048] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_H" to 0x708/1800
[468.040048] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "FB_ID" to 0x1c2/450
[468.040049] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_ID" to 0x97/151
[468.040049] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_ENCODING" to 0x0/0
[468.040050] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_RANGE" to 0x0/0
[468.046864] (kms_vrr:9106) igt_kms-DEBUG: display: }
[468.046867] (kms_vrr:9106) igt_kms-DEBUG: display: commit {
[468.046868] (kms_vrr:9106) igt_kms-DEBUG: display:     populating plane data: A.0, fb 450
[468.046869] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_X" to 0x0/0
[468.046870] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_Y" to 0x0/0
[468.046871] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_W" to 0xb400000/188743680
[468.046871] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "SRC_H" to 0x7080000/117964800
[468.046871] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_W" to 0xb40/2880
[468.046872] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_H" to 0x708/1800
[468.046872] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "FB_ID" to 0x1c2/450
[468.046873] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Setting property "CRTC_ID" to 0x97/151
[468.046873] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_ENCODING" to 0x0/0
[468.046874] (kms_vrr:9106) igt_kms-DEBUG: plane A.0: Ignoring property "COLOR_RANGE" to 0x0/0
[468.049336] (kms_vrr:9106) igt_kms-DEBUG: display: }
[468.049345] (kms_vrr:9106) DEBUG: event_ns - last_event_ns: 8464000 (118.15 Hz)
[468.049346] (kms_vrr:9106) INFO: Completed 470 flips, 0 were in threshold for [(120 Hz) 8333333ns]
[468.049423] (kms_vrr:9106) CRITICAL: Test assertion failure function test_seamless_virtual_rr_basic, file ../tests/kms_vrr.c:776:
[468.049434] (kms_vrr:9106) CRITICAL: Failed assertion: result > 75
[468.049443] (kms_vrr:9106) CRITICAL: Refresh rate (120 Hz) 8333333ns: Target threshold not reached, result was 0%
[468.069099] (kms_vrr:9106) igt_core-INFO: Stack trace:
[468.075320] (kms_vrr:9106) igt_core-INFO:   #0 ../lib/igt_core.c:2106 __igt_fail_assert()
[468.075563] (kms_vrr:9106) igt_core-INFO:   #1 ../tests/kms_vrr.c:773 test_seamless_virtual_rr_basic()
[468.075580] (kms_vrr:9106) igt_core-INFO:   #2 ../tests/kms_vrr.c:998 run_vrr_test.constprop.0()
[468.075591] (kms_vrr:9106) igt_core-INFO:   #3 ../tests/kms_vrr.c:1105 __igt_unique____real_main1046()
[468.075601] (kms_vrr:9106) igt_core-INFO:   #4 ../tests/kms_vrr.c:1046 main()
[468.118808] (kms_vrr:9106) igt_core-INFO:   #5 ../sysdeps/nptl/libc_start_call_main.h:74 __libc_start_call_main()
[468.118872] (kms_vrr:9106) igt_core-INFO:   #6 ../csu/libc-start.c:128 __libc_start_main@@GLIBC_2.34()
[468.119109] (kms_vrr:9106) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest pipe-A-eDP-1: FAIL (6.143s)
Subtest seamless-rr-switch-virtual: FAIL (6.442s)
Dmesg
<6> [492.947214] Console: switching to colour dummy device 80x25
<6> [492.947685] [IGT] kms_vrr: executing
<7> [492.955316] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:402:DP-1]
<7> [492.955327] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:402:DP-1]
<7> [492.955535] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port D/TC#1: TC port mode reset (disconnected -> tbt-alt) pin assignment: - max lanes: 4
<7> [492.955680] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:402:DP-1] disconnected
<7> [492.956102] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:414:DP-2]
<7> [492.956109] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:414:DP-2]
<7> [492.956294] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port E/TC#2: TC port mode reset (disconnected -> tbt-alt) pin assignment: - max lanes: 4
<7> [492.956431] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:414:DP-2] disconnected
<7> [492.956786] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:422:DP-3]
<7> [492.956790] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:422:DP-3]
<7> [492.956966] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port F/TC#3: TC port mode reset (disconnected -> tbt-alt) pin assignment: - max lanes: 4
<7> [492.957127] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:422:DP-3] disconnected
<7> [492.957535] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:393:eDP-1]
<7> [492.957542] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:393:eDP-1]
<7> [492.957725] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 turning VDD on
<7> [492.957894] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006f
<7> [492.958405] 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> [492.958773] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] source rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 675000, 810000
<7> [492.958932] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] sink rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 810000
<7> [492.959205] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] common rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 810000
<7> [492.959425] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:393:eDP-1] Supported Monitor Refresh rate range is 40 Hz - 120 Hz
<5> [492.959432] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<5> [492.959436] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [492.959438] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:393:eDP-1] DisplayID extension version 0x13, primary use 0x00
<7> [492.959443] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:393:eDP-1] Assigning EDID-1.4 digital sink color depth as 10 bpc.
<5> [492.959446] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [492.959449] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:393:eDP-1] ELD monitor
<5> [492.959453] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [492.959456] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:393:eDP-1] ELD size 20, SAD count 0
<5> [492.959460] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [492.959477] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:393:eDP-1] VRR capable: yes
<7> [492.959762] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:393:eDP-1] DFP max bpc 0, max dotclock 0, TMDS clock 0-0, PCON Max FRL BW 0Gbps
<7> [492.960080] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:393:eDP-1] RGB->YcbCr conversion? no, YCbCr 4:2:0 allowed? yes, YCbCr 4:4:4->4:2:0 conversion? no
<5> [492.960614] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<5> [492.960617] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<5> [492.960620] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [492.960675] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:393:eDP-1] probed modes:
<7> [492.960680] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [492.960685] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2880x1800": 120 695310 2880 2928 2960 3040 1800 1803 1809 1906 0x40 0xa
<7> [492.960702] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:402:DP-1]
<7> [492.960707] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:402:DP-1]
<7> [492.960901] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:402:DP-1] disconnected
<7> [492.960916] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:414:DP-2]
<7> [492.960920] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:414:DP-2]
<7> [492.961099] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:414:DP-2] disconnected
<7> [492.961113] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:422:DP-3]
<7> [492.961117] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:422:DP-3]
<7> [492.961285] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:422:DP-3] disconnected
<6> [492.961986] [IGT] kms_vrr: starting subtest seamless-rr-switch-virtual
<6> [492.963368] [IGT] kms_vrr: starting dynamic subtest pipe-A-eDP-1
<7> [492.963949] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:450]
<7> [492.985765] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:451]
<7> [493.030563] xe 0000:00:02.0: [drm:compute_baseline_pipe_bpp [xe]] [CONNECTOR:393:eDP-1] Limiting target display pipe bpp to 24 (EDID bpp 30, max requested bpp 24, max platform bpp 36)
<7> [493.030703] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:392:DDI A/PHY A][CRTC:151:pipe A] DP link limits: pixel clock 695310 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 24 min link_bpp 18.0000 max link_bpp 24.0000
<7> [493.030803] xe 0000:00:02.0: [drm:intel_dp_compute_output_format [xe]] DP lane count 4 clock 540000 bpp input 24 compressed 0.0000 HDR no link rate required 2085930 available 2160000
<7> [493.030902] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:151:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [493.030995] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:392:DDI A/PHY A] [CRTC:151:pipe A]
<7> [493.031087] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in dp_m_n (expected tu 64 data 8102230/8388608 link 675185/524288, found tu 64, data 8100948/8388608 link 675079/524288)
<7> [493.031183] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in dpll_hw_state
<7> [493.031277] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [493.031365] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: yes, tbt_mode: no
<7> [493.031468] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] c10pll_hw_state: fracen: yes,
<7> [493.031579] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] quot: 40960, rem: 0, den: 1,
<7> [493.031692] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] multiplier: 140, tx_clk_div: 1.
<7> [493.031796] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] c10pll_rawhw_state:
<7> [493.031880] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] tx: 0x10, cmn: 0x21
<7> [493.031960] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[0] = 0xf4, pll[1] = 0x0, pll[2] = 0xf8, pll[3] = 0x0
<7> [493.032040] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [493.032118] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [493.032196] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[12] = 0xa0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x1
<7> [493.032274] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[16] = 0x84, pll[17] = 0x4f, pll[18] = 0xe5, pll[19] = 0x23
<7> [493.032351] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [493.032444] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: yes, tbt_mode: no
<7> [493.032545] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] c10pll_hw_state: fracen: yes,
<7> [493.032644] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] quot: 40960, rem: 0, den: 1,
<7> [493.032737] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] multiplier: 140, tx_clk_div: 0.
<7> [493.032814] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] c10pll_rawhw_state:
<7> [493.032888] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] tx: 0x10, cmn: 0x21
<7> [493.032963] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[0] = 0xf4, pll[1] = 0x0, pll[2] = 0xf8, pll[3] = 0x0
<7> [493.033039] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [493.033113] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [493.033187] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[12] = 0xa0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x0
<7> [493.033261] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[16] = 0x84, pll[17] = 0x4f, pll[18] = 0xe5, pll[19] = 0x23
<7> [493.033335] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 695310)
<7> [493.033433] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 695310)
<7> [493.033530] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in port_clock (expected 270000, found 540000)
<7> [493.033627] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:151:pipe A] fastset requirement not met, forcing full modeset
<7> [493.033716] xe 0000:00:02.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:151:pipe A] releasing DPLL 0
<7> [493.033822] xe 0000:00:02.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:35:plane 1A] ddb ( 0 - 4051) -> ( 0 - 4011), size 4051 -> 4011
<7> [493.033890] xe 0000:00:02.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:145:cursor A] ddb (4051 - 4096) -> (4011 - 4096), size 45 -> 85
<7> [493.033959] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35: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> [493.034027] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] lines 1, 13, 13, 13, 13, 13, 0, 0, 0, 3, 0 -> 2, 25, 25, 25, 25, 25, 0, 0, 0, 5, 0
<7> [493.034092] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] blocks 24, 313, 313, 313, 313, 313, 0, 0, 38, 73, 87 -> 49, 601, 601, 601, 601, 601, 0, 0, 63, 121, 135
<7> [493.034154] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] min_ddb 28, 346, 346, 346, 346, 346, 0, 0, 39, 82, 88 -> 55, 663, 663, 663, 663, 663, 0, 0, 64, 135, 136
<7> [493.034221] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:151:pipe A] data rate 2781240 num active planes 1
<7> [493.034319] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 2921 qgv_peak_bw: 38400
<7> [493.034447] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 2921 qgv_peak_bw: 38400
<7> [493.034552] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 2921 qgv_peak_bw: 38400
<7> [493.034651] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 2921 qgv_peak_bw: 38400
<7> [493.034737] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 2921
<7> [493.034830] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:151:pipe A] min cdclk: 173855 kHz -> 347655 kHz
<7> [493.034929] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 21732 kHz -> 43457 kHz
<7> [493.035020] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via crawling and squashing
<7> [493.035108] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 360000 kHz, actual 360000 kHz
<7> [493.035189] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 1, actual 1
<7> [493.035280] xe 0000:00:02.0: [drm:intel_find_dpll [xe]] [CRTC:151:pipe A] allocated DPLL 0
<7> [493.035383] xe 0000:00:02.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:151:pipe A] reserving DPLL 0
<7> [493.035502] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:151:pipe A] enable: yes [modeset]
<7> [493.035605] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [493.035692] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [493.035773] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [493.035852] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [493.035929] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [493.036006] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [493.036082] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 8100948, data_n: 8388608, link_m: 675079, link_n: 524288, tu: 64
<7> [493.036158] 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> [493.036233] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [493.036331] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [493.036434] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [493.036530] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum hblank: 0
<7> [493.036614] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [493.036688] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14
<7> [493.036761] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB
<7> [493.036833] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB
<7> [493.036905] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0
<7> [493.036977] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range
<7> [493.037049] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined
<7> [493.037121] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [493.037194] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [493.037288] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1906, vmax: 1906, flipline: 1906, pipeline full: 0, guardband: 104 vsync start: 103, vsync end: 97
<7> [493.037383] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1802, vmax vblank: 1802, vmin vtotal: 1906, vmax vtotal: 1906
<7> [493.037476] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [493.037564] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] requested mode: "2880x1800": 120 695310 2880 2928 2960 3040 1800 1803 1809 1906 0x40 0xa
<7> [493.037638] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "2880x1800": 120 695310 2880 2928 2960 3040 1800 1803 1809 1906 0x40 0xa
<7> [493.037709] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=695310, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa
<7> [493.037780] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "2880x1800": 120 695310 2880 2928 2960 3040 1800 1803 1809 1906 0x40 0xa
<7> [493.037851] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=695310, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa
<7> [493.037922] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 540000, pixel rate 695310, min cdclk 347655, min voltage level 0
<7> [493.037992] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 35, ips linetime: 0
<7> [493.038062] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0, sharpness_strength: 0
<7> [493.038133] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe src: 2880x1800+0+0
<7> [493.038211] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [493.038305] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [493.038398] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [493.038491] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: yes, tbt_mode: no
<7> [493.038567] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_hw_state: fracen: yes,
<7> [493.038637] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] quot: 40960, rem: 0, den: 1,
<7> [493.038710] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] multiplier: 140, tx_clk_div: 0.
<7> [493.038784] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_rawhw_state:
<7> [493.038856] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] tx: 0x10, cmn: 0x21
<7> [493.038929] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[0] = 0xf4, pll[1] = 0x0, pll[2] = 0xf8, pll[3] = 0x0
<7> [493.039002] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [493.039073] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [493.039144] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[12] = 0xa0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x0
<7> [493.039354] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[16] = 0x84, pll[17] = 0x4f, pll[18] = 0xe5, pll[19] = 0x23
<7> [493.039463] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [493.039555] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [493.039632] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [493.039703] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [493.039774] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [493.039845] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [493.039915] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [493.039987] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [493.040058] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [493.040140] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [493.040231] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [493.040323] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [493.040415] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:35:plane 1A] fb: [FB:450] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [493.040500] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [493.040570] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [493.040641] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:65:plane 2A] fb: [NOFB], visible: no
<7> [493.040711] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:95:plane 3A] fb: [NOFB], visible: no
<7> [493.040780] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:125:plane 4A] fb: [NOFB], visible: no
<7> [493.040849] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:135:plane 5A] fb: [NOFB], visible: no
<7> [493.040918] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:145:cursor A] fb: [NOFB], visible: no
<7> [493.042855] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [493.043609] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [493.043755] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2
<7> [493.044436] xe 0000:00:02.0: [drm:intel_alpm_disable [xe]] Disabling ALPM
<7> [493.044568] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]]
<7> [493.239362] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:393:eDP-1] set backlight PWM = 0
<7> [493.240080] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe A
<7> [493.245407] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 turn panel power off
<7> [493.245798] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [493.246214] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [493.298086] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [493.298551] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:392:DDI A/PHY A] - short
<7> [493.303406] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [493.303838] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:151:pipe A]
<7> [493.303888] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:392:DDI A/PHY A]
<7> [493.305443] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disabling DPLL 0
<7> [493.306000] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A
<7> [493.306520] xe 0000:00:02.0: [drm:intel_pmdemand_program_params [xe]] initiate pmdemand request values: (0x1801071 0x16821c72)
<7> [493.306963] xe 0000:00:02.0: [drm:intel_set_cdclk [xe]] Pre changing CDCLK to 360000 kHz, VCO 960000 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 1
<7> [493.307418] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 6 (mbus joined: yes)
<7> [493.307860] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=900
<7> [493.308273] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:392:DDI A/PHY A]
<7> [493.308602] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:401:DDI TC1/PHY TC1]
<7> [493.308968] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:403:DP-MST A]
<7> [493.309306] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:404:DP-MST B]
<7> [493.309622] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:405:DP-MST C]
<7> [493.309975] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:413:DDI TC2/PHY TC2]
<7> [493.310286] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:415:DP-MST A]
<7> [493.310625] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:416:DP-MST B]
<7> [493.311009] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:417:DP-MST C]
<7> [493.311346] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:421:DDI TC3/PHY TC3]
<7> [493.311644] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:423:DP-MST A]
<7> [493.311998] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:424:DP-MST B]
<7> [493.312311] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:425:DP-MST C]
<7> [493.312713] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:402:DP-1]
<7> [493.313056] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:414:DP-2]
<7> [493.313402] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:422:DP-3]
<7> [493.313888] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A
<7> [493.315597] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:151:pipe A]
<7> [493.316057] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enabling DPLL 0
<7> [493.318563] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 turn panel power on
<7> [493.318910] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 wait for panel power cycle (485 ms remaining)
<7> [493.336862] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [493.337289] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:392:DDI A/PHY A] - long
<7> [493.337709] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [493.338164] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:392:DDI A/PHY A]
<7> [493.796991] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [493.892024] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [493.892389] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 wait for panel power on
<7> [493.892712] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [493.928689] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [493.929087] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:392:DDI A/PHY A] - long
<7> [493.929448] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [493.929891] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:392:DDI A/PHY A]
<7> [493.975426] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port E/TC#2: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [493.975420] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port F/TC#3: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [493.975449] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port D/TC#1: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [494.101832] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [494.102359] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 turning VDD on
<7> [494.102884] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [494.105075] 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> [494.106632] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [494.107421] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 06
<7> [494.108588] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [494.110022] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [494.111219] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Clock recovery OK
<7> [494.111627] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Using DP training pattern TPS4
<7> [494.113148] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [494.113532] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Link Training passed at link rate = 540000, lane count = 4
<7> [494.114374] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe A
<7> [494.114968] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]]
<7> [494.115463] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe A
<7> [494.115972] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:393:eDP-1] set backlight PWM = 4518
<7> [494.131893] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2
<7> [494.133797] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:393:eDP-1]
<7> [494.134229] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:151:pipe A]
<7> [494.138287] xe 0000:00:02.0: [drm:i915_fifo_underrun_reset_write [xe]] Re-arming FIFO underruns on pipe A
<7> [496.595132] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 turning VDD off
<7> [496.595447] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [499.057752] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [499.057906] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [499.058005] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<6> [499.106508] [IGT] kms_vrr: finished subtest pipe-A-eDP-1, FAIL
<7> [499.106879] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [499.107009] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [499.107105] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [499.107198] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [499.107289] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in dp_m_n (expected tu 64 data 8100948/8388608 link 675079/524288, found tu 0, data 0/0 link 0/0)
<7> [499.107380] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [499.107469] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [499.107557] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [499.107644] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [499.107730] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [499.107833] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [499.107930] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [499.108018] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [499.108103] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [499.108187] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0)
<7> [499.108269] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [499.108351] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [499.108432] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0)
<7> [499.108511] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0)
<7> [499.108590] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [499.108668] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [499.108755] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [499.108835] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [499.108917] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [499.108993] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [499.109069] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [499.109144] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0)
<7> [499.109219] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [499.109293] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [499.109368] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0)
<7> [499.109442] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0)
<7> [499.109516] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [499.109589] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [499.109662] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [499.109760] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [499.109838] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 695310, found 0)
<7> [499.109918] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 695310, found 0)
<7> [499.109994] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in port_clock (expected 540000, found 0)
<7> [499.110069] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:151:pipe A] fastset requirement not met, forcing full modeset
<7> [499.110145] xe 0000:00:02.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:151:pipe A] releasing DPLL 0
<7> [499.110281] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [499.110372] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [499.110463] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [499.110551] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [499.110628] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in dp_m_n (expected tu 64 data 8100948/8388608 link 675079/524288, found tu 0, data 0/0 link 0/0)
<7> [499.110712] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [499.110803] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [499.110882] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [499.110958] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [499.111032] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [499.111106] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [499.111179] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [499.111252] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [499.111324] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [499.111397] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0)
<7> [499.111469] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [499.111540] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [499.111612] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0)
<7> [499.111687] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0)
<7> [499.111759] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [499.111835] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [499.111905] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [499.111976] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [499.112046] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [499.112116] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [499.112187] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [499.112257] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0)
<7> [499.112327] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [499.112397] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [499.112467] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0)
<7> [499.112537] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0)
<7> [499.112607] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [499.112684] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [499.112761] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [499.112836] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [499.112912] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 695310, found 0)
<7> [499.112985] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 695310, found 0)
<7> [499.113060] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in port_clock (expected 540000, found 0)
<7> [499.113132] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:151:pipe A] fastset requirement not met, forcing full modeset
<7> [499.113205] xe 0000:00:02.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:151:pipe A] releasing DPLL 0
<7> [499.113308] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [499.113369] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:151:pipe A] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [499.113454] xe 0000:00:02.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:35:plane 1A] ddb ( 0 - 4011) -> ( 0 - 0), size 4011 -> 0
<7> [499.113523] xe 0000:00:02.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:145:cursor A] ddb (4011 - 4096) -> ( 0 - 0), size 85 -> 0
<7> [499.113589] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35: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> [499.113756] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] lines 2, 25, 25, 25, 25, 25, 0, 0, 0, 5, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [499.113818] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] blocks 49, 601, 601, 601, 601, 601, 0, 0, 63, 121, 135 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [499.113876] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] min_ddb 55, 663, 663, 663, 663, 663, 0, 0, 64, 135, 136 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [499.113960] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:151:pipe A] data rate 0 num active planes 0
<7> [499.114044] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400
<7> [499.114125] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400
<7> [499.114204] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [499.114282] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [499.114360] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0
<7> [499.114438] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:151:pipe A] min cdclk: 347655 kHz -> 0 kHz
<7> [499.114536] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 43457 kHz -> 0 kHz
<7> [499.114615] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via crawling and squashing
<7> [499.114709] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz
<7> [499.114792] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [499.114897] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:151:pipe A] enable: no [modeset]
<7> [499.114975] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:35:plane 1A] fb: [NOFB], visible: no
<7> [499.115053] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:65:plane 2A] fb: [NOFB], visible: no
<7> [499.115130] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:95:plane 3A] fb: [NOFB], visible: no
<7> [499.115209] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:125:plane 4A] fb: [NOFB], visible: no
<7> [499.115285] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:135:plane 5A] fb: [NOFB], visible: no
<7> [499.115360] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:145:cursor A] fb: [NOFB], visible: no
<7> [499.115506] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [499.116083] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [499.116218] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2
<7> [499.116405] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 turning VDD on
<7> [499.116509] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006f
<7> [499.117108] xe 0000:00:02.0: [drm:intel_alpm_disable [xe]] Disabling ALPM
<7> [499.117200] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]]
<7> [499.321545] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:393:eDP-1] set backlight PWM = 0
<7> [499.322159] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe A
<7> [499.325694] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 turn panel power off
<7> [499.326108] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [499.326174] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [499.326651] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:392:DDI A/PHY A] - short
<7> [499.326709] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [499.378629] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [499.379000] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:392:DDI A/PHY A] - short
<7> [499.387094] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [499.387704] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:151:pipe A]
<7> [499.387769] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:392:DDI A/PHY A]
<7> [499.388684] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:392:DDI A/PHY A]
<7> [499.389411] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disabling DPLL 0
<7> [499.390058] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A
<7> [499.390800] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:392:DDI A/PHY A]
<7> [499.391296] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:401:DDI TC1/PHY TC1]
<7> [499.391691] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:403:DP-MST A]
<7> [499.392051] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:404:DP-MST B]
<7> [499.392451] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:405:DP-MST C]
<7> [499.392760] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:413:DDI TC2/PHY TC2]
<7> [499.393065] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:415:DP-MST A]
<7> [499.393398] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:416:DP-MST B]
<7> [499.393700] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:417:DP-MST C]
<7> [499.394003] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:421:DDI TC3/PHY TC3]
<7> [499.394342] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:423:DP-MST A]
<7> [499.394640] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:424:DP-MST B]
<7> [499.394939] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:425:DP-MST C]
<7> [499.395248] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:393:eDP-1]
<7> [499.395634] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 3 (mbus joined: no)
<7> [499.395927] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [499.396310] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [499.396870] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_A
<7> [499.397336] xe 0000:00:02.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating disabled for pipe_mask=0x1 (CLKGATE_DIS_DSSDSC=0xaa000000)
<7> [499.397847] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:151:pipe A]
<7> [499.398198] 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> [499.398648] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [499.399003] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384
<6> [499.405197] [IGT] kms_vrr: finished subtest seamless-rr-switch-virtual, FAIL
<7> [499.406537] xe 0000:00:02.0: [drm:compute_baseline_pipe_bpp [xe]] [CONNECTOR:393:eDP-1] Limiting target display pipe bpp to 24 (EDID bpp 30, max requested bpp 24, max platform bpp 36)
<7> [499.407011] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:392:DDI A/PHY A][CRTC:151:pipe A] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 24 min link_bpp 18.0000 max link_bpp 24.0000
<7> [499.407409] xe 0000:00:02.0: [drm:intel_dp_compute_output_format [xe]] DP lane count 4 clock 270000 bpp input 24 compressed 0.0000 HDR no link rate required 1043130 available 1080000
<7> [499.407772] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:151:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [499.408168] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:392:DDI A/PHY A] [CRTC:151:pipe A]
<7> [499.408497] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [499.408808] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [499.409129] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [499.409410] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [499.409686] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 8102230/8388608 link 675185/524288)
<7> [499.409953] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [499.410204] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [499.410438] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [499.410706] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [499.411120] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [499.411327] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [499.411530] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [499.411722] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [499.411920] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [499.412101] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800)
<7> [499.412304] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [499.412475] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [499.412641] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906)
<7> [499.412809] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906)
<7> [499.413131] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [499.413300] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [499.413453] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [499.413600] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [499.413740] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [499.413885] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [499.414020] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [499.414150] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800)
<7> [499.414277] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [499.414400] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [499.414523] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906)
<7> [499.414641] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906)
<7> [499.414754] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [499.414873] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [499.414986] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [499.415098] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in dpll_hw_state
<7> [499.415204] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [499.415311] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: yes, tbt_mode: no
<7> [499.415418] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] c10pll_hw_state: fracen: yes,
<7> [499.415523] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] quot: 40960, rem: 0, den: 1,
<7> [499.415622] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] multiplier: 140, tx_clk_div: 0.
<7> [499.415719] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] c10pll_rawhw_state:
<7> [499.415815] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] tx: 0x10, cmn: 0x21
<7> [499.415922] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[0] = 0xf4, pll[1] = 0x0, pll[2] = 0xf8, pll[3] = 0x0
<7> [499.416016] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [499.416109] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [499.416199] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[12] = 0xa0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x0
<7> [499.416287] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[16] = 0x84, pll[17] = 0x4f, pll[18] = 0xe5, pll[19] = 0x23
<7> [499.416377] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [499.416469] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: yes, tbt_mode: no
<7> [499.416559] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] c10pll_hw_state: fracen: yes,
<7> [499.416673] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [499.416758] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:392:DDI A/PHY A] - long
<7> [499.416840] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [499.416959] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] quot: 40960, rem: 0, den: 1,
<7> [499.416875] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [499.416974] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:392:DDI A/PHY A]
<7> [499.417060] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] multiplier: 140, tx_clk_div: 1.
<7> [499.417160] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] c10pll_rawhw_state:
<7> [499.417132] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [499.417241] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] tx: 0x10, cmn: 0x21
<7> [499.417276] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [499.417321] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[0] = 0xf4, pll[1] = 0x0, pll[2] = 0xf8, pll[3] = 0x0
<7> [499.417398] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [499.417441] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling always-on
<7> [499.417476] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [499.417549] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[12] = 0xa0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x1
<7> [499.417624] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[16] = 0x84, pll[17] = 0x4f, pll[18] = 0xe5, pll[19] = 0x23
<7> [499.417696] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [499.417768] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710)
<7> [499.417857] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710)
<7> [499.417956] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in port_clock (expected 0, found 270000)
<7> [499.418057] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:151:pipe A] fastset requirement not met, forcing full modeset
<7> [499.418207] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [499.418278] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:151:pipe A] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x1
<7> [499.418349] xe 0000:00:02.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:35:plane 1A] ddb ( 0 - 0) -> ( 0 - 4051), size 0 -> 4051
<7> [499.418413] xe 0000:00:02.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:145:cursor A] ddb ( 0 - 0) -> (4051 - 4096), size 0 -> 45
<7> [499.418471] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35: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> [499.418529] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 13, 13, 13, 13, 13, 0, 0, 0, 3, 0
<7> [499.418586] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 24, 313, 313, 313, 313, 313, 0, 0, 38, 73, 87
<7> [499.418643] xe 0000:00:02.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 28, 346, 346, 346, 346, 346, 0, 0, 39, 82, 88
<7> [499.418713] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:151:pipe A] data rate 1390840 num active planes 1
<7> [499.418801] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400
<7> [499.418889] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400
<7> [499.418977] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [499.419063] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [499.419147] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461
<7> [499.419226] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:151:pipe A] min cdclk: 0 kHz -> 173855 kHz
<7> [499.419318] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 0 kHz -> 21732 kHz
<7> [499.419408] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [499.419490] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [499.419568] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [499.419655] xe 0000:00:02.0: [drm:intel_find_dpll [xe]] [CRTC:151:pipe A] allocated DPLL 0
<7> [499.419734] xe 0000:00:02.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:151:pipe A] reserving DPLL 0
<7> [499.419880] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:151:pipe A] enable: yes [modeset]
<7> [499.419969] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [499.420055] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [499.420139] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [499.420216] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [499.420291] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [499.420366] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [499.420442] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 8102230, data_n: 8388608, link_m: 675185, link_n: 524288, tu: 64
<7> [499.420517] 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> [499.420592] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [499.420667] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [499.420741] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [499.420832] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum hblank: 0
<7> [499.420913] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [499.420994] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14
<7> [499.421076] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB
<7> [499.421156] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB
<7> [499.421230] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0
<7> [499.421303] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range
<7> [499.421376] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined
<7> [499.421449] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [499.421522] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [499.421596] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1906, vmax: 1906, flipline: 1906, pipeline full: 0, guardband: 104 vsync start: 103, vsync end: 97
<7> [499.421672] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1802, vmax vblank: 1802, vmin vtotal: 1906, vmax vtotal: 1906
<7> [499.421752] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [499.421834] 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> [499.421917] 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> [499.421998] 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> [499.422080] 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> [499.422153] 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> [499.422227] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 270000, pixel rate 347710, min cdclk 173855, min voltage level 0
<7> [499.422300] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0
<7> [499.422372] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0, sharpness_strength: 0
<7> [499.422445] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe src: 2880x1800+0+0
<7> [499.422517] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [499.422590] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [499.422661] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [499.422737] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: yes, tbt_mode: no
<7> [499.422815] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_hw_state: fracen: yes,
<7> [499.422892] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] quot: 40960, rem: 0, den: 1,
<7> [499.422970] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] multiplier: 140, tx_clk_div: 1.
<7> [499.423048] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_rawhw_state:
<7> [499.423119] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] tx: 0x10, cmn: 0x21
<7> [499.423190] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[0] = 0xf4, pll[1] = 0x0, pll[2] = 0xf8, pll[3] = 0x0
<7> [499.423261] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [499.423333] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [499.423405] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[12] = 0xa0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x1
<7> [499.423476] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[16] = 0x84, pll[17] = 0x4f, pll[18] = 0xe5, pll[19] = 0x23
<7> [499.423548] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [499.423619] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [499.423690] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [499.423777] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [499.423856] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [499.423944] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [499.424032] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [499.424119] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [499.424194] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [499.424266] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [499.424338] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [499.424409] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [499.424487] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:35:plane 1A] fb: [FB:394] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [499.424561] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [499.424633] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [499.424709] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:65:plane 2A] fb: [NOFB], visible: no
<7> [499.424786] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:95:plane 3A] fb: [NOFB], visible: no
<7> [499.424863] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:125:plane 4A] fb: [NOFB], visible: no
<7> [499.424941] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:135:plane 5A] fb: [NOFB], visible: no
<7> [499.425019] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:145:cursor A] fb: [NOFB], visible: no
<7> [499.425181] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling always-on
<7> [499.425281] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [499.425525] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [499.425654] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_A
<7> [499.425831] xe 0000:00:02.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x1 (CLKGATE_DIS_DSSDSC=0xa8000000)
<7> [499.425940] xe 0000:00:02.0: [drm:intel_pmdemand_program_params [xe]] initiate pmdemand request values: (0x1800071 0xc010e72)
<7> [499.426060] 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> [499.426154] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [499.426241] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480
<7> [499.426323] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:392:DDI A/PHY A]
<7> [499.426391] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:401:DDI TC1/PHY TC1]
<7> [499.426458] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:403:DP-MST A]
<7> [499.426525] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:404:DP-MST B]
<7> [499.426592] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:405:DP-MST C]
<7> [499.426657] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:413:DDI TC2/PHY TC2]
<7> [499.426745] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:415:DP-MST A]
<7> [499.426818] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:416:DP-MST B]
<7> [499.426889] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:417:DP-MST C]
<7> [499.426959] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:421:DDI TC3/PHY TC3]
<7> [499.427028] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:423:DP-MST A]
<7> [499.427093] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:424:DP-MST B]
<7> [499.427155] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:425:DP-MST C]
<7> [499.427240] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [499.427398] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: *)
<7> [499.427462] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes)
<7> [499.427570] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A
<7> [499.428663] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:151:pipe A]
<7> [499.428748] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enabling DPLL 0
<7> [499.430715] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 turn panel power on
<7> [499.430791] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 wait for panel power cycle (457 ms remaining)
<7> [499.889343] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [499.968967] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [499.969612] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 wait for panel power on
<7> [499.970124] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [500.005774] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [500.006149] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:392:DDI A/PHY A] - long
<7> [500.006488] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [500.006897] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:392:DDI A/PHY A]
<7> [500.175576] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [500.176026] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 turning VDD on
<7> [500.176482] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:392:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [500.178729] 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> [500.180378] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [500.181296] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 03
<7> [500.182521] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [500.183952] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [500.185174] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Clock recovery OK
<7> [500.185557] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Using DP training pattern TPS4
<7> [500.187079] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [500.187467] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:393:eDP-1][ENCODER:392:DDI A/PHY A][DPRX] Link Training passed at link rate = 270000, lane count = 4
<7> [500.188391] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe A
<7> [500.188924] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]]
<7> [500.189387] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe A
<7> [500.189868] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:393:eDP-1] set backlight PWM = 4518
<7> [500.222630] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2
<7> [500.224302] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:393:eDP-1]
<7> [500.224703] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:151:pipe A]
<7> [500.227797] xe 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0
<6> [500.229606] [IGT] kms_vrr: exiting, ret=98
<6> [500.239631] Console: switching to colour frame buffer device 180x56
<7> [500.273002] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [500.273341] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [500.273598] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
Created at 2026-05-22 16:06:58