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

Result: Fail

i915_display_info4 igt_runner4 results4.json results4-xe-load.json guc_logs4.tar i915_display_info_post_exec4 boot4 dmesg4

DetailValue
Duration 3.18 seconds
Hostname 
shard-bmg-9
Igt-Version 
IGT-Version: 2.3-g53a8844b8 (x86_64) (Linux: 7.0.0-rc1-lgci-xe-xe-4623-85973a6f7a1abd95c-debug+ 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:921 run_test_on_crtc_set.constprop.0()
  #2 ../tests/kms_flip.c:1887 run_test()
  #3 ../tests/kms_flip.c:2156 __igt_unique____real_main2043()
  #4 ../tests/kms_flip.c:2043 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest D-HDMI-A3: FAIL (3.178s)
Subtest flip-vs-expired-vblank-interruptible: FAIL (31.108s)
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../lib/igt_kms.c:2351 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:7031) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:926:
(kms_flip:7031) CRITICAL: Failed assertion: end - start < 500
(kms_flip:7031) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest D-HDMI-A3 failed.
**** DEBUG ****
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.164520
last_received_ts = 348.164124
last_seq = 1737
current_ts = 348.181183
current_received_ts = 348.180878
current_seq = 1738
count = 22
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 25us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.181183
last_received_ts = 348.180878
last_seq = 1738
current_ts = 348.197845
current_received_ts = 348.197418
current_seq = 1739
count = 23
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 25us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.197845
last_received_ts = 348.197418
last_seq = 1739
current_ts = 348.214508
current_received_ts = 348.214172
current_seq = 1740
count = 24
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 25us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.214508
last_received_ts = 348.214172
last_seq = 1740
current_ts = 348.231201
current_received_ts = 348.230804
current_seq = 1741
count = 25
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.231201
last_received_ts = 348.230804
last_seq = 1741
current_ts = 348.247833
current_received_ts = 348.247498
current_seq = 1742
count = 26
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 41us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.247833
last_received_ts = 348.247498
last_seq = 1742
current_ts = 348.264526
current_received_ts = 348.264160
current_seq = 1743
count = 27
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 39us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.264526
last_received_ts = 348.264160
last_seq = 1743
current_ts = 348.281189
current_received_ts = 348.280823
current_seq = 1744
count = 28
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 39us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.281189
last_received_ts = 348.280823
last_seq = 1744
current_ts = 348.297852
current_received_ts = 348.297485
current_seq = 1745
count = 29
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 39us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.297852
last_received_ts = 348.297485
last_seq = 1745
current_ts = 348.314514
current_received_ts = 348.314148
current_seq = 1746
count = 30
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 28us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.314514
last_received_ts = 348.314148
last_seq = 1746
current_ts = 348.331177
current_received_ts = 348.330811
current_seq = 1747
count = 31
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 27us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.331177
last_received_ts = 348.330811
last_seq = 1747
current_ts = 348.347839
current_received_ts = 348.347473
current_seq = 1748
count = 32
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 27us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.347839
last_received_ts = 348.347473
last_seq = 1748
current_ts = 348.364502
current_received_ts = 348.364136
current_seq = 1749
count = 33
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.364502
last_received_ts = 348.364136
last_seq = 1749
current_ts = 348.381195
current_received_ts = 348.380798
current_seq = 1750
count = 34
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.381195
last_received_ts = 348.380798
last_seq = 1750
current_ts = 348.397858
current_received_ts = 348.397461
current_seq = 1751
count = 35
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.397858
last_received_ts = 348.397461
last_seq = 1751
current_ts = 348.414520
current_received_ts = 348.414154
current_seq = 1752
count = 36
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.414520
last_received_ts = 348.414154
last_seq = 1752
current_ts = 348.431183
current_received_ts = 348.430817
current_seq = 1753
count = 37
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.431183
last_received_ts = 348.430817
last_seq = 1753
current_ts = 348.447845
current_received_ts = 348.447479
current_seq = 1754
count = 38
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.447845
last_received_ts = 348.447479
last_seq = 1754
current_ts = 348.464508
current_received_ts = 348.464142
current_seq = 1755
count = 39
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.464508
last_received_ts = 348.464142
last_seq = 1755
current_ts = 348.481201
current_received_ts = 348.480804
current_seq = 1756
count = 40
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.481201
last_received_ts = 348.480804
last_seq = 1756
current_ts = 348.497864
current_received_ts = 348.497406
current_seq = 1757
count = 41
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.497864
last_received_ts = 348.497406
last_seq = 1757
current_ts = 348.514526
current_received_ts = 348.514069
current_seq = 1758
count = 42
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 25us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.514526
last_received_ts = 348.514069
last_seq = 1758
current_ts = 348.531189
current_received_ts = 348.530823
current_seq = 1759
count = 43
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 27us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.531189
last_received_ts = 348.530823
last_seq = 1759
current_ts = 348.547852
current_received_ts = 348.547394
current_seq = 1760
count = 44
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.547852
last_received_ts = 348.547394
last_seq = 1760
current_ts = 348.564514
current_received_ts = 348.564148
current_seq = 1761
count = 45
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.564514
last_received_ts = 348.564148
last_seq = 1761
current_ts = 348.581177
current_received_ts = 348.580811
current_seq = 1762
count = 46
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.581177
last_received_ts = 348.580811
last_seq = 1762
current_ts = 348.597870
current_received_ts = 348.597412
current_seq = 1763
count = 47
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.597870
last_received_ts = 348.597412
last_seq = 1763
current_ts = 348.614532
current_received_ts = 348.614075
current_seq = 1764
count = 48
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.614532
last_received_ts = 348.614075
last_seq = 1764
current_ts = 348.631195
current_received_ts = 348.630829
current_seq = 1765
count = 49
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.631195
last_received_ts = 348.630829
last_seq = 1765
current_ts = 348.647858
current_received_ts = 348.647400
current_seq = 1766
count = 50
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.647858
last_received_ts = 348.647400
last_seq = 1766
current_ts = 348.664520
current_received_ts = 348.664032
current_seq = 1767
count = 51
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 25us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.664520
last_received_ts = 348.664032
last_seq = 1767
current_ts = 348.681183
current_received_ts = 348.680756
current_seq = 1768
count = 52
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 27us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.681183
last_received_ts = 348.680756
last_seq = 1768
current_ts = 348.697876
current_received_ts = 348.697479
current_seq = 1769
count = 53
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 238us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.697876
last_received_ts = 348.697479
last_seq = 1769
current_ts = 348.714539
current_received_ts = 348.714142
current_seq = 1770
count = 54
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 240us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.714539
last_received_ts = 348.714142
last_seq = 1770
current_ts = 348.731201
current_received_ts = 348.730835
current_seq = 1771
count = 55
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 242us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.731201
last_received_ts = 348.730835
last_seq = 1771
current_ts = 348.747864
current_received_ts = 348.747498
current_seq = 1772
count = 56
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 238us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.747864
last_received_ts = 348.747498
last_seq = 1772
current_ts = 348.764526
current_received_ts = 348.764160
current_seq = 1773
count = 57
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 241us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.764526
last_received_ts = 348.764160
last_seq = 1773
current_ts = 348.781189
current_received_ts = 348.780823
current_seq = 1774
count = 58
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 252us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.781189
last_received_ts = 348.780823
last_seq = 1774
current_ts = 348.797882
current_received_ts = 348.797485
current_seq = 1775
count = 59
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 245us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.797882
last_received_ts = 348.797485
last_seq = 1775
current_ts = 348.814545
current_received_ts = 348.814148
current_seq = 1776
count = 60
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 239us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.814545
last_received_ts = 348.814148
last_seq = 1776
current_ts = 348.831207
current_received_ts = 348.830811
current_seq = 1777
count = 61
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 252us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.831207
last_received_ts = 348.830811
last_seq = 1777
current_ts = 348.847870
current_received_ts = 348.847504
current_seq = 1778
count = 62
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.847870
last_received_ts = 348.847504
last_seq = 1778
current_ts = 348.864532
current_received_ts = 348.864044
current_seq = 1779
count = 63
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 25us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.864532
last_received_ts = 348.864044
last_seq = 1779
current_ts = 348.881195
current_received_ts = 348.880829
current_seq = 1780
count = 64
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.881195
last_received_ts = 348.880829
last_seq = 1780
current_ts = 348.897888
current_received_ts = 348.897430
current_seq = 1781
count = 65
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.897888
last_received_ts = 348.897430
last_seq = 1781
current_ts = 348.914551
current_received_ts = 348.914062
current_seq = 1782
count = 66
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 25us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.914551
last_received_ts = 348.914062
last_seq = 1782
current_ts = 348.931213
current_received_ts = 348.930817
current_seq = 1783
count = 67
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.931213
last_received_ts = 348.930817
last_seq = 1783
current_ts = 348.947876
current_received_ts = 348.947510
current_seq = 1784
count = 68
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 241us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.947876
last_received_ts = 348.947510
last_seq = 1784
current_ts = 348.964539
current_received_ts = 348.964172
current_seq = 1785
count = 69
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 239us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.964539
last_received_ts = 348.964172
last_seq = 1785
current_ts = 348.981201
current_received_ts = 348.980835
current_seq = 1786
count = 70
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 246us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.981201
last_received_ts = 348.980835
last_seq = 1786
current_ts = 348.997864
current_received_ts = 348.997498
current_seq = 1787
count = 71
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 245us
(kms_flip:7031) DEBUG: name = flip
last_ts = 348.997864
last_received_ts = 348.997498
last_seq = 1787
current_ts = 349.014557
current_received_ts = 349.014160
current_seq = 1788
count = 72
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 240us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.014557
last_received_ts = 349.014160
last_seq = 1788
current_ts = 349.031219
current_received_ts = 349.030853
current_seq = 1789
count = 73
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 250us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.031219
last_received_ts = 349.030853
last_seq = 1789
current_ts = 349.047882
current_received_ts = 349.047516
current_seq = 1790
count = 74
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 25us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.047882
last_received_ts = 349.047516
last_seq = 1790
current_ts = 349.064545
current_received_ts = 349.064087
current_seq = 1791
count = 75
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.064545
last_received_ts = 349.064087
last_seq = 1791
current_ts = 349.081207
current_received_ts = 349.080780
current_seq = 1792
count = 76
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.081207
last_received_ts = 349.080780
last_seq = 1792
current_ts = 349.097900
current_received_ts = 349.097382
current_seq = 1793
count = 77
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.097900
last_received_ts = 349.097382
last_seq = 1793
current_ts = 349.114563
current_received_ts = 349.114075
current_seq = 1794
count = 78
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 25us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.114563
last_received_ts = 349.114075
last_seq = 1794
current_ts = 349.131226
current_received_ts = 349.130737
current_seq = 1795
count = 79
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 25us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.131226
last_received_ts = 349.130737
last_seq = 1795
current_ts = 349.147888
current_received_ts = 349.147430
current_seq = 1796
count = 80
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.147888
last_received_ts = 349.147430
last_seq = 1796
current_ts = 349.164551
current_received_ts = 349.164185
current_seq = 1797
count = 81
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.164551
last_received_ts = 349.164185
last_seq = 1797
current_ts = 349.181213
current_received_ts = 349.180847
current_seq = 1798
count = 82
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 25us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.181213
last_received_ts = 349.180847
last_seq = 1798
current_ts = 349.197876
current_received_ts = 349.197449
current_seq = 1799
count = 83
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 242us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.197876
last_received_ts = 349.197449
last_seq = 1799
current_ts = 349.214569
current_received_ts = 349.214172
current_seq = 1800
count = 84
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 241us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.214569
last_received_ts = 349.214172
last_seq = 1800
current_ts = 349.231232
current_received_ts = 349.230835
current_seq = 1801
count = 85
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 244us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.231232
last_received_ts = 349.230835
last_seq = 1801
current_ts = 349.247894
current_received_ts = 349.247528
current_seq = 1802
count = 86
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 232us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.247894
last_received_ts = 349.247528
last_seq = 1802
current_ts = 349.264557
current_received_ts = 349.264191
current_seq = 1803
count = 87
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 235us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.264557
last_received_ts = 349.264191
last_seq = 1803
current_ts = 349.281250
current_received_ts = 349.280945
current_seq = 1804
count = 88
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 246us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.281250
last_received_ts = 349.280945
last_seq = 1804
current_ts = 349.297882
current_received_ts = 349.297577
current_seq = 1805
count = 89
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 242us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.297882
last_received_ts = 349.297577
last_seq = 1805
current_ts = 349.314575
current_received_ts = 349.314240
current_seq = 1806
count = 90
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 245us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.314575
last_received_ts = 349.314240
last_seq = 1806
current_ts = 349.331238
current_received_ts = 349.330902
current_seq = 1807
count = 91
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 244us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.331238
last_received_ts = 349.330902
last_seq = 1807
current_ts = 349.347900
current_received_ts = 349.347595
current_seq = 1808
count = 92
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 234us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.347900
last_received_ts = 349.347595
last_seq = 1808
current_ts = 349.364563
current_received_ts = 349.364258
current_seq = 1809
count = 93
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 233us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.364563
last_received_ts = 349.364258
last_seq = 1809
current_ts = 349.381226
current_received_ts = 349.380920
current_seq = 1810
count = 94
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 241us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.381226
last_received_ts = 349.380920
last_seq = 1810
current_ts = 349.397888
current_received_ts = 349.397583
current_seq = 1811
count = 95
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 231us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.397888
last_received_ts = 349.397583
last_seq = 1811
current_ts = 349.414581
current_received_ts = 349.414276
current_seq = 1812
count = 96
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 233us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.414581
last_received_ts = 349.414276
last_seq = 1812
current_ts = 349.431244
current_received_ts = 349.430939
current_seq = 1813
count = 97
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 246us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.431244
last_received_ts = 349.430939
last_seq = 1813
current_ts = 349.447906
current_received_ts = 349.447601
current_seq = 1814
count = 98
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 239us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.447906
last_received_ts = 349.447601
last_seq = 1814
current_ts = 349.464569
current_received_ts = 349.464264
current_seq = 1815
count = 99
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 235us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.464569
last_received_ts = 349.464264
last_seq = 1815
current_ts = 349.481232
current_received_ts = 349.480927
current_seq = 1816
count = 100
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 258us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.481232
last_received_ts = 349.480927
last_seq = 1816
current_ts = 349.497894
current_received_ts = 349.497589
current_seq = 1817
count = 101
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 241us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.497894
last_received_ts = 349.497589
last_seq = 1817
current_ts = 349.514587
current_received_ts = 349.514252
current_seq = 1818
count = 102
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 237us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.514587
last_received_ts = 349.514252
last_seq = 1818
current_ts = 349.531219
current_received_ts = 349.530945
current_seq = 1819
count = 103
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 248us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.531219
last_received_ts = 349.530945
last_seq = 1819
current_ts = 349.547913
current_received_ts = 349.547607
current_seq = 1820
count = 104
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 244us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.547913
last_received_ts = 349.547607
last_seq = 1820
current_ts = 349.564575
current_received_ts = 349.564270
current_seq = 1821
count = 105
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 229us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.564575
last_received_ts = 349.564270
last_seq = 1821
current_ts = 349.581238
current_received_ts = 349.580933
current_seq = 1822
count = 106
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 252us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.581238
last_received_ts = 349.580933
last_seq = 1822
current_ts = 349.597931
current_received_ts = 349.597595
current_seq = 1823
count = 107
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 235us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.597931
last_received_ts = 349.597595
last_seq = 1823
current_ts = 349.614594
current_received_ts = 349.614258
current_seq = 1824
count = 108
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 236us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.614594
last_received_ts = 349.614258
last_seq = 1824
current_ts = 349.631256
current_received_ts = 349.630951
current_seq = 1825
count = 109
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 256us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.631256
last_received_ts = 349.630951
last_seq = 1825
current_ts = 349.647919
current_received_ts = 349.647614
current_seq = 1826
count = 110
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 235us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.647919
last_received_ts = 349.647614
last_seq = 1826
current_ts = 349.664581
current_received_ts = 349.664276
current_seq = 1827
count = 111
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 241us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.664581
last_received_ts = 349.664276
last_seq = 1827
current_ts = 349.681244
current_received_ts = 349.680939
current_seq = 1828
count = 112
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 245us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.681244
last_received_ts = 349.680939
last_seq = 1828
current_ts = 349.697906
current_received_ts = 349.697601
current_seq = 1829
count = 113
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 239us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.697906
last_received_ts = 349.697601
last_seq = 1829
current_ts = 349.714569
current_received_ts = 349.714264
current_seq = 1830
count = 114
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 228us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.714569
last_received_ts = 349.714264
last_seq = 1830
current_ts = 349.731262
current_received_ts = 349.730927
current_seq = 1831
count = 115
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 266us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.731262
last_received_ts = 349.730927
last_seq = 1831
current_ts = 349.747925
current_received_ts = 349.747620
current_seq = 1832
count = 116
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 237us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.747925
last_received_ts = 349.747620
last_seq = 1832
current_ts = 349.764587
current_received_ts = 349.764282
current_seq = 1833
count = 117
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 238us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.764587
last_received_ts = 349.764282
last_seq = 1833
current_ts = 349.781250
current_received_ts = 349.780945
current_seq = 1834
count = 118
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 251us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.781250
last_received_ts = 349.780945
last_seq = 1834
current_ts = 349.797913
current_received_ts = 349.797607
current_seq = 1835
count = 119
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 240us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.797913
last_received_ts = 349.797607
last_seq = 1835
current_ts = 349.814575
current_received_ts = 349.814270
current_seq = 1836
count = 120
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 232us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.814575
last_received_ts = 349.814270
last_seq = 1836
current_ts = 349.831238
current_received_ts = 349.830963
current_seq = 1837
count = 121
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 249us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.831238
last_received_ts = 349.830963
last_seq = 1837
current_ts = 349.847931
current_received_ts = 349.847626
current_seq = 1838
count = 122
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 244us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.847931
last_received_ts = 349.847626
last_seq = 1838
current_ts = 349.864594
current_received_ts = 349.864288
current_seq = 1839
count = 123
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 234us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.864594
last_received_ts = 349.864288
last_seq = 1839
current_ts = 349.881256
current_received_ts = 349.880951
current_seq = 1840
count = 124
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 258us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.881256
last_received_ts = 349.880951
last_seq = 1840
current_ts = 349.897919
current_received_ts = 349.897644
current_seq = 1841
count = 125
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 239us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.897919
last_received_ts = 349.897644
last_seq = 1841
current_ts = 349.914612
current_received_ts = 349.914276
current_seq = 1842
count = 126
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 28us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.914612
last_received_ts = 349.914276
last_seq = 1842
current_ts = 349.931244
current_received_ts = 349.930969
current_seq = 1843
count = 127
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 27us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.931244
last_received_ts = 349.930969
last_seq = 1843
current_ts = 349.947906
current_received_ts = 349.947540
current_seq = 1844
count = 128
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 26us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.947906
last_received_ts = 349.947540
last_seq = 1844
current_ts = 349.964600
current_received_ts = 349.964264
current_seq = 1845
count = 129
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 236us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.964600
last_received_ts = 349.964264
last_seq = 1845
current_ts = 349.981262
current_received_ts = 349.981079
current_seq = 1846
count = 130
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 150us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.981262
last_received_ts = 349.981079
last_seq = 1846
current_ts = 349.997925
current_received_ts = 349.997650
current_seq = 1847
count = 131
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 233us
(kms_flip:7031) DEBUG: name = flip
last_ts = 349.997925
last_received_ts = 349.997650
last_seq = 1847
current_ts = 350.014587
current_received_ts = 350.014282
current_seq = 1848
count = 132
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 27us
(kms_flip:7031) DEBUG: name = flip
last_ts = 350.014587
last_received_ts = 350.014282
last_seq = 1848
current_ts = 350.031281
current_received_ts = 350.030945
current_seq = 1849
count = 133
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 27us
(kms_flip:7031) DEBUG: name = flip
last_ts = 350.031281
last_received_ts = 350.030945
last_seq = 1849
current_ts = 350.047943
current_received_ts = 350.047607
current_seq = 1850
count = 134
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 27us
(kms_flip:7031) DEBUG: name = flip
last_ts = 350.047943
last_received_ts = 350.047607
last_seq = 1850
current_ts = 350.064606
current_received_ts = 350.064301
current_seq = 1851
count = 135
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 25us
(kms_flip:7031) DEBUG: name = flip
last_ts = 350.064606
last_received_ts = 350.064301
last_seq = 1851
current_ts = 350.081268
current_received_ts = 350.080963
current_seq = 1852
count = 136
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 25us
(kms_flip:7031) DEBUG: name = flip
last_ts = 350.081268
last_received_ts = 350.080963
last_seq = 1852
current_ts = 350.097931
current_received_ts = 350.097626
current_seq = 1853
count = 137
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 25us
(kms_flip:7031) DEBUG: name = flip
last_ts = 350.097931
last_received_ts = 350.097626
last_seq = 1853
current_ts = 350.114594
current_received_ts = 350.114288
current_seq = 1854
count = 138
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 25us
(kms_flip:7031) DEBUG: name = flip
last_ts = 350.114594
last_received_ts = 350.114288
last_seq = 1854
current_ts = 350.131256
current_received_ts = 350.130890
current_seq = 1855
count = 139
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 18us
(kms_flip:7031) DEBUG: name = flip
last_ts = 350.131256
last_received_ts = 350.130890
last_seq = 1855
current_ts = 350.147949
current_received_ts = 350.147583
current_seq = 1856
count = 140
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 28us
(kms_flip:7031) DEBUG: name = flip
last_ts = 350.147949
last_received_ts = 350.147583
last_seq = 1856
current_ts = 350.164612
current_received_ts = 350.164307
current_seq = 1857
count = 141
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 28us
(kms_flip:7031) DEBUG: name = flip
last_ts = 350.164612
last_received_ts = 350.164307
last_seq = 1857
current_ts = 350.181274
current_received_ts = 350.180969
current_seq = 1858
count = 142
seq_step = 1
(kms_flip:7031) DEBUG: Vblank took 915us
(kms_flip:7031) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:926:
(kms_flip:7031) CRITICAL: Failed assertion: end - start < 500
(kms_flip:7031) CRITICAL: Last errno: 4, Interrupted system call
(kms_flip:7031) igt_core-INFO: Stack trace:
(kms_flip:7031) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(kms_flip:7031) igt_core-INFO:   #1 ../tests/kms_flip.c:921 run_test_on_crtc_set.constprop.0()
(kms_flip:7031) igt_core-INFO:   #2 ../tests/kms_flip.c:1887 run_test()
(kms_flip:7031) igt_core-INFO:   #3 ../tests/kms_flip.c:2156 __igt_unique____real_main2043()
(kms_flip:7031) igt_core-INFO:   #4 ../tests/kms_flip.c:2043 main()
(kms_flip:7031) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:7031) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:7031) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest D-HDMI-A3: FAIL (3.178s)
Subtest flip-vs-expired-vblank-interruptible: FAIL (31.108s)
(kms_flip:7031) igt_kms-CRITICAL: Test assertion failure function kmstest_set_connector_dpms, file ../lib/igt_kms.c:2351:
(kms_flip:7031) igt_kms-CRITICAL: Failed assertion: found_it
(kms_flip:7031) igt_kms-CRITICAL: Last errno: 9, Bad file descriptor
(kms_flip:7031) igt_kms-CRITICAL: DPMS property not found on 538
Dmesg
<6> [347.762683] [IGT] kms_flip: starting dynamic subtest D-HDMI-A3
<7> [347.763538] xe 0000:03:00.0: [drm:drm_mode_addfb2] [FB:557]
<7> [347.764043] xe 0000:03:00.0: [drm:drm_mode_addfb2] [FB:558]
<7> [347.808728] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:150:pipe A]
<7> [347.808905] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:268:pipe B]
<7> [347.809031] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:386:pipe C]
<7> [347.809101] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.enable (expected yes, found no)
<7> [347.809272] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.active (expected yes, found no)
<7> [347.809428] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in cpu_transcoder (expected 2, found -1)
<7> [347.809569] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in lane_count (expected 4, found 0)
<7> [347.809702] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [347.809834] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [347.809963] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [347.810087] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [347.810208] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [347.810326] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [347.810451] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [347.810571] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [347.810690] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [347.810807] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [347.810922] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [347.811032] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [347.811139] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [347.811245] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [347.811351] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [347.811468] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [347.811575] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [347.811681] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [347.811785] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [347.811887] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [347.811986] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [347.812085] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [347.812181] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [347.812279] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [347.812374] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [347.812478] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [347.812576] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [347.812673] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [347.812768] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [347.812860] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [347.812949] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [347.813040] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [347.813128] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [347.813216] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [347.813304] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in port_clock (expected 222750, found 0)
<7> [347.813390] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [347.813484] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [347.813572] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in avi infoframe
<7> [347.813659] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [347.813744] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [347.813746] xe 0000:03:00.0: colorspace: RGB
<7> [347.813748] xe 0000:03:00.0: scan mode: Underscan
<7> [347.813749] xe 0000:03:00.0: colorimetry: No Data
<7> [347.813750] xe 0000:03:00.0: picture aspect: No Data
<7> [347.813751] xe 0000:03:00.0: active aspect: Same as Picture
<7> [347.813752] xe 0000:03:00.0: itc: No Data
<7> [347.813753] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [347.813755] xe 0000:03:00.0: quantization range: Full
<7> [347.813756] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [347.813757] xe 0000:03:00.0: video code: 0
<7> [347.813758] xe 0000:03:00.0: ycc quantization range: Full
<7> [347.813759] xe 0000:03:00.0: hdmi content type: Graphics
<7> [347.813760] xe 0000:03:00.0: pixel repeat: 0
<7> [347.813761] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [347.813763] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [347.813858] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in spd infoframe
<7> [347.813950] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [347.814040] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [347.814042] xe 0000:03:00.0: vendor: Intel
<7> [347.814043] xe 0000:03:00.0: product: Discrete gfx
<7> [347.814044] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [347.814045] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [347.814135] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:386:pipe C] fastset requirement not met in hdmi infoframe
<7> [347.814222] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [347.814310] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [347.814311] xe 0000:03:00.0: empty frame
<7> [347.814312] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [347.814400] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:386:pipe C] fastset requirement not met, forcing full modeset
<7> [347.814496] xe 0000:03:00.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:386:pipe C] releasing TC PLL 3
<7> [347.814604] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xd -> 0x1 (total dbuf slices 0xf), mbus joined? no->no
<7> [347.814687] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:386:pipe C] dbuf slices 0xc -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x4 -> 0x0
<7> [347.814784] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:380:cursor C] ddb (1989 - 2048) -> ( 0 - 0), size 59 -> 0
<7> [347.814882] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:386:pipe C] min cdclk: 192000 kHz -> 0 kHz
<7> [347.814996] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:386:pipe C] enable: no [modeset]
<7> [347.815095] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:270:plane 1C] fb: [NOFB], visible: no
<7> [347.815192] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:300:plane 2C] fb: [NOFB], visible: no
<7> [347.815289] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:330:plane 3C] fb: [NOFB], visible: no
<7> [347.815386] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:360:plane 4C] fb: [NOFB], visible: no
<7> [347.815490] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:370:plane 5C] fb: [NOFB], visible: no
<7> [347.815584] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:380:cursor C] fb: [NOFB], visible: no
<7> [347.815965] xe 0000:03:00.0: [drm:intel_audio_codec_disable [xe]] [CONNECTOR:538:HDMI-A-3][ENCODER:537:DDI TC3/PHY H] Disable audio codec on [CRTC:386:pipe C]
<7> [347.840006] xe 0000:03:00.0: [drm:intel_audio_component_get_eld [xe]] Not valid for port F
<7> [347.840367] xe 0000:03:00.0: [drm:intel_hdmi_handle_sink_scrambling [xe]] [CONNECTOR:538:HDMI-A-3] scrambling=no, TMDS bit clock ratio=1/10
<7> [347.840932] xe 0000:03:00.0: [drm:do_gmbus_xfer [xe]] GMBUS [i915 gmbus tc3] NAK for addr: 0054 w(1)
<7> [347.841199] xe 0000:03:00.0: [drm:do_gmbus_xfer [xe]] GMBUS [i915 gmbus tc3] NAK on first message, retry
<7> [347.841717] xe 0000:03:00.0: [drm:do_gmbus_xfer [xe]] GMBUS [i915 gmbus tc3] NAK for addr: 0054 w(1)
<7> [347.841956] xe 0000:03:00.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:538:HDMI-A-3] Failed to read TMDS config: -6
<7> [347.841988] xe 0000:03:00.0: [drm:intel_ddi_disable [xe]] [CONNECTOR:538:HDMI-A-3] Failed to reset sink scrambling/TMDS bit clock ratio
<7> [347.842401] xe 0000:03:00.0: [drm:intel_disable_transcoder [xe]] disabling pipe C
<7> [347.863406] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disable TC PLL 3 (active 0x4, on? 1) for [CRTC:386:pipe C]
<7> [347.863616] xe 0000:03:00.0: [drm:intel_audio_component_get_power [xe]] restored AUD_FREQ_CNTRL to 0x8010
<6> [347.864325] pcieport 0000:00:01.0: PME: Spurious native interrupt!
<7> [347.865857] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disabling TC PLL 3
<7> [347.866659] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:506:DDI TC1/PHY F]
<7> [347.867117] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:508:DP-MST A]
<7> [347.867592] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST B]
<7> [347.868024] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST C]
<7> [347.868466] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:511:DP-MST D]
<7> [347.868889] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:525:DDI TC2/PHY G]
<7> [347.869306] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:527:DP-MST A]
<7> [347.869735] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST B]
<7> [347.870150] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST C]
<7> [347.870587] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:530:DP-MST D]
<7> [347.870997] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:537:DDI TC3/PHY H]
<7> [347.871589] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:541:DDI TC4/PHY I]
<7> [347.871950] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:543:DP-MST A]
<7> [347.872301] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST B]
<7> [347.872654] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST C]
<7> [347.872989] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:546:DP-MST D]
<7> [347.873304] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:538:HDMI-A-3]
<7> [347.873683] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [347.874176] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [347.874779] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling PW_C
<7> [347.875296] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating disabled for pipe_mask=0x4 (CLKGATE_DIS_DSSDSC=0xaa000000)
<7> [347.875875] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:386:pipe C]
<7> [347.876605] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:504:pipe D]
<7> [347.877282] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:504:pipe D]
<7> [347.877325] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CONNECTOR:538:HDMI-A-3]
<7> [347.877475] xe 0000:03:00.0: [drm:intel_hdmi_compute_clock [xe]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [347.877727] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:504:pipe D] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [347.877965] xe 0000:03:00.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:537:DDI TC3/PHY H] [CRTC:504:pipe D]
<7> [347.878191] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.enable (expected no, found yes)
<7> [347.878401] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.active (expected no, found yes)
<7> [347.878428] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [347.878623] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in cpu_transcoder (expected -1, found 3)
<7> [347.878820] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in lane_count (expected 0, found 4)
<7> [347.879015] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [347.879195] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [347.879374] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [347.879566] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [347.879749] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [347.879915] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [347.880068] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [347.880215] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [347.880365] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [347.880524] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [347.880671] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [347.880807] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [347.880943] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [347.881075] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [347.881201] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [347.881329] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [347.881460] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [347.881582] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [347.881705] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [347.881826] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [347.881942] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [347.882055] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [347.882167] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [347.882278] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [347.882386] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [347.882504] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [347.882612] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [347.882721] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [347.882823] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [347.882922] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [347.883020] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [347.883117] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in dpll_hw_state
<7> [347.883212] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [347.883303] 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> [347.883395] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] c20pll_hw_state:
<7> [347.883500] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] tx[0] = 0xbe88, tx[1] = 0x4800, tx[2] = 0x0000
<7> [347.883593] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [347.883684] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[0] = 0x308c
<7> [347.883769] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[1] = 0x2110
<7> [347.883853] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[2] = 0xcc9c
<7> [347.883940] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[3] = 0xbfc1
<7> [347.884025] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[4] = 0x4b9a
<7> [347.884112] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[5] = 0x3f81
<7> [347.884199] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[6] = 0x2000
<7> [347.884286] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[7] = 0x0001
<7> [347.884372] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[8] = 0x5000
<7> [347.884468] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[9] = 0x0000
<7> [347.884556] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[10] = 0x0000
<7> [347.884642] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] vdr: custom width: 0x00, serdes rate: 0x42, hdmi rate: 0x00
<7> [347.884731] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [347.884818] 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> [347.884904] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] c20pll_hw_state:
<7> [347.884992] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] tx[0] = 0xbe88, tx[1] = 0x5800, tx[2] = 0x0000
<7> [347.885078] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [347.885165] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[0] = 0x40e8
<7> [347.885252] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[1] = 0x7d20
<7> [347.885338] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[2] = 0x0a06
<7> [347.885427] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[3] = 0x8f1c
<7> [347.885514] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[4] = 0x0000
<7> [347.885601] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[5] = 0x0000
<7> [347.885689] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[6] = 0x2200
<7> [347.885777] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[7] = 0xffff
<7> [347.885865] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[8] = 0x0400
<7> [347.885952] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[9] = 0x0000
<7> [347.886041] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[10] = 0x0001
<7> [347.886128] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] vdr: custom width: 0x00, serdes rate: 0x00, hdmi rate: 0x00
<7> [347.886220] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [347.886307] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [347.886395] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [347.886490] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in port_clock (expected 0, found 222750)
<7> [347.886577] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [347.886662] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)
<7> [347.886746] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in avi infoframe
<7> [347.886829] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [347.886913] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [347.886998] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [347.886999] xe 0000:03:00.0: colorspace: RGB
<7> [347.887000] xe 0000:03:00.0: scan mode: Underscan
<7> [347.887002] xe 0000:03:00.0: colorimetry: No Data
<7> [347.887003] xe 0000:03:00.0: picture aspect: No Data
<7> [347.887004] xe 0000:03:00.0: active aspect: Same as Picture
<7> [347.887005] xe 0000:03:00.0: itc: No Data
<7> [347.887006] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [347.887007] xe 0000:03:00.0: quantization range: Full
<7> [347.887008] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [347.887009] xe 0000:03:00.0: video code: 0
<7> [347.887010] xe 0000:03:00.0: ycc quantization range: Full
<7> [347.887011] xe 0000:03:00.0: hdmi content type: Graphics
<7> [347.887013] xe 0000:03:00.0: pixel repeat: 0
<7> [347.887014] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [347.887015] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in spd infoframe
<7> [347.887100] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [347.887187] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [347.887273] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [347.887275] xe 0000:03:00.0: vendor: Intel
<7> [347.887276] xe 0000:03:00.0: product: Discrete gfx
<7> [347.887277] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [347.887278] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hdmi infoframe
<7> [347.887364] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [347.887458] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [347.887545] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [347.887546] xe 0000:03:00.0: empty frame
<7> [347.887548] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:504:pipe D] fastset requirement not met, forcing full modeset
<7> [347.887655] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0xf), mbus joined? no->no
<7> [347.887737] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:504:pipe D] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x8
<7> [347.887836] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:388:plane 1D] ddb ( 0 - 0) -> ( 0 - 1989), size 0 -> 1989
<7> [347.887913] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:498:cursor D] ddb ( 0 - 0) -> (1989 - 2048), size 0 -> 59
<7> [347.887988] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:388: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> [347.888063] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:388: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> [347.888136] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:388: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> [347.888210] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:388: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> [347.888292] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:504:pipe D] data rate 594000 num active planes 1
<7> [347.888393] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 624 qgv_peak_bw: 48000
<7> [347.888520] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 624 qgv_peak_bw: 48000
<7> [347.888613] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 624
<7> [347.888715] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:504:pipe D] min cdclk: 0 kHz -> 192000 kHz
<7> [347.888829] xe 0000:03:00.0: [drm:intel_find_dpll [xe]] [CRTC:504:pipe D] allocated TC PLL 3
<7> [347.888924] xe 0000:03:00.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:504:pipe D] reserving TC PLL 3
<7> [347.889016] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:504:pipe D] enable: yes [modeset]
<7> [347.889115] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [347.889209] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: D, pipe bpp: 36, dithering: 0
<7> [347.889301] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [347.889393] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [347.889495] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [347.889587] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [347.889680] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [347.889766] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] GCP: 0x6
<7> [347.889856] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [347.889858] xe 0000:03:00.0: colorspace: RGB
<7> [347.889859] xe 0000:03:00.0: scan mode: Underscan
<7> [347.889860] xe 0000:03:00.0: colorimetry: No Data
<7> [347.889862] xe 0000:03:00.0: picture aspect: No Data
<7> [347.889863] xe 0000:03:00.0: active aspect: Same as Picture
<7> [347.889864] xe 0000:03:00.0: itc: No Data
<7> [347.889866] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [347.889867] xe 0000:03:00.0: quantization range: Full
<7> [347.889868] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [347.889870] xe 0000:03:00.0: video code: 0
<7> [347.889871] xe 0000:03:00.0: ycc quantization range: Full
<7> [347.889872] xe 0000:03:00.0: hdmi content type: Graphics
<7> [347.889874] xe 0000:03:00.0: pixel repeat: 0
<7> [347.889875] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [347.889877] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [347.889878] xe 0000:03:00.0: vendor: Intel
<7> [347.889880] xe 0000:03:00.0: product: Discrete gfx
<7> [347.889881] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [347.889882] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [347.889884] xe 0000:03:00.0: empty frame
<7> [347.889885] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 10 00 08 00 6d 10 00 01 00 00 00 00 00 00 00 00
<7> [347.889976] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 24 96 11 ed 41 4f 43 32 38 45 38 35 30 2e 48 44
<7> [347.890065] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 52 09 07 07
<7> [347.890154] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [347.890242] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [347.890329] 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> [347.890420] 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> [347.890509] 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> [347.890598] 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> [347.890686] 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> [347.890773] 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> [347.890861] 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> [347.890947] 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> [347.891036] 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> [347.891122] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] linetime: 119, ips linetime: 0
<7> [347.891210] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [347.891297] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [347.891385] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [347.891480] 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> [347.891567] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] c20pll_hw_state:
<7> [347.891652] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] tx[0] = 0xbe88, tx[1] = 0x5800, tx[2] = 0x0000
<7> [347.891738] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [347.891825] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[0] = 0x40e8
<7> [347.891911] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[1] = 0x7d20
<7> [347.891997] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[2] = 0x0a06
<7> [347.892083] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[3] = 0x8f1c
<7> [347.892167] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[4] = 0x0000
<7> [347.892254] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[5] = 0x0000
<7> [347.892340] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[6] = 0x2200
<7> [347.892427] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[7] = 0xffff
<7> [347.892516] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[8] = 0x0400
<7> [347.892603] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[9] = 0x0000
<7> [347.892690] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[10] = 0x0001
<7> [347.892774] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vdr: custom width: 0x00, serdes rate: 0x00, hdmi rate: 0x00
<7> [347.892860] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [347.892947] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [347.893035] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [347.893122] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [347.893209] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [347.893298] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [347.893384] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [347.893481] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [347.893570] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [347.893660] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [347.893748] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [347.893836] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [347.893923] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [347.894011] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:388:plane 1D] fb: [FB:557] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [347.894101] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [347.894187] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [347.894275] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:418:plane 2D] fb: [NOFB], visible: no
<7> [347.894363] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:448:plane 3D] fb: [NOFB], visible: no
<7> [347.894462] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:478:plane 4D] fb: [NOFB], visible: no
<7> [347.894465] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [347.894550] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:488:plane 5D] fb: [NOFB], visible: no
<7> [347.894638] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:498:cursor D] fb: [NOFB], visible: no
<7> [347.894793] xe 0000:03:00.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [347.894953] xe 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [347.895069] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling always-on
<7> [347.895163] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling always-on
<7> [347.895263] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [347.895525] xe 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [347.895650] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [347.895775] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_D
<7> [347.895908] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x8 (CLKGATE_DIS_DSSDSC=0x2a000000)
<7> [347.896010] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:506:DDI TC1/PHY F]
<7> [347.896098] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:508:DP-MST A]
<7> [347.896181] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST B]
<7> [347.896264] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST C]
<7> [347.896347] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:511:DP-MST D]
<7> [347.896433] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:525:DDI TC2/PHY G]
<7> [347.896514] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:527:DP-MST A]
<7> [347.896595] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST B]
<7> [347.896675] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST C]
<7> [347.896752] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:530:DP-MST D]
<7> [347.896829] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:537:DDI TC3/PHY H]
<7> [347.896910] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:541:DDI TC4/PHY I]
<7> [347.896990] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:543:DP-MST A]
<7> [347.897070] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST B]
<7> [347.897149] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST C]
<7> [347.897227] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:546:DP-MST D]
<7> [347.897313] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x3
<7> [347.897471] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [347.897568] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enable TC PLL 3 (active 0x8, on? 0) for [CRTC:504:pipe D]
<7> [347.897660] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enabling TC PLL 3
<7> [347.900145] xe 0000:03:00.0: [drm:intel_enable_transcoder [xe]] enabling pipe D
<7> [347.901130] xe 0000:03:00.0: [drm:intel_hdmi_handle_sink_scrambling [xe]] [CONNECTOR:538:HDMI-A-3] scrambling=no, TMDS bit clock ratio=1/10
<7> [347.901458] xe 0000:03:00.0: [drm:do_gmbus_xfer [xe]] GMBUS [i915 gmbus tc3] NAK for addr: 0054 w(1)
<7> [347.901545] xe 0000:03:00.0: [drm:do_gmbus_xfer [xe]] GMBUS [i915 gmbus tc3] NAK on first message, retry
<7> [347.901871] xe 0000:03:00.0: [drm:do_gmbus_xfer [xe]] GMBUS [i915 gmbus tc3] NAK for addr: 0054 w(1)
<7> [347.901955] xe 0000:03:00.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:538:HDMI-A-3] Failed to read TMDS config: -6
<7> [347.901968] xe 0000:03:00.0: [drm:intel_ddi_enable [xe]] [CONNECTOR:538:HDMI-A-3] Failed to configure sink scrambling/TMDS bit clock ratio
<7> [347.919520] xe 0000:03:00.0: [drm:intel_audio_codec_enable [xe]] [CONNECTOR:538:HDMI-A-3][ENCODER:537:DDI TC3/PHY H] Enable audio codec on [CRTC:504:pipe D], 36 bytes ELD
<7> [347.932183] xe 0000:03:00.0: [drm:intel_audio_component_get_power [xe]] restored AUD_FREQ_CNTRL to 0x8010
<7> [347.936019] xe 0000:03:00.0: [drm:audio_config_hdmi_pixel_clock [xe]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [347.936151] xe 0000:03:00.0: [drm:hsw_audio_config_update [xe]] using automatic N
<7> [347.936649] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:538:HDMI-A-3]
<7> [347.937013] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:504:pipe D]
<6> [350.958840] [IGT] kms_flip: finished subtest D-HDMI-A3, FAIL
<6> [350.962674] [IGT] kms_flip: finished subtest flip-vs-expired-vblank-interruptible, FAIL
<7> [350.968907] xe 0000:03:00.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:557] from all active usage due to RMFB ioctl
<7> [350.969662] xe 0000:03:00.0: [drm:atomic_remove_fb] Disabling [PLANE:388:plane 1D] because [FB:557] is removed
<7> [350.969820] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:388:plane 1D] ddb ( 0 - 1989) -> ( 0 - 0), size 1989 -> 0
<7> [350.970295] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:388: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> [350.970787] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:388: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> [350.971192] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:388: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> [350.971718] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:388: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> [350.972200] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:504:pipe D] data rate 0 num active planes 0
<7> [350.972781] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 0 qgv_peak_bw: 48000
<7> [350.973282] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 0 qgv_peak_bw: 48000
<7> [350.973869] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 0
<7> [350.987584] xe 0000:03:00.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:525:DDI TC2/PHY G][CRTC:150: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> [350.987778] xe 0000:03:00.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 270000 bpp input 36 compressed 0.0000 HDR no link rate required 668250 available 1080000
<7> [350.987938] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:150:pipe A] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [350.988108] xe 0000:03:00.0: [drm:intel_hdmi_compute_clock [xe]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [350.988248] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:268:pipe B] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [350.988396] xe 0000:03:00.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:525:DDI TC2/PHY G] [CRTC:150:pipe A]
<7> [350.988560] xe 0000:03:00.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:537:DDI TC3/PHY H] [CRTC:268:pipe B]
<7> [350.988697] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [350.988827] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [350.988947] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [350.989063] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [350.989184] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 5190451/8388608 link 288358/524288)
<7> [350.989297] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000080)
<7> [350.989408] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [350.989532] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [350.989641] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [350.989747] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [350.989844] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [350.989941] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [350.990038] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [350.990135] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [350.990231] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [350.990326] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [350.990428] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [350.990524] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [350.990620] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [350.990715] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [350.990811] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [350.990904] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [350.990998] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [350.991091] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [350.991186] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [350.991282] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [350.991377] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [350.991483] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [350.991579] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [350.991675] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [350.991771] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [350.991867] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [350.991961] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [350.992053] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [350.992146] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in enhanced_framing (expected no, found yes)
<7> [350.992242] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in dpll_hw_state
<7> [350.992337] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [350.992435] 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> [350.992536] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] c20pll_hw_state:
<7> [350.992631] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] tx[0] = 0xbe88, tx[1] = 0x5800, tx[2] = 0x0000
<7> [350.992727] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [350.992822] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[0] = 0x40e8
<7> [350.992917] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[1] = 0x7d20
<7> [350.993012] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[2] = 0x0a06
<7> [350.993107] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[3] = 0x8f1c
<7> [350.993201] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[4] = 0x0000
<7> [350.993297] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[5] = 0x0000
<7> [350.993391] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[6] = 0x2200
<7> [350.993505] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[7] = 0xffff
<7> [350.993601] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[8] = 0x0400
<7> [350.993696] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[9] = 0x0000
<7> [350.993789] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[10] = 0x0001
<7> [350.993883] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] vdr: custom width: 0x00, serdes rate: 0x00, hdmi rate: 0x00
<7> [350.993975] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [350.994070] 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> [350.994165] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] c20pll_hw_state:
<7> [350.994260] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] tx[0] = 0xbe88, tx[1] = 0x4800, tx[2] = 0x0000
<7> [350.994351] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [350.994447] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[0] = 0x308c
<7> [350.994542] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[1] = 0x2110
<7> [350.994633] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[2] = 0xcc9c
<7> [350.994728] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[3] = 0xbfc1
<7> [350.994822] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[4] = 0x4b9a
<7> [350.994925] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[5] = 0x3f81
<7> [350.995022] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[6] = 0x2000
<7> [350.995119] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[7] = 0x0001
<7> [350.995216] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[8] = 0x5000
<7> [350.995308] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[9] = 0x0000
<7> [350.995403] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[10] = 0x0000
<7> [350.995507] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] vdr: custom width: 0x00, serdes rate: 0x42, hdmi rate: 0x00
<7> [350.995602] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [350.995697] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [350.995791] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [350.995885] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:150:pipe A] fastset requirement not met in port_clock (expected 0, found 270000)
<7> [350.995980] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:150:pipe A] fastset requirement not met, forcing full modeset
<7> [350.996074] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [350.996169] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [350.996259] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [350.996350] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [350.996477] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [350.996574] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [350.996665] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [350.996757] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [350.996848] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [350.996940] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [350.997033] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [350.997125] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [350.997216] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [350.997310] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [350.997400] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [350.997500] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [350.997594] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [350.997685] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [350.997778] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [350.997871] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [350.997962] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [350.998055] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [350.998148] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [350.998240] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [350.998333] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [350.998428] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [350.998521] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [350.998614] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [350.998707] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [350.998799] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [350.998892] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [350.998984] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [350.999076] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [350.999168] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [350.999260] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [350.999353] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [350.999447] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [350.999548] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [350.999647] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in port_clock (expected 0, found 222750)
<7> [350.999744] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [350.999839] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)
<7> [350.999935] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in avi infoframe
<7> [351.000031] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [351.000123] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [351.000216] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [351.000218] xe 0000:03:00.0: colorspace: RGB
<7> [351.000220] xe 0000:03:00.0: scan mode: Underscan
<7> [351.000221] xe 0000:03:00.0: colorimetry: No Data
<7> [351.000222] xe 0000:03:00.0: picture aspect: No Data
<7> [351.000224] xe 0000:03:00.0: active aspect: Same as Picture
<7> [351.000225] xe 0000:03:00.0: itc: No Data
<7> [351.000226] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [351.000227] xe 0000:03:00.0: quantization range: Full
<7> [351.000229] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [351.000230] xe 0000:03:00.0: video code: 0
<7> [351.000231] xe 0000:03:00.0: ycc quantization range: Full
<7> [351.000233] xe 0000:03:00.0: hdmi content type: Graphics
<7> [351.000234] xe 0000:03:00.0: pixel repeat: 0
<7> [351.000235] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [351.000237] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in spd infoframe
<7> [351.000334] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [351.000432] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [351.000528] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [351.000529] xe 0000:03:00.0: vendor: Intel
<7> [351.000531] xe 0000:03:00.0: product: Discrete gfx
<7> [351.000532] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [351.000534] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:268:pipe B] fastset requirement not met in hdmi infoframe
<7> [351.000628] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [351.000723] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [351.000815] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [351.000817] xe 0000:03:00.0: empty frame
<7> [351.000818] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:268:pipe B] fastset requirement not met, forcing full modeset
<7> [351.000914] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.enable (expected yes, found no)
<7> [351.001007] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.active (expected yes, found no)
<7> [351.001102] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in cpu_transcoder (expected 3, found -1)
<7> [351.001196] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in lane_count (expected 4, found 0)
<7> [351.001290] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [351.001385] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [351.001493] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [351.001589] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [351.001682] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [351.001774] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [351.001868] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [351.001963] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [351.002058] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [351.002153] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [351.002247] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [351.002342] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [351.002439] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [351.002533] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [351.002627] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [351.002722] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [351.002816] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [351.002911] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [351.003006] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [351.003100] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [351.003194] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [351.003288] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [351.003382] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [351.003485] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [351.003583] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [351.003681] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [351.003777] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [351.003872] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [351.003966] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [351.004062] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [351.004156] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [351.004249] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [351.004342] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [351.004440] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [351.004533] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in port_clock (expected 222750, found 0)
<7> [351.004626] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [351.004720] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [351.004814] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in avi infoframe
<7> [351.004908] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [351.005001] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [351.005003] xe 0000:03:00.0: colorspace: RGB
<7> [351.005004] xe 0000:03:00.0: scan mode: Underscan
<7> [351.005005] xe 0000:03:00.0: colorimetry: No Data
<7> [351.005007] xe 0000:03:00.0: picture aspect: No Data
<7> [351.005008] xe 0000:03:00.0: active aspect: Same as Picture
<7> [351.005009] xe 0000:03:00.0: itc: No Data
<7> [351.005011] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [351.005012] xe 0000:03:00.0: quantization range: Full
<7> [351.005013] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [351.005015] xe 0000:03:00.0: video code: 0
<7> [351.005016] xe 0000:03:00.0: ycc quantization range: Full
<7> [351.005017] xe 0000:03:00.0: hdmi content type: Graphics
<7> [351.005018] xe 0000:03:00.0: pixel repeat: 0
<7> [351.005020] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [351.005021] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [351.005123] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in spd infoframe
<7> [351.005222] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [351.005318] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [351.005319] xe 0000:03:00.0: vendor: Intel
<7> [351.005321] xe 0000:03:00.0: product: Discrete gfx
<7> [351.005322] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [351.005324] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [351.005419] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:504:pipe D] fastset requirement not met in hdmi infoframe
<7> [351.005527] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [351.005622] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [351.005624] xe 0000:03:00.0: empty frame
<7> [351.005625] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [351.005720] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:504:pipe D] fastset requirement not met, forcing full modeset
<7> [351.005816] xe 0000:03:00.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:504:pipe D] releasing TC PLL 3
<7> [351.005943] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x3 -> 0xf (total dbuf slices 0xf), mbus joined? no->no
<7> [351.006030] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:150:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x8 -> 0x3
<7> [351.006111] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:268:pipe B] dbuf slices 0x0 -> 0xc, ddb (0 - 0) -> (0 - 2048), active pipes 0x8 -> 0x3
<7> [351.006190] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:504:pipe D] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x8 -> 0x3
<7> [351.006271] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:34:plane 1A] ddb ( 0 - 0) -> ( 0 - 1989), size 0 -> 1989
<7> [351.006349] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:144:cursor A] ddb ( 0 - 0) -> (1989 - 2048), size 0 -> 59
<7> [351.006431] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:34:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm
<7> [351.006507] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:34: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> [351.006584] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:34: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> [351.006660] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:34: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> [351.006737] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:152:plane 1B] ddb ( 0 - 0) -> ( 0 - 1989), size 0 -> 1989
<7> [351.006811] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:262:cursor B] ddb ( 0 - 0) -> (1989 - 2048), size 0 -> 59
<7> [351.006884] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:152: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> [351.006958] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:152: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> [351.007032] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:152: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> [351.007106] xe 0000:03:00.0: [drm:skl_print_plane_changes [xe]] [PLANE:152: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> [351.007182] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [PLANE:498:cursor D] ddb (1989 - 2048) -> ( 0 - 0), size 59 -> 0
<7> [351.007269] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:150:pipe A] data rate 594000 num active planes 1
<7> [351.007376] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:268:pipe B] data rate 594000 num active planes 1
<7> [351.007488] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 1248 qgv_peak_bw: 48000
<7> [351.007592] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 1248 qgv_peak_bw: 48000
<7> [351.007694] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 1248
<7> [351.007806] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:150:pipe A] min cdclk: 0 kHz -> 192000 kHz
<7> [351.007909] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:268:pipe B] min cdclk: 0 kHz -> 192000 kHz
<7> [351.008008] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:504:pipe D] min cdclk: 192000 kHz -> 0 kHz
<7> [351.008119] xe 0000:03:00.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 9282 kHz -> 18563 kHz
<7> [351.008236] xe 0000:03:00.0: [drm:intel_find_dpll [xe]] [CRTC:150:pipe A] allocated TC PLL 2
<7> [351.008335] xe 0000:03:00.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:150:pipe A] reserving TC PLL 2
<7> [351.008433] xe 0000:03:00.0: [drm:intel_find_dpll [xe]] [CRTC:268:pipe B] allocated TC PLL 3
<7> [351.008528] xe 0000:03:00.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:268:pipe B] reserving TC PLL 3
<7> [351.008621] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:150:pipe A] enable: yes [modeset]
<7> [351.008728] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: DP (0x80), output format: RGB, sink format: RGB
<7> [351.008832] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 36, dithering: 0
<7> [351.008934] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [351.009032] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [351.009132] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [351.009230] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [351.009328] 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> [351.009436] 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> [351.009535] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: enabled
<7> [351.009632] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [351.009729] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] psr: disabled, selective update: disabled, panel replay: disabled, selective fetch: disabled
<7> [351.009826] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [351.009919] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] audio: 1, infoframes: 0, infoframes enabled: 0x0
<7> [351.010017] 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> [351.010114] 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> [351.010210] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 17 50 51 07 00 00 00 00
<7> [351.010302] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [351.010396] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [351.010501] 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> [351.010600] 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> [351.010696] 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> [351.010792] 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> [351.010885] 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> [351.010979] 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> [351.011075] 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> [351.011171] 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> [351.011267] 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> [351.011359] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] linetime: 119, ips linetime: 0
<7> [351.011460] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [351.011556] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [351.011651] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [351.011745] 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> [351.011838] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] c20pll_hw_state:
<7> [351.011932] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] tx[0] = 0xbe88, tx[1] = 0x4800, tx[2] = 0x0000
<7> [351.012028] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [351.012123] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[0] = 0x308c
<7> [351.012218] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[1] = 0x2110
<7> [351.012314] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[2] = 0xcc9c
<7> [351.012406] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[3] = 0xbfc1
<7> [351.012518] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[4] = 0x4b9a
<7> [351.012615] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[5] = 0x3f81
<7> [351.012710] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[6] = 0x2000
<7> [351.012805] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[7] = 0x0001
<7> [351.012901] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[8] = 0x5000
<7> [351.012996] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[9] = 0x0000
<7> [351.013091] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[10] = 0x0000
<7> [351.013184] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vdr: custom width: 0x00, serdes rate: 0x42, hdmi rate: 0x00
<7> [351.013277] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [351.013373] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [351.013477] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [351.013579] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [351.013673] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [351.013766] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [351.013863] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [351.013955] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [351.014048] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [351.014142] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [351.014237] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [351.014332] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [351.014431] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [351.014525] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:34:plane 1A] fb: [FB:554] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [351.014618] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [351.014713] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [351.014808] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [351.014898] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [351.014992] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [351.015087] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [351.015180] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:144:cursor A] fb: [NOFB], visible: no
<7> [351.015270] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:268:pipe B] enable: yes [modeset]
<7> [351.015361] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [351.015463] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: B, pipe bpp: 36, dithering: 0
<7> [351.015556] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [351.015649] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [351.015744] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [351.015838] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [351.015932] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [351.016026] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] GCP: 0x6
<7> [351.016120] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [351.016122] xe 0000:03:00.0: colorspace: RGB
<7> [351.016123] xe 0000:03:00.0: scan mode: Underscan
<7> [351.016124] xe 0000:03:00.0: colorimetry: No Data
<7> [351.016126] xe 0000:03:00.0: picture aspect: No Data
<7> [351.016127] xe 0000:03:00.0: active aspect: Same as Picture
<7> [351.016128] xe 0000:03:00.0: itc: No Data
<7> [351.016129] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [351.016131] xe 0000:03:00.0: quantization range: Full
<7> [351.016132] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [351.016133] xe 0000:03:00.0: video code: 0
<7> [351.016135] xe 0000:03:00.0: ycc quantization range: Full
<7> [351.016136] xe 0000:03:00.0: hdmi content type: Graphics
<7> [351.016137] xe 0000:03:00.0: pixel repeat: 0
<7> [351.016138] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [351.016140] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [351.016141] xe 0000:03:00.0: vendor: Intel
<7> [351.016143] xe 0000:03:00.0: product: Discrete gfx
<7> [351.016144] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [351.016146] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [351.016147] xe 0000:03:00.0: empty frame
<7> [351.016148] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 10 00 08 00 6d 10 00 01 00 00 00 00 00 00 00 00
<7> [351.016242] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 24 96 11 ed 41 4f 43 32 38 45 38 35 30 2e 48 44
<7> [351.016337] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 52 09 07 07
<7> [351.016438] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [351.016534] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [351.016628] 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> [351.016723] 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> [351.016818] 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> [351.016912] 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> [351.017007] 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> [351.017102] 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> [351.017192] 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> [351.017284] 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> [351.017378] 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> [351.017481] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] linetime: 119, ips linetime: 0
<7> [351.017576] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [351.017671] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [351.017766] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [351.017861] 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> [351.017956] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] c20pll_hw_state:
<7> [351.018050] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] tx[0] = 0xbe88, tx[1] = 0x5800, tx[2] = 0x0000
<7> [351.018145] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [351.018240] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[0] = 0x40e8
<7> [351.018334] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[1] = 0x7d20
<7> [351.018431] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[2] = 0x0a06
<7> [351.018525] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[3] = 0x8f1c
<7> [351.018619] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[4] = 0x0000
<7> [351.018713] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[5] = 0x0000
<7> [351.018807] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[6] = 0x2200
<7> [351.018900] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[7] = 0xffff
<7> [351.018994] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[8] = 0x0400
<7> [351.019087] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[9] = 0x0000
<7> [351.019181] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[10] = 0x0001
<7> [351.019273] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vdr: custom width: 0x00, serdes rate: 0x00, hdmi rate: 0x00
<7> [351.019366] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [351.019467] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [351.019562] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [351.019656] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [351.019750] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [351.019844] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [351.019938] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [351.020032] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [351.020126] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [351.020217] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [351.020310] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [351.020404] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [351.020507] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [351.020602] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:152:plane 1B] fb: [FB:554] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [351.020697] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [351.020798] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [351.020898] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:182:plane 2B] fb: [NOFB], visible: no
<7> [351.020995] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:212:plane 3B] fb: [NOFB], visible: no
<7> [351.021090] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:242:plane 4B] fb: [NOFB], visible: no
<7> [351.021184] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:252:plane 5B] fb: [NOFB], visible: no
<7> [351.021278] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:262:cursor B] fb: [NOFB], visible: no
<7> [351.021372] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:504:pipe D] enable: no [modeset]
<7> [351.021476] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:388:plane 1D] fb: [NOFB], visible: no
<7> [351.021575] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:418:plane 2D] fb: [NOFB], visible: no
<7> [351.021673] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:448:plane 3D] fb: [NOFB], visible: no
<7> [351.021768] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:478:plane 4D] fb: [NOFB], visible: no
<7> [351.021863] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:488:plane 5D] fb: [NOFB], visible: no
<7> [351.021957] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:498:cursor D] fb: [NOFB], visible: no
<7> [351.022662] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_A
<7> [351.022818] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x1 (CLKGATE_DIS_DSSDSC=0x28000000)
<7> [351.022925] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_B
<7> [351.023163] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x2 (CLKGATE_DIS_DSSDSC=0x20000000)
<7> [351.023268] xe 0000:03:00.0: [drm:intel_audio_codec_disable [xe]] [CONNECTOR:538:HDMI-A-3][ENCODER:537:DDI TC3/PHY H] Disable audio codec on [CRTC:504:pipe D]
<7> [351.052992] xe 0000:03:00.0: [drm:intel_audio_component_get_eld [xe]] Not valid for port F
<7> [351.053288] xe 0000:03:00.0: [drm:intel_hdmi_handle_sink_scrambling [xe]] [CONNECTOR:538:HDMI-A-3] scrambling=no, TMDS bit clock ratio=1/10
<7> [351.053627] xe 0000:03:00.0: [drm:do_gmbus_xfer [xe]] GMBUS [i915 gmbus tc3] NAK for addr: 0054 w(1)
<7> [351.053716] xe 0000:03:00.0: [drm:do_gmbus_xfer [xe]] GMBUS [i915 gmbus tc3] NAK on first message, retry
<7> [351.054043] xe 0000:03:00.0: [drm:do_gmbus_xfer [xe]] GMBUS [i915 gmbus tc3] NAK for addr: 0054 w(1)
<7> [351.054127] xe 0000:03:00.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:538:HDMI-A-3] Failed to read TMDS config: -6
<7> [351.054141] xe 0000:03:00.0: [drm:intel_ddi_disable [xe]] [CONNECTOR:538:HDMI-A-3] Failed to reset sink scrambling/TMDS bit clock ratio
<7> [351.054356] xe 0000:03:00.0: [drm:intel_disable_transcoder [xe]] disabling pipe D
<7> [351.074689] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disable TC PLL 3 (active 0x8, on? 1) for [CRTC:504:pipe D]
<7> [351.076346] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disabling TC PLL 3
<7> [351.076777] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:506:DDI TC1/PHY F]
<7> [351.076904] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:508:DP-MST A]
<7> [351.077026] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST B]
<7> [351.077141] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST C]
<7> [351.077254] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:511:DP-MST D]
<7> [351.077368] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:525:DDI TC2/PHY G]
<7> [351.077501] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:527:DP-MST A]
<7> [351.077616] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST B]
<7> [351.077731] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST C]
<7> [351.077752] xe 0000:03:00.0: [drm:intel_audio_component_get_power [xe]] restored AUD_FREQ_CNTRL to 0x8010
<7> [351.077852] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:530:DP-MST D]
<7> [351.077972] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:537:DDI TC3/PHY H]
<7> [351.078087] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:541:DDI TC4/PHY I]
<7> [351.078201] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:543:DP-MST A]
<7> [351.078309] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST B]
<7> [351.078415] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST C]
<7> [351.078536] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:546:DP-MST D]
<7> [351.078861] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [351.079060] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [351.079393] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enable TC PLL 2 (active 0x1, on? 0) for [CRTC:150:pipe A]
<7> [351.079523] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enabling TC PLL 2
<7> [351.082175] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC2
<7> [351.087116] 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> [351.093842] xe 0000:03:00.0: [drm:intel_dp_init_lttpr_and_dprx_caps [xe]] [CONNECTOR:526:DP-2][ENCODER:525:DDI TC2/PHY G][DPRX] LTTPR common capabilities: 00 00 00 00 00 00 00 00
<7> [351.095154] 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> [351.095889] xe 0000:03:00.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:526:DP-2][ENCODER:525:DDI TC2/PHY G][DPRX] Using LINK_BW_SET value 0a
<7> [351.097755] xe 0000:03:00.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:526:DP-2][ENCODER:525:DDI TC2/PHY G][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [351.098559] xe 0000:03:00.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:526:DP-2][ENCODER:525:DDI TC2/PHY G][DPRX] Using DP training pattern TPS1
<7> [351.105357] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:526:DP-2][ENCODER:525:DDI TC2/PHY G][DPRX] Clock recovery OK
<7> [351.105940] xe 0000:03:00.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:526:DP-2][ENCODER:525:DDI TC2/PHY G][DPRX] Using DP training pattern TPS3
<7> [351.113534] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:526:DP-2][ENCODER:525:DDI TC2/PHY G][DPRX] Channel EQ done. DP Training successful
<7> [351.114054] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:526:DP-2][ENCODER:525:DDI TC2/PHY G][DPRX] Link Training passed at link rate = 270000, lane count = 4
<7> [351.115652] xe 0000:03:00.0: [drm:intel_enable_transcoder [xe]] enabling pipe A
<7> [351.116168] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enable TC PLL 3 (active 0x2, on? 0) for [CRTC:268:pipe B]
<7> [351.116353] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enabling TC PLL 3
<7> [351.119132] xe 0000:03:00.0: [drm:intel_enable_transcoder [xe]] enabling pipe B
<7> [351.120283] xe 0000:03:00.0: [drm:intel_hdmi_handle_sink_scrambling [xe]] [CONNECTOR:538:HDMI-A-3] scrambling=no, TMDS bit clock ratio=1/10
<7> [351.120654] xe 0000:03:00.0: [drm:do_gmbus_xfer [xe]] GMBUS [i915 gmbus tc3] NAK for addr: 0054 w(1)
<7> [351.120769] xe 0000:03:00.0: [drm:do_gmbus_xfer [xe]] GMBUS [i915 gmbus tc3] NAK on first message, retry
<7> [351.121125] xe 0000:03:00.0: [drm:do_gmbus_xfer [xe]] GMBUS [i915 gmbus tc3] NAK for addr: 0054 w(1)
<7> [351.121224] xe 0000:03:00.0: [drm:drm_scdc_set_high_tmds_clock_ratio [drm_display_helper]] [CONNECTOR:538:HDMI-A-3] Failed to read TMDS config: -6
<7> [351.121237] xe 0000:03:00.0: [drm:intel_ddi_enable [xe]] [CONNECTOR:538:HDMI-A-3] Failed to configure sink scrambling/TMDS bit clock ratio
<7> [351.138848] xe 0000:03:00.0: [drm:intel_audio_codec_enable [xe]] [CONNECTOR:526:DP-2][ENCODER:525:DDI TC2/PHY G] Enable audio codec on [CRTC:150:pipe A], 40 bytes ELD
<7> [351.150144] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:526:DP-2]
<7> [351.151039] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:150:pipe A]
<7> [351.152080] xe 0000:03:00.0: [drm:intel_audio_component_get_power [xe]] restored AUD_FREQ_CNTRL to 0x8010
<7> [351.155841] xe 0000:03:00.0: [drm:intel_audio_codec_enable [xe]] [CONNECTOR:538:HDMI-A-3][ENCODER:537:DDI TC3/PHY H] Enable audio codec on [CRTC:268:pipe B], 36 bytes ELD
<7> [351.172404] xe 0000:03:00.0: [drm:audio_config_hdmi_pixel_clock [xe]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [351.173144] xe 0000:03:00.0: [drm:hsw_audio_config_update [xe]] using automatic N
<7> [351.174187] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:538:HDMI-A-3]
<7> [351.175009] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:268:pipe B]
<7> [351.180263] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling PW_D
<7> [351.180957] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating disabled for pipe_mask=0x8 (CLKGATE_DIS_DSSDSC=0xa0000000)
<7> [351.181627] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:504:pipe D]
<7> [351.182303] xe 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0
<6> [351.183554] [IGT] kms_flip: exiting, ret=98
<7> [351.216450] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC2
Created at 2026-02-26 19:07:27