====================================== | [ 788.344588] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 788.347536] nipa-hw-worker: [5/46] Retrying drivers/net:napi_threaded.py | [ 788.498315] kselftest: Running tests in drivers/net [ 989.715324] INFO: task python3:5848 blocked for more than 122 seconds. [ 989.723556] Not tainted 7.1.0-rc4-nquv-ge509ba3168f2 #1 [ 989.731438] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.741027] task:python3 state:D stack:25672 pid:5848 tgid:5848 ppid:5847 task_flags:0x400100 flags:0x00080000 [ 989.754235] Call Trace: [ 989.757777] [ 989.760928] __schedule+0xcc3/0x19c0 [ 989.765745] ? io_schedule_timeout+0x140/0x140 [ 989.771532] ? find_held_lock+0x2b/0x80 [ 989.776637] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.782513] schedule+0xd8/0x260 [ 989.786930] schedule_preempt_disabled+0x18/0x30 [ 989.792912] __mutex_lock+0x6af/0x2010 [ 989.797916] ? threaded_store+0x132/0x220 [ 989.803208] ? ww_mutex_lock+0x160/0x160 [ 989.808408] ? selinux_inode_free_security+0x330/0x330 [ 989.814980] ? cap_capable+0x1d6/0x3e0 [ 989.819991] ? threaded_store+0x132/0x220 [ 989.825292] threaded_store+0x132/0x220 [ 989.830397] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.835697] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.840996] ? sysfs_kf_write+0x65/0x160 [ 989.846198] ? sysfs_file_ops+0x140/0x140 [ 989.851495] kernfs_fop_write_iter+0x335/0x510 [ 989.857271] ? kernfs_ops+0xf0/0xf0 [ 989.861983] new_sync_write+0x333/0x750 [ 989.867088] ? __lock_acquire+0x508/0xc10 [ 989.872385] ? new_sync_read+0x740/0x740 [ 989.877579] ? lock_acquire.part.0+0xbc/0x260 [ 989.883267] ? ksys_write+0x116/0x250 [ 989.888179] vfs_write+0x657/0x9b0 [ 989.892794] ksys_write+0x116/0x250 [ 989.897499] ? __ia32_sys_read+0xc0/0xc0 [ 989.902698] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.908288] ? rcu_is_watching+0x15/0xd0 [ 989.913489] do_syscall_64+0xf3/0x650 [ 989.918395] ? trace_hardirqs_off+0xd/0x30 [ 989.923784] ? exc_page_fault+0xda/0xf0 [ 989.928889] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.935363] RIP: 0033:0x7fcc96f9d22e [ 989.940173] RSP: 002b:00007fff20af7730 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.949472] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fcc96f9d22e [ 989.958280] RDX: 0000000000000001 RSI: 000055a73ed686b0 RDI: 0000000000000007 [ 989.967090] RBP: 00007fff20af7740 R08: 0000000000000000 R09: 0000000000000000 [ 989.975900] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fcc96e15390 [ 989.984710] R13: 000055a73ed686b0 R14: 0000000000000007 R15: 0000000000000003 | [ 990.356016] #1: ff1100012ce85080 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 990.366977] #2: ff110001236d2b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.378138] #3: ff11000123719d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.388228] | [ 990.390696] =============================================\x0a [ 1112.596549] INFO: task python3:5848 blocked for more than 245 seconds. [ 1112.604697] Not tainted 7.1.0-rc4-nquv-ge509ba3168f2 #1 [ 1112.611947] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.621536] task:python3 state:D stack:25672 pid:5848 tgid:5848 ppid:5847 task_flags:0x400100 flags:0x00080000 [ 1112.634743] Call Trace: [ 1112.638283] [ 1112.641507] __schedule+0xcc3/0x19c0 [ 1112.646323] ? io_schedule_timeout+0x140/0x140 [ 1112.646328] ? find_held_lock+0x2b/0x80 [ 1112.646334] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.646340] schedule+0xd8/0x260 [ 1112.646343] schedule_preempt_disabled+0x18/0x30 [ 1112.646345] __mutex_lock+0x6af/0x2010 [ 1112.646349] ? threaded_store+0x132/0x220 [ 1112.683854] ? ww_mutex_lock+0x160/0x160 [ 1112.689054] ? selinux_inode_free_security+0x330/0x330 [ 1112.695625] ? cap_capable+0x1d6/0x3e0 [ 1112.700635] ? threaded_store+0x132/0x220 [ 1112.705933] threaded_store+0x132/0x220 [ 1112.711036] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.716337] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.721636] ? sysfs_kf_write+0x65/0x160 [ 1112.726829] ? sysfs_file_ops+0x140/0x140 [ 1112.732127] kernfs_fop_write_iter+0x335/0x510 [ 1112.737902] ? kernfs_ops+0xf0/0xf0 [ 1112.742614] new_sync_write+0x333/0x750 [ 1112.747716] ? __lock_acquire+0x508/0xc10 [ 1112.753013] ? new_sync_read+0x740/0x740 [ 1112.758217] ? lock_acquire.part.0+0xbc/0x260 [ 1112.763904] ? ksys_write+0x116/0x250 [ 1112.768814] vfs_write+0x657/0x9b0 [ 1112.773432] ksys_write+0x116/0x250 [ 1112.778143] ? __ia32_sys_read+0xc0/0xc0 [ 1112.783341] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.788929] ? rcu_is_watching+0x15/0xd0 [ 1112.794122] do_syscall_64+0xf3/0x650 [ 1112.799028] ? trace_hardirqs_off+0xd/0x30 [ 1112.804416] ? exc_page_fault+0xda/0xf0 [ 1112.809513] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.815983] RIP: 0033:0x7fcc96f9d22e [ 1112.820795] RSP: 002b:00007fff20af7730 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.830094] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fcc96f9d22e [ 1112.838904] RDX: 0000000000000001 RSI: 000055a73ed686b0 RDI: 0000000000000007 [ 1112.847715] RBP: 00007fff20af7740 R08: 0000000000000000 R09: 0000000000000000 [ 1112.856525] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fcc96e15390 [ 1112.865336] R13: 000055a73ed686b0 R14: 0000000000000007 R15: 0000000000000003 | [ 1113.324458] #2: ffffffffbb769b60 (cgroup_mutex){+.+.}-{4:4}, at: cgroup_kn_lock_live+0xe2/0x3e0 | [ 1113.335121] #3: ffffffffbb5686f0 (cpu_hotplug_lock){++++}-{0:0}, at: cgroup_procs_write_start+0x3e5/0x650 | [ 1113.346765] #4: ffffffffbb7698d0 (cgroup_threadgroup_rwsem){++++}-{0:0}, at: cgroup_procs_write_start+0x3f1/0x650 | [ 1113.359182] | [ 1113.361647] =============================================\x0a [ 1235.477662] INFO: task python3:5848 blocked for more than 368 seconds. [ 1235.485809] Not tainted 7.1.0-rc4-nquv-ge509ba3168f2 #1 [ 1235.493058] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.502647] task:python3 state:D stack:25672 pid:5848 tgid:5848 ppid:5847 task_flags:0x400100 flags:0x00080002 [ 1235.515842] Call Trace: [ 1235.519381] [ 1235.522529] __schedule+0xcc3/0x19c0 [ 1235.527345] ? io_schedule_timeout+0x140/0x140 [ 1235.533131] ? find_held_lock+0x2b/0x80 [ 1235.538236] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.544120] schedule+0xd8/0x260 [ 1235.548535] schedule_preempt_disabled+0x18/0x30 [ 1235.554515] __mutex_lock+0x6af/0x2010 [ 1235.559513] ? threaded_store+0x132/0x220 [ 1235.564814] ? ww_mutex_lock+0x160/0x160 [ 1235.570011] ? selinux_inode_free_security+0x330/0x330 [ 1235.576581] ? cap_capable+0x1d6/0x3e0 [ 1235.581588] ? threaded_store+0x132/0x220 [ 1235.586885] threaded_store+0x132/0x220 [ 1235.591989] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.597287] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.602584] ? sysfs_kf_write+0x65/0x160 [ 1235.607785] ? sysfs_file_ops+0x140/0x140 [ 1235.613071] kernfs_fop_write_iter+0x335/0x510 [ 1235.618852] ? kernfs_ops+0xf0/0xf0 [ 1235.623562] new_sync_write+0x333/0x750 [ 1235.628662] ? __lock_acquire+0x508/0xc10 [ 1235.633956] ? new_sync_read+0x740/0x740 [ 1235.639158] ? lock_acquire.part.0+0xbc/0x260 [ 1235.644843] ? ksys_write+0x116/0x250 [ 1235.649752] vfs_write+0x657/0x9b0 [ 1235.654368] ksys_write+0x116/0x250 [ 1235.659080] ? __ia32_sys_read+0xc0/0xc0 [ 1235.664271] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.669861] ? rcu_is_watching+0x15/0xd0 [ 1235.675062] do_syscall_64+0xf3/0x650 [ 1235.679965] ? trace_hardirqs_off+0xd/0x30 [ 1235.685360] ? exc_page_fault+0xda/0xf0 [ 1235.690462] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.696918] RIP: 0033:0x7fcc96f9d22e [ 1235.701727] RSP: 002b:00007fff20af7730 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.711015] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fcc96f9d22e [ 1235.719824] RDX: 0000000000000001 RSI: 000055a73ed686b0 RDI: 0000000000000007 [ 1235.728628] RBP: 00007fff20af7740 R08: 0000000000000000 R09: 0000000000000000 [ 1235.737432] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fcc96e15390 [ 1235.746239] R13: 000055a73ed686b0 R14: 0000000000000007 R15: 0000000000000003 | [ 1236.144085] #1: ff1100012ce85080 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1236.155045] #2: ff110001236d2b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.166200] #3: ff11000123719d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.176288] | [ 1236.178753] =============================================\x0a [ 1358.358771] INFO: task python3:5848 blocked for more than 491 seconds. [ 1358.366918] Not tainted 7.1.0-rc4-nquv-ge509ba3168f2 #1 [ 1358.374172] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.383767] task:python3 state:D stack:25672 pid:5848 tgid:5848 ppid:5847 task_flags:0x400100 flags:0x00080002 [ 1358.396981] Call Trace: [ 1358.400521] [ 1358.403677] __schedule+0xcc3/0x19c0 [ 1358.408498] ? io_schedule_timeout+0x140/0x140 [ 1358.414288] ? find_held_lock+0x2b/0x80 [ 1358.419396] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.425290] schedule+0xd8/0x260 [ 1358.429711] schedule_preempt_disabled+0x18/0x30 [ 1358.435695] __mutex_lock+0x6af/0x2010 [ 1358.440703] ? threaded_store+0x132/0x220 [ 1358.446010] ? ww_mutex_lock+0x160/0x160 [ 1358.451204] ? selinux_inode_free_security+0x330/0x330 [ 1358.457784] ? cap_capable+0x1d6/0x3e0 [ 1358.462797] ? threaded_store+0x132/0x220 [ 1358.468098] threaded_store+0x132/0x220 [ 1358.473207] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.478508] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.483812] ? sysfs_kf_write+0x65/0x160 [ 1358.489018] ? sysfs_file_ops+0x140/0x140 [ 1358.494319] kernfs_fop_write_iter+0x335/0x510 [ 1358.500108] ? kernfs_ops+0xf0/0xf0 [ 1358.504822] new_sync_write+0x333/0x750 [ 1358.509932] ? __lock_acquire+0x508/0xc10 [ 1358.515234] ? new_sync_read+0x740/0x740 [ 1358.520444] ? lock_acquire.part.0+0xbc/0x260 [ 1358.526134] ? ksys_write+0x116/0x250 [ 1358.531055] vfs_write+0x657/0x9b0 [ 1358.535672] ksys_write+0x116/0x250 [ 1358.540388] ? __ia32_sys_read+0xc0/0xc0 [ 1358.545593] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.551188] ? rcu_is_watching+0x15/0xd0 [ 1358.556393] do_syscall_64+0xf3/0x650 [ 1358.561303] ? trace_hardirqs_off+0xd/0x30 [ 1358.566704] ? exc_page_fault+0xda/0xf0 [ 1358.571812] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.578285] RIP: 0033:0x7fcc96f9d22e [ 1358.583098] RSP: 002b:00007fff20af7730 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.592400] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fcc96f9d22e [ 1358.601214] RDX: 0000000000000001 RSI: 000055a73ed686b0 RDI: 0000000000000007 [ 1358.610025] RBP: 00007fff20af7740 R08: 0000000000000000 R09: 0000000000000000 [ 1358.618841] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fcc96e15390 [ 1358.627653] R13: 000055a73ed686b0 R14: 0000000000000007 R15: 0000000000000003 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store