====================================== | [ 745.779142] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 745.782300] nipa-hw-worker: [4/36] Retrying drivers/net:napi_threaded.py | [ 745.942690] kselftest: Running tests in drivers/net [ 989.728209] INFO: task python3:4719 blocked for more than 122 seconds. [ 989.736425] Not tainted 7.0.0-rc3-ower-g96e41a3b44f8 #1 [ 989.743677] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.753264] task:python3 state:D stack:25312 pid:4719 tgid:4719 ppid:4718 task_flags:0x400100 flags:0x00080002 [ 989.766469] Call Trace: [ 989.770006] [ 989.773156] __schedule+0xad9/0x1490 [ 989.777970] ? io_schedule_timeout+0x130/0x130 [ 989.783752] ? find_held_lock+0x2b/0x80 [ 989.788856] ? __lock_release.isra.0+0x59/0x170 [ 989.794743] schedule+0xd4/0x260 [ 989.799161] schedule_preempt_disabled+0x18/0x30 [ 989.805138] __mutex_lock+0xd76/0x1f20 [ 989.810143] ? threaded_store+0x132/0x220 [ 989.815443] ? ww_mutex_lock+0x160/0x160 [ 989.820630] ? selinux_inode_free_security+0x310/0x310 [ 989.827200] ? cap_capable+0x1ed/0x3f0 [ 989.832206] ? sysfs_file_ops+0x140/0x140 [ 989.837507] ? threaded_store+0x132/0x220 [ 989.842804] threaded_store+0x132/0x220 [ 989.847895] ? tx_maxrate_store+0x4e0/0x4e0 [ 989.853384] ? sysfs_file_ops+0x140/0x140 [ 989.858680] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.863977] ? sysfs_kf_write+0x65/0x160 [ 989.869175] kernfs_fop_write_iter+0x335/0x510 [ 989.874958] ? kernfs_ops+0xf0/0xf0 [ 989.879670] new_sync_write+0x308/0x6f0 [ 989.884773] ? new_sync_read+0x6f0/0x6f0 [ 989.889973] ? lock_acquire.part.0+0xbc/0x260 [ 989.895657] ? ksys_write+0xff/0x200 [ 989.900470] vfs_write+0x62a/0x980 [ 989.905082] ksys_write+0xff/0x200 [ 989.909697] ? __ia32_sys_read+0xc0/0xc0 [ 989.914885] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.920474] ? rcu_is_watching+0x15/0xd0 [ 989.925674] do_syscall_64+0xf3/0x5e0 [ 989.930581] ? irq_exit_rcu+0x39/0xf0 [ 989.935487] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.941953] RIP: 0033:0x7f1e88ffec5e [ 989.946752] RSP: 002b:00007ffecddcf8f0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.956060] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f1e88ffec5e [ 989.964867] RDX: 0000000000000001 RSI: 000056518126ecd0 RDI: 0000000000000007 [ 989.973672] RBP: 00007ffecddcf900 R08: 0000000000000000 R09: 0000000000000000 [ 989.982478] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f1e88e99e80 [ 989.991285] R13: 000056518126ecd0 R14: 0000000000000007 R15: 00007f1e896ffb98 | [ 990.395108] #1: ff1100017ea40888 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 990.406071] #2: ff11000121c750f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.417225] #3: ff11000121ce1cb8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.427315] | [ 990.429778] =============================================\x0a [ 1112.609385] INFO: task python3:4719 blocked for more than 245 seconds. [ 1112.617535] Not tainted 7.0.0-rc3-ower-g96e41a3b44f8 #1 [ 1112.624784] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.634372] task:python3 state:D stack:25312 pid:4719 tgid:4719 ppid:4718 task_flags:0x400100 flags:0x00080002 [ 1112.647577] Call Trace: [ 1112.651116] [ 1112.654263] __schedule+0xad9/0x1490 [ 1112.659079] ? io_schedule_timeout+0x130/0x130 [ 1112.664865] ? find_held_lock+0x2b/0x80 [ 1112.669969] ? __lock_release.isra.0+0x59/0x170 [ 1112.675853] schedule+0xd4/0x260 [ 1112.680272] schedule_preempt_disabled+0x18/0x30 [ 1112.686251] __mutex_lock+0xd76/0x1f20 [ 1112.691257] ? threaded_store+0x132/0x220 [ 1112.696557] ? ww_mutex_lock+0x160/0x160 [ 1112.701755] ? selinux_inode_free_security+0x310/0x310 [ 1112.708323] ? cap_capable+0x1ed/0x3f0 [ 1112.713329] ? sysfs_file_ops+0x140/0x140 [ 1112.718627] ? threaded_store+0x132/0x220 [ 1112.723922] threaded_store+0x132/0x220 [ 1112.729025] ? tx_maxrate_store+0x4e0/0x4e0 [ 1112.734506] ? sysfs_file_ops+0x140/0x140 [ 1112.739801] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.745095] ? sysfs_kf_write+0x65/0x160 [ 1112.750295] kernfs_fop_write_iter+0x335/0x510 [ 1112.756072] ? kernfs_ops+0xf0/0xf0 [ 1112.760775] new_sync_write+0x308/0x6f0 [ 1112.765867] ? new_sync_read+0x6f0/0x6f0 [ 1112.771067] ? lock_acquire.part.0+0xbc/0x260 [ 1112.776754] ? ksys_write+0xff/0x200 [ 1112.781564] vfs_write+0x62a/0x980 [ 1112.786169] ksys_write+0xff/0x200 [ 1112.790782] ? __ia32_sys_read+0xc0/0xc0 [ 1112.795977] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.801565] ? rcu_is_watching+0x15/0xd0 [ 1112.806766] do_syscall_64+0xf3/0x5e0 [ 1112.811670] ? irq_exit_rcu+0x39/0xf0 [ 1112.816579] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.823043] RIP: 0033:0x7f1e88ffec5e [ 1112.827853] RSP: 002b:00007ffecddcf8f0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.837150] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f1e88ffec5e [ 1112.845958] RDX: 0000000000000001 RSI: 000056518126ecd0 RDI: 0000000000000007 [ 1112.854767] RBP: 00007ffecddcf900 R08: 0000000000000000 R09: 0000000000000000 [ 1112.863576] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f1e88e99e80 [ 1112.872382] R13: 000056518126ecd0 R14: 0000000000000007 R15: 00007f1e896ffb98 | [ 1113.243042] #1: ff1100017ea40888 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 1113.254003] #2: ff11000121c750f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.265150] #3: ff11000121ce1cb8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.275243] | [ 1113.277708] =============================================\x0a [ 1235.490555] INFO: task python3:4719 blocked for more than 368 seconds. [ 1235.498705] Not tainted 7.0.0-rc3-ower-g96e41a3b44f8 #1 [ 1235.505954] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.515543] task:python3 state:D stack:25312 pid:4719 tgid:4719 ppid:4718 task_flags:0x400100 flags:0x00080002 [ 1235.528747] Call Trace: [ 1235.532285] [ 1235.535432] __schedule+0xad9/0x1490 [ 1235.540246] ? io_schedule_timeout+0x130/0x130 [ 1235.546031] ? find_held_lock+0x2b/0x80 [ 1235.551135] ? __lock_release.isra.0+0x59/0x170 [ 1235.557018] schedule+0xd4/0x260 [ 1235.561428] schedule_preempt_disabled+0x18/0x30 [ 1235.567408] __mutex_lock+0xd76/0x1f20 [ 1235.572406] ? threaded_store+0x132/0x220 [ 1235.577707] ? ww_mutex_lock+0x160/0x160 [ 1235.582904] ? selinux_inode_free_security+0x310/0x310 [ 1235.589472] ? cap_capable+0x1ed/0x3f0 [ 1235.594485] ? sysfs_file_ops+0x140/0x140 [ 1235.599789] ? threaded_store+0x132/0x220 [ 1235.605082] threaded_store+0x132/0x220 [ 1235.610183] ? tx_maxrate_store+0x4e0/0x4e0 [ 1235.615673] ? sysfs_file_ops+0x140/0x140 [ 1235.620970] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.626264] ? sysfs_kf_write+0x65/0x160 [ 1235.631464] kernfs_fop_write_iter+0x335/0x510 [ 1235.637248] ? kernfs_ops+0xf0/0xf0 [ 1235.641960] new_sync_write+0x308/0x6f0 [ 1235.647061] ? new_sync_read+0x6f0/0x6f0 [ 1235.652262] ? lock_acquire.part.0+0xbc/0x260 [ 1235.657948] ? ksys_write+0xff/0x200 [ 1235.662757] vfs_write+0x62a/0x980 [ 1235.667370] ksys_write+0xff/0x200 [ 1235.671984] ? __ia32_sys_read+0xc0/0xc0 [ 1235.677179] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.682765] ? rcu_is_watching+0x15/0xd0 [ 1235.687965] do_syscall_64+0xf3/0x5e0 [ 1235.692869] ? irq_exit_rcu+0x39/0xf0 [ 1235.697777] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.704246] RIP: 0033:0x7f1e88ffec5e [ 1235.709055] RSP: 002b:00007ffecddcf8f0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.718351] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f1e88ffec5e [ 1235.727156] RDX: 0000000000000001 RSI: 000056518126ecd0 RDI: 0000000000000007 [ 1235.735963] RBP: 00007ffecddcf900 R08: 0000000000000000 R09: 0000000000000000 [ 1235.744771] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f1e88e99e80 [ 1235.753576] R13: 000056518126ecd0 R14: 0000000000000007 R15: 00007f1e896ffb98 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store