Results for igt@kms_flip@flip-vs-expired-vblank

Result: Fail

i915_display_info1 igt_runner1 results1.json results1-xe-load.json i915_display_info_post_exec1 boot1 dmesg1

DetailValue
Duration 30.46 seconds
Hostname
shard-lnl-3
Igt-Version
IGT-Version: 2.2-gb542242f5 (x86_64) (Linux: 6.18.0-rc4-lgci-xe-xe-4071-3cabae5a2677e3629+ x86_64)
Out
Using IGT_SRANDOM=1762618050 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.140s)
Starting dynamic subtest: B-eDP1
  2880x1800: 60 347710 2880 2928 2960 3040 1800 1803 1809 1906 0x48 0xa 
Dynamic subtest B-eDP1: SUCCESS (11.262s)
Starting dynamic subtest: C-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:923 run_test_on_crtc_set.constprop.0()
  #2 ../tests/kms_flip.c:1889 run_test()
  #3 ../tests/kms_flip.c:2122 __igt_unique____real_main2045()
  #4 ../tests/kms_flip.c:2045 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest C-eDP1: FAIL (8.051s)
Subtest flip-vs-expired-vblank: FAIL (30.464s)
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../lib/igt_kms.c:2267 kmstest_set_connector_dpms()
  #2 ../lib/igt_core.c:2961 igt_atexit_handler()
  #3 [erand48_r+0x1d6]
  #4 [exit+0x1e]
  #5 ../lib/igt_core.c:2416 igt_exit()
  #6 [main+0x3f]
  #7 [__libc_init_first+0x8a]
  #8 [__libc_start_main+0x8b]
  #9 [_start+0x25]
Err
Starting subtest: flip-vs-expired-vblank
Starting dynamic subtest: A-eDP1
Dynamic subtest A-eDP1: SUCCESS (11.140s)
Starting dynamic subtest: B-eDP1
Dynamic subtest B-eDP1: SUCCESS (11.262s)
Starting dynamic subtest: C-eDP1
(kms_flip:6824) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:928:
(kms_flip:6824) CRITICAL: Failed assertion: end - start < 500
Dynamic subtest C-eDP1 failed.
**** DEBUG ****
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.032196
last_received_ts = 406.031616
last_seq = 648
current_ts = 406.048859
current_received_ts = 406.048279
current_seq = 649
count = 279
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 86us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.048859
last_received_ts = 406.048279
last_seq = 649
current_ts = 406.065552
current_received_ts = 406.065002
current_seq = 650
count = 280
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 77us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.065552
last_received_ts = 406.065002
last_seq = 650
current_ts = 406.082214
current_received_ts = 406.081635
current_seq = 651
count = 281
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 83us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.082214
last_received_ts = 406.081635
last_seq = 651
current_ts = 406.098907
current_received_ts = 406.098358
current_seq = 652
count = 282
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 138us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.098907
last_received_ts = 406.098358
last_seq = 652
current_ts = 406.115570
current_received_ts = 406.115051
current_seq = 653
count = 283
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 72us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.115570
last_received_ts = 406.115051
last_seq = 653
current_ts = 406.132263
current_received_ts = 406.131744
current_seq = 654
count = 284
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 103us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.132263
last_received_ts = 406.131744
last_seq = 654
current_ts = 406.148926
current_received_ts = 406.148407
current_seq = 655
count = 285
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 135us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.148926
last_received_ts = 406.148407
last_seq = 655
current_ts = 406.165619
current_received_ts = 406.165100
current_seq = 656
count = 286
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 52us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.165619
last_received_ts = 406.165100
last_seq = 656
current_ts = 406.182281
current_received_ts = 406.181732
current_seq = 657
count = 287
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 80us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.182281
last_received_ts = 406.181732
last_seq = 657
current_ts = 406.198975
current_received_ts = 406.198334
current_seq = 658
count = 288
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 73us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.198975
last_received_ts = 406.198334
last_seq = 658
current_ts = 406.215637
current_received_ts = 406.215057
current_seq = 659
count = 289
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 71us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.215637
last_received_ts = 406.215057
last_seq = 659
current_ts = 406.232300
current_received_ts = 406.231750
current_seq = 660
count = 290
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 73us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.232300
last_received_ts = 406.231750
last_seq = 660
current_ts = 406.248993
current_received_ts = 406.248413
current_seq = 661
count = 291
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 81us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.248993
last_received_ts = 406.248413
last_seq = 661
current_ts = 406.265656
current_received_ts = 406.265076
current_seq = 662
count = 292
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 74us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.265656
last_received_ts = 406.265076
last_seq = 662
current_ts = 406.282349
current_received_ts = 406.281769
current_seq = 663
count = 293
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 81us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.282349
last_received_ts = 406.281769
last_seq = 663
current_ts = 406.299011
current_received_ts = 406.298401
current_seq = 664
count = 294
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 74us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.299011
last_received_ts = 406.298401
last_seq = 664
current_ts = 406.315704
current_received_ts = 406.315125
current_seq = 665
count = 295
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 73us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.315704
last_received_ts = 406.315125
last_seq = 665
current_ts = 406.332367
current_received_ts = 406.331818
current_seq = 666
count = 296
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 79us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.332367
last_received_ts = 406.331818
last_seq = 666
current_ts = 406.349060
current_received_ts = 406.348480
current_seq = 667
count = 297
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 73us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.349060
last_received_ts = 406.348480
last_seq = 667
current_ts = 406.365723
current_received_ts = 406.365173
current_seq = 668
count = 298
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 72us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.365723
last_received_ts = 406.365173
last_seq = 668
current_ts = 406.382385
current_received_ts = 406.381836
current_seq = 669
count = 299
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 73us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.382385
last_received_ts = 406.381836
last_seq = 669
current_ts = 406.399078
current_received_ts = 406.398438
current_seq = 670
count = 300
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 80us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.399078
last_received_ts = 406.398438
last_seq = 670
current_ts = 406.415741
current_received_ts = 406.415161
current_seq = 671
count = 301
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 73us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.415741
last_received_ts = 406.415161
last_seq = 671
current_ts = 406.432434
current_received_ts = 406.431854
current_seq = 672
count = 302
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 73us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.432434
last_received_ts = 406.431854
last_seq = 672
current_ts = 406.449097
current_received_ts = 406.448547
current_seq = 673
count = 303
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 81us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.449097
last_received_ts = 406.448547
last_seq = 673
current_ts = 406.465790
current_received_ts = 406.465179
current_seq = 674
count = 304
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 73us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.465790
last_received_ts = 406.465179
last_seq = 674
current_ts = 406.482452
current_received_ts = 406.481903
current_seq = 675
count = 305
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 72us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.482452
last_received_ts = 406.481903
last_seq = 675
current_ts = 406.499146
current_received_ts = 406.498596
current_seq = 676
count = 306
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 51us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.499146
last_received_ts = 406.498596
last_seq = 676
current_ts = 406.515808
current_received_ts = 406.515167
current_seq = 677
count = 307
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 83us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.515808
last_received_ts = 406.515167
last_seq = 677
current_ts = 406.532501
current_received_ts = 406.531921
current_seq = 678
count = 308
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 97us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.532501
last_received_ts = 406.531921
last_seq = 678
current_ts = 406.549164
current_received_ts = 406.548584
current_seq = 679
count = 309
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 50us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.549164
last_received_ts = 406.548584
last_seq = 679
current_ts = 406.565826
current_received_ts = 406.565155
current_seq = 680
count = 310
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 80us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.565826
last_received_ts = 406.565155
last_seq = 680
current_ts = 406.582520
current_received_ts = 406.581940
current_seq = 681
count = 311
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 113us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.582520
last_received_ts = 406.581940
last_seq = 681
current_ts = 406.599182
current_received_ts = 406.598633
current_seq = 682
count = 312
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 81us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.599182
last_received_ts = 406.598633
last_seq = 682
current_ts = 406.615875
current_received_ts = 406.615265
current_seq = 683
count = 313
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 134us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.615875
last_received_ts = 406.615265
last_seq = 683
current_ts = 406.632538
current_received_ts = 406.631989
current_seq = 684
count = 314
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 71us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.632538
last_received_ts = 406.631989
last_seq = 684
current_ts = 406.649231
current_received_ts = 406.648651
current_seq = 685
count = 315
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 54us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.649231
last_received_ts = 406.648651
last_seq = 685
current_ts = 406.665894
current_received_ts = 406.665314
current_seq = 686
count = 316
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 74us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.665894
last_received_ts = 406.665314
last_seq = 686
current_ts = 406.682587
current_received_ts = 406.682068
current_seq = 687
count = 317
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 74us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.682587
last_received_ts = 406.682068
last_seq = 687
current_ts = 406.699249
current_received_ts = 406.698730
current_seq = 688
count = 318
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 72us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.699249
last_received_ts = 406.698730
last_seq = 688
current_ts = 406.715942
current_received_ts = 406.715332
current_seq = 689
count = 319
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 75us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.715942
last_received_ts = 406.715332
last_seq = 689
current_ts = 406.732605
current_received_ts = 406.732086
current_seq = 690
count = 320
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 73us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.732605
last_received_ts = 406.732086
last_seq = 690
current_ts = 406.749298
current_received_ts = 406.748749
current_seq = 691
count = 321
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 55us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.749298
last_received_ts = 406.748749
last_seq = 691
current_ts = 406.765961
current_received_ts = 406.765350
current_seq = 692
count = 322
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 72us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.765961
last_received_ts = 406.765350
last_seq = 692
current_ts = 406.782623
current_received_ts = 406.782074
current_seq = 693
count = 323
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 73us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.782623
last_received_ts = 406.782074
last_seq = 693
current_ts = 406.799316
current_received_ts = 406.798737
current_seq = 694
count = 324
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 81us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.799316
last_received_ts = 406.798737
last_seq = 694
current_ts = 406.816010
current_received_ts = 406.815460
current_seq = 695
count = 325
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 126us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.816010
last_received_ts = 406.815460
last_seq = 695
current_ts = 406.832672
current_received_ts = 406.832123
current_seq = 696
count = 326
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 81us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.832672
last_received_ts = 406.832123
last_seq = 696
current_ts = 406.849335
current_received_ts = 406.848785
current_seq = 697
count = 327
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 80us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.849335
last_received_ts = 406.848785
last_seq = 697
current_ts = 406.866028
current_received_ts = 406.865417
current_seq = 698
count = 328
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 54us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.866028
last_received_ts = 406.865417
last_seq = 698
current_ts = 406.882690
current_received_ts = 406.882111
current_seq = 699
count = 329
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 75us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.882690
last_received_ts = 406.882111
last_seq = 699
current_ts = 406.899384
current_received_ts = 406.898804
current_seq = 700
count = 330
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 72us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.899384
last_received_ts = 406.898804
last_seq = 700
current_ts = 406.916046
current_received_ts = 406.915436
current_seq = 701
count = 331
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 80us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.916046
last_received_ts = 406.915436
last_seq = 701
current_ts = 406.932709
current_received_ts = 406.932159
current_seq = 702
count = 332
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 85us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.932709
last_received_ts = 406.932159
last_seq = 702
current_ts = 406.949402
current_received_ts = 406.948853
current_seq = 703
count = 333
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 74us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.949402
last_received_ts = 406.948853
last_seq = 703
current_ts = 406.966064
current_received_ts = 406.965546
current_seq = 704
count = 334
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 89us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.966064
last_received_ts = 406.965546
last_seq = 704
current_ts = 406.982758
current_received_ts = 406.982178
current_seq = 705
count = 335
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 80us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.982758
last_received_ts = 406.982178
last_seq = 705
current_ts = 406.999420
current_received_ts = 406.998871
current_seq = 706
count = 336
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 81us
(kms_flip:6824) DEBUG: name = flip
last_ts = 406.999420
last_received_ts = 406.998871
last_seq = 706
current_ts = 407.016113
current_received_ts = 407.015503
current_seq = 707
count = 337
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 73us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.016113
last_received_ts = 407.015503
last_seq = 707
current_ts = 407.032776
current_received_ts = 407.032227
current_seq = 708
count = 338
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 81us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.032776
last_received_ts = 407.032227
last_seq = 708
current_ts = 407.049469
current_received_ts = 407.048889
current_seq = 709
count = 339
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 80us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.049469
last_received_ts = 407.048889
last_seq = 709
current_ts = 407.066132
current_received_ts = 407.065582
current_seq = 710
count = 340
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 81us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.066132
last_received_ts = 407.065582
last_seq = 710
current_ts = 407.082794
current_received_ts = 407.082153
current_seq = 711
count = 341
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 72us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.082794
last_received_ts = 407.082153
last_seq = 711
current_ts = 407.099487
current_received_ts = 407.098938
current_seq = 712
count = 342
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 92us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.099487
last_received_ts = 407.098938
last_seq = 712
current_ts = 407.116150
current_received_ts = 407.115601
current_seq = 713
count = 343
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 73us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.116150
last_received_ts = 407.115601
last_seq = 713
current_ts = 407.132843
current_received_ts = 407.132263
current_seq = 714
count = 344
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 89us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.132843
last_received_ts = 407.132263
last_seq = 714
current_ts = 407.149506
current_received_ts = 407.148956
current_seq = 715
count = 345
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 108us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.149506
last_received_ts = 407.148956
last_seq = 715
current_ts = 407.166199
current_received_ts = 407.165558
current_seq = 716
count = 346
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 73us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.166199
last_received_ts = 407.165558
last_seq = 716
current_ts = 407.182861
current_received_ts = 407.182190
current_seq = 717
count = 347
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 80us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.182861
last_received_ts = 407.182190
last_seq = 717
current_ts = 407.199554
current_received_ts = 407.199036
current_seq = 718
count = 348
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 84us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.199554
last_received_ts = 407.199036
last_seq = 718
current_ts = 407.216217
current_received_ts = 407.215668
current_seq = 719
count = 349
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 79us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.216217
last_received_ts = 407.215668
last_seq = 719
current_ts = 407.232880
current_received_ts = 407.232269
current_seq = 720
count = 350
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 72us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.232880
last_received_ts = 407.232269
last_seq = 720
current_ts = 407.249573
current_received_ts = 407.249023
current_seq = 721
count = 351
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 80us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.249573
last_received_ts = 407.249023
last_seq = 721
current_ts = 407.266235
current_received_ts = 407.265686
current_seq = 722
count = 352
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 73us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.266235
last_received_ts = 407.265686
last_seq = 722
current_ts = 407.282928
current_received_ts = 407.282318
current_seq = 723
count = 353
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 72us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.282928
last_received_ts = 407.282318
last_seq = 723
current_ts = 407.299591
current_received_ts = 407.299072
current_seq = 724
count = 354
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 84us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.299591
last_received_ts = 407.299072
last_seq = 724
current_ts = 407.316254
current_received_ts = 407.315704
current_seq = 725
count = 355
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 73us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.316254
last_received_ts = 407.315704
last_seq = 725
current_ts = 407.332947
current_received_ts = 407.332397
current_seq = 726
count = 356
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 133us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.332947
last_received_ts = 407.332397
last_seq = 726
current_ts = 407.349609
current_received_ts = 407.349091
current_seq = 727
count = 357
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 52us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.349609
last_received_ts = 407.349091
last_seq = 727
current_ts = 407.366302
current_received_ts = 407.365753
current_seq = 728
count = 358
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 75us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.366302
last_received_ts = 407.365753
last_seq = 728
current_ts = 407.382965
current_received_ts = 407.382355
current_seq = 729
count = 359
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 81us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.382965
last_received_ts = 407.382355
last_seq = 729
current_ts = 407.399658
current_received_ts = 407.399109
current_seq = 730
count = 360
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 73us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.399658
last_received_ts = 407.399109
last_seq = 730
current_ts = 407.416321
current_received_ts = 407.415771
current_seq = 731
count = 361
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 84us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.416321
last_received_ts = 407.415771
last_seq = 731
current_ts = 407.433014
current_received_ts = 407.432404
current_seq = 732
count = 362
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 54us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.433014
last_received_ts = 407.432404
last_seq = 732
current_ts = 407.449677
current_received_ts = 407.449127
current_seq = 733
count = 363
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 81us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.449677
last_received_ts = 407.449127
last_seq = 733
current_ts = 407.466339
current_received_ts = 407.465820
current_seq = 734
count = 364
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 86us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.466339
last_received_ts = 407.465820
last_seq = 734
current_ts = 407.483032
current_received_ts = 407.482483
current_seq = 735
count = 365
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 135us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.483032
last_received_ts = 407.482483
last_seq = 735
current_ts = 407.499695
current_received_ts = 407.499146
current_seq = 736
count = 366
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 72us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.499695
last_received_ts = 407.499146
last_seq = 736
current_ts = 407.516388
current_received_ts = 407.515808
current_seq = 737
count = 367
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 80us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.516388
last_received_ts = 407.515808
last_seq = 737
current_ts = 407.533051
current_received_ts = 407.532440
current_seq = 738
count = 368
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 81us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.533051
last_received_ts = 407.532440
last_seq = 738
current_ts = 407.549744
current_received_ts = 407.549164
current_seq = 739
count = 369
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 73us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.549744
last_received_ts = 407.549164
last_seq = 739
current_ts = 407.566406
current_received_ts = 407.565857
current_seq = 740
count = 370
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 79us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.566406
last_received_ts = 407.565857
last_seq = 740
current_ts = 407.583099
current_received_ts = 407.582550
current_seq = 741
count = 371
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 81us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.583099
last_received_ts = 407.582550
last_seq = 741
current_ts = 407.599762
current_received_ts = 407.599182
current_seq = 742
count = 372
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 73us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.599762
last_received_ts = 407.599182
last_seq = 742
current_ts = 407.616455
current_received_ts = 407.615875
current_seq = 743
count = 373
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 72us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.616455
last_received_ts = 407.615875
last_seq = 743
current_ts = 407.633118
current_received_ts = 407.632568
current_seq = 744
count = 374
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 73us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.633118
last_received_ts = 407.632568
last_seq = 744
current_ts = 407.649811
current_received_ts = 407.649170
current_seq = 745
count = 375
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 51us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.649811
last_received_ts = 407.649170
last_seq = 745
current_ts = 407.666473
current_received_ts = 407.665894
current_seq = 746
count = 376
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 80us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.666473
last_received_ts = 407.665894
last_seq = 746
current_ts = 407.683136
current_received_ts = 407.682556
current_seq = 747
count = 377
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 75us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.683136
last_received_ts = 407.682556
last_seq = 747
current_ts = 407.699829
current_received_ts = 407.699158
current_seq = 748
count = 378
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 72us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.699829
last_received_ts = 407.699158
last_seq = 748
current_ts = 407.716492
current_received_ts = 407.715942
current_seq = 749
count = 379
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 113us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.716492
last_received_ts = 407.715942
last_seq = 749
current_ts = 407.733185
current_received_ts = 407.732605
current_seq = 750
count = 380
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 81us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.733185
last_received_ts = 407.732605
last_seq = 750
current_ts = 407.749847
current_received_ts = 407.749207
current_seq = 751
count = 381
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 81us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.749847
last_received_ts = 407.749207
last_seq = 751
current_ts = 407.766510
current_received_ts = 407.765961
current_seq = 752
count = 382
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 103us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.766510
last_received_ts = 407.765961
last_seq = 752
current_ts = 407.783203
current_received_ts = 407.782623
current_seq = 753
count = 383
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 76us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.783203
last_received_ts = 407.782623
last_seq = 753
current_ts = 407.799866
current_received_ts = 407.799194
current_seq = 754
count = 384
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 80us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.799866
last_received_ts = 407.799194
last_seq = 754
current_ts = 407.816559
current_received_ts = 407.815979
current_seq = 755
count = 385
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 51us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.816559
last_received_ts = 407.815979
last_seq = 755
current_ts = 407.833221
current_received_ts = 407.832672
current_seq = 756
count = 386
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 84us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.833221
last_received_ts = 407.832672
last_seq = 756
current_ts = 407.849915
current_received_ts = 407.849304
current_seq = 757
count = 387
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 81us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.849915
last_received_ts = 407.849304
last_seq = 757
current_ts = 407.866577
current_received_ts = 407.866058
current_seq = 758
count = 388
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 78us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.866577
last_received_ts = 407.866058
last_seq = 758
current_ts = 407.883240
current_received_ts = 407.882721
current_seq = 759
count = 389
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 75us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.883240
last_received_ts = 407.882721
last_seq = 759
current_ts = 407.899933
current_received_ts = 407.899323
current_seq = 760
count = 390
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 81us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.899933
last_received_ts = 407.899323
last_seq = 760
current_ts = 407.916595
current_received_ts = 407.916077
current_seq = 761
count = 391
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 82us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.916595
last_received_ts = 407.916077
last_seq = 761
current_ts = 407.933289
current_received_ts = 407.932739
current_seq = 762
count = 392
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 81us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.933289
last_received_ts = 407.932739
last_seq = 762
current_ts = 407.949951
current_received_ts = 407.949402
current_seq = 763
count = 393
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 74us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.949951
last_received_ts = 407.949402
last_seq = 763
current_ts = 407.966644
current_received_ts = 407.966095
current_seq = 764
count = 394
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 79us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.966644
last_received_ts = 407.966095
last_seq = 764
current_ts = 407.983307
current_received_ts = 407.982758
current_seq = 765
count = 395
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 82us
(kms_flip:6824) DEBUG: name = flip
last_ts = 407.983307
last_received_ts = 407.982758
last_seq = 765
current_ts = 408.000000
current_received_ts = 407.999420
current_seq = 766
count = 396
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 137us
(kms_flip:6824) DEBUG: name = flip
last_ts = 408.000000
last_received_ts = 407.999420
last_seq = 766
current_ts = 408.016663
current_received_ts = 408.016113
current_seq = 767
count = 397
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 86us
(kms_flip:6824) DEBUG: name = flip
last_ts = 408.016663
last_received_ts = 408.016113
last_seq = 767
current_ts = 408.033325
current_received_ts = 408.032776
current_seq = 768
count = 398
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 54us
(kms_flip:6824) DEBUG: name = flip
last_ts = 408.033325
last_received_ts = 408.032776
last_seq = 768
current_ts = 408.050018
current_received_ts = 408.049316
current_seq = 769
count = 399
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 73us
(kms_flip:6824) DEBUG: name = flip
last_ts = 408.050018
last_received_ts = 408.049316
last_seq = 769
current_ts = 408.066681
current_received_ts = 408.066132
current_seq = 770
count = 400
seq_step = 1
(kms_flip:6824) DEBUG: Vblank took 1364us
(kms_flip:6824) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:928:
(kms_flip:6824) CRITICAL: Failed assertion: end - start < 500
(kms_flip:6824) igt_core-INFO: Stack trace:
(kms_flip:6824) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(kms_flip:6824) igt_core-INFO:   #1 ../tests/kms_flip.c:923 run_test_on_crtc_set.constprop.0()
(kms_flip:6824) igt_core-INFO:   #2 ../tests/kms_flip.c:1889 run_test()
(kms_flip:6824) igt_core-INFO:   #3 ../tests/kms_flip.c:2122 __igt_unique____real_main2045()
(kms_flip:6824) igt_core-INFO:   #4 ../tests/kms_flip.c:2045 main()
(kms_flip:6824) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:6824) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:6824) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest C-eDP1: FAIL (8.051s)
Subtest flip-vs-expired-vblank: FAIL (30.464s)
(kms_flip:6824) igt_kms-CRITICAL: Test assertion failure function kmstest_set_connector_dpms, file ../lib/igt_kms.c:2267:
(kms_flip:6824) igt_kms-CRITICAL: Failed assertion: found_it
(kms_flip:6824) igt_kms-CRITICAL: Last errno: 9, Bad file descriptor
(kms_flip:6824) igt_kms-CRITICAL: DPMS property not found on 208
Dmesg
<6> [392.119490] Console: switching to colour dummy device 80x25
<6> [392.119804] [IGT] kms_flip: executing
<7> [392.125875] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:217:DP-1]
<7> [392.125885] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:217:DP-1]
<7> [392.126064] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:217:DP-1] disconnected
<7> [392.126335] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:229:DP-2]
<7> [392.126338] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:229:DP-2]
<7> [392.126495] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:229:DP-2] disconnected
<7> [392.126765] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:237:DP-3]
<7> [392.126767] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:237:DP-3]
<7> [392.126913] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:237:DP-3] disconnected
<7> [392.127200] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:208:eDP-1]
<7> [392.127203] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:208:eDP-1]
<7> [392.127718] 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> [392.128036] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] source rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 675000, 810000
<7> [392.128147] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] sink rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 810000
<7> [392.128382] xe 0000:00:02.0: [drm:intel_dp_print_rates [xe]] common rates: 162000, 216000, 243000, 270000, 324000, 432000, 540000, 810000
<7> [392.128936] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:208:eDP-1] Supported Monitor Refresh rate range is 40 Hz - 120 Hz
<5> [392.128948] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<5> [392.128952] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [392.128955] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:208:eDP-1] DisplayID extension version 0x13, primary use 0x00
<7> [392.128962] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:208:eDP-1] Assigning EDID-1.4 digital sink color depth as 10 bpc.
<5> [392.128968] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [392.128971] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:208:eDP-1] ELD monitor
<5> [392.128978] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [392.128981] xe 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:208:eDP-1] ELD size 20, SAD count 0
<5> [392.128988] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [392.129013] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:208:eDP-1] VRR capable: yes
<7> [392.129216] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:208:eDP-1] DFP max bpc 0, max dotclock 0, TMDS clock 0-0, PCON Max FRL BW 0Gbps
<7> [392.129373] xe 0000:00:02.0: [drm:intel_dp_set_edid [xe]] [CONNECTOR:208:eDP-1] RGB->YcbCr conversion? no, YCbCr 4:2:0 allowed? yes, YCbCr 4:4:4->4:2:0 conversion? no
<5> [392.130009] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<5> [392.130012] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<5> [392.130015] [drm] DisplayID checksum invalid, remainder is 248 (ignoring)
<7> [392.130091] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:208:eDP-1] probed modes:
<7> [392.130096] 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> [392.130101] 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> [392.130120] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:217:DP-1]
<7> [392.130125] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:217:DP-1]
<7> [392.130384] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:217:DP-1] disconnected
<7> [392.130406] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:229:DP-2]
<7> [392.130412] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:229:DP-2]
<7> [392.130696] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:229:DP-2] disconnected
<7> [392.130718] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:237:DP-3]
<7> [392.130724] xe 0000:00:02.0: [drm:intel_dp_detect [xe]] [CONNECTOR:237:DP-3]
<7> [392.130982] xe 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:237:DP-3] disconnected
<6> [392.131650] [IGT] kms_flip: starting subtest flip-vs-expired-vblank
<6> [392.133225] [IGT] kms_flip: starting dynamic subtest A-eDP1
<7> [392.141826] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:245]
<7> [392.142380] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:247]
<7> [392.222272] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:88:pipe A]
<7> [392.222364] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [392.222536] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [392.222661] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [392.222782] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [392.222900] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in dp_m_n (expected tu 64 data 6329869/8388608 link 421991/524288, found tu 0, data 0/0 link 0/0)
<7> [392.222998] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [392.223095] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [392.223189] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [392.223281] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [392.223368] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [392.223465] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [392.223576] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [392.223687] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [392.223796] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [392.223888] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0)
<7> [392.223977] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [392.224072] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [392.224176] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0)
<7> [392.224277] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0)
<7> [392.224377] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [392.224479] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [392.224579] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [392.224678] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [392.224776] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [392.224861] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [392.224941] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [392.225021] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0)
<7> [392.225100] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [392.225180] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [392.225258] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0)
<7> [392.225331] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0)
<7> [392.225402] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [392.225535] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [392.225628] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [392.225721] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [392.225813] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0)
<7> [392.225895] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0)
<7> [392.225987] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in port_clock (expected 432000, found 0)
<7> [392.226084] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:88:pipe A] fastset requirement not met, forcing full modeset
<7> [392.226215] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [392.226281] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:88:pipe A] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [392.226369] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:33:plane 1A] ddb ( 0 - 4051) -> ( 0 - 0), size 4051 -> 0
<7> [392.226453] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:83:cursor A] ddb (4051 - 4096) -> ( 0 - 0), size 45 -> 0
<7> [392.226536] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [392.226610] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33: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> [392.226684] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33: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> [392.226752] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33: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> [392.226830] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:88:pipe A] data rate 0 num active planes 0
<7> [392.226922] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400
<7> [392.227009] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400
<7> [392.227092] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [392.227177] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [392.227272] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0
<7> [392.227372] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:88:pipe A] min cdclk: 173855 kHz -> 0 kHz
<7> [392.227499] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 21732 kHz -> 0 kHz
<7> [392.227613] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [392.227725] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz
<7> [392.227827] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [392.227933] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:88:pipe A] enable: no [modeset]
<7> [392.228019] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:33:plane 1A] fb: [NOFB], visible: no
<7> [392.228101] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [392.228184] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [392.228266] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [392.228347] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [392.228425] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:83:cursor A] fb: [NOFB], visible: no
<7> [392.228557] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [392.228682] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [392.228831] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2
<7> [392.248765] xe 0000:00:02.0: [drm:intel_alpm_disable [xe]] Disabling ALPM
<7> [392.248902] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]]
<7> [392.289588] xe 0000:00:02.0: [drm:drm_dp_dpcd_access [drm_display_helper]] AUX USBC1/DDI TC1/PHY TC1: Too many retries, giving up. First error: -6
<7> [392.311548] xe 0000:00:02.0: [drm:drm_dp_dpcd_access [drm_display_helper]] AUX USBC2/DDI TC2/PHY TC2: Too many retries, giving up. First error: -6
<7> [392.335420] xe 0000:00:02.0: [drm:drm_dp_dpcd_access [drm_display_helper]] AUX USBC3/DDI TC3/PHY TC3: Too many retries, giving up. First error: -6
<7> [392.454979] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:208:eDP-1] set backlight PWM = 0
<7> [392.455261] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe A
<7> [392.458135] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 turn panel power off
<7> [392.458250] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [392.458374] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000003 PP_CONTROL: 0x00000060
<7> [392.510786] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [392.510922] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:207:DDI A/PHY A] - short
<7> [392.516635] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [392.516825] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:207:DDI A/PHY A]
<7> [392.516866] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A
<7> [392.517028] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:207:DDI A/PHY A]
<7> [392.517109] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:216:DDI TC1/PHY TC1]
<7> [392.517190] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:218:DP-MST A]
<7> [392.517279] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST B]
<7> [392.517364] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST C]
<7> [392.517448] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:228:DDI TC2/PHY TC2]
<7> [392.517530] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:230:DP-MST A]
<7> [392.517611] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:231:DP-MST B]
<7> [392.517690] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:232:DP-MST C]
<7> [392.517766] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:236:DDI TC3/PHY TC3]
<7> [392.517842] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:238:DP-MST A]
<7> [392.517914] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:239:DP-MST B]
<7> [392.517975] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:240:DP-MST C]
<7> [392.518036] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:208:eDP-1]
<7> [392.518116] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [392.518211] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [392.518293] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [392.518478] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_A
<7> [392.518606] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:88:pipe A]
<7> [392.518699] 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> [392.518812] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [392.518912] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384
<7> [392.519145] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:146:pipe B]
<7> [392.519271] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:204:pipe C]
<7> [392.519361] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:88:pipe A]
<7> [392.519384] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:208:eDP-1]
<7> [392.519436] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:208:eDP-1] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [392.519537] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:207:DDI A/PHY A][CRTC:88:pipe A] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 max link_bpp 30.0000
<7> [392.519622] xe 0000:00:02.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 432000 bpp input 30 compressed 0.0000 link rate required 1303913 available 1728000
<7> [392.519711] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:88:pipe A] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [392.519798] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:207:DDI A/PHY A] [CRTC:88:pipe A]
<7> [392.519886] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [392.519965] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [392.520042] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [392.520119] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [392.520222] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6329869/8388608 link 421991/524288)
<7> [392.520326] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [392.520426] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [392.520517] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [392.520609] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [392.520709] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [392.520806] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [392.520899] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [392.520976] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [392.521048] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [392.521121] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800)
<7> [392.521224] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [392.521321] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [392.521414] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906)
<7> [392.521497] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906)
<7> [392.521573] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [392.521649] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [392.521726] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [392.521801] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [392.521877] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [392.521951] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [392.522021] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [392.522095] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800)
<7> [392.522189] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [392.522284] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [392.522379] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906)
<7> [392.522474] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906)
<7> [392.522567] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [392.522659] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [392.522743] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [392.522820] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [392.522892] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710)
<7> [392.522961] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710)
<7> [392.523037] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in port_clock (expected 0, found 432000)
<7> [392.523119] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:88:pipe A] fastset requirement not met, forcing full modeset
<7> [392.523251] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [392.523339] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:88:pipe A] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x1
<7> [392.523442] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:33:plane 1A] ddb ( 0 - 0) -> ( 0 - 4051), size 0 -> 4051
<7> [392.523514] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:83:cursor A] ddb ( 0 - 0) -> (4051 - 4096), size 0 -> 45
<7> [392.523578] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm
<7> [392.523641] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 13, 13, 13, 13, 13, 0, 0, 0, 4, 0
<7> [392.523703] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 92, 297, 297, 297, 297, 297, 0, 0, 197, 92, 197
<7> [392.523764] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 183, 456, 456, 456, 456, 456, 0, 0, 198, 183, 198
<7> [392.523839] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:88:pipe A] data rate 1390840 num active planes 1
<7> [392.523927] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400
<7> [392.524015] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400
<7> [392.524106] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [392.524203] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [392.524304] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461
<7> [392.524404] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:88:pipe A] min cdclk: 0 kHz -> 173855 kHz
<7> [392.524514] xe 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 0 kHz -> 21732 kHz
<7> [392.524615] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [392.524713] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [392.524800] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [392.524889] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:88:pipe A] enable: yes [modeset]
<7> [392.524966] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [392.525043] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 30, dithering: 0
<7> [392.525142] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [392.525241] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [392.525338] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [392.525430] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [392.525514] 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> [392.525598] 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> [392.525679] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [392.525759] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [392.525832] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [392.525902] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [392.525972] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [392.526049] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14
<7> [392.526180] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB
<7> [392.526271] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB
<7> [392.526363] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0
<7> [392.526454] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range
<7> [392.526544] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined
<7> [392.526634] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [392.526707] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [392.526776] 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> [392.526845] 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> [392.526916] 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> [392.526992] 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> [392.527072] 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> [392.527162] 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> [392.527252] 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> [392.527340] 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> [392.527419] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0
<7> [392.527496] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [392.527570] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [392.527641] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [392.527712] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dpll_hw_state: dpll: 0x69780, dpll_md: 0x42110, fp0: 0x1a2, fp1: 0x1000000
<7> [392.527787] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [392.527864] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [392.527940] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [392.528015] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [392.528105] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [392.528195] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [392.528286] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [392.528375] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [392.528456] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [392.528530] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [392.528601] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [392.528671] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [392.528745] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [392.528819] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:33:plane 1A] fb: [FB:245] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [392.528895] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [392.528969] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [392.529047] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [392.529133] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [392.529221] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [392.529308] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [392.529387] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:83:cursor A] fb: [NOFB], visible: no
<7> [392.529734] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_A
<7> [392.529886] 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> [392.529981] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [392.530110] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480
<7> [392.530217] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:207:DDI A/PHY A]
<7> [392.530305] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:216:DDI TC1/PHY TC1]
<7> [392.530385] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:218:DP-MST A]
<7> [392.530455] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST B]
<7> [392.530523] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST C]
<7> [392.530591] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:228:DDI TC2/PHY TC2]
<7> [392.530670] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:230:DP-MST A]
<7> [392.530748] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:231:DP-MST B]
<7> [392.530825] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:232:DP-MST C]
<7> [392.530901] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:236:DDI TC3/PHY TC3]
<7> [392.530966] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:238:DP-MST A]
<7> [392.531035] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:239:DP-MST B]
<7> [392.531116] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:240:DP-MST C]
<7> [392.531196] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [392.531376] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: *)
<7> [392.531442] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes)
<7> [392.531549] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A
<7> [392.532867] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 turn panel power on
<7> [392.532940] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 wait for panel power cycle (484 ms remaining)
<7> [392.550389] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [392.550502] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:207:DDI A/PHY A] - long
<7> [392.550595] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [392.550692] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:207:DDI A/PHY A]
<7> [393.017007] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [393.037663] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [393.038039] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 wait for panel power on
<7> [393.038418] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [393.074915] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [393.075383] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:207:DDI A/PHY A] - long
<7> [393.075730] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [393.076104] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:207:DDI A/PHY A]
<7> [393.245186] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [393.247335] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 turning VDD on
<7> [393.247625] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [393.249740] 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> [393.251012] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [393.251804] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05
<7> [393.252869] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [393.253993] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [393.254942] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Clock recovery OK
<7> [393.255248] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Using DP training pattern TPS4
<7> [393.256578] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [393.256846] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4
<7> [393.257609] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe A
<7> [393.258009] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]]
<7> [393.258291] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe A
<7> [393.258566] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:208:eDP-1] set backlight PWM = 4518
<7> [393.274885] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2
<7> [393.276515] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:208:eDP-1]
<7> [393.276820] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:88:pipe A]
<7> [393.309581] 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> [393.309701] 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> [393.372948] 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> [395.783452] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 turning VDD off
<7> [395.783827] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [397.395272] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port D/TC#1: TC port mode reset (disconnected -> tbt-alt) pin assignment: - max lanes: 4
<7> [397.417063] xe 0000:00:02.0: [drm:drm_dp_dpcd_access [drm_display_helper]] AUX USBC1/DDI TC1/PHY TC1: Too many retries, giving up. First error: -6
<7> [397.418599] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port E/TC#2: TC port mode reset (disconnected -> tbt-alt) pin assignment: - max lanes: 4
<7> [397.440759] xe 0000:00:02.0: [drm:drm_dp_dpcd_access [drm_display_helper]] AUX USBC2/DDI TC2/PHY TC2: Too many retries, giving up. First error: -6
<7> [397.441398] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [397.443044] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [397.447484] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [397.449149] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [397.449707] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [397.450460] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port F/TC#3: TC port mode reset (disconnected -> tbt-alt) pin assignment: - max lanes: 4
<7> [397.471538] xe 0000:00:02.0: [drm:drm_dp_dpcd_access [drm_display_helper]] AUX USBC3/DDI TC3/PHY TC3: Too many retries, giving up. First error: -6
<7> [397.472251] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 turning VDD on
<7> [397.472729] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006f
<7> [398.454281] 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> [398.454402] 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> [398.517947] 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> [399.982510] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 turning VDD off
<7> [399.982866] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [403.240308] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:247] from all active usage due to RMFB ioctl
<7> [403.242767] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:245] from all active usage due to RMFB ioctl
<7> [403.242843] xe 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:33:plane 1A] because [FB:245] is removed
<7> [403.242933] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:33:plane 1A] ddb ( 0 - 4051) -> ( 0 - 0), size 4051 -> 0
<7> [403.243306] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [403.243620] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33: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> [403.243929] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33: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> [403.244319] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33: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> [403.244697] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:88:pipe A] data rate 0 num active planes 0
<7> [403.245103] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400
<7> [403.245477] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400
<7> [403.245900] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [403.246284] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [403.246638] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0
<7> [403.247500] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2
<7> [403.257125] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 turning VDD on
<7> [403.257524] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006f
<6> [403.274757] [IGT] kms_flip: finished subtest A-eDP1, SUCCESS
<6> [403.277166] [IGT] kms_flip: starting dynamic subtest B-eDP1
<7> [403.297210] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [403.297401] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:245]
<7> [403.297362] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [403.297458] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [403.297743] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:247]
<7> [403.375194] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:88:pipe A]
<7> [403.375380] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [403.375684] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [403.375977] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [403.376218] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [403.376452] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in dp_m_n (expected tu 64 data 6329869/8388608 link 421991/524288, found tu 0, data 0/0 link 0/0)
<7> [403.376680] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [403.376944] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [403.377159] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [403.377364] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [403.377565] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [403.377785] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [403.377975] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [403.378160] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [403.378342] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [403.378515] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0)
<7> [403.378684] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [403.378870] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [403.379030] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0)
<7> [403.379185] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0)
<7> [403.379360] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [403.379527] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [403.379681] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [403.379849] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [403.379986] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [403.380122] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [403.380252] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [403.380383] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0)
<7> [403.380512] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [403.380637] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [403.380797] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0)
<7> [403.380934] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0)
<7> [403.381052] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [403.381170] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [403.381286] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [403.381400] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [403.381513] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0)
<7> [403.381626] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0)
<7> [403.381748] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in port_clock (expected 432000, found 0)
<7> [403.381881] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:88:pipe A] fastset requirement not met, forcing full modeset
<7> [403.382071] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [403.382184] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:88:pipe A] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [403.382308] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:83:cursor A] ddb (4051 - 4096) -> ( 0 - 0), size 45 -> 0
<7> [403.382419] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:88:pipe A] min cdclk: 173855 kHz -> 0 kHz
<7> [403.382541] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [403.382652] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz
<7> [403.382774] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [403.382907] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:88:pipe A] enable: no [modeset]
<7> [403.383028] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:33:plane 1A] fb: [NOFB], visible: no
<7> [403.383137] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [403.383241] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [403.383342] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [403.383441] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [403.383538] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:83:cursor A] fb: [NOFB], visible: no
<7> [403.383695] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [403.383822] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [403.384104] xe 0000:00:02.0: [drm:intel_alpm_disable [xe]] Disabling ALPM
<7> [403.384212] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]]
<7> [403.585414] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:208:eDP-1] set backlight PWM = 0
<7> [403.585889] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe A
<7> [403.591494] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 turn panel power off
<7> [403.591942] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [403.592411] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [403.643468] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [403.643891] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A
<7> [403.644314] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:207:DDI A/PHY A]
<7> [403.644544] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:216:DDI TC1/PHY TC1]
<7> [403.644752] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:218:DP-MST A]
<7> [403.644593] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [403.644974] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST B]
<7> [403.645183] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST C]
<7> [403.645094] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:207:DDI A/PHY A] - short
<7> [403.645384] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:228:DDI TC2/PHY TC2]
<7> [403.645629] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:230:DP-MST A]
<7> [403.645566] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:207:DDI A/PHY A]
<7> [403.645829] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:231:DP-MST B]
<7> [403.646039] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:232:DP-MST C]
<7> [403.646247] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:236:DDI TC3/PHY TC3]
<7> [403.646422] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:238:DP-MST A]
<7> [403.646594] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:239:DP-MST B]
<7> [403.646764] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:240:DP-MST C]
<7> [403.646951] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:208:eDP-1]
<7> [403.647176] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [403.647365] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [403.647554] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [403.647914] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_A
<7> [403.648266] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:88:pipe A]
<7> [403.648489] 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> [403.648743] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [403.648980] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384
<7> [403.649614] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:146:pipe B]
<7> [403.649882] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:204:pipe C]
<7> [403.650116] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:146:pipe B]
<7> [403.650173] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:208:eDP-1]
<7> [403.650306] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:208:eDP-1] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [403.650566] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:207:DDI A/PHY A][CRTC:146:pipe B] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 max link_bpp 30.0000
<7> [403.650791] xe 0000:00:02.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 432000 bpp input 30 compressed 0.0000 link rate required 1303913 available 1728000
<7> [403.651057] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:146:pipe B] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [403.651357] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:207:DDI A/PHY A] [CRTC:146:pipe B]
<7> [403.651608] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [403.651857] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [403.652152] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [403.652456] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [403.652713] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146: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> [403.653006] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [403.653255] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [403.653499] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [403.653732] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [403.653984] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [403.654247] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [403.654492] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [403.654776] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [403.655045] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [403.655303] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800)
<7> [403.655567] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [403.655803] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [403.656064] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906)
<7> [403.656294] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906)
<7> [403.656539] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [403.656751] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [403.656980] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [403.657184] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [403.657376] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [403.657564] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [403.657786] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [403.658015] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800)
<7> [403.658239] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [403.658422] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [403.658600] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906)
<7> [403.658774] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906)
<7> [403.658957] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [403.659123] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [403.659284] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [403.659466] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [403.659638] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710)
<7> [403.659800] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710)
<7> [403.659966] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in port_clock (expected 0, found 432000)
<7> [403.660116] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:146:pipe B] fastset requirement not met, forcing full modeset
<7> [403.660308] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [403.660423] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:146:pipe B] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x2
<7> [403.660575] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:91:plane 1B] ddb ( 0 - 0) -> ( 0 - 4051), size 0 -> 4051
<7> [403.660687] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:141:cursor B] ddb ( 0 - 0) -> (4051 - 4096), size 0 -> 45
<7> [403.660795] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:91: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> [403.660921] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:91: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> [403.661024] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:91: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> [403.661134] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:91: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> [403.661272] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:146:pipe B] data rate 1390840 num active planes 1
<7> [403.661426] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400
<7> [403.661565] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400
<7> [403.661692] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [403.661823] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [403.661964] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461
<7> [403.662108] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:146:pipe B] min cdclk: 0 kHz -> 173855 kHz
<7> [403.662253] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [403.662371] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [403.662484] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [403.662618] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:146:pipe B] enable: yes [modeset]
<7> [403.662749] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [403.662876] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: B, pipe bpp: 30, dithering: 0
<7> [403.662984] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [403.663092] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [403.663197] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [403.663297] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [403.663394] 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> [403.663490] 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> [403.663581] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [403.663670] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [403.663757] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [403.663845] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [403.663949] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [403.664037] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14
<7> [403.664121] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB
<7> [403.664204] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB
<7> [403.664285] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0
<7> [403.664365] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range
<7> [403.664443] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined
<7> [403.664521] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [403.664597] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [403.664672] 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> [403.664747] 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> [403.664817] 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> [403.664907] 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> [403.664994] 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> [403.665085] 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> [403.665176] 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> [403.665252] 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> [403.665324] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0
<7> [403.665395] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [403.665466] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [403.665537] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [403.665608] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dpll_hw_state: dpll: 0x69780, dpll_md: 0x42110, fp0: 0x1a2, fp1: 0x1000000
<7> [403.665678] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [403.665749] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [403.665820] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [403.665902] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [403.665973] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [403.666043] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [403.666112] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [403.666180] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [403.666249] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [403.666317] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [403.666386] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [403.666453] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [403.666520] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [403.666588] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:91:plane 1B] fb: [FB:245] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [403.666657] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [403.666724] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [403.666792] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:101:plane 2B] fb: [NOFB], visible: no
<7> [403.666864] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:111:plane 3B] fb: [NOFB], visible: no
<7> [403.666934] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:121:plane 4B] fb: [NOFB], visible: no
<7> [403.667005] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:131:plane 5B] fb: [NOFB], visible: no
<7> [403.667075] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:141:cursor B] fb: [NOFB], visible: no
<7> [403.667394] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [403.667509] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_B
<7> [403.667640] 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> [403.667725] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [403.667810] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480
<7> [403.667898] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:207:DDI A/PHY A]
<7> [403.667964] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:216:DDI TC1/PHY TC1]
<7> [403.668028] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:218:DP-MST A]
<7> [403.668090] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST B]
<7> [403.668152] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST C]
<7> [403.668213] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:228:DDI TC2/PHY TC2]
<7> [403.668273] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:230:DP-MST A]
<7> [403.668335] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:231:DP-MST B]
<7> [403.668398] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:232:DP-MST C]
<7> [403.668460] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:236:DDI TC3/PHY TC3]
<7> [403.668521] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:238:DP-MST A]
<7> [403.668580] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:239:DP-MST B]
<7> [403.668639] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:240:DP-MST C]
<7> [403.668698] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [403.668862] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: *)
<7> [403.668928] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes)
<7> [403.669038] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A
<7> [403.669948] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 turn panel power on
<7> [403.670015] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 wait for panel power cycle (474 ms remaining)
<7> [403.683408] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [403.683602] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:207:DDI A/PHY A] - long
<7> [403.683698] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [403.683852] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:207:DDI A/PHY A]
<7> [404.151750] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [404.242545] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [404.242903] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 wait for panel power on
<7> [404.243260] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [404.279719] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [404.280129] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:207:DDI A/PHY A] - long
<7> [404.280445] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [404.280984] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:207:DDI A/PHY A]
<7> [404.454869] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [404.457128] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 turning VDD on
<7> [404.457559] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [404.460029] 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> [404.461352] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [404.462348] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05
<7> [404.463622] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [404.464843] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [404.465932] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Clock recovery OK
<7> [404.466331] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Using DP training pattern TPS4
<7> [404.467823] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [404.468173] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4
<7> [404.469071] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe B
<7> [404.469545] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]]
<7> [404.469942] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe B
<7> [404.470354] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:208:eDP-1] set backlight PWM = 4518
<7> [404.486595] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2
<7> [404.488400] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:208:eDP-1]
<7> [404.488817] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:146:pipe B]
<7> [407.001675] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 turning VDD off
<7> [407.002062] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [414.501704] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:247] from all active usage due to RMFB ioctl
<7> [414.501813] xe 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:91:plane 1B] because [FB:247] is removed
<7> [414.501912] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:91:plane 1B] ddb ( 0 - 4051) -> ( 0 - 0), size 4051 -> 0
<7> [414.502260] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:91: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> [414.502636] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:91: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> [414.502928] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:91: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> [414.503198] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:91: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> [414.503541] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:146:pipe B] data rate 0 num active planes 0
<7> [414.503872] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400
<7> [414.504191] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400
<7> [414.504578] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [414.504891] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [414.505277] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0
<7> [414.506228] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR2
<7> [414.526635] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 turning VDD on
<7> [414.527072] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006f
<6> [414.539972] [IGT] kms_flip: finished subtest B-eDP1, SUCCESS
<6> [414.541146] [IGT] kms_flip: starting dynamic subtest C-eDP1
<7> [414.556085] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [414.556201] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [414.556343] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [414.556543] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:245]
<7> [414.556893] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:247]
<7> [414.627978] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:88:pipe A]
<7> [414.628245] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [414.628562] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [414.628935] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:146:pipe B]
<7> [414.629070] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.enable (expected yes, found no)
<7> [414.629391] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.active (expected yes, found no)
<7> [414.629616] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [414.629843] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in lane_count (expected 4, found 0)
<7> [414.630063] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146: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> [414.630295] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [414.630498] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [414.630690] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [414.630877] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [414.631063] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [414.631260] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [414.631436] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [414.631610] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [414.631781] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [414.631950] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0)
<7> [414.632113] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [414.632289] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [414.632441] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0)
<7> [414.632586] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0)
<7> [414.632729] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [414.632874] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [414.633021] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [414.633164] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [414.633294] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [414.633422] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [414.633549] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [414.633672] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0)
<7> [414.633794] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [414.633914] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [414.634033] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0)
<7> [414.634149] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0)
<7> [414.634286] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [414.634398] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [414.634508] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [414.634618] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [414.634727] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0)
<7> [414.634837] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0)
<7> [414.634949] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:146:pipe B] fastset requirement not met in port_clock (expected 432000, found 0)
<7> [414.635075] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:146:pipe B] fastset requirement not met, forcing full modeset
<7> [414.635288] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [414.635416] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:146:pipe B] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x2 -> 0x0
<7> [414.635554] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:141:cursor B] ddb (4051 - 4096) -> ( 0 - 0), size 45 -> 0
<7> [414.635678] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:146:pipe B] min cdclk: 173855 kHz -> 0 kHz
<7> [414.635806] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [414.635932] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz
<7> [414.636054] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [414.636214] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:146:pipe B] enable: no [modeset]
<7> [414.636346] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:91:plane 1B] fb: [NOFB], visible: no
<7> [414.636480] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:101:plane 2B] fb: [NOFB], visible: no
<7> [414.636612] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:111:plane 3B] fb: [NOFB], visible: no
<7> [414.636734] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:121:plane 4B] fb: [NOFB], visible: no
<7> [414.636857] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:131:plane 5B] fb: [NOFB], visible: no
<7> [414.636989] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:141:cursor B] fb: [NOFB], visible: no
<7> [414.637276] xe 0000:00:02.0: [drm:intel_alpm_disable [xe]] Disabling ALPM
<7> [414.637420] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]]
<7> [414.845189] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:208:eDP-1] set backlight PWM = 0
<7> [414.846000] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe B
<7> [414.856177] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 turn panel power off
<7> [414.856634] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [414.857089] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [414.909399] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [414.910015] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:207:DDI A/PHY A] - short
<7> [414.916917] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [414.917503] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A
<7> [414.918142] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:207:DDI A/PHY A]
<7> [414.918126] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:207:DDI A/PHY A]
<7> [414.918589] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:216:DDI TC1/PHY TC1]
<7> [414.918986] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:218:DP-MST A]
<7> [414.919339] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST B]
<7> [414.919678] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST C]
<7> [414.920074] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:228:DDI TC2/PHY TC2]
<7> [414.920407] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:230:DP-MST A]
<7> [414.920761] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:231:DP-MST B]
<7> [414.921128] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:232:DP-MST C]
<7> [414.921473] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:236:DDI TC3/PHY TC3]
<7> [414.921843] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:238:DP-MST A]
<7> [414.922213] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:239:DP-MST B]
<7> [414.922519] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:240:DP-MST C]
<7> [414.922922] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:208:eDP-1]
<7> [414.923272] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [414.923547] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [414.923825] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [414.924352] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_B
<7> [414.924812] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [414.925305] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:146:pipe B]
<7> [414.925683] 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> [414.926152] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [414.926460] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384
<7> [414.927303] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:204:pipe C]
<7> [414.927693] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:204:pipe C]
<7> [414.927768] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:208:eDP-1]
<7> [414.927965] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:208:eDP-1] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [414.928388] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:207:DDI A/PHY A][CRTC:204:pipe C] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 max link_bpp 30.0000
<7> [414.928795] xe 0000:00:02.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 432000 bpp input 30 compressed 0.0000 link rate required 1303913 available 1728000
<7> [414.929190] xe 0000:00:02.0: [drm:intel_psr_compute_config [xe]] PSR2 not supported in transcoder C
<7> [414.929468] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:204:pipe C] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [414.929850] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:207:DDI A/PHY A] [CRTC:204:pipe C]
<7> [414.930163] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.enable (expected no, found yes)
<7> [414.930473] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.active (expected no, found yes)
<7> [414.930813] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in cpu_transcoder (expected -1, found 2)
<7> [414.931146] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in lane_count (expected 0, found 4)
<7> [414.931420] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204: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> [414.931688] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [414.931971] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [414.932219] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [414.932495] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [414.932711] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [414.932946] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [414.933152] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [414.933351] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [414.933540] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [414.933764] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800)
<7> [414.933975] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [414.934156] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [414.934340] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906)
<7> [414.934503] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906)
<7> [414.934662] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [414.934820] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [414.934996] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [414.935158] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [414.935303] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [414.935448] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [414.935588] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [414.935725] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800)
<7> [414.935865] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [414.936004] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [414.936133] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906)
<7> [414.936261] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906)
<7> [414.936385] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [414.936504] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [414.936621] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [414.936736] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [414.936852] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710)
<7> [414.936962] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710)
<7> [414.937072] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in port_clock (expected 0, found 432000)
<7> [414.937180] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:204:pipe C] fastset requirement not met, forcing full modeset
<7> [414.937314] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xd (total dbuf slices 0xf), mbus joined? no->no
<7> [414.937411] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:204:pipe C] dbuf slices 0x0 -> 0xc, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x4
<7> [414.937546] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:149:plane 1C] ddb ( 0 - 0) -> ( 0 - 2003), size 0 -> 2003
<7> [414.937638] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:199:cursor C] ddb ( 0 - 0) -> (2003 - 2048), size 0 -> 45
<7> [414.937720] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:149: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> [414.937798] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:149: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> [414.937889] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:149: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> [414.937966] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:149: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> [414.938059] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:204:pipe C] data rate 1390840 num active planes 1
<7> [414.938187] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400
<7> [414.938305] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400
<7> [414.938415] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [414.938512] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [414.938606] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461
<7> [414.938713] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:204:pipe C] min cdclk: 0 kHz -> 173855 kHz
<7> [414.938817] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] Can change cdclk via squashing
<7> [414.938930] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [414.939034] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] New voltage level calculated to be logical 0, actual 0
<7> [414.939149] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:204:pipe C] enable: yes [modeset]
<7> [414.939241] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [414.939326] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: C, pipe bpp: 30, dithering: 0
<7> [414.939409] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [414.939493] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [414.939578] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [414.939660] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [414.939737] 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> [414.939822] 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> [414.939935] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [414.940032] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [414.940126] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: disabled, panel replay: disabled, selective fetch: disabled
<7> [414.940220] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [414.940314] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [414.940405] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 2, length 8
<7> [414.940482] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB
<7> [414.940559] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB
<7> [414.940628] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0
<7> [414.940703] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range
<7> [414.940785] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined
<7> [414.940878] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [414.940968] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [414.941058] 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> [414.941148] 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> [414.941230] 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> [414.941305] 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> [414.941373] 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> [414.941442] 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> [414.941509] 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> [414.941583] 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> [414.941661] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0
<7> [414.941740] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [414.941818] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [414.941918] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [414.942013] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dpll_hw_state: dpll: 0x69780, dpll_md: 0x42110, fp0: 0x1a2, fp1: 0x1000000
<7> [414.942106] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [414.942197] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [414.942274] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [414.942342] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [414.942410] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [414.942479] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [414.942547] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [414.942613] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [414.942680] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [414.942747] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [414.942813] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [414.942909] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [414.943000] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [414.943093] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:149:plane 1C] fb: [FB:245] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [414.943176] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [414.943249] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [414.943319] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:159:plane 2C] fb: [NOFB], visible: no
<7> [414.943386] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:169:plane 3C] fb: [NOFB], visible: no
<7> [414.943452] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:179:plane 4C] fb: [NOFB], visible: no
<7> [414.943518] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:189:plane 5C] fb: [NOFB], visible: no
<7> [414.943585] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:199:cursor C] fb: [NOFB], visible: no
<7> [414.943970] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [414.944147] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_C
<7> [414.944304] 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> [414.944402] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [414.944497] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480
<7> [414.944585] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:207:DDI A/PHY A]
<7> [414.944653] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:216:DDI TC1/PHY TC1]
<7> [414.944718] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:218:DP-MST A]
<7> [414.944781] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST B]
<7> [414.944861] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST C]
<7> [414.944946] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:228:DDI TC2/PHY TC2]
<7> [414.945033] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:230:DP-MST A]
<7> [414.945114] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:231:DP-MST B]
<7> [414.945184] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:232:DP-MST C]
<7> [414.945243] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:236:DDI TC3/PHY TC3]
<7> [414.945301] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:238:DP-MST A]
<7> [414.945360] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:239:DP-MST B]
<7> [414.945422] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:240:DP-MST C]
<7> [414.945483] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xd
<7> [414.945642] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [414.945751] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A
<7> [414.946936] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 turn panel power on
<7> [414.947076] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 wait for panel power cycle (471 ms remaining)
<7> [414.947865] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [414.948049] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:207:DDI A/PHY A] - long
<7> [414.948152] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [414.948268] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:207:DDI A/PHY A]
<7> [415.420719] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [415.461660] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [415.461963] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 wait for panel power on
<7> [415.462215] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [415.498817] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [415.499185] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:207:DDI A/PHY A] - long
<7> [415.499468] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [415.499780] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:207:DDI A/PHY A]
<7> [415.672719] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [415.674865] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 turning VDD on
<7> [415.675228] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [415.677762] 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> [415.679066] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [415.680002] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05
<7> [415.681208] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [415.682343] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [415.683349] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Clock recovery OK
<7> [415.683676] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Using DP training pattern TPS4
<7> [415.685041] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [415.685396] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4
<7> [415.686255] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe C
<7> [415.686693] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]]
<7> [415.687058] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe C
<7> [415.687692] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:208:eDP-1] set backlight PWM = 4518
<7> [415.688949] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] reserved 14745600 bytes of contiguous stolen space for FBC, limit: 2
<7> [415.689306] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] Enabling FBC on [PLANE:149:plane 1C]
<7> [415.703514] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR1
<7> [415.704975] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:208:eDP-1]
<7> [415.705373] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:204:pipe C]
<7> [418.249780] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 turning VDD off
<7> [418.250342] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<6> [422.592712] [IGT] kms_flip: finished subtest C-eDP1, FAIL
<6> [422.596356] [IGT] kms_flip: finished subtest flip-vs-expired-vblank, FAIL
<7> [422.615988] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:245] from all active usage due to RMFB ioctl
<7> [422.616104] xe 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:149:plane 1C] because [FB:245] is removed
<7> [422.616233] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:149:plane 1C] ddb ( 0 - 2003) -> ( 0 - 0), size 2003 -> 0
<7> [422.616648] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:149: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> [422.616945] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:149: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> [422.617249] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:149: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> [422.617562] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:149: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> [422.617913] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:204:pipe C] data rate 0 num active planes 0
<7> [422.618283] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400
<7> [422.618673] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400
<7> [422.619023] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [422.619387] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [422.619698] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0
<7> [422.620844] xe 0000:00:02.0: [drm:intel_psr_disable_locked [xe]] Disabling PSR1
<7> [422.626537] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 turning VDD on
<7> [422.626971] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006f
<7> [422.643096] xe 0000:00:02.0: [drm:__intel_fbc_disable [xe]] Disabling FBC on [PLANE:149:plane 1C]
<7> [422.663202] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:208:eDP-1] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [422.663833] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:207:DDI A/PHY A][CRTC:88:pipe A] DP link limits: pixel clock 347710 kHz DSC off max lanes 4 max rate 810000 max pipe_bpp 30 max link_bpp 30.0000
<7> [422.664254] xe 0000:00:02.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 432000 bpp input 30 compressed 0.0000 link rate required 1303913 available 1728000
<7> [422.664672] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:88:pipe A] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [422.665049] xe 0000:00:02.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:207:DDI A/PHY A] [CRTC:88:pipe A]
<7> [422.665482] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [422.665848] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [422.666184] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [422.666540] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [422.666971] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6329869/8388608 link 421991/524288)
<7> [422.667345] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [422.667738] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [422.668063] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [422.668442] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [422.668776] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [422.669078] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [422.669386] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [422.669717] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [422.669983] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [422.670292] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1800)
<7> [422.670767] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [422.670993] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [422.671216] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1906)
<7> [422.671444] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1906)
<7> [422.671650] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [422.671878] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [422.672084] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [422.672299] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [422.672605] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [422.672801] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [422.672969] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [422.673129] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1800)
<7> [422.673290] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [422.673467] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [422.673619] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1906)
<7> [422.673790] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1906)
<7> [422.673933] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [422.674073] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [422.674210] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [422.674355] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [422.674490] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 347710)
<7> [422.674628] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 347710)
<7> [422.674764] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:88:pipe A] fastset requirement not met in port_clock (expected 0, found 432000)
<7> [422.674894] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:88:pipe A] fastset requirement not met, forcing full modeset
<7> [422.675022] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.enable (expected yes, found no)
<7> [422.675145] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.active (expected yes, found no)
<7> [422.675264] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in cpu_transcoder (expected 2, found -1)
<7> [422.675394] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in lane_count (expected 4, found 0)
<7> [422.675509] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204: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> [422.675624] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [422.675733] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [422.675841] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [422.675945] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [422.676047] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [422.676150] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [422.676248] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [422.676350] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [422.676446] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [422.676540] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0)
<7> [422.676635] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [422.676727] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [422.676816] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0)
<7> [422.676904] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0)
<7> [422.676989] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [422.677073] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [422.677156] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [422.677236] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [422.677318] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [422.677422] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [422.677514] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [422.677607] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1800, found 0)
<7> [422.677691] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [422.677772] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [422.677848] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1906, found 0)
<7> [422.677924] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1906, found 0)
<7> [422.678000] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [422.678075] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [422.678149] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [422.678219] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [422.678289] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 347710, found 0)
<7> [422.678377] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 347710, found 0)
<7> [422.678468] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:204:pipe C] fastset requirement not met in port_clock (expected 432000, found 0)
<7> [422.678557] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:204:pipe C] fastset requirement not met, forcing full modeset
<7> [422.678693] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xd -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [422.678762] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:88:pipe A] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x4 -> 0x1
<7> [422.678833] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:204:pipe C] dbuf slices 0xc -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x4 -> 0x1
<7> [422.678901] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:33:plane 1A] ddb ( 0 - 0) -> ( 0 - 4051), size 0 -> 4051
<7> [422.678970] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:83:cursor A] ddb ( 0 - 0) -> (4051 - 4096), size 0 -> 45
<7> [422.679029] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm
<7> [422.679086] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 13, 13, 13, 13, 13, 0, 0, 0, 3, 0
<7> [422.679142] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 24, 313, 313, 313, 313, 313, 0, 0, 38, 73, 87
<7> [422.679197] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 28, 346, 346, 346, 346, 346, 0, 0, 39, 82, 88
<7> [422.679252] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:199:cursor C] ddb (2003 - 2048) -> ( 0 - 0), size 45 -> 0
<7> [422.679327] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:88:pipe A] data rate 1390840 num active planes 1
<7> [422.679427] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1461 qgv_peak_bw: 38400
<7> [422.679532] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1461 qgv_peak_bw: 38400
<7> [422.679634] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [422.679715] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1461 qgv_peak_bw: 38400
<7> [422.679792] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1461
<7> [422.679870] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:88:pipe A] min cdclk: 0 kHz -> 173855 kHz
<7> [422.679955] xe 0000:00:02.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:204:pipe C] min cdclk: 173855 kHz -> 0 kHz
<7> [422.680071] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:88:pipe A] enable: yes [modeset]
<7> [422.680168] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [422.680266] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 30, dithering: 0
<7> [422.680374] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [422.680478] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [422.680581] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [422.680668] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [422.680745] 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> [422.680819] 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> [422.680893] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [422.680966] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [422.681038] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [422.681109] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [422.681179] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [422.681251] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] DP SDP: VSC, revision 4, length 14
<7> [422.681328] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pixelformat: RGB
<7> [422.681417] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] colorimetry: sRGB
<7> [422.681509] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] bpc: 0
<7> [422.681600] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dynamic range: VESA range
<7> [422.681688] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] content type: Not defined
<7> [422.681761] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [422.681829] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [422.681898] 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> [422.681967] 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> [422.682035] 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> [422.682105] 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> [422.682174] 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> [422.682242] 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> [422.682310] 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> [422.682413] 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> [422.682494] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 70, ips linetime: 0
<7> [422.682572] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [422.682655] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [422.682744] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [422.682815] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dpll_hw_state: dpll: 0x69780, dpll_md: 0x42110, fp0: 0x1a2, fp1: 0x1000000
<7> [422.682886] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [422.682955] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [422.683024] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [422.683093] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [422.683161] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [422.683229] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [422.683297] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [422.683387] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [422.683478] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [422.683565] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [422.683651] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [422.683727] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [422.683793] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [422.683860] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:33:plane 1A] fb: [FB:209] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [422.683927] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [422.683994] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [422.684061] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [422.684127] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [422.684194] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [422.684260] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [422.684332] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:83:cursor A] fb: [NOFB], visible: no
<7> [422.684415] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:204:pipe C] enable: no [modeset]
<7> [422.684502] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:149:plane 1C] fb: [NOFB], visible: no
<7> [422.684588] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:159:plane 2C] fb: [NOFB], visible: no
<7> [422.684672] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:169:plane 3C] fb: [NOFB], visible: no
<7> [422.684740] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:179:plane 4C] fb: [NOFB], visible: no
<7> [422.684806] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:189:plane 5C] fb: [NOFB], visible: no
<7> [422.684872] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:199:cursor C] fb: [NOFB], visible: no
<7> [422.685008] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_A
<7> [422.685236] xe 0000:00:02.0: [drm:intel_alpm_disable [xe]] Disabling ALPM
<7> [422.685330] xe 0000:00:02.0: [drm:intel_edp_backlight_off [xe]]
<7> [422.894668] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:208:eDP-1] set backlight PWM = 0
<7> [422.895131] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe C
<7> [422.916192] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 turn panel power off
<7> [422.916653] xe 0000:00:02.0: [drm:intel_pps_off_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [422.917079] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [422.969480] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x00000009, pins 0x00000010, long 0x00000000
<7> [422.970030] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:207:DDI A/PHY A] - short
<7> [422.975398] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [422.975939] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_A
<7> [422.976523] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:207:DDI A/PHY A]
<7> [422.976537] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring short hpd on eDP [ENCODER:207:DDI A/PHY A]
<7> [422.976877] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:216:DDI TC1/PHY TC1]
<7> [422.977244] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:218:DP-MST A]
<7> [422.977563] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:219:DP-MST B]
<7> [422.977872] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:220:DP-MST C]
<7> [422.978255] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:228:DDI TC2/PHY TC2]
<7> [422.978589] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:230:DP-MST A]
<7> [422.978883] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:231:DP-MST B]
<7> [422.979192] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:232:DP-MST C]
<7> [422.979529] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:236:DDI TC3/PHY TC3]
<7> [422.979849] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:238:DP-MST A]
<7> [422.980139] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:239:DP-MST B]
<7> [422.980415] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:240:DP-MST C]
<7> [422.980722] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [422.981201] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: *)
<7> [422.981494] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes)
<7> [422.981834] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_A
<7> [422.983289] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 turn panel power on
<7> [422.983699] xe 0000:00:02.0: [drm:wait_panel_power_cycle [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 wait for panel power cycle (493 ms remaining)
<7> [423.007735] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [423.007944] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:207:DDI A/PHY A] - long
<7> [423.008086] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [423.008252] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:207:DDI A/PHY A]
<7> [423.478086] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [423.508084] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [423.508459] xe 0000:00:02.0: [drm:intel_pps_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 wait for panel power on
<7> [423.508848] xe 0000:00:02.0: [drm:wait_panel_status [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [423.545299] xe 0000:00:02.0: [drm:icp_irq_handler [xe]] hotplug event received, stat 0x00010000, dig 0x0000000a, pins 0x00000010, long 0x00000010
<7> [423.545699] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] digital hpd on [ENCODER:207:DDI A/PHY A] - long
<7> [423.546010] xe 0000:00:02.0: [drm:intel_hpd_irq_handler [xe]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [423.546345] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] ignoring long hpd on eDP [ENCODER:207:DDI A/PHY A]
<7> [423.718601] xe 0000:00:02.0: [drm:wait_panel_status [xe]] Wait complete
<7> [423.720896] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 turning VDD on
<7> [423.721290] xe 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [xe]] [ENCODER:207:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [423.723682] 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> [423.725015] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [423.725921] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 05
<7> [423.727119] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [423.728297] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [423.729368] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Clock recovery OK
<7> [423.729754] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Using DP training pattern TPS4
<7> [423.731192] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [423.731539] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:208:eDP-1][ENCODER:207:DDI A/PHY A][DPRX] Link Training passed at link rate = 432000, lane count = 4
<7> [423.732415] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe A
<7> [423.732887] xe 0000:00:02.0: [drm:intel_edp_backlight_on [xe]]
<7> [423.733222] xe 0000:00:02.0: [drm:intel_backlight_enable [xe]] pipe A
<7> [423.733586] xe 0000:00:02.0: [drm:intel_backlight_set_pwm_level [xe]] [CONNECTOR:208:eDP-1] set backlight PWM = 4518
<7> [423.749780] xe 0000:00:02.0: [drm:intel_psr_post_plane_update [xe]] Enabling PSR2
<7> [423.751468] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:208:eDP-1]
<7> [423.751858] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:88:pipe A]
<7> [423.754068] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_C
<7> [423.754454] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [423.754858] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:204:pipe C]
<7> [423.755761] xe 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0
<6> [423.756716] [IGT] kms_flip: exiting, ret=98
Created at 2025-11-09 02:19:38