igt@i915_module_load@fault-injection on shard-dg1@CI_DRM

Results for igt@i915_module_load@fault-injection

Detail	Value
Duration	unknown
Hostname	shard-dg1-14
Igt-Version	IGT-Version: 2.4-g02b0e01dd (x86_64) (Linux: 7.1.0-rc1-CI_DRM_18379-g9ee30ac229d6+ x86_64)
Out	Using IGT_SRANDOM=1777496567 for randomisation Starting subtest: fault-injection Opened device: /dev/dri/card0 Starting dynamic subtest: __uc_init Timed out: Driver unbind re-bind timeout! Dynamic subtest __uc_init: FAIL (205.615s) This test caused an abort condition: Kernel badly tainted (0x4244, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. Starting dynamic subtest: i915_driver_mmio_probe
Err	Starting subtest: fault-injection Starting dynamic subtest: __uc_init Dynamic subtest __uc_init failed. ** DEBUG (i915_module_load:3487) DEBUG: Test requirement passed: guc == GEM_SUBMISSION_GUC (i915_module_load:3487) DEBUG: probability = 100, interval = 0, times = -1, space = 0 (i915_module_load:3487) igt_core-INFO: Timed out: Driver unbind re-bind timeout! END ** Dynamic subtest __uc_init: FAIL (205.615s) Starting dynamic subtest: i915_driver_mmio_probe
Dmesg Scroll to first warning	<7> [621.841866] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DC_off <7> [621.842075] i915 0000:03:00.0: [drm:gen9_enable_dc5 [i915]] Enabling DC5 <7> [621.842227] i915 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 01 <6> [621.854506] Console: switching to colour dummy device 80x25 <6> [621.855214] [IGT] i915_module_load: executing <6> [621.860977] [IGT] i915_module_load: starting subtest fault-injection <7> [621.863396] i915 0000:03:00.0: [drm:i915_gem_open [i915]] <7> [621.864572] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7> [621.864947] i915 0000:03:00.0: [drm:i915_gem_open [i915]] <6> [621.890850] [IGT] i915_module_load: starting dynamic subtest __uc_init <6> [621.891526] [IGT] add ignored dmesg regex: .Failed to register driver for userspace access!\|.Device initialization failed.\|.probe with driver i915 failed with error.\|.GT1: GSC proxy handler failed to init.\|.GT0: GUC: failed with -ENXIO.\|.GuC fw rsa data creation failed -ENXIO.\|.GUC: failed with -ENXIO.\|.Failed to register driver for userspace access.\|.GT0: GuC fw rsa data creation failed -ENXIO.* <7> [621.892486] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling DC_off <7> [621.893096] i915 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 01 to 00 <7> [621.893441] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_2 <7> [621.893645] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_3 <7> [621.893971] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_4 <7> [621.894164] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_5 <7> [621.897797] i915 0000:03:00.0: [drm:atomic_remove_fb] Disabling [PLANE:35:plane 1A] because [FB:636] is removed <7> [621.898066] i915 0000:03:00.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:35:plane 1A] ddb ( 0 - 2012) -> ( 0 - 0), size 2012 -> 0 <7> [621.898264] i915 0000:03:00.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:35: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> [621.898408] i915 0000:03:00.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:35:plane 1A] lines 1, 5, 5, 5, 8, 8, 9, 10, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [621.898552] i915 0000:03:00.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:35:plane 1A] blocks 16, 81, 81, 81, 129, 129, 145, 161, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [621.898696] i915 0000:03:00.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:35:plane 1A] min_ddb 19, 91, 91, 91, 143, 143, 161, 179, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [621.898975] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:171:pipe A] data rate 0 num active planes 0 <7> [621.899176] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 34000 required 0 <7> [621.899352] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1 <7> [621.904280] i915 0000:03:00.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:35:plane 1A] <7> [621.921759] i915 0000:03:00.0: [drm:drm_client_release] fbdev <7> [621.926185] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.enable (expected yes, found no) <7> [621.926380] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.active (expected yes, found no) <7> [621.926537] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1) <7> [621.926691] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in lane_count (expected 4, found 0) <7> [621.926998] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000) <7> [621.927177] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0) <7> [621.927330] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0) <7> [621.928025] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0) <7> [621.928186] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0) <7> [621.928339] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0) <7> [621.928491] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0) <7> [621.928642] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0) <7> [621.929042] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0) <7> [621.929196] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0) <7> [621.929348] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0) <7> [621.929499] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0) <7> [621.929650] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0) <7> [621.930091] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0) <7> [621.930255] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0) <7> [621.930406] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0) <7> [621.930558] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0) <7> [621.930709] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0) <7> [621.930904] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0) <7> [621.931056] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0) <7> [621.931206] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0) <7> [621.931357] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0) <7> [621.931508] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0) <7> [621.931659] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0) <7> [621.931857] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0) <7> [621.932009] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0) <7> [621.932484] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0) <7> [621.932637] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0) <7> [621.932815] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0) <7> [621.932982] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0) <7> [621.933134] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0) <7> [621.933285] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0) <7> [621.933436] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in port_clock (expected 148500, found 0) <7> [621.933588] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:171:pipe A] fastset requirement not met, forcing full modeset <7> [621.933740] i915 0000:03:00.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:171:pipe A] releasing DPLL 0 <7> [621.934000] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no <7> [621.934149] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [CRTC:171:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0 <7> [621.934357] i915 0000:03:00.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:165:cursor A] ddb (2012 - 2048) -> ( 0 - 0), size 36 -> 0 <7> [621.934925] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:171:pipe A] min cdclk: 74250 kHz -> 0 kHz <7> [621.935081] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [CRTC:171:pipe A] enable: no [modeset] <7> [621.935232] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:35:plane 1A] fb: [NOFB], visible: no <7> [621.935384] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:65:plane 2A] fb: [NOFB], visible: no <7> [621.935534] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:95:plane 3A] fb: [NOFB], visible: no <7> [621.935684] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:125:plane 4A] fb: [NOFB], visible: no <7> [621.935875] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:135:plane 5A] fb: [NOFB], visible: no <7> [621.936026] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:145:plane 6A] fb: [NOFB], visible: no <7> [621.936176] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:155:plane 7A] fb: [NOFB], visible: no <7> [621.936325] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:165:cursor A] fb: [NOFB], visible: no <7> [621.937313] i915 0000:03:00.0: [drm:intel_disable_transcoder [i915]] disabling pipe A <7> [621.955964] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_A <7> [621.956356] i915 0000:03:00.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:171:pipe A] <7> [621.956591] i915 0000:03:00.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0 <7> [621.956775] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:587:DDI A/PHY A] <7> [621.956962] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:589:DP-MST A] <7> [621.957114] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:590:DP-MST B] <7> [621.957265] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:591:DP-MST C] <7> [621.957414] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:592:DP-MST D] <7> [621.957563] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:606:DDI B/PHY B] <7> [621.957712] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:610:DDI TC1/PHY C] <7> [621.957868] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:612:DP-MST A] <7> [621.958017] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:613:DP-MST B] <7> [621.958166] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:614:DP-MST C] <7> [621.958316] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:615:DP-MST D] <7> [621.958465] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:622:DDI TC2/PHY D] <7> [621.958613] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:624:DP-MST A] <7> [621.958762] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:625:DP-MST B] <7> [621.958954] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:626:DP-MST C] <7> [621.959102] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:627:DP-MST D] <7> [621.959251] i915 0000:03:00.0: [drm:verify_connector_state [i915]] [CONNECTOR:600:HDMI-A-1] <7> [621.959568] i915 0000:03:00.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1 <7> [621.959850] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:171:pipe A] <7> [621.972377] i915 0000:03:00.0: [drm:intel_gt_set_wedged [i915]] called from intel_gt_set_wedged_on_fini+0x12/0x50 [i915] <7> [621.997528] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:588:DP-1] removing connector from sysfs <7> [621.998711] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:600:HDMI-A-1] removing connector from sysfs <7> [621.999460] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:607:HDMI-A-2] removing connector from sysfs <7> [622.003409] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:611:DP-2] removing connector from sysfs <7> [622.006688] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:619:HDMI-A-3] removing connector from sysfs <7> [622.011384] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:623:DP-3] removing connector from sysfs <7> [622.011871] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:631:HDMI-A-4] removing connector from sysfs <3> [622.865944] pci 0000:03:00.0: timed out waiting for pending transaction; performing function level reset anyway <6> [622.975369] i915 0000:03:00.0: [drm] Found dg1 (device ID 4905) discrete display version 12.00 stepping B0 <7> [622.976684] i915 0000:03:00.0: [drm:intel_wopcm_init_early [i915]] WOPCM: 2048K <7> [622.976930] i915 0000:03:00.0: [drm:intel_uc_init_early [i915]] GT0: enable_guc=3 (guc:yes submission:yes huc:yes slpc:yes) <7> [622.977072] i915 0000:03:00.0: [drm:intel_pch_detect [i915]] PCH not involved in display, using fake PCH type 1024 for south display <7> [622.977218] i915 0000:03:00.0: [drm:intel_dmc_wl_init [i915]] Sanitized enable_dmc_wl value: 0 (disabled) <7> [622.977471] i915 0000:03:00.0: [drm:intel_gt_probe_all [i915]] GT0: Setting up Primary GT <7> [622.977856] i915 0000:03:00.0: [drm:intel_display_device_info_runtime_init [i915]] rawclk rate: 38400 kHz <7> [623.528588] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11) <3> [623.578784] i915 0000:03:00.0: [drm] ERROR* gt: timed out waiting for forcewake ack request. <5> [623.579021] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [624.129776] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11) <3> [624.179897] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [624.179914] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <4> [624.180082] ------------[ cut here ]------------ <4> [624.180085] i915 0000:03:00.0: [drm] drm_WARN_ON(s_en != 0x1) <4> [624.180087] WARNING: drivers/gpu/drm/i915/gt/intel_sseu.c:277 at intel_sseu_info_init+0xd3f/0x1070 [i915], CPU#0: i915_module_loa/3487 <4> [624.180215] Modules linked in: vgem snd_hda_codec_intelhdmi snd_hda_codec_hdmi mei_lb mei_gsc i915 prime_numbers drm_buddy ttm drm_display_helper cec rc_core i2c_algo_bit kunit intel_rapl_msr intel_rapl_common intel_uncore_frequency intel_uncore_frequency_common intel_tcc_cooling ee1004 cmdlinepart x86_pkg_temp_thermal spi_nor hid_generic mtd intel_powerclamp coretemp gigabyte_wmi overlay mei_pxp wmi_bmof mei_hdcp intel_wmi_thunderbolt mxm_wmi kvm_intel kvm irqbypass aesni_intel snd_hda_intel gf128mul snd_intel_dspcfg rapl snd_hda_codec snd_hda_core snd_hwdep intel_cstate snd_pcm video snd_timer i2c_i801 usbhid spi_intel_pci i2c_mux e1000e spi_intel i2c_smbus hid snd soundcore binfmt_misc intel_pmc_core pmt_telemetry pmt_discovery pmt_class intel_pmc_ssram_telemetry pinctrl_cannonlake intel_vsec acpi_pad mei_me wmi mei intel_pch_thermal nls_iso8859_1 dm_multipath msr nvme_fabrics fuse efi_pstore nfnetlink autofs4 <4> [624.180327] CPU: 0 UID: 0 PID: 3487 Comm: i915_module_loa Tainted: G S U W L 7.1.0-rc1-CI_DRM_18379-g9ee30ac229d6+ #1 PREEMPT(lazy) <4> [624.180331] Tainted: [S]=CPU_OUT_OF_SPEC, [U]=USER, [W]=WARN, [L]=SOFTLOCKUP <4> [624.180333] Hardware name: Gigabyte Technology Co., Ltd. GB-Z390 Garuda/GB-Z390 Garuda-CF, BIOS IG1c 11/19/2019 <4> [624.180336] RIP: 0010:intel_sseu_info_init+0xd49/0x1070 [i915] <4> [624.180464] Code: 04 48 8b 7f 08 4c 8b 67 50 4d 85 e4 75 03 4c 8b 27 e8 4b af 57 e1 48 89 c6 48 8d 3d 71 b4 34 00 48 c7 c1 a8 d0 1f a1 4c 89 e2 <67> 48 0f b9 3a e9 68 f5 ff ff 44 0f b7 ab 00 23 00 00 4c 89 e7 e8 <4> [624.180467] RSP: 0018:ffffc90003263680 EFLAGS: 00010246 <4> [624.180470] RAX: ffffffffa11f711e RBX: ffff88811b564028 RCX: ffffffffa11fd0a8 <4> [624.180473] RDX: ffff8881037e6e90 RSI: ffffffffa11f711e RDI: ffffffffa1007fd0 <4> [624.180475] RBP: ffffc90003263700 R08: 0000000000000000 R09: 0000000000000000 <4> [624.180477] R10: 0000000000000000 R11: 0000000000000000 R12: ffff8881037e6e90 <4> [624.180479] R13: ffff88811b566288 R14: ffff8881400e4e00 R15: 0000000000000000 <4> [624.180481] FS: 00007fe2d51d4940(0000) GS:ffff888529683000(0000) knlGS:0000000000000000 <4> [624.180483] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 <4> [624.180485] CR2: 00005fbe980b0288 CR3: 00000001479a5001 CR4: 00000000003726f0 <4> [624.180488] Call Trace: <4> [624.180490] <TASK> <4> [624.180492] ? fwtable_reg_write_fw_domains+0x4b/0x60 [i915] <4> [624.180598] ? intel_uncore_forcewake_for_reg+0x57/0x120 [i915] <4> [624.180706] intel_gt_init_mmio+0x23/0x40 [i915] <4> [624.180829] i915_driver_mmio_probe+0xb4/0x130 [i915] <4> [624.180930] i915_driver_probe+0x105/0x5d0 [i915] <4> [624.181029] ? mutex_unlock+0x12/0x20 <4> [624.181034] ? drm_privacy_screen_get+0x171/0x190 <4> [624.181037] ? acpi_dev_found+0x66/0x80 <4> [624.181046] i915_pci_probe+0xe0/0x1d0 [i915] <4> [624.181147] local_pci_probe+0x47/0xb0 <4> [624.181153] pci_call_probe+0x6c/0x360 <4> [624.181161] ? _raw_spin_unlock+0x22/0x50 <4> [624.181166] ? pci_match_device+0x16d/0x1a0 <4> [624.181171] pci_device_probe+0xa9/0x140 <4> [624.181174] ? sysfs_create_link+0x21/0x50 <4> [624.181180] really_probe+0xf1/0x410 <4> [624.181186] __driver_probe_device+0x9f/0x1d0 <4> [624.181191] device_driver_attach+0x57/0xd0 <4> [624.181196] bind_store+0x77/0xd0 <4> [624.181201] drv_attr_store+0x24/0x50 <4> [624.181205] sysfs_kf_write+0x4d/0x80 <4> [624.181209] kernfs_fop_write_iter+0x188/0x240 <4> [624.181216] vfs_write+0x283/0x540 <4> [624.181228] ksys_write+0x6f/0xf0 <4> [624.181233] __x64_sys_write+0x19/0x30 <4> [624.181236] x64_sys_call+0x259/0x26e0 <4> [624.181241] do_syscall_64+0x103/0x1410 <4> [624.181251] ? check_bytes_and_report+0x59/0x150 <4> [624.181257] ? find_held_lock+0x31/0x90 <4> [624.181262] ? free_to_partial_list+0x475/0x650 <4> [624.181266] ? lock_release+0xd0/0x2b0 <4> [624.181269] ? _raw_spin_unlock_irqrestore+0x51/0x80 <4> [624.181273] ? free_to_partial_list+0x475/0x650 <4> [624.181276] ? trace_hardirqs_on+0x22/0xf0 <4> [624.181282] ? _raw_spin_unlock_irqrestore+0x51/0x80 <4> [624.181287] ? free_to_partial_list+0x475/0x650 <4> [624.181291] ? putname+0x41/0x90 <4> [624.181298] ? __slab_free+0x12d/0x2c0 <4> [624.181303] ? putname+0x41/0x90 <4> [624.181306] ? __pcs_replace_full_main+0x2a6/0x720 <4> [624.181310] ? __pcs_replace_full_main+0x10/0x720 <4> [624.181315] ? putname+0x41/0x90 <4> [624.181318] ? kmem_cache_free+0x171/0x510 <4> [624.181326] ? putname+0x41/0x90 <4> [624.181329] ? do_sys_openat2+0x85/0xd0 <4> [624.181336] ? __x64_sys_openat+0x54/0xa0 <4> [624.181340] ? trace_hardirqs_on_prepare+0xd7/0xf0 <4> [624.181345] ? do_syscall_64+0x34/0x1410 <4> [624.181348] ? entry_SYSCALL_64_after_hwframe+0x76/0x7e <4> [624.181351] ? trace_hardirqs_on+0x22/0xf0 <4> [624.181356] ? do_syscall_64+0xb8/0x1410 <4> [624.181359] ? exc_page_fault+0xbd/0x2b0 <4> [624.181365] entry_SYSCALL_64_after_hwframe+0x76/0x7e <4> [624.181367] RIP: 0033:0x7fe2d731c5a4 <4> [624.181372] Code: c7 00 16 00 00 00 b8 ff ff ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 f3 0f 1e fa 80 3d a5 ea 0e 00 00 74 13 b8 01 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 54 c3 0f 1f 00 55 48 89 e5 48 83 ec 20 48 89 <4> [624.181374] RSP: 002b:00007ffc132cff38 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 <4> [624.181377] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007fe2d731c5a4 <4> [624.181379] RDX: 000000000000000c RSI: 00007ffc132d0170 RDI: 000000000000000c <4> [624.181381] RBP: 000000000000000c R08: 0000000000000073 R09: 0000000000000000 <4> [624.181383] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffc132d0170 <4> [624.181385] R13: 000000000000000c R14: 00005fa032b681b8 R15: 00005fa032b6828e <4> [624.181397] </TASK> <4> [624.181399] irq event stamp: 196663 <4> [624.181401] hardirqs last enabled at (196669): [<ffffffff814ab4d9>] __up_console_sem+0x79/0xa0 <4> [624.181404] hardirqs last disabled at (196674): [<ffffffff814ab4be>] __up_console_sem+0x5e/0xa0 <4> [624.181407] softirqs last enabled at (196298): [<ffffffff813d228b>] __irq_exit_rcu+0xdb/0x1c0 <4> [624.181411] softirqs last disabled at (196289): [<ffffffff813d228b>] __irq_exit_rcu+0xdb/0x1c0 <4> [624.181414] ---[ end trace 0000000000000000 ]--- <7> [624.731993] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11) <3> [624.782114] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [624.782131] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [625.332859] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11) <3> [625.382971] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [625.382988] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [625.933742] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11) <3> [625.983857] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [625.983874] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [626.534671] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11) <3> [626.584818] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [626.584848] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [626.585181] i915 0000:03:00.0: [drm:intel_engines_init_mmio [i915]] GT0: vdbox enable: 0005, instances: 0005 <7> [626.585308] i915 0000:03:00.0: [drm:intel_engines_init_mmio [i915]] GT0: vebox enable: 0001, instances: 0001 <7> [627.136038] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] render had to use fallback to set ack, 0x0 (passes 11) <3> [627.186154] i915 0000:03:00.0: [drm] ERROR render: timed out waiting for forcewake ack request. <5> [627.186172] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [627.736969] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] vdbox0 had to use fallback to set ack, 0x0 (passes 11) <3> [627.787090] i915 0000:03:00.0: [drm] ERROR vdbox0: timed out waiting for forcewake ack request. <5> [627.787108] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [628.338111] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] vdbox2 had to use fallback to set ack, 0x0 (passes 11) <3> [628.388249] i915 0000:03:00.0: [drm] ERROR vdbox2: timed out waiting for forcewake ack request. <5> [628.388269] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [628.939074] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] vebox0 had to use fallback to set ack, 0x0 (passes 11) <3> [628.989200] i915 0000:03:00.0: [drm] ERROR vebox0: timed out waiting for forcewake ack request. <5> [628.989219] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [629.539996] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11) <3> [629.590114] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [629.590133] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [630.140877] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11) <3> [630.190997] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [630.191014] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [630.741784] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] render had to use fallback to set ack, 0x0 (passes 11) <3> [630.791918] i915 0000:03:00.0: [drm] ERROR render: timed out waiting for forcewake ack request. <5> [630.791938] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [631.342720] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] render had to use fallback to set ack, 0x0 (passes 11) <3> [631.392852] i915 0000:03:00.0: [drm] ERROR render: timed out waiting for forcewake ack request. <5> [631.392872] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [631.943720] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] render had to use fallback to set ack, 0x0 (passes 11) <3> [631.993848] i915 0000:03:00.0: [drm] ERROR render: timed out waiting for forcewake ack request. <5> [631.993866] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [632.545401] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] render had to use fallback to set ack, 0x0 (passes 11) <3> [632.595520] i915 0000:03:00.0: [drm] ERROR render: timed out waiting for forcewake ack request. <5> [632.595539] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [633.146296] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11) <3> [633.196407] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [633.196425] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [633.747166] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11) <3> [633.797280] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [633.797298] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [634.348030] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11) <3> [634.398148] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [634.398166] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [634.948927] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] render had to use fallback to set ack, 0x0 (passes 11) <3> [634.999233] i915 0000:03:00.0: [drm] ERROR render: timed out waiting for forcewake ack request. <5> [634.999473] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [635.550153] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11) <3> [635.600263] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [635.600280] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [636.150978] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] vdbox0 had to use fallback to set ack, 0x0 (passes 11) <3> [636.201082] i915 0000:03:00.0: [drm] ERROR vdbox0: timed out waiting for forcewake ack request. <5> [636.201099] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [636.751798] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] vdbox2 had to use fallback to set ack, 0x0 (passes 11) <3> [636.801906] i915 0000:03:00.0: [drm] ERROR vdbox2: timed out waiting for forcewake ack request. <5> [636.801923] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [637.352619] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] vebox0 had to use fallback to set ack, 0x0 (passes 11) <3> [637.402723] i915 0000:03:00.0: [drm] ERROR vebox0: timed out waiting for forcewake ack request. <5> [637.402739] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <3> [637.403648] i915 0000:03:00.0: [drm] ERROR GT0: rcs'0 reset request timed out: {request: 00000001, RESET_CTL: 00000000} <3> [637.404376] i915 0000:03:00.0: [drm] ERROR GT0: rcs'0 reset request timed out: {request: 00000001, RESET_CTL: 00000000} <3> [637.405099] i915 0000:03:00.0: [drm] ERROR GT0: bcs'0 reset request timed out: {request: 00000001, RESET_CTL: 00000000} <3> [637.405823] i915 0000:03:00.0: [drm] ERROR GT0: vcs'0 reset request timed out: {request: 00000001, RESET_CTL: 00000000} <3> [637.406545] i915 0000:03:00.0: [drm] ERROR GT0: vcs'2 reset request timed out: {request: 00000001, RESET_CTL: 00000000} <3> [637.407268] i915 0000:03:00.0: [drm] ERROR GT0: vecs'0 reset request timed out: {request: 00000001, RESET_CTL: 00000000} <7> [637.408124] i915 0000:03:00.0: [drm:i915_ggtt_probe_hw [i915]] GGTT size = 4096M <7> [637.408253] i915 0000:03:00.0: [drm:i915_ggtt_probe_hw [i915]] GMADR size = 0M <7> [637.408366] i915 0000:03:00.0: [drm:i915_ggtt_probe_hw [i915]] DSM size = 0M <6> [637.408479] i915 0000:03:00.0: [drm] VT-d active for gfx access <6> [637.408573] i915 0000:03:00.0: vgaarb: deactivate vga console <7> [637.409237] i915 0000:03:00.0: [drm:intel_gt_setup_lmem [i915]] LMEM: reserved legacy low-memory [0x0-0x100000] <7> [637.409658] i915 0000:03:00.0: [drm:i915_gem_init_stolen [i915]] GEN6_STOLEN_RESERVED = 0x00000000ffc00107 <7> [637.409799] i915 0000:03:00.0: [drm:i915_gem_init_stolen [i915]] Memory reserved for graphics device: 65536K, usable: 61440K <7> [637.410285] i915 0000:03:00.0: [drm:intel_memory_regions_hw_probe [i915]] Memory region(0): system-ttm: 15842 MiB [mem 0x00000000-0x3de2ddfff], io: n/a <7> [637.410389] i915 0000:03:00.0: [drm:intel_memory_regions_hw_probe [i915]] Memory region(1): local0: 4024 MiB [mem 0x00000000-0xfb7fffff], io: 4024 MiB [mem 0x4000000000-0x40fb7fffff] <7> [637.410491] i915 0000:03:00.0: [drm:intel_memory_regions_hw_probe [i915]] Memory region(6): stolen-local: 60 MiB [mem 0xfc000000-0xffbfffff], io: 60 MiB [mem 0x40fc000000-0x40ffbfffff] <7> [637.411490] i915 0000:03:00.0: [drm:intel_opregion_setup [i915]] graphic opregion physical addr: 0x0 <7> [637.411647] i915 0000:03:00.0: [drm:intel_opregion_setup [i915]] ACPI OpRegion not supported! <7> [647.412611] i915 0000:03:00.0: [drm:skl_pcode_request [i915]] PCODE timeout, retrying with preemption disabled <4> [647.412877] ------------[ cut here ]------------ <4> [647.412881] i915 0000:03:00.0: [drm] drm_WARN_ON_ONCE(timeout_base_ms > 3) <4> [647.412885] WARNING: drivers/gpu/drm/i915/intel_pcode.c:200 at skl_pcode_request+0x25f/0x280 [i915], CPU#3: i915_module_loa/3487 <4> [647.413085] Modules linked in: vgem snd_hda_codec_intelhdmi snd_hda_codec_hdmi mei_lb mei_gsc i915 prime_numbers drm_buddy ttm drm_display_helper cec rc_core i2c_algo_bit kunit intel_rapl_msr intel_rapl_common intel_uncore_frequency intel_uncore_frequency_common intel_tcc_cooling ee1004 cmdlinepart x86_pkg_temp_thermal spi_nor hid_generic mtd intel_powerclamp coretemp gigabyte_wmi overlay mei_pxp wmi_bmof mei_hdcp intel_wmi_thunderbolt mxm_wmi kvm_intel kvm irqbypass aesni_intel snd_hda_intel gf128mul snd_intel_dspcfg rapl snd_hda_codec snd_hda_core snd_hwdep intel_cstate snd_pcm video snd_timer i2c_i801 usbhid spi_intel_pci i2c_mux e1000e spi_intel i2c_smbus hid snd soundcore binfmt_misc intel_pmc_core pmt_telemetry pmt_discovery pmt_class intel_pmc_ssram_telemetry pinctrl_cannonlake intel_vsec acpi_pad mei_me wmi mei intel_pch_thermal nls_iso8859_1 dm_multipath msr nvme_fabrics fuse efi_pstore nfnetlink autofs4 <4> [647.413312] CPU: 3 UID: 0 PID: 3487 Comm: i915_module_loa Tainted: G S U W L 7.1.0-rc1-CI_DRM_18379-g9ee30ac229d6+ #1 PREEMPT(lazy) <4> [647.413320] Tainted: [S]=CPU_OUT_OF_SPEC, [U]=USER, [W]=WARN, [L]=SOFTLOCKUP <4> [647.413324] Hardware name: Gigabyte Technology Co., Ltd. GB-Z390 Garuda/GB-Z390 Garuda-CF, BIOS IG1c 11/19/2019 <4> [647.413328] RIP: 0010:skl_pcode_request+0x269/0x280 [i915] <4> [647.413526] Code: 04 48 8b 7f 08 48 8b 5f 50 48 85 db 75 03 48 8b 1f e8 4b 62 62 e1 48 89 c6 48 8d 3d 91 fc 3e 00 48 c7 c1 f8 0f 21 a1 48 89 da <67> 48 0f b9 3a e9 15 ff ff ff e8 88 a3 d0 e1 0f 1f 84 00 00 00 00 <4> [647.413531] RSP: 0018:ffffc90003263660 EFLAGS: 00010246 <4> [647.413538] RAX: ffffffffa11f711e RBX: ffff8881037e6e90 RCX: ffffffffa1210ff8 <4> [647.413542] RDX: ffff8881037e6e90 RSI: ffffffffa11f711e RDI: ffffffffa10014f0 <4> [647.413546] RBP: ffffc900032636a8 R08: 0000000000000000 R09: 0000000000000000 <4> [647.413550] R10: 0000000000000000 R11: 0000000000000000 R12: ffff8881400e4e00 <4> [647.413554] R13: 000000000000007e R14: 0000000000000000 R15: 00000096b56b3411 <4> [647.413558] FS: 00007fe2d51d4940(0000) GS:ffff888529803000(0000) knlGS:0000000000000000 <4> [647.413563] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 <4> [647.413567] CR2: 0000743a2c421008 CR3: 00000001479a5001 CR4: 00000000003726f0 <4> [647.413571] Call Trace: <4> [647.413575] <TASK> <4> [647.413588] pcode_init_wait+0x50/0x80 [i915] <4> [647.413806] intel_pcode_init+0x33/0x80 [i915] <4> [647.414006] i915_pcode_init+0x29/0xd0 [i915] <4> [647.414200] i915_driver_hw_probe+0x326/0x3c0 [i915] <4> [647.414398] i915_driver_probe+0x114/0x5d0 [i915] <4> [647.414590] ? mutex_unlock+0x12/0x20 <4> [647.414598] ? drm_privacy_screen_get+0x171/0x190 <4> [647.414605] ? acpi_dev_found+0x66/0x80 <4> [647.414623] i915_pci_probe+0xe0/0x1d0 [i915] <4> [647.414849] local_pci_probe+0x47/0xb0 <4> [647.414861] pci_call_probe+0x6c/0x360 <4> [647.414877] ? _raw_spin_unlock+0x22/0x50 <4> [647.414886] ? pci_match_device+0x16d/0x1a0 <4> [647.414898] pci_device_probe+0xa9/0x140 <4> [647.414903] ? sysfs_create_link+0x21/0x50 <4> [647.414916] really_probe+0xf1/0x410 <4> [647.414928] __driver_probe_device+0x9f/0x1d0 <4> [647.414938] device_driver_attach+0x57/0xd0 <4> [647.414949] bind_store+0x77/0xd0 <4> [647.414958] drv_attr_store+0x24/0x50 <4> [647.414966] sysfs_kf_write+0x4d/0x80 <4> [647.414976] kernfs_fop_write_iter+0x188/0x240 <4> [647.414989] vfs_write+0x283/0x540 <4> [647.415012] ksys_write+0x6f/0xf0 <4> [647.415024] __x64_sys_write+0x19/0x30 <4> [647.415030] x64_sys_call+0x259/0x26e0 <4> [647.415038] do_syscall_64+0x103/0x1410 <4> [647.415059] ? check_bytes_and_report+0x59/0x150 <4> [647.415071] ? find_held_lock+0x31/0x90 <4> [647.415080] ? free_to_partial_list+0x475/0x650 <4> [647.415089] ? lock_release+0xd0/0x2b0 <4> [647.415096] ? _raw_spin_unlock_irqrestore+0x51/0x80 <4> [647.415103] ? free_to_partial_list+0x475/0x650 <4> [647.415110] ? trace_hardirqs_on+0x22/0xf0 <4> [647.415121] ? _raw_spin_unlock_irqrestore+0x51/0x80 <4> [647.415130] ? free_to_partial_list+0x475/0x650 <4> [647.415138] ? putname+0x41/0x90 <4> [647.415152] ? __slab_free+0x12d/0x2c0 <4> [647.415162] ? putname+0x41/0x90 <4> [647.415168] ? __pcs_replace_full_main+0x2a6/0x720 <4> [647.415176] ? __pcs_replace_full_main+0x10/0x720 <4> [647.415186] ? putname+0x41/0x90 <4> [647.415192] ? kmem_cache_free+0x171/0x510 <4> [647.415208] ? putname+0x41/0x90 <4> [647.415215] ? do_sys_openat2+0x85/0xd0 <4> [647.415229] ? __x64_sys_openat+0x54/0xa0 <4> [647.415237] ? trace_hardirqs_on_prepare+0xd7/0xf0 <4> [647.415248] ? do_syscall_64+0x34/0x1410 <4> [647.415254] ? entry_SYSCALL_64_after_hwframe+0x76/0x7e <4> [647.415260] ? trace_hardirqs_on+0x22/0xf0 <4> [647.415270] ? do_syscall_64+0xb8/0x1410 <4> [647.415276] ? exc_page_fault+0xbd/0x2b0 <4> [647.415288] entry_SYSCALL_64_after_hwframe+0x76/0x7e <4> [647.415293] RIP: 0033:0x7fe2d731c5a4 <4> [647.415300] Code: c7 00 16 00 00 00 b8 ff ff ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 f3 0f 1e fa 80 3d a5 ea 0e 00 00 74 13 b8 01 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 54 c3 0f 1f 00 55 48 89 e5 48 83 ec 20 48 89 <4> [647.415305] RSP: 002b:00007ffc132cff38 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 <4> [647.415312] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007fe2d731c5a4 <4> [647.415316] RDX: 000000000000000c RSI: 00007ffc132d0170 RDI: 000000000000000c <4> [647.415320] RBP: 000000000000000c R08: 0000000000000073 R09: 0000000000000000 <4> [647.415324] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffc132d0170 <4> [647.415328] R13: 000000000000000c R14: 00005fa032b681b8 R15: 00005fa032b6828e <4> [647.415353] </TASK> <4> [647.415357] irq event stamp: 3005857 <4> [647.415360] hardirqs last enabled at (3005863): [<ffffffff814ab4d9>] __up_console_sem+0x79/0xa0 <4> [647.415367] hardirqs last disabled at (3005868): [<ffffffff814ab4be>] __up_console_sem+0x5e/0xa0 <4> [647.415372] softirqs last enabled at (3005528): [<ffffffff813d228b>] __irq_exit_rcu+0xdb/0x1c0 <4> [647.415380] softirqs last disabled at (3005523): [<ffffffff813d228b>] __irq_exit_rcu+0xdb/0x1c0 <4> [647.415386] ---[ end trace 0000000000000000 ]--- <5> [647.465393] i915 0000:03:00.0: [drm] Waiting for HW initialisation... <3> [827.467193] i915 0000:03:00.0: [drm] ERROR GT0: intel_pcode_init failed -517 <3> [827.502852] i915 0000:03:00.0: [drm] ERROR Device initialization failed (-517) <6> [827.506312] [IGT] i915_module_load: finished subtest __uc_init, FAIL <6> [827.507362] [IGT] i915_module_load: starting dynamic subtest i915_driver_mmio_probe <6> [827.508268] [IGT] add ignored dmesg regex: .Failed to register driver for userspace access!\|.Device initialization failed.\|.probe with driver i915 failed with error.\|.GT1: GSC proxy handler failed to init.\|.GT0: GUC: failed with -ENXIO.\|.GuC fw rsa data creation failed -ENXIO.\|.GUC: failed with -ENXIO.\|.Failed to register driver for userspace access.\|.GT0: GuC fw rsa data creation failed -ENXIO.*

Detail

Value

Duration

unknown

Hostname

shard-dg1-14

Igt-Version

IGT-Version: 2.4-g02b0e01dd (x86_64) (Linux: 7.1.0-rc1-CI_DRM_18379-g9ee30ac229d6+ x86_64)

Out

Using IGT_SRANDOM=1777496567 for randomisation
Starting subtest: fault-injection
Opened device: /dev/dri/card0
Starting dynamic subtest: __uc_init
Timed out: Driver unbind re-bind timeout!
Dynamic subtest __uc_init: FAIL (205.615s)

This test caused an abort condition: Kernel badly tainted (0x4244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.
Starting dynamic subtest: i915_driver_mmio_probe

Err

Starting subtest: fault-injection
Starting dynamic subtest: __uc_init
Dynamic subtest __uc_init failed.
**** DEBUG ****
(i915_module_load:3487) DEBUG: Test requirement passed: guc == GEM_SUBMISSION_GUC
(i915_module_load:3487) DEBUG: probability = 100, interval = 0, times = -1, space = 0
(i915_module_load:3487) igt_core-INFO: Timed out: Driver unbind re-bind timeout!
****  END  ****
Dynamic subtest __uc_init: FAIL (205.615s)
Starting dynamic subtest: i915_driver_mmio_probe

Dmesg

Scroll to first warning

<7> [621.841866] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DC_off

<7> [621.842075] i915 0000:03:00.0: [drm:gen9_enable_dc5 [i915]] Enabling DC5

<7> [621.842227] i915 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 01

<6> [621.854506] Console: switching to colour dummy device 80x25

<6> [621.855214] [IGT] i915_module_load: executing

<6> [621.860977] [IGT] i915_module_load: starting subtest fault-injection

<7> [621.863396] i915 0000:03:00.0: [drm:i915_gem_open [i915]]

<7> [621.864572] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]

<7> [621.864947] i915 0000:03:00.0: [drm:i915_gem_open [i915]]

<6> [621.890850] [IGT] i915_module_load: starting dynamic subtest __uc_init

<6> [621.891526] [IGT] add ignored dmesg regex: .*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*

<7> [621.892486] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling DC_off

<7> [621.893096] i915 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 01 to 00

<7> [621.893441] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_2

<7> [621.893645] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_3

<7> [621.893971] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_4

<7> [621.894164] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_5

<7> [621.897797] i915 0000:03:00.0: [drm:atomic_remove_fb] Disabling [PLANE:35:plane 1A] because [FB:636] is removed

<7> [621.898066] i915 0000:03:00.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:35:plane 1A] ddb ( 0 - 2012) -> ( 0 - 0), size 2012 -> 0

<7> [621.898264] i915 0000:03:00.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:35: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> [621.898408] i915 0000:03:00.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:35:plane 1A] lines 1, 5, 5, 5, 8, 8, 9, 10, 0, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0

<7> [621.898552] i915 0000:03:00.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:35:plane 1A] blocks 16, 81, 81, 81, 129, 129, 145, 161, 30, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0

<7> [621.898696] i915 0000:03:00.0: [drm:skl_print_plane_wm_changes [i915]] [PLANE:35:plane 1A] min_ddb 19, 91, 91, 91, 143, 143, 161, 179, 31, 0, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0

<7> [621.898975] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:171:pipe A] data rate 0 num active planes 0

<7> [621.899176] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 34000 required 0

<7> [621.899352] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] No SAGV, using single QGV point mask 0x1

<7> [621.904280] i915 0000:03:00.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:35:plane 1A]

<7> [621.921759] i915 0000:03:00.0: [drm:drm_client_release] fbdev

<7> [621.926185] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.enable (expected yes, found no)

<7> [621.926380] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.active (expected yes, found no)

<7> [621.926537] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)

<7> [621.926691] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in lane_count (expected 4, found 0)

<7> [621.926998] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)

<7> [621.927177] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)

<7> [621.927330] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)

<7> [621.928025] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)

<7> [621.928186] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)

<7> [621.928339] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)

<7> [621.928491] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)

<7> [621.928642] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)

<7> [621.929042] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)

<7> [621.929196] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)

<7> [621.929348] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)

<7> [621.929499] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)

<7> [621.929650] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)

<7> [621.930091] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)

<7> [621.930255] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)

<7> [621.930406] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)

<7> [621.930558] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)

<7> [621.930709] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)

<7> [621.930904] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)

<7> [621.931056] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)

<7> [621.931206] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)

<7> [621.931357] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)

<7> [621.931508] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)

<7> [621.931659] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)

<7> [621.931857] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)

<7> [621.932009] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)

<7> [621.932484] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)

<7> [621.932637] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)

<7> [621.932815] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)

<7> [621.932982] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0)

<7> [621.933134] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0)

<7> [621.933285] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0)

<7> [621.933436] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:171:pipe A] fastset requirement not met in port_clock (expected 148500, found 0)

<7> [621.933588] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:171:pipe A] fastset requirement not met, forcing full modeset

<7> [621.933740] i915 0000:03:00.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:171:pipe A] releasing DPLL 0

<7> [621.934000] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no

<7> [621.934149] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [CRTC:171:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0

<7> [621.934357] i915 0000:03:00.0: [drm:skl_print_plane_ddb_changes [i915]] [PLANE:165:cursor A] ddb (2012 - 2048) -> ( 0 - 0), size 36 -> 0

<7> [621.934925] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:171:pipe A] min cdclk: 74250 kHz -> 0 kHz

<7> [621.935081] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [CRTC:171:pipe A] enable: no [modeset]

<7> [621.935232] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:35:plane 1A] fb: [NOFB], visible: no

<7> [621.935384] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:65:plane 2A] fb: [NOFB], visible: no

<7> [621.935534] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:95:plane 3A] fb: [NOFB], visible: no

<7> [621.935684] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:125:plane 4A] fb: [NOFB], visible: no

<7> [621.935875] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:135:plane 5A] fb: [NOFB], visible: no

<7> [621.936026] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:145:plane 6A] fb: [NOFB], visible: no

<7> [621.936176] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:155:plane 7A] fb: [NOFB], visible: no

<7> [621.936325] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:165:cursor A] fb: [NOFB], visible: no

<7> [621.937313] i915 0000:03:00.0: [drm:intel_disable_transcoder [i915]] disabling pipe A

<7> [621.955964] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_A

<7> [621.956356] i915 0000:03:00.0: [drm:intel_dpll_disable [i915]] disable DPLL 0 (active 0x1, on? 1) for [CRTC:171:pipe A]

<7> [621.956591] i915 0000:03:00.0: [drm:intel_dpll_disable [i915]] disabling DPLL 0

<7> [621.956775] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:587:DDI A/PHY A]

<7> [621.956962] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:589:DP-MST A]

<7> [621.957114] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:590:DP-MST B]

<7> [621.957265] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:591:DP-MST C]

<7> [621.957414] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:592:DP-MST D]

<7> [621.957563] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:606:DDI B/PHY B]

<7> [621.957712] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:610:DDI TC1/PHY C]

<7> [621.957868] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:612:DP-MST A]

<7> [621.958017] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:613:DP-MST B]

<7> [621.958166] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:614:DP-MST C]

<7> [621.958316] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:615:DP-MST D]

<7> [621.958465] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:622:DDI TC2/PHY D]

<7> [621.958613] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:624:DP-MST A]

<7> [621.958762] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:625:DP-MST B]

<7> [621.958954] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:626:DP-MST C]

<7> [621.959102] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:627:DP-MST D]

<7> [621.959251] i915 0000:03:00.0: [drm:verify_connector_state [i915]] [CONNECTOR:600:HDMI-A-1]

<7> [621.959568] i915 0000:03:00.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1

<7> [621.959850] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:171:pipe A]

<7> [621.972377] i915 0000:03:00.0: [drm:intel_gt_set_wedged [i915]] called from intel_gt_set_wedged_on_fini+0x12/0x50 [i915]

<7> [621.997528] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:588:DP-1] removing connector from sysfs

<7> [621.998711] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:600:HDMI-A-1] removing connector from sysfs

<7> [621.999460] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:607:HDMI-A-2] removing connector from sysfs

<7> [622.003409] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:611:DP-2] removing connector from sysfs

<7> [622.006688] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:619:HDMI-A-3] removing connector from sysfs

<7> [622.011384] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:623:DP-3] removing connector from sysfs

<7> [622.011871] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:631:HDMI-A-4] removing connector from sysfs

<3> [622.865944] pci 0000:03:00.0: timed out waiting for pending transaction; performing function level reset anyway

<6> [622.975369] i915 0000:03:00.0: [drm] Found dg1 (device ID 4905) discrete display version 12.00 stepping B0

<7> [622.976684] i915 0000:03:00.0: [drm:intel_wopcm_init_early [i915]] WOPCM: 2048K

<7> [622.976930] i915 0000:03:00.0: [drm:intel_uc_init_early [i915]] GT0: enable_guc=3 (guc:yes submission:yes huc:yes slpc:yes)

<7> [622.977072] i915 0000:03:00.0: [drm:intel_pch_detect [i915]] PCH not involved in display, using fake PCH type 1024 for south display

<7> [622.977218] i915 0000:03:00.0: [drm:intel_dmc_wl_init [i915]] Sanitized enable_dmc_wl value: 0 (disabled)

<7> [622.977471] i915 0000:03:00.0: [drm:intel_gt_probe_all [i915]] GT0: Setting up Primary GT

<7> [622.977856] i915 0000:03:00.0: [drm:intel_display_device_info_runtime_init [i915]] rawclk rate: 38400 kHz

<7> [623.528588] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11)

<3> [623.578784] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

<5> [623.579021] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<7> [624.129776] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11)

<3> [624.179897] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

<5> [624.179914] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<4> [624.180082] ------------[ cut here ]------------

<4> [624.180085] i915 0000:03:00.0: [drm] drm_WARN_ON(s_en != 0x1)

<4> [624.180087] WARNING: drivers/gpu/drm/i915/gt/intel_sseu.c:277 at intel_sseu_info_init+0xd3f/0x1070 [i915], CPU#0: i915_module_loa/3487

<4> [624.180215] Modules linked in: vgem snd_hda_codec_intelhdmi snd_hda_codec_hdmi mei_lb mei_gsc i915 prime_numbers drm_buddy ttm drm_display_helper cec rc_core i2c_algo_bit kunit intel_rapl_msr intel_rapl_common intel_uncore_frequency intel_uncore_frequency_common intel_tcc_cooling ee1004 cmdlinepart x86_pkg_temp_thermal spi_nor hid_generic mtd intel_powerclamp coretemp gigabyte_wmi overlay mei_pxp wmi_bmof mei_hdcp intel_wmi_thunderbolt mxm_wmi kvm_intel kvm irqbypass aesni_intel snd_hda_intel gf128mul snd_intel_dspcfg rapl snd_hda_codec snd_hda_core snd_hwdep intel_cstate snd_pcm video snd_timer i2c_i801 usbhid spi_intel_pci i2c_mux e1000e spi_intel i2c_smbus hid snd soundcore binfmt_misc intel_pmc_core pmt_telemetry pmt_discovery pmt_class intel_pmc_ssram_telemetry pinctrl_cannonlake intel_vsec acpi_pad mei_me wmi mei intel_pch_thermal nls_iso8859_1 dm_multipath msr nvme_fabrics fuse efi_pstore nfnetlink autofs4

<4> [624.180327] CPU: 0 UID: 0 PID: 3487 Comm: i915_module_loa Tainted: G S U W L 7.1.0-rc1-CI_DRM_18379-g9ee30ac229d6+ #1 PREEMPT(lazy)

<4> [624.180331] Tainted: [S]=CPU_OUT_OF_SPEC, [U]=USER, [W]=WARN, [L]=SOFTLOCKUP

<4> [624.180333] Hardware name: Gigabyte Technology Co., Ltd. GB-Z390 Garuda/GB-Z390 Garuda-CF, BIOS IG1c 11/19/2019

<4> [624.180336] RIP: 0010:intel_sseu_info_init+0xd49/0x1070 [i915]

<4> [624.180464] Code: 04 48 8b 7f 08 4c 8b 67 50 4d 85 e4 75 03 4c 8b 27 e8 4b af 57 e1 48 89 c6 48 8d 3d 71 b4 34 00 48 c7 c1 a8 d0 1f a1 4c 89 e2 <67> 48 0f b9 3a e9 68 f5 ff ff 44 0f b7 ab 00 23 00 00 4c 89 e7 e8

<4> [624.180467] RSP: 0018:ffffc90003263680 EFLAGS: 00010246

<4> [624.180470] RAX: ffffffffa11f711e RBX: ffff88811b564028 RCX: ffffffffa11fd0a8

<4> [624.180473] RDX: ffff8881037e6e90 RSI: ffffffffa11f711e RDI: ffffffffa1007fd0

<4> [624.180475] RBP: ffffc90003263700 R08: 0000000000000000 R09: 0000000000000000

<4> [624.180477] R10: 0000000000000000 R11: 0000000000000000 R12: ffff8881037e6e90

<4> [624.180479] R13: ffff88811b566288 R14: ffff8881400e4e00 R15: 0000000000000000

<4> [624.180481] FS: 00007fe2d51d4940(0000) GS:ffff888529683000(0000) knlGS:0000000000000000

<4> [624.180483] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033

<4> [624.180485] CR2: 00005fbe980b0288 CR3: 00000001479a5001 CR4: 00000000003726f0

<4> [624.180488] Call Trace:

<4> [624.180490] <TASK>

<4> [624.180492] ? fwtable_reg_write_fw_domains+0x4b/0x60 [i915]

<4> [624.180598] ? intel_uncore_forcewake_for_reg+0x57/0x120 [i915]

<4> [624.180706] intel_gt_init_mmio+0x23/0x40 [i915]

<4> [624.180829] i915_driver_mmio_probe+0xb4/0x130 [i915]

<4> [624.180930] i915_driver_probe+0x105/0x5d0 [i915]

<4> [624.181029] ? mutex_unlock+0x12/0x20

<4> [624.181034] ? drm_privacy_screen_get+0x171/0x190

<4> [624.181037] ? acpi_dev_found+0x66/0x80

<4> [624.181046] i915_pci_probe+0xe0/0x1d0 [i915]

<4> [624.181147] local_pci_probe+0x47/0xb0

<4> [624.181153] pci_call_probe+0x6c/0x360

<4> [624.181161] ? _raw_spin_unlock+0x22/0x50

<4> [624.181166] ? pci_match_device+0x16d/0x1a0

<4> [624.181171] pci_device_probe+0xa9/0x140

<4> [624.181174] ? sysfs_create_link+0x21/0x50

<4> [624.181180] really_probe+0xf1/0x410

<4> [624.181186] __driver_probe_device+0x9f/0x1d0

<4> [624.181191] device_driver_attach+0x57/0xd0

<4> [624.181196] bind_store+0x77/0xd0

<4> [624.181201] drv_attr_store+0x24/0x50

<4> [624.181205] sysfs_kf_write+0x4d/0x80

<4> [624.181209] kernfs_fop_write_iter+0x188/0x240

<4> [624.181216] vfs_write+0x283/0x540

<4> [624.181228] ksys_write+0x6f/0xf0

<4> [624.181233] __x64_sys_write+0x19/0x30

<4> [624.181236] x64_sys_call+0x259/0x26e0

<4> [624.181241] do_syscall_64+0x103/0x1410

<4> [624.181251] ? check_bytes_and_report+0x59/0x150

<4> [624.181257] ? find_held_lock+0x31/0x90

<4> [624.181262] ? free_to_partial_list+0x475/0x650

<4> [624.181266] ? lock_release+0xd0/0x2b0

<4> [624.181269] ? _raw_spin_unlock_irqrestore+0x51/0x80

<4> [624.181273] ? free_to_partial_list+0x475/0x650

<4> [624.181276] ? trace_hardirqs_on+0x22/0xf0

<4> [624.181282] ? _raw_spin_unlock_irqrestore+0x51/0x80

<4> [624.181287] ? free_to_partial_list+0x475/0x650

<4> [624.181291] ? putname+0x41/0x90

<4> [624.181298] ? __slab_free+0x12d/0x2c0

<4> [624.181303] ? putname+0x41/0x90

<4> [624.181306] ? __pcs_replace_full_main+0x2a6/0x720

<4> [624.181310] ? __pcs_replace_full_main+0x10/0x720

<4> [624.181315] ? putname+0x41/0x90

<4> [624.181318] ? kmem_cache_free+0x171/0x510

<4> [624.181326] ? putname+0x41/0x90

<4> [624.181329] ? do_sys_openat2+0x85/0xd0

<4> [624.181336] ? __x64_sys_openat+0x54/0xa0

<4> [624.181340] ? trace_hardirqs_on_prepare+0xd7/0xf0

<4> [624.181345] ? do_syscall_64+0x34/0x1410

<4> [624.181348] ? entry_SYSCALL_64_after_hwframe+0x76/0x7e

<4> [624.181351] ? trace_hardirqs_on+0x22/0xf0

<4> [624.181356] ? do_syscall_64+0xb8/0x1410

<4> [624.181359] ? exc_page_fault+0xbd/0x2b0

<4> [624.181365] entry_SYSCALL_64_after_hwframe+0x76/0x7e

<4> [624.181367] RIP: 0033:0x7fe2d731c5a4

<4> [624.181372] Code: c7 00 16 00 00 00 b8 ff ff ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 f3 0f 1e fa 80 3d a5 ea 0e 00 00 74 13 b8 01 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 54 c3 0f 1f 00 55 48 89 e5 48 83 ec 20 48 89

<4> [624.181374] RSP: 002b:00007ffc132cff38 EFLAGS: 00000202 ORIG_RAX: 0000000000000001

<4> [624.181377] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007fe2d731c5a4

<4> [624.181379] RDX: 000000000000000c RSI: 00007ffc132d0170 RDI: 000000000000000c

<4> [624.181381] RBP: 000000000000000c R08: 0000000000000073 R09: 0000000000000000

<4> [624.181383] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffc132d0170

<4> [624.181385] R13: 000000000000000c R14: 00005fa032b681b8 R15: 00005fa032b6828e

<4> [624.181397] </TASK>

<4> [624.181399] irq event stamp: 196663

<4> [624.181401] hardirqs last enabled at (196669): [<ffffffff814ab4d9>] __up_console_sem+0x79/0xa0

<4> [624.181404] hardirqs last disabled at (196674): [<ffffffff814ab4be>] __up_console_sem+0x5e/0xa0

<4> [624.181407] softirqs last enabled at (196298): [<ffffffff813d228b>] __irq_exit_rcu+0xdb/0x1c0

<4> [624.181411] softirqs last disabled at (196289): [<ffffffff813d228b>] __irq_exit_rcu+0xdb/0x1c0

<4> [624.181414] ---[ end trace 0000000000000000 ]---

<7> [624.731993] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11)

<3> [624.782114] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

<5> [624.782131] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<7> [625.332859] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11)

<3> [625.382971] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

<5> [625.382988] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<7> [625.933742] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11)

<3> [625.983857] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

<5> [625.983874] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<7> [626.534671] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11)

<3> [626.584818] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

<5> [626.584848] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<7> [626.585181] i915 0000:03:00.0: [drm:intel_engines_init_mmio [i915]] GT0: vdbox enable: 0005, instances: 0005

<7> [626.585308] i915 0000:03:00.0: [drm:intel_engines_init_mmio [i915]] GT0: vebox enable: 0001, instances: 0001

<7> [627.136038] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] render had to use fallback to set ack, 0x0 (passes 11)

<3> [627.186154] i915 0000:03:00.0: [drm] *ERROR* render: timed out waiting for forcewake ack request.

<5> [627.186172] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<7> [627.736969] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] vdbox0 had to use fallback to set ack, 0x0 (passes 11)

<3> [627.787090] i915 0000:03:00.0: [drm] *ERROR* vdbox0: timed out waiting for forcewake ack request.

<5> [627.787108] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<7> [628.338111] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] vdbox2 had to use fallback to set ack, 0x0 (passes 11)

<3> [628.388249] i915 0000:03:00.0: [drm] *ERROR* vdbox2: timed out waiting for forcewake ack request.

<5> [628.388269] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<7> [628.939074] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] vebox0 had to use fallback to set ack, 0x0 (passes 11)

<3> [628.989200] i915 0000:03:00.0: [drm] *ERROR* vebox0: timed out waiting for forcewake ack request.

<5> [628.989219] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<7> [629.539996] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11)

<3> [629.590114] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

<5> [629.590133] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<7> [630.140877] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11)

<3> [630.190997] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

<5> [630.191014] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<7> [630.741784] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] render had to use fallback to set ack, 0x0 (passes 11)

<3> [630.791918] i915 0000:03:00.0: [drm] *ERROR* render: timed out waiting for forcewake ack request.

<5> [630.791938] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<7> [631.342720] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] render had to use fallback to set ack, 0x0 (passes 11)

<3> [631.392852] i915 0000:03:00.0: [drm] *ERROR* render: timed out waiting for forcewake ack request.

<5> [631.392872] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<7> [631.943720] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] render had to use fallback to set ack, 0x0 (passes 11)

<3> [631.993848] i915 0000:03:00.0: [drm] *ERROR* render: timed out waiting for forcewake ack request.

<5> [631.993866] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<7> [632.545401] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] render had to use fallback to set ack, 0x0 (passes 11)

<3> [632.595520] i915 0000:03:00.0: [drm] *ERROR* render: timed out waiting for forcewake ack request.

<5> [632.595539] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<7> [633.146296] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11)

<3> [633.196407] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

<5> [633.196425] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<7> [633.747166] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11)

<3> [633.797280] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

<5> [633.797298] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<7> [634.348030] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11)

<3> [634.398148] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

<5> [634.398166] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<7> [634.948927] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] render had to use fallback to set ack, 0x0 (passes 11)

<3> [634.999233] i915 0000:03:00.0: [drm] *ERROR* render: timed out waiting for forcewake ack request.

<5> [634.999473] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<7> [635.550153] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] gt had to use fallback to set ack, 0x0 (passes 11)

<3> [635.600263] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

<5> [635.600280] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<7> [636.150978] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] vdbox0 had to use fallback to set ack, 0x0 (passes 11)

<3> [636.201082] i915 0000:03:00.0: [drm] *ERROR* vdbox0: timed out waiting for forcewake ack request.

<5> [636.201099] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<7> [636.751798] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] vdbox2 had to use fallback to set ack, 0x0 (passes 11)

<3> [636.801906] i915 0000:03:00.0: [drm] *ERROR* vdbox2: timed out waiting for forcewake ack request.

<5> [636.801923] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<7> [637.352619] i915 0000:03:00.0: [drm:fw_domain_wait_ack_with_fallback [i915]] vebox0 had to use fallback to set ack, 0x0 (passes 11)

<3> [637.402723] i915 0000:03:00.0: [drm] *ERROR* vebox0: timed out waiting for forcewake ack request.

<5> [637.402739] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915]

<3> [637.403648] i915 0000:03:00.0: [drm] *ERROR* GT0: rcs'0 reset request timed out: {request: 00000001, RESET_CTL: 00000000}

<3> [637.404376] i915 0000:03:00.0: [drm] *ERROR* GT0: rcs'0 reset request timed out: {request: 00000001, RESET_CTL: 00000000}

<3> [637.405099] i915 0000:03:00.0: [drm] *ERROR* GT0: bcs'0 reset request timed out: {request: 00000001, RESET_CTL: 00000000}

<3> [637.405823] i915 0000:03:00.0: [drm] *ERROR* GT0: vcs'0 reset request timed out: {request: 00000001, RESET_CTL: 00000000}

<3> [637.406545] i915 0000:03:00.0: [drm] *ERROR* GT0: vcs'2 reset request timed out: {request: 00000001, RESET_CTL: 00000000}

<3> [637.407268] i915 0000:03:00.0: [drm] *ERROR* GT0: vecs'0 reset request timed out: {request: 00000001, RESET_CTL: 00000000}

<7> [637.408124] i915 0000:03:00.0: [drm:i915_ggtt_probe_hw [i915]] GGTT size = 4096M

<7> [637.408253] i915 0000:03:00.0: [drm:i915_ggtt_probe_hw [i915]] GMADR size = 0M

<7> [637.408366] i915 0000:03:00.0: [drm:i915_ggtt_probe_hw [i915]] DSM size = 0M

<6> [637.408479] i915 0000:03:00.0: [drm] VT-d active for gfx access

<6> [637.408573] i915 0000:03:00.0: vgaarb: deactivate vga console

<7> [637.409237] i915 0000:03:00.0: [drm:intel_gt_setup_lmem [i915]] LMEM: reserved legacy low-memory [0x0-0x100000]

<7> [637.409658] i915 0000:03:00.0: [drm:i915_gem_init_stolen [i915]] GEN6_STOLEN_RESERVED = 0x00000000ffc00107

<7> [637.409799] i915 0000:03:00.0: [drm:i915_gem_init_stolen [i915]] Memory reserved for graphics device: 65536K, usable: 61440K

<7> [637.410285] i915 0000:03:00.0: [drm:intel_memory_regions_hw_probe [i915]] Memory region(0): system-ttm: 15842 MiB [mem 0x00000000-0x3de2ddfff], io: n/a

<7> [637.410389] i915 0000:03:00.0: [drm:intel_memory_regions_hw_probe [i915]] Memory region(1): local0: 4024 MiB [mem 0x00000000-0xfb7fffff], io: 4024 MiB [mem 0x4000000000-0x40fb7fffff]

<7> [637.410491] i915 0000:03:00.0: [drm:intel_memory_regions_hw_probe [i915]] Memory region(6): stolen-local: 60 MiB [mem 0xfc000000-0xffbfffff], io: 60 MiB [mem 0x40fc000000-0x40ffbfffff]

<7> [637.411490] i915 0000:03:00.0: [drm:intel_opregion_setup [i915]] graphic opregion physical addr: 0x0

<7> [637.411647] i915 0000:03:00.0: [drm:intel_opregion_setup [i915]] ACPI OpRegion not supported!

<7> [647.412611] i915 0000:03:00.0: [drm:skl_pcode_request [i915]] PCODE timeout, retrying with preemption disabled

<4> [647.412877] ------------[ cut here ]------------

<4> [647.412881] i915 0000:03:00.0: [drm] drm_WARN_ON_ONCE(timeout_base_ms > 3)

<4> [647.412885] WARNING: drivers/gpu/drm/i915/intel_pcode.c:200 at skl_pcode_request+0x25f/0x280 [i915], CPU#3: i915_module_loa/3487

<4> [647.413085] Modules linked in: vgem snd_hda_codec_intelhdmi snd_hda_codec_hdmi mei_lb mei_gsc i915 prime_numbers drm_buddy ttm drm_display_helper cec rc_core i2c_algo_bit kunit intel_rapl_msr intel_rapl_common intel_uncore_frequency intel_uncore_frequency_common intel_tcc_cooling ee1004 cmdlinepart x86_pkg_temp_thermal spi_nor hid_generic mtd intel_powerclamp coretemp gigabyte_wmi overlay mei_pxp wmi_bmof mei_hdcp intel_wmi_thunderbolt mxm_wmi kvm_intel kvm irqbypass aesni_intel snd_hda_intel gf128mul snd_intel_dspcfg rapl snd_hda_codec snd_hda_core snd_hwdep intel_cstate snd_pcm video snd_timer i2c_i801 usbhid spi_intel_pci i2c_mux e1000e spi_intel i2c_smbus hid snd soundcore binfmt_misc intel_pmc_core pmt_telemetry pmt_discovery pmt_class intel_pmc_ssram_telemetry pinctrl_cannonlake intel_vsec acpi_pad mei_me wmi mei intel_pch_thermal nls_iso8859_1 dm_multipath msr nvme_fabrics fuse efi_pstore nfnetlink autofs4

<4> [647.413312] CPU: 3 UID: 0 PID: 3487 Comm: i915_module_loa Tainted: G S U W L 7.1.0-rc1-CI_DRM_18379-g9ee30ac229d6+ #1 PREEMPT(lazy)

<4> [647.413320] Tainted: [S]=CPU_OUT_OF_SPEC, [U]=USER, [W]=WARN, [L]=SOFTLOCKUP

<4> [647.413324] Hardware name: Gigabyte Technology Co., Ltd. GB-Z390 Garuda/GB-Z390 Garuda-CF, BIOS IG1c 11/19/2019

<4> [647.413328] RIP: 0010:skl_pcode_request+0x269/0x280 [i915]

<4> [647.413526] Code: 04 48 8b 7f 08 48 8b 5f 50 48 85 db 75 03 48 8b 1f e8 4b 62 62 e1 48 89 c6 48 8d 3d 91 fc 3e 00 48 c7 c1 f8 0f 21 a1 48 89 da <67> 48 0f b9 3a e9 15 ff ff ff e8 88 a3 d0 e1 0f 1f 84 00 00 00 00

<4> [647.413531] RSP: 0018:ffffc90003263660 EFLAGS: 00010246

<4> [647.413538] RAX: ffffffffa11f711e RBX: ffff8881037e6e90 RCX: ffffffffa1210ff8

<4> [647.413542] RDX: ffff8881037e6e90 RSI: ffffffffa11f711e RDI: ffffffffa10014f0

<4> [647.413546] RBP: ffffc900032636a8 R08: 0000000000000000 R09: 0000000000000000

<4> [647.413550] R10: 0000000000000000 R11: 0000000000000000 R12: ffff8881400e4e00

<4> [647.413554] R13: 000000000000007e R14: 0000000000000000 R15: 00000096b56b3411

<4> [647.413558] FS: 00007fe2d51d4940(0000) GS:ffff888529803000(0000) knlGS:0000000000000000

<4> [647.413563] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033

<4> [647.413567] CR2: 0000743a2c421008 CR3: 00000001479a5001 CR4: 00000000003726f0

<4> [647.413571] Call Trace:

<4> [647.413575] <TASK>

<4> [647.413588] pcode_init_wait+0x50/0x80 [i915]

<4> [647.413806] intel_pcode_init+0x33/0x80 [i915]

<4> [647.414006] i915_pcode_init+0x29/0xd0 [i915]

<4> [647.414200] i915_driver_hw_probe+0x326/0x3c0 [i915]

<4> [647.414398] i915_driver_probe+0x114/0x5d0 [i915]

<4> [647.414590] ? mutex_unlock+0x12/0x20

<4> [647.414598] ? drm_privacy_screen_get+0x171/0x190

<4> [647.414605] ? acpi_dev_found+0x66/0x80

<4> [647.414623] i915_pci_probe+0xe0/0x1d0 [i915]

<4> [647.414849] local_pci_probe+0x47/0xb0

<4> [647.414861] pci_call_probe+0x6c/0x360

<4> [647.414877] ? _raw_spin_unlock+0x22/0x50

<4> [647.414886] ? pci_match_device+0x16d/0x1a0

<4> [647.414898] pci_device_probe+0xa9/0x140

<4> [647.414903] ? sysfs_create_link+0x21/0x50

<4> [647.414916] really_probe+0xf1/0x410

<4> [647.414928] __driver_probe_device+0x9f/0x1d0

<4> [647.414938] device_driver_attach+0x57/0xd0

<4> [647.414949] bind_store+0x77/0xd0

<4> [647.414958] drv_attr_store+0x24/0x50

<4> [647.414966] sysfs_kf_write+0x4d/0x80

<4> [647.414976] kernfs_fop_write_iter+0x188/0x240

<4> [647.414989] vfs_write+0x283/0x540

<4> [647.415012] ksys_write+0x6f/0xf0

<4> [647.415024] __x64_sys_write+0x19/0x30

<4> [647.415030] x64_sys_call+0x259/0x26e0

<4> [647.415038] do_syscall_64+0x103/0x1410

<4> [647.415059] ? check_bytes_and_report+0x59/0x150

<4> [647.415071] ? find_held_lock+0x31/0x90

<4> [647.415080] ? free_to_partial_list+0x475/0x650

<4> [647.415089] ? lock_release+0xd0/0x2b0

<4> [647.415096] ? _raw_spin_unlock_irqrestore+0x51/0x80

<4> [647.415103] ? free_to_partial_list+0x475/0x650

<4> [647.415110] ? trace_hardirqs_on+0x22/0xf0

<4> [647.415121] ? _raw_spin_unlock_irqrestore+0x51/0x80

<4> [647.415130] ? free_to_partial_list+0x475/0x650

<4> [647.415138] ? putname+0x41/0x90

<4> [647.415152] ? __slab_free+0x12d/0x2c0

<4> [647.415162] ? putname+0x41/0x90

<4> [647.415168] ? __pcs_replace_full_main+0x2a6/0x720

<4> [647.415176] ? __pcs_replace_full_main+0x10/0x720

<4> [647.415186] ? putname+0x41/0x90

<4> [647.415192] ? kmem_cache_free+0x171/0x510

<4> [647.415208] ? putname+0x41/0x90

<4> [647.415215] ? do_sys_openat2+0x85/0xd0

<4> [647.415229] ? __x64_sys_openat+0x54/0xa0

<4> [647.415237] ? trace_hardirqs_on_prepare+0xd7/0xf0

<4> [647.415248] ? do_syscall_64+0x34/0x1410

<4> [647.415254] ? entry_SYSCALL_64_after_hwframe+0x76/0x7e

<4> [647.415260] ? trace_hardirqs_on+0x22/0xf0

<4> [647.415270] ? do_syscall_64+0xb8/0x1410

<4> [647.415276] ? exc_page_fault+0xbd/0x2b0

<4> [647.415288] entry_SYSCALL_64_after_hwframe+0x76/0x7e

<4> [647.415293] RIP: 0033:0x7fe2d731c5a4

<4> [647.415300] Code: c7 00 16 00 00 00 b8 ff ff ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 f3 0f 1e fa 80 3d a5 ea 0e 00 00 74 13 b8 01 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 54 c3 0f 1f 00 55 48 89 e5 48 83 ec 20 48 89

<4> [647.415305] RSP: 002b:00007ffc132cff38 EFLAGS: 00000202 ORIG_RAX: 0000000000000001

<4> [647.415312] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007fe2d731c5a4

<4> [647.415316] RDX: 000000000000000c RSI: 00007ffc132d0170 RDI: 000000000000000c

<4> [647.415320] RBP: 000000000000000c R08: 0000000000000073 R09: 0000000000000000

<4> [647.415324] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffc132d0170

<4> [647.415328] R13: 000000000000000c R14: 00005fa032b681b8 R15: 00005fa032b6828e

<4> [647.415353] </TASK>

<4> [647.415357] irq event stamp: 3005857

<4> [647.415360] hardirqs last enabled at (3005863): [<ffffffff814ab4d9>] __up_console_sem+0x79/0xa0

<4> [647.415367] hardirqs last disabled at (3005868): [<ffffffff814ab4be>] __up_console_sem+0x5e/0xa0

<4> [647.415372] softirqs last enabled at (3005528): [<ffffffff813d228b>] __irq_exit_rcu+0xdb/0x1c0

<4> [647.415380] softirqs last disabled at (3005523): [<ffffffff813d228b>] __irq_exit_rcu+0xdb/0x1c0

<4> [647.415386] ---[ end trace 0000000000000000 ]---

<5> [647.465393] i915 0000:03:00.0: [drm] Waiting for HW initialisation...

<3> [827.467193] i915 0000:03:00.0: [drm] *ERROR* GT0: intel_pcode_init failed -517

<3> [827.502852] i915 0000:03:00.0: [drm] *ERROR* Device initialization failed (-517)

<6> [827.506312] [IGT] i915_module_load: finished subtest __uc_init, FAIL

<6> [827.507362] [IGT] i915_module_load: starting dynamic subtest i915_driver_mmio_probe

<6> [827.508268] [IGT] add ignored dmesg regex: .*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*

Created at 2026-04-29 21:56:12