Result: 17 Warning(s)
git-log-oneline igt_runner0 run0 runtimes0 results0.json boot0 dmesg0
| Detail | Value |
|---|---|
| Igt-Version |
IGT-Version: 1.27.1-g354c536a4 (x86_64) (Linux: 6.5.0-rc3-linus-v6.5-rc3-g6eaae1980760+ x86_64) |
| Out |
Opened device: /dev/dri/card0 Starting subtest: basic-clone-single-crtc Testing: basic-clone-single-crtc 2 connector combinations No dynamic tests executed. Subtest basic-clone-single-crtc: SKIP (0.000s) This test caused an abort condition: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1764 [max: 8192] direct dependencies: 17462 [max: 32768] indirect dependencies: 130921 all direct dependencies: 361862 dependency chains: 25222 [max: 131072] dependency chain hlocks used: 104249 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 287 in-softirq chains: 586 in-process chains: 24349 stack-trace entries: 165074 [max: 1048576] number of stack traces: 8335 number of stack hash chains: 6531 combined max dependencies: 4116513600 hardirq-safe locks: 105 hardirq-unsafe locks: 1050 softirq-safe locks: 204 softirq-unsafe locks: 965 irq-safe locks: 223 irq-unsafe locks: 1050 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 313 softirq-read-safe locks: 7 softirq-read-unsafe locks: 308 irq-read-safe locks: 7 irq-read-unsafe locks: 313 uncategorized locks: 285 unused locks: 1 max locking depth: 15 max bfs queue depth: 392 max lock class index: 1763 chain lookup misses: 25669 chain lookup hits: 270568914 cyclic checks: 25717 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4373 find-mask backwards checks: 2638 hardirq on events: 172702403 hardirq off events: 172702387 redundant hardirq ons: 48 redundant hardirq offs: 24 softirq on events: 711090 softirq off events: 711090 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 117 large chain blocks: 1 |
| Err |
Starting subtest: basic-clone-single-crtc Subtest basic-clone-single-crtc: SKIP (0.000s) |
| Dmesg |
<4> [216.747539]
<4> [216.747554] ======================================================
<4> [216.747576] WARNING: possible circular locking dependency detected
<4> [216.747594] 6.5.0-rc3-linus-v6.5-rc3-g6eaae1980760+ #1 Not tainted
<4> [216.747611] ------------------------------------------------------
<4> [216.747628] kworker/5:1H/150 is trying to acquire lock:
<4> [216.747646] ffff888114e0d110 (>->reset.backoff_srcu){++++}-{0:0}, at: _intel_gt_reset_lock+0x0/0x330 [i915]
<4> [216.747879]
but task is already holding lock:
<4> [216.747905] ffffc900005d3e40 ((work_completion)(&(&guc->timestamp.work)->work)){+.+.}-{0:0}, at: process_one_work+0x1c1/0x500
<4> [216.747946]
which lock already depends on the new lock.
<4> [216.747979]
the existing dependency chain (in reverse order) is:
<4> [216.748008]
-> #3 ((work_completion)(&(&guc->timestamp.work)->work)){+.+.}-{0:0}:
<4> [216.748046] lock_acquire+0xd8/0x2d0
<4> [216.748063] __flush_work+0x74/0x530
<4> [216.748078] __cancel_work_timer+0x14f/0x1f0
<4> [216.748094] intel_guc_submission_reset_prepare+0x81/0x4b0 [i915]
<4> [216.748371] intel_uc_reset_prepare+0x9c/0x120 [i915]
<4> [216.748636] reset_prepare+0x21/0x60 [i915]
<4> [216.748836] intel_gt_reset+0x1dd/0x470 [i915]
<4> [216.749032] intel_gt_reset_global+0xfb/0x170 [i915]
<4> [216.749227] intel_gt_handle_error+0x368/0x420 [i915]
<4> [216.749421] intel_gt_debugfs_reset_store+0x5c/0xc0 [i915]
<4> [216.749606] i915_wedged_set+0x1d/0x40 [i915]
<4> [216.749770] simple_attr_write_xsigned.constprop.0+0xb4/0x110
<4> [216.749792] full_proxy_write+0x58/0x80
<4> [216.749807] vfs_write+0xcb/0x520
<4> [216.749821] ksys_write+0x64/0xe0
<4> [216.749834] do_syscall_64+0x3c/0x90
<4> [216.749849] entry_SYSCALL_64_after_hwframe+0x6e/0xd8
<4> [216.749869]
-> #2 (>->reset.mutex){+.+.}-{3:3}:
<4> [216.749898] lock_acquire+0xd8/0x2d0
<4> [216.749913] i915_gem_shrinker_taints_mutex+0x31/0x50 [i915]
<4> [216.750134] intel_gt_init_reset+0x65/0x80 [i915]
<4> [216.750331] intel_gt_common_init_early+0xe1/0x170 [i915]
<4> [216.750514] intel_root_gt_init_early+0x48/0x60 [i915]
<4> [216.750695] i915_driver_probe+0x260/0xcf0 [i915]
<4> [216.750852] i915_pci_probe+0xdc/0x210 [i915]
<4> [216.751010] pci_device_probe+0x95/0x120
<4> [216.751027] really_probe+0x164/0x3c0
<4> [216.751043] __driver_probe_device+0x73/0x160
<4> [216.751060] driver_probe_device+0x19/0xa0
<4> [216.751077] __driver_attach+0xb6/0x180
<4> [216.751092] bus_for_each_dev+0x77/0xd0
<4> [216.751106] bus_add_driver+0x114/0x210
<4> [216.751121] driver_register+0x5b/0x110
<4> [216.751136] 0xffffffffa0020033
<4> [216.751157] do_one_initcall+0x57/0x270
<4> [216.751172] do_init_module+0x5f/0x210
<4> [216.751186] load_module+0x1ca4/0x1f00
<4> [216.751200] init_module_from_file+0x86/0xd0
<4> [216.751216] idempotent_init_module+0x17c/0x230
<4> [216.751233] __x64_sys_finit_module+0x56/0xb0
<4> [216.751250] do_syscall_64+0x3c/0x90
<4> [216.751263] entry_SYSCALL_64_after_hwframe+0x6e/0xd8
<4> [216.751282]
-> #1 (fs_reclaim){+.+.}-{0:0}:
<4> [216.751309] lock_acquire+0xd8/0x2d0
<4> [216.751323] fs_reclaim_acquire+0xac/0xe0
<4> [216.752172] __alloc_pages+0xeb/0x2e0
<4> [216.753008] pte_alloc_one+0x17/0xf0
<4> [216.753815] __pte_alloc+0x26/0xf0
<4> [216.754603] __apply_to_page_range+0x5c3/0x680
<4> [216.755376] remap_io_mapping+0x70/0x130 [i915]
<4> [216.756233] vm_fault_gtt+0x473/0xf70 [i915]
<4> [216.757100] __do_fault+0x2f/0x1d0
<4> [216.757822] do_pte_missing+0x4bf/0xbd0
<4> [216.758540] __handle_mm_fault+0x329/0x700
<4> [216.759287] handle_mm_fault+0xa2/0x230
<4> [216.760026] do_user_addr_fault+0x3c9/0x920
<4> [216.760769] exc_page_fault+0x68/0x1a0
<4> [216.761498] asm_exc_page_fault+0x26/0x30
<4> [216.762214]
-> #0 (>->reset.backoff_srcu){++++}-{0:0}:
<4> [216.763634] check_prev_add+0xef/0xd30
<4> [216.764359] __lock_acquire+0x184b/0x2330
<4> [216.765085] lock_acquire+0xd8/0x2d0
<4> [216.765808] _intel_gt_reset_lock+0x57/0x330 [i915]
<4> [216.766622] guc_timestamp_ping+0x35/0x130 [i915]
<4> [216.767410] process_one_work+0x24e/0x500
<4> [216.768081] worker_thread+0x4f/0x3a0
<4> [216.768744] kthread+0xff/0x130
<4> [216.769401] ret_from_fork+0x2c/0x50
<4> [216.770055] ret_from_fork_asm+0x1b/0x30
<4> [216.770712]
other info that might help us debug this:
<4> [216.772653] Chain exists of:
>->reset.backoff_srcu --> >->reset.mutex --> (work_completion)(&(&guc->timestamp.work)->work)
<4> [216.772656] Possible unsafe locking scenario:
<4> [216.772656] CPU0 CPU1
<4> [216.772657] ---- ----
<4> [216.772657] lock((work_completion)(&(&guc->timestamp.work)->work));
<4> [216.772658] lock(>->reset.mutex);
<4> [216.772659] lock((work_completion)(&(&guc->timestamp.work)->work));
<4> [216.772659] lock(>->reset.backoff_srcu);
<4> [216.772660]
*** DEADLOCK ***
<4> [216.772660] 2 locks held by kworker/5:1H/150:
<4> [216.772661] #0: ffff888100082138 ((wq_completion)events_highpri){+.+.}-{0:0}, at: process_one_work+0x1bd/0x500
<4> [216.772666] #1: ffffc900005d3e40 ((work_completion)(&(&guc->timestamp.work)->work)){+.+.}-{0:0}, at: process_one_work+0x1c1/0x500
<4> [216.772669]
stack backtrace:
<4> [216.772670] CPU: 5 PID: 150 Comm: kworker/5:1H Not tainted 6.5.0-rc3-linus-v6.5-rc3-g6eaae1980760+ #1
<4> [216.772672] Hardware name: Intel Corporation Raptor Lake Client Platform/RaptorLake-P LP5 RVP, BIOS RPLPFWI1.R00.3257.A00.2207020323 07/02/2022
<4> [216.772673] Workqueue: events_highpri guc_timestamp_ping [i915]
<4> [216.787173] Call Trace:
<4> [216.787174] <TASK>
<4> [216.787175] dump_stack_lvl+0x64/0xb0
<4> [216.787179] check_noncircular+0x15f/0x180
<4> [216.787182] check_prev_add+0xef/0xd30
<4> [216.787184] __lock_acquire+0x184b/0x2330
<4> [216.787186] lock_acquire+0xd8/0x2d0
<4> [216.787187] ? __pfx__intel_gt_reset_lock+0x10/0x10 [i915]
<6> [216.787312] Console: switching to colour dummy device 80x25
<4> [216.787296] _intel_gt_reset_lock+0x57/0x330 [i915]
<4> [216.787398] ? __pfx__intel_gt_reset_lock+0x10/0x10 [i915]
<4> [216.787510] guc_timestamp_ping+0x35/0x130 [i915]
<6> [216.787625] [IGT] kms_setmode: executing
<4> [216.787653] process_one_work+0x24e/0x500
<4> [216.787658] worker_thread+0x4f/0x3a0
<4> [216.787662] ? __pfx_worker_thread+0x10/0x10
<4> [216.787665] kthread+0xff/0x130
<4> [216.787668] ? __pfx_kthread+0x10/0x10
<4> [216.787671] ret_from_fork+0x2c/0x50
<4> [216.787675] ? __pfx_kthread+0x10/0x10
<4> [216.787678] ret_from_fork_asm+0x1b/0x30
<4> [216.787681] RIP: 0000:0x0
<4> [216.787686] Code: Unable to access opcode bytes at 0xffffffffffffffd6.
<4> [216.787690] RSP: 0000:0000000000000000 EFLAGS: 00000000 ORIG_RAX: 0000000000000000
<4> [216.787694] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000000000
<4> [216.787697] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000
<4> [216.787700] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000
<4> [216.787703] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
<4> [216.787706] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
<4> [216.787710] </TASK>
<7> [216.789501] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [216.789906] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [216.790023] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<6> [216.790492] [IGT] kms_setmode: starting subtest basic-clone-single-crtc
<6> [216.790757] [IGT] kms_setmode: finished subtest basic-clone-single-crtc, SKIP
<6> [216.790982] [IGT] kms_setmode: exiting, ret=77
<7> [216.791057] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<6> [216.810714] Console: switching to colour frame buffer device 240x67
|