====================================== | [ 756.541850] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 756.544298] nipa-hw-worker: [4/38] Retrying drivers/net:napi_threaded.py | [ 756.703978] kselftest: Running tests in drivers/net [ 989.724624] INFO: task python3:5016 blocked for more than 122 seconds. [ 989.732863] Not tainted 7.0.0-rc5-hvlo-g0a794eac6ce8 #1 [ 989.740105] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.749696] task:python3 state:D stack:25312 pid:5016 tgid:5016 ppid:5015 task_flags:0x400100 flags:0x00080000 [ 989.762904] Call Trace: [ 989.766445] [ 989.769597] __schedule+0xad9/0x1490 [ 989.774414] ? io_schedule_timeout+0x130/0x130 [ 989.780199] ? find_held_lock+0x2b/0x80 [ 989.785308] ? __lock_release.isra.0+0x59/0x170 [ 989.791192] schedule+0xd4/0x260 [ 989.795610] schedule_preempt_disabled+0x18/0x30 [ 989.801592] __mutex_lock+0xd76/0x1f20 [ 989.806596] ? threaded_store+0x132/0x220 [ 989.811896] ? ww_mutex_lock+0x160/0x160 [ 989.817096] ? selinux_inode_free_security+0x310/0x310 [ 989.823667] ? cap_capable+0x1ed/0x3f0 [ 989.828675] ? sysfs_file_ops+0x140/0x140 [ 989.833977] ? threaded_store+0x132/0x220 [ 989.839274] threaded_store+0x132/0x220 [ 989.844379] ? tx_maxrate_store+0x4e0/0x4e0 [ 989.849873] ? sysfs_file_ops+0x140/0x140 [ 989.855172] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.860467] ? sysfs_kf_write+0x65/0x160 [ 989.865670] kernfs_fop_write_iter+0x335/0x510 [ 989.871457] ? kernfs_ops+0xf0/0xf0 [ 989.876169] new_sync_write+0x308/0x6f0 [ 989.881266] ? new_sync_read+0x6f0/0x6f0 [ 989.886467] ? lock_acquire.part.0+0xbc/0x260 [ 989.892155] ? ksys_write+0xff/0x200 [ 989.896968] vfs_write+0x62a/0x980 [ 989.901582] ksys_write+0xff/0x200 [ 989.906195] ? __ia32_sys_read+0xc0/0xc0 [ 989.911395] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.916986] ? rcu_is_watching+0x15/0xd0 [ 989.922185] do_syscall_64+0xf3/0x5e0 [ 989.927094] ? exc_page_fault+0x9e/0xb0 [ 989.932197] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.938668] RIP: 0033:0x7f66638c0c5e [ 989.943476] RSP: 002b:00007ffc4a0b8f90 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.952784] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f66638c0c5e [ 989.961591] RDX: 0000000000000001 RSI: 0000556671d5a110 RDI: 0000000000000007 [ 989.970401] RBP: 00007ffc4a0b8fa0 R08: 0000000000000000 R09: 0000000000000000 [ 989.979211] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f666375be80 [ 989.988018] R13: 0000556671d5a110 R14: 0000000000000007 R15: 00007f6663fc1b98 | [ 990.369727] #2: ff11000121d590f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.381479] #3: ff11000121dd1d00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.391580] | [ 990.394046] =============================================\x0a | [ 1063.453567] kworker/u129:2 (187) used greatest stack depth: 21192 bytes left [ 1112.606227] INFO: task python3:5016 blocked for more than 245 seconds. [ 1112.614377] Not tainted 7.0.0-rc5-hvlo-g0a794eac6ce8 #1 [ 1112.621629] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.631221] task:python3 state:D stack:25312 pid:5016 tgid:5016 ppid:5015 task_flags:0x400100 flags:0x00080000 [ 1112.644429] Call Trace: [ 1112.647970] [ 1112.651120] __schedule+0xad9/0x1490 [ 1112.655938] ? io_schedule_timeout+0x130/0x130 [ 1112.661726] ? find_held_lock+0x2b/0x80 [ 1112.666902] ? __lock_release.isra.0+0x59/0x170 [ 1112.672789] schedule+0xd4/0x260 [ 1112.677208] schedule_preempt_disabled+0x18/0x30 [ 1112.683187] __mutex_lock+0xd76/0x1f20 [ 1112.688193] ? threaded_store+0x132/0x220 [ 1112.693494] ? ww_mutex_lock+0x160/0x160 [ 1112.698692] ? selinux_inode_free_security+0x310/0x310 [ 1112.705265] ? cap_capable+0x1ed/0x3f0 [ 1112.710274] ? sysfs_file_ops+0x140/0x140 [ 1112.715573] ? threaded_store+0x132/0x220 [ 1112.720863] threaded_store+0x132/0x220 [ 1112.725967] ? tx_maxrate_store+0x4e0/0x4e0 [ 1112.731461] ? sysfs_file_ops+0x140/0x140 [ 1112.736759] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.742063] ? sysfs_kf_write+0x65/0x160 [ 1112.747264] kernfs_fop_write_iter+0x335/0x510 [ 1112.753048] ? kernfs_ops+0xf0/0xf0 [ 1112.757759] new_sync_write+0x308/0x6f0 [ 1112.762863] ? new_sync_read+0x6f0/0x6f0 [ 1112.768053] ? lock_acquire.part.0+0xbc/0x260 [ 1112.773742] ? ksys_write+0xff/0x200 [ 1112.778556] vfs_write+0x62a/0x980 [ 1112.783171] ksys_write+0xff/0x200 [ 1112.787775] ? __ia32_sys_read+0xc0/0xc0 [ 1112.792973] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.798562] ? rcu_is_watching+0x15/0xd0 [ 1112.803758] do_syscall_64+0xf3/0x5e0 [ 1112.808666] ? exc_page_fault+0x9e/0xb0 [ 1112.813768] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.820236] RIP: 0033:0x7f66638c0c5e [ 1112.825046] RSP: 002b:00007ffc4a0b8f90 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.834336] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f66638c0c5e [ 1112.843145] RDX: 0000000000000001 RSI: 0000556671d5a110 RDI: 0000000000000007 [ 1112.851955] RBP: 00007ffc4a0b8fa0 R08: 0000000000000000 R09: 0000000000000000 [ 1112.860763] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f666375be80 [ 1112.869572] R13: 0000556671d5a110 R14: 0000000000000007 R15: 00007f6663fc1b98 | [ 1113.240291] #1: ff1100013df36e88 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 1113.251254] #2: ff11000121d590f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.262416] #3: ff11000121dd1d00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.272508] | [ 1113.274973] =============================================\x0a [ 1235.487573] INFO: task python3:5016 blocked for more than 368 seconds. [ 1235.495718] Not tainted 7.0.0-rc5-hvlo-g0a794eac6ce8 #1 [ 1235.502968] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.512555] task:python3 state:D stack:25312 pid:5016 tgid:5016 ppid:5015 task_flags:0x400100 flags:0x00080002 [ 1235.525761] Call Trace: [ 1235.529298] [ 1235.532447] __schedule+0xad9/0x1490 [ 1235.537263] ? io_schedule_timeout+0x130/0x130 [ 1235.543048] ? find_held_lock+0x2b/0x80 [ 1235.548153] ? __lock_release.isra.0+0x59/0x170 [ 1235.554028] schedule+0xd4/0x260 [ 1235.558448] schedule_preempt_disabled+0x18/0x30 [ 1235.564424] __mutex_lock+0xd76/0x1f20 [ 1235.569428] ? threaded_store+0x132/0x220 [ 1235.574726] ? ww_mutex_lock+0x160/0x160 [ 1235.579925] ? selinux_inode_free_security+0x310/0x310 [ 1235.586493] ? cap_capable+0x1ed/0x3f0 [ 1235.591500] ? sysfs_file_ops+0x140/0x140 [ 1235.596798] ? threaded_store+0x132/0x220 [ 1235.602092] threaded_store+0x132/0x220 [ 1235.607197] ? tx_maxrate_store+0x4e0/0x4e0 [ 1235.612692] ? sysfs_file_ops+0x140/0x140 [ 1235.617990] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.623279] ? sysfs_kf_write+0x65/0x160 [ 1235.628470] kernfs_fop_write_iter+0x335/0x510 [ 1235.634247] ? kernfs_ops+0xf0/0xf0 [ 1235.638950] new_sync_write+0x308/0x6f0 [ 1235.644052] ? new_sync_read+0x6f0/0x6f0 [ 1235.649253] ? lock_acquire.part.0+0xbc/0x260 [ 1235.654938] ? ksys_write+0xff/0x200 [ 1235.659749] vfs_write+0x62a/0x980 [ 1235.664364] ksys_write+0xff/0x200 [ 1235.668976] ? __ia32_sys_read+0xc0/0xc0 [ 1235.674178] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.679764] ? rcu_is_watching+0x15/0xd0 [ 1235.684964] do_syscall_64+0xf3/0x5e0 [ 1235.689862] ? exc_page_fault+0x9e/0xb0 [ 1235.694962] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.701428] RIP: 0033:0x7f66638c0c5e [ 1235.706238] RSP: 002b:00007ffc4a0b8f90 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.715525] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f66638c0c5e [ 1235.724333] RDX: 0000000000000001 RSI: 0000556671d5a110 RDI: 0000000000000007 [ 1235.733140] RBP: 00007ffc4a0b8fa0 R08: 0000000000000000 R09: 0000000000000000 [ 1235.741948] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f666375be80 [ 1235.750757] R13: 0000556671d5a110 R14: 0000000000000007 R15: 00007f6663fc1b98 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store