====================================== | [ 762.584073] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 762.586822] nipa-hw-worker: [5/47] Retrying drivers/net:napi_threaded.py | [ 762.737402] kselftest: Running tests in drivers/net [ 989.735903] INFO: task python3:5421 blocked for more than 122 seconds. [ 989.744127] Not tainted 7.1.0-rc7-tgje-g535aecdaa85c #1 [ 989.752013] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.761604] task:python3 state:D stack:25672 pid:5421 tgid:5421 ppid:5420 task_flags:0x400100 flags:0x00080000 [ 989.774808] Call Trace: [ 989.778346] [ 989.781496] __schedule+0xcc3/0x19c0 [ 989.786311] ? io_schedule_timeout+0x140/0x140 [ 989.792095] ? find_held_lock+0x2b/0x80 [ 989.797191] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.803073] schedule+0xd8/0x260 [ 989.807491] schedule_preempt_disabled+0x18/0x30 [ 989.813468] __mutex_lock+0x6af/0x2010 [ 989.818472] ? threaded_store+0x132/0x220 [ 989.823773] ? ww_mutex_lock+0x160/0x160 [ 989.828971] ? selinux_inode_free_security+0x330/0x330 [ 989.835541] ? cap_capable+0x1d6/0x3e0 [ 989.840547] ? threaded_store+0x132/0x220 [ 989.845840] threaded_store+0x132/0x220 [ 989.850943] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.856239] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.861541] ? sysfs_kf_write+0x65/0x160 [ 989.866744] ? sysfs_file_ops+0x140/0x140 [ 989.872039] kernfs_fop_write_iter+0x335/0x510 [ 989.877825] ? kernfs_ops+0xf0/0xf0 [ 989.882524] new_sync_write+0x333/0x750 [ 989.887627] ? __lock_acquire+0x508/0xc10 [ 989.892925] ? new_sync_read+0x740/0x740 [ 989.898124] ? lock_acquire.part.0+0xbc/0x260 [ 989.903800] ? ksys_write+0x116/0x250 [ 989.908710] vfs_write+0x657/0x9b0 [ 989.913326] ksys_write+0x116/0x250 [ 989.918035] ? __ia32_sys_read+0xc0/0xc0 [ 989.923235] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.928813] ? rcu_is_watching+0x15/0xd0 [ 989.934013] do_syscall_64+0xf3/0x650 [ 989.938916] ? trace_hardirqs_off+0xd/0x30 [ 989.944312] ? exc_page_fault+0xda/0xf0 [ 989.949413] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.955881] RIP: 0033:0x7f3cbef1264e [ 989.960691] RSP: 002b:00007ffd12a84660 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.969987] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f3cbef1264e [ 989.978787] RDX: 0000000000000001 RSI: 0000560488afdbf0 RDI: 0000000000000007 [ 989.987586] RBP: 00007ffd12a84670 R08: 0000000000000000 R09: 0000000000000000 [ 989.996386] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f3cbed8b390 [ 990.005193] R13: 0000560488afdbf0 R14: 0000000000000007 R15: 00007f3cbed21120 | [ 990.381993] #1: ff11000185161480 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 990.392955] #2: ff11000123cdcb50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.404113] #3: ff11000123c91e00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.414199] | [ 990.416664] =============================================\x0a [ 1112.617056] INFO: task python3:5421 blocked for more than 245 seconds. [ 1112.625204] Not tainted 7.1.0-rc7-tgje-g535aecdaa85c #1 [ 1112.632456] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.642048] task:python3 state:D stack:25672 pid:5421 tgid:5421 ppid:5420 task_flags:0x400100 flags:0x00080000 [ 1112.655254] Call Trace: [ 1112.658795] [ 1112.661949] __schedule+0xcc3/0x19c0 [ 1112.666765] ? io_schedule_timeout+0x140/0x140 [ 1112.672553] ? find_held_lock+0x2b/0x80 [ 1112.677656] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.683543] schedule+0xd8/0x260 [ 1112.687964] schedule_preempt_disabled+0x18/0x30 [ 1112.693943] __mutex_lock+0x6af/0x2010 [ 1112.698949] ? threaded_store+0x132/0x220 [ 1112.704248] ? ww_mutex_lock+0x160/0x160 [ 1112.709441] ? selinux_inode_free_security+0x330/0x330 [ 1112.716011] ? cap_capable+0x1d6/0x3e0 [ 1112.721022] ? threaded_store+0x132/0x220 [ 1112.726317] threaded_store+0x132/0x220 [ 1112.731419] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.736716] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.742018] ? sysfs_kf_write+0x65/0x160 [ 1112.747222] ? sysfs_file_ops+0x140/0x140 [ 1112.752517] kernfs_fop_write_iter+0x335/0x510 [ 1112.758301] ? kernfs_ops+0xf0/0xf0 [ 1112.763014] new_sync_write+0x333/0x750 [ 1112.768117] ? __lock_acquire+0x508/0xc10 [ 1112.773414] ? new_sync_read+0x740/0x740 [ 1112.778617] ? lock_acquire.part.0+0xbc/0x260 [ 1112.784306] ? ksys_write+0x116/0x250 [ 1112.789214] vfs_write+0x657/0x9b0 [ 1112.793828] ksys_write+0x116/0x250 [ 1112.798537] ? __ia32_sys_read+0xc0/0xc0 [ 1112.803735] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.809323] ? rcu_is_watching+0x15/0xd0 [ 1112.814526] do_syscall_64+0xf3/0x650 [ 1112.819431] ? trace_hardirqs_off+0xd/0x30 [ 1112.824829] ? exc_page_fault+0xda/0xf0 [ 1112.829934] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.836402] RIP: 0033:0x7f3cbef1264e [ 1112.841214] RSP: 002b:00007ffd12a84660 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.850514] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f3cbef1264e [ 1112.859320] RDX: 0000000000000001 RSI: 0000560488afdbf0 RDI: 0000000000000007 [ 1112.868128] RBP: 00007ffd12a84670 R08: 0000000000000000 R09: 0000000000000000 [ 1112.876936] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f3cbed8b390 [ 1112.885743] R13: 0000560488afdbf0 R14: 0000000000000007 R15: 00007f3cbed21120 | [ 1113.273596] #2: ff11000123cdcb50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.284755] #3: ff11000123c91e00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.294848] | [ 1113.297311] =============================================\x0a | [ 1169.961549] kworker/u130:5 (532) used greatest stack depth: 21936 bytes left [ 1235.498192] INFO: task python3:5421 blocked for more than 368 seconds. [ 1235.506337] Not tainted 7.1.0-rc7-tgje-g535aecdaa85c #1 [ 1235.513588] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.523174] task:python3 state:D stack:25672 pid:5421 tgid:5421 ppid:5420 task_flags:0x400100 flags:0x00080002 [ 1235.536379] Call Trace: [ 1235.539919] [ 1235.543067] __schedule+0xcc3/0x19c0 [ 1235.547880] ? io_schedule_timeout+0x140/0x140 [ 1235.553666] ? find_held_lock+0x2b/0x80 [ 1235.558767] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.564653] schedule+0xd8/0x260 [ 1235.569069] schedule_preempt_disabled+0x18/0x30 [ 1235.575045] __mutex_lock+0x6af/0x2010 [ 1235.580049] ? threaded_store+0x132/0x220 [ 1235.585338] ? ww_mutex_lock+0x160/0x160 [ 1235.590533] ? selinux_inode_free_security+0x330/0x330 [ 1235.597103] ? cap_capable+0x1d6/0x3e0 [ 1235.602108] ? threaded_store+0x132/0x220 [ 1235.607402] threaded_store+0x132/0x220 [ 1235.612504] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.617798] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.623096] ? sysfs_kf_write+0x65/0x160 [ 1235.628295] ? sysfs_file_ops+0x140/0x140 [ 1235.633588] kernfs_fop_write_iter+0x335/0x510 [ 1235.639375] ? kernfs_ops+0xf0/0xf0 [ 1235.644084] new_sync_write+0x333/0x750 [ 1235.649186] ? __lock_acquire+0x508/0xc10 [ 1235.654483] ? new_sync_read+0x740/0x740 [ 1235.659682] ? lock_acquire.part.0+0xbc/0x260 [ 1235.665365] ? ksys_write+0x116/0x250 [ 1235.670275] vfs_write+0x657/0x9b0 [ 1235.674888] ksys_write+0x116/0x250 [ 1235.679597] ? __ia32_sys_read+0xc0/0xc0 [ 1235.684795] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.690383] ? rcu_is_watching+0x15/0xd0 [ 1235.695585] do_syscall_64+0xf3/0x650 [ 1235.700490] ? trace_hardirqs_off+0xd/0x30 [ 1235.705882] ? exc_page_fault+0xda/0xf0 [ 1235.710985] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.717452] RIP: 0033:0x7f3cbef1264e [ 1235.722250] RSP: 002b:00007ffd12a84660 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.731546] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f3cbef1264e [ 1235.740353] RDX: 0000000000000001 RSI: 0000560488afdbf0 RDI: 0000000000000007 [ 1235.749160] RBP: 00007ffd12a84670 R08: 0000000000000000 R09: 0000000000000000 [ 1235.757966] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f3cbed8b390 [ 1235.766773] R13: 0000560488afdbf0 R14: 0000000000000007 R15: 00007f3cbed21120 | [ 1236.143598] #1: ff11000185161480 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1236.154549] #2: ff11000123cdcb50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.165707] #3: ff11000123c91e00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.175787] | [ 1236.178252] =============================================\x0a [ 1358.379326] INFO: task python3:5421 blocked for more than 491 seconds. [ 1358.387479] Not tainted 7.1.0-rc7-tgje-g535aecdaa85c #1 [ 1358.394732] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.404322] task:python3 state:D stack:25672 pid:5421 tgid:5421 ppid:5420 task_flags:0x400100 flags:0x00080002 [ 1358.417528] Call Trace: [ 1358.421069] [ 1358.424219] __schedule+0xcc3/0x19c0 [ 1358.429035] ? io_schedule_timeout+0x140/0x140 [ 1358.434823] ? find_held_lock+0x2b/0x80 [ 1358.439928] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.445813] schedule+0xd8/0x260 [ 1358.450232] schedule_preempt_disabled+0x18/0x30 [ 1358.456211] __mutex_lock+0x6af/0x2010 [ 1358.461215] ? threaded_store+0x132/0x220 [ 1358.466514] ? ww_mutex_lock+0x160/0x160 [ 1358.471711] ? selinux_inode_free_security+0x330/0x330 [ 1358.478282] ? cap_capable+0x1d6/0x3e0 [ 1358.483291] ? threaded_store+0x132/0x220 [ 1358.488588] threaded_store+0x132/0x220 [ 1358.493690] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.498981] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.504279] ? sysfs_kf_write+0x65/0x160 [ 1358.509478] ? sysfs_file_ops+0x140/0x140 [ 1358.514773] kernfs_fop_write_iter+0x335/0x510 [ 1358.520557] ? kernfs_ops+0xf0/0xf0 [ 1358.525270] new_sync_write+0x333/0x750 [ 1358.530376] ? __lock_acquire+0x508/0xc10 [ 1358.535674] ? new_sync_read+0x740/0x740 [ 1358.540866] ? lock_acquire.part.0+0xbc/0x260 [ 1358.546554] ? ksys_write+0x116/0x250 [ 1358.551465] vfs_write+0x657/0x9b0 [ 1358.556082] ksys_write+0x116/0x250 [ 1358.560792] ? __ia32_sys_read+0xc0/0xc0 [ 1358.565991] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.571580] ? rcu_is_watching+0x15/0xd0 [ 1358.576774] do_syscall_64+0xf3/0x650 [ 1358.581681] ? trace_hardirqs_off+0xd/0x30 [ 1358.587069] ? exc_page_fault+0xda/0xf0 [ 1358.592176] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.598645] RIP: 0033:0x7f3cbef1264e [ 1358.603458] RSP: 002b:00007ffd12a84660 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.612755] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f3cbef1264e [ 1358.621563] RDX: 0000000000000001 RSI: 0000560488afdbf0 RDI: 0000000000000007 [ 1358.630361] RBP: 00007ffd12a84670 R08: 0000000000000000 R09: 0000000000000000 [ 1358.639174] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f3cbed8b390 [ 1358.647983] R13: 0000560488afdbf0 R14: 0000000000000007 R15: 00007f3cbed21120 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store