====================================== | [ 778.602903] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 778.605353] nipa-hw-worker: [5/46] Retrying drivers/net:napi_threaded.py | [ 778.756177] kselftest: Running tests in drivers/net [ 989.643828] INFO: task python3:5666 blocked for more than 122 seconds. [ 989.652063] Not tainted 7.1.0-rc2-axza-g2dee1e3ea030 #1 [ 989.659949] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.669538] task:python3 state:D stack:25672 pid:5666 tgid:5666 ppid:5665 task_flags:0x400100 flags:0x00080000 [ 989.682744] Call Trace: [ 989.686283] [ 989.689434] __schedule+0xcba/0x1940 [ 989.694251] ? io_schedule_timeout+0x140/0x140 [ 989.700039] ? find_held_lock+0x2b/0x80 [ 989.705145] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.711031] schedule+0xd4/0x260 [ 989.715450] schedule_preempt_disabled+0x18/0x30 [ 989.721433] __mutex_lock+0x6a3/0x2000 [ 989.726438] ? threaded_store+0x132/0x220 [ 989.731737] ? ww_mutex_lock+0x160/0x160 [ 989.736925] ? selinux_inode_free_security+0x330/0x330 [ 989.743497] ? cap_capable+0x1d6/0x3e0 [ 989.748511] ? threaded_store+0x132/0x220 [ 989.753810] threaded_store+0x132/0x220 [ 989.758913] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.764208] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.769508] ? sysfs_kf_write+0x65/0x160 [ 989.774709] ? sysfs_file_ops+0x140/0x140 [ 989.780008] kernfs_fop_write_iter+0x335/0x510 [ 989.785793] ? kernfs_ops+0xf0/0xf0 [ 989.790498] new_sync_write+0x333/0x750 [ 989.795603] ? __lock_acquire+0x508/0xc10 [ 989.800901] ? new_sync_read+0x740/0x740 [ 989.806104] ? lock_acquire.part.0+0xbc/0x260 [ 989.811793] ? ksys_write+0x116/0x250 [ 989.816705] vfs_write+0x657/0x9b0 [ 989.821319] ksys_write+0x116/0x250 [ 989.826030] ? __ia32_sys_read+0xc0/0xc0 [ 989.831229] ? rcu_is_watching+0x15/0xd0 [ 989.836421] ? rcu_is_watching+0x15/0xd0 [ 989.841620] do_syscall_64+0xf3/0x650 [ 989.846518] ? irq_exit_rcu+0x1a/0x30 [ 989.851419] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.857886] RIP: 0033:0x7f1693cf722e [ 989.862686] RSP: 002b:00007ffd3eb02df0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.871993] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f1693cf722e [ 989.880801] RDX: 0000000000000001 RSI: 000055c21fa86fe0 RDI: 0000000000000007 [ 989.889607] RBP: 00007ffd3eb02e00 R08: 0000000000000000 R09: 0000000000000000 [ 989.898413] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f1693b6f390 [ 989.907222] R13: 000055c21fa86fe0 R14: 0000000000000007 R15: 0000000000000003 | [ 990.312820] #1: ff110001af5d1480 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 990.323785] #2: ff11000123e64b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.334943] #3: ff11000123e41d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.345033] | [ 990.347499] =============================================\x0a [ 1112.525250] INFO: task python3:5666 blocked for more than 245 seconds. [ 1112.533400] Not tainted 7.1.0-rc2-axza-g2dee1e3ea030 #1 [ 1112.540653] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.540656] task:python3 state:D stack:25672 pid:5666 tgid:5666 ppid:5665 task_flags:0x400100 flags:0x00080000 [ 1112.540664] Call Trace: [ 1112.540666] [ 1112.540670] __schedule+0xcba/0x1940 [ 1112.540682] ? io_schedule_timeout+0x140/0x140 [ 1112.580793] ? find_held_lock+0x2b/0x80 [ 1112.585897] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.591783] schedule+0xd4/0x260 [ 1112.596200] schedule_preempt_disabled+0x18/0x30 [ 1112.602178] __mutex_lock+0x6a3/0x2000 [ 1112.607182] ? threaded_store+0x132/0x220 [ 1112.612481] ? ww_mutex_lock+0x160/0x160 [ 1112.617678] ? selinux_inode_free_security+0x330/0x330 [ 1112.624248] ? cap_capable+0x1d6/0x3e0 [ 1112.629253] ? threaded_store+0x132/0x220 [ 1112.634547] threaded_store+0x132/0x220 [ 1112.639649] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.644935] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.650236] ? sysfs_kf_write+0x65/0x160 [ 1112.655434] ? sysfs_file_ops+0x140/0x140 [ 1112.660728] kernfs_fop_write_iter+0x335/0x510 [ 1112.666513] ? kernfs_ops+0xf0/0xf0 [ 1112.671221] new_sync_write+0x333/0x750 [ 1112.676323] ? __lock_acquire+0x508/0xc10 [ 1112.681617] ? new_sync_read+0x740/0x740 [ 1112.686815] ? lock_acquire.part.0+0xbc/0x260 [ 1112.692500] ? ksys_write+0x116/0x250 [ 1112.697413] vfs_write+0x657/0x9b0 [ 1112.702027] ksys_write+0x116/0x250 [ 1112.706738] ? __ia32_sys_read+0xc0/0xc0 [ 1112.711938] ? rcu_is_watching+0x15/0xd0 [ 1112.717137] ? rcu_is_watching+0x15/0xd0 [ 1112.722334] do_syscall_64+0xf3/0x650 [ 1112.727241] ? irq_exit_rcu+0x1a/0x30 [ 1112.732149] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.738616] RIP: 0033:0x7f1693cf722e [ 1112.743424] RSP: 002b:00007ffd3eb02df0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.752721] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f1693cf722e [ 1112.761519] RDX: 0000000000000001 RSI: 000055c21fa86fe0 RDI: 0000000000000007 [ 1112.770324] RBP: 00007ffd3eb02e00 R08: 0000000000000000 R09: 0000000000000000 [ 1112.779133] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f1693b6f390 [ 1112.787939] R13: 000055c21fa86fe0 R14: 0000000000000007 R15: 0000000000000003 | [ 1113.223869] #2: ffffffff97f69ce0 (cgroup_mutex){+.+.}-{4:4}, at: cgroup_kn_lock_live+0xe2/0x3e0 | [ 1113.234537] #3: ffffffff97d68970 (cpu_hotplug_lock){++++}-{0:0}, at: cgroup_procs_write_start+0x3e5/0x650 | [ 1113.246178] #4: ffffffff97f69a50 (cgroup_threadgroup_rwsem){++++}-{0:0}, at: cgroup_procs_write_start+0x3f1/0x650 | [ 1113.258601] | [ 1113.261067] =============================================\x0a [ 1235.405689] INFO: task python3:5666 blocked for more than 368 seconds. [ 1235.413839] Not tainted 7.1.0-rc2-axza-g2dee1e3ea030 #1 [ 1235.421089] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.430679] task:python3 state:D stack:25672 pid:5666 tgid:5666 ppid:5665 task_flags:0x400100 flags:0x00080002 [ 1235.443885] Call Trace: [ 1235.447424] [ 1235.450575] __schedule+0xcba/0x1940 [ 1235.455393] ? io_schedule_timeout+0x140/0x140 [ 1235.461179] ? find_held_lock+0x2b/0x80 [ 1235.466284] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.472168] schedule+0xd4/0x260 [ 1235.476588] schedule_preempt_disabled+0x18/0x30 [ 1235.482560] __mutex_lock+0x6a3/0x2000 [ 1235.487553] ? threaded_store+0x132/0x220 [ 1235.492849] ? ww_mutex_lock+0x160/0x160 [ 1235.498047] ? selinux_inode_free_security+0x330/0x330 [ 1235.504606] ? cap_capable+0x1d6/0x3e0 [ 1235.509614] ? threaded_store+0x132/0x220 [ 1235.514909] threaded_store+0x132/0x220 [ 1235.520010] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.525307] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.530603] ? sysfs_kf_write+0x65/0x160 [ 1235.535804] ? sysfs_file_ops+0x140/0x140 [ 1235.541100] kernfs_fop_write_iter+0x335/0x510 [ 1235.546883] ? kernfs_ops+0xf0/0xf0 [ 1235.551593] new_sync_write+0x333/0x750 [ 1235.556697] ? __lock_acquire+0x508/0xc10 [ 1235.561992] ? new_sync_read+0x740/0x740 [ 1235.567195] ? lock_acquire.part.0+0xbc/0x260 [ 1235.572881] ? ksys_write+0x116/0x250 [ 1235.577789] vfs_write+0x657/0x9b0 [ 1235.582406] ksys_write+0x116/0x250 [ 1235.587118] ? __ia32_sys_read+0xc0/0xc0 [ 1235.592306] ? rcu_is_watching+0x15/0xd0 [ 1235.597504] ? rcu_is_watching+0x15/0xd0 [ 1235.602703] do_syscall_64+0xf3/0x650 [ 1235.607608] ? irq_exit_rcu+0x1a/0x30 [ 1235.612516] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.618987] RIP: 0033:0x7f1693cf722e [ 1235.623796] RSP: 002b:00007ffd3eb02df0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.633094] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f1693cf722e [ 1235.641903] RDX: 0000000000000001 RSI: 000055c21fa86fe0 RDI: 0000000000000007 [ 1235.650708] RBP: 00007ffd3eb02e00 R08: 0000000000000000 R09: 0000000000000000 [ 1235.659516] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f1693b6f390 [ 1235.668328] R13: 000055c21fa86fe0 R14: 0000000000000007 R15: 0000000000000003 | [ 1236.045136] #1: ff110001af5d1480 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1236.056098] #2: ff11000123e64b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.067257] #3: ff11000123e41d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.077345] | [ 1236.079809] =============================================\x0a [ 1358.287119] INFO: task python3:5666 blocked for more than 491 seconds. [ 1358.295267] Not tainted 7.1.0-rc2-axza-g2dee1e3ea030 #1 [ 1358.302518] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.312104] task:python3 state:D stack:25672 pid:5666 tgid:5666 ppid:5665 task_flags:0x400100 flags:0x00080002 [ 1358.325310] Call Trace: [ 1358.328851] [ 1358.332002] __schedule+0xcba/0x1940 [ 1358.336819] ? io_schedule_timeout+0x140/0x140 [ 1358.342604] ? find_held_lock+0x2b/0x80 [ 1358.347709] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.353594] schedule+0xd4/0x260 [ 1358.358010] schedule_preempt_disabled+0x18/0x30 [ 1358.363989] __mutex_lock+0x6a3/0x2000 [ 1358.368992] ? threaded_store+0x132/0x220 [ 1358.374289] ? ww_mutex_lock+0x160/0x160 [ 1358.379489] ? selinux_inode_free_security+0x330/0x330 [ 1358.386057] ? cap_capable+0x1d6/0x3e0 [ 1358.391064] ? threaded_store+0x132/0x220 [ 1358.396359] threaded_store+0x132/0x220 [ 1358.401460] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.406758] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.412054] ? sysfs_kf_write+0x65/0x160 [ 1358.417255] ? sysfs_file_ops+0x140/0x140 [ 1358.422552] kernfs_fop_write_iter+0x335/0x510 [ 1358.428332] ? kernfs_ops+0xf0/0xf0 [ 1358.433043] new_sync_write+0x333/0x750 [ 1358.438135] ? __lock_acquire+0x508/0xc10 [ 1358.443430] ? new_sync_read+0x740/0x740 [ 1358.448631] ? lock_acquire.part.0+0xbc/0x260 [ 1358.454317] ? ksys_write+0x116/0x250 [ 1358.459226] vfs_write+0x657/0x9b0 [ 1358.463842] ksys_write+0x116/0x250 [ 1358.468553] ? __ia32_sys_read+0xc0/0xc0 [ 1358.473750] ? rcu_is_watching+0x15/0xd0 [ 1358.478946] ? rcu_is_watching+0x15/0xd0 [ 1358.484150] do_syscall_64+0xf3/0x650 [ 1358.489047] ? irq_exit_rcu+0x1a/0x30 [ 1358.493957] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.500422] RIP: 0033:0x7f1693cf722e [ 1358.505231] RSP: 002b:00007ffd3eb02df0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.514521] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f1693cf722e [ 1358.523326] RDX: 0000000000000001 RSI: 000055c21fa86fe0 RDI: 0000000000000007 [ 1358.532130] RBP: 00007ffd3eb02e00 R08: 0000000000000000 R09: 0000000000000000 [ 1358.540936] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f1693b6f390 [ 1358.549745] R13: 000055c21fa86fe0 R14: 0000000000000007 R15: 0000000000000003 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store