====================================== | [ 785.222159] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 785.224739] nipa-hw-worker: [5/47] Retrying drivers/net:napi_threaded.py | [ 785.379519] kselftest: Running tests in drivers/net [ 989.691873] INFO: task python3:5702 blocked for more than 122 seconds. [ 989.700102] Not tainted 7.1.0-rc3-xlsl-gd1cd808a79f4 #1 [ 989.708058] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.717646] task:python3 state:D stack:25672 pid:5702 tgid:5702 ppid:5701 task_flags:0x400100 flags:0x00080000 [ 989.730851] Call Trace: [ 989.734388] [ 989.737537] __schedule+0xcc3/0x19c0 [ 989.742355] ? io_schedule_timeout+0x140/0x140 [ 989.748138] ? find_held_lock+0x2b/0x80 [ 989.753234] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.759120] schedule+0xd8/0x260 [ 989.763536] schedule_preempt_disabled+0x18/0x30 [ 989.769515] __mutex_lock+0x6af/0x2010 [ 989.774516] ? threaded_store+0x132/0x220 [ 989.779813] ? ww_mutex_lock+0x160/0x160 [ 989.785010] ? selinux_inode_free_security+0x330/0x330 [ 989.791580] ? cap_capable+0x1d6/0x3e0 [ 989.796589] ? threaded_store+0x132/0x220 [ 989.801887] threaded_store+0x132/0x220 [ 989.806988] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.812286] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.817583] ? sysfs_kf_write+0x65/0x160 [ 989.822782] ? sysfs_file_ops+0x140/0x140 [ 989.828078] kernfs_fop_write_iter+0x335/0x510 [ 989.833864] ? kernfs_ops+0xf0/0xf0 [ 989.838574] new_sync_write+0x333/0x750 [ 989.843678] ? __lock_acquire+0x508/0xc10 [ 989.848973] ? new_sync_read+0x740/0x740 [ 989.854170] ? lock_acquire.part.0+0xbc/0x260 [ 989.859855] ? ksys_write+0x116/0x250 [ 989.864765] vfs_write+0x657/0x9b0 [ 989.869381] ksys_write+0x116/0x250 [ 989.874093] ? __ia32_sys_read+0xc0/0xc0 [ 989.879280] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.884866] ? rcu_is_watching+0x15/0xd0 [ 989.890066] do_syscall_64+0xf3/0x650 [ 989.894969] ? trace_hardirqs_off+0xd/0x30 [ 989.900362] ? exc_page_fault+0xda/0xf0 [ 989.905464] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.911929] RIP: 0033:0x7fc322e7c22e [ 989.916748] RSP: 002b:00007ffd2d4c7fa0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.926038] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fc322e7c22e [ 989.934843] RDX: 0000000000000001 RSI: 0000563182516cd0 RDI: 0000000000000007 [ 989.943650] RBP: 00007ffd2d4c7fb0 R08: 0000000000000000 R09: 0000000000000000 [ 989.952455] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fc322cf4390 [ 989.961260] R13: 0000563182516cd0 R14: 0000000000000007 R15: 0000000000000003 | [ 990.332472] #1: ff110001ec723e80 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 990.343445] #2: ff110001225beb50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.354604] #3: ff110001225a1d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.364692] | [ 990.367159] =============================================\x0a [ 1112.573125] INFO: task python3:5702 blocked for more than 245 seconds. [ 1112.581275] Not tainted 7.1.0-rc3-xlsl-gd1cd808a79f4 #1 [ 1112.588527] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.598117] task:python3 state:D stack:25672 pid:5702 tgid:5702 ppid:5701 task_flags:0x400100 flags:0x00080000 [ 1112.611325] Call Trace: [ 1112.614864] [ 1112.618014] __schedule+0xcc3/0x19c0 [ 1112.622834] ? io_schedule_timeout+0x140/0x140 [ 1112.628619] ? find_held_lock+0x2b/0x80 [ 1112.633728] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.639614] schedule+0xd8/0x260 [ 1112.644033] schedule_preempt_disabled+0x18/0x30 [ 1112.650006] __mutex_lock+0x6af/0x2010 [ 1112.655013] ? threaded_store+0x132/0x220 [ 1112.660312] ? ww_mutex_lock+0x160/0x160 [ 1112.665512] ? selinux_inode_free_security+0x330/0x330 [ 1112.672082] ? cap_capable+0x1d6/0x3e0 [ 1112.677091] ? threaded_store+0x132/0x220 [ 1112.682389] threaded_store+0x132/0x220 [ 1112.687494] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.692792] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.698092] ? sysfs_kf_write+0x65/0x160 [ 1112.703296] ? sysfs_file_ops+0x140/0x140 [ 1112.708593] kernfs_fop_write_iter+0x335/0x510 [ 1112.714371] ? kernfs_ops+0xf0/0xf0 [ 1112.719083] new_sync_write+0x333/0x750 [ 1112.724187] ? __lock_acquire+0x508/0xc10 [ 1112.729482] ? new_sync_read+0x740/0x740 [ 1112.734684] ? lock_acquire.part.0+0xbc/0x260 [ 1112.740371] ? ksys_write+0x116/0x250 [ 1112.745276] vfs_write+0x657/0x9b0 [ 1112.749892] ksys_write+0x116/0x250 [ 1112.754603] ? __ia32_sys_read+0xc0/0xc0 [ 1112.759806] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.765395] ? rcu_is_watching+0x15/0xd0 [ 1112.770600] do_syscall_64+0xf3/0x650 [ 1112.775509] ? trace_hardirqs_off+0xd/0x30 [ 1112.780905] ? exc_page_fault+0xda/0xf0 [ 1112.785999] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.792466] RIP: 0033:0x7fc322e7c22e [ 1112.797276] RSP: 002b:00007ffd2d4c7fa0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.806565] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fc322e7c22e [ 1112.815375] RDX: 0000000000000001 RSI: 0000563182516cd0 RDI: 0000000000000007 [ 1112.824182] RBP: 00007ffd2d4c7fb0 R08: 0000000000000000 R09: 0000000000000000 [ 1112.832985] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fc322cf4390 [ 1112.841796] R13: 0000563182516cd0 R14: 0000000000000007 R15: 0000000000000003 | [ 1113.241895] #1: ff110001ec723e80 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1113.252859] #2: ff110001225beb50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.264016] #3: ff110001225a1d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.274098] | [ 1113.276571] =============================================\x0a [ 1235.454371] INFO: task python3:5702 blocked for more than 368 seconds. [ 1235.462522] Not tainted 7.1.0-rc3-xlsl-gd1cd808a79f4 #1 [ 1235.469775] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.479367] task:python3 state:D stack:25672 pid:5702 tgid:5702 ppid:5701 task_flags:0x400100 flags:0x00080002 [ 1235.492572] Call Trace: [ 1235.496114] [ 1235.499266] __schedule+0xcc3/0x19c0 [ 1235.504085] ? io_schedule_timeout+0x140/0x140 [ 1235.509872] ? find_held_lock+0x2b/0x80 [ 1235.514979] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.520863] schedule+0xd8/0x260 [ 1235.525280] schedule_preempt_disabled+0x18/0x30 [ 1235.531262] __mutex_lock+0x6af/0x2010 [ 1235.536265] ? threaded_store+0x132/0x220 [ 1235.541567] ? ww_mutex_lock+0x160/0x160 [ 1235.546766] ? selinux_inode_free_security+0x330/0x330 [ 1235.553334] ? cap_capable+0x1d6/0x3e0 [ 1235.558344] ? threaded_store+0x132/0x220 [ 1235.563643] threaded_store+0x132/0x220 [ 1235.568743] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.574040] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.579331] ? sysfs_kf_write+0x65/0x160 [ 1235.584532] ? sysfs_file_ops+0x140/0x140 [ 1235.589828] kernfs_fop_write_iter+0x335/0x510 [ 1235.595615] ? kernfs_ops+0xf0/0xf0 [ 1235.600325] new_sync_write+0x333/0x750 [ 1235.605420] ? __lock_acquire+0x508/0xc10 [ 1235.610716] ? new_sync_read+0x740/0x740 [ 1235.615920] ? lock_acquire.part.0+0xbc/0x260 [ 1235.621606] ? ksys_write+0x116/0x250 [ 1235.626516] vfs_write+0x657/0x9b0 [ 1235.631132] ksys_write+0x116/0x250 [ 1235.635844] ? __ia32_sys_read+0xc0/0xc0 [ 1235.641033] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.646624] ? rcu_is_watching+0x15/0xd0 [ 1235.651826] do_syscall_64+0xf3/0x650 [ 1235.656734] ? trace_hardirqs_off+0xd/0x30 [ 1235.662129] ? exc_page_fault+0xda/0xf0 [ 1235.667231] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.673688] RIP: 0033:0x7fc322e7c22e [ 1235.678500] RSP: 002b:00007ffd2d4c7fa0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.687800] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fc322e7c22e [ 1235.696606] RDX: 0000000000000001 RSI: 0000563182516cd0 RDI: 0000000000000007 [ 1235.705416] RBP: 00007ffd2d4c7fb0 R08: 0000000000000000 R09: 0000000000000000 [ 1235.714225] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fc322cf4390 [ 1235.723035] R13: 0000563182516cd0 R14: 0000000000000007 R15: 0000000000000003 | [ 1236.133950] #2: ff110001225beb50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.145106] #3: ff110001225a1d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.155198] | [ 1236.157666] =============================================\x0a | [ 1255.934656] kworker/u129:11 (291) used greatest stack depth: 23024 bytes left [ 1358.335626] INFO: task python3:5702 blocked for more than 491 seconds. [ 1358.343780] Not tainted 7.1.0-rc3-xlsl-gd1cd808a79f4 #1 [ 1358.351032] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.360624] task:python3 state:D stack:25672 pid:5702 tgid:5702 ppid:5701 task_flags:0x400100 flags:0x00080002 [ 1358.373827] Call Trace: [ 1358.377365] [ 1358.380514] __schedule+0xcc3/0x19c0 [ 1358.385330] ? io_schedule_timeout+0x140/0x140 [ 1358.391114] ? find_held_lock+0x2b/0x80 [ 1358.396218] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.402101] schedule+0xd8/0x260 [ 1358.406516] schedule_preempt_disabled+0x18/0x30 [ 1358.412493] __mutex_lock+0x6af/0x2010 [ 1358.417495] ? threaded_store+0x132/0x220 [ 1358.422796] ? ww_mutex_lock+0x160/0x160 [ 1358.427993] ? selinux_inode_free_security+0x330/0x330 [ 1358.434552] ? cap_capable+0x1d6/0x3e0 [ 1358.439633] ? threaded_store+0x132/0x220 [ 1358.444928] threaded_store+0x132/0x220 [ 1358.450031] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.455327] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.460617] ? sysfs_kf_write+0x65/0x160 [ 1358.465818] ? sysfs_file_ops+0x140/0x140 [ 1358.471113] kernfs_fop_write_iter+0x335/0x510 [ 1358.476898] ? kernfs_ops+0xf0/0xf0 [ 1358.481609] new_sync_write+0x333/0x750 [ 1358.486711] ? __lock_acquire+0x508/0xc10 [ 1358.492006] ? new_sync_read+0x740/0x740 [ 1358.497207] ? lock_acquire.part.0+0xbc/0x260 [ 1358.502892] ? ksys_write+0x116/0x250 [ 1358.507803] vfs_write+0x657/0x9b0 [ 1358.512418] ksys_write+0x116/0x250 [ 1358.517121] ? __ia32_sys_read+0xc0/0xc0 [ 1358.522321] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.527910] ? rcu_is_watching+0x15/0xd0 [ 1358.533110] do_syscall_64+0xf3/0x650 [ 1358.538013] ? trace_hardirqs_off+0xd/0x30 [ 1358.543406] ? exc_page_fault+0xda/0xf0 [ 1358.548510] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.554978] RIP: 0033:0x7fc322e7c22e [ 1358.559789] RSP: 002b:00007ffd2d4c7fa0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.569088] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fc322e7c22e [ 1358.577899] RDX: 0000000000000001 RSI: 0000563182516cd0 RDI: 0000000000000007 [ 1358.586711] RBP: 00007ffd2d4c7fb0 R08: 0000000000000000 R09: 0000000000000000 [ 1358.586714] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fc322cf4390 [ 1358.586716] R13: 0000563182516cd0 R14: 0000000000000007 R15: 0000000000000003 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store