====================================== | [ 789.969865] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 789.972253] nipa-hw-worker: [5/46] Retrying drivers/net:napi_threaded.py | [ 790.119775] kselftest: Running tests in drivers/net | [ 961.016064] kworker/u130:6 (847) used greatest stack depth: 21456 bytes left [ 989.687362] INFO: task python3:5912 blocked for more than 122 seconds. [ 989.695577] Not tainted 7.1.0-rc4-lzvd-g4f4f46a1669e #1 [ 989.703373] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.712961] task:python3 state:D stack:25672 pid:5912 tgid:5912 ppid:5911 task_flags:0x400100 flags:0x00080000 [ 989.726166] Call Trace: [ 989.729703] [ 989.732852] __schedule+0xcc3/0x19c0 [ 989.737668] ? io_schedule_timeout+0x140/0x140 [ 989.743451] ? find_held_lock+0x2b/0x80 [ 989.748556] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.754440] schedule+0xd8/0x260 [ 989.758849] schedule_preempt_disabled+0x18/0x30 [ 989.764829] __mutex_lock+0x6af/0x2010 [ 989.769834] ? threaded_store+0x132/0x220 [ 989.775134] ? ww_mutex_lock+0x160/0x160 [ 989.780332] ? selinux_inode_free_security+0x330/0x330 [ 989.786891] ? cap_capable+0x1d6/0x3e0 [ 989.791898] ? threaded_store+0x132/0x220 [ 989.797198] threaded_store+0x132/0x220 [ 989.802297] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.807598] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.812894] ? sysfs_kf_write+0x65/0x160 [ 989.818093] ? sysfs_file_ops+0x140/0x140 [ 989.823387] kernfs_fop_write_iter+0x335/0x510 [ 989.829172] ? kernfs_ops+0xf0/0xf0 [ 989.833872] new_sync_write+0x333/0x750 [ 989.838974] ? __lock_acquire+0x508/0xc10 [ 989.844269] ? new_sync_read+0x740/0x740 [ 989.849469] ? lock_acquire.part.0+0xbc/0x260 [ 989.855144] ? ksys_write+0x116/0x250 [ 989.860053] vfs_write+0x657/0x9b0 [ 989.864668] ksys_write+0x116/0x250 [ 989.869379] ? __ia32_sys_read+0xc0/0xc0 [ 989.874577] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.880167] ? rcu_is_watching+0x15/0xd0 [ 989.885368] do_syscall_64+0xf3/0x650 [ 989.890273] ? trace_hardirqs_off+0xd/0x30 [ 989.895668] ? exc_page_fault+0xda/0xf0 [ 989.900770] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.907235] RIP: 0033:0x7f396042f22e [ 989.912044] RSP: 002b:00007ffe73164370 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.921342] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f396042f22e [ 989.930147] RDX: 0000000000000001 RSI: 00005629790126b0 RDI: 0000000000000007 [ 989.938952] RBP: 00007ffe73164380 R08: 0000000000000000 R09: 0000000000000000 [ 989.947761] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f39602a7390 [ 989.956570] R13: 00005629790126b0 R14: 0000000000000007 R15: 0000000000000003 | [ 990.360025] #1: ff11000182653880 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 990.370987] #2: ff1100011194eb50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.382142] #3: ff11000122091d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.392229] | [ 990.394693] =============================================\x0a [ 1112.569382] INFO: task python3:5912 blocked for more than 245 seconds. [ 1112.577529] Not tainted 7.1.0-rc4-lzvd-g4f4f46a1669e #1 [ 1112.584781] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.594372] task:python3 state:D stack:25672 pid:5912 tgid:5912 ppid:5911 task_flags:0x400100 flags:0x00080000 [ 1112.607577] Call Trace: [ 1112.611116] [ 1112.614267] __schedule+0xcc3/0x19c0 [ 1112.619082] ? io_schedule_timeout+0x140/0x140 [ 1112.624869] ? find_held_lock+0x2b/0x80 [ 1112.629977] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.635862] schedule+0xd8/0x260 [ 1112.640280] schedule_preempt_disabled+0x18/0x30 [ 1112.646262] __mutex_lock+0x6af/0x2010 [ 1112.651270] ? threaded_store+0x132/0x220 [ 1112.656569] ? ww_mutex_lock+0x160/0x160 [ 1112.661769] ? selinux_inode_free_security+0x330/0x330 [ 1112.668338] ? cap_capable+0x1d6/0x3e0 [ 1112.673348] ? threaded_store+0x132/0x220 [ 1112.678645] threaded_store+0x132/0x220 [ 1112.683750] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.689050] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.694349] ? sysfs_kf_write+0x65/0x160 [ 1112.699552] ? sysfs_file_ops+0x140/0x140 [ 1112.704849] kernfs_fop_write_iter+0x335/0x510 [ 1112.710626] ? kernfs_ops+0xf0/0xf0 [ 1112.715339] new_sync_write+0x333/0x750 [ 1112.720443] ? __lock_acquire+0x508/0xc10 [ 1112.725740] ? new_sync_read+0x740/0x740 [ 1112.730943] ? lock_acquire.part.0+0xbc/0x260 [ 1112.736629] ? ksys_write+0x116/0x250 [ 1112.741542] vfs_write+0x657/0x9b0 [ 1112.746159] ksys_write+0x116/0x250 [ 1112.750871] ? __ia32_sys_read+0xc0/0xc0 [ 1112.756072] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.761662] ? rcu_is_watching+0x15/0xd0 [ 1112.766866] do_syscall_64+0xf3/0x650 [ 1112.771775] ? trace_hardirqs_off+0xd/0x30 [ 1112.777171] ? exc_page_fault+0xda/0xf0 [ 1112.782273] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.788743] RIP: 0033:0x7f396042f22e [ 1112.793554] RSP: 002b:00007ffe73164370 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.802853] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f396042f22e [ 1112.811663] RDX: 0000000000000001 RSI: 00005629790126b0 RDI: 0000000000000007 [ 1112.820472] RBP: 00007ffe73164380 R08: 0000000000000000 R09: 0000000000000000 [ 1112.829283] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f39602a7390 [ 1112.838093] R13: 00005629790126b0 R14: 0000000000000007 R15: 0000000000000003 | [ 1113.213471] #1: ff11000182653880 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1113.224434] #2: ff1100011194eb50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.235592] #3: ff11000122091d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.245675] | [ 1113.248142] =============================================\x0a [ 1235.449438] INFO: task python3:5912 blocked for more than 368 seconds. [ 1235.457587] Not tainted 7.1.0-rc4-lzvd-g4f4f46a1669e #1 [ 1235.464838] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.474427] task:python3 state:D stack:25672 pid:5912 tgid:5912 ppid:5911 task_flags:0x400100 flags:0x00080002 [ 1235.487634] Call Trace: [ 1235.491175] [ 1235.494327] __schedule+0xcc3/0x19c0 [ 1235.499145] ? io_schedule_timeout+0x140/0x140 [ 1235.504932] ? find_held_lock+0x2b/0x80 [ 1235.510038] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.515923] schedule+0xd8/0x260 [ 1235.520341] schedule_preempt_disabled+0x18/0x30 [ 1235.526321] __mutex_lock+0x6af/0x2010 [ 1235.531318] ? threaded_store+0x132/0x220 [ 1235.536617] ? ww_mutex_lock+0x160/0x160 [ 1235.541816] ? selinux_inode_free_security+0x330/0x330 [ 1235.548386] ? cap_capable+0x1d6/0x3e0 [ 1235.553399] ? threaded_store+0x132/0x220 [ 1235.558699] threaded_store+0x132/0x220 [ 1235.563801] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.569099] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.574400] ? sysfs_kf_write+0x65/0x160 [ 1235.579603] ? sysfs_file_ops+0x140/0x140 [ 1235.584899] kernfs_fop_write_iter+0x335/0x510 [ 1235.590682] ? kernfs_ops+0xf0/0xf0 [ 1235.595392] new_sync_write+0x333/0x750 [ 1235.600496] ? __lock_acquire+0x508/0xc10 [ 1235.605791] ? new_sync_read+0x740/0x740 [ 1235.610993] ? lock_acquire.part.0+0xbc/0x260 [ 1235.616679] ? ksys_write+0x116/0x250 [ 1235.621591] vfs_write+0x657/0x9b0 [ 1235.626207] ksys_write+0x116/0x250 [ 1235.630920] ? __ia32_sys_read+0xc0/0xc0 [ 1235.636120] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.641701] ? rcu_is_watching+0x15/0xd0 [ 1235.646906] do_syscall_64+0xf3/0x650 [ 1235.651814] ? trace_hardirqs_off+0xd/0x30 [ 1235.657208] ? exc_page_fault+0xda/0xf0 [ 1235.662309] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.668779] RIP: 0033:0x7f396042f22e [ 1235.673590] RSP: 002b:00007ffe73164370 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.682889] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f396042f22e [ 1235.691698] RDX: 0000000000000001 RSI: 00005629790126b0 RDI: 0000000000000007 [ 1235.700508] RBP: 00007ffe73164380 R08: 0000000000000000 R09: 0000000000000000 [ 1235.709315] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f39602a7390 [ 1235.718126] R13: 00005629790126b0 R14: 0000000000000007 R15: 0000000000000003 | [ 1236.109310] #1: ff11000182653880 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1236.120273] #2: ff1100011194eb50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.131433] #3: ff11000122091d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.141522] | [ 1236.143987] =============================================\x0a [ 1358.330507] INFO: task python3:5912 blocked for more than 491 seconds. [ 1358.338655] Not tainted 7.1.0-rc4-lzvd-g4f4f46a1669e #1 [ 1358.345905] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.355491] task:python3 state:D stack:25672 pid:5912 tgid:5912 ppid:5911 task_flags:0x400100 flags:0x00080002 [ 1358.368698] Call Trace: [ 1358.372235] [ 1358.375387] __schedule+0xcc3/0x19c0 [ 1358.380203] ? io_schedule_timeout+0x140/0x140 [ 1358.385988] ? find_held_lock+0x2b/0x80 [ 1358.391093] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.396980] schedule+0xd8/0x260 [ 1358.401396] schedule_preempt_disabled+0x18/0x30 [ 1358.407375] __mutex_lock+0x6af/0x2010 [ 1358.412377] ? threaded_store+0x132/0x220 [ 1358.417674] ? ww_mutex_lock+0x160/0x160 [ 1358.422872] ? selinux_inode_free_security+0x330/0x330 [ 1358.429440] ? cap_capable+0x1d6/0x3e0 [ 1358.434447] ? threaded_store+0x132/0x220 [ 1358.439743] threaded_store+0x132/0x220 [ 1358.444844] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.450143] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.455441] ? sysfs_kf_write+0x65/0x160 [ 1358.460642] ? sysfs_file_ops+0x140/0x140 [ 1358.465937] kernfs_fop_write_iter+0x335/0x510 [ 1358.471720] ? kernfs_ops+0xf0/0xf0 [ 1358.476429] new_sync_write+0x333/0x750 [ 1358.481534] ? __lock_acquire+0x508/0xc10 [ 1358.486820] ? new_sync_read+0x740/0x740 [ 1358.492020] ? lock_acquire.part.0+0xbc/0x260 [ 1358.497706] ? ksys_write+0x116/0x250 [ 1358.502614] vfs_write+0x657/0x9b0 [ 1358.507226] ksys_write+0x116/0x250 [ 1358.511937] ? __ia32_sys_read+0xc0/0xc0 [ 1358.517133] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.522723] ? rcu_is_watching+0x15/0xd0 [ 1358.527924] do_syscall_64+0xf3/0x650 [ 1358.532821] ? trace_hardirqs_off+0xd/0x30 [ 1358.538216] ? exc_page_fault+0xda/0xf0 [ 1358.543318] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.549785] RIP: 0033:0x7f396042f22e [ 1358.554593] RSP: 002b:00007ffe73164370 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.563892] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f396042f22e [ 1358.572697] RDX: 0000000000000001 RSI: 00005629790126b0 RDI: 0000000000000007 [ 1358.581502] RBP: 00007ffe73164380 R08: 0000000000000000 R09: 0000000000000000 [ 1358.590307] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f39602a7390 [ 1358.599113] R13: 00005629790126b0 R14: 0000000000000007 R15: 0000000000000003 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store