Results for igt@kms_flip@blocking-wf_vblank@b-hdmi-a1

Machine description: shard-rkl-2

Result: Fail

git-log-oneline i915_display_info24 igt_runner24 runtimes24 results24.json results24-i915-load.json i915_display_info_post_exec24 boot24 dmesg24

DetailValue
Duration 18.12 seconds
Hostname 
shard-rkl-2
Igt-Version 
IGT-Version: 1.30-g1bd3fe08b (x86_64) (Linux: 6.14.0-rc5-CI_DRM_16246-gf811577f4244+ x86_64)
Out 
Starting dynamic subtest: B-HDMI-A1
  1920x1080: 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 
Expected frametime: 18974us; measured 18864.4us +- 6.438us accuracy 0.10%
vblank interval differs from modeline! expected 18973.8us, measured 18864us +- 6.438us, difference 109.4us (17.0 sigma)
Stack trace:
  #0 ../lib/igt_core.c:2055 __igt_fail_assert()
  #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0()
  #2 ../tests/kms_flip.c:1845 run_test()
  #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001()
  #4 ../tests/kms_flip.c:2001 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest B-HDMI-A1: FAIL (18.116s)
Subtest blocking-wf_vblank: FAIL (24.901s)
Stack trace:
  #0 ../lib/igt_core.c:2055 __igt_fail_assert()
  #1 ../lib/igt_kms.c:2246 kmstest_set_connector_dpms()
  #2 ../lib/igt_core.c:2934 igt_atexit_handler()
  #3 [erand48_r+0x1d6]
  #4 [exit+0x1e]
  #5 ../lib/igt_core.c:2390 igt_exit()
  #6 [main+0x3f]
  #7 [__libc_init_first+0x8a]
  #8 [__libc_start_main+0x8b]
  #9 [_start+0x25]
Err 
Starting dynamic subtest: B-HDMI-A1
(kms_flip:2063) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:2063) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
Dynamic subtest B-HDMI-A1 failed.
**** DEBUG ****
(kms_flip:2063) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:2063) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=3, pitch=7680)
(kms_flip:2063) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:2063) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:2063) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=4, pitch=7680)
(kms_flip:2063) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:2063) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:2063) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:2063) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
(kms_flip:2063) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:2063) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:2063) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
(kms_flip:2063) igt_kms-INFO:   1920x1080: 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5 
(kms_flip:2063) DEBUG: No stale events found
(kms_flip:2063) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0
(kms_flip:2063) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0
(kms_flip:2063) INFO: Expected frametime: 18974us; measured 18864.4us +- 6.438us accuracy 0.10%
(kms_flip:2063) INFO: vblank interval differs from modeline! expected 18973.8us, measured 18864us +- 6.438us, difference 109.4us (17.0 sigma)
(kms_flip:2063) DEBUG: name = vblank
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 70.716583
current_received_ts = 70.715874
current_seq = 30
count = 0
seq_step = 10
(kms_flip:2063) DEBUG: name = vblank
last_ts = 70.716583
last_received_ts = 70.715874
last_seq = 30
current_ts = 70.905327
current_received_ts = 70.904617
current_seq = 40
count = 1
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 70.716583/30, current 70.905327/40: elapsed=188747.0us expected=188643.8us +- 943.2us, error 0.1%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 70.905327
last_received_ts = 70.904617
last_seq = 40
current_ts = 71.094116
current_received_ts = 71.093407
current_seq = 50
count = 2
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 70.905327/40, current 71.094116/50: elapsed=188787.0us expected=188643.8us +- 943.2us, error 0.1%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 71.094116
last_received_ts = 71.093407
last_seq = 50
current_ts = 71.282906
current_received_ts = 71.282188
current_seq = 60
count = 3
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 71.094116/50, current 71.282906/60: elapsed=188788.0us expected=188643.8us +- 943.2us, error 0.1%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 71.282906
last_received_ts = 71.282188
last_seq = 60
current_ts = 71.471695
current_received_ts = 71.470978
current_seq = 70
count = 4
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 71.282906/60, current 71.471695/70: elapsed=188789.0us expected=188643.8us +- 943.2us, error 0.1%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 71.471695
last_received_ts = 71.470978
last_seq = 70
current_ts = 71.660484
current_received_ts = 71.659775
current_seq = 80
count = 5
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 71.471695/70, current 71.660484/80: elapsed=188788.0us expected=188643.8us +- 943.2us, error 0.1%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 71.660484
last_received_ts = 71.659775
last_seq = 80
current_ts = 71.849319
current_received_ts = 71.848610
current_seq = 90
count = 6
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 71.660484/80, current 71.849319/90: elapsed=188836.0us expected=188643.8us +- 943.2us, error 0.1%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 71.849319
last_received_ts = 71.848610
last_seq = 90
current_ts = 72.038223
current_received_ts = 72.037514
current_seq = 100
count = 7
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 71.849319/90, current 72.038223/100: elapsed=188906.0us expected=188643.8us +- 943.2us, error 0.1%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 72.038223
last_received_ts = 72.037514
last_seq = 100
current_ts = 72.227127
current_received_ts = 72.226418
current_seq = 110
count = 8
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 72.038223/100, current 72.227127/110: elapsed=188905.0us expected=188643.8us +- 943.2us, error 0.1%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 72.227127
last_received_ts = 72.226418
last_seq = 110
current_ts = 72.416039
current_received_ts = 72.415329
current_seq = 120
count = 9
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 72.227127/110, current 72.416039/120: elapsed=188909.0us expected=188643.8us +- 943.2us, error 0.1%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 72.416039
last_received_ts = 72.415329
last_seq = 120
current_ts = 72.604942
current_received_ts = 72.604233
current_seq = 130
count = 10
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 72.416039/120, current 72.604942/130: elapsed=188905.0us expected=188643.8us +- 943.2us, error 0.1%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 72.604942
last_received_ts = 72.604233
last_seq = 130
current_ts = 72.793861
current_received_ts = 72.793152
current_seq = 140
count = 11
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 72.604942/130, current 72.793861/140: elapsed=188917.0us expected=188643.8us +- 943.2us, error 0.1%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 72.793861
last_received_ts = 72.793152
last_seq = 140
current_ts = 72.982872
current_received_ts = 72.982155
current_seq = 150
count = 12
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 72.793861/140, current 72.982872/150: elapsed=189010.0us expected=188643.8us +- 943.2us, error 0.2%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 72.982872
last_received_ts = 72.982155
last_seq = 150
current_ts = 73.171883
current_received_ts = 73.171165
current_seq = 160
count = 13
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 72.982872/150, current 73.171883/160: elapsed=189012.0us expected=188643.8us +- 943.2us, error 0.2%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 73.171883
last_received_ts = 73.171165
last_seq = 160
current_ts = 73.360893
current_received_ts = 73.360184
current_seq = 170
count = 14
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 73.171883/160, current 73.360893/170: elapsed=189011.0us expected=188643.8us +- 943.2us, error 0.2%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 73.360893
last_received_ts = 73.360184
last_seq = 170
current_ts = 73.549904
current_received_ts = 73.549187
current_seq = 180
count = 15
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 73.360893/170, current 73.549904/180: elapsed=189009.0us expected=188643.8us +- 943.2us, error 0.2%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 73.549904
last_received_ts = 73.549187
last_seq = 180
current_ts = 73.738914
current_received_ts = 73.738197
current_seq = 190
count = 16
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 73.549904/180, current 73.738914/190: elapsed=189011.0us expected=188643.8us +- 943.2us, error 0.2%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 73.738914
last_received_ts = 73.738197
last_seq = 190
current_ts = 73.927994
current_received_ts = 73.927292
current_seq = 200
count = 17
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 73.738914/190, current 73.927994/200: elapsed=189085.0us expected=188643.8us +- 943.2us, error 0.2%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 73.927994
last_received_ts = 73.927292
last_seq = 200
current_ts = 74.117111
current_received_ts = 74.116386
current_seq = 210
count = 18
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 73.927994/200, current 74.117111/210: elapsed=189115.0us expected=188643.8us +- 943.2us, error 0.2%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 74.117111
last_received_ts = 74.116386
last_seq = 210
current_ts = 74.306198
current_received_ts = 74.305481
current_seq = 220
count = 19
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 74.117111/210, current 74.306198/220: elapsed=189086.0us expected=188643.8us +- 943.2us, error 0.2%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 74.306198
last_received_ts = 74.305481
last_seq = 220
current_ts = 74.495300
current_received_ts = 74.494583
current_seq = 230
count = 20
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 74.306198/220, current 74.495300/230: elapsed=189101.0us expected=188643.8us +- 943.2us, error 0.2%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 74.495300
last_received_ts = 74.494583
last_seq = 230
current_ts = 74.684402
current_received_ts = 74.683685
current_seq = 240
count = 21
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 74.495300/230, current 74.684402/240: elapsed=189102.0us expected=188643.8us +- 943.2us, error 0.2%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 74.684402
last_received_ts = 74.683685
last_seq = 240
current_ts = 74.873543
current_received_ts = 74.872833
current_seq = 250
count = 22
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 74.684402/240, current 74.873543/250: elapsed=189143.0us expected=188643.8us +- 943.2us, error 0.3%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 74.873543
last_received_ts = 74.872833
last_seq = 250
current_ts = 75.062737
current_received_ts = 75.062035
current_seq = 260
count = 23
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 74.873543/250, current 75.062737/260: elapsed=189194.0us expected=188643.8us +- 943.2us, error 0.3%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 75.062737
last_received_ts = 75.062035
last_seq = 260
current_ts = 75.251907
current_received_ts = 75.251190
current_seq = 270
count = 24
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 75.062737/260, current 75.251907/270: elapsed=189167.0us expected=188643.8us +- 943.2us, error 0.3%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 75.251907
last_received_ts = 75.251190
last_seq = 270
current_ts = 75.441086
current_received_ts = 75.440369
current_seq = 280
count = 25
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 75.251907/270, current 75.441086/280: elapsed=189181.0us expected=188643.8us +- 943.2us, error 0.3%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 75.441086
last_received_ts = 75.440369
last_seq = 280
current_ts = 75.630264
current_received_ts = 75.629562
current_seq = 290
count = 26
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 75.441086/280, current 75.630264/290: elapsed=189182.0us expected=188643.8us +- 943.2us, error 0.3%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 75.630264
last_received_ts = 75.629562
last_seq = 290
current_ts = 75.819466
current_received_ts = 75.818748
current_seq = 300
count = 27
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 75.630264/290, current 75.819466/300: elapsed=189195.0us expected=188643.8us +- 943.2us, error 0.3%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 75.819466
last_received_ts = 75.818748
last_seq = 300
current_ts = 76.008728
current_received_ts = 76.008041
current_seq = 310
count = 28
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 75.819466/300, current 76.008728/310: elapsed=189265.0us expected=188643.8us +- 943.2us, error 0.3%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 76.008728
last_received_ts = 76.008041
last_seq = 310
current_ts = 76.197960
current_received_ts = 76.197250
current_seq = 320
count = 29
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 76.008728/310, current 76.197960/320: elapsed=189234.0us expected=188643.8us +- 943.2us, error 0.3%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 76.197960
last_received_ts = 76.197250
last_seq = 320
current_ts = 76.387222
current_received_ts = 76.386475
current_seq = 330
count = 30
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 76.197960/320, current 76.387222/330: elapsed=189258.0us expected=188643.8us +- 943.2us, error 0.3%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 76.387222
last_received_ts = 76.386475
last_seq = 330
current_ts = 76.576462
current_received_ts = 76.575760
current_seq = 340
count = 31
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 76.387222/330, current 76.576462/340: elapsed=189245.0us expected=188643.8us +- 943.2us, error 0.3%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 76.576462
last_received_ts = 76.575760
last_seq = 340
current_ts = 76.765732
current_received_ts = 76.764999
current_seq = 350
count = 32
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 76.576462/340, current 76.765732/350: elapsed=189264.0us expected=188643.8us +- 943.2us, error 0.3%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 76.765732
last_received_ts = 76.764999
last_seq = 350
current_ts = 76.955025
current_received_ts = 76.954315
current_seq = 360
count = 33
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 76.765732/350, current 76.955025/360: elapsed=189295.0us expected=188643.8us +- 943.2us, error 0.3%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 76.955025
last_received_ts = 76.954315
last_seq = 360
current_ts = 77.144333
current_received_ts = 77.143623
current_seq = 370
count = 34
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 76.955025/360, current 77.144333/370: elapsed=189312.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 77.144333
last_received_ts = 77.143623
last_seq = 370
current_ts = 77.333649
current_received_ts = 77.332939
current_seq = 380
count = 35
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 77.144333/370, current 77.333649/380: elapsed=189312.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 77.333649
last_received_ts = 77.332939
last_seq = 380
current_ts = 77.522972
current_received_ts = 77.522247
current_seq = 390
count = 36
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 77.333649/380, current 77.522972/390: elapsed=189326.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 77.522972
last_received_ts = 77.522247
last_seq = 390
current_ts = 77.712273
current_received_ts = 77.711555
current_seq = 400
count = 37
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 77.522972/390, current 77.712273/400: elapsed=189296.0us expected=188643.8us +- 943.2us, error 0.3%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 77.712273
last_received_ts = 77.711555
last_seq = 400
current_ts = 77.901619
current_received_ts = 77.900909
current_seq = 410
count = 38
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 77.712273/400, current 77.901619/410: elapsed=189351.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 77.901619
last_received_ts = 77.900909
last_seq = 410
current_ts = 78.090981
current_received_ts = 78.090271
current_seq = 420
count = 39
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 77.901619/410, current 78.090981/420: elapsed=189363.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 78.090981
last_received_ts = 78.090271
last_seq = 420
current_ts = 78.280350
current_received_ts = 78.279633
current_seq = 430
count = 40
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 78.090981/420, current 78.280350/430: elapsed=189366.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 78.280350
last_received_ts = 78.279633
last_seq = 430
current_ts = 78.469711
current_received_ts = 78.469025
current_seq = 440
count = 41
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 78.280350/430, current 78.469711/440: elapsed=189365.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 78.469711
last_received_ts = 78.469025
last_seq = 440
current_ts = 78.659081
current_received_ts = 78.658363
current_seq = 450
count = 42
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 78.469711/440, current 78.659081/450: elapsed=189363.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 78.659081
last_received_ts = 78.658363
last_seq = 450
current_ts = 78.848465
current_received_ts = 78.847748
current_seq = 460
count = 43
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 78.659081/450, current 78.848465/460: elapsed=189385.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 78.848465
last_received_ts = 78.847748
last_seq = 460
current_ts = 79.037880
current_received_ts = 79.037132
current_seq = 470
count = 44
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 78.848465/460, current 79.037880/470: elapsed=189419.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 79.037880
last_received_ts = 79.037132
last_seq = 470
current_ts = 79.227287
current_received_ts = 79.226562
current_seq = 480
count = 45
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 79.037880/470, current 79.227287/480: elapsed=189406.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 79.227287
last_received_ts = 79.226562
last_seq = 480
current_ts = 79.416702
current_received_ts = 79.415962
current_seq = 490
count = 46
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 79.227287/480, current 79.416702/490: elapsed=189418.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 79.416702
last_received_ts = 79.415962
last_seq = 490
current_ts = 79.606117
current_received_ts = 79.605377
current_seq = 500
count = 47
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 79.416702/490, current 79.606117/500: elapsed=189412.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 79.606117
last_received_ts = 79.605377
last_seq = 500
current_ts = 79.795532
current_received_ts = 79.794800
current_seq = 510
count = 48
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 79.606117/500, current 79.795532/510: elapsed=189418.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 79.795532
last_received_ts = 79.794800
last_seq = 510
current_ts = 79.984985
current_received_ts = 79.984253
current_seq = 520
count = 49
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 79.795532/510, current 79.984985/520: elapsed=189452.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 79.984985
last_received_ts = 79.984253
last_seq = 520
current_ts = 80.174431
current_received_ts = 80.173729
current_seq = 530
count = 50
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 79.984985/520, current 80.174431/530: elapsed=189444.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 80.174431
last_received_ts = 80.173729
last_seq = 530
current_ts = 80.363884
current_received_ts = 80.363167
current_seq = 540
count = 51
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 80.174431/530, current 80.363884/540: elapsed=189450.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 80.363884
last_received_ts = 80.363167
last_seq = 540
current_ts = 80.553337
current_received_ts = 80.552635
current_seq = 550
count = 52
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 80.363884/540, current 80.553337/550: elapsed=189453.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 80.553337
last_received_ts = 80.552635
last_seq = 550
current_ts = 80.742790
current_received_ts = 80.742073
current_seq = 560
count = 53
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 80.553337/550, current 80.742790/560: elapsed=189453.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 80.742790
last_received_ts = 80.742073
last_seq = 560
current_ts = 80.932274
current_received_ts = 80.931557
current_seq = 570
count = 54
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 80.742790/560, current 80.932274/570: elapsed=189483.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 80.932274
last_received_ts = 80.931557
last_seq = 570
current_ts = 81.121758
current_received_ts = 81.121048
current_seq = 580
count = 55
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 80.932274/570, current 81.121758/580: elapsed=189488.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 81.121758
last_received_ts = 81.121048
last_seq = 580
current_ts = 81.311249
current_received_ts = 81.310532
current_seq = 590
count = 56
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 81.121758/580, current 81.311249/590: elapsed=189486.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 81.311249
last_received_ts = 81.310532
last_seq = 590
current_ts = 81.500732
current_received_ts = 81.500023
current_seq = 600
count = 57
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 81.311249/590, current 81.500732/600: elapsed=189488.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 81.500732
last_received_ts = 81.500023
last_seq = 600
current_ts = 81.690224
current_received_ts = 81.689507
current_seq = 610
count = 58
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 81.500732/600, current 81.690224/610: elapsed=189489.0us expected=188643.8us +- 943.2us, error 0.4%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 81.690224
last_received_ts = 81.689507
last_seq = 610
current_ts = 81.879730
current_received_ts = 81.879021
current_seq = 620
count = 59
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 81.690224/610, current 81.879730/620: elapsed=189506.0us expected=188643.8us +- 943.2us, error 0.5%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 81.879730
last_received_ts = 81.879021
last_seq = 620
current_ts = 82.069244
current_received_ts = 82.068535
current_seq = 630
count = 60
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 81.879730/620, current 82.069244/630: elapsed=189519.0us expected=188643.8us +- 943.2us, error 0.5%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 82.069244
last_received_ts = 82.068535
last_seq = 630
current_ts = 82.258766
current_received_ts = 82.258049
current_seq = 640
count = 61
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 82.069244/630, current 82.258766/640: elapsed=189518.0us expected=188643.8us +- 943.2us, error 0.5%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 82.258766
last_received_ts = 82.258049
last_seq = 640
current_ts = 82.448280
current_received_ts = 82.447578
current_seq = 650
count = 62
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 82.258766/640, current 82.448280/650: elapsed=189519.0us expected=188643.8us +- 943.2us, error 0.5%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 82.448280
last_received_ts = 82.447578
last_seq = 650
current_ts = 82.637802
current_received_ts = 82.637093
current_seq = 660
count = 63
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 82.448280/650, current 82.637802/660: elapsed=189521.0us expected=188643.8us +- 943.2us, error 0.5%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 82.637802
last_received_ts = 82.637093
last_seq = 660
current_ts = 82.827332
current_received_ts = 82.826622
current_seq = 670
count = 64
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 82.637802/660, current 82.827332/670: elapsed=189527.0us expected=188643.8us +- 943.2us, error 0.5%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 82.827332
last_received_ts = 82.826622
last_seq = 670
current_ts = 83.016876
current_received_ts = 83.016167
current_seq = 680
count = 65
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 82.827332/670, current 83.016876/680: elapsed=189546.0us expected=188643.8us +- 943.2us, error 0.5%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 83.016876
last_received_ts = 83.016167
last_seq = 680
current_ts = 83.206436
current_received_ts = 83.205711
current_seq = 690
count = 66
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 83.016876/680, current 83.206436/690: elapsed=189560.0us expected=188643.8us +- 943.2us, error 0.5%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 83.206436
last_received_ts = 83.205711
last_seq = 690
current_ts = 83.395973
current_received_ts = 83.395256
current_seq = 700
count = 67
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 83.206436/690, current 83.395973/700: elapsed=189533.0us expected=188643.8us +- 943.2us, error 0.5%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 83.395973
last_received_ts = 83.395256
last_seq = 700
current_ts = 83.585518
current_received_ts = 83.584808
current_seq = 710
count = 68
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 83.395973/700, current 83.585518/710: elapsed=189546.0us expected=188643.8us +- 943.2us, error 0.5%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 83.585518
last_received_ts = 83.584808
last_seq = 710
current_ts = 83.775063
current_received_ts = 83.774353
current_seq = 720
count = 69
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 83.585518/710, current 83.775063/720: elapsed=189547.0us expected=188643.8us +- 943.2us, error 0.5%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 83.775063
last_received_ts = 83.774353
last_seq = 720
current_ts = 83.964645
current_received_ts = 83.963928
current_seq = 730
count = 70
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 83.775063/720, current 83.964645/730: elapsed=189584.0us expected=188643.8us +- 943.2us, error 0.5%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 83.964645
last_received_ts = 83.963928
last_seq = 730
current_ts = 84.154205
current_received_ts = 84.153496
current_seq = 740
count = 71
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 83.964645/730, current 84.154205/740: elapsed=189556.0us expected=188643.8us +- 943.2us, error 0.5%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 84.154205
last_received_ts = 84.153496
last_seq = 740
current_ts = 84.343773
current_received_ts = 84.343063
current_seq = 750
count = 72
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 84.154205/740, current 84.343773/750: elapsed=189570.0us expected=188643.8us +- 943.2us, error 0.5%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 84.343773
last_received_ts = 84.343063
last_seq = 750
current_ts = 84.533356
current_received_ts = 84.532631
current_seq = 760
count = 73
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 84.343773/750, current 84.533356/760: elapsed=189585.0us expected=188643.8us +- 943.2us, error 0.5%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 84.533356
last_received_ts = 84.532631
last_seq = 760
current_ts = 84.722916
current_received_ts = 84.722198
current_seq = 770
count = 74
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 84.533356/760, current 84.722916/770: elapsed=189557.0us expected=188643.8us +- 943.2us, error 0.5%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 84.722916
last_received_ts = 84.722198
last_seq = 770
current_ts = 84.912498
current_received_ts = 84.911789
current_seq = 780
count = 75
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 84.722916/770, current 84.912498/780: elapsed=189584.0us expected=188643.8us +- 943.2us, error 0.5%
(kms_flip:2063) DEBUG: name = vblank
last_ts = 84.912498
last_received_ts = 84.911789
last_seq = 780
current_ts = 85.102089
current_received_ts = 85.101379
current_seq = 790
count = 76
seq_step = 10
(kms_flip:2063) DEBUG: vblank ts/seq: last 84.912498/780, current 85.102089/790: elapsed=189592.0us expected=188643.8us +- 943.2us, error 0.5%
(kms_flip:2063) DEBUG: inconsistent vblank ts/seq: last 84.912498/780, current 85.102089/790: elapsed=189592.0us expected=188643.8us
(kms_flip:2063) DEBUG: expected 204320, counted 760, encoder type 2
(kms_flip:2063) DEBUG: dropped frames, expected 204320, counted 760, encoder type 2
(kms_flip:2063) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:2063) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
(kms_flip:2063) igt_core-INFO: Stack trace:
(kms_flip:2063) igt_core-INFO:   #0 ../lib/igt_core.c:2055 __igt_fail_assert()
(kms_flip:2063) igt_core-INFO:   #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0()
(kms_flip:2063) igt_core-INFO:   #2 ../tests/kms_flip.c:1845 run_test()
(kms_flip:2063) igt_core-INFO:   #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001()
(kms_flip:2063) igt_core-INFO:   #4 ../tests/kms_flip.c:2001 main()
(kms_flip:2063) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:2063) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:2063) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest B-HDMI-A1: FAIL (18.116s)
Subtest blocking-wf_vblank: FAIL (24.901s)
(kms_flip:2063) igt_kms-CRITICAL: Test assertion failure function kmstest_set_connector_dpms, file ../lib/igt_kms.c:2246:
(kms_flip:2063) igt_kms-CRITICAL: Failed assertion: found_it
(kms_flip:2063) igt_kms-CRITICAL: Last errno: 9, Bad file descriptor
(kms_flip:2063) igt_kms-CRITICAL: DPMS property not found on 137
Dmesg
<6> [70.230805] [IGT] kms_flip: starting dynamic subtest B-HDMI-A1
<7> [70.231220] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:166]
<7> [70.231307] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:167]
<7> [70.271465] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A]
<7> [70.271593] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [70.271917] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [70.272212] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [70.272681] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [70.273014] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [70.273344] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [70.273695] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [70.274027] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2360, found 0)
<7> [70.274366] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [70.274724] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2360, found 0)
<7> [70.275055] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [70.275375] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2096, found 0)
<7> [70.275652] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [70.275914] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [70.276178] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [70.276440] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [70.276732] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [70.276991] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [70.277249] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [70.277516] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2360, found 0)
<7> [70.277773] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [70.278029] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2360, found 0)
<7> [70.278284] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [70.278452] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2096, found 0)
<7> [70.278603] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [70.278743] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [70.278888] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [70.279028] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [70.279169] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [70.279309] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [70.279450] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [70.279603] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [70.279748] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [70.279889] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [70.280031] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 139929, found 0)
<7> [70.280173] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 139929, found 0)
<7> [70.280313] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in port_clock (expected 139929, found 0)
<7> [70.280454] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset
<7> [70.280605] i915 0000:00:02.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:82:pipe A] releasing DPLL 0
<7> [70.280768] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [70.280911] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:82:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [70.281088] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0
<7> [70.281229] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:77:cursor A] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0
<7> [70.281370] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32: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> [70.281523] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] lines 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [70.281662] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] blocks 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [70.281801] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] min_ddb 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [70.281942] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:82:pipe A] data rate 0 num active planes 0
<7> [70.282088] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 0
<7> [70.282247] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 180000 kHz, actual 180000 kHz
<7> [70.282389] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [70.282542] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:82:pipe A] enable: no [modeset]
<7> [70.282689] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane 1A] fb: [NOFB], visible: no
<7> [70.282833] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:41:plane 2A] fb: [NOFB], visible: no
<7> [70.282976] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:50:plane 3A] fb: [NOFB], visible: no
<7> [70.283117] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:59:plane 4A] fb: [NOFB], visible: no
<7> [70.283257] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:68:plane 5A] fb: [NOFB], visible: no
<7> [70.283397] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:77:cursor A] fb: [NOFB], visible: no
<7> [70.283591] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [70.283739] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [70.299495] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [70.318763] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [70.319431] i915 0000:00:02.0: [drm:intel_dp_dual_mode_set_tmds_output [i915]] Disabling DP dual mode adaptor TMDS output
<7> [70.325159] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:82:pipe A]
<7> [70.325876] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling DPLL 0
<7> [70.326505] i915 0000:00:02.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:32:plane 1A]
<7> [70.327177] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:136:DDI B/PHY B]
<7> [70.327841] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:146:DDI TC1/PHY C]
<7> [70.328437] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:150:DDI TC2/PHY D]
<7> [70.329054] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:152:DP-MST A]
<7> [70.329641] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:153:DP-MST B]
<7> [70.330264] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:137:HDMI-A-1]
<7> [70.331081] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [70.331853] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:82:pipe A]
<7> [70.332985] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B]
<7> [70.333351] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:134:pipe B]
<7> [70.333405] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:137:HDMI-A-1]
<7> [70.333545] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:137:HDMI-A-1] Limiting display bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [70.334069] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [70.334513] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:134:pipe B] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [70.335007] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:136:DDI B/PHY B] [CRTC:134:pipe B]
<7> [70.335445] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [70.335783] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [70.336163] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [70.336499] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [70.336847] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [70.337179] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [70.337506] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [70.337842] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2360)
<7> [70.338171] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [70.338488] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2360)
<7> [70.338723] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [70.338971] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2096)
<7> [70.339206] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [70.339439] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [70.339673] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [70.339920] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [70.340153] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [70.340387] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [70.340620] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [70.340878] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2360)
<7> [70.341113] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [70.341347] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2360)
<7> [70.341540] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [70.341702] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2096)
<7> [70.341874] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [70.342036] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [70.342199] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [70.342362] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [70.342525] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [70.342689] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [70.342857] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [70.343021] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [70.343184] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [70.343348] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in dpll_hw_state
<7> [70.343511] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [70.343674] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: cfgcr0: 0x0, cfgcr1: 0x0, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [70.343840] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [70.344019] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: cfgcr0: 0x1a6655d, cfgcr1: 0xe84, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [70.344188] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [70.344363] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 139929)
<7> [70.344505] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 139929)
<7> [70.344645] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in port_clock (expected 0, found 139929)
<7> [70.344785] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:134:pipe B] fastset requirement not met, forcing full modeset
<7> [70.344951] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [70.345095] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:134:pipe B] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x2
<7> [70.345264] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016
<7> [70.345404] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:129:cursor B] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32
<7> [70.345543] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84: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> [70.345687] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0
<7> [70.345826] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0
<7> [70.345980] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0
<7> [70.346123] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:134:pipe B] data rate 559716 num active planes 1
<7> [70.346269] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 560
<7> [70.346411] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [70.346565] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:84:plane 1B] min cdclk (69965 kHz) > [CRTC:134:pipe B] min cdclk (0 kHz)
<7> [70.346711] i915 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [i915]] new bandwidth min cdclk (10932 kHz) > old min cdclk (0 kHz)
<7> [70.346853] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 180000 kHz, actual 180000 kHz
<7> [70.347010] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [70.347151] i915 0000:00:02.0: [drm:intel_find_shared_dpll [i915]] [CRTC:134:pipe B] allocated DPLL 0
<7> [70.347297] i915 0000:00:02.0: [drm:intel_reference_shared_dpll_crtc [i915]] [CRTC:134:pipe B] reserving DPLL 0
<7> [70.347442] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:134:pipe B] enable: yes [modeset]
<7> [70.347585] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [70.347733] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 24, dithering: 0
<7> [70.347880] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [70.348019] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [70.348160] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [70.348300] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [70.348444] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [70.348588] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [70.348731] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0
<7> [70.348877] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, vmin: 0, vmax: 0, flipline: 0, pipeline full: 0, guardband: 0 vsync start: 0, vsync end: 0
<7> [70.349017] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: -1, vmax vblank: -2, vmin vtotal: 1, vmax vtotal: 0
<7> [70.349156] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [70.349297] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [70.349437] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [70.349577] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 53 139929 1920 2008 2096 2360 1080 1084 1089 1125 0x40 0x5
<7> [70.349716] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [70.349856] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139929, pipe src: 1920x1080+0+0, pixel rate 139929
<7> [70.350006] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0
<7> [70.350145] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [70.350284] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [70.350422] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [70.350560] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1a6655d, cfgcr1: 0xe84, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [70.350699] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [70.350838] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [70.350999] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [70.351137] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [70.351274] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [70.351412] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [70.351550] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [70.351688] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [70.351826] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [70.351977] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [70.352119] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [70.352260] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [70.352399] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:84:plane 1B] fb: [FB:166] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [70.352539] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [70.352683] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [70.352823] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:93:plane 2B] fb: [NOFB], visible: no
<7> [70.352970] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:102:plane 3B] fb: [NOFB], visible: no
<7> [70.353111] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:111:plane 4B] fb: [NOFB], visible: no
<7> [70.353249] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:120:plane 5B] fb: [NOFB], visible: no
<7> [70.353388] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:129:cursor B] fb: [NOFB], visible: no
<7> [70.353967] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [70.354191] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:136:DDI B/PHY B]
<7> [70.354334] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:146:DDI TC1/PHY C]
<7> [70.354476] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:150:DDI TC2/PHY D]
<7> [70.354617] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:152:DP-MST A]
<7> [70.354756] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:153:DP-MST B]
<7> [70.354938] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [70.355116] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enable DPLL 0 (active 0x2, on? 0) for [CRTC:134:pipe B]
<7> [70.355262] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enabling DPLL 0
<7> [70.355496] i915 0000:00:02.0: [drm:intel_dp_dual_mode_set_tmds_output [i915]] Enabling DP dual mode adaptor TMDS output
<7> [70.360764] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [70.360952] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B
<7> [70.380746] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:137:HDMI-A-1]
<7> [70.380934] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:134:pipe B]
<6> [88.346977] [IGT] kms_flip: finished subtest B-HDMI-A1, FAIL
<6> [88.347512] [IGT] kms_flip: finished subtest blocking-wf_vblank, FAIL
<7> [88.355805] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:167] from all active usage due to RMFB ioctl
<7> [88.356012] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:84:plane 1B] because [FB:167] is removed
<7> [88.356087] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] ddb ( 0 - 2016) -> ( 0 - 0), size 2016 -> 0
<7> [88.356293] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84: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> [88.356469] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] lines 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [88.356729] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] blocks 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [88.356906] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:84:plane 1B] min_ddb 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [88.357082] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:134:pipe B] data rate 0 num active planes 0
<7> [88.357264] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 0
<6> [88.377784] [IGT] kms_flip: exiting, ret=98
<7> [88.389041] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:137:HDMI-A-1] Limiting display bpp to 24 (EDID bpp 24, max requested bpp 36, max platform bpp 36)
<7> [88.389231] i915 0000:00:02.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [88.389374] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:82:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [88.389535] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:136:DDI B/PHY B] [CRTC:82:pipe A]
<7> [88.389687] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [88.389839] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [88.389983] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [88.390127] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [88.390269] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [88.390411] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [88.390553] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [88.390703] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2360)
<7> [88.390849] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [88.390992] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2360)
<7> [88.391134] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [88.391275] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2096)
<7> [88.391419] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [88.391563] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [88.391712] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [88.391854] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [88.391995] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [88.392135] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [88.392275] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [88.392416] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2360)
<7> [88.392558] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [88.392709] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2360)
<7> [88.392852] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [88.392994] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2096)
<7> [88.393135] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [88.393276] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [88.393416] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [88.393556] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [88.393703] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [88.393844] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [88.393984] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [88.394124] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [88.394264] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [88.394404] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [88.394545] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 139929)
<7> [88.394877] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 139929)
<7> [88.395024] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in port_clock (expected 0, found 139929)
<7> [88.395170] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:82:pipe A] fastset requirement not met, forcing full modeset
<7> [88.395316] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.enable (expected yes, found no)
<7> [88.395461] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.active (expected yes, found no)
<7> [88.395605] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [88.395781] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in lane_count (expected 4, found 0)
<7> [88.395923] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [88.396064] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [88.396205] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [88.396346] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2360, found 0)
<7> [88.396487] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [88.396633] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2360, found 0)
<7> [88.396808] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [88.396950] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2096, found 0)
<7> [88.397091] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [88.397231] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [88.397372] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [88.397512] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [88.397680] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [88.397820] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [88.397960] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [88.398100] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2360, found 0)
<7> [88.398241] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [88.398381] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2360, found 0)
<7> [88.398521] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [88.398684] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2096, found 0)
<7> [88.398824] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [88.398965] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [88.399105] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [88.399246] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [88.399386] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [88.399528] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [88.399684] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [88.399827] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [88.399969] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [88.400110] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [88.400251] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 139929, found 0)
<7> [88.400393] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 139929, found 0)
<7> [88.400533] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:134:pipe B] fastset requirement not met in port_clock (expected 139929, found 0)
<7> [88.400680] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:134:pipe B] fastset requirement not met, forcing full modeset
<7> [88.400832] i915 0000:00:02.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:134:pipe B] releasing DPLL 0
<7> [88.401014] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:82:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x2 -> 0x1
<7> [88.401157] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:134:pipe B] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x2 -> 0x1
<7> [88.401315] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] ddb ( 0 - 0) -> ( 0 - 2016), size 0 -> 2016
<7> [88.401456] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:77:cursor A] ddb ( 0 - 0) -> (2016 - 2048), size 0 -> 32
<7> [88.401600] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32: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> [88.401751] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 2, 2, 2, 2, 5, 8, 9, 0, 0, 0
<7> [88.401891] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 33, 33, 33, 33, 81, 129, 145, 30, 0, 0
<7> [88.402030] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 38, 38, 38, 38, 91, 143, 161, 31, 0, 0
<7> [88.402169] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:129:cursor B] ddb (2016 - 2048) -> ( 0 - 0), size 32 -> 0
<7> [88.402310] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:82:pipe A] data rate 559716 num active planes 1
<7> [88.402456] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 16761 required 560
<7> [88.402598] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [88.403114] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:32:plane 1A] min cdclk (69965 kHz) > [CRTC:82:pipe A] min cdclk (0 kHz)
<7> [88.403263] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 180000 kHz, actual 180000 kHz
<7> [88.403406] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [88.403548] i915 0000:00:02.0: [drm:intel_find_shared_dpll [i915]] [CRTC:82:pipe A] allocated DPLL 0
<7> [88.403703] i915 0000:00:02.0: [drm:intel_reference_shared_dpll_crtc [i915]] [CRTC:82:pipe A] reserving DPLL 0
<7> [88.403853] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:82:pipe A] enable: yes [modeset]
<7> [88.403996] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [88.404139] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [88.404281] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [88.404426] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [88.404569] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [88.404718] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [88.404860] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [88.405001] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 2
<7> [88.405141] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0
<7> [88.405280] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, vmin: 0, vmax: 0, flipline: 0, pipeline full: 0, guardband: 0 vsync start: 0, vsync end: 0
<7> [88.405419] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: -1, vmax vblank: -2, vmin vtotal: 1, vmax vtotal: 0
<7> [88.405559] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [88.405706] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 53 139930 1920 2008 2096 2360 1080 1084 1089 1125 0x48 0x5
<7> [88.405847] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [88.405987] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 53 139929 1920 2008 2096 2360 1080 1084 1089 1125 0x40 0x5
<7> [88.406127] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=139929, hd=1920 hb=1920-2360 hs=2008-2096 ht=2360, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [88.406266] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 139929, pipe src: 1920x1080+0+0, pixel rate 139929
<7> [88.406405] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 135, ips linetime: 0
<7> [88.406544] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [88.406689] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [88.406829] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [88.406968] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x1a6655d, cfgcr1: 0xe84, div0: 0x0, mg_refclkin_ctl: 0x0, hg_clktop2_coreclkctl1: 0x0, mg_clktop2_hsclkctl: 0x0, mg_pll_div0: 0x0, mg_pll_div2: 0x0, mg_pll_lf: 0x0, mg_pll_frac_lock: 0x0, mg_pll_ssc: 0x0, mg_pll_bias: 0x0, mg_pll_tdc_coldst_bias: 0x0
<7> [88.407112] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [88.407255] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [88.407396] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [88.407537] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [88.407683] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [88.407822] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [88.407961] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [88.408100] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [88.408239] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [88.408377] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [88.408517] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [88.408662] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [88.408803] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane 1A] fb: [FB:162] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [88.408945] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [88.409090] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [88.409234] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:41:plane 2A] fb: [NOFB], visible: no
<7> [88.409376] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:50:plane 3A] fb: [NOFB], visible: no
<7> [88.409515] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:59:plane 4A] fb: [NOFB], visible: no
<7> [88.409660] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:68:plane 5A] fb: [NOFB], visible: no
<7> [88.409799] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:77:cursor A] fb: [NOFB], visible: no
<7> [88.409937] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:134:pipe B] enable: no [modeset]
<7> [88.410079] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:84:plane 1B] fb: [NOFB], visible: no
<7> [88.410217] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:93:plane 2B] fb: [NOFB], visible: no
<7> [88.410356] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:102:plane 3B] fb: [NOFB], visible: no
<7> [88.410496] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:111:plane 4B] fb: [NOFB], visible: no
<7> [88.410637] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:120:plane 5B] fb: [NOFB], visible: no
<7> [88.410792] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:129:cursor B] fb: [NOFB], visible: no
<7> [88.411740] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe B
<7> [88.426677] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_B
<7> [88.426933] i915 0000:00:02.0: [drm:intel_dp_dual_mode_set_tmds_output [i915]] Disabling DP dual mode adaptor TMDS output
<7> [88.431962] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disable DPLL 0 (active 0x2, on? 1) for [CRTC:134:pipe B]
<7> [88.432192] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling DPLL 0
<7> [88.432350] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:136:DDI B/PHY B]
<7> [88.432495] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:146:DDI TC1/PHY C]
<7> [88.432638] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:150:DDI TC2/PHY D]
<7> [88.432820] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:152:DP-MST A]
<7> [88.432965] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:153:DP-MST B]
<7> [88.433191] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:82:pipe A]
<7> [88.433338] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enabling DPLL 0
<7> [88.433924] i915 0000:00:02.0: [drm:intel_dp_dual_mode_set_tmds_output [i915]] Enabling DP dual mode adaptor TMDS output
<7> [88.439182] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_B
<7> [88.439369] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [88.439866] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1
<7> [88.440016] i915 0000:00:02.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:32:plane 1A]
<7> [88.459045] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:137:HDMI-A-1]
<7> [88.459705] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:82:pipe A]
<7> [88.461080] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_3
<7> [88.461954] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:134:pipe B]
<7> [88.463340] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0
<7> [88.480766] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [88.481415] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [88.482078] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
Created at 2025-03-08 03:17:51