ICL : igt@i915_pm_rpm@universal-planes@plane-40 - Incomplete - Unexpected reschedule of offline, logs are in pstore
https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_9755/shard-iclb4/igt@i915_pm_rpm@universal-planes@plane-40.html https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_9755/shard-iclb4/pstore19-1612927913_Panic_1.txt
<4>[ 459.288909] ------------[ cut here ]------------
<4>[ 459.288910] sched: Unexpected reschedule of offline CPU#3!
<4>[ 459.288912] WARNING: CPU: 0 PID: 1019 at arch/x86/kernel/apic/ipi.c:68 native_smp_send_reschedule+0x2f/0x40
<4>[ 459.288916] Modules linked in: vgem snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic ledtrig_audio i915 mei_hdcp x86_pkg_temp_thermal coretemp crct10dif_pclmul crc32_pclmul snd_hda_intel ghash_clmulni_intel snd_intel_dspcfg e1000e snd_hda_codec cdc_ether usbnet snd_hwdep mii snd_hda_core ptp pps_core snd_pcm mei_me mei intel_lpss_pci prime_numbers
<4>[ 459.288941] CPU: 0 PID: 1019 Comm: kworker/u16:14 Tainted: G W 5.11.0-rc7-CI-CI_DRM_9755+ #1
: 00000000ffffffff
<4>[ 459.288962] RBP: ffff8881165bc040 R08: 0000000000000001 R09: 0000000000000000
<4>[ 459.288964] R10: 00000000001dac00 R11: ffff8884b03d8ba5 R12: ffffc90000b4b770
<4>[ 459.288965] R13: ffff8881165bc8c0 R14: 0000000000000006 R15: ffff88849fbbb000
<4>[ 459.288967] FS: 0000000000000000(0000) GS:ffff88849fa00000(0000) knlGS:0000000000000000
<4>[ 459.288970] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
<4>[ 459.288972] CR2: 00007fa782f27000 CR3: 0000000005612002 CR4: 0000000000770ef0
<4>[ 459.288973] PKRU: 55555554
<4>[ 459.288975] Call Trace:
<4>[ 459.288976] check_preempt_curr+0x44/0x90
<4>[ 459.288979] ttwu_do_wakeup+0x14/0x220
<4>[ 459.288983] try_to_wake_up+0x1ef/0x7b0
<4>[ 459.288988] autoremove_wake_function+0xc/0x50
<4>[ 459.288991] __wake_up_common+0x84/0x1a0
<4>[ 459.288994] __wake_up_common_lock+0x75/0xb0
<4>[ 459.288998] __wake_up_bit+0x4c/0x70
<4>[ 459.289001] ext4_commit_super+0x62/0x120
<4>[ 459.289005] ext4_handle_error+0xf9/0x170
] ? kthread_park+0x80/0x80
<4>[ 459.289092] ret_from_fork+0x1f/0x30
<4>[ 459.289097] irq event stamp: 26628
<4>[ 459.289098] hardirqs last enabled at (26627): [<ffffffff81aa03b2>] _raw_spin_unlock_irqrestore+0x42/0x50
<4>[ 459.289103] hardirqs last disabled at (26628): [<ffffffff81aa0187>] _raw_spin_lock_irqsave+0x47/0x50
<4>[ 459.289107] softirqs last enabled at (26620): [<ffffffff81e00342>] __do_softirq+0x342/0x48e
<4>[ 459.289112] softirqs last disabled at (26611): [<ffffffff81c00f4f>] asm_call_irq_on_stack+0xf/0x20
<4>[ 459.289117] ---[ end trace c561bc7cd904a1f6 ]---
<0>[ 459.289123] Kernel Offset: disabled
<4>[ 459.289125] CPU: 5 PID: 398 Comm: rs:main Q:Reg Tainted: G W 5.11.0-rc7-CI-CI_DRM_9755+ #1
<4>[ 459.289130] Hardware name: Intel Corporation Ice Lake Client Platform/IceLake U DDR4 SODIMM PD RVP TLC, BIOS ICLSFWR1.R00.3234.A01.1906141750 06/14/2019
<4>[ 459.289132] Call Trace:
<4>[ 459.289134] dump_stack+0x77/0x97
<4>[ 459.289141] panic+0x13d/0x2db
4>[ 459.289223] RIP: 0033:0x7fea0a56c2b7
<4>[ 459.289226] Code: 44 00 00 41 54 55 49 89 d4 53 48 89 f5 89 fb 48 83 ec 10 e8 5b fd ff ff 4c 89 e2 41 89 c0 48 89 ee 89 df b8 01 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 35 44 89 c7 48 89 44 24 08 e8 94 fd ff ff 48
<4>[ 459.289230] RSP: 002b:00007fea072b8830 EFLAGS: 00000293 ORIG_RAX: 0000000000000001
<4>[ 459.289234] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007fea0a56c2b7
<4>[ 459.289236] RDX: 0000000000001000 RSI: 00007fe9fc002830 RDI: 0000000000000007
<4>[ 459.289238] RBP: 00007fe9fc002830 R08: 0000000000000000 R09: 0000000000000000
<4>[ 459.289240] R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000001000
<4>[ 459.289242] R13: 00007fe9fc002550 R14: 0000000000000000 R15: 0000564c5951d580
<4>[ 459.289248]
<4>[ 459.289249] ======================================================
<4>[ 459.289250] WARNING: possible circular locking dependency detected
<4>[ 459.289251] 5.11.0-rc7-CI-CI_DRM_9755+ #1 Tainted: G W
air+0x41/0x170
<4>[ 459.289272] sched_fork+0x13c/0x240
<4>[ 459.289273] copy_process+0x7aa/0x1c70
<4>[ 459.289274] kernel_clone+0x98/0x6f0
<4>[ 459.289275] kernel_thread+0x50/0x70
<4>[ 459.289275] rest_init+0x1d/0x231
<4>[ 459.289276] start_kernel+0x551/0x576
<4>[ 459.289277] secondary_startup_64_no_verify+0xb0/0xbb
<4>[ 459.289278]
<4>[ 459.289278] -> #1 (&p->pi_lock){-.-.}-{2:2}:
<4>[ 459.289281] _raw_spin_lock_irqsave+0x33/0x50
<4>[ 459.289282] try_to_wake_up+0x5a/0x7b0
<4>[ 459.289283] up+0x3b/0x50
<4>[ 459.289284] __up_console_sem+0x29/0x60
<4>[ 459.289285] console_unlock+0x32f/0x580
<4>[ 459.289285] vprintk_emit+0x232/0x340
<4>[ 459.289286] dev_vprintk_emit+0x136/0x15a
<4>[ 459.289287] dev_printk_emit+0x49/0x60
<4>[ 459.289287] dev_printk+0x58/0x6f
<4>[ 459.289288] drm_dev_dbg+0x8c/0xb0
<4>[ 459.289289] intel_dump_pipe_config+0x907/0xa40 [i915]
>[ 459.289300] bus_add_driver+0x14b/0x1f0
<4>[ 459.289301] driver_register+0x66/0xb0
<4>[ 459.289302] 0xffffffffa09c1070
<4>[ 459.289302] do_one_initcall+0x56/0x2e0
<4>[ 459.289303] do_init_module+0x55/0x200
<4>[ 459.289304] load_module+0x27a7/0x2a50
<4>[ 459.289305] __do_sys_finit_module+0xad/0x110
<4>[ 459.289305] do_syscall_64+0x33/0x80
<4>[ 459.289306] entry_SYSCALL_64_after_hwframe+0x44/0xa9
<4>[ 459.289307]
<4>[ 459.289308] -> #0 ((console_sem).lock){-.-.}-{2:2}:
<4>[ 459.289311] __lock_acquire+0x1523/0x25a0
<4>[ 459.289312] lock_acquire+0xd0/0x3b0
<4>[ 459.289312] _raw_spin_lock_irqsave+0x33/0x50
<4>[ 459.289313] down_trylock+0xa/0x30
<4>[ 459.289314] __down_trylock_console_sem+0x23/0x90
<4>[ 459.289315] console_trylock+0xe/0x60
<4>[ 459.289315] vprintk_emit+0x135/0x340
<4>[ 459.289316] printk+0x53/0x6a
<4>[ 459.289317] __warn_printk+0x41/0x82
8] do_writepages+0x3c/0xe0
<4>[ 459.289329] __writeback_single_inode+0x53/0x5b0
<4>[ 459.289330] writeback_sb_inodes+0x1fb/0x4f0
<4>[ 459.289331] __writeback_inodes_wb+0x5a/0xc0
<4>[ 459.289332] wb_writeback+0x2f8/0x470
<4>[ 459.289332] wb_workfn+0x42b/0x680
<4>[ 459.289333] process_one_work+0x270/0x5c0
<4>[ 459.289334] worker_thread+0x37/0x380
<4>[ 459.289335] kthread+0x146/0x170
<4>[ 459.289335] ret_from_fork+0x1f/0x30
<4>[ 459.289336]
<4>[ 459.289337] other info that might help us debug this:
<4>[ 459.289337]
<4>[ 459.289338] Chain exists of:
<4>[ 459.289339] (console_sem).lock --> &p->pi_lock --> &rq->lock
<4>[ 459.289343]
<4>[ 459.289344] Possible unsafe locking scenario:
<4>[ 459.289345]
<4>[ 459.289345] CPU0 CPU1
<4>[ 459.289346] ---- ----
<4>[ 459.289347] lock(&rq->lock);
<4>[ 459.289349] lock(&p->pi_lock);
handle+0x120/0x570