====================================== | [ 760.117711] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 760.120299] nipa-hw-worker: [4/38] Retrying drivers/net:napi_threaded.py | [ 760.261105] kselftest: Running tests in drivers/net [ 989.740773] INFO: task python3:5012 blocked for more than 122 seconds. [ 989.748984] Not tainted 7.0.0-rc4-hant-g28baa674bb94 #1 [ 989.756235] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.765824] task:python3 state:D stack:25312 pid:5012 tgid:5012 ppid:5011 task_flags:0x400100 flags:0x00080000 [ 989.779029] Call Trace: [ 989.782567] [ 989.785718] __schedule+0xad9/0x1490 [ 989.790534] ? io_schedule_timeout+0x130/0x130 [ 989.796319] ? find_held_lock+0x2b/0x80 [ 989.801423] ? __lock_release.isra.0+0x59/0x170 [ 989.807310] schedule+0xd4/0x260 [ 989.811728] schedule_preempt_disabled+0x18/0x30 [ 989.817707] __mutex_lock+0xd76/0x1f20 [ 989.822713] ? threaded_store+0x132/0x220 [ 989.828014] ? ww_mutex_lock+0x160/0x160 [ 989.833211] ? selinux_inode_free_security+0x310/0x310 [ 989.839778] ? cap_capable+0x1ed/0x3f0 [ 989.844784] ? sysfs_file_ops+0x140/0x140 [ 989.850082] ? threaded_store+0x132/0x220 [ 989.855378] threaded_store+0x132/0x220 [ 989.860479] ? tx_maxrate_store+0x4e0/0x4e0 [ 989.865974] ? sysfs_file_ops+0x140/0x140 [ 989.871272] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.876565] ? sysfs_kf_write+0x65/0x160 [ 989.881765] kernfs_fop_write_iter+0x335/0x510 [ 989.887540] ? kernfs_ops+0xf0/0xf0 [ 989.892251] new_sync_write+0x308/0x6f0 [ 989.897354] ? new_sync_read+0x6f0/0x6f0 [ 989.902544] ? lock_acquire.part.0+0xbc/0x260 [ 989.908228] ? ksys_write+0xff/0x200 [ 989.913039] vfs_write+0x62a/0x980 [ 989.917642] ksys_write+0xff/0x200 [ 989.922255] ? __ia32_sys_read+0xc0/0xc0 [ 989.927453] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.933044] ? rcu_is_watching+0x15/0xd0 [ 989.938243] do_syscall_64+0xf3/0x5e0 [ 989.943151] ? exc_page_fault+0x9e/0xb0 [ 989.948251] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.954717] RIP: 0033:0x7f5f3e0e4c5e [ 989.959525] RSP: 002b:00007ffe32212420 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.968822] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f5f3e0e4c5e [ 989.977623] RDX: 0000000000000001 RSI: 000055b012334110 RDI: 0000000000000007 [ 989.986431] RBP: 00007ffe32212430 R08: 0000000000000000 R09: 0000000000000000 [ 989.995239] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f5f3df7fe80 [ 990.004038] R13: 000055b012334110 R14: 0000000000000007 R15: 00007f5f3e7e5b98 | [ 990.374447] #1: ff1100017d4c0888 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 990.385398] #2: ff1100012112f0f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.396558] #3: ff11000121191cb8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.406645] | [ 990.409109] =============================================\x0a [ 1112.620986] INFO: task python3:5012 blocked for more than 245 seconds. [ 1112.629132] Not tainted 7.0.0-rc4-hant-g28baa674bb94 #1 [ 1112.636382] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.645971] task:python3 state:D stack:25312 pid:5012 tgid:5012 ppid:5011 task_flags:0x400100 flags:0x00080000 [ 1112.659168] Call Trace: [ 1112.662710] [ 1112.665859] __schedule+0xad9/0x1490 [ 1112.670674] ? io_schedule_timeout+0x130/0x130 [ 1112.676462] ? find_held_lock+0x2b/0x80 [ 1112.681565] ? __lock_release.isra.0+0x59/0x170 [ 1112.687451] schedule+0xd4/0x260 [ 1112.691869] schedule_preempt_disabled+0x18/0x30 [ 1112.697847] __mutex_lock+0xd76/0x1f20 [ 1112.702853] ? threaded_store+0x132/0x220 [ 1112.708153] ? ww_mutex_lock+0x160/0x160 [ 1112.713353] ? selinux_inode_free_security+0x310/0x310 [ 1112.719923] ? cap_capable+0x1ed/0x3f0 [ 1112.724933] ? sysfs_file_ops+0x140/0x140 [ 1112.730234] ? threaded_store+0x132/0x220 [ 1112.735530] threaded_store+0x132/0x220 [ 1112.740633] ? tx_maxrate_store+0x4e0/0x4e0 [ 1112.746128] ? sysfs_file_ops+0x140/0x140 [ 1112.751428] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.756725] ? sysfs_kf_write+0x65/0x160 [ 1112.761927] kernfs_fop_write_iter+0x335/0x510 [ 1112.767714] ? kernfs_ops+0xf0/0xf0 [ 1112.772428] new_sync_write+0x308/0x6f0 [ 1112.777531] ? new_sync_read+0x6f0/0x6f0 [ 1112.782733] ? lock_acquire.part.0+0xbc/0x260 [ 1112.788419] ? ksys_write+0xff/0x200 [ 1112.793230] vfs_write+0x62a/0x980 [ 1112.797846] ksys_write+0xff/0x200 [ 1112.802461] ? __ia32_sys_read+0xc0/0xc0 [ 1112.807658] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.813251] ? rcu_is_watching+0x15/0xd0 [ 1112.818452] do_syscall_64+0xf3/0x5e0 [ 1112.823361] ? exc_page_fault+0x9e/0xb0 [ 1112.828465] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.834935] RIP: 0033:0x7f5f3e0e4c5e [ 1112.839747] RSP: 002b:00007ffe32212420 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.849046] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f5f3e0e4c5e [ 1112.857857] RDX: 0000000000000001 RSI: 000055b012334110 RDI: 0000000000000007 [ 1112.866668] RBP: 00007ffe32212430 R08: 0000000000000000 R09: 0000000000000000 [ 1112.875477] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f5f3df7fe80 [ 1112.884286] R13: 000055b012334110 R14: 0000000000000007 R15: 00007f5f3e7e5b98 | [ 1113.254858] #1: ff1100017d4c0888 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 1113.265828] #2: ff1100012112f0f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.276979] #3: ff11000121191cb8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.287072] | [ 1113.289537] =============================================\x0a [ 1235.503209] INFO: task python3:5012 blocked for more than 368 seconds. [ 1235.511358] Not tainted 7.0.0-rc4-hant-g28baa674bb94 #1 [ 1235.518607] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.528200] task:python3 state:D stack:25312 pid:5012 tgid:5012 ppid:5011 task_flags:0x400100 flags:0x00080002 [ 1235.541406] Call Trace: [ 1235.544947] [ 1235.548096] __schedule+0xad9/0x1490 [ 1235.552912] ? io_schedule_timeout+0x130/0x130 [ 1235.558700] ? find_held_lock+0x2b/0x80 [ 1235.563808] ? __lock_release.isra.0+0x59/0x170 [ 1235.569693] schedule+0xd4/0x260 [ 1235.574112] schedule_preempt_disabled+0x18/0x30 [ 1235.580090] __mutex_lock+0xd76/0x1f20 [ 1235.585094] ? threaded_store+0x132/0x220 [ 1235.590394] ? ww_mutex_lock+0x160/0x160 [ 1235.595594] ? selinux_inode_free_security+0x310/0x310 [ 1235.602164] ? cap_capable+0x1ed/0x3f0 [ 1235.607173] ? sysfs_file_ops+0x140/0x140 [ 1235.612474] ? threaded_store+0x132/0x220 [ 1235.617771] threaded_store+0x132/0x220 [ 1235.622876] ? tx_maxrate_store+0x4e0/0x4e0 [ 1235.628369] ? sysfs_file_ops+0x140/0x140 [ 1235.633665] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.638961] ? sysfs_kf_write+0x65/0x160 [ 1235.644162] kernfs_fop_write_iter+0x335/0x510 [ 1235.649947] ? kernfs_ops+0xf0/0xf0 [ 1235.654661] new_sync_write+0x308/0x6f0 [ 1235.659764] ? new_sync_read+0x6f0/0x6f0 [ 1235.664957] ? lock_acquire.part.0+0xbc/0x260 [ 1235.670647] ? ksys_write+0xff/0x200 [ 1235.675460] vfs_write+0x62a/0x980 [ 1235.680075] ksys_write+0xff/0x200 [ 1235.684680] ? __ia32_sys_read+0xc0/0xc0 [ 1235.689877] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.695469] ? rcu_is_watching+0x15/0xd0 [ 1235.700671] do_syscall_64+0xf3/0x5e0 [ 1235.705576] ? exc_page_fault+0x9e/0xb0 [ 1235.710680] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.717151] RIP: 0033:0x7f5f3e0e4c5e [ 1235.721962] RSP: 002b:00007ffe32212420 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.731260] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f5f3e0e4c5e [ 1235.740068] RDX: 0000000000000001 RSI: 000055b012334110 RDI: 0000000000000007 [ 1235.748874] RBP: 00007ffe32212430 R08: 0000000000000000 R09: 0000000000000000 [ 1235.757684] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f5f3df7fe80 [ 1235.766494] R13: 000055b012334110 R14: 0000000000000007 R15: 00007f5f3e7e5b98 | [ 1236.137038] #1: ff1100017d4c0888 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 1236.148002] #2: ff1100012112f0f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.159159] #3: ff11000121191cb8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.169245] | [ 1236.171711] =============================================\x0a [ 1358.384434] INFO: task python3:5012 blocked for more than 491 seconds. [ 1358.392583] Not tainted 7.0.0-rc4-hant-g28baa674bb94 #1 [ 1358.399833] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.409420] task:python3 state:D stack:25312 pid:5012 tgid:5012 ppid:5011 task_flags:0x400100 flags:0x00080002 [ 1358.422623] Call Trace: [ 1358.426163] [ 1358.429312] __schedule+0xad9/0x1490 [ 1358.434125] ? io_schedule_timeout+0x130/0x130 [ 1358.439910] ? find_held_lock+0x2b/0x80 [ 1358.445014] ? __lock_release.isra.0+0x59/0x170 [ 1358.450909] schedule+0xd4/0x260 [ 1358.455328] schedule_preempt_disabled+0x18/0x30 [ 1358.461304] __mutex_lock+0xd76/0x1f20 [ 1358.466307] ? threaded_store+0x132/0x220 [ 1358.471596] ? ww_mutex_lock+0x160/0x160 [ 1358.476795] ? selinux_inode_free_security+0x310/0x310 [ 1358.483363] ? cap_capable+0x1ed/0x3f0 [ 1358.488371] ? sysfs_file_ops+0x140/0x140 [ 1358.493667] ? threaded_store+0x132/0x220 [ 1358.498962] threaded_store+0x132/0x220 [ 1358.504064] ? tx_maxrate_store+0x4e0/0x4e0 [ 1358.509546] ? sysfs_file_ops+0x140/0x140 [ 1358.514839] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.520135] ? sysfs_kf_write+0x65/0x160 [ 1358.525332] kernfs_fop_write_iter+0x335/0x510 [ 1358.531114] ? kernfs_ops+0xf0/0xf0 [ 1358.535823] new_sync_write+0x308/0x6f0 [ 1358.540926] ? new_sync_read+0x6f0/0x6f0 [ 1358.546119] ? lock_acquire.part.0+0xbc/0x260 [ 1358.551804] ? ksys_write+0xff/0x200 [ 1358.556618] vfs_write+0x62a/0x980 [ 1358.561233] ksys_write+0xff/0x200 [ 1358.565838] ? __ia32_sys_read+0xc0/0xc0 [ 1358.571037] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.576625] ? rcu_is_watching+0x15/0xd0 [ 1358.581825] do_syscall_64+0xf3/0x5e0 [ 1358.586722] ? exc_page_fault+0x9e/0xb0 [ 1358.591821] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.598288] RIP: 0033:0x7f5f3e0e4c5e [ 1358.603097] RSP: 002b:00007ffe32212420 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.612392] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f5f3e0e4c5e [ 1358.621197] RDX: 0000000000000001 RSI: 000055b012334110 RDI: 0000000000000007 [ 1358.630002] RBP: 00007ffe32212430 R08: 0000000000000000 R09: 0000000000000000 [ 1358.638807] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f5f3df7fe80 [ 1358.647614] R13: 000055b012334110 R14: 0000000000000007 R15: 00007f5f3e7e5b98 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store