Results for igt@kms_flip@wf_vblank-ts-check-interruptible

Result: Fail

git-log-oneline i915_display_info21 igt_runner21 runtimes21 results21.json results21-i915-load.json guc_logs21.tar i915_display_info_post_exec21 boot21 dmesg21

DetailValue
Duration 45.34 seconds
Hostname 
shard-rkl-5
Igt-Version 
IGT-Version: 2.3-gc963d01da (x86_64) (Linux: 7.0.0-rc4-CI_DRM_18169-gc479cdf62a3f+ x86_64)
Out 
Using IGT_SRANDOM=1773896598 for randomisation
Opened device: /dev/dri/card0
Using monotonic timestamps
Starting subtest: wf_vblank-ts-check-interruptible
Starting dynamic subtest: A-HDMI-A1
  1920x1080: 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 
Expected frametime: 18974us; measured 18320.1us +- 7.325us accuracy 0.12%
vblank interval differs from modeline! expected 18973.8us, measured 18320us +- 7.325us, difference 653.7us (89.2 sigma)
Event vblank: expected 549, counted 540, passrate = 11.11%, encoder type 2
Expected frametime: 18974us; measured 18865.6us +- 6.693us accuracy 0.11%
vblank interval differs from modeline! expected 18973.8us, measured 18866us +- 6.693us, difference 108.2us (16.2 sigma)
Event vblank: expected 531, counted 530, passrate = 66.04%, encoder type 2
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../tests/kms_flip.c:428 run_test_on_crtc_set.constprop.0()
  #2 ../tests/kms_flip.c:1891 run_test()
  #3 ../tests/kms_flip.c:2162 __igt_unique____real_main2047()
  #4 ../tests/kms_flip.c:2047 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest A-HDMI-A1: FAIL (24.307s)
Starting dynamic subtest: B-HDMI-A1
  1920x1080: 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 
Expected frametime: 18974us; measured 18969.9us +- 6.708us accuracy 0.11%
Event vblank: expected 529, counted 530, passrate = 100.00%, encoder type 2
Dynamic subtest B-HDMI-A1: SUCCESS (10.518s)
Starting dynamic subtest: C-HDMI-A1
  1920x1080: 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 
Expected frametime: 18974us; measured 18967.1us +- 6.323us accuracy 0.10%
Event vblank: expected 529, counted 530, passrate = 100.00%, encoder type 2
Dynamic subtest C-HDMI-A1: SUCCESS (10.503s)
Subtest wf_vblank-ts-check-interruptible: FAIL (45.335s)
Err 
Starting subtest: wf_vblank-ts-check-interruptible
Starting dynamic subtest: A-HDMI-A1
(kms_flip:2242) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1711:
(kms_flip:2242) CRITICAL: Failed assertion: !retried
(kms_flip:2242) CRITICAL: Last errno: 4, Interrupted system call
Dynamic subtest A-HDMI-A1 failed.
**** DEBUG ****
(kms_flip:2242) DEBUG: vblank ts/seq: last 105.902824/695, current 106.088699/705: elapsed=185879.0us expected=183200.6us +- 916.0us, error 1.5%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 105.902824/695, current 106.088699/705: elapsed=185879.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 106.088699
last_received_ts = 106.088097
last_seq = 705
current_ts = 106.274567
current_received_ts = 106.273949
current_seq = 715
count = 18
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 106.088699/705, current 106.274567/715: elapsed=185866.0us expected=183200.6us +- 916.0us, error 1.5%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 106.088699/705, current 106.274567/715: elapsed=185866.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 106.274567
last_received_ts = 106.273949
last_seq = 715
current_ts = 106.460426
current_received_ts = 106.459801
current_seq = 725
count = 19
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 106.274567/715, current 106.460426/725: elapsed=185858.0us expected=183200.6us +- 916.0us, error 1.5%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 106.274567/715, current 106.460426/725: elapsed=185858.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 106.460426
last_received_ts = 106.459801
last_seq = 725
current_ts = 106.646301
current_received_ts = 106.645676
current_seq = 735
count = 20
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 106.460426/725, current 106.646301/735: elapsed=185872.0us expected=183200.6us +- 916.0us, error 1.5%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 106.460426/725, current 106.646301/735: elapsed=185872.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 106.646301
last_received_ts = 106.645676
last_seq = 735
current_ts = 106.832161
current_received_ts = 106.831543
current_seq = 745
count = 21
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 106.646301/735, current 106.832161/745: elapsed=185864.0us expected=183200.6us +- 916.0us, error 1.5%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 106.646301/735, current 106.832161/745: elapsed=185864.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 106.832161
last_received_ts = 106.831543
last_seq = 745
current_ts = 107.018326
current_received_ts = 107.017708
current_seq = 755
count = 22
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 106.832161/745, current 107.018326/755: elapsed=186167.0us expected=183200.6us +- 916.0us, error 1.6%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 106.832161/745, current 107.018326/755: elapsed=186167.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 107.018326
last_received_ts = 107.017708
last_seq = 755
current_ts = 107.204659
current_received_ts = 107.204163
current_seq = 765
count = 23
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 107.018326/755, current 107.204659/765: elapsed=186329.0us expected=183200.6us +- 916.0us, error 1.7%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 107.018326/755, current 107.204659/765: elapsed=186329.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 107.204659
last_received_ts = 107.204163
last_seq = 765
current_ts = 107.391006
current_received_ts = 107.390373
current_seq = 775
count = 24
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 107.204659/765, current 107.391006/775: elapsed=186349.0us expected=183200.6us +- 916.0us, error 1.7%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 107.204659/765, current 107.391006/775: elapsed=186349.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 107.391006
last_received_ts = 107.390373
last_seq = 775
current_ts = 107.577347
current_received_ts = 107.576714
current_seq = 785
count = 25
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 107.391006/775, current 107.577347/785: elapsed=186336.0us expected=183200.6us +- 916.0us, error 1.7%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 107.391006/775, current 107.577347/785: elapsed=186336.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 107.577347
last_received_ts = 107.576714
last_seq = 785
current_ts = 107.763687
current_received_ts = 107.763062
current_seq = 795
count = 26
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 107.577347/785, current 107.763687/795: elapsed=186341.0us expected=183200.6us +- 916.0us, error 1.7%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 107.577347/785, current 107.763687/795: elapsed=186341.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 107.763687
last_received_ts = 107.763062
last_seq = 795
current_ts = 107.950127
current_received_ts = 107.949509
current_seq = 805
count = 27
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 107.763687/795, current 107.950127/805: elapsed=186445.0us expected=183200.6us +- 916.0us, error 1.8%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 107.763687/795, current 107.950127/805: elapsed=186445.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 107.950127
last_received_ts = 107.949509
last_seq = 805
current_ts = 108.136879
current_received_ts = 108.136284
current_seq = 815
count = 28
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 107.950127/805, current 108.136879/815: elapsed=186751.0us expected=183200.6us +- 916.0us, error 1.9%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 107.950127/805, current 108.136879/815: elapsed=186751.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 108.136879
last_received_ts = 108.136284
last_seq = 815
current_ts = 108.323631
current_received_ts = 108.323029
current_seq = 825
count = 29
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 108.136879/815, current 108.323631/825: elapsed=186751.0us expected=183200.6us +- 916.0us, error 1.9%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 108.136879/815, current 108.323631/825: elapsed=186751.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 108.323631
last_received_ts = 108.323029
last_seq = 825
current_ts = 108.510384
current_received_ts = 108.509727
current_seq = 835
count = 30
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 108.323631/825, current 108.510384/835: elapsed=186752.0us expected=183200.6us +- 916.0us, error 1.9%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 108.323631/825, current 108.510384/835: elapsed=186752.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 108.510384
last_received_ts = 108.509727
last_seq = 835
current_ts = 108.697128
current_received_ts = 108.696587
current_seq = 845
count = 31
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 108.510384/835, current 108.697128/845: elapsed=186745.0us expected=183200.6us +- 916.0us, error 1.9%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 108.510384/835, current 108.697128/845: elapsed=186745.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 108.697128
last_received_ts = 108.696587
last_seq = 845
current_ts = 108.883888
current_received_ts = 108.883240
current_seq = 855
count = 32
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 108.697128/845, current 108.883888/855: elapsed=186764.0us expected=183200.6us +- 916.0us, error 1.9%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 108.697128/845, current 108.883888/855: elapsed=186764.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 108.883888
last_received_ts = 108.883240
last_seq = 855
current_ts = 109.070976
current_received_ts = 109.070358
current_seq = 865
count = 33
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 108.883888/855, current 109.070976/865: elapsed=187081.0us expected=183200.6us +- 916.0us, error 2.1%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 108.883888/855, current 109.070976/865: elapsed=187081.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 109.070976
last_received_ts = 109.070358
last_seq = 865
current_ts = 109.258080
current_received_ts = 109.257484
current_seq = 875
count = 34
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 109.070976/865, current 109.258080/875: elapsed=187107.0us expected=183200.6us +- 916.0us, error 2.1%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 109.070976/865, current 109.258080/875: elapsed=187107.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 109.258080
last_received_ts = 109.257484
last_seq = 875
current_ts = 109.445190
current_received_ts = 109.444534
current_seq = 885
count = 35
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 109.258080/875, current 109.445190/885: elapsed=187111.0us expected=183200.6us +- 916.0us, error 2.1%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 109.258080/875, current 109.445190/885: elapsed=187111.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 109.445190
last_received_ts = 109.444534
last_seq = 885
current_ts = 109.632294
current_received_ts = 109.631790
current_seq = 895
count = 36
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 109.445190/885, current 109.632294/895: elapsed=187106.0us expected=183200.6us +- 916.0us, error 2.1%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 109.445190/885, current 109.632294/895: elapsed=187106.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 109.632294
last_received_ts = 109.631790
last_seq = 895
current_ts = 109.819427
current_received_ts = 109.818748
current_seq = 905
count = 37
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 109.632294/895, current 109.819427/905: elapsed=187129.0us expected=183200.6us +- 916.0us, error 2.1%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 109.632294/895, current 109.819427/905: elapsed=187129.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 109.819427
last_received_ts = 109.818748
last_seq = 905
current_ts = 110.006714
current_received_ts = 110.006065
current_seq = 915
count = 38
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 109.819427/905, current 110.006714/915: elapsed=187286.0us expected=183200.6us +- 916.0us, error 2.2%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 109.819427/905, current 110.006714/915: elapsed=187286.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 110.006714
last_received_ts = 110.006065
last_seq = 915
current_ts = 110.194138
current_received_ts = 110.193520
current_seq = 925
count = 39
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 110.006714/915, current 110.194138/925: elapsed=187426.0us expected=183200.6us +- 916.0us, error 2.3%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 110.006714/915, current 110.194138/925: elapsed=187426.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 110.194138
last_received_ts = 110.193520
last_seq = 925
current_ts = 110.381569
current_received_ts = 110.380951
current_seq = 935
count = 40
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 110.194138/925, current 110.381569/935: elapsed=187433.0us expected=183200.6us +- 916.0us, error 2.3%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 110.194138/925, current 110.381569/935: elapsed=187433.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 110.381569
last_received_ts = 110.380951
last_seq = 935
current_ts = 110.569000
current_received_ts = 110.568489
current_seq = 945
count = 41
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 110.381569/935, current 110.569000/945: elapsed=187430.0us expected=183200.6us +- 916.0us, error 2.3%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 110.381569/935, current 110.569000/945: elapsed=187430.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 110.569000
last_received_ts = 110.568489
last_seq = 945
current_ts = 110.756424
current_received_ts = 110.755798
current_seq = 955
count = 42
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 110.569000/945, current 110.756424/955: elapsed=187426.0us expected=183200.6us +- 916.0us, error 2.3%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 110.569000/945, current 110.756424/955: elapsed=187426.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 110.756424
last_received_ts = 110.755798
last_seq = 955
current_ts = 110.943924
current_received_ts = 110.943275
current_seq = 965
count = 43
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 110.756424/955, current 110.943924/965: elapsed=187498.0us expected=183200.6us +- 916.0us, error 2.3%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 110.756424/955, current 110.943924/965: elapsed=187498.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 110.943924
last_received_ts = 110.943275
last_seq = 965
current_ts = 111.131630
current_received_ts = 111.131042
current_seq = 975
count = 44
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 110.943924/965, current 111.131630/975: elapsed=187702.0us expected=183200.6us +- 916.0us, error 2.5%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 110.943924/965, current 111.131630/975: elapsed=187702.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 111.131630
last_received_ts = 111.131042
last_seq = 975
current_ts = 111.319336
current_received_ts = 111.318779
current_seq = 985
count = 45
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 111.131630/975, current 111.319336/985: elapsed=187708.0us expected=183200.6us +- 916.0us, error 2.5%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 111.131630/975, current 111.319336/985: elapsed=187708.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 111.319336
last_received_ts = 111.318779
last_seq = 985
current_ts = 111.507042
current_received_ts = 111.506401
current_seq = 995
count = 46
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 111.319336/985, current 111.507042/995: elapsed=187706.0us expected=183200.6us +- 916.0us, error 2.5%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 111.319336/985, current 111.507042/995: elapsed=187706.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 111.507042
last_received_ts = 111.506401
last_seq = 995
current_ts = 111.694748
current_received_ts = 111.694160
current_seq = 1005
count = 47
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 111.507042/995, current 111.694748/1005: elapsed=187704.0us expected=183200.6us +- 916.0us, error 2.5%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 111.507042/995, current 111.694748/1005: elapsed=187704.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 111.694748
last_received_ts = 111.694160
last_seq = 1005
current_ts = 111.882454
current_received_ts = 111.881828
current_seq = 1015
count = 48
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 111.694748/1005, current 111.882454/1015: elapsed=187706.0us expected=183200.6us +- 916.0us, error 2.5%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 111.694748/1005, current 111.882454/1015: elapsed=187706.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 111.882454
last_received_ts = 111.881828
last_seq = 1015
current_ts = 112.070374
current_received_ts = 112.069794
current_seq = 1025
count = 49
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 111.882454/1015, current 112.070374/1025: elapsed=187926.0us expected=183200.6us +- 916.0us, error 2.6%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 111.882454/1015, current 112.070374/1025: elapsed=187926.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 112.070374
last_received_ts = 112.069794
last_seq = 1025
current_ts = 112.258324
current_received_ts = 112.257698
current_seq = 1035
count = 50
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 112.070374/1025, current 112.258324/1035: elapsed=187945.0us expected=183200.6us +- 916.0us, error 2.6%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 112.070374/1025, current 112.258324/1035: elapsed=187945.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 112.258324
last_received_ts = 112.257698
last_seq = 1035
current_ts = 112.446274
current_received_ts = 112.445625
current_seq = 1045
count = 51
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 112.258324/1035, current 112.446274/1045: elapsed=187950.0us expected=183200.6us +- 916.0us, error 2.6%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 112.258324/1035, current 112.446274/1045: elapsed=187950.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 112.446274
last_received_ts = 112.445625
last_seq = 1045
current_ts = 112.634216
current_received_ts = 112.633598
current_seq = 1055
count = 52
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 112.446274/1045, current 112.634216/1055: elapsed=187947.0us expected=183200.6us +- 916.0us, error 2.6%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 112.446274/1045, current 112.634216/1055: elapsed=187947.0us expected=183200.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 112.634216
last_received_ts = 112.633598
last_seq = 1055
current_ts = 112.822166
current_received_ts = 112.821510
current_seq = 1065
count = 53
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 112.634216/1055, current 112.822166/1065: elapsed=187944.0us expected=183200.6us +- 916.0us, error 2.6%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 112.634216/1055, current 112.822166/1065: elapsed=187944.0us expected=183200.6us
(kms_flip:2242) INFO: Event vblank: expected 549, counted 540, passrate = 11.11%, encoder type 2
(kms_flip:2242) DEBUG: dropped frames, expected 549, counted 540, passrate = 11.11%, encoder type 2
(kms_flip:2242) DEBUG: Retrying without a hotplug event
(kms_flip:2242) DEBUG: No stale events found
(kms_flip:2242) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0
(kms_flip:2242) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0
(kms_flip:2242) INFO: Expected frametime: 18974us; measured 18865.6us +- 6.693us accuracy 0.11%
(kms_flip:2242) INFO: vblank interval differs from modeline! expected 18973.8us, measured 18866us +- 6.693us, difference 108.2us (16.2 sigma)
(kms_flip:2242) DEBUG: name = vblank
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 116.459389
current_received_ts = 116.458817
current_seq = 1255
count = 0
seq_step = 10
(kms_flip:2242) DEBUG: name = vblank
last_ts = 116.459389
last_received_ts = 116.458817
last_seq = 1255
current_ts = 116.648026
current_received_ts = 116.647461
current_seq = 1265
count = 1
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 116.459389/1255, current 116.648026/1265: elapsed=188639.0us expected=188655.6us +- 943.3us, error 0.0%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 116.648026
last_received_ts = 116.647461
last_seq = 1265
current_ts = 116.836685
current_received_ts = 116.836060
current_seq = 1275
count = 2
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 116.648026/1265, current 116.836685/1275: elapsed=188661.0us expected=188655.6us +- 943.3us, error 0.0%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 116.836685
last_received_ts = 116.836060
last_seq = 1275
current_ts = 117.025414
current_received_ts = 117.024788
current_seq = 1285
count = 3
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 116.836685/1275, current 117.025414/1285: elapsed=188729.0us expected=188655.6us +- 943.3us, error 0.0%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 117.025414
last_received_ts = 117.024788
last_seq = 1285
current_ts = 117.214188
current_received_ts = 117.213539
current_seq = 1295
count = 4
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 117.025414/1285, current 117.214188/1295: elapsed=188774.0us expected=188655.6us +- 943.3us, error 0.1%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 117.214188
last_received_ts = 117.213539
last_seq = 1295
current_ts = 117.402969
current_received_ts = 117.402313
current_seq = 1305
count = 5
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 117.214188/1295, current 117.402969/1305: elapsed=188777.0us expected=188655.6us +- 943.3us, error 0.1%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 117.402969
last_received_ts = 117.402313
last_seq = 1305
current_ts = 117.591736
current_received_ts = 117.591118
current_seq = 1315
count = 6
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 117.402969/1305, current 117.591736/1315: elapsed=188768.0us expected=188655.6us +- 943.3us, error 0.1%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 117.591736
last_received_ts = 117.591118
last_seq = 1315
current_ts = 117.780510
current_received_ts = 117.779884
current_seq = 1325
count = 7
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 117.591736/1315, current 117.780510/1325: elapsed=188777.0us expected=188655.6us +- 943.3us, error 0.1%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 117.780510
last_received_ts = 117.779884
last_seq = 1325
current_ts = 117.969322
current_received_ts = 117.968704
current_seq = 1335
count = 8
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 117.780510/1325, current 117.969322/1335: elapsed=188812.0us expected=188655.6us +- 943.3us, error 0.1%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 117.969322
last_received_ts = 117.968704
last_seq = 1335
current_ts = 118.158211
current_received_ts = 118.157585
current_seq = 1345
count = 9
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 117.969322/1335, current 118.158211/1345: elapsed=188884.0us expected=188655.6us +- 943.3us, error 0.1%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 118.158211
last_received_ts = 118.157585
last_seq = 1345
current_ts = 118.347076
current_received_ts = 118.346458
current_seq = 1355
count = 10
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 118.158211/1345, current 118.347076/1355: elapsed=188870.0us expected=188655.6us +- 943.3us, error 0.1%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 118.347076
last_received_ts = 118.346458
last_seq = 1355
current_ts = 118.535973
current_received_ts = 118.535316
current_seq = 1365
count = 11
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 118.347076/1355, current 118.535973/1365: elapsed=188892.0us expected=188655.6us +- 943.3us, error 0.1%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 118.535973
last_received_ts = 118.535316
last_seq = 1365
current_ts = 118.724854
current_received_ts = 118.724243
current_seq = 1375
count = 12
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 118.535973/1365, current 118.724854/1375: elapsed=188886.0us expected=188655.6us +- 943.3us, error 0.1%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 118.724854
last_received_ts = 118.724243
last_seq = 1375
current_ts = 118.913734
current_received_ts = 118.913170
current_seq = 1385
count = 13
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 118.724854/1375, current 118.913734/1385: elapsed=188880.0us expected=188655.6us +- 943.3us, error 0.1%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 118.913734
last_received_ts = 118.913170
last_seq = 1385
current_ts = 119.102715
current_received_ts = 119.102173
current_seq = 1395
count = 14
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 118.913734/1385, current 119.102715/1395: elapsed=188980.0us expected=188655.6us +- 943.3us, error 0.2%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 119.102715
last_received_ts = 119.102173
last_seq = 1395
current_ts = 119.291702
current_received_ts = 119.291084
current_seq = 1405
count = 15
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 119.102715/1395, current 119.291702/1405: elapsed=188983.0us expected=188655.6us +- 943.3us, error 0.2%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 119.291702
last_received_ts = 119.291084
last_seq = 1405
current_ts = 119.480675
current_received_ts = 119.480080
current_seq = 1415
count = 16
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 119.291702/1405, current 119.480675/1415: elapsed=188977.0us expected=188655.6us +- 943.3us, error 0.2%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 119.480675
last_received_ts = 119.480080
last_seq = 1415
current_ts = 119.669655
current_received_ts = 119.669060
current_seq = 1425
count = 17
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 119.480675/1415, current 119.669655/1425: elapsed=188977.0us expected=188655.6us +- 943.3us, error 0.2%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 119.669655
last_received_ts = 119.669060
last_seq = 1425
current_ts = 119.858620
current_received_ts = 119.857979
current_seq = 1435
count = 18
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 119.669655/1425, current 119.858620/1435: elapsed=188964.0us expected=188655.6us +- 943.3us, error 0.2%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 119.858620
last_received_ts = 119.857979
last_seq = 1435
current_ts = 120.047676
current_received_ts = 120.047043
current_seq = 1445
count = 19
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 119.858620/1435, current 120.047676/1445: elapsed=189056.0us expected=188655.6us +- 943.3us, error 0.2%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 120.047676
last_received_ts = 120.047043
last_seq = 1445
current_ts = 120.236725
current_received_ts = 120.236092
current_seq = 1455
count = 20
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 120.047676/1445, current 120.236725/1455: elapsed=189052.0us expected=188655.6us +- 943.3us, error 0.2%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 120.236725
last_received_ts = 120.236092
last_seq = 1455
current_ts = 120.425789
current_received_ts = 120.425156
current_seq = 1465
count = 21
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 120.236725/1455, current 120.425789/1465: elapsed=189064.0us expected=188655.6us +- 943.3us, error 0.2%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 120.425789
last_received_ts = 120.425156
last_seq = 1465
current_ts = 120.614853
current_received_ts = 120.614120
current_seq = 1475
count = 22
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 120.425789/1465, current 120.614853/1475: elapsed=189065.0us expected=188655.6us +- 943.3us, error 0.2%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 120.614853
last_received_ts = 120.614120
last_seq = 1475
current_ts = 120.803909
current_received_ts = 120.803276
current_seq = 1485
count = 23
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 120.614853/1475, current 120.803909/1485: elapsed=189055.0us expected=188655.6us +- 943.3us, error 0.2%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 120.803909
last_received_ts = 120.803276
last_seq = 1485
current_ts = 120.993011
current_received_ts = 120.992355
current_seq = 1495
count = 24
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 120.803909/1485, current 120.993011/1495: elapsed=189102.0us expected=188655.6us +- 943.3us, error 0.2%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 120.993011
last_received_ts = 120.992355
last_seq = 1495
current_ts = 121.182144
current_received_ts = 121.181580
current_seq = 1505
count = 25
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 120.993011/1495, current 121.182144/1505: elapsed=189134.0us expected=188655.6us +- 943.3us, error 0.3%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 121.182144
last_received_ts = 121.181580
last_seq = 1505
current_ts = 121.371277
current_received_ts = 121.370651
current_seq = 1515
count = 26
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 121.182144/1505, current 121.371277/1515: elapsed=189133.0us expected=188655.6us +- 943.3us, error 0.3%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 121.371277
last_received_ts = 121.370651
last_seq = 1515
current_ts = 121.560410
current_received_ts = 121.559784
current_seq = 1525
count = 27
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 121.371277/1515, current 121.560410/1525: elapsed=189129.0us expected=188655.6us +- 943.3us, error 0.3%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 121.560410
last_received_ts = 121.559784
last_seq = 1525
current_ts = 121.749542
current_received_ts = 121.749062
current_seq = 1535
count = 28
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 121.560410/1525, current 121.749542/1535: elapsed=189136.0us expected=188655.6us +- 943.3us, error 0.3%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 121.749542
last_received_ts = 121.749062
last_seq = 1535
current_ts = 121.938690
current_received_ts = 121.938034
current_seq = 1545
count = 29
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 121.749542/1535, current 121.938690/1545: elapsed=189144.0us expected=188655.6us +- 943.3us, error 0.3%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 121.938690
last_received_ts = 121.938034
last_seq = 1545
current_ts = 122.127884
current_received_ts = 122.127235
current_seq = 1555
count = 30
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 121.938690/1545, current 122.127884/1555: elapsed=189200.0us expected=188655.6us +- 943.3us, error 0.3%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 122.127884
last_received_ts = 122.127235
last_seq = 1555
current_ts = 122.317078
current_received_ts = 122.316589
current_seq = 1565
count = 31
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 122.127884/1555, current 122.317078/1565: elapsed=189190.0us expected=188655.6us +- 943.3us, error 0.3%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 122.317078
last_received_ts = 122.316589
last_seq = 1565
current_ts = 122.506294
current_received_ts = 122.505646
current_seq = 1575
count = 32
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 122.317078/1565, current 122.506294/1575: elapsed=189215.0us expected=188655.6us +- 943.3us, error 0.3%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 122.506294
last_received_ts = 122.505646
last_seq = 1575
current_ts = 122.695488
current_received_ts = 122.694862
current_seq = 1585
count = 33
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 122.506294/1575, current 122.695488/1585: elapsed=189198.0us expected=188655.6us +- 943.3us, error 0.3%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 122.695488
last_received_ts = 122.694862
last_seq = 1585
current_ts = 122.884682
current_received_ts = 122.884064
current_seq = 1595
count = 34
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 122.695488/1585, current 122.884682/1595: elapsed=189194.0us expected=188655.6us +- 943.3us, error 0.3%
(kms_flip:2242) DEBUG: name = vblank
last_ts = 122.884682
last_received_ts = 122.884064
last_seq = 1595
current_ts = 123.074356
current_received_ts = 123.073738
current_seq = 1605
count = 35
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 122.884682/1595, current 123.074356/1605: elapsed=189674.0us expected=188655.6us +- 943.3us, error 0.5%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 122.884682/1595, current 123.074356/1605: elapsed=189674.0us expected=188655.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 123.074356
last_received_ts = 123.073738
last_seq = 1605
current_ts = 123.264069
current_received_ts = 123.263435
current_seq = 1615
count = 36
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 123.074356/1605, current 123.264069/1615: elapsed=189709.0us expected=188655.6us +- 943.3us, error 0.6%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 123.074356/1605, current 123.264069/1615: elapsed=189709.0us expected=188655.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 123.264069
last_received_ts = 123.263435
last_seq = 1615
current_ts = 123.453766
current_received_ts = 123.453156
current_seq = 1625
count = 37
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 123.264069/1615, current 123.453766/1625: elapsed=189697.0us expected=188655.6us +- 943.3us, error 0.6%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 123.264069/1615, current 123.453766/1625: elapsed=189697.0us expected=188655.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 123.453766
last_received_ts = 123.453156
last_seq = 1625
current_ts = 123.643471
current_received_ts = 123.642830
current_seq = 1635
count = 38
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 123.453766/1625, current 123.643471/1635: elapsed=189706.0us expected=188655.6us +- 943.3us, error 0.6%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 123.453766/1625, current 123.643471/1635: elapsed=189706.0us expected=188655.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 123.643471
last_received_ts = 123.642830
last_seq = 1635
current_ts = 123.833183
current_received_ts = 123.832512
current_seq = 1645
count = 39
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 123.643471/1635, current 123.833183/1645: elapsed=189715.0us expected=188655.6us +- 943.3us, error 0.6%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 123.643471/1635, current 123.833183/1645: elapsed=189715.0us expected=188655.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 123.833183
last_received_ts = 123.832512
last_seq = 1645
current_ts = 124.022896
current_received_ts = 124.022270
current_seq = 1655
count = 40
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 123.833183/1645, current 124.022896/1655: elapsed=189710.0us expected=188655.6us +- 943.3us, error 0.6%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 123.833183/1645, current 124.022896/1655: elapsed=189710.0us expected=188655.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 124.022896
last_received_ts = 124.022270
last_seq = 1655
current_ts = 124.212601
current_received_ts = 124.212044
current_seq = 1665
count = 41
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 124.022896/1655, current 124.212601/1665: elapsed=189705.0us expected=188655.6us +- 943.3us, error 0.6%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 124.022896/1655, current 124.212601/1665: elapsed=189705.0us expected=188655.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 124.212601
last_received_ts = 124.212044
last_seq = 1665
current_ts = 124.402298
current_received_ts = 124.401680
current_seq = 1675
count = 42
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 124.212601/1665, current 124.402298/1675: elapsed=189699.0us expected=188655.6us +- 943.3us, error 0.6%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 124.212601/1665, current 124.402298/1675: elapsed=189699.0us expected=188655.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 124.402298
last_received_ts = 124.401680
last_seq = 1675
current_ts = 124.592010
current_received_ts = 124.591377
current_seq = 1685
count = 43
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 124.402298/1675, current 124.592010/1685: elapsed=189709.0us expected=188655.6us +- 943.3us, error 0.6%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 124.402298/1675, current 124.592010/1685: elapsed=189709.0us expected=188655.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 124.592010
last_received_ts = 124.591377
last_seq = 1685
current_ts = 124.781708
current_received_ts = 124.781189
current_seq = 1695
count = 44
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 124.592010/1685, current 124.781708/1695: elapsed=189700.0us expected=188655.6us +- 943.3us, error 0.6%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 124.592010/1685, current 124.781708/1695: elapsed=189700.0us expected=188655.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 124.781708
last_received_ts = 124.781189
last_seq = 1695
current_ts = 124.971397
current_received_ts = 124.970802
current_seq = 1705
count = 45
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 124.781708/1695, current 124.971397/1705: elapsed=189692.0us expected=188655.6us +- 943.3us, error 0.5%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 124.781708/1695, current 124.971397/1705: elapsed=189692.0us expected=188655.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 124.971397
last_received_ts = 124.970802
last_seq = 1705
current_ts = 125.161110
current_received_ts = 125.160454
current_seq = 1715
count = 46
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 124.971397/1705, current 125.161110/1715: elapsed=189709.0us expected=188655.6us +- 943.3us, error 0.6%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 124.971397/1705, current 125.161110/1715: elapsed=189709.0us expected=188655.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 125.161110
last_received_ts = 125.160454
last_seq = 1715
current_ts = 125.350807
current_received_ts = 125.350159
current_seq = 1725
count = 47
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 125.161110/1715, current 125.350807/1725: elapsed=189701.0us expected=188655.6us +- 943.3us, error 0.6%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 125.161110/1715, current 125.350807/1725: elapsed=189701.0us expected=188655.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 125.350807
last_received_ts = 125.350159
last_seq = 1725
current_ts = 125.540512
current_received_ts = 125.539886
current_seq = 1735
count = 48
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 125.350807/1725, current 125.540512/1735: elapsed=189700.0us expected=188655.6us +- 943.3us, error 0.6%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 125.350807/1725, current 125.540512/1735: elapsed=189700.0us expected=188655.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 125.540512
last_received_ts = 125.539886
last_seq = 1735
current_ts = 125.730202
current_received_ts = 125.729607
current_seq = 1745
count = 49
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 125.540512/1735, current 125.730202/1745: elapsed=189691.0us expected=188655.6us +- 943.3us, error 0.5%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 125.540512/1735, current 125.730202/1745: elapsed=189691.0us expected=188655.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 125.730202
last_received_ts = 125.729607
last_seq = 1745
current_ts = 125.919914
current_received_ts = 125.919319
current_seq = 1755
count = 50
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 125.730202/1745, current 125.919914/1755: elapsed=189712.0us expected=188655.6us +- 943.3us, error 0.6%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 125.730202/1745, current 125.919914/1755: elapsed=189712.0us expected=188655.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 125.919914
last_received_ts = 125.919319
last_seq = 1755
current_ts = 126.109604
current_received_ts = 126.108986
current_seq = 1765
count = 51
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 125.919914/1755, current 126.109604/1765: elapsed=189694.0us expected=188655.6us +- 943.3us, error 0.6%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 125.919914/1755, current 126.109604/1765: elapsed=189694.0us expected=188655.6us
(kms_flip:2242) DEBUG: name = vblank
last_ts = 126.109604
last_received_ts = 126.108986
last_seq = 1765
current_ts = 126.299301
current_received_ts = 126.298683
current_seq = 1775
count = 52
seq_step = 10
(kms_flip:2242) DEBUG: vblank ts/seq: last 126.109604/1765, current 126.299301/1775: elapsed=189695.0us expected=188655.6us +- 943.3us, error 0.6%
(kms_flip:2242) DEBUG: inconsistent vblank ts/seq: last 126.109604/1765, current 126.299301/1775: elapsed=189695.0us expected=188655.6us
(kms_flip:2242) INFO: Event vblank: expected 531, counted 530, passrate = 66.04%, encoder type 2
(kms_flip:2242) DEBUG: dropped frames, expected 531, counted 530, passrate = 66.04%, encoder type 2
(kms_flip:2242) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1711:
(kms_flip:2242) CRITICAL: Failed assertion: !retried
(kms_flip:2242) CRITICAL: Last errno: 4, Interrupted system call
(kms_flip:2242) igt_core-INFO: Stack trace:
(kms_flip:2242) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(kms_flip:2242) igt_core-INFO:   #1 ../tests/kms_flip.c:428 run_test_on_crtc_set.constprop.0()
(kms_flip:2242) igt_core-INFO:   #2 ../tests/kms_flip.c:1891 run_test()
(kms_flip:2242) igt_core-INFO:   #3 ../tests/kms_flip.c:2162 __igt_unique____real_main2047()
(kms_flip:2242) igt_core-INFO:   #4 ../tests/kms_flip.c:2047 main()
(kms_flip:2242) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:2242) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:2242) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest A-HDMI-A1: FAIL (24.307s)
Starting dynamic subtest: B-HDMI-A1
Dynamic subtest B-HDMI-A1: SUCCESS (10.518s)
Starting dynamic subtest: C-HDMI-A1
Dynamic subtest C-HDMI-A1: SUCCESS (10.503s)
Subtest wf_vblank-ts-check-interruptible: FAIL (45.335s)
Dmesg
<6> [102.659400] Console: switching to colour dummy device 80x25
<6> [102.659528] [IGT] kms_flip: executing
<7> [102.661550] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [102.662133] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [102.662375] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [102.666539] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:399:HDMI-A-2]
<7> [102.666550] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:399:HDMI-A-2]
<7> [102.670906] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:399:HDMI-A-2] disconnected
<7> [102.671234] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:403:DP-1]
<7> [102.671238] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:403:DP-1]
<7> [102.675698] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:403:DP-1] disconnected
<7> [102.675944] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:411:HDMI-A-3]
<7> [102.675947] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:411:HDMI-A-3]
<7> [102.680272] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:411:HDMI-A-3] disconnected
<7> [102.680562] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:389:HDMI-A-1]
<7> [102.680567] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:389:HDMI-A-1]
<7> [102.710212] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:389:HDMI-A-1] Supported Monitor Refresh rate range is 0 Hz - 0 Hz
<7> [102.710220] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:389:HDMI-A-1] Assigning EDID-1.4 digital sink color depth as 8 bpc.
<7> [102.710223] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:389:HDMI-A-1] ELD monitor fitHeadless4k
<7> [102.710226] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:389:HDMI-A-1] ELD size 36, SAD count 0
<7> [102.712606] i915 0000:00:02.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: DP-HDMI ADAPTOR\004 (err 0)
<7> [102.715113] i915 0000:00:02.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode adaptor ID: a0 (err 0)
<7> [102.718966] i915 0000:00:02.0: [drm:intel_hdmi_set_edid [i915]] DP dual mode adaptor (type 2 HDMI) detected (max TMDS clock: 600000 kHz)
<7> [102.719093] i915 0000:00:02.0: [drm:intel_hdmi_set_edid [i915]] Ignoring DP dual mode adaptor max TMDS clock for native HDMI port
<7> [102.719586] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "1366x768": 216 268000 1366 1414 1446 1526 768 771 777 814 0x40 0x6 (CLOCK_HIGH)
<7> [102.719593] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "1920x1080i": 60 74250 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x15 (NO_INTERLACE)
<7> [102.719597] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "1920x1080i": 60 74176 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x15 (NO_INTERLACE)
<7> [102.719603] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:389:HDMI-A-1] probed modes:
<7> [102.719606] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [102.719609] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "4088x2304": 10 108000 4088 4152 4280 4536 2304 2305 2308 2340 0x40 0x5
<7> [102.719611] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "3840x2160": 15 128430 3840 3889 3921 4000 2160 2163 2169 2195 0x40 0xa
<7> [102.719614] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2880x1800": 11 60000 2880 2888 2984 3040 1800 1802 1820 1845 0x40 0xa
<7> [102.719616] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1600": 13 60000 2560 2568 2664 2720 1600 1602 1620 1645 0x40 0xa
<7> [102.719619] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2560x1440": 15 60000 2560 2568 2664 2720 1440 1442 1460 1485 0x40 0xa
<7> [102.719621] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "2048x1536": 17 60000 2048 2056 2152 2208 1536 1538 1556 1581 0x40 0xa
<7> [102.719624] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x1200": 60 162000 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5
<7> [102.719626] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1680x1050": 60 146250 1680 1784 1960 2240 1050 1053 1059 1089 0x40 0x6
<7> [102.719629] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1600x900": 60 108000 1600 1624 1704 1800 900 901 904 1000 0x40 0x5
<7> [102.719631] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x1024": 75 135000 1280 1296 1440 1688 1024 1025 1028 1066 0x40 0x5
<7> [102.719633] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1360x768": 60 84963 1366 1431 1567 1776 768 771 781 798 0x0 0x6
<7> [102.719636] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1360x768": 20 25190 1360 1368 1464 1520 768 770 788 813 0x40 0xa
<7> [102.719639] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x800": 60 83500 1280 1352 1480 1680 800 803 809 831 0x40 0x6
<7> [102.719641] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1152x864": 75 108000 1152 1216 1344 1600 864 865 868 900 0x40 0x5
<7> [102.719643] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [102.719646] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [102.719648] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [102.719651] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 75 78750 1024 1040 1136 1312 768 769 772 800 0x40 0x5
<7> [102.719653] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [102.719655] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1440x480": 60 54054 1440 1472 1596 1716 480 489 495 525 0x40 0xa
<7> [102.719658] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1440x480": 60 54000 1440 1472 1596 1716 480 489 495 525 0x40 0xa
<7> [102.719660] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "1024x576": 60 46560 1024 1064 1160 1296 576 579 584 599 0x0 0x6
<7> [102.719663] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "832x624": 75 57284 832 864 928 1152 624 625 628 667 0x40 0xa
<7> [102.719665] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 75 49500 800 816 896 1056 600 601 604 625 0x40 0x5
<7> [102.719668] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5
<7> [102.719670] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 75 31500 640 656 720 840 480 481 484 500 0x40 0xa
<7> [102.719672] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25200 640 656 752 800 480 490 492 525 0x40 0xa
<7> [102.719675] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [102.719677] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [102.719680] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] Probed mode: "720x400": 70 28320 720 738 846 900 400 412 414 449 0x40 0x6
<7> [102.719696] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:399:HDMI-A-2]
<7> [102.719699] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:399:HDMI-A-2]
<7> [102.724015] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:399:HDMI-A-2] disconnected
<7> [102.724027] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:403:DP-1]
<7> [102.724029] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:403:DP-1]
<7> [102.728376] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:403:DP-1] disconnected
<7> [102.728387] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:411:HDMI-A-3]
<7> [102.728390] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:411:HDMI-A-3]
<7> [102.732717] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes] [CONNECTOR:411:HDMI-A-3] disconnected
<6> [102.736763] [IGT] kms_flip: starting subtest wf_vblank-ts-check-interruptible
<6> [102.738037] [IGT] kms_flip: starting dynamic subtest A-HDMI-A1
<7> [102.738356] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:415]
<7> [102.738435] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:418]
<7> [102.762737] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:150:pipe A]
<7> [102.762822] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [102.762993] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [102.763130] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [102.763265] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [102.763399] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [102.763532] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [102.763737] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [102.763869] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2360, found 0)
<7> [102.764001] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [102.764133] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2360, found 0)
<7> [102.764265] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [102.764397] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2096, found 0)
<7> [102.764528] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [102.764965] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [102.765107] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [102.765240] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [102.765374] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [102.765506] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [102.765638] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [102.765779] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2360, found 0)
<7> [102.765917] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [102.766053] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2360, found 0)
<7> [102.766188] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [102.766323] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2096, found 0)
<7> [102.766454] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [102.766588] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [102.766720] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [102.766869] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [102.767000] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [102.767131] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [102.767262] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [102.767393] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [102.767523] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [102.767655] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [102.767788] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 139929, found 0)
<7> [102.767974] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 139929, found 0)
<7> [102.768110] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in port_clock (expected 139929, found 0)
<7> [102.768241] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:150:pipe A] fastset requirement not met, forcing full modeset
<7> [102.768373] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:150:pipe A] releasing DPLL 0
<7> [102.768533] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [102.768664] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:150:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [102.768815] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:34:plane 1A] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0
<7> [102.768956] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:144:cursor A] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0
<7> [102.769086] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [102.769217] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] lines 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [102.769346] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] blocks 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [102.769474] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] min_ddb 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [102.769618] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:150:pipe A] data rate 0 num active planes 0
<7> [102.769754] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 0
<7> [102.769917] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:150:pipe A] min cdclk: 69965 kHz -> 0 kHz
<7> [102.770068] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 8746 kHz -> 0 kHz
<7> [102.770207] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:150:pipe A] enable: no [modeset]
<7> [102.770344] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:plane 1A] fb: [NOFB], visible: no
<7> [102.770480] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [102.770615] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [102.770747] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [102.770880] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [102.771029] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:144:cursor A] fb: [NOFB], visible: no
<7> [102.771210] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [102.771349] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [102.778138] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [102.797881] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [102.798068] i915 0000:00:02.0: [drm:intel_dp_dual_mode_set_tmds_output [i915]] Disabling DP dual mode adaptor TMDS output
<7> [102.802931] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:150:pipe A]
<7> [102.803096] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0
<7> [102.803242] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:34:plane 1A]
<7> [102.803385] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:388:DDI B/PHY B]
<7> [102.803533] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:398:DDI TC1/PHY C]
<7> [102.803667] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:402:DDI TC2/PHY D]
<7> [102.803801] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:404:DP-MST A]
<7> [102.803936] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:405:DP-MST B]
<7> [102.804078] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:406:DP-MST C]
<7> [102.804209] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:389:HDMI-A-1]
<7> [102.804409] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [102.804604] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:150:pipe A]
<7> [102.804996] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:268:pipe B]
<7> [102.805135] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:386:pipe C]
<7> [102.805251] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:150:pipe A]
<7> [102.805272] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:389:HDMI-A-1]
<7> [102.805328] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:389:HDMI-A-1] Limiting target display pipe bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [102.805480] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [102.805607] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:150:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [102.805745] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:388:DDI B/PHY B] [CRTC:150:pipe A]
<7> [102.805874] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [102.806011] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [102.806159] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [102.806292] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [102.806425] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [102.806564] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [102.806702] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [102.806836] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2360)
<7> [102.806969] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [102.807102] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2360)
<7> [102.807254] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [102.807385] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2096)
<7> [102.807517] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [102.807651] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [102.807785] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [102.807915] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [102.808045] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [102.808176] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [102.808319] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [102.808452] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2360)
<7> [102.808585] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [102.808716] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2360)
<7> [102.808848] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [102.808978] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2096)
<7> [102.809108] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [102.809246] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [102.809378] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [102.809511] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [102.809643] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [102.809774] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [102.809905] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [102.810037] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [102.810169] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [102.810314] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [102.810444] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 139929)
<7> [102.810575] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 139929)
<7> [102.810705] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in port_clock (expected 0, found 139929)
<7> [102.810838] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:150:pipe A] fastset requirement not met, forcing full modeset
<7> [102.810991] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [102.811123] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:150:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x1
<7> [102.811276] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:34:plane 1A] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016
<7> [102.811415] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:144:cursor A] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32
<7> [102.811544] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [102.811671] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0
<7> [102.811802] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0
<7> [102.811932] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0
<7> [102.812075] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:150:pipe A] data rate 559716 num active planes 1
<7> [102.812212] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 560
<7> [102.812355] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [102.812501] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:150:pipe A] min cdclk: 0 kHz -> 69965 kHz
<7> [102.812647] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 0 kHz -> 8746 kHz
<7> [102.812782] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:150:pipe A] allocated DPLL 0
<7> [102.812918] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:150:pipe A] reserving DPLL 0
<7> [102.813058] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:150:pipe A] enable: yes [modeset]
<7> [102.813196] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [102.813332] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [102.813486] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [102.813619] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [102.813751] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [102.813883] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [102.814017] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [102.814153] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [102.814286] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [102.814430] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 42, guardband: 44 vsync start: 0, vsync end: 0
<7> [102.814563] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1081, vmax vblank: 1081, vmin vtotal: 1125, vmax vtotal: 1125
<7> [102.814694] 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> [102.814826] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [102.814958] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [102.815091] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [102.815225] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 53 139929 1920 2008 2096 2360 1080 1084 1089 1125 0x40 0x5
<7> [102.815357] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [102.815496] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139929, pipe src: 1920x1080+0+0, pixel rate 139929, min cdclk 69965
<7> [102.815630] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0
<7> [102.815761] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [102.815894] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [102.816027] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [102.816159] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1a6655d, cfgcr1: 0xe84, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [102.816296] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [102.816433] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [102.816578] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [102.816712] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [102.816843] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [102.816974] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [102.817105] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [102.817235] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [102.817366] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [102.817497] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [102.817641] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [102.817774] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [102.817904] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [102.818034] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:plane 1A] fb: [FB:415] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [102.818167] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [102.818297] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [102.818430] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [102.818568] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [102.818702] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [102.818833] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [102.818963] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:144:cursor A] fb: [NOFB], visible: no
<7> [102.820504] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:388:DDI B/PHY B]
<7> [102.820658] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:398:DDI TC1/PHY C]
<7> [102.820803] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:402:DDI TC2/PHY D]
<7> [102.820938] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:404:DP-MST A]
<7> [102.821070] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:405:DP-MST B]
<7> [102.821202] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:406:DP-MST C]
<7> [102.821372] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [102.821598] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:150:pipe A]
<7> [102.821799] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0
<7> [102.821979] i915 0000:00:02.0: [drm:intel_dp_dual_mode_set_tmds_output [i915]] Enabling DP dual mode adaptor TMDS output
<7> [102.826864] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [102.827040] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [102.827422] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1
<7> [102.827561] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:34:plane 1A]
<7> [102.846624] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:389:HDMI-A-1]
<7> [102.846843] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:150:pipe A]
<7> [102.865296] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [102.865800] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [102.866327] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [103.174140] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [103.174900] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [103.207078] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [103.207664] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [103.208249] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<6> [106.325093] pcieport 0000:00:06.0: AER: Correctable error message received from 0000:01:00.0
<4> [106.325111] nvme 0000:01:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID)
<4> [106.325118] nvme 0000:01:00.0: device [15b7:5006] error status/mask=00000001/0000e000
<4> [106.325124] nvme 0000:01:00.0: [ 0] RxErr (First)
<7> [116.459153] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:150:pipe A]
<7> [116.459465] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [116.460207] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [116.460832] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [116.461504] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [116.462141] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [116.462754] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [116.463407] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [116.464030] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2360, found 0)
<7> [116.464461] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [116.464592] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2360, found 0)
<7> [116.464723] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [116.464854] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2096, found 0)
<7> [116.464990] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [116.465122] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [116.465252] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [116.465381] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [116.465511] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [116.465642] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [116.465772] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [116.465901] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2360, found 0)
<7> [116.466041] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [116.466173] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2360, found 0)
<7> [116.466302] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [116.466432] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2096, found 0)
<7> [116.466561] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [116.466690] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [116.466820] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [116.466955] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [116.467085] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [116.467214] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [116.467344] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [116.467475] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [116.467605] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [116.467738] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [116.467868] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 139929, found 0)
<7> [116.468005] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 139929, found 0)
<7> [116.468136] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in port_clock (expected 139929, found 0)
<7> [116.468266] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:150:pipe A] fastset requirement not met, forcing full modeset
<7> [116.468397] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:150:pipe A] releasing DPLL 0
<7> [116.468555] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [116.468685] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:150:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [116.468834] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:34:plane 1A] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0
<7> [116.468969] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:144:cursor A] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0
<7> [116.469106] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [116.469236] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] lines 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [116.469365] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] blocks 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [116.469493] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] min_ddb 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [116.469639] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:150:pipe A] data rate 0 num active planes 0
<7> [116.469775] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 0
<7> [116.469923] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:150:pipe A] min cdclk: 69965 kHz -> 0 kHz
<7> [116.470084] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 8746 kHz -> 0 kHz
<7> [116.470222] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:150:pipe A] enable: no [modeset]
<7> [116.470357] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:plane 1A] fb: [NOFB], visible: no
<7> [116.470492] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [116.470625] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [116.470757] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [116.470890] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [116.471030] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:144:cursor A] fb: [NOFB], visible: no
<7> [116.471211] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [116.471349] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [116.488836] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [116.508348] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [116.509043] i915 0000:00:02.0: [drm:intel_dp_dual_mode_set_tmds_output [i915]] Disabling DP dual mode adaptor TMDS output
<7> [116.514439] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:150:pipe A]
<7> [116.515027] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0
<7> [116.515604] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:34:plane 1A]
<7> [116.516143] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:388:DDI B/PHY B]
<7> [116.516794] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:398:DDI TC1/PHY C]
<7> [116.517358] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:402:DDI TC2/PHY D]
<7> [116.517908] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:404:DP-MST A]
<7> [116.518491] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:405:DP-MST B]
<7> [116.519030] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:406:DP-MST C]
<7> [116.519518] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:389:HDMI-A-1]
<7> [116.520196] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [116.520843] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:150:pipe A]
<7> [116.521987] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:268:pipe B]
<7> [116.522293] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:386:pipe C]
<7> [116.522602] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:150:pipe A]
<7> [116.522650] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:389:HDMI-A-1]
<7> [116.522780] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:389:HDMI-A-1] Limiting target display pipe bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [116.523146] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [116.523495] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:150:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [116.523839] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:388:DDI B/PHY B] [CRTC:150:pipe A]
<7> [116.524170] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [116.524537] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [116.524810] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [116.525080] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [116.525357] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [116.525612] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [116.525874] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [116.526129] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2360)
<7> [116.526405] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [116.526659] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2360)
<7> [116.526920] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [116.527171] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2096)
<7> [116.527449] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [116.527684] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [116.527857] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [116.528031] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [116.528203] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [116.528384] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [116.528557] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [116.528730] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2360)
<7> [116.528902] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [116.529075] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2360)
<7> [116.529249] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [116.529436] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2096)
<7> [116.529610] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [116.529789] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [116.529963] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [116.530137] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [116.530311] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [116.530496] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [116.530669] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [116.530843] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [116.531022] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [116.531179] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [116.531312] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 139929)
<7> [116.531450] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 139929)
<7> [116.531582] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in port_clock (expected 0, found 139929)
<7> [116.531713] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:150:pipe A] fastset requirement not met, forcing full modeset
<7> [116.531865] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [116.531998] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:150:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x1
<7> [116.532150] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:34:plane 1A] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016
<7> [116.532279] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:144:cursor A] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32
<7> [116.532417] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [116.532547] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0
<7> [116.532677] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0
<7> [116.532807] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0
<7> [116.532949] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:150:pipe A] data rate 559716 num active planes 1
<7> [116.533085] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 560
<7> [116.533221] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [116.533366] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:150:pipe A] min cdclk: 0 kHz -> 69965 kHz
<7> [116.533573] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 0 kHz -> 8746 kHz
<7> [116.533709] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:150:pipe A] allocated DPLL 0
<7> [116.533847] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:150:pipe A] reserving DPLL 0
<7> [116.533984] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:150:pipe A] enable: yes [modeset]
<7> [116.534120] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [116.534254] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [116.534394] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [116.534531] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [116.534667] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [116.534801] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [116.534934] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [116.535066] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [116.535199] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [116.535334] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 42, guardband: 44 vsync start: 0, vsync end: 0
<7> [116.535474] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1081, vmax vblank: 1081, vmin vtotal: 1125, vmax vtotal: 1125
<7> [116.535608] 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> [116.535739] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [116.535870] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [116.536000] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [116.536131] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 53 139929 1920 2008 2096 2360 1080 1084 1089 1125 0x40 0x5
<7> [116.536264] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [116.536402] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139929, pipe src: 1920x1080+0+0, pixel rate 139929, min cdclk 69965
<7> [116.536536] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0
<7> [116.536670] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [116.536800] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [116.536932] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [116.537062] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1a6655d, cfgcr1: 0xe84, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [116.537194] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [116.537323] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [116.537464] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [116.537596] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [116.537729] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [116.537861] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [116.537992] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [116.538125] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [116.538259] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [116.538391] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [116.538536] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [116.538665] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [116.538797] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [116.538928] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:plane 1A] fb: [FB:415] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [116.539060] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [116.539189] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [116.539320] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [116.539456] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [116.539586] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [116.539716] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [116.539847] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:144:cursor A] fb: [NOFB], visible: no
<7> [116.540064] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:388:DDI B/PHY B]
<7> [116.540201] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:398:DDI TC1/PHY C]
<7> [116.540334] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:402:DDI TC2/PHY D]
<7> [116.540475] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:404:DP-MST A]
<7> [116.540609] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:405:DP-MST B]
<7> [116.540743] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:406:DP-MST C]
<7> [116.540911] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [116.541134] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:150:pipe A]
<7> [116.541271] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0
<7> [116.541447] i915 0000:00:02.0: [drm:intel_dp_dual_mode_set_tmds_output [i915]] Enabling DP dual mode adaptor TMDS output
<7> [116.546471] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [116.546652] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [116.547032] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1
<7> [116.547172] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:34:plane 1A]
<7> [116.566287] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:389:HDMI-A-1]
<7> [116.566552] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:150:pipe A]
<7> [116.585809] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [116.586390] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [116.586952] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [116.889577] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [116.890149] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [116.925821] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [116.926413] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [116.927013] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<6> [127.044932] [IGT] kms_flip: finished subtest A-HDMI-A1, FAIL
<6> [127.045412] [IGT] kms_flip: starting dynamic subtest B-HDMI-A1
<7> [127.045710] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:419]
<7> [127.045792] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:420]
<7> [127.061470] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:150:pipe A]
<7> [127.061552] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [127.061724] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [127.061862] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [127.061998] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [127.062181] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [127.062315] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [127.062450] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [127.062581] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2360, found 0)
<7> [127.062711] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [127.062841] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2360, found 0)
<7> [127.062973] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [127.063114] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2096, found 0)
<7> [127.063247] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [127.063381] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [127.063511] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [127.063650] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [127.063781] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [127.063912] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [127.064045] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [127.064214] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2360, found 0)
<7> [127.064348] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [127.064482] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2360, found 0)
<7> [127.064616] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [127.064748] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2096, found 0)
<7> [127.064880] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [127.065011] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [127.065153] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [127.065287] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [127.065421] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [127.065552] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [127.065684] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [127.065817] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [127.065951] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [127.066089] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [127.066222] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 139929, found 0)
<7> [127.066354] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 139929, found 0)
<7> [127.066485] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in port_clock (expected 139929, found 0)
<7> [127.066617] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:150:pipe A] fastset requirement not met, forcing full modeset
<7> [127.066747] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:150:pipe A] releasing DPLL 0
<7> [127.066906] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [127.067039] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:150:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [127.067199] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:34:plane 1A] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0
<7> [127.067332] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:144:cursor A] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0
<7> [127.067461] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [127.067590] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] lines 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [127.067719] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] blocks 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [127.067847] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] min_ddb 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [127.067990] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:150:pipe A] data rate 0 num active planes 0
<7> [127.068133] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 0
<7> [127.068283] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:150:pipe A] min cdclk: 69965 kHz -> 0 kHz
<7> [127.068435] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 8746 kHz -> 0 kHz
<7> [127.068572] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:150:pipe A] enable: no [modeset]
<7> [127.068709] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:plane 1A] fb: [NOFB], visible: no
<7> [127.068844] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [127.068977] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [127.069121] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [127.069255] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [127.069389] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:144:cursor A] fb: [NOFB], visible: no
<7> [127.069568] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [127.069708] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [127.077572] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [127.098169] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [127.098329] i915 0000:00:02.0: [drm:intel_dp_dual_mode_set_tmds_output [i915]] Disabling DP dual mode adaptor TMDS output
<7> [127.103133] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:150:pipe A]
<7> [127.103291] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0
<7> [127.103436] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:34:plane 1A]
<7> [127.103576] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:388:DDI B/PHY B]
<7> [127.103726] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:398:DDI TC1/PHY C]
<7> [127.103859] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:402:DDI TC2/PHY D]
<7> [127.103994] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:404:DP-MST A]
<7> [127.104137] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:405:DP-MST B]
<7> [127.104269] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:406:DP-MST C]
<7> [127.104400] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:389:HDMI-A-1]
<7> [127.104595] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [127.104786] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:150:pipe A]
<7> [127.105183] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:268:pipe B]
<7> [127.105306] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:386:pipe C]
<7> [127.105415] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:268:pipe B]
<7> [127.105435] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:389:HDMI-A-1]
<7> [127.105488] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:389:HDMI-A-1] Limiting target display pipe bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [127.105632] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [127.105759] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:268:pipe B] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [127.105896] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:388:DDI B/PHY B] [CRTC:268:pipe B]
<7> [127.106025] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [127.106171] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [127.106304] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [127.106435] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [127.106570] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [127.106703] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [127.106835] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [127.106966] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2360)
<7> [127.107107] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [127.107246] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2360)
<7> [127.107377] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [127.107509] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2096)
<7> [127.107641] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [127.107773] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [127.107903] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [127.108034] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [127.108173] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [127.108303] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [127.108433] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [127.108563] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2360)
<7> [127.108693] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [127.108822] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2360)
<7> [127.108952] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [127.109081] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2096)
<7> [127.109223] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [127.109353] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [127.109484] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [127.109613] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [127.109743] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [127.109874] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [127.110010] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [127.110154] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [127.110289] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [127.110422] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in dpll_hw_state
<7> [127.110554] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [127.110687] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: cfgcr0: 0x0, cfgcr1: 0x0, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [127.110822] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [127.110955] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: cfgcr0: 0x1a6655d, cfgcr1: 0xe84, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [127.111096] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [127.111234] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 139929)
<7> [127.111370] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 139929)
<7> [127.111504] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in port_clock (expected 0, found 139929)
<7> [127.111639] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:268:pipe B] fastset requirement not met, forcing full modeset
<7> [127.111790] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [127.111923] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:268:pipe B] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x2
<7> [127.112077] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:152:plane 1B] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016
<7> [127.112218] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:262:cursor B] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32
<7> [127.112348] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:152:plane 1B] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [127.112477] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:152:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0
<7> [127.112610] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:152:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0
<7> [127.112739] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:152:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0
<7> [127.112882] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:268:pipe B] data rate 559716 num active planes 1
<7> [127.113017] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 560
<7> [127.113160] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [127.113305] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:268:pipe B] min cdclk: 0 kHz -> 69965 kHz
<7> [127.113453] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 0 kHz -> 8746 kHz
<7> [127.113587] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:268:pipe B] allocated DPLL 0
<7> [127.113725] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:268:pipe B] reserving DPLL 0
<7> [127.113862] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:268:pipe B] enable: yes [modeset]
<7> [127.113997] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [127.114181] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 24, dithering: 0
<7> [127.114317] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [127.114448] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [127.114580] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [127.114711] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [127.114841] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [127.114973] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [127.115111] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [127.115246] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 42, guardband: 44 vsync start: 0, vsync end: 0
<7> [127.115379] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1081, vmax vblank: 1081, vmin vtotal: 1125, vmax vtotal: 1125
<7> [127.115511] 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> [127.115642] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [127.115776] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [127.115906] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [127.116037] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 53 139929 1920 2008 2096 2360 1080 1084 1089 1125 0x40 0x5
<7> [127.116175] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [127.116305] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139929, pipe src: 1920x1080+0+0, pixel rate 139929, min cdclk 69965
<7> [127.116434] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0
<7> [127.116564] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [127.116695] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [127.116827] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [127.116958] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1a6655d, cfgcr1: 0xe84, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [127.117096] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [127.117228] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [127.117362] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [127.117494] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [127.117624] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [127.117755] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [127.117885] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [127.118015] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [127.118152] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [127.118282] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [127.118412] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [127.118543] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [127.118674] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [127.118805] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:152:plane 1B] fb: [FB:419] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [127.118938] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [127.119069] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [127.119211] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:182:plane 2B] fb: [NOFB], visible: no
<7> [127.119342] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:212:plane 3B] fb: [NOFB], visible: no
<7> [127.119472] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:242:plane 4B] fb: [NOFB], visible: no
<7> [127.119604] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:252:plane 5B] fb: [NOFB], visible: no
<7> [127.119735] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:262:cursor B] fb: [NOFB], visible: no
<7> [127.120334] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [127.120494] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:388:DDI B/PHY B]
<7> [127.120629] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:398:DDI TC1/PHY C]
<7> [127.120762] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:402:DDI TC2/PHY D]
<7> [127.120895] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:404:DP-MST A]
<7> [127.121028] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:405:DP-MST B]
<7> [127.121173] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:406:DP-MST C]
<7> [127.121342] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [127.121512] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x2, on? 0) for [CRTC:268:pipe B]
<7> [127.121650] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0
<7> [127.121827] i915 0000:00:02.0: [drm:intel_dp_dual_mode_set_tmds_output [i915]] Enabling DP dual mode adaptor TMDS output
<7> [127.126666] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [127.126838] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B
<7> [127.146700] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:389:HDMI-A-1]
<7> [127.146910] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:268:pipe B]
<7> [137.544464] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:420] from all active usage due to RMFB ioctl
<7> [137.544586] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:152:plane 1B] because [FB:420] is removed
<7> [137.544703] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:152:plane 1B] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0
<7> [137.545314] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:152:plane 1B] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [137.545869] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:152:plane 1B] lines 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [137.546444] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:152:plane 1B] blocks 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [137.546990] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:152:plane 1B] min_ddb 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [137.547641] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:268:pipe B] data rate 0 num active planes 0
<7> [137.548251] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 0
<6> [137.563997] [IGT] kms_flip: finished subtest B-HDMI-A1, SUCCESS
<6> [137.564698] [IGT] kms_flip: starting dynamic subtest C-HDMI-A1
<7> [137.565130] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:419]
<7> [137.565259] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:420]
<7> [137.582302] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:150:pipe A]
<7> [137.582471] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:268:pipe B]
<7> [137.582535] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.enable (expected yes, found no)
<7> [137.582712] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.active (expected yes, found no)
<7> [137.582852] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [137.582990] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in lane_count (expected 4, found 0)
<7> [137.583149] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [137.583282] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [137.583414] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [137.583545] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2360, found 0)
<7> [137.583676] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [137.583807] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2360, found 0)
<7> [137.583937] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [137.584069] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2096, found 0)
<7> [137.584251] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [137.584385] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [137.584518] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [137.584697] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [137.584828] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [137.584959] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [137.585099] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [137.585233] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2360, found 0)
<7> [137.585368] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [137.585504] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2360, found 0)
<7> [137.585638] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [137.585771] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2096, found 0)
<7> [137.585904] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [137.586037] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [137.586180] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [137.586312] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [137.586443] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [137.586573] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [137.586704] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [137.586835] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [137.586966] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [137.587106] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [137.587240] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 139929, found 0)
<7> [137.587372] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 139929, found 0)
<7> [137.587541] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:268:pipe B] fastset requirement not met in port_clock (expected 139929, found 0)
<7> [137.587673] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:268:pipe B] fastset requirement not met, forcing full modeset
<7> [137.587812] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:268:pipe B] releasing DPLL 0
<7> [137.587966] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [137.588117] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:268:pipe B] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x2 -> 0x0
<7> [137.588295] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:262:cursor B] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0
<7> [137.588456] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:268:pipe B] min cdclk: 69965 kHz -> 0 kHz
<7> [137.588605] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:268:pipe B] enable: no [modeset]
<7> [137.588747] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:152:plane 1B] fb: [NOFB], visible: no
<7> [137.588881] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:182:plane 2B] fb: [NOFB], visible: no
<7> [137.589014] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:212:plane 3B] fb: [NOFB], visible: no
<7> [137.589157] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:242:plane 4B] fb: [NOFB], visible: no
<7> [137.589291] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:252:plane 5B] fb: [NOFB], visible: no
<7> [137.589422] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:262:cursor B] fb: [NOFB], visible: no
<7> [137.589648] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe B
<7> [137.602184] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [137.602345] i915 0000:00:02.0: [drm:intel_dp_dual_mode_set_tmds_output [i915]] Disabling DP dual mode adaptor TMDS output
<7> [137.607134] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x2, on? 1) for [CRTC:268:pipe B]
<7> [137.607293] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0
<7> [137.607439] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:388:DDI B/PHY B]
<7> [137.607591] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:398:DDI TC1/PHY C]
<7> [137.607726] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:402:DDI TC2/PHY D]
<7> [137.607859] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:404:DP-MST A]
<7> [137.607989] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:405:DP-MST B]
<7> [137.608130] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:406:DP-MST C]
<7> [137.608261] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:389:HDMI-A-1]
<7> [137.608455] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [137.608630] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3
<7> [137.608848] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:268:pipe B]
<7> [137.609124] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:386:pipe C]
<7> [137.609256] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:386:pipe C]
<7> [137.609277] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:389:HDMI-A-1]
<7> [137.609341] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:389:HDMI-A-1] Limiting target display pipe bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [137.609494] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [137.609622] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:386:pipe C] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [137.609759] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:388:DDI B/PHY B] [CRTC:386:pipe C]
<7> [137.609890] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.enable (expected no, found yes)
<7> [137.610024] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.active (expected no, found yes)
<7> [137.610177] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in cpu_transcoder (expected -1, found 2)
<7> [137.610338] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in lane_count (expected 0, found 4)
<7> [137.610473] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [137.610607] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [137.610741] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [137.610874] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2360)
<7> [137.611015] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [137.611165] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2360)
<7> [137.611322] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [137.611455] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2096)
<7> [137.611589] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [137.611722] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [137.611854] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [137.611987] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [137.612132] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [137.612295] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [137.612428] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [137.612561] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2360)
<7> [137.612693] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [137.612825] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2360)
<7> [137.612956] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [137.613089] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2096)
<7> [137.613288] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [137.613426] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [137.613557] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [137.613689] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [137.613819] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [137.613951] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [137.614083] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [137.614236] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [137.614382] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [137.614516] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [137.614649] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 139929)
<7> [137.614779] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 139929)
<7> [137.614911] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in port_clock (expected 0, found 139929)
<7> [137.615049] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:386:pipe C] fastset requirement not met, forcing full modeset
<7> [137.615229] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [137.615375] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:386:pipe C] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x4
<7> [137.615527] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:270:plane 1C] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016
<7> [137.615658] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:380:cursor C] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32
<7> [137.615791] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:270: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> [137.615922] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:270:plane 1C] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0
<7> [137.616050] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:270:plane 1C] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0
<7> [137.616191] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:270:plane 1C] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0
<7> [137.616352] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:386:pipe C] data rate 559716 num active planes 1
<7> [137.616488] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 560
<7> [137.616621] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [137.616766] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:386:pipe C] min cdclk: 0 kHz -> 69965 kHz
<7> [137.616917] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:386:pipe C] allocated DPLL 0
<7> [137.617057] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:386:pipe C] reserving DPLL 0
<7> [137.617208] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:386:pipe C] enable: yes [modeset]
<7> [137.617366] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [137.617499] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: C, pipe bpp: 24, dithering: 0
<7> [137.617634] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [137.617768] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [137.617901] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [137.618033] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [137.618176] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [137.618328] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [137.618459] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [137.618592] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 42, guardband: 44 vsync start: 0, vsync end: 0
<7> [137.618726] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1081, vmax vblank: 1081, vmin vtotal: 1125, vmax vtotal: 1125
<7> [137.618859] 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> [137.618990] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [137.619133] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [137.619283] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [137.619418] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 53 139929 1920 2008 2096 2360 1080 1084 1089 1125 0x40 0x5
<7> [137.619550] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [137.619682] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139929, pipe src: 1920x1080+0+0, pixel rate 139929, min cdclk 69965
<7> [137.619814] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0
<7> [137.619947] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [137.620080] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [137.620225] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [137.620374] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1a6655d, cfgcr1: 0xe84, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [137.620504] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [137.620634] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [137.620764] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [137.620897] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [137.621029] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [137.621170] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [137.621320] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [137.621453] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [137.621585] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [137.621718] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [137.621848] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [137.621977] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [137.622116] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [137.622265] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:270:plane 1C] fb: [FB:419] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000001, visible: yes
<7> [137.622399] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [137.622532] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [137.622663] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:300:plane 2C] fb: [NOFB], visible: no
<7> [137.622794] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:330:plane 3C] fb: [NOFB], visible: no
<7> [137.622924] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:360:plane 4C] fb: [NOFB], visible: no
<7> [137.623054] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:370:plane 5C] fb: [NOFB], visible: no
<7> [137.623196] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:380:cursor C] fb: [NOFB], visible: no
<7> [137.623810] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [137.623961] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_4
<7> [137.624131] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:388:DDI B/PHY B]
<7> [137.624285] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:398:DDI TC1/PHY C]
<7> [137.624420] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:402:DDI TC2/PHY D]
<7> [137.624556] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:404:DP-MST A]
<7> [137.624690] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:405:DP-MST B]
<7> [137.624822] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:406:DP-MST C]
<7> [137.624988] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [137.625195] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x4, on? 0) for [CRTC:386:pipe C]
<7> [137.625339] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0
<7> [137.625517] i915 0000:00:02.0: [drm:intel_dp_dual_mode_set_tmds_output [i915]] Enabling DP dual mode adaptor TMDS output
<7> [137.630308] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [137.630484] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe C
<7> [137.650493] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:389:HDMI-A-1]
<7> [137.650755] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:386:pipe C]
<7> [148.048161] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:420] from all active usage due to RMFB ioctl
<7> [148.048287] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:270:plane 1C] because [FB:420] is removed
<7> [148.048403] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:270:plane 1C] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0
<7> [148.048949] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:270: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> [148.049540] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:270:plane 1C] lines 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [148.050226] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:270:plane 1C] blocks 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [148.050767] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:270:plane 1C] min_ddb 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [148.051404] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:386:pipe C] data rate 0 num active planes 0
<7> [148.052080] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 0
<6> [148.068207] [IGT] kms_flip: finished subtest C-HDMI-A1, SUCCESS
<6> [148.072373] [IGT] kms_flip: finished subtest wf_vblank-ts-check-interruptible, FAIL
<6> [148.079860] [IGT] kms_flip: exiting, ret=98
<7> [148.081268] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [148.102273] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:389:HDMI-A-1] Limiting target display pipe bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [148.102923] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [148.103511] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:150:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [148.104117] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:388:DDI B/PHY B] [CRTC:150:pipe A]
<7> [148.104708] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [148.105337] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [148.105898] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [148.106526] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [148.107121] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [148.107687] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [148.108287] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [148.108840] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2360)
<7> [148.109459] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [148.110018] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2360)
<7> [148.110710] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [148.111215] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2096)
<7> [148.111682] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [148.112170] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [148.112645] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [148.113216] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [148.113670] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [148.114032] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [148.114584] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [148.114993] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2360)
<7> [148.115390] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [148.115749] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2360)
<7> [148.116125] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [148.116485] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2096)
<7> [148.116762] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [148.117004] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [148.117278] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [148.117520] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [148.117760] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [148.118002] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [148.118277] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [148.118521] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [148.118798] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [148.119042] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [148.119318] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 139929)
<7> [148.119560] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 139929)
<7> [148.119807] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:150:pipe A] fastset requirement not met in port_clock (expected 0, found 139929)
<7> [148.120032] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:150:pipe A] fastset requirement not met, forcing full modeset
<7> [148.120213] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.enable (expected yes, found no)
<7> [148.120380] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.active (expected yes, found no)
<7> [148.120557] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in cpu_transcoder (expected 2, found -1)
<7> [148.120726] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in lane_count (expected 4, found 0)
<7> [148.120893] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [148.121060] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [148.121248] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [148.121413] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2360, found 0)
<7> [148.121578] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [148.121744] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2360, found 0)
<7> [148.121909] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [148.122089] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2096, found 0)
<7> [148.122255] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [148.122424] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [148.122590] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [148.122740] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [148.122873] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [148.123006] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [148.123153] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [148.123286] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2360, found 0)
<7> [148.123431] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [148.123562] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2360, found 0)
<7> [148.123693] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [148.123824] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2096, found 0)
<7> [148.123956] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [148.124095] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [148.124228] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [148.124361] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [148.124493] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [148.124625] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [148.124760] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [148.124895] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [148.125029] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [148.125190] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [148.125325] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 139929, found 0)
<7> [148.125457] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 139929, found 0)
<7> [148.125591] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:386:pipe C] fastset requirement not met in port_clock (expected 139929, found 0)
<7> [148.125724] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:386:pipe C] fastset requirement not met, forcing full modeset
<7> [148.125857] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:386:pipe C] releasing DPLL 0
<7> [148.126023] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:150:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x4 -> 0x1
<7> [148.126188] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:386:pipe C] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x4 -> 0x1
<7> [148.126341] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:34:plane 1A] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016
<7> [148.126472] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:144:cursor A] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32
<7> [148.126601] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [148.126728] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0
<7> [148.126857] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0
<7> [148.126988] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:34:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0
<7> [148.127148] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:380:cursor C] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0
<7> [148.127294] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:150:pipe A] data rate 559716 num active planes 1
<7> [148.127434] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 560
<7> [148.127569] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [148.127719] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:150:pipe A] min cdclk: 0 kHz -> 69965 kHz
<7> [148.127855] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:386:pipe C] min cdclk: 69965 kHz -> 0 kHz
<7> [148.128004] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:150:pipe A] allocated DPLL 0
<7> [148.128154] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:150:pipe A] reserving DPLL 0
<7> [148.128292] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:150:pipe A] enable: yes [modeset]
<7> [148.128445] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [148.128580] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [148.128712] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [148.128847] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [148.128981] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [148.129135] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [148.129269] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [148.129404] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [148.129538] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [148.129673] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 42, guardband: 44 vsync start: 0, vsync end: 0
<7> [148.129810] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1081, vmax vblank: 1081, vmin vtotal: 1125, vmax vtotal: 1125
<7> [148.129944] 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> [148.130084] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [148.130216] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [148.130348] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [148.130481] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 53 139929 1920 2008 2096 2360 1080 1084 1089 1125 0x40 0x5
<7> [148.130613] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [148.130747] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139929, pipe src: 1920x1080+0+0, pixel rate 139929, min cdclk 69965
<7> [148.130882] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0
<7> [148.131016] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [148.131161] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [148.131295] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [148.131427] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1a6655d, cfgcr1: 0xe84, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [148.131557] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [148.131702] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [148.131831] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [148.131965] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [148.132110] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [148.132241] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [148.132371] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [148.132500] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [148.132630] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [148.132761] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [148.132891] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [148.133021] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [148.133164] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [148.133298] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:plane 1A] fb: [FB:414] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [148.133431] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [148.133564] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [148.133697] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:64:plane 2A] fb: [NOFB], visible: no
<7> [148.133829] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:94:plane 3A] fb: [NOFB], visible: no
<7> [148.133962] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:124:plane 4A] fb: [NOFB], visible: no
<7> [148.134104] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:134:plane 5A] fb: [NOFB], visible: no
<7> [148.134233] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:144:cursor A] fb: [NOFB], visible: no
<7> [148.134362] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:386:pipe C] enable: no [modeset]
<7> [148.134493] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:270:plane 1C] fb: [NOFB], visible: no
<7> [148.134622] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:300:plane 2C] fb: [NOFB], visible: no
<7> [148.134751] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:330:plane 3C] fb: [NOFB], visible: no
<7> [148.134897] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:360:plane 4C] fb: [NOFB], visible: no
<7> [148.135026] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:370:plane 5C] fb: [NOFB], visible: no
<7> [148.135173] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:380:cursor C] fb: [NOFB], visible: no
<7> [148.135799] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe C
<7> [148.144168] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [148.144332] i915 0000:00:02.0: [drm:intel_dp_dual_mode_set_tmds_output [i915]] Disabling DP dual mode adaptor TMDS output
<7> [148.149146] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x4, on? 1) for [CRTC:386:pipe C]
<7> [148.149305] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0
<7> [148.149450] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:388:DDI B/PHY B]
<7> [148.149587] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:398:DDI TC1/PHY C]
<7> [148.149720] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:402:DDI TC2/PHY D]
<7> [148.149853] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:404:DP-MST A]
<7> [148.149985] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:405:DP-MST B]
<7> [148.150128] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:406:DP-MST C]
<7> [148.150371] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:150:pipe A]
<7> [148.150510] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0
<7> [148.150687] i915 0000:00:02.0: [drm:intel_dp_dual_mode_set_tmds_output [i915]] Enabling DP dual mode adaptor TMDS output
<7> [148.155536] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [148.155712] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [148.156095] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1
<7> [148.156230] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:34:plane 1A]
<7> [148.175478] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:389:HDMI-A-1]
<7> [148.175916] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:150:pipe A]
<7> [148.176955] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_4
<7> [148.177318] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:386:pipe C]
<7> [148.177778] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3
<7> [148.178361] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0
<6> [148.194625] Console: switching to colour frame buffer device 240x67
<7> [148.231330] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [148.231971] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [148.232647] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
Created at 2026-03-19 06:07:10