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

Result: Fail

integration-manifest git-log-oneline i915_display_info12 igt_runner12 runtimes12 results12.json results12-i915-load.json guc_logs12.tar boot12 dmesg12

DetailValue
Duration 10.32 seconds
Hostname
shard-glk1
Igt-Version
IGT-Version: 2.3-g07ca77c0e (x86_64) (Linux: 6.19.0-CI_DRM_17987-g69686d26e229+ x86_64)
Out
Starting dynamic subtest: BC-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:921 run_test_on_crtc_set.constprop.0()
  #2 ../tests/kms_flip.c:1972 run_pair()
  #3 ../tests/kms_flip.c:2129 __igt_unique____real_main2043()
  #4 ../tests/kms_flip.c:2043 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest BC-HDMI-A1-HDMI-A2: FAIL (10.316s)
Subtest 2x-flip-vs-expired-vblank: FAIL (31.809s)
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../lib/igt_kms.c:2351 kmstest_set_connector_dpms()
  #2 ../lib/igt_core.c:2961 igt_atexit_handler()
  #3 [erand48_r+0x1d6]
  #4 [exit+0x1e]
  #5 ../lib/igt_core.c:2416 igt_exit()
  #6 [main+0x3f]
  #7 [__libc_init_first+0x8a]
  #8 [__libc_start_main+0x8b]
  #9 [_start+0x25]
Err
Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
(kms_flip:2279) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:926:
(kms_flip:2279) CRITICAL: Failed assertion: end - start < 500
Dynamic subtest BC-HDMI-A1-HDMI-A2 failed.
**** DEBUG ****
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.335800
last_received_ts = 155.335510
last_seq = 2950
current_ts = 155.352463
current_received_ts = 155.352234
current_seq = 2951
count = 446
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 23us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.352463
last_received_ts = 155.352234
last_seq = 2951
current_ts = 155.369125
current_received_ts = 155.368835
current_seq = 2952
count = 447
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.369125
last_received_ts = 155.368835
last_seq = 2952
current_ts = 155.385803
current_received_ts = 155.385529
current_seq = 2953
count = 448
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 26us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.385803
last_received_ts = 155.385529
last_seq = 2953
current_ts = 155.402466
current_received_ts = 155.402283
current_seq = 2954
count = 449
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 22us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.402466
last_received_ts = 155.402283
last_seq = 2954
current_ts = 155.419128
current_received_ts = 155.418839
current_seq = 2955
count = 450
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.419128
last_received_ts = 155.418839
last_seq = 2955
current_ts = 155.435791
current_received_ts = 155.435516
current_seq = 2956
count = 451
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 17us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.435791
last_received_ts = 155.435516
last_seq = 2956
current_ts = 155.452454
current_received_ts = 155.452225
current_seq = 2957
count = 452
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 22us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.452454
last_received_ts = 155.452225
last_seq = 2957
current_ts = 155.469116
current_received_ts = 155.468842
current_seq = 2958
count = 453
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 22us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.469116
last_received_ts = 155.468842
last_seq = 2958
current_ts = 155.485779
current_received_ts = 155.485565
current_seq = 2959
count = 454
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 24us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.485779
last_received_ts = 155.485565
last_seq = 2959
current_ts = 155.502457
current_received_ts = 155.502289
current_seq = 2960
count = 455
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 21us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.502457
last_received_ts = 155.502289
last_seq = 2960
current_ts = 155.519119
current_received_ts = 155.518829
current_seq = 2961
count = 456
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 23us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.519119
last_received_ts = 155.518829
last_seq = 2961
current_ts = 155.535797
current_received_ts = 155.535507
current_seq = 2962
count = 457
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 22us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.535797
last_received_ts = 155.535507
last_seq = 2962
current_ts = 155.552444
current_received_ts = 155.552246
current_seq = 2963
count = 458
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 21us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.552444
last_received_ts = 155.552246
last_seq = 2963
current_ts = 155.569122
current_received_ts = 155.568832
current_seq = 2964
count = 459
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 24us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.569122
last_received_ts = 155.568832
last_seq = 2964
current_ts = 155.585785
current_received_ts = 155.585541
current_seq = 2965
count = 460
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 26us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.585785
last_received_ts = 155.585541
last_seq = 2965
current_ts = 155.602463
current_received_ts = 155.602280
current_seq = 2966
count = 461
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 22us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.602463
last_received_ts = 155.602280
last_seq = 2966
current_ts = 155.619125
current_received_ts = 155.618790
current_seq = 2967
count = 462
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.619125
last_received_ts = 155.618790
last_seq = 2967
current_ts = 155.635788
current_received_ts = 155.635498
current_seq = 2968
count = 463
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 21us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.635788
last_received_ts = 155.635498
last_seq = 2968
current_ts = 155.652466
current_received_ts = 155.652222
current_seq = 2969
count = 464
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 22us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.652466
last_received_ts = 155.652222
last_seq = 2969
current_ts = 155.669113
current_received_ts = 155.668869
current_seq = 2970
count = 465
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.669113
last_received_ts = 155.668869
last_seq = 2970
current_ts = 155.685791
current_received_ts = 155.685547
current_seq = 2971
count = 466
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 26us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.685791
last_received_ts = 155.685547
last_seq = 2971
current_ts = 155.702454
current_received_ts = 155.702240
current_seq = 2972
count = 467
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 24us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.702454
last_received_ts = 155.702240
last_seq = 2972
current_ts = 155.719116
current_received_ts = 155.718842
current_seq = 2973
count = 468
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 26us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.719116
last_received_ts = 155.718842
last_seq = 2973
current_ts = 155.735794
current_received_ts = 155.735535
current_seq = 2974
count = 469
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 41us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.735794
last_received_ts = 155.735535
last_seq = 2974
current_ts = 155.752457
current_received_ts = 155.752243
current_seq = 2975
count = 470
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 23us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.752457
last_received_ts = 155.752243
last_seq = 2975
current_ts = 155.769135
current_received_ts = 155.768829
current_seq = 2976
count = 471
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.769135
last_received_ts = 155.768829
last_seq = 2976
current_ts = 155.785797
current_received_ts = 155.785522
current_seq = 2977
count = 472
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 23us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.785797
last_received_ts = 155.785522
last_seq = 2977
current_ts = 155.802444
current_received_ts = 155.802292
current_seq = 2978
count = 473
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 22us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.802444
last_received_ts = 155.802292
last_seq = 2978
current_ts = 155.819122
current_received_ts = 155.818787
current_seq = 2979
count = 474
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.819122
last_received_ts = 155.818787
last_seq = 2979
current_ts = 155.835785
current_received_ts = 155.835464
current_seq = 2980
count = 475
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 16us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.835785
last_received_ts = 155.835464
last_seq = 2980
current_ts = 155.852463
current_received_ts = 155.852234
current_seq = 2981
count = 476
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 24us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.852463
last_received_ts = 155.852234
last_seq = 2981
current_ts = 155.869125
current_received_ts = 155.868820
current_seq = 2982
count = 477
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 26us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.869125
last_received_ts = 155.868820
last_seq = 2982
current_ts = 155.885788
current_received_ts = 155.885513
current_seq = 2983
count = 478
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.885788
last_received_ts = 155.885513
last_seq = 2983
current_ts = 155.902451
current_received_ts = 155.902298
current_seq = 2984
count = 479
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 23us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.902451
last_received_ts = 155.902298
last_seq = 2984
current_ts = 155.919128
current_received_ts = 155.918839
current_seq = 2985
count = 480
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.919128
last_received_ts = 155.918839
last_seq = 2985
current_ts = 155.935791
current_received_ts = 155.935516
current_seq = 2986
count = 481
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 43us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.935791
last_received_ts = 155.935516
last_seq = 2986
current_ts = 155.952454
current_received_ts = 155.952225
current_seq = 2987
count = 482
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 23us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.952454
last_received_ts = 155.952225
last_seq = 2987
current_ts = 155.969116
current_received_ts = 155.968842
current_seq = 2988
count = 483
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.969116
last_received_ts = 155.968842
last_seq = 2988
current_ts = 155.985794
current_received_ts = 155.985535
current_seq = 2989
count = 484
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 155.985794
last_received_ts = 155.985535
last_seq = 2989
current_ts = 156.002457
current_received_ts = 156.002289
current_seq = 2990
count = 485
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 22us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.002457
last_received_ts = 156.002289
last_seq = 2990
current_ts = 156.019135
current_received_ts = 156.018845
current_seq = 2991
count = 486
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 26us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.019135
last_received_ts = 156.018845
last_seq = 2991
current_ts = 156.035782
current_received_ts = 156.035507
current_seq = 2992
count = 487
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 16us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.035782
last_received_ts = 156.035507
last_seq = 2992
current_ts = 156.052460
current_received_ts = 156.052231
current_seq = 2993
count = 488
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 23us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.052460
last_received_ts = 156.052231
last_seq = 2993
current_ts = 156.069122
current_received_ts = 156.068741
current_seq = 2994
count = 489
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 26us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.069122
last_received_ts = 156.068741
last_seq = 2994
current_ts = 156.085785
current_received_ts = 156.085556
current_seq = 2995
count = 490
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.085785
last_received_ts = 156.085556
last_seq = 2995
current_ts = 156.102448
current_received_ts = 156.102234
current_seq = 2996
count = 491
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 24us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.102448
last_received_ts = 156.102234
last_seq = 2996
current_ts = 156.119125
current_received_ts = 156.119064
current_seq = 2997
count = 492
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 21us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.119125
last_received_ts = 156.119064
last_seq = 2997
current_ts = 156.135788
current_received_ts = 156.135529
current_seq = 2998
count = 493
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 22us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.135788
last_received_ts = 156.135529
last_seq = 2998
current_ts = 156.152451
current_received_ts = 156.152237
current_seq = 2999
count = 494
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.152451
last_received_ts = 156.152237
last_seq = 2999
current_ts = 156.169113
current_received_ts = 156.169067
current_seq = 3000
count = 495
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 20us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.169113
last_received_ts = 156.169067
last_seq = 3000
current_ts = 156.185791
current_received_ts = 156.185486
current_seq = 3001
count = 496
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 23us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.185791
last_received_ts = 156.185486
last_seq = 3001
current_ts = 156.202454
current_received_ts = 156.202225
current_seq = 3002
count = 497
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 22us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.202454
last_received_ts = 156.202225
last_seq = 3002
current_ts = 156.219131
current_received_ts = 156.218765
current_seq = 3003
count = 498
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 23us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.219131
last_received_ts = 156.218765
last_seq = 3003
current_ts = 156.235779
current_received_ts = 156.235504
current_seq = 3004
count = 499
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 22us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.235779
last_received_ts = 156.235504
last_seq = 3004
current_ts = 156.252441
current_received_ts = 156.252304
current_seq = 3005
count = 500
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 22us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.252441
last_received_ts = 156.252304
last_seq = 3005
current_ts = 156.269119
current_received_ts = 156.268890
current_seq = 3006
count = 501
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 20us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.269119
last_received_ts = 156.268890
last_seq = 3006
current_ts = 156.285782
current_received_ts = 156.285522
current_seq = 3007
count = 502
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 24us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.285782
last_received_ts = 156.285522
last_seq = 3007
current_ts = 156.302460
current_received_ts = 156.302231
current_seq = 3008
count = 503
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 26us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.302460
last_received_ts = 156.302231
last_seq = 3008
current_ts = 156.319122
current_received_ts = 156.319046
current_seq = 3009
count = 504
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 21us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.319122
last_received_ts = 156.319046
last_seq = 3009
current_ts = 156.335785
current_received_ts = 156.335541
current_seq = 3010
count = 505
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 37us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.335785
last_received_ts = 156.335541
last_seq = 3010
current_ts = 156.352448
current_received_ts = 156.352234
current_seq = 3011
count = 506
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 24us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.352448
last_received_ts = 156.352234
last_seq = 3011
current_ts = 156.369110
current_received_ts = 156.368851
current_seq = 3012
count = 507
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.369110
last_received_ts = 156.368851
last_seq = 3012
current_ts = 156.385788
current_received_ts = 156.385574
current_seq = 3013
count = 508
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 26us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.385788
last_received_ts = 156.385574
last_seq = 3013
current_ts = 156.402451
current_received_ts = 156.402237
current_seq = 3014
count = 509
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 24us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.402451
last_received_ts = 156.402237
last_seq = 3014
current_ts = 156.419128
current_received_ts = 156.418823
current_seq = 3015
count = 510
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 26us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.419128
last_received_ts = 156.418823
last_seq = 3015
current_ts = 156.435791
current_received_ts = 156.435471
current_seq = 3016
count = 511
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 16us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.435791
last_received_ts = 156.435471
last_seq = 3016
current_ts = 156.452454
current_received_ts = 156.452332
current_seq = 3017
count = 512
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 24us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.452454
last_received_ts = 156.452332
last_seq = 3017
current_ts = 156.469116
current_received_ts = 156.468826
current_seq = 3018
count = 513
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.469116
last_received_ts = 156.468826
last_seq = 3018
current_ts = 156.485794
current_received_ts = 156.485550
current_seq = 3019
count = 514
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 24us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.485794
last_received_ts = 156.485550
last_seq = 3019
current_ts = 156.502441
current_received_ts = 156.502228
current_seq = 3020
count = 515
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.502441
last_received_ts = 156.502228
last_seq = 3020
current_ts = 156.519119
current_received_ts = 156.519104
current_seq = 3021
count = 516
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 26us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.519119
last_received_ts = 156.519104
last_seq = 3021
current_ts = 156.535797
current_received_ts = 156.535538
current_seq = 3022
count = 517
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 26us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.535797
last_received_ts = 156.535538
last_seq = 3022
current_ts = 156.552444
current_received_ts = 156.552307
current_seq = 3023
count = 518
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 24us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.552444
last_received_ts = 156.552307
last_seq = 3023
current_ts = 156.569107
current_received_ts = 156.568787
current_seq = 3024
count = 519
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 27us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.569107
last_received_ts = 156.568787
last_seq = 3024
current_ts = 156.585785
current_received_ts = 156.585556
current_seq = 3025
count = 520
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.585785
last_received_ts = 156.585556
last_seq = 3025
current_ts = 156.602463
current_received_ts = 156.602280
current_seq = 3026
count = 521
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 21us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.602463
last_received_ts = 156.602280
last_seq = 3026
current_ts = 156.619125
current_received_ts = 156.618774
current_seq = 3027
count = 522
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.619125
last_received_ts = 156.618774
last_seq = 3027
current_ts = 156.635788
current_received_ts = 156.635483
current_seq = 3028
count = 523
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 17us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.635788
last_received_ts = 156.635483
last_seq = 3028
current_ts = 156.652451
current_received_ts = 156.652237
current_seq = 3029
count = 524
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.652451
last_received_ts = 156.652237
last_seq = 3029
current_ts = 156.669128
current_received_ts = 156.668930
current_seq = 3030
count = 525
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 20us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.669128
last_received_ts = 156.668930
last_seq = 3030
current_ts = 156.685791
current_received_ts = 156.685516
current_seq = 3031
count = 526
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 20us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.685791
last_received_ts = 156.685516
last_seq = 3031
current_ts = 156.702454
current_received_ts = 156.702240
current_seq = 3032
count = 527
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 22us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.702454
last_received_ts = 156.702240
last_seq = 3032
current_ts = 156.719116
current_received_ts = 156.718826
current_seq = 3033
count = 528
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 26us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.719116
last_received_ts = 156.718826
last_seq = 3033
current_ts = 156.735779
current_received_ts = 156.735474
current_seq = 3034
count = 529
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 20us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.735779
last_received_ts = 156.735474
last_seq = 3034
current_ts = 156.752441
current_received_ts = 156.752304
current_seq = 3035
count = 530
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.752441
last_received_ts = 156.752304
last_seq = 3035
current_ts = 156.769104
current_received_ts = 156.768860
current_seq = 3036
count = 531
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 24us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.769104
last_received_ts = 156.768860
last_seq = 3036
current_ts = 156.785782
current_received_ts = 156.785492
current_seq = 3037
count = 532
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 18us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.785782
last_received_ts = 156.785492
last_seq = 3037
current_ts = 156.802444
current_received_ts = 156.802292
current_seq = 3038
count = 533
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.802444
last_received_ts = 156.802292
last_seq = 3038
current_ts = 156.819122
current_received_ts = 156.818863
current_seq = 3039
count = 534
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 24us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.819122
last_received_ts = 156.818863
last_seq = 3039
current_ts = 156.835785
current_received_ts = 156.835480
current_seq = 3040
count = 535
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 26us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.835785
last_received_ts = 156.835480
last_seq = 3040
current_ts = 156.852448
current_received_ts = 156.852325
current_seq = 3041
count = 536
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.852448
last_received_ts = 156.852325
last_seq = 3041
current_ts = 156.869125
current_received_ts = 156.868927
current_seq = 3042
count = 537
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 81us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.869125
last_received_ts = 156.868927
last_seq = 3042
current_ts = 156.885788
current_received_ts = 156.885498
current_seq = 3043
count = 538
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 22us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.885788
last_received_ts = 156.885498
last_seq = 3043
current_ts = 156.902451
current_received_ts = 156.902313
current_seq = 3044
count = 539
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.902451
last_received_ts = 156.902313
last_seq = 3044
current_ts = 156.919128
current_received_ts = 156.918976
current_seq = 3045
count = 540
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 22us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.919128
last_received_ts = 156.918976
last_seq = 3045
current_ts = 156.935791
current_received_ts = 156.935486
current_seq = 3046
count = 541
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 21us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.935791
last_received_ts = 156.935486
last_seq = 3046
current_ts = 156.952454
current_received_ts = 156.952271
current_seq = 3047
count = 542
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 21us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.952454
last_received_ts = 156.952271
last_seq = 3047
current_ts = 156.969116
current_received_ts = 156.968857
current_seq = 3048
count = 543
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 24us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.969116
last_received_ts = 156.968857
last_seq = 3048
current_ts = 156.985779
current_received_ts = 156.985550
current_seq = 3049
count = 544
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 26us
(kms_flip:2279) DEBUG: name = flip
last_ts = 156.985779
last_received_ts = 156.985550
last_seq = 3049
current_ts = 157.002441
current_received_ts = 157.002289
current_seq = 3050
count = 545
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 23us
(kms_flip:2279) DEBUG: name = flip
last_ts = 157.002441
last_received_ts = 157.002289
last_seq = 3050
current_ts = 157.019119
current_received_ts = 157.018829
current_seq = 3051
count = 546
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 157.019119
last_received_ts = 157.018829
last_seq = 3051
current_ts = 157.035782
current_received_ts = 157.035461
current_seq = 3052
count = 547
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 16us
(kms_flip:2279) DEBUG: name = flip
last_ts = 157.035782
last_received_ts = 157.035461
last_seq = 3052
current_ts = 157.052444
current_received_ts = 157.052231
current_seq = 3053
count = 548
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 24us
(kms_flip:2279) DEBUG: name = flip
last_ts = 157.052444
last_received_ts = 157.052231
last_seq = 3053
current_ts = 157.069122
current_received_ts = 157.068832
current_seq = 3054
count = 549
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 26us
(kms_flip:2279) DEBUG: name = flip
last_ts = 157.069122
last_received_ts = 157.068832
last_seq = 3054
current_ts = 157.085785
current_received_ts = 157.085556
current_seq = 3055
count = 550
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 157.085785
last_received_ts = 157.085556
last_seq = 3055
current_ts = 157.102448
current_received_ts = 157.102234
current_seq = 3056
count = 551
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 24us
(kms_flip:2279) DEBUG: name = flip
last_ts = 157.102448
last_received_ts = 157.102234
last_seq = 3056
current_ts = 157.119110
current_received_ts = 157.118820
current_seq = 3057
count = 552
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 26us
(kms_flip:2279) DEBUG: name = flip
last_ts = 157.119110
last_received_ts = 157.118820
last_seq = 3057
current_ts = 157.135788
current_received_ts = 157.135544
current_seq = 3058
count = 553
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 24us
(kms_flip:2279) DEBUG: name = flip
last_ts = 157.135788
last_received_ts = 157.135544
last_seq = 3058
current_ts = 157.152451
current_received_ts = 157.152283
current_seq = 3059
count = 554
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 21us
(kms_flip:2279) DEBUG: name = flip
last_ts = 157.152451
last_received_ts = 157.152283
last_seq = 3059
current_ts = 157.169113
current_received_ts = 157.168823
current_seq = 3060
count = 555
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 157.169113
last_received_ts = 157.168823
last_seq = 3060
current_ts = 157.185776
current_received_ts = 157.185516
current_seq = 3061
count = 556
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 157.185776
last_received_ts = 157.185516
last_seq = 3061
current_ts = 157.202454
current_received_ts = 157.202271
current_seq = 3062
count = 557
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 20us
(kms_flip:2279) DEBUG: name = flip
last_ts = 157.202454
last_received_ts = 157.202271
last_seq = 3062
current_ts = 157.219116
current_received_ts = 157.218781
current_seq = 3063
count = 558
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 157.219116
last_received_ts = 157.218781
last_seq = 3063
current_ts = 157.235779
current_received_ts = 157.235489
current_seq = 3064
count = 559
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 17us
(kms_flip:2279) DEBUG: name = flip
last_ts = 157.235779
last_received_ts = 157.235489
last_seq = 3064
current_ts = 157.252441
current_received_ts = 157.252228
current_seq = 3065
count = 560
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 24us
(kms_flip:2279) DEBUG: name = flip
last_ts = 157.252441
last_received_ts = 157.252228
last_seq = 3065
current_ts = 157.269119
current_received_ts = 157.268829
current_seq = 3066
count = 561
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 157.269119
last_received_ts = 157.268829
last_seq = 3066
current_ts = 157.285782
current_received_ts = 157.285477
current_seq = 3067
count = 562
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 23us
(kms_flip:2279) DEBUG: name = flip
last_ts = 157.285782
last_received_ts = 157.285477
last_seq = 3067
current_ts = 157.302444
current_received_ts = 157.302307
current_seq = 3068
count = 563
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 25us
(kms_flip:2279) DEBUG: name = flip
last_ts = 157.302444
last_received_ts = 157.302307
last_seq = 3068
current_ts = 157.319122
current_received_ts = 157.318481
current_seq = 3069
count = 564
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 22us
(kms_flip:2279) DEBUG: name = flip
last_ts = 157.319122
last_received_ts = 157.318481
last_seq = 3069
current_ts = 157.335785
current_received_ts = 157.335846
current_seq = 3070
count = 565
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 13us
(kms_flip:2279) DEBUG: name = flip
last_ts = 157.335785
last_received_ts = 157.335846
last_seq = 3070
current_ts = 157.352448
current_received_ts = 157.351837
current_seq = 3071
count = 566
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 11us
(kms_flip:2279) DEBUG: name = flip
last_ts = 157.352448
last_received_ts = 157.351837
last_seq = 3071
current_ts = 157.369125
current_received_ts = 157.368500
current_seq = 3072
count = 567
seq_step = 1
(kms_flip:2279) DEBUG: Vblank took 1513us
(kms_flip:2279) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:926:
(kms_flip:2279) CRITICAL: Failed assertion: end - start < 500
(kms_flip:2279) igt_core-INFO: Stack trace:
(kms_flip:2279) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(kms_flip:2279) igt_core-INFO:   #1 ../tests/kms_flip.c:921 run_test_on_crtc_set.constprop.0()
(kms_flip:2279) igt_core-INFO:   #2 ../tests/kms_flip.c:1972 run_pair()
(kms_flip:2279) igt_core-INFO:   #3 ../tests/kms_flip.c:2129 __igt_unique____real_main2043()
(kms_flip:2279) igt_core-INFO:   #4 ../tests/kms_flip.c:2043 main()
(kms_flip:2279) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:2279) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:2279) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest BC-HDMI-A1-HDMI-A2: FAIL (10.316s)
Subtest 2x-flip-vs-expired-vblank: FAIL (31.809s)
(kms_flip:2279) igt_kms-CRITICAL: Test assertion failure function kmstest_set_connector_dpms, file ../lib/igt_kms.c:2351:
(kms_flip:2279) igt_kms-CRITICAL: Failed assertion: found_it
(kms_flip:2279) igt_kms-CRITICAL: Last errno: 9, Bad file descriptor
(kms_flip:2279) igt_kms-CRITICAL: DPMS property not found on 165
Dmesg
<6> [147.386283] [IGT] kms_flip: starting dynamic subtest BC-HDMI-A1-HDMI-A2
<7> [147.387641] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:178]
<7> [147.388217] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:184]
<7> [147.442987] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:77:pipe A]
<7> [147.443467] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [147.444794] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [147.445892] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [147.446999] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [147.448090] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in lane_lat_optim_mask (expected 0x0000000d, found 0x00000000)
<7> [147.449038] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [147.449450] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [147.449869] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [147.450278] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [147.450697] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [147.451105] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [147.451587] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [147.452014] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [147.452422] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [147.452842] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [147.453343] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [147.453777] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [147.454189] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [147.454596] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [147.455026] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [147.455437] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [147.455854] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [147.456262] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [147.456693] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [147.457102] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [147.457512] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [147.457933] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [147.458341] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [147.458760] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [147.459171] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [147.459579] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [147.459996] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [147.460407] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [147.460826] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [147.461235] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [147.461643] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [147.462077] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [147.462488] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [147.462908] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [147.463318] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in port_clock (expected 222750, found 0)
<7> [147.463736] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [147.464144] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [147.464554] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in avi infoframe
<7> [147.464976] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [147.465386] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [147.465391] i915 0000:00:02.0: colorspace: RGB
<7> [147.465395] i915 0000:00:02.0: scan mode: Underscan
<7> [147.465398] i915 0000:00:02.0: colorimetry: No Data
<7> [147.465401] i915 0000:00:02.0: picture aspect: No Data
<7> [147.465405] i915 0000:00:02.0: active aspect: Same as Picture
<7> [147.465408] i915 0000:00:02.0: itc: No Data
<7> [147.465411] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [147.465414] i915 0000:00:02.0: quantization range: Full
<7> [147.465417] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [147.465421] i915 0000:00:02.0: video code: 0
<7> [147.465423] i915 0000:00:02.0: ycc quantization range: Full
<7> [147.465427] i915 0000:00:02.0: hdmi content type: Graphics
<7> [147.465430] i915 0000:00:02.0: pixel repeat: 0
<7> [147.465433] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [147.465436] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [147.465853] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in spd infoframe
<7> [147.466261] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [147.466681] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [147.466685] i915 0000:00:02.0: vendor: Intel
<7> [147.466689] i915 0000:00:02.0: product: Integrated gfx
<7> [147.466692] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [147.466696] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [147.467102] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hdmi infoframe
<7> [147.467509] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [147.467928] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [147.467932] i915 0000:00:02.0: empty frame
<7> [147.467935] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [147.468346] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:77:pipe A] fastset requirement not met, forcing full modeset
<7> [147.468770] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:77:pipe A] releasing PORT PLL B
<7> [147.470139] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:77:pipe A] dbuf slices 0x1 -> 0x0, ddb (0 - 510) -> (0 - 0), active pipes 0x5 -> 0x4
<7> [147.470639] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:163:pipe C] dbuf slices 0x1 -> 0x1, ddb (510 - 1020) -> (0 - 1020), active pipes 0x5 -> 0x4
<7> [147.471341] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:71:cursor A] ddb ( 497 - 510) -> ( 0 - 0), size 13 -> 0
<7> [147.471769] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:157:cursor C] ddb (1007 - 1020) -> ( 988 - 1020), size 13 -> 32
<7> [147.472277] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:77:pipe A] min cdclk: 192000 kHz -> 0 kHz
<7> [147.472755] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:77:pipe A] enable: no [modeset]
<7> [147.473170] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:35:plane 1A] fb: [NOFB], visible: no
<7> [147.473580] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:44:plane 2A] fb: [NOFB], visible: no
<7> [147.474070] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [147.474534] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:62:plane 4A] fb: [NOFB], visible: no
<7> [147.474975] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:71:cursor A] fb: [NOFB], visible: no
<7> [147.475824] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:165:HDMI-A-1][ENCODER:164:DDI B/PHY B] Disable audio codec on [CRTC:77:pipe A]
<7> [147.497690] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port B
<7> [147.498484] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [147.511180] i915 0000:00:02.0: [drm:intel_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x10
<7> [147.515746] i915 0000:00:02.0: [drm:intel_ddi_disable_transcoder_func [i915]] Quirk Increase DDI disabled time
<7> [147.617167] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [147.618588] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PORT PLL B (active 0x1, on? 1) for [CRTC:77:pipe A]
<7> [147.621014] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PORT PLL B
<7> [147.621485] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:164:DDI B/PHY B]
<7> [147.622537] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:174:DDI C/PHY C]
<7> [147.623043] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:165:HDMI-A-1]
<7> [147.627115] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling dpio-common-b
<7> [147.628406] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:77:pipe A]
<7> [147.630239] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:120:pipe B]
<7> [147.631606] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:163:pipe C]
<7> [147.632034] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.enable (expected yes, found no)
<7> [147.632559] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.active (expected yes, found no)
<7> [147.633071] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in cpu_transcoder (expected 2, found -1)
<7> [147.633485] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in lane_count (expected 4, found 0)
<7> [147.633980] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in lane_lat_optim_mask (expected 0x0000000d, found 0x00000000)
<7> [147.634453] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [147.634913] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [147.635325] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [147.635727] azx_init_pci: snd_hda_intel 0000:00:0e.0: Clearing TCSEL
<7> [147.635744] azx_init_pci: snd_hda_intel 0000:00:0e.0: SCH snoop: Enabled
<7> [147.635772] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [147.636189] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [147.636598] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [147.637043] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [147.637453] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [147.637886] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [147.638298] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [147.638738] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [147.639151] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [147.639565] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [147.640004] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [147.640413] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [147.640857] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [147.641268] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [147.641700] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [147.642109] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [147.642518] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [147.642945] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [147.643354] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [147.643777] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [147.644187] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [147.644594] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [147.645027] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [147.645436] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [147.645859] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [147.646267] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [147.646692] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [147.647104] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [147.647516] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [147.647942] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [147.648351] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [147.648779] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in port_clock (expected 222750, found 0)
<7> [147.649189] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [147.649598] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [147.650023] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in avi infoframe
<7> [147.650433] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [147.650860] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [147.650865] i915 0000:00:02.0: colorspace: RGB
<7> [147.650869] i915 0000:00:02.0: scan mode: Underscan
<7> [147.650872] i915 0000:00:02.0: colorimetry: No Data
<7> [147.650876] i915 0000:00:02.0: picture aspect: No Data
<7> [147.650879] i915 0000:00:02.0: active aspect: Same as Picture
<7> [147.650882] i915 0000:00:02.0: itc: No Data
<7> [147.650886] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [147.650889] i915 0000:00:02.0: quantization range: Full
<7> [147.650892] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [147.650896] i915 0000:00:02.0: video code: 0
<7> [147.650899] i915 0000:00:02.0: ycc quantization range: Full
<7> [147.650902] i915 0000:00:02.0: hdmi content type: Graphics
<7> [147.650905] i915 0000:00:02.0: pixel repeat: 0
<7> [147.650908] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [147.650912] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [147.651319] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in spd infoframe
<7> [147.651739] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [147.652146] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [147.652150] i915 0000:00:02.0: vendor: Intel
<7> [147.652154] i915 0000:00:02.0: product: Integrated gfx
<7> [147.652157] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [147.652161] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [147.652568] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hdmi infoframe
<7> [147.652994] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [147.653402] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [147.653408] i915 0000:00:02.0: empty frame
<7> [147.653412] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [147.653834] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:163:pipe C] fastset requirement not met, forcing full modeset
<7> [147.654246] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:163:pipe C] releasing PORT PLL C
<7> [147.655541] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:163:pipe C] dbuf slices 0x1 -> 0x0, ddb (0 - 1020) -> (0 - 0), active pipes 0x4 -> 0x0
<7> [147.656091] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:157:cursor C] ddb ( 988 - 1020) -> ( 0 - 0), size 32 -> 0
<7> [147.656568] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:163:pipe C] min cdclk: 192000 kHz -> 0 kHz
<7> [147.657014] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:163:pipe C] enable: no [modeset]
<7> [147.657428] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:121:plane 1C] fb: [NOFB], visible: no
<7> [147.657852] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:130:plane 2C] fb: [NOFB], visible: no
<7> [147.658262] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:139:plane 3C] fb: [NOFB], visible: no
<7> [147.658690] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:148:plane 4C] fb: [NOFB], visible: no
<7> [147.659096] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:157:cursor C] fb: [NOFB], visible: no
<7> [147.660002] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:175:HDMI-A-2][ENCODER:174:DDI C/PHY C] Disable audio codec on [CRTC:163:pipe C]
<7> [147.693758] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port C
<7> [147.694409] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe C
<7> [147.711723] i915 0000:00:02.0: [drm:intel_ddi_disable_transcoder_func [i915]] Quirk Increase DDI disabled time
<7> [147.817141] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_C
<7> [147.818561] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PORT PLL C (active 0x4, on? 1) for [CRTC:163:pipe C]
<7> [147.820765] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PORT PLL C
<7> [147.821202] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:164:DDI B/PHY B]
<7> [147.821611] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:174:DDI C/PHY C]
<7> [147.822223] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:175:HDMI-A-2]
<7> [147.823024] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling dpio-common-c
<7> [147.823498] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:163:pipe C]
<7> [147.824864] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:163:pipe C]
<7> [147.824778] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change
<7> [147.825306] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 79200 kHz, actual 79200 kHz
<7> [147.825734] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 4, actual 4
<7> [147.826554] 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> [147.828536] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:175:HDMI-A-2]
<7> [147.828773] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [147.829354] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:163:pipe C] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [147.829820] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:174:DDI C/PHY C] [CRTC:163:pipe C]
<7> [147.830316] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.enable (expected no, found yes)
<7> [147.830783] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.active (expected no, found yes)
<7> [147.831194] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in cpu_transcoder (expected -1, found 2)
<7> [147.831603] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in lane_count (expected 0, found 4)
<7> [147.832058] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in lane_lat_optim_mask (expected 0x00000000, found 0x0000000d)
<7> [147.832471] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [147.832936] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [147.833351] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [147.833792] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [147.834202] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [147.834610] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [147.835062] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [147.835471] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [147.835908] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [147.836322] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [147.836760] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [147.837168] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [147.837576] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [147.838007] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [147.838415] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [147.838850] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [147.839259] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [147.839689] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [147.840098] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [147.840506] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [147.840944] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [147.841353] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [147.841784] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [147.842192] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [147.842605] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [147.843045] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [147.843457] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [147.843884] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [147.844294] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [147.844731] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [147.845143] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [147.845554] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [147.845986] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [147.846395] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [147.846830] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in port_clock (expected 0, found 222750)
<7> [147.847239] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [147.847648] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)
<7> [147.848080] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in avi infoframe
<7> [147.848494] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [147.848932] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [147.849339] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [147.849346] i915 0000:00:02.0: colorspace: RGB
<7> [147.849350] i915 0000:00:02.0: scan mode: Underscan
<7> [147.849353] i915 0000:00:02.0: colorimetry: No Data
<7> [147.849356] i915 0000:00:02.0: picture aspect: No Data
<7> [147.849360] i915 0000:00:02.0: active aspect: Same as Picture
<7> [147.849363] i915 0000:00:02.0: itc: No Data
<7> [147.849366] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [147.849370] i915 0000:00:02.0: quantization range: Full
<7> [147.849373] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [147.849376] i915 0000:00:02.0: video code: 0
<7> [147.849379] i915 0000:00:02.0: ycc quantization range: Full
<7> [147.849382] i915 0000:00:02.0: hdmi content type: Graphics
<7> [147.849385] i915 0000:00:02.0: pixel repeat: 0
<7> [147.849388] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [147.849392] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in spd infoframe
<7> [147.849824] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [147.850232] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [147.850638] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [147.850642] i915 0000:00:02.0: vendor: Intel
<7> [147.850645] i915 0000:00:02.0: product: Integrated gfx
<7> [147.850648] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [147.850652] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hdmi infoframe
<7> [147.851086] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [147.851494] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [147.851923] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [147.851928] i915 0000:00:02.0: empty frame
<7> [147.851933] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:163:pipe C] fastset requirement not met, forcing full modeset
<7> [147.852523] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:163:pipe C] dbuf slices 0x0 -> 0x1, ddb (0 - 0) -> (0 - 1020), active pipes 0x0 -> 0x4
<7> [147.853049] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:121:plane 1C] ddb ( 0 - 0) -> ( 0 - 988), size 0 -> 988
<7> [147.853456] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:157:cursor C] ddb ( 0 - 0) -> ( 988 - 1020), size 0 -> 32
<7> [147.853878] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:121:plane 1C] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [147.854280] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:121:plane 1C] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 1, 1, 2, 2, 2, 2, 2, 0, 0, 0
<7> [147.854712] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:121:plane 1C] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 16, 16, 33, 33, 33, 33, 33, 30, 0, 0
<7> [147.855118] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:121:plane 1C] 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> [147.855611] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:163:pipe C] min cdclk: 0 kHz -> 192000 kHz
<7> [147.856080] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 18563 kHz -> 9282 kHz
<7> [147.856533] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Modeset required for cdclk change
<7> [147.856982] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 316800 kHz, actual 316800 kHz
<7> [147.857388] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 13, actual 13
<7> [147.857820] i915 0000:00:02.0: [drm:bxt_get_dpll [i915]] [CRTC:163:pipe C] using pre-allocated PORT PLL C
<7> [147.858305] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:163:pipe C] reserving PORT PLL C
<7> [147.858751] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:163:pipe C] enable: yes [modeset]
<7> [147.859263] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [147.859712] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: C, pipe bpp: 36, dithering: 0
<7> [147.860120] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [147.860527] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [147.860967] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [147.861375] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [147.861806] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [147.862216] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x6
<7> [147.862621] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [147.862625] i915 0000:00:02.0: colorspace: RGB
<7> [147.862628] i915 0000:00:02.0: scan mode: Underscan
<7> [147.862632] i915 0000:00:02.0: colorimetry: No Data
<7> [147.862635] i915 0000:00:02.0: picture aspect: No Data
<7> [147.862639] i915 0000:00:02.0: active aspect: Same as Picture
<7> [147.862642] i915 0000:00:02.0: itc: No Data
<7> [147.862645] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [147.862649] i915 0000:00:02.0: quantization range: Full
<7> [147.862652] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [147.862655] i915 0000:00:02.0: video code: 0
<7> [147.862658] i915 0000:00:02.0: ycc quantization range: Full
<7> [147.862692] i915 0000:00:02.0: hdmi content type: Graphics
<7> [147.862696] i915 0000:00:02.0: pixel repeat: 0
<7> [147.862700] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [147.862704] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [147.862708] i915 0000:00:02.0: vendor: Intel
<7> [147.862711] i915 0000:00:02.0: product: Integrated gfx
<7> [147.862715] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [147.862718] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [147.862722] i915 0000:00:02.0: empty frame
<7> [147.862725] 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> [147.863135] 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> [147.863544] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [147.863976] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [147.864385] 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> [147.864820] 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> [147.865228] 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> [147.865634] 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> [147.866070] 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> [147.866482] 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> [147.866915] 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> [147.867323] 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> [147.867760] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 222750, pipe src: 1920x1080+0+0, pixel rate 148500, min cdclk 192000
<7> [147.868168] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [147.868578] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 1, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [147.869003] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [147.869413] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [147.869846] 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> [147.870257] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [147.870687] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [147.871095] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [147.871500] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [147.871934] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [147.872341] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [147.872768] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [147.873175] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [147.873580] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:121:plane 1C] fb: [FB:178] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [147.874018] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [147.874424] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [147.874851] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:130:plane 2C] fb: [NOFB], visible: no
<7> [147.875264] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:139:plane 3C] fb: [NOFB], visible: no
<7> [147.875697] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:148:plane 4C] fb: [NOFB], visible: no
<7> [147.876107] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:157:cursor C] fb: [NOFB], visible: no
<7> [147.877329] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling dpio-common-c
<7> [147.878194] 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> [147.878685] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:164:DDI B/PHY B]
<7> [147.879095] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:174:DDI C/PHY C]
<7> [147.879651] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable PORT PLL C (active 0x4, on? 0) for [CRTC:163:pipe C]
<7> [147.880100] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling PORT PLL C
<7> [147.880712] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_C
<7> [147.881224] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe C
<7> [147.898852] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:175:HDMI-A-2][ENCODER:174:DDI C/PHY C] Enable audio codec on [CRTC:163:pipe C], 32 bytes ELD
<7> [147.915504] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [147.916001] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N
<7> [147.916583] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:175:HDMI-A-2]
<7> [147.917224] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:163:pipe C]
<7> [147.919385] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:120:pipe B]
<7> [147.919447] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:165:HDMI-A-1]
<7> [147.919763] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [147.920304] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:120:pipe B] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [147.920761] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:164:DDI B/PHY B] [CRTC:120:pipe B]
<7> [147.921208] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [147.921659] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [147.922101] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [147.922512] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [147.922960] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in lane_lat_optim_mask (expected 0x00000000, found 0x0000000d)
<7> [147.923371] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [147.923816] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [147.924226] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [147.924634] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [147.925071] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [147.925481] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [147.925928] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [147.926338] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [147.926776] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [147.927185] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [147.927593] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [147.928047] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [147.928455] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [147.928896] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [147.929306] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [147.929751] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [147.930161] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [147.930569] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [147.931004] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [147.931412] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [147.931846] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [147.932255] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [147.932687] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [147.933096] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [147.933504] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [147.933937] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [147.934346] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [147.934771] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [147.935179] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [147.935586] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [147.936014] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [147.936423] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [147.936846] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [147.937255] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [147.937677] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in port_clock (expected 0, found 222750)
<7> [147.938085] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [147.938493] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)
<7> [147.938924] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in avi infoframe
<7> [147.939331] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [147.939753] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [147.940160] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [147.940165] i915 0000:00:02.0: colorspace: RGB
<7> [147.940168] i915 0000:00:02.0: scan mode: Underscan
<7> [147.940171] i915 0000:00:02.0: colorimetry: No Data
<7> [147.940175] i915 0000:00:02.0: picture aspect: No Data
<7> [147.940178] i915 0000:00:02.0: active aspect: Same as Picture
<7> [147.940181] i915 0000:00:02.0: itc: No Data
<7> [147.940184] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [147.940188] i915 0000:00:02.0: quantization range: Full
<7> [147.940191] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [147.940194] i915 0000:00:02.0: video code: 0
<7> [147.940197] i915 0000:00:02.0: ycc quantization range: Full
<7> [147.940200] i915 0000:00:02.0: hdmi content type: Graphics
<7> [147.940203] i915 0000:00:02.0: pixel repeat: 0
<7> [147.940206] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [147.940210] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in spd infoframe
<7> [147.940617] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [147.941049] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [147.941456] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [147.941460] i915 0000:00:02.0: vendor: Intel
<7> [147.941463] i915 0000:00:02.0: product: Integrated gfx
<7> [147.941466] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [147.941470] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:120:pipe B] fastset requirement not met in hdmi infoframe
<7> [147.941892] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [147.942299] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [147.942728] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [147.942732] i915 0000:00:02.0: empty frame
<7> [147.942736] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:120:pipe B] fastset requirement not met, forcing full modeset
<7> [147.943297] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:120:pipe B] dbuf slices 0x0 -> 0x1, ddb (0 - 0) -> (0 - 510), active pipes 0x4 -> 0x6
<7> [147.943767] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:163:pipe C] dbuf slices 0x1 -> 0x1, ddb (0 - 1020) -> (510 - 1020), active pipes 0x4 -> 0x6
<7> [147.944243] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:78:plane 1B] ddb ( 0 - 0) -> ( 0 - 497), size 0 -> 497
<7> [147.944643] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:114:cursor B] ddb ( 0 - 0) -> ( 497 - 510), size 0 -> 13
<7> [147.945071] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78: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> [147.945476] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78: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> [147.945894] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78: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> [147.946296] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78: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> [147.946721] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:121:plane 1C] ddb ( 0 - 988) -> ( 510 - 1007), size 988 -> 497
<7> [147.947120] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:157:cursor C] ddb ( 988 - 1020) -> (1007 - 1020), size 32 -> 13
<7> [147.947630] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:120:pipe B] min cdclk: 0 kHz -> 192000 kHz
<7> [147.948091] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 9282 kHz -> 18563 kHz
<7> [147.948503] i915 0000:00:02.0: [drm:bxt_get_dpll [i915]] [CRTC:120:pipe B] using pre-allocated PORT PLL B
<7> [147.949000] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:120:pipe B] reserving PORT PLL B
<7> [147.949419] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:120:pipe B] enable: yes [modeset]
<7> [147.949854] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [147.950315] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 36, dithering: 0
<7> [147.950753] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [147.951160] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [147.951565] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [147.951995] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [147.952402] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [147.952834] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x6
<7> [147.953241] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [147.953245] i915 0000:00:02.0: colorspace: RGB
<7> [147.953248] i915 0000:00:02.0: scan mode: Underscan
<7> [147.953252] i915 0000:00:02.0: colorimetry: No Data
<7> [147.953255] i915 0000:00:02.0: picture aspect: No Data
<7> [147.953258] i915 0000:00:02.0: active aspect: Same as Picture
<7> [147.953261] i915 0000:00:02.0: itc: No Data
<7> [147.953264] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [147.953267] i915 0000:00:02.0: quantization range: Full
<7> [147.953270] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [147.953273] i915 0000:00:02.0: video code: 0
<7> [147.953276] i915 0000:00:02.0: ycc quantization range: Full
<7> [147.953279] i915 0000:00:02.0: hdmi content type: Graphics
<7> [147.953283] i915 0000:00:02.0: pixel repeat: 0
<7> [147.953286] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [147.953289] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [147.953293] i915 0000:00:02.0: vendor: Intel
<7> [147.953296] i915 0000:00:02.0: product: Integrated gfx
<7> [147.953299] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [147.953302] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [147.953306] i915 0000:00:02.0: empty frame
<7> [147.953309] 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> [147.953753] 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> [147.954160] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [147.954566] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [147.954998] 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> [147.955406] 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> [147.955827] 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> [147.956234] 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> [147.956641] 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> [147.957070] 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> [147.957480] 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> [147.957903] 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> [147.958312] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 222750, pipe src: 1920x1080+0+0, pixel rate 148500, min cdclk 192000
<7> [147.958739] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [147.959146] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [147.959553] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [147.959974] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [147.960381] 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> [147.960812] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [147.961218] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [147.961633] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [147.962053] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [147.962460] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [147.962887] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [147.963294] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [147.963716] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [147.964123] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:78:plane 1B] fb: [FB:178] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [147.964530] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [147.964958] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [147.965370] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:87:plane 2B] fb: [NOFB], visible: no
<7> [147.965795] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:96:plane 3B] fb: [NOFB], visible: no
<7> [147.966204] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:105:plane 4B] fb: [NOFB], visible: no
<7> [147.966612] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:114:cursor B] fb: [NOFB], visible: no
<7> [147.967483] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling dpio-common-b
<7> [147.968261] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:164:DDI B/PHY B]
<7> [147.968696] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:174:DDI C/PHY C]
<7> [147.982251] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable PORT PLL B (active 0x2, on? 0) for [CRTC:120:pipe B]
<7> [147.982783] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling PORT PLL B
<7> [147.983327] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [147.984266] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B
<7> [148.002250] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:165:HDMI-A-1][ENCODER:164:DDI B/PHY B] Enable audio codec on [CRTC:120:pipe B], 32 bytes ELD
<7> [148.018908] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [148.019374] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N
<7> [148.020349] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:165:HDMI-A-1]
<7> [148.021339] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:120:pipe B]
<6> [157.702306] [IGT] kms_flip: finished subtest BC-HDMI-A1-HDMI-A2, FAIL
<6> [157.702979] [IGT] kms_flip: finished subtest 2x-flip-vs-expired-vblank, FAIL
<7> [157.724878] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:184] from all active usage due to RMFB ioctl
<7> [157.726005] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:78:plane 1B] because [FB:184] is removed
<7> [157.726064] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:121:plane 1C] because [FB:184] is removed
<7> [157.726170] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:78:plane 1B] ddb ( 0 - 497) -> ( 0 - 0), size 497 -> 0
<7> [157.726677] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78: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> [157.727141] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78: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> [157.727547] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78: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> [157.728003] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78: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> [157.728410] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:121:plane 1C] ddb ( 510 - 1007) -> ( 0 - 0), size 497 -> 0
<7> [157.728903] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:121:plane 1C] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [157.729307] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:121:plane 1C] lines 1, 1, 1, 2, 2, 2, 2, 2, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [157.729711] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:121:plane 1C] blocks 16, 16, 16, 33, 33, 33, 33, 33, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [157.730220] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:121:plane 1C] min_ddb 17, 17, 17, 34, 34, 34, 34, 34, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<6> [157.739215] [IGT] kms_flip: exiting, ret=98
<7> [157.783083] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [157.783655] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:77:pipe A] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [157.784250] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 12 bpc for HDMI output (pipe bpp: 36)
<7> [157.784700] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:120:pipe B] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [157.785289] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:164:DDI B/PHY B] [CRTC:77:pipe A]
<7> [157.785692] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:174:DDI C/PHY C] [CRTC:120:pipe B]
<7> [157.786395] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [157.786851] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [157.787338] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [157.787802] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [157.788214] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in lane_lat_optim_mask (expected 0x00000000, found 0x0000000d)
<7> [157.788624] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [157.789086] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [157.789497] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [157.789981] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [157.790392] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [157.790839] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [157.791249] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [157.791658] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [157.792134] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [157.792545] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [157.792984] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1083)
<7> [157.793396] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1088)
<7> [157.793833] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [157.794244] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [157.794653] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [157.795102] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [157.795513] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [157.795959] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [157.796370] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [157.796813] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [157.797224] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [157.797633] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [157.798072] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1083)
<7> [157.798481] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1088)
<7> [157.798914] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [157.799325] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [157.799766] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [157.800176] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [157.800584] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [157.801014] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in has_hdmi_sink (expected no, found yes)
<7> [157.801425] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in has_infoframe (expected no, found yes)
<7> [157.801861] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [157.802273] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [157.802683] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [157.803113] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in port_clock (expected 0, found 222750)
<7> [157.803523] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000000, found 0x00000071)
<7> [157.803959] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in infoframes.gcp (expected 0x00000000, found 0x00000006)
<7> [157.804369] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in avi infoframe
<7> [157.804801] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [157.805210] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [157.805618] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [157.805623] i915 0000:00:02.0: colorspace: RGB
<7> [157.805628] i915 0000:00:02.0: scan mode: Underscan
<7> [157.805631] i915 0000:00:02.0: colorimetry: No Data
<7> [157.805636] i915 0000:00:02.0: picture aspect: No Data
<7> [157.805639] i915 0000:00:02.0: active aspect: Same as Picture
<7> [157.805643] i915 0000:00:02.0: itc: No Data
<7> [157.805647] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [157.805651] i915 0000:00:02.0: quantization range: Full
<7> [157.805655] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [157.805658] i915 0000:00:02.0: video code: 0
<7> [157.805662] i915 0000:00:02.0: ycc quantization range: Full
<7> [157.805666] i915 0000:00:02.0: hdmi content type: Graphics
<7> [157.805670] i915 0000:00:02.0: pixel repeat: 0
<7> [157.805673] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [157.805678] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in spd infoframe
<7> [157.806118] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [157.806526] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [157.806953] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [157.806959] i915 0000:00:02.0: vendor: Intel
<7> [157.806963] i915 0000:00:02.0: product: Integrated gfx
<7> [157.806967] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [157.806971] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:77:pipe A] fastset requirement not met in hdmi infoframe
<7> [157.807380] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [157.807815] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [157.808224] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [157.808229] i915 0000:00:02.0: empty frame
<7> [157.808235] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:77:pipe A] fastset requirement not met, forcing full modeset
<7> [157.808647] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.enable (expected yes, found no)
<7> [157.809078] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.active (expected yes, found no)
<7> [157.809488] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in cpu_transcoder (expected 2, found -1)
<7> [157.809931] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in lane_count (expected 4, found 0)
<7> [157.810342] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in lane_lat_optim_mask (expected 0x0000000d, found 0x00000000)
<7> [157.810774] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [157.811184] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [157.811593] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [157.812030] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [157.812441] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [157.812874] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [157.813285] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [157.813694] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [157.814127] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [157.814536] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [157.814964] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1083, found 0)
<7> [157.815373] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1088, found 0)
<7> [157.815812] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [157.816223] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [157.816630] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [157.817067] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [157.817478] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [157.817915] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [157.818325] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [157.818754] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [157.819162] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [157.819569] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [157.820012] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1083, found 0)
<7> [157.820424] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1088, found 0)
<7> [157.820857] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [157.821268] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [157.821676] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [157.822112] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [157.822521] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [157.822958] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [157.823368] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [157.823803] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [157.824215] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [157.824623] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [157.825058] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in port_clock (expected 222750, found 0)
<7> [157.825468] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [157.825903] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [157.826313] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in avi infoframe
<7> [157.826741] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [157.827151] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [157.827155] i915 0000:00:02.0: colorspace: RGB
<7> [157.827159] i915 0000:00:02.0: scan mode: Underscan
<7> [157.827163] i915 0000:00:02.0: colorimetry: No Data
<7> [157.827166] i915 0000:00:02.0: picture aspect: No Data
<7> [157.827170] i915 0000:00:02.0: active aspect: Same as Picture
<7> [157.827174] i915 0000:00:02.0: itc: No Data
<7> [157.827177] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [157.827181] i915 0000:00:02.0: quantization range: Full
<7> [157.827184] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [157.827188] i915 0000:00:02.0: video code: 0
<7> [157.827192] i915 0000:00:02.0: ycc quantization range: Full
<7> [157.827195] i915 0000:00:02.0: hdmi content type: Graphics
<7> [157.827199] i915 0000:00:02.0: pixel repeat: 0
<7> [157.827202] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [157.827207] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [157.827613] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in spd infoframe
<7> [157.828041] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [157.828451] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [157.828455] i915 0000:00:02.0: vendor: Intel
<7> [157.828459] i915 0000:00:02.0: product: Integrated gfx
<7> [157.828463] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [157.828467] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [157.828906] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:163:pipe C] fastset requirement not met in hdmi infoframe
<7> [157.829316] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [157.829749] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [157.829754] i915 0000:00:02.0: empty frame
<7> [157.829757] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [157.830166] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:163:pipe C] fastset requirement not met, forcing full modeset
<7> [157.830579] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:120:pipe B] releasing PORT PLL B
<7> [157.831017] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:163:pipe C] releasing PORT PLL C
<7> [157.832806] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:77:pipe A] dbuf slices 0x0 -> 0x1, ddb (0 - 0) -> (0 - 510), active pipes 0x6 -> 0x3
<7> [157.833398] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:120:pipe B] dbuf slices 0x1 -> 0x1, ddb (0 - 510) -> (510 - 1020), active pipes 0x6 -> 0x3
<7> [157.833912] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:163:pipe C] dbuf slices 0x1 -> 0x0, ddb (510 - 1020) -> (0 - 0), active pipes 0x6 -> 0x3
<7> [157.834349] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:35:plane 1A] ddb ( 0 - 0) -> ( 0 - 497), size 0 -> 497
<7> [157.834771] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:71:cursor A] ddb ( 0 - 0) -> ( 497 - 510), size 0 -> 13
<7> [157.835175] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:35:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [157.835577] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:35: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> [157.836039] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:35: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> [157.836443] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:35: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> [157.836885] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:78:plane 1B] ddb ( 0 - 0) -> ( 510 - 1007), size 0 -> 497
<7> [157.837287] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:114:cursor B] ddb ( 497 - 510) -> (1007 - 1020), size 13 -> 13
<7> [157.837687] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78: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> [157.838120] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78: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> [157.838524] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78: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> [157.838950] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:78: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> [157.839354] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:157:cursor C] ddb (1007 - 1020) -> ( 0 - 0), size 13 -> 0
<7> [157.839973] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:77:pipe A] min cdclk: 0 kHz -> 192000 kHz
<7> [157.840430] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:163:pipe C] min cdclk: 192000 kHz -> 0 kHz
<7> [157.840989] i915 0000:00:02.0: [drm:bxt_get_dpll [i915]] [CRTC:77:pipe A] using pre-allocated PORT PLL B
<7> [157.841421] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:77:pipe A] reserving PORT PLL B
<7> [157.841957] i915 0000:00:02.0: [drm:bxt_get_dpll [i915]] [CRTC:120:pipe B] using pre-allocated PORT PLL C
<7> [157.842366] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:120:pipe B] reserving PORT PLL C
<7> [157.842802] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:77:pipe A] enable: yes [modeset]
<7> [157.843213] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [157.843622] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 36, dithering: 0
<7> [157.844066] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [157.844473] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [157.844907] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [157.845315] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [157.845753] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [157.846161] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x6
<7> [157.846566] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [157.846572] i915 0000:00:02.0: colorspace: RGB
<7> [157.846576] i915 0000:00:02.0: scan mode: Underscan
<7> [157.846580] i915 0000:00:02.0: colorimetry: No Data
<7> [157.846584] i915 0000:00:02.0: picture aspect: No Data
<7> [157.846588] i915 0000:00:02.0: active aspect: Same as Picture
<7> [157.846591] i915 0000:00:02.0: itc: No Data
<7> [157.846595] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [157.846599] i915 0000:00:02.0: quantization range: Full
<7> [157.846603] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [157.846606] i915 0000:00:02.0: video code: 0
<7> [157.846610] i915 0000:00:02.0: ycc quantization range: Full
<7> [157.846613] i915 0000:00:02.0: hdmi content type: Graphics
<7> [157.846617] i915 0000:00:02.0: pixel repeat: 0
<7> [157.846621] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [157.846625] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [157.846629] i915 0000:00:02.0: vendor: Intel
<7> [157.846633] i915 0000:00:02.0: product: Integrated gfx
<7> [157.846636] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [157.846641] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [157.846645] i915 0000:00:02.0: empty frame
<7> [157.846649] 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> [157.847086] 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> [157.847495] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [157.847921] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [157.848331] 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> [157.848775] 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> [157.849183] 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> [157.849589] 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> [157.850018] 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> [157.850428] 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> [157.850870] 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> [157.851280] 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> [157.851689] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 222750, pipe src: 1920x1080+0+0, pixel rate 148500, min cdclk 192000
<7> [157.852117] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [157.852525] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [157.852963] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [157.853372] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [157.853800] 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> [157.854212] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [157.854618] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [157.855051] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [157.855458] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [157.855886] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [157.856293] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [157.856698] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [157.857138] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [157.857545] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:35:plane 1A] fb: [FB:180] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [157.857977] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [157.858384] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [157.858826] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:44:plane 2A] fb: [NOFB], visible: no
<7> [157.859236] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [157.859644] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:62:plane 4A] fb: [NOFB], visible: no
<7> [157.860076] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:71:cursor A] fb: [NOFB], visible: no
<7> [157.860487] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:120:pipe B] enable: yes [modeset]
<7> [157.860924] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [157.861331] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 36, dithering: 0
<7> [157.861760] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [157.862166] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [157.862573] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [157.863006] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [157.863413] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 1, infoframes: 1, infoframes enabled: 0x71
<7> [157.863840] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] GCP: 0x6
<7> [157.864247] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [157.864251] i915 0000:00:02.0: colorspace: RGB
<7> [157.864255] i915 0000:00:02.0: scan mode: Underscan
<7> [157.864259] i915 0000:00:02.0: colorimetry: No Data
<7> [157.864262] i915 0000:00:02.0: picture aspect: No Data
<7> [157.864266] i915 0000:00:02.0: active aspect: Same as Picture
<7> [157.864270] i915 0000:00:02.0: itc: No Data
<7> [157.864273] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [157.864277] i915 0000:00:02.0: quantization range: Full
<7> [157.864280] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [157.864284] i915 0000:00:02.0: video code: 0
<7> [157.864287] i915 0000:00:02.0: ycc quantization range: Full
<7> [157.864291] i915 0000:00:02.0: hdmi content type: Graphics
<7> [157.864295] i915 0000:00:02.0: pixel repeat: 0
<7> [157.864298] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [157.864303] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [157.864307] i915 0000:00:02.0: vendor: Intel
<7> [157.864310] i915 0000:00:02.0: product: Integrated gfx
<7> [157.864314] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [157.864318] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [157.864323] i915 0000:00:02.0: empty frame
<7> [157.864326] 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> [157.864764] 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> [157.865171] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [157.865577] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [157.866005] 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> [157.866412] 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> [157.866845] 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> [157.867254] 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> [157.867661] 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> [157.868089] 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> [157.868498] 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> [157.868933] 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> [157.869343] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 222750, pipe src: 1920x1080+0+0, pixel rate 148500, min cdclk 192000
<7> [157.869769] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 59, ips linetime: 0
<7> [157.870177] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [157.870584] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [157.871019] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [157.871427] 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> [157.871857] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [157.872265] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [157.872671] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [157.873108] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [157.873516] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [157.873942] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [157.874349] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [157.874785] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [157.875193] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:78:plane 1B] fb: [FB:180] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [157.875603] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [157.876029] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [157.876440] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:87:plane 2B] fb: [NOFB], visible: no
<7> [157.876879] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:96:plane 3B] fb: [NOFB], visible: no
<7> [157.877292] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:105:plane 4B] fb: [NOFB], visible: no
<7> [157.877700] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:114:cursor B] fb: [NOFB], visible: no
<7> [157.878132] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:163:pipe C] enable: no [modeset]
<7> [157.878542] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:121:plane 1C] fb: [NOFB], visible: no
<7> [157.878980] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:130:plane 2C] fb: [NOFB], visible: no
<7> [157.879392] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:139:plane 3C] fb: [NOFB], visible: no
<7> [157.879819] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:148:plane 4C] fb: [NOFB], visible: no
<7> [157.880228] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:157:cursor C] fb: [NOFB], visible: no
<7> [157.881232] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:165:HDMI-A-1][ENCODER:164:DDI B/PHY B] Disable audio codec on [CRTC:120:pipe B]
<7> [157.902205] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port B
<7> [157.902823] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:175:HDMI-A-2][ENCODER:174:DDI C/PHY C] Disable audio codec on [CRTC:163:pipe C]
<7> [157.932177] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port C
<7> [157.933614] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe B
<7> [157.935752] i915 0000:00:02.0: [drm:intel_ddi_disable_transcoder_func [i915]] Quirk Increase DDI disabled time
<7> [158.040826] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [158.041377] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PORT PLL B (active 0x2, on? 1) for [CRTC:120:pipe B]
<7> [158.042457] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PORT PLL B
<7> [158.043048] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe C
<7> [158.048846] i915 0000:00:02.0: [drm:intel_ddi_disable_transcoder_func [i915]] Quirk Increase DDI disabled time
<7> [158.152820] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_C
<7> [158.153372] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable PORT PLL C (active 0x4, on? 1) for [CRTC:163:pipe C]
<7> [158.154453] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling PORT PLL C
<7> [158.154946] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:164:DDI B/PHY B]
<7> [158.155359] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:174:DDI C/PHY C]
<7> [158.156589] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable PORT PLL B (active 0x1, on? 0) for [CRTC:77:pipe A]
<7> [158.157091] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling PORT PLL B
<7> [158.157709] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [158.158346] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [158.160578] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable PORT PLL C (active 0x2, on? 0) for [CRTC:120:pipe B]
<7> [158.161098] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling PORT PLL C
<7> [158.161664] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_C
<7> [158.162675] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B
<7> [158.164515] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 16588800 bytes of contiguous stolen space for FBC, limit: 1
<7> [158.165026] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:35:plane 1A]
<7> [158.180706] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:165:HDMI-A-1][ENCODER:164:DDI B/PHY B] Enable audio codec on [CRTC:77:pipe A], 32 bytes ELD
<7> [158.193753] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [158.194214] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N
<7> [158.194859] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:165:HDMI-A-1]
<7> [158.195470] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:77:pipe A]
<7> [158.197695] i915 0000:00:02.0: [drm:intel_audio_codec_enable [i915]] [CONNECTOR:175:HDMI-A-2][ENCODER:174:DDI C/PHY C] Enable audio codec on [CRTC:120:pipe B], 32 bytes ELD
<7> [158.214025] i915 0000:00:02.0: [drm:audio_config_hdmi_pixel_clock [i915]] Configuring HDMI audio for pixel clock 148500 (0x00090000)
<7> [158.214496] i915 0000:00:02.0: [drm:hsw_audio_config_update [i915]] using automatic N
<7> [158.215537] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:175:HDMI-A-2]
<7> [158.216454] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:120:pipe B]
<7> [158.218437] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:163:pipe C]
<7> [158.221197] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0
Created at 2026-02-13 22:22:48