Result:
boot-20250925-0317 dmesg-20250925-0317
| Detail | Value |
|---|---|
| Duration | 10.84 seconds |
| Igt-Version |
IGT-Version: 2.1-g162a06a82 (x86_64) (Linux: 6.17.0-rc7-lgci-xe-xe-3827-690ed0728a0e31e6b+ x86_64) |
| Out |
Using IGT_SRANDOM=1758770462 for randomisation Opened device: /dev/dri/card0 Using monotonic timestamps Starting subtest: 2x-flip-vs-expired-vblank-interruptible Starting dynamic subtest: AB-eDP1-DP1 1024x768: 60 65000 1024 1048 1184 1344 768 771 777 806 0x48 0xa 1024x768: 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa Stack trace: #0 ../lib/igt_core.c:2075 __igt_fail_assert() #1 ../tests/kms_flip.c:923 run_test_on_crtc_set.constprop.0() #2 ../tests/kms_flip.c:1969 run_pair() #3 ../tests/kms_flip.c:2160 __igt_unique____real_main2040() #4 ../tests/kms_flip.c:2040 main() #5 [__libc_init_first+0x8a] #6 [__libc_start_main+0x8b] #7 [_start+0x25] Dynamic subtest AB-eDP1-DP1: FAIL (10.836s) |
| Err |
Starting subtest: 2x-flip-vs-expired-vblank-interruptible Starting dynamic subtest: AB-eDP1-DP1 (kms_flip:2542) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:928: (kms_flip:2542) CRITICAL: Failed assertion: end - start < 500 (kms_flip:2542) CRITICAL: Last errno: 4, Interrupted system call Dynamic subtest AB-eDP1-DP1 failed. **** DEBUG **** (kms_flip:2542) DEBUG: Vblank took 87us (kms_flip:2542) DEBUG: name = flip last_ts = 299.026550 last_received_ts = 299.025940 last_seq = 6963 current_ts = 299.043243 current_received_ts = 299.042572 current_seq = 6964 count = 454 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 51us (kms_flip:2542) DEBUG: name = flip last_ts = 299.043243 last_received_ts = 299.042572 last_seq = 6964 current_ts = 299.059906 current_received_ts = 299.059387 current_seq = 6965 count = 455 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 79us (kms_flip:2542) DEBUG: name = flip last_ts = 299.059906 last_received_ts = 299.059387 last_seq = 6965 current_ts = 299.076569 current_received_ts = 299.076050 current_seq = 6966 count = 456 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 49us (kms_flip:2542) DEBUG: name = flip last_ts = 299.076569 last_received_ts = 299.076050 last_seq = 6966 current_ts = 299.093231 current_received_ts = 299.092682 current_seq = 6967 count = 457 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 53us (kms_flip:2542) DEBUG: name = flip last_ts = 299.093231 last_received_ts = 299.092682 last_seq = 6967 current_ts = 299.109894 current_received_ts = 299.109314 current_seq = 6968 count = 458 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 49us (kms_flip:2542) DEBUG: name = flip last_ts = 299.109894 last_received_ts = 299.109314 last_seq = 6968 current_ts = 299.126556 current_received_ts = 299.126038 current_seq = 6969 count = 459 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 47us (kms_flip:2542) DEBUG: name = flip last_ts = 299.126556 last_received_ts = 299.126038 last_seq = 6969 current_ts = 299.143219 current_received_ts = 299.142700 current_seq = 6970 count = 460 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 51us (kms_flip:2542) DEBUG: name = flip last_ts = 299.143219 last_received_ts = 299.142700 last_seq = 6970 current_ts = 299.159912 current_received_ts = 299.159363 current_seq = 6971 count = 461 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 61us (kms_flip:2542) DEBUG: name = flip last_ts = 299.159912 last_received_ts = 299.159363 last_seq = 6971 current_ts = 299.176544 current_received_ts = 299.175995 current_seq = 6972 count = 462 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 42us (kms_flip:2542) DEBUG: name = flip last_ts = 299.176544 last_received_ts = 299.175995 last_seq = 6972 current_ts = 299.193237 current_received_ts = 299.192688 current_seq = 6973 count = 463 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 46us (kms_flip:2542) DEBUG: name = flip last_ts = 299.193237 last_received_ts = 299.192688 last_seq = 6973 current_ts = 299.209900 current_received_ts = 299.209320 current_seq = 6974 count = 464 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 43us (kms_flip:2542) DEBUG: name = flip last_ts = 299.209900 last_received_ts = 299.209320 last_seq = 6974 current_ts = 299.226562 current_received_ts = 299.226044 current_seq = 6975 count = 465 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 47us (kms_flip:2542) DEBUG: name = flip last_ts = 299.226562 last_received_ts = 299.226044 last_seq = 6975 current_ts = 299.243225 current_received_ts = 299.242676 current_seq = 6976 count = 466 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 56us (kms_flip:2542) DEBUG: name = flip last_ts = 299.243225 last_received_ts = 299.242676 last_seq = 6976 current_ts = 299.259918 current_received_ts = 299.259277 current_seq = 6977 count = 467 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 46us (kms_flip:2542) DEBUG: name = flip last_ts = 299.259918 last_received_ts = 299.259277 last_seq = 6977 current_ts = 299.276550 current_received_ts = 299.275940 current_seq = 6978 count = 468 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 71us (kms_flip:2542) DEBUG: name = flip last_ts = 299.276550 last_received_ts = 299.275940 last_seq = 6978 current_ts = 299.293243 current_received_ts = 299.292572 current_seq = 6979 count = 469 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 56us (kms_flip:2542) DEBUG: name = flip last_ts = 299.293243 last_received_ts = 299.292572 last_seq = 6979 current_ts = 299.309906 current_received_ts = 299.309235 current_seq = 6980 count = 470 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 55us (kms_flip:2542) DEBUG: name = flip last_ts = 299.309906 last_received_ts = 299.309235 last_seq = 6980 current_ts = 299.326569 current_received_ts = 299.325928 current_seq = 6981 count = 471 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 49us (kms_flip:2542) DEBUG: name = flip last_ts = 299.326569 last_received_ts = 299.325928 last_seq = 6981 current_ts = 299.343231 current_received_ts = 299.342682 current_seq = 6982 count = 472 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 47us (kms_flip:2542) DEBUG: name = flip last_ts = 299.343231 last_received_ts = 299.342682 last_seq = 6982 current_ts = 299.359894 current_received_ts = 299.359344 current_seq = 6983 count = 473 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 50us (kms_flip:2542) DEBUG: name = flip last_ts = 299.359894 last_received_ts = 299.359344 last_seq = 6983 current_ts = 299.376556 current_received_ts = 299.375916 current_seq = 6984 count = 474 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 53us (kms_flip:2542) DEBUG: name = flip last_ts = 299.376556 last_received_ts = 299.375916 last_seq = 6984 current_ts = 299.393219 current_received_ts = 299.392670 current_seq = 6985 count = 475 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 35us (kms_flip:2542) DEBUG: name = flip last_ts = 299.393219 last_received_ts = 299.392670 last_seq = 6985 current_ts = 299.409882 current_received_ts = 299.409363 current_seq = 6986 count = 476 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 54us (kms_flip:2542) DEBUG: name = flip last_ts = 299.409882 last_received_ts = 299.409363 last_seq = 6986 current_ts = 299.426575 current_received_ts = 299.426056 current_seq = 6987 count = 477 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 53us (kms_flip:2542) DEBUG: name = flip last_ts = 299.426575 last_received_ts = 299.426056 last_seq = 6987 current_ts = 299.443237 current_received_ts = 299.442566 current_seq = 6988 count = 478 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 47us (kms_flip:2542) DEBUG: name = flip last_ts = 299.443237 last_received_ts = 299.442566 last_seq = 6988 current_ts = 299.459900 current_received_ts = 299.459229 current_seq = 6989 count = 479 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 54us (kms_flip:2542) DEBUG: name = flip last_ts = 299.459900 last_received_ts = 299.459229 last_seq = 6989 current_ts = 299.476562 current_received_ts = 299.476013 current_seq = 6990 count = 480 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 51us (kms_flip:2542) DEBUG: name = flip last_ts = 299.476562 last_received_ts = 299.476013 last_seq = 6990 current_ts = 299.493225 current_received_ts = 299.492676 current_seq = 6991 count = 481 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 54us (kms_flip:2542) DEBUG: name = flip last_ts = 299.493225 last_received_ts = 299.492676 last_seq = 6991 current_ts = 299.509888 current_received_ts = 299.509247 current_seq = 6992 count = 482 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 39us (kms_flip:2542) DEBUG: name = flip last_ts = 299.509888 last_received_ts = 299.509247 last_seq = 6992 current_ts = 299.526550 current_received_ts = 299.526001 current_seq = 6993 count = 483 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 58us (kms_flip:2542) DEBUG: name = flip last_ts = 299.526550 last_received_ts = 299.526001 last_seq = 6993 current_ts = 299.543213 current_received_ts = 299.542603 current_seq = 6994 count = 484 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 54us (kms_flip:2542) DEBUG: name = flip last_ts = 299.543213 last_received_ts = 299.542603 last_seq = 6994 current_ts = 299.559906 current_received_ts = 299.559235 current_seq = 6995 count = 485 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 53us (kms_flip:2542) DEBUG: name = flip last_ts = 299.559906 last_received_ts = 299.559235 last_seq = 6995 current_ts = 299.576569 current_received_ts = 299.576019 current_seq = 6996 count = 486 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 56us (kms_flip:2542) DEBUG: name = flip last_ts = 299.576569 last_received_ts = 299.576019 last_seq = 6996 current_ts = 299.593201 current_received_ts = 299.592682 current_seq = 6997 count = 487 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 62us (kms_flip:2542) DEBUG: name = flip last_ts = 299.593201 last_received_ts = 299.592682 last_seq = 6997 current_ts = 299.609894 current_received_ts = 299.609375 current_seq = 6998 count = 488 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 51us (kms_flip:2542) DEBUG: name = flip last_ts = 299.609894 last_received_ts = 299.609375 last_seq = 6998 current_ts = 299.626556 current_received_ts = 299.626038 current_seq = 6999 count = 489 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 68us (kms_flip:2542) DEBUG: name = flip last_ts = 299.626556 last_received_ts = 299.626038 last_seq = 6999 current_ts = 299.643219 current_received_ts = 299.642700 current_seq = 7000 count = 490 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 49us (kms_flip:2542) DEBUG: name = flip last_ts = 299.643219 last_received_ts = 299.642700 last_seq = 7000 current_ts = 299.659882 current_received_ts = 299.659302 current_seq = 7001 count = 491 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 44us (kms_flip:2542) DEBUG: name = flip last_ts = 299.659882 last_received_ts = 299.659302 last_seq = 7001 current_ts = 299.676544 current_received_ts = 299.675903 current_seq = 7002 count = 492 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 45us (kms_flip:2542) DEBUG: name = flip last_ts = 299.676544 last_received_ts = 299.675903 last_seq = 7002 current_ts = 299.693207 current_received_ts = 299.692657 current_seq = 7003 count = 493 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 55us (kms_flip:2542) DEBUG: name = flip last_ts = 299.693207 last_received_ts = 299.692657 last_seq = 7003 current_ts = 299.709869 current_received_ts = 299.709351 current_seq = 7004 count = 494 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 56us (kms_flip:2542) DEBUG: name = flip last_ts = 299.709869 last_received_ts = 299.709351 last_seq = 7004 current_ts = 299.726562 current_received_ts = 299.725922 current_seq = 7005 count = 495 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 49us (kms_flip:2542) DEBUG: name = flip last_ts = 299.726562 last_received_ts = 299.725922 last_seq = 7005 current_ts = 299.743195 current_received_ts = 299.742676 current_seq = 7006 count = 496 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 52us (kms_flip:2542) DEBUG: name = flip last_ts = 299.743195 last_received_ts = 299.742676 last_seq = 7006 current_ts = 299.759857 current_received_ts = 299.759369 current_seq = 7007 count = 497 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 40us (kms_flip:2542) DEBUG: name = flip last_ts = 299.759857 last_received_ts = 299.759369 last_seq = 7007 current_ts = 299.776550 current_received_ts = 299.775909 current_seq = 7008 count = 498 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 56us (kms_flip:2542) DEBUG: name = flip last_ts = 299.776550 last_received_ts = 299.775909 last_seq = 7008 current_ts = 299.793213 current_received_ts = 299.792664 current_seq = 7009 count = 499 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 48us (kms_flip:2542) DEBUG: name = flip last_ts = 299.793213 last_received_ts = 299.792664 last_seq = 7009 current_ts = 299.809875 current_received_ts = 299.809326 current_seq = 7010 count = 500 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 51us (kms_flip:2542) DEBUG: name = flip last_ts = 299.809875 last_received_ts = 299.809326 last_seq = 7010 current_ts = 299.826538 current_received_ts = 299.826019 current_seq = 7011 count = 501 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 50us (kms_flip:2542) DEBUG: name = flip last_ts = 299.826538 last_received_ts = 299.826019 last_seq = 7011 current_ts = 299.843201 current_received_ts = 299.842651 current_seq = 7012 count = 502 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 43us (kms_flip:2542) DEBUG: name = flip last_ts = 299.843201 last_received_ts = 299.842651 last_seq = 7012 current_ts = 299.859894 current_received_ts = 299.859344 current_seq = 7013 count = 503 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 45us (kms_flip:2542) DEBUG: name = flip last_ts = 299.859894 last_received_ts = 299.859344 last_seq = 7013 current_ts = 299.876526 current_received_ts = 299.875977 current_seq = 7014 count = 504 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 49us (kms_flip:2542) DEBUG: name = flip last_ts = 299.876526 last_received_ts = 299.875977 last_seq = 7014 current_ts = 299.893219 current_received_ts = 299.892670 current_seq = 7015 count = 505 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 59us (kms_flip:2542) DEBUG: name = flip last_ts = 299.893219 last_received_ts = 299.892670 last_seq = 7015 current_ts = 299.909882 current_received_ts = 299.909332 current_seq = 7016 count = 506 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 50us (kms_flip:2542) DEBUG: name = flip last_ts = 299.909882 last_received_ts = 299.909332 last_seq = 7016 current_ts = 299.926544 current_received_ts = 299.925995 current_seq = 7017 count = 507 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 56us (kms_flip:2542) DEBUG: name = flip last_ts = 299.926544 last_received_ts = 299.925995 last_seq = 7017 current_ts = 299.943207 current_received_ts = 299.942719 current_seq = 7018 count = 508 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 114us (kms_flip:2542) DEBUG: name = flip last_ts = 299.943207 last_received_ts = 299.942719 last_seq = 7018 current_ts = 299.959869 current_received_ts = 299.959259 current_seq = 7019 count = 509 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 93us (kms_flip:2542) DEBUG: name = flip last_ts = 299.959869 last_received_ts = 299.959259 last_seq = 7019 current_ts = 299.976532 current_received_ts = 299.976044 current_seq = 7020 count = 510 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 99us (kms_flip:2542) DEBUG: name = flip last_ts = 299.976532 last_received_ts = 299.976044 last_seq = 7020 current_ts = 299.993225 current_received_ts = 299.992706 current_seq = 7021 count = 511 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 83us (kms_flip:2542) DEBUG: name = flip last_ts = 299.993225 last_received_ts = 299.992706 last_seq = 7021 current_ts = 300.009888 current_received_ts = 300.009247 current_seq = 7022 count = 512 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 71us (kms_flip:2542) DEBUG: name = flip last_ts = 300.009888 last_received_ts = 300.009247 last_seq = 7022 current_ts = 300.026520 current_received_ts = 300.025909 current_seq = 7023 count = 513 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 97us (kms_flip:2542) DEBUG: name = flip last_ts = 300.026520 last_received_ts = 300.025909 last_seq = 7023 current_ts = 300.043213 current_received_ts = 300.042572 current_seq = 7024 count = 514 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 74us (kms_flip:2542) DEBUG: name = flip last_ts = 300.043213 last_received_ts = 300.042572 last_seq = 7024 current_ts = 300.059875 current_received_ts = 300.059235 current_seq = 7025 count = 515 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 70us (kms_flip:2542) DEBUG: name = flip last_ts = 300.059875 last_received_ts = 300.059235 last_seq = 7025 current_ts = 300.076538 current_received_ts = 300.076019 current_seq = 7026 count = 516 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 64us (kms_flip:2542) DEBUG: name = flip last_ts = 300.076538 last_received_ts = 300.076019 last_seq = 7026 current_ts = 300.093201 current_received_ts = 300.092560 current_seq = 7027 count = 517 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 67us (kms_flip:2542) DEBUG: name = flip last_ts = 300.093201 last_received_ts = 300.092560 last_seq = 7027 current_ts = 300.109894 current_received_ts = 300.109253 current_seq = 7028 count = 518 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 63us (kms_flip:2542) DEBUG: name = flip last_ts = 300.109894 last_received_ts = 300.109253 last_seq = 7028 current_ts = 300.126526 current_received_ts = 300.126099 current_seq = 7029 count = 519 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 63us (kms_flip:2542) DEBUG: name = flip last_ts = 300.126526 last_received_ts = 300.126099 last_seq = 7029 current_ts = 300.143188 current_received_ts = 300.142639 current_seq = 7030 count = 520 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 66us (kms_flip:2542) DEBUG: name = flip last_ts = 300.143188 last_received_ts = 300.142639 last_seq = 7030 current_ts = 300.159851 current_received_ts = 300.159271 current_seq = 7031 count = 521 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 65us (kms_flip:2542) DEBUG: name = flip last_ts = 300.159851 last_received_ts = 300.159271 last_seq = 7031 current_ts = 300.176544 current_received_ts = 300.176086 current_seq = 7032 count = 522 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 67us (kms_flip:2542) DEBUG: name = flip last_ts = 300.176544 last_received_ts = 300.176086 last_seq = 7032 current_ts = 300.193207 current_received_ts = 300.192688 current_seq = 7033 count = 523 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 65us (kms_flip:2542) DEBUG: name = flip last_ts = 300.193207 last_received_ts = 300.192688 last_seq = 7033 current_ts = 300.209869 current_received_ts = 300.209229 current_seq = 7034 count = 524 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 64us (kms_flip:2542) DEBUG: name = flip last_ts = 300.209869 last_received_ts = 300.209229 last_seq = 7034 current_ts = 300.226532 current_received_ts = 300.225922 current_seq = 7035 count = 525 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 64us (kms_flip:2542) DEBUG: name = flip last_ts = 300.226532 last_received_ts = 300.225922 last_seq = 7035 current_ts = 300.243195 current_received_ts = 300.242645 current_seq = 7036 count = 526 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 65us (kms_flip:2542) DEBUG: name = flip last_ts = 300.243195 last_received_ts = 300.242645 last_seq = 7036 current_ts = 300.259857 current_received_ts = 300.259247 current_seq = 7037 count = 527 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 63us (kms_flip:2542) DEBUG: name = flip last_ts = 300.259857 last_received_ts = 300.259247 last_seq = 7037 current_ts = 300.276520 current_received_ts = 300.275970 current_seq = 7038 count = 528 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 63us (kms_flip:2542) DEBUG: name = flip last_ts = 300.276520 last_received_ts = 300.275970 last_seq = 7038 current_ts = 300.293182 current_received_ts = 300.292664 current_seq = 7039 count = 529 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 65us (kms_flip:2542) DEBUG: name = flip last_ts = 300.293182 last_received_ts = 300.292664 last_seq = 7039 current_ts = 300.309875 current_received_ts = 300.309296 current_seq = 7040 count = 530 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 60us (kms_flip:2542) DEBUG: name = flip last_ts = 300.309875 last_received_ts = 300.309296 last_seq = 7040 current_ts = 300.326538 current_received_ts = 300.325897 current_seq = 7041 count = 531 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 65us (kms_flip:2542) DEBUG: name = flip last_ts = 300.326538 last_received_ts = 300.325897 last_seq = 7041 current_ts = 300.343201 current_received_ts = 300.342560 current_seq = 7042 count = 532 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 66us (kms_flip:2542) DEBUG: name = flip last_ts = 300.343201 last_received_ts = 300.342560 last_seq = 7042 current_ts = 300.359863 current_received_ts = 300.359222 current_seq = 7043 count = 533 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 65us (kms_flip:2542) DEBUG: name = flip last_ts = 300.359863 last_received_ts = 300.359222 last_seq = 7043 current_ts = 300.376526 current_received_ts = 300.375916 current_seq = 7044 count = 534 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 62us (kms_flip:2542) DEBUG: name = flip last_ts = 300.376526 last_received_ts = 300.375916 last_seq = 7044 current_ts = 300.393188 current_received_ts = 300.392761 current_seq = 7045 count = 535 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 63us (kms_flip:2542) DEBUG: name = flip last_ts = 300.393188 last_received_ts = 300.392761 last_seq = 7045 current_ts = 300.409851 current_received_ts = 300.409454 current_seq = 7046 count = 536 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 64us (kms_flip:2542) DEBUG: name = flip last_ts = 300.409851 last_received_ts = 300.409454 last_seq = 7046 current_ts = 300.426514 current_received_ts = 300.426117 current_seq = 7047 count = 537 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 64us (kms_flip:2542) DEBUG: name = flip last_ts = 300.426514 last_received_ts = 300.426117 last_seq = 7047 current_ts = 300.443176 current_received_ts = 300.442749 current_seq = 7048 count = 538 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 63us (kms_flip:2542) DEBUG: name = flip last_ts = 300.443176 last_received_ts = 300.442749 last_seq = 7048 current_ts = 300.459869 current_received_ts = 300.459442 current_seq = 7049 count = 539 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 64us (kms_flip:2542) DEBUG: name = flip last_ts = 300.459869 last_received_ts = 300.459442 last_seq = 7049 current_ts = 300.476532 current_received_ts = 300.476105 current_seq = 7050 count = 540 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 63us (kms_flip:2542) DEBUG: name = flip last_ts = 300.476532 last_received_ts = 300.476105 last_seq = 7050 current_ts = 300.493195 current_received_ts = 300.492645 current_seq = 7051 count = 541 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 62us (kms_flip:2542) DEBUG: name = flip last_ts = 300.493195 last_received_ts = 300.492645 last_seq = 7051 current_ts = 300.509857 current_received_ts = 300.509216 current_seq = 7052 count = 542 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 59us (kms_flip:2542) DEBUG: name = flip last_ts = 300.509857 last_received_ts = 300.509216 last_seq = 7052 current_ts = 300.526520 current_received_ts = 300.526031 current_seq = 7053 count = 543 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 63us (kms_flip:2542) DEBUG: name = flip last_ts = 300.526520 last_received_ts = 300.526031 last_seq = 7053 current_ts = 300.543182 current_received_ts = 300.542633 current_seq = 7054 count = 544 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 63us (kms_flip:2542) DEBUG: name = flip last_ts = 300.543182 last_received_ts = 300.542633 last_seq = 7054 current_ts = 300.559875 current_received_ts = 300.559204 current_seq = 7055 count = 545 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 64us (kms_flip:2542) DEBUG: name = flip last_ts = 300.559875 last_received_ts = 300.559204 last_seq = 7055 current_ts = 300.576508 current_received_ts = 300.575897 current_seq = 7056 count = 546 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 67us (kms_flip:2542) DEBUG: name = flip last_ts = 300.576508 last_received_ts = 300.575897 last_seq = 7056 current_ts = 300.593201 current_received_ts = 300.592651 current_seq = 7057 count = 547 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 65us (kms_flip:2542) DEBUG: name = flip last_ts = 300.593201 last_received_ts = 300.592651 last_seq = 7057 current_ts = 300.609863 current_received_ts = 300.609192 current_seq = 7058 count = 548 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 70us (kms_flip:2542) DEBUG: name = flip last_ts = 300.609863 last_received_ts = 300.609192 last_seq = 7058 current_ts = 300.626526 current_received_ts = 300.625885 current_seq = 7059 count = 549 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 102us (kms_flip:2542) DEBUG: name = flip last_ts = 300.626526 last_received_ts = 300.625885 last_seq = 7059 current_ts = 300.643188 current_received_ts = 300.642517 current_seq = 7060 count = 550 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 73us (kms_flip:2542) DEBUG: name = flip last_ts = 300.643188 last_received_ts = 300.642517 last_seq = 7060 current_ts = 300.659851 current_received_ts = 300.659149 current_seq = 7061 count = 551 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 78us (kms_flip:2542) DEBUG: name = flip last_ts = 300.659851 last_received_ts = 300.659149 last_seq = 7061 current_ts = 300.676544 current_received_ts = 300.675873 current_seq = 7062 count = 552 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 100us (kms_flip:2542) DEBUG: name = flip last_ts = 300.676544 last_received_ts = 300.675873 last_seq = 7062 current_ts = 300.693207 current_received_ts = 300.692535 current_seq = 7063 count = 553 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 67us (kms_flip:2542) DEBUG: name = flip last_ts = 300.693207 last_received_ts = 300.692535 last_seq = 7063 current_ts = 300.709839 current_received_ts = 300.709229 current_seq = 7064 count = 554 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 60us (kms_flip:2542) DEBUG: name = flip last_ts = 300.709839 last_received_ts = 300.709229 last_seq = 7064 current_ts = 300.726501 current_received_ts = 300.725952 current_seq = 7065 count = 555 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 59us (kms_flip:2542) DEBUG: name = flip last_ts = 300.726501 last_received_ts = 300.725952 last_seq = 7065 current_ts = 300.743195 current_received_ts = 300.742767 current_seq = 7066 count = 556 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 58us (kms_flip:2542) DEBUG: name = flip last_ts = 300.743195 last_received_ts = 300.742767 last_seq = 7066 current_ts = 300.759857 current_received_ts = 300.759399 current_seq = 7067 count = 557 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 59us (kms_flip:2542) DEBUG: name = flip last_ts = 300.759857 last_received_ts = 300.759399 last_seq = 7067 current_ts = 300.776520 current_received_ts = 300.776062 current_seq = 7068 count = 558 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 60us (kms_flip:2542) DEBUG: name = flip last_ts = 300.776520 last_received_ts = 300.776062 last_seq = 7068 current_ts = 300.793182 current_received_ts = 300.792633 current_seq = 7069 count = 559 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 47us (kms_flip:2542) DEBUG: name = flip last_ts = 300.793182 last_received_ts = 300.792633 last_seq = 7069 current_ts = 300.809845 current_received_ts = 300.809235 current_seq = 7070 count = 560 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 64us (kms_flip:2542) DEBUG: name = flip last_ts = 300.809845 last_received_ts = 300.809235 last_seq = 7070 current_ts = 300.826508 current_received_ts = 300.826080 current_seq = 7071 count = 561 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 58us (kms_flip:2542) DEBUG: name = flip last_ts = 300.826508 last_received_ts = 300.826080 last_seq = 7071 current_ts = 300.843170 current_received_ts = 300.842743 current_seq = 7072 count = 562 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 60us (kms_flip:2542) DEBUG: name = flip last_ts = 300.843170 last_received_ts = 300.842743 last_seq = 7072 current_ts = 300.859863 current_received_ts = 300.859436 current_seq = 7073 count = 563 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 59us (kms_flip:2542) DEBUG: name = flip last_ts = 300.859863 last_received_ts = 300.859436 last_seq = 7073 current_ts = 300.876526 current_received_ts = 300.876068 current_seq = 7074 count = 564 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 73us (kms_flip:2542) DEBUG: name = flip last_ts = 300.876526 last_received_ts = 300.876068 last_seq = 7074 current_ts = 300.893158 current_received_ts = 300.892731 current_seq = 7075 count = 565 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 60us (kms_flip:2542) DEBUG: name = flip last_ts = 300.893158 last_received_ts = 300.892731 last_seq = 7075 current_ts = 300.909851 current_received_ts = 300.909424 current_seq = 7076 count = 566 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 59us (kms_flip:2542) DEBUG: name = flip last_ts = 300.909851 last_received_ts = 300.909424 last_seq = 7076 current_ts = 300.926514 current_received_ts = 300.926086 current_seq = 7077 count = 567 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 59us (kms_flip:2542) DEBUG: name = flip last_ts = 300.926514 last_received_ts = 300.926086 last_seq = 7077 current_ts = 300.943176 current_received_ts = 300.942627 current_seq = 7078 count = 568 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 56us (kms_flip:2542) DEBUG: name = flip last_ts = 300.943176 last_received_ts = 300.942627 last_seq = 7078 current_ts = 300.959869 current_received_ts = 300.959198 current_seq = 7079 count = 569 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 56us (kms_flip:2542) DEBUG: name = flip last_ts = 300.959869 last_received_ts = 300.959198 last_seq = 7079 current_ts = 300.976501 current_received_ts = 300.975922 current_seq = 7080 count = 570 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 67us (kms_flip:2542) DEBUG: name = flip last_ts = 300.976501 last_received_ts = 300.975922 last_seq = 7080 current_ts = 300.993164 current_received_ts = 300.992554 current_seq = 7081 count = 571 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 80us (kms_flip:2542) DEBUG: name = flip last_ts = 300.993164 last_received_ts = 300.992554 last_seq = 7081 current_ts = 301.009827 current_received_ts = 301.009216 current_seq = 7082 count = 572 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 66us (kms_flip:2542) DEBUG: name = flip last_ts = 301.009827 last_received_ts = 301.009216 last_seq = 7082 current_ts = 301.026520 current_received_ts = 301.025818 current_seq = 7083 count = 573 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 29us (kms_flip:2542) DEBUG: name = flip last_ts = 301.026520 last_received_ts = 301.025818 last_seq = 7083 current_ts = 301.043182 current_received_ts = 301.042511 current_seq = 7084 count = 574 seq_step = 1 (kms_flip:2542) DEBUG: Vblank took 685us (kms_flip:2542) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:928: (kms_flip:2542) CRITICAL: Failed assertion: end - start < 500 (kms_flip:2542) CRITICAL: Last errno: 4, Interrupted system call (kms_flip:2542) igt_core-INFO: Stack trace: (kms_flip:2542) igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (kms_flip:2542) igt_core-INFO: #1 ../tests/kms_flip.c:923 run_test_on_crtc_set.constprop.0() (kms_flip:2542) igt_core-INFO: #2 ../tests/kms_flip.c:1969 run_pair() (kms_flip:2542) igt_core-INFO: #3 ../tests/kms_flip.c:2160 __igt_unique____real_main2040() (kms_flip:2542) igt_core-INFO: #4 ../tests/kms_flip.c:2040 main() (kms_flip:2542) igt_core-INFO: #5 [__libc_init_first+0x8a] (kms_flip:2542) igt_core-INFO: #6 [__libc_start_main+0x8b] (kms_flip:2542) igt_core-INFO: #7 [_start+0x25] **** END **** Dynamic subtest AB-eDP1-DP1: FAIL (10.836s) |
| Dmesg |
<6> [290.192286] Console: switching to colour dummy device 80x25
<6> [290.192737] [IGT] kms_flip: executing
<7> [290.200839] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:225:DP-2]
<7> [290.200859] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:225:DP-2]
<7> [290.201050] 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> [290.201167] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:225:DP-2] disconnected
<7> [290.201971] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:233:DP-3]
<7> [290.201977] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:233:DP-3]
<7> [290.202116] 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> [290.202217] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:233:DP-3] disconnected
<7> [290.202614] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:205:eDP-1]
<7> [290.202620] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:205:eDP-1]
<7> [290.203139] xe 0000:00:02.0: [drm:intel_dp_read_dsc_dpcd [xe]] DSC DPCD: 01 11 00 76 0b 01 01 80 00 01 06 66 08 00 00 00
<7> [290.203456] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] source rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 675000, 810000
<7> [290.203554] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] sink rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 810000
<7> [290.203647] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] common rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 810000
<7> [290.203741] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:205:eDP-1] VRR capable: no
<7> [290.203832] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:205:eDP-1] DFP max bpc 0, max dotclock 0, TMDS clock 0-0, PCON Max FRL BW 0Gbps
<7> [290.203923] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:205:eDP-1] RGB->YcbCr conversion? no, YCbCr 4:2:0 allowed? yes, YCbCr 4:4:4->4:2:0 conversion? no
<7> [290.204484] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:205:eDP-1] probed modes:
<7> [290.204489] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x48 0xa
<7> [290.204506] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:213:DP-1]
<7> [290.204512] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:213:DP-1]
<7> [290.204651] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC1
<7> [290.207795] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC1/DDI TC1/PHY TC1: Base DPCD: 12 14 c4 81 01 00 01 81 02 02 06 00 00 00 80
<7> [290.207815] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC1/DDI TC1/PHY TC1: DPCD: 14 1e c4 81 01 00 01 81 02 02 06 00 00 00 81
<7> [290.208559] xe 0000:00:02.0: [drm:intel_dp_init_lttpr_and_dprx_caps [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][DPRX] LTTPR common capabilities: 20 1e 80 aa 04 00 01 03
<7> [290.209382] xe 0000:00:02.0: [drm:intel_dp_init_lttpr_and_dprx_caps [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][LTTPR 1] PHY capabilities: 04 03 00
<7> [290.210234] xe 0000:00:02.0: [drm:drm_dp_dump_desc [drm_display_helper]] AUX USBC1/DDI TC1/PHY TC1: LTTPR 1: OUI 98-4f-ee dev-ID HBR HW-rev 10.2 SW-rev 2.11 quirks 0x0000
<7> [290.211711] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC1/DDI TC1/PHY TC1: Base DPCD: 12 14 c4 81 01 00 01 81 02 02 06 00 00 00 80
<7> [290.211725] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC1/DDI TC1/PHY TC1: DPCD: 14 1e c4 81 01 00 01 81 02 02 06 00 00 00 81
<7> [290.212383] xe 0000:00:02.0: [drm:drm_dp_dump_desc [drm_display_helper]] AUX USBC1/DDI TC1/PHY TC1: DP sink: OUI 00-0c-e7 dev-ID 27UP85 HW-rev 1.0 SW-rev 3.1 quirks 0x0020
<7> [290.213204] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [ENCODER:212:DDI TC1/PHY TC1] MST support: port: yes, sink: SST, modparam: yes -> enable: SST
<7> [290.218573] xe 0000:00:02.0: [drm:intel_dp_read_dsc_dpcd [xe]] DSC DPCD: 00 12 00 00 00 00 00 00 00 00 00 00 00 00 00 00
<7> [290.219083] xe 0000:00:02.0: [drm:intel_dp_get_dsc_sink_cap [xe]] FEC CAPABILITY: 0
<7> [290.219573] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] source rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 675000, 810000, 1000000, 2000000
<7> [290.219671] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] sink rates: 162000, 270000, 540000, 810000
<7> [290.219764] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] common rates: 162000, 270000, 540000, 810000
<7> [290.238051] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:213:DP-1] CEA VCDB 0x6a
<7> [290.238061] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:213:DP-1] Assigning EDID-1.4 digital sink color depth as 10 bpc.
<7> [290.238066] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:213:DP-1] ELD monitor LG ULTRAFINE
<7> [290.238069] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:213:DP-1] ELD size 36, SAD count 1
<7> [290.238098] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:213:DP-1] VRR capable: no
<7> [290.238212] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:213:DP-1] DFP max bpc 0, max dotclock 0, TMDS clock 0-0, PCON Max FRL BW 0Gbps
<7> [290.238305] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:213:DP-1] RGB->YcbCr conversion? no, YCbCr 4:2:0 allowed? yes, YCbCr 4:4:4->4:2:0 conversion? no
<7> [290.239555] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:213:DP-1] probed modes:
<7> [290.239563] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 60 537600 3840 3888 3920 4000 2160 2163 2168 2240 0x48 0x9
<7> [290.239567] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 30 262750 3840 3888 3920 4000 2160 2163 2168 2191 0x40 0x9
<7> [290.239571] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1440": 60 241500 2560 2608 2640 2720 1440 1443 1448 1481 0x40 0x9
<7> [290.239574] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x9
<7> [290.239578] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [290.239581] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148352 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [290.239585] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [290.239589] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [290.239592] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [290.239596] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5
<7> [290.239600] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x480": 60 27027 720 736 798 858 480 489 495 525 0x40 0xa
<7> [290.239603] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x480": 60 27000 720 736 798 858 480 489 495 525 0x40 0xa
<7> [290.239606] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25200 640 656 752 800 480 490 492 525 0x40 0xa
<7> [290.239609] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [290.239612] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [290.239649] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:225:DP-2]
<7> [290.239654] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:225:DP-2]
<7> [290.239807] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:225:DP-2] disconnected
<7> [290.239822] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:233:DP-3]
<7> [290.239826] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:233:DP-3]
<7> [290.239950] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:233:DP-3] disconnected
<6> [290.245472] [IGT] kms_flip: starting subtest 2x-flip-vs-expired-vblank-interruptible
<6> [290.249567] [IGT] kms_flip: starting dynamic subtest AB-eDP1-DP1
<7> [290.250356] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:243]
<7> [290.250596] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:244]
<7> [290.289113] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:88:pipe A]
<7> [290.289223] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [290.289495] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [290.289610] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [290.289717] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in lane_count (expected 2, found 0)
<7> [290.289820] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in dp_m_n (expected tu 64 data 5048699/8388608 link 210362/524288, found tu 0, data 0/0 link 0/0)
<7> [290.289922] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [290.290021] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [290.290119] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1024, found 0)
<7> [290.290216] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 1344, found 0)
<7> [290.290314] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1024, found 0)
<7> [290.290430] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 1344, found 0)
<7> [290.290534] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 1048, found 0)
<7> [290.290636] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 1184, found 0)
<7> [290.290735] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 768, found 0)
<7> [290.290834] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 768, found 0)
<7> [290.290934] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 771, found 0)
<7> [290.291030] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 777, found 0)
<7> [290.291129] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 806, found 0)
<7> [290.291227] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 806, found 0)
<7> [290.291324] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1024, found 0)
<7> [290.291447] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 1344, found 0)
<7> [290.291549] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1024, found 0)
<7> [290.291648] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 1344, found 0)
<7> [290.291747] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 1048, found 0)
<7> [290.291844] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 1184, found 0)
<7> [290.291943] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 768, found 0)
<7> [290.292039] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 768, found 0)
<7> [290.292136] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 771, found 0)
<7> [290.292232] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 777, found 0)
<7> [290.292329] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 806, found 0)
<7> [290.292469] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 806, found 0)
<7> [290.292570] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [290.292669] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [290.292767] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [290.292866] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [290.292963] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 65000, found 0)
<7> [290.293059] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 65000, found 0)
<7> [290.293157] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in port_clock (expected 162000, found 0)
<7> [290.293258] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:88:pipe A] fastset requirement not met, forcing full modeset
<7> [290.294018] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [290.294166] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:88:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x3 -> 0x2
<7> [290.294257] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:145:pipe B] dbuf slices 0xc -> 0xf, ddb (0 - 2048) -> (0 - 4096), active pipes 0x3 -> 0x2
<7> [290.294443] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:33:plane 1A] ddb ( 0 - 2026) -> ( 0 - 0), size 2026 -> 0
<7> [290.294542] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:83:cursor A] ddb (2026 - 2048) -> ( 0 - 0), size 22 -> 0
<7> [290.294636] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33: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> [290.294726] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] lines 1, 6, 6, 6, 6, 6, 0, 0, 0, 2, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [290.294793] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] blocks 9, 55, 55, 55, 55, 55, 0, 0, 23, 12, 26 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [290.294852] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] min_ddb 11, 62, 62, 62, 62, 62, 0, 0, 24, 15, 27 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [290.294912] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:90:plane 1B] ddb ( 0 - 1996) -> ( 0 - 4044), size 1996 -> 4044
<7> [290.294970] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:140:cursor B] ddb (1996 - 2048) -> (4044 - 4096), size 52 -> 52
<7> [290.295050] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:88:pipe A] data rate 0 num active planes 0
<7> [290.295134] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 2258 qgv_peak_bw: 38400
<7> [290.295215] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 2258 qgv_peak_bw: 38400
<7> [290.295302] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 2258 qgv_peak_bw: 38400
<7> [290.295408] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 2258 qgv_peak_bw: 38400
<7> [290.295516] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 2258
<7> [290.295625] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 268800 kHz, actual 268800 kHz
<7> [290.295728] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0
<7> [290.295835] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:88:pipe A] enable: no [modeset]
<7> [290.295913] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:33:plane 1A] fb: [NOFB], visible: no
<7> [290.295990] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [290.296065] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [290.296139] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [290.296212] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [290.296284] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:83:cursor A] fb: [NOFB], visible: no
<7> [290.296585] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR1
<7> [290.312435] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC1
<7> [290.319005] xe 0000:00:02.0: [drm:intel_alpm_disable [xe]] Disabling ALPM
<7> [290.319271] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]]
<7> [290.528365] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:205:eDP-1] set backlight PWM = 0
<7> [290.528870] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe A
<7> [290.538757] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:204:DDI A/PHY A] PPS 0 turn panel power off
<7> [290.539194] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:204:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [290.539602] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:204:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [290.592785] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [290.593186] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:204:DDI A/PHY A] - short
<7> [290.599366] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [290.599755] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:204:DDI A/PHY A]
<7> [290.599817] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A
<7> [290.600274] xe 0000:00:02.0: [drm:__intel_fbc_disable [xe]] Disabling FBC on [PLANE:33:plane 1A]
<7> [290.600947] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:204:DDI A/PHY A]
<7> [290.601247] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DDI TC1/PHY TC1]
<7> [290.601561] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:214:DP-MST A]
<7> [290.601830] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:215:DP-MST B]
<7> [290.602146] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:216:DP-MST C]
<7> [290.602444] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:224:DDI TC2/PHY TC2]
<7> [290.602700] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:226:DP-MST A]
<7> [290.602952] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:227:DP-MST B]
<7> [290.603198] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:228:DP-MST C]
<7> [290.603485] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:232:DDI TC3/PHY TC3]
<7> [290.603728] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:234:DP-MST A]
<7> [290.604005] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:235:DP-MST B]
<7> [290.604239] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:236:DP-MST C]
<7> [290.604515] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:205:eDP-1]
<7> [290.604819] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: B)
<7> [290.605090] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 6 (mbus joined: yes)
<7> [290.617768] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_A
<7> [290.618106] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:88:pipe A]
<7> [290.618490] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:145:pipe B]
<7> [290.618739] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.enable (expected yes, found no)
<7> [290.619064] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.active (expected yes, found no)
<7> [290.619364] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [290.619671] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in lane_count (expected 4, found 0)
<7> [290.619967] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in dp_m_n (expected tu 64 data 7829367/8388608 link 521957/524288, found tu 0, data 0/0 link 0/0)
<7> [290.620267] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in output_types (expected 0x00000080, found 0x00000000)
<7> [290.620606] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [290.620980] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 3840, found 0)
<7> [290.621304] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 4000, found 0)
<7> [290.621683] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 3840, found 0)
<7> [290.622024] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 4000, found 0)
<7> [290.622394] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 3888, found 0)
<7> [290.622769] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 3920, found 0)
<7> [290.623112] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 2160, found 0)
<7> [290.623552] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 2160, found 0)
<7> [290.623917] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 2163, found 0)
<7> [290.624261] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 2168, found 0)
<7> [290.624617] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 2240, found 0)
<7> [290.624966] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [290.625245] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:204:DDI A/PHY A] - long
<7> [290.625526] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [290.625867] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:204:DDI A/PHY A]
<7> [290.625863] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 2240, found 0)
<7> [290.626231] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 3840, found 0)
<7> [290.626609] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 4000, found 0)
<7> [290.626918] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 3840, found 0)
<7> [290.627249] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 4000, found 0)
<7> [290.627554] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 3888, found 0)
<7> [290.627819] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 3920, found 0)
<7> [290.628081] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 2160, found 0)
<7> [290.628403] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 2160, found 0)
<7> [290.628663] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 2163, found 0)
<7> [290.628899] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 2168, found 0)
<7> [290.629123] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 2240, found 0)
<7> [290.629360] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 2240, found 0)
<7> [290.629593] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [290.629819] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [290.630074] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [290.630280] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in enhanced_framing (expected yes, found no)
<7> [290.630516] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [290.630754] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 537600, found 0)
<7> [290.630953] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 537600, found 0)
<7> [290.631133] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in port_clock (expected 540000, found 0)
<7> [290.631310] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:145:pipe B] fastset requirement not met, forcing full modeset
<7> [290.631641] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [290.631837] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:145:pipe B] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x2 -> 0x0
<7> [290.632056] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:90:plane 1B] ddb ( 0 - 4044) -> ( 0 - 0), size 4044 -> 0
<7> [290.632242] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:140:cursor B] ddb (4044 - 4096) -> ( 0 - 0), size 52 -> 0
<7> [290.632454] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:90:plane 1B] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [290.632610] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:90:plane 1B] lines 1, 15, 15, 15, 15, 15, 0, 0, 0, 3, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [290.632761] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:90:plane 1B] blocks 31, 466, 466, 466, 466, 466, 0, 0, 45, 94, 108 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [290.632940] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:90:plane 1B] min_ddb 36, 514, 514, 514, 514, 514, 0, 0, 46, 105, 109 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [290.633133] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:145:pipe B] data rate 0 num active planes 0
<7> [290.633382] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400
<7> [290.633625] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400
<7> [290.633853] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [290.634075] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [290.634348] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0
<7> [290.634583] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing
<7> [290.634832] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz
<7> [290.635083] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0
<7> [290.635390] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:145:pipe B] enable: no [modeset]
<7> [290.635707] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:90:plane 1B] fb: [NOFB], visible: no
<7> [290.635964] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:100:plane 2B] fb: [NOFB], visible: no
<7> [290.636300] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:110:plane 3B] fb: [NOFB], visible: no
<7> [290.636641] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:120:plane 4B] fb: [NOFB], visible: no
<7> [290.636979] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:130:plane 5B] fb: [NOFB], visible: no
<7> [290.637278] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:140:cursor B] fb: [NOFB], visible: no
<7> [290.637760] xe 0000:00:02.0: [drm:intel_audio_codec_disable [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1] Disable audio codec on [CRTC:145:pipe B]
<7> [290.667765] xe 0000:00:02.0: [drm:intel_audio_component_get_eld [xe]] Not valid for port D
<7> [290.683866] xe 0000:00:02.0: [drm:intel_audio_component_get_power [xe]] restored AUD_FREQ_CNTRL to 0x8010
<7> [290.684662] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe B
<7> [290.704443] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC1
<7> [290.706880] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC1
<7> [290.707454] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port D/TC#1: TC port mode reset (dp-alt -> disconnected) pin assignment: C max lanes: 4
<7> [290.707841] xe 0000:00:02.0: [drm:__intel_fbc_disable [xe]] Disabling FBC on [PLANE:90:plane 1B]
<7> [290.708601] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:204:DDI A/PHY A]
<7> [290.708937] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DDI TC1/PHY TC1]
<7> [290.709265] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:214:DP-MST A]
<7> [290.709650] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:215:DP-MST B]
<7> [290.709962] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:216:DP-MST C]
<7> [290.710337] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:224:DDI TC2/PHY TC2]
<7> [290.710646] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:226:DP-MST A]
<7> [290.710932] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:227:DP-MST B]
<7> [290.711217] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:228:DP-MST C]
<7> [290.711545] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:232:DDI TC3/PHY TC3]
<7> [290.711842] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:234:DP-MST A]
<7> [290.712127] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:235:DP-MST B]
<7> [290.712433] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:236:DP-MST C]
<7> [290.712762] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:213:DP-1]
<7> [290.713118] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 3 (mbus joined: no)
<7> [290.713426] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [290.713713] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [290.714196] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_B
<7> [290.714644] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PICA_TC
<7> [290.715007] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [290.715475] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:145:pipe B]
<7> [290.715819] 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> [290.716211] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [290.716563] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384
<7> [290.717387] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:202:pipe C]
<7> [290.717758] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:145:pipe B]
<7> [290.717834] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:213:DP-1]
<7> [290.718039] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:213:DP-1] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [290.718501] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:212:DDI TC1/PHY TC1][CRTC:145:pipe B] DP link limits: pixel clock 65000 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 max link_bpp 30.0000
<7> [290.718839] xe 0000:00:02.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 2 clock 162000 bpp input 30 compressed 0.0000 link rate required 243750 available 324000
<7> [290.719176] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:145:pipe B] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [290.719539] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:212:DDI TC1/PHY TC1] [CRTC:145:pipe B]
<7> [290.719868] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [290.720173] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [290.720499] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [290.720830] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in lane_count (expected 0, found 2)
<7> [290.721094] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6310874/8388608 link 210362/524288)
<7> [290.721365] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000080)
<7> [290.721648] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [290.721890] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1024)
<7> [290.722124] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 1344)
<7> [290.722369] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1024)
<7> [290.722581] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 1344)
<7> [290.722784] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 1048)
<7> [290.722984] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 1184)
<7> [290.723212] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 768)
<7> [290.723440] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 768)
<7> [290.723652] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 771)
<7> [290.723833] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 777)
<7> [290.724000] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 806)
<7> [290.724175] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 806)
<7> [290.724356] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1024)
<7> [290.724512] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 1344)
<7> [290.724666] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1024)
<7> [290.724814] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 1344)
<7> [290.724956] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 1048)
<7> [290.725091] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 1184)
<7> [290.725225] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 768)
<7> [290.725387] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 768)
<7> [290.725544] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 771)
<7> [290.725686] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 777)
<7> [290.725823] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 806)
<7> [290.725950] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 806)
<7> [290.726073] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [290.726191] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [290.726306] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [290.726437] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in enhanced_framing (expected no, found yes)
<7> [290.726558] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in dpll_hw_state.cx0pll C20
<7> [290.726673] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [290.726785] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] c20pll_hw_state:
<7> [290.726898] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] tx[0] = 0xbe88, tx[1] = 0x4800, tx[2] = 0x0000
<7> [290.727010] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [290.727122] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] mpllb[0] = 0x108c
<7> [290.727226] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] mpllb[1] = 0x2108
<7> [290.727383] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] mpllb[2] = 0xcc9c
<7> [290.727494] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] mpllb[3] = 0xbfc1
<7> [290.727594] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] mpllb[4] = 0x4b9a
<7> [290.727689] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] mpllb[5] = 0x3f81
<7> [290.727785] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] mpllb[6] = 0x2000
<7> [290.727894] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] mpllb[7] = 0x0001
<7> [290.727993] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] mpllb[8] = 0x5000
<7> [290.728082] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] mpllb[9] = 0x0000
<7> [290.728170] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] mpllb[10] = 0x0000
<7> [290.728257] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [290.728351] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] c20pll_hw_state:
<7> [290.728446] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] tx[0] = 0xbe88, tx[1] = 0x5800, tx[2] = 0x0000
<7> [290.728537] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [290.728626] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] mpllb[0] = 0x50a8
<7> [290.728718] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] mpllb[1] = 0x2120
<7> [290.728807] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] mpllb[2] = 0xcd9a
<7> [290.728894] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] mpllb[3] = 0xbfc1
<7> [290.728971] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] mpllb[4] = 0x5ab8
<7> [290.729045] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] mpllb[5] = 0x4c34
<7> [290.729115] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] mpllb[6] = 0x2000
<7> [290.729186] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] mpllb[7] = 0x0001
<7> [290.729255] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] mpllb[8] = 0x6000
<7> [290.729333] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] mpllb[9] = 0x0000
<7> [290.729414] xe 0000:00:02.0: [drm:intel_cx0pll_dump_hw_state [xe]] mpllb[10] = 0x0000
<7> [290.729500] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [290.729589] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 65000)
<7> [290.729669] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 65000)
<7> [290.729742] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in port_clock (expected 0, found 162000)
<7> [290.729817] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:145:pipe B] fastset requirement not met, forcing full modeset
<7> [290.729923] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [290.729993] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:145:pipe B] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x2
<7> [290.730087] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:90:plane 1B] ddb ( 0 - 0) -> ( 0 - 4064), size 0 -> 4064
<7> [290.730161] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:140:cursor B] ddb ( 0 - 0) -> (4064 - 4096), size 0 -> 32
<7> [290.730228] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:90:plane 1B] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm
<7> [290.730287] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:90:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 6, 6, 6, 6, 6, 0, 0, 0, 4, 0
<7> [290.730363] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:90:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 34, 51, 51, 51, 51, 51, 0, 0, 81, 34, 81
<7> [290.730434] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:90:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 67, 100, 100, 100, 100, 100, 0, 0, 82, 67, 82
<7> [290.730523] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:145:pipe B] data rate 260000 num active planes 1
<7> [290.730637] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 273 qgv_peak_bw: 38400
<7> [290.730728] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 273 qgv_peak_bw: 38400
<7> [290.730814] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 273 qgv_peak_bw: 38400
<7> [290.730906] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 273 qgv_peak_bw: 38400
<7> [290.730988] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 273
<7> [290.731062] xe 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [xe]] [PLANE:90:plane 1B] min cdclk (32500 kHz) > [CRTC:145:pipe B] min cdclk (0 kHz)
<7> [290.731126] xe 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [xe]] new bandwidth min cdclk (5079 kHz) > old min cdclk (0 kHz)
<7> [290.731208] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing
<7> [290.731290] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [290.731394] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0
<7> [290.731519] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:145:pipe B] enable: yes [modeset]
<7> [290.731635] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: DP (0x80), output format: RGB, sink format: RGB
<7> [290.731747] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: B, pipe bpp: 30, dithering: 0
<7> [290.731840] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [290.731915] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [290.731986] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [290.732075] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [290.732163] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 2; data_m: 6310874, data_n: 8388608, link_m: 210362, link_n: 524288, tu: 64
<7> [290.732235] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 2; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [290.732305] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: enabled
<7> [290.732400] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [290.732490] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: disabled, selective update: disabled, panel replay: disabled, selective fetch: disabled
<7> [290.732579] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [290.732659] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 1, infoframes: 0, infoframes enabled: 0x0
<7> [290.732731] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ELD: 10 00 08 00 6c 14 00 01 00 00 00 00 00 00 00 00
<7> [290.732804] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ELD: 1e 6d c2 5b 4c 47 20 55 4c 54 52 41 46 49 4e 45
<7> [290.732874] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ELD: 09 07 07 00
<7> [290.732940] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [290.733015] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0
<7> [290.733092] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 806, vmax: 806, flipline: 806, pipeline full: 0, guardband: 38 vsync start: 35, vsync end: 29
<7> [290.733160] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 768, vmax vblank: 768, vmin vtotal: 806, vmax vtotal: 806
<7> [290.733227] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] requested mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [290.733296] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [290.733393] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=65000, hd=1024 hb=1024-1344 hs=1048-1184 ht=1344, vd=768 vb=768-806 vs=771-777 vt=806, flags=0xa
<7> [290.733483] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [290.733570] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=65000, hd=1024 hb=1024-1344 hs=1048-1184 ht=1344, vd=768 vb=768-806 vs=771-777 vt=806, flags=0xa
<7> [290.733655] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 162000, pipe src: 1024x768+0+0, pixel rate 65000
<7> [290.733730] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 166, ips linetime: 0
<7> [290.733795] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [290.733862] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [290.733931] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [290.734009] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dpll_hw_state: dpll: 0x278d0, dpll_md: 0x5800be88, fp0: 0x5000000, fp1: 0x5
<7> [290.734096] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [290.734168] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [290.734235] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [290.734301] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [290.734393] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [290.734482] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [290.734567] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [290.734651] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [290.734722] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [290.734793] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [290.734869] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [290.734948] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [290.735021] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:90:plane 1B] fb: [FB:243] 1024x768 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [290.735092] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [290.735157] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 1024.000000x768.000000+0.000000+0.000000 dst: 1024x768+0+0
<7> [290.735226] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:100:plane 2B] fb: [NOFB], visible: no
<7> [290.735298] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:110:plane 3B] fb: [NOFB], visible: no
<7> [290.735394] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:120:plane 4B] fb: [NOFB], visible: no
<7> [290.735404] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [290.735489] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:130:plane 5B] fb: [NOFB], visible: no
<7> [290.735573] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:140:cursor B] fb: [NOFB], visible: no
<7> [290.735561] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [290.735687] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [290.735939] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [290.736075] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [290.736209] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [290.736341] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_B
<7> [290.736491] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PICA_TC
<7> [290.736640] 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> [290.736759] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [290.736857] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480
<7> [290.736955] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:204:DDI A/PHY A]
<7> [290.737032] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DDI TC1/PHY TC1]
<7> [290.737099] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:214:DP-MST A]
<7> [290.737161] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:215:DP-MST B]
<7> [290.737219] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:216:DP-MST C]
<7> [290.737276] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:224:DDI TC2/PHY TC2]
<7> [290.737349] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:226:DP-MST A]
<7> [290.737428] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:227:DP-MST B]
<7> [290.737506] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:228:DP-MST C]
<7> [290.737582] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:232:DDI TC3/PHY TC3]
<7> [290.737657] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:234:DP-MST A]
<7> [290.737722] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:235:DP-MST B]
<7> [290.737788] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:236:DP-MST C]
<7> [290.737855] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [290.738008] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: *)
<7> [290.738078] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes)
<7> [290.738270] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port D/TC#1: TC port mode reset (disconnected -> dp-alt) pin assignment: C max lanes: 4
<7> [290.742269] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC1
<7> [290.745973] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC1/DDI TC1/PHY TC1: Base DPCD: 12 14 c4 81 01 00 01 81 02 02 06 00 00 00 80
<7> [290.745999] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC1/DDI TC1/PHY TC1: DPCD: 14 1e c4 81 01 00 01 81 02 02 06 00 00 00 81
<7> [290.746725] xe 0000:00:02.0: [drm:intel_dp_init_lttpr_and_dprx_caps [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][DPRX] LTTPR common capabilities: 20 1e 80 aa 04 00 01 03
<7> [290.748519] xe 0000:00:02.0: [drm:intel_dp_init_lttpr_and_dprx_caps [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][LTTPR 1] PHY capabilities: 04 03 00
<7> [290.749366] xe 0000:00:02.0: [drm:drm_dp_dump_desc [drm_display_helper]] AUX USBC1/DDI TC1/PHY TC1: LTTPR 1: OUI 98-4f-ee dev-ID HBR HW-rev 10.2 SW-rev 2.11 quirks 0x0000
<7> [290.750882] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC1/DDI TC1/PHY TC1: Base DPCD: 12 14 c4 81 01 00 01 81 02 02 06 00 00 00 80
<7> [290.750898] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC1/DDI TC1/PHY TC1: DPCD: 14 1e c4 81 01 00 01 81 02 02 06 00 00 00 81
<7> [290.751393] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][DPRX] Using LINK_BW_SET value 06
<7> [290.752658] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][LTTPR 1] 8b/10b, lanes: 2, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [290.753018] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][LTTPR 1] Using DP training pattern TPS1
<7> [290.754677] xe 0000:00:02.0: [drm:intel_dp_get_adjust_train [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][LTTPR 1] 8b/10b, lanes: 2, vswing request: 2/2/2/2, pre-emphasis request: 0/0/0/0
<7> [290.754780] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][LTTPR 1] 8b/10b, lanes: 2, vswing levels: 2/2/2/2, pre-emphasis levels: 0/0/0/0
<7> [290.756349] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][LTTPR 1] Clock recovery OK
<7> [290.756851] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][LTTPR 1] Using DP training pattern TPS4
<7> [290.775178] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][LTTPR 1] Channel EQ done. DP Training successful
<7> [290.775301] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][LTTPR 1] Link Training passed at link rate = 162000, lane count = 2
<7> [290.775875] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][DPRX] 8b/10b, lanes: 2, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [290.776263] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][DPRX] Using DP training pattern TPS1
<7> [290.778287] xe 0000:00:02.0: [drm:intel_dp_get_adjust_train [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][DPRX] 8b/10b, lanes: 2, vswing request: 1/1/0/0, pre-emphasis request: 0/0/0/0
<7> [290.778688] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][DPRX] 8b/10b, lanes: 2, vswing levels: 1/1/1/1, pre-emphasis levels: 0/0/0/0
<7> [290.780350] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][DPRX] Clock recovery OK
<7> [290.780473] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][DPRX] Using DP training pattern TPS4
<7> [290.788167] xe 0000:00:02.0: [drm:intel_dp_get_adjust_train [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][DPRX] 8b/10b, lanes: 2, vswing request: 1/1/0/0, pre-emphasis request: 0/0/0/0
<7> [290.788564] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][DPRX] 8b/10b, lanes: 2, vswing levels: 1/1/1/1, pre-emphasis levels: 0/0/0/0
<7> [290.796148] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][DPRX] Channel EQ done. DP Training successful
<7> [290.796378] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1][DPRX] Link Training passed at link rate = 162000, lane count = 2
<7> [290.797511] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe B
<7> [290.798806] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] reserved 7077888 bytes of contiguous stolen space for FBC, limit: 1
<7> [290.799047] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] Enabling FBC on [PLANE:90:plane 1B]
<7> [290.814881] xe 0000:00:02.0: [drm:intel_audio_codec_enable [xe]] [CONNECTOR:213:DP-1][ENCODER:212:DDI TC1/PHY TC1] Enable audio codec on [CRTC:145:pipe B], 36 bytes ELD
<7> [290.831847] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:213:DP-1]
<7> [290.832299] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:145:pipe B]
<7> [290.832837] xe 0000:00:02.0: [drm:intel_audio_component_get_power [xe]] restored AUD_FREQ_CNTRL to 0x8010
<7> [290.839603] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:88:pipe A]
<7> [290.839711] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:205:eDP-1]
<7> [290.839986] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:205:eDP-1] Limiting display bpp to 24 (EDID bpp 0, max requested bpp 36, max platform bpp 36)
<7> [290.840525] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:204:DDI A/PHY A][CRTC:88:pipe A] DP link limits: pixel clock 65000 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 24 max link_bpp 24.0000
<7> [290.840913] xe 0000:00:02.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 2 clock 162000 bpp input 24 compressed 0.0000 link rate required 195000 available 324000
<7> [290.841350] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:88:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [290.841755] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:204:DDI A/PHY A] [CRTC:88:pipe A]
<7> [290.842169] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [290.842563] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [290.842922] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [290.843267] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in lane_count (expected 0, found 2)
<7> [290.843611] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 5048699/8388608 link 210362/524288)
<7> [290.843935] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [290.844227] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [290.844540] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1024)
<7> [290.844826] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 1344)
<7> [290.845093] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1024)
<7> [290.845381] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 1344)
<7> [290.845631] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 1048)
<7> [290.845875] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 1184)
<7> [290.846104] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 768)
<7> [290.846358] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 768)
<7> [290.846590] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 771)
<7> [290.846808] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 777)
<7> [290.847013] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 806)
<7> [290.847214] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 806)
<7> [290.847458] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1024)
<7> [290.847656] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 1344)
<7> [290.847842] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1024)
<7> [290.848023] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 1344)
<7> [290.848199] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 1048)
<7> [290.848408] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 1184)
<7> [290.848584] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 768)
<7> [290.848752] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 768)
<7> [290.848914] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 771)
<7> [290.849072] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 777)
<7> [290.849224] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 806)
<7> [290.849411] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 806)
<7> [290.849364] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC1
<7> [290.849572] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [290.849722] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [290.849859] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [290.849996] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [290.850130] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 65000)
<7> [290.850261] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 65000)
<7> [290.850418] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in port_clock (expected 0, found 162000)
<7> [290.850553] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:88:pipe A] fastset requirement not met, forcing full modeset
<7> [290.850778] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0xf (total dbuf slices 0xf), mbus joined? yes->no
<7> [290.850885] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:88:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x2 -> 0x3
<7> [290.850989] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:145:pipe B] dbuf slices 0xf -> 0xc, ddb (0 - 4096) -> (0 - 2048), active pipes 0x2 -> 0x3
<7> [290.851123] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:33:plane 1A] ddb ( 0 - 0) -> ( 0 - 2026), size 0 -> 2026
<7> [290.851206] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:83:cursor A] ddb ( 0 - 0) -> (2026 - 2048), size 0 -> 22
<7> [290.851284] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33: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> [290.851371] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 6, 6, 6, 6, 6, 0, 0, 0, 4, 0
<7> [290.851452] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 34, 51, 51, 51, 51, 51, 0, 0, 81, 34, 81
<7> [290.851526] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 67, 100, 100, 100, 100, 100, 0, 0, 82, 67, 82
<7> [290.851599] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:90:plane 1B] ddb ( 0 - 4064) -> ( 0 - 2026), size 4064 -> 2026
<7> [290.851671] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:140:cursor B] ddb (4064 - 4096) -> (2026 - 2048), size 32 -> 22
<7> [290.851768] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:88:pipe A] data rate 260000 num active planes 1
<7> [290.851885] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 546 qgv_peak_bw: 38400
<7> [290.851992] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 546 qgv_peak_bw: 38400
<7> [290.852099] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 546 qgv_peak_bw: 38400
<7> [290.852208] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 546 qgv_peak_bw: 38400
<7> [290.852327] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 546
<7> [290.852441] xe 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [xe]] [PLANE:33:plane 1A] min cdclk (32500 kHz) > [CRTC:88:pipe A] min cdclk (0 kHz)
<7> [290.852526] xe 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [xe]] new bandwidth min cdclk (8125 kHz) > old min cdclk (5079 kHz)
<7> [290.852637] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [290.852746] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0
<7> [290.852886] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:88:pipe A] enable: yes [modeset]
<7> [290.852999] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [290.853104] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [290.853211] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [290.853328] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [290.853437] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [290.853543] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [290.853648] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 2; data_m: 5048699, data_n: 8388608, link_m: 210362, link_n: 524288, tu: 64
<7> [290.853752] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 2; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [290.853856] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [290.853959] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [290.854065] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: disabled, panel replay: disabled, selective fetch: disabled
<7> [290.854171] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [290.854276] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [290.854392] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 2, length 8
<7> [290.854502] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB
<7> [290.854606] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB
<7> [290.854708] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0
<7> [290.854812] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range
<7> [290.854917] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined
<7> [290.855022] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [290.855126] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0
<7> [290.855229] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 806, vmax: 806, flipline: 806, pipeline full: 0, guardband: 38 vsync start: 35, vsync end: 29
<7> [290.855345] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 768, vmax vblank: 768, vmin vtotal: 806, vmax vtotal: 806
<7> [290.855452] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] requested mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x48 0xa
<7> [290.855555] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x48 0xa
<7> [290.855659] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=65000, hd=1024 hb=1024-1344 hs=1048-1184 ht=1344, vd=768 vb=768-806 vs=771-777 vt=806, flags=0xa
<7> [290.855766] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [290.855871] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=65000, hd=1024 hb=1024-1344 hs=1048-1184 ht=1344, vd=768 vb=768-806 vs=771-777 vt=806, flags=0xa
<7> [290.855978] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 162000, pipe src: 1024x768+0+0, pixel rate 65000
<7> [290.856082] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 166, ips linetime: 0
<7> [290.856184] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [290.856287] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [290.856397] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [290.856503] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dpll_hw_state: dpll: 0x278d0, dpll_md: 0xb42110, fp0: 0x130, fp1: 0x1000000
<7> [290.856609] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [290.856712] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [290.856815] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [290.856916] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [290.857017] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [290.857118] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [290.857217] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [290.857328] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [290.857435] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [290.857536] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [290.857636] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [290.857736] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [290.857835] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:33:plane 1A] fb: [FB:243] 1024x768 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [290.857937] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [290.858035] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 1024.000000x768.000000+0.000000+0.000000 dst: 1024x768+0+0
<7> [290.858134] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [290.858233] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [290.858351] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [290.858456] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [290.858557] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:83:cursor A] fb: [NOFB], visible: no
<7> [290.859272] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_A
<7> [290.859502] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:204:DDI A/PHY A]
<7> [290.859606] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:212:DDI TC1/PHY TC1]
<7> [290.859691] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:214:DP-MST A]
<7> [290.859771] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:215:DP-MST B]
<7> [290.859850] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:216:DP-MST C]
<7> [290.859929] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:224:DDI TC2/PHY TC2]
<7> [290.860007] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:226:DP-MST A]
<7> [290.860086] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:227:DP-MST B]
<7> [290.860163] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:228:DP-MST C]
<7> [290.860240] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:232:DDI TC3/PHY TC3]
<7> [290.860332] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:234:DP-MST A]
<7> [290.860416] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:235:DP-MST B]
<7> [290.860493] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:236:DP-MST C]
<7> [290.864864] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [290.864967] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: B)
<7> [290.881554] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A
<7> [290.883140] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:204:DDI A/PHY A] PPS 0 turn panel power on
<7> [290.883423] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:204:DDI A/PHY A] PPS 0 wait for panel power cycle (217 ms remaining)
<7> [291.105393] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:204:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [291.206227] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [291.206487] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:204:DDI A/PHY A] PPS 0 wait for panel power on
<7> [291.206720] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:204:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [291.242786] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [291.243131] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:204:DDI A/PHY A] - long
<7> [291.243424] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [291.243742] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:204:DDI A/PHY A]
<7> [291.248375] 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> [291.248383] 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> [291.417733] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [291.419915] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:204:DDI A/PHY A] PPS 0 turning VDD on
<7> [291.420202] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:204:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [291.422354] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX A/DDI A/PHY A: DPCD: 14 1e 44 41 00 00 01 c0 02 00 02 00 00 0b 80
<7> [291.423380] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:205:eDP-1][ENCODER:204:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [291.424134] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:205:eDP-1][ENCODER:204:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 00
<7> [291.425214] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:205:eDP-1][ENCODER:204:DDI A/PHY A][DPRX] 8b/10b, lanes: 2, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [291.426086] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:205:eDP-1][ENCODER:204:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [291.427043] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:205:eDP-1][ENCODER:204:DDI A/PHY A][DPRX] Clock recovery OK
<7> [291.427323] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:205:eDP-1][ENCODER:204:DDI A/PHY A][DPRX] Using DP training pattern TPS3
<7> [291.428619] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:205:eDP-1][ENCODER:204:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [291.428881] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:205:eDP-1][ENCODER:204:DDI A/PHY A][DPRX] Link Training passed at link rate = 162000, lane count = 2
<7> [291.429828] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe A
<7> [291.430256] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]]
<7> [291.430568] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe A
<7> [291.430931] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:205:eDP-1] set backlight PWM = 13892
<7> [291.431850] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] reserved 7077888 bytes of contiguous stolen space for FBC, limit: 1
<7> [291.432142] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] Enabling FBC on [PLANE:33:plane 1A]
<7> [291.447090] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR1
<7> [291.448660] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:205:eDP-1]
<7> [291.449047] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:88:pipe A]
<7> [292.848471] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC1
<7> [292.865321] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC1
<7> [294.001284] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:204:DDI A/PHY A] PPS 0 turning VDD off
<7> [294.001776] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:204:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<6> [301.086460] [IGT] kms_flip: finished subtest AB-eDP1-DP1, FAIL
|