Results for igt@kms_flip@2x-flip-vs-expired-vblank-interruptible@ab-hdmi-a1-hdmi-a2

Result: Fail

git-log-oneline i915_display_info22 igt_runner22 runtimes22 results22.json results22-i915-load.json guc_logs22.tar boot22 dmesg22

DetailValue
Duration 9.53 seconds
Hostname 
shard-glk1
Igt-Version 
IGT-Version: 2.4-g63a08403d (x86_64) (Linux: 7.0.0-CI_DRM_18335-g45975e225ecb+ x86_64)
Out 
Using IGT_SRANDOM=1776304121 for randomisation
Opened device: /dev/dri/card0
Using monotonic timestamps
Starting subtest: 2x-flip-vs-expired-vblank-interruptible
Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
  1920x1080: 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9 
  1920x1080: 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9 
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../tests/kms_flip.c:926 run_test_on_crtc_set()
  #2 ../tests/kms_flip.c:2029 run_pair()
  #3 ../tests/kms_flip.c:2227 __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 AB-HDMI-A1-HDMI-A2: FAIL (9.533s)
Err 
Starting subtest: 2x-flip-vs-expired-vblank-interruptible
Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
(kms_flip:2666) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:931:
(kms_flip:2666) CRITICAL: Failed assertion: end - start < 500
(kms_flip:2666) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest AB-HDMI-A1-HDMI-A2 failed.
**** DEBUG ****
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.090515
last_received_ts = 391.090393
last_seq = 16291
current_ts = 391.107208
current_received_ts = 391.107117
current_seq = 16292
count = 394
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 21us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.107208
last_received_ts = 391.107117
last_seq = 16292
current_ts = 391.123871
current_received_ts = 391.123474
current_seq = 16293
count = 395
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.123871
last_received_ts = 391.123474
last_seq = 16293
current_ts = 391.140533
current_received_ts = 391.140350
current_seq = 16294
count = 396
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.140533
last_received_ts = 391.140350
last_seq = 16294
current_ts = 391.157196
current_received_ts = 391.156982
current_seq = 16295
count = 397
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.157196
last_received_ts = 391.156982
last_seq = 16295
current_ts = 391.173859
current_received_ts = 391.173401
current_seq = 16296
count = 398
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.173859
last_received_ts = 391.173401
last_seq = 16296
current_ts = 391.190521
current_received_ts = 391.190277
current_seq = 16297
count = 399
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.190521
last_received_ts = 391.190277
last_seq = 16297
current_ts = 391.207214
current_received_ts = 391.206757
current_seq = 16298
count = 400
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.207214
last_received_ts = 391.206757
last_seq = 16298
current_ts = 391.223846
current_received_ts = 391.223419
current_seq = 16299
count = 401
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.223846
last_received_ts = 391.223419
last_seq = 16299
current_ts = 391.240540
current_received_ts = 391.240326
current_seq = 16300
count = 402
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.240540
last_received_ts = 391.240326
last_seq = 16300
current_ts = 391.257202
current_received_ts = 391.256653
current_seq = 16301
count = 403
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.257202
last_received_ts = 391.256653
last_seq = 16301
current_ts = 391.273865
current_received_ts = 391.273468
current_seq = 16302
count = 404
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 22us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.273865
last_received_ts = 391.273468
last_seq = 16302
current_ts = 391.290527
current_received_ts = 391.290771
current_seq = 16303
count = 405
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 21us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.290527
last_received_ts = 391.290771
last_seq = 16303
current_ts = 391.307190
current_received_ts = 391.307068
current_seq = 16304
count = 406
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.307190
last_received_ts = 391.307068
last_seq = 16304
current_ts = 391.323853
current_received_ts = 391.323761
current_seq = 16305
count = 407
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.323853
last_received_ts = 391.323761
last_seq = 16305
current_ts = 391.340546
current_received_ts = 391.340698
current_seq = 16306
count = 408
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 21us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.340546
last_received_ts = 391.340698
last_seq = 16306
current_ts = 391.357178
current_received_ts = 391.356689
current_seq = 16307
count = 409
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.357178
last_received_ts = 391.356689
last_seq = 16307
current_ts = 391.373871
current_received_ts = 391.373596
current_seq = 16308
count = 410
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.373871
last_received_ts = 391.373596
last_seq = 16308
current_ts = 391.390533
current_received_ts = 391.390320
current_seq = 16309
count = 411
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.390533
last_received_ts = 391.390320
last_seq = 16309
current_ts = 391.407196
current_received_ts = 391.406982
current_seq = 16310
count = 412
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.407196
last_received_ts = 391.406982
last_seq = 16310
current_ts = 391.423859
current_received_ts = 391.423462
current_seq = 16311
count = 413
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.423859
last_received_ts = 391.423462
last_seq = 16311
current_ts = 391.440521
current_received_ts = 391.440704
current_seq = 16312
count = 414
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 21us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.440521
last_received_ts = 391.440704
last_seq = 16312
current_ts = 391.457214
current_received_ts = 391.456696
current_seq = 16313
count = 415
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.457214
last_received_ts = 391.456696
last_seq = 16313
current_ts = 391.473877
current_received_ts = 391.473907
current_seq = 16314
count = 416
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.473877
last_received_ts = 391.473907
last_seq = 16314
current_ts = 391.490540
current_received_ts = 391.490845
current_seq = 16315
count = 417
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 22us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.490540
last_received_ts = 391.490845
last_seq = 16315
current_ts = 391.507202
current_received_ts = 391.507141
current_seq = 16316
count = 418
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.507202
last_received_ts = 391.507141
last_seq = 16316
current_ts = 391.523865
current_received_ts = 391.523407
current_seq = 16317
count = 419
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.523865
last_received_ts = 391.523407
last_seq = 16317
current_ts = 391.540527
current_received_ts = 391.540314
current_seq = 16318
count = 420
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.540527
last_received_ts = 391.540314
last_seq = 16318
current_ts = 391.557190
current_received_ts = 391.556976
current_seq = 16319
count = 421
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.557190
last_received_ts = 391.556976
last_seq = 16319
current_ts = 391.573853
current_received_ts = 391.573456
current_seq = 16320
count = 422
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.573853
last_received_ts = 391.573456
last_seq = 16320
current_ts = 391.590546
current_received_ts = 391.590393
current_seq = 16321
count = 423
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.590546
last_received_ts = 391.590393
last_seq = 16321
current_ts = 391.607208
current_received_ts = 391.607056
current_seq = 16322
count = 424
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 17us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.607208
last_received_ts = 391.607056
last_seq = 16322
current_ts = 391.623871
current_received_ts = 391.623779
current_seq = 16323
count = 425
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.623871
last_received_ts = 391.623779
last_seq = 16323
current_ts = 391.640533
current_received_ts = 391.640625
current_seq = 16324
count = 426
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.640533
last_received_ts = 391.640625
last_seq = 16324
current_ts = 391.657196
current_received_ts = 391.656799
current_seq = 16325
count = 427
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.657196
last_received_ts = 391.656799
last_seq = 16325
current_ts = 391.673889
current_received_ts = 391.673584
current_seq = 16326
count = 428
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.673889
last_received_ts = 391.673584
last_seq = 16326
current_ts = 391.690552
current_received_ts = 391.690369
current_seq = 16327
count = 429
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 42us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.690552
last_received_ts = 391.690369
last_seq = 16327
current_ts = 391.707214
current_received_ts = 391.706970
current_seq = 16328
count = 430
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.707214
last_received_ts = 391.706970
last_seq = 16328
current_ts = 391.723877
current_received_ts = 391.723450
current_seq = 16329
count = 431
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 17us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.723877
last_received_ts = 391.723450
last_seq = 16329
current_ts = 391.740540
current_received_ts = 391.740570
current_seq = 16330
count = 432
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.740540
last_received_ts = 391.740570
last_seq = 16330
current_ts = 391.757202
current_received_ts = 391.757263
current_seq = 16331
count = 433
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.757202
last_received_ts = 391.757263
last_seq = 16331
current_ts = 391.773865
current_received_ts = 391.773438
current_seq = 16332
count = 434
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.773865
last_received_ts = 391.773438
last_seq = 16332
current_ts = 391.790527
current_received_ts = 391.790344
current_seq = 16333
count = 435
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.790527
last_received_ts = 391.790344
last_seq = 16333
current_ts = 391.807220
current_received_ts = 391.807068
current_seq = 16334
count = 436
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.807220
last_received_ts = 391.807068
last_seq = 16334
current_ts = 391.823883
current_received_ts = 391.823883
current_seq = 16335
count = 437
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.823883
last_received_ts = 391.823883
last_seq = 16335
current_ts = 391.840546
current_received_ts = 391.840363
current_seq = 16336
count = 438
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.840546
last_received_ts = 391.840363
last_seq = 16336
current_ts = 391.857208
current_received_ts = 391.857178
current_seq = 16337
count = 439
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.857208
last_received_ts = 391.857178
last_seq = 16337
current_ts = 391.873871
current_received_ts = 391.873444
current_seq = 16338
count = 440
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.873871
last_received_ts = 391.873444
last_seq = 16338
current_ts = 391.890564
current_received_ts = 391.890350
current_seq = 16339
count = 441
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 21us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.890564
last_received_ts = 391.890350
last_seq = 16339
current_ts = 391.907227
current_received_ts = 391.906708
current_seq = 16340
count = 442
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 22us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.907227
last_received_ts = 391.906708
last_seq = 16340
current_ts = 391.923889
current_received_ts = 391.923828
current_seq = 16341
count = 443
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.923889
last_received_ts = 391.923828
last_seq = 16341
current_ts = 391.940552
current_received_ts = 391.940491
current_seq = 16342
count = 444
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.940552
last_received_ts = 391.940491
last_seq = 16342
current_ts = 391.957214
current_received_ts = 391.957123
current_seq = 16343
count = 445
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 22us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.957214
last_received_ts = 391.957123
last_seq = 16343
current_ts = 391.973877
current_received_ts = 391.973419
current_seq = 16344
count = 446
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.973877
last_received_ts = 391.973419
last_seq = 16344
current_ts = 391.990570
current_received_ts = 391.990326
current_seq = 16345
count = 447
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 391.990570
last_received_ts = 391.990326
last_seq = 16345
current_ts = 392.007233
current_received_ts = 392.007080
current_seq = 16346
count = 448
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.007233
last_received_ts = 392.007080
last_seq = 16346
current_ts = 392.023895
current_received_ts = 392.023499
current_seq = 16347
count = 449
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.023895
last_received_ts = 392.023499
last_seq = 16347
current_ts = 392.040558
current_received_ts = 392.040314
current_seq = 16348
count = 450
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.040558
last_received_ts = 392.040314
last_seq = 16348
current_ts = 392.057220
current_received_ts = 392.056976
current_seq = 16349
count = 451
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.057220
last_received_ts = 392.056976
last_seq = 16349
current_ts = 392.073883
current_received_ts = 392.073761
current_seq = 16350
count = 452
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.073883
last_received_ts = 392.073761
last_seq = 16350
current_ts = 392.090546
current_received_ts = 392.090668
current_seq = 16351
count = 453
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.090546
last_received_ts = 392.090668
last_seq = 16351
current_ts = 392.107239
current_received_ts = 392.107513
current_seq = 16352
count = 454
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.107239
last_received_ts = 392.107513
last_seq = 16352
current_ts = 392.123871
current_received_ts = 392.123413
current_seq = 16353
count = 455
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.123871
last_received_ts = 392.123413
last_seq = 16353
current_ts = 392.140564
current_received_ts = 392.140411
current_seq = 16354
count = 456
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 21us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.140564
last_received_ts = 392.140411
last_seq = 16354
current_ts = 392.157227
current_received_ts = 392.157074
current_seq = 16355
count = 457
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 21us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.157227
last_received_ts = 392.157074
last_seq = 16355
current_ts = 392.173889
current_received_ts = 392.173462
current_seq = 16356
count = 458
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.173889
last_received_ts = 392.173462
last_seq = 16356
current_ts = 392.190552
current_received_ts = 392.190674
current_seq = 16357
count = 459
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.190552
last_received_ts = 392.190674
last_seq = 16357
current_ts = 392.207214
current_received_ts = 392.206726
current_seq = 16358
count = 460
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.207214
last_received_ts = 392.206726
last_seq = 16358
current_ts = 392.223907
current_received_ts = 392.223358
current_seq = 16359
count = 461
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 32us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.223907
last_received_ts = 392.223358
last_seq = 16359
current_ts = 392.240570
current_received_ts = 392.240479
current_seq = 16360
count = 462
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 32us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.240570
last_received_ts = 392.240479
last_seq = 16360
current_ts = 392.257233
current_received_ts = 392.257080
current_seq = 16361
count = 463
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.257233
last_received_ts = 392.257080
last_seq = 16361
current_ts = 392.273895
current_received_ts = 392.273743
current_seq = 16362
count = 464
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.273895
last_received_ts = 392.273743
last_seq = 16362
current_ts = 392.290558
current_received_ts = 392.290405
current_seq = 16363
count = 465
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.290558
last_received_ts = 392.290405
last_seq = 16363
current_ts = 392.307220
current_received_ts = 392.307526
current_seq = 16364
count = 466
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.307220
last_received_ts = 392.307526
last_seq = 16364
current_ts = 392.323883
current_received_ts = 392.323486
current_seq = 16365
count = 467
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 17us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.323883
last_received_ts = 392.323486
last_seq = 16365
current_ts = 392.340576
current_received_ts = 392.340393
current_seq = 16366
count = 468
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 21us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.340576
last_received_ts = 392.340393
last_seq = 16366
current_ts = 392.357239
current_received_ts = 392.357056
current_seq = 16367
count = 469
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 21us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.357239
last_received_ts = 392.357056
last_seq = 16367
current_ts = 392.373901
current_received_ts = 392.373352
current_seq = 16368
count = 470
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.373901
last_received_ts = 392.373352
last_seq = 16368
current_ts = 392.390564
current_received_ts = 392.390350
current_seq = 16369
count = 471
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.390564
last_received_ts = 392.390350
last_seq = 16369
current_ts = 392.407227
current_received_ts = 392.407166
current_seq = 16370
count = 472
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.407227
last_received_ts = 392.407166
last_seq = 16370
current_ts = 392.423889
current_received_ts = 392.423431
current_seq = 16371
count = 473
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.423889
last_received_ts = 392.423431
last_seq = 16371
current_ts = 392.440552
current_received_ts = 392.440491
current_seq = 16372
count = 474
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.440552
last_received_ts = 392.440491
last_seq = 16372
current_ts = 392.457245
current_received_ts = 392.457153
current_seq = 16373
count = 475
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.457245
last_received_ts = 392.457153
last_seq = 16373
current_ts = 392.473907
current_received_ts = 392.473450
current_seq = 16374
count = 476
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.473907
last_received_ts = 392.473450
last_seq = 16374
current_ts = 392.490570
current_received_ts = 392.490326
current_seq = 16375
count = 477
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.490570
last_received_ts = 392.490326
last_seq = 16375
current_ts = 392.507233
current_received_ts = 392.507019
current_seq = 16376
count = 478
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.507233
last_received_ts = 392.507019
last_seq = 16376
current_ts = 392.523895
current_received_ts = 392.523376
current_seq = 16377
count = 479
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.523895
last_received_ts = 392.523376
last_seq = 16377
current_ts = 392.540558
current_received_ts = 392.540894
current_seq = 16378
count = 480
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 22us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.540558
last_received_ts = 392.540894
last_seq = 16378
current_ts = 392.557251
current_received_ts = 392.557220
current_seq = 16379
count = 481
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.557251
last_received_ts = 392.557220
last_seq = 16379
current_ts = 392.573914
current_received_ts = 392.573486
current_seq = 16380
count = 482
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.573914
last_received_ts = 392.573486
last_seq = 16380
current_ts = 392.590576
current_received_ts = 392.590363
current_seq = 16381
count = 483
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 21us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.590576
last_received_ts = 392.590363
last_seq = 16381
current_ts = 392.607239
current_received_ts = 392.606750
current_seq = 16382
count = 484
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.607239
last_received_ts = 392.606750
last_seq = 16382
current_ts = 392.623901
current_received_ts = 392.623474
current_seq = 16383
count = 485
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 22us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.623901
last_received_ts = 392.623474
last_seq = 16383
current_ts = 392.640564
current_received_ts = 392.640411
current_seq = 16384
count = 486
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.640564
last_received_ts = 392.640411
last_seq = 16384
current_ts = 392.657227
current_received_ts = 392.657196
current_seq = 16385
count = 487
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 21us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.657227
last_received_ts = 392.657196
last_seq = 16385
current_ts = 392.673889
current_received_ts = 392.673431
current_seq = 16386
count = 488
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.673889
last_received_ts = 392.673431
last_seq = 16386
current_ts = 392.690582
current_received_ts = 392.690430
current_seq = 16387
count = 489
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 22us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.690582
last_received_ts = 392.690430
last_seq = 16387
current_ts = 392.707245
current_received_ts = 392.707001
current_seq = 16388
count = 490
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.707245
last_received_ts = 392.707001
last_seq = 16388
current_ts = 392.723907
current_received_ts = 392.723480
current_seq = 16389
count = 491
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.723907
last_received_ts = 392.723480
last_seq = 16389
current_ts = 392.740570
current_received_ts = 392.740692
current_seq = 16390
count = 492
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.740570
last_received_ts = 392.740692
last_seq = 16390
current_ts = 392.757233
current_received_ts = 392.756744
current_seq = 16391
count = 493
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 22us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.757233
last_received_ts = 392.756744
last_seq = 16391
current_ts = 392.773895
current_received_ts = 392.773834
current_seq = 16392
count = 494
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.773895
last_received_ts = 392.773834
last_seq = 16392
current_ts = 392.790588
current_received_ts = 392.790405
current_seq = 16393
count = 495
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.790588
last_received_ts = 392.790405
last_seq = 16393
current_ts = 392.807251
current_received_ts = 392.807068
current_seq = 16394
count = 496
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.807251
last_received_ts = 392.807068
last_seq = 16394
current_ts = 392.823914
current_received_ts = 392.823456
current_seq = 16395
count = 497
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.823914
last_received_ts = 392.823456
last_seq = 16395
current_ts = 392.840576
current_received_ts = 392.840729
current_seq = 16396
count = 498
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 21us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.840576
last_received_ts = 392.840729
last_seq = 16396
current_ts = 392.857239
current_received_ts = 392.856720
current_seq = 16397
count = 499
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.857239
last_received_ts = 392.856720
last_seq = 16397
current_ts = 392.873901
current_received_ts = 392.873505
current_seq = 16398
count = 500
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.873901
last_received_ts = 392.873505
last_seq = 16398
current_ts = 392.890564
current_received_ts = 392.890442
current_seq = 16399
count = 501
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 22us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.890564
last_received_ts = 392.890442
last_seq = 16399
current_ts = 392.907257
current_received_ts = 392.907104
current_seq = 16400
count = 502
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.907257
last_received_ts = 392.907104
last_seq = 16400
current_ts = 392.923920
current_received_ts = 392.923737
current_seq = 16401
count = 503
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.923920
last_received_ts = 392.923737
last_seq = 16401
current_ts = 392.940582
current_received_ts = 392.940338
current_seq = 16402
count = 504
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.940582
last_received_ts = 392.940338
last_seq = 16402
current_ts = 392.957245
current_received_ts = 392.956726
current_seq = 16403
count = 505
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 23us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.957245
last_received_ts = 392.956726
last_seq = 16403
current_ts = 392.973907
current_received_ts = 392.973907
current_seq = 16404
count = 506
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.973907
last_received_ts = 392.973907
last_seq = 16404
current_ts = 392.990570
current_received_ts = 392.990356
current_seq = 16405
count = 507
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 392.990570
last_received_ts = 392.990356
last_seq = 16405
current_ts = 393.007233
current_received_ts = 393.006989
current_seq = 16406
count = 508
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 393.007233
last_received_ts = 393.006989
last_seq = 16406
current_ts = 393.023926
current_received_ts = 393.023773
current_seq = 16407
count = 509
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 393.023926
last_received_ts = 393.023773
last_seq = 16407
current_ts = 393.040588
current_received_ts = 393.040344
current_seq = 16408
count = 510
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 19us
(kms_flip:2666) DEBUG: name = flip
last_ts = 393.040588
last_received_ts = 393.040344
last_seq = 16408
current_ts = 393.057251
current_received_ts = 393.056732
current_seq = 16409
count = 511
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 18us
(kms_flip:2666) DEBUG: name = flip
last_ts = 393.057251
last_received_ts = 393.056732
last_seq = 16409
current_ts = 393.073914
current_received_ts = 393.073425
current_seq = 16410
count = 512
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 20us
(kms_flip:2666) DEBUG: name = flip
last_ts = 393.073914
last_received_ts = 393.073425
last_seq = 16410
current_ts = 393.090576
current_received_ts = 393.090393
current_seq = 16411
count = 513
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 21us
(kms_flip:2666) DEBUG: name = flip
last_ts = 393.090576
last_received_ts = 393.090393
last_seq = 16411
current_ts = 393.107269
current_received_ts = 393.106659
current_seq = 16412
count = 514
seq_step = 1
(kms_flip:2666) DEBUG: Vblank took 2123us
(kms_flip:2666) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:931:
(kms_flip:2666) CRITICAL: Failed assertion: end - start < 500
(kms_flip:2666) CRITICAL: Last errno: 4, Interrupted system call
(kms_flip:2666) igt_core-INFO: Stack trace:
(kms_flip:2666) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(kms_flip:2666) igt_core-INFO:   #1 ../tests/kms_flip.c:926 run_test_on_crtc_set()
(kms_flip:2666) igt_core-INFO:   #2 ../tests/kms_flip.c:2029 run_pair()
(kms_flip:2666) igt_core-INFO:   #3 ../tests/kms_flip.c:2227 __igt_unique____real_main2105()
(kms_flip:2666) igt_core-INFO:   #4 ../tests/kms_flip.c:2105 main()
(kms_flip:2666) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:2666) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:2666) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest AB-HDMI-A1-HDMI-A2: FAIL (9.533s)
Dmesg
<6> [383.295259] Console: switching to colour dummy device 80x25
<6> [383.296818] [IGT] kms_flip: executing
<7> [383.301508] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [383.303207] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [383.304051] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [383.318841] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:166:HDMI-A-1]
<7> [383.318879] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:166:HDMI-A-1]
<7> [383.345151] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:166:HDMI-A-1] HDMI: DVI dual 0, max TMDS clock 340000 kHz
<7> [383.345171] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:166:HDMI-A-1] HDMI sink does deep color 30.
<7> [383.345178] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:166:HDMI-A-1] HDMI sink does deep color 36.
<7> [383.345185] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:166:HDMI-A-1] Assigning HDMI sink color depth as 12 bpc.
<7> [383.345192] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:166:HDMI-A-1] HDMI sink does YCRCB444 in deep color.
<7> [383.345198] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:166:HDMI-A-1] HF-VSDB: max TMDS clock: 600000 KHz, HDMI 2.1 support: no, DSC 1.2 support: no
<7> [383.345207] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:166:HDMI-A-1] ELD monitor 28E850
<7> [383.345215] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:166:HDMI-A-1] HDMI: latency present 0 0, video latency 0 0, audio latency 0 0
<7> [383.345222] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:166:HDMI-A-1] ELD size 32, SAD count 1
<7> [383.345441] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0040 w(1)
<7> [383.347804] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK on first message, retry
<7> [383.348501] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpb] NAK for addr: 0040 w(1)
<7> [383.348960] i915 0000:00:02.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: (err -6)
<7> [383.350666] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:166:HDMI-A-1] probed modes:
<7> [383.350679] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [383.350688] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 60 594000 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [383.350696] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 60 593407 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [383.350703] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 50 594000 4096 5064 5152 5280 2160 2168 2178 2250 0x40 0x5
<7> [383.350710] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 24 297000 4096 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [383.350717] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 24 296703 4096 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [383.350725] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 60 594000 3840 4016 4104 4400 2160 2162 2172 2250 0x40 0x5
<7> [383.350732] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 60 594000 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [383.350739] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 60 593407 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [383.350746] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 50 594000 3840 4896 4984 5280 2160 2168 2178 2250 0x40 0x5
<7> [383.350752] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 30 297000 3840 3888 3920 4400 2160 2164 2170 2250 0x40 0x9
<7> [383.350759] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 30 297000 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [383.353104] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 30 296703 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [383.353120] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 25 297000 3840 4896 4984 5280 2160 2168 2178 2250 0x40 0x5
<7> [383.353127] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 24 297000 3840 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [383.353134] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 24 296703 3840 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [383.353142] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2880x1800": 60 336720 2880 2928 2960 3040 1800 1803 1809 1846 0x40 0x9
<7> [383.353149] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1600": 60 268500 2560 2608 2640 2720 1600 1603 1609 1646 0x40 0x9
<7> [383.353156] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1440": 60 241500 2560 2608 2640 2720 1440 1443 1449 1481 0x40 0x9
<7> [383.353163] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1200": 60 154000 1920 1968 2000 2080 1200 1203 1209 1235 0x40 0x9
<7> [383.353170] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 120 297000 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [383.353178] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 120 296703 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [383.353185] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 75 220597 1920 2056 2264 2608 1080 1081 1084 1128 0x0 0x6
<7> [383.353192] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080i": 60 74250 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x15
<7> [383.353199] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080i": 60 74176 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x15
<7> [383.353206] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 50 148500 1920 2448 2492 2640 1080 1084 1089 1125 0x40 0x5
<7> [383.353213] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080i": 50 74250 1920 2448 2492 2640 1080 1084 1094 1125 0x40 0x15
<7> [383.353220] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 24 74250 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x5
<7> [383.353227] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 24 74176 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x5
<7> [383.353234] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1680x1050": 60 119000 1680 1728 1760 1840 1050 1053 1059 1080 0x40 0x9
<7> [383.353242] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x900": 60 108000 1600 1624 1704 1800 900 901 904 1000 0x40 0x5
<7> [383.353249] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 75 135000 1280 1296 1440 1688 1024 1025 1028 1066 0x40 0x5
<7> [383.353256] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 61 110809 1280 1360 1496 1712 1024 1025 1028 1061 0x0 0x6
<7> [383.353263] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1440x900": 60 88750 1440 1488 1520 1600 900 903 909 926 0x40 0x9
<7> [383.353270] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x800": 60 71000 1280 1328 1360 1440 800 803 809 823 0x40 0x9
<7> [383.353277] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [383.353284] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [383.353291] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [383.353298] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 50 74250 1280 1720 1760 1980 720 725 730 750 0x40 0x5
<7> [383.353305] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 75 78750 1024 1040 1136 1312 768 769 772 800 0x40 0x5
<7> [383.353312] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 70 75000 1024 1048 1184 1328 768 771 777 806 0x40 0xa
<7> [383.353319] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [383.353326] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 75 49500 800 816 896 1056 600 601 604 625 0x40 0x5
<7> [383.353333] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 72 50000 800 856 976 1040 600 637 643 666 0x40 0x5
<7> [383.353340] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5
<7> [383.353347] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5
<7> [383.353354] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x576": 50 27000 720 732 796 864 576 581 586 625 0x40 0xa
<7> [383.353361] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x480": 60 27027 720 736 798 858 480 489 495 525 0x40 0xa
<7> [383.353368] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x480": 60 27000 720 736 798 858 480 489 495 525 0x40 0xa
<7> [383.353375] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 75 31500 640 656 720 840 480 481 484 500 0x40 0xa
<7> [383.353382] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 73 31500 640 664 704 832 480 489 492 520 0x40 0xa
<7> [383.353389] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25200 640 656 752 800 480 490 492 525 0x40 0xa
<7> [383.353396] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [383.353403] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [383.353637] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:176:HDMI-A-2]
<7> [383.353654] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:176:HDMI-A-2]
<7> [383.380819] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:176:HDMI-A-2] HDMI: DVI dual 0, max TMDS clock 340000 kHz
<7> [383.380838] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:176:HDMI-A-2] HDMI sink does deep color 30.
<7> [383.380845] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:176:HDMI-A-2] HDMI sink does deep color 36.
<7> [383.380851] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:176:HDMI-A-2] Assigning HDMI sink color depth as 12 bpc.
<7> [383.380858] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:176:HDMI-A-2] HDMI sink does YCRCB444 in deep color.
<7> [383.380864] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:176:HDMI-A-2] HF-VSDB: max TMDS clock: 600000 KHz, HDMI 2.1 support: no, DSC 1.2 support: no
<7> [383.380873] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:176:HDMI-A-2] ELD monitor 28E850
<7> [383.380881] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:176:HDMI-A-2] HDMI: latency present 0 0, video latency 0 0, audio latency 0 0
<7> [383.380889] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:176:HDMI-A-2] ELD size 32, SAD count 1
<7> [383.381107] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpc] NAK for addr: 0040 w(1)
<7> [383.381597] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpc] NAK on first message, retry
<7> [383.384362] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpc] NAK for addr: 0040 w(1)
<7> [383.384921] i915 0000:00:02.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: (err -6)
<7> [383.386915] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:176:HDMI-A-2] probed modes:
<7> [383.386929] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [383.386938] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 60 594000 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [383.386945] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 60 593407 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5
<7> [383.386953] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 50 594000 4096 5064 5152 5280 2160 2168 2178 2250 0x40 0x5
<7> [383.386960] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 24 297000 4096 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [383.386967] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4096x2160": 24 296703 4096 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [383.386975] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 60 594000 3840 4016 4104 4400 2160 2162 2172 2250 0x40 0x5
<7> [383.386982] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 60 594000 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [383.386989] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 60 593407 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [383.386996] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 50 594000 3840 4896 4984 5280 2160 2168 2178 2250 0x40 0x5
<7> [383.387003] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 30 297000 3840 3888 3920 4400 2160 2164 2170 2250 0x40 0x9
<7> [383.387009] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 30 297000 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [383.387016] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 30 296703 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5
<7> [383.387023] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 25 297000 3840 4896 4984 5280 2160 2168 2178 2250 0x40 0x5
<7> [383.387030] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 24 297000 3840 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [383.387037] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 24 296703 3840 5116 5204 5500 2160 2168 2178 2250 0x40 0x5
<7> [383.387044] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2880x1800": 60 336720 2880 2928 2960 3040 1800 1803 1809 1846 0x40 0x9
<7> [383.387050] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1600": 60 268500 2560 2608 2640 2720 1600 1603 1609 1646 0x40 0x9
<7> [383.387057] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1440": 60 241500 2560 2608 2640 2720 1440 1443 1449 1481 0x40 0x9
<7> [383.387064] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1200": 60 154000 1920 1968 2000 2080 1200 1203 1209 1235 0x40 0x9
<7> [383.387071] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 120 297000 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [383.387078] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 120 296703 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [383.387085] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 75 220597 1920 2056 2264 2608 1080 1081 1084 1128 0x0 0x6
<7> [383.387092] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080i": 60 74250 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x15
<7> [383.387099] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080i": 60 74176 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x15
<7> [383.387106] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 50 148500 1920 2448 2492 2640 1080 1084 1089 1125 0x40 0x5
<7> [383.387113] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080i": 50 74250 1920 2448 2492 2640 1080 1084 1094 1125 0x40 0x15
<7> [383.387120] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 24 74250 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x5
<7> [383.387127] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 24 74176 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x5
<7> [383.387133] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1680x1050": 60 119000 1680 1728 1760 1840 1050 1053 1059 1080 0x40 0x9
<7> [383.387140] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x900": 60 108000 1600 1624 1704 1800 900 901 904 1000 0x40 0x5
<7> [383.387147] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 75 135000 1280 1296 1440 1688 1024 1025 1028 1066 0x40 0x5
<7> [383.387154] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 61 110809 1280 1360 1496 1712 1024 1025 1028 1061 0x0 0x6
<7> [383.387161] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1440x900": 60 88750 1440 1488 1520 1600 900 903 909 926 0x40 0x9
<7> [383.387168] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x800": 60 71000 1280 1328 1360 1440 800 803 809 823 0x40 0x9
<7> [383.387175] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [383.387182] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [383.387189] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [383.387196] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 50 74250 1280 1720 1760 1980 720 725 730 750 0x40 0x5
<7> [383.387202] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 75 78750 1024 1040 1136 1312 768 769 772 800 0x40 0x5
<7> [383.387209] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 70 75000 1024 1048 1184 1328 768 771 777 806 0x40 0xa
<7> [383.387216] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [383.387223] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 75 49500 800 816 896 1056 600 601 604 625 0x40 0x5
<7> [383.387230] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 72 50000 800 856 976 1040 600 637 643 666 0x40 0x5
<7> [383.387237] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5
<7> [383.387244] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5
<7> [383.387251] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x576": 50 27000 720 732 796 864 576 581 586 625 0x40 0xa
<7> [383.387257] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x480": 60 27027 720 736 798 858 480 489 495 525 0x40 0xa
<7> [383.387264] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x480": 60 27000 720 736 798 858 480 489 495 525 0x40 0xa
<7> [383.387271] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 75 31500 640 656 720 840 480 481 484 500 0x40 0xa
<7> [383.387278] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 73 31500 640 664 704 832 480 489 492 520 0x40 0xa
<7> [383.387285] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25200 640 656 752 800 480 490 492 525 0x40 0xa
<7> [383.387292] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [383.387298] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<6> [383.406334] [IGT] kms_flip: starting subtest 2x-flip-vs-expired-vblank-interruptible
<6> [383.415242] [IGT] kms_flip: starting dynamic subtest AB-HDMI-A1-HDMI-A2
<7> [383.418523] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:183]
<7> [383.419226] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:185]
<7> [383.525800] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:78:pipe A]
<7> [383.526016] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [383.526521] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [383.527261] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [383.527683] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [383.528562] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in lane_lat_optim_mask (expected 0x0000000d, found 0x00000000)
<7> [383.529204] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [383.529625] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [383.531682] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [383.532507] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [383.533694] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [383.534321] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [383.534740] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [383.535343] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [383.537207] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [383.537733] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [383.538448] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [383.539493] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [383.540104] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [383.540521] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [383.543059] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [383.543581] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [383.544358] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [383.544959] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [383.545377] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [383.545988] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [383.546405] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [383.548388] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [383.549717] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [383.550345] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [383.550900] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [383.551319] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [383.551732] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [383.553858] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [383.554385] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [383.555401] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [383.556202] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [383.556624] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [383.557319] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [383.557737] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [383.559892] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in port_clock (expected 222750, found 0)
<7> [383.560417] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [383.561101] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [383.561520] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in avi infoframe
<7> [383.562788] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [383.563212] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [383.563217] i915 0000:00:02.0: colorspace: RGB
<7> [383.563221] i915 0000:00:02.0: scan mode: Underscan
<7> [383.563224] i915 0000:00:02.0: colorimetry: No Data
<7> [383.563227] i915 0000:00:02.0: picture aspect: No Data
<7> [383.563231] i915 0000:00:02.0: active aspect: Same as Picture
<7> [383.563234] i915 0000:00:02.0: itc: No Data
<7> [383.563237] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [383.563241] i915 0000:00:02.0: quantization range: Full
<7> [383.563244] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [383.563247] i915 0000:00:02.0: video code: 0
<7> [383.563250] i915 0000:00:02.0: ycc quantization range: Full
<7> [383.563253] i915 0000:00:02.0: hdmi content type: Graphics
<7> [383.563257] i915 0000:00:02.0: pixel repeat: 0
<7> [383.563260] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [383.563263] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [383.563676] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in spd infoframe
<7> [383.564651] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [383.565354] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [383.565360] i915 0000:00:02.0: vendor: Intel
<7> [383.565363] i915 0000:00:02.0: product: Integrated gfx
<7> [383.565367] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [383.565370] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [383.567831] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hdmi infoframe
<7> [383.568362] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [383.570077] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [383.570083] i915 0000:00:02.0: empty frame
<7> [383.570086] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [383.570512] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:78:pipe A] fastset requirement not met, forcing full modeset
<7> [383.571436] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:78:pipe A] releasing PORT PLL B
<7> [383.572179] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:78:pipe A] dbuf slices 0x1 -> 0x0, ddb (0 - 510) -> (0 - 0), active pipes 0x3 -> 0x2
<7> [383.572624] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:121:pipe B] dbuf slices 0x1 -> 0x1, ddb (510 - 1020) -> (0 - 1020), active pipes 0x3 -> 0x2
<7> [383.574936] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:36:plane 1A] ddb ( 0 - 497) -> ( 0 - 0), size 497 -> 0
<7> [383.575470] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:72:cursor A] ddb ( 497 - 510) -> ( 0 - 0), size 13 -> 0
<7> [383.576550] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36: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> [383.577408] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] lines 1, 1, 1, 2, 2, 2, 2, 2, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [383.578046] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] blocks 16, 16, 16, 33, 33, 33, 33, 33, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [383.578459] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] min_ddb 17, 17, 17, 34, 34, 34, 34, 34, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [383.580386] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] min_ddb_uv 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [383.581199] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:79:plane 1B] ddb ( 510 - 1007) -> ( 0 - 988), size 497 -> 988
<7> [383.581612] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:115:cursor B] ddb (1007 - 1020) -> ( 988 - 1020), size 13 -> 32
<7> [383.582816] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:78:pipe A] min cdclk: 192000 kHz -> 0 kHz
<7> [383.583279] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 18563 kHz -> 9282 kHz
<7> [383.583706] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:78:pipe A] enable: no [modeset]
<7> [383.584512] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:36:plane 1A] fb: [NOFB], visible: no
<7> [383.585192] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:45:plane 2A] fb: [NOFB], visible: no
<7> [383.585609] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:54:plane 3A] fb: [NOFB], visible: no
<7> [383.587882] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [383.588409] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:72:cursor A] fb: [NOFB], visible: no
<7> [383.590115] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:166:HDMI-A-1][ENCODER:165:DDI B/PHY B] Disable audio codec on [CRTC:78:pipe A]
<7> [383.619805] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port B
<7> [383.632334] i915 0000:00:02.0: [drm:intel_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x10
<7> [383.636540] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [383.654848] i915 0000:00:02.0: [drm:intel_ddi_disable_transcoder_func [i915]] Quirk Increase DDI disabled time
<7> [383.759274] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [383.760369] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PORT PLL B (active 0x1, on? 1) for [CRTC:78:pipe A]
<7> [383.763714] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PORT PLL B
<7> [383.764589] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:36:plane 1A]
<7> [383.765202] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:165:DDI B/PHY B]
<7> [383.765664] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:175:DDI C/PHY C]
<7> [383.766500] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:166:HDMI-A-1]
<7> [383.775339] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling dpio-common-b
<7> [383.776483] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:78:pipe A]
<7> [383.779298] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:121:pipe B]
<7> [383.779472] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.enable (expected yes, found no)
<7> [383.780275] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.active (expected yes, found no)
<7> [383.780694] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [383.781308] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in lane_count (expected 4, found 0)
<7> [383.781726] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in lane_lat_optim_mask (expected 0x0000000d, found 0x00000000)
<7> [383.782507] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [383.783313] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [383.783733] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [383.784372] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [383.785002] azx_init_pci: snd_hda_intel 0000:00:0e.0: Clearing TCSEL
<7> [383.785018] azx_init_pci: snd_hda_intel 0000:00:0e.0: SCH snoop: Enabled
<7> [383.785058] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [383.785555] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [383.786295] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [383.786742] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [383.787364] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [383.788058] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [383.788477] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [383.789342] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [383.790049] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [383.790468] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [383.791103] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [383.791522] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [383.792409] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [383.793138] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [383.793558] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [383.794304] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [383.794726] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [383.795381] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [383.796151] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [383.796571] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [383.797290] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [383.797711] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [383.798335] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [383.798984] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [383.799463] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [383.800196] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [383.800619] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [383.801303] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [383.801723] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [383.802312] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [383.802728] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in port_clock (expected 222750, found 0)
<7> [383.803466] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [383.804145] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [383.804565] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in avi infoframe
<7> [383.805176] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [383.805594] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [383.805600] i915 0000:00:02.0: colorspace: RGB
<7> [383.805604] i915 0000:00:02.0: scan mode: Underscan
<7> [383.805607] i915 0000:00:02.0: colorimetry: No Data
<7> [383.805611] i915 0000:00:02.0: picture aspect: No Data
<7> [383.805614] i915 0000:00:02.0: active aspect: Same as Picture
<7> [383.805618] i915 0000:00:02.0: itc: No Data
<7> [383.805621] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [383.805625] i915 0000:00:02.0: quantization range: Full
<7> [383.805628] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [383.805632] i915 0000:00:02.0: video code: 0
<7> [383.805635] i915 0000:00:02.0: ycc quantization range: Full
<7> [383.805638] i915 0000:00:02.0: hdmi content type: Graphics
<7> [383.805642] i915 0000:00:02.0: pixel repeat: 0
<7> [383.805645] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [383.805649] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [383.806430] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in spd infoframe
<7> [383.807132] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [383.807549] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [383.807553] i915 0000:00:02.0: vendor: Intel
<7> [383.807557] i915 0000:00:02.0: product: Integrated gfx
<7> [383.807561] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [383.807565] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [383.808225] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hdmi infoframe
<7> [383.808649] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [383.809275] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [383.809280] i915 0000:00:02.0: empty frame
<7> [383.809283] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [383.809700] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:121:pipe B] fastset requirement not met, forcing full modeset
<7> [383.810566] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:121:pipe B] releasing PORT PLL C
<7> [383.811313] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:121:pipe B] dbuf slices 0x1 -> 0x0, ddb (0 - 1020) -> (0 - 0), active pipes 0x2 -> 0x0
<7> [383.812001] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:79:plane 1B] ddb ( 0 - 988) -> ( 0 - 0), size 988 -> 0
<7> [383.812419] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:115:cursor B] ddb ( 988 - 1020) -> ( 0 - 0), size 32 -> 0
<7> [383.813112] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:79:plane 1B] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [383.813581] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:79:plane 1B] lines 1, 1, 1, 2, 2, 2, 2, 2, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [383.814241] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:79:plane 1B] blocks 16, 16, 16, 33, 33, 33, 33, 33, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [383.814651] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:79:plane 1B] min_ddb 17, 17, 17, 34, 34, 34, 34, 34, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [383.815275] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:79:plane 1B] min_ddb_uv 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [383.815745] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:121:pipe B] min cdclk: 192000 kHz -> 0 kHz
<7> [383.816672] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 9282 kHz -> 0 kHz
<7> [383.817398] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:121:pipe B] enable: no [modeset]
<7> [383.818021] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:79:plane 1B] fb: [NOFB], visible: no
<7> [383.818439] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:88:plane 2B] fb: [NOFB], visible: no
<7> [383.819131] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:97:plane 3B] fb: [NOFB], visible: no
<7> [383.819601] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:106:plane 4B] fb: [NOFB], visible: no
<7> [383.820387] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:115:cursor B] fb: [NOFB], visible: no
<7> [383.821252] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:176:HDMI-A-2][ENCODER:175:DDI C/PHY C] Disable audio codec on [CRTC:121:pipe B]
<7> [383.841676] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port C
<7> [383.842328] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe B
<7> [383.858820] i915 0000:00:02.0: [drm:intel_ddi_disable_transcoder_func [i915]] Quirk Increase DDI disabled time
<7> [383.967303] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_C
<7> [383.968419] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PORT PLL C (active 0x2, on? 1) for [CRTC:121:pipe B]
<7> [383.972417] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PORT PLL C
<7> [383.974067] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:165:DDI B/PHY B]
<7> [383.974580] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:175:DDI C/PHY C]
<7> [383.976500] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:176:HDMI-A-2]
<7> [383.977282] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling dpio-common-c
<7> [383.977775] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:121:pipe B]
<7> [383.978783] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change
<7> [383.979215] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 79200 kHz, actual 79200 kHz
<7> [383.979630] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 4, actual 4
<7> [383.980178] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 79200 kHz, VCO 633600 kHz, ref 19200 kHz, bypass 19200 kHz, voltage level 4
<7> [383.981479] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:164:pipe C]
<7> [383.984252] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:121:pipe B]
<7> [383.984327] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:176:HDMI-A-2]
<7> [383.984538] i915 0000:00:02.0: [drm:intel_hdmi_compute_output_format [i915]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [383.985353] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:121:pipe B] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [383.986585] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:175:DDI C/PHY C] [CRTC:121:pipe B]
<7> [383.987356] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [383.988131] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [383.988554] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [383.990894] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [383.991439] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in lane_lat_optim_mask (expected 0x00000000, found 0x0000000d)
<7> [383.992196] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [383.992631] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [383.993465] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [383.994378] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [383.996353] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [383.997161] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [383.997588] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [383.999109] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [383.999543] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [384.000631] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [384.001337] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [384.003648] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [384.004551] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [384.005203] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [384.005622] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [384.006458] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [384.007095] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [384.007514] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [384.009476] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [384.010801] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [384.011240] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [384.011657] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [384.012386] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [384.013126] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [384.013550] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [384.014224] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [384.014643] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [384.016855] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [384.017393] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [384.018717] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [384.019810] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [384.020249] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [384.020665] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [384.021455] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [384.023851] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in port_clock (expected 0, found 222750)
<7> [384.024391] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [384.025090] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)
<7> [384.025513] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in avi infoframe
<7> [384.026410] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [384.027086] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [384.027506] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [384.027511] i915 0000:00:02.0: colorspace: RGB
<7> [384.027515] i915 0000:00:02.0: scan mode: Underscan
<7> [384.027518] i915 0000:00:02.0: colorimetry: No Data
<7> [384.027522] i915 0000:00:02.0: picture aspect: No Data
<7> [384.027525] i915 0000:00:02.0: active aspect: Same as Picture
<7> [384.027529] i915 0000:00:02.0: itc: No Data
<7> [384.027532] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [384.027536] i915 0000:00:02.0: quantization range: Full
<7> [384.027539] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [384.027542] i915 0000:00:02.0: video code: 0
<7> [384.027546] i915 0000:00:02.0: ycc quantization range: Full
<7> [384.027549] i915 0000:00:02.0: hdmi content type: Graphics
<7> [384.027552] i915 0000:00:02.0: pixel repeat: 0
<7> [384.027555] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [384.027560] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in spd infoframe
<7> [384.029814] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [384.030354] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [384.031067] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [384.031072] i915 0000:00:02.0: vendor: Intel
<7> [384.031077] i915 0000:00:02.0: product: Integrated gfx
<7> [384.031080] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [384.031085] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:121:pipe B] fastset requirement not met in hdmi infoframe
<7> [384.031521] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [384.033062] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [384.033498] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [384.033503] i915 0000:00:02.0: empty frame
<7> [384.033508] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:121:pipe B] fastset requirement not met, forcing full modeset
<7> [384.034622] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:121:pipe B] dbuf slices 0x0 -> 0x1, ddb (0 - 0) -> (0 - 1020), active pipes 0x0 -> 0x2
<7> [384.035388] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:79:plane 1B] ddb ( 0 - 0) -> ( 0 - 988), size 0 -> 988
<7> [384.036813] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:115:cursor B] ddb ( 0 - 0) -> ( 988 - 1020), size 0 -> 32
<7> [384.037344] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:79:plane 1B] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [384.039789] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:79:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 1, 1, 2, 2, 2, 2, 2, 0, 0, 0
<7> [384.040290] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:79:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 16, 16, 33, 33, 33, 33, 33, 30, 0, 0
<7> [384.040682] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:79:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 17, 17, 17, 34, 34, 34, 34, 34, 31, 0, 0
<7> [384.042849] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:79:plane 1B] min_ddb_uv 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [384.043574] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:121:pipe B] min cdclk: 0 kHz -> 192000 kHz
<7> [384.044260] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 0 kHz -> 9282 kHz
<7> [384.044824] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change
<7> [384.045236] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 316800 kHz, actual 316800 kHz
<7> [384.045646] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 13, actual 13
<7> [384.046110] i915 0000:00:02.0: [drm:bxt_get_dpll [i915]] [CRTC:121:pipe B] using pre-allocated PORT PLL C
<7> [384.046581] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:121:pipe B] reserving PORT PLL C
<7> [384.047065] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:121:pipe B] enable: yes [modeset]
<7> [384.047485] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [384.047925] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 36, dithering: 0
<7> [384.048339] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [384.048791] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [384.049226] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [384.049641] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [384.050166] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [384.050589] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x6
<7> [384.051021] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [384.051026] i915 0000:00:02.0: colorspace: RGB
<7> [384.051030] i915 0000:00:02.0: scan mode: Underscan
<7> [384.051033] i915 0000:00:02.0: colorimetry: No Data
<7> [384.051037] i915 0000:00:02.0: picture aspect: No Data
<7> [384.051040] i915 0000:00:02.0: active aspect: Same as Picture
<7> [384.051044] i915 0000:00:02.0: itc: No Data
<7> [384.051047] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [384.051051] i915 0000:00:02.0: quantization range: Full
<7> [384.051054] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [384.051057] i915 0000:00:02.0: video code: 0
<7> [384.051060] i915 0000:00:02.0: ycc quantization range: Full
<7> [384.051063] i915 0000:00:02.0: hdmi content type: Graphics
<7> [384.051067] i915 0000:00:02.0: pixel repeat: 0
<7> [384.051070] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [384.051074] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [384.051077] i915 0000:00:02.0: vendor: Intel
<7> [384.051080] i915 0000:00:02.0: product: Integrated gfx
<7> [384.051084] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [384.051087] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [384.051091] i915 0000:00:02.0: empty frame
<7> [384.051095] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 10 00 07 00 66 10 00 01 00 00 00 00 00 00 00 00
<7> [384.051507] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 05 e3 cd 0c 32 38 45 38 35 30 09 07 07 00 00 00
<7> [384.051951] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [384.052372] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [384.052913] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: no, vmin: 0, vmax: 0, flipline: 0, pipeline full: 0, guardband: 0 vsync start: 0, vsync end: 0
<7> [384.053343] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 0, vmax vblank: 0, vmin vtotal: 0, vmax vtotal: 0
<7> [384.053777] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [384.054190] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [384.054677] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [384.055140] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9
<7> [384.055560] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x40 0x9
<7> [384.056087] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9
<7> [384.056535] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 222750, pixel rate 148500, min cdclk 192000, min voltage level 0
<7> [384.056971] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [384.057390] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0, sharpness_strength: 0
<7> [384.057845] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe src: 1920x1080+0+0
<7> [384.058284] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [384.058702] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [384.059201] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [384.059619] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: ebb0: 0x6200, ebb4: 0x2000,pll0: 0x21, pll1: 0x100, pll2: 0x1a6666, pll3: 0x10000, pll6: 0x30904, pll8: 0x8, pll9: 0xa, pll10: 0x8003c00, pcsdw12: 0x4d
<7> [384.060067] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [384.060482] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [384.060944] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [384.061448] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [384.061922] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [384.062338] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [384.062776] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [384.063188] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:79:plane 1B] fb: [FB:183] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [384.063676] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [384.064238] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [384.064666] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:88:plane 2B] fb: [NOFB], visible: no
<7> [384.065135] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:97:plane 3B] fb: [NOFB], visible: no
<7> [384.065580] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:106:plane 4B] fb: [NOFB], visible: no
<7> [384.066015] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:115:cursor B] fb: [NOFB], visible: no
<7> [384.067193] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling dpio-common-c
<7> [384.068900] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 316800 kHz, VCO 633600 kHz, ref 19200 kHz, bypass 19200 kHz, voltage level 13
<7> [384.069390] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:165:DDI B/PHY B]
<7> [384.070483] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:175:DDI C/PHY C]
<7> [384.071187] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable PORT PLL C (active 0x2, on? 0) for [CRTC:121:pipe B]
<7> [384.071617] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling PORT PLL C
<7> [384.072334] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_C
<7> [384.072985] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B
<7> [384.090572] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:176:HDMI-A-2][ENCODER:175:DDI C/PHY C] Enable audio codec on [CRTC:121:pipe B], 32 bytes ELD
<7> [384.107227] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [384.107785] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N
<7> [384.108421] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:176:HDMI-A-2]
<7> [384.109054] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:121:pipe B]
<7> [384.113164] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:78:pipe A]
<7> [384.113225] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:166:HDMI-A-1]
<7> [384.113415] i915 0000:00:02.0: [drm:intel_hdmi_compute_output_format [i915]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [384.115028] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:78:pipe A] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [384.115554] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:165:DDI B/PHY B] [CRTC:78:pipe A]
<7> [384.115993] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [384.116410] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [384.117824] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [384.118310] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [384.118724] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in lane_lat_optim_mask (expected 0x00000000, found 0x0000000d)
<7> [384.119166] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [384.119581] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [384.120071] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [384.120540] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [384.120994] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [384.121410] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [384.121928] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [384.122372] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [384.122853] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [384.123299] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [384.123712] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [384.124155] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [384.124570] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [384.128144] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [384.128736] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [384.129209] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [384.129633] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [384.130152] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [384.130571] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [384.131064] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [384.131505] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [384.131952] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [384.132380] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [384.135117] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [384.135638] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [384.136090] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [384.136505] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [384.136981] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [384.137407] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [384.137972] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [384.138412] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [384.138940] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [384.139381] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [384.139821] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [384.140244] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in port_clock (expected 0, found 222750)
<7> [384.140657] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [384.143201] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)
<7> [384.143916] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in avi infoframe
<7> [384.144386] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [384.144844] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [384.145257] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [384.145262] i915 0000:00:02.0: colorspace: RGB
<7> [384.145267] i915 0000:00:02.0: scan mode: Underscan
<7> [384.145270] i915 0000:00:02.0: colorimetry: No Data
<7> [384.145273] i915 0000:00:02.0: picture aspect: No Data
<7> [384.145276] i915 0000:00:02.0: active aspect: Same as Picture
<7> [384.145280] i915 0000:00:02.0: itc: No Data
<7> [384.145283] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [384.145286] i915 0000:00:02.0: quantization range: Full
<7> [384.145289] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [384.145293] i915 0000:00:02.0: video code: 0
<7> [384.145296] i915 0000:00:02.0: ycc quantization range: Full
<7> [384.145299] i915 0000:00:02.0: hdmi content type: Graphics
<7> [384.145302] i915 0000:00:02.0: pixel repeat: 0
<7> [384.145305] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [384.145309] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in spd infoframe
<7> [384.145721] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [384.146261] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [384.146704] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [384.146709] i915 0000:00:02.0: vendor: Intel
<7> [384.146712] i915 0000:00:02.0: product: Integrated gfx
<7> [384.146716] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [384.146720] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:78:pipe A] fastset requirement not met in hdmi infoframe
<7> [384.147189] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [384.147601] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [384.148042] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [384.148047] i915 0000:00:02.0: empty frame
<7> [384.148052] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:78:pipe A] fastset requirement not met, forcing full modeset
<7> [384.148559] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:78:pipe A] dbuf slices 0x0 -> 0x1, ddb (0 - 0) -> (0 - 510), active pipes 0x2 -> 0x3
<7> [384.151678] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:121:pipe B] dbuf slices 0x1 -> 0x1, ddb (0 - 1020) -> (510 - 1020), active pipes 0x2 -> 0x3
<7> [384.152363] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:36:plane 1A] ddb ( 0 - 0) -> ( 0 - 497), size 0 -> 497
<7> [384.152906] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:72:cursor A] ddb ( 0 - 0) -> ( 497 - 510), size 0 -> 13
<7> [384.153342] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36: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> [384.153834] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 1, 1, 2, 2, 2, 2, 2, 0, 0, 0
<7> [384.154271] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 16, 16, 33, 33, 33, 33, 33, 30, 0, 0
<7> [384.154677] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 17, 17, 17, 34, 34, 34, 34, 34, 31, 0, 0
<7> [384.155167] i915 0000:00:02.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:36:plane 1A] min_ddb_uv 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [384.155604] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:79:plane 1B] ddb ( 0 - 988) -> ( 510 - 1007), size 988 -> 497
<7> [384.158296] i915 0000:00:02.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:115:cursor B] ddb ( 988 - 1020) -> (1007 - 1020), size 32 -> 13
<7> [384.158937] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:78:pipe A] min cdclk: 0 kHz -> 192000 kHz
<7> [384.159397] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 9282 kHz -> 18563 kHz
<7> [384.159924] i915 0000:00:02.0: [drm:bxt_get_dpll [i915]] [CRTC:78:pipe A] using pre-allocated PORT PLL B
<7> [384.160371] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:78:pipe A] reserving PORT PLL B
<7> [384.160908] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:78:pipe A] enable: yes [modeset]
<7> [384.161327] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [384.161779] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 36, dithering: 0
<7> [384.162217] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [384.162627] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [384.163084] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [384.163495] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [384.165943] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [384.166552] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x6
<7> [384.167068] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [384.167074] i915 0000:00:02.0: colorspace: RGB
<7> [384.167078] i915 0000:00:02.0: scan mode: Underscan
<7> [384.167081] i915 0000:00:02.0: colorimetry: No Data
<7> [384.167084] i915 0000:00:02.0: picture aspect: No Data
<7> [384.167088] i915 0000:00:02.0: active aspect: Same as Picture
<7> [384.167091] i915 0000:00:02.0: itc: No Data
<7> [384.167094] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [384.167097] i915 0000:00:02.0: quantization range: Full
<7> [384.167100] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [384.167103] i915 0000:00:02.0: video code: 0
<7> [384.167106] i915 0000:00:02.0: ycc quantization range: Full
<7> [384.167110] i915 0000:00:02.0: hdmi content type: Graphics
<7> [384.167113] i915 0000:00:02.0: pixel repeat: 0
<7> [384.167116] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [384.167120] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [384.167124] i915 0000:00:02.0: vendor: Intel
<7> [384.167127] i915 0000:00:02.0: product: Integrated gfx
<7> [384.167130] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [384.167133] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [384.167137] i915 0000:00:02.0: empty frame
<7> [384.167141] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 10 00 07 00 66 10 00 01 00 00 00 00 00 00 00 00
<7> [384.167619] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ELD: 05 e3 cd 0c 32 38 45 38 35 30 09 07 07 00 00 00
<7> [384.168069] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [384.168481] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [384.168966] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: no, vmin: 0, vmax: 0, flipline: 0, pipeline full: 0, guardband: 0 vsync start: 0, vsync end: 0
<7> [384.169409] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 0, vmax vblank: 0, vmin vtotal: 0, vmax vtotal: 0
<7> [384.169928] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [384.170370] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [384.170811] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x48 0x9
<7> [384.171224] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9
<7> [384.171636] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1083 1088 1125 0x40 0x9
<7> [384.174734] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1083-1088 vt=1125, flags=0x9
<7> [384.175380] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 222750, pixel rate 148500, min cdclk 192000, min voltage level 0
<7> [384.175852] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [384.176342] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0, sharpness_strength: 0
<7> [384.176899] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe src: 1920x1080+0+0
<7> [384.177340] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [384.177774] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [384.178184] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [384.178593] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: ebb0: 0x6200, ebb4: 0x2000,pll0: 0x21, pll1: 0x100, pll2: 0x1a6666, pll3: 0x10000, pll6: 0x30904, pll8: 0x8, pll9: 0xa, pll10: 0x8003c00, pcsdw12: 0x4d
<7> [384.181026] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [384.181584] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [384.182106] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [384.182575] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [384.183024] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [384.183437] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [384.183905] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [384.184348] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:36:plane 1A] fb: [FB:183] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [384.184864] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [384.185306] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [384.185719] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:45:plane 2A] fb: [NOFB], visible: no
<7> [384.188152] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:54:plane 3A] fb: [NOFB], visible: no
<7> [384.188843] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [384.189335] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:72:cursor A] fb: [NOFB], visible: no
<7> [384.192421] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling dpio-common-b
<7> [384.193734] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:165:DDI B/PHY B]
<7> [384.194332] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:175:DDI C/PHY C]
<7> [384.207277] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable PORT PLL B (active 0x1, on? 0) for [CRTC:78:pipe A]
<7> [384.207838] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling PORT PLL B
<7> [384.208399] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [384.208939] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [384.210896] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 16588800 bytes of contiguous stolen space for FBC, limit: 1
<7> [384.211427] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:36:plane 1A]
<7> [384.226481] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:166:HDMI-A-1][ENCODER:165:DDI B/PHY B] Enable audio codec on [CRTC:78:pipe A], 32 bytes ELD
<7> [384.243144] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [384.243668] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N
<7> [384.244313] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:166:HDMI-A-1]
<7> [384.244939] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:78:pipe A]
<6> [392.951937] [IGT] kms_flip: finished subtest AB-HDMI-A1-HDMI-A2, FAIL
Created at 2026-04-16 02:39:16