Bug 111028

Summary:	[CI][DRMTIP] igt@perf_pmu@cpu-hotplug - dmesg-warn - BUG: sleeping function called from invalid context at kernel/locking/mutex.c:909
Product:	DRI	Reporter:	Lakshmi <lakshminarayana.vudum>
Component:	DRM/Intel	Assignee:	Intel GFX Bugs mailing list <intel-gfx-bugs>
Status:	RESOLVED DUPLICATE	QA Contact:	Intel GFX Bugs mailing list <intel-gfx-bugs>
Severity:	normal
Priority:	medium	CC:	intel-gfx-bugs
Version:	DRI git
Hardware:	Other
OS:	All
Whiteboard:	ReadyForDev
i915 platform:	ICL	i915 features:	Perf/PMU

Description Lakshmi 2019-07-01 06:49:16 UTC

https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_317/fi-icl-u3/igt@perf_pmu@cpu-hotplug.html

6> [881.677280] Console: switching to colour dummy device 80x25
<6> [881.677321] [IGT] perf_pmu: executing
<6> [881.685436] [IGT] perf_pmu: starting subtest cpu-hotplug
<4> [881.835264] NOHZ: local_softirq_pending 80
<4> [881.836164] IRQ 120: no longer affine to CPU0
<4> [881.836182] IRQ 121: no longer affine to CPU0
<4> [881.836200] IRQ 122: no longer affine to CPU0
<3> [881.836595] BUG: sleeping function called from invalid context at kernel/locking/mutex.c:909
<3> [881.836595] in_atomic(): 1, irqs_disabled(): 1, pid: 11, name: migration/0
<4> [881.836595] no locks held by migration/0/11.
<4> [881.836595] irq event stamp: 73720
<4> [881.836595] hardirqs last  enabled at (73719): [<ffffffffb29bf954>] _raw_spin_unlock_irq+0x24/0x50
<4> [881.836595] hardirqs last disabled at (73720): [<ffffffffb217dfd3>] multi_cpu_stop+0xb3/0xf0
<4> [881.836595] softirqs last  enabled at (68742): [<ffffffffc04e63d4>] intel_engine_is_idle+0x184/0x270 [i915]
<4> [881.836595] softirqs last disabled at (68738): [<ffffffffc04e6387>] intel_engine_is_idle+0x137/0x270 [i915]
<3> [881.836595] Preemption disabled at:
<4> [881.836595] [<ffffffffb217e1f4>] cpu_stopper_thread+0x84/0x110
<4> [881.836595] CPU: 0 PID: 11 Comm: migration/0 Tainted: G     U            5.2.0-rc6-g01457c077195-drmtip_317+ #1
<4> [881.836595] Hardware name: Intel Corporation Ice Lake Client Platform/IceLake U DDR4 SODIMM PD RVP TLC, BIOS ICLSFWR1.R00.3183.A00.1905020411 05/02/2019
<4> [881.836595] Call Trace:
<4> [881.836595]  dump_stack+0x67/0x9b
<4> [881.836595]  ___might_sleep+0x167/0x250
<4> [881.836595]  ? kernfs_find_and_get_ns+0x1b/0x50
<4> [881.836595]  __mutex_lock+0x57/0x960
<4> [881.836595]  ? lockdep_hardirqs_off+0x94/0xd0
<4> [881.836595]  ? generic_exec_single+0x9f/0xe0
<4> [881.836595]  ? kernfs_find_and_get_ns+0x1b/0x50
<4> [881.836595]  ? __rdmsr_on_cpu+0x60/0x60
<4> [881.836595]  ? smp_call_function_single+0xb4/0x150
<4> [881.836595]  ? _raw_spin_unlock_irqrestore+0x39/0x60
<4> [881.836595]  ? kernfs_find_and_get_ns+0x1b/0x50
<4> [881.836595]  kernfs_find_and_get_ns+0x1b/0x50
<4> [881.836595]  sysfs_remove_group+0x20/0x80
<4> [881.836595]  ? __reload_late+0xd0/0xd0
<4> [881.836595]  mc_cpu_down_prep+0x17/0x40
<4> [881.836595]  cpuhp_invoke_callback+0x9b/0xa20
<4> [881.836595]  take_cpu_down+0x62/0xa0
<4> [881.836595]  multi_cpu_stop+0x5a/0xf0
<4> [881.836595]  ? cpu_stop_queue_work+0xe0/0xe0
<4> [881.836595]  cpu_stopper_thread+0x8c/0x110
<4> [881.836595]  ? smpboot_thread_fn+0x23/0x280
<4> [881.836595]  ? smpboot_thread_fn+0x6b/0x280
<4> [881.836595]  smpboot_thread_fn+0x1d3/0x280
<4> [881.836595]  ? sort_range+0x20/0x20
<4> [881.836595]  kthread+0x119/0x130
<4> [881.836595]  ? kthread_park+0x80/0x80
<4> [881.836595]  ret_from_fork+0x24/0x50
<6> [881.840265] smpboot: CPU 0 is now offline
<6> [882.861282] smpboot: Booting Node 0 Processor 0 APIC 0x0
<3> [882.861931] BUG: sleeping function called from invalid context at mm/slab.h:418
<3> [882.861931] in_atomic(): 1, irqs_disabled(): 1, pid: 0, name: swapper/0
<4> [882.861931] no locks held by swapper/0/0.
<4> [882.861931] irq event stamp: 3285024
<4> [882.861931] hardirqs last  enabled at (3285023): [<ffffffffb205b53f>] switch_mm+0x2f/0x50
<4> [882.861931] hardirqs last disabled at (3285024): [<ffffffffb2043c74>] native_play_dead+0x14/0x100
<4> [882.861931] softirqs last  enabled at (3284992): [<ffffffffb2c0033a>] __do_softirq+0x33a/0x4b9
<4> [882.861931] softirqs last disabled at (3284981): [<ffffffffb20ba219>] irq_exit+0xa9/0xc0
<3> [882.861931] Preemption disabled at:
<4> [882.861931] [<ffffffffb2042c30>] start_secondary+0x60/0x1c0
<4> [882.861931] CPU: 0 PID: 0 Comm: swapper/0 Tainted: G     U  W         5.2.0-rc6-g01457c077195-drmtip_317+ #1
<4> [882.861931] Hardware name: Intel Corporation Ice Lake Client Platform/IceLake U DDR4 SODIMM PD RVP TLC, BIOS ICLSFWR1.R00.3183.A00.1905020411 05/02/2019
<4> [882.861931] Call Trace:
<4> [882.861931]  dump_stack+0x67/0x9b
<4> [882.861931]  ___might_sleep+0x167/0x250
<4> [882.861931]  ? __kernfs_new_node.constprop.8+0x59/0x200
<4> [882.861931]  kmem_cache_alloc+0x1ab/0x280
<4> [882.861931]  __kernfs_new_node.constprop.8+0x59/0x200
<4> [882.861931]  ? apply_microcode_intel+0x40/0x1a0
<4> [882.861931]  ? collect_cpu_info+0xe0/0xe0
<4> [882.861931]  ? collect_cpu_info_local+0x30/0x30
<4> [882.861931]  ? lockdep_hardirqs_off+0x94/0xd0
<4> [882.861931]  kernfs_new_node+0x1f/0x40
<4> [882.861931]  kernfs_create_dir_ns+0x26/0x80
<4> [882.861931]  internal_create_group+0x2c7/0x390
<4> [882.861931]  mc_cpu_online+0x42/0xa0
<4> [882.861931]  ? microcode_init_cpu+0xa0/0xa0
<4> [882.861931]  cpuhp_invoke_callback+0x9b/0xa20
<4> [882.861931]  ? cpumask_next+0x16/0x20
<4> [882.861931]  ? topology_phys_to_logical_pkg+0x1e/0x60
<4> [882.861931]  notify_cpu_starting+0x52/0x70
<4> [882.861931]  start_secondary+0xbb/0x1c0
<4> [882.861931]  secondary_startup_64+0xa4/0xb0
<7> [883.012302] [drm:edp_panel_vdd_off_sync [i915]] Turning eDP port A VDD off
<7> [883.012596] [drm:edp_panel_vdd_off_sync [i915]] PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<6> [883.064252] smpboot: CPU 1 is now offline
<6> [884.084086] x86: Booting SMP configuration:
<6> [884.084100] smpboot: Booting Node 0 Processor 1 APIC 0x2
<3> [884.087055] BUG: sleeping function called from invalid context at mm/slab.h:418
<3> [884.087055] in_atomic(): 1, irqs_disabled(): 1, pid: 0, name: swapper/1
<4> [884.087055] no locks held by swapper/1/0.
<4> [884.087055] irq event stamp: 4221500
<4> [884.087055] hardirqs last  enabled at (4221499): [<ffffffffb205b53f>] switch_mm+0x2f/0x50
<4> [884.087055] hardirqs last disabled at (4221500): [<ffffffffb2043c74>] native_play_dead+0x14/0x100
<4> [884.087055] softirqs last  enabled at (4221454): [<ffffffffb2c0033a>] __do_softirq+0x33a/0x4b9
<4> [884.087055] softirqs last disabled at (4221435): [<ffffffffb20ba219>] irq_exit+0xa9/0xc0
<3> [884.087055] Preemption disabled at:
<4> [884.087055] [<ffffffffb2042c30>] start_secondary+0x60/0x1c0
<4> [884.087055] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G     U  W         5.2.0-rc6-g01457c077195-drmtip_317+ #1
<4> [884.087055] Hardware name: Intel Corporation Ice Lake Client Platform/IceLake U DDR4 SODIMM PD RVP TLC, BIOS ICLSFWR1.R00.3183.A00.1905020411 05/02/2019
<4> [884.087055] Call Trace:
<4> [884.087055]  dump_stack+0x67/0x9b
<4> [884.087055]  ___might_sleep+0x167/0x250
<4> [884.087055]  ? __kernfs_new_node.constprop.8+0x59/0x200
<4> [884.087055]  kmem_cache_alloc+0x1ab/0x280
<4> [884.087055]  __kernfs_new_node.constprop.8+0x59/0x200
<4> [884.087055]  ? apply_microcode_intel+0x40/0x1a0
<4> [884.087055]  ? collect_cpu_info+0xe0/0xe0
<4> [884.087055]  ? collect_cpu_info_local+0x30/0x30
<4> [884.087055]  ? lockdep_hardirqs_off+0x94/0xd0
<4> [884.087055]  kernfs_new_node+0x1f/0x40
<4> [884.087055]  kernfs_create_dir_ns+0x26/0x80
<4> [884.087055]  internal_create_group+0x2c7/0x390
<4> [884.087055]  mc_cpu_online+0x42/0xa0
<4> [884.087055]  ? microcode_init_cpu+0xa0/0xa0
<4> [884.087055]  cpuhp_invoke_callback+0x9b/0xa20
<4> [884.087055]  ? cpumask_next+0x16/0x20
<4> [884.087055]  ? topology_phys_to_logical_pkg+0x1e/0x60
<4> [884.087055]  notify_cpu_starting+0x52/0x70
<4> [884.087055]  start_secondary+0xbb/0x1c0
<4> [884.087055]  secondary_startup_64+0xa4/0xb0
<6> [884.175025] smpboot: CPU 2 is now offline
<6> [885.187551] smpboot: Booting Node 0 Processor 2 APIC 0x4
<3> [885.190417] BUG: sleeping function called from invalid context at mm/slab.h:418
<3> [885.190417] in_atomic(): 1, irqs_disabled(): 1, pid: 0, name: swapper/2
<4> [885.190417] no locks held by swapper/2/0.
<4> [885.190417] irq event stamp: 3229114
<4> [885.190417] hardirqs last  enabled at (3229113): [<ffffffffb205b53f>] switch_mm+0x2f/0x50
<4> [885.190417] hardirqs last disabled at (3229114): [<ffffffffb2043c74>] native_play_dead+0x14/0x100
<4> [885.190417] softirqs last  enabled at (3229068): [<ffffffffb2c0033a>] __do_softirq+0x33a/0x4b9
<4> [885.190417] softirqs last disabled at (3229049): [<ffffffffb20ba219>] irq_exit+0xa9/0xc0
<3> [885.190417] Preemption disabled at:
<4> [885.190417] [<ffffffffb2042c30>] start_secondary+0x60/0x1c0
<4> [885.190417] CPU: 2 PID: 0 Comm: swapper/2 Tainted: G     U  W         5.2.0-rc6-g01457c077195-drmtip_317+ #1
<4> [885.190417] Hardware name: Intel Corporation Ice Lake Client Platform/IceLake U DDR4 SODIMM PD RVP TLC, BIOS ICLSFWR1.R00.3183.A00.1905020411 05/02/2019
<4> [885.190417] Call Trace:
<4> [885.190417]  dump_stack+0x67/0x9b
<4> [885.190417]  ___might_sleep+0x167/0x250
<4> [885.190417]  ? __kernfs_new_node.constprop.8+0x59/0x200
<4> [885.190417]  kmem_cache_alloc+0x1ab/0x280
<4> [885.190417]  __kernfs_new_node.constprop.8+0x59/0x200
<4> [885.190417]  ? apply_microcode_intel+0x40/0x1a0
<4> [885.190417]  ? collect_cpu_info+0xe0/0xe0
<4> [885.190417]  ? collect_cpu_info_local+0x30/0x30
<4> [885.190417]  ? lockdep_hardirqs_off+0x94/0xd0
<4> [885.190417]  kernfs_new_node+0x1f/0x40
<4> [885.190417]  kernfs_create_dir_ns+0x26/0x80
<4> [885.190417]  internal_create_group+0x2c7/0x390
<4> [885.190417]  mc_cpu_online+0x42/0xa0
<4> [885.190417]  ? microcode_init_cpu+0xa0/0xa0
<4> [885.190417]  cpuhp_invoke_callback+0x9b/0xa20
<4> [885.190417]  ? cpumask_next+0x16/0x20
<4> [885.190417]  ? topology_phys_to_logical_pkg+0x1e/0x60
<4> [885.190417]  notify_cpu_starting+0x52/0x70
<4> [885.190417]  start_secondary+0xbb/0x1c0
<4> [885.190417]  secondary_startup_64+0xa4/0xb0
<6> [885.259769] smpboot: CPU 3 is now offline
<6> [886.271418] smpboot: Booting Node 0 Processor 3 APIC 0x6
<3> [886.274289] BUG: sleeping function called from invalid context at mm/slab.h:418
<3> [886.274289] in_atomic(): 1, irqs_disabled(): 1, pid: 0, name: swapper/3
<4> [886.274289] no locks held by swapper/3/0.
<4> [886.274289] irq event stamp: 2548064
<4> [886.274289] hardirqs last  enabled at (2548063): [<ffffffffb205b53f>] switch_mm+0x2f/0x50
<4> [886.274289] hardirqs last disabled at (2548064): [<ffffffffb2043c74>] native_play_dead+0x14/0x100
<4> [886.274289] softirqs last  enabled at (2548018): [<ffffffffb2c0033a>] __do_softirq+0x33a/0x4b9
<4> [886.274289] softirqs last disabled at (2547991): [<ffffffffb20ba219>] irq_exit+0xa9/0xc0
<3> [886.274289] Preemption disabled at:
<4> [886.274289] [<ffffffffb2042c30>] start_secondary+0x60/0x1c0
<4> [886.274289] CPU: 3 PID: 0 Comm: swapper/3 Tainted: G     U  W         5.2.0-rc6-g01457c077195-drmtip_317+ #1
<4> [886.274289] Hardware name: Intel Corporation Ice Lake Client Platform/IceLake U DDR4 SODIMM PD RVP TLC, BIOS ICLSFWR1.R00.3183.A00.1905020411 05/02/2019
<4> [886.274289] Call Trace:
<4> [886.274289]  dump_stack+0x67/0x9b
<4> [886.274289]  ___might_sleep+0x167/0x250
<4> [886.274289]  ? __kernfs_new_node.constprop.8+0x59/0x200
<4> [886.274289]  kmem_cache_alloc+0x1ab/0x280
<4> [886.274289]  __kernfs_new_node.constprop.8+0x59/0x200
<4> [886.274289]  ? apply_microcode_intel+0x40/0x1a0
<4> [886.274289]  ? collect_cpu_info+0xe0/0xe0
<4> [886.274289]  ? collect_cpu_info_local+0x30/0x30
<4> [886.274289]  ? lockdep_hardirqs_off+0x94/0xd0
<4> [886.274289]  kernfs_new_node+0x1f/0x40
<4> [886.274289]  kernfs_create_dir_ns+0x26/0x80
<4> [886.274289]  internal_create_group+0x2c7/0x390
<4> [886.274289]  mc_cpu_online+0x42/0xa0
<4> [886.274289]  ? microcode_init_cpu+0xa0/0xa0
<4> [886.274289]  cpuhp_invoke_callback+0x9b/0xa20
<4> [886.274289]  ? cpumask_next+0x16/0x20
<4> [886.274289]  ? topology_phys_to_logical_pkg+0x1e/0x60
<4> [886.274289]  notify_cpu_starting+0x52/0x70
<4> [886.274289]  start_secondary+0xbb/0x1c0
<4> [886.274289]  secondary_startup_64+0xa4/0xb0
<6> [886.349791] smpboot: CPU 4 is now offline
<6> [887.359702] smpboot: Booting Node 0 Processor 4 APIC 0x1
<3> [887.362067] BUG: sleeping function called from invalid context at mm/slab.h:418
<3> [887.362067] in_atomic(): 1, irqs_disabled(): 1, pid: 0, name: swapper/4
<4> [887.362067] no locks held by swapper/4/0.
<4> [887.362067] irq event stamp: 2614842
<4> [887.362067] hardirqs last  enabled at (2614841): [<ffffffffb205b53f>] switch_mm+0x2f/0x50
<4> [887.362067] hardirqs last disabled at (2614842): [<ffffffffb2043c74>] native_play_dead+0x14/0x100
<4> [887.362067] softirqs last  enabled at (2614796): [<ffffffffb2c0033a>] __do_softirq+0x33a/0x4b9
<4> [887.362067] softirqs last disabled at (2614781): [<ffffffffb20ba219>] irq_exit+0xa9/0xc0
<3> [887.362067] Preemption disabled at:
<4> [887.362067] [<ffffffffb2042c30>] start_secondary+0x60/0x1c0
<4> [887.362067] CPU: 4 PID: 0 Comm: swapper/4 Tainted: G     U  W         5.2.0-rc6-g01457c077195-drmtip_317+ #1
<4> [887.362067] Hardware name: Intel Corporation Ice Lake Client Platform/IceLake U DDR4 SODIMM PD RVP TLC, BIOS ICLSFWR1.R00.3183.A00.1905020411 05/02/2019
<4> [887.362067] Call Trace:
<4> [887.362067]  dump_stack+0x67/0x9b
<4> [887.362067]  ___might_sleep+0x167/0x250
<4> [887.362067]  ? __kernfs_new_node.constprop.8+0x59/0x200
<4> [887.362067]  kmem_cache_alloc+0x1ab/0x280
<4> [887.362067]  __kernfs_new_node.constprop.8+0x59/0x200
<4> [887.362067]  ? apply_microcode_intel+0x40/0x1a0
<4> [887.362067]  ? collect_cpu_info+0xe0/0xe0
<4> [887.362067]  ? collect_cpu_info_local+0x30/0x30
<4> [887.362067]  ? lockdep_hardirqs_off+0x94/0xd0
<4> [887.362067]  kernfs_new_node+0x1f/0x40
<4> [887.362067]  kernfs_create_dir_ns+0x26/0x80
<4> [887.362067]  internal_create_group+0x2c7/0x390
<4> [887.362067]  mc_cpu_online+0x42/0xa0
<4> [887.362067]  ? microcode_init_cpu+0xa0/0xa0
<4> [887.362067]  cpuhp_invoke_callback+0x9b/0xa20
<4> [887.362067]  ? cpumask_next+0x16/0x20
<4> [887.362067]  ? topology_phys_to_logical_pkg+0x1e/0x60
<4> [887.362067]  notify_cpu_starting+0x52/0x70
<4> [887.362067]  start_secondary+0xbb/0x1c0
<4> [887.362067]  secondary_startup_64+0xa4/0xb0
<6> [887.429135] smpboot: CPU 5 is now offline
<6> [888.438500] smpboot: Booting Node 0 Processor 5 APIC 0x3
<3> [888.440783] BUG: sleeping function called from invalid context at mm/slab.h:418
<3> [888.440783] in_atomic(): 1, irqs_disabled(): 1, pid: 0, name: swapper/5
<4> [888.440783] no locks held by swapper/5/0.
<4> [888.440783] irq event stamp: 2785966
<4> [888.440783] hardirqs last  enabled at (2785965): [<ffffffffb205b53f>] switch_mm+0x2f/0x50
<4> [888.440783] hardirqs last disabled at (2785966): [<ffffffffb2043c74>] native_play_dead+0x14/0x100
<4> [888.440783] softirqs last  enabled at (2785920): [<ffffffffb2c0033a>] __do_softirq+0x33a/0x4b9
<4> [888.440783] softirqs last disabled at (2785901): [<ffffffffb20ba219>] irq_exit+0xa9/0xc0
<3> [888.440783] Preemption disabled at:
<4> [888.440783] [<ffffffffb2042c30>] start_secondary+0x60/0x1c0
<4> [888.440783] CPU: 5 PID: 0 Comm: swapper/5 Tainted: G     U  W         5.2.0-rc6-g01457c077195-drmtip_317+ #1
<4> [888.440783] Hardware name: Intel Corporation Ice Lake Client Platform/IceLake U DDR4 SODIMM PD RVP TLC, BIOS ICLSFWR1.R00.3183.A00.1905020411 05/02/2019
<4> [888.440783] Call Trace:
<4> [888.440783]  dump_stack+0x67/0x9b
<4> [888.440783]  ___might_sleep+0x167/0x250
<4> [888.440783]  ? __kernfs_new_node.constprop.8+0x59/0x200
<4> [888.440783]  kmem_cache_alloc+0x1ab/0x280
<4> [888.440783]  __kernfs_new_node.constprop.8+0x59/0x200
<4> [888.440783]  ? apply_microcode_intel+0x40/0x1a0
<4> [888.440783]  ? collect_cpu_info+0xe0/0xe0
<4> [888.440783]  ? collect_cpu_info_local+0x30/0x30
<4> [888.440783]  ? lockdep_hardirqs_off+0x94/0xd0
<4> [888.440783]  kernfs_new_node+0x1f/0x40
<4> [888.440783]  kernfs_create_dir_ns+0x26/0x80
<4> [888.440783]  internal_create_group+0x2c7/0x390
<4> [888.440783]  mc_cpu_online+0x42/0xa0
<4> [888.440783]  ? microcode_init_cpu+0xa0/0xa0
<4> [888.440783]  cpuhp_invoke_callback+0x9b/0xa20
<4> [888.440783]  ? cpumask_next+0x16/0x20
<4> [888.440783]  ? topology_phys_to_logical_pkg+0x1e/0x60
<4> [888.440783]  notify_cpu_starting+0x52/0x70
<4> [888.440783]  start_secondary+0xbb/0x1c0
<4> [888.440783]  secondary_startup_64+0xa4/0xb0
<6> [888.507694] smpboot: CPU 6 is now offline
<6> [889.518416] smpboot: Booting Node 0 Processor 6 APIC 0x5
<3> [889.520710] BUG: sleeping function called from invalid context at mm/slab.h:418
<3> [889.520710] in_atomic(): 1, irqs_disabled(): 1, pid: 0, name: swapper/6
<4> [889.520710] no locks held by swapper/6/0.
<4> [889.520710] irq event stamp: 2436256
<4> [889.520710] hardirqs last  enabled at (2436255): [<ffffffffb205b53f>] switch_mm+0x2f/0x50
<4> [889.520710] hardirqs last disabled at (2436256): [<ffffffffb2043c74>] native_play_dead+0x14/0x100
<4> [889.520710] softirqs last  enabled at (2436210): [<ffffffffb2c0033a>] __do_softirq+0x33a/0x4b9
<4> [889.520710] softirqs last disabled at (2436179): [<ffffffffb20ba219>] irq_exit+0xa9/0xc0
<3> [889.520710] Preemption disabled at:
<4> [889.520710] [<ffffffffb2042c30>] start_secondary+0x60/0x1c0
<4> [889.520710] CPU: 6 PID: 0 Comm: swapper/6 Tainted: G     U  W         5.2.0-rc6-g01457c077195-drmtip_317+ #1
<4> [889.520710] Hardware name: Intel Corporation Ice Lake Client Platform/IceLake U DDR4 SODIMM PD RVP TLC, BIOS ICLSFWR1.R00.3183.A00.1905020411 05/02/2019
<4> [889.520710] Call Trace:
<4> [889.520710]  dump_stack+0x67/0x9b
<4> [889.520710]  ___might_sleep+0x167/0x250
<4> [889.520710]  ? __kernfs_new_node.constprop.8+0x59/0x200
<4> [889.520710]  kmem_cache_alloc+0x1ab/0x280
<4> [889.520710]  __kernfs_new_node.constprop.8+0x59/0x200
<4> [889.520710]  ? apply_microcode_intel+0x40/0x1a0
<4> [889.520710]  ? collect_cpu_info+0xe0/0xe0
<4> [889.520710]  ? collect_cpu_info_local+0x30/0x30
<4> [889.520710]  ? lockdep_hardirqs_off+0x94/0xd0
<4> [889.520710]  kernfs_new_node+0x1f/0x40
<4> [889.520710]  kernfs_create_dir_ns+0x26/0x80
<4> [889.520710]  internal_create_group+0x2c7/0x390
<4> [889.520710]  mc_cpu_online+0x42/0xa0
<4> [889.520710]  ? microcode_init_cpu+0xa0/0xa0
<4> [889.520710]  cpuhp_invoke_callback+0x9b/0xa20
<4> [889.520710]  ? cpumask_next+0x16/0x20
<4> [889.520710]  ? topology_phys_to_logical_pkg+0x1e/0x60
<4> [889.520710]  notify_cpu_starting+0x52/0x70
<4> [889.520710]  start_secondary+0xbb/0x1c0
<4> [889.520710]  secondary_startup_64+0xa4/0xb0
<6> [889.591031] smpboot: CPU 7 is now offline
<6> [890.603653] smpboot: Booting Node 0 Processor 7 APIC 0x7
<3> [890.606620] BUG: sleeping function called from invalid context at mm/slab.h:418
<3> [890.606620] in_atomic(): 1, irqs_disabled(): 1, pid: 0, name: swapper/7
<4> [890.606620] no locks held by swapper/7/0.
<4> [890.606620] irq event stamp: 5718458
<4> [890.606620] hardirqs last  enabled at (5718457): [<ffffffffb2237868>] __slab_free+0x3e8/0x4f0
<4> [890.606620] hardirqs last disabled at (5718458): [<ffffffffb2043c74>] native_play_dead+0x14/0x100
<4> [890.606620] softirqs last  enabled at (5718398): [<ffffffffb2c0033a>] __do_softirq+0x33a/0x4b9
<4> [890.606620] softirqs last disabled at (5718359): [<ffffffffb20ba219>] irq_exit+0xa9/0xc0
<3> [890.606620] Preemption disabled at:
<4> [890.606620] [<ffffffffb2042c30>] start_secondary+0x60/0x1c0
<4> [890.606620] CPU: 7 PID: 0 Comm: swapper/7 Tainted: G     U  W         5.2.0-rc6-g01457c077195-drmtip_317+ #1
<4> [890.606620] Hardware name: Intel Corporation Ice Lake Client Platform/IceLake U DDR4 SODIMM PD RVP TLC, BIOS ICLSFWR1.R00.3183.A00.1905020411 05/02/2019
<4> [890.606620] Call Trace:
<4> [890.606620]  dump_stack+0x67/0x9b
<4> [890.606620]  ___might_sleep+0x167/0x250
<4> [890.606620]  ? __kernfs_new_node.constprop.8+0x59/0x200
<4> [890.606620]  kmem_cache_alloc+0x1ab/0x280
<4> [890.606620]  __kernfs_new_node.constprop.8+0x59/0x200
<4> [890.606620]  ? apply_microcode_intel+0x40/0x1a0
<4> [890.606620]  ? collect_cpu_info+0xe0/0xe0
<4> [890.606620]  ? collect_cpu_info_local+0x30/0x30
<4> [890.606620]  ? lockdep_hardirqs_off+0x94/0xd0
<4> [890.606620]  kernfs_new_node+0x1f/0x40
<4> [890.606620]  kernfs_create_dir_ns+0x26/0x80
<4> [890.606620]  internal_create_group+0x2c7/0x390
<4> [890.606620]  mc_cpu_online+0x42/0xa0
<4> [890.606620]  ? microcode_init_cpu+0xa0/0xa0
<4> [890.606620]  cpuhp_invoke_callback+0x9b/0xa20
<4> [890.606620]  ? cpumask_next+0x16/0x20
<4> [890.606620]  ? topology_phys_to_logical_pkg+0x1e/0x60
<4> [890.606620]  notify_cpu_starting+0x52/0x70
<4> [890.606620]  start_secondary+0xbb/0x1c0
<4> [890.606620]  secondary_startup_64+0xa4/0xb0
<6> [890.743830] [IGT] perf_pmu: exiting, ret=0
<5> [890.744258] Setting dangerous option reset - tainting kernel
<5> [890.753230] Setting dangerous option reset - tainting kernel
<6> [890.772419] Console: switching to colour frame buffer device 240x75

Comment 1 CI Bug Log 2019-07-01 06:50:58 UTC

The CI Bug Log issue associated to this bug has been updated.

### New filters associated

* ICL: igt@perf_pmu@cpu-hotplug - dmesg-warn - BUG: sleeping function called from invalid context at kernel/locking/mutex.c:909
  - https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_317/fi-icl-u3/igt@perf_pmu@cpu-hotplug.html

Comment 2 Chris Wilson 2019-07-01 07:26:35 UTC


*** This bug has been marked as a duplicate of bug 110974 ***

Comment 3 CI Bug Log 2019-07-02 08:31:56 UTC

The CI Bug Log issue associated to this bug has been archived.

New failures matching the above filters will not be associated to this bug anymore.

Use of freedesktop.org services, including Bugzilla, is subject to our Code of Conduct. How we collect and use information is described in our Privacy Policy.