Result:
integration-manifest git-log-oneline i915_display_info9 igt_runner9 runtimes9 results9.json results9-i915-load.json i915_display_info_post_exec9 boot9 dmesg9
| Detail | Value |
|---|---|
| Duration | 5.14 seconds |
| Hostname |
shard-mtlp-5 |
| Igt-Version |
IGT-Version: 2.1-g87027eb34 (x86_64) (Linux: 6.17.0-rc2-CI_DRM_17043-g16e133c7e692+ x86_64) |
| Out |
Using IGT_SRANDOM=1755786746 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[88] [Pipe A] Mode: 2880x1800@90Hz Connectors: eDP-1[262]
Expected frametime: 11111us; measured 11111.3us +- 1.977us accuracy 0.00% [0.09 scanlines]
Dynamic subtest pipe-A-eDP-1: SUCCESS (2.074s)
Starting dynamic subtest: pipe-B-eDP-1
Test id#2 CRTC count 1
CRTC[145] [Pipe B] Mode: 2880x1800@90Hz Connectors: eDP-1[262]
Expected frametime: 11111us; measured 11111.3us +- 2.434us accuracy 0.01% [0.11 scanlines]
Dynamic subtest pipe-B-eDP-1: SUCCESS (2.094s)
Testing: basic 2 connector combinations
Subtest basic: SUCCESS (5.145s)
|
| Err |
Starting subtest: basic Starting dynamic subtest: pipe-A-eDP-1 Dynamic subtest pipe-A-eDP-1: SUCCESS (2.074s) Starting dynamic subtest: pipe-B-eDP-1 Dynamic subtest pipe-B-eDP-1: SUCCESS (2.094s) Subtest basic: SUCCESS (5.145s) |
| Dmesg |
<6> [269.138805] Console: switching to colour dummy device 80x25
<6> [269.139034] [IGT] kms_setmode: executing
<7> [269.142531] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [269.143626] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [269.160330] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<6> [269.162234] [IGT] kms_setmode: starting subtest basic
<7> [269.162507] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:88:pipe A]
<7> [269.162694] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [269.163265] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [269.163792] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [269.164159] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [269.164494] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88: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> [269.164824] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [269.165120] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [269.165298] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [269.165462] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [269.165624] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [269.165785] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [269.165947] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [269.166107] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [269.166280] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [269.166440] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1801, found 0)
<7> [269.166595] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [269.166730] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [269.166867] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1878, found 0)
<7> [269.167006] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1878, found 0)
<7> [269.167147] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [269.167285] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [269.167422] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [269.167560] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [269.167699] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [269.167836] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [269.167973] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [269.168109] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1801, found 0)
<7> [269.168277] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [269.168418] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [269.168557] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1878, found 0)
<7> [269.168695] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1878, found 0)
<7> [269.168830] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [269.168964] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [269.169098] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [269.169239] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in enhanced_framing (expected yes, found no)
<7> [269.169374] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [269.169508] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 513820, found 0)
<7> [269.169642] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 513820, found 0)
<7> [269.169776] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in port_clock (expected 540000, found 0)
<7> [269.169912] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:88:pipe A] fastset requirement not met, forcing full modeset
<7> [269.170080] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [269.170219] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:88:pipe A] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [269.170368] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:33:plane 1A] ddb ( 0 - 4001) -> ( 0 - 0), size 4001 -> 0
<7> [269.170499] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:83:cursor A] ddb (4001 - 4096) -> ( 0 - 0), size 95 -> 0
<7> [269.170627] 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> [269.170755] 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> [269.170883] 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> [269.171010] 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> [269.171155] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:88:pipe A] data rate 0 num active planes 0
<7> [269.171299] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 28913 required 0 qgv_peak_bw: 51200
<7> [269.171444] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 1: max bw 38000 required 0 qgv_peak_bw: 51200
<7> [269.171586] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 51200
<7> [269.171729] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 51200
<7> [269.171867] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] Matching peaks QGV bw: 51200 for required data rate: 0
<7> [269.172021] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] Can change cdclk via squashing
<7> [269.172185] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 172800 kHz, actual 172800 kHz
<7> [269.172327] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [269.172486] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:88:pipe A] enable: no [modeset]
<7> [269.172625] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:33:plane 1A] fb: [NOFB], visible: no
<7> [269.172760] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [269.172893] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [269.173025] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [269.173165] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [269.173297] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:83:cursor A] fb: [NOFB], visible: no
<7> [269.173474] i915 0000:00:02.0: [drm:intel_psr_disable_locked [i915]] Disabling PSR2
<7> [269.174399] i915 0000:00:02.0: [drm:intel_edp_backlight_off [i915]]
<7> [269.380455] i915 0000:00:02.0: [drm:intel_backlight_set_pwm_level [i915]] [CONNECTOR:262:eDP-1] set backlight PWM = 0
<7> [269.381437] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [269.385794] i915 0000:00:02.0: [drm:intel_pps_off_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 turn panel power off
<7> [269.386093] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x00000089, pins 0x00000010, long 0x00000000
<7> [269.386381] i915 0000:00:02.0: [drm:intel_pps_off_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [269.386638] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:261:DDI A/PHY A] - short
<7> [269.386942] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [269.437379] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [269.437961] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring short hpd on eDP [ENCODER:261:DDI A/PHY A]
<7> [269.438024] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling AUX_A
<7> [269.438678] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:261:DDI A/PHY A]
<7> [269.438882] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x0000008a, pins 0x00000010, long 0x00000010
<7> [269.439235] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:270:DDI B/PHY B]
<7> [269.439420] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:261:DDI A/PHY A] - long
<7> [269.439705] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:272:DP-MST A]
<7> [269.439909] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [269.440156] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:273:DP-MST B]
<7> [269.440401] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring long hpd on eDP [ENCODER:261:DDI A/PHY A]
<7> [269.440621] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:274:DP-MST C]
<7> [269.440912] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:275:DP-MST D]
<7> [269.441190] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:288:DDI TC1/PHY TC1]
<7> [269.441459] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:290:DP-MST A]
<7> [269.441731] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:291:DP-MST B]
<7> [269.441980] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:292:DP-MST C]
<7> [269.442361] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:293:DP-MST D]
<7> [269.442740] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:297:DDI TC2/PHY TC2]
<7> [269.442991] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:301:DDI TC3/PHY TC3]
<7> [269.443200] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:303:DP-MST A]
<7> [269.443350] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:304:DP-MST B]
<7> [269.443524] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:305:DP-MST C]
<7> [269.443660] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:306:DP-MST D]
<7> [269.443789] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:310:DDI TC4/PHY TC4]
<7> [269.443919] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:312:DP-MST A]
<7> [269.444049] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:313:DP-MST B]
<7> [269.444218] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:314:DP-MST C]
<7> [269.444347] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:315:DP-MST D]
<7> [269.444498] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:262:eDP-1]
<7> [269.444715] i915 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [i915]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [269.444865] i915 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [i915]] Changing mbus joined: yes -> no (pipe: *)
<7> [269.445001] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [269.445238] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_A
<7> [269.445441] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:88:pipe A]
<7> [269.445629] 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> [269.445803] i915 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [i915]] aud_ts_cdclk set to M=60, N=432
<7> [269.446118] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:145:pipe B]
<7> [269.446251] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:202:pipe C]
<7> [269.446357] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:259:pipe D]
<7> [269.446744] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:263]
<7> [269.449528] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [269.449919] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [269.464408] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [269.464684] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [269.464904] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [269.477183] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [269.477424] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<6> [269.484847] [IGT] kms_setmode: starting dynamic subtest pipe-A-eDP-1
<7> [269.485050] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:319]
<7> [269.487365] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [269.487619] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [269.507964] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [269.508402] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [269.521313] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [269.522054] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [269.533171] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [269.533425] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [269.540843] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:88:pipe A]
<7> [269.540944] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:262:eDP-1]
<7> [269.541053] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:262:eDP-1] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [269.541278] i915 0000:00:02.0: [drm:intel_dp_compute_config_limits [i915]] [ENCODER:261:DDI A/PHY A][CRTC:88: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> [269.541523] 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> [269.541774] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:88:pipe A] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [269.541982] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:261:DDI A/PHY A] [CRTC:88:pipe A]
<7> [269.542193] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [269.542398] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [269.542602] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [269.542804] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [269.543003] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88: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> [269.543223] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [269.543425] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [269.543626] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [269.543823] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [269.544021] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [269.544235] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [269.544432] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [269.544632] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [269.544831] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [269.545028] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1801)
<7> [269.545236] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [269.545432] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [269.545628] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1878)
<7> [269.545825] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1878)
<7> [269.546022] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [269.546228] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [269.546424] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [269.546617] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [269.546811] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [269.547006] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [269.547230] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [269.547428] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1801)
<7> [269.547623] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [269.547817] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [269.548011] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1878)
<7> [269.548237] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1878)
<7> [269.548433] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [269.548629] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [269.548824] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [269.549019] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in enhanced_framing (expected no, found yes)
<7> [269.549239] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [269.549436] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 513820)
<7> [269.549632] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 513820)
<7> [269.549828] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in port_clock (expected 0, found 540000)
<7> [269.550023] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:88:pipe A] fastset requirement not met, forcing full modeset
<7> [269.550320] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [269.550553] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:88:pipe A] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x1
<7> [269.550800] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:33:plane 1A] ddb ( 0 - 0) -> ( 0 - 4001), size 0 -> 4001
<7> [269.551005] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:83:cursor A] ddb ( 0 - 0) -> (4001 - 4096), size 0 -> 95
<7> [269.551218] 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> [269.551417] 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> [269.551615] 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> [269.551809] 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> [269.552074] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:88:pipe A] data rate 2055280 num active planes 1
<7> [269.552650] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 28913 required 2159 qgv_peak_bw: 51200
<7> [269.553186] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 1: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [269.553753] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 2: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [269.554241] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 3: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [269.554699] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] Matching peaks QGV bw: 51200 for required data rate: 2159
<7> [269.554989] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:33:plane 1A] min cdclk (256910 kHz) > [CRTC:88:pipe A] min cdclk (0 kHz)
<7> [269.555276] i915 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [i915]] new bandwidth min cdclk (40143 kHz) > old min cdclk (0 kHz)
<7> [269.555574] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] Can change cdclk via squashing
<7> [269.555881] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 307200 kHz, actual 307200 kHz
<7> [269.556162] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [269.556348] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:88:pipe A] enable: yes [modeset]
<7> [269.556505] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [269.556654] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 30, dithering: 0
<7> [269.556797] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [269.556933] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [269.557069] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [269.557234] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [269.557370] 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> [269.557505] 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> [269.557640] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] fec: disabled, enhanced framing: enabled
<7> [269.557772] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sdp split: disabled
<7> [269.557954] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [269.558150] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] minimum HBlank: 0
<7> [269.558338] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [269.558496] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] DP SDP: VSC, revision 4, length 14
<7> [269.558632] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pixelformat: RGB
<7> [269.558763] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] colorimetry: sRGB
<7> [269.558892] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] bpc: 0
<7> [269.559021] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dynamic range: VESA range
<7> [269.559159] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] content type: Not defined
<7> [269.559289] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 1
<7> [269.559417] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vblank delay: 1, framestart delay: 1, MSA timing delay: 0
<7> [269.559546] 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: 77 vsync start: 75, vsync end: 69
<7> [269.559675] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1801, vmax vblank: 1801, vmin vtotal: 1878, vmax vtotal: 1878
<7> [269.559803] 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> [269.559935] 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> [269.560066] 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> [269.560206] 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> [269.560337] 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> [269.560470] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 540000, pipe src: 2880x1800+0+0, pixel rate 513820
<7> [269.560601] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 48, ips linetime: 0
<7> [269.560729] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [269.560896] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [269.561079] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [269.561277] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x83d60, dpll_md: 0xf42110, fp0: 0xf8, fp1: 0x1000000
<7> [269.561457] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [269.561594] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [269.561728] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [269.561856] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [269.561986] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [269.562112] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [269.562251] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [269.562379] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [269.562504] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [269.562628] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [269.562753] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [269.562877] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [269.563002] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:33:plane 1A] fb: [FB:319] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [269.563147] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [269.563282] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [269.563414] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [269.563544] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [269.563670] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [269.563796] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [269.563942] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:83:cursor A] fb: [NOFB], visible: no
<7> [269.566615] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [269.567093] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [269.567755] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_A
<7> [269.568082] 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> [269.568394] i915 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [i915]] aud_ts_cdclk set to M=60, N=768
<7> [269.568622] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:261:DDI A/PHY A]
<7> [269.568839] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:270:DDI B/PHY B]
<7> [269.569053] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:272:DP-MST A]
<7> [269.569282] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:273:DP-MST B]
<7> [269.569497] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:274:DP-MST C]
<7> [269.569792] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:275:DP-MST D]
<7> [269.569934] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:288:DDI TC1/PHY TC1]
<7> [269.570073] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:290:DP-MST A]
<7> [269.570215] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:291:DP-MST B]
<7> [269.570348] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:292:DP-MST C]
<7> [269.570486] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:293:DP-MST D]
<7> [269.570622] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:297:DDI TC2/PHY TC2]
<7> [269.570754] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:301:DDI TC3/PHY TC3]
<7> [269.570884] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:303:DP-MST A]
<7> [269.571013] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:304:DP-MST B]
<7> [269.571151] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:305:DP-MST C]
<7> [269.571279] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:306:DP-MST D]
<7> [269.571409] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:310:DDI TC4/PHY TC4]
<7> [269.571540] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:312:DP-MST A]
<7> [269.571671] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:313:DP-MST B]
<7> [269.571798] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:314:DP-MST C]
<7> [269.571931] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:315:DP-MST D]
<7> [269.572202] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0xf
<7> [269.572504] i915 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [i915]] Changing mbus joined: no -> yes (pipe: *)
<7> [269.572675] i915 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [i915]] Updating dbuf ratio to 4 (mbus joined: yes)
<7> [269.572891] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling AUX_A
<7> [269.574276] i915 0000:00:02.0: [drm:intel_pps_on_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 turn panel power on
<7> [269.574563] i915 0000:00:02.0: [drm:wait_panel_power_cycle [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 wait for panel power cycle (364 ms remaining)
<7> [269.940555] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [269.980522] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [269.981088] i915 0000:00:02.0: [drm:intel_pps_on_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 wait for panel power on
<7> [269.981674] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [270.013084] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x0000008a, pins 0x00000010, long 0x00000010
<7> [270.013640] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:261:DDI A/PHY A] - long
<7> [270.014138] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [270.014754] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring long hpd on eDP [ENCODER:261:DDI A/PHY A]
<7> [270.189965] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [270.192429] i915 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 turning VDD on
<7> [270.192992] i915 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [270.196050] 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> [270.196903] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [270.197657] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 07
<7> [270.198675] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [270.199357] i915 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [270.200293] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Clock recovery OK
<7> [270.200434] i915 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Using DP training pattern TPS3
<7> [270.202069] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [270.202566] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Link Training passed at link rate = 540000, lane count = 4
<7> [270.203405] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [270.203646] i915 0000:00:02.0: [drm:intel_edp_backlight_on [i915]]
<7> [270.203765] i915 0000:00:02.0: [drm:intel_backlight_enable [i915]] pipe A
<7> [270.203938] i915 0000:00:02.0: [drm:intel_backlight_set_pwm_level [i915]] [CONNECTOR:262:eDP-1] set backlight PWM = 13892
<7> [270.214822] i915 0000:00:02.0: [drm:intel_psr_post_plane_update [i915]] Enabling PSR2
<7> [270.216711] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:262:eDP-1]
<7> [270.216912] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:88:pipe A]
<6> [271.559603] [IGT] kms_setmode: finished subtest pipe-A-eDP-1, SUCCESS
<7> [271.559700] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:319] from all active usage due to RMFB ioctl
<7> [271.559744] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:33:plane 1A] because [FB:319] is removed
<7> [271.559798] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:33:plane 1A] ddb ( 0 - 4001) -> ( 0 - 0), size 4001 -> 0
<7> [271.560021] 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> [271.560233] 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> [271.560425] 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> [271.560612] 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> [271.560820] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:88:pipe A] data rate 0 num active planes 0
<7> [271.561053] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 28913 required 0 qgv_peak_bw: 51200
<7> [271.561281] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 1: max bw 38000 required 0 qgv_peak_bw: 51200
<7> [271.561482] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 51200
<7> [271.561702] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 51200
<7> [271.561996] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] Matching peaks QGV bw: 51200 for required data rate: 0
<7> [271.562240] i915 0000:00:02.0: [drm:intel_psr_disable_locked [i915]] Disabling PSR2
<7> [271.581603] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:88:pipe A]
<7> [271.581704] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [271.581989] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [271.582271] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [271.582535] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [271.582790] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88: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> [271.583010] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [271.583231] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [271.583428] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [271.583625] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [271.583820] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [271.584015] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [271.584235] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [271.584431] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [271.584626] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [271.584820] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1801, found 0)
<7> [271.585014] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [271.585222] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [271.585435] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1878, found 0)
<7> [271.585649] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1878, found 0)
<7> [271.585856] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [271.586063] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [271.586288] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [271.586499] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [271.586704] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [271.586908] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [271.587128] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [271.587334] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1801, found 0)
<7> [271.587541] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [271.587744] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [271.587949] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1878, found 0)
<7> [271.588167] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1878, found 0)
<7> [271.588365] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [271.588559] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [271.588771] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [271.588981] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in enhanced_framing (expected yes, found no)
<7> [271.589198] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [271.589409] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 513820, found 0)
<7> [271.589615] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 513820, found 0)
<7> [271.589821] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in port_clock (expected 540000, found 0)
<7> [271.590028] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:88:pipe A] fastset requirement not met, forcing full modeset
<7> [271.590353] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [271.590831] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:88:pipe A] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x1 -> 0x0
<7> [271.591414] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:83:cursor A] ddb (4001 - 4096) -> ( 0 - 0), size 95 -> 0
<7> [271.591942] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] Can change cdclk via squashing
<7> [271.592451] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 172800 kHz, actual 172800 kHz
<7> [271.592934] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [271.593489] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:88:pipe A] enable: no [modeset]
<7> [271.593727] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:33:plane 1A] fb: [NOFB], visible: no
<7> [271.593959] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [271.594204] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [271.594432] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [271.594662] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [271.594887] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:83:cursor A] fb: [NOFB], visible: no
<7> [271.595257] i915 0000:00:02.0: [drm:intel_edp_backlight_off [i915]]
<7> [271.804372] i915 0000:00:02.0: [drm:intel_backlight_set_pwm_level [i915]] [CONNECTOR:262:eDP-1] set backlight PWM = 0
<7> [271.805173] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [271.815753] i915 0000:00:02.0: [drm:intel_pps_off_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 turn panel power off
<7> [271.816043] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x00000089, pins 0x00000010, long 0x00000000
<7> [271.816324] i915 0000:00:02.0: [drm:intel_pps_off_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [271.816619] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:261:DDI A/PHY A] - short
<7> [271.816805] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [271.867568] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [271.868282] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring short hpd on eDP [ENCODER:261:DDI A/PHY A]
<7> [271.868352] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling AUX_A
<7> [271.868837] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x0000008a, pins 0x00000010, long 0x00000010
<7> [271.869223] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:261:DDI A/PHY A]
<7> [271.869373] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:261:DDI A/PHY A] - long
<7> [271.869868] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [271.869918] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:270:DDI B/PHY B]
<7> [271.870356] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:272:DP-MST A]
<7> [271.870412] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring long hpd on eDP [ENCODER:261:DDI A/PHY A]
<7> [271.870743] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:273:DP-MST B]
<7> [271.871148] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:274:DP-MST C]
<7> [271.871559] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:275:DP-MST D]
<7> [271.871818] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:288:DDI TC1/PHY TC1]
<7> [271.871993] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:290:DP-MST A]
<7> [271.872197] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:291:DP-MST B]
<7> [271.872376] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:292:DP-MST C]
<7> [271.872593] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:293:DP-MST D]
<7> [271.872824] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:297:DDI TC2/PHY TC2]
<7> [271.873033] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:301:DDI TC3/PHY TC3]
<7> [271.873262] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:303:DP-MST A]
<7> [271.873445] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:304:DP-MST B]
<7> [271.873593] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:305:DP-MST C]
<7> [271.873736] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:306:DP-MST D]
<7> [271.873868] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:310:DDI TC4/PHY TC4]
<7> [271.873997] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:312:DP-MST A]
<7> [271.874148] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:313:DP-MST B]
<7> [271.874285] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:314:DP-MST C]
<7> [271.874415] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:315:DP-MST D]
<7> [271.874546] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:262:eDP-1]
<7> [271.874702] i915 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [i915]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [271.874847] i915 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [i915]] Changing mbus joined: yes -> no (pipe: *)
<7> [271.874976] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [271.875206] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_A
<7> [271.875405] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:88:pipe A]
<7> [271.875590] 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> [271.875756] i915 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [i915]] aud_ts_cdclk set to M=60, N=432
<7> [271.876047] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:88:pipe A]
<7> [271.876195] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:145:pipe B]
<7> [271.876286] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:202:pipe C]
<7> [271.876373] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:259:pipe D]
<7> [271.876682] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:319]
<7> [271.879405] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [271.879721] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [271.894162] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [271.894744] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [271.895283] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [271.898332] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [271.898584] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<6> [271.906221] [IGT] kms_setmode: starting dynamic subtest pipe-B-eDP-1
<7> [271.906409] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:322]
<7> [271.908721] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [271.908986] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [271.929094] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [271.929381] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [271.939891] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [271.940167] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [271.949996] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [271.950262] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [271.957335] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:145:pipe B]
<7> [271.957372] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:262:eDP-1]
<7> [271.957439] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:262:eDP-1] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [271.957606] i915 0000:00:02.0: [drm:intel_dp_compute_config_limits [i915]] [ENCODER:261:DDI A/PHY A][CRTC:145: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> [271.957741] 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> [271.957882] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:145:pipe B] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [271.958027] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:261:DDI A/PHY A] [CRTC:145:pipe B]
<7> [271.958173] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [271.958314] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [271.958455] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [271.958595] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [271.958739] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145: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> [271.958876] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [271.959007] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [271.959145] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [271.959278] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [271.959412] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [271.959541] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [271.959670] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [271.959799] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [271.959927] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [271.960055] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1801)
<7> [271.960194] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [271.960325] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [271.960453] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1878)
<7> [271.960585] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1878)
<7> [271.960711] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [271.960838] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [271.960963] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [271.961090] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [271.961228] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [271.961360] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [271.961485] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [271.961611] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1801)
<7> [271.961737] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [271.961864] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [271.961990] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1878)
<7> [271.962126] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1878)
<7> [271.962259] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [271.962385] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [271.962512] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [271.962638] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in enhanced_framing (expected no, found yes)
<7> [271.962764] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [271.962892] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 513820)
<7> [271.963016] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 513820)
<7> [271.963215] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in port_clock (expected 0, found 540000)
<7> [271.963347] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:145:pipe B] fastset requirement not met, forcing full modeset
<7> [271.963593] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [271.963724] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:145:pipe B] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x2
<7> [271.963871] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:90:plane 1B] ddb ( 0 - 0) -> ( 0 - 4001), size 0 -> 4001
<7> [271.963997] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:140:cursor B] ddb ( 0 - 0) -> (4001 - 4096), size 0 -> 95
<7> [271.964133] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:90: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> [271.964260] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:90: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> [271.964388] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:90: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> [271.964515] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:90: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> [271.964654] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:145:pipe B] data rate 2055280 num active planes 1
<7> [271.964792] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 28913 required 2159 qgv_peak_bw: 51200
<7> [271.964927] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 1: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [271.965060] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 2: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [271.965206] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 3: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [271.965340] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] Matching peaks QGV bw: 51200 for required data rate: 2159
<7> [271.965471] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:90:plane 1B] min cdclk (256910 kHz) > [CRTC:145:pipe B] min cdclk (0 kHz)
<7> [271.965603] i915 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [i915]] new bandwidth min cdclk (40143 kHz) > old min cdclk (0 kHz)
<7> [271.965739] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] Can change cdclk via squashing
<7> [271.965871] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 307200 kHz, actual 307200 kHz
<7> [271.966003] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [271.966166] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:145:pipe B] enable: yes [modeset]
<7> [271.966297] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [271.966424] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: B, pipe bpp: 30, dithering: 0
<7> [271.966550] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [271.966680] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [271.966810] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [271.966937] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [271.967063] 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> [271.967202] 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> [271.967333] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] fec: disabled, enhanced framing: enabled
<7> [271.967470] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sdp split: disabled
<7> [271.967605] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [271.967732] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] minimum HBlank: 0
<7> [271.967856] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [271.967981] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] DP SDP: VSC, revision 4, length 14
<7> [271.968116] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pixelformat: RGB
<7> [271.968241] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] colorimetry: sRGB
<7> [271.968366] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] bpc: 0
<7> [271.968492] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dynamic range: VESA range
<7> [271.968618] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] content type: Not defined
<7> [271.968742] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 1
<7> [271.968865] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vblank delay: 1, framestart delay: 1, MSA timing delay: 0
<7> [271.968989] 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: 77 vsync start: 75, vsync end: 69
<7> [271.969120] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1801, vmax vblank: 1801, vmin vtotal: 1878, vmax vtotal: 1878
<7> [271.969247] 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> [271.969378] 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> [271.969512] 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> [271.969642] 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> [271.969772] 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> [271.969896] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 540000, pipe src: 2880x1800+0+0, pixel rate 513820
<7> [271.970019] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 48, ips linetime: 0
<7> [271.970160] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [271.970289] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [271.970415] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [271.970541] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x83d60, dpll_md: 0xf42110, fp0: 0xf8, fp1: 0x1000000
<7> [271.970666] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [271.970791] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [271.970919] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [271.971049] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [271.971182] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [271.971309] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [271.971437] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [271.971564] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [271.971692] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [271.971823] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [271.971947] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [271.972071] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [271.972242] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:90:plane 1B] fb: [FB:322] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [271.972371] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [271.972498] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [271.972624] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:100:plane 2B] fb: [NOFB], visible: no
<7> [271.972750] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:110:plane 3B] fb: [NOFB], visible: no
<7> [271.972873] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:120:plane 4B] fb: [NOFB], visible: no
<7> [271.972997] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:130:plane 5B] fb: [NOFB], visible: no
<7> [271.973145] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:140:cursor B] fb: [NOFB], visible: no
<7> [271.975481] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [271.975798] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [271.976007] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_2
<7> [271.976204] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_B
<7> [271.976420] 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> [271.976599] i915 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [i915]] aud_ts_cdclk set to M=60, N=768
<7> [271.976734] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:261:DDI A/PHY A]
<7> [271.976864] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:270:DDI B/PHY B]
<7> [271.976991] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:272:DP-MST A]
<7> [271.977149] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:273:DP-MST B]
<7> [271.977272] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:274:DP-MST C]
<7> [271.977394] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:275:DP-MST D]
<7> [271.977516] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:288:DDI TC1/PHY TC1]
<7> [271.977647] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:290:DP-MST A]
<7> [271.977767] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:291:DP-MST B]
<7> [271.977890] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:292:DP-MST C]
<7> [271.978015] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:293:DP-MST D]
<7> [271.978153] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:297:DDI TC2/PHY TC2]
<7> [271.978280] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:301:DDI TC3/PHY TC3]
<7> [271.978403] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:303:DP-MST A]
<7> [271.978526] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:304:DP-MST B]
<7> [271.978649] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:305:DP-MST C]
<7> [271.978771] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:306:DP-MST D]
<7> [271.978893] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:310:DDI TC4/PHY TC4]
<7> [271.979015] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:312:DP-MST A]
<7> [271.979145] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:313:DP-MST B]
<7> [271.979268] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:314:DP-MST C]
<7> [271.979393] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:315:DP-MST D]
<7> [271.979517] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0xf
<7> [271.979750] i915 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [i915]] Changing mbus joined: no -> yes (pipe: *)
<7> [271.979882] i915 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [i915]] Updating dbuf ratio to 4 (mbus joined: yes)
<7> [271.980089] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling AUX_A
<7> [271.981168] i915 0000:00:02.0: [drm:intel_pps_on_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 turn panel power on
<7> [271.981417] i915 0000:00:02.0: [drm:wait_panel_power_cycle [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 wait for panel power cycle (387 ms remaining)
<7> [272.372541] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [272.423532] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [272.424086] i915 0000:00:02.0: [drm:intel_pps_on_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 wait for panel power on
<7> [272.424691] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [272.456022] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x0000008a, pins 0x00000010, long 0x00000010
<7> [272.456576] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:261:DDI A/PHY A] - long
<7> [272.457077] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [272.457662] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring long hpd on eDP [ENCODER:261:DDI A/PHY A]
<7> [272.631306] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [272.634025] i915 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 turning VDD on
<7> [272.634624] i915 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [272.637700] 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> [272.638607] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [272.639344] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 07
<7> [272.640385] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [272.641052] i915 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [272.641950] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Clock recovery OK
<7> [272.642069] i915 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Using DP training pattern TPS3
<7> [272.643347] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [272.643466] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Link Training passed at link rate = 540000, lane count = 4
<7> [272.644062] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe B
<7> [272.644322] i915 0000:00:02.0: [drm:intel_edp_backlight_on [i915]]
<7> [272.644470] i915 0000:00:02.0: [drm:intel_backlight_enable [i915]] pipe B
<7> [272.644659] i915 0000:00:02.0: [drm:intel_backlight_set_pwm_level [i915]] [CONNECTOR:262:eDP-1] set backlight PWM = 13892
<7> [272.655469] i915 0000:00:02.0: [drm:intel_psr_post_plane_update [i915]] Enabling PSR2
<7> [272.656989] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:262:eDP-1]
<7> [272.657223] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:145:pipe B]
<6> [274.000712] [IGT] kms_setmode: finished subtest pipe-B-eDP-1, SUCCESS
<7> [274.000895] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:322] from all active usage due to RMFB ioctl
<7> [274.000992] i915 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:90:plane 1B] because [FB:322] is removed
<7> [274.001120] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:90:plane 1B] ddb ( 0 - 4001) -> ( 0 - 0), size 4001 -> 0
<7> [274.001610] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:90: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> [274.002226] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:90: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> [274.002700] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:90: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> [274.003194] i915 0000:00:02.0: [drm:skl_print_plane_changes [i915]] [PLANE:90: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> [274.003501] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:145:pipe B] data rate 0 num active planes 0
<7> [274.003808] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 28913 required 0 qgv_peak_bw: 51200
<7> [274.004128] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 1: max bw 38000 required 0 qgv_peak_bw: 51200
<7> [274.004431] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 51200
<7> [274.004736] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 51200
<7> [274.004986] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] Matching peaks QGV bw: 51200 for required data rate: 0
<7> [274.005363] i915 0000:00:02.0: [drm:intel_psr_disable_locked [i915]] Disabling PSR2
<7> [274.022471] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:145:pipe B]
<7> [274.022666] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.enable (expected yes, found no)
<7> [274.023232] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.active (expected yes, found no)
<7> [274.023760] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [274.024321] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in lane_count (expected 4, found 0)
<7> [274.024818] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145: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> [274.025296] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [274.025584] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [274.025861] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [274.026162] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [274.026450] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [274.026681] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [274.026852] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [274.027012] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [274.027198] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [274.027367] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1801, found 0)
<7> [274.027526] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [274.027685] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [274.027849] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1878, found 0)
<7> [274.028006] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1878, found 0)
<7> [274.028154] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [274.028297] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [274.028433] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [274.028566] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)
<7> [274.028698] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2928, found 0)
<7> [274.028830] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2960, found 0)
<7> [274.028965] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1800, found 0)
<7> [274.029112] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1801, found 0)
<7> [274.029255] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1803, found 0)
<7> [274.029389] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1809, found 0)
<7> [274.029522] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1878, found 0)
<7> [274.029654] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1878, found 0)
<7> [274.029786] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [274.029920] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 2, found 0)
<7> [274.030055] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [274.030204] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in enhanced_framing (expected yes, found no)
<7> [274.030355] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in pipe_bpp (expected 30, found 0)
<7> [274.030490] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 513820, found 0)
<7> [274.030625] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 513820, found 0)
<7> [274.030759] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:145:pipe B] fastset requirement not met in port_clock (expected 540000, found 0)
<7> [274.030893] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:145:pipe B] fastset requirement not met, forcing full modeset
<7> [274.031062] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [274.031213] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:145:pipe B] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x2 -> 0x0
<7> [274.031371] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:140:cursor B] ddb (4001 - 4096) -> ( 0 - 0), size 95 -> 0
<7> [274.031518] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] Can change cdclk via squashing
<7> [274.031659] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 172800 kHz, actual 172800 kHz
<7> [274.031800] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [274.031955] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:145:pipe B] enable: no [modeset]
<7> [274.032115] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:90:plane 1B] fb: [NOFB], visible: no
<7> [274.032264] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:100:plane 2B] fb: [NOFB], visible: no
<7> [274.032402] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:110:plane 3B] fb: [NOFB], visible: no
<7> [274.032539] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:120:plane 4B] fb: [NOFB], visible: no
<7> [274.032674] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:130:plane 5B] fb: [NOFB], visible: no
<7> [274.032809] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:140:cursor B] fb: [NOFB], visible: no
<7> [274.033320] i915 0000:00:02.0: [drm:intel_edp_backlight_off [i915]]
<7> [274.236308] i915 0000:00:02.0: [drm:intel_backlight_set_pwm_level [i915]] [CONNECTOR:262:eDP-1] set backlight PWM = 0
<7> [274.237038] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe B
<7> [274.245717] i915 0000:00:02.0: [drm:intel_pps_off_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 turn panel power off
<7> [274.246058] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x00000089, pins 0x00000010, long 0x00000000
<7> [274.246277] i915 0000:00:02.0: [drm:intel_pps_off_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 wait for panel power off time
<7> [274.246605] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:261:DDI A/PHY A] - short
<7> [274.246807] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 mask: 0xb0000000 value: 0x00000000 PP_STATUS: 0xa0000002 PP_CONTROL: 0x00000060
<7> [274.297568] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [274.298332] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring short hpd on eDP [ENCODER:261:DDI A/PHY A]
<7> [274.298314] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling AUX_A
<7> [274.298635] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x0000008a, pins 0x00000010, long 0x00000010
<7> [274.298928] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:261:DDI A/PHY A]
<7> [274.299171] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:261:DDI A/PHY A] - long
<7> [274.299534] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:270:DDI B/PHY B]
<7> [274.299667] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 4 - cnt: 10
<7> [274.300032] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:272:DP-MST A]
<7> [274.300115] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring long hpd on eDP [ENCODER:261:DDI A/PHY A]
<7> [274.300541] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:273:DP-MST B]
<7> [274.301055] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:274:DP-MST C]
<7> [274.301563] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:275:DP-MST D]
<7> [274.301790] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:288:DDI TC1/PHY TC1]
<7> [274.302006] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:290:DP-MST A]
<7> [274.302263] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:291:DP-MST B]
<7> [274.302471] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:292:DP-MST C]
<7> [274.302678] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:293:DP-MST D]
<7> [274.302888] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:297:DDI TC2/PHY TC2]
<7> [274.303142] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:301:DDI TC3/PHY TC3]
<7> [274.303468] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:303:DP-MST A]
<7> [274.303808] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:304:DP-MST B]
<7> [274.303962] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:305:DP-MST C]
<7> [274.304117] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:306:DP-MST D]
<7> [274.304264] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:310:DDI TC4/PHY TC4]
<7> [274.304397] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:312:DP-MST A]
<7> [274.304528] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:313:DP-MST B]
<7> [274.304655] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:314:DP-MST C]
<7> [274.304785] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:315:DP-MST D]
<7> [274.304912] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:262:eDP-1]
<7> [274.305078] i915 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [i915]] Updating dbuf ratio to 2 (mbus joined: no)
<7> [274.305248] i915 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [i915]] Changing mbus joined: yes -> no (pipe: *)
<7> [274.305424] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1
<7> [274.305667] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_B
<7> [274.305856] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling PW_2
<7> [274.306041] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:145:pipe B]
<7> [274.306276] 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> [274.306472] i915 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [i915]] aud_ts_cdclk set to M=60, N=432
<6> [274.307292] [IGT] kms_setmode: finished subtest basic, SUCCESS
<6> [274.308013] [IGT] kms_setmode: exiting, ret=0
<7> [274.308536] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [274.324166] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [274.324749] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [274.325276] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [274.325813] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on
<7> [274.365976] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:262:eDP-1] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [274.366625] i915 0000:00:02.0: [drm:intel_dp_compute_config_limits [i915]] [ENCODER:261:DDI A/PHY A][CRTC:88: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> [274.367162] 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> [274.367648] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:88:pipe A] hw max bpp: 30, pipe bpp: 30, dithering: 0
<7> [274.368030] i915 0000:00:02.0: [drm:intel_ddi_compute_config_late [i915]] [ENCODER:261:DDI A/PHY A] [CRTC:88:pipe A]
<7> [274.368473] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [274.368822] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [274.369094] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [274.369269] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in lane_count (expected 0, found 4)
<7> [274.369441] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88: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> [274.369614] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000100)
<7> [274.369785] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [274.369953] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 2880)
<7> [274.370097] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 3040)
<7> [274.370235] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 2880)
<7> [274.370375] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 3040)
<7> [274.370512] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 2928)
<7> [274.370647] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 2960)
<7> [274.370782] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 1800)
<7> [274.370919] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 1801)
<7> [274.371054] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 1803)
<7> [274.371205] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 1809)
<7> [274.371343] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 1878)
<7> [274.371479] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 1878)
<7> [274.371613] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 2880)
<7> [274.371746] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 3040)
<7> [274.371885] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 2880)
<7> [274.372020] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 3040)
<7> [274.372169] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 2928)
<7> [274.372303] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 2960)
<7> [274.372436] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 1800)
<7> [274.372569] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 1801)
<7> [274.372703] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 1803)
<7> [274.372838] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 1809)
<7> [274.372973] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 1878)
<7> [274.373120] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 1878)
<7> [274.373257] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [274.373392] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [274.373527] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [274.373663] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in enhanced_framing (expected no, found yes)
<7> [274.373797] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 30)
<7> [274.373930] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 513820)
<7> [274.374062] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 513820)
<7> [274.374208] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:88:pipe A] fastset requirement not met in port_clock (expected 0, found 540000)
<7> [274.374345] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:88:pipe A] fastset requirement not met, forcing full modeset
<7> [274.374538] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [274.374673] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [CRTC:88:pipe A] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x1
<7> [274.374809] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:33:plane 1A] ddb ( 0 - 0) -> ( 0 - 4001), size 0 -> 4001
<7> [274.374939] i915 0000:00:02.0: [drm:skl_compute_wm [i915]] [PLANE:83:cursor A] ddb ( 0 - 0) -> (4001 - 4096), size 0 -> 95
<7> [274.375067] 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> [274.375216] 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> [274.375344] 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> [274.375472] 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> [274.375612] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] [CRTC:88:pipe A] data rate 2055280 num active planes 1
<7> [274.375754] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 28913 required 2159 qgv_peak_bw: 51200
<7> [274.375894] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 1: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [274.376032] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 2: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [274.376177] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] QGV point 3: max bw 38000 required 2159 qgv_peak_bw: 51200
<7> [274.376313] i915 0000:00:02.0: [drm:intel_bw_atomic_check [i915]] Matching peaks QGV bw: 51200 for required data rate: 2159
<7> [274.376447] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:33:plane 1A] min cdclk (256910 kHz) > [CRTC:88:pipe A] min cdclk (0 kHz)
<7> [274.376580] i915 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [i915]] new bandwidth min cdclk (40143 kHz) > old min cdclk (0 kHz)
<7> [274.376721] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] Can change cdclk via squashing
<7> [274.376858] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 307200 kHz, actual 307200 kHz
<7> [274.376995] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [274.377151] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:88:pipe A] enable: yes [modeset]
<7> [274.377291] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: EDP (0x100), output format: RGB, sink format: RGB
<7> [274.377431] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 30, dithering: 0
<7> [274.377568] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [274.377705] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [274.377842] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [274.377977] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [274.378123] 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> [274.378257] 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> [274.378391] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] fec: disabled, enhanced framing: enabled
<7> [274.378527] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] sdp split: disabled
<7> [274.378661] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] psr: enabled, selective update: enabled, panel replay: disabled, selective fetch: enabled
<7> [274.378794] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] minimum HBlank: 0
<7> [274.378927] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x4
<7> [274.379061] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] DP SDP: VSC, revision 4, length 14
<7> [274.379211] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pixelformat: RGB
<7> [274.379346] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] colorimetry: sRGB
<7> [274.379479] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] bpc: 0
<7> [274.379613] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dynamic range: VESA range
<7> [274.379745] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] content type: Not defined
<7> [274.379878] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 1
<7> [274.380010] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vblank delay: 1, framestart delay: 1, MSA timing delay: 0
<7> [274.380201] 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: 77 vsync start: 75, vsync end: 69
<7> [274.380338] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: 1801, vmax vblank: 1801, vmin vtotal: 1878, vmax vtotal: 1878
<7> [274.380473] 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> [274.380607] 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> [274.380740] 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> [274.380873] 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> [274.381009] 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> [274.381156] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 540000, pipe src: 2880x1800+0+0, pixel rate 513820
<7> [274.381290] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 48, ips linetime: 0
<7> [274.381422] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [274.381553] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [274.381685] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [274.381816] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x83d60, dpll_md: 0xf42110, fp0: 0xf8, fp1: 0x1000000
<7> [274.381950] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [274.382089] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [274.382222] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [274.382353] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [274.382484] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [274.382616] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [274.382747] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [274.382878] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [274.383008] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [274.383150] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [274.383283] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [274.383416] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [274.383548] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:33:plane 1A] fb: [FB:320] 2880x1800 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [274.383681] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [274.383811] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 2880.000000x1800.000000+0.000000+0.000000 dst: 2880x1800+0+0
<7> [274.383943] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:43:plane 2A] fb: [NOFB], visible: no
<7> [274.384079] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:53:plane 3A] fb: [NOFB], visible: no
<7> [274.384210] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:63:plane 4A] fb: [NOFB], visible: no
<7> [274.384343] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:73:plane 5A] fb: [NOFB], visible: no
<7> [274.384477] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:83:cursor A] fb: [NOFB], visible: no
<7> [274.384699] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on
<7> [274.384841] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [274.385143] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [274.385349] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_A
<7> [274.385568] 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> [274.385746] i915 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [i915]] aud_ts_cdclk set to M=60, N=768
<7> [274.385885] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:261:DDI A/PHY A]
<7> [274.386018] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:270:DDI B/PHY B]
<7> [274.386159] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:272:DP-MST A]
<7> [274.386288] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:273:DP-MST B]
<7> [274.386416] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:274:DP-MST C]
<7> [274.386545] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:275:DP-MST D]
<7> [274.386672] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:288:DDI TC1/PHY TC1]
<7> [274.386799] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:290:DP-MST A]
<7> [274.386926] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:291:DP-MST B]
<7> [274.387056] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:292:DP-MST C]
<7> [274.387200] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:293:DP-MST D]
<7> [274.387328] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:297:DDI TC2/PHY TC2]
<7> [274.387455] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:301:DDI TC3/PHY TC3]
<7> [274.387583] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:303:DP-MST A]
<7> [274.387711] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:304:DP-MST B]
<7> [274.387837] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:305:DP-MST C]
<7> [274.387966] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:306:DP-MST D]
<7> [274.388100] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:310:DDI TC4/PHY TC4]
<7> [274.388228] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:312:DP-MST A]
<7> [274.388353] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:313:DP-MST B]
<7> [274.388479] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:314:DP-MST C]
<7> [274.388606] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:315:DP-MST D]
<7> [274.388733] i915 0000:00:02.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0xf
<7> [274.388998] i915 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [i915]] Changing mbus joined: no -> yes (pipe: *)
<7> [274.389184] i915 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [i915]] Updating dbuf ratio to 4 (mbus joined: yes)
<7> [274.389424] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling AUX_A
<7> [274.390403] i915 0000:00:02.0: [drm:intel_pps_on_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 turn panel power on
<7> [274.390556] i915 0000:00:02.0: [drm:wait_panel_power_cycle [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 wait for panel power cycle (408 ms remaining)
<7> [274.804492] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 mask: 0xb800000f value: 0x00000000 PP_STATUS: 0x08000001 PP_CONTROL: 0x00000060
<7> [274.854454] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [274.855009] i915 0000:00:02.0: [drm:intel_pps_on_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 wait for panel power on
<7> [274.855615] i915 0000:00:02.0: [drm:wait_panel_status [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 mask: 0xb000000f value: 0x80000008 PP_STATUS: 0x9000000a PP_CONTROL: 0x00000063
<7> [274.886964] i915 0000:00:02.0: [drm:icp_irq_handler [i915]] hotplug event received, stat 0x00010000, dig 0x0000008a, pins 0x00000010, long 0x00000010
<7> [274.887515] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] digital hpd on [ENCODER:261:DDI A/PHY A] - long
<7> [274.888008] i915 0000:00:02.0: [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 4 - cnt: 20
<7> [274.888521] i915 0000:00:02.0: [drm:intel_dp_hpd_pulse [i915]] ignoring long hpd on eDP [ENCODER:261:DDI A/PHY A]
<7> [275.065230] i915 0000:00:02.0: [drm:wait_panel_status [i915]] Wait complete
<7> [275.067907] i915 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 turning VDD on
<7> [275.068569] i915 0000:00:02.0: [drm:intel_pps_vdd_on_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7> [275.072420] 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> [275.073540] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Reloading eDP link rates
<7> [275.074337] i915 0000:00:02.0: [drm:intel_dp_start_link_train [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Using LINK_RATE_SET value 07
<7> [275.075477] i915 0000:00:02.0: [drm:intel_dp_set_signal_levels [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [275.076192] i915 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Using DP training pattern TPS1
<7> [275.077104] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Clock recovery OK
<7> [275.077239] i915 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Using DP training pattern TPS3
<7> [275.078498] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Channel EQ done. DP Training successful
<7> [275.078623] i915 0000:00:02.0: [drm:intel_dp_link_train_phy [i915]] [CONNECTOR:262:eDP-1][ENCODER:261:DDI A/PHY A][DPRX] Link Training passed at link rate = 540000, lane count = 4
<7> [275.079250] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [275.079519] i915 0000:00:02.0: [drm:intel_edp_backlight_on [i915]]
<7> [275.079650] i915 0000:00:02.0: [drm:intel_backlight_enable [i915]] pipe A
<7> [275.079834] i915 0000:00:02.0: [drm:intel_backlight_set_pwm_level [i915]] [CONNECTOR:262:eDP-1] set backlight PWM = 13892
<7> [275.090777] i915 0000:00:02.0: [drm:intel_psr_post_plane_update [i915]] Enabling PSR2
<7> [275.092406] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:262:eDP-1]
<7> [275.092617] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:88:pipe A]
<7> [275.094783] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0
<6> [275.102128] Console: switching to colour frame buffer device 180x56
|