====================================== | [ 759.775133] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 759.777676] nipa-hw-worker: [4/38] Retrying drivers/net:napi_threaded.py | [ 759.939641] kselftest: Running tests in drivers/net [ 989.762241] INFO: task python3:5064 blocked for more than 122 seconds. [ 989.770464] Not tainted 7.0.0-rc5-flmx-g1b317aaa646c #1 [ 989.777714] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.787304] task:python3 state:D stack:25312 pid:5064 tgid:5064 ppid:5063 task_flags:0x400100 flags:0x00080000 [ 989.800513] Call Trace: [ 989.804052] [ 989.807206] __schedule+0xad9/0x1490 [ 989.812023] ? io_schedule_timeout+0x130/0x130 [ 989.817810] ? find_held_lock+0x2b/0x80 [ 989.822918] ? __lock_release.isra.0+0x59/0x170 [ 989.828806] schedule+0xd4/0x260 [ 989.833226] schedule_preempt_disabled+0x18/0x30 [ 989.839197] __mutex_lock+0xd76/0x1f20 [ 989.844196] ? threaded_store+0x132/0x220 [ 989.849498] ? ww_mutex_lock+0x160/0x160 [ 989.854697] ? selinux_inode_free_security+0x310/0x310 [ 989.861270] ? cap_capable+0x1ed/0x3f0 [ 989.866281] ? sysfs_file_ops+0x140/0x140 [ 989.871583] ? threaded_store+0x132/0x220 [ 989.876882] threaded_store+0x132/0x220 [ 989.881983] ? tx_maxrate_store+0x4e0/0x4e0 [ 989.887476] ? sysfs_file_ops+0x140/0x140 [ 989.892773] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.898073] ? sysfs_kf_write+0x65/0x160 [ 989.903273] kernfs_fop_write_iter+0x335/0x510 [ 989.909058] ? kernfs_ops+0xf0/0xf0 [ 989.913775] new_sync_write+0x308/0x6f0 [ 989.918881] ? new_sync_read+0x6f0/0x6f0 [ 989.924085] ? lock_acquire.part.0+0xbc/0x260 [ 989.929770] ? ksys_write+0xff/0x200 [ 989.934584] vfs_write+0x62a/0x980 [ 989.939197] ksys_write+0xff/0x200 [ 989.943813] ? __ia32_sys_read+0xc0/0xc0 [ 989.949012] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.954603] ? rcu_is_watching+0x15/0xd0 [ 989.959806] do_syscall_64+0xf3/0x5e0 [ 989.964713] ? exc_page_fault+0x9e/0xb0 [ 989.969817] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.976285] RIP: 0033:0x7f97ddd5fc5e [ 989.981093] RSP: 002b:00007ffcac254220 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.990391] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f97ddd5fc5e [ 989.999190] RDX: 0000000000000001 RSI: 000055f1b94ce110 RDI: 0000000000000007 [ 990.007990] RBP: 00007ffcac254230 R08: 0000000000000000 R09: 0000000000000000 [ 990.016796] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f97ddbfae80 [ 990.025604] R13: 000055f1b94ce110 R14: 0000000000000007 R15: 00007f97de460b98 | [ 990.413262] #2: ff11000120ad10f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.424423] #3: ff11000120aa9d00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.434514] | [ 990.436970] =============================================\x0a | [ 1051.203829] kworker/u130:2 (455) used greatest stack depth: 21192 bytes left [ 1112.643513] INFO: task python3:5064 blocked for more than 245 seconds. [ 1112.651668] Not tainted 7.0.0-rc5-flmx-g1b317aaa646c #1 [ 1112.658918] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.668506] task:python3 state:D stack:25312 pid:5064 tgid:5064 ppid:5063 task_flags:0x400100 flags:0x00080000 [ 1112.681713] Call Trace: [ 1112.685255] [ 1112.688406] __schedule+0xad9/0x1490 [ 1112.693225] ? io_schedule_timeout+0x130/0x130 [ 1112.699010] ? find_held_lock+0x2b/0x80 [ 1112.704118] ? __lock_release.isra.0+0x59/0x170 [ 1112.710006] schedule+0xd4/0x260 [ 1112.714427] schedule_preempt_disabled+0x18/0x30 [ 1112.720408] __mutex_lock+0xd76/0x1f20 [ 1112.725412] ? threaded_store+0x132/0x220 [ 1112.730713] ? ww_mutex_lock+0x160/0x160 [ 1112.735912] ? selinux_inode_free_security+0x310/0x310 [ 1112.742483] ? cap_capable+0x1ed/0x3f0 [ 1112.747491] ? sysfs_file_ops+0x140/0x140 [ 1112.752791] ? threaded_store+0x132/0x220 [ 1112.758088] threaded_store+0x132/0x220 [ 1112.763194] ? tx_maxrate_store+0x4e0/0x4e0 [ 1112.768686] ? sysfs_file_ops+0x140/0x140 [ 1112.773974] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.779271] ? sysfs_kf_write+0x65/0x160 [ 1112.784472] kernfs_fop_write_iter+0x335/0x510 [ 1112.790260] ? kernfs_ops+0xf0/0xf0 [ 1112.794973] new_sync_write+0x308/0x6f0 [ 1112.800078] ? new_sync_read+0x6f0/0x6f0 [ 1112.805270] ? lock_acquire.part.0+0xbc/0x260 [ 1112.810957] ? ksys_write+0xff/0x200 [ 1112.815768] vfs_write+0x62a/0x980 [ 1112.820385] ksys_write+0xff/0x200 [ 1112.824999] ? __ia32_sys_read+0xc0/0xc0 [ 1112.830195] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.835787] ? rcu_is_watching+0x15/0xd0 [ 1112.840989] do_syscall_64+0xf3/0x5e0 [ 1112.845894] ? exc_page_fault+0x9e/0xb0 [ 1112.850997] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.857468] RIP: 0033:0x7f97ddd5fc5e [ 1112.862277] RSP: 002b:00007ffcac254220 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.871577] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f97ddd5fc5e [ 1112.880384] RDX: 0000000000000001 RSI: 000055f1b94ce110 RDI: 0000000000000007 [ 1112.889191] RBP: 00007ffcac254230 R08: 0000000000000000 R09: 0000000000000000 [ 1112.897999] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f97ddbfae80 [ 1112.906809] R13: 000055f1b94ce110 R14: 0000000000000007 R15: 00007f97de460b98 | [ 1113.317790] #1: ff110001bb820288 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 1113.328744] #2: ff11000120ad10f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.339900] #3: ff11000120aa9d00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.349991] | [ 1113.352458] =============================================\x0a [ 1235.525769] INFO: task python3:5064 blocked for more than 368 seconds. [ 1235.533918] Not tainted 7.0.0-rc5-flmx-g1b317aaa646c #1 [ 1235.541169] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.550757] task:python3 state:D stack:25312 pid:5064 tgid:5064 ppid:5063 task_flags:0x400100 flags:0x00080002 [ 1235.563953] Call Trace: [ 1235.567495] [ 1235.570646] __schedule+0xad9/0x1490 [ 1235.575466] ? io_schedule_timeout+0x130/0x130 [ 1235.581252] ? find_held_lock+0x2b/0x80 [ 1235.586358] ? __lock_release.isra.0+0x59/0x170 [ 1235.592244] schedule+0xd4/0x260 [ 1235.596662] schedule_preempt_disabled+0x18/0x30 [ 1235.602641] __mutex_lock+0xd76/0x1f20 [ 1235.607645] ? threaded_store+0x132/0x220 [ 1235.612944] ? ww_mutex_lock+0x160/0x160 [ 1235.618144] ? selinux_inode_free_security+0x310/0x310 [ 1235.624715] ? cap_capable+0x1ed/0x3f0 [ 1235.629725] ? sysfs_file_ops+0x140/0x140 [ 1235.635026] ? threaded_store+0x132/0x220 [ 1235.640322] threaded_store+0x132/0x220 [ 1235.645428] ? tx_maxrate_store+0x4e0/0x4e0 [ 1235.650921] ? sysfs_file_ops+0x140/0x140 [ 1235.656221] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.661518] ? sysfs_kf_write+0x65/0x160 [ 1235.666719] kernfs_fop_write_iter+0x335/0x510 [ 1235.672505] ? kernfs_ops+0xf0/0xf0 [ 1235.677218] new_sync_write+0x308/0x6f0 [ 1235.682323] ? new_sync_read+0x6f0/0x6f0 [ 1235.687525] ? lock_acquire.part.0+0xbc/0x260 [ 1235.693212] ? ksys_write+0xff/0x200 [ 1235.698014] vfs_write+0x62a/0x980 [ 1235.702630] ksys_write+0xff/0x200 [ 1235.707244] ? __ia32_sys_read+0xc0/0xc0 [ 1235.712445] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.718038] ? rcu_is_watching+0x15/0xd0 [ 1235.723239] do_syscall_64+0xf3/0x5e0 [ 1235.728145] ? exc_page_fault+0x9e/0xb0 [ 1235.733247] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.739718] RIP: 0033:0x7f97ddd5fc5e [ 1235.744529] RSP: 002b:00007ffcac254220 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.753827] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f97ddd5fc5e [ 1235.762637] RDX: 0000000000000001 RSI: 000055f1b94ce110 RDI: 0000000000000007 [ 1235.771443] RBP: 00007ffcac254230 R08: 0000000000000000 R09: 0000000000000000 [ 1235.780252] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f97ddbfae80 [ 1235.789062] R13: 000055f1b94ce110 R14: 0000000000000007 R15: 00007f97de460b98 | [ 1236.186372] #1: ff110001bb820288 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 1236.197335] #2: ff11000120ad10f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.208493] #3: ff11000120aa9d00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.218583] | [ 1236.221051] =============================================\x0a [ 1358.407107] INFO: task python3:5064 blocked for more than 491 seconds. [ 1358.415257] Not tainted 7.0.0-rc5-flmx-g1b317aaa646c #1 [ 1358.422507] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.432099] task:python3 state:D stack:25312 pid:5064 tgid:5064 ppid:5063 task_flags:0x400100 flags:0x00080002 [ 1358.445306] Call Trace: [ 1358.448847] [ 1358.451998] __schedule+0xad9/0x1490 [ 1358.456814] ? io_schedule_timeout+0x130/0x130 [ 1358.462603] ? find_held_lock+0x2b/0x80 [ 1358.467711] ? __lock_release.isra.0+0x59/0x170 [ 1358.473595] schedule+0xd4/0x260 [ 1358.478011] schedule_preempt_disabled+0x18/0x30 [ 1358.483988] __mutex_lock+0xd76/0x1f20 [ 1358.488992] ? threaded_store+0x132/0x220 [ 1358.494290] ? ww_mutex_lock+0x160/0x160 [ 1358.499489] ? selinux_inode_free_security+0x310/0x310 [ 1358.506059] ? cap_capable+0x1ed/0x3f0 [ 1358.511067] ? sysfs_file_ops+0x140/0x140 [ 1358.516366] ? threaded_store+0x132/0x220 [ 1358.521659] threaded_store+0x132/0x220 [ 1358.526763] ? tx_maxrate_store+0x4e0/0x4e0 [ 1358.532256] ? sysfs_file_ops+0x140/0x140 [ 1358.537542] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.542837] ? sysfs_kf_write+0x65/0x160 [ 1358.548037] kernfs_fop_write_iter+0x335/0x510 [ 1358.553824] ? kernfs_ops+0xf0/0xf0 [ 1358.558533] new_sync_write+0x308/0x6f0 [ 1358.563635] ? new_sync_read+0x6f0/0x6f0 [ 1358.568835] ? lock_acquire.part.0+0xbc/0x260 [ 1358.574512] ? ksys_write+0xff/0x200 [ 1358.579323] vfs_write+0x62a/0x980 [ 1358.583942] ksys_write+0xff/0x200 [ 1358.588556] ? __ia32_sys_read+0xc0/0xc0 [ 1358.593752] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.599340] ? rcu_is_watching+0x15/0xd0 [ 1358.604541] do_syscall_64+0xf3/0x5e0 [ 1358.609447] ? exc_page_fault+0x9e/0xb0 [ 1358.614549] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.621016] RIP: 0033:0x7f97ddd5fc5e [ 1358.625818] RSP: 002b:00007ffcac254220 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.635116] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f97ddd5fc5e [ 1358.643922] RDX: 0000000000000001 RSI: 000055f1b94ce110 RDI: 0000000000000007 [ 1358.652732] RBP: 00007ffcac254230 R08: 0000000000000000 R09: 0000000000000000 [ 1358.661541] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f97ddbfae80 [ 1358.670347] R13: 000055f1b94ce110 R14: 0000000000000007 R15: 00007f97de460b98 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store