====================================== | [ 761.160048] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 761.162744] nipa-hw-worker: [4/38] Retrying drivers/net:napi_threaded.py | [ 761.325888] kselftest: Running tests in drivers/net [ 989.748101] INFO: task python3:5002 blocked for more than 122 seconds. [ 989.756323] Not tainted 7.0.0-rc4-txcn-g6f46748b781a #1 [ 989.763572] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.773151] task:python3 state:D stack:25312 pid:5002 tgid:5002 ppid:5001 task_flags:0x400100 flags:0x00080000 [ 989.786356] Call Trace: [ 989.789893] [ 989.793043] __schedule+0xad9/0x1490 [ 989.797860] ? io_schedule_timeout+0x130/0x130 [ 989.803642] ? find_held_lock+0x2b/0x80 [ 989.808747] ? __lock_release.isra.0+0x59/0x170 [ 989.814629] schedule+0xd4/0x260 [ 989.819047] schedule_preempt_disabled+0x18/0x30 [ 989.825025] __mutex_lock+0xd76/0x1f20 [ 989.830030] ? threaded_store+0x132/0x220 [ 989.835329] ? ww_mutex_lock+0x160/0x160 [ 989.840531] ? selinux_inode_free_security+0x310/0x310 [ 989.847098] ? cap_capable+0x1ed/0x3f0 [ 989.852093] ? sysfs_file_ops+0x140/0x140 [ 989.857389] ? threaded_store+0x132/0x220 [ 989.862686] threaded_store+0x132/0x220 [ 989.867790] ? tx_maxrate_store+0x4e0/0x4e0 [ 989.873282] ? sysfs_file_ops+0x140/0x140 [ 989.878577] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.883874] ? sysfs_kf_write+0x65/0x160 [ 989.889064] kernfs_fop_write_iter+0x335/0x510 [ 989.894849] ? kernfs_ops+0xf0/0xf0 [ 989.899550] new_sync_write+0x308/0x6f0 [ 989.904652] ? new_sync_read+0x6f0/0x6f0 [ 989.909850] ? lock_acquire.part.0+0xbc/0x260 [ 989.915535] ? ksys_write+0xff/0x200 [ 989.920345] vfs_write+0x62a/0x980 [ 989.924959] ksys_write+0xff/0x200 [ 989.929571] ? __ia32_sys_read+0xc0/0xc0 [ 989.934769] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.940359] ? rcu_is_watching+0x15/0xd0 [ 989.945557] do_syscall_64+0xf3/0x5e0 [ 989.950465] ? irq_exit_rcu+0x39/0xf0 [ 989.955372] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.961840] RIP: 0033:0x7ff060855c5e [ 989.966648] RSP: 002b:00007fff14bee430 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.975946] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007ff060855c5e [ 989.984755] RDX: 0000000000000001 RSI: 000055d997270110 RDI: 0000000000000007 [ 989.993562] RBP: 00007fff14bee440 R08: 0000000000000000 R09: 0000000000000000 [ 990.002369] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ff0606f0e80 [ 990.011176] R13: 000055d997270110 R14: 0000000000000007 R15: 00007ff060f56b98 | [ 990.392528] #2: ff110001203bb0f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.403685] #3: ff110001203a1cb8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.413763] | [ 990.416227] =============================================\x0a | [ 1075.765017] kworker/u129:15 (309) used greatest stack depth: 21192 bytes left [ 1112.629421] INFO: task python3:5002 blocked for more than 245 seconds. [ 1112.637568] Not tainted 7.0.0-rc4-txcn-g6f46748b781a #1 [ 1112.644816] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.654405] task:python3 state:D stack:25312 pid:5002 tgid:5002 ppid:5001 task_flags:0x400100 flags:0x00080000 [ 1112.667611] Call Trace: [ 1112.671149] [ 1112.674297] __schedule+0xad9/0x1490 [ 1112.679110] ? io_schedule_timeout+0x130/0x130 [ 1112.684894] ? find_held_lock+0x2b/0x80 [ 1112.689996] ? __lock_release.isra.0+0x59/0x170 [ 1112.695880] schedule+0xd4/0x260 [ 1112.700300] schedule_preempt_disabled+0x18/0x30 [ 1112.706280] __mutex_lock+0xd76/0x1f20 [ 1112.711274] ? threaded_store+0x132/0x220 [ 1112.716570] ? ww_mutex_lock+0x160/0x160 [ 1112.721770] ? selinux_inode_free_security+0x310/0x310 [ 1112.728339] ? cap_capable+0x1ed/0x3f0 [ 1112.733346] ? sysfs_file_ops+0x140/0x140 [ 1112.738644] ? threaded_store+0x132/0x220 [ 1112.743938] threaded_store+0x132/0x220 [ 1112.749043] ? tx_maxrate_store+0x4e0/0x4e0 [ 1112.754535] ? sysfs_file_ops+0x140/0x140 [ 1112.759833] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.765117] ? sysfs_kf_write+0x65/0x160 [ 1112.770317] kernfs_fop_write_iter+0x335/0x510 [ 1112.776093] ? kernfs_ops+0xf0/0xf0 [ 1112.780801] new_sync_write+0x308/0x6f0 [ 1112.785903] ? new_sync_read+0x6f0/0x6f0 [ 1112.791103] ? lock_acquire.part.0+0xbc/0x260 [ 1112.796789] ? ksys_write+0xff/0x200 [ 1112.801600] vfs_write+0x62a/0x980 [ 1112.806207] ksys_write+0xff/0x200 [ 1112.810821] ? __ia32_sys_read+0xc0/0xc0 [ 1112.816018] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.821605] ? rcu_is_watching+0x15/0xd0 [ 1112.826806] do_syscall_64+0xf3/0x5e0 [ 1112.831711] ? irq_exit_rcu+0x39/0xf0 [ 1112.836619] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.843088] RIP: 0033:0x7ff060855c5e [ 1112.847898] RSP: 002b:00007fff14bee430 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.857194] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007ff060855c5e [ 1112.865992] RDX: 0000000000000001 RSI: 000055d997270110 RDI: 0000000000000007 [ 1112.874797] RBP: 00007fff14bee440 R08: 0000000000000000 R09: 0000000000000000 [ 1112.883605] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ff0606f0e80 [ 1112.892414] R13: 000055d997270110 R14: 0000000000000007 R15: 00007ff060f56b98 | [ 1113.262825] #1: ff110001bd37ac88 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 1113.273787] #2: ff110001203bb0f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.284935] #3: ff110001203a1cb8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.295026] | [ 1113.297490] =============================================\x0a [ 1235.509734] INFO: task python3:5002 blocked for more than 368 seconds. [ 1235.517880] Not tainted 7.0.0-rc4-txcn-g6f46748b781a #1 [ 1235.525130] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.534719] task:python3 state:D stack:25312 pid:5002 tgid:5002 ppid:5001 task_flags:0x400100 flags:0x00080002 [ 1235.547926] Call Trace: [ 1235.551468] [ 1235.554617] __schedule+0xad9/0x1490 [ 1235.559433] ? io_schedule_timeout+0x130/0x130 [ 1235.565217] ? find_held_lock+0x2b/0x80 [ 1235.570324] ? __lock_release.isra.0+0x59/0x170 [ 1235.576209] schedule+0xd4/0x260 [ 1235.580626] schedule_preempt_disabled+0x18/0x30 [ 1235.586607] __mutex_lock+0xd76/0x1f20 [ 1235.591615] ? threaded_store+0x132/0x220 [ 1235.596917] ? ww_mutex_lock+0x160/0x160 [ 1235.602118] ? selinux_inode_free_security+0x310/0x310 [ 1235.608689] ? cap_capable+0x1ed/0x3f0 [ 1235.613699] ? sysfs_file_ops+0x140/0x140 [ 1235.619000] ? threaded_store+0x132/0x220 [ 1235.624296] threaded_store+0x132/0x220 [ 1235.629398] ? tx_maxrate_store+0x4e0/0x4e0 [ 1235.634884] ? sysfs_file_ops+0x140/0x140 [ 1235.640182] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.645477] ? sysfs_kf_write+0x65/0x160 [ 1235.650678] kernfs_fop_write_iter+0x335/0x510 [ 1235.656465] ? kernfs_ops+0xf0/0xf0 [ 1235.661177] new_sync_write+0x308/0x6f0 [ 1235.666280] ? new_sync_read+0x6f0/0x6f0 [ 1235.671480] ? lock_acquire.part.0+0xbc/0x260 [ 1235.677159] ? ksys_write+0xff/0x200 [ 1235.681970] vfs_write+0x62a/0x980 [ 1235.686587] ksys_write+0xff/0x200 [ 1235.691200] ? __ia32_sys_read+0xc0/0xc0 [ 1235.696397] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.701988] ? rcu_is_watching+0x15/0xd0 [ 1235.707194] do_syscall_64+0xf3/0x5e0 [ 1235.712099] ? irq_exit_rcu+0x39/0xf0 [ 1235.717008] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.723476] RIP: 0033:0x7ff060855c5e [ 1235.728287] RSP: 002b:00007fff14bee430 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.737578] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007ff060855c5e [ 1235.746386] RDX: 0000000000000001 RSI: 000055d997270110 RDI: 0000000000000007 [ 1235.755195] RBP: 00007fff14bee440 R08: 0000000000000000 R09: 0000000000000000 [ 1235.763994] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ff0606f0e80 [ 1235.772804] R13: 000055d997270110 R14: 0000000000000007 R15: 00007ff060f56b98 | [ 1236.143298] #1: ff110001bd37ac88 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 1236.154262] #2: ff110001203bb0f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.165421] #3: ff110001203a1cb8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.175514] | [ 1236.177980] =============================================\x0a [ 1358.392038] INFO: task python3:5002 blocked for more than 491 seconds. [ 1358.400182] Not tainted 7.0.0-rc4-txcn-g6f46748b781a #1 [ 1358.407430] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.417016] task:python3 state:D stack:25312 pid:5002 tgid:5002 ppid:5001 task_flags:0x400100 flags:0x00080002 [ 1358.430221] Call Trace: [ 1358.433760] [ 1358.436908] __schedule+0xad9/0x1490 [ 1358.441722] ? io_schedule_timeout+0x130/0x130 [ 1358.447508] ? find_held_lock+0x2b/0x80 [ 1358.452615] ? __lock_release.isra.0+0x59/0x170 [ 1358.458510] schedule+0xd4/0x260 [ 1358.462928] schedule_preempt_disabled+0x18/0x30 [ 1358.468907] __mutex_lock+0xd76/0x1f20 [ 1358.473913] ? threaded_store+0x132/0x220 [ 1358.479211] ? ww_mutex_lock+0x160/0x160 [ 1358.484410] ? selinux_inode_free_security+0x310/0x310 [ 1358.490978] ? cap_capable+0x1ed/0x3f0 [ 1358.495984] ? sysfs_file_ops+0x140/0x140 [ 1358.501283] ? threaded_store+0x132/0x220 [ 1358.506576] threaded_store+0x132/0x220 [ 1358.511677] ? tx_maxrate_store+0x4e0/0x4e0 [ 1358.517168] ? sysfs_file_ops+0x140/0x140 [ 1358.522464] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.527759] ? sysfs_kf_write+0x65/0x160 [ 1358.532959] kernfs_fop_write_iter+0x335/0x510 [ 1358.538745] ? kernfs_ops+0xf0/0xf0 [ 1358.543456] new_sync_write+0x308/0x6f0 [ 1358.548559] ? new_sync_read+0x6f0/0x6f0 [ 1358.553758] ? lock_acquire.part.0+0xbc/0x260 [ 1358.559443] ? ksys_write+0xff/0x200 [ 1358.564254] vfs_write+0x62a/0x980 [ 1358.568858] ksys_write+0xff/0x200 [ 1358.573472] ? __ia32_sys_read+0xc0/0xc0 [ 1358.578668] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.584259] ? rcu_is_watching+0x15/0xd0 [ 1358.589459] do_syscall_64+0xf3/0x5e0 [ 1358.594363] ? irq_exit_rcu+0x39/0xf0 [ 1358.599270] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.605738] RIP: 0033:0x7ff060855c5e [ 1358.610547] RSP: 002b:00007fff14bee430 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.619843] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007ff060855c5e [ 1358.628651] RDX: 0000000000000001 RSI: 000055d997270110 RDI: 0000000000000007 [ 1358.637449] RBP: 00007fff14bee440 R08: 0000000000000000 R09: 0000000000000000 [ 1358.646256] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ff0606f0e80 [ 1358.655062] R13: 000055d997270110 R14: 0000000000000007 R15: 00007ff060f56b98 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store