====================================== | [ 758.480144] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 758.482638] nipa-hw-worker: [4/37] Retrying drivers/net:napi_threaded.py | [ 758.649223] kselftest: Running tests in drivers/net [ 989.734958] INFO: task python3:5009 blocked for more than 122 seconds. [ 989.743187] Not tainted 7.0.0-rc4-bztq-gf7131a6ab2b5 #1 [ 989.750439] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.760029] task:python3 state:D stack:25312 pid:5009 tgid:5009 ppid:5008 task_flags:0x400100 flags:0x00080000 [ 989.773237] Call Trace: [ 989.776781] [ 989.779934] __schedule+0xad9/0x1490 [ 989.784751] ? io_schedule_timeout+0x130/0x130 [ 989.790536] ? find_held_lock+0x2b/0x80 [ 989.795641] ? __lock_release.isra.0+0x59/0x170 [ 989.801520] schedule+0xd4/0x260 [ 989.805939] schedule_preempt_disabled+0x18/0x30 [ 989.811919] __mutex_lock+0xd76/0x1f20 [ 989.816917] ? threaded_store+0x132/0x220 [ 989.822219] ? ww_mutex_lock+0x160/0x160 [ 989.827416] ? selinux_inode_free_security+0x310/0x310 [ 989.833988] ? cap_capable+0x1ed/0x3f0 [ 989.839001] ? sysfs_file_ops+0x140/0x140 [ 989.844308] ? threaded_store+0x132/0x220 [ 989.849607] threaded_store+0x132/0x220 [ 989.854708] ? tx_maxrate_store+0x4e0/0x4e0 [ 989.860200] ? sysfs_file_ops+0x140/0x140 [ 989.865489] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.870783] ? sysfs_kf_write+0x65/0x160 [ 989.875984] kernfs_fop_write_iter+0x335/0x510 [ 989.881771] ? kernfs_ops+0xf0/0xf0 [ 989.886488] new_sync_write+0x308/0x6f0 [ 989.891593] ? new_sync_read+0x6f0/0x6f0 [ 989.896797] ? lock_acquire.part.0+0xbc/0x260 [ 989.902482] ? ksys_write+0xff/0x200 [ 989.907295] vfs_write+0x62a/0x980 [ 989.911912] ksys_write+0xff/0x200 [ 989.916530] ? __ia32_sys_read+0xc0/0xc0 [ 989.921728] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.927319] ? rcu_is_watching+0x15/0xd0 [ 989.932523] do_syscall_64+0xf3/0x5e0 [ 989.937431] ? exc_page_fault+0x9e/0xb0 [ 989.942536] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.949005] RIP: 0033:0x7f72d2525c5e [ 989.953814] RSP: 002b:00007ffc38bf55b0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.963111] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f72d2525c5e [ 989.971918] RDX: 0000000000000001 RSI: 0000558eccb4c110 RDI: 0000000000000007 [ 989.980727] RBP: 00007ffc38bf55c0 R08: 0000000000000000 R09: 0000000000000000 [ 989.989534] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f72d23c0e80 [ 989.998342] R13: 0000558eccb4c110 R14: 0000000000000007 R15: 00007f72d2c26b98 | [ 990.405909] #2: ff110001110290f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.417063] #3: ff11000111731cb8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.427151] | [ 990.429617] =============================================\x0a | [ 993.830941] kworker/u129:11 (304) used greatest stack depth: 21688 bytes left [ 1112.615097] INFO: task python3:5009 blocked for more than 245 seconds. [ 1112.623248] Not tainted 7.0.0-rc4-bztq-gf7131a6ab2b5 #1 [ 1112.630496] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.640074] task:python3 state:D stack:25312 pid:5009 tgid:5009 ppid:5008 task_flags:0x400100 flags:0x00080000 [ 1112.653280] Call Trace: [ 1112.656820] [ 1112.659967] __schedule+0xad9/0x1490 [ 1112.664781] ? io_schedule_timeout+0x130/0x130 [ 1112.670566] ? find_held_lock+0x2b/0x80 [ 1112.675741] ? __lock_release.isra.0+0x59/0x170 [ 1112.681624] schedule+0xd4/0x260 [ 1112.686034] schedule_preempt_disabled+0x18/0x30 [ 1112.692014] __mutex_lock+0xd76/0x1f20 [ 1112.697016] ? threaded_store+0x132/0x220 [ 1112.702317] ? ww_mutex_lock+0x160/0x160 [ 1112.707515] ? selinux_inode_free_security+0x310/0x310 [ 1112.714088] ? cap_capable+0x1ed/0x3f0 [ 1112.719095] ? sysfs_file_ops+0x140/0x140 [ 1112.724484] ? threaded_store+0x132/0x220 [ 1112.729782] threaded_store+0x132/0x220 [ 1112.734877] ? tx_maxrate_store+0x4e0/0x4e0 [ 1112.740367] ? sysfs_file_ops+0x140/0x140 [ 1112.745662] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.750957] ? sysfs_kf_write+0x65/0x160 [ 1112.756156] kernfs_fop_write_iter+0x335/0x510 [ 1112.761940] ? kernfs_ops+0xf0/0xf0 [ 1112.766649] new_sync_write+0x308/0x6f0 [ 1112.771753] ? new_sync_read+0x6f0/0x6f0 [ 1112.776950] ? lock_acquire.part.0+0xbc/0x260 [ 1112.782634] ? ksys_write+0xff/0x200 [ 1112.787445] vfs_write+0x62a/0x980 [ 1112.792060] ksys_write+0xff/0x200 [ 1112.796675] ? __ia32_sys_read+0xc0/0xc0 [ 1112.801864] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.807452] ? rcu_is_watching+0x15/0xd0 [ 1112.812651] do_syscall_64+0xf3/0x5e0 [ 1112.817555] ? exc_page_fault+0x9e/0xb0 [ 1112.822655] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.829122] RIP: 0033:0x7f72d2525c5e [ 1112.833932] RSP: 002b:00007ffc38bf55b0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.843229] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f72d2525c5e [ 1112.852026] RDX: 0000000000000001 RSI: 0000558eccb4c110 RDI: 0000000000000007 [ 1112.860834] RBP: 00007ffc38bf55c0 R08: 0000000000000000 R09: 0000000000000000 [ 1112.869630] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f72d23c0e80 [ 1112.878438] R13: 0000558eccb4c110 R14: 0000000000000007 R15: 00007f72d2c26b98 | [ 1113.249345] #1: ff11000184815688 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 1113.260306] #2: ff110001110290f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.271456] #3: ff11000111731cb8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.281549] | [ 1113.284015] =============================================\x0a [ 1235.496247] INFO: task python3:5009 blocked for more than 368 seconds. [ 1235.504394] Not tainted 7.0.0-rc4-bztq-gf7131a6ab2b5 #1 [ 1235.511635] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.521222] task:python3 state:D stack:25312 pid:5009 tgid:5009 ppid:5008 task_flags:0x400100 flags:0x00080002 [ 1235.534429] Call Trace: [ 1235.537969] [ 1235.541120] __schedule+0xad9/0x1490 [ 1235.545936] ? io_schedule_timeout+0x130/0x130 [ 1235.551719] ? find_held_lock+0x2b/0x80 [ 1235.556815] ? __lock_release.isra.0+0x59/0x170 [ 1235.562698] schedule+0xd4/0x260 [ 1235.567108] schedule_preempt_disabled+0x18/0x30 [ 1235.573083] __mutex_lock+0xd76/0x1f20 [ 1235.578089] ? threaded_store+0x132/0x220 [ 1235.583387] ? ww_mutex_lock+0x160/0x160 [ 1235.588586] ? selinux_inode_free_security+0x310/0x310 [ 1235.595155] ? cap_capable+0x1ed/0x3f0 [ 1235.600164] ? sysfs_file_ops+0x140/0x140 [ 1235.605469] ? threaded_store+0x132/0x220 [ 1235.610764] threaded_store+0x132/0x220 [ 1235.615865] ? tx_maxrate_store+0x4e0/0x4e0 [ 1235.621355] ? sysfs_file_ops+0x140/0x140 [ 1235.626652] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.631946] ? sysfs_kf_write+0x65/0x160 [ 1235.637146] kernfs_fop_write_iter+0x335/0x510 [ 1235.642932] ? kernfs_ops+0xf0/0xf0 [ 1235.647641] new_sync_write+0x308/0x6f0 [ 1235.652742] ? new_sync_read+0x6f0/0x6f0 [ 1235.657941] ? lock_acquire.part.0+0xbc/0x260 [ 1235.663626] ? ksys_write+0xff/0x200 [ 1235.668436] vfs_write+0x62a/0x980 [ 1235.673049] ksys_write+0xff/0x200 [ 1235.677662] ? __ia32_sys_read+0xc0/0xc0 [ 1235.682858] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.688449] ? rcu_is_watching+0x15/0xd0 [ 1235.693650] do_syscall_64+0xf3/0x5e0 [ 1235.698554] ? exc_page_fault+0x9e/0xb0 [ 1235.703654] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.710123] RIP: 0033:0x7f72d2525c5e [ 1235.714933] RSP: 002b:00007ffc38bf55b0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.724228] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f72d2525c5e [ 1235.733034] RDX: 0000000000000001 RSI: 0000558eccb4c110 RDI: 0000000000000007 [ 1235.741843] RBP: 00007ffc38bf55c0 R08: 0000000000000000 R09: 0000000000000000 [ 1235.750648] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f72d23c0e80 [ 1235.759457] R13: 0000558eccb4c110 R14: 0000000000000007 R15: 00007f72d2c26b98 | [ 1236.130044] #1: ff11000184815688 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 1236.141006] #2: ff110001110290f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.152160] #3: ff11000111731cb8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.162251] | [ 1236.164718] =============================================\x0a [ 1358.377390] INFO: task python3:5009 blocked for more than 491 seconds. [ 1358.385538] Not tainted 7.0.0-rc4-bztq-gf7131a6ab2b5 #1 [ 1358.392789] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.402379] task:python3 state:D stack:25312 pid:5009 tgid:5009 ppid:5008 task_flags:0x400100 flags:0x00080002 [ 1358.415587] Call Trace: [ 1358.419125] [ 1358.422277] __schedule+0xad9/0x1490 [ 1358.427096] ? io_schedule_timeout+0x130/0x130 [ 1358.432883] ? find_held_lock+0x2b/0x80 [ 1358.437990] ? __lock_release.isra.0+0x59/0x170 [ 1358.443875] schedule+0xd4/0x260 [ 1358.448295] schedule_preempt_disabled+0x18/0x30 [ 1358.454273] __mutex_lock+0xd76/0x1f20 [ 1358.459277] ? threaded_store+0x132/0x220 [ 1358.464579] ? ww_mutex_lock+0x160/0x160 [ 1358.469779] ? selinux_inode_free_security+0x310/0x310 [ 1358.476348] ? cap_capable+0x1ed/0x3f0 [ 1358.481357] ? sysfs_file_ops+0x140/0x140 [ 1358.486657] ? threaded_store+0x132/0x220 [ 1358.491955] threaded_store+0x132/0x220 [ 1358.497059] ? tx_maxrate_store+0x4e0/0x4e0 [ 1358.502555] ? sysfs_file_ops+0x140/0x140 [ 1358.507853] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.513152] ? sysfs_kf_write+0x65/0x160 [ 1358.518352] kernfs_fop_write_iter+0x335/0x510 [ 1358.524138] ? kernfs_ops+0xf0/0xf0 [ 1358.528850] new_sync_write+0x308/0x6f0 [ 1358.533956] ? new_sync_read+0x6f0/0x6f0 [ 1358.539157] ? lock_acquire.part.0+0xbc/0x260 [ 1358.544842] ? ksys_write+0xff/0x200 [ 1358.549656] vfs_write+0x62a/0x980 [ 1358.554274] ksys_write+0xff/0x200 [ 1358.558891] ? __ia32_sys_read+0xc0/0xc0 [ 1358.564090] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.569681] ? rcu_is_watching+0x15/0xd0 [ 1358.574886] do_syscall_64+0xf3/0x5e0 [ 1358.579795] ? exc_page_fault+0x9e/0xb0 [ 1358.584896] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.591365] RIP: 0033:0x7f72d2525c5e [ 1358.596175] RSP: 002b:00007ffc38bf55b0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.602737] nipa-hw-worker: drivers/net:napi_threaded.py: timed out [ 1358.605455] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f72d2525c5e [ 1358.605459] RDX: 0000000000000001 RSI: 0000558eccb4c110 RDI: 0000000000000007 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store