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

Detail	Value
Duration	unknown
Hostname	shard-dg1-13
Igt-Version	IGT-Version: 2.3-gdc0445d49 (x86_64) (Linux: 7.0.0-rc5-Patchwork_163871v2-gb0c967b64ac6+ x86_64)
Out	Using IGT_SRANDOM=1774703067 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.613s) 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:2390) DEBUG: Test requirement passed: guc == GEM_SUBMISSION_GUC (i915_module_load:2390) DEBUG: probability = 100, interval = 0, times = -1, space = 0 (i915_module_load:2390) igt_core-INFO: Timed out: Driver unbind re-bind timeout! END ** Dynamic subtest __uc_init: FAIL (205.613s) Starting dynamic subtest: i915_driver_mmio_probe
Dmesg Scroll to first warning	<6> [330.925147] Console: switching to colour dummy device 80x25 <6> [330.925837] [IGT] i915_module_load: executing <6> [330.929266] [IGT] i915_module_load: starting subtest fault-injection <7> [330.931575] i915 0000:03:00.0: [drm:i915_gem_open [i915]] <7> [330.932685] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc] <7> [330.933008] i915 0000:03:00.0: [drm:i915_gem_open [i915]] <6> [330.954703] [IGT] i915_module_load: starting dynamic subtest __uc_init <6> [330.955318] [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> [330.956129] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_4 <7> [330.956609] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling PW_5 <7> [330.959326] i915 0000:03:00.0: [drm:atomic_remove_fb] Disabling [PLANE:35:plane 1A] because [FB:636] is removed <7> [330.959388] 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> [330.959650] 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> [330.959850] 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> [330.960018] 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> [330.960184] 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> [330.960383] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:171:pipe A] data rate 0 num active planes 0 <7> [330.960709] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] QGV point 0: max bw 34000 required 0 <7> [330.964691] i915 0000:03:00.0: [drm:__intel_fbc_disable [i915]] Disabling FBC on [PLANE:35:plane 1A] <7> [330.982019] i915 0000:03:00.0: [drm:drm_client_release] fbdev <7> [330.985149] 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> [330.985358] 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> [330.985564] 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> [330.985816] 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> [330.985988] 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> [330.986162] 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> [330.986344] 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> [330.986573] 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> [330.986773] 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> [330.986954] 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> [330.987123] 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> [330.987290] 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> [330.987474] 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> [330.987992] 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> [330.988175] 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> [330.988374] 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> [330.988600] 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> [330.988798] 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> [330.988965] 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> [330.989164] 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> [330.989332] 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> [330.989500] 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> [330.989741] 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> [330.989925] 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> [330.990093] 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> [330.990260] 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> [330.990427] 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> [330.990763] 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> [330.990947] 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> [330.991116] 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> [330.991284] 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> [330.991469] 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> [330.991690] 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> [330.991889] 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> [330.992056] 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> [330.992239] 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> [330.992411] 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> [330.992649] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:171:pipe A] fastset requirement not met, forcing full modeset <7> [330.992833] i915 0000:03:00.0: [drm:intel_dpll_crtc_put [i915]] [CRTC:171:pipe A] releasing DPLL 2 <7> [330.993033] i915 0000:03:00.0: [drm:skl_compute_wm [i915]] Enabled dbuf slices 0x3 -> 0x1 (total dbuf slices 0x3), mbus joined? no->no <7> [330.993227] 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> [330.993455] 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> [330.993760] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:171:pipe A] min cdclk: 74250 kHz -> 0 kHz <7> [330.993963] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [CRTC:171:pipe A] enable: no [modeset] <7> [330.994134] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:35:plane 1A] fb: [NOFB], visible: no <7> [330.994306] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:65:plane 2A] fb: [NOFB], visible: no <7> [330.994476] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:95:plane 3A] fb: [NOFB], visible: no <7> [330.994689] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:125:plane 4A] fb: [NOFB], visible: no <7> [330.994898] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:135:plane 5A] fb: [NOFB], visible: no <7> [330.995069] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:145:plane 6A] fb: [NOFB], visible: no <7> [330.995240] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:155:plane 7A] fb: [NOFB], visible: no <7> [330.995410] i915 0000:03:00.0: [drm:intel_crtc_state_dump [i915]] [PLANE:165:cursor A] fb: [NOFB], visible: no <7> [330.996190] i915 0000:03:00.0: [drm:intel_disable_transcoder [i915]] disabling pipe A <7> [330.998125] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_TC1 <7> [330.998504] i915 0000:03:00.0: [drm:intel_dpll_disable [i915]] disable DPLL 2 (active 0x1, on? 1) for [CRTC:171:pipe A] <7> [330.998803] i915 0000:03:00.0: [drm:intel_dpll_disable [i915]] disabling DPLL 2 <7> [330.999008] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:587:DDI A/PHY A] <7> [330.999180] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:589:DP-MST A] <7> [330.999350] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:590:DP-MST B] <7> [330.999547] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:591:DP-MST C] <7> [330.999730] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:592:DP-MST D] <7> [330.999898] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:606:DDI B/PHY B] <7> [331.000066] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:610:DDI TC1/PHY C] <7> [331.000260] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:612:DP-MST A] <7> [331.000429] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:613:DP-MST B] <7> [331.000637] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:614:DP-MST C] <7> [331.000806] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:615:DP-MST D] <7> [331.000974] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:622:DDI TC2/PHY D] <7> [331.001142] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:624:DP-MST A] <7> [331.001310] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:625:DP-MST B] <7> [331.001478] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:626:DP-MST C] <7> [331.001695] i915 0000:03:00.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:627:DP-MST D] <7> [331.001865] i915 0000:03:00.0: [drm:verify_connector_state [i915]] [CONNECTOR:619:HDMI-A-3] <7> [331.002205] i915 0000:03:00.0: [drm:gen9_dbuf_slices_update [i915]] Updating dbuf slices to 0x1 <7> [331.002462] i915 0000:03:00.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:171:pipe A] <7> [331.013273] i915 0000:03:00.0: [drm:intel_gt_set_wedged [i915]] called from intel_gt_set_wedged_on_fini+0x12/0x50 [i915] <7> [331.028841] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:588:DP-1] removing connector from sysfs <7> [331.029428] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:600:HDMI-A-1] removing connector from sysfs <7> [331.030301] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:607:HDMI-A-2] removing connector from sysfs <7> [331.033349] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:611:DP-2] removing connector from sysfs <7> [331.033746] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:619:HDMI-A-3] removing connector from sysfs <7> [331.038833] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:623:DP-3] removing connector from sysfs <7> [331.045161] i915 0000:03:00.0: [drm:drm_sysfs_connector_remove] [CONNECTOR:631:HDMI-A-4] removing connector from sysfs <3> [331.925677] pci 0000:03:00.0: timed out waiting for pending transaction; performing function level reset anyway <6> [332.033597] i915 0000:03:00.0: [drm] Found dg1 (device ID 4905) discrete display version 12.00 stepping B0 <7> [332.035801] i915 0000:03:00.0: [drm:intel_wopcm_init_early [i915]] WOPCM: 2048K <7> [332.036018] i915 0000:03:00.0: [drm:intel_uc_init_early [i915]] GT0: enable_guc=3 (guc:yes submission:yes huc:yes slpc:yes) <7> [332.036184] i915 0000:03:00.0: [drm:intel_pch_detect [i915]] PCH not involved in display, using fake PCH type 1024 for south display <7> [332.036350] i915 0000:03:00.0: [drm:intel_dmc_wl_init [i915]] Sanitized enable_dmc_wl value: 0 (disabled) <7> [332.036616] i915 0000:03:00.0: [drm:intel_gt_probe_all [i915]] GT0: Setting up Primary GT <7> [332.037098] i915 0000:03:00.0: [drm:intel_display_device_info_runtime_init [i915]] rawclk rate: 38400 kHz <7> [332.587836] 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.638051] i915 0000:03:00.0: [drm] ERROR* gt: timed out waiting for forcewake ack request. <5> [332.638272] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [333.189171] 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.239313] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [333.239331] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <4> [333.239551] ------------[ cut here ]------------ <4> [333.239554] i915 0000:03:00.0: [drm] drm_WARN_ON(s_en != 0x1) <4> [333.239556] WARNING: drivers/gpu/drm/i915/gt/intel_sseu.c:277 at intel_sseu_info_init+0xd3f/0x1070 [i915], CPU#2: i915_module_loa/2390 <4> [333.239709] Modules linked in: vgem snd_hda_codec_intelhdmi snd_hda_codec_hdmi mei_gsc mei_me mei 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 ee1004 intel_tcc_cooling x86_pkg_temp_thermal cmdlinepart hid_generic intel_powerclamp spi_nor mtd gigabyte_wmi coretemp wmi_bmof intel_wmi_thunderbolt mxm_wmi kvm_intel snd_hda_intel snd_intel_dspcfg kvm irqbypass snd_hda_codec ghash_clmulni_intel aesni_intel snd_hda_core rapl usbhid snd_hwdep intel_cstate hid i2c_i801 snd_pcm i2c_mux snd_timer spi_intel_pci i2c_smbus snd video spi_intel soundcore e1000e intel_pch_thermal binfmt_misc intel_pmc_core pmt_telemetry pmt_discovery pmt_class pinctrl_cannonlake intel_pmc_ssram_telemetry nls_iso8859_1 acpi_pad intel_vsec wmi dm_multipath msr nvme_fabrics fuse efi_pstore nfnetlink autofs4 <4> [333.239810] CPU: 2 UID: 0 PID: 2390 Comm: i915_module_loa Tainted: G S U W L 7.0.0-rc5-Patchwork_163871v2-gb0c967b64ac6+ #1 PREEMPT(lazy) <4> [333.239814] Tainted: [S]=CPU_OUT_OF_SPEC, [U]=USER, [W]=WARN, [L]=SOFTLOCKUP <4> [333.239816] Hardware name: Gigabyte Technology Co., Ltd. GB-Z390 Garuda/GB-Z390 Garuda-CF, BIOS IG1c 11/19/2019 <4> [333.239818] RIP: 0010:intel_sseu_info_init+0xd49/0x1070 [i915] <4> [333.239968] Code: 04 48 8b 7f 08 4c 8b 67 50 4d 85 e4 75 03 4c 8b 27 e8 9b 84 59 e1 48 89 c6 48 8d 3d 71 cd 34 00 48 c7 c1 d4 1e ad a0 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> [333.239971] RSP: 0018:ffffc9002211b6a0 EFLAGS: 00010246 <4> [333.239975] RAX: ffffffffa0acbffe RBX: ffff88810bd64028 RCX: ffffffffa0ad1ed4 <4> [333.239977] RDX: ffff888101531f10 RSI: ffffffffa0acbffe RDI: ffffffffa1007df0 <4> [333.239979] RBP: ffffc9002211b720 R08: 0000000000000000 R09: 0000000000000000 <4> [333.239980] R10: 0000000000000000 R11: 0000000000000000 R12: ffff888101531f10 <4> [333.239982] R13: ffff88810bd662c8 R14: ffff88813d4d8e48 R15: 0000000000000000 <4> [333.239984] FS: 000074a54e22c940(0000) GS:ffff88852979a000(0000) knlGS:0000000000000000 <4> [333.239987] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 <4> [333.239989] CR2: 00005b8749952a30 CR3: 000000011c7ed004 CR4: 00000000003726f0 <4> [333.239991] Call Trace: <4> [333.239993] <TASK> <4> [333.239995] ? fwtable_reg_write_fw_domains+0x4b/0x60 [i915] <4> [333.240125] ? intel_uncore_forcewake_for_reg+0x57/0x120 [i915] <4> [333.240258] intel_gt_init_mmio+0x23/0x40 [i915] <4> [333.240398] i915_driver_mmio_probe+0xb4/0x130 [i915] <4> [333.240532] i915_driver_probe+0x105/0x5d0 [i915] <4> [333.240657] ? mutex_unlock+0x12/0x20 <4> [333.240663] ? drm_privacy_screen_get+0x171/0x190 <4> [333.240667] ? acpi_dev_found+0x66/0x80 <4> [333.240675] i915_pci_probe+0xe2/0x1d0 [i915] <4> [333.240802] local_pci_probe+0x47/0xb0 <4> [333.240808] pci_call_probe+0x6c/0x360 <4> [333.240817] ? _raw_spin_unlock+0x22/0x50 <4> [333.240824] pci_device_probe+0xae/0x110 <4> [333.240830] really_probe+0xf1/0x410 <4> [333.240835] __driver_probe_device+0x8c/0x190 <4> [333.240840] device_driver_attach+0x57/0xd0 <4> [333.240845] bind_store+0x77/0xd0 <4> [333.240850] drv_attr_store+0x24/0x50 <4> [333.240854] sysfs_kf_write+0x4d/0x80 <4> [333.240859] kernfs_fop_write_iter+0x188/0x240 <4> [333.240865] vfs_write+0x283/0x540 <4> [333.240877] ksys_write+0x6f/0xf0 <4> [333.240883] __x64_sys_write+0x19/0x30 <4> [333.240886] x64_sys_call+0x259/0x26e0 <4> [333.240889] do_syscall_64+0xdd/0x1470 <4> [333.240894] ? putname+0x41/0x90 <4> [333.240897] ? kmem_cache_free+0x165/0x510 <4> [333.240905] ? putname+0x41/0x90 <4> [333.240909] ? do_sys_openat2+0x85/0xd0 <4> [333.240916] ? __x64_sys_openat+0x54/0xa0 <4> [333.240920] ? trace_hardirqs_on_prepare+0xe1/0x100 <4> [333.240925] ? do_syscall_64+0x22e/0x1470 <4> [333.240930] ? free_to_partial_list+0x46d/0x640 <4> [333.240933] ? __fput+0x1bf/0x2f0 <4> [333.240940] ? __slab_free+0x129/0x2b0 <4> [333.240946] ? __pcs_replace_full_main+0x2ad/0x710 <4> [333.240949] ? __pcs_replace_full_main+0x10/0x710 <4> [333.240953] ? __fput+0x1bf/0x2f0 <4> [333.240956] ? kmem_cache_free+0x165/0x510 <4> [333.240964] ? __fput+0x1bf/0x2f0 <4> [333.240969] ? fput_close_sync+0x3d/0xa0 <4> [333.240973] ? trace_hardirqs_on_prepare+0xe1/0x100 <4> [333.240978] ? do_syscall_64+0x22e/0x1470 <4> [333.240982] ? trace_hardirqs_on_prepare+0xe1/0x100 <4> [333.240987] ? do_syscall_64+0x22e/0x1470 <4> [333.240991] ? exc_page_fault+0xbd/0x2c0 <4> [333.240997] entry_SYSCALL_64_after_hwframe+0x76/0x7e <4> [333.241000] RIP: 0033:0x74a55051c5a4 <4> [333.241003] 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> [333.241006] RSP: 002b:00007ffced2c1208 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 <4> [333.241009] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 000074a55051c5a4 <4> [333.241011] RDX: 000000000000000c RSI: 00007ffced2c1440 RDI: 000000000000000c <4> [333.241013] RBP: 000000000000000c R08: 0000000000000073 R09: 0000000000000000 <4> [333.241015] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffced2c1440 <4> [333.241017] R13: 000000000000000c R14: 00005a9104c001b8 R15: 00005a9104c0028e <4> [333.241029] </TASK> <4> [333.241031] irq event stamp: 235285 <4> [333.241032] hardirqs last enabled at (235291): [<ffffffff814a9d69>] __up_console_sem+0x79/0xa0 <4> [333.241037] hardirqs last disabled at (235296): [<ffffffff814a9d4e>] __up_console_sem+0x5e/0xa0 <4> [333.241040] softirqs last enabled at (234962): [<ffffffff813d0e9f>] __irq_exit_rcu+0x13f/0x160 <4> [333.241043] softirqs last disabled at (234957): [<ffffffff813d0e9f>] __irq_exit_rcu+0x13f/0x160 <4> [333.241046] ---[ end trace 0000000000000000 ]--- <7> [333.791624] 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.841760] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [333.841777] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [334.392547] 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.442693] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [334.442710] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [334.993453] 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> [335.043595] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [335.043612] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [335.594804] 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> [335.644953] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [335.644970] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [335.645348] i915 0000:03:00.0: [drm:intel_engines_init_mmio [i915]] GT0: vdbox enable: 0005, instances: 0005 <7> [335.645490] i915 0000:03:00.0: [drm:intel_engines_init_mmio [i915]] GT0: vebox enable: 0001, instances: 0001 <7> [336.196343] 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> [336.246490] i915 0000:03:00.0: [drm] ERROR render: timed out waiting for forcewake ack request. <5> [336.246507] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [336.797349] 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> [336.847494] i915 0000:03:00.0: [drm] ERROR vdbox0: timed out waiting for forcewake ack request. <5> [336.847512] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [337.398311] 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> [337.448454] i915 0000:03:00.0: [drm] ERROR vdbox2: timed out waiting for forcewake ack request. <5> [337.448472] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [337.999616] 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> [338.049758] i915 0000:03:00.0: [drm] ERROR vebox0: timed out waiting for forcewake ack request. <5> [338.049776] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [338.600546] 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> [338.650681] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [338.650698] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [339.201420] 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> [339.251553] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [339.251570] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [339.802352] 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> [339.852487] i915 0000:03:00.0: [drm] ERROR render: timed out waiting for forcewake ack request. <5> [339.852504] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [340.403329] 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> [340.453464] i915 0000:03:00.0: [drm] ERROR render: timed out waiting for forcewake ack request. <5> [340.453481] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [341.004226] 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> [341.054359] i915 0000:03:00.0: [drm] ERROR render: timed out waiting for forcewake ack request. <5> [341.054377] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [341.605147] 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> [341.655283] i915 0000:03:00.0: [drm] ERROR render: timed out waiting for forcewake ack request. <5> [341.655301] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [342.206041] 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> [342.256174] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [342.256191] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [342.806933] 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> [342.857069] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [342.857086] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [343.407822] 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> [343.457955] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [343.457971] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [344.008720] 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> [344.059027] i915 0000:03:00.0: [drm] ERROR render: timed out waiting for forcewake ack request. <5> [344.059247] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [344.609958] 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> [344.660091] i915 0000:03:00.0: [drm] ERROR gt: timed out waiting for forcewake ack request. <5> [344.660108] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [345.210835] 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> [345.260994] i915 0000:03:00.0: [drm] ERROR vdbox0: timed out waiting for forcewake ack request. <5> [345.261011] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [345.811735] 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> [345.861870] i915 0000:03:00.0: [drm] ERROR vdbox2: timed out waiting for forcewake ack request. <5> [345.861887] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <7> [346.412610] 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> [346.462741] i915 0000:03:00.0: [drm] ERROR vebox0: timed out waiting for forcewake ack request. <5> [346.462757] i915 0000:03:00.0: [drm] CI tainted: 0x9 by fw_domains_get_with_fallback+0x30e/0x410 [i915] <3> [346.463624] i915 0000:03:00.0: [drm] ERROR GT0: rcs'0 reset request timed out: {request: 00000001, RESET_CTL: 00000000} <3> [346.464360] i915 0000:03:00.0: [drm] ERROR GT0: rcs'0 reset request timed out: {request: 00000001, RESET_CTL: 00000000} <3> [346.465083] i915 0000:03:00.0: [drm] ERROR GT0: bcs'0 reset request timed out: {request: 00000001, RESET_CTL: 00000000} <3> [346.465806] i915 0000:03:00.0: [drm] ERROR GT0: vcs'0 reset request timed out: {request: 00000001, RESET_CTL: 00000000} <3> [346.466528] i915 0000:03:00.0: [drm] ERROR GT0: vcs'2 reset request timed out: {request: 00000001, RESET_CTL: 00000000} <3> [346.467250] i915 0000:03:00.0: [drm] ERROR GT0: vecs'0 reset request timed out: {request: 00000001, RESET_CTL: 00000000} <7> [346.467665] i915 0000:03:00.0: [drm:i915_ggtt_probe_hw [i915]] GGTT size = 4096M <7> [346.467839] i915 0000:03:00.0: [drm:i915_ggtt_probe_hw [i915]] GMADR size = 0M <7> [346.467980] i915 0000:03:00.0: [drm:i915_ggtt_probe_hw [i915]] DSM size = 0M <6> [346.468118] i915 0000:03:00.0: [drm] VT-d active for gfx access <6> [346.468198] i915 0000:03:00.0: vgaarb: deactivate vga console <7> [346.468662] i915 0000:03:00.0: [drm:intel_gt_setup_lmem [i915]] LMEM: reserved legacy low-memory [0x0-0x100000] <7> [346.469093] i915 0000:03:00.0: [drm:i915_gem_init_stolen [i915]] GEN6_STOLEN_RESERVED = 0x00000000ffc00107 <7> [346.469258] i915 0000:03:00.0: [drm:i915_gem_init_stolen [i915]] Memory reserved for graphics device: 65536K, usable: 61440K <7> [346.469662] i915 0000:03:00.0: [drm:intel_memory_regions_hw_probe [i915]] Memory region(0): system-ttm: 15825 MiB [mem 0x00000000-0x3dd143fff], io: n/a <7> [346.469795] 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> [346.469924] 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> [346.471262] i915 0000:03:00.0: [drm:intel_opregion_setup [i915]] graphic opregion physical addr: 0x0 <7> [346.471454] i915 0000:03:00.0: [drm:intel_opregion_setup [i915]] ACPI OpRegion not supported! <7> [356.472167] i915 0000:03:00.0: [drm:skl_pcode_request [i915]] PCODE timeout, retrying with preemption disabled <4> [356.472529] ------------[ cut here ]------------ <4> [356.472534] i915 0000:03:00.0: [drm] drm_WARN_ON_ONCE(timeout_base_ms > 3) <4> [356.472538] WARNING: drivers/gpu/drm/i915/intel_pcode.c:200 at skl_pcode_request+0x25f/0x280 [i915], CPU#4: i915_module_loa/2390 <4> [356.472831] Modules linked in: vgem snd_hda_codec_intelhdmi snd_hda_codec_hdmi mei_gsc mei_me mei 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 ee1004 intel_tcc_cooling x86_pkg_temp_thermal cmdlinepart hid_generic intel_powerclamp spi_nor mtd gigabyte_wmi coretemp wmi_bmof intel_wmi_thunderbolt mxm_wmi kvm_intel snd_hda_intel snd_intel_dspcfg kvm irqbypass snd_hda_codec ghash_clmulni_intel aesni_intel snd_hda_core rapl usbhid snd_hwdep intel_cstate hid i2c_i801 snd_pcm i2c_mux snd_timer spi_intel_pci i2c_smbus snd video spi_intel soundcore e1000e intel_pch_thermal binfmt_misc intel_pmc_core pmt_telemetry pmt_discovery pmt_class pinctrl_cannonlake intel_pmc_ssram_telemetry nls_iso8859_1 acpi_pad intel_vsec wmi dm_multipath msr nvme_fabrics fuse efi_pstore nfnetlink autofs4 <4> [356.473075] CPU: 4 UID: 0 PID: 2390 Comm: i915_module_loa Tainted: G S U W L 7.0.0-rc5-Patchwork_163871v2-gb0c967b64ac6+ #1 PREEMPT(lazy) <4> [356.473085] Tainted: [S]=CPU_OUT_OF_SPEC, [U]=USER, [W]=WARN, [L]=SOFTLOCKUP <4> [356.473089] Hardware name: Gigabyte Technology Co., Ltd. GB-Z390 Garuda/GB-Z390 Garuda-CF, BIOS IG1c 11/19/2019 <4> [356.473093] RIP: 0010:skl_pcode_request+0x269/0x280 [i915] <4> [356.473406] Code: 04 48 8b 7f 08 48 8b 5f 50 48 85 db 75 03 48 8b 1f e8 bb 1c 64 e1 48 89 c6 48 8d 3d 91 fc 3e 00 48 c7 c1 88 5e ae a0 48 89 da <67> 48 0f b9 3a e9 15 ff ff ff e8 a8 a0 d1 e1 0f 1f 84 00 00 00 00 <4> [356.473412] RSP: 0018:ffffc9002211b680 EFLAGS: 00010246 <4> [356.473420] RAX: ffffffffa0acbffe RBX: ffff888101531f10 RCX: ffffffffa0ae5e88 <4> [356.473425] RDX: ffff888101531f10 RSI: ffffffffa0acbffe RDI: ffffffffa10014f0 <4> [356.473429] RBP: ffffc9002211b6c8 R08: 0000000000000000 R09: 0000000000000000 <4> [356.473433] R10: 0000000000000000 R11: 0000000000000000 R12: ffff88813d4d8e48 <4> [356.473438] R13: 000000000000007e R14: 0000000000000000 R15: 00000052f827e1ca <4> [356.473442] FS: 000074a54e22c940(0000) GS:ffff88852989a000(0000) knlGS:0000000000000000 <4> [356.473448] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 <4> [356.473452] CR2: 00005a9416050cb4 CR3: 000000011c7ed004 CR4: 00000000003726f0 <4> [356.473457] Call Trace: <4> [356.473461] <TASK> <4> [356.473477] pcode_init_wait+0x50/0x80 [i915] <4> [356.473773] intel_pcode_init+0x33/0x80 [i915] <4> [356.474062] i915_pcode_init+0x29/0xd0 [i915] <4> [356.474365] i915_driver_hw_probe+0x326/0x3c0 [i915] <4> [356.474654] i915_driver_probe+0x114/0x5d0 [i915] <4> [356.474937] ? mutex_unlock+0x12/0x20 <4> [356.474949] ? drm_privacy_screen_get+0x171/0x190 <4> [356.474958] ? acpi_dev_found+0x66/0x80 <4> [356.474976] i915_pci_probe+0xe2/0x1d0 [i915] <4> [356.475282] local_pci_probe+0x47/0xb0 <4> [356.475296] pci_call_probe+0x6c/0x360 <4> [356.475316] ? _raw_spin_unlock+0x22/0x50 <4> [356.475332] pci_device_probe+0xae/0x110 <4> [356.475345] really_probe+0xf1/0x410 <4> [356.475358] __driver_probe_device+0x8c/0x190 <4> [356.475368] device_driver_attach+0x57/0xd0 <4> [356.475380] bind_store+0x77/0xd0 <4> [356.475391] drv_attr_store+0x24/0x50 <4> [356.475400] sysfs_kf_write+0x4d/0x80 <4> [356.475412] kernfs_fop_write_iter+0x188/0x240 <4> [356.475426] vfs_write+0x283/0x540 <4> [356.475452] ksys_write+0x6f/0xf0 <4> [356.475465] __x64_sys_write+0x19/0x30 <4> [356.475472] x64_sys_call+0x259/0x26e0 <4> [356.475481] do_syscall_64+0xdd/0x1470 <4> [356.475491] ? putname+0x41/0x90 <4> [356.475499] ? kmem_cache_free+0x165/0x510 <4> [356.475516] ? putname+0x41/0x90 <4> [356.475524] ? do_sys_openat2+0x85/0xd0 <4> [356.475540] ? __x64_sys_openat+0x54/0xa0 <4> [356.475549] ? trace_hardirqs_on_prepare+0xe1/0x100 <4> [356.475562] ? do_syscall_64+0x22e/0x1470 <4> [356.475572] ? free_to_partial_list+0x46d/0x640 <4> [356.475580] ? __fput+0x1bf/0x2f0 <4> [356.475595] ? __slab_free+0x129/0x2b0 <4> [356.475610] ? __pcs_replace_full_main+0x2ad/0x710 <4> [356.475617] ? __pcs_replace_full_main+0x10/0x710 <4> [356.475627] ? __fput+0x1bf/0x2f0 <4> [356.475634] ? kmem_cache_free+0x165/0x510 <4> [356.475651] ? __fput+0x1bf/0x2f0 <4> [356.475663] ? fput_close_sync+0x3d/0xa0 <4> [356.475672] ? trace_hardirqs_on_prepare+0xe1/0x100 <4> [356.475684] ? do_syscall_64+0x22e/0x1470 <4> [356.475694] ? trace_hardirqs_on_prepare+0xe1/0x100 <4> [356.475706] ? do_syscall_64+0x22e/0x1470 <4> [356.475714] ? exc_page_fault+0xbd/0x2c0 <4> [356.475728] entry_SYSCALL_64_after_hwframe+0x76/0x7e <4> [356.475734] RIP: 0033:0x74a55051c5a4 <4> [356.475742] 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> [356.475747] RSP: 002b:00007ffced2c1208 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 <4> [356.475755] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 000074a55051c5a4 <4> [356.475760] RDX: 000000000000000c RSI: 00007ffced2c1440 RDI: 000000000000000c <4> [356.475765] RBP: 000000000000000c R08: 0000000000000073 R09: 0000000000000000 <4> [356.475769] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffced2c1440 <4> [356.475773] R13: 000000000000000c R14: 00005a9104c001b8 R15: 00005a9104c0028e <4> [356.475802] </TASK> <4> [356.475806] irq event stamp: 3117531 <4> [356.475810] hardirqs last enabled at (3117537): [<ffffffff814a9d69>] __up_console_sem+0x79/0xa0 <4> [356.475820] hardirqs last disabled at (3117542): [<ffffffff814a9d4e>] __up_console_sem+0x5e/0xa0 <4> [356.475827] softirqs last enabled at (3117238): [<ffffffff813d0e9f>] __irq_exit_rcu+0x13f/0x160 <4> [356.475834] softirqs last disabled at (3117233): [<ffffffff813d0e9f>] __irq_exit_rcu+0x13f/0x160 <4> [356.475841] ---[ end trace 0000000000000000 ]--- <5> [356.525980] i915 0000:03:00.0: [drm] Waiting for HW initialisation... <6> [386.071622] /proc/cgroups lists only v1 controllers, use cgroup.controllers of root cgroup for v2 info <3> [536.528484] i915 0000:03:00.0: [drm] ERROR GT0: intel_pcode_init failed -517 <3> [536.565160] i915 0000:03:00.0: [drm] ERROR Device initialization failed (-517) <6> [536.567999] [IGT] i915_module_load: finished subtest __uc_init, FAIL <6> [536.568828] [IGT] i915_module_load: starting dynamic subtest i915_driver_mmio_probe <6> [536.569481] [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.*

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

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

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

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

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

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

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

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

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

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

<7> [330.959388] 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> [330.959650] 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> [330.959850] 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> [330.960018] 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> [330.960184] 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> [330.960383] i915 0000:03:00.0: [drm:intel_bw_atomic_check [i915]] [CRTC:171:pipe A] data rate 0 num active planes 0

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

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

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

<7> [330.985149] 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> [330.985358] 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> [330.985564] 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> [330.985816] 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> [330.985988] 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> [330.986162] 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> [330.986344] 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> [330.986573] 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> [330.986773] 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> [330.986954] 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> [330.987123] 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> [330.987290] 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> [330.987474] 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> [330.987992] 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> [330.988175] 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> [330.988374] 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> [330.988600] 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> [330.988798] 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> [330.988965] 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> [330.989164] 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> [330.989332] 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> [330.989500] 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> [330.989741] 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> [330.989925] 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> [330.990093] 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> [330.990260] 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> [330.990427] 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> [330.990763] 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> [330.990947] 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> [330.991116] 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> [330.991284] 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> [330.991469] 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> [330.991690] 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> [330.991889] 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> [330.992056] 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> [330.992239] 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> [330.992411] 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> [330.992649] i915 0000:03:00.0: [drm:intel_atomic_check [i915]] [CRTC:171:pipe A] fastset requirement not met, forcing full modeset

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

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

<7> [330.993227] 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> [330.993455] 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> [330.993760] i915 0000:03:00.0: [drm:intel_cdclk_atomic_check [i915]] [CRTC:171:pipe A] min cdclk: 74250 kHz -> 0 kHz

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

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

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

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

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

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

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

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

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

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

<7> [330.998125] i915 0000:03:00.0: [drm:intel_power_well_disable [i915]] disabling DDI_IO_TC1

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

<7> [331.001865] i915 0000:03:00.0: [drm:verify_connector_state [i915]] [CONNECTOR:619:HDMI-A-3]

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

<4> [333.239810] CPU: 2 UID: 0 PID: 2390 Comm: i915_module_loa Tainted: G S U W L 7.0.0-rc5-Patchwork_163871v2-gb0c967b64ac6+ #1 PREEMPT(lazy)

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

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

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

<4> [333.239968] Code: 04 48 8b 7f 08 4c 8b 67 50 4d 85 e4 75 03 4c 8b 27 e8 9b 84 59 e1 48 89 c6 48 8d 3d 71 cd 34 00 48 c7 c1 d4 1e ad a0 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> [333.239971] RSP: 0018:ffffc9002211b6a0 EFLAGS: 00010246

<4> [333.239975] RAX: ffffffffa0acbffe RBX: ffff88810bd64028 RCX: ffffffffa0ad1ed4

<4> [333.239977] RDX: ffff888101531f10 RSI: ffffffffa0acbffe RDI: ffffffffa1007df0

<4> [333.239979] RBP: ffffc9002211b720 R08: 0000000000000000 R09: 0000000000000000

<4> [333.239980] R10: 0000000000000000 R11: 0000000000000000 R12: ffff888101531f10

<4> [333.239982] R13: ffff88810bd662c8 R14: ffff88813d4d8e48 R15: 0000000000000000

<4> [333.239984] FS: 000074a54e22c940(0000) GS:ffff88852979a000(0000) knlGS:0000000000000000

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

<4> [333.239989] CR2: 00005b8749952a30 CR3: 000000011c7ed004 CR4: 00000000003726f0

<4> [333.239991] Call Trace:

<4> [333.239993] <TASK>

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

<4> [333.240930] ? free_to_partial_list+0x46d/0x640

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

<4> [333.240940] ? __slab_free+0x129/0x2b0

<4> [333.240946] ? __pcs_replace_full_main+0x2ad/0x710

<4> [333.240949] ? __pcs_replace_full_main+0x10/0x710

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

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

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

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

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

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

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

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

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

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

<4> [333.241000] RIP: 0033:0x74a55051c5a4

<4> [333.241003] 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> [333.241006] RSP: 002b:00007ffced2c1208 EFLAGS: 00000202 ORIG_RAX: 0000000000000001

<4> [333.241009] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 000074a55051c5a4

<4> [333.241011] RDX: 000000000000000c RSI: 00007ffced2c1440 RDI: 000000000000000c

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

<4> [333.241015] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffced2c1440

<4> [333.241017] R13: 000000000000000c R14: 00005a9104c001b8 R15: 00005a9104c0028e

<4> [333.241029] </TASK>

<4> [333.241031] irq event stamp: 235285

<4> [333.241032] hardirqs last enabled at (235291): [<ffffffff814a9d69>] __up_console_sem+0x79/0xa0

<4> [333.241037] hardirqs last disabled at (235296): [<ffffffff814a9d4e>] __up_console_sem+0x5e/0xa0

<4> [333.241040] softirqs last enabled at (234962): [<ffffffff813d0e9f>] __irq_exit_rcu+0x13f/0x160

<4> [333.241043] softirqs last disabled at (234957): [<ffffffff813d0e9f>] __irq_exit_rcu+0x13f/0x160

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

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

Results for igt@i915_module_load@fault-injection