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

Result: Fail

i915_display_info12 igt_runner12 results12.json results12-xe-load.json guc_logs12.tar i915_display_info_post_exec12 serial_data12 boot12 dmesg12

DetailValue
Duration 4.67 seconds
Hostname
shard-bmg-4
Igt-Version
IGT-Version: 2.4-g98b65acc4 (x86_64) (Linux: 7.1.0-rc4-lgci-xe-xe-5116-127c8434a6a018110-debug+ x86_64)
Out
Starting dynamic subtest: D-HDMI-A3
  1920x1080: 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 
Stack trace:
  #0 ../lib/igt_core.c:2106 __igt_fail_assert()
  #1 ../tests/kms_flip.c:926 run_test_on_crtc_set()
  #2 ../tests/kms_flip.c:1920 run_test()
  #3 ../tests/kms_flip.c:2184 __igt_unique____real_main2105()
  #4 ../tests/kms_flip.c:2105 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest D-HDMI-A3: FAIL (4.674s)
Subtest flip-vs-expired-vblank: FAIL (32.942s)
Stack trace:
  #0 ../lib/igt_core.c:2106 __igt_fail_assert()
  #1 ../lib/igt_kms.c:2354 kmstest_set_connector_dpms()
  #2 ../lib/igt_core.c:2992 igt_atexit_handler()
  #3 [erand48_r+0x1d6]
  #4 [exit+0x1e]
  #5 ../lib/igt_core.c:2447 igt_exit()
  #6 [main+0x3f]
  #7 [__libc_init_first+0x8a]
  #8 [__libc_start_main+0x8b]
  #9 [_start+0x25]
Err
Starting dynamic subtest: D-HDMI-A3
[87.754431] (kms_flip:2270) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:931:
[87.754550] (kms_flip:2270) CRITICAL: Failed assertion: end - start < 500
Dynamic subtest D-HDMI-A3 failed.
**** DEBUG ****
[85.736146] (kms_flip:2270) DEBUG: name = flip
last_ts = 86.933266
last_received_ts = 86.932892
last_seq = 325
current_ts = 86.949928
current_received_ts = 86.949562
current_seq = 326
count = 82
seq_step = 1
[85.736180] (kms_flip:2270) DEBUG: Vblank took 28us
[85.752814] (kms_flip:2270) DEBUG: name = flip
last_ts = 86.949928
last_received_ts = 86.949562
last_seq = 326
current_ts = 86.966606
current_received_ts = 86.966232
current_seq = 327
count = 83
seq_step = 1
[85.752848] (kms_flip:2270) DEBUG: Vblank took 28us
[85.769557] (kms_flip:2270) DEBUG: name = flip
last_ts = 86.966606
last_received_ts = 86.966232
last_seq = 327
current_ts = 86.983284
current_received_ts = 86.982986
current_seq = 328
count = 84
seq_step = 1
[85.769624] (kms_flip:2270) DEBUG: Vblank took 60us
[85.786154] (kms_flip:2270) DEBUG: name = flip
last_ts = 86.983284
last_received_ts = 86.982986
last_seq = 328
current_ts = 86.999954
current_received_ts = 86.999588
current_seq = 329
count = 85
seq_step = 1
[85.786188] (kms_flip:2270) DEBUG: Vblank took 28us
[85.802814] (kms_flip:2270) DEBUG: name = flip
last_ts = 86.999954
last_received_ts = 86.999588
last_seq = 329
current_ts = 87.016624
current_received_ts = 87.016251
current_seq = 330
count = 86
seq_step = 1
[85.802843] (kms_flip:2270) DEBUG: Vblank took 25us
[85.819595] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.016624
last_received_ts = 87.016251
last_seq = 330
current_ts = 87.033302
current_received_ts = 87.033043
current_seq = 331
count = 87
seq_step = 1
[85.819629] (kms_flip:2270) DEBUG: Vblank took 29us
[85.836110] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.033302
last_received_ts = 87.033043
last_seq = 331
current_ts = 87.049973
current_received_ts = 87.049561
current_seq = 332
count = 88
seq_step = 1
[85.836143] (kms_flip:2270) DEBUG: Vblank took 28us
[85.852827] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.049973
last_received_ts = 87.049561
last_seq = 332
current_ts = 87.066643
current_received_ts = 87.066284
current_seq = 333
count = 89
seq_step = 1
[85.852861] (kms_flip:2270) DEBUG: Vblank took 28us
[85.869578] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.066643
last_received_ts = 87.066284
last_seq = 333
current_ts = 87.083328
current_received_ts = 87.083038
current_seq = 334
count = 90
seq_step = 1
[85.869612] (kms_flip:2270) DEBUG: Vblank took 29us
[85.886144] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.083328
last_received_ts = 87.083038
last_seq = 334
current_ts = 87.099998
current_received_ts = 87.099617
current_seq = 335
count = 91
seq_step = 1
[85.886179] (kms_flip:2270) DEBUG: Vblank took 28us
[85.902825] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.099998
last_received_ts = 87.099617
last_seq = 335
current_ts = 87.116676
current_received_ts = 87.116302
current_seq = 336
count = 92
seq_step = 1
[85.902859] (kms_flip:2270) DEBUG: Vblank took 28us
[85.919453] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.116676
last_received_ts = 87.116302
last_seq = 336
current_ts = 87.133339
current_received_ts = 87.132935
current_seq = 337
count = 93
seq_step = 1
[85.919486] (kms_flip:2270) DEBUG: Vblank took 28us
[85.936241] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.133339
last_received_ts = 87.132935
last_seq = 337
current_ts = 87.150009
current_received_ts = 87.149727
current_seq = 338
count = 94
seq_step = 1
[85.936275] (kms_flip:2270) DEBUG: Vblank took 28us
[85.952789] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.150009
last_received_ts = 87.149727
last_seq = 338
current_ts = 87.166687
current_received_ts = 87.166283
current_seq = 339
count = 95
seq_step = 1
[85.952823] (kms_flip:2270) DEBUG: Vblank took 28us
[85.969572] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.166687
last_received_ts = 87.166283
last_seq = 339
current_ts = 87.183357
current_received_ts = 87.183075
current_seq = 340
count = 96
seq_step = 1
[85.969605] (kms_flip:2270) DEBUG: Vblank took 28us
[85.986116] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.183357
last_received_ts = 87.183075
last_seq = 340
current_ts = 87.200027
current_received_ts = 87.199623
current_seq = 341
count = 97
seq_step = 1
[85.986145] (kms_flip:2270) DEBUG: Vblank took 25us
[86.002834] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.200027
last_received_ts = 87.199623
last_seq = 341
current_ts = 87.216713
current_received_ts = 87.216347
current_seq = 342
count = 98
seq_step = 1
[86.002869] (kms_flip:2270) DEBUG: Vblank took 27us
[86.019576] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.216713
last_received_ts = 87.216347
last_seq = 342
current_ts = 87.233391
current_received_ts = 87.233093
current_seq = 343
count = 99
seq_step = 1
[86.019611] (kms_flip:2270) DEBUG: Vblank took 29us
[86.036122] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.233391
last_received_ts = 87.233093
last_seq = 343
current_ts = 87.250053
current_received_ts = 87.249649
current_seq = 344
count = 100
seq_step = 1
[86.036152] (kms_flip:2270) DEBUG: Vblank took 25us
[86.052837] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.250053
last_received_ts = 87.249649
last_seq = 344
current_ts = 87.266739
current_received_ts = 87.266373
current_seq = 345
count = 101
seq_step = 1
[86.052871] (kms_flip:2270) DEBUG: Vblank took 29us
[86.069627] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.266739
last_received_ts = 87.266373
last_seq = 345
current_ts = 87.283409
current_received_ts = 87.283157
current_seq = 346
count = 102
seq_step = 1
[86.069680] (kms_flip:2270) DEBUG: Vblank took 38us
[86.086355] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.283409
last_received_ts = 87.283157
last_seq = 346
current_ts = 87.300087
current_received_ts = 87.299889
current_seq = 347
count = 103
seq_step = 1
[86.086409] (kms_flip:2270) DEBUG: Vblank took 39us
[86.103018] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.300087
last_received_ts = 87.299889
last_seq = 347
current_ts = 87.316757
current_received_ts = 87.316559
current_seq = 348
count = 104
seq_step = 1
[86.103072] (kms_flip:2270) DEBUG: Vblank took 39us
[86.119683] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.316757
last_received_ts = 87.316559
last_seq = 348
current_ts = 87.333427
current_received_ts = 87.333229
current_seq = 349
count = 105
seq_step = 1
[86.119737] (kms_flip:2270) DEBUG: Vblank took 41us
[86.136354] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.333427
last_received_ts = 87.333229
last_seq = 349
current_ts = 87.350105
current_received_ts = 87.349907
current_seq = 350
count = 106
seq_step = 1
[86.136408] (kms_flip:2270) DEBUG: Vblank took 40us
[86.153020] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.350105
last_received_ts = 87.349907
last_seq = 350
current_ts = 87.366776
current_received_ts = 87.366577
current_seq = 351
count = 107
seq_step = 1
[86.153073] (kms_flip:2270) DEBUG: Vblank took 40us
[86.169713] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.366776
last_received_ts = 87.366577
last_seq = 351
current_ts = 87.383446
current_received_ts = 87.383278
current_seq = 352
count = 108
seq_step = 1
[86.169767] (kms_flip:2270) DEBUG: Vblank took 40us
[86.186353] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.383446
last_received_ts = 87.383278
last_seq = 352
current_ts = 87.400124
current_received_ts = 87.399925
current_seq = 353
count = 109
seq_step = 1
[86.186407] (kms_flip:2270) DEBUG: Vblank took 40us
[86.202950] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.400124
last_received_ts = 87.399925
last_seq = 353
current_ts = 87.416794
current_received_ts = 87.416527
current_seq = 354
count = 110
seq_step = 1
[86.203001] (kms_flip:2270) DEBUG: Vblank took 38us
[86.219536] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.416794
last_received_ts = 87.416527
last_seq = 354
current_ts = 87.433472
current_received_ts = 87.433128
current_seq = 355
count = 111
seq_step = 1
[86.219573] (kms_flip:2270) DEBUG: Vblank took 29us
[86.236237] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.433472
last_received_ts = 87.433128
last_seq = 355
current_ts = 87.450134
current_received_ts = 87.449837
current_seq = 356
count = 112
seq_step = 1
[86.236274] (kms_flip:2270) DEBUG: Vblank took 30us
[86.252827] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.450134
last_received_ts = 87.449837
last_seq = 356
current_ts = 87.466812
current_received_ts = 87.466438
current_seq = 357
count = 113
seq_step = 1
[86.252861] (kms_flip:2270) DEBUG: Vblank took 28us
[86.269515] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.466812
last_received_ts = 87.466438
last_seq = 357
current_ts = 87.483498
current_received_ts = 87.483131
current_seq = 358
count = 114
seq_step = 1
[86.269548] (kms_flip:2270) DEBUG: Vblank took 28us
[86.286134] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.483498
last_received_ts = 87.483131
last_seq = 358
current_ts = 87.500160
current_received_ts = 87.499756
current_seq = 359
count = 115
seq_step = 1
[86.286165] (kms_flip:2270) DEBUG: Vblank took 26us
[86.302847] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.500160
last_received_ts = 87.499756
last_seq = 359
current_ts = 87.516838
current_received_ts = 87.516472
current_seq = 360
count = 116
seq_step = 1
[86.302883] (kms_flip:2270) DEBUG: Vblank took 29us
[86.319512] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.516838
last_received_ts = 87.516472
last_seq = 360
current_ts = 87.533516
current_received_ts = 87.533142
current_seq = 361
count = 117
seq_step = 1
[86.319546] (kms_flip:2270) DEBUG: Vblank took 28us
[86.336179] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.533516
last_received_ts = 87.533142
last_seq = 361
current_ts = 87.550186
current_received_ts = 87.549812
current_seq = 362
count = 118
seq_step = 1
[86.336213] (kms_flip:2270) DEBUG: Vblank took 28us
[86.352836] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.550186
last_received_ts = 87.549812
last_seq = 362
current_ts = 87.566849
current_received_ts = 87.566483
current_seq = 363
count = 119
seq_step = 1
[86.352869] (kms_flip:2270) DEBUG: Vblank took 28us
[86.369508] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.566849
last_received_ts = 87.566483
last_seq = 363
current_ts = 87.583527
current_received_ts = 87.583160
current_seq = 364
count = 120
seq_step = 1
[86.369538] (kms_flip:2270) DEBUG: Vblank took 25us
[86.386259] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.583527
last_received_ts = 87.583160
last_seq = 364
current_ts = 87.600212
current_received_ts = 87.599915
current_seq = 365
count = 121
seq_step = 1
[86.386291] (kms_flip:2270) DEBUG: Vblank took 28us
[86.402837] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.600212
last_received_ts = 87.599915
last_seq = 365
current_ts = 87.616875
current_received_ts = 87.616501
current_seq = 366
count = 122
seq_step = 1
[86.402870] (kms_flip:2270) DEBUG: Vblank took 28us
[86.419501] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.616875
last_received_ts = 87.616501
last_seq = 366
current_ts = 87.633545
current_received_ts = 87.633171
current_seq = 367
count = 123
seq_step = 1
[86.419535] (kms_flip:2270) DEBUG: Vblank took 28us
[86.436187] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.633545
last_received_ts = 87.633171
last_seq = 367
current_ts = 87.650215
current_received_ts = 87.649864
current_seq = 368
count = 124
seq_step = 1
[86.436220] (kms_flip:2270) DEBUG: Vblank took 28us
[86.452800] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.650215
last_received_ts = 87.649864
last_seq = 368
current_ts = 87.666893
current_received_ts = 87.666481
current_seq = 369
count = 125
seq_step = 1
[86.452833] (kms_flip:2270) DEBUG: Vblank took 28us
[86.469511] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.666893
last_received_ts = 87.666481
last_seq = 369
current_ts = 87.683563
current_received_ts = 87.683197
current_seq = 370
count = 126
seq_step = 1
[86.469544] (kms_flip:2270) DEBUG: Vblank took 28us
[86.486181] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.683563
last_received_ts = 87.683197
last_seq = 370
current_ts = 87.700241
current_received_ts = 87.699875
current_seq = 371
count = 127
seq_step = 1
[86.486214] (kms_flip:2270) DEBUG: Vblank took 28us
[86.502854] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.700241
last_received_ts = 87.699875
last_seq = 371
current_ts = 87.716927
current_received_ts = 87.716553
current_seq = 372
count = 128
seq_step = 1
[86.502888] (kms_flip:2270) DEBUG: Vblank took 28us
[86.519521] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.716927
last_received_ts = 87.716553
last_seq = 372
current_ts = 87.733597
current_received_ts = 87.733223
current_seq = 373
count = 129
seq_step = 1
[86.519555] (kms_flip:2270) DEBUG: Vblank took 28us
[86.536268] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.733597
last_received_ts = 87.733223
last_seq = 373
current_ts = 87.750259
current_received_ts = 87.749977
current_seq = 374
count = 130
seq_step = 1
[86.536335] (kms_flip:2270) DEBUG: Vblank took 61us
[86.552814] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.750259
last_received_ts = 87.749977
last_seq = 374
current_ts = 87.766930
current_received_ts = 87.766525
current_seq = 375
count = 131
seq_step = 1
[86.552847] (kms_flip:2270) DEBUG: Vblank took 27us
[86.569522] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.766930
last_received_ts = 87.766525
last_seq = 375
current_ts = 87.783615
current_received_ts = 87.783241
current_seq = 376
count = 132
seq_step = 1
[86.569550] (kms_flip:2270) DEBUG: Vblank took 24us
[86.586294] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.783615
last_received_ts = 87.783241
last_seq = 376
current_ts = 87.800293
current_received_ts = 87.799995
current_seq = 377
count = 133
seq_step = 1
[86.586328] (kms_flip:2270) DEBUG: Vblank took 28us
[86.602795] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.800293
last_received_ts = 87.799995
last_seq = 377
current_ts = 87.816948
current_received_ts = 87.816528
current_seq = 378
count = 134
seq_step = 1
[86.602828] (kms_flip:2270) DEBUG: Vblank took 27us
[86.619520] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.816948
last_received_ts = 87.816528
last_seq = 378
current_ts = 87.833626
current_received_ts = 87.833260
current_seq = 379
count = 135
seq_step = 1
[86.619554] (kms_flip:2270) DEBUG: Vblank took 28us
[86.636192] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.833626
last_received_ts = 87.833260
last_seq = 379
current_ts = 87.850311
current_received_ts = 87.849937
current_seq = 380
count = 136
seq_step = 1
[86.636226] (kms_flip:2270) DEBUG: Vblank took 28us
[86.652859] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.850311
last_received_ts = 87.849937
last_seq = 380
current_ts = 87.866982
current_received_ts = 87.866608
current_seq = 381
count = 137
seq_step = 1
[86.652894] (kms_flip:2270) DEBUG: Vblank took 29us
[86.669516] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.866982
last_received_ts = 87.866608
last_seq = 381
current_ts = 87.883644
current_received_ts = 87.883270
current_seq = 382
count = 138
seq_step = 1
[86.669551] (kms_flip:2270) DEBUG: Vblank took 28us
[86.686280] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.883644
last_received_ts = 87.883270
last_seq = 382
current_ts = 87.900322
current_received_ts = 87.900040
current_seq = 383
count = 139
seq_step = 1
[86.686313] (kms_flip:2270) DEBUG: Vblank took 27us
[86.702921] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.900322
last_received_ts = 87.900040
last_seq = 383
current_ts = 87.916992
current_received_ts = 87.916695
current_seq = 384
count = 140
seq_step = 1
[86.702950] (kms_flip:2270) DEBUG: Vblank took 25us
[86.719592] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.916992
last_received_ts = 87.916695
last_seq = 384
current_ts = 87.933678
current_received_ts = 87.933365
current_seq = 385
count = 141
seq_step = 1
[86.719628] (kms_flip:2270) DEBUG: Vblank took 29us
[86.736158] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.933678
last_received_ts = 87.933365
last_seq = 385
current_ts = 87.950340
current_received_ts = 87.949936
current_seq = 386
count = 142
seq_step = 1
[86.736191] (kms_flip:2270) DEBUG: Vblank took 28us
[86.752857] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.950340
last_received_ts = 87.949936
last_seq = 386
current_ts = 87.967010
current_received_ts = 87.966644
current_seq = 387
count = 143
seq_step = 1
[86.752891] (kms_flip:2270) DEBUG: Vblank took 28us
[86.769525] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.967010
last_received_ts = 87.966644
last_seq = 387
current_ts = 87.983688
current_received_ts = 87.983322
current_seq = 388
count = 144
seq_step = 1
[86.769558] (kms_flip:2270) DEBUG: Vblank took 28us
[86.786265] (kms_flip:2270) DEBUG: name = flip
last_ts = 87.983688
last_received_ts = 87.983322
last_seq = 388
current_ts = 88.000366
current_received_ts = 88.000069
current_seq = 389
count = 145
seq_step = 1
[86.786296] (kms_flip:2270) DEBUG: Vblank took 26us
[86.802943] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.000366
last_received_ts = 88.000069
last_seq = 389
current_ts = 88.017044
current_received_ts = 88.016747
current_seq = 390
count = 146
seq_step = 1
[86.802974] (kms_flip:2270) DEBUG: Vblank took 25us
[86.819490] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.017044
last_received_ts = 88.016747
last_seq = 390
current_ts = 88.033714
current_received_ts = 88.033302
current_seq = 391
count = 147
seq_step = 1
[86.819523] (kms_flip:2270) DEBUG: Vblank took 28us
[86.836389] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.033714
last_received_ts = 88.033302
last_seq = 391
current_ts = 88.050392
current_received_ts = 88.050194
current_seq = 392
count = 148
seq_step = 1
[86.836443] (kms_flip:2270) DEBUG: Vblank took 40us
[86.853047] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.050392
last_received_ts = 88.050194
last_seq = 392
current_ts = 88.067055
current_received_ts = 88.066856
current_seq = 393
count = 149
seq_step = 1
[86.853100] (kms_flip:2270) DEBUG: Vblank took 39us
[86.869713] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.067055
last_received_ts = 88.066856
last_seq = 393
current_ts = 88.083725
current_received_ts = 88.083534
current_seq = 394
count = 150
seq_step = 1
[86.869768] (kms_flip:2270) DEBUG: Vblank took 40us
[86.886390] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.083725
last_received_ts = 88.083534
last_seq = 394
current_ts = 88.100403
current_received_ts = 88.100212
current_seq = 395
count = 151
seq_step = 1
[86.886444] (kms_flip:2270) DEBUG: Vblank took 40us
[86.903057] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.100403
last_received_ts = 88.100212
last_seq = 395
current_ts = 88.117081
current_received_ts = 88.116890
current_seq = 396
count = 152
seq_step = 1
[86.903109] (kms_flip:2270) DEBUG: Vblank took 39us
[86.919722] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.117081
last_received_ts = 88.116890
last_seq = 396
current_ts = 88.133751
current_received_ts = 88.133560
current_seq = 397
count = 153
seq_step = 1
[86.919775] (kms_flip:2270) DEBUG: Vblank took 39us
[86.936382] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.133751
last_received_ts = 88.133560
last_seq = 397
current_ts = 88.150429
current_received_ts = 88.150223
current_seq = 398
count = 154
seq_step = 1
[86.936437] (kms_flip:2270) DEBUG: Vblank took 40us
[86.953054] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.150429
last_received_ts = 88.150223
last_seq = 398
current_ts = 88.167091
current_received_ts = 88.166901
current_seq = 399
count = 155
seq_step = 1
[86.953108] (kms_flip:2270) DEBUG: Vblank took 40us
[86.969725] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.167091
last_received_ts = 88.166901
last_seq = 399
current_ts = 88.183769
current_received_ts = 88.183578
current_seq = 400
count = 156
seq_step = 1
[86.969778] (kms_flip:2270) DEBUG: Vblank took 40us
[86.986391] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.183769
last_received_ts = 88.183578
last_seq = 400
current_ts = 88.200447
current_received_ts = 88.200249
current_seq = 401
count = 157
seq_step = 1
[86.986446] (kms_flip:2270) DEBUG: Vblank took 40us
[87.003067] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.200447
last_received_ts = 88.200249
last_seq = 401
current_ts = 88.217117
current_received_ts = 88.216934
current_seq = 402
count = 158
seq_step = 1
[87.003174] (kms_flip:2270) DEBUG: Vblank took 93us
[87.019725] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.217117
last_received_ts = 88.216934
last_seq = 402
current_ts = 88.233795
current_received_ts = 88.233597
current_seq = 403
count = 159
seq_step = 1
[87.019780] (kms_flip:2270) DEBUG: Vblank took 40us
[87.036391] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.233795
last_received_ts = 88.233597
last_seq = 403
current_ts = 88.250465
current_received_ts = 88.250267
current_seq = 404
count = 160
seq_step = 1
[87.036446] (kms_flip:2270) DEBUG: Vblank took 40us
[87.053053] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.250465
last_received_ts = 88.250267
last_seq = 404
current_ts = 88.267136
current_received_ts = 88.266937
current_seq = 405
count = 161
seq_step = 1
[87.053161] (kms_flip:2270) DEBUG: Vblank took 93us
[87.069725] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.267136
last_received_ts = 88.266937
last_seq = 405
current_ts = 88.283813
current_received_ts = 88.283615
current_seq = 406
count = 162
seq_step = 1
[87.069779] (kms_flip:2270) DEBUG: Vblank took 40us
[87.086391] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.283813
last_received_ts = 88.283615
last_seq = 406
current_ts = 88.300484
current_received_ts = 88.300285
current_seq = 407
count = 163
seq_step = 1
[87.086446] (kms_flip:2270) DEBUG: Vblank took 40us
[87.103058] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.300484
last_received_ts = 88.300285
last_seq = 407
current_ts = 88.317154
current_received_ts = 88.316963
current_seq = 408
count = 164
seq_step = 1
[87.103169] (kms_flip:2270) DEBUG: Vblank took 96us
[87.119706] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.317154
last_received_ts = 88.316963
last_seq = 408
current_ts = 88.333839
current_received_ts = 88.333618
current_seq = 409
count = 165
seq_step = 1
[87.119760] (kms_flip:2270) DEBUG: Vblank took 40us
[87.136304] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.333839
last_received_ts = 88.333618
last_seq = 409
current_ts = 88.350510
current_received_ts = 88.350227
current_seq = 410
count = 166
seq_step = 1
[87.136346] (kms_flip:2270) DEBUG: Vblank took 32us
[87.152961] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.350510
last_received_ts = 88.350227
last_seq = 410
current_ts = 88.367172
current_received_ts = 88.366890
current_seq = 411
count = 167
seq_step = 1
[87.152997] (kms_flip:2270) DEBUG: Vblank took 30us
[87.169506] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.367172
last_received_ts = 88.366890
last_seq = 411
current_ts = 88.383858
current_received_ts = 88.383446
current_seq = 412
count = 168
seq_step = 1
[87.169537] (kms_flip:2270) DEBUG: Vblank took 25us
[87.186214] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.383858
last_received_ts = 88.383446
last_seq = 412
current_ts = 88.400528
current_received_ts = 88.400162
current_seq = 413
count = 169
seq_step = 1
[87.186248] (kms_flip:2270) DEBUG: Vblank took 28us
[87.202882] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.400528
last_received_ts = 88.400162
last_seq = 413
current_ts = 88.417198
current_received_ts = 88.416832
current_seq = 414
count = 170
seq_step = 1
[87.202915] (kms_flip:2270) DEBUG: Vblank took 28us
[87.219550] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.417198
last_received_ts = 88.416832
last_seq = 414
current_ts = 88.433876
current_received_ts = 88.433502
current_seq = 415
count = 171
seq_step = 1
[87.219584] (kms_flip:2270) DEBUG: Vblank took 27us
[87.236211] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.433876
last_received_ts = 88.433502
last_seq = 415
current_ts = 88.450539
current_received_ts = 88.450172
current_seq = 416
count = 172
seq_step = 1
[87.236244] (kms_flip:2270) DEBUG: Vblank took 28us
[87.252845] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.450539
last_received_ts = 88.450172
last_seq = 416
current_ts = 88.467209
current_received_ts = 88.466812
current_seq = 417
count = 173
seq_step = 1
[87.252879] (kms_flip:2270) DEBUG: Vblank took 28us
[87.269555] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.467209
last_received_ts = 88.466812
last_seq = 417
current_ts = 88.483879
current_received_ts = 88.483528
current_seq = 418
count = 174
seq_step = 1
[87.269588] (kms_flip:2270) DEBUG: Vblank took 27us
[87.286212] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.483879
last_received_ts = 88.483528
last_seq = 418
current_ts = 88.500557
current_received_ts = 88.500191
current_seq = 419
count = 175
seq_step = 1
[87.286246] (kms_flip:2270) DEBUG: Vblank took 27us
[87.302879] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.500557
last_received_ts = 88.500191
last_seq = 419
current_ts = 88.517235
current_received_ts = 88.516861
current_seq = 420
count = 176
seq_step = 1
[87.302914] (kms_flip:2270) DEBUG: Vblank took 28us
[87.319553] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.517235
last_received_ts = 88.516861
last_seq = 420
current_ts = 88.533913
current_received_ts = 88.533539
current_seq = 421
count = 177
seq_step = 1
[87.319587] (kms_flip:2270) DEBUG: Vblank took 28us
[87.336221] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.533913
last_received_ts = 88.533539
last_seq = 421
current_ts = 88.550591
current_received_ts = 88.550217
current_seq = 422
count = 178
seq_step = 1
[87.336254] (kms_flip:2270) DEBUG: Vblank took 28us
[87.352832] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.550591
last_received_ts = 88.550217
last_seq = 422
current_ts = 88.567245
current_received_ts = 88.566833
current_seq = 423
count = 179
seq_step = 1
[87.352861] (kms_flip:2270) DEBUG: Vblank took 25us
[87.369627] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.567245
last_received_ts = 88.566833
last_seq = 423
current_ts = 88.583931
current_received_ts = 88.583633
current_seq = 424
count = 180
seq_step = 1
[87.369660] (kms_flip:2270) DEBUG: Vblank took 28us
[87.386222] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.583931
last_received_ts = 88.583633
last_seq = 424
current_ts = 88.600601
current_received_ts = 88.600235
current_seq = 425
count = 181
seq_step = 1
[87.386255] (kms_flip:2270) DEBUG: Vblank took 28us
[87.402961] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.600601
last_received_ts = 88.600235
last_seq = 425
current_ts = 88.617271
current_received_ts = 88.616982
current_seq = 426
count = 182
seq_step = 1
[87.403018] (kms_flip:2270) DEBUG: Vblank took 52us
[87.419519] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.617271
last_received_ts = 88.616982
last_seq = 426
current_ts = 88.633942
current_received_ts = 88.633537
current_seq = 427
count = 183
seq_step = 1
[87.419551] (kms_flip:2270) DEBUG: Vblank took 27us
[87.436226] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.633942
last_received_ts = 88.633537
last_seq = 427
current_ts = 88.650627
current_received_ts = 88.650253
current_seq = 428
count = 184
seq_step = 1
[87.436259] (kms_flip:2270) DEBUG: Vblank took 27us
[87.452996] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.650627
last_received_ts = 88.650253
last_seq = 428
current_ts = 88.667297
current_received_ts = 88.667000
current_seq = 429
count = 185
seq_step = 1
[87.453031] (kms_flip:2270) DEBUG: Vblank took 29us
[87.469559] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.667297
last_received_ts = 88.667000
last_seq = 429
current_ts = 88.683968
current_received_ts = 88.683601
current_seq = 430
count = 186
seq_step = 1
[87.469593] (kms_flip:2270) DEBUG: Vblank took 28us
[87.486227] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.683968
last_received_ts = 88.683601
last_seq = 430
current_ts = 88.700645
current_received_ts = 88.700272
current_seq = 431
count = 187
seq_step = 1
[87.486259] (kms_flip:2270) DEBUG: Vblank took 27us
[87.502991] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.700645
last_received_ts = 88.700272
last_seq = 431
current_ts = 88.717316
current_received_ts = 88.717041
current_seq = 432
count = 188
seq_step = 1
[87.503026] (kms_flip:2270) DEBUG: Vblank took 28us
[87.519552] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.717316
last_received_ts = 88.717041
last_seq = 432
current_ts = 88.733978
current_received_ts = 88.733604
current_seq = 433
count = 189
seq_step = 1
[87.519586] (kms_flip:2270) DEBUG: Vblank took 28us
[87.536219] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.733978
last_received_ts = 88.733604
last_seq = 433
current_ts = 88.750656
current_received_ts = 88.750282
current_seq = 434
count = 190
seq_step = 1
[87.536253] (kms_flip:2270) DEBUG: Vblank took 28us
[87.552981] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.750656
last_received_ts = 88.750282
last_seq = 434
current_ts = 88.767326
current_received_ts = 88.767052
current_seq = 435
count = 191
seq_step = 1
[87.553015] (kms_flip:2270) DEBUG: Vblank took 28us
[87.569706] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.767326
last_received_ts = 88.767052
last_seq = 435
current_ts = 88.784004
current_received_ts = 88.783768
current_seq = 436
count = 192
seq_step = 1
[87.569767] (kms_flip:2270) DEBUG: Vblank took 42us
[87.586363] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.784004
last_received_ts = 88.783768
last_seq = 436
current_ts = 88.800682
current_received_ts = 88.800430
current_seq = 437
count = 193
seq_step = 1
[87.586415] (kms_flip:2270) DEBUG: Vblank took 37us
[87.603025] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.800682
last_received_ts = 88.800430
last_seq = 437
current_ts = 88.817345
current_received_ts = 88.817101
current_seq = 438
count = 194
seq_step = 1
[87.603077] (kms_flip:2270) DEBUG: Vblank took 38us
[87.619688] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.817345
last_received_ts = 88.817101
last_seq = 438
current_ts = 88.834023
current_received_ts = 88.833771
current_seq = 439
count = 195
seq_step = 1
[87.619739] (kms_flip:2270) DEBUG: Vblank took 37us
[87.636382] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.834023
last_received_ts = 88.833771
last_seq = 439
current_ts = 88.850700
current_received_ts = 88.850464
current_seq = 440
count = 196
seq_step = 1
[87.636442] (kms_flip:2270) DEBUG: Vblank took 43us
[87.653061] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.850700
last_received_ts = 88.850464
last_seq = 440
current_ts = 88.867371
current_received_ts = 88.867149
current_seq = 441
count = 197
seq_step = 1
[87.653121] (kms_flip:2270) DEBUG: Vblank took 43us
[87.669719] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.867371
last_received_ts = 88.867149
last_seq = 441
current_ts = 88.884033
current_received_ts = 88.883812
current_seq = 442
count = 198
seq_step = 1
[87.669777] (kms_flip:2270) DEBUG: Vblank took 41us
[87.686320] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.884033
last_received_ts = 88.883812
last_seq = 442
current_ts = 88.900719
current_received_ts = 88.900429
current_seq = 443
count = 199
seq_step = 1
[87.686356] (kms_flip:2270) DEBUG: Vblank took 29us
[87.702966] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.900719
last_received_ts = 88.900429
last_seq = 443
current_ts = 88.917389
current_received_ts = 88.917084
current_seq = 444
count = 200
seq_step = 1
[87.703002] (kms_flip:2270) DEBUG: Vblank took 29us
[87.719530] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.917389
last_received_ts = 88.917084
last_seq = 444
current_ts = 88.934059
current_received_ts = 88.933655
current_seq = 445
count = 201
seq_step = 1
[87.719559] (kms_flip:2270) DEBUG: Vblank took 25us
[87.736275] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.934059
last_received_ts = 88.933655
last_seq = 445
current_ts = 88.950729
current_received_ts = 88.950401
current_seq = 446
count = 202
seq_step = 1
[87.736313] (kms_flip:2270) DEBUG: Vblank took 30us
[87.753090] (kms_flip:2270) DEBUG: name = flip
last_ts = 88.950729
last_received_ts = 88.950401
last_seq = 446
current_ts = 88.967400
current_received_ts = 88.967209
current_seq = 447
count = 203
seq_step = 1
[87.754414] (kms_flip:2270) DEBUG: Vblank took 1298us
[87.754431] (kms_flip:2270) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:931:
[87.754550] (kms_flip:2270) CRITICAL: Failed assertion: end - start < 500
[87.766359] (kms_flip:2270) igt_core-INFO: Stack trace:
[87.774295] (kms_flip:2270) igt_core-INFO:   #0 ../lib/igt_core.c:2106 __igt_fail_assert()
[87.774707] (kms_flip:2270) igt_core-INFO:   #1 ../tests/kms_flip.c:926 run_test_on_crtc_set()
[87.774737] (kms_flip:2270) igt_core-INFO:   #2 ../tests/kms_flip.c:1920 run_test()
[87.774750] (kms_flip:2270) igt_core-INFO:   #3 ../tests/kms_flip.c:2184 __igt_unique____real_main2105()
[87.774762] (kms_flip:2270) igt_core-INFO:   #4 ../tests/kms_flip.c:2105 main()
[87.776393] (kms_flip:2270) igt_core-INFO:   #5 [__libc_init_first+0x8a]
[87.776966] (kms_flip:2270) igt_core-INFO:   #6 [__libc_start_main+0x8b]
[87.777094] (kms_flip:2270) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest D-HDMI-A3: FAIL (4.674s)
Subtest flip-vs-expired-vblank: FAIL (32.942s)
[89.056291] (kms_flip:2270) igt_kms-CRITICAL: Test assertion failure function kmstest_set_connector_dpms, file ../lib/igt_kms.c:2354:
[89.056339] (kms_flip:2270) igt_kms-CRITICAL: Failed assertion: found_it
[89.056378] (kms_flip:2270) igt_kms-CRITICAL: Last errno: 9, Bad file descriptor
[89.056405] (kms_flip:2270) igt_kms-CRITICAL: DPMS property not found on 539
Dmesg
<6> [85.720969] [IGT] kms_flip: starting dynamic subtest D-HDMI-A3
<7> [85.722507] xe 0000:03:00.0: [drm:drm_mode_addfb2] [FB:556]
<7> [85.722790] xe 0000:03:00.0: [drm:drm_mode_addfb2] [FB:559]
<7> [85.787541] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:151:pipe A]
<7> [85.788418] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:269:pipe C]
<7> [85.788584] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:387:pipe B]
<7> [85.788701] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.enable (expected yes, found no)
<7> [85.788992] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.active (expected yes, found no)
<7> [85.789224] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [85.789438] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in lane_count (expected 4, found 0)
<7> [85.789640] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [85.789838] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [85.790161] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [85.790350] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [85.790836] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [85.791034] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [85.791216] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [85.791389] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [85.791558] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [85.791724] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [85.791887] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [85.792068] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [85.792228] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [85.792381] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [85.792537] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [85.792684] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [85.792830] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [85.792985] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [85.793132] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [85.793279] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [85.793419] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [85.793560] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [85.793716] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [85.793854] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [85.793997] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [85.794131] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [85.794261] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [85.794389] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [85.794513] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [85.794636] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [85.794753] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [85.794874] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [85.795010] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [85.795134] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [85.795250] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in port_clock (expected 222750, found 0)
<7> [85.795364] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [85.795473] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [85.795582] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in avi infoframe
<7> [85.795686] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [85.795789] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [85.795791] xe 0000:03:00.0: colorspace: RGB
<7> [85.795793] xe 0000:03:00.0: scan mode: Underscan
<7> [85.795794] xe 0000:03:00.0: colorimetry: No Data
<7> [85.795796] xe 0000:03:00.0: picture aspect: 16:9
<7> [85.795797] xe 0000:03:00.0: active aspect: Same as Picture
<7> [85.795798] xe 0000:03:00.0: itc: No Data
<7> [85.795800] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [85.795801] xe 0000:03:00.0: quantization range: Limited
<7> [85.795802] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [85.795804] xe 0000:03:00.0: video code: 16
<7> [85.795805] xe 0000:03:00.0: ycc quantization range: Limited
<7> [85.795806] xe 0000:03:00.0: hdmi content type: Graphics
<7> [85.795808] xe 0000:03:00.0: pixel repeat: 0
<7> [85.795809] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [85.795811] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [85.795915] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in spd infoframe
<7> [85.796027] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [85.796129] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [85.796130] xe 0000:03:00.0: vendor: Intel
<7> [85.796132] xe 0000:03:00.0: product: Discrete gfx
<7> [85.796133] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [85.796135] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [85.796232] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:387:pipe B] fastset requirement not met in hdmi infoframe
<7> [85.796331] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [85.796426] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [85.796427] xe 0000:03:00.0: empty frame
<7> [85.796429] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [85.796526] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:387:pipe B] fastset requirement not met, forcing full modeset
<7> [85.796620] xe 0000:03:00.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:387:pipe B] releasing TC PLL 3
<7> [85.796745] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [85.796829] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:387:pipe B] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x2 -> 0x0
<7> [85.796931] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:381:cursor B] ddb (4037 - 4096) -> ( 0 - 0), size 59 -> 0
<7> [85.797022] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:387:pipe B] min cdclk: 192000 kHz -> 0 kHz
<7> [85.797153] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:387:pipe B] enable: no [modeset]
<7> [85.797256] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:271:plane 1B] fb: [NOFB], visible: no
<7> [85.797355] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:301:plane 2B] fb: [NOFB], visible: no
<7> [85.797453] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:331:plane 3B] fb: [NOFB], visible: no
<7> [85.797549] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:361:plane 4B] fb: [NOFB], visible: no
<7> [85.797647] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:371:plane 5B] fb: [NOFB], visible: no
<7> [85.797741] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:381:cursor B] fb: [NOFB], visible: no
<7> [85.798410] xe 0000:03:00.0: [drm:intel_audio_codec_disable [xe]] [CONNECTOR:539:HDMI-A-3][ENCODER:538:DDI TC3/PHY H] Disable audio codec on [CRTC:387:pipe B]
<7> [85.816788] xe 0000:03:00.0: [drm:intel_audio_component_get_eld [xe]] Not valid for port F
<7> [85.817208] xe 0000:03:00.0: [drm:intel_disable_transcoder [xe]] disabling pipe B
<7> [85.834194] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disable TC PLL 3 (active 0x2, on? 1) for [CRTC:387:pipe B]
<7> [85.836655] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disabling TC PLL 3
<7> [85.837485] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:507:DDI TC1/PHY F]
<7> [85.837971] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST A]
<7> [85.838400] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST B]
<7> [85.838825] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:511:DP-MST C]
<7> [85.839267] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:512:DP-MST D]
<7> [85.839627] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:526:DDI TC2/PHY G]
<7> [85.839990] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST A]
<7> [85.840339] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST B]
<7> [85.840674] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:530:DP-MST C]
<7> [85.840994] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:531:DP-MST D]
<7> [85.841307] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:538:DDI TC3/PHY H]
<7> [85.841383] xe 0000:03:00.0: [drm:intel_audio_component_get_power [xe]] restored AUD_FREQ_CNTRL to 0x8010
<7> [85.841822] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:542:DDI TC4/PHY I]
<7> [85.842135] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST A]
<7> [85.842428] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST B]
<7> [85.842701] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:546:DP-MST C]
<7> [85.842965] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:547:DP-MST D]
<7> [85.843228] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:539:HDMI-A-3]
<7> [85.843718] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [85.844181] xe 0000:03:00.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [85.844401] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [85.844947] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling PW_B
<7> [85.845416] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating disabled for pipe_mask=0x2 (CLKGATE_DIS_DSSDSC=0xaa000000)
<7> [85.845913] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:387:pipe B]
<7> [85.846637] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:505:pipe D]
<7> [85.847412] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:505:pipe D]
<7> [85.847449] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CONNECTOR:539:HDMI-A-3]
<7> [85.847552] xe 0000:03:00.0: [drm:intel_hdmi_compute_output_format [xe]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [85.847740] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:505:pipe D] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [85.847955] xe 0000:03:00.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:538:DDI TC3/PHY H] [CRTC:505:pipe D]
<7> [85.848154] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.enable (expected no, found yes)
<7> [85.848337] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.active (expected no, found yes)
<7> [85.848514] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in cpu_transcoder (expected -1, found 3)
<7> [85.848684] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in lane_count (expected 0, found 4)
<7> [85.848844] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [85.849012] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [85.849168] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [85.849317] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [85.849462] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [85.849604] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [85.849741] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [85.849889] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [85.850045] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [85.850187] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [85.850316] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [85.850442] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [85.850566] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [85.850687] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [85.850804] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [85.850920] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [85.851054] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [85.851174] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [85.851280] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [85.851385] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [85.851490] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [85.851593] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [85.851698] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [85.851801] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [85.851905] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [85.852017] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [85.852121] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [85.852215] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [85.852309] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [85.852404] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [85.852497] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [85.852593] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in dpll_hw_state
<7> [85.852684] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [85.852775] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [85.852868] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] c20pll_hw_state:
<7> [85.852965] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] tx[0] = 0xbe88, tx[1] = 0x4800, tx[2] = 0x0000
<7> [85.853057] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [85.853148] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[0] = 0x308c
<7> [85.853239] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[1] = 0x2110
<7> [85.853329] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[2] = 0xcc9c
<7> [85.853419] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[3] = 0xbfc1
<7> [85.853507] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[4] = 0x4b9a
<7> [85.853596] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[5] = 0x3f81
<7> [85.853684] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[6] = 0x2000
<7> [85.853772] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[7] = 0x0001
<7> [85.853860] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[8] = 0x5000
<7> [85.853953] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[9] = 0x0000
<7> [85.854042] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[10] = 0x0000
<7> [85.854130] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] vdr: custom width: 0x00, serdes rate: 0x42, hdmi rate: 0x00
<7> [85.854219] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [85.854307] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [85.854396] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] c20pll_hw_state:
<7> [85.854484] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] tx[0] = 0xbe88, tx[1] = 0x5800, tx[2] = 0x0000
<7> [85.854572] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [85.854660] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[0] = 0x40e8
<7> [85.854747] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[1] = 0x7d20
<7> [85.854837] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[2] = 0x0a06
<7> [85.854930] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[3] = 0x8f1c
<7> [85.855019] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[4] = 0x0000
<7> [85.855109] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[5] = 0x0000
<7> [85.855120] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [85.855196] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[6] = 0x2200
<7> [85.855284] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[7] = 0xffff
<7> [85.855374] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[8] = 0x0400
<7> [85.855463] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[9] = 0x0000
<7> [85.855553] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[10] = 0x0001
<7> [85.855643] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] vdr: custom width: 0x00, serdes rate: 0x00, hdmi rate: 0x00
<7> [85.855733] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [85.855823] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [85.855912] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [85.856013] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in port_clock (expected 0, found 222750)
<7> [85.856107] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [85.856205] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)
<7> [85.856300] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in avi infoframe
<7> [85.856394] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [85.856487] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [85.856580] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [85.856581] xe 0000:03:00.0: colorspace: RGB
<7> [85.856583] xe 0000:03:00.0: scan mode: Underscan
<7> [85.856584] xe 0000:03:00.0: colorimetry: No Data
<7> [85.856585] xe 0000:03:00.0: picture aspect: 16:9
<7> [85.856586] xe 0000:03:00.0: active aspect: Same as Picture
<7> [85.856587] xe 0000:03:00.0: itc: No Data
<7> [85.856589] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [85.856590] xe 0000:03:00.0: quantization range: Limited
<7> [85.856591] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [85.856592] xe 0000:03:00.0: video code: 16
<7> [85.856593] xe 0000:03:00.0: ycc quantization range: Limited
<7> [85.856595] xe 0000:03:00.0: hdmi content type: Graphics
<7> [85.856596] xe 0000:03:00.0: pixel repeat: 0
<7> [85.856597] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [85.856599] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in spd infoframe
<7> [85.856691] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [85.856782] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [85.856873] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [85.856874] xe 0000:03:00.0: vendor: Intel
<7> [85.856876] xe 0000:03:00.0: product: Discrete gfx
<7> [85.856877] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [85.856878] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hdmi infoframe
<7> [85.856975] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [85.857065] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [85.857154] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [85.857156] xe 0000:03:00.0: empty frame
<7> [85.857157] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:505:pipe D] fastset requirement not met, forcing full modeset
<7> [85.857266] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0xf), mbus joined? no->no
<7> [85.857346] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:505:pipe D] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x8
<7> [85.857440] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:389:plane 1D] ddb ( 0 - 0) -> ( 0 - 1989), size 0 -> 1989
<7> [85.857516] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:499:cursor D] ddb ( 0 - 0) -> (1989 - 2048), size 0 -> 59
<7> [85.857592] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:389: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> [85.857662] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:389:plane 1D] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 4, 9, 9, 17, 17, 17, 17, 0, 15, 0
<7> [85.857732] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:389:plane 1D] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 62, 62, 139, 139, 261, 261, 261, 261, 137, 230, 244
<7> [85.857800] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:389:plane 1D] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 123, 123, 245, 245, 367, 367, 0, 0, 138, 306, 306
<7> [85.857880] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:505:pipe D] data rate 594000 num active planes 1
<7> [85.857992] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 624 qgv_peak_bw: 48000
<7> [85.858092] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 624 qgv_peak_bw: 48000
<7> [85.858189] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 624
<7> [85.858296] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:505:pipe D] min cdclk: 0 kHz -> 192000 kHz
<7> [85.858417] xe 0000:03:00.0: [drm:intel_find_dpll [xe]] [CRTC:505:pipe D] allocated TC PLL 3
<7> [85.858510] xe 0000:03:00.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:505:pipe D] reserving TC PLL 3
<7> [85.858600] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:505:pipe D] enable: yes [modeset]
<7> [85.858703] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [85.858802] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: D, pipe bpp: 36, dithering: 0
<7> [85.858899] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [85.859002] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [85.859097] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [85.859192] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [85.859285] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [85.859378] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] GCP: 0x6
<7> [85.859471] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [85.859473] xe 0000:03:00.0: colorspace: RGB
<7> [85.859474] xe 0000:03:00.0: scan mode: Underscan
<7> [85.859475] xe 0000:03:00.0: colorimetry: No Data
<7> [85.859477] xe 0000:03:00.0: picture aspect: 16:9
<7> [85.859478] xe 0000:03:00.0: active aspect: Same as Picture
<7> [85.859479] xe 0000:03:00.0: itc: No Data
<7> [85.859480] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [85.859481] xe 0000:03:00.0: quantization range: Limited
<7> [85.859482] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [85.859484] xe 0000:03:00.0: video code: 16
<7> [85.859485] xe 0000:03:00.0: ycc quantization range: Limited
<7> [85.859486] xe 0000:03:00.0: hdmi content type: Graphics
<7> [85.859487] xe 0000:03:00.0: pixel repeat: 0
<7> [85.859488] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [85.859490] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [85.859491] xe 0000:03:00.0: vendor: Intel
<7> [85.859492] xe 0000:03:00.0: product: Discrete gfx
<7> [85.859493] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [85.859495] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [85.859496] xe 0000:03:00.0: empty frame
<7> [85.859497] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 10 00 08 00 65 32 00 01 00 00 00 00 00 00 00 00
<7> [85.859592] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 61 a4 9a 00 4d 69 20 54 56 09 07 07 11 17 50 51
<7> [85.859684] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 07 00 00 00
<7> [85.859775] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [85.859868] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [85.859967] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 0, guardband: 45 vsync start: 41, vsync end: 36
<7> [85.860060] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1080, vmax vblank: 1080, vmin vtotal: 1125, vmax vtotal: 1125
<7> [85.860151] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [85.860245] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [85.860337] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [85.860429] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [85.860522] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [85.860614] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [85.860706] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port clock: 222750, pixel rate 148500, min cdclk 192000, min voltage level 0
<7> [85.860798] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] linetime: 119, ips linetime: 0
<7> [85.860889] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0, sharpness_strength: 0
<7> [85.860995] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe src: 1920x1080+0+0
<7> [85.861091] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [85.861185] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [85.861277] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [85.861369] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [85.861460] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] c20pll_hw_state:
<7> [85.861550] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] tx[0] = 0xbe88, tx[1] = 0x5800, tx[2] = 0x0000
<7> [85.861641] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [85.861732] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[0] = 0x40e8
<7> [85.861824] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[1] = 0x7d20
<7> [85.861914] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[2] = 0x0a06
<7> [85.862015] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[3] = 0x8f1c
<7> [85.862105] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[4] = 0x0000
<7> [85.862194] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[5] = 0x0000
<7> [85.862283] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[6] = 0x2200
<7> [85.862371] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[7] = 0xffff
<7> [85.862460] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[8] = 0x0400
<7> [85.862549] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[9] = 0x0000
<7> [85.862638] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[10] = 0x0001
<7> [85.862727] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vdr: custom width: 0x00, serdes rate: 0x00, hdmi rate: 0x00
<7> [85.862818] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x40000000 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [85.862909] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [85.863011] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [85.863101] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0db0 0x0000 0x0000
<7> [85.863191] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0db0 0x0000
<7> [85.863280] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0db0
<7> [85.863369] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0100 0x0100 0x0100
<7> [85.863459] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [85.863548] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [85.863638] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [85.863726] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [85.863815] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [85.863904] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:389:plane 1D] fb: [FB:556] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [85.864024] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [85.864114] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [85.864206] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:419:plane 2D] fb: [NOFB], visible: no
<7> [85.864297] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:449:plane 3D] fb: [NOFB], visible: no
<7> [85.864388] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:479:plane 4D] fb: [NOFB], visible: no
<7> [85.864477] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:489:plane 5D] fb: [NOFB], visible: no
<7> [85.864566] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:499:cursor D] fb: [NOFB], visible: no
<7> [85.865118] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [85.865241] xe 0000:03:00.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [85.865342] xe 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<7> [85.865458] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling always-on
<7> [85.865554] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling always-on
<7> [85.865655] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [85.865909] xe 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [85.866046] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [85.866146] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_D
<7> [85.866258] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x8 (CLKGATE_DIS_DSSDSC=0x2a000000)
<7> [85.866361] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:507:DDI TC1/PHY F]
<7> [85.866448] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST A]
<7> [85.866531] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST B]
<7> [85.866612] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:511:DP-MST C]
<7> [85.866692] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:512:DP-MST D]
<7> [85.866771] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:526:DDI TC2/PHY G]
<7> [85.866850] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST A]
<7> [85.866931] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST B]
<7> [85.867009] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:530:DP-MST C]
<7> [85.867087] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:531:DP-MST D]
<7> [85.867164] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:538:DDI TC3/PHY H]
<7> [85.867242] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:542:DDI TC4/PHY I]
<7> [85.867322] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST A]
<7> [85.867401] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST B]
<7> [85.867478] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:546:DP-MST C]
<7> [85.867556] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:547:DP-MST D]
<7> [85.867643] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x3
<7> [85.867804] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [85.867899] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enable TC PLL 3 (active 0x8, on? 0) for [CRTC:505:pipe D]
<7> [85.868004] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enabling TC PLL 3
<7> [85.870162] xe 0000:03:00.0: [drm:intel_enable_transcoder [xe]] enabling pipe D
<7> [85.905653] xe 0000:03:00.0: [drm:intel_audio_codec_enable [xe]] [CONNECTOR:539:HDMI-A-3][ENCODER:538:DDI TC3/PHY H] Enable audio codec on [CRTC:505:pipe D], 36 bytes ELD
<7> [85.919443] xe 0000:03:00.0: [drm:intel_audio_component_get_power [xe]] restored AUD_FREQ_CNTRL to 0x8010
<7> [85.922177] xe 0000:03:00.0: [drm:audio_config_hdmi_pixel_clock [xe]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [85.922804] xe 0000:03:00.0: [drm:hsw_audio_config_update [xe]] using automatic N
<7> [85.923877] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:539:HDMI-A-3]
<7> [85.924688] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:505:pipe D]
<7> [89.383717] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 0 val 0x26252424
<7> [89.383921] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 1 val 0x27272626
<6> [90.396218] [IGT] kms_flip: finished subtest D-HDMI-A3, FAIL
<6> [90.399836] [IGT] kms_flip: finished subtest flip-vs-expired-vblank, FAIL
<7> [90.407515] xe 0000:03:00.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:559] from all active usage due to RMFB ioctl
<7> [90.407812] xe 0000:03:00.0: [drm:atomic_remove_fb] Disabling [PLANE:389:plane 1D] because [FB:559] is removed
<7> [90.407871] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:389:plane 1D] ddb ( 0 - 1989) -> ( 0 - 0), size 1989 -> 0
<7> [90.408056] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:389: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> [90.408196] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:389:plane 1D] lines 4, 4, 9, 9, 17, 17, 17, 17, 0, 15, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [90.408351] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:389:plane 1D] blocks 62, 62, 139, 139, 261, 261, 261, 261, 137, 230, 244 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [90.408490] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:389:plane 1D] min_ddb 123, 123, 245, 245, 367, 367, 0, 0, 138, 306, 306 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [90.408662] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:505:pipe D] data rate 0 num active planes 0
<7> [90.408855] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 0 qgv_peak_bw: 48000
<7> [90.409036] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 0 qgv_peak_bw: 48000
<7> [90.409213] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 0
<7> [90.423032] xe 0000:03:00.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:526:DDI TC2/PHY G][CRTC:151:pipe A] DP link limits: pixel clock 148500 kHz DSC off max lanes 4 max rate 540000 max pipe_bpp 36 min link_bpp 18.0000 max link_bpp 36.0000
<7> [90.423162] xe 0000:03:00.0: [drm:intel_dp_compute_output_format [xe]] DP lane count 4 clock 270000 bpp input 36 compressed 0.0000 HDR no link rate required 668250 available 1080000
<7> [90.423284] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:151:pipe A] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [90.423465] xe 0000:03:00.0: [drm:intel_hdmi_compute_output_format [xe]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [90.423597] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:269:pipe C] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [90.423747] xe 0000:03:00.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:526:DDI TC2/PHY G] [CRTC:151:pipe A]
<7> [90.423887] xe 0000:03:00.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:538:DDI TC3/PHY H] [CRTC:269:pipe C]
<7> [90.424025] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [90.424162] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [90.424338] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [90.424453] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [90.424552] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 5190451/8388608 link 288358/524288)
<7> [90.424642] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000080)
<7> [90.424730] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [90.424817] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [90.424901] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [90.424987] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [90.425071] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [90.425155] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [90.425239] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [90.425347] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [90.425457] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [90.425542] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [90.425625] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [90.425708] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [90.425795] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [90.425878] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [90.425960] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [90.426041] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [90.426123] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [90.426205] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [90.426320] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [90.426410] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [90.426492] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [90.426574] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [90.426656] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [90.426738] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [90.426819] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [90.426899] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [90.426979] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [90.427060] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [90.427141] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in enhanced_framing (expected no, found yes)
<7> [90.427223] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in dpll_hw_state
<7> [90.427320] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [90.427413] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [90.427498] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] c20pll_hw_state:
<7> [90.427582] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] tx[0] = 0xbe88, tx[1] = 0x5800, tx[2] = 0x0000
<7> [90.427665] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [90.427750] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[0] = 0x40e8
<7> [90.427833] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[1] = 0x7d20
<7> [90.427916] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[2] = 0x0a06
<7> [90.427996] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[3] = 0x8f1c
<7> [90.428079] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[4] = 0x0000
<7> [90.428162] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[5] = 0x0000
<7> [90.428244] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[6] = 0x2200
<7> [90.428346] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[7] = 0xffff
<7> [90.428433] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[8] = 0x0400
<7> [90.428516] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[9] = 0x0000
<7> [90.428599] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[10] = 0x0001
<7> [90.428681] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] vdr: custom width: 0x00, serdes rate: 0x00, hdmi rate: 0x00
<7> [90.428761] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [90.428844] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [90.428928] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] c20pll_hw_state:
<7> [90.429011] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] tx[0] = 0xbe88, tx[1] = 0x4800, tx[2] = 0x0000
<7> [90.429092] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [90.429175] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[0] = 0x308c
<7> [90.429258] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[1] = 0x2110
<7> [90.429366] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[2] = 0xcc9c
<7> [90.429451] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[3] = 0xbfc1
<7> [90.429533] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[4] = 0x4b9a
<7> [90.429615] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[5] = 0x3f81
<7> [90.429697] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[6] = 0x2000
<7> [90.429779] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[7] = 0x0001
<7> [90.429861] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[8] = 0x5000
<7> [90.429944] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[9] = 0x0000
<7> [90.430026] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[10] = 0x0000
<7> [90.430110] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] vdr: custom width: 0x00, serdes rate: 0x42, hdmi rate: 0x00
<7> [90.430192] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [90.430275] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [90.430366] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [90.430455] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in port_clock (expected 0, found 270000)
<7> [90.430552] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:151:pipe A] fastset requirement not met, forcing full modeset
<7> [90.430645] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.enable (expected no, found yes)
<7> [90.430745] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.active (expected no, found yes)
<7> [90.430836] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in cpu_transcoder (expected -1, found 2)
<7> [90.430930] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in lane_count (expected 0, found 4)
<7> [90.431021] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [90.431112] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [90.431202] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [90.431314] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [90.431404] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [90.431495] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [90.431584] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [90.431673] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [90.431762] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [90.431851] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [90.431939] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [90.432029] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [90.432117] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [90.432208] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [90.432315] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [90.432406] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [90.432496] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [90.432587] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [90.432677] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [90.432768] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [90.432860] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [90.432950] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [90.433040] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [90.433128] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [90.433217] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [90.433313] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [90.433403] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [90.433492] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [90.433582] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [90.433671] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [90.433759] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [90.433847] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [90.433935] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [90.434023] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [90.434111] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in port_clock (expected 0, found 222750)
<7> [90.434198] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [90.434289] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)
<7> [90.434390] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in avi infoframe
<7> [90.434487] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [90.434581] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [90.434674] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [90.434676] xe 0000:03:00.0: colorspace: RGB
<7> [90.434677] xe 0000:03:00.0: scan mode: Underscan
<7> [90.434679] xe 0000:03:00.0: colorimetry: No Data
<7> [90.434680] xe 0000:03:00.0: picture aspect: 16:9
<7> [90.434682] xe 0000:03:00.0: active aspect: Same as Picture
<7> [90.434683] xe 0000:03:00.0: itc: No Data
<7> [90.434684] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [90.434686] xe 0000:03:00.0: quantization range: Limited
<7> [90.434687] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [90.434689] xe 0000:03:00.0: video code: 16
<7> [90.434690] xe 0000:03:00.0: ycc quantization range: Limited
<7> [90.434691] xe 0000:03:00.0: hdmi content type: Graphics
<7> [90.434693] xe 0000:03:00.0: pixel repeat: 0
<7> [90.434694] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [90.434696] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in spd infoframe
<7> [90.434790] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [90.434883] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [90.434974] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [90.434976] xe 0000:03:00.0: vendor: Intel
<7> [90.434977] xe 0000:03:00.0: product: Discrete gfx
<7> [90.434979] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [90.434981] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe C] fastset requirement not met in hdmi infoframe
<7> [90.435072] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [90.435162] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [90.435251] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [90.435253] xe 0000:03:00.0: empty frame
<7> [90.435254] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:269:pipe C] fastset requirement not met, forcing full modeset
<7> [90.435356] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.enable (expected yes, found no)
<7> [90.435447] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.active (expected yes, found no)
<7> [90.435537] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in cpu_transcoder (expected 3, found -1)
<7> [90.435628] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in lane_count (expected 4, found 0)
<7> [90.435717] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [90.435806] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [90.435896] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [90.435986] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [90.436075] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [90.436163] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [90.436252] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [90.436353] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [90.436443] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [90.436532] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [90.436621] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [90.436710] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [90.436799] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [90.436888] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [90.436980] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [90.437069] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [90.437159] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [90.437249] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [90.437350] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [90.437442] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [90.437532] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [90.437622] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [90.437712] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [90.437803] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [90.437892] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [90.437981] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [90.438070] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [90.438158] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [90.438248] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [90.438352] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [90.438442] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [90.438531] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [90.438620] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [90.438710] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [90.438799] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in port_clock (expected 222750, found 0)
<7> [90.438888] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [90.438977] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [90.439066] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in avi infoframe
<7> [90.439155] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [90.439246] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [90.439247] xe 0000:03:00.0: colorspace: RGB
<7> [90.439249] xe 0000:03:00.0: scan mode: Underscan
<7> [90.439250] xe 0000:03:00.0: colorimetry: No Data
<7> [90.439251] xe 0000:03:00.0: picture aspect: 16:9
<7> [90.439253] xe 0000:03:00.0: active aspect: Same as Picture
<7> [90.439254] xe 0000:03:00.0: itc: No Data
<7> [90.439255] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [90.439257] xe 0000:03:00.0: quantization range: Limited
<7> [90.439258] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [90.439259] xe 0000:03:00.0: video code: 16
<7> [90.439261] xe 0000:03:00.0: ycc quantization range: Limited
<7> [90.439267] xe 0000:03:00.0: hdmi content type: Graphics
<7> [90.439269] xe 0000:03:00.0: pixel repeat: 0
<7> [90.439270] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [90.439272] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [90.439362] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in spd infoframe
<7> [90.439452] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [90.439541] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [90.439542] xe 0000:03:00.0: vendor: Intel
<7> [90.439544] xe 0000:03:00.0: product: Discrete gfx
<7> [90.439545] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [90.439547] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [90.439636] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:505:pipe D] fastset requirement not met in hdmi infoframe
<7> [90.439724] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [90.439814] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [90.439815] xe 0000:03:00.0: empty frame
<7> [90.439817] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [90.439907] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:505:pipe D] fastset requirement not met, forcing full modeset
<7> [90.439998] xe 0000:03:00.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:505:pipe D] releasing TC PLL 3
<7> [90.440121] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x3 -> 0xf (total dbuf slices 0xf), mbus joined? no->no
<7> [90.440203] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:151:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x8 -> 0x5
<7> [90.440287] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:269:pipe C] dbuf slices 0x0 -> 0xc, ddb (0 - 0) -> (0 - 2048), active pipes 0x8 -> 0x5
<7> [90.440363] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:505:pipe D] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x8 -> 0x5
<7> [90.440440] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:35:plane 1A] ddb ( 0 - 0) -> ( 0 - 1989), size 0 -> 1989
<7> [90.440511] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:145:cursor A] ddb ( 0 - 0) -> (1989 - 2048), size 0 -> 59
<7> [90.440580] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35: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> [90.440648] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 3, 9, 9, 17, 17, 17, 17, 0, 15, 0
<7> [90.440716] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 49, 145, 145, 273, 273, 273, 273, 30, 241, 255
<7> [90.440784] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 55, 161, 161, 302, 302, 0, 0, 31, 267, 267
<7> [90.440853] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:153:plane 1C] ddb ( 0 - 0) -> ( 0 - 1989), size 0 -> 1989
<7> [90.440920] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:263:cursor C] ddb ( 0 - 0) -> (1989 - 2048), size 0 -> 59
<7> [90.440987] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153: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> [90.441054] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1C] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 3, 9, 9, 17, 17, 17, 17, 0, 15, 0
<7> [90.441122] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1C] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 49, 145, 145, 273, 273, 273, 273, 30, 241, 255
<7> [90.441188] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1C] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 55, 161, 161, 302, 302, 0, 0, 31, 267, 267
<7> [90.441254] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:499:cursor D] ddb (1989 - 2048) -> ( 0 - 0), size 59 -> 0
<7> [90.441350] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:151:pipe A] data rate 594000 num active planes 1
<7> [90.441454] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:269:pipe C] data rate 594000 num active planes 1
<7> [90.441556] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 1248 qgv_peak_bw: 48000
<7> [90.441653] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 1248 qgv_peak_bw: 48000
<7> [90.441748] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 1248
<7> [90.441854] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:151:pipe A] min cdclk: 0 kHz -> 192000 kHz
<7> [90.441954] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:269:pipe C] min cdclk: 0 kHz -> 192000 kHz
<7> [90.442048] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:505:pipe D] min cdclk: 192000 kHz -> 0 kHz
<7> [90.442156] xe 0000:03:00.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 9282 kHz -> 18563 kHz
<7> [90.442272] xe 0000:03:00.0: [drm:intel_find_dpll [xe]] [CRTC:151:pipe A] allocated TC PLL 2
<7> [90.442367] xe 0000:03:00.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:151:pipe A] reserving TC PLL 2
<7> [90.442462] xe 0000:03:00.0: [drm:intel_find_dpll [xe]] [CRTC:269:pipe C] allocated TC PLL 3
<7> [90.442550] xe 0000:03:00.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:269:pipe C] reserving TC PLL 3
<7> [90.442643] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:151:pipe A] enable: yes [modeset]
<7> [90.442747] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: DP (0x80), output format: RGB, sink format: RGB
<7> [90.442847] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: A, pipe bpp: 36, dithering: 0
<7> [90.442944] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [90.443040] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [90.443134] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [90.443227] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [90.443330] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 5190451, data_n: 8388608, link_m: 288358, link_n: 524288, tu: 64
<7> [90.443425] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [90.443518] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: enabled
<7> [90.443609] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [90.443700] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] psr: disabled, selective update: disabled, panel replay: disabled, selective fetch: disabled
<7> [90.443791] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] minimum hblank: 0
<7> [90.443882] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] audio: 1, infoframes: 0, infoframes enabled: 0x0
<7> [90.443974] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 10 00 09 00 68 36 00 01 00 00 00 00 00 00 00 00
<7> [90.444067] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 61 a4 9a 00 44 50 46 39 30 34 33 35 09 07 07 11
<7> [90.444159] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 17 50 51 07 00 00 00 00
<7> [90.444249] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [90.444353] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [90.444448] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 0, guardband: 42 vsync start: 41, vsync end: 36
<7> [90.444545] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1083, vmax vblank: 1083, vmin vtotal: 1125, vmax vtotal: 1125
<7> [90.444640] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [90.444733] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [90.444826] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [90.444918] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [90.445011] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [90.445103] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [90.445196] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port clock: 270000, pixel rate 148500, min cdclk 192000, min voltage level 0
<7> [90.445292] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] linetime: 119, ips linetime: 0
<7> [90.445384] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0, sharpness_strength: 0
<7> [90.445477] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe src: 1920x1080+0+0
<7> [90.445573] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [90.445666] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [90.445758] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [90.445849] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [90.445941] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] c20pll_hw_state:
<7> [90.446033] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] tx[0] = 0xbe88, tx[1] = 0x4800, tx[2] = 0x0000
<7> [90.446124] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [90.446218] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[0] = 0x308c
<7> [90.446317] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[1] = 0x2110
<7> [90.446409] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[2] = 0xcc9c
<7> [90.446499] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[3] = 0xbfc1
<7> [90.446589] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[4] = 0x4b9a
<7> [90.446679] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[5] = 0x3f81
<7> [90.446770] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[6] = 0x2000
<7> [90.446860] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[7] = 0x0001
<7> [90.446950] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[8] = 0x5000
<7> [90.447040] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[9] = 0x0000
<7> [90.447129] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[10] = 0x0000
<7> [90.447219] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vdr: custom width: 0x00, serdes rate: 0x42, hdmi rate: 0x00
<7> [90.447319] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x40000000 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [90.447410] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [90.447499] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [90.447590] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0db0 0x0000 0x0000
<7> [90.447679] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0db0 0x0000
<7> [90.447768] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0db0
<7> [90.447857] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0100 0x0100 0x0100
<7> [90.447947] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [90.448036] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [90.448126] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [90.448216] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [90.448315] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [90.448406] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:35:plane 1A] fb: [FB:555] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [90.448498] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [90.448591] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [90.448681] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:65:plane 2A] fb: [NOFB], visible: no
<7> [90.448771] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:95:plane 3A] fb: [NOFB], visible: no
<7> [90.448863] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:125:plane 4A] fb: [NOFB], visible: no
<7> [90.448952] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:135:plane 5A] fb: [NOFB], visible: no
<7> [90.449041] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:145:cursor A] fb: [NOFB], visible: no
<7> [90.449130] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:269:pipe C] enable: yes [modeset]
<7> [90.449220] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [90.449317] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: C, pipe bpp: 36, dithering: 0
<7> [90.449407] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [90.449498] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [90.449582] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [90.449663] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [90.449745] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [90.449826] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] GCP: 0x6
<7> [90.449908] xe 0000:03:00.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [90.449910] xe 0000:03:00.0: colorspace: RGB
<7> [90.449911] xe 0000:03:00.0: scan mode: Underscan
<7> [90.449913] xe 0000:03:00.0: colorimetry: No Data
<7> [90.449914] xe 0000:03:00.0: picture aspect: 16:9
<7> [90.449915] xe 0000:03:00.0: active aspect: Same as Picture
<7> [90.449916] xe 0000:03:00.0: itc: No Data
<7> [90.449917] xe 0000:03:00.0: extended colorimetry: xvYCC 601
<7> [90.449919] xe 0000:03:00.0: quantization range: Limited
<7> [90.449920] xe 0000:03:00.0: nups: Unknown Non-uniform Scaling
<7> [90.449921] xe 0000:03:00.0: video code: 16
<7> [90.449922] xe 0000:03:00.0: ycc quantization range: Limited
<7> [90.449924] xe 0000:03:00.0: hdmi content type: Graphics
<7> [90.449925] xe 0000:03:00.0: pixel repeat: 0
<7> [90.449926] xe 0000:03:00.0: bar top 0, bottom 0, left 0, right 0
<7> [90.449928] xe 0000:03:00.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [90.449929] xe 0000:03:00.0: vendor: Intel
<7> [90.449930] xe 0000:03:00.0: product: Discrete gfx
<7> [90.449932] xe 0000:03:00.0: source device information: PC General (0x9)
<7> [90.449933] xe 0000:03:00.0: HDMI infoframe: Vendor, version 1, length 4
<7> [90.449934] xe 0000:03:00.0: empty frame
<7> [90.449936] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 10 00 08 00 65 32 00 01 00 00 00 00 00 00 00 00
<7> [90.450018] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 61 a4 9a 00 4d 69 20 54 56 09 07 07 11 17 50 51
<7> [90.450100] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 07 00 00 00
<7> [90.450182] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [90.450268] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [90.450359] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 0, guardband: 45 vsync start: 41, vsync end: 36
<7> [90.450444] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1080, vmax vblank: 1080, vmin vtotal: 1125, vmax vtotal: 1125
<7> [90.450527] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [90.450610] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [90.450695] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [90.450778] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [90.450861] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [90.450943] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [90.451027] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port clock: 222750, pixel rate 148500, min cdclk 192000, min voltage level 0
<7> [90.451109] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] linetime: 119, ips linetime: 0
<7> [90.451191] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0, sharpness_strength: 0
<7> [90.451277] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe src: 1920x1080+0+0
<7> [90.451367] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [90.451449] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [90.451531] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [90.451616] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [90.451699] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] c20pll_hw_state:
<7> [90.451781] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] tx[0] = 0xbe88, tx[1] = 0x5800, tx[2] = 0x0000
<7> [90.451863] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [90.451946] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[0] = 0x40e8
<7> [90.452029] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[1] = 0x7d20
<7> [90.452112] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[2] = 0x0a06
<7> [90.452195] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[3] = 0x8f1c
<7> [90.452286] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[4] = 0x0000
<7> [90.452375] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[5] = 0x0000
<7> [90.452458] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[6] = 0x2200
<7> [90.452541] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[7] = 0xffff
<7> [90.452624] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[8] = 0x0400
<7> [90.452707] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[9] = 0x0000
<7> [90.452789] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[10] = 0x0001
<7> [90.452871] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vdr: custom width: 0x00, serdes rate: 0x00, hdmi rate: 0x00
<7> [90.452953] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x40000000 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [90.453037] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [90.453120] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [90.453202] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0db0 0x0000 0x0000
<7> [90.453291] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0db0 0x0000
<7> [90.453386] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0db0
<7> [90.453471] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0100 0x0100 0x0100
<7> [90.453555] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [90.453639] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [90.453720] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [90.453803] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [90.453885] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [90.453967] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:153:plane 1C] fb: [FB:555] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [90.454050] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [90.454133] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [90.454217] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:183:plane 2C] fb: [NOFB], visible: no
<7> [90.454310] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:213:plane 3C] fb: [NOFB], visible: no
<7> [90.454398] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:243:plane 4C] fb: [NOFB], visible: no
<7> [90.454479] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:253:plane 5C] fb: [NOFB], visible: no
<7> [90.454560] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:263:cursor C] fb: [NOFB], visible: no
<7> [90.454642] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:505:pipe D] enable: no [modeset]
<7> [90.454725] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:389:plane 1D] fb: [NOFB], visible: no
<7> [90.454808] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:419:plane 2D] fb: [NOFB], visible: no
<7> [90.454890] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:449:plane 3D] fb: [NOFB], visible: no
<7> [90.454972] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:479:plane 4D] fb: [NOFB], visible: no
<7> [90.455054] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:489:plane 5D] fb: [NOFB], visible: no
<7> [90.455137] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:499:cursor D] fb: [NOFB], visible: no
<7> [90.455995] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_A
<7> [90.456122] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x1 (CLKGATE_DIS_DSSDSC=0x28000000)
<7> [90.456218] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_C
<7> [90.456542] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x4 (CLKGATE_DIS_DSSDSC=0x08000000)
<7> [90.456636] xe 0000:03:00.0: [drm:intel_audio_codec_disable [xe]] [CONNECTOR:539:HDMI-A-3][ENCODER:538:DDI TC3/PHY H] Disable audio codec on [CRTC:505:pipe D]
<7> [90.488581] xe 0000:03:00.0: [drm:intel_audio_component_get_eld [xe]] Not valid for port F
<7> [90.488942] xe 0000:03:00.0: [drm:intel_disable_transcoder [xe]] disabling pipe D
<7> [90.506487] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disable TC PLL 3 (active 0x8, on? 1) for [CRTC:505:pipe D]
<7> [90.508129] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disabling TC PLL 3
<7> [90.508892] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:507:DDI TC1/PHY F]
<7> [90.508977] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST A]
<7> [90.509056] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST B]
<7> [90.509133] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:511:DP-MST C]
<7> [90.509207] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:512:DP-MST D]
<7> [90.509303] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:526:DDI TC2/PHY G]
<7> [90.509440] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST A]
<7> [90.509559] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST B]
<7> [90.509676] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:530:DP-MST C]
<7> [90.509792] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:531:DP-MST D]
<7> [90.509905] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:538:DDI TC3/PHY H]
<7> [90.510019] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:542:DDI TC4/PHY I]
<7> [90.510156] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST A]
<7> [90.510284] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST B]
<7> [90.510373] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:546:DP-MST C]
<7> [90.510448] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:547:DP-MST D]
<7> [90.510764] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [90.510920] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [90.511222] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enable TC PLL 2 (active 0x1, on? 0) for [CRTC:151:pipe A]
<7> [90.511339] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enabling TC PLL 2
<7> [90.513501] xe 0000:03:00.0: [drm:intel_audio_component_get_power [xe]] restored AUD_FREQ_CNTRL to 0x8010
<7> [90.513662] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC2
<7> [90.517811] xe 0000:03:00.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC2/DDI TC2/PHY G: DPCD: 12 14 c4 01 01 15 01 81 00 01 04 01 0f 00 01
<7> [90.522374] xe 0000:03:00.0: [drm:intel_dp_init_lttpr_and_dprx_caps [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] LTTPR common capabilities: 00 00 00 00 00 00 00 00
<7> [90.523278] xe 0000:03:00.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC2/DDI TC2/PHY G: DPCD: 12 14 c4 01 01 15 01 81 00 01 04 01 0f 00 01
<7> [90.523723] xe 0000:03:00.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Using LINK_BW_SET value 0a
<7> [90.525183] xe 0000:03:00.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [90.525755] xe 0000:03:00.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Using DP training pattern TPS1
<7> [90.532133] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Clock recovery OK
<7> [90.532331] xe 0000:03:00.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Using DP training pattern TPS3
<7> [90.539157] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Channel EQ done. DP Training successful
<7> [90.539539] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Link Training passed at link rate = 270000, lane count = 4
<7> [90.540882] xe 0000:03:00.0: [drm:intel_enable_transcoder [xe]] enabling pipe A
<7> [90.558421] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enable TC PLL 3 (active 0x4, on? 0) for [CRTC:269:pipe C]
<7> [90.558802] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enabling TC PLL 3
<7> [90.561577] xe 0000:03:00.0: [drm:intel_enable_transcoder [xe]] enabling pipe C
<7> [90.597308] xe 0000:03:00.0: [drm:intel_audio_codec_enable [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G] Enable audio codec on [CRTC:151:pipe A], 40 bytes ELD
<7> [90.608840] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:527:DP-2]
<7> [90.609767] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:151:pipe A]
<7> [90.611487] xe 0000:03:00.0: [drm:intel_audio_component_get_power [xe]] restored AUD_FREQ_CNTRL to 0x8010
<7> [90.614941] xe 0000:03:00.0: [drm:intel_audio_codec_enable [xe]] [CONNECTOR:539:HDMI-A-3][ENCODER:538:DDI TC3/PHY H] Enable audio codec on [CRTC:269:pipe C], 36 bytes ELD
<7> [90.630446] xe 0000:03:00.0: [drm:audio_config_hdmi_pixel_clock [xe]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [90.631132] xe 0000:03:00.0: [drm:hsw_audio_config_update [xe]] using automatic N
<7> [90.632229] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:539:HDMI-A-3]
<7> [90.633008] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:269:pipe C]
<7> [90.637968] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling PW_D
<7> [90.638770] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating disabled for pipe_mask=0x8 (CLKGATE_DIS_DSSDSC=0x88000000)
<7> [90.639586] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:505:pipe D]
<7> [90.640415] xe 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0
<6> [90.641572] [IGT] kms_flip: exiting, ret=98
<7> [90.644297] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC2
Created at 2026-05-22 16:06:54