====================================== | [ 759.062225] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 759.064786] nipa-hw-worker: [4/38] Retrying drivers/net:napi_threaded.py | [ 759.225361] kselftest: Running tests in drivers/net [ 989.746026] INFO: task python3:4966 blocked for more than 122 seconds. [ 989.754254] Not tainted 7.0.0-rc4-gfpd-gb5a55d9e4f05 #1 [ 989.761503] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.771083] task:python3 state:D stack:25312 pid:4966 tgid:4966 ppid:4965 task_flags:0x400100 flags:0x00080000 [ 989.784287] Call Trace: [ 989.787824] [ 989.790975] __schedule+0xad9/0x1490 [ 989.795792] ? io_schedule_timeout+0x130/0x130 [ 989.801574] ? find_held_lock+0x2b/0x80 [ 989.806676] ? __lock_release.isra.0+0x59/0x170 [ 989.812563] schedule+0xd4/0x260 [ 989.816987] schedule_preempt_disabled+0x18/0x30 [ 989.822967] __mutex_lock+0xd76/0x1f20 [ 989.827973] ? threaded_store+0x132/0x220 [ 989.833274] ? ww_mutex_lock+0x160/0x160 [ 989.838473] ? selinux_inode_free_security+0x310/0x310 [ 989.845045] ? cap_capable+0x1ed/0x3f0 [ 989.850049] ? sysfs_file_ops+0x140/0x140 [ 989.855349] ? threaded_store+0x132/0x220 [ 989.860644] threaded_store+0x132/0x220 [ 989.865746] ? tx_maxrate_store+0x4e0/0x4e0 [ 989.871240] ? sysfs_file_ops+0x140/0x140 [ 989.876535] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.881832] ? sysfs_kf_write+0x65/0x160 [ 989.887030] kernfs_fop_write_iter+0x335/0x510 [ 989.892813] ? kernfs_ops+0xf0/0xf0 [ 989.897522] new_sync_write+0x308/0x6f0 [ 989.902625] ? new_sync_read+0x6f0/0x6f0 [ 989.907822] ? lock_acquire.part.0+0xbc/0x260 [ 989.913509] ? ksys_write+0xff/0x200 [ 989.918320] vfs_write+0x62a/0x980 [ 989.922934] ksys_write+0xff/0x200 [ 989.927545] ? __ia32_sys_read+0xc0/0xc0 [ 989.932742] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.938330] ? rcu_is_watching+0x15/0xd0 [ 989.943533] do_syscall_64+0xf3/0x5e0 [ 989.948439] ? exc_page_fault+0x9e/0xb0 [ 989.953542] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.960009] RIP: 0033:0x7f36b7f1dc5e [ 989.964808] RSP: 002b:00007ffe0a76a6e0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.974105] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f36b7f1dc5e [ 989.982913] RDX: 0000000000000001 RSI: 0000563093b37110 RDI: 0000000000000007 [ 989.991721] RBP: 00007ffe0a76a6f0 R08: 0000000000000000 R09: 0000000000000000 [ 990.000518] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f36b7db8e80 [ 990.009324] R13: 0000563093b37110 R14: 0000000000000007 R15: 00007f36b861eb98 | [ 990.390745] #2: ff11000120df10f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.401905] #3: ff11000120e39cb8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.411993] | [ 990.414462] =============================================\x0a | [ 1092.146396] kworker/u129:11 (306) used greatest stack depth: 21192 bytes left [ 1112.626224] INFO: task python3:4966 blocked for more than 245 seconds. [ 1112.634375] Not tainted 7.0.0-rc4-gfpd-gb5a55d9e4f05 #1 [ 1112.641629] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.651223] task:python3 state:D stack:25312 pid:4966 tgid:4966 ppid:4965 task_flags:0x400100 flags:0x00080000 [ 1112.664435] Call Trace: [ 1112.667980] [ 1112.671253] __schedule+0xad9/0x1490 [ 1112.676079] ? io_schedule_timeout+0x130/0x130 [ 1112.681867] ? find_held_lock+0x2b/0x80 [ 1112.686976] ? __lock_release.isra.0+0x59/0x170 [ 1112.692867] schedule+0xd4/0x260 [ 1112.697292] schedule_preempt_disabled+0x18/0x30 [ 1112.703277] __mutex_lock+0xd76/0x1f20 [ 1112.708290] ? threaded_store+0x132/0x220 [ 1112.713595] ? ww_mutex_lock+0x160/0x160 [ 1112.718797] ? selinux_inode_free_security+0x310/0x310 [ 1112.725373] ? cap_capable+0x1ed/0x3f0 [ 1112.730390] ? sysfs_file_ops+0x140/0x140 [ 1112.735693] ? threaded_store+0x132/0x220 [ 1112.740991] threaded_store+0x132/0x220 [ 1112.746095] ? tx_maxrate_store+0x4e0/0x4e0 [ 1112.751590] ? sysfs_file_ops+0x140/0x140 [ 1112.756893] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.762313] ? sysfs_kf_write+0x65/0x160 [ 1112.767520] kernfs_fop_write_iter+0x335/0x510 [ 1112.773308] ? kernfs_ops+0xf0/0xf0 [ 1112.778025] new_sync_write+0x308/0x6f0 [ 1112.783133] ? new_sync_read+0x6f0/0x6f0 [ 1112.788339] ? lock_acquire.part.0+0xbc/0x260 [ 1112.794027] ? ksys_write+0xff/0x200 [ 1112.798847] vfs_write+0x62a/0x980 [ 1112.803464] ksys_write+0xff/0x200 [ 1112.808083] ? __ia32_sys_read+0xc0/0xc0 [ 1112.813286] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.818882] ? rcu_is_watching+0x15/0xd0 [ 1112.824087] do_syscall_64+0xf3/0x5e0 [ 1112.829000] ? exc_page_fault+0x9e/0xb0 [ 1112.834107] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.840764] RIP: 0033:0x7f36b7f1dc5e [ 1112.845578] RSP: 002b:00007ffe0a76a6e0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.854883] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f36b7f1dc5e [ 1112.863697] RDX: 0000000000000001 RSI: 0000563093b37110 RDI: 0000000000000007 [ 1112.872507] RBP: 00007ffe0a76a6f0 R08: 0000000000000000 R09: 0000000000000000 [ 1112.881320] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f36b7db8e80 [ 1112.890132] R13: 0000563093b37110 R14: 0000000000000007 R15: 00007f36b861eb98 | [ 1113.312416] #1: ff1100017aad2088 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 1113.323388] #2: ff11000120df10f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.334554] #3: ff11000120e39cb8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.344654] | [ 1113.347123] =============================================\x0a [ 1235.507405] INFO: task python3:4966 blocked for more than 368 seconds. [ 1235.515553] Not tainted 7.0.0-rc4-gfpd-gb5a55d9e4f05 #1 [ 1235.522802] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.532391] task:python3 state:D stack:25312 pid:4966 tgid:4966 ppid:4965 task_flags:0x400100 flags:0x00080002 [ 1235.545589] Call Trace: [ 1235.549129] [ 1235.552283] __schedule+0xad9/0x1490 [ 1235.557100] ? io_schedule_timeout+0x130/0x130 [ 1235.562886] ? find_held_lock+0x2b/0x80 [ 1235.567992] ? __lock_release.isra.0+0x59/0x170 [ 1235.573877] schedule+0xd4/0x260 [ 1235.578297] schedule_preempt_disabled+0x18/0x30 [ 1235.584278] __mutex_lock+0xd76/0x1f20 [ 1235.589283] ? threaded_store+0x132/0x220 [ 1235.594586] ? ww_mutex_lock+0x160/0x160 [ 1235.599784] ? selinux_inode_free_security+0x310/0x310 [ 1235.606354] ? cap_capable+0x1ed/0x3f0 [ 1235.611361] ? sysfs_file_ops+0x140/0x140 [ 1235.616660] ? threaded_store+0x132/0x220 [ 1235.621949] threaded_store+0x132/0x220 [ 1235.627042] ? tx_maxrate_store+0x4e0/0x4e0 [ 1235.632536] ? sysfs_file_ops+0x140/0x140 [ 1235.637835] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.643131] ? sysfs_kf_write+0x65/0x160 [ 1235.648331] kernfs_fop_write_iter+0x335/0x510 [ 1235.654109] ? kernfs_ops+0xf0/0xf0 [ 1235.658820] new_sync_write+0x308/0x6f0 [ 1235.663918] ? new_sync_read+0x6f0/0x6f0 [ 1235.669120] ? lock_acquire.part.0+0xbc/0x260 [ 1235.674806] ? ksys_write+0xff/0x200 [ 1235.679620] vfs_write+0x62a/0x980 [ 1235.684238] ksys_write+0xff/0x200 [ 1235.688852] ? __ia32_sys_read+0xc0/0xc0 [ 1235.694052] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.699643] ? rcu_is_watching+0x15/0xd0 [ 1235.704848] do_syscall_64+0xf3/0x5e0 [ 1235.709757] ? exc_page_fault+0x9e/0xb0 [ 1235.714863] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.721332] RIP: 0033:0x7f36b7f1dc5e [ 1235.726143] RSP: 002b:00007ffe0a76a6e0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.735442] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f36b7f1dc5e [ 1235.744252] RDX: 0000000000000001 RSI: 0000563093b37110 RDI: 0000000000000007 [ 1235.753060] RBP: 00007ffe0a76a6f0 R08: 0000000000000000 R09: 0000000000000000 [ 1235.761861] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f36b7db8e80 [ 1235.770671] R13: 0000563093b37110 R14: 0000000000000007 R15: 00007f36b861eb98 | [ 1236.141202] #1: ff1100017aad2088 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 1236.152165] #2: ff11000120df10f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.163323] #3: ff11000120e39cb8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.173418] | [ 1236.175886] =============================================\x0a [ 1358.388582] INFO: task python3:4966 blocked for more than 491 seconds. [ 1358.396735] Not tainted 7.0.0-rc4-gfpd-gb5a55d9e4f05 #1 [ 1358.403976] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.413553] task:python3 state:D stack:25312 pid:4966 tgid:4966 ppid:4965 task_flags:0x400100 flags:0x00080002 [ 1358.426759] Call Trace: [ 1358.430295] [ 1358.433443] __schedule+0xad9/0x1490 [ 1358.438261] ? io_schedule_timeout+0x130/0x130 [ 1358.444045] ? find_held_lock+0x2b/0x80 [ 1358.449150] ? __lock_release.isra.0+0x59/0x170 [ 1358.455025] schedule+0xd4/0x260 [ 1358.459435] schedule_preempt_disabled+0x18/0x30 [ 1358.465415] __mutex_lock+0xd76/0x1f20 [ 1358.470426] ? threaded_store+0x132/0x220 [ 1358.475726] ? ww_mutex_lock+0x160/0x160 [ 1358.480923] ? selinux_inode_free_security+0x310/0x310 [ 1358.487483] ? cap_capable+0x1ed/0x3f0 [ 1358.492490] ? sysfs_file_ops+0x140/0x140 [ 1358.497789] ? threaded_store+0x132/0x220 [ 1358.503081] threaded_store+0x132/0x220 [ 1358.508183] ? tx_maxrate_store+0x4e0/0x4e0 [ 1358.513673] ? sysfs_file_ops+0x140/0x140 [ 1358.518967] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.524262] ? sysfs_kf_write+0x65/0x160 [ 1358.529459] kernfs_fop_write_iter+0x335/0x510 [ 1358.535245] ? kernfs_ops+0xf0/0xf0 [ 1358.539955] new_sync_write+0x308/0x6f0 [ 1358.545058] ? new_sync_read+0x6f0/0x6f0 [ 1358.550259] ? lock_acquire.part.0+0xbc/0x260 [ 1358.555945] ? ksys_write+0xff/0x200 [ 1358.560756] vfs_write+0x62a/0x980 [ 1358.565371] ksys_write+0xff/0x200 [ 1358.569973] ? __ia32_sys_read+0xc0/0xc0 [ 1358.575169] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.580756] ? rcu_is_watching+0x15/0xd0 [ 1358.585959] do_syscall_64+0xf3/0x5e0 [ 1358.590864] ? exc_page_fault+0x9e/0xb0 [ 1358.595966] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.602431] RIP: 0033:0x7f36b7f1dc5e [ 1358.607239] RSP: 002b:00007ffe0a76a6e0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.616537] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f36b7f1dc5e [ 1358.625343] RDX: 0000000000000001 RSI: 0000563093b37110 RDI: 0000000000000007 [ 1358.634148] RBP: 00007ffe0a76a6f0 R08: 0000000000000000 R09: 0000000000000000 [ 1358.642954] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f36b7db8e80 [ 1358.651761] R13: 0000563093b37110 R14: 0000000000000007 R15: 00007f36b861eb98 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store