====================================== | [ 791.553320] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 791.555729] nipa-hw-worker: [5/46] Retrying drivers/net:napi_threaded.py | [ 791.710199] kselftest: Running tests in drivers/net [ 989.712691] INFO: task python3:5874 blocked for more than 122 seconds. [ 989.720908] Not tainted 7.1.0-rc4-wvvd-gb2b2ce506207 #1 [ 989.728715] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.738314] task:python3 state:D stack:25672 pid:5874 tgid:5874 ppid:5873 task_flags:0x400100 flags:0x00080000 [ 989.751531] Call Trace: [ 989.755074] [ 989.758228] __schedule+0xcc3/0x19c0 [ 989.763051] ? io_schedule_timeout+0x140/0x140 [ 989.768839] ? find_held_lock+0x2b/0x80 [ 989.773951] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.779839] schedule+0xd8/0x260 [ 989.784263] schedule_preempt_disabled+0x18/0x30 [ 989.790245] __mutex_lock+0x6af/0x2010 [ 989.795255] ? threaded_store+0x132/0x220 [ 989.800559] ? ww_mutex_lock+0x160/0x160 [ 989.805760] ? selinux_inode_free_security+0x330/0x330 [ 989.812332] ? cap_capable+0x1d6/0x3e0 [ 989.817350] ? threaded_store+0x132/0x220 [ 989.822651] threaded_store+0x132/0x220 [ 989.827762] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.833063] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.838368] ? sysfs_kf_write+0x65/0x160 [ 989.843573] ? sysfs_file_ops+0x140/0x140 [ 989.848871] kernfs_fop_write_iter+0x335/0x510 [ 989.854659] ? kernfs_ops+0xf0/0xf0 [ 989.859376] new_sync_write+0x333/0x750 [ 989.864484] ? __lock_acquire+0x508/0xc10 [ 989.869786] ? new_sync_read+0x740/0x740 [ 989.874989] ? lock_acquire.part.0+0xbc/0x260 [ 989.880680] ? ksys_write+0x116/0x250 [ 989.885594] vfs_write+0x657/0x9b0 [ 989.890214] ksys_write+0x116/0x250 [ 989.894931] ? __ia32_sys_read+0xc0/0xc0 [ 989.900135] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.905731] ? rcu_is_watching+0x15/0xd0 [ 989.910938] do_syscall_64+0xf3/0x650 [ 989.915846] ? trace_hardirqs_off+0xd/0x30 [ 989.921236] ? exc_page_fault+0xda/0xf0 [ 989.926342] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.932816] RIP: 0033:0x7fb2b931f22e [ 989.937631] RSP: 002b:00007fff610e4240 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.946937] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fb2b931f22e [ 989.955749] RDX: 0000000000000001 RSI: 000055d5b8bdf6b0 RDI: 0000000000000007 [ 989.964565] RBP: 00007fff610e4250 R08: 0000000000000000 R09: 0000000000000000 [ 989.973378] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fb2b9197390 [ 989.982189] R13: 000055d5b8bdf6b0 R14: 0000000000000007 R15: 0000000000000003 | [ 990.387967] #1: ff110001ef154480 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 990.398928] #2: ff11000120b39450 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.410081] #3: ff11000120bc1d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.420169] | [ 990.422633] =============================================\x0a [ 1112.593799] INFO: task python3:5874 blocked for more than 245 seconds. [ 1112.601948] Not tainted 7.1.0-rc4-wvvd-gb2b2ce506207 #1 [ 1112.609190] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.618779] task:python3 state:D stack:25672 pid:5874 tgid:5874 ppid:5873 task_flags:0x400100 flags:0x00080000 [ 1112.631985] Call Trace: [ 1112.635526] [ 1112.638677] __schedule+0xcc3/0x19c0 [ 1112.643496] ? io_schedule_timeout+0x140/0x140 [ 1112.649284] ? find_held_lock+0x2b/0x80 [ 1112.654387] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.660272] schedule+0xd8/0x260 [ 1112.664691] schedule_preempt_disabled+0x18/0x30 [ 1112.670668] __mutex_lock+0x6af/0x2010 [ 1112.675672] ? threaded_store+0x132/0x220 [ 1112.680971] ? ww_mutex_lock+0x160/0x160 [ 1112.686171] ? selinux_inode_free_security+0x330/0x330 [ 1112.692742] ? cap_capable+0x1d6/0x3e0 [ 1112.697752] ? threaded_store+0x132/0x220 [ 1112.703054] threaded_store+0x132/0x220 [ 1112.708157] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.713456] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.718753] ? sysfs_kf_write+0x65/0x160 [ 1112.723956] ? sysfs_file_ops+0x140/0x140 [ 1112.729253] kernfs_fop_write_iter+0x335/0x510 [ 1112.735038] ? kernfs_ops+0xf0/0xf0 [ 1112.739750] new_sync_write+0x333/0x750 [ 1112.744852] ? __lock_acquire+0x508/0xc10 [ 1112.750149] ? new_sync_read+0x740/0x740 [ 1112.755344] ? lock_acquire.part.0+0xbc/0x260 [ 1112.761031] ? ksys_write+0x116/0x250 [ 1112.765932] vfs_write+0x657/0x9b0 [ 1112.770547] ksys_write+0x116/0x250 [ 1112.775261] ? __ia32_sys_read+0xc0/0xc0 [ 1112.780459] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.786050] ? rcu_is_watching+0x15/0xd0 [ 1112.791252] do_syscall_64+0xf3/0x650 [ 1112.796157] ? trace_hardirqs_off+0xd/0x30 [ 1112.801554] ? exc_page_fault+0xda/0xf0 [ 1112.806658] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.813126] RIP: 0033:0x7fb2b931f22e [ 1112.817938] RSP: 002b:00007fff610e4240 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.827237] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fb2b931f22e [ 1112.836048] RDX: 0000000000000001 RSI: 000055d5b8bdf6b0 RDI: 0000000000000007 [ 1112.844858] RBP: 00007fff610e4250 R08: 0000000000000000 R09: 0000000000000000 [ 1112.853665] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fb2b9197390 [ 1112.862476] R13: 000055d5b8bdf6b0 R14: 0000000000000007 R15: 0000000000000003 | [ 1113.239362] #1: ff110001ef154480 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1113.250322] #2: ff11000120b39450 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.261480] #3: ff11000120bc1d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.271571] | [ 1113.274038] =============================================\x0a [ 1235.473931] INFO: task python3:5874 blocked for more than 368 seconds. [ 1235.482078] Not tainted 7.1.0-rc4-wvvd-gb2b2ce506207 #1 [ 1235.489330] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.498919] task:python3 state:D stack:25672 pid:5874 tgid:5874 ppid:5873 task_flags:0x400100 flags:0x00080002 [ 1235.512125] Call Trace: [ 1235.515667] [ 1235.518819] __schedule+0xcc3/0x19c0 [ 1235.523639] ? io_schedule_timeout+0x140/0x140 [ 1235.529426] ? find_held_lock+0x2b/0x80 [ 1235.534533] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.540418] schedule+0xd8/0x260 [ 1235.544836] schedule_preempt_disabled+0x18/0x30 [ 1235.550818] __mutex_lock+0x6af/0x2010 [ 1235.555823] ? threaded_store+0x132/0x220 [ 1235.561126] ? ww_mutex_lock+0x160/0x160 [ 1235.566325] ? selinux_inode_free_security+0x330/0x330 [ 1235.572896] ? cap_capable+0x1d6/0x3e0 [ 1235.577904] ? threaded_store+0x132/0x220 [ 1235.583204] threaded_store+0x132/0x220 [ 1235.588309] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.593608] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.598905] ? sysfs_kf_write+0x65/0x160 [ 1235.604107] ? sysfs_file_ops+0x140/0x140 [ 1235.609404] kernfs_fop_write_iter+0x335/0x510 [ 1235.615183] ? kernfs_ops+0xf0/0xf0 [ 1235.619894] new_sync_write+0x333/0x750 [ 1235.624999] ? __lock_acquire+0x508/0xc10 [ 1235.630285] ? new_sync_read+0x740/0x740 [ 1235.635489] ? lock_acquire.part.0+0xbc/0x260 [ 1235.641175] ? ksys_write+0x116/0x250 [ 1235.646084] vfs_write+0x657/0x9b0 [ 1235.650702] ksys_write+0x116/0x250 [ 1235.655416] ? __ia32_sys_read+0xc0/0xc0 [ 1235.660618] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.666208] ? rcu_is_watching+0x15/0xd0 [ 1235.671410] do_syscall_64+0xf3/0x650 [ 1235.676318] ? trace_hardirqs_off+0xd/0x30 [ 1235.681715] ? exc_page_fault+0xda/0xf0 [ 1235.686819] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.693286] RIP: 0033:0x7fb2b931f22e [ 1235.698088] RSP: 002b:00007fff610e4240 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.707386] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fb2b931f22e [ 1235.716196] RDX: 0000000000000001 RSI: 000055d5b8bdf6b0 RDI: 0000000000000007 [ 1235.725006] RBP: 00007fff610e4250 R08: 0000000000000000 R09: 0000000000000000 [ 1235.733816] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fb2b9197390 [ 1235.742627] R13: 000055d5b8bdf6b0 R14: 0000000000000007 R15: 0000000000000003 | [ 1236.148198] #1: ff110001ef154480 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1236.159153] #2: ff11000120b39450 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.170311] #3: ff11000120bc1d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.180402] | [ 1236.182867] =============================================\x0a [ 1358.356000] INFO: task python3:5874 blocked for more than 491 seconds. [ 1358.364151] Not tainted 7.1.0-rc4-wvvd-gb2b2ce506207 #1 [ 1358.371741] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.381330] task:python3 state:D stack:25672 pid:5874 tgid:5874 ppid:5873 task_flags:0x400100 flags:0x00080002 [ 1358.394527] Call Trace: [ 1358.398064] [ 1358.401215] __schedule+0xcc3/0x19c0 [ 1358.406031] ? io_schedule_timeout+0x140/0x140 [ 1358.411816] ? find_held_lock+0x2b/0x80 [ 1358.411824] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.411830] schedule+0xd8/0x260 [ 1358.411833] schedule_preempt_disabled+0x18/0x30 [ 1358.411836] __mutex_lock+0x6af/0x2010 [ 1358.411840] ? threaded_store+0x132/0x220 [ 1358.443586] ? ww_mutex_lock+0x160/0x160 [ 1358.448788] ? selinux_inode_free_security+0x330/0x330 [ 1358.455357] ? cap_capable+0x1d6/0x3e0 [ 1358.460364] ? threaded_store+0x132/0x220 [ 1358.465660] threaded_store+0x132/0x220 [ 1358.470759] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.476057] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.481353] ? sysfs_kf_write+0x65/0x160 [ 1358.486553] ? sysfs_file_ops+0x140/0x140 [ 1358.491840] kernfs_fop_write_iter+0x335/0x510 [ 1358.497627] ? kernfs_ops+0xf0/0xf0 [ 1358.502336] new_sync_write+0x333/0x750 [ 1358.507440] ? __lock_acquire+0x508/0xc10 [ 1358.512734] ? new_sync_read+0x740/0x740 [ 1358.517935] ? lock_acquire.part.0+0xbc/0x260 [ 1358.523618] ? ksys_write+0x116/0x250 [ 1358.528526] vfs_write+0x657/0x9b0 [ 1358.533142] ksys_write+0x116/0x250 [ 1358.537856] ? __ia32_sys_read+0xc0/0xc0 [ 1358.543056] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.548643] ? rcu_is_watching+0x15/0xd0 [ 1358.553842] do_syscall_64+0xf3/0x650 [ 1358.558750] ? trace_hardirqs_off+0xd/0x30 [ 1358.564144] ? exc_page_fault+0xda/0xf0 [ 1358.569244] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.575708] RIP: 0033:0x7fb2b931f22e [ 1358.580518] RSP: 002b:00007fff610e4240 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.589807] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fb2b931f22e [ 1358.598612] RDX: 0000000000000001 RSI: 000055d5b8bdf6b0 RDI: 0000000000000007 [ 1358.607422] RBP: 00007fff610e4250 R08: 0000000000000000 R09: 0000000000000000 [ 1358.616226] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fb2b9197390 [ 1358.625031] R13: 000055d5b8bdf6b0 R14: 0000000000000007 R15: 0000000000000003 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store