Results for igt@kms_flip@flip-vs-expired-vblank@d-hdmi-a3

Result: Fail

i915_display_info21 igt_runner21 results21.json results21-xe-load.json guc_logs21.tar i915_display_info_post_exec21 boot21 dmesg21

DetailValue
Duration 4.51 seconds
Hostname 
shard-bmg-7
Igt-Version 
IGT-Version: 2.3-g72b3f732c (x86_64) (Linux: 6.19.0-rc6-lgci-xe-xe-4442-ab42b1c3fe4ce1ae5+ x86_64)
Out 
Starting dynamic subtest: D-HDMI-A3
  1920x1080: 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9 
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 D-HDMI-A3: FAIL (4.510s)
Subtest flip-vs-expired-vblank: FAIL (32.596s)
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../lib/igt_kms.c:2388 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 dynamic subtest: D-HDMI-A3
(kms_flip:7935) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:928:
(kms_flip:7935) CRITICAL: Failed assertion: end - start < 500
Dynamic subtest D-HDMI-A3 failed.
**** DEBUG ****
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.043671
last_received_ts = 231.043365
last_seq = 789
current_ts = 231.060349
current_received_ts = 231.060043
current_seq = 790
count = 59
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.060349
last_received_ts = 231.060043
last_seq = 790
current_ts = 231.077011
current_received_ts = 231.076721
current_seq = 791
count = 60
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.077011
last_received_ts = 231.076721
last_seq = 791
current_ts = 231.093674
current_received_ts = 231.093262
current_seq = 792
count = 61
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.093674
last_received_ts = 231.093262
last_seq = 792
current_ts = 231.110352
current_received_ts = 231.110062
current_seq = 793
count = 62
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 37us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.110352
last_received_ts = 231.110062
last_seq = 793
current_ts = 231.127029
current_received_ts = 231.126724
current_seq = 794
count = 63
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.127029
last_received_ts = 231.126724
last_seq = 794
current_ts = 231.143692
current_received_ts = 231.143265
current_seq = 795
count = 64
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.143692
last_received_ts = 231.143265
last_seq = 795
current_ts = 231.160370
current_received_ts = 231.160049
current_seq = 796
count = 65
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.160370
last_received_ts = 231.160049
last_seq = 796
current_ts = 231.177032
current_received_ts = 231.176727
current_seq = 797
count = 66
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.177032
last_received_ts = 231.176727
last_seq = 797
current_ts = 231.193710
current_received_ts = 231.193390
current_seq = 798
count = 67
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.193710
last_received_ts = 231.193390
last_seq = 798
current_ts = 231.210373
current_received_ts = 231.210068
current_seq = 799
count = 68
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 26us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.210373
last_received_ts = 231.210068
last_seq = 799
current_ts = 231.227036
current_received_ts = 231.226746
current_seq = 800
count = 69
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.227036
last_received_ts = 231.226746
last_seq = 800
current_ts = 231.243713
current_received_ts = 231.243408
current_seq = 801
count = 70
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.243713
last_received_ts = 231.243408
last_seq = 801
current_ts = 231.260391
current_received_ts = 231.260086
current_seq = 802
count = 71
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.260391
last_received_ts = 231.260086
last_seq = 802
current_ts = 231.277054
current_received_ts = 231.276764
current_seq = 803
count = 72
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.277054
last_received_ts = 231.276764
last_seq = 803
current_ts = 231.293716
current_received_ts = 231.293411
current_seq = 804
count = 73
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.293716
last_received_ts = 231.293411
last_seq = 804
current_ts = 231.310379
current_received_ts = 231.310089
current_seq = 805
count = 74
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 26us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.310379
last_received_ts = 231.310089
last_seq = 805
current_ts = 231.327042
current_received_ts = 231.326752
current_seq = 806
count = 75
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.327042
last_received_ts = 231.326752
last_seq = 806
current_ts = 231.343719
current_received_ts = 231.343430
current_seq = 807
count = 76
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.343719
last_received_ts = 231.343430
last_seq = 807
current_ts = 231.360397
current_received_ts = 231.360046
current_seq = 808
count = 77
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.360397
last_received_ts = 231.360046
last_seq = 808
current_ts = 231.377075
current_received_ts = 231.376770
current_seq = 809
count = 78
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.377075
last_received_ts = 231.376770
last_seq = 809
current_ts = 231.393723
current_received_ts = 231.393433
current_seq = 810
count = 79
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.393723
last_received_ts = 231.393433
last_seq = 810
current_ts = 231.410400
current_received_ts = 231.409988
current_seq = 811
count = 80
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 30us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.410400
last_received_ts = 231.409988
last_seq = 811
current_ts = 231.427078
current_received_ts = 231.426758
current_seq = 812
count = 81
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.427078
last_received_ts = 231.426758
last_seq = 812
current_ts = 231.443741
current_received_ts = 231.443451
current_seq = 813
count = 82
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.443741
last_received_ts = 231.443451
last_seq = 813
current_ts = 231.460403
current_received_ts = 231.459991
current_seq = 814
count = 83
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 27us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.460403
last_received_ts = 231.459991
last_seq = 814
current_ts = 231.477081
current_received_ts = 231.476776
current_seq = 815
count = 84
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.477081
last_received_ts = 231.476776
last_seq = 815
current_ts = 231.493759
current_received_ts = 231.493362
current_seq = 816
count = 85
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.493759
last_received_ts = 231.493362
last_seq = 816
current_ts = 231.510422
current_received_ts = 231.510040
current_seq = 817
count = 86
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 30us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.510422
last_received_ts = 231.510040
last_seq = 817
current_ts = 231.527084
current_received_ts = 231.526672
current_seq = 818
count = 87
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.527084
last_received_ts = 231.526672
last_seq = 818
current_ts = 231.543747
current_received_ts = 231.543335
current_seq = 819
count = 88
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.543747
last_received_ts = 231.543335
last_seq = 819
current_ts = 231.560440
current_received_ts = 231.560120
current_seq = 820
count = 89
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.560440
last_received_ts = 231.560120
last_seq = 820
current_ts = 231.577087
current_received_ts = 231.576675
current_seq = 821
count = 90
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.577087
last_received_ts = 231.576675
last_seq = 821
current_ts = 231.593765
current_received_ts = 231.593475
current_seq = 822
count = 91
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.593765
last_received_ts = 231.593475
last_seq = 822
current_ts = 231.610443
current_received_ts = 231.610123
current_seq = 823
count = 92
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.610443
last_received_ts = 231.610123
last_seq = 823
current_ts = 231.627106
current_received_ts = 231.626694
current_seq = 824
count = 93
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.627106
last_received_ts = 231.626694
last_seq = 824
current_ts = 231.643784
current_received_ts = 231.643387
current_seq = 825
count = 94
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.643784
last_received_ts = 231.643387
last_seq = 825
current_ts = 231.660446
current_received_ts = 231.660080
current_seq = 826
count = 95
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.660446
last_received_ts = 231.660080
last_seq = 826
current_ts = 231.677109
current_received_ts = 231.676819
current_seq = 827
count = 96
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.677109
last_received_ts = 231.676819
last_seq = 827
current_ts = 231.693787
current_received_ts = 231.693405
current_seq = 828
count = 97
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.693787
last_received_ts = 231.693405
last_seq = 828
current_ts = 231.710464
current_received_ts = 231.710144
current_seq = 829
count = 98
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.710464
last_received_ts = 231.710144
last_seq = 829
current_ts = 231.727127
current_received_ts = 231.726700
current_seq = 830
count = 99
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.727127
last_received_ts = 231.726700
last_seq = 830
current_ts = 231.743805
current_received_ts = 231.743423
current_seq = 831
count = 100
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.743805
last_received_ts = 231.743423
last_seq = 831
current_ts = 231.760452
current_received_ts = 231.760178
current_seq = 832
count = 101
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.760452
last_received_ts = 231.760178
last_seq = 832
current_ts = 231.777145
current_received_ts = 231.776825
current_seq = 833
count = 102
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.777145
last_received_ts = 231.776825
last_seq = 833
current_ts = 231.793808
current_received_ts = 231.793427
current_seq = 834
count = 103
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 27us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.793808
last_received_ts = 231.793427
last_seq = 834
current_ts = 231.810471
current_received_ts = 231.810165
current_seq = 835
count = 104
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.810471
last_received_ts = 231.810165
last_seq = 835
current_ts = 231.827148
current_received_ts = 231.826752
current_seq = 836
count = 105
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.827148
last_received_ts = 231.826752
last_seq = 836
current_ts = 231.843811
current_received_ts = 231.843430
current_seq = 837
count = 106
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.843811
last_received_ts = 231.843430
last_seq = 837
current_ts = 231.860489
current_received_ts = 231.860123
current_seq = 838
count = 107
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 26us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.860489
last_received_ts = 231.860123
last_seq = 838
current_ts = 231.877136
current_received_ts = 231.876724
current_seq = 839
count = 108
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.877136
last_received_ts = 231.876724
last_seq = 839
current_ts = 231.893829
current_received_ts = 231.893433
current_seq = 840
count = 109
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.893829
last_received_ts = 231.893433
last_seq = 840
current_ts = 231.910492
current_received_ts = 231.910187
current_seq = 841
count = 110
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.910492
last_received_ts = 231.910187
last_seq = 841
current_ts = 231.927155
current_received_ts = 231.926865
current_seq = 842
count = 111
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.927155
last_received_ts = 231.926865
last_seq = 842
current_ts = 231.943832
current_received_ts = 231.943512
current_seq = 843
count = 112
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.943832
last_received_ts = 231.943512
last_seq = 843
current_ts = 231.960495
current_received_ts = 231.960068
current_seq = 844
count = 113
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.960495
last_received_ts = 231.960068
last_seq = 844
current_ts = 231.977158
current_received_ts = 231.976868
current_seq = 845
count = 114
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 26us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.977158
last_received_ts = 231.976868
last_seq = 845
current_ts = 231.993835
current_received_ts = 231.993454
current_seq = 846
count = 115
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 231.993835
last_received_ts = 231.993454
last_seq = 846
current_ts = 232.010498
current_received_ts = 232.010086
current_seq = 847
count = 116
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.010498
last_received_ts = 232.010086
last_seq = 847
current_ts = 232.027161
current_received_ts = 232.026749
current_seq = 848
count = 117
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.027161
last_received_ts = 232.026749
last_seq = 848
current_ts = 232.043839
current_received_ts = 232.043457
current_seq = 849
count = 118
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.043839
last_received_ts = 232.043457
last_seq = 849
current_ts = 232.060516
current_received_ts = 232.060135
current_seq = 850
count = 119
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.060516
last_received_ts = 232.060135
last_seq = 850
current_ts = 232.077179
current_received_ts = 232.076767
current_seq = 851
count = 120
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.077179
last_received_ts = 232.076767
last_seq = 851
current_ts = 232.093857
current_received_ts = 232.093430
current_seq = 852
count = 121
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.093857
last_received_ts = 232.093430
last_seq = 852
current_ts = 232.110519
current_received_ts = 232.110138
current_seq = 853
count = 122
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.110519
last_received_ts = 232.110138
last_seq = 853
current_ts = 232.127182
current_received_ts = 232.126770
current_seq = 854
count = 123
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.127182
last_received_ts = 232.126770
last_seq = 854
current_ts = 232.143860
current_received_ts = 232.143555
current_seq = 855
count = 124
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 26us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.143860
last_received_ts = 232.143555
last_seq = 855
current_ts = 232.160522
current_received_ts = 232.160110
current_seq = 856
count = 125
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.160522
last_received_ts = 232.160110
last_seq = 856
current_ts = 232.177200
current_received_ts = 232.176773
current_seq = 857
count = 126
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.177200
last_received_ts = 232.176773
last_seq = 857
current_ts = 232.193878
current_received_ts = 232.193558
current_seq = 858
count = 127
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.193878
last_received_ts = 232.193558
last_seq = 858
current_ts = 232.210541
current_received_ts = 232.210129
current_seq = 859
count = 128
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.210541
last_received_ts = 232.210129
last_seq = 859
current_ts = 232.227203
current_received_ts = 232.226898
current_seq = 860
count = 129
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.227203
last_received_ts = 232.226898
last_seq = 860
current_ts = 232.243881
current_received_ts = 232.243484
current_seq = 861
count = 130
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.243881
last_received_ts = 232.243484
last_seq = 861
current_ts = 232.260544
current_received_ts = 232.260162
current_seq = 862
count = 131
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 30us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.260544
last_received_ts = 232.260162
last_seq = 862
current_ts = 232.277222
current_received_ts = 232.276901
current_seq = 863
count = 132
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.277222
last_received_ts = 232.276901
last_seq = 863
current_ts = 232.293884
current_received_ts = 232.293503
current_seq = 864
count = 133
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.293884
last_received_ts = 232.293503
last_seq = 864
current_ts = 232.310562
current_received_ts = 232.310181
current_seq = 865
count = 134
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.310562
last_received_ts = 232.310181
last_seq = 865
current_ts = 232.327225
current_received_ts = 232.326843
current_seq = 866
count = 135
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.327225
last_received_ts = 232.326843
last_seq = 866
current_ts = 232.343887
current_received_ts = 232.343582
current_seq = 867
count = 136
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.343887
last_received_ts = 232.343582
last_seq = 867
current_ts = 232.360565
current_received_ts = 232.360153
current_seq = 868
count = 137
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 32us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.360565
last_received_ts = 232.360153
last_seq = 868
current_ts = 232.377228
current_received_ts = 232.376862
current_seq = 869
count = 138
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.377228
last_received_ts = 232.376862
last_seq = 869
current_ts = 232.393906
current_received_ts = 232.393524
current_seq = 870
count = 139
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.393906
last_received_ts = 232.393524
last_seq = 870
current_ts = 232.410568
current_received_ts = 232.410187
current_seq = 871
count = 140
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.410568
last_received_ts = 232.410187
last_seq = 871
current_ts = 232.427231
current_received_ts = 232.426865
current_seq = 872
count = 141
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.427231
last_received_ts = 232.426865
last_seq = 872
current_ts = 232.443909
current_received_ts = 232.443542
current_seq = 873
count = 142
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.443909
last_received_ts = 232.443542
last_seq = 873
current_ts = 232.460571
current_received_ts = 232.460175
current_seq = 874
count = 143
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 27us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.460571
last_received_ts = 232.460175
last_seq = 874
current_ts = 232.477249
current_received_ts = 232.476944
current_seq = 875
count = 144
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.477249
last_received_ts = 232.476944
last_seq = 875
current_ts = 232.493927
current_received_ts = 232.493530
current_seq = 876
count = 145
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.493927
last_received_ts = 232.493530
last_seq = 876
current_ts = 232.510590
current_received_ts = 232.510223
current_seq = 877
count = 146
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.510590
last_received_ts = 232.510223
last_seq = 877
current_ts = 232.527252
current_received_ts = 232.526871
current_seq = 878
count = 147
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.527252
last_received_ts = 232.526871
last_seq = 878
current_ts = 232.543930
current_received_ts = 232.543503
current_seq = 879
count = 148
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 227us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.543930
last_received_ts = 232.543503
last_seq = 879
current_ts = 232.560593
current_received_ts = 232.560242
current_seq = 880
count = 149
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 236us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.560593
last_received_ts = 232.560242
last_seq = 880
current_ts = 232.577255
current_received_ts = 232.576920
current_seq = 881
count = 150
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 242us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.577255
last_received_ts = 232.576920
last_seq = 881
current_ts = 232.593933
current_received_ts = 232.593567
current_seq = 882
count = 151
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 30us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.593933
last_received_ts = 232.593567
last_seq = 882
current_ts = 232.610611
current_received_ts = 232.610229
current_seq = 883
count = 152
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 30us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.610611
last_received_ts = 232.610229
last_seq = 883
current_ts = 232.627258
current_received_ts = 232.626831
current_seq = 884
count = 153
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.627258
last_received_ts = 232.626831
last_seq = 884
current_ts = 232.643936
current_received_ts = 232.643494
current_seq = 885
count = 154
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 30us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.643936
last_received_ts = 232.643494
last_seq = 885
current_ts = 232.660599
current_received_ts = 232.660172
current_seq = 886
count = 155
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 31us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.660599
last_received_ts = 232.660172
last_seq = 886
current_ts = 232.677277
current_received_ts = 232.676834
current_seq = 887
count = 156
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.677277
last_received_ts = 232.676834
last_seq = 887
current_ts = 232.693939
current_received_ts = 232.693497
current_seq = 888
count = 157
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.693939
last_received_ts = 232.693497
last_seq = 888
current_ts = 232.710617
current_received_ts = 232.710251
current_seq = 889
count = 158
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.710617
last_received_ts = 232.710251
last_seq = 889
current_ts = 232.727280
current_received_ts = 232.726913
current_seq = 890
count = 159
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.727280
last_received_ts = 232.726913
last_seq = 890
current_ts = 232.743958
current_received_ts = 232.743591
current_seq = 891
count = 160
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.743958
last_received_ts = 232.743591
last_seq = 891
current_ts = 232.760620
current_received_ts = 232.760269
current_seq = 892
count = 161
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.760620
last_received_ts = 232.760269
last_seq = 892
current_ts = 232.777283
current_received_ts = 232.776932
current_seq = 893
count = 162
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 30us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.777283
last_received_ts = 232.776932
last_seq = 893
current_ts = 232.793961
current_received_ts = 232.793610
current_seq = 894
count = 163
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 30us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.793961
last_received_ts = 232.793610
last_seq = 894
current_ts = 232.810638
current_received_ts = 232.810257
current_seq = 895
count = 164
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 30us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.810638
last_received_ts = 232.810257
last_seq = 895
current_ts = 232.827301
current_received_ts = 232.826935
current_seq = 896
count = 165
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.827301
last_received_ts = 232.826935
last_seq = 896
current_ts = 232.843964
current_received_ts = 232.843597
current_seq = 897
count = 166
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 30us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.843964
last_received_ts = 232.843597
last_seq = 897
current_ts = 232.860641
current_received_ts = 232.860168
current_seq = 898
count = 167
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.860641
last_received_ts = 232.860168
last_seq = 898
current_ts = 232.877319
current_received_ts = 232.876938
current_seq = 899
count = 168
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.877319
last_received_ts = 232.876938
last_seq = 899
current_ts = 232.893982
current_received_ts = 232.893539
current_seq = 900
count = 169
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.893982
last_received_ts = 232.893539
last_seq = 900
current_ts = 232.910645
current_received_ts = 232.910202
current_seq = 901
count = 170
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.910645
last_received_ts = 232.910202
last_seq = 901
current_ts = 232.927307
current_received_ts = 232.926941
current_seq = 902
count = 171
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.927307
last_received_ts = 232.926941
last_seq = 902
current_ts = 232.943985
current_received_ts = 232.943542
current_seq = 903
count = 172
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.943985
last_received_ts = 232.943542
last_seq = 903
current_ts = 232.960648
current_received_ts = 232.960205
current_seq = 904
count = 173
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.960648
last_received_ts = 232.960205
last_seq = 904
current_ts = 232.977325
current_received_ts = 232.976959
current_seq = 905
count = 174
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.977325
last_received_ts = 232.976959
last_seq = 905
current_ts = 232.993988
current_received_ts = 232.993546
current_seq = 906
count = 175
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 232.993988
last_received_ts = 232.993546
last_seq = 906
current_ts = 233.010651
current_received_ts = 233.010223
current_seq = 907
count = 176
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 233.010651
last_received_ts = 233.010223
last_seq = 907
current_ts = 233.027328
current_received_ts = 233.026840
current_seq = 908
count = 177
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 233.027328
last_received_ts = 233.026840
last_seq = 908
current_ts = 233.043991
current_received_ts = 233.043625
current_seq = 909
count = 178
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 29us
(kms_flip:7935) DEBUG: name = flip
last_ts = 233.043991
last_received_ts = 233.043625
last_seq = 909
current_ts = 233.060669
current_received_ts = 233.060242
current_seq = 910
count = 179
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 28us
(kms_flip:7935) DEBUG: name = flip
last_ts = 233.060669
last_received_ts = 233.060242
last_seq = 910
current_ts = 233.077332
current_received_ts = 233.076965
current_seq = 911
count = 180
seq_step = 1
(kms_flip:7935) DEBUG: Vblank took 719us
(kms_flip:7935) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:928:
(kms_flip:7935) CRITICAL: Failed assertion: end - start < 500
(kms_flip:7935) igt_core-INFO: Stack trace:
(kms_flip:7935) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(kms_flip:7935) igt_core-INFO:   #1 ../tests/kms_flip.c:923 run_test_on_crtc_set.constprop.0()
(kms_flip:7935) igt_core-INFO:   #2 ../tests/kms_flip.c:1889 run_test()
(kms_flip:7935) igt_core-INFO:   #3 ../tests/kms_flip.c:2122 __igt_unique____real_main2045()
(kms_flip:7935) igt_core-INFO:   #4 ../tests/kms_flip.c:2045 main()
(kms_flip:7935) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:7935) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:7935) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest D-HDMI-A3: FAIL (4.510s)
Subtest flip-vs-expired-vblank: FAIL (32.596s)
(kms_flip:7935) igt_kms-CRITICAL: Test assertion failure function kmstest_set_connector_dpms, file ../lib/igt_kms.c:2388:
(kms_flip:7935) igt_kms-CRITICAL: Failed assertion: found_it
(kms_flip:7935) igt_kms-CRITICAL: Last errno: 9, Bad file descriptor
(kms_flip:7935) igt_kms-CRITICAL: DPMS property not found on 537
Dmesg
<6> [229.782119] [IGT] kms_flip: starting dynamic subtest D-HDMI-A3
<7> [229.785152] xe 0000:03:00.0: [drm:drm_mode_addfb2] [FB:554]
<7> [229.787390] xe 0000:03:00.0: [drm:drm_mode_addfb2] [FB:556]
<7> [229.860750] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:149:pipe A]
<7> [229.861742] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:267:pipe B]
<7> [229.862034] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:385:pipe C]
<7> [229.862197] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.enable (expected yes, found no)
<7> [229.862628] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.active (expected yes, found no)
<7> [229.862965] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in cpu_transcoder (expected 2, found -1)
<7> [229.863270] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in lane_count (expected 4, found 0)
<7> [229.863565] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [229.863857] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [229.864122] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [229.864416] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [229.864685] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [229.864944] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [229.865189] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [229.865466] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [229.865707] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [229.865929] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [229.866151] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [229.866379] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [229.866588] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [229.866791] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [229.866990] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [229.867185] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [229.867351] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [229.867436] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [229.867521] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [229.867605] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [229.867690] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [229.867775] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [229.867861] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [229.867945] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [229.868028] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [229.868113] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [229.868197] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [229.868289] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [229.868374] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [229.868459] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [229.868543] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [229.868629] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [229.868712] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [229.868799] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [229.868884] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in port_clock (expected 222750, found 0)
<7> [229.868968] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [229.869053] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [229.869137] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in avi infoframe
<7> [229.869221] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [229.869319] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [229.869321] xe 0000:03:00.0: colorspace: RGB
<7> [229.869322] xe 0000:03:00.0: scan mode: Underscan
<7> [229.869323] xe 0000:03:00.0: colorimetry: No Data
<7> [229.869325] xe 0000:03:00.0: picture aspect: No Data
<7> [229.869326] xe 0000:03:00.0: active aspect: Same as Picture
<7> [229.869327] xe 0000:03:00.0: itc: No Data
<7> [229.869328] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [229.869330] xe 0000:03:00.0: quantization range: Full
<7> [229.869331] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [229.869332] xe 0000:03:00.0: video code: 0
<7> [229.869333] xe 0000:03:00.0: ycc quantization range: Full
<7> [229.869334] xe 0000:03:00.0: hdmi content type: Graphics
<7> [229.869335] xe 0000:03:00.0: pixel repeat: 0
<7> [229.869336] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [229.869337] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [229.869422] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in spd infoframe
<7> [229.869506] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [229.869590] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [229.869592] xe 0000:03:00.0: vendor: Intel
<7> [229.869593] xe 0000:03:00.0: product: Discrete gfx
<7> [229.869594] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [229.869595] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [229.869680] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:385:pipe C] fastset requirement not met in hdmi infoframe
<7> [229.869763] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [229.869846] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [229.869848] xe 0000:03:00.0: empty frame
<7> [229.869849] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [229.869933] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:385:pipe C] fastset requirement not met, forcing full modeset
<7> [229.870019] xe 0000:03:00.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:385:pipe C] releasing TC PLL 3
<7> [229.870120] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xd -> 0x1 (total dbuf slices 0xf), mbus joined? no->no
<7> [229.870197] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:385:pipe C] dbuf slices 0xc -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x4 -> 0x0
<7> [229.870302] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:379:cursor C] ddb (1989 - 2048) -> ( 0 - 0), size 59 -> 0
<7> [229.870397] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:385:pipe C] min cdclk: 192000 kHz -> 0 kHz
<7> [229.870506] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:385:pipe C] enable: no [modeset]
<7> [229.870600] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:269:plane 1C] fb: [NOFB], visible: no
<7> [229.870692] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:299:plane 2C] fb: [NOFB], visible: no
<7> [229.870782] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:329:plane 3C] fb: [NOFB], visible: no
<7> [229.870870] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:359:plane 4C] fb: [NOFB], visible: no
<7> [229.870957] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:369:plane 5C] fb: [NOFB], visible: no
<7> [229.871043] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:379:cursor C] fb: [NOFB], visible: no
<7> [229.871706] xe 0000:03:00.0: [drm:intel_audio_codec_disable [xe]] [CONNECTOR:537:HDMI-A-3][ENCODER:536:DDI TC3/PHY H] Disable audio codec on [CRTC:385:pipe C]
<7> [229.893325] xe 0000:03:00.0: [drm:intel_audio_component_get_eld [xe]] Not valid for port F
<7> [229.893869] xe 0000:03:00.0: [drm:intel_disable_transcoder [xe]] disabling pipe C
<7> [229.915333] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disable TC PLL 3 (active 0x4, on? 1) for [CRTC:385:pipe C]
<7> [229.917541] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disabling TC PLL 3
<7> [229.917514] xe 0000:03:00.0: [drm:intel_audio_component_get_power [xe]] restored AUD_FREQ_CNTRL to 0x8010
<7> [229.918371] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:505:DDI TC1/PHY F]
<7> [229.918849] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:507:DP-MST A]
<7> [229.919331] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:508:DP-MST B]
<7> [229.919781] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST C]
<7> [229.920247] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST D]
<7> [229.920694] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:524:DDI TC2/PHY G]
<7> [229.921144] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:526:DP-MST A]
<7> [229.921635] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:527:DP-MST B]
<7> [229.922085] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST C]
<7> [229.922552] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST D]
<7> [229.922981] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:536:DDI TC3/PHY H]
<7> [229.923648] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:540:DDI TC4/PHY I]
<7> [229.924027] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:542:DP-MST A]
<7> [229.924423] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:543:DP-MST B]
<7> [229.924800] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST C]
<7> [229.925142] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST D]
<7> [229.925504] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:537:HDMI-A-3]
<7> [229.926089] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [229.926638] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [229.927267] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling PW_C
<7> [229.927856] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:385:pipe C]
<7> [229.928586] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:503:pipe D]
<7> [229.929249] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:503:pipe D]
<7> [229.929300] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CONNECTOR:537:HDMI-A-3]
<7> [229.929435] xe 0000:03:00.0: [drm:intel_hdmi_compute_clock [xe]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [229.929707] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:503:pipe D] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [229.929964] xe 0000:03:00.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:536:DDI TC3/PHY H] [CRTC:503:pipe D]
<7> [229.930210] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.enable (expected no, found yes)
<7> [229.930468] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.active (expected no, found yes)
<7> [229.930694] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in cpu_transcoder (expected -1, found 3)
<7> [229.930915] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in lane_count (expected 0, found 4)
<7> [229.931122] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [229.931340] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [229.931528] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [229.931715] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [229.931902] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [229.932078] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [229.932150] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [229.932257] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [229.932428] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [229.932592] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [229.932752] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [229.932910] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [229.933061] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [229.933206] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [229.933367] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [229.933508] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [229.933646] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [229.933784] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [229.933911] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [229.934038] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [229.934161] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [229.934291] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [229.934411] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [229.934532] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [229.934651] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [229.934766] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [229.934875] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [229.934982] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [229.935088] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [229.935194] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [229.935308] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [229.935409] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [229.935508] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in dpll_hw_state
<7> [229.935603] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [229.935698] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [229.935793] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] c20pll_hw_state:
<7> [229.935888] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] tx[0] = 0xbe88, tx[1] = 0x4800, tx[2] = 0x0000
<7> [229.935977] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [229.936066] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[0] = 0x308c
<7> [229.936155] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[1] = 0x2110
<7> [229.936248] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[2] = 0xcc9c
<7> [229.936339] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[3] = 0xbfc1
<7> [229.936427] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[4] = 0x4b9a
<7> [229.936517] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[5] = 0x3f81
<7> [229.936606] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[6] = 0x2000
<7> [229.936695] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[7] = 0x0001
<7> [229.936783] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[8] = 0x5000
<7> [229.936871] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[9] = 0x0000
<7> [229.936959] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[10] = 0x0000
<7> [229.937047] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] vdr: custom width: 0x00, serdes rate: 0x42, hdmi rate: 0x00
<7> [229.937137] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [229.937229] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [229.937319] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] c20pll_hw_state:
<7> [229.937407] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] tx[0] = 0xbe88, tx[1] = 0x5800, tx[2] = 0x0000
<7> [229.937495] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [229.937582] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[0] = 0x40e8
<7> [229.937670] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[1] = 0x7d20
<7> [229.937759] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[2] = 0x0a06
<7> [229.937849] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[3] = 0x8f1c
<7> [229.937938] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[4] = 0x0000
<7> [229.938025] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[5] = 0x0000
<7> [229.938113] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[6] = 0x2200
<7> [229.938201] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[7] = 0xffff
<7> [229.938299] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[8] = 0x0400
<7> [229.938388] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[9] = 0x0000
<7> [229.938475] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[10] = 0x0001
<7> [229.938565] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] vdr: custom width: 0x00, serdes rate: 0x00, hdmi rate: 0x00
<7> [229.938655] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [229.938749] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [229.938841] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [229.938930] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in port_clock (expected 0, found 222750)
<7> [229.939020] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [229.939110] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)
<7> [229.939199] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in avi infoframe
<7> [229.939297] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [229.939387] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [229.939473] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [229.939475] xe 0000:03:00.0: colorspace: RGB
<7> [229.939476] xe 0000:03:00.0: scan mode: Underscan
<7> [229.939477] xe 0000:03:00.0: colorimetry: No Data
<7> [229.939478] xe 0000:03:00.0: picture aspect: No Data
<7> [229.939479] xe 0000:03:00.0: active aspect: Same as Picture
<7> [229.939481] xe 0000:03:00.0: itc: No Data
<7> [229.939482] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [229.939483] xe 0000:03:00.0: quantization range: Full
<7> [229.939484] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [229.939485] xe 0000:03:00.0: video code: 0
<7> [229.939486] xe 0000:03:00.0: ycc quantization range: Full
<7> [229.939487] xe 0000:03:00.0: hdmi content type: Graphics
<7> [229.939488] xe 0000:03:00.0: pixel repeat: 0
<7> [229.939489] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [229.939490] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in spd infoframe
<7> [229.939579] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [229.939666] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [229.939754] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [229.939755] xe 0000:03:00.0: vendor: Intel
<7> [229.939756] xe 0000:03:00.0: product: Discrete gfx
<7> [229.939757] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [229.939759] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hdmi infoframe
<7> [229.939846] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [229.939933] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [229.940019] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [229.940020] xe 0000:03:00.0: empty frame
<7> [229.940022] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:503:pipe D] fastset requirement not met, forcing full modeset
<7> [229.940127] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0xf), mbus joined? no->no
<7> [229.940210] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:503:pipe D] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x8
<7> [229.940320] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:387:plane 1D] ddb ( 0 - 0) -> ( 0 - 1989), size 0 -> 1989
<7> [229.940397] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:497:cursor D] ddb ( 0 - 0) -> (1989 - 2048), size 0 -> 59
<7> [229.940470] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:387:plane 1D] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm
<7> [229.940541] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:387:plane 1D] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 4, 9, 9, 17, 17, 17, 17, 0, 15, 0
<7> [229.940611] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:387:plane 1D] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 62, 62, 139, 139, 261, 261, 261, 261, 137, 230, 244
<7> [229.940680] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:387:plane 1D] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 123, 123, 245, 245, 367, 367, 0, 0, 138, 306, 306
<7> [229.940759] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:503:pipe D] data rate 594000 num active planes 1
<7> [229.940859] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 624 qgv_peak_bw: 48000
<7> [229.940957] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 624 qgv_peak_bw: 48000
<7> [229.941052] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 624
<7> [229.941155] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:503:pipe D] min cdclk: 0 kHz -> 192000 kHz
<7> [229.941280] xe 0000:03:00.0: [drm:intel_find_dpll [xe]] [CRTC:503:pipe D] allocated TC PLL 3
<7> [229.941374] xe 0000:03:00.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:503:pipe D] reserving TC PLL 3
<7> [229.941467] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:503:pipe D] enable: yes [modeset]
<7> [229.941568] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [229.941665] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: D, pipe bpp: 36, dithering: 0
<7> [229.941760] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [229.941854] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [229.941948] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [229.942041] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [229.942134] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [229.942229] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] GCP: 0x6
<7> [229.942321] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [229.942322] xe 0000:03:00.0: colorspace: RGB
<7> [229.942323] xe 0000:03:00.0: scan mode: Underscan
<7> [229.942325] xe 0000:03:00.0: colorimetry: No Data
<7> [229.942326] xe 0000:03:00.0: picture aspect: No Data
<7> [229.942327] xe 0000:03:00.0: active aspect: Same as Picture
<7> [229.942328] xe 0000:03:00.0: itc: No Data
<7> [229.942329] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [229.942330] xe 0000:03:00.0: quantization range: Full
<7> [229.942331] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [229.942332] xe 0000:03:00.0: video code: 0
<7> [229.942333] xe 0000:03:00.0: ycc quantization range: Full
<7> [229.942334] xe 0000:03:00.0: hdmi content type: Graphics
<7> [229.942335] xe 0000:03:00.0: pixel repeat: 0
<7> [229.942336] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [229.942337] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [229.942339] xe 0000:03:00.0: vendor: Intel
<7> [229.942340] xe 0000:03:00.0: product: Discrete gfx
<7> [229.942341] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [229.942342] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [229.942343] xe 0000:03:00.0: empty frame
<7> [229.942344] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 10 00 07 00 66 10 00 01 00 00 00 00 00 00 00 00
<7> [229.942436] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 05 e3 cd 0c 32 38 45 38 35 30 09 07 07 00 00 00
<7> [229.942526] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [229.942617] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [229.942708] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 0, guardband: 45 vsync start: 42, vsync end: 37
<7> [229.942799] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1080, vmax vblank: 1080, vmin vtotal: 1125, vmax vtotal: 1125
<7> [229.942890] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [229.942980] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [229.943071] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [229.943161] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9
<7> [229.943260] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x40 0x9
<7> [229.943352] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9
<7> [229.943444] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port clock: 222750, pipe src: 1920x1080+0+0, pixel rate 148500, min cdclk 192000
<7> [229.943535] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] linetime: 119, ips linetime: 0
<7> [229.943624] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [229.943714] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [229.943803] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [229.943894] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [229.943988] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] c20pll_hw_state:
<7> [229.944080] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] tx[0] = 0xbe88, tx[1] = 0x5800, tx[2] = 0x0000
<7> [229.944172] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [229.944271] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[0] = 0x40e8
<7> [229.944361] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[1] = 0x7d20
<7> [229.944452] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[2] = 0x0a06
<7> [229.944543] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[3] = 0x8f1c
<7> [229.944634] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[4] = 0x0000
<7> [229.944723] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[5] = 0x0000
<7> [229.944814] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[6] = 0x2200
<7> [229.944903] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[7] = 0xffff
<7> [229.944993] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[8] = 0x0400
<7> [229.945083] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[9] = 0x0000
<7> [229.945172] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[10] = 0x0001
<7> [229.945268] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vdr: custom width: 0x00, serdes rate: 0x00, hdmi rate: 0x00
<7> [229.945357] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [229.945446] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [229.945534] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [229.945623] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [229.945710] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [229.945798] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [229.945885] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [229.945974] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [229.946062] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [229.946151] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [229.946249] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [229.946264] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [229.946372] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [229.946480] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [229.946575] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:387:plane 1D] fb: [FB:554] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [229.946574] xe 0000:03:00.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [229.946666] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [229.946671] xe 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [229.946754] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [229.946781] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling always-on
<7> [229.946844] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:417:plane 2D] fb: [NOFB], visible: no
<7> [229.946932] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:447:plane 3D] fb: [NOFB], visible: no
<7> [229.947021] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:477:plane 4D] fb: [NOFB], visible: no
<7> [229.947112] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:487:plane 5D] fb: [NOFB], visible: no
<7> [229.947201] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:497:cursor D] fb: [NOFB], visible: no
<7> [229.947808] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling always-on
<7> [229.947909] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [229.948141] xe 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [229.948271] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [229.948398] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_D
<7> [229.948561] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:505:DDI TC1/PHY F]
<7> [229.948646] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:507:DP-MST A]
<7> [229.948727] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:508:DP-MST B]
<7> [229.948805] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST C]
<7> [229.948881] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST D]
<7> [229.948956] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:524:DDI TC2/PHY G]
<7> [229.949032] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:526:DP-MST A]
<7> [229.949107] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:527:DP-MST B]
<7> [229.949181] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST C]
<7> [229.949292] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST D]
<7> [229.949373] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:536:DDI TC3/PHY H]
<7> [229.949452] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:540:DDI TC4/PHY I]
<7> [229.949526] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:542:DP-MST A]
<7> [229.949599] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:543:DP-MST B]
<7> [229.949672] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST C]
<7> [229.949743] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST D]
<7> [229.949823] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x3
<7> [229.949982] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [229.950077] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enable TC PLL 3 (active 0x8, on? 0) for [CRTC:503:pipe D]
<7> [229.950166] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enabling TC PLL 3
<7> [229.952387] xe 0000:03:00.0: [drm:intel_enable_transcoder [xe]] enabling pipe D
<7> [229.970661] xe 0000:03:00.0: [drm:intel_audio_codec_enable [xe]] [CONNECTOR:537:HDMI-A-3][ENCODER:536:DDI TC3/PHY H] Enable audio codec on [CRTC:503:pipe D], 32 bytes ELD
<7> [229.982594] xe 0000:03:00.0: [drm:intel_audio_component_get_power [xe]] restored AUD_FREQ_CNTRL to 0x8010
<7> [229.987291] xe 0000:03:00.0: [drm:audio_config_hdmi_pixel_clock [xe]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [229.987459] xe 0000:03:00.0: [drm:hsw_audio_config_update [xe]] using automatic N
<7> [229.987972] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:537:HDMI-A-3]
<7> [229.988411] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:503:pipe D]
<6> [234.293777] [IGT] kms_flip: finished subtest D-HDMI-A3, FAIL
<6> [234.296595] [IGT] kms_flip: finished subtest flip-vs-expired-vblank, FAIL
<7> [234.305977] xe 0000:03:00.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:554] from all active usage due to RMFB ioctl
<7> [234.306688] xe 0000:03:00.0: [drm:atomic_remove_fb] Disabling [PLANE:387:plane 1D] because [FB:554] is removed
<7> [234.306831] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:387:plane 1D] ddb ( 0 - 1989) -> ( 0 - 0), size 1989 -> 0
<7> [234.307130] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:387:plane 1D] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [234.307375] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:387:plane 1D] lines 4, 4, 9, 9, 17, 17, 17, 17, 0, 15, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [234.307596] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:387:plane 1D] blocks 62, 62, 139, 139, 261, 261, 261, 261, 137, 230, 244 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [234.307866] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:387:plane 1D] min_ddb 123, 123, 245, 245, 367, 367, 0, 0, 138, 306, 306 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [234.308148] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:503:pipe D] data rate 0 num active planes 0
<7> [234.308416] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 0 qgv_peak_bw: 48000
<7> [234.308678] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 0 qgv_peak_bw: 48000
<7> [234.308959] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 0
<7> [234.322096] xe 0000:03:00.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:524:DDI TC2/PHY G][CRTC:149:pipe A] DP link limits: pixel clock 148500 kHz DSC off max lanes 4 max rate 540000 max pipe_bpp 36 min link_bpp 18.0000 max link_bpp 36.0000
<7> [234.322265] xe 0000:03:00.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 270000 bpp input 36 compressed 0.0000 link rate required 668250 available 1080000
<7> [234.322414] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:149:pipe A] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [234.322577] xe 0000:03:00.0: [drm:intel_hdmi_compute_clock [xe]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [234.322735] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:267:pipe B] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [234.322875] xe 0000:03:00.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:524:DDI TC2/PHY G] [CRTC:149:pipe A]
<7> [234.323006] xe 0000:03:00.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:536:DDI TC3/PHY H] [CRTC:267:pipe B]
<7> [234.323128] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [234.323249] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [234.323366] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [234.323481] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [234.323596] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 5190451/8388608 link 288358/524288)
<7> [234.323718] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000080)
<7> [234.323828] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [234.323933] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [234.324036] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [234.324139] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [234.324239] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [234.324338] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [234.324437] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [234.324532] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [234.324627] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [234.324730] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [234.324826] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [234.324920] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [234.325012] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [234.325103] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [234.325188] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [234.325273] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [234.325357] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [234.325438] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [234.325520] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [234.325602] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [234.325685] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [234.325783] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [234.325866] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [234.325946] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [234.326036] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [234.326116] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [234.326194] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [234.326272] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [234.326350] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in enhanced_framing (expected no, found yes)
<7> [234.326428] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in dpll_hw_state
<7> [234.326507] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [234.326586] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [234.326664] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] c20pll_hw_state:
<7> [234.326756] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] tx[0] = 0xbe88, tx[1] = 0x5800, tx[2] = 0x0000
<7> [234.326840] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [234.326922] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[0] = 0x40e8
<7> [234.327001] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[1] = 0x7d20
<7> [234.327080] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[2] = 0x0a06
<7> [234.327158] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[3] = 0x8f1c
<7> [234.327236] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[4] = 0x0000
<7> [234.327313] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[5] = 0x0000
<7> [234.327391] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[6] = 0x2200
<7> [234.327468] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[7] = 0xffff
<7> [234.327545] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[8] = 0x0400
<7> [234.327621] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[9] = 0x0000
<7> [234.327704] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[10] = 0x0001
<7> [234.327835] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] vdr: custom width: 0x00, serdes rate: 0x00, hdmi rate: 0x00
<7> [234.327913] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [234.327990] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [234.328070] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] c20pll_hw_state:
<7> [234.328148] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] tx[0] = 0xbe88, tx[1] = 0x4800, tx[2] = 0x0000
<7> [234.328227] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [234.328307] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[0] = 0x308c
<7> [234.328385] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[1] = 0x2110
<7> [234.328463] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[2] = 0xcc9c
<7> [234.328540] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[3] = 0xbfc1
<7> [234.328617] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[4] = 0x4b9a
<7> [234.328696] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[5] = 0x3f81
<7> [234.328797] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[6] = 0x2000
<7> [234.328878] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[7] = 0x0001
<7> [234.328957] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[8] = 0x5000
<7> [234.329035] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[9] = 0x0000
<7> [234.329115] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[10] = 0x0000
<7> [234.329196] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] vdr: custom width: 0x00, serdes rate: 0x42, hdmi rate: 0x00
<7> [234.329282] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [234.329365] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [234.329446] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [234.329525] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:149:pipe A] fastset requirement not met in port_clock (expected 0, found 270000)
<7> [234.329604] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:149:pipe A] fastset requirement not met, forcing full modeset
<7> [234.329683] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [234.329780] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [234.329862] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [234.329941] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [234.330019] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [234.330096] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [234.330173] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [234.330250] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [234.330329] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [234.330405] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [234.330483] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [234.330561] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [234.330639] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [234.330726] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [234.330812] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [234.330890] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [234.330966] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [234.331041] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [234.331117] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [234.331194] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [234.331271] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [234.331348] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [234.331425] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [234.331502] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [234.331581] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [234.331659] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [234.331749] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [234.331834] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [234.331910] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [234.331987] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [234.332065] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [234.332144] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [234.332222] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [234.332300] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [234.332380] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [234.332459] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [234.332537] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [234.332613] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [234.332690] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in port_clock (expected 0, found 222750)
<7> [234.332786] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [234.332869] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)
<7> [234.332947] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in avi infoframe
<7> [234.333025] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [234.333101] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [234.333179] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [234.333180] xe 0000:03:00.0: colorspace: RGB
<7> [234.333182] xe 0000:03:00.0: scan mode: Underscan
<7> [234.333183] xe 0000:03:00.0: colorimetry: No Data
<7> [234.333184] xe 0000:03:00.0: picture aspect: No Data
<7> [234.333185] xe 0000:03:00.0: active aspect: Same as Picture
<7> [234.333186] xe 0000:03:00.0: itc: No Data
<7> [234.333187] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [234.333188] xe 0000:03:00.0: quantization range: Full
<7> [234.333189] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [234.333191] xe 0000:03:00.0: video code: 0
<7> [234.333192] xe 0000:03:00.0: ycc quantization range: Full
<7> [234.333193] xe 0000:03:00.0: hdmi content type: Graphics
<7> [234.333194] xe 0000:03:00.0: pixel repeat: 0
<7> [234.333195] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [234.333197] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in spd infoframe
<7> [234.333275] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [234.333352] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [234.333429] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [234.333430] xe 0000:03:00.0: vendor: Intel
<7> [234.333431] xe 0000:03:00.0: product: Discrete gfx
<7> [234.333432] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [234.333434] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:267:pipe B] fastset requirement not met in hdmi infoframe
<7> [234.333511] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [234.333589] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [234.333666] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [234.333668] xe 0000:03:00.0: empty frame
<7> [234.333669] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:267:pipe B] fastset requirement not met, forcing full modeset
<7> [234.333760] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.enable (expected yes, found no)
<7> [234.333845] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.active (expected yes, found no)
<7> [234.333922] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in cpu_transcoder (expected 3, found -1)
<7> [234.333999] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in lane_count (expected 4, found 0)
<7> [234.334075] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [234.334151] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [234.334229] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [234.334306] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [234.334382] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [234.334459] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [234.334536] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [234.334614] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [234.334691] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [234.334791] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [234.334875] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [234.334957] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [234.335034] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [234.335112] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [234.335191] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [234.335269] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [234.335346] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [234.335425] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [234.335502] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [234.335579] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [234.335657] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [234.335794] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [234.335894] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [234.335971] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [234.336049] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [234.336128] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [234.336206] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [234.336286] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [234.336365] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [234.336443] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [234.336522] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [234.336599] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [234.336677] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [234.336787] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [234.336869] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in port_clock (expected 222750, found 0)
<7> [234.336946] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [234.337023] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [234.337101] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in avi infoframe
<7> [234.337180] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [234.337258] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [234.337260] xe 0000:03:00.0: colorspace: RGB
<7> [234.337261] xe 0000:03:00.0: scan mode: Underscan
<7> [234.337262] xe 0000:03:00.0: colorimetry: No Data
<7> [234.337264] xe 0000:03:00.0: picture aspect: No Data
<7> [234.337265] xe 0000:03:00.0: active aspect: Same as Picture
<7> [234.337266] xe 0000:03:00.0: itc: No Data
<7> [234.337267] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [234.337268] xe 0000:03:00.0: quantization range: Full
<7> [234.337269] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [234.337270] xe 0000:03:00.0: video code: 0
<7> [234.337271] xe 0000:03:00.0: ycc quantization range: Full
<7> [234.337272] xe 0000:03:00.0: hdmi content type: Graphics
<7> [234.337273] xe 0000:03:00.0: pixel repeat: 0
<7> [234.337274] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [234.337276] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [234.337353] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in spd infoframe
<7> [234.337432] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [234.337511] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [234.337512] xe 0000:03:00.0: vendor: Intel
<7> [234.337513] xe 0000:03:00.0: product: Discrete gfx
<7> [234.337515] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [234.337516] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [234.337595] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:503:pipe D] fastset requirement not met in hdmi infoframe
<7> [234.337672] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [234.337764] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [234.337765] xe 0000:03:00.0: empty frame
<7> [234.337767] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [234.337848] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:503:pipe D] fastset requirement not met, forcing full modeset
<7> [234.337927] xe 0000:03:00.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:503:pipe D] releasing TC PLL 3
<7> [234.338036] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x3 -> 0xf (total dbuf slices 0xf), mbus joined? no->no
<7> [234.338107] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:149:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x8 -> 0x3
<7> [234.338178] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:267:pipe B] dbuf slices 0x0 -> 0xc, ddb (0 - 0) -> (0 - 2048), active pipes 0x8 -> 0x3
<7> [234.338245] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:503:pipe D] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x8 -> 0x3
<7> [234.338312] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:33:plane 1A] ddb ( 0 - 0) -> ( 0 - 1989), size 0 -> 1989
<7> [234.338375] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:143:cursor A] ddb ( 0 - 0) -> (1989 - 2048), size 0 -> 59
<7> [234.338437] xe 0000:03:00.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> [234.338497] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 3, 9, 9, 17, 17, 17, 17, 0, 15, 0
<7> [234.338558] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 49, 145, 145, 273, 273, 273, 273, 30, 241, 255
<7> [234.338618] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:33:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 55, 161, 161, 302, 302, 0, 0, 31, 267, 267
<7> [234.338682] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:151:plane 1B] ddb ( 0 - 0) -> ( 0 - 1989), size 0 -> 1989
<7> [234.338764] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:261:cursor B] ddb ( 0 - 0) -> (1989 - 2048), size 0 -> 59
<7> [234.338829] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:151: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> [234.338893] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:151:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 3, 9, 9, 17, 17, 17, 17, 0, 15, 0
<7> [234.338953] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:151:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 49, 145, 145, 273, 273, 273, 273, 30, 241, 255
<7> [234.339012] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:151:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 55, 161, 161, 302, 302, 0, 0, 31, 267, 267
<7> [234.339071] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:497:cursor D] ddb (1989 - 2048) -> ( 0 - 0), size 59 -> 0
<7> [234.339140] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:149:pipe A] data rate 594000 num active planes 1
<7> [234.339227] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:267:pipe B] data rate 594000 num active planes 1
<7> [234.339311] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 1248 qgv_peak_bw: 48000
<7> [234.339393] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 1248 qgv_peak_bw: 48000
<7> [234.339474] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 1248
<7> [234.339562] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:149:pipe A] min cdclk: 0 kHz -> 192000 kHz
<7> [234.339646] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:267:pipe B] min cdclk: 0 kHz -> 192000 kHz
<7> [234.339750] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:503:pipe D] min cdclk: 192000 kHz -> 0 kHz
<7> [234.339855] xe 0000:03:00.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 9282 kHz -> 18563 kHz
<7> [234.339947] xe 0000:03:00.0: [drm:intel_find_dpll [xe]] [CRTC:149:pipe A] allocated TC PLL 2
<7> [234.340030] xe 0000:03:00.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:149:pipe A] reserving TC PLL 2
<7> [234.340114] xe 0000:03:00.0: [drm:intel_find_dpll [xe]] [CRTC:267:pipe B] allocated TC PLL 3
<7> [234.340194] xe 0000:03:00.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:267:pipe B] reserving TC PLL 3
<7> [234.340275] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:149:pipe A] enable: yes [modeset]
<7> [234.340361] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: DP (0x80), output format: RGB, sink format: RGB
<7> [234.340446] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 36, dithering: 0
<7> [234.340530] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [234.340612] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [234.340694] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [234.340796] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [234.340879] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 5190451, data_n: 8388608, link_m: 288358, link_n: 524288, tu: 64
<7> [234.340959] xe 0000:03:00.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> [234.341040] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: enabled
<7> [234.341121] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [234.341201] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] psr: disabled, selective update: disabled, panel replay: disabled, selective fetch: disabled
<7> [234.341279] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [234.341362] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] audio: 1, infoframes: 0, infoframes enabled: 0x0
<7> [234.341444] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 10 00 09 00 68 36 00 01 00 00 00 00 00 00 00 00
<7> [234.341524] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 61 a4 9a 00 44 50 46 39 30 34 33 35 09 07 07 11
<7> [234.341604] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 17 50 51 07 00 00 00 00
<7> [234.341683] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [234.341775] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [234.341852] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 0, guardband: 42 vsync start: 41, vsync end: 36
<7> [234.341930] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1083, vmax vblank: 1083, vmin vtotal: 1125, vmax vtotal: 1125
<7> [234.342007] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [234.342085] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [234.342165] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [234.342243] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [234.342320] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [234.342397] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [234.342475] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port clock: 270000, pipe src: 1920x1080+0+0, pixel rate 148500, min cdclk 192000
<7> [234.342552] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] linetime: 119, ips linetime: 0
<7> [234.342628] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [234.342712] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [234.342796] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [234.342878] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [234.342957] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] c20pll_hw_state:
<7> [234.343034] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] tx[0] = 0xbe88, tx[1] = 0x4800, tx[2] = 0x0000
<7> [234.343111] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [234.343188] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[0] = 0x308c
<7> [234.343265] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[1] = 0x2110
<7> [234.343343] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[2] = 0xcc9c
<7> [234.343421] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[3] = 0xbfc1
<7> [234.343498] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[4] = 0x4b9a
<7> [234.343575] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[5] = 0x3f81
<7> [234.343652] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[6] = 0x2000
<7> [234.343798] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[7] = 0x0001
<7> [234.343882] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[8] = 0x5000
<7> [234.343960] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[9] = 0x0000
<7> [234.344038] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[10] = 0x0000
<7> [234.344116] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vdr: custom width: 0x00, serdes rate: 0x42, hdmi rate: 0x00
<7> [234.344194] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [234.344271] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [234.344349] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [234.344428] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [234.344505] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [234.344582] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [234.344660] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [234.344761] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [234.344846] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [234.344926] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [234.345003] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [234.345081] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [234.345159] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [234.345237] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:33:plane 1A] fb: [FB:553] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [234.345317] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [234.345396] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [234.345475] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:63:plane 2A] fb: [NOFB], visible: no
<7> [234.345552] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:93:plane 3A] fb: [NOFB], visible: no
<7> [234.345629] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:123:plane 4A] fb: [NOFB], visible: no
<7> [234.345710] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:133:plane 5A] fb: [NOFB], visible: no
<7> [234.345794] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:143:cursor A] fb: [NOFB], visible: no
<7> [234.345877] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:267:pipe B] enable: yes [modeset]
<7> [234.345958] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [234.346037] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: B, pipe bpp: 36, dithering: 0
<7> [234.346114] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [234.346192] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [234.346270] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [234.346349] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [234.346427] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [234.346506] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] GCP: 0x6
<7> [234.346584] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [234.346585] xe 0000:03:00.0: colorspace: RGB
<7> [234.346587] xe 0000:03:00.0: scan mode: Underscan
<7> [234.346588] xe 0000:03:00.0: colorimetry: No Data
<7> [234.346589] xe 0000:03:00.0: picture aspect: No Data
<7> [234.346590] xe 0000:03:00.0: active aspect: Same as Picture
<7> [234.346591] xe 0000:03:00.0: itc: No Data
<7> [234.346592] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [234.346593] xe 0000:03:00.0: quantization range: Full
<7> [234.346594] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [234.346595] xe 0000:03:00.0: video code: 0
<7> [234.346596] xe 0000:03:00.0: ycc quantization range: Full
<7> [234.346598] xe 0000:03:00.0: hdmi content type: Graphics
<7> [234.346599] xe 0000:03:00.0: pixel repeat: 0
<7> [234.346600] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [234.346601] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [234.346602] xe 0000:03:00.0: vendor: Intel
<7> [234.346604] xe 0000:03:00.0: product: Discrete gfx
<7> [234.346605] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [234.346606] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [234.346607] xe 0000:03:00.0: empty frame
<7> [234.346608] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 10 00 07 00 66 10 00 01 00 00 00 00 00 00 00 00
<7> [234.346686] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 05 e3 cd 0c 32 38 45 38 35 30 09 07 07 00 00 00
<7> [234.346782] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [234.346865] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [234.346942] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 0, guardband: 45 vsync start: 42, vsync end: 37
<7> [234.347020] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1080, vmax vblank: 1080, vmin vtotal: 1125, vmax vtotal: 1125
<7> [234.347096] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [234.347174] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [234.347251] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [234.347330] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9
<7> [234.347408] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x40 0x9
<7> [234.347486] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9
<7> [234.347565] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port clock: 222750, pipe src: 1920x1080+0+0, pixel rate 148500, min cdclk 192000
<7> [234.347642] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] linetime: 119, ips linetime: 0
<7> [234.347733] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [234.347817] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [234.347894] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [234.347971] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [234.348046] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] c20pll_hw_state:
<7> [234.348123] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] tx[0] = 0xbe88, tx[1] = 0x5800, tx[2] = 0x0000
<7> [234.348199] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [234.348275] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[0] = 0x40e8
<7> [234.348352] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[1] = 0x7d20
<7> [234.348429] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[2] = 0x0a06
<7> [234.348506] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[3] = 0x8f1c
<7> [234.348582] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[4] = 0x0000
<7> [234.348659] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[5] = 0x0000
<7> [234.348749] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[6] = 0x2200
<7> [234.348833] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[7] = 0xffff
<7> [234.348916] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[8] = 0x0400
<7> [234.348996] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[9] = 0x0000
<7> [234.349071] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[10] = 0x0001
<7> [234.349148] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vdr: custom width: 0x00, serdes rate: 0x00, hdmi rate: 0x00
<7> [234.349224] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [234.349299] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [234.349376] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [234.349453] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [234.349528] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [234.349604] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [234.349681] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [234.349773] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [234.349860] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [234.349946] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [234.350024] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [234.350103] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [234.350181] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [234.350258] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:151:plane 1B] fb: [FB:553] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [234.350337] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [234.350413] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [234.350489] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:181:plane 2B] fb: [NOFB], visible: no
<7> [234.350567] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:211:plane 3B] fb: [NOFB], visible: no
<7> [234.350644] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:241:plane 4B] fb: [NOFB], visible: no
<7> [234.350736] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:251:plane 5B] fb: [NOFB], visible: no
<7> [234.350829] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:261:cursor B] fb: [NOFB], visible: no
<7> [234.350909] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:503:pipe D] enable: no [modeset]
<7> [234.350988] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:387:plane 1D] fb: [NOFB], visible: no
<7> [234.351065] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:417:plane 2D] fb: [NOFB], visible: no
<7> [234.351141] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:447:plane 3D] fb: [NOFB], visible: no
<7> [234.351219] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:477:plane 4D] fb: [NOFB], visible: no
<7> [234.351297] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:487:plane 5D] fb: [NOFB], visible: no
<7> [234.351375] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:497:cursor D] fb: [NOFB], visible: no
<7> [234.352077] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_A
<7> [234.352217] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_B
<7> [234.352438] xe 0000:03:00.0: [drm:intel_audio_codec_disable [xe]] [CONNECTOR:537:HDMI-A-3][ENCODER:536:DDI TC3/PHY H] Disable audio codec on [CRTC:503:pipe D]
<7> [234.370965] xe 0000:03:00.0: [drm:intel_audio_component_get_eld [xe]] Not valid for port F
<7> [234.371349] xe 0000:03:00.0: [drm:intel_disable_transcoder [xe]] disabling pipe D
<7> [234.391959] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disable TC PLL 3 (active 0x8, on? 1) for [CRTC:503:pipe D]
<7> [234.393588] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disabling TC PLL 3
<7> [234.393968] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:505:DDI TC1/PHY F]
<7> [234.394055] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:507:DP-MST A]
<7> [234.394135] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:508:DP-MST B]
<7> [234.394214] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST C]
<7> [234.394293] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST D]
<7> [234.394371] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:524:DDI TC2/PHY G]
<7> [234.394451] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:526:DP-MST A]
<7> [234.394533] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:527:DP-MST B]
<7> [234.394611] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST C]
<7> [234.394689] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST D]
<7> [234.394778] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:536:DDI TC3/PHY H]
<7> [234.394855] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:540:DDI TC4/PHY I]
<7> [234.394932] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:542:DP-MST A]
<7> [234.395011] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:543:DP-MST B]
<7> [234.395008] xe 0000:03:00.0: [drm:intel_audio_component_get_power [xe]] restored AUD_FREQ_CNTRL to 0x8010
<7> [234.395087] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST C]
<7> [234.395162] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST D]
<7> [234.395460] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [234.395634] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [234.395956] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enable TC PLL 2 (active 0x1, on? 0) for [CRTC:149:pipe A]
<7> [234.396042] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enabling TC PLL 2
<7> [234.398168] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC2
<7> [234.402284] xe 0000:03:00.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC2/DDI TC2/PHY G: DPCD: 12 14 c4 01 01 15 01 81 00 01 04 01 0f 00 01
<7> [234.406715] xe 0000:03:00.0: [drm:intel_dp_init_lttpr_and_dprx_caps [xe]] [CONNECTOR:525:DP-2][ENCODER:524:DDI TC2/PHY G][DPRX] LTTPR common capabilities: 00 00 00 00 00 00 00 00
<7> [234.407724] xe 0000:03:00.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC2/DDI TC2/PHY G: DPCD: 12 14 c4 01 01 15 01 81 00 01 04 01 0f 00 01
<7> [234.408098] xe 0000:03:00.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:525:DP-2][ENCODER:524:DDI TC2/PHY G][DPRX] Using LINK_BW_SET value 0a
<7> [234.409286] xe 0000:03:00.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:525:DP-2][ENCODER:524:DDI TC2/PHY G][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [234.409586] xe 0000:03:00.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:525:DP-2][ENCODER:524:DDI TC2/PHY G][DPRX] Using DP training pattern TPS1
<7> [234.416559] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:525:DP-2][ENCODER:524:DDI TC2/PHY G][DPRX] Clock recovery OK
<7> [234.416677] xe 0000:03:00.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:525:DP-2][ENCODER:524:DDI TC2/PHY G][DPRX] Using DP training pattern TPS3
<7> [234.423610] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:525:DP-2][ENCODER:524:DDI TC2/PHY G][DPRX] Channel EQ done. DP Training successful
<7> [234.423895] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:525:DP-2][ENCODER:524:DDI TC2/PHY G][DPRX] Link Training passed at link rate = 270000, lane count = 4
<7> [234.425223] xe 0000:03:00.0: [drm:intel_enable_transcoder [xe]] enabling pipe A
<7> [234.425396] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enable TC PLL 3 (active 0x2, on? 0) for [CRTC:267:pipe B]
<7> [234.425494] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enabling TC PLL 3
<7> [234.427803] xe 0000:03:00.0: [drm:intel_enable_transcoder [xe]] enabling pipe B
<7> [234.446207] xe 0000:03:00.0: [drm:intel_audio_codec_enable [xe]] [CONNECTOR:525:DP-2][ENCODER:524:DDI TC2/PHY G] Enable audio codec on [CRTC:149:pipe A], 40 bytes ELD
<7> [234.459385] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:525:DP-2]
<7> [234.459929] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:149:pipe A]
<7> [234.459880] xe 0000:03:00.0: [drm:intel_audio_component_get_power [xe]] restored AUD_FREQ_CNTRL to 0x8010
<7> [234.464136] xe 0000:03:00.0: [drm:intel_audio_codec_enable [xe]] [CONNECTOR:537:HDMI-A-3][ENCODER:536:DDI TC3/PHY H] Enable audio codec on [CRTC:267:pipe B], 32 bytes ELD
<7> [234.479807] xe 0000:03:00.0: [drm:audio_config_hdmi_pixel_clock [xe]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [234.480365] xe 0000:03:00.0: [drm:hsw_audio_config_update [xe]] using automatic N
<7> [234.481335] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:537:HDMI-A-3]
<7> [234.482136] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:267:pipe B]
<7> [234.486281] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling PW_D
<7> [234.487253] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:503:pipe D]
<7> [234.488438] xe 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0
<6> [234.489486] [IGT] kms_flip: exiting, ret=98
<7> [234.532806] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC2
Created at 2026-01-23 23:40:30