====================================== | [ 789.948139] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 789.950667] nipa-hw-worker: [5/44] Retrying drivers/net:napi_threaded.py | [ 790.076274] kselftest: Running tests in drivers/net [ 989.716336] INFO: task python3:5899 blocked for more than 122 seconds. [ 989.724563] Not tainted 7.1.0-rc1-jihu-g7808d11040e7 #1 [ 989.732459] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.742047] task:python3 state:D stack:25672 pid:5899 tgid:5899 ppid:5898 task_flags:0x400100 flags:0x00080000 [ 989.755252] Call Trace: [ 989.758791] [ 989.761943] __schedule+0xcba/0x1940 [ 989.766762] ? io_schedule_timeout+0x140/0x140 [ 989.772548] ? find_held_lock+0x2b/0x80 [ 989.777654] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.783539] schedule+0xd4/0x260 [ 989.787954] schedule_preempt_disabled+0x18/0x30 [ 989.793934] __mutex_lock+0x6a3/0x2000 [ 989.798937] ? threaded_store+0x132/0x220 [ 989.804234] ? ww_mutex_lock+0x160/0x160 [ 989.809434] ? selinux_inode_free_security+0x330/0x330 [ 989.816004] ? cap_capable+0x1d6/0x3e0 [ 989.821012] ? threaded_store+0x132/0x220 [ 989.826308] threaded_store+0x132/0x220 [ 989.831411] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.836697] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.841995] ? sysfs_kf_write+0x65/0x160 [ 989.847191] ? sysfs_file_ops+0x140/0x140 [ 989.852484] kernfs_fop_write_iter+0x335/0x510 [ 989.858268] ? kernfs_ops+0xf0/0xf0 [ 989.862980] new_sync_write+0x333/0x750 [ 989.868083] ? __lock_acquire+0x508/0xc10 [ 989.873380] ? new_sync_read+0x740/0x740 [ 989.878579] ? lock_acquire.part.0+0xbc/0x260 [ 989.884264] ? ksys_write+0x116/0x250 [ 989.889180] vfs_write+0x657/0x9b0 [ 989.893794] ksys_write+0x116/0x250 [ 989.898503] ? __ia32_sys_read+0xc0/0xc0 [ 989.903702] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.909290] ? rcu_is_watching+0x15/0xd0 [ 989.914491] do_syscall_64+0xf3/0x650 [ 989.919397] ? trace_hardirqs_off+0xd/0x30 [ 989.924791] ? exc_page_fault+0xda/0xf0 [ 989.929889] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.936355] RIP: 0033:0x7f928632f22e [ 989.941166] RSP: 002b:00007ffd053ce910 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.950463] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f928632f22e [ 989.959270] RDX: 0000000000000001 RSI: 000055d2f6771a10 RDI: 0000000000000007 [ 989.968078] RBP: 00007ffd053ce920 R08: 0000000000000000 R09: 0000000000000000 [ 989.976885] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f92861a7390 [ 989.985685] R13: 000055d2f6771a10 R14: 0000000000000007 R15: 0000000000000003 | [ 990.356988] #1: ff110001ee13a080 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 990.367950] #2: ff11000123000b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.379106] #3: ff11000123049d60 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.389193] | [ 990.391658] =============================================\x0a [ 1112.594621] INFO: task python3:5899 blocked for more than 245 seconds. [ 1112.602770] Not tainted 7.1.0-rc1-jihu-g7808d11040e7 #1 [ 1112.610021] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.619611] task:python3 state:D stack:25672 pid:5899 tgid:5899 ppid:5898 task_flags:0x400100 flags:0x00080000 [ 1112.632819] Call Trace: [ 1112.636360] [ 1112.639511] __schedule+0xcba/0x1940 [ 1112.644330] ? io_schedule_timeout+0x140/0x140 [ 1112.650116] ? find_held_lock+0x2b/0x80 [ 1112.655223] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.661109] schedule+0xd4/0x260 [ 1112.665529] schedule_preempt_disabled+0x18/0x30 [ 1112.671511] __mutex_lock+0x6a3/0x2000 [ 1112.676518] ? threaded_store+0x132/0x220 [ 1112.681817] ? ww_mutex_lock+0x160/0x160 [ 1112.687017] ? selinux_inode_free_security+0x330/0x330 [ 1112.693586] ? cap_capable+0x1d6/0x3e0 [ 1112.698594] ? threaded_store+0x132/0x220 [ 1112.703892] threaded_store+0x132/0x220 [ 1112.708988] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.714289] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.719590] ? sysfs_kf_write+0x65/0x160 [ 1112.724793] ? sysfs_file_ops+0x140/0x140 [ 1112.730089] kernfs_fop_write_iter+0x335/0x510 [ 1112.735875] ? kernfs_ops+0xf0/0xf0 [ 1112.740589] new_sync_write+0x333/0x750 [ 1112.745692] ? __lock_acquire+0x508/0xc10 [ 1112.750991] ? new_sync_read+0x740/0x740 [ 1112.756193] ? lock_acquire.part.0+0xbc/0x260 [ 1112.761879] ? ksys_write+0x116/0x250 [ 1112.766788] vfs_write+0x657/0x9b0 [ 1112.771403] ksys_write+0x116/0x250 [ 1112.776114] ? __ia32_sys_read+0xc0/0xc0 [ 1112.781314] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.786896] ? rcu_is_watching+0x15/0xd0 [ 1112.792097] do_syscall_64+0xf3/0x650 [ 1112.797004] ? trace_hardirqs_off+0xd/0x30 [ 1112.802390] ? exc_page_fault+0xda/0xf0 [ 1112.807492] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.813959] RIP: 0033:0x7f928632f22e [ 1112.818769] RSP: 002b:00007ffd053ce910 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.828068] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f928632f22e [ 1112.836874] RDX: 0000000000000001 RSI: 000055d2f6771a10 RDI: 0000000000000007 [ 1112.845685] RBP: 00007ffd053ce920 R08: 0000000000000000 R09: 0000000000000000 [ 1112.854495] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f92861a7390 [ 1112.863306] R13: 000055d2f6771a10 R14: 0000000000000007 R15: 0000000000000003 | [ 1113.307052] | [ 1113.309520] =============================================\x0a | [ 1223.820651] block nvme0n1: No UUID available providing old NGUID | SUBSYSTEM=block | DEVICE=b259:0 [ 1235.475877] INFO: task python3:5899 blocked for more than 368 seconds. [ 1235.484028] Not tainted 7.1.0-rc1-jihu-g7808d11040e7 #1 [ 1235.491279] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.500865] task:python3 state:D stack:25672 pid:5899 tgid:5899 ppid:5898 task_flags:0x400100 flags:0x00080002 [ 1235.514073] Call Trace: [ 1235.517612] [ 1235.520763] __schedule+0xcba/0x1940 [ 1235.525576] ? io_schedule_timeout+0x140/0x140 [ 1235.531360] ? find_held_lock+0x2b/0x80 [ 1235.536466] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.542349] schedule+0xd4/0x260 [ 1235.546769] schedule_preempt_disabled+0x18/0x30 [ 1235.552736] __mutex_lock+0x6a3/0x2000 [ 1235.557739] ? threaded_store+0x132/0x220 [ 1235.563038] ? ww_mutex_lock+0x160/0x160 [ 1235.568237] ? selinux_inode_free_security+0x330/0x330 [ 1235.574805] ? cap_capable+0x1d6/0x3e0 [ 1235.579815] ? threaded_store+0x132/0x220 [ 1235.585112] threaded_store+0x132/0x220 [ 1235.590203] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.595498] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.600793] ? sysfs_kf_write+0x65/0x160 [ 1235.605995] ? sysfs_file_ops+0x140/0x140 [ 1235.611290] kernfs_fop_write_iter+0x335/0x510 [ 1235.617072] ? kernfs_ops+0xf0/0xf0 [ 1235.621782] new_sync_write+0x333/0x750 [ 1235.626879] ? __lock_acquire+0x508/0xc10 [ 1235.632175] ? new_sync_read+0x740/0x740 [ 1235.637376] ? lock_acquire.part.0+0xbc/0x260 [ 1235.643063] ? ksys_write+0x116/0x250 [ 1235.647971] vfs_write+0x657/0x9b0 [ 1235.652586] ksys_write+0x116/0x250 [ 1235.657299] ? __ia32_sys_read+0xc0/0xc0 [ 1235.662487] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.668077] ? rcu_is_watching+0x15/0xd0 [ 1235.673278] do_syscall_64+0xf3/0x650 [ 1235.678182] ? trace_hardirqs_off+0xd/0x30 [ 1235.683578] ? exc_page_fault+0xda/0xf0 [ 1235.688678] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.695143] RIP: 0033:0x7f928632f22e [ 1235.699953] RSP: 002b:00007ffd053ce910 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.709248] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f928632f22e [ 1235.718057] RDX: 0000000000000001 RSI: 000055d2f6771a10 RDI: 0000000000000007 [ 1235.726863] RBP: 00007ffd053ce920 R08: 0000000000000000 R09: 0000000000000000 [ 1235.735669] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f92861a7390 [ 1235.744475] R13: 000055d2f6771a10 R14: 0000000000000007 R15: 0000000000000003 | [ 1236.115651] #1: ff110001ee13a080 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1236.126612] #2: ff11000123000b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.137767] #3: ff11000123049d60 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.147860] | [ 1236.150326] =============================================\x0a [ 1358.357964] INFO: task python3:5899 blocked for more than 491 seconds. [ 1358.366115] Not tainted 7.1.0-rc1-jihu-g7808d11040e7 #1 [ 1358.373366] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.382954] task:python3 state:D stack:25672 pid:5899 tgid:5899 ppid:5898 task_flags:0x400100 flags:0x00080002 [ 1358.396160] Call Trace: [ 1358.399698] [ 1358.402850] __schedule+0xcba/0x1940 [ 1358.407662] ? io_schedule_timeout+0x140/0x140 [ 1358.413447] ? find_held_lock+0x2b/0x80 [ 1358.418550] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.424434] schedule+0xd4/0x260 [ 1358.428850] schedule_preempt_disabled+0x18/0x30 [ 1358.434826] __mutex_lock+0x6a3/0x2000 [ 1358.439831] ? threaded_store+0x132/0x220 [ 1358.445128] ? ww_mutex_lock+0x160/0x160 [ 1358.450326] ? selinux_inode_free_security+0x330/0x330 [ 1358.456893] ? cap_capable+0x1d6/0x3e0 [ 1358.461899] ? threaded_store+0x132/0x220 [ 1358.467195] threaded_store+0x132/0x220 [ 1358.472295] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.477592] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.482891] ? sysfs_kf_write+0x65/0x160 [ 1358.488092] ? sysfs_file_ops+0x140/0x140 [ 1358.493387] kernfs_fop_write_iter+0x335/0x510 [ 1358.499168] ? kernfs_ops+0xf0/0xf0 [ 1358.503877] new_sync_write+0x333/0x750 [ 1358.508981] ? __lock_acquire+0x508/0xc10 [ 1358.514267] ? new_sync_read+0x740/0x740 [ 1358.519467] ? lock_acquire.part.0+0xbc/0x260 [ 1358.525145] ? ksys_write+0x116/0x250 [ 1358.530045] vfs_write+0x657/0x9b0 [ 1358.534658] ksys_write+0x116/0x250 [ 1358.539369] ? __ia32_sys_read+0xc0/0xc0 [ 1358.544566] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.550152] ? rcu_is_watching+0x15/0xd0 [ 1358.555353] do_syscall_64+0xf3/0x650 [ 1358.560261] ? trace_hardirqs_off+0xd/0x30 [ 1358.565656] ? exc_page_fault+0xda/0xf0 [ 1358.570758] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.577223] RIP: 0033:0x7f928632f22e [ 1358.582032] RSP: 002b:00007ffd053ce910 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.591321] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f928632f22e [ 1358.600117] RDX: 0000000000000001 RSI: 000055d2f6771a10 RDI: 0000000000000007 [ 1358.608923] RBP: 00007ffd053ce920 R08: 0000000000000000 R09: 0000000000000000 [ 1358.617727] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f92861a7390 [ 1358.626537] R13: 000055d2f6771a10 R14: 0000000000000007 R15: 0000000000000003 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store