Result:
i915_display_info22 igt_runner22 results22.json results22-xe-load.json guc_logs22.tar boot22 dmesg22
| Detail | Value |
|---|---|
| Duration | 31.53 seconds |
| Hostname |
shard-lnl-5 |
| Igt-Version |
IGT-Version: 2.3-g99eb2bb6a (x86_64) (Linux: 7.0.0-rc3-lgci-xe-xe-4694-1735c19271f165607-debug+ x86_64) |
| Out |
Using IGT_SRANDOM=1773250787 for randomisation Opened device: /dev/dri/card0 Using monotonic timestamps Starting subtest: flip-vs-expired-vblank Starting dynamic subtest: A-eDP1 2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa Dynamic subtest A-eDP1: SUCCESS (11.231s) Starting dynamic subtest: B-eDP1 2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa Stack trace: #0 ../lib/igt_core.c:2075 __igt_fail_assert() #1 ../tests/kms_flip.c:921 run_test_on_crtc_set.constprop.0() #2 ../tests/kms_flip.c:1887 run_test() #3 ../tests/kms_flip.c:2120 __igt_unique____real_main2043() #4 ../tests/kms_flip.c:2043 main() #5 [__libc_init_first+0x8a] #6 [__libc_start_main+0x8b] #7 [_start+0x25] Dynamic subtest B-eDP1: FAIL (9.084s) Starting dynamic subtest: C-eDP1 2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa Dynamic subtest C-eDP1: SUCCESS (11.210s) Subtest flip-vs-expired-vblank: FAIL (31.532s) |
| Err |
Starting subtest: flip-vs-expired-vblank Starting dynamic subtest: A-eDP1 Dynamic subtest A-eDP1: SUCCESS (11.231s) Starting dynamic subtest: B-eDP1 (kms_flip:3148) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:926: (kms_flip:3148) CRITICAL: Failed assertion: end - start < 500 Dynamic subtest B-eDP1 failed. **** DEBUG **** (kms_flip:3148) DEBUG: name = flip last_ts = 173.531494 last_received_ts = 173.530945 last_seq = 343 current_ts = 173.548157 current_received_ts = 173.547623 current_seq = 344 count = 340 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 80us (kms_flip:3148) DEBUG: name = flip last_ts = 173.548157 last_received_ts = 173.547623 last_seq = 344 current_ts = 173.564835 current_received_ts = 173.564270 current_seq = 345 count = 341 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 146us (kms_flip:3148) DEBUG: name = flip last_ts = 173.564835 last_received_ts = 173.564270 last_seq = 345 current_ts = 173.581482 current_received_ts = 173.580948 current_seq = 346 count = 342 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 120us (kms_flip:3148) DEBUG: name = flip last_ts = 173.581482 last_received_ts = 173.580948 last_seq = 346 current_ts = 173.598145 current_received_ts = 173.597610 current_seq = 347 count = 343 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 85us (kms_flip:3148) DEBUG: name = flip last_ts = 173.598145 last_received_ts = 173.597610 last_seq = 347 current_ts = 173.614822 current_received_ts = 173.614273 current_seq = 348 count = 344 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 145us (kms_flip:3148) DEBUG: name = flip last_ts = 173.614822 last_received_ts = 173.614273 last_seq = 348 current_ts = 173.631485 current_received_ts = 173.630936 current_seq = 349 count = 345 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 121us (kms_flip:3148) DEBUG: name = flip last_ts = 173.631485 last_received_ts = 173.630936 last_seq = 349 current_ts = 173.648148 current_received_ts = 173.647614 current_seq = 350 count = 346 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 81us (kms_flip:3148) DEBUG: name = flip last_ts = 173.648148 last_received_ts = 173.647614 last_seq = 350 current_ts = 173.664810 current_received_ts = 173.664276 current_seq = 351 count = 347 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 159us (kms_flip:3148) DEBUG: name = flip last_ts = 173.664810 last_received_ts = 173.664276 last_seq = 351 current_ts = 173.681473 current_received_ts = 173.680939 current_seq = 352 count = 348 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 125us (kms_flip:3148) DEBUG: name = flip last_ts = 173.681473 last_received_ts = 173.680939 last_seq = 352 current_ts = 173.698135 current_received_ts = 173.697617 current_seq = 353 count = 349 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 90us (kms_flip:3148) DEBUG: name = flip last_ts = 173.698135 last_received_ts = 173.697617 last_seq = 353 current_ts = 173.714798 current_received_ts = 173.714233 current_seq = 354 count = 350 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 90us (kms_flip:3148) DEBUG: name = flip last_ts = 173.714798 last_received_ts = 173.714233 last_seq = 354 current_ts = 173.731461 current_received_ts = 173.730942 current_seq = 355 count = 351 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 122us (kms_flip:3148) DEBUG: name = flip last_ts = 173.731461 last_received_ts = 173.730942 last_seq = 355 current_ts = 173.748123 current_received_ts = 173.747604 current_seq = 356 count = 352 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 81us (kms_flip:3148) DEBUG: name = flip last_ts = 173.748123 last_received_ts = 173.747604 last_seq = 356 current_ts = 173.764786 current_received_ts = 173.764236 current_seq = 357 count = 353 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 79us (kms_flip:3148) DEBUG: name = flip last_ts = 173.764786 last_received_ts = 173.764236 last_seq = 357 current_ts = 173.781464 current_received_ts = 173.780899 current_seq = 358 count = 354 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 99us (kms_flip:3148) DEBUG: name = flip last_ts = 173.781464 last_received_ts = 173.780899 last_seq = 358 current_ts = 173.798126 current_received_ts = 173.797592 current_seq = 359 count = 355 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 83us (kms_flip:3148) DEBUG: name = flip last_ts = 173.798126 last_received_ts = 173.797592 last_seq = 359 current_ts = 173.814789 current_received_ts = 173.814240 current_seq = 360 count = 356 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 90us (kms_flip:3148) DEBUG: name = flip last_ts = 173.814789 last_received_ts = 173.814240 last_seq = 360 current_ts = 173.831451 current_received_ts = 173.830917 current_seq = 361 count = 357 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 94us (kms_flip:3148) DEBUG: name = flip last_ts = 173.831451 last_received_ts = 173.830917 last_seq = 361 current_ts = 173.848114 current_received_ts = 173.847610 current_seq = 362 count = 358 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 92us (kms_flip:3148) DEBUG: name = flip last_ts = 173.848114 last_received_ts = 173.847610 last_seq = 362 current_ts = 173.864777 current_received_ts = 173.864227 current_seq = 363 count = 359 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 90us (kms_flip:3148) DEBUG: name = flip last_ts = 173.864777 last_received_ts = 173.864227 last_seq = 363 current_ts = 173.881454 current_received_ts = 173.880905 current_seq = 364 count = 360 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 135us (kms_flip:3148) DEBUG: name = flip last_ts = 173.881454 last_received_ts = 173.880905 last_seq = 364 current_ts = 173.898102 current_received_ts = 173.897568 current_seq = 365 count = 361 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 81us (kms_flip:3148) DEBUG: name = flip last_ts = 173.898102 last_received_ts = 173.897568 last_seq = 365 current_ts = 173.914764 current_received_ts = 173.914215 current_seq = 366 count = 362 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 82us (kms_flip:3148) DEBUG: name = flip last_ts = 173.914764 last_received_ts = 173.914215 last_seq = 366 current_ts = 173.931427 current_received_ts = 173.930908 current_seq = 367 count = 363 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 126us (kms_flip:3148) DEBUG: name = flip last_ts = 173.931427 last_received_ts = 173.930908 last_seq = 367 current_ts = 173.948105 current_received_ts = 173.947556 current_seq = 368 count = 364 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 91us (kms_flip:3148) DEBUG: name = flip last_ts = 173.948105 last_received_ts = 173.947556 last_seq = 368 current_ts = 173.964767 current_received_ts = 173.964218 current_seq = 369 count = 365 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 91us (kms_flip:3148) DEBUG: name = flip last_ts = 173.964767 last_received_ts = 173.964218 last_seq = 369 current_ts = 173.981430 current_received_ts = 173.980881 current_seq = 370 count = 366 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 90us (kms_flip:3148) DEBUG: name = flip last_ts = 173.981430 last_received_ts = 173.980881 last_seq = 370 current_ts = 173.998093 current_received_ts = 173.997574 current_seq = 371 count = 367 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 80us (kms_flip:3148) DEBUG: name = flip last_ts = 173.998093 last_received_ts = 173.997574 last_seq = 371 current_ts = 174.014755 current_received_ts = 174.014206 current_seq = 372 count = 368 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 90us (kms_flip:3148) DEBUG: name = flip last_ts = 174.014755 last_received_ts = 174.014206 last_seq = 372 current_ts = 174.031418 current_received_ts = 174.030899 current_seq = 373 count = 369 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 125us (kms_flip:3148) DEBUG: name = flip last_ts = 174.031418 last_received_ts = 174.030899 last_seq = 373 current_ts = 174.048080 current_received_ts = 174.047562 current_seq = 374 count = 370 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 90us (kms_flip:3148) DEBUG: name = flip last_ts = 174.048080 last_received_ts = 174.047562 last_seq = 374 current_ts = 174.064743 current_received_ts = 174.064209 current_seq = 375 count = 371 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 90us (kms_flip:3148) DEBUG: name = flip last_ts = 174.064743 last_received_ts = 174.064209 last_seq = 375 current_ts = 174.081406 current_received_ts = 174.080872 current_seq = 376 count = 372 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 81us (kms_flip:3148) DEBUG: name = flip last_ts = 174.081406 last_received_ts = 174.080872 last_seq = 376 current_ts = 174.098083 current_received_ts = 174.097549 current_seq = 377 count = 373 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 92us (kms_flip:3148) DEBUG: name = flip last_ts = 174.098083 last_received_ts = 174.097549 last_seq = 377 current_ts = 174.114746 current_received_ts = 174.114197 current_seq = 378 count = 374 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 80us (kms_flip:3148) DEBUG: name = flip last_ts = 174.114746 last_received_ts = 174.114197 last_seq = 378 current_ts = 174.131409 current_received_ts = 174.130875 current_seq = 379 count = 375 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 79us (kms_flip:3148) DEBUG: name = flip last_ts = 174.131409 last_received_ts = 174.130875 last_seq = 379 current_ts = 174.148071 current_received_ts = 174.147537 current_seq = 380 count = 376 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 90us (kms_flip:3148) DEBUG: name = flip last_ts = 174.148071 last_received_ts = 174.147537 last_seq = 380 current_ts = 174.164734 current_received_ts = 174.164185 current_seq = 381 count = 377 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 80us (kms_flip:3148) DEBUG: name = flip last_ts = 174.164734 last_received_ts = 174.164185 last_seq = 381 current_ts = 174.181396 current_received_ts = 174.180862 current_seq = 382 count = 378 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 81us (kms_flip:3148) DEBUG: name = flip last_ts = 174.181396 last_received_ts = 174.180862 last_seq = 382 current_ts = 174.198059 current_received_ts = 174.197540 current_seq = 383 count = 379 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 80us (kms_flip:3148) DEBUG: name = flip last_ts = 174.198059 last_received_ts = 174.197540 last_seq = 383 current_ts = 174.214722 current_received_ts = 174.214188 current_seq = 384 count = 380 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 85us (kms_flip:3148) DEBUG: name = flip last_ts = 174.214722 last_received_ts = 174.214188 last_seq = 384 current_ts = 174.231384 current_received_ts = 174.230865 current_seq = 385 count = 381 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 93us (kms_flip:3148) DEBUG: name = flip last_ts = 174.231384 last_received_ts = 174.230865 last_seq = 385 current_ts = 174.248062 current_received_ts = 174.247467 current_seq = 386 count = 382 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 57us (kms_flip:3148) DEBUG: name = flip last_ts = 174.248062 last_received_ts = 174.247467 last_seq = 386 current_ts = 174.264725 current_received_ts = 174.264023 current_seq = 387 count = 383 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 39us (kms_flip:3148) DEBUG: name = flip last_ts = 174.264725 last_received_ts = 174.264023 last_seq = 387 current_ts = 174.281387 current_received_ts = 174.280731 current_seq = 388 count = 384 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 62us (kms_flip:3148) DEBUG: name = flip last_ts = 174.281387 last_received_ts = 174.280731 last_seq = 388 current_ts = 174.298050 current_received_ts = 174.297409 current_seq = 389 count = 385 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 96us (kms_flip:3148) DEBUG: name = flip last_ts = 174.298050 last_received_ts = 174.297409 last_seq = 389 current_ts = 174.314713 current_received_ts = 174.314087 current_seq = 390 count = 386 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 105us (kms_flip:3148) DEBUG: name = flip last_ts = 174.314713 last_received_ts = 174.314087 last_seq = 390 current_ts = 174.331375 current_received_ts = 174.330734 current_seq = 391 count = 387 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 81us (kms_flip:3148) DEBUG: name = flip last_ts = 174.331375 last_received_ts = 174.330734 last_seq = 391 current_ts = 174.348038 current_received_ts = 174.347397 current_seq = 392 count = 388 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 91us (kms_flip:3148) DEBUG: name = flip last_ts = 174.348038 last_received_ts = 174.347397 last_seq = 392 current_ts = 174.364700 current_received_ts = 174.364059 current_seq = 393 count = 389 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 91us (kms_flip:3148) DEBUG: name = flip last_ts = 174.364700 last_received_ts = 174.364059 last_seq = 393 current_ts = 174.381363 current_received_ts = 174.380722 current_seq = 394 count = 390 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 81us (kms_flip:3148) DEBUG: name = flip last_ts = 174.381363 last_received_ts = 174.380722 last_seq = 394 current_ts = 174.398026 current_received_ts = 174.397400 current_seq = 395 count = 391 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 155us (kms_flip:3148) DEBUG: name = flip last_ts = 174.398026 last_received_ts = 174.397400 last_seq = 395 current_ts = 174.414688 current_received_ts = 174.414093 current_seq = 396 count = 392 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 81us (kms_flip:3148) DEBUG: name = flip last_ts = 174.414688 last_received_ts = 174.414093 last_seq = 396 current_ts = 174.431351 current_received_ts = 174.430725 current_seq = 397 count = 393 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 80us (kms_flip:3148) DEBUG: name = flip last_ts = 174.431351 last_received_ts = 174.430725 last_seq = 397 current_ts = 174.448029 current_received_ts = 174.447372 current_seq = 398 count = 394 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 92us (kms_flip:3148) DEBUG: name = flip last_ts = 174.448029 last_received_ts = 174.447372 last_seq = 398 current_ts = 174.464691 current_received_ts = 174.464096 current_seq = 399 count = 395 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 85us (kms_flip:3148) DEBUG: name = flip last_ts = 174.464691 last_received_ts = 174.464096 last_seq = 399 current_ts = 174.481354 current_received_ts = 174.480713 current_seq = 400 count = 396 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 78us (kms_flip:3148) DEBUG: name = flip last_ts = 174.481354 last_received_ts = 174.480713 last_seq = 400 current_ts = 174.498016 current_received_ts = 174.497467 current_seq = 401 count = 397 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 81us (kms_flip:3148) DEBUG: name = flip last_ts = 174.498016 last_received_ts = 174.497467 last_seq = 401 current_ts = 174.514679 current_received_ts = 174.514145 current_seq = 402 count = 398 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 93us (kms_flip:3148) DEBUG: name = flip last_ts = 174.514679 last_received_ts = 174.514145 last_seq = 402 current_ts = 174.531342 current_received_ts = 174.530807 current_seq = 403 count = 399 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 93us (kms_flip:3148) DEBUG: name = flip last_ts = 174.531342 last_received_ts = 174.530807 last_seq = 403 current_ts = 174.548004 current_received_ts = 174.547470 current_seq = 404 count = 400 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 171us (kms_flip:3148) DEBUG: name = flip last_ts = 174.548004 last_received_ts = 174.547470 last_seq = 404 current_ts = 174.564667 current_received_ts = 174.564117 current_seq = 405 count = 401 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 80us (kms_flip:3148) DEBUG: name = flip last_ts = 174.564667 last_received_ts = 174.564117 last_seq = 405 current_ts = 174.581329 current_received_ts = 174.580795 current_seq = 406 count = 402 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 80us (kms_flip:3148) DEBUG: name = flip last_ts = 174.581329 last_received_ts = 174.580795 last_seq = 406 current_ts = 174.597992 current_received_ts = 174.597458 current_seq = 407 count = 403 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 81us (kms_flip:3148) DEBUG: name = flip last_ts = 174.597992 last_received_ts = 174.597458 last_seq = 407 current_ts = 174.614670 current_received_ts = 174.614105 current_seq = 408 count = 404 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 92us (kms_flip:3148) DEBUG: name = flip last_ts = 174.614670 last_received_ts = 174.614105 last_seq = 408 current_ts = 174.631332 current_received_ts = 174.630768 current_seq = 409 count = 405 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 81us (kms_flip:3148) DEBUG: name = flip last_ts = 174.631332 last_received_ts = 174.630768 last_seq = 409 current_ts = 174.647995 current_received_ts = 174.647446 current_seq = 410 count = 406 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 81us (kms_flip:3148) DEBUG: name = flip last_ts = 174.647995 last_received_ts = 174.647446 last_seq = 410 current_ts = 174.664658 current_received_ts = 174.664108 current_seq = 411 count = 407 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 80us (kms_flip:3148) DEBUG: name = flip last_ts = 174.664658 last_received_ts = 174.664108 last_seq = 411 current_ts = 174.681320 current_received_ts = 174.680756 current_seq = 412 count = 408 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 80us (kms_flip:3148) DEBUG: name = flip last_ts = 174.681320 last_received_ts = 174.680756 last_seq = 412 current_ts = 174.697983 current_received_ts = 174.697433 current_seq = 413 count = 409 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 80us (kms_flip:3148) DEBUG: name = flip last_ts = 174.697983 last_received_ts = 174.697433 last_seq = 413 current_ts = 174.714645 current_received_ts = 174.714127 current_seq = 414 count = 410 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 91us (kms_flip:3148) DEBUG: name = flip last_ts = 174.714645 last_received_ts = 174.714127 last_seq = 414 current_ts = 174.731308 current_received_ts = 174.730789 current_seq = 415 count = 411 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 82us (kms_flip:3148) DEBUG: name = flip last_ts = 174.731308 last_received_ts = 174.730789 last_seq = 415 current_ts = 174.747971 current_received_ts = 174.747437 current_seq = 416 count = 412 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 80us (kms_flip:3148) DEBUG: name = flip last_ts = 174.747971 last_received_ts = 174.747437 last_seq = 416 current_ts = 174.764633 current_received_ts = 174.764099 current_seq = 417 count = 413 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 81us (kms_flip:3148) DEBUG: name = flip last_ts = 174.764633 last_received_ts = 174.764099 last_seq = 417 current_ts = 174.781311 current_received_ts = 174.780746 current_seq = 418 count = 414 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 81us (kms_flip:3148) DEBUG: name = flip last_ts = 174.781311 last_received_ts = 174.780746 last_seq = 418 current_ts = 174.797974 current_received_ts = 174.797424 current_seq = 419 count = 415 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 91us (kms_flip:3148) DEBUG: name = flip last_ts = 174.797974 last_received_ts = 174.797424 last_seq = 419 current_ts = 174.814636 current_received_ts = 174.814117 current_seq = 420 count = 416 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 90us (kms_flip:3148) DEBUG: name = flip last_ts = 174.814636 last_received_ts = 174.814117 last_seq = 420 current_ts = 174.831299 current_received_ts = 174.830750 current_seq = 421 count = 417 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 81us (kms_flip:3148) DEBUG: name = flip last_ts = 174.831299 last_received_ts = 174.830750 last_seq = 421 current_ts = 174.847961 current_received_ts = 174.847412 current_seq = 422 count = 418 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 80us (kms_flip:3148) DEBUG: name = flip last_ts = 174.847961 last_received_ts = 174.847412 last_seq = 422 current_ts = 174.864624 current_received_ts = 174.864090 current_seq = 423 count = 419 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 61us (kms_flip:3148) DEBUG: name = flip last_ts = 174.864624 last_received_ts = 174.864090 last_seq = 423 current_ts = 174.881287 current_received_ts = 174.880753 current_seq = 424 count = 420 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 90us (kms_flip:3148) DEBUG: name = flip last_ts = 174.881287 last_received_ts = 174.880753 last_seq = 424 current_ts = 174.897949 current_received_ts = 174.897400 current_seq = 425 count = 421 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 81us (kms_flip:3148) DEBUG: name = flip last_ts = 174.897949 last_received_ts = 174.897400 last_seq = 425 current_ts = 174.914627 current_received_ts = 174.914078 current_seq = 426 count = 422 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 80us (kms_flip:3148) DEBUG: name = flip last_ts = 174.914627 last_received_ts = 174.914078 last_seq = 426 current_ts = 174.931274 current_received_ts = 174.930740 current_seq = 427 count = 423 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 91us (kms_flip:3148) DEBUG: name = flip last_ts = 174.931274 last_received_ts = 174.930740 last_seq = 427 current_ts = 174.947952 current_received_ts = 174.947418 current_seq = 428 count = 424 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 81us (kms_flip:3148) DEBUG: name = flip last_ts = 174.947952 last_received_ts = 174.947418 last_seq = 428 current_ts = 174.964615 current_received_ts = 174.964081 current_seq = 429 count = 425 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 90us (kms_flip:3148) DEBUG: name = flip last_ts = 174.964615 last_received_ts = 174.964081 last_seq = 429 current_ts = 174.981277 current_received_ts = 174.980743 current_seq = 430 count = 426 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 94us (kms_flip:3148) DEBUG: name = flip last_ts = 174.981277 last_received_ts = 174.980743 last_seq = 430 current_ts = 174.997940 current_received_ts = 174.997406 current_seq = 431 count = 427 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 91us (kms_flip:3148) DEBUG: name = flip last_ts = 174.997940 last_received_ts = 174.997406 last_seq = 431 current_ts = 175.014603 current_received_ts = 175.014084 current_seq = 432 count = 428 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 86us (kms_flip:3148) DEBUG: name = flip last_ts = 175.014603 last_received_ts = 175.014084 last_seq = 432 current_ts = 175.031265 current_received_ts = 175.030716 current_seq = 433 count = 429 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 80us (kms_flip:3148) DEBUG: name = flip last_ts = 175.031265 last_received_ts = 175.030716 last_seq = 433 current_ts = 175.047928 current_received_ts = 175.047394 current_seq = 434 count = 430 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 92us (kms_flip:3148) DEBUG: name = flip last_ts = 175.047928 last_received_ts = 175.047394 last_seq = 434 current_ts = 175.064590 current_received_ts = 175.064056 current_seq = 435 count = 431 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 88us (kms_flip:3148) DEBUG: name = flip last_ts = 175.064590 last_received_ts = 175.064056 last_seq = 435 current_ts = 175.081253 current_received_ts = 175.080719 current_seq = 436 count = 432 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 81us (kms_flip:3148) DEBUG: name = flip last_ts = 175.081253 last_received_ts = 175.080719 last_seq = 436 current_ts = 175.097916 current_received_ts = 175.097412 current_seq = 437 count = 433 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 89us (kms_flip:3148) DEBUG: name = flip last_ts = 175.097916 last_received_ts = 175.097412 last_seq = 437 current_ts = 175.114594 current_received_ts = 175.114059 current_seq = 438 count = 434 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 89us (kms_flip:3148) DEBUG: name = flip last_ts = 175.114594 last_received_ts = 175.114059 last_seq = 438 current_ts = 175.131256 current_received_ts = 175.130707 current_seq = 439 count = 435 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 81us (kms_flip:3148) DEBUG: name = flip last_ts = 175.131256 last_received_ts = 175.130707 last_seq = 439 current_ts = 175.147919 current_received_ts = 175.147385 current_seq = 440 count = 436 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 147us (kms_flip:3148) DEBUG: name = flip last_ts = 175.147919 last_received_ts = 175.147385 last_seq = 440 current_ts = 175.164581 current_received_ts = 175.164062 current_seq = 441 count = 437 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 89us (kms_flip:3148) DEBUG: name = flip last_ts = 175.164581 last_received_ts = 175.164062 last_seq = 441 current_ts = 175.181244 current_received_ts = 175.180695 current_seq = 442 count = 438 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 91us (kms_flip:3148) DEBUG: name = flip last_ts = 175.181244 last_received_ts = 175.180695 last_seq = 442 current_ts = 175.197906 current_received_ts = 175.197357 current_seq = 443 count = 439 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 81us (kms_flip:3148) DEBUG: name = flip last_ts = 175.197906 last_received_ts = 175.197357 last_seq = 443 current_ts = 175.214569 current_received_ts = 175.214035 current_seq = 444 count = 440 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 89us (kms_flip:3148) DEBUG: name = flip last_ts = 175.214569 last_received_ts = 175.214035 last_seq = 444 current_ts = 175.231232 current_received_ts = 175.230682 current_seq = 445 count = 441 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 82us (kms_flip:3148) DEBUG: name = flip last_ts = 175.231232 last_received_ts = 175.230682 last_seq = 445 current_ts = 175.247910 current_received_ts = 175.247375 current_seq = 446 count = 442 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 149us (kms_flip:3148) DEBUG: name = flip last_ts = 175.247910 last_received_ts = 175.247375 last_seq = 446 current_ts = 175.264557 current_received_ts = 175.264038 current_seq = 447 count = 443 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 88us (kms_flip:3148) DEBUG: name = flip last_ts = 175.264557 last_received_ts = 175.264038 last_seq = 447 current_ts = 175.281219 current_received_ts = 175.280701 current_seq = 448 count = 444 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 85us (kms_flip:3148) DEBUG: name = flip last_ts = 175.281219 last_received_ts = 175.280701 last_seq = 448 current_ts = 175.297882 current_received_ts = 175.297363 current_seq = 449 count = 445 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 80us (kms_flip:3148) DEBUG: name = flip last_ts = 175.297882 last_received_ts = 175.297363 last_seq = 449 current_ts = 175.314560 current_received_ts = 175.313995 current_seq = 450 count = 446 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 79us (kms_flip:3148) DEBUG: name = flip last_ts = 175.314560 last_received_ts = 175.313995 last_seq = 450 current_ts = 175.331223 current_received_ts = 175.330673 current_seq = 451 count = 447 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 81us (kms_flip:3148) DEBUG: name = flip last_ts = 175.331223 last_received_ts = 175.330673 last_seq = 451 current_ts = 175.347885 current_received_ts = 175.347351 current_seq = 452 count = 448 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 90us (kms_flip:3148) DEBUG: name = flip last_ts = 175.347885 last_received_ts = 175.347351 last_seq = 452 current_ts = 175.364548 current_received_ts = 175.363998 current_seq = 453 count = 449 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 79us (kms_flip:3148) DEBUG: name = flip last_ts = 175.364548 last_received_ts = 175.363998 last_seq = 453 current_ts = 175.381210 current_received_ts = 175.380676 current_seq = 454 count = 450 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 93us (kms_flip:3148) DEBUG: name = flip last_ts = 175.381210 last_received_ts = 175.380676 last_seq = 454 current_ts = 175.397873 current_received_ts = 175.397354 current_seq = 455 count = 451 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 81us (kms_flip:3148) DEBUG: name = flip last_ts = 175.397873 last_received_ts = 175.397354 last_seq = 455 current_ts = 175.414536 current_received_ts = 175.413986 current_seq = 456 count = 452 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 79us (kms_flip:3148) DEBUG: name = flip last_ts = 175.414536 last_received_ts = 175.413986 last_seq = 456 current_ts = 175.431198 current_received_ts = 175.430664 current_seq = 457 count = 453 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 91us (kms_flip:3148) DEBUG: name = flip last_ts = 175.431198 last_received_ts = 175.430664 last_seq = 457 current_ts = 175.447876 current_received_ts = 175.447311 current_seq = 458 count = 454 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 113us (kms_flip:3148) DEBUG: name = flip last_ts = 175.447876 last_received_ts = 175.447311 last_seq = 458 current_ts = 175.464539 current_received_ts = 175.464005 current_seq = 459 count = 455 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 87us (kms_flip:3148) DEBUG: name = flip last_ts = 175.464539 last_received_ts = 175.464005 last_seq = 459 current_ts = 175.481201 current_received_ts = 175.480667 current_seq = 460 count = 456 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 80us (kms_flip:3148) DEBUG: name = flip last_ts = 175.481201 last_received_ts = 175.480667 last_seq = 460 current_ts = 175.497864 current_received_ts = 175.497314 current_seq = 461 count = 457 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 120us (kms_flip:3148) DEBUG: name = flip last_ts = 175.497864 last_received_ts = 175.497314 last_seq = 461 current_ts = 175.514526 current_received_ts = 175.513962 current_seq = 462 count = 458 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 101us (kms_flip:3148) DEBUG: name = flip last_ts = 175.514526 last_received_ts = 175.513962 last_seq = 462 current_ts = 175.531189 current_received_ts = 175.530655 current_seq = 463 count = 459 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 90us (kms_flip:3148) DEBUG: name = flip last_ts = 175.531189 last_received_ts = 175.530655 last_seq = 463 current_ts = 175.547852 current_received_ts = 175.547318 current_seq = 464 count = 460 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 152us (kms_flip:3148) DEBUG: name = flip last_ts = 175.547852 last_received_ts = 175.547318 last_seq = 464 current_ts = 175.564514 current_received_ts = 175.563980 current_seq = 465 count = 461 seq_step = 1 (kms_flip:3148) DEBUG: Vblank took 1302us (kms_flip:3148) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:926: (kms_flip:3148) CRITICAL: Failed assertion: end - start < 500 (kms_flip:3148) igt_core-INFO: Stack trace: (kms_flip:3148) igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (kms_flip:3148) igt_core-INFO: #1 ../tests/kms_flip.c:921 run_test_on_crtc_set.constprop.0() (kms_flip:3148) igt_core-INFO: #2 ../tests/kms_flip.c:1887 run_test() (kms_flip:3148) igt_core-INFO: #3 ../tests/kms_flip.c:2120 __igt_unique____real_main2043() (kms_flip:3148) igt_core-INFO: #4 ../tests/kms_flip.c:2043 main() (kms_flip:3148) igt_core-INFO: #5 [__libc_init_first+0x8a] (kms_flip:3148) igt_core-INFO: #6 [__libc_start_main+0x8b] (kms_flip:3148) igt_core-INFO: #7 [_start+0x25] **** END **** Dynamic subtest B-eDP1: FAIL (9.084s) Starting dynamic subtest: C-eDP1 Dynamic subtest C-eDP1: SUCCESS (11.210s) Subtest flip-vs-expired-vblank: FAIL (31.532s) |
| Dmesg |
<6> [155.502341] Console: switching to colour dummy device 80x25
<6> [155.502579] [IGT] kms_flip: executing
<7> [155.508057] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:401:DP-1]
<7> [155.508067] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:401:DP-1]
<7> [155.508213] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:401:DP-1] disconnected
<7> [155.508421] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:413:DP-2]
<7> [155.508424] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:413:DP-2]
<7> [155.508644] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:413:DP-2] disconnected
<7> [155.508985] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:421:DP-3]
<7> [155.508987] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:421:DP-3]
<7> [155.509099] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:421:DP-3] disconnected
<7> [155.509334] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:392:eDP-1]
<7> [155.509336] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:392:eDP-1]
<7> [155.509781] xe 0000:00:02.0: [drm:intel_dp_read_dsc_dpcd [xe]] DSC DPCD: 00 11 00 76 0b 01 01 80 00 01 06 66 08 00 00 00
<7> [155.510096] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] source rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 675000, 810000
<7> [155.510202] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] sink rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 810000
<7> [155.510307] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] common rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 810000
<7> [155.510431] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:392:eDP-1] Supported Monitor Refresh rate range is 40 Hz - 120 Hz
<5> [155.510436] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<5> [155.510438] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [155.510440] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:392:eDP-1] DisplayID extension version 0x13, primary use 0x00
<7> [155.510450] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:392:eDP-1] Assigning EDID-1.4 digital sink color depth as 10 bpc.
<5> [155.510453] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [155.510455] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:392:eDP-1] ELD monitor
<5> [155.510458] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [155.510460] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:392:eDP-1] ELD size 20, SAD count 0
<5> [155.510463] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [155.510477] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:392:eDP-1] VRR capable: yes
<7> [155.510597] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:392:eDP-1] DFP max bpc 0, max dotclock 0, TMDS clock 0-0, PCON Max FRL BW 0Gbps
<7> [155.510716] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:392:eDP-1] RGB->YcbCr conversion? no, YCbCr 4:2:0 allowed? yes, YCbCr 4:4:4->4:2:0 conversion? no
<5> [155.511048] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<5> [155.511050] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<5> [155.511051] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [155.511124] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:392:eDP-1] probed modes:
<7> [155.511127] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [155.511130] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2880x1800": 120 695310 2880 2928 2960 3040 1800 1803 1809 1906 0x40 0xa
<7> [155.511143] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:401:DP-1]
<7> [155.511146] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:401:DP-1]
<7> [155.511298] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:401:DP-1] disconnected
<7> [155.511308] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:413:DP-2]
<7> [155.511310] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:413:DP-2]
<7> [155.511422] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:413:DP-2] disconnected
<7> [155.511429] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:421:DP-3]
<7> [155.511431] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:421:DP-3]
<7> [155.511567] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:421:DP-3] disconnected
<6> [155.512148] [IGT] kms_flip: starting subtest flip-vs-expired-vblank
<6> [155.513308] [IGT] kms_flip: starting dynamic subtest A-eDP1
<7> [155.514328] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:430]
<7> [155.514827] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:431]
<7> [155.593371] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:150:pipe A]
<7> [155.593609] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [155.593922] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [155.594165] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [155.594398] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [155.594650] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in dp_m_n (expected tu 64 data 6329869/8388608 link 421991/524288, found tu 0, data 0/0 link 0/0)
<7> [155.594866] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [155.595086] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [155.595295] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [155.595501] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [155.595695] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [155.595874] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [155.596079] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [155.596265] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [155.596431] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [155.596620] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0)
<7> [155.596776] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [155.596949] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [155.597117] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0)
<7> [155.597281] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0)
<7> [155.597423] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [155.597590] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [155.597725] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [155.597858] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [155.597991] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [155.598123] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [155.598255] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [155.598382] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0)
<7> [155.598521] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [155.598642] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [155.598763] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0)
<7> [155.598879] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0)
<7> [155.598994] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [155.599110] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [155.599226] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [155.599343] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [155.599460] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0)
<7> [155.599569] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0)
<7> [155.599682] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in port_clock (expected 432000, found 0)
<7> [155.599796] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:150:pipe A] fastset requirement not met, forcing full modeset
<7> [155.599908] xe 0000:00:02.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:150:pipe A] releasing DPLL 0
<7> [155.600087] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [155.600189] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:150:pipe A] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [155.600323] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:34:plane 1A] ddb ( 0 - 4051) -> ( 0 - 0), size 4051 -> 0
<7> [155.600409] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:144:cursor A] ddb (4051 - 4096) -> ( 0 - 0), size 45 -> 0
<7> [155.600503] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34: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> [155.600581] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] lines 1, 13, 13, 13, 13, 13, 0, 0, 0, 3, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [155.600657] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] blocks 24, 313, 313, 313, 313, 313, 0, 0, 38, 73, 87 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [155.600730] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] min_ddb 28, 346, 346, 346, 346, 346, 0, 0, 39, 82, 88 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [155.600825] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:150:pipe A] data rate 0 num active planes 0
<7> [155.600935] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400
<7> [155.601041] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400
<7> [155.601144] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [155.601246] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [155.601347] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0
<7> [155.601450] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:150:pipe A] min cdclk: 173855 kHz -> 0 kHz
<7> [155.601576] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 21732 kHz -> 0 kHz
<7> [155.601691] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [155.601790] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz
<7> [155.601883] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [155.602004] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:150:pipe A] enable: no [modeset]
<7> [155.602098] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:34:plane 1A] fb: [NOFB], visible: no
<7> [155.602188] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [155.602278] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [155.602363] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [155.602452] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [155.602543] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:144:cursor A] fb: [NOFB], visible: no
<7> [155.602695] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [155.603422] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [155.603603] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2
<7> [155.604300] xe 0000:00:02.0: [drm:intel_alpm_disable [xe]] Disabling ALPM
<7> [155.604401] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]]
<7> [155.809575] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:392:eDP-1] set backlight PWM = 0
<7> [155.810289] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe A
<7> [155.820996] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turn panel power off
<7> [155.821389] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [155.821811] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [155.872929] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [155.873298] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:150:pipe A]
<7> [155.873853] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [155.874443] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - short
<7> [155.874811] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disabling DPLL 0
<7> [155.875004] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [155.875252] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A
<7> [155.875807] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:391:DDI A/PHY A]
<7> [155.876185] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:400:DDI TC1/PHY TC1]
<7> [155.876540] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:402:DP-MST A]
<7> [155.876847] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:403:DP-MST B]
<7> [155.877194] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:404:DP-MST C]
<7> [155.877517] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:412:DDI TC2/PHY TC2]
<7> [155.877783] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:414:DP-MST A]
<7> [155.878044] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:415:DP-MST B]
<7> [155.878323] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:416:DP-MST C]
<7> [155.878622] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:420:DDI TC3/PHY TC3]
<7> [155.878916] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:422:DP-MST A]
<7> [155.879167] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:423:DP-MST B]
<7> [155.879435] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:424:DP-MST C]
<7> [155.879784] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:392:eDP-1]
<7> [155.880219] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [155.880567] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [155.880859] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [155.881432] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_A
<7> [155.881912] xe 0000:00:02.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating disabled for pipe_mask=0x1 (CLKGATE_DIS_DSSDSC=0xaa000000)
<7> [155.882398] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:150:pipe A]
<7> [155.882822] 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> [155.883257] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [155.883589] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384
<7> [155.884505] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:269:pipe B]
<7> [155.884893] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:388:pipe C]
<7> [155.885218] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:150:pipe A]
<7> [155.885289] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:392:eDP-1]
<7> [155.885482] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:392:eDP-1] Limiting target display pipe bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [155.885866] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:391:DDI A/PHY A][CRTC:150:pipe A] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 min link_bpp 18.0000 max link_bpp 30.0000
<7> [155.886192] xe 0000:00:02.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 432000 bpp input 30 compressed 0.0000 HDR no link rate required 1303913 available 1728000
<7> [155.886547] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:150:pipe A] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [155.886923] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:391:DDI A/PHY A] [CRTC:150:pipe A]
<7> [155.887261] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [155.887639] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [155.887934] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [155.888211] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [155.888504] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6329869/8388608 link 421991/524288)
<7> [155.888760] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [155.888993] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [155.889225] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [155.889454] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [155.889710] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [155.889920] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [155.890153] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [155.890370] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [155.890612] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [155.890796] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800)
<7> [155.890970] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [155.891142] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [155.891313] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906)
<7> [155.891492] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906)
<7> [155.891647] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [155.891802] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [155.891976] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [155.892150] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [155.892325] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [155.892517] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [155.892659] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [155.892798] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800)
<7> [155.892950] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [155.893109] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [155.893247] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906)
<7> [155.893392] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906)
<7> [155.893560] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [155.893683] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [155.893805] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [155.893943] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [155.894067] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710)
<7> [155.894182] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710)
<7> [155.894298] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in port_clock (expected 0, found 432000)
<7> [155.894405] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:150:pipe A] fastset requirement not met, forcing full modeset
<7> [155.894568] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [155.894650] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:150:pipe A] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x1
<7> [155.894763] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:34:plane 1A] ddb ( 0 - 0) -> ( 0 - 4051), size 0 -> 4051
<7> [155.894842] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:144:cursor A] ddb ( 0 - 0) -> (4051 - 4096), size 0 -> 45
<7> [155.894919] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34: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> [155.894991] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 13, 13, 13, 13, 13, 0, 0, 0, 4, 0
<7> [155.895064] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 92, 297, 297, 297, 297, 297, 0, 0, 197, 92, 197
<7> [155.895135] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 183, 456, 456, 456, 456, 456, 0, 0, 198, 183, 198
<7> [155.895224] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:150:pipe A] data rate 1390840 num active planes 1
<7> [155.895333] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400
<7> [155.895435] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400
<7> [155.895555] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [155.895651] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [155.895744] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461
<7> [155.895836] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:150:pipe A] min cdclk: 0 kHz -> 173855 kHz
<7> [155.895945] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 0 kHz -> 21732 kHz
<7> [155.896034] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [155.896120] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [155.896206] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [155.896306] xe 0000:00:02.0: [drm:intel_find_dpll [xe]] [CRTC:150:pipe A] allocated DPLL 0
<7> [155.896395] xe 0000:00:02.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:150:pipe A] reserving DPLL 0
<7> [155.896509] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:150:pipe A] enable: yes [modeset]
<7> [155.896596] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [155.896682] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 30, dithering: 0
<7> [155.896766] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [155.896844] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [155.896919] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [155.896993] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [155.897068] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 6329869, data_n: 8388608, link_m: 421991, link_n: 524288, tu: 64
<7> [155.897142] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [155.897214] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [155.897286] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [155.897357] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [155.897428] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [155.897531] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [155.897609] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14
<7> [155.897686] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB
<7> [155.897764] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB
<7> [155.897846] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0
<7> [155.897926] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range
<7> [155.898006] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined
<7> [155.898085] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [155.898154] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [155.898223] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1906, vmax: 1906, flipline: 1906, pipeline full: 0, guardband: 104 vsync start: 103, vsync end: 97
<7> [155.898294] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1802, vmax vblank: 1802, vmin vtotal: 1906, vmax vtotal: 1906
<7> [155.898364] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [155.898434] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] requested mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [155.898542] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [155.898618] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa
<7> [155.898708] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x40 0xa
<7> [155.898797] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa
<7> [155.898880] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710, min cdclk 173855
<7> [155.898954] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0
<7> [155.899026] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [155.899097] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [155.899168] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [155.899241] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: yes, tbt_mode: no
<7> [155.899317] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_hw_state: fracen: no,
<7> [155.899389] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] multiplier: 225, tx_clk_div: 1.
<7> [155.899469] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_rawhw_state:
<7> [155.899549] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] tx: 0x10, cmn: 0x21
<7> [155.899626] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[0] = 0x4, pll[1] = 0x0, pll[2] = 0xa2, pll[3] = 0x1
<7> [155.899702] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [155.899777] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [155.899848] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[12] = 0x0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x1
<7> [155.899916] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[16] = 0x85, pll[17] = 0xf, pll[18] = 0xe6, pll[19] = 0x23
<7> [155.899984] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [155.900052] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [155.900120] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [155.900187] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [155.900254] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [155.900322] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [155.900389] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [155.900464] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [155.900537] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [155.900611] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [155.900685] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [155.900759] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [155.900830] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [155.900897] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:34:plane 1A] fb: [FB:430] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [155.900967] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [155.901035] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [155.901103] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [155.901171] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [155.901238] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [155.901304] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [155.901372] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:144:cursor A] fb: [NOFB], visible: no
<7> [155.901775] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_A
<7> [155.901923] xe 0000:00:02.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x1 (CLKGATE_DIS_DSSDSC=0xa8000000)
<7> [155.902016] 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> [155.902103] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [155.902188] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480
<7> [155.902267] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:391:DDI A/PHY A]
<7> [155.902334] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:400:DDI TC1/PHY TC1]
<7> [155.902399] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:402:DP-MST A]
<7> [155.902474] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:403:DP-MST B]
<7> [155.902544] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:404:DP-MST C]
<7> [155.902612] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:412:DDI TC2/PHY TC2]
<7> [155.902677] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:414:DP-MST A]
<7> [155.902744] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:415:DP-MST B]
<7> [155.902807] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:416:DP-MST C]
<7> [155.902867] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:420:DDI TC3/PHY TC3]
<7> [155.902929] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:422:DP-MST A]
<7> [155.902990] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:423:DP-MST B]
<7> [155.903050] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:424:DP-MST C]
<7> [155.903131] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [155.903286] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: *)
<7> [155.903347] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes)
<7> [155.903452] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A
<7> [155.904545] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:150:pipe A]
<7> [155.904689] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enabling DPLL 0
<7> [155.906670] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turn panel power on
<7> [155.906755] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power cycle (467 ms remaining)
<7> [155.909386] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [155.909595] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - long
<7> [155.909698] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [155.909811] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [156.377623] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [156.435773] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [156.436199] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power on
<7> [156.436634] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [156.473031] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [156.473674] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - long
<7> [156.474193] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [156.474835] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [156.537669] 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> [156.537787] 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> [156.537999] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port D/TC#1: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [156.649017] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [156.649398] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turning VDD on
<7> [156.649799] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [156.651973] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX A/DDI A/PHY A: DPCD: 14 1e 44 c1 00 00 01 c0 02 00 02 00 00 0b 80
<7> [156.653526] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [156.654322] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05
<7> [156.655488] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [156.656835] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [156.657981] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Clock recovery OK
<7> [156.658314] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using DP training pattern TPS4
<7> [156.659921] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [156.660365] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4
<7> [156.661241] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe A
<7> [156.661766] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]]
<7> [156.662137] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe A
<7> [156.662552] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:392:eDP-1] set backlight PWM = 192000
<7> [156.678650] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2
<7> [156.680326] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:392:eDP-1]
<7> [156.680790] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:150:pipe A]
<7> [159.226583] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turning VDD off
<7> [159.227032] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [166.710666] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:431] from all active usage due to RMFB ioctl
<7> [166.713566] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:430] from all active usage due to RMFB ioctl
<7> [166.713659] xe 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:34:plane 1A] because [FB:430] is removed
<7> [166.713768] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:34:plane 1A] ddb ( 0 - 4051) -> ( 0 - 0), size 4051 -> 0
<7> [166.714154] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34: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> [166.714494] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] lines 4, 13, 13, 13, 13, 13, 0, 0, 0, 4, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [166.714782] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] blocks 92, 297, 297, 297, 297, 297, 0, 0, 197, 92, 197 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [166.715082] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] min_ddb 183, 456, 456, 456, 456, 456, 0, 0, 198, 183, 198 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [166.715402] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:150:pipe A] data rate 0 num active planes 0
<7> [166.715863] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400
<7> [166.716262] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400
<7> [166.716771] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [166.717203] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [166.717672] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0
<7> [166.719101] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2
<7> [166.728552] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turning VDD on
<7> [166.728969] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006f
<6> [166.744787] [IGT] kms_flip: finished subtest A-eDP1, SUCCESS
<6> [166.746587] [IGT] kms_flip: starting dynamic subtest B-eDP1
<7> [166.749655] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:430]
<7> [166.751122] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:431]
<7> [166.761525] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [166.761894] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [166.762172] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [166.832497] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:150:pipe A]
<7> [166.832725] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [166.833021] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [166.833250] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [166.833499] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [166.833701] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in dp_m_n (expected tu 64 data 6329869/8388608 link 421991/524288, found tu 0, data 0/0 link 0/0)
<7> [166.833899] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [166.834085] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [166.834263] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [166.834470] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [166.834649] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [166.834841] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [166.835005] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [166.835163] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [166.835322] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [166.835493] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0)
<7> [166.835643] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [166.835789] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [166.835953] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0)
<7> [166.836093] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0)
<7> [166.836232] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [166.836374] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [166.836509] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [166.836641] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [166.836789] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [166.836920] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [166.837053] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [166.837181] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0)
<7> [166.837306] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [166.837451] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [166.837580] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0)
<7> [166.837705] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0)
<7> [166.837828] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [166.837962] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [166.838099] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [166.838218] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [166.838331] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0)
<7> [166.838459] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0)
<7> [166.838569] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in port_clock (expected 432000, found 0)
<7> [166.838679] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:150:pipe A] fastset requirement not met, forcing full modeset
<7> [166.838788] xe 0000:00:02.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:150:pipe A] releasing DPLL 0
<7> [166.838967] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [166.839062] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:150:pipe A] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [166.839173] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:144:cursor A] ddb (4051 - 4096) -> ( 0 - 0), size 45 -> 0
<7> [166.839282] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:150:pipe A] min cdclk: 173855 kHz -> 0 kHz
<7> [166.839435] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [166.839550] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz
<7> [166.839661] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [166.839806] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:150:pipe A] enable: no [modeset]
<7> [166.839919] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:34:plane 1A] fb: [NOFB], visible: no
<7> [166.840025] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [166.840126] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [166.840237] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [166.840343] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [166.840454] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:144:cursor A] fb: [NOFB], visible: no
<7> [166.840605] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [166.840708] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [166.841069] xe 0000:00:02.0: [drm:intel_alpm_disable [xe]] Disabling ALPM
<7> [166.841194] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]]
<7> [167.049491] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:392:eDP-1] set backlight PWM = 0
<7> [167.050149] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe A
<7> [167.060931] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turn panel power off
<7> [167.061404] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [167.061836] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [167.113958] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [167.114599] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - short
<7> [167.117428] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [167.117886] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:150:pipe A]
<7> [167.117922] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [167.119386] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disabling DPLL 0
<7> [167.119963] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A
<7> [167.120569] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:391:DDI A/PHY A]
<7> [167.121033] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:400:DDI TC1/PHY TC1]
<7> [167.121523] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:402:DP-MST A]
<7> [167.121940] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:403:DP-MST B]
<7> [167.122300] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:404:DP-MST C]
<7> [167.122682] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:412:DDI TC2/PHY TC2]
<7> [167.123005] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:414:DP-MST A]
<7> [167.123322] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:415:DP-MST B]
<7> [167.123696] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:416:DP-MST C]
<7> [167.124009] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:420:DDI TC3/PHY TC3]
<7> [167.124317] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:422:DP-MST A]
<7> [167.124681] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:423:DP-MST B]
<7> [167.124988] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:424:DP-MST C]
<7> [167.125294] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:392:eDP-1]
<7> [167.125758] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [167.126077] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [167.126426] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [167.126946] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_A
<7> [167.127396] xe 0000:00:02.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating disabled for pipe_mask=0x1 (CLKGATE_DIS_DSSDSC=0xaa000000)
<7> [167.127854] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:150:pipe A]
<7> [167.128212] 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> [167.128726] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [167.129079] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384
<7> [167.129930] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:269:pipe B]
<7> [167.130314] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:388:pipe C]
<7> [167.130628] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:269:pipe B]
<7> [167.130694] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:392:eDP-1]
<7> [167.130860] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:392:eDP-1] Limiting target display pipe bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [167.131200] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:391:DDI A/PHY A][CRTC:269:pipe B] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 min link_bpp 18.0000 max link_bpp 30.0000
<7> [167.131522] xe 0000:00:02.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 432000 bpp input 30 compressed 0.0000 HDR no link rate required 1303913 available 1728000
<7> [167.131878] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:269:pipe B] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [167.132162] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:391:DDI A/PHY A] [CRTC:269:pipe B]
<7> [167.132446] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [167.132706] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [167.132946] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [167.133232] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [167.133487] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6329869/8388608 link 421991/524288)
<7> [167.133717] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [167.133932] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [167.134141] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [167.134342] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [167.134566] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [167.134773] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [167.134946] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [167.135114] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [167.135282] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [167.135496] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800)
<7> [167.135671] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [167.135840] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [167.136011] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906)
<7> [167.136174] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906)
<7> [167.136314] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [167.136465] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [167.136595] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [167.136720] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [167.136842] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [167.136961] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [167.137080] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [167.137204] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800)
<7> [167.137325] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [167.137457] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [167.137571] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906)
<7> [167.137682] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906)
<7> [167.137803] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [167.137925] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [167.138028] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [167.138128] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in dpll_hw_state
<7> [167.138226] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [167.138323] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] cx0pll_hw_state: lane_count: 0, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [167.138433] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] c20pll_hw_state:
<7> [167.138526] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] tx[0] = 0x0000, tx[1] = 0x0000, tx[2] = 0x0000
<7> [167.138616] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] cmn[0] = 0x0000, cmn[1] = 0x0000, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [167.138705] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] mplla[0] = 0x0000
<7> [167.138794] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] mplla[1] = 0x0000
<7> [167.138879] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] mplla[2] = 0x0000
<7> [167.138962] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] mplla[3] = 0x0000
<7> [167.139045] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] mplla[4] = 0x0000
<7> [167.139127] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] mplla[5] = 0x0000
<7> [167.139207] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] mplla[6] = 0x0000
<7> [167.139287] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] mplla[7] = 0x0000
<7> [167.139371] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] mplla[8] = 0x0000
<7> [167.139472] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] mplla[9] = 0x0000
<7> [167.139564] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] mpllb[10] = 0x0000
<7> [167.139656] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] vdr: custom width: 0x00, serdes rate: 0x00, hdmi rate: 0x00
<7> [167.139735] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [167.139809] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: yes, tbt_mode: no
<7> [167.139882] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] c10pll_hw_state: fracen: no,
<7> [167.139954] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] multiplier: 225, tx_clk_div: 1.
<7> [167.140026] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] c10pll_rawhw_state:
<7> [167.140095] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] tx: 0x10, cmn: 0x21
<7> [167.140164] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[0] = 0x4, pll[1] = 0x0, pll[2] = 0xa2, pll[3] = 0x1
<7> [167.140234] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [167.140304] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [167.140375] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[12] = 0x0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x1
<7> [167.140463] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] pll[16] = 0x85, pll[17] = 0xf, pll[18] = 0xe6, pll[19] = 0x23
<7> [167.140552] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [167.140641] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710)
<7> [167.140717] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710)
<7> [167.140795] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in port_clock (expected 0, found 432000)
<7> [167.140870] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:269:pipe B] fastset requirement not met, forcing full modeset
<7> [167.140979] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [167.141045] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:269:pipe B] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x2
<7> [167.141136] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:153:plane 1B] ddb ( 0 - 0) -> ( 0 - 4051), size 0 -> 4051
<7> [167.141199] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:263:cursor B] ddb ( 0 - 0) -> (4051 - 4096), size 0 -> 45
<7> [167.141260] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:153: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> [167.141319] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:153:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 13, 13, 13, 13, 13, 0, 0, 0, 4, 0
<7> [167.141385] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:153:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 92, 297, 297, 297, 297, 297, 0, 0, 197, 92, 197
<7> [167.141454] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:153:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 183, 456, 456, 456, 456, 456, 0, 0, 198, 183, 198
<7> [167.141538] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:269:pipe B] data rate 1390840 num active planes 1
<7> [167.141662] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400
<7> [167.141754] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400
<7> [167.141831] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [167.141907] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [167.141982] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461
<7> [167.142057] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:269:pipe B] min cdclk: 0 kHz -> 173855 kHz
<7> [167.142150] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [167.142232] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [167.142318] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [167.142508] xe 0000:00:02.0: [drm:intel_find_dpll [xe]] [CRTC:269:pipe B] allocated DPLL 0
<7> [167.142611] xe 0000:00:02.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:269:pipe B] reserving DPLL 0
<7> [167.142710] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:269:pipe B] enable: yes [modeset]
<7> [167.142800] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [167.142877] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: B, pipe bpp: 30, dithering: 0
<7> [167.142954] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [167.143030] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [167.143105] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [167.143179] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [167.143252] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 6329869, data_n: 8388608, link_m: 421991, link_n: 524288, tu: 64
<7> [167.143325] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [167.143419] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [167.143516] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [167.143611] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [167.143702] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [167.143775] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [167.143848] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14
<7> [167.143919] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB
<7> [167.143991] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB
<7> [167.144060] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0
<7> [167.144130] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range
<7> [167.144199] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined
<7> [167.144268] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [167.144338] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [167.144428] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1906, vmax: 1906, flipline: 1906, pipeline full: 0, guardband: 104 vsync start: 103, vsync end: 97
<7> [167.144520] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1802, vmax vblank: 1802, vmin vtotal: 1906, vmax vtotal: 1906
<7> [167.144610] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [167.144694] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] requested mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [167.144770] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [167.144845] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa
<7> [167.144920] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x40 0xa
<7> [167.144996] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa
<7> [167.145071] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710, min cdclk 173855
<7> [167.145142] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0
<7> [167.145211] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [167.145279] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [167.145347] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [167.145452] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: yes, tbt_mode: no
<7> [167.145546] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_hw_state: fracen: no,
<7> [167.145638] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] multiplier: 225, tx_clk_div: 1.
<7> [167.145718] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_rawhw_state:
<7> [167.145794] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] tx: 0x10, cmn: 0x21
<7> [167.145865] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[0] = 0x4, pll[1] = 0x0, pll[2] = 0xa2, pll[3] = 0x1
<7> [167.145936] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [167.146005] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [167.146073] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[12] = 0x0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x1
<7> [167.146141] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[16] = 0x85, pll[17] = 0xf, pll[18] = 0xe6, pll[19] = 0x23
<7> [167.146210] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [167.146279] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [167.146348] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [167.146445] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [167.146536] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [167.146624] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [167.146711] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [167.146799] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [167.146877] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [167.146944] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [167.147011] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [167.147079] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [167.147146] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [167.147213] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:153:plane 1B] fb: [FB:430] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [167.147282] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [167.147349] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [167.147450] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:183:plane 2B] fb: [NOFB], visible: no
<7> [167.147547] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:213:plane 3B] fb: [NOFB], visible: no
<7> [167.147647] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:243:plane 4B] fb: [NOFB], visible: no
<7> [167.147733] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:253:plane 5B] fb: [NOFB], visible: no
<7> [167.147812] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:263:cursor B] fb: [NOFB], visible: no
<7> [167.148179] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [167.148300] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_B
<7> [167.148445] xe 0000:00:02.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x2 (CLKGATE_DIS_DSSDSC=0xa2000000)
<7> [167.148548] 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> [167.148640] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [167.148726] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480
<7> [167.148805] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:391:DDI A/PHY A]
<7> [167.148869] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:400:DDI TC1/PHY TC1]
<7> [167.148932] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:402:DP-MST A]
<7> [167.148994] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:403:DP-MST B]
<7> [167.149054] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:404:DP-MST C]
<7> [167.149116] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:412:DDI TC2/PHY TC2]
<7> [167.149175] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:414:DP-MST A]
<7> [167.149236] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:415:DP-MST B]
<7> [167.149220] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [167.149297] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:416:DP-MST C]
<7> [167.149351] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - long
<7> [167.149365] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:420:DDI TC3/PHY TC3]
<7> [167.149446] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:422:DP-MST A]
<7> [167.149452] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [167.149527] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:423:DP-MST B]
<7> [167.149559] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [167.149607] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:424:DP-MST C]
<7> [167.149703] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [167.149865] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: *)
<7> [167.149926] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes)
<7> [167.150030] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A
<7> [167.151341] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enable DPLL 0 (active 0x2, on? 0) for [CRTC:269:pipe B]
<7> [167.151443] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enabling DPLL 0
<7> [167.153423] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turn panel power on
<7> [167.153507] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power cycle (465 ms remaining)
<7> [167.625730] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [167.656667] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [167.656996] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power on
<7> [167.657270] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [167.693591] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [167.693950] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - long
<7> [167.694269] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [167.694599] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [167.867801] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [167.868237] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turning VDD on
<7> [167.868698] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [167.870865] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX A/DDI A/PHY A: DPCD: 14 1e 44 c1 00 00 01 c0 02 00 02 00 00 0b 80
<7> [167.872530] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [167.873540] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05
<7> [167.874947] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [167.876494] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [167.877958] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Clock recovery OK
<7> [167.878684] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using DP training pattern TPS4
<7> [167.880533] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [167.881101] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4
<7> [167.882118] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe B
<7> [167.882805] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]]
<7> [167.883312] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe B
<7> [167.883888] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:392:eDP-1] set backlight PWM = 192000
<7> [167.899685] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2
<7> [167.901588] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:392:eDP-1]
<7> [167.902066] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:269:pipe B]
<7> [170.426491] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turning VDD off
<7> [170.426940] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [175.632476] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [175.633009] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [175.633480] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<6> [175.831534] [IGT] kms_flip: finished subtest B-eDP1, FAIL
<6> [175.833259] [IGT] kms_flip: starting dynamic subtest C-eDP1
<7> [175.835918] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:432]
<7> [175.850190] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:433]
<7> [175.925540] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:150:pipe A]
<7> [175.925764] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [175.926719] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [175.927021] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:269:pipe B]
<7> [175.927150] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.enable (expected yes, found no)
<7> [175.927398] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.active (expected yes, found no)
<7> [175.927581] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [175.927762] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in lane_count (expected 4, found 0)
<7> [175.927937] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in dp_m_n (expected tu 64 data 6329869/8388608 link 421991/524288, found tu 0, data 0/0 link 0/0)
<7> [175.928106] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [175.928271] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [175.928479] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [175.928631] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [175.928776] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [175.928918] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [175.929058] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [175.929196] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [175.929405] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [175.929561] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0)
<7> [175.929706] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [175.929830] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [175.929953] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0)
<7> [175.930072] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0)
<7> [175.930189] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [175.930312] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [175.930426] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [175.930537] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [175.930645] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [175.930753] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [175.930859] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [175.930976] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0)
<7> [175.931089] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [175.931191] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [175.931295] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0)
<7> [175.931416] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0)
<7> [175.931518] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [175.931619] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [175.931718] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [175.931817] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [175.931913] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0)
<7> [175.932007] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0)
<7> [175.932100] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in port_clock (expected 432000, found 0)
<7> [175.932193] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:269:pipe B] fastset requirement not met, forcing full modeset
<7> [175.932286] xe 0000:00:02.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:269:pipe B] releasing DPLL 0
<7> [175.932438] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [175.932525] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:269:pipe B] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x2 -> 0x0
<7> [175.932632] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:153:plane 1B] ddb ( 0 - 4051) -> ( 0 - 0), size 4051 -> 0
<7> [175.932699] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:263:cursor B] ddb (4051 - 4096) -> ( 0 - 0), size 45 -> 0
<7> [175.932764] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:153: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> [175.932830] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:153:plane 1B] lines 4, 13, 13, 13, 13, 13, 0, 0, 0, 4, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [175.932896] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:153:plane 1B] blocks 92, 297, 297, 297, 297, 297, 0, 0, 197, 92, 197 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [175.932961] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:153:plane 1B] min_ddb 183, 456, 456, 456, 456, 456, 0, 0, 198, 183, 198 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [175.933041] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:269:pipe B] data rate 0 num active planes 0
<7> [175.933138] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400
<7> [175.933232] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400
<7> [175.933341] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [175.933447] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [175.933546] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0
<7> [175.933644] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:269:pipe B] min cdclk: 173855 kHz -> 0 kHz
<7> [175.933763] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 21732 kHz -> 0 kHz
<7> [175.933846] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [175.933925] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz
<7> [175.934004] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [175.934106] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:269:pipe B] enable: no [modeset]
<7> [175.934186] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:153:plane 1B] fb: [NOFB], visible: no
<7> [175.934265] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:183:plane 2B] fb: [NOFB], visible: no
<7> [175.934363] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:213:plane 3B] fb: [NOFB], visible: no
<7> [175.934461] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:243:plane 4B] fb: [NOFB], visible: no
<7> [175.934558] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:253:plane 5B] fb: [NOFB], visible: no
<7> [175.934646] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:263:cursor B] fb: [NOFB], visible: no
<7> [175.934758] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2
<7> [175.934939] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turning VDD on
<7> [175.935048] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006f
<7> [175.935630] xe 0000:00:02.0: [drm:intel_alpm_disable [xe]] Disabling ALPM
<7> [175.935738] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]]
<7> [176.137507] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:392:eDP-1] set backlight PWM = 0
<7> [176.138221] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe B
<7> [176.159384] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turn panel power off
<7> [176.159716] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [176.159974] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [176.160474] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - short
<7> [176.160556] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [176.211611] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [176.211999] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disable DPLL 0 (active 0x2, on? 1) for [CRTC:269:pipe B]
<7> [176.212154] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [176.212598] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [176.213178] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - short
<7> [176.213512] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disabling DPLL 0
<7> [176.213793] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [176.213989] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A
<7> [176.214574] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:391:DDI A/PHY A]
<7> [176.214983] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:400:DDI TC1/PHY TC1]
<7> [176.215374] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:402:DP-MST A]
<7> [176.215816] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:403:DP-MST B]
<7> [176.216233] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:404:DP-MST C]
<7> [176.216633] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:412:DDI TC2/PHY TC2]
<7> [176.217014] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:414:DP-MST A]
<7> [176.217433] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:415:DP-MST B]
<7> [176.217763] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:416:DP-MST C]
<7> [176.218080] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:420:DDI TC3/PHY TC3]
<7> [176.218430] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:422:DP-MST A]
<7> [176.218743] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:423:DP-MST B]
<7> [176.219114] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:424:DP-MST C]
<7> [176.219503] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:392:eDP-1]
<7> [176.219904] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [176.220197] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [176.220526] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [176.221062] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_B
<7> [176.221484] xe 0000:00:02.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating disabled for pipe_mask=0x2 (CLKGATE_DIS_DSSDSC=0xaa000000)
<7> [176.221959] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [176.222446] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:269:pipe B]
<7> [176.222825] 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> [176.223266] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [176.223689] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384
<7> [176.224904] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:388:pipe C]
<7> [176.225284] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:388:pipe C]
<7> [176.225379] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:392:eDP-1]
<7> [176.225561] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:392:eDP-1] Limiting target display pipe bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [176.225934] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:391:DDI A/PHY A][CRTC:388:pipe C] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 min link_bpp 18.0000 max link_bpp 30.0000
<7> [176.226237] xe 0000:00:02.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 432000 bpp input 30 compressed 0.0000 HDR no link rate required 1303913 available 1728000
<7> [176.226561] xe 0000:00:02.0: [drm:intel_psr_compute_config [xe]] PSR2 not supported in transcoder C
<7> [176.226795] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:388:pipe C] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [176.227075] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:391:DDI A/PHY A] [CRTC:388:pipe C]
<7> [176.227366] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.enable (expected no, found yes)
<7> [176.227656] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.active (expected no, found yes)
<7> [176.227906] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in cpu_transcoder (expected -1, found 2)
<7> [176.228152] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in lane_count (expected 0, found 4)
<7> [176.228407] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6329869/8388608 link 421991/524288)
<7> [176.228686] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [176.228905] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [176.229115] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [176.229325] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [176.229545] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [176.229725] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [176.229901] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [176.230101] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [176.230286] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [176.230497] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800)
<7> [176.230657] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [176.230811] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [176.230966] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906)
<7> [176.231118] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906)
<7> [176.231267] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [176.231438] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [176.231594] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [176.231739] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [176.231865] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [176.231991] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [176.232118] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [176.232242] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800)
<7> [176.232389] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [176.232520] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [176.232636] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906)
<7> [176.232750] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906)
<7> [176.232860] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [176.232981] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [176.233109] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [176.233231] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [176.233349] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710)
<7> [176.233451] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710)
<7> [176.233549] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in port_clock (expected 0, found 432000)
<7> [176.233644] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:388:pipe C] fastset requirement not met, forcing full modeset
<7> [176.233763] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xd (total dbuf slices 0xf), mbus joined? no->no
<7> [176.233857] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:388:pipe C] dbuf slices 0x0 -> 0xc, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x4
<7> [176.233981] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:272:plane 1C] ddb ( 0 - 0) -> ( 0 - 2003), size 0 -> 2003
<7> [176.234074] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:382:cursor C] ddb ( 0 - 0) -> (2003 - 2048), size 0 -> 45
<7> [176.234152] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:272:plane 1C] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm
<7> [176.234227] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:272:plane 1C] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 13, 13, 13, 13, 13, 0, 0, 0, 4, 0
<7> [176.234305] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:272:plane 1C] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 92, 297, 297, 297, 297, 297, 0, 0, 197, 92, 197
<7> [176.234378] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:272:plane 1C] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 183, 456, 456, 456, 456, 456, 0, 0, 198, 183, 198
<7> [176.234465] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:388:pipe C] data rate 1390840 num active planes 1
<7> [176.234589] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400
<7> [176.234684] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400
<7> [176.234773] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [176.234859] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [176.234943] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461
<7> [176.235043] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:388:pipe C] min cdclk: 0 kHz -> 173855 kHz
<7> [176.235148] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 0 kHz -> 21732 kHz
<7> [176.235243] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [176.235355] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [176.235471] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [176.235588] xe 0000:00:02.0: [drm:intel_find_dpll [xe]] [CRTC:388:pipe C] allocated DPLL 0
<7> [176.235672] xe 0000:00:02.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:388:pipe C] reserving DPLL 0
<7> [176.235760] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:388:pipe C] enable: yes [modeset]
<7> [176.235853] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [176.235937] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: C, pipe bpp: 30, dithering: 0
<7> [176.236013] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [176.236088] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [176.236163] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [176.236240] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [176.236327] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 6329869, data_n: 8388608, link_m: 421991, link_n: 524288, tu: 64
<7> [176.236427] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [176.236524] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [176.236622] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [176.236709] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: disabled, panel replay: disabled, selective fetch: disabled
<7> [176.236788] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [176.236865] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [176.236936] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 2, length 8
<7> [176.237007] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB
<7> [176.237077] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB
<7> [176.237146] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0
<7> [176.237218] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range
<7> [176.237289] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined
<7> [176.237396] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [176.237490] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [176.237581] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1906, vmax: 1906, flipline: 1906, pipeline full: 0, guardband: 104 vsync start: 103, vsync end: 97
<7> [176.237660] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1802, vmax vblank: 1802, vmin vtotal: 1906, vmax vtotal: 1906
<7> [176.237735] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [176.237804] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] requested mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [176.237873] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [176.237943] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa
<7> [176.238015] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x40 0xa
<7> [176.238086] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa
<7> [176.238155] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710, min cdclk 173855
<7> [176.238227] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0
<7> [176.238310] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [176.238402] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [176.238493] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [176.238579] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: yes, tbt_mode: no
<7> [176.238657] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_hw_state: fracen: no,
<7> [176.238729] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] multiplier: 225, tx_clk_div: 1.
<7> [176.238800] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_rawhw_state:
<7> [176.238871] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] tx: 0x10, cmn: 0x21
<7> [176.238942] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[0] = 0x4, pll[1] = 0x0, pll[2] = 0xa2, pll[3] = 0x1
<7> [176.239013] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [176.239083] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [176.239152] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[12] = 0x0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x1
<7> [176.239220] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[16] = 0x85, pll[17] = 0xf, pll[18] = 0xe6, pll[19] = 0x23
<7> [176.239288] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [176.239439] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [176.239540] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [176.239628] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [176.239705] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [176.239781] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [176.239848] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [176.239916] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [176.239983] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [176.240051] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [176.240118] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [176.240185] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [176.240251] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [176.240330] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:272:plane 1C] fb: [FB:432] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [176.240426] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [176.240517] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [176.240608] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:302:plane 2C] fb: [NOFB], visible: no
<7> [176.240697] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:332:plane 3C] fb: [NOFB], visible: no
<7> [176.240774] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:362:plane 4C] fb: [NOFB], visible: no
<7> [176.240847] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:372:plane 5C] fb: [NOFB], visible: no
<7> [176.240920] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:382:cursor C] fb: [NOFB], visible: no
<7> [176.241276] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [176.241465] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_C
<7> [176.241639] xe 0000:00:02.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x4 (CLKGATE_DIS_DSSDSC=0x8a000000)
<7> [176.241748] 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> [176.241842] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [176.241929] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480
<7> [176.242011] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:391:DDI A/PHY A]
<7> [176.242078] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:400:DDI TC1/PHY TC1]
<7> [176.242143] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:402:DP-MST A]
<7> [176.242208] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:403:DP-MST B]
<7> [176.242272] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:404:DP-MST C]
<7> [176.242358] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:412:DDI TC2/PHY TC2]
<7> [176.242442] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:414:DP-MST A]
<7> [176.242525] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:415:DP-MST B]
<7> [176.242607] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:416:DP-MST C]
<7> [176.242686] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:420:DDI TC3/PHY TC3]
<7> [176.242761] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:422:DP-MST A]
<7> [176.242829] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:423:DP-MST B]
<7> [176.242894] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:424:DP-MST C]
<7> [176.242974] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xd
<7> [176.243136] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [176.243245] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A
<7> [176.244356] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enable DPLL 0 (active 0x4, on? 0) for [CRTC:388:pipe C]
<7> [176.244475] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enabling DPLL 0
<7> [176.246465] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turn panel power on
<7> [176.246550] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power cycle (466 ms remaining)
<7> [176.247661] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [176.247796] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - long
<7> [176.247891] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [176.248019] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [176.721529] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [176.732274] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [176.732943] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power on
<7> [176.733511] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [176.769510] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [176.769975] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - long
<7> [176.770417] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [176.771012] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [176.946821] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [176.947428] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turning VDD on
<7> [176.947889] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [176.950217] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX A/DDI A/PHY A: DPCD: 14 1e 44 c1 00 00 01 c0 02 00 02 00 00 0b 80
<7> [176.951852] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [176.952766] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05
<7> [176.954029] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [176.955629] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [176.956915] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Clock recovery OK
<7> [176.957419] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using DP training pattern TPS4
<7> [176.958985] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [176.959355] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4
<7> [176.960205] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe C
<7> [176.960735] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]]
<7> [176.961084] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe C
<7> [176.961517] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:392:eDP-1] set backlight PWM = 192000
<7> [176.963274] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] reserved 14745600 bytes of contiguous stolen space for FBC, limit: 2
<7> [176.963729] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] Enabling FBC on [PLANE:272:plane 1C]
<7> [176.977496] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR1
<7> [176.978961] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:392:eDP-1]
<7> [176.979432] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:388:pipe C]
<7> [179.513469] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turning VDD off
<7> [179.513919] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [187.009601] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:433] from all active usage due to RMFB ioctl
<7> [187.012499] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:432] from all active usage due to RMFB ioctl
<7> [187.012581] xe 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:272:plane 1C] because [FB:432] is removed
<7> [187.012679] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:272:plane 1C] ddb ( 0 - 2003) -> ( 0 - 0), size 2003 -> 0
<7> [187.013031] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:272:plane 1C] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [187.013382] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:272:plane 1C] lines 4, 13, 13, 13, 13, 13, 0, 0, 0, 4, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [187.013669] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:272:plane 1C] blocks 92, 297, 297, 297, 297, 297, 0, 0, 197, 92, 197 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [187.013999] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:272:plane 1C] min_ddb 183, 456, 456, 456, 456, 456, 0, 0, 198, 183, 198 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [187.014346] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:388:pipe C] data rate 0 num active planes 0
<7> [187.014746] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400
<7> [187.015131] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400
<7> [187.015565] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [187.015936] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [187.016410] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0
<7> [187.017450] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR1
<7> [187.017785] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turning VDD on
<7> [187.018107] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006f
<7> [187.026008] xe 0000:00:02.0: [drm:__intel_fbc_disable [xe]] Disabling FBC on [PLANE:272:plane 1C]
<6> [187.043121] [IGT] kms_flip: finished subtest C-eDP1, SUCCESS
<6> [187.044116] [IGT] kms_flip: finished subtest flip-vs-expired-vblank, FAIL
<7> [187.053011] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:392:eDP-1] Limiting target display pipe bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [187.053155] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:391:DDI A/PHY A][CRTC:150:pipe A] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 min link_bpp 18.0000 max link_bpp 30.0000
<7> [187.053288] xe 0000:00:02.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 432000 bpp input 30 compressed 0.0000 HDR no link rate required 1303913 available 1728000
<7> [187.053407] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:150:pipe A] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [187.053526] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:391:DDI A/PHY A] [CRTC:150:pipe A]
<7> [187.053648] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [187.053768] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [187.053876] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [187.053973] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [187.054067] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6329869/8388608 link 421991/524288)
<7> [187.054163] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [187.054263] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [187.054352] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [187.054440] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [187.054525] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [187.054609] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [187.054691] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [187.054774] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [187.054854] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [187.054935] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800)
<7> [187.055012] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [187.055089] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [187.055166] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906)
<7> [187.055302] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906)
<7> [187.055387] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [187.055469] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [187.055544] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [187.055618] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [187.055691] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [187.055764] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [187.055836] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [187.055907] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800)
<7> [187.055977] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [187.056048] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [187.056118] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906)
<7> [187.056188] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906)
<7> [187.056264] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [187.056336] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [187.056423] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [187.056493] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [187.056562] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710)
<7> [187.056631] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710)
<7> [187.056699] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in port_clock (expected 0, found 432000)
<7> [187.056768] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:150:pipe A] fastset requirement not met, forcing full modeset
<7> [187.056837] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.enable (expected yes, found no)
<7> [187.056906] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.active (expected yes, found no)
<7> [187.056974] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in cpu_transcoder (expected 2, found -1)
<7> [187.057042] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in lane_count (expected 4, found 0)
<7> [187.057111] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in dp_m_n (expected tu 64 data 6329869/8388608 link 421991/524288, found tu 0, data 0/0 link 0/0)
<7> [187.057182] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [187.057257] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [187.057328] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [187.057403] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [187.057475] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [187.057547] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [187.057617] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [187.057686] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [187.057755] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [187.057824] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0)
<7> [187.057892] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [187.057963] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [187.058031] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0)
<7> [187.058100] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0)
<7> [187.058167] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [187.058235] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [187.058318] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [187.058392] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [187.058459] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [187.058527] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [187.058594] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [187.058661] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0)
<7> [187.058728] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [187.058795] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [187.058861] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0)
<7> [187.058928] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0)
<7> [187.058994] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [187.059062] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [187.059132] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [187.059202] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [187.059283] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0)
<7> [187.059357] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0)
<7> [187.059429] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:388:pipe C] fastset requirement not met in port_clock (expected 432000, found 0)
<7> [187.059498] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:388:pipe C] fastset requirement not met, forcing full modeset
<7> [187.059569] xe 0000:00:02.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:388:pipe C] releasing DPLL 0
<7> [187.059702] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xd -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [187.059769] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:150:pipe A] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x4 -> 0x1
<7> [187.059835] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:388:pipe C] dbuf slices 0xc -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x4 -> 0x1
<7> [187.059901] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:34:plane 1A] ddb ( 0 - 0) -> ( 0 - 4051), size 0 -> 4051
<7> [187.059963] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:144:cursor A] ddb ( 0 - 0) -> (4051 - 4096), size 0 -> 45
<7> [187.060018] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34: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> [187.060071] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 13, 13, 13, 13, 13, 0, 0, 0, 3, 0
<7> [187.060126] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 24, 313, 313, 313, 313, 313, 0, 0, 38, 73, 87
<7> [187.060179] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 28, 346, 346, 346, 346, 346, 0, 0, 39, 82, 88
<7> [187.060232] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:382:cursor C] ddb (2003 - 2048) -> ( 0 - 0), size 45 -> 0
<7> [187.060328] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:150:pipe A] data rate 1390840 num active planes 1
<7> [187.060429] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400
<7> [187.060520] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400
<7> [187.060602] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [187.060680] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [187.060757] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461
<7> [187.060834] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:150:pipe A] min cdclk: 0 kHz -> 173855 kHz
<7> [187.060911] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:388:pipe C] min cdclk: 173855 kHz -> 0 kHz
<7> [187.061026] xe 0000:00:02.0: [drm:intel_find_dpll [xe]] [CRTC:150:pipe A] allocated DPLL 0
<7> [187.061110] xe 0000:00:02.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:150:pipe A] reserving DPLL 0
<7> [187.061201] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:150:pipe A] enable: yes [modeset]
<7> [187.061302] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [187.061394] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 30, dithering: 0
<7> [187.061471] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [187.061548] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [187.061624] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [187.061700] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [187.061774] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 6329869, data_n: 8388608, link_m: 421991, link_n: 524288, tu: 64
<7> [187.061847] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [187.061921] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [187.061993] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [187.062065] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [187.062137] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [187.062210] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [187.062293] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14
<7> [187.062375] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB
<7> [187.062449] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB
<7> [187.062520] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0
<7> [187.062590] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range
<7> [187.062660] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined
<7> [187.062746] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [187.062815] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [187.062885] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1906, vmax: 1906, flipline: 1906, pipeline full: 0, guardband: 104 vsync start: 103, vsync end: 97
<7> [187.062955] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1802, vmax vblank: 1802, vmin vtotal: 1906, vmax vtotal: 1906
<7> [187.063024] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [187.063094] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] requested mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [187.063164] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa
<7> [187.063233] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa
<7> [187.063319] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "2880x1800": 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x40 0xa
<7> [187.063394] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=347710, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1800-1906 vs=1803-1809 vt=1906, flags=0xa
<7> [187.063469] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 432000, pipe src: 2880x1800+0+0, pixel rate 347710, min cdclk 173855
<7> [187.063549] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0
<7> [187.063628] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [187.063697] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [187.063767] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [187.063838] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: yes, tbt_mode: no
<7> [187.063910] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_hw_state: fracen: no,
<7> [187.063981] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] multiplier: 225, tx_clk_div: 1.
<7> [187.064052] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] c10pll_rawhw_state:
<7> [187.064123] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] tx: 0x10, cmn: 0x21
<7> [187.064192] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[0] = 0x4, pll[1] = 0x0, pll[2] = 0xa2, pll[3] = 0x1
<7> [187.064268] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [187.064345] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [187.064423] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[12] = 0x0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x1
<7> [187.064492] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pll[16] = 0x85, pll[17] = 0xf, pll[18] = 0xe6, pll[19] = 0x23
<7> [187.064562] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [187.064630] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [187.064699] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [187.064767] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [187.064835] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [187.064903] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [187.064971] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [187.065039] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [187.065107] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [187.065175] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [187.065246] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [187.065314] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [187.065397] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [187.065465] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:34:plane 1A] fb: [FB:393] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [187.065537] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [187.065607] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [187.065678] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [187.065748] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [187.065817] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [187.065886] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [187.065955] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:144:cursor A] fb: [NOFB], visible: no
<7> [187.066024] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:388:pipe C] enable: no [modeset]
<7> [187.066093] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:272:plane 1C] fb: [NOFB], visible: no
<7> [187.066162] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:302:plane 2C] fb: [NOFB], visible: no
<7> [187.066230] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:332:plane 3C] fb: [NOFB], visible: no
<7> [187.066422] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:362:plane 4C] fb: [NOFB], visible: no
<7> [187.066504] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:372:plane 5C] fb: [NOFB], visible: no
<7> [187.066585] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:382:cursor C] fb: [NOFB], visible: no
<7> [187.066715] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_A
<7> [187.066949] xe 0000:00:02.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x1 (CLKGATE_DIS_DSSDSC=0x88000000)
<7> [187.067212] xe 0000:00:02.0: [drm:intel_alpm_disable [xe]] Disabling ALPM
<7> [187.067325] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]]
<7> [187.273470] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:392:eDP-1] set backlight PWM = 0
<7> [187.274143] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe C
<7> [187.276698] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turn panel power off
<7> [187.277094] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [187.277204] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [187.277690] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - short
<7> [187.277805] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [187.329028] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [187.329443] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disable DPLL 0 (active 0x4, on? 1) for [CRTC:388:pipe C]
<7> [187.329600] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [187.329861] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [187.330249] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - short
<7> [187.330758] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [187.330850] xe 0000:00:02.0: [drm:intel_dpll_disable [xe]] disabling DPLL 0
<7> [187.331277] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A
<7> [187.332684] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:391:DDI A/PHY A]
<7> [187.333027] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:400:DDI TC1/PHY TC1]
<7> [187.333372] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:402:DP-MST A]
<7> [187.333660] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:403:DP-MST B]
<7> [187.333933] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:404:DP-MST C]
<7> [187.334216] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:412:DDI TC2/PHY TC2]
<7> [187.334568] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:414:DP-MST A]
<7> [187.334890] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:415:DP-MST B]
<7> [187.335171] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:416:DP-MST C]
<7> [187.335480] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:420:DDI TC3/PHY TC3]
<7> [187.335759] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:422:DP-MST A]
<7> [187.336018] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:423:DP-MST B]
<7> [187.336314] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:424:DP-MST C]
<7> [187.336677] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [187.337149] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: *)
<7> [187.337483] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes)
<7> [187.337804] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A
<7> [187.339408] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:150:pipe A]
<7> [187.339904] xe 0000:00:02.0: [drm:intel_dpll_enable [xe]] enabling DPLL 0
<7> [187.342471] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turn panel power on
<7> [187.342824] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power cycle (487 ms remaining)
<7> [187.364829] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [187.365245] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - long
<7> [187.365629] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [187.366272] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [187.833467] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [187.945495] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [187.945899] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 wait for panel power on
<7> [187.946290] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [187.982496] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [187.982957] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:391:DDI A/PHY A] - long
<7> [187.983395] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [187.984075] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:391:DDI A/PHY A]
<7> [188.153452] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [188.153884] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 turning VDD on
<7> [188.154289] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:391:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [188.156539] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX A/DDI A/PHY A: DPCD: 14 1e 44 c1 00 00 01 c0 02 00 02 00 00 0b 80
<7> [188.158130] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [188.159158] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05
<7> [188.160638] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [188.162190] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [188.163641] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Clock recovery OK
<7> [188.164145] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Using DP training pattern TPS4
<7> [188.165908] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [188.166326] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:392:eDP-1][ENCODER:391:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4
<7> [188.167138] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe A
<7> [188.167673] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]]
<7> [188.168051] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe A
<7> [188.168489] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:392:eDP-1] set backlight PWM = 192000
<7> [188.184703] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2
<7> [188.186550] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:392:eDP-1]
<7> [188.187032] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:150:pipe A]
<7> [188.190155] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_C
<7> [188.190661] xe 0000:00:02.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating disabled for pipe_mask=0x4 (CLKGATE_DIS_DSSDSC=0xa8000000)
<7> [188.191210] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [188.191778] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:388:pipe C]
<7> [188.192347] xe 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0
<6> [188.194074] [IGT] kms_flip: exiting, ret=98
<6> [188.201553] Console: switching to colour frame buffer device 180x56
|