====================================== | [ 765.128631] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 765.131065] nipa-hw-worker: [5/40] Retrying drivers/net:napi_threaded.py | [ 765.296133] kselftest: Running tests in drivers/net | [ 809.522686] kworker/u130:1 (206) used greatest stack depth: 21896 bytes left [ 989.748347] INFO: task python3:5210 blocked for more than 122 seconds. [ 989.756572] Not tainted 7.0.0-rc5-yrfy-gbd020e9f07b9 #1 [ 989.763823] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.773413] task:python3 state:D stack:25312 pid:5210 tgid:5210 ppid:5209 task_flags:0x400100 flags:0x00080000 [ 989.786620] Call Trace: [ 989.790159] [ 989.793311] __schedule+0xad9/0x1490 [ 989.798127] ? io_schedule_timeout+0x130/0x130 [ 989.803913] ? find_held_lock+0x2b/0x80 [ 989.809020] ? __lock_release.isra.0+0x59/0x170 [ 989.814906] schedule+0xd4/0x260 [ 989.819326] schedule_preempt_disabled+0x18/0x30 [ 989.825296] __mutex_lock+0xd76/0x1f20 [ 989.830303] ? threaded_store+0x132/0x220 [ 989.835604] ? ww_mutex_lock+0x160/0x160 [ 989.840806] ? selinux_inode_free_security+0x310/0x310 [ 989.847375] ? cap_capable+0x1ed/0x3f0 [ 989.852381] ? sysfs_file_ops+0x140/0x140 [ 989.857679] ? threaded_store+0x132/0x220 [ 989.862977] threaded_store+0x132/0x220 [ 989.868072] ? tx_maxrate_store+0x4e0/0x4e0 [ 989.873568] ? sysfs_file_ops+0x140/0x140 [ 989.878863] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.884161] ? sysfs_kf_write+0x65/0x160 [ 989.889362] kernfs_fop_write_iter+0x335/0x510 [ 989.895147] ? kernfs_ops+0xf0/0xf0 [ 989.899851] new_sync_write+0x308/0x6f0 [ 989.904947] ? new_sync_read+0x6f0/0x6f0 [ 989.910147] ? lock_acquire.part.0+0xbc/0x260 [ 989.915824] ? ksys_write+0xff/0x200 [ 989.920637] vfs_write+0x62a/0x980 [ 989.925255] ksys_write+0xff/0x200 [ 989.929868] ? __ia32_sys_read+0xc0/0xc0 [ 989.935067] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.940658] ? rcu_is_watching+0x15/0xd0 [ 989.945858] do_syscall_64+0xf3/0x5e0 [ 989.950757] ? exc_page_fault+0x9e/0xb0 [ 989.955858] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.962327] RIP: 0033:0x7f19ce971c5e [ 989.967137] RSP: 002b:00007ffe2c1d7450 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.976433] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f19ce971c5e [ 989.985242] RDX: 0000000000000001 RSI: 000055c819e4c760 RDI: 0000000000000007 [ 989.994050] RBP: 00007ffe2c1d7460 R08: 0000000000000000 R09: 0000000000000000 [ 990.002847] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f19ce80ce80 [ 990.011656] R13: 000055c819e4c760 R14: 0000000000000007 R15: 00007f19cf072b98 | [ 990.382153] #1: ff1100017fceac88 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 990.393117] #2: ff110001211430f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.404277] #3: ff110001211b9d00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.414368] | [ 990.416826] =============================================\x0a [ 1112.630539] INFO: task python3:5210 blocked for more than 245 seconds. [ 1112.638678] Not tainted 7.0.0-rc5-yrfy-gbd020e9f07b9 #1 [ 1112.645927] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.655513] task:python3 state:D stack:25312 pid:5210 tgid:5210 ppid:5209 task_flags:0x400100 flags:0x00080000 [ 1112.668718] Call Trace: [ 1112.672256] [ 1112.675403] __schedule+0xad9/0x1490 [ 1112.680210] ? io_schedule_timeout+0x130/0x130 [ 1112.685995] ? find_held_lock+0x2b/0x80 [ 1112.691101] ? __lock_release.isra.0+0x59/0x170 [ 1112.696985] schedule+0xd4/0x260 [ 1112.701399] schedule_preempt_disabled+0x18/0x30 [ 1112.707379] __mutex_lock+0xd76/0x1f20 [ 1112.712378] ? threaded_store+0x132/0x220 [ 1112.717674] ? ww_mutex_lock+0x160/0x160 [ 1112.722872] ? selinux_inode_free_security+0x310/0x310 [ 1112.729433] ? cap_capable+0x1ed/0x3f0 [ 1112.734439] ? sysfs_file_ops+0x140/0x140 [ 1112.739741] ? threaded_store+0x132/0x220 [ 1112.745036] threaded_store+0x132/0x220 [ 1112.750137] ? tx_maxrate_store+0x4e0/0x4e0 [ 1112.755627] ? sysfs_file_ops+0x140/0x140 [ 1112.760924] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.766219] ? sysfs_kf_write+0x65/0x160 [ 1112.771419] kernfs_fop_write_iter+0x335/0x510 [ 1112.777204] ? kernfs_ops+0xf0/0xf0 [ 1112.781916] new_sync_write+0x308/0x6f0 [ 1112.787019] ? new_sync_read+0x6f0/0x6f0 [ 1112.792220] ? lock_acquire.part.0+0xbc/0x260 [ 1112.797905] ? ksys_write+0xff/0x200 [ 1112.802715] vfs_write+0x62a/0x980 [ 1112.807320] ksys_write+0xff/0x200 [ 1112.811933] ? __ia32_sys_read+0xc0/0xc0 [ 1112.817129] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.822716] ? rcu_is_watching+0x15/0xd0 [ 1112.827917] do_syscall_64+0xf3/0x5e0 [ 1112.832813] ? exc_page_fault+0x9e/0xb0 [ 1112.837914] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.844375] RIP: 0033:0x7f19ce971c5e [ 1112.849185] RSP: 002b:00007ffe2c1d7450 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.858484] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f19ce971c5e [ 1112.867289] RDX: 0000000000000001 RSI: 000055c819e4c760 RDI: 0000000000000007 [ 1112.876097] RBP: 00007ffe2c1d7460 R08: 0000000000000000 R09: 0000000000000000 [ 1112.884896] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f19ce80ce80 [ 1112.893696] R13: 000055c819e4c760 R14: 0000000000000007 R15: 00007f19cf072b98 | [ 1113.264124] #1: ff1100017fceac88 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 1113.275086] #2: ff110001211430f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.286243] #3: ff110001211b9d00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.296323] | [ 1113.298789] =============================================\x0a [ 1235.510731] INFO: task python3:5210 blocked for more than 368 seconds. [ 1235.518881] Not tainted 7.0.0-rc5-yrfy-gbd020e9f07b9 #1 [ 1235.526131] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.535722] task:python3 state:D stack:25312 pid:5210 tgid:5210 ppid:5209 task_flags:0x400100 flags:0x00080002 [ 1235.548930] Call Trace: [ 1235.552471] [ 1235.555624] __schedule+0xad9/0x1490 [ 1235.560442] ? io_schedule_timeout+0x130/0x130 [ 1235.566228] ? find_held_lock+0x2b/0x80 [ 1235.571336] ? __lock_release.isra.0+0x59/0x170 [ 1235.577221] schedule+0xd4/0x260 [ 1235.581642] schedule_preempt_disabled+0x18/0x30 [ 1235.587623] __mutex_lock+0xd76/0x1f20 [ 1235.592629] ? threaded_store+0x132/0x220 [ 1235.597927] ? ww_mutex_lock+0x160/0x160 [ 1235.603127] ? selinux_inode_free_security+0x310/0x310 [ 1235.609700] ? cap_capable+0x1ed/0x3f0 [ 1235.614710] ? sysfs_file_ops+0x140/0x140 [ 1235.620010] ? threaded_store+0x132/0x220 [ 1235.625305] threaded_store+0x132/0x220 [ 1235.630407] ? tx_maxrate_store+0x4e0/0x4e0 [ 1235.635902] ? sysfs_file_ops+0x140/0x140 [ 1235.641199] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.646486] ? sysfs_kf_write+0x65/0x160 [ 1235.651687] kernfs_fop_write_iter+0x335/0x510 [ 1235.657475] ? kernfs_ops+0xf0/0xf0 [ 1235.662188] new_sync_write+0x308/0x6f0 [ 1235.667295] ? new_sync_read+0x6f0/0x6f0 [ 1235.672495] ? lock_acquire.part.0+0xbc/0x260 [ 1235.678172] ? ksys_write+0xff/0x200 [ 1235.682987] vfs_write+0x62a/0x980 [ 1235.687601] ksys_write+0xff/0x200 [ 1235.692215] ? __ia32_sys_read+0xc0/0xc0 [ 1235.697415] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.703007] ? rcu_is_watching+0x15/0xd0 [ 1235.708212] do_syscall_64+0xf3/0x5e0 [ 1235.713120] ? exc_page_fault+0x9e/0xb0 [ 1235.718221] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.724690] RIP: 0033:0x7f19ce971c5e [ 1235.729501] RSP: 002b:00007ffe2c1d7450 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.738801] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f19ce971c5e [ 1235.747610] RDX: 0000000000000001 RSI: 000055c819e4c760 RDI: 0000000000000007 [ 1235.756418] RBP: 00007ffe2c1d7460 R08: 0000000000000000 R09: 0000000000000000 [ 1235.765226] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f19ce80ce80 [ 1235.774026] R13: 000055c819e4c760 R14: 0000000000000007 R15: 00007f19cf072b98 | [ 1236.144515] #1: ff1100017fceac88 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 1236.155480] #2: ff110001211430f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.166640] #3: ff110001211b9d00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.176733] | [ 1236.179199] =============================================\x0a [ 1358.392926] INFO: task python3:5210 blocked for more than 491 seconds. [ 1358.401071] Not tainted 7.0.0-rc5-yrfy-gbd020e9f07b9 #1 [ 1358.408319] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.417909] task:python3 state:D stack:25312 pid:5210 tgid:5210 ppid:5209 task_flags:0x400100 flags:0x00080002 [ 1358.431116] Call Trace: [ 1358.434655] [ 1358.437802] __schedule+0xad9/0x1490 [ 1358.442618] ? io_schedule_timeout+0x130/0x130 [ 1358.448404] ? find_held_lock+0x2b/0x80 [ 1358.453510] ? __lock_release.isra.0+0x59/0x170 [ 1358.459391] schedule+0xd4/0x260 [ 1358.463807] schedule_preempt_disabled+0x18/0x30 [ 1358.469787] __mutex_lock+0xd76/0x1f20 [ 1358.474793] ? threaded_store+0x132/0x220 [ 1358.480094] ? ww_mutex_lock+0x160/0x160 [ 1358.485292] ? selinux_inode_free_security+0x310/0x310 [ 1358.491850] ? cap_capable+0x1ed/0x3f0 [ 1358.496848] ? sysfs_file_ops+0x140/0x140 [ 1358.502146] ? threaded_store+0x132/0x220 [ 1358.507440] threaded_store+0x132/0x220 [ 1358.512545] ? tx_maxrate_store+0x4e0/0x4e0 [ 1358.518037] ? sysfs_file_ops+0x140/0x140 [ 1358.523324] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.528617] ? sysfs_kf_write+0x65/0x160 [ 1358.533818] kernfs_fop_write_iter+0x335/0x510 [ 1358.539603] ? kernfs_ops+0xf0/0xf0 [ 1358.544315] new_sync_write+0x308/0x6f0 [ 1358.549418] ? new_sync_read+0x6f0/0x6f0 [ 1358.554618] ? lock_acquire.part.0+0xbc/0x260 [ 1358.560294] ? ksys_write+0xff/0x200 [ 1358.565105] vfs_write+0x62a/0x980 [ 1358.569718] ksys_write+0xff/0x200 [ 1358.574332] ? __ia32_sys_read+0xc0/0xc0 [ 1358.579527] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.585113] ? rcu_is_watching+0x15/0xd0 [ 1358.590312] do_syscall_64+0xf3/0x5e0 [ 1358.595217] ? exc_page_fault+0x9e/0xb0 [ 1358.600319] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.606775] RIP: 0033:0x7f19ce971c5e [ 1358.611586] RSP: 002b:00007ffe2c1d7450 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.620882] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f19ce971c5e [ 1358.629689] RDX: 0000000000000001 RSI: 000055c819e4c760 RDI: 0000000000000007 [ 1358.638493] RBP: 00007ffe2c1d7460 R08: 0000000000000000 R09: 0000000000000000 [ 1358.647303] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f19ce80ce80 [ 1358.656111] R13: 000055c819e4c760 R14: 0000000000000007 R15: 00007f19cf072b98 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store