Results for igt@kms_flip@flip-vs-expired-vblank@d-hdmi-a4

Machine description: shard-dg1-16

Result: Fail

integration-manifest git-log-oneline i915_display_info2 igt_runner2 run2 runtimes2 results2.json i915_display_info_post_exec2 boot2 dmesg2

DetailValue
Duration 1.22 seconds
Hostname 
shard-dg1-16
Igt-Version 
IGT-Version: 1.29-NO-GIT (x86_64) (Linux: 6.12.0-rc5-CI_DRM_15614-gafdb5631acb3+ x86_64)
Out 
Starting dynamic subtest: D-HDMI-A4
  1920x1080: 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 
Stack trace:
  #0 ../lib/igt_core.c:2051 __igt_fail_assert()
  #1 ../tests/kms_flip.c:919 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 D-HDMI-A4: FAIL (1.216s)
Subtest flip-vs-expired-vblank: FAIL (24.283s)
Stack trace:
  #0 ../lib/igt_core.c:2051 __igt_fail_assert()
  #1 ../lib/igt_kms.c:2234 kmstest_set_connector_dpms()
  #2 ../lib/igt_core.c:2930 igt_atexit_handler()
  #3 [erand48_r+0x1d6]
  #4 [exit+0x1e]
  #5 ../lib/igt_core.c:2386 igt_exit()
  #6 [main+0x3f]
  #7 [__libc_init_first+0x8a]
  #8 [__libc_start_main+0x8b]
  #9 [_start+0x25]
Err 
Starting dynamic subtest: D-HDMI-A4
(kms_flip:1177) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:924:
(kms_flip:1177) CRITICAL: Failed assertion: end - start < 500
Dynamic subtest D-HDMI-A4 failed.
**** DEBUG ****
(kms_flip:1177) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:1177) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=7680)
(kms_flip:1177) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:1177) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:1177) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=7680)
(kms_flip:1177) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:1177) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1177) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1177) igt_fb-DEBUG: Test requirement passed: gem_has_contexts(fb->fd)
(kms_flip:1177) intel_allocator_reloc-DEBUG: Using reloc allocator
(kms_flip:1177) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1177) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1177) igt_fb-DEBUG: Test requirement passed: gem_has_contexts(fb->fd)
(kms_flip:1177) intel_allocator_reloc-DEBUG: Using reloc allocator
(kms_flip:1177) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1177) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1177) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1177) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1177) igt_fb-DEBUG: Test requirement passed: gem_has_contexts(fb->fd)
(kms_flip:1177) intel_allocator_reloc-DEBUG: Using reloc allocator
(kms_flip:1177) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1177) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1177) igt_fb-DEBUG: Test requirement passed: gem_has_contexts(fb->fd)
(kms_flip:1177) intel_allocator_reloc-DEBUG: Using reloc allocator
(kms_flip:1177) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1177) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:1177) igt_kms-INFO:   1920x1080: 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5 
(kms_flip:1177) DEBUG: No stale events found
(kms_flip:1177) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0
(kms_flip:1177) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0
(kms_flip:1177) DEBUG: name = flip
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 96.103966
current_received_ts = 96.103516
current_seq = 4
count = 0
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 23us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.103966
last_received_ts = 96.103516
last_seq = 4
current_ts = 96.120636
current_received_ts = 96.120193
current_seq = 5
count = 1
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 23us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.120636
last_received_ts = 96.120193
last_seq = 5
current_ts = 96.137299
current_received_ts = 96.136826
current_seq = 6
count = 2
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 26us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.137299
last_received_ts = 96.136826
last_seq = 6
current_ts = 96.153961
current_received_ts = 96.153496
current_seq = 7
count = 3
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 30us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.153961
last_received_ts = 96.153496
last_seq = 7
current_ts = 96.170624
current_received_ts = 96.170174
current_seq = 8
count = 4
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 41us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.170624
last_received_ts = 96.170174
last_seq = 8
current_ts = 96.187302
current_received_ts = 96.186920
current_seq = 9
count = 5
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 120us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.187302
last_received_ts = 96.186920
last_seq = 9
current_ts = 96.203964
current_received_ts = 96.203583
current_seq = 10
count = 6
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.203964
last_received_ts = 96.203583
last_seq = 10
current_ts = 96.220642
current_received_ts = 96.220245
current_seq = 11
count = 7
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 59us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.220642
last_received_ts = 96.220245
last_seq = 11
current_ts = 96.237312
current_received_ts = 96.236916
current_seq = 12
count = 8
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 108us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.237312
last_received_ts = 96.236916
last_seq = 12
current_ts = 96.253967
current_received_ts = 96.253586
current_seq = 13
count = 9
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.253967
last_received_ts = 96.253586
last_seq = 13
current_ts = 96.270645
current_received_ts = 96.270210
current_seq = 14
count = 10
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.270645
last_received_ts = 96.270210
last_seq = 14
current_ts = 96.287308
current_received_ts = 96.286926
current_seq = 15
count = 11
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 128us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.287308
last_received_ts = 96.286926
last_seq = 15
current_ts = 96.303970
current_received_ts = 96.303581
current_seq = 16
count = 12
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.303970
last_received_ts = 96.303581
last_seq = 16
current_ts = 96.320648
current_received_ts = 96.320244
current_seq = 17
count = 13
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 59us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.320648
last_received_ts = 96.320244
last_seq = 17
current_ts = 96.337318
current_received_ts = 96.336922
current_seq = 18
count = 14
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 108us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.337318
last_received_ts = 96.336922
last_seq = 18
current_ts = 96.353973
current_received_ts = 96.353592
current_seq = 19
count = 15
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.353973
last_received_ts = 96.353592
last_seq = 19
current_ts = 96.370644
current_received_ts = 96.370277
current_seq = 20
count = 16
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.370644
last_received_ts = 96.370277
last_seq = 20
current_ts = 96.387314
current_received_ts = 96.386932
current_seq = 21
count = 17
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 119us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.387314
last_received_ts = 96.386932
last_seq = 21
current_ts = 96.403984
current_received_ts = 96.403595
current_seq = 22
count = 18
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.403984
last_received_ts = 96.403595
last_seq = 22
current_ts = 96.420647
current_received_ts = 96.420280
current_seq = 23
count = 19
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.420647
last_received_ts = 96.420280
last_seq = 23
current_ts = 96.437317
current_received_ts = 96.436928
current_seq = 24
count = 20
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 103us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.437317
last_received_ts = 96.436928
last_seq = 24
current_ts = 96.453979
current_received_ts = 96.453590
current_seq = 25
count = 21
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.453979
last_received_ts = 96.453590
last_seq = 25
current_ts = 96.470650
current_received_ts = 96.470261
current_seq = 26
count = 22
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.470650
last_received_ts = 96.470261
last_seq = 26
current_ts = 96.487328
current_received_ts = 96.486916
current_seq = 27
count = 23
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 107us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.487328
last_received_ts = 96.486916
last_seq = 27
current_ts = 96.503990
current_received_ts = 96.503593
current_seq = 28
count = 24
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.503990
last_received_ts = 96.503593
last_seq = 28
current_ts = 96.520653
current_received_ts = 96.520287
current_seq = 29
count = 25
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 59us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.520653
last_received_ts = 96.520287
last_seq = 29
current_ts = 96.537331
current_received_ts = 96.536926
current_seq = 30
count = 26
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 107us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.537331
last_received_ts = 96.536926
last_seq = 30
current_ts = 96.553986
current_received_ts = 96.553596
current_seq = 31
count = 27
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.553986
last_received_ts = 96.553596
last_seq = 31
current_ts = 96.570656
current_received_ts = 96.570267
current_seq = 32
count = 28
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 59us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.570656
last_received_ts = 96.570267
last_seq = 32
current_ts = 96.587334
current_received_ts = 96.586922
current_seq = 33
count = 29
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 108us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.587334
last_received_ts = 96.586922
last_seq = 33
current_ts = 96.603989
current_received_ts = 96.603607
current_seq = 34
count = 30
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 59us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.603989
last_received_ts = 96.603607
last_seq = 34
current_ts = 96.620651
current_received_ts = 96.620293
current_seq = 35
count = 31
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.620651
last_received_ts = 96.620293
last_seq = 35
current_ts = 96.637337
current_received_ts = 96.636925
current_seq = 36
count = 32
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 108us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.637337
last_received_ts = 96.636925
last_seq = 36
current_ts = 96.653999
current_received_ts = 96.653603
current_seq = 37
count = 33
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 59us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.653999
last_received_ts = 96.653603
last_seq = 37
current_ts = 96.670662
current_received_ts = 96.670280
current_seq = 38
count = 34
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.670662
last_received_ts = 96.670280
last_seq = 38
current_ts = 96.687340
current_received_ts = 96.686928
current_seq = 39
count = 35
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 106us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.687340
last_received_ts = 96.686928
last_seq = 39
current_ts = 96.703995
current_received_ts = 96.703606
current_seq = 40
count = 36
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 59us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.703995
last_received_ts = 96.703606
last_seq = 40
current_ts = 96.720665
current_received_ts = 96.720268
current_seq = 41
count = 37
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.720665
last_received_ts = 96.720268
last_seq = 41
current_ts = 96.737335
current_received_ts = 96.736931
current_seq = 42
count = 38
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 109us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.737335
last_received_ts = 96.736931
last_seq = 42
current_ts = 96.753998
current_received_ts = 96.753609
current_seq = 43
count = 39
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.753998
last_received_ts = 96.753609
last_seq = 43
current_ts = 96.770668
current_received_ts = 96.770279
current_seq = 44
count = 40
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 61us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.770668
last_received_ts = 96.770279
last_seq = 44
current_ts = 96.787338
current_received_ts = 96.786934
current_seq = 45
count = 41
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 106us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.787338
last_received_ts = 96.786934
last_seq = 45
current_ts = 96.804001
current_received_ts = 96.803612
current_seq = 46
count = 42
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.804001
last_received_ts = 96.803612
last_seq = 46
current_ts = 96.820671
current_received_ts = 96.820282
current_seq = 47
count = 43
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.820671
last_received_ts = 96.820282
last_seq = 47
current_ts = 96.837341
current_received_ts = 96.836937
current_seq = 48
count = 44
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 106us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.837341
last_received_ts = 96.836937
last_seq = 48
current_ts = 96.854004
current_received_ts = 96.853615
current_seq = 49
count = 45
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 59us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.854004
last_received_ts = 96.853615
last_seq = 49
current_ts = 96.870674
current_received_ts = 96.870277
current_seq = 50
count = 46
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 59us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.870674
last_received_ts = 96.870277
last_seq = 50
current_ts = 96.887344
current_received_ts = 96.886940
current_seq = 51
count = 47
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 108us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.887344
last_received_ts = 96.886940
last_seq = 51
current_ts = 96.904007
current_received_ts = 96.903610
current_seq = 52
count = 48
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.904007
last_received_ts = 96.903610
last_seq = 52
current_ts = 96.920677
current_received_ts = 96.920288
current_seq = 53
count = 49
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 59us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.920677
last_received_ts = 96.920288
last_seq = 53
current_ts = 96.937340
current_received_ts = 96.936951
current_seq = 54
count = 50
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 108us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.937340
last_received_ts = 96.936951
last_seq = 54
current_ts = 96.954010
current_received_ts = 96.953613
current_seq = 55
count = 51
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.954010
last_received_ts = 96.953613
last_seq = 55
current_ts = 96.970680
current_received_ts = 96.970291
current_seq = 56
count = 52
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 59us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.970680
last_received_ts = 96.970291
last_seq = 56
current_ts = 96.987343
current_received_ts = 96.986954
current_seq = 57
count = 53
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 108us
(kms_flip:1177) DEBUG: name = flip
last_ts = 96.987343
last_received_ts = 96.986954
last_seq = 57
current_ts = 97.004013
current_received_ts = 97.003616
current_seq = 58
count = 54
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 97.004013
last_received_ts = 97.003616
last_seq = 58
current_ts = 97.020683
current_received_ts = 97.020287
current_seq = 59
count = 55
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 59us
(kms_flip:1177) DEBUG: name = flip
last_ts = 97.020683
last_received_ts = 97.020287
last_seq = 59
current_ts = 97.037354
current_received_ts = 97.036949
current_seq = 60
count = 56
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 107us
(kms_flip:1177) DEBUG: name = flip
last_ts = 97.037354
last_received_ts = 97.036949
last_seq = 60
current_ts = 97.054016
current_received_ts = 97.053627
current_seq = 61
count = 57
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 59us
(kms_flip:1177) DEBUG: name = flip
last_ts = 97.054016
last_received_ts = 97.053627
last_seq = 61
current_ts = 97.070686
current_received_ts = 97.070290
current_seq = 62
count = 58
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 97.070686
last_received_ts = 97.070290
last_seq = 62
current_ts = 97.087357
current_received_ts = 97.086952
current_seq = 63
count = 59
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 108us
(kms_flip:1177) DEBUG: name = flip
last_ts = 97.087357
last_received_ts = 97.086952
last_seq = 63
current_ts = 97.104019
current_received_ts = 97.103622
current_seq = 64
count = 60
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 59us
(kms_flip:1177) DEBUG: name = flip
last_ts = 97.104019
last_received_ts = 97.103622
last_seq = 64
current_ts = 97.120682
current_received_ts = 97.120293
current_seq = 65
count = 61
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 60us
(kms_flip:1177) DEBUG: name = flip
last_ts = 97.120682
last_received_ts = 97.120293
last_seq = 65
current_ts = 97.137360
current_received_ts = 97.136955
current_seq = 66
count = 62
seq_step = 1
(kms_flip:1177) DEBUG: Vblank took 778us
(kms_flip:1177) CRITICAL: Test assertion failure function run_test_step, file ../tests/kms_flip.c:924:
(kms_flip:1177) CRITICAL: Failed assertion: end - start < 500
(kms_flip:1177) igt_core-INFO: Stack trace:
(kms_flip:1177) igt_core-INFO:   #0 ../lib/igt_core.c:2051 __igt_fail_assert()
(kms_flip:1177) igt_core-INFO:   #1 ../tests/kms_flip.c:919 run_test_on_crtc_set.constprop.0()
(kms_flip:1177) igt_core-INFO:   #2 ../tests/kms_flip.c:1845 run_test()
(kms_flip:1177) igt_core-INFO:   #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001()
(kms_flip:1177) igt_core-INFO:   #4 ../tests/kms_flip.c:2001 main()
(kms_flip:1177) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:1177) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:1177) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest D-HDMI-A4: FAIL (1.216s)
Subtest flip-vs-expired-vblank: FAIL (24.283s)
(kms_flip:1177) igt_kms-CRITICAL: Test assertion failure function kmstest_set_connector_dpms, file ../lib/igt_kms.c:2234:
(kms_flip:1177) igt_kms-CRITICAL: Failed assertion: found_it
(kms_flip:1177) igt_kms-CRITICAL: Last errno: 9, Bad file descriptor
(kms_flip:1177) igt_kms-CRITICAL: DPMS property not found on 356
Dmesg
<6> [95.747667] [IGT] kms_flip: starting dynamic subtest D-HDMI-A4
<7> [95.751910] i915 0000:03:00.0: [drm:drm_mode_addfb2] [FB:362]
<7> [95.751990] i915 0000:03:00.0: [drm:drm_mode_addfb2] [FB:363]
<7> [95.752237] [drm:i915_gem_do_execbuffer [i915]] EINVAL at eb_validate_vma:509
<7> [95.752659] [drm:i915_gem_do_execbuffer [i915]] EINVAL at eb_validate_vma:509
<7> [95.769643] [drm:i915_gem_do_execbuffer [i915]] EINVAL at eb_validate_vma:509
<7> [95.770659] [drm:i915_gem_do_execbuffer [i915]] EINVAL at eb_validate_vma:509
<7> [95.775521] [drm:i915_gem_do_execbuffer [i915]] EINVAL at eb_validate_vma:509
<7> [95.775818] [drm:i915_gem_do_execbuffer [i915]] EINVAL at eb_validate_vma:509
<7> [95.792433] [drm:i915_gem_do_execbuffer [i915]] EINVAL at eb_validate_vma:509
<7> [95.792729] [drm:i915_gem_do_execbuffer [i915]] EINVAL at eb_validate_vma:509
<7> [95.817207] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:100:pipe A]
<7> [95.817433] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:170:pipe B]
<7> [95.817626] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:240:pipe C]
<7> [95.817713] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.enable (expected yes, found no)
<7> [95.817898] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.active (expected yes, found no)
<7> [95.818056] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in cpu_transcoder (expected 2, found -1)
<7> [95.818212] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in lane_count (expected 4, found 0)
<7> [95.818368] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [95.818524] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [95.818679] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [95.818844] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [95.818999] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [95.819155] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [95.819310] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [95.819465] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [95.819620] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [95.819774] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [95.819936] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [95.820092] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [95.820247] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [95.820402] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [95.820557] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [95.820712] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [95.820874] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [95.821029] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [95.821184] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [95.821339] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [95.821494] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [95.821649] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [95.821804] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [95.821966] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [95.822122] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [95.822278] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [95.822433] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [95.822588] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [95.822743] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [95.822906] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [95.823063] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [95.823218] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [95.823373] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:240:pipe C] fastset requirement not met in port_clock (expected 148500, found 0)
<7> [95.823529] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:240:pipe C] fastset requirement not met, forcing full modeset
<7> [95.823684] i915 0000:03:00.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:240:pipe C] releasing DPLL 2
<7> [95.823862] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no
<7> [95.824009] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [CRTC:240:pipe C] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x4 -> 0x0
<7> [95.824199] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:235:cursor C] ddb (2012 - 2048) -> ( 0 - 0), size 36 -> 0
<7> [95.824363] i915 0000:03:00.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 172800 kHz, actual 172800 kHz
<7> [95.824520] i915 0000:03:00.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [95.824677] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [CRTC:240:pipe C] enable: no [modeset]
<7> [95.824841] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:172:plane 1C] fb: [NOFB], visible: no
<7> [95.824997] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:181:plane 2C] fb: [NOFB], visible: no
<7> [95.825152] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:190:plane 3C] fb: [NOFB], visible: no
<7> [95.825306] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:199:plane 4C] fb: [NOFB], visible: no
<7> [95.825461] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:208:plane 5C] fb: [NOFB], visible: no
<7> [95.825615] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:217:plane 6C] fb: [NOFB], visible: no
<7> [95.825771] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:226:plane 7C] fb: [NOFB], visible: no
<7> [95.825932] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:235:cursor C] fb: [NOFB], visible: no
<7> [95.826315] i915 0000:03:00.0: [drm:intel_disable_transcoder [i915]] disabling pipe C
<7> [95.830910] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_TC2
<7> [95.831100] i915 0000:03:00.0: [drm:intel_disable_shared_dpll [i915]] disable DPLL 2 (active 0x4, on? 1) for [CRTC:240:pipe C]
<7> [95.831288] i915 0000:03:00.0: [drm:intel_disable_shared_dpll [i915]] disabling DPLL 2
<7> [95.831459] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:312:DDI A/PHY A]
<7> [95.831607] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:314:DP-MST A]
<7> [95.831755] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:315:DP-MST B]
<7> [95.831911] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:316:DP-MST C]
<7> [95.832059] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:317:DP-MST D]
<7> [95.832205] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:331:DDI B/PHY B]
<7> [95.832352] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:335:DDI TC1/PHY C]
<7> [95.832499] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:337:DP-MST A]
<7> [95.832646] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:338:DP-MST B]
<7> [95.832792] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:339:DP-MST C]
<7> [95.832946] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:340:DP-MST D]
<7> [95.833093] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:347:DDI TC2/PHY D]
<7> [95.833262] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:349:DP-MST A]
<7> [95.833410] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:350:DP-MST B]
<7> [95.833556] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:351:DP-MST C]
<7> [95.833703] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:352:DP-MST D]
<7> [95.833857] i915 0000:03:00.0: [drm:verify_connector_state [i915]] [CONNECTOR:356:HDMI-A-4]
<7> [95.834125] i915 0000:03:00.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [95.834339] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling PW_4
<7> [95.834530] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling PW_3
<7> [95.834711] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling PW_2
<7> [95.834899] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:240:pipe C]
<7> [95.835308] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:310:pipe D]
<7> [95.835512] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CRTC:310:pipe D]
<7> [95.835558] i915 0000:03:00.0: [drm:drm_mode_setcrtc] [CONNECTOR:356:HDMI-A-4]
<7> [95.835621] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CONNECTOR:356:HDMI-A-4] Limiting display bpp to 24 (EDID bpp 0, max requested bpp 36, max platform bpp 36)
<7> [95.835782] i915 0000:03:00.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [95.835930] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:310:pipe D] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [95.836087] i915 0000:03:00.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:347:DDI TC2/PHY D] [CRTC:310:pipe D]
<7> [95.836230] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.enable (expected no, found yes)
<7> [95.836386] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.active (expected no, found yes)
<7> [95.836542] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in cpu_transcoder (expected -1, found 3)
<7> [95.836697] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in lane_count (expected 0, found 4)
<7> [95.836863] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [95.837020] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [95.837175] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [95.837330] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [95.837486] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [95.837641] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [95.837796] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [95.837958] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [95.838114] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [95.838269] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [95.838424] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [95.838579] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [95.838734] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [95.838901] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [95.839056] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [95.839211] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [95.839366] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [95.839521] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [95.839676] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [95.839839] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [95.839994] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [95.840149] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [95.840304] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [95.840459] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [95.840615] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [95.840769] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [95.840932] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [95.841087] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [95.841243] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [95.841398] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in dpll_hw_state
<7> [95.841553] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [95.841708] i915 0000:03:00.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> [95.841870] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [95.842025] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: cfgcr0: 0x2001d0, 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> [95.842181] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [95.842337] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [95.842491] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [95.842647] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in port_clock (expected 0, found 148500)
<7> [95.842802] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:310:pipe D] fastset requirement not met, forcing full modeset
<7> [95.842988] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0x3 (total dbuf slices 0x3), mbus joined? no->no
<7> [95.843136] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [CRTC:310:pipe D] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x0 -> 0x8
<7> [95.843327] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:242:plane 1D] ddb ( 0 - 0) -> ( 0 - 2012), size 0 -> 2012
<7> [95.843472] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:305:cursor D] ddb ( 0 - 0) -> (2012 - 2048), size 0 -> 36
<7> [95.843616] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:242:plane 1D] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm
<7> [95.843760] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:242:plane 1D] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 5, 5, 5, 8, 8, 9, 10, 0, 0, 0
<7> [95.843914] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:242:plane 1D] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 81, 81, 81, 129, 129, 145, 161, 30, 0, 0
<7> [95.844059] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:242:plane 1D] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 91, 91, 91, 143, 143, 161, 179, 31, 0, 0
<7> [95.844205] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:310:pipe D] data rate 594000 num active planes 1
<7> [95.844362] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 34000 required 594
<7> [95.844518] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [95.844688] i915 0000:03:00.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:242:plane 1D] min cdclk (74250 kHz) > [CRTC:310:pipe D] min cdclk (0 kHz)
<7> [95.844856] i915 0000:03:00.0: [drm:intel_bw_calc_min_cdclk [i915]] new bandwidth min cdclk (11602 kHz) > old min cdclk (0 kHz)
<7> [95.845015] i915 0000:03:00.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 172800 kHz, actual 172800 kHz
<7> [95.845170] i915 0000:03:00.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [95.845326] i915 0000:03:00.0: [drm:intel_find_shared_dpll [i915]] [CRTC:310:pipe D] allocated DPLL 2
<7> [95.845479] i915 0000:03:00.0: [drm:intel_reference_shared_dpll_crtc [i915]] [CRTC:310:pipe D] reserving DPLL 2
<7> [95.845633] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [CRTC:310:pipe D] enable: yes [modeset]
<7> [95.845788] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [95.845953] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: D, pipe bpp: 24, dithering: 0
<7> [95.846109] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [95.846264] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [95.846419] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [95.846573] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [95.846728] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0
<7> [95.846890] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [95.847047] i915 0000:03:00.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> [95.847203] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [95.847359] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [95.847516] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [95.847672] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [95.847837] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [95.847993] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] port clock: 148500, pipe src: 1920x1080+0+0, pixel rate 148500
<7> [95.848149] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] linetime: 119, ips linetime: 0
<7> [95.848305] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [95.848460] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [95.848616] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [95.848771] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x2001d0, 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> [95.848936] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [95.849091] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [95.849246] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [95.849401] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [95.849556] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [95.849722] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [95.849869] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [95.850009] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [95.850149] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [95.850289] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [95.850428] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [95.850568] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [95.850707] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:242:plane 1D] fb: [FB:362] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [95.850856] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [95.850997] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [95.851138] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:251:plane 2D] fb: [NOFB], visible: no
<7> [95.851278] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:260:plane 3D] fb: [NOFB], visible: no
<7> [95.851418] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:269:plane 4D] fb: [NOFB], visible: no
<7> [95.851558] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:278:plane 5D] fb: [NOFB], visible: no
<7> [95.851697] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:287:plane 6D] fb: [NOFB], visible: no
<7> [95.851844] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:296:plane 7D] fb: [NOFB], visible: no
<7> [95.851984] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:305:cursor D] fb: [NOFB], visible: no
<7> [95.852392] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_2
<7> [95.852543] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [95.852706] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_4
<7> [95.852876] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_5
<7> [95.853051] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:312:DDI A/PHY A]
<7> [95.853185] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:314:DP-MST A]
<7> [95.853318] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:315:DP-MST B]
<7> [95.853450] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:316:DP-MST C]
<7> [95.853582] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:317:DP-MST D]
<7> [95.853715] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:331:DDI B/PHY B]
<7> [95.853856] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:335:DDI TC1/PHY C]
<7> [95.853989] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:337:DP-MST A]
<7> [95.854122] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:338:DP-MST B]
<7> [95.854254] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:339:DP-MST C]
<7> [95.854387] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:340:DP-MST D]
<7> [95.854519] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:347:DDI TC2/PHY D]
<7> [95.854664] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:349:DP-MST A]
<7> [95.854787] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:350:DP-MST B]
<7> [95.854917] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:351:DP-MST C]
<7> [95.855079] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:352:DP-MST D]
<7> [95.855269] i915 0000:03:00.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x3
<7> [95.855446] i915 0000:03:00.0: [drm:intel_enable_shared_dpll [i915]] enable DPLL 2 (active 0x8, on? 0) for [CRTC:310:pipe D]
<7> [95.855575] i915 0000:03:00.0: [drm:intel_enable_shared_dpll [i915]] enabling DPLL 2
<7> [95.855756] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_TC2
<7> [95.856006] i915 0000:03:00.0: [drm:intel_enable_transcoder [i915]] enabling pipe D
<7> [95.874117] i915 0000:03:00.0: [drm:verify_connector_state [i915]] [CONNECTOR:356:HDMI-A-4]
<7> [95.874354] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:310:pipe D]
<6> [96.963555] [IGT] kms_flip: finished subtest D-HDMI-A4, FAIL
<6> [96.963761] [IGT] kms_flip: finished subtest flip-vs-expired-vblank, FAIL
<7> [96.971010] i915 0000:03:00.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:362] from all active usage due to RMFB ioctl
<7> [96.971220] i915 0000:03:00.0: [drm:atomic_remove_fb] Disabling [PLANE:242:plane 1D] because [FB:362] is removed
<7> [96.971334] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:242:plane 1D] ddb ( 0 - 2012) -> ( 0 - 0), size 2012 -> 0
<7> [96.971487] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:242:plane 1D] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm, swm, stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [96.971617] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:242:plane 1D] lines 1, 5, 5, 5, 8, 8, 9, 10, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [96.971761] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:242:plane 1D] blocks 16, 81, 81, 81, 129, 129, 145, 161, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [96.971890] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:242:plane 1D] min_ddb 19, 91, 91, 91, 143, 143, 161, 179, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [96.972018] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:310:pipe D] data rate 0 num active planes 0
<7> [96.972157] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 34000 required 0
<6> [96.974732] [IGT] kms_flip: exiting, ret=98
<7> [96.988597] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CONNECTOR:356:HDMI-A-4] Limiting display bpp to 24 (EDID bpp 0, max requested bpp 36, max platform bpp 36)
<7> [96.988798] i915 0000:03:00.0: [drm:intel_hdmi_compute_clock [i915]] picking 8 bpc for HDMI output (pipe bpp: 24)
<7> [96.988914] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:100:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [96.989055] i915 0000:03:00.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:347:DDI TC2/PHY D] [CRTC:100:pipe A]
<7> [96.989174] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [96.989303] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [96.989432] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [96.989560] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [96.989727] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000040)
<7> [96.989881] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [96.990050] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1920)
<7> [96.990178] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 2200)
<7> [96.990306] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1920)
<7> [96.990434] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 2200)
<7> [96.990562] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2008)
<7> [96.990918] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2052)
<7> [96.991060] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1080)
<7> [96.991188] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1080)
<7> [96.991316] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1084)
<7> [96.991443] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1089)
<7> [96.991571] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1125)
<7> [96.991787] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1125)
<7> [96.991974] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1920)
<7> [96.992117] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 2200)
<7> [96.992245] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1920)
<7> [96.992373] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 2200)
<7> [96.992517] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2008)
<7> [96.992697] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2052)
<7> [96.992843] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1080)
<7> [96.992985] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1080)
<7> [96.993113] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1084)
<7> [96.993241] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1089)
<7> [96.993397] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1125)
<7> [96.993553] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1125)
<7> [96.993718] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [96.993886] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [96.994015] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 0, found 4)
<7> [96.994172] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [96.994327] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 148500)
<7> [96.994455] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 148500)
<7> [96.994582] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:100:pipe A] fastset requirement not met in port_clock (expected 0, found 148500)
<7> [96.994751] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:100:pipe A] fastset requirement not met, forcing full modeset
<7> [96.994974] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.enable (expected yes, found no)
<7> [96.995129] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.active (expected yes, found no)
<7> [96.995257] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in cpu_transcoder (expected 3, found -1)
<7> [96.995385] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in lane_count (expected 4, found 0)
<7> [96.995513] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [96.995667] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [96.995838] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [96.995993] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [96.996121] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [96.996248] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [96.996376] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [96.996504] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [96.996721] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [96.996892] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [96.997036] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [96.997163] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [96.997291] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [96.997418] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [96.997563] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [96.997773] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [96.997969] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [96.998098] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [96.998227] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [96.998369] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [96.998526] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [96.998737] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [96.998949] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [96.999077] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [96.999205] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [96.999361] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [96.999518] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [96.999703] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [96.999874] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [97.000002] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [97.000158] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)
<7> [97.000315] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)
<7> [97.000443] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:310:pipe D] fastset requirement not met in port_clock (expected 148500, found 0)
<7> [97.000571] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:310:pipe D] fastset requirement not met, forcing full modeset
<7> [97.000736] i915 0000:03:00.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:310:pipe D] releasing DPLL 2
<7> [97.000978] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [CRTC:100:pipe A] dbuf slices 0x0 -> 0x3, ddb (0 - 0) -> (0 - 2048), active pipes 0x8 -> 0x1
<7> [97.001128] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [CRTC:310:pipe D] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x8 -> 0x1
<7> [97.001265] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] ddb ( 0 - 0) -> ( 0 - 2012), size 0 -> 2012
<7> [97.001384] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:95:cursor A] ddb ( 0 - 0) -> (2012 - 2048), size 0 -> 36
<7> [97.001503] i915 0000:03:00.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> [97.001622] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 5, 5, 5, 8, 8, 9, 10, 0, 0, 0
<7> [97.001828] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 16, 81, 81, 81, 129, 129, 145, 161, 30, 0, 0
<7> [97.001964] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:32:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 19, 91, 91, 91, 143, 143, 161, 179, 31, 0, 0
<7> [97.002100] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:305:cursor D] ddb (2012 - 2048) -> ( 0 - 0), size 36 -> 0
<7> [97.002220] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:100:pipe A] data rate 594000 num active planes 1
<7> [97.002350] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 34000 required 594
<7> [97.002478] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1
<7> [97.002620] i915 0000:03:00.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:32:plane 1A] min cdclk (74250 kHz) > [CRTC:100:pipe A] min cdclk (0 kHz)
<7> [97.002836] i915 0000:03:00.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 172800 kHz, actual 172800 kHz
<7> [97.003021] i915 0000:03:00.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [97.003150] i915 0000:03:00.0: [drm:intel_find_shared_dpll [i915]] [CRTC:100:pipe A] allocated DPLL 2
<7> [97.003276] i915 0000:03:00.0: [drm:intel_reference_shared_dpll_crtc [i915]] [CRTC:100:pipe A] reserving DPLL 2
<7> [97.003405] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [CRTC:100:pipe A] enable: yes [modeset]
<7> [97.003533] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: HDMI (0x40), output format: RGB, sink format: RGB
<7> [97.003739] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [97.003912] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [97.004041] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [97.004169] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [97.004296] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [97.004424] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0
<7> [97.004567] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [97.004795] i915 0000:03:00.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> [97.004941] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [97.005074] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [97.005206] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [97.005338] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [97.005470] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=148500, hd=1920 hb=1920-2200 hs=2008-2052 ht=2200, vd=1080 vb=1080-1125 vs=1084-1089 vt=1125, flags=0x5
<7> [97.005602] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] port clock: 148500, pipe src: 1920x1080+0+0, pixel rate 148500
<7> [97.006318] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] linetime: 119, ips linetime: 0
<7> [97.006458] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [97.006591] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [97.006737] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [97.006869] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: cfgcr0: 0x2001d0, 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> [97.007002] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [97.007134] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [97.007265] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [97.007396] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [97.007527] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [97.007665] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [97.007835] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [97.007967] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [97.008097] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [97.008228] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [97.008359] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [97.008489] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [97.008620] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:plane 1A] fb: [FB:361] 1920x1080 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [97.008761] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [97.008963] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] src: 1920.000000x1080.000000+0.000000+0.000000 dst: 1920x1080+0+0
<7> [97.009095] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:41:plane 2A] fb: [NOFB], visible: no
<7> [97.009226] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:50:plane 3A] fb: [NOFB], visible: no
<7> [97.009357] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:59:plane 4A] fb: [NOFB], visible: no
<7> [97.009488] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:68:plane 5A] fb: [NOFB], visible: no
<7> [97.009618] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:77:plane 6A] fb: [NOFB], visible: no
<7> [97.009756] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:86:plane 7A] fb: [NOFB], visible: no
<7> [97.009925] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:95:cursor A] fb: [NOFB], visible: no
<7> [97.010056] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [CRTC:310:pipe D] enable: no [modeset]
<7> [97.010187] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:242:plane 1D] fb: [NOFB], visible: no
<7> [97.010318] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:251:plane 2D] fb: [NOFB], visible: no
<7> [97.010449] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:260:plane 3D] fb: [NOFB], visible: no
<7> [97.010579] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:269:plane 4D] fb: [NOFB], visible: no
<7> [97.010716] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:278:plane 5D] fb: [NOFB], visible: no
<7> [97.010847] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:287:plane 6D] fb: [NOFB], visible: no
<7> [97.010977] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:296:plane 7D] fb: [NOFB], visible: no
<7> [97.011107] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:305:cursor D] fb: [NOFB], visible: no
<7> [97.012045] i915 0000:03:00.0: [drm:intel_disable_transcoder [i915]] disabling pipe D
<7> [97.024700] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_TC2
<7> [97.024877] i915 0000:03:00.0: [drm:intel_disable_shared_dpll [i915]] disable DPLL 2 (active 0x8, on? 1) for [CRTC:310:pipe D]
<7> [97.025073] i915 0000:03:00.0: [drm:intel_disable_shared_dpll [i915]] disabling DPLL 2
<7> [97.025221] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:312:DDI A/PHY A]
<7> [97.025347] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:314:DP-MST A]
<7> [97.025472] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:315:DP-MST B]
<7> [97.025596] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:316:DP-MST C]
<7> [97.025730] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:317:DP-MST D]
<7> [97.025854] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:331:DDI B/PHY B]
<7> [97.025978] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:335:DDI TC1/PHY C]
<7> [97.026102] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:337:DP-MST A]
<7> [97.026226] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:338:DP-MST B]
<7> [97.026349] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:339:DP-MST C]
<7> [97.026473] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:340:DP-MST D]
<7> [97.026597] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:347:DDI TC2/PHY D]
<7> [97.026727] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:349:DP-MST A]
<7> [97.026851] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:350:DP-MST B]
<7> [97.026975] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:351:DP-MST C]
<7> [97.027098] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:352:DP-MST D]
<7> [97.027336] i915 0000:03:00.0: [drm:intel_enable_shared_dpll [i915]] enable DPLL 2 (active 0x1, on? 0) for [CRTC:100:pipe A]
<7> [97.027468] i915 0000:03:00.0: [drm:intel_enable_shared_dpll [i915]] enabling DPLL 2
<7> [97.027656] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling DDI_IO_TC2
<7> [97.027864] i915 0000:03:00.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [97.028415] i915 0000:03:00.0: [drm:intel_fbc_update [i915]] reserved 17694720 bytes of contiguous stolen space for FBC, limit: 1
<7> [97.028545] i915 0000:03:00.0: [drm:intel_fbc_update [i915]] Enabling FBC on [PLANE:32:plane 1A]
<7> [97.045398] i915 0000:03:00.0: [drm:verify_connector_state [i915]] [CONNECTOR:356:HDMI-A-4]
<7> [97.045667] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:100:pipe A]
<7> [97.046548] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling PW_5
<7> [97.046803] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:310:pipe D]
<7> [97.047238] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling PW_4
<7> [97.047854] i915 0000:03:00.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0
Created at 2024-10-31 04:24:23