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

Result: Fail

integration-manifest git-log-oneline i915_display_info6 igt_runner6 runtimes6 results6.json results6-i915-load.json guc_logs6.tar i915_display_info_post_exec6 boot6 dmesg6

DetailValue
Duration 27.36 seconds
Hostname
shard-dg2-3
Igt-Version
IGT-Version: 2.2-g9410b6926 (x86_64) (Linux: 6.18.0-CI_DRM_17651-g46691bf8a4a5+ x86_64)
Out
Using IGT_SRANDOM=1765326030 for randomisation
Opened device: /dev/dri/card0
Using monotonic timestamps
Starting subtest: flip-vs-expired-vblank
Starting dynamic subtest: A-HDMI-A3
  1920x1080: 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../tests/kms_flip.c:923 run_test_on_crtc_set.constprop.0()
  #2 ../tests/kms_flip.c:1889 run_test()
  #3 ../tests/kms_flip.c:2122 __igt_unique____real_main2045()
  #4 ../tests/kms_flip.c:2045 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest A-HDMI-A3: FAIL (4.149s)
Starting dynamic subtest: B-HDMI-A3
  1920x1080: 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 
Dynamic subtest B-HDMI-A3: SUCCESS (7.749s)
Starting dynamic subtest: C-HDMI-A3
  1920x1080: 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 
Dynamic subtest C-HDMI-A3: SUCCESS (7.731s)
Starting dynamic subtest: D-HDMI-A3
  1920x1080: 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 
Dynamic subtest D-HDMI-A3: SUCCESS (7.705s)
Subtest flip-vs-expired-vblank: FAIL (27.357s)
Err
Starting subtest: flip-vs-expired-vblank
Starting dynamic subtest: A-HDMI-A3
(kms_flip:2622) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:928:
(kms_flip:2622) CRITICAL: Failed assertion: end - start < 500
Dynamic subtest A-HDMI-A3 failed.
**** DEBUG ****
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.570251
last_received_ts = 632.570007
last_seq = 13466
current_ts = 632.586914
current_received_ts = 632.586548
current_seq = 13467
count = 97
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 56us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.586914
last_received_ts = 632.586548
last_seq = 13467
current_ts = 632.603577
current_received_ts = 632.603149
current_seq = 13468
count = 98
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 54us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.603577
last_received_ts = 632.603149
last_seq = 13468
current_ts = 632.620239
current_received_ts = 632.619812
current_seq = 13469
count = 99
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 51us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.620239
last_received_ts = 632.619812
last_seq = 13469
current_ts = 632.636902
current_received_ts = 632.636475
current_seq = 13470
count = 100
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 55us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.636902
last_received_ts = 632.636475
last_seq = 13470
current_ts = 632.653564
current_received_ts = 632.653381
current_seq = 13471
count = 101
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 55us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.653564
last_received_ts = 632.653381
last_seq = 13471
current_ts = 632.670227
current_received_ts = 632.669800
current_seq = 13472
count = 102
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 57us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.670227
last_received_ts = 632.669800
last_seq = 13472
current_ts = 632.686890
current_received_ts = 632.686584
current_seq = 13473
count = 103
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 57us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.686890
last_received_ts = 632.686584
last_seq = 13473
current_ts = 632.703552
current_received_ts = 632.703186
current_seq = 13474
count = 104
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 57us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.703552
last_received_ts = 632.703186
last_seq = 13474
current_ts = 632.720215
current_received_ts = 632.719849
current_seq = 13475
count = 105
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 56us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.720215
last_received_ts = 632.719849
last_seq = 13475
current_ts = 632.736877
current_received_ts = 632.736572
current_seq = 13476
count = 106
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 56us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.736877
last_received_ts = 632.736572
last_seq = 13476
current_ts = 632.753540
current_received_ts = 632.753174
current_seq = 13477
count = 107
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 57us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.753540
last_received_ts = 632.753174
last_seq = 13477
current_ts = 632.770203
current_received_ts = 632.769897
current_seq = 13478
count = 108
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 57us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.770203
last_received_ts = 632.769897
last_seq = 13478
current_ts = 632.786865
current_received_ts = 632.786499
current_seq = 13479
count = 109
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.786865
last_received_ts = 632.786499
last_seq = 13479
current_ts = 632.803528
current_received_ts = 632.803345
current_seq = 13480
count = 110
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 60us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.803528
last_received_ts = 632.803345
last_seq = 13480
current_ts = 632.820190
current_received_ts = 632.819946
current_seq = 13481
count = 111
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 90us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.820190
last_received_ts = 632.819946
last_seq = 13481
current_ts = 632.836853
current_received_ts = 632.836487
current_seq = 13482
count = 112
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 58us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.836853
last_received_ts = 632.836487
last_seq = 13482
current_ts = 632.853516
current_received_ts = 632.853210
current_seq = 13483
count = 113
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 56us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.853516
last_received_ts = 632.853210
last_seq = 13483
current_ts = 632.870178
current_received_ts = 632.869934
current_seq = 13484
count = 114
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 97us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.870178
last_received_ts = 632.869934
last_seq = 13484
current_ts = 632.886841
current_received_ts = 632.886475
current_seq = 13485
count = 115
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 56us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.886841
last_received_ts = 632.886475
last_seq = 13485
current_ts = 632.903564
current_received_ts = 632.903198
current_seq = 13486
count = 116
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.903564
last_received_ts = 632.903198
last_seq = 13486
current_ts = 632.920227
current_received_ts = 632.919922
current_seq = 13487
count = 117
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 96us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.920227
last_received_ts = 632.919922
last_seq = 13487
current_ts = 632.936829
current_received_ts = 632.936462
current_seq = 13488
count = 118
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 57us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.936829
last_received_ts = 632.936462
last_seq = 13488
current_ts = 632.953491
current_received_ts = 632.953125
current_seq = 13489
count = 119
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 54us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.953491
last_received_ts = 632.953125
last_seq = 13489
current_ts = 632.970215
current_received_ts = 632.969849
current_seq = 13490
count = 120
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.970215
last_received_ts = 632.969849
last_seq = 13490
current_ts = 632.986877
current_received_ts = 632.986450
current_seq = 13491
count = 121
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 58us
(kms_flip:2622) DEBUG: name = flip
last_ts = 632.986877
last_received_ts = 632.986450
last_seq = 13491
current_ts = 633.003540
current_received_ts = 633.003174
current_seq = 13492
count = 122
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 55us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.003540
last_received_ts = 633.003174
last_seq = 13492
current_ts = 633.020203
current_received_ts = 633.019836
current_seq = 13493
count = 123
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 56us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.020203
last_received_ts = 633.019836
last_seq = 13493
current_ts = 633.036865
current_received_ts = 633.036499
current_seq = 13494
count = 124
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 58us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.036865
last_received_ts = 633.036499
last_seq = 13494
current_ts = 633.053528
current_received_ts = 633.053162
current_seq = 13495
count = 125
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 56us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.053528
last_received_ts = 633.053162
last_seq = 13495
current_ts = 633.070190
current_received_ts = 633.069824
current_seq = 13496
count = 126
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 55us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.070190
last_received_ts = 633.069824
last_seq = 13496
current_ts = 633.086853
current_received_ts = 633.086487
current_seq = 13497
count = 127
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.086853
last_received_ts = 633.086487
last_seq = 13497
current_ts = 633.103516
current_received_ts = 633.103333
current_seq = 13498
count = 128
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 56us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.103516
last_received_ts = 633.103333
last_seq = 13498
current_ts = 633.120178
current_received_ts = 633.119812
current_seq = 13499
count = 129
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.120178
last_received_ts = 633.119812
last_seq = 13499
current_ts = 633.136841
current_received_ts = 633.136475
current_seq = 13500
count = 130
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.136841
last_received_ts = 633.136475
last_seq = 13500
current_ts = 633.153503
current_received_ts = 633.153320
current_seq = 13501
count = 131
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 58us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.153503
last_received_ts = 633.153320
last_seq = 13501
current_ts = 633.170166
current_received_ts = 633.169800
current_seq = 13502
count = 132
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 56us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.170166
last_received_ts = 633.169800
last_seq = 13502
current_ts = 633.186829
current_received_ts = 633.186462
current_seq = 13503
count = 133
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.186829
last_received_ts = 633.186462
last_seq = 13503
current_ts = 633.203491
current_received_ts = 633.203186
current_seq = 13504
count = 134
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 58us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.203491
last_received_ts = 633.203186
last_seq = 13504
current_ts = 633.220154
current_received_ts = 633.219849
current_seq = 13505
count = 135
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 58us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.220154
last_received_ts = 633.219849
last_seq = 13505
current_ts = 633.236816
current_received_ts = 633.236450
current_seq = 13506
count = 136
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.236816
last_received_ts = 633.236450
last_seq = 13506
current_ts = 633.253479
current_received_ts = 633.253296
current_seq = 13507
count = 137
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 57us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.253479
last_received_ts = 633.253296
last_seq = 13507
current_ts = 633.270142
current_received_ts = 633.269836
current_seq = 13508
count = 138
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.270142
last_received_ts = 633.269836
last_seq = 13508
current_ts = 633.286804
current_received_ts = 633.286438
current_seq = 13509
count = 139
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.286804
last_received_ts = 633.286438
last_seq = 13509
current_ts = 633.303467
current_received_ts = 633.303162
current_seq = 13510
count = 140
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.303467
last_received_ts = 633.303162
last_seq = 13510
current_ts = 633.320129
current_received_ts = 633.319824
current_seq = 13511
count = 141
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 58us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.320129
last_received_ts = 633.319824
last_seq = 13511
current_ts = 633.336853
current_received_ts = 633.336487
current_seq = 13512
count = 142
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.336853
last_received_ts = 633.336487
last_seq = 13512
current_ts = 633.353516
current_received_ts = 633.353271
current_seq = 13513
count = 143
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.353516
last_received_ts = 633.353271
last_seq = 13513
current_ts = 633.370178
current_received_ts = 633.369934
current_seq = 13514
count = 144
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 88us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.370178
last_received_ts = 633.369934
last_seq = 13514
current_ts = 633.386841
current_received_ts = 633.386475
current_seq = 13515
count = 145
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 58us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.386841
last_received_ts = 633.386475
last_seq = 13515
current_ts = 633.403503
current_received_ts = 633.403137
current_seq = 13516
count = 146
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 56us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.403503
last_received_ts = 633.403137
last_seq = 13516
current_ts = 633.420166
current_received_ts = 633.419922
current_seq = 13517
count = 147
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 89us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.420166
last_received_ts = 633.419922
last_seq = 13517
current_ts = 633.436829
current_received_ts = 633.436462
current_seq = 13518
count = 148
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.436829
last_received_ts = 633.436462
last_seq = 13518
current_ts = 633.453491
current_received_ts = 633.453186
current_seq = 13519
count = 149
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.453491
last_received_ts = 633.453186
last_seq = 13519
current_ts = 633.470154
current_received_ts = 633.469788
current_seq = 13520
count = 150
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 56us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.470154
last_received_ts = 633.469788
last_seq = 13520
current_ts = 633.486816
current_received_ts = 633.486450
current_seq = 13521
count = 151
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.486816
last_received_ts = 633.486450
last_seq = 13521
current_ts = 633.503479
current_received_ts = 633.503235
current_seq = 13522
count = 152
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.503479
last_received_ts = 633.503235
last_seq = 13522
current_ts = 633.520142
current_received_ts = 633.519775
current_seq = 13523
count = 153
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 58us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.520142
last_received_ts = 633.519775
last_seq = 13523
current_ts = 633.536804
current_received_ts = 633.536438
current_seq = 13524
count = 154
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.536804
last_received_ts = 633.536438
last_seq = 13524
current_ts = 633.553467
current_received_ts = 633.553162
current_seq = 13525
count = 155
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.553467
last_received_ts = 633.553162
last_seq = 13525
current_ts = 633.570129
current_received_ts = 633.569763
current_seq = 13526
count = 156
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.570129
last_received_ts = 633.569763
last_seq = 13526
current_ts = 633.586792
current_received_ts = 633.586365
current_seq = 13527
count = 157
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.586792
last_received_ts = 633.586365
last_seq = 13527
current_ts = 633.603455
current_received_ts = 633.603149
current_seq = 13528
count = 158
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.603455
last_received_ts = 633.603149
last_seq = 13528
current_ts = 633.620117
current_received_ts = 633.619873
current_seq = 13529
count = 159
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.620117
last_received_ts = 633.619873
last_seq = 13529
current_ts = 633.636780
current_received_ts = 633.636475
current_seq = 13530
count = 160
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 58us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.636780
last_received_ts = 633.636475
last_seq = 13530
current_ts = 633.653442
current_received_ts = 633.653076
current_seq = 13531
count = 161
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 56us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.653442
last_received_ts = 633.653076
last_seq = 13531
current_ts = 633.670105
current_received_ts = 633.669800
current_seq = 13532
count = 162
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.670105
last_received_ts = 633.669800
last_seq = 13532
current_ts = 633.686768
current_received_ts = 633.686401
current_seq = 13533
count = 163
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.686768
last_received_ts = 633.686401
last_seq = 13533
current_ts = 633.703430
current_received_ts = 633.703125
current_seq = 13534
count = 164
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 60us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.703430
last_received_ts = 633.703125
last_seq = 13534
current_ts = 633.720093
current_received_ts = 633.719788
current_seq = 13535
count = 165
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.720093
last_received_ts = 633.719788
last_seq = 13535
current_ts = 633.736755
current_received_ts = 633.736389
current_seq = 13536
count = 166
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 58us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.736755
last_received_ts = 633.736389
last_seq = 13536
current_ts = 633.753479
current_received_ts = 633.753174
current_seq = 13537
count = 167
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.753479
last_received_ts = 633.753174
last_seq = 13537
current_ts = 633.770142
current_received_ts = 633.769836
current_seq = 13538
count = 168
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.770142
last_received_ts = 633.769836
last_seq = 13538
current_ts = 633.786804
current_received_ts = 633.786377
current_seq = 13539
count = 169
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.786804
last_received_ts = 633.786377
last_seq = 13539
current_ts = 633.803467
current_received_ts = 633.803101
current_seq = 13540
count = 170
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.803467
last_received_ts = 633.803101
last_seq = 13540
current_ts = 633.820129
current_received_ts = 633.819763
current_seq = 13541
count = 171
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 58us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.820129
last_received_ts = 633.819763
last_seq = 13541
current_ts = 633.836792
current_received_ts = 633.836487
current_seq = 13542
count = 172
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.836792
last_received_ts = 633.836487
last_seq = 13542
current_ts = 633.853455
current_received_ts = 633.853210
current_seq = 13543
count = 173
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.853455
last_received_ts = 633.853210
last_seq = 13543
current_ts = 633.870117
current_received_ts = 633.869751
current_seq = 13544
count = 174
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.870117
last_received_ts = 633.869751
last_seq = 13544
current_ts = 633.886780
current_received_ts = 633.886353
current_seq = 13545
count = 175
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 55us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.886780
last_received_ts = 633.886353
last_seq = 13545
current_ts = 633.903442
current_received_ts = 633.903198
current_seq = 13546
count = 176
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.903442
last_received_ts = 633.903198
last_seq = 13546
current_ts = 633.920105
current_received_ts = 633.919861
current_seq = 13547
count = 177
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.920105
last_received_ts = 633.919861
last_seq = 13547
current_ts = 633.936768
current_received_ts = 633.936462
current_seq = 13548
count = 178
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.936768
last_received_ts = 633.936462
last_seq = 13548
current_ts = 633.953430
current_received_ts = 633.953125
current_seq = 13549
count = 179
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.953430
last_received_ts = 633.953125
last_seq = 13549
current_ts = 633.970093
current_received_ts = 633.969727
current_seq = 13550
count = 180
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.970093
last_received_ts = 633.969727
last_seq = 13550
current_ts = 633.986755
current_received_ts = 633.986511
current_seq = 13551
count = 181
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 633.986755
last_received_ts = 633.986511
last_seq = 13551
current_ts = 634.003418
current_received_ts = 634.003113
current_seq = 13552
count = 182
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 58us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.003418
last_received_ts = 634.003113
last_seq = 13552
current_ts = 634.020081
current_received_ts = 634.019836
current_seq = 13553
count = 183
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 60us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.020081
last_received_ts = 634.019836
last_seq = 13553
current_ts = 634.036743
current_received_ts = 634.036377
current_seq = 13554
count = 184
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 60us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.036743
last_received_ts = 634.036377
last_seq = 13554
current_ts = 634.053406
current_received_ts = 634.053162
current_seq = 13555
count = 185
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.053406
last_received_ts = 634.053162
last_seq = 13555
current_ts = 634.070068
current_received_ts = 634.069763
current_seq = 13556
count = 186
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.070068
last_received_ts = 634.069763
last_seq = 13556
current_ts = 634.086731
current_received_ts = 634.086365
current_seq = 13557
count = 187
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.086731
last_received_ts = 634.086365
last_seq = 13557
current_ts = 634.103394
current_received_ts = 634.103210
current_seq = 13558
count = 188
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 58us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.103394
last_received_ts = 634.103210
last_seq = 13558
current_ts = 634.120056
current_received_ts = 634.119751
current_seq = 13559
count = 189
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 58us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.120056
last_received_ts = 634.119751
last_seq = 13559
current_ts = 634.136780
current_received_ts = 634.136475
current_seq = 13560
count = 190
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.136780
last_received_ts = 634.136475
last_seq = 13560
current_ts = 634.153381
current_received_ts = 634.153076
current_seq = 13561
count = 191
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 56us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.153381
last_received_ts = 634.153076
last_seq = 13561
current_ts = 634.170105
current_received_ts = 634.169739
current_seq = 13562
count = 192
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.170105
last_received_ts = 634.169739
last_seq = 13562
current_ts = 634.186768
current_received_ts = 634.186462
current_seq = 13563
count = 193
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.186768
last_received_ts = 634.186462
last_seq = 13563
current_ts = 634.203430
current_received_ts = 634.203125
current_seq = 13564
count = 194
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 57us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.203430
last_received_ts = 634.203125
last_seq = 13564
current_ts = 634.220093
current_received_ts = 634.219727
current_seq = 13565
count = 195
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.220093
last_received_ts = 634.219727
last_seq = 13565
current_ts = 634.236755
current_received_ts = 634.236328
current_seq = 13566
count = 196
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 60us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.236755
last_received_ts = 634.236328
last_seq = 13566
current_ts = 634.253418
current_received_ts = 634.253174
current_seq = 13567
count = 197
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.253418
last_received_ts = 634.253174
last_seq = 13567
current_ts = 634.270081
current_received_ts = 634.269836
current_seq = 13568
count = 198
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 58us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.270081
last_received_ts = 634.269836
last_seq = 13568
current_ts = 634.286743
current_received_ts = 634.286316
current_seq = 13569
count = 199
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 56us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.286743
last_received_ts = 634.286316
last_seq = 13569
current_ts = 634.303406
current_received_ts = 634.303162
current_seq = 13570
count = 200
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.303406
last_received_ts = 634.303162
last_seq = 13570
current_ts = 634.320068
current_received_ts = 634.319824
current_seq = 13571
count = 201
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 58us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.320068
last_received_ts = 634.319824
last_seq = 13571
current_ts = 634.336731
current_received_ts = 634.336365
current_seq = 13572
count = 202
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 58us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.336731
last_received_ts = 634.336365
last_seq = 13572
current_ts = 634.353394
current_received_ts = 634.353088
current_seq = 13573
count = 203
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.353394
last_received_ts = 634.353088
last_seq = 13573
current_ts = 634.370056
current_received_ts = 634.369751
current_seq = 13574
count = 204
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 58us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.370056
last_received_ts = 634.369751
last_seq = 13574
current_ts = 634.386719
current_received_ts = 634.386475
current_seq = 13575
count = 205
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 58us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.386719
last_received_ts = 634.386475
last_seq = 13575
current_ts = 634.403381
current_received_ts = 634.403076
current_seq = 13576
count = 206
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.403381
last_received_ts = 634.403076
last_seq = 13576
current_ts = 634.420044
current_received_ts = 634.419739
current_seq = 13577
count = 207
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.420044
last_received_ts = 634.419739
last_seq = 13577
current_ts = 634.436707
current_received_ts = 634.436401
current_seq = 13578
count = 208
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.436707
last_received_ts = 634.436401
last_seq = 13578
current_ts = 634.453369
current_received_ts = 634.453064
current_seq = 13579
count = 209
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.453369
last_received_ts = 634.453064
last_seq = 13579
current_ts = 634.470032
current_received_ts = 634.469788
current_seq = 13580
count = 210
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.470032
last_received_ts = 634.469788
last_seq = 13580
current_ts = 634.486694
current_received_ts = 634.486328
current_seq = 13581
count = 211
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.486694
last_received_ts = 634.486328
last_seq = 13581
current_ts = 634.503357
current_received_ts = 634.503113
current_seq = 13582
count = 212
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 60us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.503357
last_received_ts = 634.503113
last_seq = 13582
current_ts = 634.520081
current_received_ts = 634.519775
current_seq = 13583
count = 213
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.520081
last_received_ts = 634.519775
last_seq = 13583
current_ts = 634.536682
current_received_ts = 634.536438
current_seq = 13584
count = 214
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 59us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.536682
last_received_ts = 634.536438
last_seq = 13584
current_ts = 634.553406
current_received_ts = 634.553040
current_seq = 13585
count = 215
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 57us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.553406
last_received_ts = 634.553040
last_seq = 13585
current_ts = 634.570068
current_received_ts = 634.569702
current_seq = 13586
count = 216
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 56us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.570068
last_received_ts = 634.569702
last_seq = 13586
current_ts = 634.586731
current_received_ts = 634.586365
current_seq = 13587
count = 217
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 60us
(kms_flip:2622) DEBUG: name = flip
last_ts = 634.586731
last_received_ts = 634.586365
last_seq = 13587
current_ts = 634.603394
current_received_ts = 634.603027
current_seq = 13588
count = 218
seq_step = 1
(kms_flip:2622) DEBUG: Vblank took 539us
(kms_flip:2622) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:928:
(kms_flip:2622) CRITICAL: Failed assertion: end - start < 500
(kms_flip:2622) igt_core-INFO: Stack trace:
(kms_flip:2622) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(kms_flip:2622) igt_core-INFO:   #1 ../tests/kms_flip.c:923 run_test_on_crtc_set.constprop.0()
(kms_flip:2622) igt_core-INFO:   #2 ../tests/kms_flip.c:1889 run_test()
(kms_flip:2622) igt_core-INFO:   #3 ../tests/kms_flip.c:2122 __igt_unique____real_main2045()
(kms_flip:2622) igt_core-INFO:   #4 ../tests/kms_flip.c:2045 main()
(kms_flip:2622) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:2622) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:2622) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest A-HDMI-A3: FAIL (4.149s)
Starting dynamic subtest: B-HDMI-A3
Dynamic subtest B-HDMI-A3: SUCCESS (7.749s)
Starting dynamic subtest: C-HDMI-A3
Dynamic subtest C-HDMI-A3: SUCCESS (7.731s)
Starting dynamic subtest: D-HDMI-A3
Dynamic subtest D-HDMI-A3: SUCCESS (7.705s)
Subtest flip-vs-expired-vblank: FAIL (27.357s)
Dmesg
<6> [629.813252] Console: switching to colour dummy device 80x25
<6> [629.813758] [IGT] kms_flip: executing
<7> [629.831407] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<7> [629.833272] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [629.845022] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<7> [629.853831] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:506:DP-1]
<7> [629.853839] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:506:DP-1]
<7> [629.858097] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:506:DP-1] disconnected
<7> [629.858473] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:519:DP-2]
<7> [629.858478] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:519:DP-2]
<7> [629.862729] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:519:DP-2] disconnected
<7> [629.863141] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:528:HDMI-A-1]
<7> [629.863146] i915 0000:03:00.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:528:HDMI-A-1]
<7> [629.867406] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:528:HDMI-A-1] disconnected
<7> [629.867834] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:534:DP-3]
<7> [629.867839] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:534:DP-3]
<7> [629.872099] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:534:DP-3] disconnected
<7> [629.872472] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:542:HDMI-A-2]
<7> [629.872476] i915 0000:03:00.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:542:HDMI-A-2]
<7> [629.876715] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:542:HDMI-A-2] disconnected
<7> [629.877133] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:546:DP-4]
<7> [629.877138] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:546:DP-4]
<7> [629.877394] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling AUX_D
<7> [629.899595] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [629.920736] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [629.941869] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [629.963000] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [629.984128] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.005286] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.026427] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.047568] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.068739] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.089876] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.111034] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.132189] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.153344] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.174502] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.195699] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.216834] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.237990] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.259148] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.280305] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.301459] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.322600] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.343767] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.364924] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.386077] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.407234] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.428387] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.449543] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.470738] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.491901] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.513043] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.534183] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.555337] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.555567] i915 0000:03:00.0: [drm:drm_dp_dpcd_access [drm_display_helper]] AUX D/DDI D/PHY D: Too many retries, giving up. First error: -110
<7> [630.555599] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:546:DP-4] disconnected
<7> [630.556380] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:506:DP-1]
<7> [630.556386] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:506:DP-1]
<7> [630.560663] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:506:DP-1] disconnected
<7> [630.560679] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:519:DP-2]
<7> [630.560683] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:519:DP-2]
<7> [630.565016] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:519:DP-2] disconnected
<7> [630.565031] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:528:HDMI-A-1]
<7> [630.565035] i915 0000:03:00.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:528:HDMI-A-1]
<7> [630.569287] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:528:HDMI-A-1] disconnected
<7> [630.569302] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:534:DP-3]
<7> [630.569306] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:534:DP-3]
<7> [630.573534] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:534:DP-3] disconnected
<7> [630.573549] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:542:HDMI-A-2]
<7> [630.573553] i915 0000:03:00.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:542:HDMI-A-2]
<7> [630.577781] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:542:HDMI-A-2] disconnected
<7> [630.577802] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:546:DP-4]
<7> [630.577832] i915 0000:03:00.0: [drm:intel_dp_detect [i915]] [CONNECTOR:546:DP-4]
<7> [630.598974] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.620093] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.641236] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.662361] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.683502] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.704693] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.725855] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.747011] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.768152] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.789307] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.810464] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.831606] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.852779] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.873937] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.895076] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.916235] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.937392] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.958551] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [630.979705] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [631.000873] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [631.022032] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [631.043180] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [631.064339] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [631.085490] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [631.106647] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [631.127786] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [631.148946] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [631.170104] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [631.191257] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [631.212395] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [631.233551] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [631.254707] i915 0000:03:00.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DDI D/PHY D: timeout (status 0x7d40023f)
<7> [631.254929] i915 0000:03:00.0: [drm:drm_dp_dpcd_access [drm_display_helper]] AUX D/DDI D/PHY D: Too many retries, giving up. First error: -110
<7> [631.254974] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:546:DP-4] disconnected
<7> [631.254998] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:554:HDMI-A-3]
<7> [631.255004] i915 0000:03:00.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:554:HDMI-A-3]
<7> [631.279332] i915 0000:03:00.0: [drm:update_display_info.part.0] [CONNECTOR:554:HDMI-A-3] ELD monitor FH-DP4K
<7> [631.279337] i915 0000:03:00.0: [drm:update_display_info.part.0] [CONNECTOR:554:HDMI-A-3] ELD size 36, SAD count 2
<7> [631.279499] i915 0000:03:00.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK for addr: 0040 w(1)
<7> [631.279688] i915 0000:03:00.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK on first message, retry
<7> [631.280019] i915 0000:03:00.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK for addr: 0040 w(1)
<7> [631.280223] i915 0000:03:00.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: (err -6)
<7> [631.280237] i915 0000:03:00.0: [drm:intel_hdmi_set_edid [i915]] Assuming DP dual mode adaptor presence based on VBT
<7> [631.280419] i915 0000:03:00.0: [drm:intel_hdmi_set_edid [i915]] DP dual mode adaptor (type 1 DVI) detected (max TMDS clock: 165000 kHz)
<7> [631.281143] i915 0000:03:00.0: [drm:drm_mode_prune_invalid] Rejected mode: "2560x1440": 60 241700 2560 2608 2640 2720 1440 1443 1448 1481 0x40 0x9 (CLOCK_HIGH)
<7> [631.281151] i915 0000:03:00.0: [drm:drm_mode_prune_invalid] Rejected mode: "2560x1600": 60 267820 2560 2608 2640 2720 1600 1603 1608 1641 0x40 0x9 (CLOCK_HIGH)
<7> [631.281156] i915 0000:03:00.0: [drm:drm_mode_prune_invalid] Rejected mode: "1920x1080": 120 297000 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5 (CLOCK_HIGH)
<7> [631.281160] i915 0000:03:00.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 30 266640 3840 3888 3920 4000 2160 2163 2168 2222 0x40 0x9 (CLOCK_HIGH)
<7> [631.281165] i915 0000:03:00.0: [drm:drm_mode_prune_invalid] Rejected mode: "1920x1080": 120 296703 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5 (CLOCK_HIGH)
<7> [631.281171] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:554:HDMI-A-3] probed modes:
<7> [631.281175] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [631.281178] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 17 151100 3840 3888 3920 4000 2160 2163 2168 2222 0x40 0x9
<7> [631.281181] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1600": 30 133910 2560 2608 2640 2720 1600 1603 1608 1641 0x40 0x9
<7> [631.281185] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1440": 30 120850 2560 2608 2640 2720 1440 1443 1448 1481 0x40 0x9
<7> [631.281188] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1200": 60 154000 1920 1968 2000 2080 1200 1203 1209 1235 0x40 0x9
<7> [631.281191] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148352 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [631.281194] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1680x1050": 60 119000 1680 1728 1760 1840 1050 1053 1059 1080 0x40 0x9
<7> [631.281197] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x900": 60 108000 1600 1624 1704 1800 900 901 904 1000 0x40 0x5
<7> [631.281200] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 75 135000 1280 1296 1440 1688 1024 1025 1028 1066 0x40 0x5
<7> [631.281203] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 60 108000 1280 1328 1440 1688 1024 1025 1028 1066 0x40 0x5
<7> [631.281206] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1440x900": 60 88750 1440 1488 1520 1600 900 903 909 926 0x40 0x9
<7> [631.281210] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x800": 60 71000 1280 1328 1360 1440 800 803 809 823 0x40 0x9
<7> [631.281213] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1152x864": 75 108000 1152 1216 1344 1600 864 865 868 900 0x40 0x5
<7> [631.281216] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [631.281219] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [631.281222] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 75 78750 1024 1040 1136 1312 768 769 772 800 0x40 0x5
<7> [631.281225] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 70 75000 1024 1048 1184 1328 768 771 777 806 0x40 0xa
<7> [631.281229] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [631.281232] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 75 49500 800 816 896 1056 600 601 604 625 0x40 0x5
<7> [631.281235] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 72 50000 800 856 976 1040 600 637 643 666 0x40 0x5
<7> [631.281238] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5
<7> [631.281241] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5
<7> [631.281244] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 75 31500 640 656 720 840 480 481 484 500 0x40 0xa
<7> [631.281247] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 73 31500 640 664 704 832 480 489 492 520 0x40 0xa
<7> [631.281250] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25200 640 656 752 800 480 490 492 525 0x40 0xa
<7> [631.281253] i915 0000:03:00.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<6> [631.282161] [IGT] kms_flip: starting subtest flip-vs-expired-vblank
<6> [631.288774] [IGT] kms_flip: starting dynamic subtest A-HDMI-A3
<7> [631.289228] i915 0000:03:00.0: [drm:drm_mode_addfb2] [FB:558]
<7> [631.289360] i915 0000:03:00.0: [drm:drm_mode_addfb2] [FB:561]
<7> [631.289665] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [631.290156] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [631.298946] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling AUX_D
<7> [631.347566] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [631.347957] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [631.353538] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [631.353880] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [631.374431] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [631.374778] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [631.399938] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:149:pipe A]
<7> [631.400037] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [631.400264] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [631.400471] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [631.400677] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [631.400894] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [631.401143] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [631.401351] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [631.401557] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [631.401763] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [631.402010] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [631.402216] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [631.402421] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [631.402626] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [631.402833] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [631.403082] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [631.403288] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [631.403493] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [631.403698] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [631.403946] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [631.404152] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [631.404357] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [631.404562] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [631.404767] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [631.405014] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [631.405220] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [631.405425] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [631.405630] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [631.405835] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [631.406080] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [631.406286] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [631.406491] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [631.406696] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [631.406929] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [631.407150] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [631.407356] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [631.407562] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [631.407768] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in port_clock (expected 148500, found 0)
<7> [631.408012] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:149:pipe A] fastset requirement not met, forcing full modeset
<7> [631.408242] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0xf), mbus joined? no->no
<7> [631.408440] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [CRTC:149:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [631.408660] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:33:plane 1A] ddb ( 0 - 1963) -> ( 0 - 0), size 1963 -> 0
<7> [631.408858] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:143:cursor A] ddb (1963 - 2048) -> ( 0 - 0), size 85 -> 0
<7> [631.409102] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [631.409298] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] lines 1, 3, 4, 5, 9, 11, 17, 25, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [631.409496] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] blocks 16, 49, 65, 81, 145, 177, 273, 401, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [631.409693] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] min_ddb 19, 55, 73, 91, 161, 196, 302, 443, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [631.409947] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:149:pipe A] data rate 0 num active planes 0
<7> [631.410182] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 50000 required 0
<7> [631.410401] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:149:pipe A] min cdclk: 74250 kHz -> 0 kHz
<7> [631.410622] i915 0000:03:00.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 9282 kHz -> 0 kHz
<7> [631.410827] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 163200 kHz, actual 163200 kHz
<7> [631.411070] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [631.411276] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [CRTC:149:pipe A] enable: no [modeset]
<7> [631.411481] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:33:plane 1A] fb: [NOFB], visible: no
<7> [631.411685] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 2A] fb: [NOFB], visible: no
<7> [631.411895] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:93:plane 3A] fb: [NOFB], visible: no
<7> [631.412163] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:123:plane 4A] fb: [NOFB], visible: no
<7> [631.412367] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:133:plane 5A] fb: [NOFB], visible: no
<7> [631.412571] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:143:cursor A] fb: [NOFB], visible: no
<7> [631.415246] i915 0000:03:00.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [631.432217] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_D
<7> [631.432532] i915 0000:03:00.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:33:plane 1A]
<7> [631.432777] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:505:DDI A/PHY A]
<7> [631.433016] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:507:DP-MST A]
<7> [631.433257] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:508:DP-MST B]
<7> [631.433472] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:509:DP-MST C]
<7> [631.433686] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:510:DP-MST D]
<7> [631.433910] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:518:DDI B/PHY B]
<7> [631.434125] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:520:DP-MST A]
<7> [631.434339] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:521:DP-MST B]
<7> [631.434552] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:522:DP-MST C]
<7> [631.434765] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:523:DP-MST D]
<7> [631.434987] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:533:DDI C/PHY C]
<7> [631.435204] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:535:DP-MST A]
<7> [631.435417] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:536:DP-MST B]
<7> [631.435630] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:537:DP-MST C]
<7> [631.435843] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:538:DP-MST D]
<7> [631.436067] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:545:DDI D/PHY D]
<7> [631.436304] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:547:DP-MST A]
<7> [631.436521] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:548:DP-MST B]
<7> [631.436736] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:549:DP-MST C]
<7> [631.436958] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:550:DP-MST D]
<7> [631.437172] i915 0000:03:00.0: [drm:verify_connector_state [i915]] [CONNECTOR:554:HDMI-A-3]
<7> [631.437429] i915 0000:03:00.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [631.437758] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling PW_A
<7> [631.438054] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling PW_2
<7> [631.438315] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:149:pipe A]
<7> [631.438749] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:267:pipe B]
<7> [631.438930] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:385:pipe C]
<7> [631.439081] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:503:pipe D]
<7> [631.439236] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:149:pipe A]
<7> [631.439269] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CONNECTOR:554:HDMI-A-3]
<7> [631.439342] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CONNECTOR:554:HDMI-A-3] Limiting display bpp to 24 (EDID bpp 0, max requested bpp 36, max platform bpp 36)
<7> [631.439579] i915 0000:03:00.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [631.439783] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:149:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [631.440015] i915 0000:03:00.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:545:DDI D/PHY D] [CRTC:149:pipe A]
<7> [631.440225] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [631.440446] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [631.440667] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [631.440896] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [631.441118] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [631.441339] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [631.441560] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [631.441781] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [631.442008] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [631.442230] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [631.442451] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [631.442672] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [631.442900] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [631.443121] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [631.443341] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [631.443561] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [631.443782] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [631.444012] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [631.444234] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [631.444455] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [631.444676] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [631.444904] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [631.445124] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [631.445345] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [631.445565] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [631.445787] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [631.446012] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [631.446233] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [631.446455] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [631.446675] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [631.446902] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [631.447123] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [631.447345] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [631.447566] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [631.447787] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [631.448070] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [631.448292] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in port_clock (expected 0, found 148500)
<7> [631.448513] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:149:pipe A] fastset requirement not met, forcing full modeset
<7> [631.448761] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0xf), mbus joined? no->no
<7> [631.448981] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [CRTC:149:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x1
<7> [631.449220] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:33:plane 1A] ddb ( 0 - 0) -> ( 0 - 1963), size 0 -> 1963
<7> [631.449431] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:143:cursor A] ddb ( 0 - 0) -> (1963 - 2048), size 0 -> 85
<7> [631.449642] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [631.449852] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 4, 4, 5, 9, 11, 17, 25, 0, 0, 0
<7> [631.450071] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 62, 62, 62, 78, 139, 169, 261, 383, 137, 0, 0
<7> [631.450283] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 123, 123, 123, 184, 245, 245, 367, 489, 138, 0, 0
<7> [631.450511] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:149:pipe A] data rate 594000 num active planes 1
<7> [631.450732] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 50000 required 624
<7> [631.450958] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [631.451193] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:149:pipe A] min cdclk: 0 kHz -> 74250 kHz
<7> [631.451427] i915 0000:03:00.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 0 kHz -> 9282 kHz
<7> [631.451650] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 163200 kHz, actual 163200 kHz
<7> [631.451868] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [631.452097] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [CRTC:149:pipe A] enable: yes [modeset]
<7> [631.452317] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [631.452536] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [631.452755] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [631.452982] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [631.453202] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [631.453422] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [631.453641] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [631.453860] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [631.454085] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [631.454305] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 0, guardband: 45 vsync start: 41, vsync end: 36
<7> [631.454525] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1080, vmax vblank: 1080, vmin vtotal: 1125, vmax vtotal: 1125
<7> [631.454745] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [631.454972] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [631.455191] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] 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> [631.455412] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [631.455632] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] 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> [631.455851] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] port clock: 148500, pipe src: 1920x1080+0+0, pixel rate 148500, min cdclk 74250
<7> [631.456079] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] linetime: 119, ips linetime: 0
<7> [631.456300] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [631.456520] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [631.456740] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [631.456970] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x24414, dpll_md: 0x18000000, fp0: 0x8801ef8, fp1: 0x2b000440
<7> [631.457021] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [631.457191] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [631.457285] i915 0000:03:00.0: [drm:gen9_enable_dc5 [i915]] Enabling DC5
<7> [631.457411] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [631.457510] i915 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 01
<7> [631.457630] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [631.457850] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [631.458077] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [631.458296] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [631.458516] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [631.458735] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [631.458960] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [631.459179] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [631.459398] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [631.459618] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [631.459838] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [631.460065] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:33:plane 1A] fb: [FB:558] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [631.460286] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [631.460505] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [631.460725] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 2A] fb: [NOFB], visible: no
<7> [631.460951] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:93:plane 3A] fb: [NOFB], visible: no
<7> [631.461171] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:123:plane 4A] fb: [NOFB], visible: no
<7> [631.461390] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:133:plane 5A] fb: [NOFB], visible: no
<7> [631.461609] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:143:cursor A] fb: [NOFB], visible: no
<7> [631.462226] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [631.462574] i915 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 01 to 00
<7> [631.462999] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_A
<7> [631.463267] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_2
<7> [631.463512] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:505:DDI A/PHY A]
<7> [631.463727] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:507:DP-MST A]
<7> [631.463948] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:508:DP-MST B]
<7> [631.464162] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:509:DP-MST C]
<7> [631.464375] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:510:DP-MST D]
<7> [631.464589] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:518:DDI B/PHY B]
<7> [631.464803] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:520:DP-MST A]
<7> [631.465023] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:521:DP-MST B]
<7> [631.465237] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:522:DP-MST C]
<7> [631.465451] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:523:DP-MST D]
<7> [631.465665] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:533:DDI C/PHY C]
<7> [631.465877] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:535:DP-MST A]
<7> [631.466099] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:536:DP-MST B]
<7> [631.466312] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:537:DP-MST C]
<7> [631.466526] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:538:DP-MST D]
<7> [631.466739] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:545:DDI D/PHY D]
<7> [631.466957] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:547:DP-MST A]
<7> [631.467171] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:548:DP-MST B]
<7> [631.467385] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:549:DP-MST C]
<7> [631.467599] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:550:DP-MST D]
<7> [631.467813] i915 0000:03:00.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [631.468286] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_D
<7> [631.468631] i915 0000:03:00.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [631.470911] i915 0000:03:00.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1
<7> [631.471134] i915 0000:03:00.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:33:plane 1A]
<7> [631.487760] i915 0000:03:00.0: [drm:verify_connector_state [i915]] [CONNECTOR:554:HDMI-A-3]
<7> [631.488091] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:149:pipe A]
<6> [635.439797] [IGT] kms_flip: finished subtest A-HDMI-A3, FAIL
<6> [635.443559] [IGT] kms_flip: starting dynamic subtest B-HDMI-A3
<7> [635.445131] i915 0000:03:00.0: [drm:drm_mode_addfb2] [FB:562]
<7> [635.445831] i915 0000:03:00.0: [drm:drm_mode_addfb2] [FB:563]
<7> [635.446847] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [635.448904] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [635.495909] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [635.496380] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [635.503048] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [635.503480] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [635.523774] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [635.524125] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [635.549288] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:149:pipe A]
<7> [635.549430] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [635.549680] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [635.549888] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [635.550095] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [635.550301] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [635.550549] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [635.550755] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [635.550960] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [635.551166] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [635.551376] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [635.551616] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [635.551820] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [635.552025] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [635.552231] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [635.552475] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [635.552681] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [635.552888] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [635.553093] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [635.553298] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [635.553549] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [635.553756] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [635.553961] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [635.554167] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [635.554379] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [635.554618] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [635.554824] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [635.555030] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [635.555236] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [635.555480] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [635.555717] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [635.555924] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [635.556129] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [635.556335] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [635.556582] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [635.556788] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [635.556996] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [635.557207] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in port_clock (expected 148500, found 0)
<7> [635.557452] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:149:pipe A] fastset requirement not met, forcing full modeset
<7> [635.557681] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0xf), mbus joined? no->no
<7> [635.557878] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [CRTC:149:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [635.558097] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:33:plane 1A] ddb ( 0 - 1963) -> ( 0 - 0), size 1963 -> 0
<7> [635.558293] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:143:cursor A] ddb (1963 - 2048) -> ( 0 - 0), size 85 -> 0
<7> [635.558527] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [635.558724] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] lines 4, 4, 4, 5, 9, 11, 17, 25, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [635.558921] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] blocks 62, 62, 62, 78, 139, 169, 261, 383, 137, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [635.559118] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] min_ddb 123, 123, 123, 184, 245, 245, 367, 489, 138, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [635.559333] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:149:pipe A] data rate 0 num active planes 0
<7> [635.559581] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 50000 required 0
<7> [635.559802] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:149:pipe A] min cdclk: 74250 kHz -> 0 kHz
<7> [635.560022] i915 0000:03:00.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 9282 kHz -> 0 kHz
<7> [635.560227] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 163200 kHz, actual 163200 kHz
<7> [635.560469] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [635.560674] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [CRTC:149:pipe A] enable: no [modeset]
<7> [635.560879] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:33:plane 1A] fb: [NOFB], visible: no
<7> [635.561084] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 2A] fb: [NOFB], visible: no
<7> [635.561289] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:93:plane 3A] fb: [NOFB], visible: no
<7> [635.561532] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:123:plane 4A] fb: [NOFB], visible: no
<7> [635.561738] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:133:plane 5A] fb: [NOFB], visible: no
<7> [635.561942] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:143:cursor A] fb: [NOFB], visible: no
<7> [635.571079] i915 0000:03:00.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [635.587675] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_D
<7> [635.587975] i915 0000:03:00.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:33:plane 1A]
<7> [635.588205] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:505:DDI A/PHY A]
<7> [635.588431] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:507:DP-MST A]
<7> [635.588700] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:508:DP-MST B]
<7> [635.588903] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:509:DP-MST C]
<7> [635.589103] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:510:DP-MST D]
<7> [635.589302] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:518:DDI B/PHY B]
<7> [635.589511] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:520:DP-MST A]
<7> [635.589712] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:521:DP-MST B]
<7> [635.589910] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:522:DP-MST C]
<7> [635.590109] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:523:DP-MST D]
<7> [635.590310] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:533:DDI C/PHY C]
<7> [635.590517] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:535:DP-MST A]
<7> [635.590717] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:536:DP-MST B]
<7> [635.590917] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:537:DP-MST C]
<7> [635.591116] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:538:DP-MST D]
<7> [635.591315] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:545:DDI D/PHY D]
<7> [635.591543] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:547:DP-MST A]
<7> [635.591774] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:548:DP-MST B]
<7> [635.591973] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:549:DP-MST C]
<7> [635.592173] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:550:DP-MST D]
<7> [635.592380] i915 0000:03:00.0: [drm:verify_connector_state [i915]] [CONNECTOR:554:HDMI-A-3]
<7> [635.592653] i915 0000:03:00.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [635.592965] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling PW_A
<7> [635.593235] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling PW_2
<7> [635.593527] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:149:pipe A]
<7> [635.593955] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:267:pipe B]
<7> [635.594116] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:385:pipe C]
<7> [635.594259] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:503:pipe D]
<7> [635.594477] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:267:pipe B]
<7> [635.594508] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CONNECTOR:554:HDMI-A-3]
<7> [635.594576] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CONNECTOR:554:HDMI-A-3] Limiting display bpp to 24 (EDID bpp 0, max requested bpp 36, max platform bpp 36)
<7> [635.594798] i915 0000:03:00.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [635.594987] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:267:pipe B] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [635.595194] i915 0000:03:00.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:545:DDI D/PHY D] [CRTC:267:pipe B]
<7> [635.595430] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [635.595636] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [635.595842] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [635.596047] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [635.596254] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [635.596501] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [635.596707] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [635.596913] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [635.597118] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [635.597324] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [635.597572] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [635.597778] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [635.597985] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [635.598190] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [635.598434] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [635.598640] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [635.598846] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [635.599052] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [635.599259] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [635.599562] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [635.599769] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [635.599974] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [635.600180] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [635.600413] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [635.600669] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [635.600876] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [635.601082] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [635.601287] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [635.601537] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [635.601742] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [635.601947] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [635.602152] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [635.602358] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [635.602603] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [635.602809] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [635.603015] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [635.603220] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in port_clock (expected 0, found 148500)
<7> [635.603465] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:267:pipe B] fastset requirement not met, forcing full modeset
<7> [635.603696] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0xf), mbus joined? no->no
<7> [635.603894] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [CRTC:267:pipe B] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x2
<7> [635.604118] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:151:plane 1B] ddb ( 0 - 0) -> ( 0 - 1963), size 0 -> 1963
<7> [635.604314] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:261:cursor B] ddb ( 0 - 0) -> (1963 - 2048), size 0 -> 85
<7> [635.604552] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:151:plane 1B] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [635.604749] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:151:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 4, 4, 5, 9, 11, 17, 25, 0, 0, 0
<7> [635.604946] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:151:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 62, 62, 62, 78, 139, 169, 261, 383, 137, 0, 0
<7> [635.605142] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:151:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 123, 123, 123, 184, 245, 245, 367, 489, 138, 0, 0
<7> [635.605357] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:267:pipe B] data rate 594000 num active planes 1
<7> [635.605604] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 50000 required 624
<7> [635.605809] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [635.606028] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:267:pipe B] min cdclk: 0 kHz -> 74250 kHz
<7> [635.606245] i915 0000:03:00.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 0 kHz -> 9282 kHz
<7> [635.606492] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 163200 kHz, actual 163200 kHz
<7> [635.606696] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [635.606902] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [CRTC:267:pipe B] enable: yes [modeset]
<7> [635.607108] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [635.607313] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 24, dithering: 0
<7> [635.607554] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [635.607759] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [635.607963] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [635.608167] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [635.608377] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [635.608613] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [635.608819] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [635.609022] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 0, guardband: 45 vsync start: 41, vsync end: 36
<7> [635.609228] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1080, vmax vblank: 1080, vmin vtotal: 1125, vmax vtotal: 1125
<7> [635.609473] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [635.609680] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [635.609886] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] 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> [635.610092] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [635.610297] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] 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> [635.610538] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] port clock: 148500, pipe src: 1920x1080+0+0, pixel rate 148500, min cdclk 74250
<7> [635.610743] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] linetime: 119, ips linetime: 0
<7> [635.610948] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [635.611153] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [635.611358] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [635.611605] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x24414, dpll_md: 0x18000000, fp0: 0x8801ef8, fp1: 0x2b000440
<7> [635.611682] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [635.611849] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [635.611947] i915 0000:03:00.0: [drm:gen9_enable_dc5 [i915]] Enabling DC5
<7> [635.612054] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [635.612158] i915 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 01
<7> [635.612258] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [635.612701] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [635.612907] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [635.613112] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [635.613317] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [635.613560] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [635.613765] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [635.613969] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [635.614173] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [635.614383] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [635.614622] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [635.614828] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:151:plane 1B] fb: [FB:562] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [635.615034] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [635.615239] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [635.615512] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:181:plane 2B] fb: [NOFB], visible: no
<7> [635.615717] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:211:plane 3B] fb: [NOFB], visible: no
<7> [635.615921] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:241:plane 4B] fb: [NOFB], visible: no
<7> [635.616126] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:251:plane 5B] fb: [NOFB], visible: no
<7> [635.616331] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:261:cursor B] fb: [NOFB], visible: no
<7> [635.616959] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [635.617292] i915 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 01 to 00
<7> [635.617729] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_2
<7> [635.617958] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_B
<7> [635.618211] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:505:DDI A/PHY A]
<7> [635.618451] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:507:DP-MST A]
<7> [635.618650] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:508:DP-MST B]
<7> [635.618851] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:509:DP-MST C]
<7> [635.619050] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:510:DP-MST D]
<7> [635.619249] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:518:DDI B/PHY B]
<7> [635.619488] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:520:DP-MST A]
<7> [635.619687] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:521:DP-MST B]
<7> [635.619885] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:522:DP-MST C]
<7> [635.620084] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:523:DP-MST D]
<7> [635.620283] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:533:DDI C/PHY C]
<7> [635.620522] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:535:DP-MST A]
<7> [635.620721] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:536:DP-MST B]
<7> [635.620920] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:537:DP-MST C]
<7> [635.621119] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:538:DP-MST D]
<7> [635.621316] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:545:DDI D/PHY D]
<7> [635.621553] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:547:DP-MST A]
<7> [635.621752] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:548:DP-MST B]
<7> [635.621951] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:549:DP-MST C]
<7> [635.622149] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:550:DP-MST D]
<7> [635.622349] i915 0000:03:00.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [635.622810] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_D
<7> [635.623138] i915 0000:03:00.0: [drm:intel_enable_transcoder [i915]] enabling pipe B
<7> [635.642272] i915 0000:03:00.0: [drm:verify_connector_state [i915]] [CONNECTOR:554:HDMI-A-3]
<7> [635.642618] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:267:pipe B]
<7> [643.175891] i915 0000:03:00.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:563] from all active usage due to RMFB ioctl
<7> [643.177446] i915 0000:03:00.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:562] from all active usage due to RMFB ioctl
<7> [643.177628] i915 0000:03:00.0: [drm:atomic_remove_fb] Disabling [PLANE:151:plane 1B] because [FB:562] is removed
<7> [643.177791] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:151:plane 1B] ddb ( 0 - 1963) -> ( 0 - 0), size 1963 -> 0
<7> [643.178835] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:151:plane 1B] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [643.179825] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:151:plane 1B] lines 4, 4, 4, 5, 9, 11, 17, 25, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [643.180809] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:151:plane 1B] blocks 62, 62, 62, 78, 139, 169, 261, 383, 137, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [643.181785] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:151:plane 1B] min_ddb 123, 123, 123, 184, 245, 245, 367, 489, 138, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [643.182890] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:267:pipe B] data rate 0 num active planes 0
<7> [643.183922] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 50000 required 0
<6> [643.194969] [IGT] kms_flip: finished subtest B-HDMI-A3, SUCCESS
<6> [643.198785] [IGT] kms_flip: starting dynamic subtest C-HDMI-A3
<7> [643.200509] i915 0000:03:00.0: [drm:drm_mode_addfb2] [FB:562]
<7> [643.201171] i915 0000:03:00.0: [drm:drm_mode_addfb2] [FB:563]
<7> [643.202201] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [643.204297] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [643.243563] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [643.244035] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [643.251004] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [643.251391] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [643.272815] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [643.273157] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [643.299886] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:149:pipe A]
<7> [643.300032] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:267:pipe B]
<7> [643.300111] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.enable (expected yes, found no)
<7> [643.300351] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.active (expected yes, found no)
<7> [643.300597] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [643.300806] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in lane_count (expected 4, found 0)
<7> [643.301011] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [643.301217] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [643.301465] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [643.301701] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [643.301908] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [643.302114] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [643.302328] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [643.302569] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [643.302775] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [643.302981] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [643.303186] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [643.303402] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [643.303608] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [643.303813] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [643.304020] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [643.304225] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [643.304439] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [643.304646] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [643.304852] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [643.305057] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [643.305263] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [643.305474] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [643.305680] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [643.305885] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [643.306091] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [643.306296] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [643.306507] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [643.306745] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [643.306951] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [643.307157] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [643.307405] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [643.307612] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [643.307818] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in port_clock (expected 148500, found 0)
<7> [643.308025] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:267:pipe B] fastset requirement not met, forcing full modeset
<7> [643.308296] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0xf), mbus joined? no->no
<7> [643.308504] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [CRTC:267:pipe B] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x2 -> 0x0
<7> [643.308727] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:261:cursor B] ddb (1963 - 2048) -> ( 0 - 0), size 85 -> 0
<7> [643.308954] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:267:pipe B] min cdclk: 74250 kHz -> 0 kHz
<7> [643.309161] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 163200 kHz, actual 163200 kHz
<7> [643.309372] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [643.309578] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [CRTC:267:pipe B] enable: no [modeset]
<7> [643.309783] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:151:plane 1B] fb: [NOFB], visible: no
<7> [643.309988] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:181:plane 2B] fb: [NOFB], visible: no
<7> [643.310193] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:211:plane 3B] fb: [NOFB], visible: no
<7> [643.310407] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:241:plane 4B] fb: [NOFB], visible: no
<7> [643.310612] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:251:plane 5B] fb: [NOFB], visible: no
<7> [643.310816] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:261:cursor B] fb: [NOFB], visible: no
<7> [643.311176] i915 0000:03:00.0: [drm:intel_disable_transcoder [i915]] disabling pipe B
<7> [643.326534] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_D
<7> [643.326806] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:505:DDI A/PHY A]
<7> [643.327009] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:507:DP-MST A]
<7> [643.327210] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:508:DP-MST B]
<7> [643.327420] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:509:DP-MST C]
<7> [643.327620] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:510:DP-MST D]
<7> [643.327820] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:518:DDI B/PHY B]
<7> [643.328019] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:520:DP-MST A]
<7> [643.328218] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:521:DP-MST B]
<7> [643.328463] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:522:DP-MST C]
<7> [643.328663] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:523:DP-MST D]
<7> [643.328863] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:533:DDI C/PHY C]
<7> [643.329062] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:535:DP-MST A]
<7> [643.329261] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:536:DP-MST B]
<7> [643.329467] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:537:DP-MST C]
<7> [643.329666] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:538:DP-MST D]
<7> [643.329865] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:545:DDI D/PHY D]
<7> [643.330085] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:547:DP-MST A]
<7> [643.330285] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:548:DP-MST B]
<7> [643.330524] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:549:DP-MST C]
<7> [643.330724] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:550:DP-MST D]
<7> [643.330923] i915 0000:03:00.0: [drm:verify_connector_state [i915]] [CONNECTOR:554:HDMI-A-3]
<7> [643.331160] i915 0000:03:00.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [643.331517] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling PW_B
<7> [643.331782] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling PW_2
<7> [643.332027] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:267:pipe B]
<7> [643.332469] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:385:pipe C]
<7> [643.332625] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:503:pipe D]
<7> [643.332771] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:385:pipe C]
<7> [643.332801] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CONNECTOR:554:HDMI-A-3]
<7> [643.332867] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CONNECTOR:554:HDMI-A-3] Limiting display bpp to 24 (EDID bpp 0, max requested bpp 36, max platform bpp 36)
<7> [643.333082] i915 0000:03:00.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [643.333271] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:385:pipe C] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [643.333522] i915 0000:03:00.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:545:DDI D/PHY D] [CRTC:385:pipe C]
<7> [643.333716] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.enable (expected no, found yes)
<7> [643.333922] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.active (expected no, found yes)
<7> [643.334128] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in cpu_transcoder (expected -1, found 2)
<7> [643.334340] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in lane_count (expected 0, found 4)
<7> [643.334598] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [643.334810] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [643.335020] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [643.335230] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [643.335449] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [643.335660] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [643.335870] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [643.336080] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [643.336291] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [643.336511] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [643.336722] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [643.336932] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [643.337143] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [643.337360] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [643.337571] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [643.337781] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [643.337992] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [643.338203] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [643.338469] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [643.338680] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [643.338890] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [643.339100] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [643.339311] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [643.339528] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [643.339739] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [643.339950] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [643.340161] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [643.340377] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [643.340589] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [643.340800] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [643.341010] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [643.341220] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [643.341439] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in port_clock (expected 0, found 148500)
<7> [643.341650] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:385:pipe C] fastset requirement not met, forcing full modeset
<7> [643.341886] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0xd (total dbuf slices 0xf), mbus joined? no->no
<7> [643.342088] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [CRTC:385:pipe C] dbuf slices 0x0 -> 0xc, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x4
<7> [643.342317] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:269:plane 1C] ddb ( 0 - 0) -> ( 0 - 1963), size 0 -> 1963
<7> [643.342526] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:379:cursor C] ddb ( 0 - 0) -> (1963 - 2048), size 0 -> 85
<7> [643.342727] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:269:plane 1C] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [643.342927] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:269:plane 1C] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 4, 4, 5, 9, 11, 17, 25, 0, 0, 0
<7> [643.343129] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:269:plane 1C] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 62, 62, 62, 78, 139, 169, 261, 383, 137, 0, 0
<7> [643.343336] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:269:plane 1C] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 123, 123, 123, 184, 245, 245, 367, 489, 138, 0, 0
<7> [643.343555] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:385:pipe C] data rate 594000 num active planes 1
<7> [643.343765] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 50000 required 624
<7> [643.343973] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [643.344197] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:385:pipe C] min cdclk: 0 kHz -> 74250 kHz
<7> [643.344443] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 163200 kHz, actual 163200 kHz
<7> [643.344648] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [643.344853] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [CRTC:385:pipe C] enable: yes [modeset]
<7> [643.345059] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [643.345263] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: C, pipe bpp: 24, dithering: 0
<7> [643.345508] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [643.345713] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [643.345918] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [643.346122] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [643.346332] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [643.346566] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [643.346770] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [643.346974] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 0, guardband: 45 vsync start: 41, vsync end: 36
<7> [643.347179] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1080, vmax vblank: 1080, vmin vtotal: 1125, vmax vtotal: 1125
<7> [643.347423] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [643.347628] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [643.347834] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] 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> [643.348040] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [643.348246] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] 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> [643.348491] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] port clock: 148500, pipe src: 1920x1080+0+0, pixel rate 148500, min cdclk 74250
<7> [643.348696] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] linetime: 119, ips linetime: 0
<7> [643.348901] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [643.349106] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [643.349310] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [643.349553] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x24414, dpll_md: 0x18000000, fp0: 0x8801ef8, fp1: 0x2b000440
<7> [643.349758] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [643.349962] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [643.350167] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [643.350412] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [643.350474] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [643.350616] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [643.350724] i915 0000:03:00.0: [drm:gen9_enable_dc5 [i915]] Enabling DC5
<7> [643.350821] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [643.350934] i915 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 01
<7> [643.351024] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [643.351229] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [643.351473] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [643.351678] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [643.351882] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [643.352087] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [643.352291] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [643.352534] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:269:plane 1C] fb: [FB:562] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [643.352741] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [643.352946] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [643.353151] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:299:plane 2C] fb: [NOFB], visible: no
<7> [643.353393] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:329:plane 3C] fb: [NOFB], visible: no
<7> [643.353598] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:359:plane 4C] fb: [NOFB], visible: no
<7> [643.353802] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:369:plane 5C] fb: [NOFB], visible: no
<7> [643.354007] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:379:cursor C] fb: [NOFB], visible: no
<7> [643.354613] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [643.354945] i915 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 01 to 00
<7> [643.355365] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_2
<7> [643.355606] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_C
<7> [643.355859] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:505:DDI A/PHY A]
<7> [643.356060] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:507:DP-MST A]
<7> [643.356260] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:508:DP-MST B]
<7> [643.356496] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:509:DP-MST C]
<7> [643.356695] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:510:DP-MST D]
<7> [643.356894] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:518:DDI B/PHY B]
<7> [643.357094] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:520:DP-MST A]
<7> [643.357293] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:521:DP-MST B]
<7> [643.357529] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:522:DP-MST C]
<7> [643.357730] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:523:DP-MST D]
<7> [643.357929] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:533:DDI C/PHY C]
<7> [643.358129] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:535:DP-MST A]
<7> [643.358334] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:536:DP-MST B]
<7> [643.358566] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:537:DP-MST C]
<7> [643.358766] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:538:DP-MST D]
<7> [643.358965] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:545:DDI D/PHY D]
<7> [643.359164] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:547:DP-MST A]
<7> [643.359402] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:548:DP-MST B]
<7> [643.359601] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:549:DP-MST C]
<7> [643.359802] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:550:DP-MST D]
<7> [643.360001] i915 0000:03:00.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0xd
<7> [643.360460] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_D
<7> [643.360788] i915 0000:03:00.0: [drm:intel_enable_transcoder [i915]] enabling pipe C
<7> [643.379947] i915 0000:03:00.0: [drm:verify_connector_state [i915]] [CONNECTOR:554:HDMI-A-3]
<7> [643.380280] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:385:pipe C]
<7> [650.913387] i915 0000:03:00.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:563] from all active usage due to RMFB ioctl
<7> [650.913826] i915 0000:03:00.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:562] from all active usage due to RMFB ioctl
<7> [650.914002] i915 0000:03:00.0: [drm:atomic_remove_fb] Disabling [PLANE:269:plane 1C] because [FB:562] is removed
<7> [650.914165] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:269:plane 1C] ddb ( 0 - 1963) -> ( 0 - 0), size 1963 -> 0
<7> [650.915215] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:269:plane 1C] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [650.916214] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:269:plane 1C] lines 4, 4, 4, 5, 9, 11, 17, 25, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [650.917196] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:269:plane 1C] blocks 62, 62, 62, 78, 139, 169, 261, 383, 137, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [650.918179] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:269:plane 1C] min_ddb 123, 123, 123, 184, 245, 245, 367, 489, 138, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [650.919230] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:385:pipe C] data rate 0 num active planes 0
<7> [650.920253] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 50000 required 0
<6> [650.930417] [IGT] kms_flip: finished subtest C-HDMI-A3, SUCCESS
<6> [650.931312] [IGT] kms_flip: starting dynamic subtest D-HDMI-A3
<7> [650.931711] i915 0000:03:00.0: [drm:drm_mode_addfb2] [FB:562]
<7> [650.931866] i915 0000:03:00.0: [drm:drm_mode_addfb2] [FB:563]
<7> [650.932257] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [650.932728] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [650.955078] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [650.955481] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [650.961093] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [650.961488] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [650.981230] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [650.981606] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [651.006968] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:149:pipe A]
<7> [651.007119] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:267:pipe B]
<7> [651.007235] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:385:pipe C]
<7> [651.007311] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.enable (expected yes, found no)
<7> [651.007554] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.active (expected yes, found no)
<7> [651.007764] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in cpu_transcoder (expected 2, found -1)
<7> [651.007973] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in lane_count (expected 4, found 0)
<7> [651.008179] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [651.008428] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [651.008636] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [651.008841] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [651.009047] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [651.009253] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [651.009502] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [651.009708] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [651.009914] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [651.010120] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [651.010326] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [651.010574] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [651.010780] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [651.010987] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [651.011192] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [651.011438] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [651.011645] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [651.011850] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [651.012055] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [651.012261] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [651.012508] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [651.012716] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [651.012921] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [651.013127] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [651.013333] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [651.013578] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [651.013784] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [651.013989] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [651.014195] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [651.014448] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [651.014653] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [651.014859] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [651.015064] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:385:pipe C] fastset requirement not met in port_clock (expected 148500, found 0)
<7> [651.015271] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:385:pipe C] fastset requirement not met, forcing full modeset
<7> [651.015606] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0xd -> 0x1 (total dbuf slices 0xf), mbus joined? no->no
<7> [651.015807] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [CRTC:385:pipe C] dbuf slices 0xc -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x4 -> 0x0
<7> [651.016028] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:379:cursor C] ddb (1963 - 2048) -> ( 0 - 0), size 85 -> 0
<7> [651.016257] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:385:pipe C] min cdclk: 74250 kHz -> 0 kHz
<7> [651.016547] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 163200 kHz, actual 163200 kHz
<7> [651.016751] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [651.016956] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [CRTC:385:pipe C] enable: no [modeset]
<7> [651.017161] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:269:plane 1C] fb: [NOFB], visible: no
<7> [651.017396] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:299:plane 2C] fb: [NOFB], visible: no
<7> [651.017618] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:329:plane 3C] fb: [NOFB], visible: no
<7> [651.017822] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:359:plane 4C] fb: [NOFB], visible: no
<7> [651.018027] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:369:plane 5C] fb: [NOFB], visible: no
<7> [651.018232] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:379:cursor C] fb: [NOFB], visible: no
<7> [651.018707] i915 0000:03:00.0: [drm:intel_disable_transcoder [i915]] disabling pipe C
<7> [651.031570] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_D
<7> [651.031840] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:505:DDI A/PHY A]
<7> [651.032042] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:507:DP-MST A]
<7> [651.032242] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:508:DP-MST B]
<7> [651.032491] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:509:DP-MST C]
<7> [651.032691] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:510:DP-MST D]
<7> [651.032890] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:518:DDI B/PHY B]
<7> [651.033088] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:520:DP-MST A]
<7> [651.033288] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:521:DP-MST B]
<7> [651.033528] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:522:DP-MST C]
<7> [651.033727] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:523:DP-MST D]
<7> [651.033926] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:533:DDI C/PHY C]
<7> [651.034126] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:535:DP-MST A]
<7> [651.034325] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:536:DP-MST B]
<7> [651.034566] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:537:DP-MST C]
<7> [651.034766] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:538:DP-MST D]
<7> [651.034964] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:545:DDI D/PHY D]
<7> [651.035183] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:547:DP-MST A]
<7> [651.035389] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:548:DP-MST B]
<7> [651.035589] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:549:DP-MST C]
<7> [651.035789] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:550:DP-MST D]
<7> [651.035988] i915 0000:03:00.0: [drm:verify_connector_state [i915]] [CONNECTOR:554:HDMI-A-3]
<7> [651.036224] i915 0000:03:00.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [651.036578] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling PW_C
<7> [651.036842] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling PW_2
<7> [651.037086] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:385:pipe C]
<7> [651.037526] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:503:pipe D]
<7> [651.037690] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:503:pipe D]
<7> [651.037720] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CONNECTOR:554:HDMI-A-3]
<7> [651.037788] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CONNECTOR:554:HDMI-A-3] Limiting display bpp to 24 (EDID bpp 0, max requested bpp 36, max platform bpp 36)
<7> [651.038002] i915 0000:03:00.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [651.038190] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:503:pipe D] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [651.038440] i915 0000:03:00.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:545:DDI D/PHY D] [CRTC:503:pipe D]
<7> [651.038634] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.enable (expected no, found yes)
<7> [651.038841] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.active (expected no, found yes)
<7> [651.039047] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in cpu_transcoder (expected -1, found 3)
<7> [651.039254] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in lane_count (expected 0, found 4)
<7> [651.039499] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [651.039706] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [651.039912] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [651.040118] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [651.040325] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [651.040572] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [651.040776] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [651.040981] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [651.041187] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [651.041469] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [651.041676] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [651.041882] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [651.042088] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [651.042293] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [651.042539] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [651.042745] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [651.042951] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [651.043157] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [651.043389] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [651.043611] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [651.043817] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [651.044023] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [651.044228] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [651.044474] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [651.044681] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [651.044887] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [651.045092] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [651.045297] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [651.045582] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [651.045789] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [651.045995] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [651.046202] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [651.046449] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in port_clock (expected 0, found 148500)
<7> [651.046655] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:503:pipe D] fastset requirement not met, forcing full modeset
<7> [651.046885] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0xd (total dbuf slices 0xf), mbus joined? no->no
<7> [651.047083] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [CRTC:503:pipe D] dbuf slices 0x0 -> 0xc, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x8
<7> [651.047306] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:387:plane 1D] ddb ( 0 - 0) -> ( 0 - 1963), size 0 -> 1963
<7> [651.047545] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:497:cursor D] ddb ( 0 - 0) -> (1963 - 2048), size 0 -> 85
<7> [651.047742] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:387:plane 1D] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [651.047937] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:387:plane 1D] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 4, 4, 5, 9, 11, 17, 25, 0, 0, 0
<7> [651.048133] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:387:plane 1D] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 62, 62, 62, 78, 139, 169, 261, 383, 137, 0, 0
<7> [651.048328] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:387:plane 1D] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 123, 123, 123, 184, 245, 245, 367, 489, 138, 0, 0
<7> [651.048583] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:503:pipe D] data rate 594000 num active planes 1
<7> [651.048788] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 50000 required 624
<7> [651.048992] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [651.049210] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:503:pipe D] min cdclk: 0 kHz -> 74250 kHz
<7> [651.049473] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 163200 kHz, actual 163200 kHz
<7> [651.049678] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [651.049884] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [CRTC:503:pipe D] enable: yes [modeset]
<7> [651.050089] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [651.050294] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: D, pipe bpp: 24, dithering: 0
<7> [651.050538] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [651.050742] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [651.050946] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [651.051150] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [651.051379] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [651.051598] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [651.051802] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [651.052007] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 0, guardband: 45 vsync start: 41, vsync end: 36
<7> [651.052212] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1080, vmax vblank: 1080, vmin vtotal: 1125, vmax vtotal: 1125
<7> [651.052459] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [651.052666] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [651.052871] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] 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> [651.053077] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [651.053282] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] 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> [651.053528] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] port clock: 148500, pipe src: 1920x1080+0+0, pixel rate 148500, min cdclk 74250
<7> [651.053733] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] linetime: 119, ips linetime: 0
<7> [651.053937] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [651.054142] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [651.054351] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [651.054590] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x24414, dpll_md: 0x18000000, fp0: 0x8801ef8, fp1: 0x2b000440
<7> [651.054796] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [651.055001] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [651.055206] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [651.055455] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [651.055557] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [651.055728] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [651.055821] i915 0000:03:00.0: [drm:gen9_enable_dc5 [i915]] Enabling DC5
<7> [651.055932] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [651.056030] i915 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 01
<7> [651.056136] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [651.056446] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [651.056700] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [651.056904] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [651.057108] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [651.057313] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [651.057557] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [651.057763] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:387:plane 1D] fb: [FB:562] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [651.057969] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [651.058173] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [651.058418] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:417:plane 2D] fb: [NOFB], visible: no
<7> [651.058624] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:447:plane 3D] fb: [NOFB], visible: no
<7> [651.058828] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:477:plane 4D] fb: [NOFB], visible: no
<7> [651.059033] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:487:plane 5D] fb: [NOFB], visible: no
<7> [651.059237] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:497:cursor D] fb: [NOFB], visible: no
<7> [651.059894] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [651.060226] i915 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 01 to 00
<7> [651.060664] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_2
<7> [651.060892] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_D
<7> [651.061145] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:505:DDI A/PHY A]
<7> [651.061353] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:507:DP-MST A]
<7> [651.061617] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:508:DP-MST B]
<7> [651.061816] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:509:DP-MST C]
<7> [651.062014] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:510:DP-MST D]
<7> [651.062214] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:518:DDI B/PHY B]
<7> [651.062453] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:520:DP-MST A]
<7> [651.062653] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:521:DP-MST B]
<7> [651.062852] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:522:DP-MST C]
<7> [651.063051] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:523:DP-MST D]
<7> [651.063250] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:533:DDI C/PHY C]
<7> [651.063497] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:535:DP-MST A]
<7> [651.063731] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:536:DP-MST B]
<7> [651.063930] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:537:DP-MST C]
<7> [651.064130] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:538:DP-MST D]
<7> [651.064329] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:545:DDI D/PHY D]
<7> [651.064570] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:547:DP-MST A]
<7> [651.064769] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:548:DP-MST B]
<7> [651.064968] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:549:DP-MST C]
<7> [651.065166] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:550:DP-MST D]
<7> [651.065392] i915 0000:03:00.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0xd
<7> [651.065830] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_D
<7> [651.066158] i915 0000:03:00.0: [drm:intel_enable_transcoder [i915]] enabling pipe D
<7> [651.085662] i915 0000:03:00.0: [drm:verify_connector_state [i915]] [CONNECTOR:554:HDMI-A-3]
<7> [651.085996] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:503:pipe D]
<7> [658.619190] i915 0000:03:00.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:563] from all active usage due to RMFB ioctl
<7> [658.619700] i915 0000:03:00.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:562] from all active usage due to RMFB ioctl
<7> [658.619877] i915 0000:03:00.0: [drm:atomic_remove_fb] Disabling [PLANE:387:plane 1D] because [FB:562] is removed
<7> [658.620045] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:387:plane 1D] ddb ( 0 - 1963) -> ( 0 - 0), size 1963 -> 0
<7> [658.621088] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:387:plane 1D] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [658.622082] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:387:plane 1D] lines 4, 4, 4, 5, 9, 11, 17, 25, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [658.623074] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:387:plane 1D] blocks 62, 62, 62, 78, 139, 169, 261, 383, 137, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [658.624057] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:387:plane 1D] min_ddb 123, 123, 123, 184, 245, 245, 367, 489, 138, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [658.625121] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:503:pipe D] data rate 0 num active planes 0
<7> [658.626143] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 50000 required 0
<6> [658.638463] [IGT] kms_flip: finished subtest D-HDMI-A3, SUCCESS
<6> [658.641112] [IGT] kms_flip: finished subtest flip-vs-expired-vblank, FAIL
<6> [658.668264] [IGT] kms_flip: exiting, ret=98
<7> [658.668919] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [658.703185] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CONNECTOR:554:HDMI-A-3] Limiting display bpp to 24 (EDID bpp 0, max requested bpp 36, max platform bpp 36)
<7> [658.703501] i915 0000:03:00.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [658.703751] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:149:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [658.704030] i915 0000:03:00.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:545:DDI D/PHY D] [CRTC:149:pipe A]
<7> [658.704275] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [658.704551] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [658.704812] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [658.705072] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [658.705332] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [658.705599] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [658.705860] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [658.706119] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [658.706377] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [658.706642] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [658.706903] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [658.707165] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [658.707431] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [658.707690] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [658.707950] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [658.708210] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [658.708476] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [658.708737] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [658.708996] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [658.709255] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [658.709525] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [658.709785] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [658.710044] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [658.710303] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [658.710571] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [658.710830] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [658.711090] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [658.711348] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [658.711613] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [658.711874] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [658.712134] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [658.712393] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [658.712658] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [658.712918] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [658.713177] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [658.713446] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [658.713706] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in port_clock (expected 0, found 148500)
<7> [658.713967] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:149:pipe A] fastset requirement not met, forcing full modeset
<7> [658.714225] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.enable (expected yes, found no)
<7> [658.714592] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.active (expected yes, found no)
<7> [658.714856] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in cpu_transcoder (expected 3, found -1)
<7> [658.715117] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in lane_count (expected 4, found 0)
<7> [658.715377] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [658.715646] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [658.715905] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [658.716165] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [658.716432] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [658.716692] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [658.716952] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [658.717211] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [658.717480] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [658.717739] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [658.717999] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [658.718258] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [658.718527] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [658.718787] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [658.719047] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [658.719306] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [658.719607] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [658.719868] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [658.720127] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [658.720385] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [658.720652] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [658.720912] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [658.721171] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [658.721435] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [658.721697] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [658.721955] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [658.722215] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [658.722481] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [658.722741] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [658.723000] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [658.723260] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [658.723527] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [658.723787] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:503:pipe D] fastset requirement not met in port_clock (expected 148500, found 0)
<7> [658.724047] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:503:pipe D] fastset requirement not met, forcing full modeset
<7> [658.724349] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0xd -> 0x3 (total dbuf slices 0xf), mbus joined? no->no
<7> [658.724608] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [CRTC:149:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x8 -> 0x1
<7> [658.724857] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [CRTC:503:pipe D] dbuf slices 0xc -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x8 -> 0x1
<7> [658.725109] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:33:plane 1A] ddb ( 0 - 0) -> ( 0 - 1963), size 0 -> 1963
<7> [658.725357] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:143:cursor A] ddb ( 0 - 0) -> (1963 - 2048), size 0 -> 85
<7> [658.725610] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [658.725856] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 3, 4, 5, 9, 11, 17, 25, 0, 0, 0
<7> [658.726102] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 49, 65, 81, 145, 177, 273, 401, 30, 0, 0
<7> [658.726349] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 55, 73, 91, 161, 196, 302, 443, 31, 0, 0
<7> [658.726605] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:497:cursor D] ddb (1963 - 2048) -> ( 0 - 0), size 85 -> 0
<7> [658.726876] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:149:pipe A] data rate 594000 num active planes 1
<7> [658.727134] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 50000 required 624
<7> [658.727391] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [658.727673] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:149:pipe A] min cdclk: 0 kHz -> 74250 kHz
<7> [658.727931] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:503:pipe D] min cdclk: 74250 kHz -> 0 kHz
<7> [658.728214] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [CRTC:149:pipe A] enable: yes [modeset]
<7> [658.728480] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [658.728712] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [658.728944] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [658.729175] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [658.729413] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [658.729645] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [658.729877] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [658.730108] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [658.730338] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [658.730585] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 0, guardband: 45 vsync start: 41, vsync end: 36
<7> [658.730818] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1080, vmax vblank: 1080, vmin vtotal: 1125, vmax vtotal: 1125
<7> [658.731050] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [658.731281] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [658.731521] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] 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> [658.731753] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [658.731985] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] 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> [658.732216] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] port clock: 148500, pipe src: 1920x1080+0+0, pixel rate 148500, min cdclk 74250
<7> [658.732454] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] linetime: 119, ips linetime: 0
<7> [658.732685] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [658.732916] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [658.733148] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [658.733389] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x24414, dpll_md: 0x18000000, fp0: 0x8801ef8, fp1: 0x2b000440
<7> [658.733606] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [658.733815] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [658.734025] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [658.734235] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [658.734452] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [658.734662] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [658.734872] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [658.735082] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [658.735291] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [658.735505] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [658.735714] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [658.735923] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [658.736132] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [658.736342] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:33:plane 1A] fb: [FB:557] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [658.736559] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [658.736768] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [658.736979] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 2A] fb: [NOFB], visible: no
<7> [658.737189] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:93:plane 3A] fb: [NOFB], visible: no
<7> [658.737398] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:123:plane 4A] fb: [NOFB], visible: no
<7> [658.737617] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:133:plane 5A] fb: [NOFB], visible: no
<7> [658.737827] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:143:cursor A] fb: [NOFB], visible: no
<7> [658.738037] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [CRTC:503:pipe D] enable: no [modeset]
<7> [658.738247] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:387:plane 1D] fb: [NOFB], visible: no
<7> [658.738506] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:417:plane 2D] fb: [NOFB], visible: no
<7> [658.738711] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:447:plane 3D] fb: [NOFB], visible: no
<7> [658.738917] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:477:plane 4D] fb: [NOFB], visible: no
<7> [658.739121] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:487:plane 5D] fb: [NOFB], visible: no
<7> [658.739325] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:497:cursor D] fb: [NOFB], visible: no
<7> [658.739691] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_A
<7> [658.740012] i915 0000:03:00.0: [drm:intel_disable_transcoder [i915]] disabling pipe D
<7> [658.752547] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_D
<7> [658.752822] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:505:DDI A/PHY A]
<7> [658.753025] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:507:DP-MST A]
<7> [658.753226] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:508:DP-MST B]
<7> [658.753436] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:509:DP-MST C]
<7> [658.753674] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:510:DP-MST D]
<7> [658.753875] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:518:DDI B/PHY B]
<7> [658.754075] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:520:DP-MST A]
<7> [658.754274] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:521:DP-MST B]
<7> [658.754518] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:522:DP-MST C]
<7> [658.754718] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:523:DP-MST D]
<7> [658.754918] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:533:DDI C/PHY C]
<7> [658.755118] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:535:DP-MST A]
<7> [658.755319] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:536:DP-MST B]
<7> [658.755560] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:537:DP-MST C]
<7> [658.755760] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:538:DP-MST D]
<7> [658.755958] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:545:DDI D/PHY D]
<7> [658.756158] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:547:DP-MST A]
<7> [658.756358] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:548:DP-MST B]
<7> [658.756600] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:549:DP-MST C]
<7> [658.756800] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:550:DP-MST D]
<7> [658.757007] i915 0000:03:00.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0xf
<7> [658.757491] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_D
<7> [658.757824] i915 0000:03:00.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [658.760410] i915 0000:03:00.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1
<7> [658.760672] i915 0000:03:00.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:33:plane 1A]
<7> [658.776618] i915 0000:03:00.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [658.777247] i915 0000:03:00.0: [drm:verify_connector_state [i915]] [CONNECTOR:554:HDMI-A-3]
<7> [658.777611] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:149:pipe A]
<7> [658.778600] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling PW_D
<7> [658.778881] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:503:pipe D]
<7> [658.779650] i915 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0
<6> [658.793819] Console: switching to colour frame buffer device 240x67
Created at 2025-12-10 03:29:34