Results for igt@kms_flip@flip-vs-absolute-wf_vblank@b-vga1

Machine description: shard-snb7

Result: Fail

integration-manifest git-log-oneline i915_display_info6 igt_runner6 run6 runtimes6 results6.json i915_display_info_post_exec6 boot6 dmesg6

DetailValue
Duration 10.98 seconds
Hostname
shard-snb7
Igt-Version
IGT-Version: 1.29-NO-GIT (x86_64) (Linux: 6.12.0-rc2-CI_DRM_15514-gf3354eab2a45+ x86_64)
Out
Starting dynamic subtest: B-VGA1
  1024x768: 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa 
Expected frametime: 16666us; measured 16837.9us +- 1.746us accuracy 0.03%
vblank interval differs from modeline! expected 16665.6us, measured 16838us +- 1.746us, difference 172.3us (98.6 sigma)
Stack trace:
  #0 ../lib/igt_core.c:2051 __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-VGA1: FAIL (10.979s)
Err
Starting dynamic subtest: B-VGA1
(kms_flip:1830) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:1830) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
Dynamic subtest B-VGA1 failed.
**** DEBUG ****
(kms_flip:1830) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1024, height=768, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:1830) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=3, pitch=4096)
(kms_flip:1830) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:1830) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1024, height=768, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:1830) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=4, pitch=4096)
(kms_flip:1830) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:1830) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1830) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1830) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
(kms_flip:1830) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1830) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1830) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
(kms_flip:1830) igt_kms-INFO:   1024x768: 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa 
(kms_flip:1830) DEBUG: No stale events found
(kms_flip:1830) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0
(kms_flip:1830) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0
(kms_flip:1830) INFO: Expected frametime: 16666us; measured 16837.9us +- 1.746us accuracy 0.03%
(kms_flip:1830) INFO: vblank interval differs from modeline! expected 16665.6us, measured 16838us +- 1.746us, difference 172.3us (98.6 sigma)
(kms_flip:1830) DEBUG: name = flip
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 304.292114
current_received_ts = 304.291534
current_seq = 3402
count = 0
seq_step = 1
(kms_flip:1830) DEBUG: name = vblank
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 304.443634
current_received_ts = 304.443054
current_seq = 3411
count = 0
seq_step = 10
(kms_flip:1830) DEBUG: name = flip
last_ts = 304.292114
last_received_ts = 304.291534
last_seq = 3402
current_ts = 304.460480
current_received_ts = 304.459900
current_seq = 3412
count = 1
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 304.292114/3402, current 304.460480/3412: elapsed=168380.0us expected=168378.8us +- 841.9us, error 0.0%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 304.443634
last_received_ts = 304.443054
last_seq = 3411
current_ts = 304.611969
current_received_ts = 304.611359
current_seq = 3421
count = 1
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 304.443634/3411, current 304.611969/3421: elapsed=168309.0us expected=168378.8us +- 841.9us, error 0.0%
(kms_flip:1830) DEBUG: name = flip
last_ts = 304.460480
last_received_ts = 304.459900
last_seq = 3412
current_ts = 304.628784
current_received_ts = 304.628174
current_seq = 3422
count = 2
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 304.460480/3412, current 304.628784/3422: elapsed=168294.0us expected=168378.8us +- 841.9us, error 0.1%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 304.611969
last_received_ts = 304.611359
last_seq = 3421
current_ts = 304.780182
current_received_ts = 304.779572
current_seq = 3431
count = 2
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 304.611969/3421, current 304.780182/3431: elapsed=168239.0us expected=168378.8us +- 841.9us, error 0.1%
(kms_flip:1830) DEBUG: name = flip
last_ts = 304.628784
last_received_ts = 304.628174
last_seq = 3422
current_ts = 304.797028
current_received_ts = 304.796387
current_seq = 3432
count = 3
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 304.628784/3422, current 304.797028/3432: elapsed=168242.0us expected=168378.8us +- 841.9us, error 0.1%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 304.780182
last_received_ts = 304.779572
last_seq = 3431
current_ts = 304.948425
current_received_ts = 304.947815
current_seq = 3441
count = 3
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 304.780182/3431, current 304.948425/3441: elapsed=168238.0us expected=168378.8us +- 841.9us, error 0.1%
(kms_flip:1830) DEBUG: name = flip
last_ts = 304.797028
last_received_ts = 304.796387
last_seq = 3432
current_ts = 304.965271
current_received_ts = 304.964661
current_seq = 3442
count = 4
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 304.797028/3432, current 304.965271/3442: elapsed=168235.0us expected=168378.8us +- 841.9us, error 0.1%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 304.948425
last_received_ts = 304.947815
last_seq = 3441
current_ts = 305.116669
current_received_ts = 305.116058
current_seq = 3451
count = 4
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 304.948425/3441, current 305.116669/3451: elapsed=168238.0us expected=168378.8us +- 841.9us, error 0.1%
(kms_flip:1830) DEBUG: name = flip
last_ts = 304.965271
last_received_ts = 304.964661
last_seq = 3442
current_ts = 305.133484
current_received_ts = 305.132904
current_seq = 3452
count = 5
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 304.965271/3442, current 305.133484/3452: elapsed=168238.0us expected=168378.8us +- 841.9us, error 0.1%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 305.116669
last_received_ts = 305.116058
last_seq = 3451
current_ts = 305.284912
current_received_ts = 305.284302
current_seq = 3461
count = 5
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 305.116669/3451, current 305.284912/3461: elapsed=168239.0us expected=168378.8us +- 841.9us, error 0.1%
(kms_flip:1830) DEBUG: name = flip
last_ts = 305.133484
last_received_ts = 305.132904
last_seq = 3452
current_ts = 305.301727
current_received_ts = 305.301117
current_seq = 3462
count = 6
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 305.133484/3452, current 305.301727/3462: elapsed=168239.0us expected=168378.8us +- 841.9us, error 0.1%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 305.284912
last_received_ts = 305.284302
last_seq = 3461
current_ts = 305.453156
current_received_ts = 305.452515
current_seq = 3471
count = 6
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 305.284912/3461, current 305.453156/3471: elapsed=168239.0us expected=168378.8us +- 841.9us, error 0.1%
(kms_flip:1830) DEBUG: name = flip
last_ts = 305.301727
last_received_ts = 305.301117
last_seq = 3462
current_ts = 305.469971
current_received_ts = 305.469360
current_seq = 3472
count = 7
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 305.301727/3462, current 305.469971/3472: elapsed=168239.0us expected=168378.8us +- 841.9us, error 0.1%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 305.453156
last_received_ts = 305.452515
last_seq = 3471
current_ts = 305.621307
current_received_ts = 305.620697
current_seq = 3481
count = 7
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 305.453156/3471, current 305.621307/3481: elapsed=168169.0us expected=168378.8us +- 841.9us, error 0.1%
(kms_flip:1830) DEBUG: name = flip
last_ts = 305.469971
last_received_ts = 305.469360
last_seq = 3472
current_ts = 305.638123
current_received_ts = 305.637512
current_seq = 3482
count = 8
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 305.469971/3472, current 305.638123/3482: elapsed=168158.0us expected=168378.8us +- 841.9us, error 0.1%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 305.621307
last_received_ts = 305.620697
last_seq = 3481
current_ts = 305.789429
current_received_ts = 305.788818
current_seq = 3491
count = 8
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 305.621307/3481, current 305.789429/3491: elapsed=168115.0us expected=168378.8us +- 841.9us, error 0.2%
(kms_flip:1830) DEBUG: name = flip
last_ts = 305.638123
last_received_ts = 305.637512
last_seq = 3482
current_ts = 305.806244
current_received_ts = 305.805634
current_seq = 3492
count = 9
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 305.638123/3482, current 305.806244/3492: elapsed=168114.0us expected=168378.8us +- 841.9us, error 0.2%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 305.789429
last_received_ts = 305.788818
last_seq = 3491
current_ts = 305.957550
current_received_ts = 305.956909
current_seq = 3501
count = 9
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 305.789429/3491, current 305.957550/3501: elapsed=168117.0us expected=168378.8us +- 841.9us, error 0.2%
(kms_flip:1830) DEBUG: name = flip
last_ts = 305.806244
last_received_ts = 305.805634
last_seq = 3492
current_ts = 305.974365
current_received_ts = 305.973724
current_seq = 3502
count = 10
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 305.806244/3492, current 305.974365/3502: elapsed=168115.0us expected=168378.8us +- 841.9us, error 0.2%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 305.957550
last_received_ts = 305.956909
last_seq = 3501
current_ts = 306.125671
current_received_ts = 306.125092
current_seq = 3511
count = 10
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 305.957550/3501, current 306.125671/3511: elapsed=168114.0us expected=168378.8us +- 841.9us, error 0.2%
(kms_flip:1830) DEBUG: name = flip
last_ts = 305.974365
last_received_ts = 305.973724
last_seq = 3502
current_ts = 306.142487
current_received_ts = 306.141876
current_seq = 3512
count = 11
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 305.974365/3502, current 306.142487/3512: elapsed=168115.0us expected=168378.8us +- 841.9us, error 0.2%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 306.125671
last_received_ts = 306.125092
last_seq = 3511
current_ts = 306.293793
current_received_ts = 306.293152
current_seq = 3521
count = 11
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 306.125671/3511, current 306.293793/3521: elapsed=168116.0us expected=168378.8us +- 841.9us, error 0.2%
(kms_flip:1830) DEBUG: name = flip
last_ts = 306.142487
last_received_ts = 306.141876
last_seq = 3512
current_ts = 306.310577
current_received_ts = 306.309998
current_seq = 3522
count = 12
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 306.142487/3512, current 306.310577/3522: elapsed=168116.0us expected=168378.8us +- 841.9us, error 0.2%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 306.293793
last_received_ts = 306.293152
last_seq = 3521
current_ts = 306.461884
current_received_ts = 306.461273
current_seq = 3531
count = 12
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 306.293793/3521, current 306.461884/3531: elapsed=168115.0us expected=168378.8us +- 841.9us, error 0.2%
(kms_flip:1830) DEBUG: name = flip
last_ts = 306.310577
last_received_ts = 306.309998
last_seq = 3522
current_ts = 306.478699
current_received_ts = 306.478088
current_seq = 3532
count = 13
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 306.310577/3522, current 306.478699/3532: elapsed=168115.0us expected=168378.8us +- 841.9us, error 0.2%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 306.461884
last_received_ts = 306.461273
last_seq = 3531
current_ts = 306.629944
current_received_ts = 306.629333
current_seq = 3541
count = 13
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 306.461884/3531, current 306.629944/3541: elapsed=168050.0us expected=168378.8us +- 841.9us, error 0.2%
(kms_flip:1830) DEBUG: name = flip
last_ts = 306.478699
last_received_ts = 306.478088
last_seq = 3532
current_ts = 306.646759
current_received_ts = 306.646149
current_seq = 3542
count = 14
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 306.478699/3532, current 306.646759/3542: elapsed=168040.0us expected=168378.8us +- 841.9us, error 0.2%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 306.629944
last_received_ts = 306.629333
last_seq = 3541
current_ts = 306.797943
current_received_ts = 306.797333
current_seq = 3551
count = 14
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 306.629944/3541, current 306.797943/3551: elapsed=168007.0us expected=168378.8us +- 841.9us, error 0.2%
(kms_flip:1830) DEBUG: name = flip
last_ts = 306.646759
last_received_ts = 306.646149
last_seq = 3542
current_ts = 306.814758
current_received_ts = 306.814117
current_seq = 3552
count = 15
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 306.646759/3542, current 306.814758/3552: elapsed=168010.0us expected=168378.8us +- 841.9us, error 0.2%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 306.797943
last_received_ts = 306.797333
last_seq = 3551
current_ts = 306.965973
current_received_ts = 306.965332
current_seq = 3561
count = 15
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 306.797943/3551, current 306.965973/3561: elapsed=168008.0us expected=168378.8us +- 841.9us, error 0.2%
(kms_flip:1830) DEBUG: name = flip
last_ts = 306.814758
last_received_ts = 306.814117
last_seq = 3552
current_ts = 306.982758
current_received_ts = 306.982178
current_seq = 3562
count = 16
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 306.814758/3552, current 306.982758/3562: elapsed=168005.0us expected=168378.8us +- 841.9us, error 0.2%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 306.965973
last_received_ts = 306.965332
last_seq = 3561
current_ts = 307.133972
current_received_ts = 307.133392
current_seq = 3571
count = 16
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 306.965973/3561, current 307.133972/3571: elapsed=168007.0us expected=168378.8us +- 841.9us, error 0.2%
(kms_flip:1830) DEBUG: name = flip
last_ts = 306.982758
last_received_ts = 306.982178
last_seq = 3562
current_ts = 307.150757
current_received_ts = 307.150177
current_seq = 3572
count = 17
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 306.982758/3562, current 307.150757/3572: elapsed=168007.0us expected=168378.8us +- 841.9us, error 0.2%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 307.133972
last_received_ts = 307.133392
last_seq = 3571
current_ts = 307.301971
current_received_ts = 307.301392
current_seq = 3581
count = 17
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 307.133972/3571, current 307.301971/3581: elapsed=168008.0us expected=168378.8us +- 841.9us, error 0.2%
(kms_flip:1830) DEBUG: name = flip
last_ts = 307.150757
last_received_ts = 307.150177
last_seq = 3572
current_ts = 307.318787
current_received_ts = 307.318176
current_seq = 3582
count = 18
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 307.150757/3572, current 307.318787/3582: elapsed=168009.0us expected=168378.8us +- 841.9us, error 0.2%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 307.301971
last_received_ts = 307.301392
last_seq = 3581
current_ts = 307.469971
current_received_ts = 307.469360
current_seq = 3591
count = 18
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 307.301971/3581, current 307.469971/3591: elapsed=168008.0us expected=168378.8us +- 841.9us, error 0.2%
(kms_flip:1830) DEBUG: name = flip
last_ts = 307.318787
last_received_ts = 307.318176
last_seq = 3582
current_ts = 307.486786
current_received_ts = 307.486176
current_seq = 3592
count = 19
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 307.318787/3582, current 307.486786/3592: elapsed=168006.0us expected=168378.8us +- 841.9us, error 0.2%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 307.469971
last_received_ts = 307.469360
last_seq = 3591
current_ts = 307.637939
current_received_ts = 307.637329
current_seq = 3601
count = 19
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 307.469971/3591, current 307.637939/3601: elapsed=167943.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = flip
last_ts = 307.486786
last_received_ts = 307.486176
last_seq = 3592
current_ts = 307.654724
current_received_ts = 307.654114
current_seq = 3602
count = 20
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 307.486786/3592, current 307.654724/3602: elapsed=167936.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 307.637939
last_received_ts = 307.637329
last_seq = 3601
current_ts = 307.805847
current_received_ts = 307.805237
current_seq = 3611
count = 20
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 307.637939/3601, current 307.805847/3611: elapsed=167913.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = flip
last_ts = 307.654724
last_received_ts = 307.654114
last_seq = 3602
current_ts = 307.822632
current_received_ts = 307.822052
current_seq = 3612
count = 21
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 307.654724/3602, current 307.822632/3612: elapsed=167911.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 307.805847
last_received_ts = 307.805237
last_seq = 3611
current_ts = 307.973755
current_received_ts = 307.973114
current_seq = 3621
count = 21
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 307.805847/3611, current 307.973755/3621: elapsed=167913.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = flip
last_ts = 307.822632
last_received_ts = 307.822052
last_seq = 3612
current_ts = 307.990540
current_received_ts = 307.989960
current_seq = 3622
count = 22
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 307.822632/3612, current 307.990540/3622: elapsed=167914.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 307.973755
last_received_ts = 307.973114
last_seq = 3621
current_ts = 308.141663
current_received_ts = 308.141083
current_seq = 3631
count = 22
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 307.973755/3621, current 308.141663/3631: elapsed=167914.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = flip
last_ts = 307.990540
last_received_ts = 307.989960
last_seq = 3622
current_ts = 308.158447
current_received_ts = 308.157867
current_seq = 3632
count = 23
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 307.990540/3622, current 308.158447/3632: elapsed=167914.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 308.141663
last_received_ts = 308.141083
last_seq = 3631
current_ts = 308.309570
current_received_ts = 308.309052
current_seq = 3641
count = 23
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 308.141663/3631, current 308.309570/3641: elapsed=167916.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = flip
last_ts = 308.158447
last_received_ts = 308.157867
last_seq = 3632
current_ts = 308.326355
current_received_ts = 308.325775
current_seq = 3642
count = 24
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 308.158447/3632, current 308.326355/3642: elapsed=167913.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 308.309570
last_received_ts = 308.309052
last_seq = 3641
current_ts = 308.477478
current_received_ts = 308.476929
current_seq = 3651
count = 24
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 308.309570/3641, current 308.477478/3651: elapsed=167910.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = flip
last_ts = 308.326355
last_received_ts = 308.325775
last_seq = 3642
current_ts = 308.494293
current_received_ts = 308.493713
current_seq = 3652
count = 25
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 308.326355/3642, current 308.494293/3652: elapsed=167912.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 308.477478
last_received_ts = 308.476929
last_seq = 3651
current_ts = 308.645355
current_received_ts = 308.644745
current_seq = 3661
count = 25
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 308.477478/3651, current 308.645355/3661: elapsed=167855.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = flip
last_ts = 308.494293
last_received_ts = 308.493713
last_seq = 3652
current_ts = 308.662140
current_received_ts = 308.661560
current_seq = 3662
count = 26
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 308.494293/3652, current 308.662140/3662: elapsed=167848.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 308.645355
last_received_ts = 308.644745
last_seq = 3661
current_ts = 308.813171
current_received_ts = 308.812592
current_seq = 3671
count = 26
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 308.645355/3661, current 308.813171/3671: elapsed=167831.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = flip
last_ts = 308.662140
last_received_ts = 308.661560
last_seq = 3662
current_ts = 308.829956
current_received_ts = 308.829346
current_seq = 3672
count = 27
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 308.662140/3662, current 308.829956/3672: elapsed=167828.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 308.813171
last_received_ts = 308.812592
last_seq = 3671
current_ts = 308.981018
current_received_ts = 308.980408
current_seq = 3681
count = 27
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 308.813171/3671, current 308.981018/3681: elapsed=167830.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = flip
last_ts = 308.829956
last_received_ts = 308.829346
last_seq = 3672
current_ts = 308.997803
current_received_ts = 308.997162
current_seq = 3682
count = 28
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 308.829956/3672, current 308.997803/3682: elapsed=167832.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 308.981018
last_received_ts = 308.980408
last_seq = 3681
current_ts = 309.148834
current_received_ts = 309.148224
current_seq = 3691
count = 28
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 308.981018/3681, current 309.148834/3691: elapsed=167831.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = flip
last_ts = 308.997803
last_received_ts = 308.997162
last_seq = 3682
current_ts = 309.165619
current_received_ts = 309.165100
current_seq = 3692
count = 29
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 308.997803/3682, current 309.165619/3692: elapsed=167831.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 309.148834
last_received_ts = 309.148224
last_seq = 3691
current_ts = 309.316681
current_received_ts = 309.316071
current_seq = 3701
count = 29
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 309.148834/3691, current 309.316681/3701: elapsed=167832.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = flip
last_ts = 309.165619
last_received_ts = 309.165100
last_seq = 3692
current_ts = 309.333466
current_received_ts = 309.332947
current_seq = 3702
count = 30
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 309.165619/3692, current 309.333466/3702: elapsed=167830.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 309.316681
last_received_ts = 309.316071
last_seq = 3701
current_ts = 309.484497
current_received_ts = 309.483856
current_seq = 3711
count = 30
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 309.316681/3701, current 309.484497/3711: elapsed=167827.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = flip
last_ts = 309.333466
last_received_ts = 309.332947
last_seq = 3702
current_ts = 309.501282
current_received_ts = 309.500702
current_seq = 3712
count = 31
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 309.333466/3702, current 309.501282/3712: elapsed=167832.0us expected=168378.8us +- 841.9us, error 0.3%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 309.484497
last_received_ts = 309.483856
last_seq = 3711
current_ts = 309.652283
current_received_ts = 309.651672
current_seq = 3721
count = 31
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 309.484497/3711, current 309.652283/3721: elapsed=167779.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = flip
last_ts = 309.501282
last_received_ts = 309.500702
last_seq = 3712
current_ts = 309.669067
current_received_ts = 309.668488
current_seq = 3722
count = 32
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 309.501282/3712, current 309.669067/3722: elapsed=167772.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 309.652283
last_received_ts = 309.651672
last_seq = 3721
current_ts = 309.820038
current_received_ts = 309.819458
current_seq = 3731
count = 32
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 309.652283/3721, current 309.820038/3731: elapsed=167760.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = flip
last_ts = 309.669067
last_received_ts = 309.668488
last_seq = 3722
current_ts = 309.836823
current_received_ts = 309.836243
current_seq = 3732
count = 33
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 309.669067/3722, current 309.836823/3732: elapsed=167755.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 309.820038
last_received_ts = 309.819458
last_seq = 3731
current_ts = 309.987793
current_received_ts = 309.987152
current_seq = 3741
count = 33
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 309.820038/3731, current 309.987793/3741: elapsed=167754.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = flip
last_ts = 309.836823
last_received_ts = 309.836243
last_seq = 3732
current_ts = 310.004578
current_received_ts = 310.003998
current_seq = 3742
count = 34
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 309.836823/3732, current 310.004578/3742: elapsed=167758.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 309.987793
last_received_ts = 309.987152
last_seq = 3741
current_ts = 310.155548
current_received_ts = 310.154968
current_seq = 3751
count = 34
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 309.987793/3741, current 310.155548/3751: elapsed=167761.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = flip
last_ts = 310.004578
last_received_ts = 310.003998
last_seq = 3742
current_ts = 310.172333
current_received_ts = 310.171722
current_seq = 3752
count = 35
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 310.004578/3742, current 310.172333/3752: elapsed=167760.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 310.155548
last_received_ts = 310.154968
last_seq = 3751
current_ts = 310.323303
current_received_ts = 310.322632
current_seq = 3761
count = 35
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 310.155548/3751, current 310.323303/3761: elapsed=167750.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = flip
last_ts = 310.172333
last_received_ts = 310.171722
last_seq = 3752
current_ts = 310.340088
current_received_ts = 310.339447
current_seq = 3762
count = 36
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 310.172333/3752, current 310.340088/3762: elapsed=167758.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 310.323303
last_received_ts = 310.322632
last_seq = 3761
current_ts = 310.491058
current_received_ts = 310.490417
current_seq = 3771
count = 36
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 310.323303/3761, current 310.491058/3771: elapsed=167761.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = flip
last_ts = 310.340088
last_received_ts = 310.339447
last_seq = 3762
current_ts = 310.507843
current_received_ts = 310.507233
current_seq = 3772
count = 37
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 310.340088/3762, current 310.507843/3772: elapsed=167758.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 310.491058
last_received_ts = 310.490417
last_seq = 3771
current_ts = 310.658783
current_received_ts = 310.658173
current_seq = 3781
count = 37
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 310.491058/3771, current 310.658783/3781: elapsed=167714.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = flip
last_ts = 310.507843
last_received_ts = 310.507233
last_seq = 3772
current_ts = 310.675537
current_received_ts = 310.674957
current_seq = 3782
count = 38
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 310.507843/3772, current 310.675537/3782: elapsed=167702.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 310.658783
last_received_ts = 310.658173
last_seq = 3781
current_ts = 310.826477
current_received_ts = 310.825867
current_seq = 3791
count = 38
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 310.658783/3781, current 310.826477/3791: elapsed=167695.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = flip
last_ts = 310.675537
last_received_ts = 310.674957
last_seq = 3782
current_ts = 310.843231
current_received_ts = 310.842621
current_seq = 3792
count = 39
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 310.675537/3782, current 310.843231/3792: elapsed=167694.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 310.826477
last_received_ts = 310.825867
last_seq = 3791
current_ts = 310.994171
current_received_ts = 310.993500
current_seq = 3801
count = 39
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 310.826477/3791, current 310.994171/3801: elapsed=167694.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = flip
last_ts = 310.843231
last_received_ts = 310.842621
last_seq = 3792
current_ts = 311.010925
current_received_ts = 311.010345
current_seq = 3802
count = 40
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 310.843231/3792, current 311.010925/3802: elapsed=167697.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 310.994171
last_received_ts = 310.993500
last_seq = 3801
current_ts = 311.161865
current_received_ts = 311.161255
current_seq = 3811
count = 40
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 310.994171/3801, current 311.161865/3811: elapsed=167697.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = flip
last_ts = 311.010925
last_received_ts = 311.010345
last_seq = 3802
current_ts = 311.178619
current_received_ts = 311.178070
current_seq = 3812
count = 41
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 311.010925/3802, current 311.178619/3812: elapsed=167694.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 311.161865
last_received_ts = 311.161255
last_seq = 3811
current_ts = 311.329559
current_received_ts = 311.328949
current_seq = 3821
count = 41
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 311.161865/3811, current 311.329559/3821: elapsed=167695.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = flip
last_ts = 311.178619
last_received_ts = 311.178070
last_seq = 3812
current_ts = 311.346344
current_received_ts = 311.345642
current_seq = 3822
count = 42
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 311.178619/3812, current 311.346344/3822: elapsed=167704.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 311.329559
last_received_ts = 311.328949
last_seq = 3821
current_ts = 311.497253
current_received_ts = 311.496613
current_seq = 3831
count = 42
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 311.329559/3821, current 311.497253/3831: elapsed=167694.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = flip
last_ts = 311.346344
last_received_ts = 311.345642
last_seq = 3822
current_ts = 311.514008
current_received_ts = 311.513397
current_seq = 3832
count = 43
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 311.346344/3822, current 311.514008/3832: elapsed=167687.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 311.497253
last_received_ts = 311.496613
last_seq = 3831
current_ts = 311.664917
current_received_ts = 311.664307
current_seq = 3841
count = 43
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 311.497253/3831, current 311.664917/3841: elapsed=167652.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = flip
last_ts = 311.514008
last_received_ts = 311.513397
last_seq = 3832
current_ts = 311.681671
current_received_ts = 311.681091
current_seq = 3842
count = 44
seq_step = 1
(kms_flip:1830) DEBUG: flip ts/seq: last 311.514008/3832, current 311.681671/3842: elapsed=167640.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: name = vblank
last_ts = 311.664917
last_received_ts = 311.664307
last_seq = 3841
current_ts = 311.832550
current_received_ts = 311.831909
current_seq = 3851
count = 44
seq_step = 10
(kms_flip:1830) DEBUG: vblank ts/seq: last 311.664917/3841, current 311.832550/3851: elapsed=167639.0us expected=168378.8us +- 841.9us, error 0.4%
(kms_flip:1830) DEBUG: expected 448, counted 450, encoder type 1
(kms_flip:1830) DEBUG: dropped frames, expected 448, counted 450, encoder type 1
(kms_flip:1830) DEBUG: expected 448, counted 450, encoder type 1
(kms_flip:1830) DEBUG: dropped frames, expected 448, counted 450, encoder type 1
(kms_flip:1830) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:1830) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
(kms_flip:1830) igt_core-INFO: Stack trace:
(kms_flip:1830) igt_core-INFO:   #0 ../lib/igt_core.c:2051 __igt_fail_assert()
(kms_flip:1830) igt_core-INFO:   #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0()
(kms_flip:1830) igt_core-INFO:   #2 ../tests/kms_flip.c:1845 run_test()
(kms_flip:1830) igt_core-INFO:   #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001()
(kms_flip:1830) igt_core-INFO:   #4 ../tests/kms_flip.c:2001 main()
(kms_flip:1830) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:1830) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:1830) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest B-VGA1: FAIL (10.979s)
Dmesg
<6> [303.465624] [IGT] kms_flip: starting dynamic subtest B-VGA1
<7> [303.465960] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [303.466036] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:85]
<7> [303.499443] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:47:pipe A]
<7> [303.499564] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [303.499983] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [303.500281] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [303.500502] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in has_pch_encoder (expected yes, found no)
<7> [303.500785] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in fdi_lanes (expected 1, found 0)
<7> [303.501011] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in fdi_m_n (expected tu 64 data 6039797/8388608 link 125829/524288, found tu 0, data 0/0 link 0/0)
<7> [303.501303] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in output_types (expected 0x00000002, found 0x00000000)
<7> [303.501559] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [303.501772] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1024, found 0)
<7> [303.502053] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 1344, found 0)
<7> [303.502282] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1024, found 0)
<7> [303.502465] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 1344, found 0)
<7> [303.502698] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 1048, found 0)
<7> [303.502963] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 1184, found 0)
<7> [303.503186] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 768, found 0)
<7> [303.503412] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 768, found 0)
<7> [303.503618] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 771, found 0)
<7> [303.503819] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 777, found 0)
<7> [303.504035] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 806, found 0)
<7> [303.504217] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 806, found 0)
<7> [303.504398] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1024, found 0)
<7> [303.504579] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 1344, found 0)
<7> [303.504760] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1024, found 0)
<7> [303.504974] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 1344, found 0)
<7> [303.505195] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 1048, found 0)
<7> [303.505376] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 1184, found 0)
<7> [303.505557] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 768, found 0)
<7> [303.505738] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 768, found 0)
<7> [303.505930] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 771, found 0)
<7> [303.506157] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 777, found 0)
<7> [303.506339] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 806, found 0)
<7> [303.506519] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 806, found 0)
<7> [303.506700] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [303.506892] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [303.507110] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [303.507293] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [303.507474] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 64800, found 0)
<7> [303.507654] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 64800, found 0)
<7> [303.507858] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in port_clock (expected 64800, found 0)
<7> [303.508074] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe A] fastset requirement not met, forcing full modeset
<7> [303.508255] i915 0000:00:02.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:47:pipe A] releasing PCH DPLL A
<7> [303.508451] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 400000 kHz, actual 400000 kHz
<7> [303.508634] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [303.508836] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:47:pipe A] enable: no [modeset]
<7> [303.509035] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:primary A] fb: [NOFB], visible: no
<7> [303.509364] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [303.519784] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port B found
<7> [303.520170] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port C found
<7> [303.520544] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port D found
<7> [303.536985] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disable PCH DPLL A (active 0x1, on? 1) for [CRTC:47:pipe A]
<7> [303.537258] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling PCH DPLL A
<7> [303.537730] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:65:CRT]
<7> [303.537989] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:66:HDMI D]
<7> [303.538321] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:74:DP D]
<7> [303.538684] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:64:VGA-1]
<7> [303.539146] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:47:pipe A]
<7> [303.539694] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:63:pipe B]
<7> [303.539864] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:63:pipe B]
<7> [303.539895] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:64:VGA-1]
<7> [303.539982] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:64:VGA-1] Limiting display bpp to 24 (EDID bpp 0, max requested bpp 0, max platform bpp 36)
<7> [303.540297] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:63:pipe B] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [303.540596] i915 0000:00:02.0: [drm:intel_fdi_atomic_check_link [i915]] checking fdi config on pipe B, lanes 1
<7> [303.540872] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [303.541153] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [303.541372] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [303.541593] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in has_pch_encoder (expected no, found yes)
<7> [303.541776] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in fdi_lanes (expected 0, found 1)
<7> [303.541960] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in fdi_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6039797/8388608 link 125829/524288)
<7> [303.542249] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000002)
<7> [303.542558] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [303.542842] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1024)
<7> [303.543069] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 1344)
<7> [303.543252] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1024)
<7> [303.543440] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 1344)
<7> [303.543691] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 1048)
<7> [303.543988] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 1184)
<7> [303.544293] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 768)
<7> [303.544547] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 768)
<7> [303.544742] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 771)
<7> [303.544942] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 777)
<7> [303.545229] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 806)
<7> [303.545534] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 806)
<7> [303.545775] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1024)
<7> [303.545954] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 1344)
<7> [303.546130] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1024)
<7> [303.546366] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 1344)
<7> [303.546684] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 1048)
<7> [303.546980] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 1184)
<7> [303.547200] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 768)
<7> [303.547409] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 768)
<7> [303.547596] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 771)
<7> [303.547796] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 777)
<7> [303.548080] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 806)
<7> [303.548367] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 806)
<7> [303.548624] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [303.548838] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [303.549032] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [303.549233] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in dpll_hw_state
<7> [303.549552] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [303.549849] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: dpll: 0xc4010001, dpll_md: 0x0, fp0: 0x30f06, fp1: 0x30f06
<7> [303.550067] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [303.550253] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: dpll: 0x84100010, dpll_md: 0x0, fp0: 0x10c09, fp1: 0x10c09
<7> [303.550430] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [303.550697] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 64800)
<7> [303.551002] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 64800)
<7> [303.551268] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:63:pipe B] fastset requirement not met in port_clock (expected 0, found 64800)
<7> [303.551468] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:63:pipe B] fastset requirement not met, forcing full modeset
<7> [303.551696] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:48:primary B] min cdclk (64800 kHz) > [CRTC:63:pipe B] min cdclk (0 kHz)
<7> [303.551887] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 400000 kHz, actual 400000 kHz
<7> [303.552173] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [303.552480] i915 0000:00:02.0: [drm:intel_find_shared_dpll [i915]] [CRTC:63:pipe B] allocated PCH DPLL A
<7> [303.552750] i915 0000:00:02.0: [drm:intel_reference_shared_dpll_crtc [i915]] [CRTC:63:pipe B] reserving PCH DPLL A
<7> [303.552961] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:63:pipe B] enable: yes [modeset]
<7> [303.553140] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: ANALOG (0x2), output format: RGB, sink format: RGB
<7> [303.553318] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 24, dithering: 0
<7> [303.553531] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [303.553727] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [303.553904] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [303.554080] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [303.554257] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] fdi: lanes: 1; data_m: 6039797, data_n: 8388608, link_m: 125829, link_n: 524288, tu: 64
<7> [303.554451] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0
<7> [303.554639] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [303.554851] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, vmin: 0, vmax: 0, pipeline full: 0, guardband: 0 flipline: 0, vmin vblank: -1, vmax vblank: -2
<7> [303.555044] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [303.555221] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [303.555398] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=64800, hd=1024 hb=1024-1344 hs=1048-1184 ht=1344, vd=768 vb=768-806 vs=771-777 vt=806, flags=0xa
<7> [303.555594] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1024x768": 60 64800 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [303.555788] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=64800, hd=1024 hb=1024-1344 hs=1048-1184 ht=1344, vd=768 vb=768-806 vs=771-777 vt=806, flags=0xa
<7> [303.555966] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 64800, pipe src: 1024x768+0+0, pixel rate 64800
<7> [303.556142] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 0, ips linetime: 0
<7> [303.556349] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [303.556563] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [303.556755] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x84100010, dpll_md: 0x0, fp0: 0x10c09, fp1: 0x10c09
<7> [303.556932] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x3 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [303.557108] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [303.557284] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [303.557499] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [303.557510] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on
<7> [303.557688] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [303.557888] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [303.558069] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:48:primary B] fb: [FB:84] 1024x768 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [303.558251] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [303.558439] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1024.000000x768.000000+0.000000+0.000000 dst: 1024x768+0+0
<7> [303.559496] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on
<7> [303.559692] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:65:CRT]
<7> [303.559867] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:66:HDMI D]
<7> [303.560039] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:74:DP D]
<7> [303.560774] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B
<7> [303.561794] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI_RX_IIR 0x100
<7> [303.561969] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI train 1 done.
<7> [303.562836] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI_RX_IIR 0x200
<7> [303.563040] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI train 2 done.
<7> [303.563227] i915 0000:00:02.0: [drm:ilk_pch_enable [i915]] FDI train done.
<7> [303.563426] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enable PCH DPLL A (active 0x2, on? 0) for [CRTC:63:pipe B]
<7> [303.563645] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enabling PCH DPLL A
<7> [303.615573] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:64:VGA-1]
<7> [303.616039] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:63:pipe B]
<6> [314.444650] [IGT] kms_flip: finished subtest B-VGA1, FAIL
Created at 2024-10-11 19:49:36