Result:
integration-manifest git-log-oneline i915_display_info6 igt_runner6 runtimes6 results6.json results6-i915-load.json i915_display_info_post_exec6 boot6 dmesg6
| Detail | Value |
|---|---|
| Duration | 6.51 seconds |
| Hostname |
shard-mtlp-5 |
| Igt-Version |
IGT-Version: 2.2-gb3c7fe859 (x86_64) (Linux: 6.18.0-CI_DRM_17639-ged8ce4499604+ x86_64) |
| Out |
Using IGT_SRANDOM=1765007374 for randomisation
Opened device: /dev/dri/card0
Starting subtest: basic
Testing: basic 1 connector combinations
Starting dynamic subtest: pipe-A-eDP-1
Test id#1 CRTC count 1
CRTC[149] [Pipe A] Mode: 2880x1800@90Hz Connectors: eDP-1[506]
Expected frametime: 11111us; measured 11117.8us +- 2.338us accuracy 0.01% [0.11 scanlines]
vblank interval differs from modeline! expected 11111.1us, measured 11118us +- 2.338us, difference 6.7us (2.8 sigma, 1.1 scanlines)
Timing check failed on attempt 1, retrying...
Expected frametime: 11111us; measured 11117.4us +- 2.547us accuracy 0.01% [0.12 scanlines]
vblank interval differs from modeline! expected 11111.1us, measured 11117us +- 2.547us, difference 6.2us (2.5 sigma, 1.1 scanlines)
Timing check failed on attempt 2, retrying...
Stack trace:
#0 ../lib/igt_core.c:2075 __igt_fail_assert()
#1 ../tests/kms_setmode.c:535 test_one_combination()
#2 ../tests/kms_setmode.c:978 __igt_unique____real_main1033()
#3 ../tests/kms_setmode.c:1033 main()
#4 [__libc_init_first+0x8a]
#5 [__libc_start_main+0x8b]
#6 [_start+0x25]
Dynamic subtest pipe-A-eDP-1: FAIL (3.417s)
Starting dynamic subtest: pipe-B-eDP-1
Test id#2 CRTC count 1
CRTC[267] [Pipe B] Mode: 2880x1800@90Hz Connectors: eDP-1[506]
Expected frametime: 11111us; measured 11116.6us +- 2.329us accuracy 0.01% [0.11 scanlines]
Dynamic subtest pipe-B-eDP-1: SUCCESS (2.132s)
Testing: basic 2 connector combinations
Subtest basic: FAIL (6.511s)
|
| Err |
Starting subtest: basic Starting dynamic subtest: pipe-A-eDP-1 (kms_setmode:2238) CRITICAL: Test assertion failure function test_crtc_config, file ../tests/kms_setmode.c:700: (kms_setmode:2238) CRITICAL: Failed assertion: status (kms_setmode:2238) CRITICAL: VBlank timing test failed after 2 attempt(s) Dynamic subtest pipe-A-eDP-1 failed. **** DEBUG **** (kms_setmode:2238) INFO: Test id#1 CRTC count 1 (kms_setmode:2238) INFO: CRTC[149] [Pipe A] Mode: 2880x1800@90Hz Connectors: eDP-1[506] (kms_setmode:2238) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=2880, height=1800, format=XR24(0x34325258), modifier=0x0, size=0) (kms_setmode:2238) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=11520) (kms_setmode:2238) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd) (kms_setmode:2238) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_setmode:2238) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_setmode:2238) igt_fb-DEBUG: Test requirement passed: gem_has_contexts(fb->fd) (kms_setmode:2238) intel_allocator_reloc-DEBUG: Using reloc allocator (kms_setmode:2238) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_setmode:2238) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_setmode:2238) igt_fb-DEBUG: Test requirement passed: gem_has_contexts(fb->fd) (kms_setmode:2238) intel_allocator_reloc-DEBUG: Using reloc allocator (kms_setmode:2238) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_setmode:2238) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_setmode:2238) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_setmode:2238) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_setmode:2238) igt_fb-DEBUG: Test requirement passed: gem_has_contexts(fb->fd) (kms_setmode:2238) intel_allocator_reloc-DEBUG: Using reloc allocator (kms_setmode:2238) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_setmode:2238) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_setmode:2238) igt_fb-DEBUG: Test requirement passed: gem_has_contexts(fb->fd) (kms_setmode:2238) intel_allocator_reloc-DEBUG: Using reloc allocator (kms_setmode:2238) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_setmode:2238) intel_blt-DEBUG: Test requirement passed: cmds_info (kms_setmode:2238) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0 (kms_setmode:2238) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0 (kms_setmode:2238) INFO: Expected frametime: 11111us; measured 11117.8us +- 2.338us accuracy 0.01% [0.11 scanlines] (kms_setmode:2238) INFO: vblank interval differs from modeline! expected 11111.1us, measured 11118us +- 2.338us, difference 6.7us (2.8 sigma, 1.1 scanlines) (kms_setmode:2238) INFO: Timing check failed on attempt 1, retrying... (kms_setmode:2238) INFO: Expected frametime: 11111us; measured 11117.4us +- 2.547us accuracy 0.01% [0.12 scanlines] (kms_setmode:2238) INFO: vblank interval differs from modeline! expected 11111.1us, measured 11117us +- 2.547us, difference 6.2us (2.5 sigma, 1.1 scanlines) (kms_setmode:2238) INFO: Timing check failed on attempt 2, retrying... (kms_setmode:2238) CRITICAL: Test assertion failure function test_crtc_config, file ../tests/kms_setmode.c:700: (kms_setmode:2238) CRITICAL: Failed assertion: status (kms_setmode:2238) CRITICAL: VBlank timing test failed after 2 attempt(s) (kms_setmode:2238) igt_core-INFO: Stack trace: (kms_setmode:2238) igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (kms_setmode:2238) igt_core-INFO: #1 ../tests/kms_setmode.c:535 test_one_combination() (kms_setmode:2238) igt_core-INFO: #2 ../tests/kms_setmode.c:978 __igt_unique____real_main1033() (kms_setmode:2238) igt_core-INFO: #3 ../tests/kms_setmode.c:1033 main() (kms_setmode:2238) igt_core-INFO: #4 [__libc_init_first+0x8a] (kms_setmode:2238) igt_core-INFO: #5 [__libc_start_main+0x8b] (kms_setmode:2238) igt_core-INFO: #6 [_start+0x25] **** END **** Dynamic subtest pipe-A-eDP-1: FAIL (3.417s) Starting dynamic subtest: pipe-B-eDP-1 Dynamic subtest pipe-B-eDP-1: SUCCESS (2.132s) Subtest basic: FAIL (6.511s) |
| Dmesg |
<6> [93.876692] Console: switching to colour dummy device 80x25
<6> [93.876735] [IGT] kms_setmode: executing
<7> [93.882272] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [93.883410] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [93.895464] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<6> [93.896675] [IGT] kms_setmode: starting subtest basic
<7> [93.896901] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:149:pipe A]
<7> [93.896983] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [93.897134] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [93.897276] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [93.897434] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [93.897573] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in dp_m_n (expected tu 64 data 7483046/8388608 link 498869/524288, found tu 0, data 0/0 link 0/0)
<7> [93.897713] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [93.897850] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [93.897986] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [93.898129] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [93.898265] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [93.898421] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [93.898582] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [93.898719] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [93.898854] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [93.898989] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1801, found 0)
<7> [93.899121] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [93.899255] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [93.899408] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1878, found 0)
<7> [93.899565] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1878, found 0)
<7> [93.899699] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [93.899834] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [93.899968] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [93.900100] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [93.900233] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [93.900380] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [93.900525] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [93.900655] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1801, found 0)
<7> [93.900786] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [93.900919] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [93.901050] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1878, found 0)
<7> [93.901181] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1878, found 0)
<7> [93.901319] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [93.901469] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [93.901601] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [93.901731] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in enhanced_framing (expected yes, found no)
<7> [93.901862] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [93.901991] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 513820, found 0)
<7> [93.902119] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 513820, found 0)
<7> [93.902250] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in port_clock (expected 540000, found 0)
<7> [93.902393] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in set_context_latency (expected 1, found 0)
<7> [93.902540] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:149:pipe A] fastset requirement not met, forcing full modeset
<7> [93.902671] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:149:pipe A] releasing DPLL 0
<7> [93.902889] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [93.903018] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:149:pipe A] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [93.903162] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:33:plane 1A] ddb ( 0 - 4001) -> ( 0 - 0), size 4001 -> 0
<7> [93.903288] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:143:cursor A] ddb (4001 - 4096) -> ( 0 - 0), size 95 -> 0
<7> [93.903435] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33: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> [93.903617] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] lines 2, 16, 16, 19, 19, 28, 0, 0, 0, 3, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [93.903742] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] blocks 49, 385, 385, 457, 457, 673, 0, 0, 63, 73, 87 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [93.903865] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] min_ddb 55, 425, 425, 504, 504, 742, 0, 0, 64, 82, 88 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [93.904004] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:149:pipe A] data rate 0 num active planes 0
<7> [93.904140] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 28913 required 0 qgv_peak_bw: 51200
<7> [93.904273] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 1: max bw 38000 required 0 qgv_peak_bw: 51200
<7> [93.904423] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 51200
<7> [93.904553] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 51200
<7> [93.904682] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] Matching peaks QGV bw: 51200 for required data rate: 0
<7> [93.904814] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:149:pipe A] min cdclk: 256910 kHz -> 0 kHz
<7> [93.904960] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 32114 kHz -> 0 kHz
<7> [93.905093] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Can change cdclk via squashing
<7> [93.905224] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 172800 kHz, actual 172800 kHz
<7> [93.905364] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [93.905514] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:149:pipe A] enable: no [modeset]
<7> [93.905648] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:33:plane 1A] fb: [NOFB], visible: no
<7> [93.905819] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 2A] fb: [NOFB], visible: no
<7> [93.905956] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:93:plane 3A] fb: [NOFB], visible: no
<7> [93.906089] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:123:plane 4A] fb: [NOFB], visible: no
<7> [93.906222] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:133:plane 5A] fb: [NOFB], visible: no
<7> [93.906379] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:143:cursor A] fb: [NOFB], visible: no
<7> [93.906555] i915 0000:00:02.0: [drm:intel_psr_disable_locked [i915]] Disabling PSR2
<7> [93.910150] i915 0000:00:02.0: [drm:intel_edp_backlight_off [i915]]
<7> [94.112458] i915 0000:00:02.0: [drm:intel_backlight_set_pwm_level [i915]] [CONNECTOR:506:eDP-1] set backlight PWM = 0
<7> [94.113258] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [94.121481] i915 0000:00:02.0: [drm:intel_pps_off_unlocked [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 turn panel power off
<7> [94.121845] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x00000089, pins 0x00000010, long 0x00000000
<7> [94.122010] i915 0000:00:02.0: [drm:intel_pps_off_unlocked [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [94.122404] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:505:DDI A/PHY A] - short
<7> [94.122614] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [94.174474] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x0000008a, pins 0x00000010, long 0x00000010
<7> [94.175025] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:505:DDI A/PHY A] - long
<7> [94.175258] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [94.175531] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [94.175811] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:149:pipe A]
<7> [94.175957] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring short hpd on eDP [ENCODER:505:DDI A/PHY A]
<7> [94.176474] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring long hpd on eDP [ENCODER:505:DDI A/PHY A]
<7> [94.177261] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0
<7> [94.177848] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling AUX_A
<7> [94.178351] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:505:DDI A/PHY A]
<7> [94.178758] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:514:DDI B/PHY B]
<7> [94.179018] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:516:DP-MST A]
<7> [94.179242] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:517:DP-MST B]
<7> [94.179436] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:518:DP-MST C]
<7> [94.179920] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:519:DP-MST D]
<7> [94.180109] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:532:DDI TC1/PHY TC1]
<7> [94.180286] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:534:DP-MST A]
<7> [94.180433] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:535:DP-MST B]
<7> [94.180622] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:536:DP-MST C]
<7> [94.180757] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:537:DP-MST D]
<7> [94.180881] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:541:DDI TC2/PHY TC2]
<7> [94.181003] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:545:DDI TC3/PHY TC3]
<7> [94.181139] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:547:DP-MST A]
<7> [94.181283] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:548:DP-MST B]
<7> [94.181415] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:549:DP-MST C]
<7> [94.181539] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:550:DP-MST D]
<7> [94.181676] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:554:DDI TC4/PHY TC4]
<7> [94.181817] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:556:DP-MST A]
<7> [94.181957] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:557:DP-MST B]
<7> [94.182095] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:558:DP-MST C]
<7> [94.182240] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:559:DP-MST D]
<7> [94.182440] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:506:eDP-1]
<7> [94.182665] i915 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [i915]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [94.182833] i915 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [i915]] Changing mbus joined: yes -> no (pipe: *)
<7> [94.182980] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [94.183229] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_A
<7> [94.183432] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:149:pipe A]
<7> [94.183627] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Post changing CDCLK to 172800 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [94.183805] i915 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [i915]] aud_ts_cdclk set to M=60, N=432
<7> [94.184228] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:267:pipe B]
<7> [94.184400] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:385:pipe C]
<7> [94.184498] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:503:pipe D]
<7> [94.184981] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:507]
<7> [94.188115] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [94.188572] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [94.202173] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [94.202735] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [94.203336] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [94.214434] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [94.214676] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<6> [94.222636] [IGT] kms_setmode: starting dynamic subtest pipe-A-eDP-1
<7> [94.222844] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:563]
<7> [94.225206] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [94.225466] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [94.244481] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [94.244742] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [94.254019] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [94.254389] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [94.266821] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [94.267106] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [94.274220] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:149:pipe A]
<7> [94.274260] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:506:eDP-1]
<7> [94.274339] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:506:eDP-1] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [94.274522] i915 0000:00:02.0: [drm:intel_dp_compute_config_limits [i915]] [ENCODER:505:DDI A/PHY A][CRTC:149:pipe A] DP link limits: pixel clock 513820 kHz DSC off max lanes 4 max rate 540000 max pipe_bpp 30 max link_bpp 30.0000
<7> [94.274674] i915 0000:00:02.0: [drm:intel_dp_compute_link_config [i915]] DP lane count 4 clock 540000 bpp input 30 compressed 0.0000 link rate required 1926825 available 2160000
<7> [94.274824] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:149:pipe A] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [94.274967] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:505:DDI A/PHY A] [CRTC:149:pipe A]
<7> [94.275114] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [94.275266] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [94.275409] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [94.275555] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [94.275701] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 7483046/8388608 link 498869/524288)
<7> [94.275840] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [94.275974] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [94.276114] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [94.276251] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [94.276393] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [94.276526] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [94.276659] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [94.276791] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [94.276922] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [94.277053] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1801)
<7> [94.277196] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [94.277326] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [94.277456] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1878)
<7> [94.277586] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1878)
<7> [94.277719] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [94.277853] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [94.277986] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [94.278123] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [94.278255] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [94.278386] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [94.278518] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [94.278652] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1801)
<7> [94.278784] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [94.278915] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [94.279046] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1878)
<7> [94.279198] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1878)
<7> [94.279331] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [94.279461] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [94.279589] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [94.279719] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in enhanced_framing (expected no, found yes)
<7> [94.279850] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [94.279978] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 513820)
<7> [94.280114] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 513820)
<7> [94.280245] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in port_clock (expected 0, found 540000)
<7> [94.280376] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in set_context_latency (expected 0, found 1)
<7> [94.280505] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:149:pipe A] fastset requirement not met, forcing full modeset
<7> [94.280673] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [94.280802] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:149:pipe A] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x1
<7> [94.280944] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:33:plane 1A] ddb ( 0 - 0) -> ( 0 - 4001), size 0 -> 4001
<7> [94.281075] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:143:cursor A] ddb ( 0 - 0) -> (4001 - 4096), size 0 -> 95
<7> [94.281199] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33: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> [94.281324] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 2, 16, 16, 19, 19, 28, 0, 0, 0, 3, 0
<7> [94.281447] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 49, 385, 385, 457, 457, 673, 0, 0, 63, 73, 87
<7> [94.281572] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 55, 425, 425, 504, 504, 742, 0, 0, 64, 82, 88
<7> [94.281706] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:149:pipe A] data rate 2055280 num active planes 1
<7> [94.281841] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 28913 required 2159 qgv_peak_bw: 51200
<7> [94.281974] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 1: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [94.282111] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 2: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [94.282241] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 3: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [94.282371] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] Matching peaks QGV bw: 51200 for required data rate: 2159
<7> [94.282503] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:149:pipe A] min cdclk: 0 kHz -> 256910 kHz
<7> [94.282646] i915 0000:00:02.0: [drm:intel_cdclk_update_dbuf_bw_min_cdclk [i915]] dbuf bandwidth min cdclk: 0 kHz -> 32114 kHz
<7> [94.282784] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Can change cdclk via squashing
<7> [94.282918] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 307200 kHz, actual 307200 kHz
<7> [94.283051] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [94.283315] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:149:pipe A] allocated DPLL 0
<7> [94.283455] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:149:pipe A] reserving DPLL 0
<7> [94.283597] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:149:pipe A] enable: yes [modeset]
<7> [94.283736] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [94.283873] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 30, dithering: 0
<7> [94.284010] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [94.284153] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [94.284292] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [94.284429] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [94.284561] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dp m_n: lanes: 4; data_m: 7483046, data_n: 8388608, link_m: 498869, link_n: 524288, tu: 64
<7> [94.284691] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [94.284821] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] fec: disabled, enhanced framing: enabled
<7> [94.284949] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sdp split: disabled
<7> [94.285082] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [94.285215] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] minimum HBlank: 0
<7> [94.285347] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [94.285479] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] DP SDP: VSC, revision 4, length 14
<7> [94.285612] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pixelformat: RGB
<7> [94.285741] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] colorimetry: sRGB
<7> [94.285869] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] bpc: 0
<7> [94.285997] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dynamic range: VESA range
<7> [94.286130] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] content type: Not defined
<7> [94.286260] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 1
<7> [94.286391] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 1
<7> [94.286519] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1878, vmax: 1878, flipline: 1878, pipeline full: 0, guardband: 76 vsync start: 75, vsync end: 69
<7> [94.286647] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1802, vmax vblank: 1802, vmin vtotal: 1878, vmax vtotal: 1878
<7> [94.286778] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "2880x1800": 90 513820 2880 2928 2960 3040 1800 1803 1809 1878 0x48 0xa
<7> [94.286911] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "2880x1800": 90 513820 2880 2928 2960 3040 1800 1803 1809 1878 0x48 0xa
<7> [94.287043] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=513820, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1801-1878 vs=1803-1809 vt=1878, flags=0xa
<7> [94.287186] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "2880x1800": 90 513820 2880 2928 2960 3040 1800 1803 1809 1878 0x40 0xa
<7> [94.287317] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=513820, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1801-1878 vs=1803-1809 vt=1878, flags=0xa
<7> [94.287447] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 540000, pipe src: 2880x1800+0+0, pixel rate 513820, min cdclk 256910
<7> [94.287577] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 48, ips linetime: 0
<7> [94.287707] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [94.287838] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [94.287969] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [94.288106] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: yes, tbt_mode: no
<7> [94.288236] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] c10pll_hw_state: clock: 540000, fracen: yes,
<7> [94.288366] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] quot: 40960, rem: 0, den: 1,
<7> [94.288494] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] multiplier: 140, tx_clk_div: 0.
<7> [94.288623] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] c10pll_rawhw_state:
<7> [94.288751] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] tx: 0x10, cmn: 0x21
<7> [94.288880] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pll[0] = 0xf4, pll[1] = 0x0, pll[2] = 0xf8, pll[3] = 0x0
<7> [94.289010] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [94.289145] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [94.289274] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pll[12] = 0xa0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x0
<7> [94.289402] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pll[16] = 0x84, pll[17] = 0x4f, pll[18] = 0xe5, pll[19] = 0x23
<7> [94.289531] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [94.289659] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [94.289788] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [94.289916] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [94.290046] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [94.290187] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [94.290320] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [94.290449] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [94.290580] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [94.290709] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [94.290838] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [94.290967] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [94.291102] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [94.291231] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:33:plane 1A] fb: [FB:563] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [94.291367] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [94.291500] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [94.291633] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 2A] fb: [NOFB], visible: no
<7> [94.291765] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:93:plane 3A] fb: [NOFB], visible: no
<7> [94.291895] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:123:plane 4A] fb: [NOFB], visible: no
<7> [94.292024] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:133:plane 5A] fb: [NOFB], visible: no
<7> [94.292175] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:143:cursor A] fb: [NOFB], visible: no
<7> [94.294137] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [94.294517] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [94.294732] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_A
<7> [94.294951] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 307200 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [94.295153] i915 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [i915]] aud_ts_cdclk set to M=60, N=768
<7> [94.295290] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:505:DDI A/PHY A]
<7> [94.295425] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:514:DDI B/PHY B]
<7> [94.295558] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:516:DP-MST A]
<7> [94.295689] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:517:DP-MST B]
<7> [94.295821] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:518:DP-MST C]
<7> [94.295951] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:519:DP-MST D]
<7> [94.296098] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:532:DDI TC1/PHY TC1]
<7> [94.296228] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:534:DP-MST A]
<7> [94.296356] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:535:DP-MST B]
<7> [94.296487] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:536:DP-MST C]
<7> [94.296619] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:537:DP-MST D]
<7> [94.296745] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:541:DDI TC2/PHY TC2]
<7> [94.296871] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:545:DDI TC3/PHY TC3]
<7> [94.296994] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:547:DP-MST A]
<7> [94.297146] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:548:DP-MST B]
<7> [94.297272] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:549:DP-MST C]
<7> [94.297401] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:550:DP-MST D]
<7> [94.297529] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:554:DDI TC4/PHY TC4]
<7> [94.297663] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:556:DP-MST A]
<7> [94.297785] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:557:DP-MST B]
<7> [94.297906] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:558:DP-MST C]
<7> [94.298027] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:559:DP-MST D]
<7> [94.298206] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0xf
<7> [94.298440] i915 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [i915]] Changing mbus joined: no -> yes (pipe: *)
<7> [94.298577] i915 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [i915]] Updating dbuf ratio to 4 (mbus joined: yes)
<7> [94.298783] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling AUX_A
<7> [94.300123] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:149:pipe A]
<7> [94.300281] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0
<7> [94.301813] i915 0000:00:02.0: [drm:intel_pps_on_unlocked [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 turn panel power on
<7> [94.301971] i915 0000:00:02.0: [drm:wait_panel_power_cycle [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 wait for panel power cycle (374 ms remaining)
<7> [94.680266] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x00000000 PP_CONTROL: 0x00000060
<7> [94.691090] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [94.691687] i915 0000:00:02.0: [drm:intel_pps_on_unlocked [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 wait for panel power on
<7> [94.692301] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [94.723653] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x0000008a, pins 0x00000010, long 0x00000010
<7> [94.724206] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:505:DDI A/PHY A] - long
<7> [94.724716] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [94.725337] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring long hpd on eDP [ENCODER:505:DDI A/PHY A]
<7> [94.896103] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [94.896860] i915 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 turning VDD on
<7> [94.897467] i915 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [94.900614] i915 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX A/DDI A/PHY A: DPCD: 14 14 c4 41 00 00 01 c0 02 00 00 00 00 0b 80
<7> [94.901555] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [94.902241] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 07
<7> [94.903295] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [94.903989] i915 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [94.905009] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] Clock recovery OK
<7> [94.905130] i915 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] Using DP training pattern TPS3
<7> [94.906809] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [94.906930] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] Link Training passed at link rate = 540000, lane count = 4
<7> [94.907533] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [94.907808] i915 0000:00:02.0: [drm:intel_edp_backlight_on [i915]]
<7> [94.907944] i915 0000:00:02.0: [drm:intel_backlight_enable [i915]] pipe A
<7> [94.908126] i915 0000:00:02.0: [drm:intel_backlight_set_pwm_level [i915]] [CONNECTOR:506:eDP-1] set backlight PWM = 13892
<7> [94.919204] i915 0000:00:02.0: [drm:intel_psr_post_plane_update [i915]] Enabling PSR2
<7> [94.920729] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:506:eDP-1]
<7> [94.920929] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:149:pipe A]
<7> [97.470262] i915 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 turning VDD off
<7> [97.470862] i915 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [97.471404] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [97.471952] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [97.472469] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<6> [97.640166] [IGT] kms_setmode: finished subtest pipe-A-eDP-1, FAIL
<7> [97.640424] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:563] from all active usage due to RMFB ioctl
<7> [97.640607] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:33:plane 1A] because [FB:563] is removed
<7> [97.640652] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:33:plane 1A] ddb ( 0 - 4001) -> ( 0 - 0), size 4001 -> 0
<7> [97.640796] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33: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.640927] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] lines 2, 16, 16, 19, 19, 28, 0, 0, 0, 3, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [97.641054] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] blocks 49, 385, 385, 457, 457, 673, 0, 0, 63, 73, 87 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [97.641194] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] min_ddb 55, 425, 425, 504, 504, 742, 0, 0, 64, 82, 88 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [97.641356] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:149:pipe A] data rate 0 num active planes 0
<7> [97.641494] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 28913 required 0 qgv_peak_bw: 51200
<7> [97.641629] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 1: max bw 38000 required 0 qgv_peak_bw: 51200
<7> [97.641762] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 51200
<7> [97.641892] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 51200
<7> [97.642021] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] Matching peaks QGV bw: 51200 for required data rate: 0
<7> [97.642212] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [97.643041] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [97.643280] i915 0000:00:02.0: [drm:intel_psr_disable_locked [i915]] Disabling PSR2
<7> [97.643792] i915 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 turning VDD on
<7> [97.644029] i915 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006f
<7> [97.655115] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:149:pipe A]
<7> [97.655282] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [97.655834] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [97.656362] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [97.656854] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [97.657185] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in dp_m_n (expected tu 64 data 7483046/8388608 link 498869/524288, found tu 0, data 0/0 link 0/0)
<7> [97.657493] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [97.657857] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [97.658192] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [97.658516] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [97.658838] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [97.659017] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [97.659176] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [97.659315] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [97.659454] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [97.659593] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1801, found 0)
<7> [97.659731] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [97.659888] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [97.660036] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1878, found 0)
<7> [97.660196] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1878, found 0)
<7> [97.660333] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [97.660468] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [97.660603] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [97.660737] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [97.660868] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [97.661001] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [97.661154] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [97.661289] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1801, found 0)
<7> [97.661419] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [97.661550] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [97.661684] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1878, found 0)
<7> [97.661822] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1878, found 0)
<7> [97.661954] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [97.662109] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [97.662258] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [97.662394] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in enhanced_framing (expected yes, found no)
<7> [97.662527] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [97.662658] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 513820, found 0)
<7> [97.662792] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 513820, found 0)
<7> [97.662926] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in port_clock (expected 540000, found 0)
<7> [97.663060] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in set_context_latency (expected 1, found 0)
<7> [97.663206] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:149:pipe A] fastset requirement not met, forcing full modeset
<7> [97.663340] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:149:pipe A] releasing DPLL 0
<7> [97.663502] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [97.663631] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:149:pipe A] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [97.663772] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:143:cursor A] ddb (4001 - 4096) -> ( 0 - 0), size 95 -> 0
<7> [97.663908] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:149:pipe A] min cdclk: 256910 kHz -> 0 kHz
<7> [97.664045] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Can change cdclk via squashing
<7> [97.664194] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 172800 kHz, actual 172800 kHz
<7> [97.664352] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [97.664501] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:149:pipe A] enable: no [modeset]
<7> [97.664638] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:33:plane 1A] fb: [NOFB], visible: no
<7> [97.664774] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 2A] fb: [NOFB], visible: no
<7> [97.664908] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:93:plane 3A] fb: [NOFB], visible: no
<7> [97.665041] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:123:plane 4A] fb: [NOFB], visible: no
<7> [97.665199] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:133:plane 5A] fb: [NOFB], visible: no
<7> [97.665334] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:143:cursor A] fb: [NOFB], visible: no
<7> [97.665655] i915 0000:00:02.0: [drm:intel_edp_backlight_off [i915]]
<7> [97.870286] i915 0000:00:02.0: [drm:intel_backlight_set_pwm_level [i915]] [CONNECTOR:506:eDP-1] set backlight PWM = 0
<7> [97.871370] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [97.878308] i915 0000:00:02.0: [drm:intel_pps_off_unlocked [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 turn panel power off
<7> [97.878510] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x00000089, pins 0x00000010, long 0x00000000
<7> [97.879045] i915 0000:00:02.0: [drm:intel_pps_off_unlocked [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [97.879067] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:505:DDI A/PHY A] - short
<7> [97.879644] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [97.930180] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [97.930709] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:149:pipe A]
<7> [97.930898] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring short hpd on eDP [ENCODER:505:DDI A/PHY A]
<7> [97.931489] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x0000008a, pins 0x00000010, long 0x00000010
<7> [97.932038] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:505:DDI A/PHY A] - long
<7> [97.932277] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0
<7> [97.932548] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [97.932859] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling AUX_A
<7> [97.933130] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring long hpd on eDP [ENCODER:505:DDI A/PHY A]
<7> [97.933472] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:505:DDI A/PHY A]
<7> [97.933851] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:514:DDI B/PHY B]
<7> [97.934106] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:516:DP-MST A]
<7> [97.934342] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:517:DP-MST B]
<7> [97.934572] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:518:DP-MST C]
<7> [97.934801] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:519:DP-MST D]
<7> [97.935040] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:532:DDI TC1/PHY TC1]
<7> [97.935268] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:534:DP-MST A]
<7> [97.935494] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:535:DP-MST B]
<7> [97.935627] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:536:DP-MST C]
<7> [97.935750] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:537:DP-MST D]
<7> [97.935909] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:541:DDI TC2/PHY TC2]
<7> [97.936069] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:545:DDI TC3/PHY TC3]
<7> [97.936266] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:547:DP-MST A]
<7> [97.936388] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:548:DP-MST B]
<7> [97.936510] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:549:DP-MST C]
<7> [97.936650] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:550:DP-MST D]
<7> [97.936778] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:554:DDI TC4/PHY TC4]
<7> [97.936902] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:556:DP-MST A]
<7> [97.937036] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:557:DP-MST B]
<7> [97.937175] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:558:DP-MST C]
<7> [97.937295] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:559:DP-MST D]
<7> [97.937416] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:506:eDP-1]
<7> [97.937617] i915 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [i915]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [97.937770] i915 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [i915]] Changing mbus joined: yes -> no (pipe: *)
<7> [97.937904] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [97.938157] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_A
<7> [97.938364] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:149:pipe A]
<7> [97.938542] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Post changing CDCLK to 172800 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [97.938717] i915 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [i915]] aud_ts_cdclk set to M=60, N=432
<7> [97.938983] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:149:pipe A]
<7> [97.939280] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:267:pipe B]
<7> [97.939487] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:385:pipe C]
<7> [97.939668] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:503:pipe D]
<7> [97.940312] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:563]
<7> [97.942978] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [97.943412] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [97.956965] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [97.957522] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [97.958093] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [97.960427] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [97.960665] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<6> [97.967597] [IGT] kms_setmode: starting dynamic subtest pipe-B-eDP-1
<7> [97.967780] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:566]
<7> [97.970154] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [97.970397] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [97.987089] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [97.987343] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [97.998138] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [97.998391] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [98.007299] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [98.007544] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [98.014489] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:267:pipe B]
<7> [98.014577] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:506:eDP-1]
<7> [98.014669] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:506:eDP-1] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [98.014841] i915 0000:00:02.0: [drm:intel_dp_compute_config_limits [i915]] [ENCODER:505:DDI A/PHY A][CRTC:267:pipe B] DP link limits: pixel clock 513820 kHz DSC off max lanes 4 max rate 540000 max pipe_bpp 30 max link_bpp 30.0000
<7> [98.015023] i915 0000:00:02.0: [drm:intel_dp_compute_link_config [i915]] DP lane count 4 clock 540000 bpp input 30 compressed 0.0000 link rate required 1926825 available 2160000
<7> [98.015172] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:267:pipe B] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [98.015315] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:505:DDI A/PHY A] [CRTC:267:pipe B]
<7> [98.015446] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [98.015583] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [98.015718] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [98.015857] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [98.016059] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 7483046/8388608 link 498869/524288)
<7> [98.016196] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [98.016336] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [98.016470] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [98.016603] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [98.016737] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [98.016871] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [98.017034] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [98.017171] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [98.017304] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [98.017437] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1801)
<7> [98.017570] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [98.017702] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [98.017835] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1878)
<7> [98.017979] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1878)
<7> [98.018114] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [98.018248] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [98.018380] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [98.018512] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [98.018643] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [98.018774] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [98.018912] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [98.019053] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1801)
<7> [98.019188] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [98.019321] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [98.019452] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1878)
<7> [98.019585] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1878)
<7> [98.019718] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [98.019850] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [98.019992] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [98.020127] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in enhanced_framing (expected no, found yes)
<7> [98.020259] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in dpll_hw_state
<7> [98.020389] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [98.020521] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] cx0pll_hw_state: lane_count: 0, ssc_enabled: no, use_c10: no, tbt_mode: no
<7> [98.020653] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] c20pll_hw_state: clock: 0
<7> [98.020785] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] tx[0] = 0x0000, tx[1] = 0x0000, tx[2] = 0x0000
<7> [98.020968] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] cmn[0] = 0x0000, cmn[1] = 0x0000, cmn[2] = 0x0000, cmn[3] = 0x0000
<7> [98.021099] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] mplla[0] = 0x0000
<7> [98.021229] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] mplla[1] = 0x0000
<7> [98.021358] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] mplla[2] = 0x0000
<7> [98.021488] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] mplla[3] = 0x0000
<7> [98.021616] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] mplla[4] = 0x0000
<7> [98.021747] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] mplla[5] = 0x0000
<7> [98.021885] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] mplla[6] = 0x0000
<7> [98.022030] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] mplla[7] = 0x0000
<7> [98.022162] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] mplla[8] = 0x0000
<7> [98.022293] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] mplla[9] = 0x0000
<7> [98.022423] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] mpllb[10] = 0x0000
<7> [98.022553] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] vdr: custom width: 0x00, serdes rate: 0x00, hdmi rate: 0x00
<7> [98.022682] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [98.022812] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: yes, tbt_mode: no
<7> [98.022951] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] c10pll_hw_state: clock: 540000, fracen: yes,
<7> [98.023089] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] quot: 40960, rem: 0, den: 1,
<7> [98.023224] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] multiplier: 140, tx_clk_div: 0.
<7> [98.023357] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] c10pll_rawhw_state:
<7> [98.023489] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] tx: 0x10, cmn: 0x21
<7> [98.023616] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] pll[0] = 0xf4, pll[1] = 0x0, pll[2] = 0xf8, pll[3] = 0x0
<7> [98.023743] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [98.023869] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [98.024009] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] pll[12] = 0xa0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x0
<7> [98.024149] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] pll[16] = 0x84, pll[17] = 0x4f, pll[18] = 0xe5, pll[19] = 0x23
<7> [98.024285] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [98.024417] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 513820)
<7> [98.024546] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 513820)
<7> [98.024673] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in port_clock (expected 0, found 540000)
<7> [98.024802] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in set_context_latency (expected 0, found 1)
<7> [98.024980] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:267:pipe B] fastset requirement not met, forcing full modeset
<7> [98.025151] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [98.025282] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:267:pipe B] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x2
<7> [98.025427] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:151:plane 1B] ddb ( 0 - 0) -> ( 0 - 4001), size 0 -> 4001
<7> [98.025552] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:261:cursor B] ddb ( 0 - 0) -> (4001 - 4096), size 0 -> 95
<7> [98.025677] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:151:plane 1B] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm
<7> [98.025800] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:151:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 2, 16, 16, 19, 19, 28, 0, 0, 0, 3, 0
<7> [98.025938] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:151:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 49, 385, 385, 457, 457, 673, 0, 0, 63, 73, 87
<7> [98.026062] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:151:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 55, 425, 425, 504, 504, 742, 0, 0, 64, 82, 88
<7> [98.026197] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:267:pipe B] data rate 2055280 num active planes 1
<7> [98.026333] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 28913 required 2159 qgv_peak_bw: 51200
<7> [98.026469] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 1: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [98.026601] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 2: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [98.026731] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 3: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [98.026861] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] Matching peaks QGV bw: 51200 for required data rate: 2159
<7> [98.027006] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:267:pipe B] min cdclk: 0 kHz -> 256910 kHz
<7> [98.027167] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Can change cdclk via squashing
<7> [98.027301] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 307200 kHz, actual 307200 kHz
<7> [98.027441] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [98.027597] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:267:pipe B] allocated DPLL 0
<7> [98.027735] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:267:pipe B] reserving DPLL 0
<7> [98.027879] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:267:pipe B] enable: yes [modeset]
<7> [98.028016] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [98.028157] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 30, dithering: 0
<7> [98.028295] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [98.028431] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [98.028561] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [98.028690] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [98.028820] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dp m_n: lanes: 4; data_m: 7483046, data_n: 8388608, link_m: 498869, link_n: 524288, tu: 64
<7> [98.028969] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [98.029107] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] fec: disabled, enhanced framing: enabled
<7> [98.029241] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sdp split: disabled
<7> [98.029378] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [98.029516] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] minimum HBlank: 0
<7> [98.029645] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [98.029774] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] DP SDP: VSC, revision 4, length 14
<7> [98.029916] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pixelformat: RGB
<7> [98.030049] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] colorimetry: sRGB
<7> [98.030185] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] bpc: 0
<7> [98.030319] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dynamic range: VESA range
<7> [98.030448] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] content type: Not defined
<7> [98.030577] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 1
<7> [98.030706] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 1
<7> [98.030835] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1878, vmax: 1878, flipline: 1878, pipeline full: 0, guardband: 76 vsync start: 75, vsync end: 69
<7> [98.030974] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1802, vmax vblank: 1802, vmin vtotal: 1878, vmax vtotal: 1878
<7> [98.031115] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "2880x1800": 90 513820 2880 2928 2960 3040 1800 1803 1809 1878 0x48 0xa
<7> [98.031252] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "2880x1800": 90 513820 2880 2928 2960 3040 1800 1803 1809 1878 0x48 0xa
<7> [98.031386] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=513820, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1801-1878 vs=1803-1809 vt=1878, flags=0xa
<7> [98.031519] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "2880x1800": 90 513820 2880 2928 2960 3040 1800 1803 1809 1878 0x40 0xa
<7> [98.031646] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=513820, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1801-1878 vs=1803-1809 vt=1878, flags=0xa
<7> [98.031773] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 540000, pipe src: 2880x1800+0+0, pixel rate 513820, min cdclk 256910
<7> [98.031908] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 48, ips linetime: 0
<7> [98.032039] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [98.032168] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [98.032297] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [98.032427] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: yes, tbt_mode: no
<7> [98.032557] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] c10pll_hw_state: clock: 540000, fracen: yes,
<7> [98.032685] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] quot: 40960, rem: 0, den: 1,
<7> [98.032814] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] multiplier: 140, tx_clk_div: 0.
<7> [98.032951] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] c10pll_rawhw_state:
<7> [98.033085] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] tx: 0x10, cmn: 0x21
<7> [98.033216] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pll[0] = 0xf4, pll[1] = 0x0, pll[2] = 0xf8, pll[3] = 0x0
<7> [98.033344] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [98.033472] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [98.033600] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pll[12] = 0xa0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x0
<7> [98.033727] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pll[16] = 0x84, pll[17] = 0x4f, pll[18] = 0xe5, pll[19] = 0x23
<7> [98.033855] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [98.033995] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [98.034123] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [98.034251] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [98.034377] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [98.034504] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [98.034630] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [98.034756] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [98.034887] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [98.035021] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [98.035150] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [98.035280] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [98.035413] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [98.035545] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:151:plane 1B] fb: [FB:566] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [98.035678] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [98.035807] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [98.035944] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:181:plane 2B] fb: [NOFB], visible: no
<7> [98.036076] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:211:plane 3B] fb: [NOFB], visible: no
<7> [98.036206] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:241:plane 4B] fb: [NOFB], visible: no
<7> [98.036334] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:251:plane 5B] fb: [NOFB], visible: no
<7> [98.036461] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:261:cursor B] fb: [NOFB], visible: no
<7> [98.038437] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [98.038736] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [98.038990] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_2
<7> [98.039350] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_B
<7> [98.039575] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 307200 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [98.039753] i915 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [i915]] aud_ts_cdclk set to M=60, N=768
<7> [98.039907] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:505:DDI A/PHY A]
<7> [98.040042] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:514:DDI B/PHY B]
<7> [98.040174] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:516:DP-MST A]
<7> [98.040303] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:517:DP-MST B]
<7> [98.040431] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:518:DP-MST C]
<7> [98.040559] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:519:DP-MST D]
<7> [98.040686] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:532:DDI TC1/PHY TC1]
<7> [98.040819] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:534:DP-MST A]
<7> [98.040968] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:535:DP-MST B]
<7> [98.041096] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:536:DP-MST C]
<7> [98.041224] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:537:DP-MST D]
<7> [98.041352] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:541:DDI TC2/PHY TC2]
<7> [98.041479] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:545:DDI TC3/PHY TC3]
<7> [98.041605] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:547:DP-MST A]
<7> [98.041731] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:548:DP-MST B]
<7> [98.041857] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:549:DP-MST C]
<7> [98.042008] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:550:DP-MST D]
<7> [98.042132] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:554:DDI TC4/PHY TC4]
<7> [98.042257] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:556:DP-MST A]
<7> [98.042382] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:557:DP-MST B]
<7> [98.042505] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:558:DP-MST C]
<7> [98.042628] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:559:DP-MST D]
<7> [98.042782] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0xf
<7> [98.043034] i915 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [i915]] Changing mbus joined: no -> yes (pipe: *)
<7> [98.043170] i915 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [i915]] Updating dbuf ratio to 4 (mbus joined: yes)
<7> [98.043365] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling AUX_A
<7> [98.044724] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x2, on? 0) for [CRTC:267:pipe B]
<7> [98.044901] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0
<7> [98.046333] i915 0000:00:02.0: [drm:intel_pps_on_unlocked [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 turn panel power on
<7> [98.046482] i915 0000:00:02.0: [drm:wait_panel_power_cycle [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 wait for panel power cycle (385 ms remaining)
<7> [98.438145] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [98.522018] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [98.522836] i915 0000:00:02.0: [drm:intel_pps_on_unlocked [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 wait for panel power on
<7> [98.523471] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [98.554766] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x0000008a, pins 0x00000010, long 0x00000010
<7> [98.555361] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:505:DDI A/PHY A] - long
<7> [98.555875] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [98.556392] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring long hpd on eDP [ENCODER:505:DDI A/PHY A]
<7> [98.732967] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [98.733787] i915 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 turning VDD on
<7> [98.734427] i915 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [98.737649] i915 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX A/DDI A/PHY A: DPCD: 14 14 c4 41 00 00 01 c0 02 00 00 00 00 0b 80
<7> [98.738571] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [98.739196] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 07
<7> [98.740330] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [98.741124] i915 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [98.742025] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] Clock recovery OK
<7> [98.742146] i915 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] Using DP training pattern TPS3
<7> [98.743443] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [98.743570] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] Link Training passed at link rate = 540000, lane count = 4
<7> [98.744162] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B
<7> [98.744406] i915 0000:00:02.0: [drm:intel_edp_backlight_on [i915]]
<7> [98.744533] i915 0000:00:02.0: [drm:intel_backlight_enable [i915]] pipe B
<7> [98.744710] i915 0000:00:02.0: [drm:intel_backlight_set_pwm_level [i915]] [CONNECTOR:506:eDP-1] set backlight PWM = 13892
<7> [98.755673] i915 0000:00:02.0: [drm:intel_psr_post_plane_update [i915]] Enabling PSR2
<7> [98.757102] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:506:eDP-1]
<7> [98.757293] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:267:pipe B]
<6> [100.100171] [IGT] kms_setmode: finished subtest pipe-B-eDP-1, SUCCESS
<7> [100.100626] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:566] from all active usage due to RMFB ioctl
<7> [100.100700] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:151:plane 1B] because [FB:566] is removed
<7> [100.100784] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:151:plane 1B] ddb ( 0 - 4001) -> ( 0 - 0), size 4001 -> 0
<7> [100.101074] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:151:plane 1B] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5, wm6, wm7,*twm,*swm,*stwm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm, swm, stwm
<7> [100.101278] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:151:plane 1B] lines 2, 16, 16, 19, 19, 28, 0, 0, 0, 3, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [100.101475] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:151:plane 1B] blocks 49, 385, 385, 457, 457, 673, 0, 0, 63, 73, 87 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [100.101668] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:151:plane 1B] min_ddb 55, 425, 425, 504, 504, 742, 0, 0, 64, 82, 88 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [100.101910] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:267:pipe B] data rate 0 num active planes 0
<7> [100.102168] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 28913 required 0 qgv_peak_bw: 51200
<7> [100.102375] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 1: max bw 38000 required 0 qgv_peak_bw: 51200
<7> [100.102579] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 51200
<7> [100.102783] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 51200
<7> [100.102991] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] Matching peaks QGV bw: 51200 for required data rate: 0
<7> [100.103281] i915 0000:00:02.0: [drm:intel_psr_disable_locked [i915]] Disabling PSR2
<7> [100.122726] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:267:pipe B]
<7> [100.122867] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.enable (expected yes, found no)
<7> [100.123115] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.active (expected yes, found no)
<7> [100.123331] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [100.123541] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in lane_count (expected 4, found 0)
<7> [100.123747] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in dp_m_n (expected tu 64 data 7483046/8388608 link 498869/524288, found tu 0, data 0/0 link 0/0)
<7> [100.123967] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [100.124171] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [100.124373] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [100.124573] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [100.124774] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [100.124986] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [100.125189] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [100.125387] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [100.125587] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [100.125792] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1801, found 0)
<7> [100.126004] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [100.126209] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [100.126413] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1878, found 0)
<7> [100.126615] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1878, found 0)
<7> [100.126816] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [100.127020] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [100.127230] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [100.127428] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [100.127627] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [100.127832] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [100.128033] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [100.128231] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1801, found 0)
<7> [100.128429] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [100.128632] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [100.128845] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1878, found 0)
<7> [100.129049] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1878, found 0)
<7> [100.129251] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [100.129455] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [100.129657] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [100.129861] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in enhanced_framing (expected yes, found no)
<7> [100.130063] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [100.130263] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 513820, found 0)
<7> [100.130465] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 513820, found 0)
<7> [100.130666] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in port_clock (expected 540000, found 0)
<7> [100.130873] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:267:pipe B] fastset requirement not met in set_context_latency (expected 1, found 0)
<7> [100.131075] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:267:pipe B] fastset requirement not met, forcing full modeset
<7> [100.131276] i915 0000:00:02.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:267:pipe B] releasing DPLL 0
<7> [100.131573] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [100.132092] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:267:pipe B] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x2 -> 0x0
<7> [100.132720] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:261:cursor B] ddb (4001 - 4096) -> ( 0 - 0), size 95 -> 0
<7> [100.133296] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:267:pipe B] min cdclk: 256910 kHz -> 0 kHz
<7> [100.133797] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Can change cdclk via squashing
<7> [100.134336] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 172800 kHz, actual 172800 kHz
<7> [100.134872] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [100.135278] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:267:pipe B] enable: no [modeset]
<7> [100.135501] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:151:plane 1B] fb: [NOFB], visible: no
<7> [100.135720] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:181:plane 2B] fb: [NOFB], visible: no
<7> [100.135956] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:211:plane 3B] fb: [NOFB], visible: no
<7> [100.136172] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:241:plane 4B] fb: [NOFB], visible: no
<7> [100.136395] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:251:plane 5B] fb: [NOFB], visible: no
<7> [100.136608] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:261:cursor B] fb: [NOFB], visible: no
<7> [100.136852] i915 0000:00:02.0: [drm:intel_edp_backlight_off [i915]]
<7> [100.341067] i915 0000:00:02.0: [drm:intel_backlight_set_pwm_level [i915]] [CONNECTOR:506:eDP-1] set backlight PWM = 0
<7> [100.341839] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe B
<7> [100.345405] i915 0000:00:02.0: [drm:intel_pps_off_unlocked [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 turn panel power off
<7> [100.345750] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x00000089, pins 0x00000010, long 0x00000000
<7> [100.346012] i915 0000:00:02.0: [drm:intel_pps_off_unlocked [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [100.346310] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:505:DDI A/PHY A] - short
<7> [100.346493] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [100.396962] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [100.397494] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x2, on? 1) for [CRTC:267:pipe B]
<7> [100.397639] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring short hpd on eDP [ENCODER:505:DDI A/PHY A]
<7> [100.398476] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x0000008a, pins 0x00000010, long 0x00000010
<7> [100.399025] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:505:DDI A/PHY A] - long
<7> [100.399090] i915 0000:00:02.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0
<7> [100.399534] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [100.399760] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling AUX_A
<7> [100.400132] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring long hpd on eDP [ENCODER:505:DDI A/PHY A]
<7> [100.400384] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:505:DDI A/PHY A]
<7> [100.400947] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:514:DDI B/PHY B]
<7> [100.401356] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:516:DP-MST A]
<7> [100.401771] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:517:DP-MST B]
<7> [100.402180] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:518:DP-MST C]
<7> [100.402622] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:519:DP-MST D]
<7> [100.403030] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:532:DDI TC1/PHY TC1]
<7> [100.403198] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:534:DP-MST A]
<7> [100.403480] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:535:DP-MST B]
<7> [100.403757] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:536:DP-MST C]
<7> [100.404032] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:537:DP-MST D]
<7> [100.404255] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:541:DDI TC2/PHY TC2]
<7> [100.404413] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:545:DDI TC3/PHY TC3]
<7> [100.404572] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:547:DP-MST A]
<7> [100.404723] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:548:DP-MST B]
<7> [100.404847] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:549:DP-MST C]
<7> [100.404970] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:550:DP-MST D]
<7> [100.405095] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:554:DDI TC4/PHY TC4]
<7> [100.405220] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:556:DP-MST A]
<7> [100.405345] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:557:DP-MST B]
<7> [100.405469] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:558:DP-MST C]
<7> [100.405592] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:559:DP-MST D]
<7> [100.405732] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:506:eDP-1]
<7> [100.405945] i915 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [i915]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [100.406102] i915 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [i915]] Changing mbus joined: yes -> no (pipe: *)
<7> [100.406236] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [100.406490] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_B
<7> [100.406681] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_2
<7> [100.406877] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:267:pipe B]
<7> [100.407068] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Post changing CDCLK to 172800 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [100.407249] i915 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [i915]] aud_ts_cdclk set to M=60, N=432
<6> [100.407963] [IGT] kms_setmode: finished subtest basic, FAIL
<6> [100.408665] [IGT] kms_setmode: exiting, ret=98
<7> [100.409192] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [100.425752] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [100.425934] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [100.426077] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [100.426267] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on
<7> [100.475578] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:506:eDP-1] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [100.476216] i915 0000:00:02.0: [drm:intel_dp_compute_config_limits [i915]] [ENCODER:505:DDI A/PHY A][CRTC:149:pipe A] DP link limits: pixel clock 513820 kHz DSC off max lanes 4 max rate 540000 max pipe_bpp 30 max link_bpp 30.0000
<7> [100.476720] i915 0000:00:02.0: [drm:intel_dp_compute_link_config [i915]] DP lane count 4 clock 540000 bpp input 30 compressed 0.0000 link rate required 1926825 available 2160000
<7> [100.477194] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:149:pipe A] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [100.477675] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:505:DDI A/PHY A] [CRTC:149:pipe A]
<7> [100.478071] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [100.478490] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [100.478813] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [100.479013] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [100.479208] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 7483046/8388608 link 498869/524288)
<7> [100.479407] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [100.479602] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [100.479900] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [100.480140] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [100.480337] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [100.480496] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [100.480633] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [100.480776] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [100.480904] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [100.481033] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1801)
<7> [100.481162] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [100.481289] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [100.481416] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1878)
<7> [100.481542] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1878)
<7> [100.481675] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [100.481803] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [100.481928] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [100.482053] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [100.482179] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [100.482305] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [100.482430] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [100.482566] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1801)
<7> [100.482703] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [100.482834] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [100.482965] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1878)
<7> [100.483093] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1878)
<7> [100.483221] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [100.483350] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [100.483478] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [100.483606] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in enhanced_framing (expected no, found yes)
<7> [100.483745] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [100.483874] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 513820)
<7> [100.484002] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 513820)
<7> [100.484149] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in port_clock (expected 0, found 540000)
<7> [100.484283] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:149:pipe A] fastset requirement not met in set_context_latency (expected 0, found 1)
<7> [100.484411] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:149:pipe A] fastset requirement not met, forcing full modeset
<7> [100.484581] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [100.484716] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:149:pipe A] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x1
<7> [100.484845] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:33:plane 1A] ddb ( 0 - 0) -> ( 0 - 4001), size 0 -> 4001
<7> [100.484970] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:143:cursor A] ddb ( 0 - 0) -> (4001 - 4096), size 0 -> 95
<7> [100.485092] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33: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> [100.485215] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 2, 16, 16, 19, 19, 28, 0, 0, 0, 3, 0
<7> [100.485338] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 49, 385, 385, 457, 457, 673, 0, 0, 63, 73, 87
<7> [100.485460] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:33:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 55, 425, 425, 504, 504, 742, 0, 0, 64, 82, 88
<7> [100.485596] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:149:pipe A] data rate 2055280 num active planes 1
<7> [100.485741] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 28913 required 2159 qgv_peak_bw: 51200
<7> [100.485877] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 1: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [100.486009] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 2: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [100.486140] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 3: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [100.486270] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] Matching peaks QGV bw: 51200 for required data rate: 2159
<7> [100.486403] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:149:pipe A] min cdclk: 0 kHz -> 256910 kHz
<7> [100.486547] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] Can change cdclk via squashing
<7> [100.486687] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New cdclk calculated to be logical 307200 kHz, actual 307200 kHz
<7> [100.486820] i915 0000:00:02.0: [drm:intel_cdclk_atomic_check [i915]] New voltage level calculated to be logical 0, actual 0
<7> [100.486969] i915 0000:00:02.0: [drm:intel_find_dpll [i915]] [CRTC:149:pipe A] allocated DPLL 0
<7> [100.487118] i915 0000:00:02.0: [drm:intel_dpll_crtc_get [i915]] [CRTC:149:pipe A] reserving DPLL 0
<7> [100.487255] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:149:pipe A] enable: yes [modeset]
<7> [100.487391] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [100.487525] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 30, dithering: 0
<7> [100.487666] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [100.487797] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [100.487930] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [100.488062] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [100.488195] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dp m_n: lanes: 4; data_m: 7483046, data_n: 8388608, link_m: 498869, link_n: 524288, tu: 64
<7> [100.488328] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [100.488461] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] fec: disabled, enhanced framing: enabled
<7> [100.488594] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sdp split: disabled
<7> [100.488737] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [100.488872] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] minimum HBlank: 0
<7> [100.489004] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [100.489136] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] DP SDP: VSC, revision 4, length 14
<7> [100.489268] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pixelformat: RGB
<7> [100.489398] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] colorimetry: sRGB
<7> [100.489529] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] bpc: 0
<7> [100.489664] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dynamic range: VESA range
<7> [100.489794] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] content type: Not defined
<7> [100.489940] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 1
<7> [100.490070] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] framestart delay: 1, MSA timing delay: 0, set context latency: 1
<7> [100.490200] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, fixed rr: yes, vmin: 1878, vmax: 1878, flipline: 1878, pipeline full: 0, guardband: 76 vsync start: 75, vsync end: 69
<7> [100.490329] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1802, vmax vblank: 1802, vmin vtotal: 1878, vmax vtotal: 1878
<7> [100.490458] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "2880x1800": 90 513820 2880 2928 2960 3040 1800 1803 1809 1878 0x48 0xa
<7> [100.490588] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "2880x1800": 90 513820 2880 2928 2960 3040 1800 1803 1809 1878 0x48 0xa
<7> [100.490794] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=513820, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1801-1878 vs=1803-1809 vt=1878, flags=0xa
<7> [100.490930] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "2880x1800": 90 513820 2880 2928 2960 3040 1800 1803 1809 1878 0x40 0xa
<7> [100.491064] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=513820, hd=2880 hb=2880-3040 hs=2928-2960 ht=3040, vd=1800 vb=1801-1878 vs=1803-1809 vt=1878, flags=0xa
<7> [100.491196] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 540000, pipe src: 2880x1800+0+0, pixel rate 513820, min cdclk 256910
<7> [100.491327] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 48, ips linetime: 0
<7> [100.491458] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [100.491591] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [100.491737] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [100.491873] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cx0pll_hw_state: lane_count: 4, ssc_enabled: no, use_c10: yes, tbt_mode: no
<7> [100.492006] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] c10pll_hw_state: clock: 540000, fracen: yes,
<7> [100.492137] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] quot: 40960, rem: 0, den: 1,
<7> [100.492268] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] multiplier: 140, tx_clk_div: 0.
<7> [100.492398] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] c10pll_rawhw_state:
<7> [100.492528] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] tx: 0x10, cmn: 0x21
<7> [100.492670] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pll[0] = 0xf4, pll[1] = 0x0, pll[2] = 0xf8, pll[3] = 0x0
<7> [100.492822] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pll[4] = 0x0, pll[5] = 0x0, pll[6] = 0x0, pll[7] = 0x0
<7> [100.492953] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pll[8] = 0x0, pll[9] = 0x1, pll[10] = 0x0, pll[11] = 0x0
<7> [100.493082] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pll[12] = 0xa0, pll[13] = 0x0, pll[14] = 0x0, pll[15] = 0x0
<7> [100.493211] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pll[16] = 0x84, pll[17] = 0x4f, pll[18] = 0xe5, pll[19] = 0x23
<7> [100.493339] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [100.493468] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [100.493599] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [100.493739] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [100.493872] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [100.494003] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [100.494134] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [100.494264] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [100.494393] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [100.494523] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [100.494657] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [100.494787] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [100.494918] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sharpness strength: 0, sharpness tap size: 0, sharpness enable: 0
<7> [100.495050] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:33:plane 1A] fb: [FB:564] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [100.495184] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [100.495315] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [100.495462] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 2A] fb: [NOFB], visible: no
<7> [100.495591] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:93:plane 3A] fb: [NOFB], visible: no
<7> [100.495729] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:123:plane 4A] fb: [NOFB], visible: no
<7> [100.495858] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:133:plane 5A] fb: [NOFB], visible: no
<7> [100.495986] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:143:cursor A] fb: [NOFB], visible: no
<7> [100.497367] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on
<7> [100.497963] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [100.498647] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [100.499490] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_A
<7> [100.500220] i915 0000:00:02.0: [drm:intel_set_cdclk [i915]] Pre changing CDCLK to 307200 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [100.500406] i915 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [i915]] aud_ts_cdclk set to M=60, N=768
<7> [100.500547] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:505:DDI A/PHY A]
<7> [100.500693] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:514:DDI B/PHY B]
<7> [100.500824] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:516:DP-MST A]
<7> [100.500954] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:517:DP-MST B]
<7> [100.501085] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:518:DP-MST C]
<7> [100.501214] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:519:DP-MST D]
<7> [100.501345] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:532:DDI TC1/PHY TC1]
<7> [100.501477] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:534:DP-MST A]
<7> [100.501607] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:535:DP-MST B]
<7> [100.501743] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:536:DP-MST C]
<7> [100.501871] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:537:DP-MST D]
<7> [100.501997] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:541:DDI TC2/PHY TC2]
<7> [100.502124] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:545:DDI TC3/PHY TC3]
<7> [100.502251] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:547:DP-MST A]
<7> [100.502380] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:548:DP-MST B]
<7> [100.502508] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:549:DP-MST C]
<7> [100.502634] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:550:DP-MST D]
<7> [100.502775] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:554:DDI TC4/PHY TC4]
<7> [100.502900] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:556:DP-MST A]
<7> [100.503024] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:557:DP-MST B]
<7> [100.503149] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:558:DP-MST C]
<7> [100.503272] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:559:DP-MST D]
<7> [100.503425] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0xf
<7> [100.503661] i915 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [i915]] Changing mbus joined: no -> yes (pipe: *)
<7> [100.503798] i915 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [i915]] Updating dbuf ratio to 4 (mbus joined: yes)
<7> [100.503995] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling AUX_A
<7> [100.505376] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enable DPLL 0 (active 0x1, on? 0) for [CRTC:149:pipe A]
<7> [100.505540] i915 0000:00:02.0: [drm:intel_dpll_enable [i915]] enabling DPLL 0
<7> [100.506949] i915 0000:00:02.0: [drm:intel_pps_on_unlocked [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 turn panel power on
<7> [100.507103] i915 0000:00:02.0: [drm:wait_panel_power_cycle [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 wait for panel power cycle (391 ms remaining)
<7> [100.900955] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [100.951975] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [100.952628] i915 0000:00:02.0: [drm:intel_pps_on_unlocked [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 wait for panel power on
<7> [100.953175] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [100.984579] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x0000008a, pins 0x00000010, long 0x00000010
<7> [100.985147] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:505:DDI A/PHY A] - long
<7> [100.985664] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [100.986260] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring long hpd on eDP [ENCODER:505:DDI A/PHY A]
<7> [101.162322] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [101.163557] i915 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 turning VDD on
<7> [101.164491] i915 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [i915]] [ENCODER:505:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [101.168369] i915 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX A/DDI A/PHY A: DPCD: 14 14 c4 41 00 00 01 c0 02 00 00 00 00 0b 80
<7> [101.169309] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [101.169973] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 07
<7> [101.172632] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [101.174125] i915 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [101.175166] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] Clock recovery OK
<7> [101.175378] i915 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] Using DP training pattern TPS3
<7> [101.176728] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [101.176862] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:506:eDP-1][ENCODER:505:DDI A/PHY A][DPRX] Link Training passed at link rate = 540000, lane count = 4
<7> [101.177540] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [101.177816] i915 0000:00:02.0: [drm:intel_edp_backlight_on [i915]]
<7> [101.177955] i915 0000:00:02.0: [drm:intel_backlight_enable [i915]] pipe A
<7> [101.178143] i915 0000:00:02.0: [drm:intel_backlight_set_pwm_level [i915]] [CONNECTOR:506:eDP-1] set backlight PWM = 13892
<7> [101.188989] i915 0000:00:02.0: [drm:intel_psr_post_plane_update [i915]] Enabling PSR2
<7> [101.190488] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:506:eDP-1]
<7> [101.190697] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:149:pipe A]
<7> [101.193120] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0
<6> [101.200217] Console: switching to colour frame buffer device 180x56
|