Result: 24 Warning(s)
integration-manifest git-log-oneline i915_display_info0 igt_runner0 run0 runtimes0 results0.json i915_display_info_post_exec0 boot0 dmesg0
| Detail | Value |
|---|---|
| Duration | unknown |
| Igt-Version |
IGT-Version: 2.3-g16ce286ca (x86_64) (Linux: 6.19.0-rc6-Patchwork_159035v10-gd081bd677479+ x86_64) |
| Out |
Starting dynamic subtest: gem_contexts Dynamic subtest gem_contexts: SUCCESS (40.220s) This test caused an abort condition: Lockdep not active /proc/lockdep_stats contents: lock-classes: 2658 [max: 8192] dynamic-keys: 881 direct dependencies: 37160 [max: 524288] indirect dependencies: 185995 all direct dependencies: 126928 dependency chains: 523942 [max: 524288] dependency chain hlocks used: 2555252 [max: 2621440] dependency chain hlocks lost: 0 in-hardirq chains: 15 in-softirq chains: 0 in-process chains: 101 stack-trace entries: 497449 [max: 524288] number of stack traces: 22986 number of stack hash chains: 12319 combined max dependencies: 1632 hardirq-safe locks: 28 hardirq-unsafe locks: 1603 softirq-safe locks: 0 softirq-unsafe locks: 1420 irq-safe locks: 28 irq-unsafe locks: 1603 hardirq-read-safe locks: 2 hardirq-read-unsafe locks: 408 softirq-read-safe locks: 0 softirq-read-unsafe locks: 405 irq-read-safe locks: 2 irq-read-unsafe locks: 408 uncategorized locks: 736 unused locks: 0 max locking depth: 23 max bfs queue depth: 1291 max lock class index: 2777 debug_locks: 0 zapped classes: 3190 zapped lock chains: 61011 large chain blocks: 187 |
| Err |
Starting dynamic subtest: gem_contexts Dynamic subtest gem_contexts: SUCCESS (40.220s) |
| Dmesg |
<6> [1109.654933] [IGT] i915_selftest: starting dynamic subtest gem_contexts
<5> [1111.590189] Setting dangerous option force_probe - tainting kernel
<5> [1111.590681] Setting dangerous option live_selftests - tainting kernel
<6> [1111.666020] i915 0000:4d:00.0: Force probing unsupported Device ID 56c0, tainting kernel
<7> [1111.699517] i915 0000:4d:00.0: [drm:intel_display_device_probe [i915]] Unknown device ID 56c0; disabling display.
<7> [1111.742887] i915 0000:4d:00.0: [drm:intel_wopcm_init_early [i915]] WOPCM: 2048K
<7> [1111.743453] i915 0000:4d:00.0: [drm:intel_uc_init_early [i915]] GT0: enable_guc=3 (guc:yes submission:yes huc:yes slpc:yes)
<7> [1111.745483] i915 0000:4d:00.0: [drm:intel_pch_detect [i915]] No PCH found.
<7> [1111.747402] i915 0000:4d:00.0: [drm:intel_gt_probe_all [i915]] GT0: Setting up Primary GT
<6> [1111.753739] resource: avoiding allocation from e820 entry [mem 0x0009f000-0x000fffff]
<6> [1111.753754] resource: avoiding allocation from e820 entry [mem 0x0009f000-0x000fffff]
<7> [1111.756963] i915 0000:4d:00.0: [drm:intel_engines_init_mmio [i915]] GT0: vdbox enable: 0005, instances: 0005
<7> [1111.757437] i915 0000:4d:00.0: [drm:intel_engines_init_mmio [i915]] GT0: vebox enable: 0003, instances: 0003
<7> [1111.830425] i915 0000:4d:00.0: [drm:i915_ggtt_probe_hw [i915]] GGTT size = 4096M
<7> [1111.830704] i915 0000:4d:00.0: [drm:i915_ggtt_probe_hw [i915]] GMADR size = 0M
<7> [1111.830917] i915 0000:4d:00.0: [drm:i915_ggtt_probe_hw [i915]] DSM size = 0M
<6> [1111.831183] i915 0000:4d:00.0: [drm] VT-d active for gfx access
<7> [1111.861943] i915 0000:4d:00.0: [drm:i915_gem_init_stolen [i915]] GEN6_STOLEN_RESERVED = 0x000000037fc00147
<7> [1111.862364] i915 0000:4d:00.0: [drm:i915_gem_init_stolen [i915]] Memory reserved for graphics device: 24576K, usable: 20480K
<7> [1111.863256] i915 0000:4d:00.0: [drm:intel_memory_regions_hw_probe [i915]] Memory region(0): system-ttm: 128487 MiB [mem 0x00000000-0x1f5e7ccfff], io: n/a
<7> [1111.863638] i915 0000:4d:00.0: [drm:intel_memory_regions_hw_probe [i915]] Memory region(1): local0: 14248 MiB [mem 0x00000000-0x37a7fffff], io: 14248 MiB [mem 0x3bbc00000000-0x3bbf7a7fffff]
<7> [1111.864016] i915 0000:4d:00.0: [drm:intel_memory_regions_hw_probe [i915]] Memory region(6): stolen-local: 20 MiB [mem 0x37e800000-0x37fbfffff], io: 20 MiB [mem 0x3bbf7e800000-0x3bbf7fbfffff]
<7> [1111.953573] i915 0000:4d:00.0: [drm:intel_opregion_setup [i915]] graphic opregion physical addr: 0x0
<7> [1111.953887] i915 0000:4d:00.0: [drm:intel_opregion_setup [i915]] ACPI OpRegion not supported!
<7> [1111.968215] i915 0000:4d:00.0: [drm:snb_pcode_write_timeout [i915]] warning: pcode (write of 0x00000000 to mbox 67c) mailbox access failed for snb_pcode_write_p [i915]: -6
<7> [1111.968668] i915 0000:4d:00.0: [drm:intel_bios_init [i915]] Skipping VBT init due to disabled display.
<7> [1112.046316] i915 0000:4d:00.0: [drm:intel_wopcm_init [i915]] GuC WOPCM is already locked [1440K, 544K)
<7> [1112.046659] i915 0000:4d:00.0: [drm:i915_init_ggtt [i915]] clearing unused GTT space: [0, fee00000]
<7> [1112.053015] i915 0000:4d:00.0: [drm:debug_dump_steering [i915]] MCR Steering: Default steering: group=0x0, instance=0x0
<7> [1112.053279] i915 0000:4d:00.0: [drm:debug_dump_steering [i915]] MCR Steering: MSLICE steering: uses default steering
<7> [1112.053498] i915 0000:4d:00.0: [drm:debug_dump_steering [i915]] MCR Steering: LNCF steering: uses default steering
<7> [1112.053768] i915 0000:4d:00.0: [drm:wa_init_finish [i915]] GT0: Initialized 18 GT workarounds on global
<7> [1112.132973] i915 0000:4d:00.0: [drm:wa_init_finish [i915]] GT0: Initialized 18 engine workarounds on rcs'0
<7> [1112.133311] i915 0000:4d:00.0: [drm:wa_init_finish [i915]] GT0: Initialized 2 whitelist workarounds on rcs'0
<7> [1112.133573] i915 0000:4d:00.0: [drm:wa_init_finish [i915]] GT0: Initialized 9 context workarounds on rcs'0
<7> [1112.147921] i915 0000:4d:00.0: [drm:wa_init_finish [i915]] GT0: Initialized 2 engine workarounds on bcs'0
<7> [1112.148277] i915 0000:4d:00.0: [drm:wa_init_finish [i915]] GT0: Initialized 2 context workarounds on bcs'0
<7> [1112.152650] i915 0000:4d:00.0: [drm:wa_init_finish [i915]] GT0: Initialized 1 engine workarounds on vcs'0
<7> [1112.152957] i915 0000:4d:00.0: [drm:wa_init_finish [i915]] GT0: Initialized 1 context workarounds on vcs'0
<7> [1112.177591] i915 0000:4d:00.0: [drm:wa_init_finish [i915]] GT0: Initialized 1 engine workarounds on vcs'2
<7> [1112.177916] i915 0000:4d:00.0: [drm:wa_init_finish [i915]] GT0: Initialized 1 context workarounds on vcs'2
<7> [1112.180757] i915 0000:4d:00.0: [drm:wa_init_finish [i915]] GT0: Initialized 1 engine workarounds on vecs'0
<7> [1112.181085] i915 0000:4d:00.0: [drm:wa_init_finish [i915]] GT0: Initialized 1 context workarounds on vecs'0
<7> [1112.189063] i915 0000:4d:00.0: [drm:wa_init_finish [i915]] GT0: Initialized 1 engine workarounds on vecs'1
<7> [1112.189384] i915 0000:4d:00.0: [drm:wa_init_finish [i915]] GT0: Initialized 1 context workarounds on vecs'1
<7> [1112.190754] i915 0000:4d:00.0: [drm:wa_init_finish [i915]] GT0: Initialized 12 engine workarounds on ccs'0
<7> [1112.191025] i915 0000:4d:00.0: [drm:wa_init_finish [i915]] GT0: Initialized 1 context workarounds on ccs'0
<7> [1112.206707] i915 0000:4d:00.0: [drm:intel_guc_log_create [i915]] GT0: GUC: guc_log_level=5 (enabled, verbose:yes, verbosity:3)
<7> [1112.207141] i915 0000:4d:00.0: [drm:intel_guc_capture_init [i915]] GT0: GUC: capture found 96 ext-regs.
<7> [1112.207525] i915 0000:4d:00.0: [drm:intel_guc_ads_create [i915]] GT0: GUC: Used 8 KB for temporary ADS regset
<7> [1112.294958] i915 0000:4d:00.0: [drm:intel_guc_init [i915]] GT0: GUC: param[ 0] = 0xb004f
<7> [1112.295322] i915 0000:4d:00.0: [drm:intel_guc_init [i915]] GT0: GUC: param[ 1] = 0x424800
<7> [1112.295590] i915 0000:4d:00.0: [drm:intel_guc_init [i915]] GT0: GUC: param[ 2] = 0x4
<7> [1112.295838] i915 0000:4d:00.0: [drm:intel_guc_init [i915]] GT0: GUC: param[ 3] = 0x3
<7> [1112.296127] i915 0000:4d:00.0: [drm:intel_guc_init [i915]] GT0: GUC: param[ 4] = 0x980
<7> [1112.296385] i915 0000:4d:00.0: [drm:intel_guc_init [i915]] GT0: GUC: param[ 5] = 0x56c00008
<7> [1112.296625] i915 0000:4d:00.0: [drm:intel_guc_init [i915]] GT0: GUC: param[ 6] = 0x0
<7> [1112.296855] i915 0000:4d:00.0: [drm:intel_guc_init [i915]] GT0: GUC: param[ 7] = 0x0
<7> [1112.297120] i915 0000:4d:00.0: [drm:intel_guc_init [i915]] GT0: GUC: param[ 8] = 0x0
<7> [1112.297350] i915 0000:4d:00.0: [drm:intel_guc_init [i915]] GT0: GUC: param[ 9] = 0x0
<7> [1112.297576] i915 0000:4d:00.0: [drm:intel_guc_init [i915]] GT0: GUC: param[10] = 0x0
<7> [1112.297800] i915 0000:4d:00.0: [drm:intel_guc_init [i915]] GT0: GUC: param[11] = 0x0
<7> [1112.298026] i915 0000:4d:00.0: [drm:intel_guc_init [i915]] GT0: GUC: param[12] = 0x0
<7> [1112.298282] i915 0000:4d:00.0: [drm:intel_guc_init [i915]] GT0: GUC: param[13] = 0x0
<7> [1112.298513] i915 0000:4d:00.0: [drm:intel_huc_init [i915]] GT0: HuC: loaded by GSC = yes
<6> [1112.324312] i915 0000:4d:00.0: [drm] GT0: GuC firmware i915/dg2_guc_70.bin version 70.53.0
<6> [1112.324318] i915 0000:4d:00.0: [drm] GT0: HuC firmware i915/dg2_huc_gsc.bin version 7.10.16
<7> [1112.336924] i915 0000:4d:00.0: [drm:intel_guc_fw_upload [i915]] GT0: GUC: init took 7ms, freq = 1800MHz -> 1800MHz vs 1800MHz, status = 0x8002F034, count = 0, ret = 0
<7> [1112.349156] i915 0000:4d:00.0: [drm:guc_enable_communication [i915]] GT0: GUC: communication enabled
<6> [1112.385552] i915 0000:4d:00.0: [drm] GT0: GUC: submission enabled
<6> [1112.385558] i915 0000:4d:00.0: [drm] GT0: GUC: SLPC enabled
<6> [1112.401631] i915 0000:4d:00.0: [drm] GT0: GUC: RC enabled
<7> [1112.405779] i915 0000:4d:00.0: [drm:__guc_action_get_hwconfig [i915]] GT0: GUC: Querying HW config table: size = 0, offset = 0x00000000
<7> [1112.406585] i915 0000:4d:00.0: [drm:__guc_action_get_hwconfig [i915]] GT0: GUC: Querying HW config table: size = 780, offset = 0x00D30000
<7> [1113.055398] i915 0000:4d:00.0: [drm:intel_engines_driver_register [i915]] renamed rcs'0 to rcs0
<7> [1113.055666] i915 0000:4d:00.0: [drm:intel_engines_driver_register [i915]] renamed bcs'0 to bcs0
<7> [1113.055883] i915 0000:4d:00.0: [drm:intel_engines_driver_register [i915]] renamed vcs'0 to vcs0
<7> [1113.056779] i915 0000:4d:00.0: [drm:intel_engines_driver_register [i915]] renamed vcs'2 to vcs1
<7> [1113.056987] i915 0000:4d:00.0: [drm:intel_engines_driver_register [i915]] renamed vecs'0 to vecs0
<7> [1113.057225] i915 0000:4d:00.0: [drm:intel_engines_driver_register [i915]] renamed vecs'1 to vecs1
<7> [1113.057417] i915 0000:4d:00.0: [drm:intel_engines_driver_register [i915]] renamed ccs'0 to ccs0
<6> [1113.124398] [drm] Initialized i915 1.6.0 for 0000:4d:00.0 on minor 0
<7> [1113.187677] i915 0000:4d:00.0: [drm:intel_gsc_init [i915]] setting up GSC lmem
<7> [1113.926742] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: pciid=0x56c0 rev=0x08 platform=DG2 (subplatform=0x1) gen=12
<7> [1113.926996] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: graphics version: 12.55
<7> [1113.927255] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: media version: 12.55
<7> [1113.927452] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: graphics stepping: C0
<7> [1113.927643] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: media stepping: C0
<7> [1113.927829] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: gt: 0
<7> [1113.928014] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: memory-regions: 0x43
<7> [1113.928234] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: page-sizes: 0x211000
<7> [1113.928424] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: platform: DG2
<7> [1113.928609] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: ppgtt-size: 48
<7> [1113.928794] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: ppgtt-type: 2
<7> [1113.928979] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: dma_mask_size: 46
<7> [1113.929202] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: is_mobile: no
<7> [1113.929391] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: require_force_probe: yes
<7> [1113.929576] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: is_dgfx: yes
<7> [1113.929761] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_64bit_reloc: yes
<7> [1113.929947] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_64k_pages: yes
<7> [1113.930162] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: gpu_reset_clobbers_display: no
<7> [1113.930348] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_reset_engine: yes
<7> [1113.930533] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_3d_pipeline: yes
<7> [1113.930718] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_flat_ccs: yes
<7> [1113.930902] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_global_mocs: yes
<7> [1113.931111] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_gmd_id: no
<7> [1113.931297] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_gt_uc: yes
<7> [1113.931481] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_heci_pxp: yes
<7> [1113.931667] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_heci_gscfi: yes
<7> [1113.931851] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_guc_deprivilege: yes
<7> [1113.932055] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_guc_tlb_invalidation: no
<7> [1113.932241] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_l3_ccs_read: no
<7> [1113.932426] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_l3_dpf: no
<7> [1113.932611] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_llc: no
<7> [1113.932796] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_logical_ring_contexts: yes
<7> [1113.932980] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_logical_ring_elsq: yes
<7> [1113.933190] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_media_ratio_mode: yes
<7> [1113.933375] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_mslice_steering: yes
<7> [1113.933559] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_oa_bpc_reporting: yes
<7> [1113.933744] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_oa_slice_contrib_limits: yes
<7> [1113.933928] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_oam: yes
<7> [1113.934137] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_one_eu_per_fuse_bit: no
<7> [1113.934322] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_pxp: no
<7> [1113.934506] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_rc6: yes
<7> [1113.934690] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_rc6p: no
<7> [1113.934874] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_rps: yes
<7> [1113.943555] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_runtime_pm: yes
<7> [1113.943778] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_snoop: yes
<7> [1113.943964] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_coherent_ggtt: no
<7> [1113.944187] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: tuning_thread_rr_after_dep: yes
<7> [1113.944375] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: unfenced_needs_alignment: no
<7> [1113.944570] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: hws_needs_physical: no
<7> [1113.944756] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has_pooled_eu: no
<7> [1113.944941] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: iommu: enabled
<7> [1113.945150] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: available engines: 4c1403
<7> [1113.945338] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: subslice total: 32
<7> [1113.945522] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: geometry dss mask=00000000,ffffffff
<7> [1113.945708] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: compute dss mask=00000000,ffffffff
<7> [1113.945892] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: EU total: 512
<7> [1113.946100] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: EU per subslice: 16
<7> [1113.946287] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has slice power gating: no
<7> [1113.946471] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has subslice power gating: no
<7> [1113.946656] i915 0000:4d:00.0: [drm:i915_driver_probe [i915]] device info: has EU power gating: no
<6> [1113.946840] i915 0000:4d:00.0: [drm] DRM_I915_DEBUG enabled
<6> [1113.946841] i915 0000:4d:00.0: [drm] DRM_I915_DEBUG_GEM enabled
<6> [1113.946842] i915 0000:4d:00.0: [drm] DRM_I915_DEBUG_RUNTIME_PM enabled
<6> [1113.969627] i915: Performing live selftests with st_random_seed=0x918f0ede st_timeout=500
<6> [1113.969632] i915: Running gem_contexts
<6> [1114.015436] i915: Running i915_gem_context_live_selftests/live_nop_switch
<7> [1114.019344] i915 0000:4d:00.0: [drm:i915_gem_open [i915]]
<6> [1114.356157] mei_pxp i915.mei-gsc.19712-fbf6fcf1-96cf-4e2e-a6a6-1bab8cbe36b1: bound 0000:4d:00.0 (ops i915_pxp_tee_component_ops [i915])
<7> [1118.029037] BUG: MAX_LOCKDEP_CHAINS too low!
<7> [1118.029042] turning off the locking correctness validator.
<4> [1118.029046] CPU: 0 UID: 0 PID: 8456 Comm: kworker/0:4 Tainted: G S U 6.19.0-rc6-Patchwork_159035v10-gd081bd677479+ #1 PREEMPT_{RT,(lazy)}
<4> [1118.029051] Tainted: [S]=CPU_OUT_OF_SPEC, [U]=USER
<4> [1118.029052] Hardware name: Intel Corporation WHITLEY/WHITLEY, BIOS SE5C6200.86B.0020.P41.2109300305 09/30/2021
<4> [1118.029053] Workqueue: events work_for_cpu_fn
<4> [1118.029062] Call Trace:
<4> [1118.029063] <TASK>
<4> [1118.029067] dump_stack_lvl+0x91/0xf0
<4> [1118.029075] dump_stack+0x10/0x20
<4> [1118.029078] __lock_acquire+0x1f1e/0x2790
<4> [1118.029086] ? __lock_acquire+0x1187/0x2790
<4> [1118.029089] ? lock_is_held_type+0xa3/0x130
<4> [1118.029096] lock_acquire+0xc4/0x2c0
<4> [1118.029099] ? __schedule+0x912/0x1c00
<4> [1118.029104] ? plist_del+0x62/0xc0
<4> [1118.029108] ? lock_is_held_type+0xa3/0x130
<4> [1118.029111] psi_task_switch+0x99/0x550
<4> [1118.029116] ? __schedule+0x912/0x1c00
<4> [1118.029119] __schedule+0x912/0x1c00
<4> [1118.029122] ? is_module_text_address+0x88/0x180
<4> [1118.029130] ? __entry_text_end+0x16ebf/0x1025bd
<4> [1118.029135] preempt_schedule_irq+0x3d/0x90
<4> [1118.029138] raw_irqentry_exit_cond_resched+0x3e/0x50
<4> [1118.029144] irqentry_exit+0x65/0x7c0
<4> [1118.029148] sysvec_apic_timer_interrupt+0x57/0xc0
<4> [1118.029151] asm_sysvec_apic_timer_interrupt+0x1b/0x20
<4> [1118.029153] RIP: 0010:lock_acquire+0xeb/0x2c0
<4> [1118.029157] Code: cf ff ff b8 ff ff ff ff 48 83 c4 28 65 0f c1 05 f3 78 ae 02 83 f8 01 0f 85 c0 01 00 00 48 83 7d a0 00 74 06 fb 0f 1f 44 00 00 <48> 8b 45 d0 65 48 2b 05 11 23 ae 02 0f 85 b3 01 00 00 48 8d 65 d8
<4> [1118.029159] RSP: 0018:ffa00000080236c8 EFLAGS: 00000206
<4> [1118.029161] RAX: 0000000000000001 RBX: 0000000000000000 RCX: 0000000000000000
<4> [1118.029163] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000
<4> [1118.029164] RBP: ffa0000008023728 R08: 0000000000000000 R09: 0000000000000000
<4> [1118.029165] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000001
<4> [1118.029166] R13: 0000000000000000 R14: ffffffff836fcd40 R15: 0000000000000000
<4> [1118.029172] ? i915_gem_object_create_lmem+0x19/0x30 [i915]
<4> [1118.029594] ? lrc_alloc+0x81/0x2e0 [i915]
<4> [1118.029832] ? guc_context_alloc+0x12/0x20 [i915]
<4> [1118.030112] ? intel_context_alloc_state+0x8e/0x390 [i915]
<4> [1118.030336] ? __intel_context_do_pin_ww+0x4b4/0xe90 [i915]
<4> [1118.030546] fs_reclaim_acquire+0xc5/0x100
<4> [1118.030551] ? kmem_cache_alloc_noprof+0x47/0x620
<4> [1118.030556] kmem_cache_alloc_noprof+0x47/0x620
<4> [1118.030559] ? __alloc_object+0x34/0x310
<4> [1118.030566] __alloc_object+0x34/0x310
<4> [1118.030569] __create_object+0x29/0xc0
<4> [1118.030573] kmemleak_alloc+0x4a/0xa0
<4> [1118.030577] kmem_cache_alloc_noprof+0x441/0x620
<4> [1118.030581] ? i915_gem_object_alloc+0x1a/0x40 [i915]
<4> [1118.030830] i915_gem_object_alloc+0x1a/0x40 [i915]
<4> [1118.031064] __i915_gem_object_create_region+0xe3/0x3b0 [i915]
<4> [1118.031310] i915_gem_object_create_region+0x1e/0x30 [i915]
<4> [1118.031544] i915_gem_object_create_lmem+0x19/0x30 [i915]
<4> [1118.031773] lrc_alloc+0x81/0x2e0 [i915]
<4> [1118.032006] guc_context_alloc+0x12/0x20 [i915]
<4> [1118.032276] intel_context_alloc_state+0x8e/0x390 [i915]
<4> [1118.032502] __intel_context_do_pin_ww+0x4b4/0xe90 [i915]
<4> [1118.032714] ? i915_gem_ww_ctx_init+0xee/0x150 [i915]
<4> [1118.032970] ? intel_context_create_request+0x35/0x1c0 [i915]
<4> [1118.033185] ? intel_context_create_request+0x35/0x1c0 [i915]
<4> [1118.033391] intel_context_create_request+0x174/0x1c0 [i915]
<4> [1118.033596] ? mg_pll_enable+0x660/0x680 [i915]
<4> [1118.033896] ? irq_entries_start+0xd0/0x660
<4> [1118.033899] igt_request_alloc+0xda/0x310 [i915]
<4> [1118.034171] live_nop_switch.part.0+0x1df/0x750 [i915]
<4> [1118.034432] ? ring_buffer_unlock_commit+0x2d/0x1c0
<4> [1118.034438] ? trace_vbprintk+0x216/0x2b0
<4> [1118.034442] ? __i915_subtests+0xa4/0x250 [i915]
<4> [1118.034698] ? __trace_bprintk+0xa9/0xb0
<4> [1118.034704] live_nop_switch+0x20/0x30 [i915]
<4> [1118.034951] __i915_subtests+0xb8/0x250 [i915]
<4> [1118.035201] ? __pfx___i915_live_teardown+0x10/0x10 [i915]
<4> [1118.035446] ? __pfx___i915_live_setup+0x10/0x10 [i915]
<4> [1118.035688] ? _printk+0x57/0x80
<4> [1118.035694] i915_gem_context_live_selftests+0x8e/0x100 [i915]
<4> [1118.035939] __run_selftests+0xc5/0x220 [i915]
<4> [1118.036192] i915_live_selftests+0xaa/0x130 [i915]
<4> [1118.036441] i915_pci_probe+0xee/0x1d0 [i915]
<4> [1118.036678] ? __pm_runtime_resume+0x53/0x90
<4> [1118.036684] local_pci_probe+0x47/0xb0
<4> [1118.036690] work_for_cpu_fn+0x1a/0x30
<4> [1118.036694] process_one_work+0x22e/0x6b0
<4> [1118.036699] worker_thread+0x1e8/0x3d0
<4> [1118.036703] ? __pfx_worker_thread+0x10/0x10
<4> [1118.036706] kthread+0x11f/0x250
<4> [1118.036710] ? rt_spin_unlock+0xa0/0x140
<4> [1118.036713] ? __pfx_kthread+0x10/0x10
<4> [1118.036716] ret_from_fork+0x344/0x3a0
<4> [1118.036719] ? __pfx_kthread+0x10/0x10
<4> [1118.036722] ret_from_fork_asm+0x1a/0x30
<4> [1118.036730] </TASK>
<6> [1118.536028] Populated 1024 contexts on rcs0 in 514322095ns
<6> [1119.769285] Switch latencies on rcs0: 1 = 595564ns, 180 = 240845ns
<6> [1120.262605] Populated 1024 contexts on bcs0 in 493307891ns
<6> [1121.536454] Switch latencies on bcs0: 1 = 455799ns, 192 = 129052ns
<6> [1122.175714] Populated 1024 contexts on vcs0 in 639249377ns
<6> [1123.446780] Switch latencies on vcs0: 1 = 972641ns, 178 = 221728ns
<6> [1123.949332] Populated 1024 contexts on vcs1 in 502540450ns
<6> [1125.210110] Switch latencies on vcs1: 1 = 900105ns, 178 = 214034ns
<6> [1125.696998] Populated 1024 contexts on vecs0 in 486876346ns
<6> [1126.944494] Switch latencies on vecs0: 1 = 679784ns, 162 = 239223ns
<6> [1127.470206] Populated 1024 contexts on vecs1 in 525700949ns
<6> [1128.715753] Switch latencies on vecs1: 1 = 548634ns, 178 = 219435ns
<6> [1129.253628] Populated 1024 contexts on ccs0 in 537864475ns
<6> [1130.523417] Switch latencies on ccs0: 1 = 811218ns, 178 = 155719ns
<6> [1130.523505] i915: Running i915_gem_context_live_selftests/live_parallel_switch
<7> [1130.523797] i915 0000:4d:00.0: [drm:i915_gem_open [i915]]
<6> [1131.200949] bcs0: 347 switches (sync) <0>
<6> [1131.201081] vecs1: 344 switches (sync) <0>
<6> [1131.201904] ccs0: 332 switches (sync) <0>
<6> [1131.201945] vecs0: 349 switches (sync) <0>
<6> [1131.201964] rcs0: 345 switches (sync) <0>
<6> [1131.202048] vcs1: 329 switches (sync) <0>
<6> [1131.202130] vcs0: 328 switches (sync) <0>
<6> [1131.719859] vcs1: 408 switches (many) <0>
<6> [1131.719949] rcs0: 381 switches (many) <0>
<6> [1131.720849] ccs0: 374 switches (many) <0>
<6> [1131.721165] bcs0: 412 switches (many) <0>
<6> [1131.721268] vecs0: 407 switches (many) <0>
<6> [1131.721330] vecs1: 407 switches (many) <0>
<6> [1131.721417] vcs0: 408 switches (many) <0>
<6> [1133.944229] i915: Running i915_gem_context_live_selftests/igt_ctx_exec
<7> [1133.944592] i915 0000:4d:00.0: [drm:i915_gem_open [i915]]
<6> [1134.448268] Submitted 2 contexts to rcs0, filling 2 dwords
<7> [1134.753190] i915 0000:4d:00.0: [drm:i915_gem_open [i915]]
<6> [1135.295812] Submitted 2 contexts to bcs0, filling 2 dwords
<7> [1135.703134] i915 0000:4d:00.0: [drm:i915_gem_open [i915]]
<6> [1136.244250] Submitted 2 contexts to vcs0, filling 2 dwords
<7> [1136.589428] i915 0000:4d:00.0: [drm:i915_gem_open [i915]]
<6> [1137.228716] Submitted 2 contexts to vcs1, filling 2 dwords
<7> [1137.573513] i915 0000:4d:00.0: [drm:i915_gem_open [i915]]
<6> [1138.177487] Submitted 2 contexts to vecs0, filling 2 dwords
<7> [1138.528003] i915 0000:4d:00.0: [drm:i915_gem_open [i915]]
<6> [1139.047084] Submitted 2 contexts to vecs1, filling 2 dwords
<7> [1139.407293] i915 0000:4d:00.0: [drm:i915_gem_open [i915]]
<6> [1139.941888] Submitted 2 contexts to ccs0, filling 2 dwords
<6> [1140.320838] i915: Running i915_gem_context_live_selftests/igt_ctx_readonly
<7> [1140.321113] i915 0000:4d:00.0: [drm:i915_gem_open [i915]]
<6> [1140.381930] i915: Running i915_gem_context_live_selftests/igt_ctx_sseu
<6> [1140.403437] i915: Running i915_gem_context_live_selftests/igt_shared_ctx_exec
<7> [1140.403695] i915 0000:4d:00.0: [drm:i915_gem_open [i915]]
<6> [1140.915038] Submitted 94 contexts to rcs0, filling 94 dwords
<6> [1141.440268] Submitted 95 contexts to bcs0, filling 95 dwords
<6> [1141.967315] Submitted 96 contexts to vcs0, filling 96 dwords
<6> [1142.494200] Submitted 122 contexts to vcs1, filling 122 dwords
<6> [1143.035482] Submitted 121 contexts to vecs0, filling 121 dwords
<6> [1143.572473] Submitted 129 contexts to vecs1, filling 129 dwords
<6> [1144.109298] Submitted 113 contexts to ccs0, filling 113 dwords
<6> [1145.283628] i915: Running i915_gem_context_live_selftests/igt_vm_isolation
<7> [1145.284022] i915 0000:4d:00.0: [drm:i915_gem_open [i915]]
<6> [1148.802601] Checked 12381 scratch offsets across 7 engines
<7> [1148.875291] i915 0000:4d:00.0: [drm:intel_gt_set_wedged [i915]] called from intel_gt_set_wedged_on_fini+0x12/0x50 [i915]
<3> [1149.130238] i915 0000:4d:00.0: probe with driver i915 failed with error -25
<4> [1149.625711]
<4> [1149.625716] ============================================
<4> [1149.625717] WARNING: possible recursive locking detected
<4> [1149.625719] 6.19.0-rc6-Patchwork_159035v10-gd081bd677479+ #1 Tainted: G S U
<4> [1149.625721] --------------------------------------------
<4> [1149.625723] kworker/0:4/8456 is trying to acquire lock:
<4> [1149.625725] ff1100103ea36598 (&rq->__lock){-...}-{2:2}, at: finish_task_switch.isra.0+0x8e/0x400
<4> [1149.625738]
but task is already holding lock:
<4> [1149.625739] ff1100103ea36598 (&rq->__lock){-...}-{2:2}, at: raw_spin_rq_lock_nested+0x22/0xa0
<4> [1149.625744]
other info that might help us debug this:
<4> [1149.625745] Possible unsafe locking scenario:
<4> [1149.625746] CPU0
<4> [1149.625747] ----
<4> [1149.625748] lock(&rq->__lock);
<4> [1149.625749] lock(&rq->__lock);
<4> [1149.625750]
*** DEADLOCK ***
<4> [1149.625751] May be due to missing lock nesting notation
<4> [1149.625751] 7 locks held by kworker/0:4/8456:
<4> [1149.625753] #0: ff11000100803938 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x441/0x6b0
<4> [1149.625761] #1: ffa0000008023e20 ((work_completion)(&wfc.work)#2){+.+.}-{0:0}, at: process_one_work+0x1ee/0x6b0
<4> [1149.625767] #2: ffa0000008023a30 (reservation_ww_class_acquire){+.+.}-{0:0}, at: intel_context_create_request+0x35/0x1c0 [i915]
<4> [1149.626055] #3: ffa0000008023a58 (reservation_ww_class_mutex){+.+.}-{3:3}, at: intel_context_create_request+0x35/0x1c0 [i915]
<4> [1149.626235] #4: ff1100017ae955f0 (&ce->pin_mutex){+.+.}-{3:3}, at: intel_context_alloc_state+0x2a/0x390 [i915]
<4> [1149.626412] #5: ffffffff836fcd40 (fs_reclaim){+.+.}-{0:0}, at: kmem_cache_alloc_noprof+0x47/0x620
<4> [1149.626420] #6: ff1100103ea36598 (&rq->__lock){-...}-{2:2}, at: raw_spin_rq_lock_nested+0x22/0xa0
<4> [1149.626427]
stack backtrace:
<4> [1149.626430] CPU: 0 UID: 0 PID: 8456 Comm: kworker/0:4 Tainted: G S U 6.19.0-rc6-Patchwork_159035v10-gd081bd677479+ #1 PREEMPT_{RT,(lazy)}
<4> [1149.626434] Tainted: [S]=CPU_OUT_OF_SPEC, [U]=USER
<4> [1149.626435] Hardware name: Intel Corporation WHITLEY/WHITLEY, BIOS SE5C6200.86B.0020.P41.2109300305 09/30/2021
<4> [1149.626437] Workqueue: 0x0 (events)
<4> [1149.626442] Call Trace:
<4> [1149.626443] <TASK>
<4> [1149.626445] dump_stack_lvl+0x91/0xf0
<4> [1149.626453] dump_stack+0x10/0x20
<4> [1149.626456] print_deadlock_bug+0x23f/0x320
<4> [1149.626463] __lock_acquire+0x146e/0x2790
<4> [1149.626467] ? lock_acquire+0x27d/0x2c0
<4> [1149.626473] lock_acquire+0xc4/0x2c0
<4> [1149.626476] ? finish_task_switch.isra.0+0x8e/0x400
<4> [1149.626481] finish_task_switch.isra.0+0xb3/0x400
<4> [1149.626484] ? finish_task_switch.isra.0+0x8e/0x400
<4> [1149.626488] __schedule+0x5b3/0x1c00
<4> [1149.626494] ? lock_acquire+0x27d/0x2c0
<4> [1149.626497] ? process_one_work+0x257/0x6b0
<4> [1149.626502] ? lock_release+0x1db/0x280
<4> [1149.626506] schedule+0x3a/0x180
<4> [1149.626509] worker_thread+0xc8/0x3d0
<4> [1149.626513] ? __pfx_worker_thread+0x10/0x10
<4> [1149.626516] kthread+0x11f/0x250
<4> [1149.626520] ? rt_spin_unlock+0xa0/0x140
<4> [1149.626524] ? __pfx_kthread+0x10/0x10
<4> [1149.626527] ret_from_fork+0x344/0x3a0
<4> [1149.626531] ? __pfx_kthread+0x10/0x10
<4> [1149.626533] ret_from_fork_asm+0x1a/0x30
<4> [1149.626542] </TASK>
<6> [1149.875328] [IGT] i915_selftest: finished subtest gem_contexts, SUCCESS
|