Results for igt@kms_sequence@queue-busy@pipe-b-dp-5

Result: Pass

boot-20250830-0526 dmesg-20250830-0526

DetailValue
Duration 5.17 seconds
Igt-Version
IGT-Version: 2.1-g8a840cd64 (x86_64) (Linux: 6.17.0-rc3-lgci-xe-xe-3643-99f4b32d88cb9718c+ x86_64)
Out
Starting dynamic subtest: pipe-B-DP-5
Beginning queue-busy on pipe B, connector DP-5 (1 threads)
Time per frame from queue to event (busy):       33.357ms( 29.979Hz)

queue-busy on pipe B, connector DP-5: PASSED

Dynamic subtest pipe-B-DP-5: SUCCESS (5.170s)
Err
Starting dynamic subtest: pipe-B-DP-5
Dynamic subtest pipe-B-DP-5: SUCCESS (5.170s)
Dmesg
<6> [592.025540] [IGT] kms_sequence: starting dynamic subtest pipe-B-DP-5
<7> [592.027489] xe 0000:00:02.0: [drm:drm_mode_addfb2] [FB:256]
<7> [592.039428] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:88:pipe A]
<7> [592.041455] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:145:pipe B]
<7> [592.041490] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:241:DP-5]
<7> [592.041593] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CONNECTOR:241:DP-5] Limiting display bpp to 30 (EDID bpp 30, max requested bpp 36, max platform bpp 36)
<7> [592.041734] xe 0000:00:02.0: [drm:intel_dp_compute_config_limits [xe]] [ENCODER:213:DDI TC1/PHY TC1][CRTC:145:pipe B] DP link limits: pixel clock 262750 kHz DSC off max lanes 4 max rate 270000 max pipe_bpp 24 max link_bpp 24.0000
<7> [592.041849] [drm:drm_dp_mst_update_slots [drm_display_helper]] 8b/10b encoding format on mst_state 0xffff88814c31cfe0
<7> [592.041866] xe 0000:00:02.0: [drm:intel_dp_mtp_tu_compute_config [xe]] Looking for slots in range min bpp 18.0000 max bpp 24.0000
<7> [592.041956] xe 0000:00:02.0: [drm:intel_dp_mtp_tu_compute_config [xe]] Trying bpp 24.0000
<7> [592.042051] xe 0000:00:02.0: [drm:drm_dp_mst_get_port_malloc [drm_display_helper]] port ffff888103151000 (16)
<7> [592.042063] xe 0000:00:02.0: [drm:intel_dp_mtp_tu_compute_config [xe]] Got 47 slots for pipe bpp 24.0000 dsc 0
<7> [592.042154] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:145:pipe B] hw max bpp: 30, pipe bpp: 24, dithering: 0
<7> [592.042283] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.enable (expected no, found yes)
<7> [592.042385] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.active (expected no, found yes)
<7> [592.042479] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in cpu_transcoder (expected -1, found 1)
<7> [592.042569] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in mst_master_transcoder (expected -1, found 1)
<7> [592.042661] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in lane_count (expected 0, found 4)
<7> [592.042749] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in dp_m_n (expected tu 0 data 0/0 link 0/0, found tu 47, data 6122518/8388608 link 510209/524288)
<7> [592.042837] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in output_types (expected 0x00000000, found 0x00000800)
<7> [592.042923] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [592.043009] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 3840)
<7> [592.043093] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 4000)
<7> [592.043178] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 3840)
<7> [592.043271] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 4000)
<7> [592.043360] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 3888)
<7> [592.043448] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 3920)
<7> [592.043537] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 2160)
<7> [592.043626] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 2160)
<7> [592.043717] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 2163)
<7> [592.043806] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 2168)
<7> [592.043893] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 2191)
<7> [592.043981] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 2191)
<7> [592.044069] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 3840)
<7> [592.044157] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 4000)
<7> [592.044251] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 3840)
<7> [592.044339] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 4000)
<7> [592.044424] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 3888)
<7> [592.044509] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 3920)
<7> [592.044594] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 2160)
<7> [592.044679] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 2160)
<7> [592.044766] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 2163)
<7> [592.044853] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 2168)
<7> [592.044939] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 2191)
<7> [592.045027] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 2191)
<7> [592.045116] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [592.045219] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 0, found 1)
<7> [592.045311] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [592.045401] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [592.045488] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 262750)
<7> [592.045577] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 262750)
<7> [592.045664] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in port_clock (expected 0, found 270000)
<7> [592.045750] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:145:pipe B] fastset requirement not met, forcing full modeset
<7> [592.045893] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0x1 -> 0xf (total dbuf slices 0xf), mbus joined? no->yes
<7> [592.045972] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:145:pipe B] dbuf slices 0x0 -> 0xf, ddb (0 - 0) -> (0 - 4096), active pipes 0x0 -> 0x2
<7> [592.046064] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:90:plane 1B] ddb ( 0 - 0) -> ( 0 - 4064), size 0 -> 4064
<7> [592.046130] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:140:cursor B] ddb ( 0 - 0) -> (4064 - 4096), size 0 -> 32
<7> [592.046200] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [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> [592.046267] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:90:plane 1B] lines 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 7, 7, 7, 7, 7, 0, 0, 0, 2, 0
<7> [592.046327] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:90:plane 1B] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 31, 218, 218, 218, 218, 218, 0, 0, 45, 63, 77
<7> [592.046390] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:90:plane 1B] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 36, 241, 241, 241, 241, 241, 0, 0, 46, 71, 78
<7> [592.046472] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:145:pipe B] data rate 1051000 num active planes 1
<7> [592.046576] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 1104 qgv_peak_bw: 38400
<7> [592.046678] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 1104 qgv_peak_bw: 38400
<7> [592.046780] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 1104 qgv_peak_bw: 38400
<7> [592.046877] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 1104 qgv_peak_bw: 38400
<7> [592.046973] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 1104
<7> [592.047072] xe 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [xe]] [PLANE:90:plane 1B] min cdclk (131375 kHz) > [CRTC:145:pipe B] min cdclk (0 kHz)
<7> [592.047151] xe 0000:00:02.0: [drm:intel_bw_calc_min_cdclk [xe]] new bandwidth min cdclk (20528 kHz) > old min cdclk (0 kHz)
<7> [592.047330] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing
<7> [592.047429] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 192000 kHz, actual 192000 kHz
<7> [592.047521] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0
<7> [592.047640] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:145:pipe B] enable: yes [modeset]
<7> [592.047735] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] active: yes, output_types: DP_MST (0x800), output format: RGB, sink format: RGB
<7> [592.047830] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] cpu_transcoder: B, pipe bpp: 24, dithering: 0
<7> [592.047922] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] MST master transcoder: B
<7> [592.048015] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [592.048109] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] joiner: no, pipes: 0x0
<7> [592.048217] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] splitter: disabled, link count 0, overlap 0
<7> [592.048320] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m_n: lanes: 4; data_m: 6122518, data_n: 8388608, link_m: 510209, link_n: 524288, tu: 47
<7> [592.048412] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dp m2_n2: lanes: 4; data_m: 0, data_n: 0, link_m: 0, link_n: 0, tu: 0
<7> [592.048502] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] fec: disabled, enhanced framing: disabled
<7> [592.048592] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] sdp split: disabled
<7> [592.048681] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] psr: disabled, selective update: disabled, panel replay: disabled, selective fetch: disabled
<7> [592.048769] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] minimum HBlank: 0
<7> [592.048858] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] audio: 1, infoframes: 0, infoframes enabled: 0x0
<7> [592.048947] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ELD: 10 00 08 00 6c 14 00 01 00 00 00 00 00 00 00 00
<7> [592.049034] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ELD: 1e 6d c2 5b 4c 47 20 55 4c 54 52 41 46 49 4e 45
<7> [592.049124] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ELD: 09 07 07 00
<7> [592.049219] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] scanline offset: 1
<7> [592.049310] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0
<7> [592.049403] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: no, fixed rr: yes, vmin: 2191, vmax: 2191, flipline: 2191, pipeline full: 0, guardband: 31 vsync start: 28, vsync end: 23
<7> [592.049495] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] vrr: vmin vblank: 2160, vmax vblank: 2160, vmin vtotal: 2191, vmax vtotal: 2191
<7> [592.049586] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] requested mode: "3840x2160": 30 262750 3840 3888 3920 4000 2160 2163 2168 2191 0x40 0x9
<7> [592.049678] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] adjusted mode: "3840x2160": 30 262750 3840 3888 3920 4000 2160 2163 2168 2191 0x40 0x9
<7> [592.049771] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=262750, hd=3840 hb=3840-4000 hs=3888-3920 ht=4000, vd=2160 vb=2160-2191 vs=2163-2168 vt=2191, flags=0x9
<7> [592.049860] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe mode: "3840x2160": 30 262750 3840 3888 3920 4000 2160 2163 2168 2191 0x40 0x9
<7> [592.049947] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] crtc timings: clock=262750, hd=3840 hb=3840-4000 hs=3888-3920 ht=4000, vd=2160 vb=2160-2191 vs=2163-2168 vt=2191, flags=0x9
<7> [592.050034] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] port clock: 270000, pipe src: 3840x2160+0+0, pixel rate 262750
<7> [592.050121] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] linetime: 122, ips linetime: 0
<7> [592.050274] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] num_scalers: 2, scaler_users: 0x0, scaler_id: -1, scaling_filter: 0
<7> [592.050366] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [592.050457] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] ips: 0, double wide: 0, drrs: 0
<7> [592.050547] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] dpll_hw_state: dpll: 0x41eb0, dpll_md: 0x4800be88, fp0: 0x5000000, fp1: 0x5
<7> [592.050635] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] csc_mode: 0x0 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [592.050724] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [592.050814] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: pre offsets: 0x0000 0x0000 0x0000
<7> [592.050905] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [592.050994] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [592.051084] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: coefficients: 0x0000 0x0000 0x0000
<7> [592.051171] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] output csc: post offsets: 0x0000 0x0000 0x0000
<7> [592.051274] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [592.051366] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [592.051453] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [592.051539] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [592.051626] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] pipe csc: post offsets: 0x0000 0x0000 0x0000
<7> [592.051715] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:90:plane 1B] fb: [FB:256] 3840x2160 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [592.051809] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [592.051899] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] src: 3840.000000x2160.000000+0.000000+0.000000 dst: 3840x2160+0+0
<7> [592.051990] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:100:plane 2B] fb: [NOFB], visible: no
<7> [592.052082] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:110:plane 3B] fb: [NOFB], visible: no
<7> [592.052177] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:120:plane 4B] fb: [NOFB], visible: no
<7> [592.052286] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:130:plane 5B] fb: [NOFB], visible: no
<7> [592.052377] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:140:cursor B] fb: [NOFB], visible: no
<7> [592.054408] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [592.054557] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_B
<7> [592.054709] xe 0000:00:02.0: [drm:intel_set_cdclk [xe]] Pre changing CDCLK to 192000 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [592.054815] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [592.054910] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=480
<7> [592.055007] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:204:DDI A/PHY A]
<7> [592.055081] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DDI TC1/PHY TC1]
<7> [592.055150] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:215:DP-MST A]
<7> [592.055233] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:216:DP-MST B]
<7> [592.055303] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DP-MST C]
<7> [592.055370] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:225:DDI TC2/PHY TC2]
<7> [592.055438] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:227:DP-MST A]
<7> [592.055506] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:228:DP-MST B]
<7> [592.055573] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:229:DP-MST C]
<7> [592.055641] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:233:DDI TC3/PHY TC3]
<7> [592.055710] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:235:DP-MST A]
<7> [592.055778] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:236:DP-MST B]
<7> [592.055843] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:237:DP-MST C]
<7> [592.055909] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:242:DP-4]
<7> [592.055976] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:247:DP-6]
<7> [592.056045] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0xf
<7> [592.056218] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: no -> yes (pipe: *)
<7> [592.056290] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 8 (mbus joined: yes)
<7> [592.056428] xe 0000:00:02.0: [drm:mst_stream_pre_enable [xe]] active MST streams 0 -> 1
<7> [592.057216] xe 0000:00:02.0: [drm:drm_dp_mst_topology_get_port_validated [drm_display_helper]] port ffff888103151000 (2)
<7> [592.108315] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] got hpd irq on [ENCODER:213:DDI TC1/PHY TC1] - short
<7> [592.112227] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] DPRX ESI: 02 10 00 00
<7> [592.114573] xe 0000:00:02.0: [drm:drm_dp_mst_topology_try_get_mstb [drm_display_helper]] mstb ffff88814ddd7de0 (2)
<7> [592.114624] xe 0000:00:02.0: [drm:drm_dp_mst_topology_put_mstb [drm_display_helper]] mstb ffff88814ddd7de0 (1)
<7> [592.114715] xe 0000:00:02.0: [drm:drm_dp_mst_topology_put_port [drm_display_helper]] port ffff888103151000 (1)
<7> [592.116243] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC1
<7> [592.116877] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC1
<7> [592.120435] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] DPRX ESI: 02 00 00 00
<7> [592.125083] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC1/DDI TC1/PHY TC1: DPCD: 12 0a c4 01 00 05 01 83 02 00 00 00 00 00 04
<7> [592.132030] xe 0000:00:02.0: [drm:intel_dp_init_lttpr_and_dprx_caps [xe]] [CONNECTOR:214:DP-1][ENCODER:213:DDI TC1/PHY TC1][DPRX] LTTPR common capabilities: 20 1e 80 aa 04 00 01 03
<7> [592.136902] xe 0000:00:02.0: [drm:intel_dp_init_lttpr_and_dprx_caps [xe]] [CONNECTOR:214:DP-1][ENCODER:213:DDI TC1/PHY TC1][LTTPR 1] PHY capabilities: 04 03 00
<7> [592.138935] xe 0000:00:02.0: [drm:drm_dp_dump_desc [drm_display_helper]] AUX USBC1/DDI TC1/PHY TC1: LTTPR 1: OUI 98-4f-ee dev-ID HBR HW-rev 10.2 SW-rev 2.11 quirks 0x0000
<7> [592.141247] xe 0000:00:02.0: [drm:drm_dp_read_dpcd_caps [drm_display_helper]] AUX USBC1/DDI TC1/PHY TC1: DPCD: 12 0a c4 01 00 05 01 83 02 00 00 00 00 00 04
<7> [592.142062] xe 0000:00:02.0: [drm:intel_dp_start_link_train [xe]] [CONNECTOR:214:DP-1][ENCODER:213:DDI TC1/PHY TC1][DPRX] Using LINK_BW_SET value 0a
<7> [592.144255] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:214:DP-1][ENCODER:213:DDI TC1/PHY TC1][LTTPR 1] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [592.145305] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:214:DP-1][ENCODER:213:DDI TC1/PHY TC1][LTTPR 1] Using DP training pattern TPS1
<7> [592.147606] xe 0000:00:02.0: [drm:intel_dp_get_adjust_train [xe]] [CONNECTOR:214:DP-1][ENCODER:213:DDI TC1/PHY TC1][LTTPR 1] 8b/10b, lanes: 4, vswing request: 2/2/2/2, pre-emphasis request: 0/0/0/0
<7> [592.148115] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:214:DP-1][ENCODER:213:DDI TC1/PHY TC1][LTTPR 1] 8b/10b, lanes: 4, vswing levels: 2/2/2/2, pre-emphasis levels: 0/0/0/0
<7> [592.151157] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:214:DP-1][ENCODER:213:DDI TC1/PHY TC1][LTTPR 1] Clock recovery OK
<7> [592.152467] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:214:DP-1][ENCODER:213:DDI TC1/PHY TC1][LTTPR 1] Using DP training pattern TPS4
<7> [592.172138] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:214:DP-1][ENCODER:213:DDI TC1/PHY TC1][LTTPR 1] Channel EQ done. DP Training successful
<7> [592.172656] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:214:DP-1][ENCODER:213:DDI TC1/PHY TC1][LTTPR 1] Link Training passed at link rate = 270000, lane count = 4
<7> [592.174085] xe 0000:00:02.0: [drm:intel_dp_set_signal_levels [xe]] [CONNECTOR:214:DP-1][ENCODER:213:DDI TC1/PHY TC1][DPRX] 8b/10b, lanes: 4, vswing levels: 0/0/0/0, pre-emphasis levels: 0/0/0/0
<7> [592.174600] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:214:DP-1][ENCODER:213:DDI TC1/PHY TC1][DPRX] Using DP training pattern TPS1
<7> [592.194263] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:214:DP-1][ENCODER:213:DDI TC1/PHY TC1][DPRX] Clock recovery OK
<7> [592.194744] xe 0000:00:02.0: [drm:intel_dp_program_link_training_pattern [xe]] [CONNECTOR:214:DP-1][ENCODER:213:DDI TC1/PHY TC1][DPRX] Using DP training pattern TPS3
<7> [592.214248] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:214:DP-1][ENCODER:213:DDI TC1/PHY TC1][DPRX] Channel EQ done. DP Training successful
<7> [592.214669] xe 0000:00:02.0: [drm:intel_dp_link_train_phy [xe]] [CONNECTOR:214:DP-1][ENCODER:213:DDI TC1/PHY TC1][DPRX] Link Training passed at link rate = 270000, lane count = 4
<7> [592.217233] xe 0000:00:02.0: [drm:drm_dp_mst_topology_get_port_validated [drm_display_helper]] port ffff888103151000 (2)
<7> [592.221065] xe 0000:00:02.0: [drm:drm_dp_mst_topology_put_port [drm_display_helper]] port ffff888103151000 (1)
<7> [592.221222] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC1
<7> [592.221677] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC1
<7> [592.225172] xe 0000:00:02.0: [drm:drm_dp_mst_topology_get_port_validated [drm_display_helper]] port ffff888103151000 (2)
<7> [592.225271] xe 0000:00:02.0: [drm:drm_dp_mst_topology_try_get_mstb [drm_display_helper]] mstb ffff88814ddd7de0 (2)
<7> [592.278454] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] got hpd irq on [ENCODER:213:DDI TC1/PHY TC1] - short
<7> [592.283052] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] DPRX ESI: 02 10 00 00
<7> [592.285698] xe 0000:00:02.0: [drm:drm_dp_mst_topology_try_get_mstb [drm_display_helper]] mstb ffff88814ddd7de0 (3)
<7> [592.285791] xe 0000:00:02.0: [drm:drm_dp_mst_topology_put_mstb [drm_display_helper]] mstb ffff88814ddd7de0 (2)
<7> [592.285891] xe 0000:00:02.0: [drm:drm_dp_mst_topology_put_mstb [drm_display_helper]] mstb ffff88814ddd7de0 (1)
<7> [592.285994] xe 0000:00:02.0: [drm:drm_dp_mst_topology_put_port [drm_display_helper]] port ffff888103151000 (1)
<7> [592.286051] xe 0000:00:02.0: [drm:intel_enable_transcoder [xe]] enabling pipe B
<7> [592.289044] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] reserved 8572928 bytes of contiguous stolen space for FBC, limit: 4
<7> [592.289593] xe 0000:00:02.0: [drm:intel_fbc_update [xe]] Enabling FBC on [PLANE:90:plane 1B]
<7> [592.291299] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] DPRX ESI: 02 00 00 00
<7> [592.321071] xe 0000:00:02.0: [drm:intel_audio_codec_enable [xe]] [CONNECTOR:241:DP-5][ENCODER:216:DP-MST B] Enable audio codec on [CRTC:145:pipe B], 36 bytes ELD
<7> [592.324239] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC1
<7> [592.338670] xe 0000:00:02.0: [drm:intel_audio_component_get_power [xe]] restored AUD_FREQ_CNTRL to 0x8010
<7> [592.354744] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:241:DP-5]
<7> [592.355242] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:145:pipe B]
<7> [592.369608] xe 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:202:pipe C]
<7> [592.422082] xe 0000:00:02.0: [drm:i915_fifo_underrun_reset_write [xe]] Re-arming FIFO underruns on pipe B
<7> [594.260396] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC1
<7> [594.364179] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC1
<7> [596.857863] xe 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:256] from all active usage due to RMFB ioctl
<7> [596.858132] xe 0000:00:02.0: [drm:atomic_remove_fb] Disabling [PLANE:90:plane 1B] because [FB:256] is removed
<7> [596.858364] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:90:plane 1B] ddb ( 0 - 4064) -> ( 0 - 0), size 4064 -> 0
<7> [596.859008] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [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> [596.859473] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:90:plane 1B] lines 1, 7, 7, 7, 7, 7, 0, 0, 0, 2, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [596.859886] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:90:plane 1B] blocks 31, 218, 218, 218, 218, 218, 0, 0, 45, 63, 77 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [596.860323] xe 0000:00:02.0: [drm:skl_print_plane_changes [xe]] [PLANE:90:plane 1B] min_ddb 36, 241, 241, 241, 241, 241, 0, 0, 46, 71, 78 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0
<7> [596.860794] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] [CRTC:145:pipe B] data rate 0 num active planes 0
<7> [596.861489] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 0: max bw 23530 required 0 qgv_peak_bw: 38400
<7> [596.862163] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 1: max bw 36260 required 0 qgv_peak_bw: 38400
<7> [596.862757] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 2: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [596.863366] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] QGV point 3: max bw 38000 required 0 qgv_peak_bw: 38400
<7> [596.863962] xe 0000:00:02.0: [drm:intel_bw_atomic_check [xe]] Matching peaks QGV bw: 38400 for required data rate: 0
<7> [596.890874] xe 0000:00:02.0: [drm:__intel_fbc_disable [xe]] Disabling FBC on [PLANE:90:plane 1B]
<7> [596.940544] xe 0000:00:02.0: [drm:drm_dp_mst_get_port_malloc [drm_display_helper]] port ffff888103151000 (17)
<7> [596.940714] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.enable (expected yes, found no)
<7> [596.941265] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.active (expected yes, found no)
<7> [596.941691] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [596.942128] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in mst_master_transcoder (expected 1, found -1)
<7> [596.942517] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in lane_count (expected 4, found 0)
<7> [596.942863] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in dp_m_n (expected tu 47 data 6122518/8388608 link 510209/524288, found tu 0, data 0/0 link 0/0)
<7> [596.943235] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in output_types (expected 0x00000800, found 0x00000000)
<7> [596.943552] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [596.943855] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 3840, found 0)
<7> [596.944174] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 4000, found 0)
<7> [596.944445] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 3840, found 0)
<7> [596.944719] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 4000, found 0)
<7> [596.945009] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 3888, found 0)
<7> [596.945268] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 3920, found 0)
<7> [596.945516] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 2160, found 0)
<7> [596.945753] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 2160, found 0)
<7> [596.946005] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 2163, found 0)
<7> [596.946232] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 2168, found 0)
<7> [596.946460] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 2191, found 0)
<7> [596.946666] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 2191, found 0)
<7> [596.946878] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 3840, found 0)
<7> [596.947184] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 4000, found 0)
<7> [596.947382] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 3840, found 0)
<7> [596.947565] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 4000, found 0)
<7> [596.947736] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 3888, found 0)
<7> [596.947901] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 3920, found 0)
<7> [596.948084] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 2160, found 0)
<7> [596.948249] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 2160, found 0)
<7> [596.948416] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 2163, found 0)
<7> [596.948568] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 2168, found 0)
<7> [596.948727] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 2191, found 0)
<7> [596.948874] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 2191, found 0)
<7> [596.949038] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [596.949189] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [596.949341] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [596.949485] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [596.949627] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 262750, found 0)
<7> [596.949758] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 262750, found 0)
<7> [596.949890] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in port_clock (expected 270000, found 0)
<7> [596.950047] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:145:pipe B] fastset requirement not met, forcing full modeset
<7> [596.950286] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [596.950402] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:145:pipe B] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x2 -> 0x0
<7> [596.950768] xe 0000:00:02.0: [drm:drm_dp_mst_get_port_malloc [drm_display_helper]] port ffff888103151000 (18)
<7> [596.950837] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.enable (expected yes, found no)
<7> [596.950995] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.active (expected yes, found no)
<7> [596.951124] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in cpu_transcoder (expected 1, found -1)
<7> [596.951252] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in mst_master_transcoder (expected 1, found -1)
<7> [596.951359] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in lane_count (expected 4, found 0)
<7> [596.951476] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in dp_m_n (expected tu 47 data 6122518/8388608 link 510209/524288, found tu 0, data 0/0 link 0/0)
<7> [596.951579] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in output_types (expected 0x00000800, found 0x00000000)
<7> [596.951684] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [596.951787] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 3840, found 0)
<7> [596.951886] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 4000, found 0)
<7> [596.951994] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 3840, found 0)
<7> [596.952094] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 4000, found 0)
<7> [596.952185] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 3888, found 0)
<7> [596.952273] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 3920, found 0)
<7> [596.952362] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 2160, found 0)
<7> [596.952453] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 2160, found 0)
<7> [596.952542] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 2163, found 0)
<7> [596.952628] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 2168, found 0)
<7> [596.952714] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 2191, found 0)
<7> [596.952800] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 2191, found 0)
<7> [596.952886] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 3840, found 0)
<7> [596.952979] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 4000, found 0)
<7> [596.953065] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 3840, found 0)
<7> [596.953151] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 4000, found 0)
<7> [596.953239] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 3888, found 0)
<7> [596.953326] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 3920, found 0)
<7> [596.953415] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 2160, found 0)
<7> [596.953502] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 2160, found 0)
<7> [596.953591] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 2163, found 0)
<7> [596.953680] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 2168, found 0)
<7> [596.953766] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 2191, found 0)
<7> [596.953851] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 2191, found 0)
<7> [596.953946] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [596.954035] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [596.954121] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 8, found 0)
<7> [596.954208] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in pipe_bpp (expected 24, found 0)
<7> [596.954294] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 262750, found 0)
<7> [596.954379] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 262750, found 0)
<7> [596.954463] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:145:pipe B] fastset requirement not met in port_clock (expected 270000, found 0)
<7> [596.954551] xe 0000:00:02.0: [drm:intel_atomic_check [xe]] [CRTC:145:pipe B] fastset requirement not met, forcing full modeset
<7> [596.954666] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] Enabled dbuf slices 0xf -> 0x1 (total dbuf slices 0xf), mbus joined? yes->no
<7> [596.954740] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [CRTC:145:pipe B] dbuf slices 0xf -> 0x0, ddb (0 - 4096) -> (0 - 0), active pipes 0x2 -> 0x0
<7> [596.954832] xe 0000:00:02.0: [drm:skl_compute_wm [xe]] [PLANE:140:cursor B] ddb (4064 - 4096) -> ( 0 - 0), size 32 -> 0
<7> [596.954965] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] Can change cdclk via squashing
<7> [596.955074] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New cdclk calculated to be logical 153600 kHz, actual 153600 kHz
<7> [596.955172] xe 0000:00:02.0: [drm:intel_modeset_calc_cdclk [xe]] New voltage level calculated to be logical 0, actual 0
<7> [596.955291] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [CRTC:145:pipe B] enable: no [modeset]
<7> [596.955388] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:90:plane 1B] fb: [NOFB], visible: no
<7> [596.955483] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:100:plane 2B] fb: [NOFB], visible: no
<7> [596.955573] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:110:plane 3B] fb: [NOFB], visible: no
<7> [596.955663] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:120:plane 4B] fb: [NOFB], visible: no
<7> [596.955753] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:130:plane 5B] fb: [NOFB], visible: no
<7> [596.955843] xe 0000:00:02.0: [drm:intel_crtc_state_dump [xe]] [PLANE:140:cursor B] fb: [NOFB], visible: no
<7> [596.956015] xe 0000:00:02.0: [drm:intel_audio_codec_disable [xe]] [CONNECTOR:241:DP-5][ENCODER:216:DP-MST B] Disable audio codec on [CRTC:145:pipe B]
<7> [596.991002] xe 0000:00:02.0: [drm:intel_audio_component_get_eld [xe]] Not valid for port D
<7> [596.991860] xe 0000:00:02.0: [drm:mst_stream_post_disable [xe]] active MST streams 1 -> 0
<7> [596.992737] xe 0000:00:02.0: [drm:intel_disable_transcoder [xe]] disabling pipe B
<7> [597.006558] xe 0000:00:02.0: [drm:intel_audio_component_get_power [xe]] restored AUD_FREQ_CNTRL to 0x8010
<7> [597.033788] xe 0000:00:02.0: [drm:drm_dp_remove_payload_part1 [drm_display_helper]]
<7> [597.033868] xe 0000:00:02.0: [drm:drm_dp_mst_topology_try_get_mstb [drm_display_helper]] mstb ffff88814ddd7de0 (2)
<7> [597.034099] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC1
<7> [597.087060] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] got hpd irq on [ENCODER:213:DDI TC1/PHY TC1] - short
<7> [597.091858] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] DPRX ESI: 02 10 00 00
<7> [597.094831] xe 0000:00:02.0: [drm:drm_dp_mst_topology_try_get_mstb [drm_display_helper]] mstb ffff88814ddd7de0 (3)
<7> [597.094971] xe 0000:00:02.0: [drm:drm_dp_mst_topology_put_mstb [drm_display_helper]] mstb ffff88814ddd7de0 (2)
<7> [597.095054] xe 0000:00:02.0: [drm:drm_dp_mst_topology_put_mstb [drm_display_helper]] mstb ffff88814ddd7de0 (1)
<7> [597.101766] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] DPRX ESI: 02 00 00 00
<7> [597.123187] xe 0000:00:02.0: [drm:drm_dp_mst_put_port_malloc [drm_display_helper]] port ffff888103151000 (17)
<7> [597.123279] xe 0000:00:02.0: [drm:drm_dp_mst_topology_get_port_validated [drm_display_helper]] port ffff888103151000 (2)
<7> [597.141101] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC1
<7> [597.175043] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] got hpd irq on [ENCODER:213:DDI TC1/PHY TC1] - short
<7> [597.175650] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC1
<7> [597.180996] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] DPRX ESI: 02 10 00 00
<7> [597.183863] xe 0000:00:02.0: [drm:drm_dp_mst_topology_try_get_mstb [drm_display_helper]] mstb ffff88814ddd7de0 (2)
<7> [597.183991] xe 0000:00:02.0: [drm:drm_dp_mst_topology_put_mstb [drm_display_helper]] mstb ffff88814ddd7de0 (1)
<7> [597.184076] xe 0000:00:02.0: [drm:drm_dp_mst_topology_put_port [drm_display_helper]] port ffff888103151000 (1)
<7> [597.186858] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC1
<7> [597.187758] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port D/TC#1: TC port mode reset (dp-alt -> disconnected) pin assignment: C max lanes: 4
<7> [597.188557] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:204:DDI A/PHY A]
<7> [597.188547] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port D/TC#1: TC port mode reset (disconnected -> dp-alt) pin assignment: C max lanes: 4
<7> [597.188867] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:213:DDI TC1/PHY TC1]
<7> [597.189159] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:215:DP-MST A]
<7> [597.189384] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:216:DP-MST B]
<7> [597.189198] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC1
<7> [597.189598] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:217:DP-MST C]
<7> [597.189813] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:225:DDI TC2/PHY TC2]
<7> [597.190050] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:227:DP-MST A]
<7> [597.190313] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:228:DP-MST B]
<7> [597.190519] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:229:DP-MST C]
<7> [597.190722] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:233:DDI TC3/PHY TC3]
<7> [597.190917] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:235:DP-MST A]
<7> [597.191146] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:236:DP-MST B]
<7> [597.191328] xe 0000:00:02.0: [drm:intel_modeset_verify_disabled [xe]] [ENCODER:237:DP-MST C]
<7> [597.191507] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:242:DP-4]
<7> [597.191684] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:241:DP-5]
<7> [597.191860] xe 0000:00:02.0: [drm:verify_connector_state [xe]] [CONNECTOR:247:DP-6]
<7> [597.192130] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [597.192319] xe 0000:00:02.0: [drm:intel_dbuf_mbus_join_update [xe]] Changing mbus joined: yes -> no (pipe: *)
<7> [597.192503] xe 0000:00:02.0: [drm:gen9_dbuf_slices_update [xe]] Updating dbuf slices to 0x1
<7> [597.192866] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_B
<7> [597.193264] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling PW_2
<7> [597.193593] xe 0000:00:02.0: [drm:intel_modeset_verify_crtc [xe]] [CRTC:145:pipe B]
<7> [597.193869] xe 0000:00:02.0: [drm:intel_set_cdclk [xe]] Post changing CDCLK to 153600 kHz, VCO 614400 kHz, ref 38400 kHz, bypass 19200 kHz, voltage level 0
<7> [597.194172] xe 0000:00:02.0: [drm:intel_dbuf_mdclk_cdclk_ratio_update [xe]] Updating dbuf ratio to 4 (mbus joined: no)
<7> [597.194076] xe 0000:00:02.0: [drm:intel_dp_hpd_pulse [xe]] DPRX ESI: 02 00 00 00
<7> [597.194388] xe 0000:00:02.0: [drm:intel_audio_cdclk_change_post.part.0 [xe]] aud_ts_cdclk set to M=60, N=384
<7> [597.194959] xe 0000:00:02.0: [drm:drm_dp_mst_put_port_malloc [drm_display_helper]] port ffff888103151000 (16)
<6> [597.196182] [IGT] kms_sequence: finished subtest pipe-B-DP-5, SUCCESS
Created at 2025-08-30 06:56:11