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-18
Igt-Version	IGT-Version: 2.3-g33f5420a2 (x86_64) (Linux: 7.0.0-rc3-CI_DRM_18150-gb01ac5e93e3a+ x86_64)
Out	Using IGT_SRANDOM=1773618883 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.561s) 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:2380) DEBUG: Test requirement passed: guc == GEM_SUBMISSION_GUC (i915_module_load:2380) DEBUG: probability = 100, interval = 0, times = -1, space = 0 (i915_module_load:2380) igt_core-INFO: Timed out: Driver unbind re-bind timeout! END ** Dynamic subtest __uc_init: FAIL (205.561s) Starting dynamic subtest: i915_driver_mmio_probe
Dmesg Scroll to first warning	<6> [320.960369] Console: switching to colour dummy device 80x25 <6> [320.960937] [IGT] i915_module_load: executing <6> [320.964475] [IGT] i915_module_load: starting subtest fault-injection <7> [320.966589] i915 0000:03:00.0: [drm:i915_gem_open [i915]] <7> [320.967731] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7> [320.968001] i915 0000:03:00.0: [drm:i915_gem_open [i915]] <6> [320.989927] [IGT] i915_module_load: starting dynamic subtest __uc_init <6> [320.990869] [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> [320.991114] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_4 <7> [320.991329] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_5 <7> [320.992481] i915 0000:03:00.0: [drm:atomic_remove_fb] Disabling [PLANE:34:plane 1A] because [FB:633] is removed <7> [320.992537] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:34:plane 1A] ddb ( 0 - 2012) -> ( 0 - 0), size 2012 -> 0 <7> [320.992699] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:34: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> [320.992844] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:34: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> [320.992990] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:34: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> [320.993456] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:34: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> [320.993634] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:170:pipe A] data rate 0 num active planes 0 <7> [320.993785] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 34000 required 0 <7> [321.000682] i915 0000:03:00.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:34:plane 1A] <7> [321.017481] i915 0000:03:00.0: [drm:drm_client_release] fbdev <7> [321.018013] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.enable (expected yes, found no) <7> [321.018890] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.active (expected yes, found no) <7> [321.019117] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1) <7> [321.019312] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in lane_count (expected 4, found 0) <7> [321.019462] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000) <7> [321.019612] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0) <7> [321.019761] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0) <7> [321.019910] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0) <7> [321.020060] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0) <7> [321.020331] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0) <7> [321.020484] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0) <7> [321.020636] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0) <7> [321.020786] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0) <7> [321.020937] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0) <7> [321.021369] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0) <7> [321.021519] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0) <7> [321.021669] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0) <7> [321.021818] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0) <7> [321.021967] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0) <7> [321.022177] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0) <7> [321.022327] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0) <7> [321.022476] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0) <7> [321.022625] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0) <7> [321.022774] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0) <7> [321.022925] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0) <7> [321.023103] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0) <7> [321.023300] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0) <7> [321.023449] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0) <7> [321.023598] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0) <7> [321.023748] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0) <7> [321.023896] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0) <7> [321.024045] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0) <7> [321.024235] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0) <7> [321.024385] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in pipe_bpp (expected 24, found 0) <7> [321.024535] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148500, found 0) <7> [321.024684] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148500, found 0) <7> [321.024833] i915 0000:03:00.0: [drm:intel_pipe_config_compare [i915]] [CRTC:170:pipe A] fastset requirement not met in port_clock (expected 148500, found 0) <7> [321.024982] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:170:pipe A] fastset requirement not met, forcing full modeset <7> [321.025170] i915 0000:03:00.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:170:pipe A] releasing DPLL 2 <7> [321.025354] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no <7> [321.025502] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [CRTC:170:pipe A] dbuf slices 0x3 -> 0x0, ddb (0 - 2048) -> (0 - 0), active pipes 0x1 -> 0x0 <7> [321.025711] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:164:cursor A] ddb (2012 - 2048) -> ( 0 - 0), size 36 -> 0 <7> [321.025899] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:170:pipe A] min cdclk: 74250 kHz -> 0 kHz <7> [321.026051] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [CRTC:170:pipe A] enable: no [modeset] <7> [321.026242] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:34:plane 1A] fb: [NOFB], visible: no <7> [321.026391] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:64:plane 2A] fb: [NOFB], visible: no <7> [321.026539] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:94:plane 3A] fb: [NOFB], visible: no <7> [321.026688] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:124:plane 4A] fb: [NOFB], visible: no <7> [321.026836] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:134:plane 5A] fb: [NOFB], visible: no <7> [321.026984] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:144:plane 6A] fb: [NOFB], visible: no <7> [321.027171] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:154:plane 7A] fb: [NOFB], visible: no <7> [321.027319] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:164:cursor A] fb: [NOFB], visible: no <7> [321.027718] i915 0000:03:00.0: [drm:intel_disable_transcoder [i915]] disabling pipe A <7> [321.034183] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_TC2 <7> [321.034380] i915 0000:03:00.0: [drm:intel_dpll_disable [i915]] disable DPLL 2 (active 0x1, on? 1) for [CRTC:170:pipe A] <7> [321.034563] i915 0000:03:00.0: [drm:intel_dpll_disable [i915]] disabling DPLL 2 <7> [321.034735] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:586:DDI A/PHY A] <7> [321.034884] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:588:DP-MST A] <7> [321.035032] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:589:DP-MST B] <7> [321.035226] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:590:DP-MST C] <7> [321.035374] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:591:DP-MST D] <7> [321.035522] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:605:DDI B/PHY B] <7> [321.035670] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:609:DDI TC1/PHY C] <7> [321.035817] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:611:DP-MST A] <7> [321.035965] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:612:DP-MST B] <7> [321.036151] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:613:DP-MST C] <7> [321.036299] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:614:DP-MST D] <7> [321.036446] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:621:DDI TC2/PHY D] <7> [321.036617] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:623:DP-MST A] <7> [321.036764] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:624:DP-MST B] <7> [321.036912] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:625:DP-MST C] <7> [321.037059] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:626:DP-MST D] <7> [321.037261] i915 0000:03:00.0: [drm:verify_connector_state [i915]] [CONNECTOR:630:HDMI-A-4] <7> [321.037543] i915 0000:03:00.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1 <7> [321.037777] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:170:pipe A] <7> [321.041445] i915 0000:03:00.0: [drm:intel_gt_set_wedged [i915]] called from intel_gt_set_wedged_on_fini+0x12/0x50 [i915] <7> [321.056240] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:587:DP-1] removing connector from sysfs <7> [321.056622] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:599:HDMI-A-1] removing connector from sysfs <7> [321.056983] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:606:HDMI-A-2] removing connector from sysfs <7> [321.061661] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:610:DP-2] removing connector from sysfs <7> [321.062254] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:618:HDMI-A-3] removing connector from sysfs <7> [321.069567] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:622:DP-3] removing connector from sysfs <7> [321.070030] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:630:HDMI-A-4] removing connector from sysfs <3> [321.917235] pci 0000:03:00.0: timed out waiting for pending transaction; performing function level reset anyway <6> [322.023349] i915 0000:03:00.0: [drm] Found dg1 (device ID 4905) discrete display version 12.00 stepping B0 <7> [322.026875] i915 0000:03:00.0: [drm:intel_wopcm_init_early [i915]] WOPCM: 2048K <7> [322.027847] i915 0000:03:00.0: [drm:intel_uc_init_early [i915]] GT0: enable_guc=3 (guc:yes submission:yes huc:yes slpc:yes) <7> [322.028705] i915 0000:03:00.0: [drm:intel_pch_detect [i915]] PCH not involved in display, using fake PCH type 1024 for south display <7> [322.029619] i915 0000:03:00.0: [drm:intel_dmc_wl_init [i915]] Sanitized enable_dmc_wl value: 0 (disabled) <7> [322.030623] i915 0000:03:00.0: [drm:intel_gt_probe_all [i915]] GT0: Setting up Primary GT <7> [322.031577] i915 0000:03:00.0: [drm:intel_display_device_info_runtime_init [i915]] rawclk rate: 38400 kHz <7> [322.582298] 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> [322.632494] i915 0000:03:00.0: [drm] ERROR* gt: timed out waiting for forcewake ack request. <5> [322.632705] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [323.183486] 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> [323.233605] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [323.233609] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <4> [323.234124] ------------[ cut here ]------------ <4> [323.234126] i915 0000:03:00.0: [drm] drm_WARN_ON(s_en != 0x1) <4> [323.234128] WARNING: drivers/gpu/drm/i915/gt/intel_sseu.c:277 at intel_sseu_info_init+0xd3f/0x1070 [i915], CPU#1: i915_module_loa/2380 <4> [323.234261] Modules linked in: snd_hda_intel 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 cmdlinepart spi_nor ee1004 x86_pkg_temp_thermal intel_powerclamp mtd hid_generic coretemp gigabyte_wmi wmi_bmof intel_wmi_thunderbolt mei_pxp mei_hdcp mxm_wmi kvm_intel kvm irqbypass snd_intel_dspcfg ghash_clmulni_intel snd_hda_codec aesni_intel snd_hda_core rapl snd_hwdep intel_cstate i2c_i801 snd_pcm i2c_mux spi_intel_pci snd_timer e1000e spi_intel i2c_smbus usbhid snd hid soundcore video binfmt_misc intel_pmc_core pmt_telemetry pmt_discovery pinctrl_cannonlake pmt_class intel_pmc_ssram_telemetry nls_iso8859_1 acpi_pad intel_vsec mei_me wmi mei intel_pch_thermal dm_multipath msr nvme_fabrics fuse efi_pstore nfnetlink autofs4 [last unloaded: snd_hda_intel] <4> [323.234367] CPU: 1 UID: 0 PID: 2380 Comm: i915_module_loa Tainted: G S U W L 7.0.0-rc3-CI_DRM_18150-gb01ac5e93e3a+ #1 PREEMPT(lazy) <4> [323.234371] Tainted: [S]=CPU_OUT_OF_SPEC, [U]=USER, [W]=WARN, [L]=SOFTLOCKUP <4> [323.234373] Hardware name: Gigabyte Technology Co., Ltd. GB-Z390 Garuda/GB-Z390 Garuda-CF, BIOS IG1c 11/19/2019 <4> [323.234375] RIP: 0010:intel_sseu_info_init+0xd49/0x1070 [i915] <4> [323.234499] Code: 04 48 8b 7f 08 4c 8b 67 50 4d 85 e4 75 03 4c 8b 27 e8 3b 45 59 e1 48 89 c6 48 8d 3d 21 d2 34 00 48 c7 c1 11 ac 1f a1 4c 89 e2 <67> 48 0f b9 3a e9 68 f5 ff ff 44 0f b7 ab 40 23 00 00 4c 89 e7 e8 <4> [323.234501] RSP: 0018:ffffc90020d67720 EFLAGS: 00010246 <4> [323.234504] RAX: ffffffffa11f4d5e RBX: ffff88813d8a0028 RCX: ffffffffa11fac11 <4> [323.234506] RDX: ffff888103bdff90 RSI: ffffffffa11f4d5e RDI: ffffffffa1007de0 <4> [323.234508] RBP: ffffc90020d677a0 R08: 0000000000000000 R09: 0000000000000000 <4> [323.234510] R10: 0000000000000000 R11: 0000000000000000 R12: ffff888103bdff90 <4> [323.234512] R13: ffff88813d8a22c8 R14: ffff888114014e40 R15: 0000000000000000 <4> [323.234514] FS: 0000763e993c0940(0000) GS:ffff88852971b000(0000) knlGS:0000000000000000 <4> [323.234516] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 <4> [323.234518] CR2: 0000654dcb801400 CR3: 0000000133f6a004 CR4: 00000000003726f0 <4> [323.234520] Call Trace: <4> [323.234522] <TASK> <4> [323.234524] ? fwtable_reg_write_fw_domains+0x4b/0x60 [i915] <4> [323.234627] ? intel_uncore_forcewake_for_reg+0x57/0x120 [i915] <4> [323.234733] intel_gt_init_mmio+0x23/0x40 [i915] <4> [323.234847] i915_driver_mmio_probe+0xb4/0x130 [i915] <4> [323.234946] i915_driver_probe+0x105/0x5d0 [i915] <4> [323.235053] ? mutex_unlock+0x12/0x20 <4> [323.235058] ? drm_privacy_screen_get+0x171/0x190 <4> [323.235062] ? acpi_dev_found+0x66/0x80 <4> [323.235070] i915_pci_probe+0xe2/0x1d0 [i915] <4> [323.235170] local_pci_probe+0x47/0xb0 <4> [323.235176] pci_call_probe+0x6c/0x360 <4> [323.235184] ? _raw_spin_unlock+0x22/0x50 <4> [323.235191] pci_device_probe+0xae/0x110 <4> [323.235197] really_probe+0xf1/0x410 <4> [323.235202] __driver_probe_device+0x8c/0x190 <4> [323.235207] device_driver_attach+0x57/0xd0 <4> [323.235212] bind_store+0x77/0xd0 <4> [323.235217] drv_attr_store+0x24/0x50 <4> [323.235220] sysfs_kf_write+0x4d/0x80 <4> [323.235227] kernfs_fop_write_iter+0x188/0x240 <4> [323.235233] vfs_write+0x283/0x540 <4> [323.235245] ksys_write+0x6f/0xf0 <4> [323.235250] __x64_sys_write+0x19/0x30 <4> [323.235253] x64_sys_call+0x259/0x26e0 <4> [323.235257] do_syscall_64+0xdd/0x1470 <4> [323.235261] ? putname+0x41/0x90 <4> [323.235264] ? kmem_cache_free+0x165/0x510 <4> [323.235272] ? putname+0x41/0x90 <4> [323.235275] ? do_sys_openat2+0x85/0xd0 <4> [323.235282] ? __x64_sys_openat+0x54/0xa0 <4> [323.235286] ? trace_hardirqs_on_prepare+0xe1/0x100 <4> [323.235291] ? do_syscall_64+0x22e/0x1470 <4> [323.235295] ? do_syscall_64+0x22e/0x1470 <4> [323.235299] ? __fput+0x1bf/0x2f0 <4> [323.235304] ? fput_close_sync+0x3d/0xa0 <4> [323.235308] ? trace_hardirqs_on_prepare+0xe1/0x100 <4> [323.235313] ? do_syscall_64+0x22e/0x1470 <4> [323.235316] ? putname+0x41/0x90 <4> [323.235318] ? kmem_cache_free+0x165/0x510 <4> [323.235326] ? putname+0x41/0x90 <4> [323.235329] ? do_sys_openat2+0x85/0xd0 <4> [323.235336] ? __x64_sys_openat+0x54/0xa0 <4> [323.235339] ? trace_hardirqs_on_prepare+0xe1/0x100 <4> [323.235344] ? do_syscall_64+0x22e/0x1470 <4> [323.235348] ? exc_page_fault+0xbd/0x2c0 <4> [323.235353] entry_SYSCALL_64_after_hwframe+0x76/0x7e <4> [323.235356] RIP: 0033:0x763e9b51c5a4 <4> [323.235360] 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> [323.235362] RSP: 002b:00007ffd5634f428 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 <4> [323.235365] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 0000763e9b51c5a4 <4> [323.235367] RDX: 000000000000000c RSI: 00007ffd5634f660 RDI: 000000000000000c <4> [323.235369] RBP: 000000000000000c R08: 0000000000000073 R09: 0000000000000000 <4> [323.235371] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffd5634f660 <4> [323.235373] R13: 000000000000000c R14: 0000579076ea71b8 R15: 0000579076ea728e <4> [323.235385] </TASK> <4> [323.235387] irq event stamp: 175525 <4> [323.235389] hardirqs last enabled at (175531): [<ffffffff814a9e59>] __up_console_sem+0x79/0xa0 <4> [323.235393] hardirqs last disabled at (175536): [<ffffffff814a9e3e>] __up_console_sem+0x5e/0xa0 <4> [323.235395] softirqs last enabled at (175214): [<ffffffff813d0eef>] __irq_exit_rcu+0x13f/0x160 <4> [323.235399] softirqs last disabled at (175201): [<ffffffff813d0eef>] __irq_exit_rcu+0x13f/0x160 <4> [323.235402] ---[ end trace 0000000000000000 ]--- <7> [323.785980] 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> [323.836096] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [323.836099] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [324.386825] 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> [324.436936] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [324.436939] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [324.987660] 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> [325.037778] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [325.037781] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [325.588506] 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> [325.638619] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [325.638622] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [325.638775] i915 0000:03:00.0: [drm:intel_engines_init_mmio [i915]] GT0: vdbox enable: 0005, instances: 0005 <7> [325.638888] i915 0000:03:00.0: [drm:intel_engines_init_mmio [i915]] GT0: vebox enable: 0001, instances: 0001 <7> [326.189629] 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> [326.239753] i915 0000:03:00.0: [drm] ERROR render: timed out waiting for forcewake ack request. <5> [326.239756] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [326.790892] 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> [326.841015] i915 0000:03:00.0: [drm] ERROR vdbox0: timed out waiting for forcewake ack request. <5> [326.841018] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [327.391786] 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> [327.441900] i915 0000:03:00.0: [drm] ERROR vdbox2: timed out waiting for forcewake ack request. <5> [327.441903] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [327.992655] 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> [328.042771] i915 0000:03:00.0: [drm] ERROR vebox0: timed out waiting for forcewake ack request. <5> [328.042774] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [328.593504] 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> [328.643621] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [328.643624] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [329.194335] 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> [329.244449] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [329.244452] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [329.795218] 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> [329.845339] i915 0000:03:00.0: [drm] ERROR render: timed out waiting for forcewake ack request. <5> [329.845342] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [330.396745] 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> [330.446864] i915 0000:03:00.0: [drm] ERROR render: timed out waiting for forcewake ack request. <5> [330.446868] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [330.998534] 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> [331.048652] i915 0000:03:00.0: [drm] ERROR render: timed out waiting for forcewake ack request. <5> [331.048655] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [331.599391] 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> [331.649504] i915 0000:03:00.0: [drm] ERROR render: timed out waiting for forcewake ack request. <5> [331.649507] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [332.200257] 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> [332.250375] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [332.250378] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [332.801101] 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> [332.851210] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [332.851213] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [333.401924] 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> [333.452037] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [333.452040] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [334.002768] 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> [334.052959] i915 0000:03:00.0: [drm] ERROR render: timed out waiting for forcewake ack request. <5> [334.053164] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [334.603840] 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> [334.653952] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [334.653954] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [335.204651] 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> [335.254754] i915 0000:03:00.0: [drm] ERROR vdbox0: timed out waiting for forcewake ack request. <5> [335.254757] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [335.805456] 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> [335.855583] i915 0000:03:00.0: [drm] ERROR vdbox2: timed out waiting for forcewake ack request. <5> [335.855586] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [336.406286] 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> [336.456388] i915 0000:03:00.0: [drm] ERROR vebox0: timed out waiting for forcewake ack request. <5> [336.456390] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <3> [336.457231] i915 0000:03:00.0: [drm] ERROR GT0: rcs'0 reset request timed out: {request: 00000001, RESET_CTL: 00000000} <3> [336.457957] i915 0000:03:00.0: [drm] ERROR GT0: rcs'0 reset request timed out: {request: 00000001, RESET_CTL: 00000000} <3> [336.458663] i915 0000:03:00.0: [drm] ERROR GT0: bcs'0 reset request timed out: {request: 00000001, RESET_CTL: 00000000} <3> [336.459369] i915 0000:03:00.0: [drm] ERROR GT0: vcs'0 reset request timed out: {request: 00000001, RESET_CTL: 00000000} <3> [336.460074] i915 0000:03:00.0: [drm] ERROR GT0: vcs'2 reset request timed out: {request: 00000001, RESET_CTL: 00000000} <3> [336.460780] i915 0000:03:00.0: [drm] ERROR GT0: vecs'0 reset request timed out: {request: 00000001, RESET_CTL: 00000000} <7> [336.461059] i915 0000:03:00.0: [drm:i915_ggtt_probe_hw [i915]] GGTT size = 4096M <7> [336.461198] i915 0000:03:00.0: [drm:i915_ggtt_probe_hw [i915]] GMADR size = 0M <7> [336.461310] i915 0000:03:00.0: [drm:i915_ggtt_probe_hw [i915]] DSM size = 0M <6> [336.461421] i915 0000:03:00.0: [drm] VT-d active for gfx access <6> [336.461436] i915 0000:03:00.0: vgaarb: deactivate vga console <7> [336.461753] i915 0000:03:00.0: [drm:intel_gt_setup_lmem [i915]] LMEM: reserved legacy low-memory [0x0-0x100000] <7> [336.462121] i915 0000:03:00.0: [drm:i915_gem_init_stolen [i915]] GEN6_STOLEN_RESERVED = 0x00000000ffc00107 <7> [336.462266] i915 0000:03:00.0: [drm:i915_gem_init_stolen [i915]] Memory reserved for graphics device: 65536K, usable: 61440K <7> [336.462577] i915 0000:03:00.0: [drm:intel_memory_regions_hw_probe [i915]] Memory region(0): system-ttm: 15845 MiB [mem 0x00000000-0x3de534fff], io: n/a <7> [336.462680] 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> [336.462782] 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> [336.463488] i915 0000:03:00.0: [drm:intel_opregion_setup [i915]] graphic opregion physical addr: 0x0 <7> [336.463640] i915 0000:03:00.0: [drm:intel_opregion_setup [i915]] ACPI OpRegion not supported! <7> [346.464330] i915 0000:03:00.0: [drm:skl_pcode_request [i915]] PCODE timeout, retrying with preemption disabled <4> [346.464653] ------------[ cut here ]------------ <4> [346.464657] i915 0000:03:00.0: [drm] drm_WARN_ON_ONCE(timeout_base_ms > 3) <4> [346.464661] WARNING: drivers/gpu/drm/i915/intel_pcode.c:200 at skl_pcode_request+0x25f/0x280 [i915], CPU#5: i915_module_loa/2380 <4> [346.464917] Modules linked in: snd_hda_intel 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 cmdlinepart spi_nor ee1004 x86_pkg_temp_thermal intel_powerclamp mtd hid_generic coretemp gigabyte_wmi wmi_bmof intel_wmi_thunderbolt mei_pxp mei_hdcp mxm_wmi kvm_intel kvm irqbypass snd_intel_dspcfg ghash_clmulni_intel snd_hda_codec aesni_intel snd_hda_core rapl snd_hwdep intel_cstate i2c_i801 snd_pcm i2c_mux spi_intel_pci snd_timer e1000e spi_intel i2c_smbus usbhid snd hid soundcore video binfmt_misc intel_pmc_core pmt_telemetry pmt_discovery pinctrl_cannonlake pmt_class intel_pmc_ssram_telemetry nls_iso8859_1 acpi_pad intel_vsec mei_me wmi mei intel_pch_thermal dm_multipath msr nvme_fabrics fuse efi_pstore nfnetlink autofs4 [last unloaded: snd_hda_intel] <4> [346.465194] CPU: 5 UID: 0 PID: 2380 Comm: i915_module_loa Tainted: G S U W L 7.0.0-rc3-CI_DRM_18150-gb01ac5e93e3a+ #1 PREEMPT(lazy) <4> [346.465203] Tainted: [S]=CPU_OUT_OF_SPEC, [U]=USER, [W]=WARN, [L]=SOFTLOCKUP <4> [346.465208] Hardware name: Gigabyte Technology Co., Ltd. GB-Z390 Garuda/GB-Z390 Garuda-CF, BIOS IG1c 11/19/2019 <4> [346.465212] RIP: 0010:skl_pcode_request+0x269/0x280 [i915] <4> [346.465445] Code: 04 48 8b 7f 08 48 8b 5f 50 48 85 db 75 03 48 8b 1f e8 cb d5 63 e1 48 89 c6 48 8d 3d c1 f9 3e 00 48 c7 c1 d8 eb 20 a1 48 89 da <67> 48 0f b9 3a e9 15 ff ff ff e8 d8 9d d1 e1 0f 1f 84 00 00 00 00 <4> [346.465451] RSP: 0018:ffffc90020d67700 EFLAGS: 00010246 <4> [346.465459] RAX: ffffffffa11f4d5e RBX: ffff888103bdff90 RCX: ffffffffa120ebd8 <4> [346.465464] RDX: ffff888103bdff90 RSI: ffffffffa11f4d5e RDI: ffffffffa10014f0 <4> [346.465469] RBP: ffffc90020d67748 R08: 0000000000000000 R09: 0000000000000000 <4> [346.465473] R10: 0000000000000000 R11: 0000000000000000 R12: ffff888114014e40 <4> [346.465477] R13: 000000000000007e R14: 0000000000000000 R15: 00000050a42acf19 <4> [346.465482] FS: 0000763e993c0940(0000) GS:ffff88852991b000(0000) knlGS:0000000000000000 <4> [346.465488] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 <4> [346.465493] CR2: 000064df14f64514 CR3: 0000000133f6a005 CR4: 00000000003726f0 <4> [346.465498] Call Trace: <4> [346.465502] <TASK> <4> [346.465517] pcode_init_wait+0x50/0x80 [i915] <4> [346.465766] intel_pcode_init+0x33/0x80 [i915] <4> [346.465995] i915_pcode_init+0x29/0xd0 [i915] <4> [346.466219] i915_driver_hw_probe+0x326/0x3c0 [i915] <4> [346.466447] i915_driver_probe+0x114/0x5d0 [i915] <4> [346.466668] ? mutex_unlock+0x12/0x20 <4> [346.466696] ? drm_privacy_screen_get+0x171/0x190 <4> [346.466705] ? acpi_dev_found+0x66/0x80 <4> [346.466723] i915_pci_probe+0xe2/0x1d0 [i915] <4> [346.466950] local_pci_probe+0x47/0xb0 <4> [346.466963] pci_call_probe+0x6c/0x360 <4> [346.466984] ? _raw_spin_unlock+0x22/0x50 <4> [346.467000] pci_device_probe+0xae/0x110 <4> [346.467013] really_probe+0xf1/0x410 <4> [346.467025] __driver_probe_device+0x8c/0x190 <4> [346.467035] device_driver_attach+0x57/0xd0 <4> [346.467046] bind_store+0x77/0xd0 <4> [346.467058] drv_attr_store+0x24/0x50 <4> [346.467066] sysfs_kf_write+0x4d/0x80 <4> [346.467080] kernfs_fop_write_iter+0x188/0x240 <4> [346.467094] vfs_write+0x283/0x540 <4> [346.467120] ksys_write+0x6f/0xf0 <4> [346.467133] __x64_sys_write+0x19/0x30 <4> [346.467140] x64_sys_call+0x259/0x26e0 <4> [346.467148] do_syscall_64+0xdd/0x1470 <4> [346.467157] ? putname+0x41/0x90 <4> [346.467164] ? kmem_cache_free+0x165/0x510 <4> [346.467182] ? putname+0x41/0x90 <4> [346.467189] ? do_sys_openat2+0x85/0xd0 <4> [346.467206] ? __x64_sys_openat+0x54/0xa0 <4> [346.467214] ? trace_hardirqs_on_prepare+0xe1/0x100 <4> [346.467227] ? do_syscall_64+0x22e/0x1470 <4> [346.467236] ? do_syscall_64+0x22e/0x1470 <4> [346.467244] ? __fput+0x1bf/0x2f0 <4> [346.467256] ? fput_close_sync+0x3d/0xa0 <4> [346.467265] ? trace_hardirqs_on_prepare+0xe1/0x100 <4> [346.467276] ? do_syscall_64+0x22e/0x1470 <4> [346.467284] ? putname+0x41/0x90 <4> [346.467290] ? kmem_cache_free+0x165/0x510 <4> [346.467307] ? putname+0x41/0x90 <4> [346.467314] ? do_sys_openat2+0x85/0xd0 <4> [346.467330] ? __x64_sys_openat+0x54/0xa0 <4> [346.467338] ? trace_hardirqs_on_prepare+0xe1/0x100 <4> [346.467349] ? do_syscall_64+0x22e/0x1470 <4> [346.467358] ? exc_page_fault+0xbd/0x2c0 <4> [346.467371] entry_SYSCALL_64_after_hwframe+0x76/0x7e <4> [346.467377] RIP: 0033:0x763e9b51c5a4 <4> [346.467385] 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> [346.467391] RSP: 002b:00007ffd5634f428 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 <4> [346.467399] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 0000763e9b51c5a4 <4> [346.467403] RDX: 000000000000000c RSI: 00007ffd5634f660 RDI: 000000000000000c <4> [346.467408] RBP: 000000000000000c R08: 0000000000000073 R09: 0000000000000000 <4> [346.467412] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffd5634f660 <4> [346.467416] R13: 000000000000000c R14: 0000579076ea71b8 R15: 0000579076ea728e <4> [346.467445] </TASK> <4> [346.467449] irq event stamp: 2746865 <4> [346.467453] hardirqs last enabled at (2746871): [<ffffffff814a9e59>] __up_console_sem+0x79/0xa0 <4> [346.467461] hardirqs last disabled at (2746876): [<ffffffff814a9e3e>] __up_console_sem+0x5e/0xa0 <4> [346.467468] softirqs last enabled at (2746528): [<ffffffff813d0eef>] __irq_exit_rcu+0x13f/0x160 <4> [346.467476] softirqs last disabled at (2746523): [<ffffffff813d0eef>] __irq_exit_rcu+0x13f/0x160 <4> [346.467483] ---[ end trace 0000000000000000 ]--- <5> [346.517490] i915 0000:03:00.0: [drm] Waiting for HW initialisation... <3> [526.518207] i915 0000:03:00.0: [drm] ERROR GT0: intel_pcode_init failed -517 <3> [526.550460] i915 0000:03:00.0: [drm] ERROR Device initialization failed (-517) <6> [526.551691] [IGT] i915_module_load: finished subtest __uc_init, FAIL <6> [526.552642] [IGT] i915_module_load: starting dynamic subtest i915_driver_mmio_probe <6> [526.553525] [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-18

Igt-Version

IGT-Version: 2.3-g33f5420a2 (x86_64) (Linux: 7.0.0-rc3-CI_DRM_18150-gb01ac5e93e3a+ x86_64)

Out

Using IGT_SRANDOM=1773618883 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.561s)

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:2380) DEBUG: Test requirement passed: guc == GEM_SUBMISSION_GUC
(i915_module_load:2380) DEBUG: probability = 100, interval = 0, times = -1, space = 0
(i915_module_load:2380) igt_core-INFO: Timed out: Driver unbind re-bind timeout!
****  END  ****
Dynamic subtest __uc_init: FAIL (205.561s)
Starting dynamic subtest: i915_driver_mmio_probe

Dmesg

Scroll to first warning

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

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

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

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

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

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

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

<6> [320.990869] [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> [320.991114] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_4

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

<7> [320.992481] i915 0000:03:00.0: [drm:atomic_remove_fb] Disabling [PLANE:34:plane 1A] because [FB:633] is removed

<7> [320.992537] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] [PLANE:34:plane 1A] ddb ( 0 - 2012) -> ( 0 - 0), size 2012 -> 0

<7> [320.992699] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:34: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> [320.992844] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:34: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> [320.992990] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:34: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> [320.993456] i915 0000:03:00.0: [drm:skl_print_plane_changes [i915]] [PLANE:34: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> [320.993634] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:170:pipe A] data rate 0 num active planes 0

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

<7> [321.025170] i915 0000:03:00.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:170:pipe A] releasing DPLL 2

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

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

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

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

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

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

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

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

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

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

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

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

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

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

<7> [321.034183] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_TC2

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

<7> [321.034563] i915 0000:03:00.0: [drm:intel_dpll_disable [i915]] disabling DPLL 2

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

<7> [321.037261] i915 0000:03:00.0: [drm:verify_connector_state [i915]] [CONNECTOR:630:HDMI-A-4]

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

<7> [321.037777] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:170:pipe A]

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

<7> [322.582298] 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> [322.632494] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

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

<7> [323.183486] 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> [323.233605] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

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

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

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

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

<4> [323.234261] Modules linked in: snd_hda_intel 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 cmdlinepart spi_nor ee1004 x86_pkg_temp_thermal intel_powerclamp mtd hid_generic coretemp gigabyte_wmi wmi_bmof intel_wmi_thunderbolt mei_pxp mei_hdcp mxm_wmi kvm_intel kvm irqbypass snd_intel_dspcfg ghash_clmulni_intel snd_hda_codec aesni_intel snd_hda_core rapl snd_hwdep intel_cstate i2c_i801 snd_pcm i2c_mux spi_intel_pci snd_timer e1000e spi_intel i2c_smbus usbhid snd hid soundcore video binfmt_misc intel_pmc_core pmt_telemetry pmt_discovery pinctrl_cannonlake pmt_class intel_pmc_ssram_telemetry nls_iso8859_1 acpi_pad intel_vsec mei_me wmi mei intel_pch_thermal dm_multipath msr nvme_fabrics fuse efi_pstore nfnetlink autofs4 [last unloaded: snd_hda_intel]

<4> [323.234367] CPU: 1 UID: 0 PID: 2380 Comm: i915_module_loa Tainted: G S U W L 7.0.0-rc3-CI_DRM_18150-gb01ac5e93e3a+ #1 PREEMPT(lazy)

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

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

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

<4> [323.234499] Code: 04 48 8b 7f 08 4c 8b 67 50 4d 85 e4 75 03 4c 8b 27 e8 3b 45 59 e1 48 89 c6 48 8d 3d 21 d2 34 00 48 c7 c1 11 ac 1f a1 4c 89 e2 <67> 48 0f b9 3a e9 68 f5 ff ff 44 0f b7 ab 40 23 00 00 4c 89 e7 e8

<4> [323.234501] RSP: 0018:ffffc90020d67720 EFLAGS: 00010246

<4> [323.234504] RAX: ffffffffa11f4d5e RBX: ffff88813d8a0028 RCX: ffffffffa11fac11

<4> [323.234506] RDX: ffff888103bdff90 RSI: ffffffffa11f4d5e RDI: ffffffffa1007de0

<4> [323.234508] RBP: ffffc90020d677a0 R08: 0000000000000000 R09: 0000000000000000

<4> [323.234510] R10: 0000000000000000 R11: 0000000000000000 R12: ffff888103bdff90

<4> [323.234512] R13: ffff88813d8a22c8 R14: ffff888114014e40 R15: 0000000000000000

<4> [323.234514] FS: 0000763e993c0940(0000) GS:ffff88852971b000(0000) knlGS:0000000000000000

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

<4> [323.234518] CR2: 0000654dcb801400 CR3: 0000000133f6a004 CR4: 00000000003726f0

<4> [323.234520] Call Trace:

<4> [323.234522] <TASK>

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

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

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

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

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

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

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

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

<4> [323.235070] i915_pci_probe+0xe2/0x1d0 [i915]

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

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

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

<4> [323.235191] pci_device_probe+0xae/0x110

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

<4> [323.235202] __driver_probe_device+0x8c/0x190

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

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

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

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

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

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

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

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

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

<4> [323.235257] do_syscall_64+0xdd/0x1470

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

<4> [323.235264] ? kmem_cache_free+0x165/0x510

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

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

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

<4> [323.235286] ? trace_hardirqs_on_prepare+0xe1/0x100

<4> [323.235291] ? do_syscall_64+0x22e/0x1470

<4> [323.235295] ? do_syscall_64+0x22e/0x1470

<4> [323.235299] ? __fput+0x1bf/0x2f0

<4> [323.235304] ? fput_close_sync+0x3d/0xa0

<4> [323.235308] ? trace_hardirqs_on_prepare+0xe1/0x100

<4> [323.235313] ? do_syscall_64+0x22e/0x1470

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

<4> [323.235318] ? kmem_cache_free+0x165/0x510

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

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

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

<4> [323.235339] ? trace_hardirqs_on_prepare+0xe1/0x100

<4> [323.235344] ? do_syscall_64+0x22e/0x1470

<4> [323.235348] ? exc_page_fault+0xbd/0x2c0

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

<4> [323.235356] RIP: 0033:0x763e9b51c5a4

<4> [323.235360] 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> [323.235362] RSP: 002b:00007ffd5634f428 EFLAGS: 00000202 ORIG_RAX: 0000000000000001

<4> [323.235365] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 0000763e9b51c5a4

<4> [323.235367] RDX: 000000000000000c RSI: 00007ffd5634f660 RDI: 000000000000000c

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

<4> [323.235371] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffd5634f660

<4> [323.235373] R13: 000000000000000c R14: 0000579076ea71b8 R15: 0000579076ea728e

<4> [323.235385] </TASK>

<4> [323.235387] irq event stamp: 175525

<4> [323.235389] hardirqs last enabled at (175531): [<ffffffff814a9e59>] __up_console_sem+0x79/0xa0

<4> [323.235393] hardirqs last disabled at (175536): [<ffffffff814a9e3e>] __up_console_sem+0x5e/0xa0

<4> [323.235395] softirqs last enabled at (175214): [<ffffffff813d0eef>] __irq_exit_rcu+0x13f/0x160

<4> [323.235399] softirqs last disabled at (175201): [<ffffffff813d0eef>] __irq_exit_rcu+0x13f/0x160

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

<7> [323.785980] 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> [323.836096] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

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

<7> [324.386825] 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> [324.436936] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

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

<7> [324.987660] 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> [325.037778] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

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

<7> [325.588506] 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> [325.638619] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

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

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

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

<7> [326.189629] 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> [326.239753] i915 0000:03:00.0: [drm] *ERROR* render: timed out waiting for forcewake ack request.

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

<7> [326.790892] 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> [326.841015] i915 0000:03:00.0: [drm] *ERROR* vdbox0: timed out waiting for forcewake ack request.

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

<7> [327.391786] 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> [327.441900] i915 0000:03:00.0: [drm] *ERROR* vdbox2: timed out waiting for forcewake ack request.

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

<7> [327.992655] 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> [328.042771] i915 0000:03:00.0: [drm] *ERROR* vebox0: timed out waiting for forcewake ack request.

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

<7> [328.593504] 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> [328.643621] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

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

<7> [329.194335] 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> [329.244449] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

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

<7> [329.795218] 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> [329.845339] i915 0000:03:00.0: [drm] *ERROR* render: timed out waiting for forcewake ack request.

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

<7> [330.396745] 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> [330.446864] i915 0000:03:00.0: [drm] *ERROR* render: timed out waiting for forcewake ack request.

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

<7> [330.998534] 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> [331.048652] i915 0000:03:00.0: [drm] *ERROR* render: timed out waiting for forcewake ack request.

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

<7> [331.599391] 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> [331.649504] i915 0000:03:00.0: [drm] *ERROR* render: timed out waiting for forcewake ack request.

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

<7> [332.200257] 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> [332.250375] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

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

<7> [332.801101] 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> [332.851210] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

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

<7> [333.401924] 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> [333.452037] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

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

<7> [334.002768] 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> [334.052959] i915 0000:03:00.0: [drm] *ERROR* render: timed out waiting for forcewake ack request.

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

<7> [334.603840] 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> [334.653952] i915 0000:03:00.0: [drm] *ERROR* gt: timed out waiting for forcewake ack request.

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

<7> [335.204651] 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> [335.254754] i915 0000:03:00.0: [drm] *ERROR* vdbox0: timed out waiting for forcewake ack request.

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

<7> [335.805456] 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> [335.855583] i915 0000:03:00.0: [drm] *ERROR* vdbox2: timed out waiting for forcewake ack request.

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

<7> [336.406286] 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> [336.456388] i915 0000:03:00.0: [drm] *ERROR* vebox0: timed out waiting for forcewake ack request.

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

<7> [336.462680] 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> [336.462782] 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> [336.463488] i915 0000:03:00.0: [drm:intel_opregion_setup [i915]] graphic opregion physical addr: 0x0

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

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

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

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

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

<4> [346.464917] Modules linked in: snd_hda_intel 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 cmdlinepart spi_nor ee1004 x86_pkg_temp_thermal intel_powerclamp mtd hid_generic coretemp gigabyte_wmi wmi_bmof intel_wmi_thunderbolt mei_pxp mei_hdcp mxm_wmi kvm_intel kvm irqbypass snd_intel_dspcfg ghash_clmulni_intel snd_hda_codec aesni_intel snd_hda_core rapl snd_hwdep intel_cstate i2c_i801 snd_pcm i2c_mux spi_intel_pci snd_timer e1000e spi_intel i2c_smbus usbhid snd hid soundcore video binfmt_misc intel_pmc_core pmt_telemetry pmt_discovery pinctrl_cannonlake pmt_class intel_pmc_ssram_telemetry nls_iso8859_1 acpi_pad intel_vsec mei_me wmi mei intel_pch_thermal dm_multipath msr nvme_fabrics fuse efi_pstore nfnetlink autofs4 [last unloaded: snd_hda_intel]

<4> [346.465194] CPU: 5 UID: 0 PID: 2380 Comm: i915_module_loa Tainted: G S U W L 7.0.0-rc3-CI_DRM_18150-gb01ac5e93e3a+ #1 PREEMPT(lazy)

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

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

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

<4> [346.465445] Code: 04 48 8b 7f 08 48 8b 5f 50 48 85 db 75 03 48 8b 1f e8 cb d5 63 e1 48 89 c6 48 8d 3d c1 f9 3e 00 48 c7 c1 d8 eb 20 a1 48 89 da <67> 48 0f b9 3a e9 15 ff ff ff e8 d8 9d d1 e1 0f 1f 84 00 00 00 00

<4> [346.465451] RSP: 0018:ffffc90020d67700 EFLAGS: 00010246

<4> [346.465459] RAX: ffffffffa11f4d5e RBX: ffff888103bdff90 RCX: ffffffffa120ebd8

<4> [346.465464] RDX: ffff888103bdff90 RSI: ffffffffa11f4d5e RDI: ffffffffa10014f0

<4> [346.465469] RBP: ffffc90020d67748 R08: 0000000000000000 R09: 0000000000000000

<4> [346.465473] R10: 0000000000000000 R11: 0000000000000000 R12: ffff888114014e40

<4> [346.465477] R13: 000000000000007e R14: 0000000000000000 R15: 00000050a42acf19

<4> [346.465482] FS: 0000763e993c0940(0000) GS:ffff88852991b000(0000) knlGS:0000000000000000

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

<4> [346.465493] CR2: 000064df14f64514 CR3: 0000000133f6a005 CR4: 00000000003726f0

<4> [346.465498] Call Trace:

<4> [346.465502] <TASK>

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

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

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

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

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

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

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

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

<4> [346.466723] i915_pci_probe+0xe2/0x1d0 [i915]

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

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

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

<4> [346.467000] pci_device_probe+0xae/0x110

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

<4> [346.467025] __driver_probe_device+0x8c/0x190

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

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

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

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

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

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

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

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

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

<4> [346.467148] do_syscall_64+0xdd/0x1470

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

<4> [346.467164] ? kmem_cache_free+0x165/0x510

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

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

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

<4> [346.467214] ? trace_hardirqs_on_prepare+0xe1/0x100

<4> [346.467227] ? do_syscall_64+0x22e/0x1470

<4> [346.467236] ? do_syscall_64+0x22e/0x1470

<4> [346.467244] ? __fput+0x1bf/0x2f0

<4> [346.467256] ? fput_close_sync+0x3d/0xa0

<4> [346.467265] ? trace_hardirqs_on_prepare+0xe1/0x100

<4> [346.467276] ? do_syscall_64+0x22e/0x1470

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

<4> [346.467290] ? kmem_cache_free+0x165/0x510

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

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

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

<4> [346.467338] ? trace_hardirqs_on_prepare+0xe1/0x100

<4> [346.467349] ? do_syscall_64+0x22e/0x1470

<4> [346.467358] ? exc_page_fault+0xbd/0x2c0

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

<4> [346.467377] RIP: 0033:0x763e9b51c5a4

<4> [346.467385] 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> [346.467391] RSP: 002b:00007ffd5634f428 EFLAGS: 00000202 ORIG_RAX: 0000000000000001

<4> [346.467399] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 0000763e9b51c5a4

<4> [346.467403] RDX: 000000000000000c RSI: 00007ffd5634f660 RDI: 000000000000000c

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

<4> [346.467412] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffd5634f660

<4> [346.467416] R13: 000000000000000c R14: 0000579076ea71b8 R15: 0000579076ea728e

<4> [346.467445] </TASK>

<4> [346.467449] irq event stamp: 2746865

<4> [346.467453] hardirqs last enabled at (2746871): [<ffffffff814a9e59>] __up_console_sem+0x79/0xa0

<4> [346.467461] hardirqs last disabled at (2746876): [<ffffffff814a9e3e>] __up_console_sem+0x5e/0xa0

<4> [346.467468] softirqs last enabled at (2746528): [<ffffffff813d0eef>] __irq_exit_rcu+0x13f/0x160

<4> [346.467476] softirqs last disabled at (2746523): [<ffffffff813d0eef>] __irq_exit_rcu+0x13f/0x160

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

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

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

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

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

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

<6> [526.553525] [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-03-16 01:13:36