Results for igt@kms_flip@blocking-wf_vblank@b-dp2

Result: Fail

i915_display_info13 igt_runner13 results13.json results13-xe-load.json guc_logs13.tar i915_display_info_post_exec13 boot13 dmesg13

DetailValue
Duration 11.88 seconds
Hostname 
shard-bmg-7
Igt-Version 
IGT-Version: 2.4-g0a8f2f8f5 (x86_64) (Linux: 7.0.0-rc6-lgci-xe-xe-pw-161217v3-debug+ x86_64)
Out 
Starting dynamic subtest: B-DP2
  1920x1080: 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 
Expected frametime: 16667us; measured 16089.1us +- 6.981us accuracy 0.13%
vblank interval differs from modeline! expected 16666.7us, measured 16089us +- 6.981us, difference 577.6us (82.7 sigma)
Event vblank: expected 242, counted 240, passrate = 33.33%, encoder type 2
Expected frametime: 16667us; measured 16437.7us +- 8.546us accuracy 0.16%
vblank interval differs from modeline! expected 16666.7us, measured 16438us +- 8.546us, difference 229.0us (26.8 sigma)
Event vblank: expected 230, counted 230, passrate = 78.26%, 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:2126 __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 B-DP2: FAIL (11.881s)
Err 
Starting dynamic subtest: B-DP2
(kms_flip:14274) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1711:
(kms_flip:14274) CRITICAL: Failed assertion: !retried
Dynamic subtest B-DP2 failed.
**** DEBUG ****
(kms_flip:14274) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x100000000000009, size=0)
(kms_flip:14274) drmtest-DEBUG: Test requirement passed: is_intel_device(fd)
(kms_flip:14274) drmtest-DEBUG: Test requirement passed: is_intel_device(fd)
(kms_flip:14274) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=3, pitch=7680)
(kms_flip:14274) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:14274) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x100000000000009, size=0)
(kms_flip:14274) drmtest-DEBUG: Test requirement passed: is_intel_device(fd)
(kms_flip:14274) drmtest-DEBUG: Test requirement passed: is_intel_device(fd)
(kms_flip:14274) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=4, pitch=7680)
(kms_flip:14274) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:14274) intel_allocator_simple-DEBUG: Using simple allocator
(kms_flip:14274) intel_allocator_simple-DEBUG: <ial: 0x5c7af89237b0, fd: 5> objects: 3, reserved_areas: 0
(kms_flip:14274) intel_allocator_simple-DEBUG: <ial: 0x5c7af89237b0, fd: 5> objects: 3, reserved_areas: 0
(kms_flip:14274) intel_allocator_simple-DEBUG: Using simple allocator
(kms_flip:14274) intel_allocator_simple-DEBUG: <ial: 0x5c7af89237b0, fd: 5> objects: 3, reserved_areas: 0
(kms_flip:14274) intel_allocator_simple-DEBUG: <ial: 0x5c7af89237b0, fd: 5> objects: 3, reserved_areas: 0
(kms_flip:14274) intel_allocator_simple-DEBUG: Using simple allocator
(kms_flip:14274) intel_allocator_simple-DEBUG: <ial: 0x5c7af89a6700, fd: 5> objects: 3, reserved_areas: 0
(kms_flip:14274) intel_allocator_simple-DEBUG: <ial: 0x5c7af89a6700, fd: 5> objects: 3, reserved_areas: 0
(kms_flip:14274) intel_allocator_simple-DEBUG: Using simple allocator
(kms_flip:14274) intel_allocator_simple-DEBUG: <ial: 0x5c7af89237b0, fd: 5> objects: 3, reserved_areas: 0
(kms_flip:14274) intel_allocator_simple-DEBUG: <ial: 0x5c7af89237b0, fd: 5> objects: 3, reserved_areas: 0
(kms_flip:14274) igt_kms-INFO:   1920x1080: 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 
(kms_flip:14274) DEBUG: No stale events found
(kms_flip:14274) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0
(kms_flip:14274) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0
(kms_flip:14274) INFO: Expected frametime: 16667us; measured 16089.1us +- 6.981us accuracy 0.13%
(kms_flip:14274) INFO: vblank interval differs from modeline! expected 16666.7us, measured 16089us +- 6.981us, difference 577.6us (82.7 sigma)
(kms_flip:14274) DEBUG: name = vblank
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 534.759705
current_received_ts = 534.759460
current_seq = 8539
count = 0
seq_step = 10
(kms_flip:14274) DEBUG: name = vblank
last_ts = 534.759705
last_received_ts = 534.759460
last_seq = 8539
current_ts = 534.920532
current_received_ts = 534.920654
current_seq = 8549
count = 1
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 534.759705/8539, current 534.920532/8549: elapsed=160880.0us expected=160890.6us +- 804.5us, error 0.0%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 534.920532
last_received_ts = 534.920654
last_seq = 8549
current_ts = 535.082092
current_received_ts = 535.082092
current_seq = 8559
count = 2
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 534.920532/8549, current 535.082092/8559: elapsed=161553.0us expected=160890.6us +- 804.5us, error 0.4%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 535.082092
last_received_ts = 535.082092
last_seq = 8559
current_ts = 535.243713
current_received_ts = 535.243713
current_seq = 8569
count = 3
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 535.082092/8559, current 535.243713/8569: elapsed=161596.0us expected=160890.6us +- 804.5us, error 0.4%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 535.243713
last_received_ts = 535.243713
last_seq = 8569
current_ts = 535.405273
current_received_ts = 535.405334
current_seq = 8579
count = 4
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 535.243713/8569, current 535.405273/8579: elapsed=161597.0us expected=160890.6us +- 804.5us, error 0.4%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 535.405273
last_received_ts = 535.405334
last_seq = 8579
current_ts = 535.566895
current_received_ts = 535.567017
current_seq = 8589
count = 5
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 535.405273/8579, current 535.566895/8589: elapsed=161610.0us expected=160890.6us +- 804.5us, error 0.4%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 535.566895
last_received_ts = 535.567017
last_seq = 8589
current_ts = 535.728516
current_received_ts = 535.728638
current_seq = 8599
count = 6
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 535.566895/8589, current 535.728516/8599: elapsed=161598.0us expected=160890.6us +- 804.5us, error 0.4%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 535.728516
last_received_ts = 535.728638
last_seq = 8599
current_ts = 535.890137
current_received_ts = 535.890137
current_seq = 8609
count = 7
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 535.728516/8599, current 535.890137/8609: elapsed=161606.0us expected=160890.6us +- 804.5us, error 0.4%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 535.890137
last_received_ts = 535.890137
last_seq = 8609
current_ts = 536.052185
current_received_ts = 536.052124
current_seq = 8619
count = 8
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 535.890137/8609, current 536.052185/8619: elapsed=162043.0us expected=160890.6us +- 804.5us, error 0.7%
(kms_flip:14274) DEBUG: inconsistent vblank ts/seq: last 535.890137/8609, current 536.052185/8619: elapsed=162043.0us expected=160890.6us
(kms_flip:14274) DEBUG: name = vblank
last_ts = 536.052185
last_received_ts = 536.052124
last_seq = 8619
current_ts = 536.214417
current_received_ts = 536.214417
current_seq = 8629
count = 9
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 536.052185/8619, current 536.214417/8629: elapsed=162234.0us expected=160890.6us +- 804.5us, error 0.8%
(kms_flip:14274) DEBUG: inconsistent vblank ts/seq: last 536.052185/8619, current 536.214417/8629: elapsed=162234.0us expected=160890.6us
(kms_flip:14274) DEBUG: name = vblank
last_ts = 536.214417
last_received_ts = 536.214417
last_seq = 8629
current_ts = 536.376587
current_received_ts = 536.376709
current_seq = 8639
count = 10
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 536.214417/8629, current 536.376587/8639: elapsed=162219.0us expected=160890.6us +- 804.5us, error 0.8%
(kms_flip:14274) DEBUG: inconsistent vblank ts/seq: last 536.214417/8629, current 536.376587/8639: elapsed=162219.0us expected=160890.6us
(kms_flip:14274) DEBUG: name = vblank
last_ts = 536.376587
last_received_ts = 536.376709
last_seq = 8639
current_ts = 536.538818
current_received_ts = 536.538940
current_seq = 8649
count = 11
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 536.376587/8639, current 536.538818/8649: elapsed=162229.0us expected=160890.6us +- 804.5us, error 0.8%
(kms_flip:14274) DEBUG: inconsistent vblank ts/seq: last 536.376587/8639, current 536.538818/8649: elapsed=162229.0us expected=160890.6us
(kms_flip:14274) DEBUG: name = vblank
last_ts = 536.538818
last_received_ts = 536.538940
last_seq = 8649
current_ts = 536.701050
current_received_ts = 536.701172
current_seq = 8659
count = 12
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 536.538818/8649, current 536.701050/8659: elapsed=162235.0us expected=160890.6us +- 804.5us, error 0.8%
(kms_flip:14274) DEBUG: inconsistent vblank ts/seq: last 536.538818/8649, current 536.701050/8659: elapsed=162235.0us expected=160890.6us
(kms_flip:14274) DEBUG: name = vblank
last_ts = 536.701050
last_received_ts = 536.701172
last_seq = 8659
current_ts = 536.863281
current_received_ts = 536.863403
current_seq = 8669
count = 13
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 536.701050/8659, current 536.863281/8669: elapsed=162216.0us expected=160890.6us +- 804.5us, error 0.8%
(kms_flip:14274) DEBUG: inconsistent vblank ts/seq: last 536.701050/8659, current 536.863281/8669: elapsed=162216.0us expected=160890.6us
(kms_flip:14274) DEBUG: name = vblank
last_ts = 536.863281
last_received_ts = 536.863403
last_seq = 8669
current_ts = 537.025818
current_received_ts = 537.025757
current_seq = 8679
count = 14
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 536.863281/8669, current 537.025818/8679: elapsed=162502.0us expected=160890.6us +- 804.5us, error 1.0%
(kms_flip:14274) DEBUG: inconsistent vblank ts/seq: last 536.863281/8669, current 537.025818/8679: elapsed=162502.0us expected=160890.6us
(kms_flip:14274) DEBUG: name = vblank
last_ts = 537.025818
last_received_ts = 537.025757
last_seq = 8679
current_ts = 537.188599
current_received_ts = 537.188599
current_seq = 8689
count = 15
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 537.025818/8679, current 537.188599/8689: elapsed=162777.0us expected=160890.6us +- 804.5us, error 1.2%
(kms_flip:14274) DEBUG: inconsistent vblank ts/seq: last 537.025818/8679, current 537.188599/8689: elapsed=162777.0us expected=160890.6us
(kms_flip:14274) DEBUG: name = vblank
last_ts = 537.188599
last_received_ts = 537.188599
last_seq = 8689
current_ts = 537.351379
current_received_ts = 537.351135
current_seq = 8699
count = 16
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 537.188599/8689, current 537.351379/8699: elapsed=162784.0us expected=160890.6us +- 804.5us, error 1.2%
(kms_flip:14274) DEBUG: inconsistent vblank ts/seq: last 537.188599/8689, current 537.351379/8699: elapsed=162784.0us expected=160890.6us
(kms_flip:14274) DEBUG: name = vblank
last_ts = 537.351379
last_received_ts = 537.351135
last_seq = 8699
current_ts = 537.514099
current_received_ts = 537.514221
current_seq = 8709
count = 17
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 537.351379/8699, current 537.514099/8709: elapsed=162759.0us expected=160890.6us +- 804.5us, error 1.2%
(kms_flip:14274) DEBUG: inconsistent vblank ts/seq: last 537.351379/8699, current 537.514099/8709: elapsed=162759.0us expected=160890.6us
(kms_flip:14274) DEBUG: name = vblank
last_ts = 537.514099
last_received_ts = 537.514221
last_seq = 8709
current_ts = 537.676880
current_received_ts = 537.676941
current_seq = 8719
count = 18
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 537.514099/8709, current 537.676880/8719: elapsed=162768.0us expected=160890.6us +- 804.5us, error 1.2%
(kms_flip:14274) DEBUG: inconsistent vblank ts/seq: last 537.514099/8709, current 537.676880/8719: elapsed=162768.0us expected=160890.6us
(kms_flip:14274) DEBUG: name = vblank
last_ts = 537.676880
last_received_ts = 537.676941
last_seq = 8719
current_ts = 537.839661
current_received_ts = 537.839722
current_seq = 8729
count = 19
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 537.676880/8719, current 537.839661/8729: elapsed=162775.0us expected=160890.6us +- 804.5us, error 1.2%
(kms_flip:14274) DEBUG: inconsistent vblank ts/seq: last 537.676880/8719, current 537.839661/8729: elapsed=162775.0us expected=160890.6us
(kms_flip:14274) DEBUG: name = vblank
last_ts = 537.839661
last_received_ts = 537.839722
last_seq = 8729
current_ts = 538.002625
current_received_ts = 538.002625
current_seq = 8739
count = 20
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 537.839661/8729, current 538.002625/8739: elapsed=162961.0us expected=160890.6us +- 804.5us, error 1.3%
(kms_flip:14274) DEBUG: inconsistent vblank ts/seq: last 537.839661/8729, current 538.002625/8739: elapsed=162961.0us expected=160890.6us
(kms_flip:14274) DEBUG: name = vblank
last_ts = 538.002625
last_received_ts = 538.002625
last_seq = 8739
current_ts = 538.165894
current_received_ts = 538.165894
current_seq = 8749
count = 21
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 538.002625/8739, current 538.165894/8749: elapsed=163254.0us expected=160890.6us +- 804.5us, error 1.5%
(kms_flip:14274) DEBUG: inconsistent vblank ts/seq: last 538.002625/8739, current 538.165894/8749: elapsed=163254.0us expected=160890.6us
(kms_flip:14274) DEBUG: name = vblank
last_ts = 538.165894
last_received_ts = 538.165894
last_seq = 8749
current_ts = 538.329102
current_received_ts = 538.329163
current_seq = 8759
count = 22
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 538.165894/8749, current 538.329102/8759: elapsed=163253.0us expected=160890.6us +- 804.5us, error 1.5%
(kms_flip:14274) DEBUG: inconsistent vblank ts/seq: last 538.165894/8749, current 538.329102/8759: elapsed=163253.0us expected=160890.6us
(kms_flip:14274) DEBUG: name = vblank
last_ts = 538.329102
last_received_ts = 538.329163
last_seq = 8759
current_ts = 538.492371
current_received_ts = 538.492371
current_seq = 8769
count = 23
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 538.329102/8759, current 538.492371/8769: elapsed=163244.0us expected=160890.6us +- 804.5us, error 1.5%
(kms_flip:14274) DEBUG: inconsistent vblank ts/seq: last 538.329102/8759, current 538.492371/8769: elapsed=163244.0us expected=160890.6us
(kms_flip:14274) INFO: Event vblank: expected 242, counted 240, passrate = 33.33%, encoder type 2
(kms_flip:14274) DEBUG: dropped frames, expected 242, counted 240, passrate = 33.33%, encoder type 2
(kms_flip:14274) DEBUG: Retrying without a hotplug event
(kms_flip:14274) DEBUG: No stale events found
(kms_flip:14274) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0
(kms_flip:14274) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0
(kms_flip:14274) INFO: Expected frametime: 16667us; measured 16437.7us +- 8.546us accuracy 0.16%
(kms_flip:14274) INFO: vblank interval differs from modeline! expected 16666.7us, measured 16438us +- 8.546us, difference 229.0us (26.8 sigma)
(kms_flip:14274) DEBUG: name = vblank
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 542.130005
current_received_ts = 542.129944
current_seq = 8984
count = 0
seq_step = 10
(kms_flip:14274) DEBUG: name = vblank
last_ts = 542.130005
last_received_ts = 542.129944
last_seq = 8984
current_ts = 542.294617
current_received_ts = 542.294617
current_seq = 8994
count = 1
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 542.130005/8984, current 542.294617/8994: elapsed=164632.0us expected=164376.9us +- 821.9us, error 0.2%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 542.294617
last_received_ts = 542.294617
last_seq = 8994
current_ts = 542.459290
current_received_ts = 542.459290
current_seq = 9004
count = 2
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 542.294617/8994, current 542.459290/9004: elapsed=164641.0us expected=164376.9us +- 821.9us, error 0.2%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 542.459290
last_received_ts = 542.459290
last_seq = 9004
current_ts = 542.623901
current_received_ts = 542.623901
current_seq = 9014
count = 3
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 542.459290/9004, current 542.623901/9014: elapsed=164625.0us expected=164376.9us +- 821.9us, error 0.2%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 542.623901
last_received_ts = 542.623901
last_seq = 9014
current_ts = 542.788513
current_received_ts = 542.788574
current_seq = 9024
count = 4
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 542.623901/9014, current 542.788513/9024: elapsed=164632.0us expected=164376.9us +- 821.9us, error 0.2%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 542.788513
last_received_ts = 542.788574
last_seq = 9024
current_ts = 542.953186
current_received_ts = 542.953064
current_seq = 9034
count = 5
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 542.788513/9024, current 542.953186/9034: elapsed=164669.0us expected=164376.9us +- 821.9us, error 0.2%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 542.953186
last_received_ts = 542.953064
last_seq = 9034
current_ts = 543.118042
current_received_ts = 543.118103
current_seq = 9044
count = 6
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 542.953186/9034, current 543.118042/9044: elapsed=164874.0us expected=164376.9us +- 821.9us, error 0.3%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 543.118042
last_received_ts = 543.118103
last_seq = 9044
current_ts = 543.282959
current_received_ts = 543.282898
current_seq = 9054
count = 7
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 543.118042/9044, current 543.282959/9054: elapsed=164868.0us expected=164376.9us +- 821.9us, error 0.3%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 543.282959
last_received_ts = 543.282898
last_seq = 9054
current_ts = 543.447815
current_received_ts = 543.447815
current_seq = 9064
count = 8
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 543.282959/9054, current 543.447815/9064: elapsed=164875.0us expected=164376.9us +- 821.9us, error 0.3%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 543.447815
last_received_ts = 543.447815
last_seq = 9064
current_ts = 543.612671
current_received_ts = 543.612305
current_seq = 9074
count = 9
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 543.447815/9064, current 543.612671/9074: elapsed=164886.0us expected=164376.9us +- 821.9us, error 0.3%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 543.612671
last_received_ts = 543.612305
last_seq = 9074
current_ts = 543.777588
current_received_ts = 543.777222
current_seq = 9084
count = 10
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 543.612671/9074, current 543.777588/9084: elapsed=164872.0us expected=164376.9us +- 821.9us, error 0.3%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 543.777588
last_received_ts = 543.777222
last_seq = 9084
current_ts = 543.942444
current_received_ts = 543.942505
current_seq = 9094
count = 11
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 543.777588/9084, current 543.942444/9094: elapsed=164878.0us expected=164376.9us +- 821.9us, error 0.3%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 543.942444
last_received_ts = 543.942505
last_seq = 9094
current_ts = 544.107544
current_received_ts = 544.107544
current_seq = 9104
count = 12
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 543.942444/9094, current 544.107544/9104: elapsed=165092.0us expected=164376.9us +- 821.9us, error 0.4%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 544.107544
last_received_ts = 544.107544
last_seq = 9104
current_ts = 544.272644
current_received_ts = 544.272644
current_seq = 9114
count = 13
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 544.107544/9104, current 544.272644/9114: elapsed=165092.0us expected=164376.9us +- 821.9us, error 0.4%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 544.272644
last_received_ts = 544.272644
last_seq = 9114
current_ts = 544.437744
current_received_ts = 544.437744
current_seq = 9124
count = 14
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 544.272644/9114, current 544.437744/9124: elapsed=165097.0us expected=164376.9us +- 821.9us, error 0.4%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 544.437744
last_received_ts = 544.437744
last_seq = 9124
current_ts = 544.602783
current_received_ts = 544.602783
current_seq = 9134
count = 15
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 544.437744/9124, current 544.602783/9134: elapsed=165090.0us expected=164376.9us +- 821.9us, error 0.4%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 544.602783
last_received_ts = 544.602783
last_seq = 9134
current_ts = 544.767883
current_received_ts = 544.767883
current_seq = 9144
count = 16
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 544.602783/9134, current 544.767883/9144: elapsed=165084.0us expected=164376.9us +- 821.9us, error 0.4%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 544.767883
last_received_ts = 544.767883
last_seq = 9144
current_ts = 544.932983
current_received_ts = 544.932983
current_seq = 9154
count = 17
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 544.767883/9144, current 544.932983/9154: elapsed=165103.0us expected=164376.9us +- 821.9us, error 0.4%
(kms_flip:14274) DEBUG: name = vblank
last_ts = 544.932983
last_received_ts = 544.932983
last_seq = 9154
current_ts = 545.098267
current_received_ts = 545.098328
current_seq = 9164
count = 18
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 544.932983/9154, current 545.098267/9164: elapsed=165283.0us expected=164376.9us +- 821.9us, error 0.6%
(kms_flip:14274) DEBUG: inconsistent vblank ts/seq: last 544.932983/9154, current 545.098267/9164: elapsed=165283.0us expected=164376.9us
(kms_flip:14274) DEBUG: name = vblank
last_ts = 545.098267
last_received_ts = 545.098328
last_seq = 9164
current_ts = 545.263550
current_received_ts = 545.263672
current_seq = 9174
count = 19
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 545.098267/9164, current 545.263550/9174: elapsed=165277.0us expected=164376.9us +- 821.9us, error 0.5%
(kms_flip:14274) DEBUG: inconsistent vblank ts/seq: last 545.098267/9164, current 545.263550/9174: elapsed=165277.0us expected=164376.9us
(kms_flip:14274) DEBUG: name = vblank
last_ts = 545.263550
last_received_ts = 545.263672
last_seq = 9174
current_ts = 545.428833
current_received_ts = 545.428894
current_seq = 9184
count = 20
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 545.263550/9174, current 545.428833/9184: elapsed=165268.0us expected=164376.9us +- 821.9us, error 0.5%
(kms_flip:14274) DEBUG: inconsistent vblank ts/seq: last 545.263550/9174, current 545.428833/9184: elapsed=165268.0us expected=164376.9us
(kms_flip:14274) DEBUG: name = vblank
last_ts = 545.428833
last_received_ts = 545.428894
last_seq = 9184
current_ts = 545.594116
current_received_ts = 545.594177
current_seq = 9194
count = 21
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 545.428833/9184, current 545.594116/9194: elapsed=165281.0us expected=164376.9us +- 821.9us, error 0.6%
(kms_flip:14274) DEBUG: inconsistent vblank ts/seq: last 545.428833/9184, current 545.594116/9194: elapsed=165281.0us expected=164376.9us
(kms_flip:14274) DEBUG: name = vblank
last_ts = 545.594116
last_received_ts = 545.594177
last_seq = 9194
current_ts = 545.759399
current_received_ts = 545.759399
current_seq = 9204
count = 22
seq_step = 10
(kms_flip:14274) DEBUG: vblank ts/seq: last 545.594116/9194, current 545.759399/9204: elapsed=165289.0us expected=164376.9us +- 821.9us, error 0.6%
(kms_flip:14274) DEBUG: inconsistent vblank ts/seq: last 545.594116/9194, current 545.759399/9204: elapsed=165289.0us expected=164376.9us
(kms_flip:14274) INFO: Event vblank: expected 230, counted 230, passrate = 78.26%, encoder type 2
(kms_flip:14274) DEBUG: dropped frames, expected 230, counted 230, passrate = 78.26%, encoder type 2
(kms_flip:14274) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1711:
(kms_flip:14274) CRITICAL: Failed assertion: !retried
(kms_flip:14274) igt_core-INFO: Stack trace:
(kms_flip:14274) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(kms_flip:14274) igt_core-INFO:   #1 ../tests/kms_flip.c:428 run_test_on_crtc_set.constprop.0()
(kms_flip:14274) igt_core-INFO:   #2 ../tests/kms_flip.c:1891 run_test()
(kms_flip:14274) igt_core-INFO:   #3 ../tests/kms_flip.c:2126 __igt_unique____real_main2047()
(kms_flip:14274) igt_core-INFO:   #4 ../tests/kms_flip.c:2047 main()
(kms_flip:14274) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:14274) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:14274) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest B-DP2: FAIL (11.881s)
Dmesg
<6> [549.193398] [IGT] kms_flip: starting dynamic subtest B-DP2
<7> [549.193973] xe 0000:03:00.0: [drm:drm_mode_addfb2] [FB:555]
<7> [549.194272] xe 0000:03:00.0: [drm:drm_mode_addfb2] [FB:561]
<7> [549.251659] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:151:pipe A]
<7> [549.251806] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [549.252027] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [549.252218] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [549.252425] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [549.252601] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in dp_m_n (expected tu 64 data 5190451/8388608 link 288358/524288, found tu 0, data 0/0 link 0/0)
<7> [549.252773] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in output_types (expected 0x00000080, found 0x00000000)
<7> [549.252938] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [549.253099] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [549.253263] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [549.253432] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [549.253580] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [549.253730] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [549.253870] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [549.254009] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [549.254147] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [549.254282] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [549.254433] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [549.254566] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [549.254698] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [549.254826] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [549.254952] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [549.255075] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [549.255197] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [549.255319] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [549.255456] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [549.255576] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [549.255693] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [549.255809] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [549.255924] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [549.256036] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [549.256148] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [549.256259] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [549.256368] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [549.256487] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [549.256596] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in enhanced_framing (expected yes, found no)
<7> [549.256702] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [549.256807] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [549.256911] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [549.257015] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:151:pipe A] fastset requirement not met in port_clock (expected 270000, found 0)
<7> [549.257120] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:151:pipe A] fastset requirement not met, forcing full modeset
<7> [549.257226] xe 0000:03:00.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:151:pipe A] releasing TC PLL 2
<7> [549.257362] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [549.257459] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:151:pipe A] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [549.257562] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:35:plane 1A] ddb ( 0 - 4037) -> ( 0 - 0), size 4037 -> 0
<7> [549.257643] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:145:cursor A] ddb (4037 - 4096) -> ( 0 - 0), size 59 -> 0
<7> [549.257724] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [549.257805] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] lines 4, 4, 9, 9, 17, 17, 17, 17, 0, 15, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [549.257882] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] blocks 62, 62, 139, 139, 261, 261, 261, 261, 137, 230, 244 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [549.257956] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:35:plane 1A] min_ddb 123, 123, 245, 245, 367, 367, 0, 0, 138, 306, 306 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [549.258039] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:151:pipe A] data rate 0 num active planes 0
<7> [549.258140] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 0 qgv_peak_bw: 48000
<7> [549.258236] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 0 qgv_peak_bw: 48000
<7> [549.258329] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 0
<7> [549.258424] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:151:pipe A] min cdclk: 192000 kHz -> 0 kHz
<7> [549.258545] xe 0000:03:00.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 9282 kHz -> 0 kHz
<7> [549.258656] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:151:pipe A] enable: no [modeset]
<7> [549.258754] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:35:plane 1A] fb: [NOFB], visible: no
<7> [549.258848] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:65:plane 2A] fb: [NOFB], visible: no
<7> [549.258941] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:95:plane 3A] fb: [NOFB], visible: no
<7> [549.259031] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:125:plane 4A] fb: [NOFB], visible: no
<7> [549.259123] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:135:plane 5A] fb: [NOFB], visible: no
<7> [549.259216] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:145:cursor A] fb: [NOFB], visible: no
<7> [549.259626] xe 0000:03:00.0: [drm:intel_audio_codec_disable [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G] Disable audio codec on [CRTC:151:pipe A]
<7> [549.286337] xe 0000:03:00.0: [drm:intel_disable_transcoder [xe]] disabling pipe A
<7> [549.304308] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC2
<7> [549.307300] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disable TC PLL 2 (active 0x1, on? 1) for [CRTC:151:pipe A]
<7> [549.310080] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disabling TC PLL 2
<7> [549.310959] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:507:DDI TC1/PHY F]
<7> [549.311466] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST A]
<7> [549.311888] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST B]
<7> [549.312294] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:511:DP-MST C]
<7> [549.312763] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:512:DP-MST D]
<7> [549.313117] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:526:DDI TC2/PHY G]
<7> [549.313716] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST A]
<7> [549.314069] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST B]
<7> [549.314401] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:530:DP-MST C]
<7> [549.314784] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:531:DP-MST D]
<7> [549.315089] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:538:DDI TC3/PHY H]
<7> [549.315370] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:542:DDI TC4/PHY I]
<7> [549.315816] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST A]
<7> [549.316080] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST B]
<7> [549.316336] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:546:DP-MST C]
<7> [549.316622] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:547:DP-MST D]
<7> [549.316860] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:527:DP-2]
<7> [549.317334] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [549.317784] xe 0000:03:00.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [549.317992] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [549.318727] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling PW_A
<7> [549.319178] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating disabled for pipe_mask=0x1 (CLKGATE_DIS_DSSDSC=0xaa000000)
<7> [549.319433] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [549.319905] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:151:pipe A]
<7> [549.320376] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:269:pipe B]
<7> [549.320674] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:387:pipe C]
<7> [549.321039] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:505:pipe D]
<7> [549.321213] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:269:pipe B]
<7> [549.321247] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CONNECTOR:527:DP-2]
<7> [549.321367] xe 0000:03:00.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:526:DDI TC2/PHY G][CRTC:269:pipe B] DP link limits: pixel clock 148500 kHz DSC off max lanes 4 max rate 540000 max pipe_bpp 36 min link_bpp 18.0000 max link_bpp 36.0000
<7> [549.321550] xe 0000:03:00.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 270000 bpp input 36 compressed 0.0000 HDR no link rate required 668250 available 1080000
<7> [549.321754] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:269:pipe B] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [549.321932] xe 0000:03:00.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:526:DDI TC2/PHY G] [CRTC:269:pipe B]
<7> [549.322103] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [549.322268] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [549.322416] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [549.322562] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [549.322716] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 5190451/8388608 link 288358/524288)
<7> [549.322851] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000080)
<7> [549.322986] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [549.323120] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [549.323250] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [549.323377] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [549.323499] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [549.323617] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [549.323746] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [549.323862] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [549.323977] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [549.324089] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [549.324202] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [549.324315] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [549.324424] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [549.324529] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [549.324633] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [549.324738] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [549.324868] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [549.324966] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [549.325064] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [549.325164] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [549.325261] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [549.325354] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [549.325445] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [549.325535] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [549.325621] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [549.325708] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [549.325799] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [549.325915] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [549.325998] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in enhanced_framing (expected no, found yes)
<7> [549.326081] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in dpll_hw_state
<7> [549.326163] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] expected:
<7> [549.326246] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [549.326330] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] c20pll_hw_state:
<7> [549.326413] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] tx[0] = 0xbe88, tx[1] = 0x5800, tx[2] = 0x0000
<7> [549.326495] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [549.326577] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[0] = 0x40e8
<7> [549.326660] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[1] = 0x7d20
<7> [549.326741] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[2] = 0x0a06
<7> [549.326823] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[3] = 0x8f1c
<7> [549.326939] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[4] = 0x0000
<7> [549.327025] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[5] = 0x0000
<7> [549.327107] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[6] = 0x2200
<7> [549.327190] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[7] = 0xffff
<7> [549.327272] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[8] = 0x0400
<7> [549.327355] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[9] = 0x0000
<7> [549.327436] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[10] = 0x0001
<7> [549.327518] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] vdr: custom width: 0x00, serdes rate: 0x00, hdmi rate: 0x00
<7> [549.327602] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] found:
<7> [549.327684] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [549.327767] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] c20pll_hw_state:
<7> [549.327851] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] tx[0] = 0xbe88, tx[1] = 0x4800, tx[2] = 0x0000
<7> [549.327960] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [549.328042] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[0] = 0x308c
<7> [549.328123] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[1] = 0x2110
<7> [549.328203] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[2] = 0xcc9c
<7> [549.328284] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[3] = 0xbfc1
<7> [549.328369] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[4] = 0x4b9a
<7> [549.328451] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[5] = 0x3f81
<7> [549.328532] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[6] = 0x2000
<7> [549.328613] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[7] = 0x0001
<7> [549.328696] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[8] = 0x5000
<7> [549.328776] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[9] = 0x0000
<7> [549.328856] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] mpllb[10] = 0x0000
<7> [549.328964] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] vdr: custom width: 0x00, serdes rate: 0x42, hdmi rate: 0x00
<7> [549.329063] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [549.329148] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [549.329231] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [549.329313] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in port_clock (expected 0, found 270000)
<7> [549.329396] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:269:pipe B] fastset requirement not met, forcing full modeset
<7> [549.329504] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [549.329578] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:269:pipe B] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x2
<7> [549.329666] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:153:plane 1B] ddb ( 0 - 0) -> ( 0 - 4037), size 0 -> 4037
<7> [549.329734] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:263:cursor B] ddb ( 0 - 0) -> (4037 - 4096), size 0 -> 59
<7> [549.329799] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153: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> [549.329865] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 4, 9, 9, 17, 17, 17, 17, 0, 15, 0
<7> [549.329935] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 62, 62, 139, 139, 261, 261, 261, 261, 137, 230, 244
<7> [549.330040] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 123, 123, 245, 245, 367, 367, 0, 0, 138, 306, 306
<7> [549.330118] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:269:pipe B] data rate 594000 num active planes 1
<7> [549.330209] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 624 qgv_peak_bw: 48000
<7> [549.330296] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 624 qgv_peak_bw: 48000
<7> [549.330382] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 624
<7> [549.330469] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:269:pipe B] min cdclk: 0 kHz -> 192000 kHz
<7> [549.330566] xe 0000:03:00.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 0 kHz -> 9282 kHz
<7> [549.330662] xe 0000:03:00.0: [drm:intel_find_dpll [xe]] [CRTC:269:pipe B] allocated TC PLL 2
<7> [549.330746] xe 0000:03:00.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:269:pipe B] reserving TC PLL 2
<7> [549.330827] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:269:pipe B] enable: yes [modeset]
<7> [549.330916] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: DP (0x80), output format: RGB, sink format: RGB
<7> [549.331033] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: B, pipe bpp: 36, dithering: 0
<7> [549.331127] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [549.331214] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [549.331298] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [549.331381] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [549.331463] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 5190451, data_n: 8388608, link_m: 288358, link_n: 524288, tu: 64
<7> [549.331545] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [549.331627] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: enabled
<7> [549.331708] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [549.331789] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] psr: disabled, selective update: disabled, panel replay: disabled, selective fetch: disabled
<7> [549.331871] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] minimum hblank: 0
<7> [549.331953] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] audio: 1, infoframes: 0, infoframes enabled: 0x0
<7> [549.332048] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 10 00 09 00 68 36 00 01 00 00 00 00 00 00 00 00
<7> [549.332136] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 61 a4 9a 00 44 50 46 39 30 34 33 35 09 07 07 11
<7> [549.332217] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 17 50 51 07 00 00 00 00
<7> [549.332297] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [549.332379] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [549.332460] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 0, guardband: 42 vsync start: 41, vsync end: 36
<7> [549.332542] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1083, vmax vblank: 1083, vmin vtotal: 1125, vmax vtotal: 1125
<7> [549.332626] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [549.332708] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [549.332790] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [549.332872] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [549.332953] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [549.333037] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [549.333168] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port clock: 270000, pixel rate 148500, min cdclk 192000, min voltage level 0
<7> [549.333254] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] linetime: 119, ips linetime: 0
<7> [549.333337] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [549.333419] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe src: 1920x1080+0+0
<7> [549.333501] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [549.333582] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [549.333663] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [549.333743] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [549.333825] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] c20pll_hw_state:
<7> [549.333906] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] tx[0] = 0xbe88, tx[1] = 0x4800, tx[2] = 0x0000
<7> [549.333987] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [549.334068] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[0] = 0x308c
<7> [549.334183] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[1] = 0x2110
<7> [549.334265] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[2] = 0xcc9c
<7> [549.334344] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[3] = 0xbfc1
<7> [549.334424] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[4] = 0x4b9a
<7> [549.334503] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[5] = 0x3f81
<7> [549.334584] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[6] = 0x2000
<7> [549.334663] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[7] = 0x0001
<7> [549.334742] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[8] = 0x5000
<7> [549.334823] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[9] = 0x0000
<7> [549.334903] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[10] = 0x0000
<7> [549.334983] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vdr: custom width: 0x00, serdes rate: 0x42, hdmi rate: 0x00
<7> [549.335062] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [549.335163] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [549.335253] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [549.335333] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [549.335411] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [549.335490] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [549.335568] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [549.335647] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [549.335727] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [549.335807] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [549.335884] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [549.335962] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [549.336040] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:153:plane 1B] fb: [FB:555] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [549.336121] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [549.336250] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [549.336336] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:183:plane 2B] fb: [NOFB], visible: no
<7> [549.336416] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:213:plane 3B] fb: [NOFB], visible: no
<7> [549.336496] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:243:plane 4B] fb: [NOFB], visible: no
<7> [549.336575] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:253:plane 5B] fb: [NOFB], visible: no
<7> [549.336653] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:263:cursor B] fb: [NOFB], visible: no
<7> [549.337285] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [549.337388] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_B
<7> [549.337493] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x2 (CLKGATE_DIS_DSSDSC=0xa2000000)
<7> [549.337588] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:507:DDI TC1/PHY F]
<7> [549.337667] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST A]
<7> [549.337743] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST B]
<7> [549.337817] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:511:DP-MST C]
<7> [549.337890] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:512:DP-MST D]
<7> [549.337964] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:526:DDI TC2/PHY G]
<7> [549.338038] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST A]
<7> [549.338109] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST B]
<7> [549.338178] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:530:DP-MST C]
<7> [549.338260] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:531:DP-MST D]
<7> [549.338336] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:538:DDI TC3/PHY H]
<7> [549.338409] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:542:DDI TC4/PHY I]
<7> [549.338477] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST A]
<7> [549.338544] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST B]
<7> [549.338609] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:546:DP-MST C]
<7> [549.338674] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:547:DP-MST D]
<7> [549.338751] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [549.338902] xe 0000:03:00.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: *)
<7> [549.338972] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: yes)
<7> [549.339063] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enable TC PLL 2 (active 0x2, on? 0) for [CRTC:269:pipe B]
<7> [549.339144] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enabling TC PLL 2
<7> [549.343007] xe 0000:03:00.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC2/DDI TC2/PHY G: DPCD: 12 14 c4 01 01 15 01 81 00 01 04 01 0f 00 01
<7> [549.347768] xe 0000:03:00.0: [drm:intel_dp_init_lttpr_and_dprx_caps [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] LTTPR common capabilities: 00 00 00 00 00 00 00 00
<7> [549.348768] xe 0000:03:00.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC2/DDI TC2/PHY G: DPCD: 12 14 c4 01 01 15 01 81 00 01 04 01 0f 00 01
<7> [549.349208] xe 0000:03:00.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Using LINK_BW_SET value 0a
<7> [549.350712] xe 0000:03:00.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [549.351258] xe 0000:03:00.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Using DP training pattern TPS1
<7> [549.358816] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Clock recovery OK
<7> [549.358929] xe 0000:03:00.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Using DP training pattern TPS3
<7> [549.365024] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Channel EQ done. DP Training successful
<7> [549.365142] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Link Training passed at link rate = 270000, lane count = 4
<7> [549.366389] xe 0000:03:00.0: [drm:intel_enable_transcoder [xe]] enabling pipe B
<7> [549.384021] xe 0000:03:00.0: [drm:intel_audio_codec_enable [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G] Enable audio codec on [CRTC:269:pipe B], 40 bytes ELD
<7> [549.400721] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:527:DP-2]
<7> [549.401606] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:269:pipe B]
<7> [549.472004] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC2
<7> [551.445367] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC2
<7> [551.552087] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC2
<7> [555.634314] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 0 val 0x22212020
<7> [555.634494] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 1 val 0x21212122
<7> [556.776122] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:151:pipe A]
<7> [556.777217] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:269:pipe B]
<7> [556.777619] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.enable (expected yes, found no)
<7> [556.778249] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.active (expected yes, found no)
<7> [556.778838] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [556.779401] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in lane_count (expected 4, found 0)
<7> [556.779976] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in dp_m_n (expected tu 64 data 5190451/8388608 link 288358/524288, found tu 0, data 0/0 link 0/0)
<7> [556.780549] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in output_types (expected 0x00000080, found 0x00000000)
<7> [556.781017] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [556.781518] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [556.781616] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [556.781728] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [556.781810] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [556.781889] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [556.781969] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [556.782048] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [556.782127] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [556.782206] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [556.782284] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [556.782363] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [556.782443] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [556.782549] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [556.782643] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [556.782737] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [556.782817] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [556.782895] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [556.782972] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [556.783050] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [556.783129] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [556.783206] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [556.783284] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [556.783362] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [556.783442] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [556.783538] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [556.783625] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [556.783732] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [556.783814] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in enhanced_framing (expected yes, found no)
<7> [556.783894] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [556.783975] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [556.784055] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [556.784135] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in port_clock (expected 270000, found 0)
<7> [556.784216] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:269:pipe B] fastset requirement not met, forcing full modeset
<7> [556.784297] xe 0000:03:00.0: [drm:intel_dpll_crtc_put [xe]] [CRTC:269:pipe B] releasing TC PLL 2
<7> [556.784406] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [556.784479] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:269:pipe B] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x2 -> 0x0
<7> [556.784586] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:153:plane 1B] ddb ( 0 - 4037) -> ( 0 - 0), size 4037 -> 0
<7> [556.784665] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:263:cursor B] ddb (4037 - 4096) -> ( 0 - 0), size 59 -> 0
<7> [556.784732] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153: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> [556.784797] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] lines 4, 4, 9, 9, 17, 17, 17, 17, 0, 15, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [556.784861] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] blocks 62, 62, 139, 139, 261, 261, 261, 261, 137, 230, 244 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [556.784926] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] min_ddb 123, 123, 245, 245, 367, 367, 0, 0, 138, 306, 306 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [556.785006] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:269:pipe B] data rate 0 num active planes 0
<7> [556.785097] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 0 qgv_peak_bw: 48000
<7> [556.785185] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 0 qgv_peak_bw: 48000
<7> [556.785271] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 0
<7> [556.785355] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:269:pipe B] min cdclk: 192000 kHz -> 0 kHz
<7> [556.785454] xe 0000:03:00.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 9282 kHz -> 0 kHz
<7> [556.785585] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:269:pipe B] enable: no [modeset]
<7> [556.785693] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:153:plane 1B] fb: [NOFB], visible: no
<7> [556.785780] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:183:plane 2B] fb: [NOFB], visible: no
<7> [556.785866] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:213:plane 3B] fb: [NOFB], visible: no
<7> [556.785951] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:243:plane 4B] fb: [NOFB], visible: no
<7> [556.786035] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:253:plane 5B] fb: [NOFB], visible: no
<7> [556.786117] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:263:cursor B] fb: [NOFB], visible: no
<7> [556.786790] xe 0000:03:00.0: [drm:intel_audio_codec_disable [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G] Disable audio codec on [CRTC:269:pipe B]
<7> [556.817731] xe 0000:03:00.0: [drm:intel_disable_transcoder [xe]] disabling pipe B
<7> [556.834460] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC2
<7> [556.837393] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disable TC PLL 2 (active 0x2, on? 1) for [CRTC:269:pipe B]
<7> [556.839974] xe 0000:03:00.0: [drm:intel_dpll_disable [xe]] disabling TC PLL 2
<7> [556.840817] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:507:DDI TC1/PHY F]
<7> [556.841317] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST A]
<7> [556.841863] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST B]
<7> [556.842323] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:511:DP-MST C]
<7> [556.842812] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:512:DP-MST D]
<7> [556.843225] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:526:DDI TC2/PHY G]
<7> [556.843942] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST A]
<7> [556.844477] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST B]
<7> [556.844856] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:530:DP-MST C]
<7> [556.845211] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:531:DP-MST D]
<7> [556.845607] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:538:DDI TC3/PHY H]
<7> [556.846027] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:542:DDI TC4/PHY I]
<7> [556.846344] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST A]
<7> [556.846702] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST B]
<7> [556.847053] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:546:DP-MST C]
<7> [556.847334] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:547:DP-MST D]
<7> [556.847659] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:527:DP-2]
<7> [556.848217] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [556.848715] xe 0000:03:00.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [556.849190] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [556.849955] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling PW_B
<7> [556.850203] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating disabled for pipe_mask=0x2 (CLKGATE_DIS_DSSDSC=0xaa000000)
<7> [556.850699] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [556.851182] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:269:pipe B]
<7> [556.851471] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:387:pipe C]
<7> [556.851962] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:505:pipe D]
<7> [556.852284] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:269:pipe B]
<7> [556.852321] xe 0000:03:00.0: [drm:drm_mode_setcrtc] [CONNECTOR:527:DP-2]
<7> [556.852473] xe 0000:03:00.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:526:DDI TC2/PHY G][CRTC:269:pipe B] DP link limits: pixel clock 148500 kHz DSC off max lanes 4 max rate 540000 max pipe_bpp 36 min link_bpp 18.0000 max link_bpp 36.0000
<7> [556.852665] xe 0000:03:00.0: [drm:intel_dp_compute_link_config [xe]] DP lane count 4 clock 270000 bpp input 36 compressed 0.0000 HDR no link rate required 668250 available 1080000
<7> [556.852846] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:269:pipe B] hw max bpp: 36, pipe bpp: 36, dithering: 0
<7> [556.853015] xe 0000:03:00.0: [drm:intel_ddi_compute_config_late [xe]] [ENCODER:526:DDI TC2/PHY G] [CRTC:269:pipe B]
<7> [556.853185] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [556.853349] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [556.853528] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [556.853682] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [556.853824] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 5190451/8388608 link 288358/524288)
<7> [556.853965] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000080)
<7> [556.854102] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [556.854232] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [556.854359] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [556.854496] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [556.854621] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [556.854739] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [556.854854] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [556.854964] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [556.855075] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [556.855181] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [556.855285] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [556.855390] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [556.855582] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [556.855681] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [556.855779] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [556.855878] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [556.855974] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [556.856067] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [556.856158] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [556.856249] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [556.856339] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [556.856428] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [556.856538] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [556.856626] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [556.856713] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [556.856800] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [556.856886] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [556.856973] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [556.857061] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in enhanced_framing (expected no, found yes)
<7> [556.857150] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 36)
<7> [556.857238] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [556.857326] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [556.857413] xe 0000:03:00.0: [drm:intel_pipe_config_compare [xe]] [CRTC:269:pipe B] fastset requirement not met in port_clock (expected 0, found 270000)
<7> [556.857504] xe 0000:03:00.0: [drm:intel_atomic_check [xe]] [CRTC:269:pipe B] fastset requirement not met, forcing full modeset
<7> [556.857638] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [556.857720] xe 0000:03:00.0: [drm:skl_compute_wm [xe]] [CRTC:269:pipe B] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x2
<7> [556.857815] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:153:plane 1B] ddb ( 0 - 0) -> ( 0 - 4037), size 0 -> 4037
<7> [556.857890] xe 0000:03:00.0: [drm:skl_print_plane_ddb_changes [xe]] [PLANE:263:cursor B] ddb ( 0 - 0) -> (4037 - 4096), size 0 -> 59
<7> [556.857964] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153: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> [556.858037] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 4, 4, 9, 9, 17, 17, 17, 17, 0, 15, 0
<7> [556.858109] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 62, 62, 139, 139, 261, 261, 261, 261, 137, 230, 244
<7> [556.858182] xe 0000:03:00.0: [drm:skl_print_plane_wm_changes [xe]] [PLANE:153:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 123, 123, 245, 245, 367, 367, 0, 0, 138, 306, 306
<7> [556.858265] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] [CRTC:269:pipe B] data rate 594000 num active planes 1
<7> [556.858365] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 33600 required 624 qgv_peak_bw: 48000
<7> [556.858458] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 53000 required 624 qgv_peak_bw: 48000
<7> [556.858564] xe 0000:03:00.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 48000 for required data rate: 624
<7> [556.858657] xe 0000:03:00.0: [drm:intel_cdclk_atomic_check [xe]] [CRTC:269:pipe B] min cdclk: 0 kHz -> 192000 kHz
<7> [556.858761] xe 0000:03:00.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [xe]] dbuf bandwidth min cdclk: 0 kHz -> 9282 kHz
<7> [556.858865] xe 0000:03:00.0: [drm:intel_find_dpll [xe]] [CRTC:269:pipe B] allocated TC PLL 2
<7> [556.858955] xe 0000:03:00.0: [drm:intel_dpll_crtc_get [xe]] [CRTC:269:pipe B] reserving TC PLL 2
<7> [556.859044] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [CRTC:269:pipe B] enable: yes [modeset]
<7> [556.859142] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: DP (0x80), output format: RGB, sink format: RGB
<7> [556.859237] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: B, pipe bpp: 36, dithering: 0
<7> [556.859331] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: <invalid>
<7> [556.859423] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [556.859515] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [556.859625] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [556.859717] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 5190451, data_n: 8388608, link_m: 288358, link_n: 524288, tu: 64
<7> [556.859808] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [556.859899] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: enabled
<7> [556.859988] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [556.860077] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] psr: disabled, selective update: disabled, panel replay: disabled, selective fetch: disabled
<7> [556.860165] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] minimum hblank: 0
<7> [556.860254] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] audio: 1, infoframes: 0, infoframes enabled: 0x0
<7> [556.860345] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 10 00 09 00 68 36 00 01 00 00 00 00 00 00 00 00
<7> [556.860434] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 61 a4 9a 00 44 50 46 39 30 34 33 35 09 07 07 11
<7> [556.860524] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ELD: 17 50 51 07 00 00 00 00
<7> [556.860659] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [556.860750] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] framestart delay: 1, MSA timing delay: 0, set context latency: 0
<7> [556.860839] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 1125, vmax: 1125, flipline: 1125, pipeline full: 0, guardband: 42 vsync start: 41, vsync end: 36
<7> [556.860927] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 1083, vmax vblank: 1083, vmin vtotal: 1125, vmax vtotal: 1125
<7> [556.861015] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vrr: dc balance: no, vmin: 0 vmax: 0 guardband: 0, slope: 0 max increase: 0 max decrease: 0 vblank target: 0
<7> [556.861104] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [556.861192] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [556.861281] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [556.861370] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [556.861459] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [556.861547] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] port clock: 270000, pixel rate 148500, min cdclk 192000, min voltage level 0
<7> [556.861650] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] linetime: 119, ips linetime: 0
<7> [556.861739] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [556.861828] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe src: 1920x1080+0+0
<7> [556.861916] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [556.862005] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [556.862093] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [556.862181] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [556.862270] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] c20pll_hw_state:
<7> [556.862357] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] tx[0] = 0xbe88, tx[1] = 0x4800, tx[2] = 0x0000
<7> [556.862444] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] cmn[0] = 0x0500, cmn[1] = 0x0005, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [556.862532] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[0] = 0x308c
<7> [556.862630] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[1] = 0x2110
<7> [556.862719] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[2] = 0xcc9c
<7> [556.862808] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[3] = 0xbfc1
<7> [556.862896] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[4] = 0x4b9a
<7> [556.862984] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[5] = 0x3f81
<7> [556.863075] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[6] = 0x2000
<7> [556.863166] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[7] = 0x0001
<7> [556.863257] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[8] = 0x5000
<7> [556.863344] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[9] = 0x0000
<7> [556.863432] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] mpllb[10] = 0x0000
<7> [556.863520] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] vdr: custom width: 0x00, serdes rate: 0x42, hdmi rate: 0x00
<7> [556.863611] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [556.863702] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [556.863790] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [556.863877] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [556.863965] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [556.864053] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [556.864140] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [556.864227] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [556.864316] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [556.864403] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [556.864489] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [556.864575] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [556.864672] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:153:plane 1B] fb: [FB:555] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x100000000000009, visible: yes
<7> [556.864763] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [556.864850] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [556.864937] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:183:plane 2B] fb: [NOFB], visible: no
<7> [556.865024] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:213:plane 3B] fb: [NOFB], visible: no
<7> [556.865110] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:243:plane 4B] fb: [NOFB], visible: no
<7> [556.865196] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:253:plane 5B] fb: [NOFB], visible: no
<7> [556.865283] xe 0000:03:00.0: [drm:intel_crtc_state_dump [xe]] [PLANE:263:cursor B] fb: [NOFB], visible: no
<7> [556.865904] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [556.866017] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling PW_B
<7> [556.866135] xe 0000:03:00.0: [drm:dss_pipe_gating_enable_disable [xe]] DSS clock gating enabled for pipe_mask=0x2 (CLKGATE_DIS_DSSDSC=0xa2000000)
<7> [556.866438] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:507:DDI TC1/PHY F]
<7> [556.866527] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:509:DP-MST A]
<7> [556.866611] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:510:DP-MST B]
<7> [556.866702] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:511:DP-MST C]
<7> [556.866784] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:512:DP-MST D]
<7> [556.866861] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:526:DDI TC2/PHY G]
<7> [556.866937] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:528:DP-MST A]
<7> [556.867013] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:529:DP-MST B]
<7> [556.867089] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:530:DP-MST C]
<7> [556.867165] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:531:DP-MST D]
<7> [556.867241] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:538:DDI TC3/PHY H]
<7> [556.867319] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:542:DDI TC4/PHY I]
<7> [556.867394] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:544:DP-MST A]
<7> [556.867469] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:545:DP-MST B]
<7> [556.867545] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:546:DP-MST C]
<7> [556.867619] xe 0000:03:00.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:547:DP-MST D]
<7> [556.867914] xe 0000:03:00.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [556.868076] xe 0000:03:00.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: *)
<7> [556.868355] xe 0000:03:00.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: yes)
<7> [556.868455] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enable TC PLL 2 (active 0x2, on? 0) for [CRTC:269:pipe B]
<7> [556.868543] xe 0000:03:00.0: [drm:intel_dpll_enable [xe]] enabling TC PLL 2
<7> [556.873500] xe 0000:03:00.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC2/DDI TC2/PHY G: DPCD: 12 14 c4 01 01 15 01 81 00 01 04 01 0f 00 01
<7> [556.878236] xe 0000:03:00.0: [drm:intel_dp_init_lttpr_and_dprx_caps [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] LTTPR common capabilities: 00 00 00 00 00 00 00 00
<7> [556.879239] xe 0000:03:00.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC2/DDI TC2/PHY G: DPCD: 12 14 c4 01 01 15 01 81 00 01 04 01 0f 00 01
<7> [556.879678] xe 0000:03:00.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Using LINK_BW_SET value 0a
<7> [556.881180] xe 0000:03:00.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [556.881724] xe 0000:03:00.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Using DP training pattern TPS1
<7> [556.888842] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Clock recovery OK
<7> [556.888962] xe 0000:03:00.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Using DP training pattern TPS3
<7> [556.895950] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Channel EQ done. DP Training successful
<7> [556.896191] xe 0000:03:00.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G][DPRX] Link Training passed at link rate = 270000, lane count = 4
<7> [556.897543] xe 0000:03:00.0: [drm:intel_enable_transcoder [xe]] enabling pipe B
<7> [556.915057] xe 0000:03:00.0: [drm:intel_audio_codec_enable [xe]] [CONNECTOR:527:DP-2][ENCODER:526:DDI TC2/PHY G] Enable audio codec on [CRTC:269:pipe B], 40 bytes ELD
<7> [556.932114] xe 0000:03:00.0: [drm:verify_connector_state [xe]] [CONNECTOR:527:DP-2]
<7> [556.932991] xe 0000:03:00.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:269:pipe B]
<7> [557.001663] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC2
<7> [558.936803] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC2
<7> [558.962644] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 0 val 0x2221201f
<7> [558.963325] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 1 val 0x2121211f
<7> [559.041839] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC2
<6> [561.074964] [IGT] kms_flip: finished subtest B-DP2, FAIL
Created at 2026-04-07 05:29:58